Daily Usenet report for paganini.linuxd.org

Mar 19 00:00:05 -- Mar 20 00:00:04

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Mar 19 17:25:26 paganini overchan[30393]: input line too long, skipping
Mar 20 00:00:04 paganini overchan[9040]: 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 106600 64.4%13.3 MB 55.5%
inn 39266 23.7%8.1 MB 34.0%
innd 19154 11.6%2.4 MB 10.2%
nnrpd 533 0.3%75.0 KB 0.3%
nocem 69 0.0%12.0 KB 0.0%
overchan 3 0.0%0.2 KB 0.0%
TOTAL: 6 165625 100.0%24.0 MB100.0%

History cache:

ReasonCount%Count
Positive hits 111478 49.7%
Negative hits 74754 33.3%
Do not exist 38018 16.9%
Cache misses 70 0.0%
TOTAL: 4 224320 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.596 0.0%171 0.000 3.485 45.250
article cleanup00:00:00.243 0.0%38526 0.000 0.006 0.026
article logging00:00:00.569 0.0%39102 0.000 0.015 0.420
article parse00:00:01.093 0.0%89695 0.000 0.012 0.046
article write00:00:44.896 0.1%20632 0.145 2.176 20.531
artlog/artcncl00:00:00.001 0.0%169 0.000 0.006 0.059
data move00:00:00.176 0.0%241351 0.000 0.001 0.004
hisgrep/artcncl00:00:00.048 0.0%168 0.000 0.286 19.000
hishave/artcncl00:00:00.002 0.0%171 0.000 0.012 0.062
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:12.195 0.0%226898 0.011 0.054 0.430
history sync00:00:00.180 0.0%395 0.000 0.456 52.667
history write00:00:30.062 0.0%38526 0.014 0.780 4.316
hiswrite/artcncl00:00:00.000 0.0%3 0.000 0.000 0.000
idle23:57:17.874 99.7%238882 148.716 361.006 1438.329
nntp read00:00:01.630 0.0%247386 0.001 0.007 0.016
overview write00:00:23.651 0.0%20632 0.026 1.146 11.864
perl filter00:01:20.366 0.1%38526 0.972 2.086 3.418
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.976 0.0%62025 0.000 0.016 0.047
TOTAL: 24:01:02.99924:00:34.558100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.091 0.0%41488 0.000 0.002 0.012
article prepare00:00:00.005 0.0%48152 0.000 0.000 0.004
article read00:00:03.956 0.0%9330 0.000 0.424 23.370
backlog stats00:00:00.223 0.0%334436 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.352 0.0%181330 0.003 0.007 0.016
data write00:00:02.976 0.0%161223 0.009 0.018 0.036
idle23:42:08.443 99.2%334436 67.358 255.141 461.696
status file00:10:33.846 0.7%44624 8.674 14.204 24.517
TOTAL: 23:53:02.00923:52:50.892100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle04:22:21.979 99.9%476 27.333 33071.384600128.333
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.016 0.0%1260 0.000 0.013 0.250
readart00:00:00.048 0.0%10 0.000 4.800 31.000
TOTAL: 04:22:36.49404:22:22.043 99.9%----

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1linuxd-out.news.weretis.net 4 45310 17338 25801 2171 38%48:09:22
2newsfeed.neva.ru 146 80390 2757 62085 15548 3%71:51:07
3news.fcku.it 2 5444 502 4838 104 9%24:31:58
4nntp.pasdenom.info 3 23771 85 23678 8 0%31:11:29
5localhost 25 0 0 0 0 0%00:00:00
TOTAL: 5 180 154915 20682 116402 17831 13%175:43:56
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1linuxd-out.news.weretis.net51.4 MB0.0 KB14.7 MB66.1 MB 77%3.5 KB
2newsfeed.neva.ru6.9 MB0.0 KB139.7 MB146.5 MB 4%8.2 KB
3news.fcku.it2.0 MB0.0 KB5.0 MB7.0 MB 28%11.8 KB
4nntp.pasdenom.info261.2 KB0.0 KB14.6 KB275.7 KB 94%3.0 KB
5localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 560.5 MB0.0 KB159.4 MB219.9 MB 27%5.8 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Mar 19 00:00:05 - 00:59:59 792 3.8% 0.222.4 MB 4.0% 0.69
Mar 19 01:00:00 - 01:59:59 665 3.2% 0.182.1 MB 3.5% 0.60
Mar 19 02:00:00 - 02:59:59 502 2.4% 0.141.6 MB 2.6% 0.44
Mar 19 03:00:00 - 03:59:59 494 2.4% 0.142.1 MB 3.5% 0.61
Mar 19 04:00:00 - 04:59:59 449 2.2% 0.121.8 MB 3.0% 0.51
Mar 19 05:00:00 - 05:59:59 347 1.7% 0.101.0 MB 1.7% 0.30
Mar 19 06:00:00 - 06:59:59 453 2.2% 0.131.3 MB 2.2% 0.38
Mar 19 07:00:00 - 07:59:59 381 1.8% 0.111.0 MB 1.7% 0.30
Mar 19 08:00:00 - 08:59:59 530 2.6% 0.151.4 MB 2.2% 0.39
Mar 19 09:00:00 - 09:59:59 780 3.8% 0.222.4 MB 4.0% 0.68
Mar 19 10:00:00 - 10:59:59 832 4.0% 0.232.4 MB 3.9% 0.67
Mar 19 11:00:00 - 11:59:59 1027 5.0% 0.292.8 MB 4.6% 0.79
Mar 19 12:00:00 - 12:59:59 959 4.6% 0.272.6 MB 4.3% 0.73
Mar 19 13:00:00 - 13:59:59 1132 5.5% 0.312.9 MB 4.9% 0.83
Mar 19 14:00:00 - 14:59:59 985 4.8% 0.272.7 MB 4.5% 0.77
Mar 19 15:00:00 - 15:59:59 1073 5.2% 0.302.7 MB 4.5% 0.78
Mar 19 16:00:00 - 16:59:59 1245 6.0% 0.353.5 MB 5.9% 1.01
Mar 19 17:00:00 - 17:59:59 1189 5.8% 0.333.2 MB 5.3% 0.92
Mar 19 18:00:00 - 18:59:59 1277 6.2% 0.353.7 MB 6.0% 1.04
Mar 19 19:00:00 - 19:59:59 1063 5.2% 0.302.8 MB 4.7% 0.81
Mar 19 20:00:00 - 20:59:59 1322 6.4% 0.373.5 MB 5.7% 0.99
Mar 19 21:00:00 - 21:59:59 1082 5.2% 0.303.5 MB 5.7% 0.99
Mar 19 22:00:00 - 22:59:59 1138 5.5% 0.324.3 MB 7.2% 1.23
Mar 19 23:00:00 - 23:59:59 902 4.4% 0.252.5 MB 4.2% 0.72
Mar 20 00:00:00 - 00:00:04 7 0.0% 1.7528.0 KB 0.0% 7.01
TOTAL: 23:59:59 20626 100.0% 0.2460.5 MB 100.0% 0.72
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 15659 388 0 0 0 0 0 015271
2linuxd-out.news.weretis.net 2712 373 0 0 0 0 0 0 2339
3news.fcku.it 93 6 0 0 0 0 0 0 87
4nntp.pasdenom.info 6 0 0 0 0 0 0 0 6
TOTAL: 4 18470 767 0 0 0 0 0 017703

