Daily Usenet report

May 23 06:01:01 -- May 24 06:01:01

Unknown entries from news log file:

First 47 / 47 lines (100.0%)

May 23 06:01:48 kennel innd: message repeated 2 times: [ ctlinnd command s]
May 23 09:43:59 kennel thermald[787]: 32 CPUID levels; family:model:stepping 0x6:be:0 (6:190:0)
May 23 09:43:59 kennel thermald[787]: 32 CPUID levels; family:model:stepping 0x6:be:0 (6:190:0)
May 23 09:43:59 kennel thermald[787]: sensor id 5 : No temp sysfs for reading raw temp
May 23 09:43:59 kennel thermald[787]: message repeated 2 times: [ sensor id 5 : No temp sysfs for reading raw temp]
May 23 09:43:59 kennel thermald[787]: Config file /etc/thermald/thermal-conf.xml does not exist
May 23 09:43:59 kennel thermald[787]: Config file /etc/thermald/thermal-conf.xml does not exist
May 23 09:43:59 kennel thermald[787]: Config file /etc/thermald/thermal-conf.xml does not exist
May 23 09:43:59 kennel thermald[787]: Polling mode is enabled: 4
May 23 09:45:00 kennel innd: message repeated 2 times: [ 24.182.239.66 rejected 502]
May 23 09:46:00 kennel innd: message repeated 3 times: [ 24.182.239.66 rejected 502]
May 23 09:47:00 kennel innd: message repeated 4 times: [ 24.182.239.66 rejected 502]
May 23 09:48:00 kennel innd: message repeated 5 times: [ 24.182.239.66 rejected 502]
May 23 09:49:00 kennel innd: message repeated 6 times: [ 24.182.239.66 rejected 502]
May 23 09:50:00 kennel innd: message repeated 7 times: [ 24.182.239.66 rejected 502]
May 23 09:51:00 kennel innd: message repeated 8 times: [ 24.182.239.66 rejected 502]
May 23 09:51:00 kennel innd: message repeated 2 times: [ 144.76.237.92 rejected 502]
May 23 09:52:00 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
May 23 09:52:00 kennel innd: message repeated 2 times: [ 37.252.120.71 rejected 502]
May 23 09:53:00 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
May 23 09:54:00 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
May 23 09:55:00 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
May 23 09:56:00 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
May 23 09:56:00 kennel innd: message repeated 2 times: [ 144.76.237.92 rejected 502]
May 23 09:57:00 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
May 23 09:57:00 kennel innd: message repeated 3 times: [ 37.252.120.71 rejected 502]
May 23 09:58:00 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
May 23 09:59:00 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
May 23 10:00:00 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
May 23 10:01:00 kennel innd: message repeated 2 times: [ 144.76.237.92 rejected 502]
May 23 10:01:00 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
May 23 10:02:00 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
May 23 10:02:00 kennel innd: message repeated 3 times: [ 37.252.120.71 rejected 502]
May 23 10:03:00 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
May 23 10:04:00 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
May 23 10:05:00 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
May 23 10:06:00 kennel innd: message repeated 4 times: [ 24.182.239.66 rejected 502]
May 23 10:06:00 kennel innd: message repeated 4 times: [ 24.182.239.66 rejected 502]
May 23 10:07:00 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
May 23 10:07:00 kennel innd: message repeated 3 times: [ 37.252.120.71 rejected 502]
May 23 10:08:00 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
May 23 10:09:00 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
May 23 10:10:00 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
May 23 10:11:00 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
May 23 10:11:00 kennel innd: message repeated 3 times: [ 144.76.237.92 rejected 502]
May 23 21:19:00 kennel pgpverify[95845]: pgpverify: verification failed
May 24 01:37:58 kennel innd: message repeated 4 times: [ 172.104.164.247 rejected 502]

Log entries by program:

