Daily Usenet report for paganini.linuxd.org

Oct 2 00:00:02 -- Oct 3 00:00:02

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Oct 2 20:02:53 paganini overchan[10105]: input line too long, skipping
Oct 3 00:00:02 paganini overchan[28904]: 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 89535 62.8%11.0 MB 52.7%
inn 36169 25.4%7.7 MB 36.6%
innd 16304 11.4%2.2 MB 10.4%
nnrpd 526 0.4%73.9 KB 0.3%
nocem 22 0.0%3.8 KB 0.0%
overchan 3 0.0%0.3 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 7 142560 100.0%21.0 MB100.0%

History cache:

ReasonCount%Count
Positive hits 89772 45.8%
Negative hits 70540 36.0%
Do not exist 35190 18.0%
Cache misses 381 0.2%
TOTAL: 4 195883 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.066 0.0%415 0.000 2.569 26.000
article cleanup00:00:00.241 0.0%35498 0.000 0.007 0.026
article logging00:00:00.315 0.0%35902 0.000 0.009 0.025
article parse00:00:00.888 0.0%79281 0.000 0.011 0.037
article write00:00:48.782 0.1%19759 0.189 2.469 15.772
artlog/artcncl00:00:00.003 0.0%412 0.000 0.007 0.012
data move00:00:00.129 0.0%214756 0.000 0.001 0.003
hisgrep/artcncl00:00:00.027 0.0%415 0.000 0.065 0.143
hishave/artcncl00:00:00.011 0.0%415 0.000 0.027 0.037
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:10.875 0.0%197191 0.014 0.055 1.456
history sync00:00:00.015 0.0%316 0.000 0.047 0.500
history write00:00:27.080 0.0%35498 0.021 0.763 4.831
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:56:38.372 99.7%215539 216.842 399.920 1599.987
nntp read00:00:01.684 0.0%220510 0.002 0.008 0.015
overview write00:00:17.416 0.0%19759 0.000 0.881 3.266
perl filter00:01:23.043 0.1%35498 1.112 2.339 6.773
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.020 0.0%59386 0.000 0.017 0.040
TOTAL: 24:00:29.98923:59:50.967100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.093 0.0%33273 0.000 0.003 0.014
article prepare00:00:00.003 0.0%17328 0.000 0.000 0.008
article read00:00:01.384 0.0%3093 0.000 0.447 35.000
backlog stats00:00:00.197 0.0%321022 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.395 0.0%172733 0.001 0.008 0.016
data write00:00:02.593 0.0%153099 0.006 0.017 0.028
idle23:43:13.710 99.3%321022 153.707 266.006 586.129
status file00:09:56.445 0.7%37310 8.300 15.986 37.641
TOTAL: 23:53:35.89523:53:15.820100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle02:43:34.968 99.8%505 28.333 19435.580360665.400
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:01.141 0.0%1361 0.000 0.838 18.410
readart00:00:00.142 0.0%1767 0.000 0.080 10.333
TOTAL: 02:43:53.96702:43:36.251 99.8%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1linuxd-out.news.weretis.net 5 43808 15645 26173 1990 35%47:47:01
2newsfeed.neva.ru 144 74037 2163 58343 13531 2%71:32:02
3news.fcku.it 2 7638 1781 5624 233 23%24:31:00
4localhost 25 0 0 0 0 0%00:00:00
5nntp.pasdenom.info 1 0 0 0 0 0%00:10:02
TOTAL: 5 177 125483 19589 90140 15754 15%144:00:05
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1linuxd-out.news.weretis.net50.1 MB0.0 KB11.7 MB61.8 MB 81%3.6 KB
2newsfeed.neva.ru6.2 MB0.0 KB110.3 MB116.5 MB 5%7.6 KB
3news.fcku.it4.4 MB0.0 KB3.3 MB7.7 MB 56%3.9 KB
4localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
5nntp.pasdenom.info0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 560.7 MB0.0 KB125.3 MB186.0 MB 32%5.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 2 00:00:02 - 00:59:59 786 4.0% 0.222.5 MB 4.1% 0.72
Oct 2 01:00:00 - 01:59:59 665 3.4% 0.182.2 MB 3.6% 0.63
Oct 2 02:00:00 - 02:59:59 585 3.0% 0.161.6 MB 2.6% 0.46
Oct 2 03:00:00 - 03:59:59 613 3.1% 0.171.9 MB 3.0% 0.53
Oct 2 04:00:00 - 04:59:59 467 2.4% 0.131.5 MB 2.4% 0.43
Oct 2 05:00:00 - 05:59:59 376 1.9% 0.101.7 MB 2.8% 0.48
Oct 2 06:00:00 - 06:59:59 652 3.3% 0.184.1 MB 6.7% 1.16
Oct 2 07:00:00 - 07:59:59 493 2.5% 0.141.4 MB 2.2% 0.39
Oct 2 08:00:00 - 08:59:59 469 2.4% 0.131.5 MB 2.5% 0.44
Oct 2 09:00:00 - 09:59:59 558 2.8% 0.151.5 MB 2.5% 0.43
Oct 2 10:00:00 - 10:59:59 645 3.3% 0.181.8 MB 3.0% 0.52
Oct 2 11:00:00 - 11:59:59 805 4.1% 0.222.0 MB 3.2% 0.56
Oct 2 12:00:00 - 12:59:59 794 4.0% 0.222.2 MB 3.6% 0.63
Oct 2 13:00:00 - 13:59:59 841 4.3% 0.232.0 MB 3.2% 0.56
Oct 2 14:00:00 - 14:59:59 881 4.5% 0.242.2 MB 3.6% 0.63
Oct 2 15:00:00 - 15:59:59 953 4.8% 0.264.1 MB 6.7% 1.17
Oct 2 16:00:00 - 16:59:59 1123 5.7% 0.313.2 MB 5.3% 0.92
Oct 2 17:00:00 - 17:59:59 1027 5.2% 0.292.7 MB 4.5% 0.78
Oct 2 18:00:00 - 18:59:59 1181 6.0% 0.333.0 MB 4.9% 0.85
Oct 2 19:00:00 - 19:59:59 1009 5.1% 0.282.5 MB 4.0% 0.70
Oct 2 20:00:00 - 20:59:59 1260 6.4% 0.355.3 MB 8.6% 1.50
Oct 2 21:00:00 - 21:59:59 1273 6.5% 0.353.2 MB 5.2% 0.90
Oct 2 22:00:00 - 22:59:59 1293 6.6% 0.362.9 MB 4.8% 0.84
Oct 2 23:00:00 - 23:59:59 980 5.0% 0.274.3 MB 7.0% 1.22
Oct 3 00:00:00 - 00:00:02 7 0.0% 3.5079.2 KB 0.1% 39.62
TOTAL: 24:00:00 19736 100.0% 0.2361.4 MB 100.0% 0.73
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 13457 623 0 0 0 0 0 012834
2linuxd-out.news.weretis.net 2365 544 0 0 0 0 0 0 1821
3news.fcku.it 199 6 0 0 0 0 0 0 193
TOTAL: 3 16021 1173 0 0 0 0 0 014848

