Daily Usenet report for paganini.linuxd.org

Mar 20 00:00:04 -- Mar 21 00:00:04

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

Mar 20 08:47:46 paganini overchan[9040]: input line too long, skipping
Mar 20 22:09:58 paganini overchan[9040]: input line too long, skipping
Mar 21 00:00:04 paganini overchan[27340]: 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 152579 70.9%18.7 MB 61.8%
inn 42222 19.6%8.9 MB 29.2%
innd 19777 9.2%2.6 MB 8.6%
nnrpd 528 0.2%74.4 KB 0.2%
nocem 117 0.1%19.6 KB 0.1%
overchan 4 0.0%0.4 KB 0.0%
controlchan 1 0.0%0.0 KB 0.0%
TOTAL: 7 215228 100.0%30.3 MB100.0%

History cache:

ReasonCount%Count
Positive hits 120092 48.4%
Negative hits 86700 34.9%
Do not exist 41322 16.6%
Cache misses 124 0.0%
TOTAL: 4 248238 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.693 0.0%221 0.000 7.661 44.611
article cleanup00:00:00.319 0.0%41441 0.000 0.008 0.021
article logging00:00:00.389 0.0%42038 0.000 0.009 0.054
article parse00:00:01.143 0.0%92383 0.000 0.012 0.037
article write00:03:26.948 0.2%22622 0.033 9.148 49.183
artlog/artcncl00:00:00.000 0.0%202 0.000 0.000 0.000
data move00:00:00.287 0.0%255826 0.000 0.001 0.025
hisgrep/artcncl00:00:00.093 0.0%219 0.000 0.425 5.000
hishave/artcncl00:00:00.100 0.0%221 0.000 0.452 7.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:03:55.656 0.3%248748 0.015 0.947 5.439
history sync00:00:00.019 0.0%395 0.000 0.048 0.500
history write00:03:51.383 0.3%41432 0.033 5.585 33.762
hiswrite/artcncl00:00:00.000 0.0%2 0.000 0.000 0.000
idle23:45:55.132 98.9%246134 192.760 347.596 1096.656
nntp read00:00:02.478 0.0%264657 0.003 0.009 0.113
overview write00:01:38.235 0.1%22622 0.000 4.342 31.314
perl filter00:01:30.133 0.1%41432 0.985 2.175 3.729
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.942 0.0%68093 0.000 0.014 0.053
TOTAL: 24:01:09.14424:00:24.950 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.138 0.0%48153 0.000 0.003 0.015
article prepare00:00:00.004 0.0%32840 0.000 0.000 0.016
article read00:00:05.531 0.0%6370 0.000 0.868 25.722
backlog stats00:00:00.287 0.0%414512 0.000 0.001 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.655 0.0%226384 0.003 0.007 0.017
data write00:00:03.270 0.0%204259 0.006 0.016 0.029
idle23:26:10.754 98.1%414512 127.357 203.542 423.110
status file00:26:47.881 1.9%79704 5.143 20.173 103.481
TOTAL: 23:53:26.98823:53:09.520100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle05:39:48.431 98.6%467 27.333 43658.310600125.333
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:03:29.040 1.0%2073 0.000 100.839 231.737
readart00:01:15.039 0.4%37267 0.000 2.014 26.000
TOTAL: 05:44:44.83405:44:32.510 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 49241 18883 28139 2219 38%48:26:19
2newsfeed.neva.ru 140 84332 3251 64461 16620 3%72:15:58
3news.fcku.it 2 6355 458 5810 87 7%22:36:11
4nntp.pasdenom.info 3 14684 29 14652 3 0%17:02:06
5localhost 25 0 0 0 0 0%00:00:00
TOTAL: 5 174 154612 22621 113062 18929 14%160:20:34
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1linuxd-out.news.weretis.net58.2 MB13.1 KB13.4 MB71.7 MB 81%3.5 KB
2newsfeed.neva.ru9.1 MB28.0 KB139.9 MB149.1 MB 6%7.7 KB
3news.fcku.it4.8 MB0.0 KB2.7 MB7.5 MB 63%14.1 KB
4nntp.pasdenom.info64.1 KB0.0 KB80.5 KB144.6 KB 44%4.5 KB
5localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 572.2 MB41.1 KB156.2 MB228.4 MB 31%5.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Mar 20 00:00:04 - 00:59:59 792 3.5% 0.222.2 MB 3.1% 0.64
Mar 20 01:00:00 - 01:59:59 618 2.7% 0.171.7 MB 2.4% 0.49
Mar 20 02:00:00 - 02:59:59 495 2.2% 0.142.5 MB 3.4% 0.71
Mar 20 03:00:00 - 03:59:59 470 2.1% 0.131.6 MB 2.2% 0.45
Mar 20 04:00:00 - 04:59:59 457 2.0% 0.131.9 MB 2.7% 0.55
Mar 20 05:00:00 - 05:59:59 439 1.9% 0.121.7 MB 2.4% 0.50
Mar 20 06:00:00 - 06:59:59 479 2.1% 0.131.5 MB 2.1% 0.43
Mar 20 07:00:00 - 07:59:59 592 2.6% 0.162.1 MB 2.9% 0.59
Mar 20 08:00:00 - 08:59:59 697 3.1% 0.193.0 MB 4.2% 0.86
Mar 20 09:00:00 - 09:59:59 873 3.9% 0.243.4 MB 4.7% 0.97
Mar 20 10:00:00 - 10:59:59 986 4.4% 0.272.7 MB 3.7% 0.76
Mar 20 11:00:00 - 11:59:59 1120 5.0% 0.313.7 MB 5.2% 1.07
Mar 20 12:00:00 - 12:59:59 989 4.4% 0.272.6 MB 3.6% 0.74
Mar 20 13:00:00 - 13:59:59 1062 4.7% 0.292.8 MB 3.9% 0.80
Mar 20 14:00:00 - 14:59:59 1237 5.5% 0.343.5 MB 4.9% 1.00
Mar 20 15:00:00 - 15:59:59 1139 5.0% 0.323.1 MB 4.3% 0.88
Mar 20 16:00:00 - 16:59:59 1296 5.7% 0.363.5 MB 4.9% 1.00
Mar 20 17:00:00 - 17:59:59 1429 6.3% 0.404.1 MB 5.7% 1.17
Mar 20 18:00:00 - 18:59:59 1339 5.9% 0.374.0 MB 5.5% 1.13
Mar 20 19:00:00 - 19:59:59 1579 7.0% 0.445.1 MB 7.1% 1.46
Mar 20 20:00:00 - 20:59:59 1307 5.8% 0.364.6 MB 6.4% 1.32
Mar 20 21:00:00 - 21:59:59 1135 5.0% 0.323.5 MB 4.8% 0.99
Mar 20 22:00:00 - 22:59:59 1123 5.0% 0.313.7 MB 5.1% 1.05
Mar 20 23:00:00 - 23:59:59 951 4.2% 0.263.4 MB 4.8% 0.98
Mar 21 00:00:00 - 00:00:04 15 0.1% 3.7563.8 KB 0.1% 15.95
TOTAL: 24:00:00 22619 100.0% 0.2672.2 MB 100.0% 0.86
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 16539 345 0 6 0 0 0 016188
2linuxd-out.news.weretis.net 2780 686 0 3 0 0 0 0 2091
3news.fcku.it 78 1 0 0 0 0 0 0 77
4nntp.pasdenom.info 5 1 0 0 0 0 0 0 4
TOTAL: 4 19402 1033 0 9 0 0 0 018360