Program nameLines%LinesSize%Size
inn 415098 97.0%54.5 MB 96.8%
innd 10781 2.5%1.5 MB 2.7%
innfeed 1524 0.4%227.2 KB 0.4%
nnrpd 202 0.0%22.1 KB 0.0%
cnfsstat 144 0.0%21.0 KB 0.0%
controlchan 13 0.0%2.5 KB 0.0%
thermald 8 0.0%0.8 KB 0.0%
overchan 1 0.0%0.1 KB 0.0%
pgpverify 1 0.0%0.2 KB 0.0%
TOTAL: 9 427772 100.0%56.3 MB100.0%

History cache:

ReasonCount%Count
Negative hits 692745 45.7%
Positive hits 416179 27.4%
Do not exist 402491 26.5%
Cache misses 6084 0.4%
TOTAL: 4 1517499 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.001 0.0%34 0.000 0.029 1.000
article cleanup00:00:04.093 0.0%413116 0.004 0.010 0.016
article logging00:00:16.221 0.0%413231 0.019 0.039 0.047
article parse00:00:20.732 0.0%1000305 0.009 0.021 0.025
article write00:00:15.597 0.0%185762 0.044 0.084 0.121
artlog/artparse00:00:00.018 0.0%349 0.000 0.052 0.667
data move00:00:11.115 0.0%1041328 0.004 0.011 0.016
hisgrep/artcncl00:00:00.000 0.0%34 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:16.732 0.0%1521525 0.003 0.011 0.179
history sync00:00:00.024 0.0%320 0.000 0.075 1.000
history write00:00:24.691 0.0%402859 0.037 0.061 0.078
idle23:43:52.429 99.5%890891 67.574 95.895 3489.041
nntp read00:00:41.158 0.0%889899 0.019 0.046 0.072
overview write00:00:01.054 0.0%185762 0.002 0.006 0.014
perl filter00:00:18.517 0.0%402514 0.021 0.046 0.058
python filter00:00:19.282 0.0%402514 0.020 0.048 0.067
site send00:00:07.093 0.0%474560 0.008 0.015 0.102
TOTAL: 23:50:28.63723:47:08.757 99.8%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.357 0.0%103597 0.000 0.003 0.010
article prepare00:00:00.001 0.0%949 0.000 0.001 0.143
article read00:00:00.043 0.0%526 0.000 0.082 1.000
backlog stats00:00:00.346 0.0%320650 0.000 0.001 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:05.304 0.0%205293 0.000 0.026 0.044
data write00:00:05.342 0.0%118384 0.000 0.045 0.097
idle23:52:51.429100.0%320650 148.641 268.116 13055.283
status file00:00:00.202 0.0%340 0.000 0.594 1.250
TOTAL: 23:53:15.57923:53:03.024100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:00.000 0.0%0 0.000 0.000 0.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.006 0.1%48 0.000 0.125 1.000
TOTAL: 00:00:10.65000:00:00.006 0.1%----

Control commands to INND:

