Daily Usenet report for paganini.linuxd.org

Feb 15 00:00:02 -- Feb 16 00:00:02

Unknown entries from news log file:

First 6 / 6 lines (100.0%)

Feb 15 04:18:11 paganini overchan[25061]: input line too long, skipping
Feb 15 05:36:36 paganini overchan[25061]: input line too long, skipping
Feb 15 09:14:16 paganini overchan[25061]: input line too long, skipping
Feb 15 10:50:02 paganini controlchan[25059]: Unknown "tags" control by robomod@news.nic.it
Feb 15 17:00:04 paganini pgpverify[3512]: pgpverify: verification failed
Feb 16 00:00:02 paganini overchan[13732]: overchan is running while innd is creating overview data (you can ignore this message if you are running makehistory -F)

Log entries by program:

Program nameLines%LinesSize%Size
innfeed 104927 63.2%13.1 MB 53.5%
inn 41751 25.1%8.9 MB 36.3%
innd 18887 11.4%2.4 MB 9.9%
nnrpd 426 0.3%61.9 KB 0.2%
nocem 86 0.1%14.4 KB 0.1%
controlchan 5 0.0%0.8 KB 0.0%
overchan 5 0.0%0.8 KB 0.0%
pgpverify 1 0.0%0.2 KB 0.0%
TOTAL: 8 166088 100.0%24.5 MB100.0%

History cache:

ReasonCount%Count
Positive hits 128677 51.4%
Negative hits 80774 32.2%
Do not exist 40960 16.4%
Cache misses 108 0.0%
TOTAL: 4 250519 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.831 0.0%180 0.000 4.617 178.000
article cleanup00:00:00.255 0.0%41034 0.000 0.006 0.031
article logging00:00:00.374 0.0%41593 0.000 0.009 0.025
article parse00:00:01.099 0.0%90554 0.000 0.012 0.040
article write00:00:48.128 0.1%23178 0.118 2.076 12.953
artlog/artcncl00:00:00.000 0.0%178 0.000 0.000 0.000
data move00:00:00.146 0.0%248861 0.000 0.001 0.003
hisgrep/artcncl00:00:00.027 0.0%176 0.000 0.153 1.091
hishave/artcncl00:00:00.005 0.0%180 0.000 0.028 1.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:14.143 0.0%250962 0.012 0.056 0.277
history sync00:00:00.016 0.0%310 0.000 0.052 1.000
history write00:00:38.243 0.0%41033 0.013 0.932 5.340
hiswrite/artcncl00:00:00.000 0.0%4 0.000 0.000 0.000
idle23:55:54.335 99.7%252467 147.963 341.250 1199.030
nntp read00:00:02.081 0.0%261906 0.003 0.008 0.016
overview write00:00:24.333 0.0%23178 0.029 1.050 4.645
perl filter00:01:30.218 0.1%41033 1.035 2.199 5.268
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.456 0.0%69731 0.005 0.021 0.049
TOTAL: 24:00:23.48523:59:35.690 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.128 0.0%63984 0.000 0.002 0.016
article prepare00:00:00.004 0.0%24492 0.000 0.000 0.011
article read00:00:02.117 0.0%5081 0.000 0.417 16.172
backlog stats00:00:00.271 0.0%375643 0.000 0.001 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.619 0.0%204081 0.002 0.008 0.017
data write00:00:03.264 0.0%181238 0.009 0.018 0.037
idle23:42:10.025 99.2%375643 27.991 227.157 502.206
status file00:10:36.836 0.7%43843 8.443 14.525 40.188
TOTAL: 23:53:16.36823:52:54.264100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle03:04:30.133 99.3%377 29.667 29363.748600113.333
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.012 0.0%986 0.000 0.012 0.250
TOTAL: 03:05:42.68303:04:30.145 99.3%----

Control commands to INND:

CommandNumber
L 1
flush 6
flushlogs 2
go 2
logmode 2
mode 149
name 2
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 172

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
group-admin@isc.org000100
TOTAL000100

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1linuxd-out.news.weretis.net 5 50905 19946 28772 2187 39%48:24:23
2newsfeed.neva.ru 147 86705 2938 68299 15468 3%71:18:49
3news.fcku.it 2 4963 224 4643 96 4%17:13:33
4nntp.pasdenom.info 5 25572 55 25509 8 0%25:20:18
5localhost 25 0 0 0 0 0%00:00:00
TOTAL: 5 184 168145 23163 127223 17759 13%162:17:03
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1linuxd-out.news.weretis.net60.6 MB0.0 KB13.7 MB74.3 MB 81%3.4 KB
2newsfeed.neva.ru8.0 MB9.9 KB138.7 MB146.7 MB 5%8.2 KB
3news.fcku.it469.6 KB0.0 KB210.1 KB679.7 KB 69%2.1 KB
4nntp.pasdenom.info133.0 KB0.0 KB248.6 KB381.6 KB 34%6.1 KB
5localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 569.2 MB9.9 KB152.9 MB222.1 MB 31%5.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Feb 15 00:00:02 - 00:59:59 807 3.5% 0.222.4 MB 3.5% 0.69
Feb 15 01:00:00 - 01:59:59 764 3.3% 0.213.0 MB 4.3% 0.86
Feb 15 02:00:00 - 02:59:59 580 2.5% 0.162.2 MB 3.2% 0.62
Feb 15 03:00:00 - 03:59:59 500 2.2% 0.141.7 MB 2.4% 0.48
Feb 15 04:00:00 - 04:59:59 534 2.3% 0.152.2 MB 3.2% 0.64
Feb 15 05:00:00 - 05:59:59 435 1.9% 0.121.5 MB 2.1% 0.42
Feb 15 06:00:00 - 06:59:59 525 2.3% 0.151.8 MB 2.6% 0.51
Feb 15 07:00:00 - 07:59:59 490 2.1% 0.141.9 MB 2.8% 0.55
Feb 15 08:00:00 - 08:59:59 633 2.7% 0.181.8 MB 2.6% 0.51
Feb 15 09:00:00 - 09:59:59 865 3.7% 0.242.5 MB 3.6% 0.70
Feb 15 10:00:00 - 10:59:59 1032 4.5% 0.292.7 MB 3.9% 0.77
Feb 15 11:00:00 - 11:59:59 1179 5.1% 0.332.9 MB 4.2% 0.84
Feb 15 12:00:00 - 12:59:59 1008 4.4% 0.282.5 MB 3.6% 0.71
Feb 15 13:00:00 - 13:59:59 1141 4.9% 0.322.8 MB 4.0% 0.79
Feb 15 14:00:00 - 14:59:59 1181 5.1% 0.333.3 MB 4.8% 0.94
Feb 15 15:00:00 - 15:59:59 1196 5.2% 0.333.2 MB 4.6% 0.91
Feb 15 16:00:00 - 16:59:59 1214 5.2% 0.343.5 MB 5.1% 1.00
Feb 15 17:00:00 - 17:59:59 1432 6.2% 0.404.3 MB 6.3% 1.24
Feb 15 18:00:00 - 18:59:59 1361 5.9% 0.384.1 MB 5.9% 1.17
Feb 15 19:00:00 - 19:59:59 1486 6.4% 0.414.4 MB 6.3% 1.24
Feb 15 20:00:00 - 20:59:59 1262 5.4% 0.353.8 MB 5.5% 1.08
Feb 15 21:00:00 - 21:59:59 1274 5.5% 0.353.9 MB 5.6% 1.11
Feb 15 22:00:00 - 22:59:59 1157 5.0% 0.323.6 MB 5.2% 1.03
Feb 15 23:00:00 - 00:00:02 1116 4.8% 0.313.1 MB 4.5% 0.88
TOTAL: 24:00:00 23172 100.0% 0.2769.2 MB 100.0% 0.82
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 15544 452 0 1 0 0 0 015091
2linuxd-out.news.weretis.net 2703 566 0 0 0 0 0 0 2137
3news.fcku.it 148 0 0 0 0 0 0 0 148
4nntp.pasdenom.info 7 1 0 0 0 0 0 0 6
TOTAL: 4 18402 1019 0 1 0 0 0 017382

Unwanted newsgroups [Top 20]:

NewsgroupCount
ut.test 147
lada.talk 146
lada.auto 87
it-alt.sport.calcio.juventus 73
it.annunci.immobiliari 39
it.annunci.commerciali 36
alt.windows7.general 34
it.annunci.varie 33
gmane.linux.alsa.devel 29
it.comp.os.win.windows10 25
oesterreich.tratsch 21
alt.politics.scorched-earth 18
lada.mobile 18
mpc.lists.freebsd.x11 17
spline.eisfair 15
mozilla.support.seamonkey 15
cakewalk.audio 15
mozilla.support.firefox 9
fido7.ru.android 9
lada.commerce 9
TOTAL: 123 1019

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 14300
EMP (phn path) 1794
EMP (phl) 476
EMP (phn nph) 107
Too many newsgroups 98
Binary Payload 14
User-issued cancel 13
Binary Image: misplaced jpg 9
Binary: non-binary distribution 8
HTML post 4
Binary: misplaced JPG 1
Too many newsgroups (meow) 1
TOTAL: 12 16825

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
linuxd-out.news.weretis.net 521
newsfeed.neva.ru 34
news.fcku.it 2
TOTAL: 3 557
TOTAL: 1 557

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.fcku.it 30590 1903 18543 2418 0 76 6%23:59:45
2nntp.pasdenom.info 58292 1274 42211 283 0 5993 2%23:57:39
3weretis.net 4129 108 3203 0 0 10 2%23:56:45
4neva.ru 29600 69 20095 45 0 77 0%23:59:45
5eternal-september 25423 48 19675 0 0 27 0%23:59:45
6news.albasani.net 2863 0 0 0 0 24844 0%23:59:45
7news.mixmin.net 0 0 0 0 0 0 0%00:10:00
8news.stack.nl 2846 0 0 0 0 25991 0%23:59:45
9news.killfile.org 2849 0 0 0 0 26020 0%23:59:45
10news.netfront.net 2736 0 0 0 0 25862 0%23:59:38
11vc89.vc.panix.com 2838 0 0 0 0 26009 0%23:59:45
12etla.org 0 0 0 0 0 23172 0%23:59:46
TOTAL: 12 162166 3402 103727 2746 0 158081 2%264:02:03
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.fcku.it5.2 MB8.5 MB13.7 MB0.2 KB/s3.2 KB23:59:45
2nntp.pasdenom.info3.9 MB1.1 MB4.9 MB0.1 KB/s3.2 KB23:57:39
3eternal-september319.0 KB0.0 KB319.0 KB0.0 KB/s6.6 KB23:59:45
4neva.ru299.4 KB166.3 KB465.7 KB0.0 KB/s4.1 KB23:59:45
5weretis.net167.6 KB0.0 KB167.6 KB0.0 KB/s1.6 KB23:56:45
6news.albasani.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:45
7news.mixmin.net0.0 KB0.0 KB0.0 KB0.0 KB/s000:10:00
8news.stack.nl0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:45
9news.killfile.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:45
10news.netfront.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:38
11vc89.vc.panix.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:45
12etla.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:46
TOTAL: 129.9 MB9.7 MB19.6 MB0.0 KB/s3.3 KB264:02:03
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1206.113.192.12 1 00.0 KB 0 0 000:00:15
2challenger.nielsenmedia.com 11 00.0 KB 0 0 002:31:03
347-192-187-101.drr02.clwr.fl.frontiernet.net 8 00.0 KB 0 0 000:33:24
4dslb-188-110-184-251.188.110.pools.vodafone-ip.de 111 00.0 KB 0 0 000:00:53
5188.110.184.251 1 00.0 KB 0 0 000:00:05
6ninja.census.shodan.io 1 00.0 KB 0 0 000:00:00
TOTAL: 6 133 00.0 KB 0 0 003:05:42

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 2 00.0 KB 0 0 000:00:20
2*.drr02.clwr.fl.frontiernet.net 8 00.0 KB 0 0 000:33:24
3*.census.shodan.io 1 00.0 KB 0 0 000:00:00
4*.nielsenmedia.com 11 00.0 KB 0 0 002:31:03
5*.188.110.pools.vodafone-ip.de 111 00.0 KB 0 0 000:00:53
TOTAL: 5 133 00.0 KB 0 0 003:05:42

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
challenger.nielsenmedia.com 0.700 0.064 0.00002:31:03
47-192-187-101.drr02.clwr.fl.frontiernet.net 0.512 0.036 0.00000:33:24
dslb-188-110-184-251.188.110.pools.vodafone-ip.de 6.012 0.400 0.00000:00:53
206.113.192.12 0.072 0.008 0.00000:00:15
188.110.184.251 0.048 0.008 0.00000:00:05
ninja.census.shodan.io 0.056 0.004 0.00000:00:00
TOTAL: 6 7.400 0.520 0.00003:05:42

NNRP client timeouts [Top 20]:

SystemConnPeer
challenger.nielsenmedia.com 5 0
TOTAL: 1 5 0