Daily Usenet report for paganini.linuxd.org

Apr 12 00:00:02 -- Apr 13 00:00:07

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

Apr 12 08:40:45 paganini overchan[13095]: input line too long, skipping
Apr 12 18:43:32 paganini overchan[13095]: input line too long, skipping
Apr 13 00:00:06 paganini overchan[2505]: 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 115620 48.0%14.4 MB 43.4%
nnrpd 65413 27.2%7.5 MB 22.8%
inn 40814 17.0%8.7 MB 26.2%
innd 18808 7.8%2.5 MB 7.5%
nocem 80 0.0%13.7 KB 0.0%
overchan 4 0.0%0.4 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 7 240740 100.0%33.1 MB100.0%

History cache:

ReasonCount%Count
Positive hits 119449 49.0%
Negative hits 84132 34.5%
Do not exist 40082 16.4%
Cache misses 74 0.0%
TOTAL: 4 243737 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.276 0.0%170 0.000 7.506 53.000
article cleanup00:00:00.268 0.0%40277 0.000 0.007 0.021
article logging00:00:01.737 0.0%40680 0.000 0.043 1.985
article parse00:00:01.103 0.0%85764 0.000 0.013 0.046
article write00:02:33.822 0.2%22431 0.234 6.858 34.445
artlog/artcncl00:00:00.001 0.0%163 0.000 0.006 1.000
data move00:00:00.214 0.0%243630 0.000 0.001 0.008
hisgrep/artcncl00:00:00.169 0.0%167 0.000 1.012 6.579
hishave/artcncl00:00:00.065 0.0%170 0.000 0.382 9.333
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:03:43.728 0.3%244995 0.017 0.913 6.026
history sync00:00:00.028 0.0%397 0.000 0.071 0.667
history write00:03:34.521 0.2%40277 0.031 5.326 33.587
hiswrite/artcncl00:00:00.085 0.0%3 28.333 28.333 28.333
idle23:47:34.929 99.1%238557 161.379 359.054 988.158
nntp read00:00:02.019 0.0%254656 0.002 0.008 0.071
overview write00:01:24.591 0.1%22431 0.015 3.771 24.586
perl filter00:01:25.545 0.1%40276 1.117 2.124 3.735
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.204 0.0%67571 0.003 0.018 0.311
TOTAL: 24:01:05.21224:00:25.305100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.119 0.0%38984 0.000 0.003 0.014
article prepare00:00:00.003 0.0%19880 0.000 0.000 0.009
article read00:00:02.674 0.0%4416 0.000 0.606 44.923
backlog stats00:00:00.171 0.0%292428 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.215 0.0%161217 0.002 0.008 0.017
data write00:00:02.612 0.0%139207 0.009 0.019 0.030
idle23:37:25.754 98.9%292428 222.974 290.826 437.341
status file00:16:07.995 1.1%48451 9.582 19.979 143.807
TOTAL: 23:53:54.20023:53:40.543100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle03:58:52.483 99.8%66262 36.986 216.300600127.333
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:01.312 0.0%134710 0.000 0.010 0.020
readart00:00:00.006 0.0%2 0.000 3.000 6.000
TOTAL: 03:59:14.60003:58:53.801 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 48269 19131 27202 1936 39%48:16:30
2newsfeed.neva.ru 151 81473 2915 62750 15808 3%71:49:17
3news.fcku.it 2 7994 364 7530 100 4%23:40:38
4nntp.pasdenom.info 2 21792 39 21751 2 0%24:07:51
5localhost 25 0 0 0 0 0%00:00:00
TOTAL: 5 184 159528 22449 119233 17846 14%167:54:16
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1linuxd-out.news.weretis.net61.2 MB0.0 KB13.6 MB74.8 MB 81%3.6 KB
2newsfeed.neva.ru8.6 MB0.0 KB135.2 MB143.9 MB 6%7.9 KB
3news.fcku.it657.4 KB0.0 KB699.5 KB1.3 MB 48%2.9 KB
4nntp.pasdenom.info99.7 KB0.0 KB115.8 KB215.5 KB 46%5.3 KB
5localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 570.6 MB0.0 KB149.6 MB220.2 MB 32%5.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Apr 12 00:00:02 - 00:59:59 851 3.8% 0.242.6 MB 3.7% 0.74
Apr 12 01:00:00 - 01:59:59 771 3.4% 0.212.3 MB 3.3% 0.66
Apr 12 02:00:00 - 02:59:59 598 2.7% 0.171.7 MB 2.5% 0.49
Apr 12 03:00:00 - 03:59:59 505 2.3% 0.142.4 MB 3.4% 0.69
Apr 12 04:00:00 - 04:59:59 448 2.0% 0.121.4 MB 1.9% 0.39
Apr 12 05:00:00 - 05:59:59 413 1.8% 0.111.2 MB 1.7% 0.35
Apr 12 06:00:00 - 06:59:59 533 2.4% 0.152.0 MB 2.9% 0.57
Apr 12 07:00:00 - 07:59:59 604 2.7% 0.172.0 MB 2.8% 0.57
Apr 12 08:00:00 - 08:59:59 702 3.1% 0.202.1 MB 3.0% 0.59
Apr 12 09:00:00 - 09:59:59 891 4.0% 0.252.6 MB 3.7% 0.75
Apr 12 10:00:00 - 10:59:59 992 4.4% 0.282.6 MB 3.7% 0.75
Apr 12 11:00:00 - 11:59:59 1068 4.8% 0.302.8 MB 4.0% 0.81
Apr 12 12:00:00 - 12:59:59 1047 4.7% 0.292.7 MB 3.8% 0.76
Apr 12 13:00:00 - 13:59:59 1156 5.2% 0.323.6 MB 5.1% 1.03
Apr 12 14:00:00 - 14:59:59 1130 5.0% 0.313.7 MB 5.3% 1.06
Apr 12 15:00:00 - 15:59:59 1246 5.6% 0.354.0 MB 5.6% 1.13
Apr 12 16:00:00 - 16:59:59 1217 5.4% 0.343.5 MB 5.0% 1.00
Apr 12 17:00:00 - 17:59:59 1263 5.6% 0.354.2 MB 6.0% 1.20
Apr 12 18:00:00 - 18:59:59 1237 5.5% 0.344.6 MB 6.6% 1.32
Apr 12 19:00:00 - 19:59:59 1390 6.2% 0.395.4 MB 7.6% 1.52
Apr 12 20:00:00 - 20:59:59 1269 5.7% 0.354.0 MB 5.6% 1.13
Apr 12 21:00:00 - 21:59:59 1054 4.7% 0.293.0 MB 4.2% 0.85
Apr 12 22:00:00 - 22:59:59 1067 4.8% 0.303.1 MB 4.3% 0.87
Apr 12 23:00:00 - 23:59:59 948 4.2% 0.262.9 MB 4.1% 0.82
Apr 13 00:00:00 - 00:00:07 20 0.1% 2.86162.9 KB 0.2% 23.27
TOTAL: 24:00:05 22420 100.0% 0.2670.7 MB 100.0% 0.84
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 15790 406 0 0 1 0 0 015383
2linuxd-out.news.weretis.net 2321 652 0 0 0 0 0 0 1669
3news.fcku.it 111 2 0 0 0 0 0 0 109
4nntp.pasdenom.info 7 3 0 0 0 1 0 0 3
TOTAL: 4 18229 1063 0 0 1 1 0 017164