CommandNumber
flush 5
flushlogs 2
go 2
logmode 2
lowmark 1
mode 147
name 2
pause 2
paused 2
reload 48
reserve 2
TOTAL: 11 215

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
nl-admin@nic.surfnet.nl001101
TOTAL001101

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1hasname-out.feeder.erje.net 572 804785 180838 395885 228062 22%46:39:21
2hasname-out.news.weretis.net 4 9829 2566 7225 38 26%40:54:24
3news.nntp4.net 2 6683 1727 4838 118 25%24:51:49
4usenet.blueworldhosting.com 1305 6595 1165 5401 29 17%23:25:58
5localhost 1 0 0 0 0 0%00:00:00
TOTAL: 5 1884 827892 186296 413349 228247 22%135:51:32
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1hasname-out.feeder.erje.net1.3 GB85.2 MB1.8 GB3.2 GB 40%8.2 KB
2hasname-out.news.weretis.net7.2 MB6.7 KB65.1 KB7.3 MB 99%2.9 KB
3news.nntp4.net5.3 MB0.0 KB1.1 MB6.5 MB 82%3.6 KB
4usenet.blueworldhosting.com2.6 MB1.5 KB86.1 KB2.7 MB 96%2.3 KB
5localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 51.3 GB85.2 MB1.8 GB3.2 GB 40%8.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 23 06:01:01 - 06:59:59 8290 4.4% 2.3450.9 MB 3.8% 14.72
May 23 07:00:00 - 07:59:59 8071 4.3% 2.2462.9 MB 4.7% 17.89
May 23 08:00:00 - 08:59:59 8365 4.5% 2.3260.7 MB 4.6% 17.27
May 23 09:00:00 - 09:59:59 6354 3.4% 1.7644.5 MB 3.3% 12.65
May 23 10:00:00 - 10:59:59 7407 4.0% 2.0661.7 MB 4.6% 17.56
May 23 11:00:00 - 11:59:59 9989 5.4% 2.7781.5 MB 6.1% 23.19
May 23 12:00:00 - 12:59:59 7845 4.2% 2.1852.8 MB 4.0% 15.01
May 23 13:00:00 - 13:59:59 10208 5.5% 2.8477.3 MB 5.8% 21.98
May 23 14:00:00 - 14:59:59 9143 4.9% 2.5464.3 MB 4.8% 18.28
May 23 15:00:00 - 15:59:59 8489 4.6% 2.3666.9 MB 5.0% 19.02
May 23 16:00:00 - 16:59:59 10384 5.6% 2.8882.5 MB 6.2% 23.47
May 23 17:00:00 - 17:59:59 8516 4.6% 2.3771.3 MB 5.4% 20.27
May 23 18:00:00 - 18:59:59 6182 3.3% 1.7250.6 MB 3.8% 14.40
May 23 19:00:00 - 19:59:59 9311 5.0% 2.5958.8 MB 4.4% 16.73
May 23 20:00:00 - 20:59:59 9322 5.0% 2.5964.4 MB 4.8% 18.32
May 23 21:00:00 - 21:59:59 7587 4.1% 2.1154.4 MB 4.1% 15.47
May 23 22:00:00 - 22:59:59 4963 2.7% 1.3843.3 MB 3.3% 12.32
May 23 23:00:00 - 23:59:59 6263 3.4% 1.7444.6 MB 3.4% 12.68
May 24 00:00:00 - 00:59:59 8477 4.5% 2.3544.2 MB 3.3% 12.56
May 24 01:00:00 - 01:59:59 7544 4.0% 2.1042.5 MB 3.2% 12.09
May 24 02:00:00 - 02:59:59 6389 3.4% 1.7735.5 MB 2.7% 10.09
May 24 03:00:00 - 03:59:59 6216 3.3% 1.7340.7 MB 3.1% 11.57
May 24 04:00:00 - 04:59:59 6137 3.3% 1.7042.3 MB 3.2% 12.02
May 24 05:00:00 - 05:59:59 4939 2.6% 1.3730.6 MB 2.3% 8.72
May 24 06:00:00 - 06:01:01 102 0.1% 1.67704.2 KB 0.1% 11.54
TOTAL: 24:00:00 186493 100.0% 2.161.3 GB 100.0% 15.76
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
C1DEFAULT10.0 GB7.9 GB 78.8% 146 20.51 5.92
TOTAL: 1-10.0 GB7.9 GB 78.8% 146 20.51-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1hasname-out.feeder.erje.net228359217313 0 10647 0 1 0 0 398
2news.nntp4.net 118 113 0 0 0 0 0 0 5
3usenet.blueworldhosting.com 71 28 0 1 0 0 0 0 42
4hasname-out.news.weretis.net 56 33 0 3 0 0 0 0 20
5hasname-out.feeder.erje.neMay 1 0 0 0 0 0 0 0 1
TOTAL: 5228605217487 0 10651 0 1 0 0 466

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.binaries.friends 150578
alt.binaries.pwp 7331
alt.binaries.amazing 5386
alt.binaries.encrypted 4722
alt.binaries.u-4all 1993
alt.binaries.storage 1742
alt.binaries.flowed 1649
alt.binaries.wtfnzb.hotel 1613
alt.binaries.wtfnzb.echo 1601
alt.binaries.wtfnzb.bravo 1595
alt.binaries.wtfnzb.mike 1593
alt.binaries.wtfnzb.kilo 1588
alt.binaries.wtfnzb.delta 1580
alt.binaries.wtfnzb.alpha 1567
alt.binaries.wtfnzb.india 1565
alt.binaries.wtfnzb.beta 1560
alt.binaries.wtfnzb.foxtrot 1549
alt.binaries.wtfnzb.novemeber 1544
alt.binaries.wtfnzb.charlie 1543
alt.binaries.wtfnzb.lima 1538
TOTAL: 186 217487

