Daily Usenet report for paganini.linuxd.org

Feb 14 00:00:02 -- Feb 15 00:00:02

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Feb 14 09:32:42 paganini overchan[2764]: input line too long, skipping
Feb 15 00:00:02 paganini overchan[25061]: 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 101138 63.0%12.5 MB 52.7%
inn 40746 25.4%8.8 MB 37.2%
innd 17842 11.1%2.3 MB 9.7%
nnrpd 653 0.4%91.8 KB 0.4%
nocem 68 0.0%11.7 KB 0.0%
overchan 3 0.0%0.6 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 7 160451 100.0%23.7 MB100.0%

History cache:

ReasonCount%Count
Positive hits 127011 51.5%
Negative hits 79707 32.3%
Do not exist 39973 16.2%
Cache misses 101 0.0%
TOTAL: 4 246792 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.319 0.0%148 0.000 2.155 82.000
article cleanup00:00:00.235 0.0%40017 0.000 0.006 0.023
article logging00:00:00.345 0.0%40598 0.000 0.008 0.031
article parse00:00:01.081 0.0%87854 0.000 0.012 0.033
article write00:00:52.553 0.1%23319 0.098 2.254 17.341
artlog/artcncl00:00:00.000 0.0%147 0.000 0.000 0.000
data move00:00:00.144 0.0%243845 0.000 0.001 0.003
hisgrep/artcncl00:00:00.001 0.0%145 0.000 0.007 0.056
hishave/artcncl00:00:00.002 0.0%148 0.000 0.014 0.056
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:17.818 0.0%247243 0.014 0.072 1.484
history sync00:00:00.016 0.0%295 0.000 0.054 1.000
history write00:00:34.937 0.0%40016 0.032 0.873 6.197
hiswrite/artcncl00:00:00.000 0.0%3 0.000 0.000 0.000
idle23:55:51.576 99.7%247883 159.901 347.549 1359.190
nntp read00:00:02.052 0.0%257475 0.000 0.008 0.017
overview write00:00:24.333 0.0%23319 0.020 1.043 5.901
perl filter00:01:25.930 0.1%40016 1.054 2.147 4.481
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.467 0.0%70161 0.002 0.021 0.065
TOTAL: 24:00:24.64923:59:32.809 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.101 0.0%37546 0.000 0.003 0.014
article prepare00:00:00.005 0.0%17232 0.000 0.000 0.014
article read00:00:02.418 0.0%4074 0.000 0.594 24.200
backlog stats00:00:00.197 0.0%285812 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.205 0.0%156756 0.002 0.008 0.014
data write00:00:02.725 0.0%133717 0.011 0.020 0.037
idle23:43:10.960 99.3%285812 203.683 298.766 495.728
status file00:10:14.540 0.7%42306 8.613 14.526 46.326
TOTAL: 23:53:52.17223:53:32.151100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle06:26:37.347 99.6%569 29.333 40768.624600130.333
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.011 0.0%1518 0.000 0.007 0.250
readart00:00:00.084 0.0%28 0.000 3.000 33.000
TOTAL: 06:28:04.44506:26:37.442 99.6%----

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 49677 19415 28361 1901 39%47:55:09
2newsfeed.neva.ru 154 85731 3007 68213 14511 3%72:01:16
3news.fcku.it 2 7685 859 6631 195 11%22:39:41
4nntp.pasdenom.info 3 37602 53 37542 7 0%37:40:08
5localhost 25 0 0 0 0 0%00:00:00
TOTAL: 5 188 180695 23334 140747 16614 12%180:16:14
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1linuxd-out.news.weretis.net59.0 MB0.0 KB10.8 MB69.7 MB 84%3.4 KB
2newsfeed.neva.ru8.4 MB4.8 KB133.0 MB141.5 MB 5%8.3 KB
3news.fcku.it1.9 MB0.0 KB604.2 KB2.5 MB 75%2.4 KB
4nntp.pasdenom.info145.3 KB0.0 KB110.4 KB255.7 KB 56%4.3 KB
5localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 569.4 MB4.8 KB144.5 MB213.9 MB 32%5.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Feb 14 00:00:02 - 00:59:59 801 3.4% 0.223.0 MB 4.3% 0.84
Feb 14 01:00:00 - 01:59:59 746 3.2% 0.212.3 MB 3.3% 0.65
Feb 14 02:00:00 - 02:59:59 591 2.5% 0.162.3 MB 3.3% 0.65
Feb 14 03:00:00 - 03:59:59 551 2.4% 0.151.6 MB 2.2% 0.44
Feb 14 04:00:00 - 04:59:59 535 2.3% 0.151.7 MB 2.4% 0.47
Feb 14 05:00:00 - 05:59:59 428 1.8% 0.121.7 MB 2.4% 0.48
Feb 14 06:00:00 - 06:59:59 546 2.3% 0.151.7 MB 2.5% 0.49
Feb 14 07:00:00 - 07:59:59 654 2.8% 0.182.0 MB 2.9% 0.58
Feb 14 08:00:00 - 08:59:59 763 3.3% 0.212.3 MB 3.3% 0.66
Feb 14 09:00:00 - 09:59:59 942 4.0% 0.262.6 MB 3.8% 0.75
Feb 14 10:00:00 - 10:59:59 987 4.2% 0.272.8 MB 4.1% 0.80
Feb 14 11:00:00 - 11:59:59 933 4.0% 0.262.4 MB 3.4% 0.68
Feb 14 12:00:00 - 12:59:59 969 4.2% 0.272.4 MB 3.5% 0.69
Feb 14 13:00:00 - 13:59:59 919 3.9% 0.262.4 MB 3.5% 0.69
Feb 14 14:00:00 - 14:59:59 1175 5.0% 0.333.2 MB 4.7% 0.92
Feb 14 15:00:00 - 15:59:59 1136 4.9% 0.323.3 MB 4.7% 0.93
Feb 14 16:00:00 - 16:59:59 1273 5.5% 0.353.4 MB 5.0% 0.98
Feb 14 17:00:00 - 17:59:59 1399 6.0% 0.394.4 MB 6.4% 1.26
Feb 14 18:00:00 - 18:59:59 1456 6.2% 0.403.9 MB 5.6% 1.10
Feb 14 19:00:00 - 19:59:59 1454 6.2% 0.404.4 MB 6.3% 1.25
Feb 14 20:00:00 - 20:59:59 1432 6.1% 0.404.7 MB 6.8% 1.34
Feb 14 21:00:00 - 21:59:59 1298 5.6% 0.364.0 MB 5.8% 1.14
Feb 14 22:00:00 - 22:59:59 1257 5.4% 0.353.7 MB 5.3% 1.05
Feb 14 23:00:00 - 23:59:59 1059 4.5% 0.293.0 MB 4.4% 0.86
Feb 15 00:00:00 - 00:00:02 5 0.0% 2.5073.3 KB 0.1% 36.65
TOTAL: 24:00:00 23309 100.0% 0.2769.3 MB 100.0% 0.82
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 14673 364 0 1 0 0 0 014308
2linuxd-out.news.weretis.net 2412 561 0 0 0 0 0 0 1851
3news.fcku.it 201 9 0 0 0 0 0 0 192
4nntp.pasdenom.info 3 0 0 0 0 0 0 0 3
TOTAL: 4 17289 934 0 1 0 0 0 016354