Unwanted newsgroups [Top 20]:

NewsgroupCount
lada.talk 124
mozilla.general 105
ut.test 78
gmane.linux.alsa.devel 64
it.annunci.immobiliari 34
it.annunci.commerciali 33
it.annunci.varie 33
it-alt.sport.calcio.juventus 30
mozilla.support.firefox 30
alt.windows7.general 29
lada.auto 28
alt.survival 26
alt.politics.scorched-earth 24
mpc.lists.nanog 20
gmane.comp.gis.openstreetmap.tagging 18
it.comp.os.win.windows10 17
us 15
alt.sci.physics 14
mozilla.dev.security.policy 13
alt.pl.nieruchomosci.gielda 12
TOTAL: 147 1033

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 16145
EMP (phn path) 1408
EMP (phn nph) 86
Too many newsgroups 44
User-issued cancel 35
Binary Payload 24
Binary: non-binary distribution 9
EMP (phl) 8
HTML post 3
Too many newsgroups (low_xpost) 1
Binary: misplaced pdf 1
Too many newsgroups (meow) 1
TOTAL: 12 17765

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
linuxd-out.news.weretis.net 561
newsfeed.neva.ru 34
TOTAL: 2 595
TOTAL: 1 595

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nntp.pasdenom.info 36914 2143 19443 891 0 461 5%23:56:35
2news.fcku.it 27054 1967 17407 2832 0 67 7%24:08:22
3weretis.net 3917 152 3616 0 0 5 3%23:56:08
4neva.ru 26579 103 19109 114 0 131 0%24:01:17
5eternal-september 24762 86 19710 0 0 36 0%24:00:01
6vc89.vc.panix.com 2841 0 0 0 0 25451 0%24:00:02
7news.mixmin.net 0 0 0 0 0 0 0%00:10:00
8news.albasani.net 2864 0 0 0 0 24553 0%23:59:42
9news.killfile.org 2848 0 0 0 0 25448 0%23:59:42
10etla.org 0 0 0 0 0 22595 0%24:00:01
11news.stack.nl 2847 0 0 0 0 25420 0%23:59:54
12news.netfront.net 15267 0 0 0 0 36239 0%24:00:12
TOTAL: 12 145893 4451 79285 3837 0 160406 3%264:11:56
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nntp.pasdenom.info7.3 MB1.8 MB9.2 MB0.1 KB/s3.1 KB23:56:35
2news.fcku.it5.3 MB8.8 MB14.1 MB0.2 KB/s3.0 KB24:08:22
3eternal-september405.1 KB0.0 KB405.1 KB0.0 KB/s4.7 KB24:00:01
4neva.ru288.0 KB268.6 KB556.6 KB0.0 KB/s2.6 KB24:01:17
5weretis.net247.4 KB0.0 KB247.4 KB0.0 KB/s1.6 KB23:56:08
6vc89.vc.panix.com0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:02
7news.mixmin.net0.0 KB0.0 KB0.0 KB0.0 KB/s000:10:00
8news.albasani.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:42
9news.killfile.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:42
10etla.org0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:01
11news.stack.nl0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:54
12news.netfront.net0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:12
TOTAL: 1213.6 MB10.8 MB24.4 MB0.0 KB/s3.0 KB264:11:56
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1challenger.nielsenmedia.com 16 59.9 KB 5 0 004:03:01
247-192-187-101.drr02.clwr.fl.frontiernet.net 11 12.0 KB 1 0 001:36:10
TOTAL: 2 27 611.9 KB 6 0 005:44:44

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.nielsenmedia.com 16 59.9 KB 5 0 004:03:01
2*.drr02.clwr.fl.frontiernet.net 11 12.0 KB 1 0 001:36:10
3unresolved 1 00.0 KB 0 0 000:05:13
4*.092.073.pools.vodafone-ip.de 126 00.0 KB 0 0 000:00:19
TOTAL: 4 154 611.9 KB 6 0 005:44:44

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
challenger.nielsenmedia.com 1.132 0.060 0.00004:03:01
47-192-187-101.drr02.clwr.fl.frontiernet.net 0.668 0.048 0.00001:36:10
196.52.20.47 0.992 2.212 0.00000:05:13
dslb-092-073-008-096.092.073.pools.vodafone-ip.de 6.724 0.408 0.00000:00:19
TOTAL: 4 9.516 2.728 0.00005:44:44

Curious NNRP server explorers [Top 20]:

SystemConn
dslb-092-073-008-096.092.073.pools.vodafone-ip.de 126
196.52.20.47 1
TOTAL: 2 127

NNRP client timeouts [Top 20]:

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

Newsgroup request counts (by category):

CategoryCountPct
1comp 6100.0%
TOTAL: 1 6100.0%

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

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