INND no permission servers:

SystemConn
103.193.138.76 30
24.182.239.66 29
144.76.237.92 12
37.252.120.71 7
159.195.56.112 5
168.119.53.7 5
5.161.41.9 5
167.94.146.51 2
77.91.118.50 2
172.104.164.247 1
185.247.137.196 1
195.96.139.202 1
TOTAL: 12 100

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
hasname-out.feeder.erje.net 17
usenet.blueworldhosting.com 1
TOTAL: 2 18
Including strange strings
hasname-out.feeder.erje.net 48
usenet.blueworldhosting.com 42
hasname-out.news.weretis.net 20
news.nntp4.net 5
TOTAL: 4 115
No colon-space in header field
hasname-out.feeder.erje.net 350
TOTAL: 1 350
TOTAL: 3 483

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1bbsgslincom 386 386 0 0 0 0100%18:46:57
2blueworldhosting 104964 141 101850 1 0 0 0%23:54:36
3erje 5006 0 4999 0 0 102 0%23:54:34
4nntp4 4717 0 4716 0 0 120 0%23:54:37
5weretis 3445 0 3443 0 0 66 0%23:53:23
TOTAL: 5 118518 527 115008 1 0 288 0%114:24:07
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1bbsgslincom1.4 MB0.0 KB1.4 MB0.0 KB/s3.8 KB18:46:57
2blueworldhosting1.2 MB5.4 KB1.2 MB0.0 KB/s8.3 KB23:54:36
3erje0.0 KB0.0 KB0.0 KB0.0 KB/s023:54:34
4nntp40.0 KB0.0 KB0.0 KB0.0 KB/s023:54:37
5weretis0.0 KB0.0 KB0.0 KB0.0 KB/s023:53:23
TOTAL: 52.6 MB5.4 KB2.6 MB0.0 KB/s5.0 KB114:24:07
Outgoing feeds (innfeed) by Volume

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
prod53client01.academyforinternetresearch.org 0.013 0.049 0.00000:00:02
165.154.246.244 0.001 0.004 0.00000:00:02
prod55client01.academyforinternetresearch.org 0.020 0.040 0.00000:00:02
193.124.20.252 0.003 0.007 0.00000:00:00
69.5.169.146 0.002 0.002 0.00000:00:00
69.5.169.166 0.000 0.003 0.00000:00:00
69.5.169.189 0.001 0.004 0.00000:00:00
193.124.20.247 0.002 0.002 0.00000:00:00
69.5.169.182 0.001 0.004 0.00000:00:00
azpdcs9veufw.stretchoid.com 0.002 0.007 0.00000:00:00
53.146.94.167.censys-scanner.com 0.002 0.008 0.00000:00:00
172-236-15-97.ip.linodeusercontent.com 0.002 0.002 0.00000:00:00
37.10.113.211 0.001 0.003 0.00000:00:00
198.235.24.95 0.001 0.002 0.00000:00:00
TOTAL: 14 0.051 0.137 0.00000:00:10

NNRP no permission clients [Top 20]:

SystemConn
prod53client01.academyforinternetresearch.org 16
prod55client01.academyforinternetresearch.org 16
53.146.94.167.censys-scanner.com 3
193.124.20.252 2
azpdcs9veufw.stretchoid.com 2
165.154.246.244 1
172-236-15-97.ip.linodeusercontent.com 1
193.124.20.247 1
198.235.24.95 1
37.10.113.211 1
69.5.169.146 1
69.5.169.166 1
69.5.169.182 1
69.5.169.189 1
TOTAL: 14 48
innreport from INN 2.7.2 based on initial work (©) 1996-2001 by Fabien Tassin <fta@sofaraway.org> and enhanced by several contributors since then