Unwanted newsgroups [Top 20]:

NewsgroupCount
ut.test 135
lada.talk 80
lada.auto 71
it-alt.sport.calcio.juventus 58
it.annunci.varie 56
it.annunci.immobiliari 54
it.annunci.commerciali 53
it.comp.os.win.windows10 26
mozilla.support.firefox 19
alt.computer.workshop 19
alt.windows7.general 17
gmane.linux.alsa.devel 16
mozilla.dev.security.policy 15
gmane.comp.gis.openstreetmap.tagging 12
mozilla.dev.platform 12
mozilla.support.seamonkey 12
oesterreich.tratsch 11
alt.english.usage 11
mozilla.general 10
mpc.lists.nanog 10
TOTAL: 115 934

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 13526
EMP (phn path) 1487
EMP (phl) 544
EMP (phn nph) 116
Too many newsgroups 56
Binary Payload 18
User-issued cancel 17
Binary: non-binary distribution 3
HTML post 3
Binary Image: misplaced gif 1
Too many newsgroups (meow) 1
TOTAL: 11 15772

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
linuxd-out.news.weretis.net 507
newsfeed.neva.ru 72
news.fcku.it 3
TOTAL: 3 582
TOTAL: 1 582

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.fcku.it 29401 1617 18691 2208 0 105 5%23:59:46
2weretis.net 4325 202 3607 0 0 7 4%23:57:28
3neva.ru 29471 146 20041 105 0 106 0%23:59:44
4eternal-september 25215 44 19700 0 0 33 0%23:59:37
5news.stack.nl 2852 0 0 0 0 26147 0%23:59:46
6news.netfront.net 2727 0 0 0 0 25957 0%23:59:44
7vc89.vc.panix.com 2839 0 0 0 0 26147 0%23:59:46
8news.mixmin.net 0 0 0 0 0 0 0%00:10:00
9news.killfile.org 2847 0 0 0 0 26155 0%23:59:46
10etla.org 0 0 0 0 0 23309 0%23:59:46
11news.albasani.net 2865 0 0 0 0 25195 0%23:59:46
12nntp.pasdenom.info 0 0 0 0 0 23280 0%23:57:39
TOTAL: 12 102542 2009 62039 2313 0 176441 1%264:02:48
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.fcku.it4.7 MB6.8 MB11.5 MB0.1 KB/s3.1 KB23:59:46
2neva.ru326.4 KB378.1 KB704.5 KB0.0 KB/s2.8 KB23:59:44
3weretis.net323.4 KB0.0 KB323.4 KB0.0 KB/s1.6 KB23:57:28
4eternal-september187.7 KB0.0 KB187.7 KB0.0 KB/s4.3 KB23:59:37
5news.stack.nl0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:46
6news.netfront.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:44
7vc89.vc.panix.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:46
8news.mixmin.net0.0 KB0.0 KB0.0 KB0.0 KB/s000:10:00
9news.killfile.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:46
10etla.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:46
11news.albasani.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:46
12nntp.pasdenom.info0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:39
TOTAL: 125.5 MB7.2 MB12.7 MB0.0 KB/s3.0 KB264:02:48
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1challenger.nielsenmedia.com 39 2888.5 KB 7 0 006:26:32
TOTAL: 1 39 2888.5 KB 7 0 006:28:03

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.nielsenmedia.com 39 2888.5 KB 7 0 006:26:32
2*.188.110.pools.vodafone-ip.de 146 00.0 KB 0 0 000:01:04
3unresolved 5 00.0 KB 0 0 000:00:26
TOTAL: 3 190 2888.5 KB 7 0 006:28:03

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
challenger.nielsenmedia.com 2.664 0.200 0.00006:26:32
dslb-188-110-184-251.188.110.pools.vodafone-ip.de 7.804 0.656 0.00000:01:04
188.110.184.251 0.208 0.024 0.00000:00:26
122.224.153.122 0.052 0.004 0.00000:00:00
TOTAL: 4 10.728 0.884 0.00006:28:03

Curious NNRP server explorers [Top 20]:

SystemConn
dslb-188-110-184-251.188.110.pools.vodafone-ip.de 146
188.110.184.251 4
122.224.153.122 1
TOTAL: 3 151

NNRP unrecognized commands (by host):

SystemConn
122.224.153.122 1
TOTAL: 1 1

NNRP unrecognized commands (by command):

CommandCount
GET / HTTP/1.0 1
TOTAL: 1 1

NNRP client timeouts [Top 20]:

SystemConnPeer
challenger.nielsenmedia.com 10 0
122.224.153.122 1 1
TOTAL: 2 11 1

Newsgroup request counts (by category):

CategoryCountPct
1comp 28100.0%
TOTAL: 1 28100.0%

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

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