Unwanted newsgroups [Top 20]:

NewsgroupCount
lada.talk 134
ut.test 116
it-alt.sport.calcio.juventus 51
lada.auto 47
mozilla.general 39
alt.survival 35
alt.politics.scorched-earth 29
alt.windows7.general 16
mozilla.support.firefox 15
alt.computer.workshop 14
gmane.comp.gis.openstreetmap 13
alt.religion.christianity 12
cakewalk.audio 12
lada.photo 11
lada.commerce 11
spline.eisfair 10
alt.politics 9
alt.english.usage 9
oesterreich.tratsch 9
spline.eisfair.dev 7
TOTAL: 96 767

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 14933
EMP (phn path) 1994
EMP (phn nph) 74
Too many newsgroups 42
Binary Payload 22
User-issued cancel 18
EMP (phl) 16
HTML post 10
Binary: non-binary distribution 7
Binary Image: misplaced jpg 2
Binary: misplaced pdf 2
Binary: misplaced par2 1
Binary: misplaced exe 1
Binary: misplaced sfv 1
Binary: misplaced nfo 1
Binary: misplaced srr 1
TOTAL: 16 17125

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
linuxd-out.news.weretis.net 542
newsfeed.neva.ru 35
news.fcku.it 1
TOTAL: 3 578
TOTAL: 1 578

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nntp.pasdenom.info 30085 4182 15484 820 0 6617 13%23:49:47
2news.fcku.it 24714 2930 13372 3746 0 131 11%23:50:01
3eternal-september 24787 95 17711 7 0 161 0%23:50:01
4weretis.net 3402 87 3143 0 0 2 2%23:53:02
5neva.ru 26395 62 17663 100 0 20 0%23:55:49
6etla.org 0 0 0 0 0 20507 0%23:50:01
7news.netfront.net 2672 0 0 0 0 23227 0%23:59:36
8news.albasani.net 2867 0 0 0 0 22568 0%23:59:45
9vc89.vc.panix.com 2841 0 0 0 0 23455 0%23:59:29
10news.mixmin.net 0 0 0 0 0 0 0%00:10:00
11news.stack.nl 2856 0 0 0 0 23453 0%23:59:47
12news.killfile.org 2847 0 0 0 0 23472 0%23:59:55
TOTAL: 12 123466 7356 67373 4673 0 143613 5%263:17:13
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nntp.pasdenom.info12.4 MB1.7 MB14.1 MB0.2 KB/s2.9 KB23:49:47
2news.fcku.it8.5 MB10.6 MB19.1 MB0.2 KB/s2.9 KB23:50:01
3eternal-september769.5 KB23.0 KB792.6 KB0.0 KB/s7.8 KB23:50:01
4neva.ru264.8 KB299.9 KB564.7 KB0.0 KB/s3.5 KB23:55:49
5weretis.net153.0 KB0.0 KB153.0 KB0.0 KB/s1.8 KB23:53:02
6etla.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:01
7news.netfront.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:36
8news.albasani.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:45
9vc89.vc.panix.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:29
10news.mixmin.net0.0 KB0.0 KB0.0 KB0.0 KB/s000:10:00
11news.stack.nl0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:47
12news.killfile.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:55
TOTAL: 1222.1 MB12.7 MB34.7 MB0.0 KB/s3.0 KB263:17:13
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1challenger.nielsenmedia.com 10 514.5 KB 3 0 001:37:12
247-192-187-101.drr02.clwr.fl.frontiernet.net 14 514.5 KB 3 0 002:45:02
TOTAL: 2 24 1029.0 KB 6 0 004:22:36

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.nielsenmedia.com 10 514.5 KB 3 0 001:37:12
2*.drr02.clwr.fl.frontiernet.net 14 514.5 KB 3 0 002:45:02
3*.092.073.pools.vodafone-ip.de 136 00.0 KB 0 0 000:00:20
TOTAL: 3 160 1029.0 KB 6 0 004:22:36

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
47-192-187-101.drr02.clwr.fl.frontiernet.net 1.088 0.056 0.00002:45:02
challenger.nielsenmedia.com 0.720 0.036 0.00001:37:12
dslb-092-073-008-096.092.073.pools.vodafone-ip.de 7.148 0.320 0.00000:00:20
TOTAL: 3 8.956 0.412 0.00004:22:36

Curious NNRP server explorers [Top 20]:

SystemConn
dslb-092-073-008-096.092.073.pools.vodafone-ip.de 136
TOTAL: 1 136

NNRP client timeouts [Top 20]:

SystemConnPeer
47-192-187-101.drr02.clwr.fl.frontiernet.net 5 0
challenger.nielsenmedia.com 3 0
TOTAL: 2 8 0

Newsgroup request counts (by category):

CategoryCountPct
1comp 10100.0%
TOTAL: 1 10100.0%

Newsgroup request counts (by newsgroup) [Top 100]:

NewsgroupCount
1comp.lang.awk 10
TOTAL: 1 10