Unwanted newsgroups [Top 20]:

NewsgroupCount
lada.talk 211
ut.test 93
it-alt.sport.calcio.juventus 90
it.annunci.commerciali 59
alt.windows7.general 43
alt.survival 36
it.annunci.varie 33
it.annunci.immobiliari 31
mpc.lists.freebsd.gecko 30
gmane.linux.alsa.devel 29
mozilla.dev.security.policy 28
mozilla.support.thunderbird 26
it.comp.os.win.windows10 25
lada.auto 23
mpc.lists.freebsd.ports.bugs 21
cakewalk.audio 13
mozilla.general 13
alt.politics 13
gmane.comp.gis.openstreetmap.tagging 10
mozilla.support.seamonkey 10
TOTAL: 116 1063

Supposedly-moderated groups with unmoderated postings [Top 20]:

GroupsCount
it.scienza.astronomia 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 15272
EMP (phn path) 1224
EMP (phn nph) 158
User-issued cancel 37
Too many newsgroups 30
EMP (phl) 15
Binary Payload 13
HTML post 3
User-issued spam cancel 2
Binary: non-binary distribution 2
Binary: misplaced nfo 1
Too many newsgroups (meow) 1
Binary: misplaced sfv 1
TOTAL: 13 16759

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
linuxd-out.news.weretis.net 384
newsfeed.neva.ru 21
TOTAL: 2 405
TOTAL: 1 405

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.fcku.it 28128 1574 18189 2304 0 94 5%23:59:56
2nntp.pasdenom.info 8617 664 3184 100 0 20524 7%23:57:52
3weretis.net 3511 150 3192 0 0 257 4%23:59:59
4eternal-september 22993 26 19302 0 0 8 0%23:59:59
5neva.ru 25982 13 19312 150 0 38 0%23:59:58
6news.killfile.org 2847 0 0 0 0 25266 0%23:59:59
7news.albasani.net 2862 0 0 0 0 24569 0%23:59:59
8etla.org 0 0 0 0 0 22420 0%23:59:59
9vc89.vc.panix.com 2840 0 0 0 0 25259 0%23:59:59
10news.stack.nl 2856 0 0 0 0 25249 0%23:59:59
11news.netfront.net 2771 0 0 0 0 25136 0%23:59:58
12news.mixmin.net 0 0 0 0 0 0 0%00:10:00
TOTAL: 12 103407 2427 63179 2554 0 168820 2%264:07:37
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.fcku.it4.6 MB8.7 MB13.3 MB0.2 KB/s3.5 KB23:59:56
2nntp.pasdenom.info2.1 MB358.0 KB2.5 MB0.0 KB/s3.3 KB23:57:52
3weretis.net186.8 KB0.0 KB186.8 KB0.0 KB/s1.2 KB23:59:59
4eternal-september97.4 KB0.0 KB97.4 KB0.0 KB/s3.7 KB23:59:59
5neva.ru21.5 KB451.5 KB472.9 KB0.0 KB/s2.9 KB23:59:58
6news.killfile.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:59
7news.albasani.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:59
8etla.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:59
9vc89.vc.panix.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:59
10news.stack.nl0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:59
11news.netfront.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:58
12news.mixmin.net0.0 KB0.0 KB0.0 KB0.0 KB/s000:10:00
TOTAL: 127.0 MB9.5 MB16.5 MB0.0 KB/s3.4 KB264:07:37
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1dslb-094-217-142-075.094.217.pools.vodafone-ip.de 118 25.6 KB 2 0 000:50:23
TOTAL: 1 118 25.6 KB 2 0 003:59:14

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.094.217.pools.vodafone-ip.de 118 25.6 KB 2 0 000:50:23
2*.nielsenmedia.com 7 00.0 KB 0 0 002:50:05
3*.drr02.clwr.fl.frontiernet.net 1 00.0 KB 0 0 000:18:46
TOTAL: 3 126 25.6 KB 2 0 003:59:14

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
challenger.nielsenmedia.com 0.360 0.032 0.00002:50:05
dslb-094-217-142-075.094.217.pools.vodafone-ip.de 12.716 3.176 0.00000:50:23
47-192-187-101.drr02.clwr.fl.frontiernet.net 0.064 0.004 0.00000:18:46
TOTAL: 3 13.140 3.212 0.00003:59:14

Curious NNRP server explorers [Top 20]:

SystemConn
challenger.nielsenmedia.com 7
47-192-187-101.drr02.clwr.fl.frontiernet.net 1
TOTAL: 2 8

NNRP client timeouts [Top 20]:

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

Newsgroup request counts (by category):

CategoryCountPct
1de 2100.0%
TOTAL: 1 2100.0%

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

NewsgroupCount
1de.rec.fotografie 1
2de.talk.tagesgeschehen 1
TOTAL: 2 2