Unwanted newsgroups [Top 20]:

NewsgroupCount
it-alt.sport.calcio.juventus 168
lada.talk 157
ut.test 101
fa.linux.kernel 99
lada.auto 42
fa.openbsd.source-changes 35
it.comp.os.win.windows10 34
fa.freebsd.cvs-all 33
mozilla.support.seamonkey 31
alt.survival 27
mozilla.support.thunderbird 24
gmane.comp.bacula.user 24
alt.windows7.general 23
fa.openbsd.tech 22
fa.netbsd.bugs 17
fa.netbsd.current-users 15
mpc.lists.nanog 15
lada.photo 14
lada.commerce 13
oesterreich.tratsch 11
TOTAL: 106 1173

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 11303
EMP (phn path) 2109
EMP (phl) 834
EMP (phn nph) 114
Too many newsgroups 36
User-issued cancel 19
Binary: non-binary distribution 11
Binary Payload 6
Binary: misplaced py 3
HTML post 2
Binary: misplaced cmd 2
Binary Image: misplaced jpg 1
Binary: misplaced arj 1
EMP (phr path) 1
TOTAL: 14 14442

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
linuxd-out.news.weretis.net 376
newsfeed.neva.ru 24
news.fcku.it 6
TOTAL: 3 406
TOTAL: 1 406

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nntp.pasdenom.info 35472 1127 18309 265 0 724 3%23:57:39
2news.fcku.it 23960 679 15992 1328 0 110 2%23:59:45
3weretis.net 4185 441 3456 0 0 7 10%23:59:36
4neva.ru 27144 95 17049 403 0 171 0%23:59:45
5eternal-september 22950 5 16830 2 0 203 0%23:59:40
6news.albasani.net 2860 0 0 0 0 21786 0%23:59:45
7news.netfront.net 2760 0 0 0 0 22416 0%23:59:45
8news.stack.nl 2840 0 0 0 0 22482 0%23:59:45
9vc89.vc.panix.com 2002 0 0 0 0 21737 0%23:59:45
10etla.org 0 0 0 0 0 19736 0%23:59:46
11news.mixmin.net 0 0 0 0 0 0 0%00:10:00
12news.killfile.org 2010 0 0 0 0 21745 0%23:59:45
TOTAL: 12 126183 2347 71636 1998 0 131117 1%264:04:56
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nntp.pasdenom.info4.1 MB917.9 KB5.0 MB0.1 KB/s3.7 KB23:57:39
2news.fcku.it3.1 MB5.3 MB8.4 MB0.1 KB/s4.3 KB23:59:45
3weretis.net1.2 MB0.0 KB1.2 MB0.0 KB/s2.7 KB23:59:36
4neva.ru449.5 KB1.2 MB1.6 MB0.0 KB/s3.3 KB23:59:45
5eternal-september23.2 KB4.0 KB27.2 KB0.0 KB/s3.9 KB23:59:40
6news.albasani.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:45
7news.netfront.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:45
8news.stack.nl0.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:45
10etla.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:46
11news.mixmin.net0.0 KB0.0 KB0.0 KB0.0 KB/s000:10:00
12news.killfile.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:45
TOTAL: 128.9 MB7.3 MB16.2 MB0.0 KB/s3.8 KB264:04:56
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1challenger.nielsenmedia.com 5 816.6 KB 2 0 001:00:50
247.192.187.101 8 816.6 KB 2 0 001:42:24
TOTAL: 2 13 1633.2 KB 4 0 002:43:53

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 10 816.6 KB 2 0 001:42:32
2*.nielsenmedia.com 5 816.6 KB 2 0 001:00:50
3*.188.110.pools.vodafone-ip.de 144 00.0 KB 0 0 000:00:30
TOTAL: 3 159 1633.2 KB 4 0 002:43:53

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
47.192.187.101 0.700 0.016 0.00001:42:24
challenger.nielsenmedia.com 0.364 0.036 0.00001:00:50
dslb-188-110-188-212.188.110.pools.vodafone-ip.de 7.528 0.500 0.00000:00:30
196.52.22.22 0.176 0.020 0.00000:00:08
TOTAL: 4 8.768 0.572 0.00002:43:53

Curious NNRP server explorers [Top 20]:

SystemConn
dslb-188-110-188-212.188.110.pools.vodafone-ip.de 144
196.52.22.22 2
TOTAL: 2 146

NNRP client timeouts [Top 20]:

SystemConnPeer
47.192.187.101 3 0
challenger.nielsenmedia.com 2 0
TOTAL: 2 5 0

Newsgroup request counts (by category):

CategoryCountPct
1comp 16100.0%
TOTAL: 1 16100.0%

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

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