Daily Usenet report for paganini.linuxd.org

May 9 00:00:03 -- May 10 00:00:06

Unknown entries from news log file:

First 5 / 5 lines (100.0%)

May 9 00:24:43 paganini overchan[15066]: input line too long, skipping
May 9 00:54:25 paganini overchan[15066]: input line too long, skipping
May 9 13:15:07 paganini overchan[15066]: input line too long, skipping
May 9 20:49:41 paganini pgpverify[10002]: pgpverify: verification failed
May 10 00:00:06 paganini overchan[10283]: 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 101266 44.6%12.5 MB 40.4%
nnrpd 64837 28.6%7.5 MB 24.1%
inn 40636 17.9%8.4 MB 27.1%
innd 20080 8.8%2.6 MB 8.3%
nocem 89 0.0%13.8 KB 0.0%
overchan 5 0.0%0.9 KB 0.0%
controlchan 4 0.0%0.6 KB 0.0%
pgpverify 1 0.0%0.1 KB 0.0%
TOTAL: 8 226918 100.0%31.0 MB100.0%

History cache:

ReasonCount%Count
Positive hits 117275 48.7%
Negative hits 83495 34.7%
Do not exist 39894 16.6%
Cache misses 178 0.1%
TOTAL: 4 240842 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.545 0.0%240 0.000 2.271 25.889
article cleanup00:00:00.278 0.0%40121 0.000 0.007 0.025
article logging00:00:00.381 0.0%40494 0.000 0.009 0.032
article parse00:00:01.068 0.0%87651 0.000 0.012 0.041
article write00:01:27.056 0.1%21243 0.127 4.098 38.010
artlog/artcncl00:00:00.000 0.0%149 0.000 0.000 0.000
data move00:00:00.174 0.0%234942 0.000 0.001 0.003
hisgrep/artcncl00:00:00.168 0.0%240 0.000 0.700 12.750
hishave/artcncl00:00:00.001 0.0%240 0.000 0.004 0.167
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:56.452 0.1%242050 0.016 0.233 3.415
history sync00:00:00.018 0.0%304 0.000 0.059 1.000
history write00:00:36.798 0.0%40121 0.042 0.917 3.939
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:54:06.159 99.6%240484 172.133 357.804 957.829
nntp read00:00:01.864 0.0%250869 0.001 0.007 0.017
overview write00:00:49.830 0.1%21243 0.012 2.346 34.523
perl filter00:01:32.910 0.1%40121 1.141 2.316 5.996
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:03.892 0.0%64162 0.004 0.061 1.701
TOTAL: 24:00:23.11323:59:37.594 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.091 0.0%35796 0.000 0.003 0.015
article prepare00:00:00.001 0.0%27320 0.000 0.000 0.014
article read00:00:03.449 0.0%5386 0.000 0.640 28.833
backlog stats00:00:00.228 0.0%336736 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.436 0.0%184335 0.003 0.008 0.017
data write00:00:02.933 0.0%163250 0.009 0.018 0.032
idle23:40:56.710 99.1%336736 171.715 253.186 423.347
status file00:12:15.187 0.9%42324 8.467 17.370 99.976
TOTAL: 23:53:38.37623:53:20.035100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle05:16:25.033 99.9%65567 37.038 289.552600211.333
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:01.257 0.0%133166 0.000 0.009 0.091
readart00:00:00.051 0.0%10 0.000 5.100 33.000
TOTAL: 05:16:50.72405:16:26.341 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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
grisbi-control@grisbi.org000100
TOTAL000100

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1linuxd-out.news.weretis.net 4 46972 18846 26088 2038 40%48:22:36
2newsfeed.neva.ru 139 82023 2087 63174 16762 2%72:03:09
3news.fcku.it 2 6140 280 5775 85 4%19:11:39
4nntp.pasdenom.info 3 21171 126 20988 57 0%22:14:58
5localhost 25 0 0 0 0 0%00:00:00
TOTAL: 5 173 156306 21339 116025 18942 13%161:52:22
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1linuxd-out.news.weretis.net57.0 MB0.0 KB13.8 MB70.9 MB 80%3.5 KB
2newsfeed.neva.ru5.3 MB0.0 KB144.4 MB149.7 MB 3%8.1 KB
3news.fcku.it1020.2 KB0.0 KB594.0 KB1.6 MB 63%4.4 KB
4nntp.pasdenom.info262.0 KB0.0 KB104.0 KB366.0 KB 71%2.0 KB
5localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 563.6 MB0.0 KB159.0 MB222.5 MB 28%5.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 9 00:00:03 - 00:59:59 780 3.7% 0.222.3 MB 3.6% 0.64
May 9 01:00:00 - 01:59:59 629 3.0% 0.172.1 MB 3.3% 0.59
May 9 02:00:00 - 02:59:59 585 2.8% 0.161.9 MB 2.9% 0.53
May 9 03:00:00 - 03:59:59 697 3.3% 0.192.2 MB 3.4% 0.62
May 9 04:00:00 - 04:59:59 580 2.7% 0.161.8 MB 2.9% 0.52
May 9 05:00:00 - 05:59:59 446 2.1% 0.121.4 MB 2.2% 0.40
May 9 06:00:00 - 06:59:59 520 2.4% 0.141.6 MB 2.5% 0.45
May 9 07:00:00 - 07:59:59 572 2.7% 0.161.7 MB 2.7% 0.49
May 9 08:00:00 - 08:59:59 666 3.1% 0.181.8 MB 2.9% 0.52
May 9 09:00:00 - 09:59:59 858 4.0% 0.242.7 MB 4.3% 0.78
May 9 10:00:00 - 10:59:59 901 4.2% 0.252.7 MB 4.2% 0.76
May 9 11:00:00 - 11:59:59 836 3.9% 0.232.7 MB 4.2% 0.76
May 9 12:00:00 - 12:59:59 1006 4.7% 0.282.6 MB 4.1% 0.74
May 9 13:00:00 - 13:59:59 816 3.8% 0.232.2 MB 3.5% 0.63
May 9 14:00:00 - 14:59:59 1092 5.1% 0.302.9 MB 4.5% 0.82
May 9 15:00:00 - 15:59:59 1014 4.8% 0.283.1 MB 4.8% 0.87
May 9 16:00:00 - 16:59:59 1256 5.9% 0.355.1 MB 8.1% 1.46
May 9 17:00:00 - 17:59:59 1227 5.8% 0.343.7 MB 5.8% 1.05
May 9 18:00:00 - 18:59:59 1134 5.3% 0.323.1 MB 4.9% 0.88
May 9 19:00:00 - 19:59:59 1214 5.7% 0.343.4 MB 5.4% 0.97
May 9 20:00:00 - 20:59:59 1243 5.8% 0.354.0 MB 6.3% 1.13
May 9 21:00:00 - 21:59:59 1084 5.1% 0.302.9 MB 4.5% 0.82
May 9 22:00:00 - 22:59:59 1036 4.9% 0.292.6 MB 4.1% 0.74
May 9 23:00:00 - 23:59:59 1034 4.9% 0.292.9 MB 4.6% 0.82
May 10 00:00:00 - 00:00:06 29 0.1% 4.83115.9 KB 0.2% 19.31
TOTAL: 24:00:03 21255 100.0% 0.2563.4 MB 100.0% 0.75
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 16692 287 0 0 0 0 0 016405
2linuxd-out.news.weretis.net 2387 448 0 0 0 0 0 0 1939
3news.fcku.it 132 34 0 0 0 0 0 0 98
4nntp.pasdenom.info 2 0 0 0 0 0 0 0 2
TOTAL: 4 19213 769 0 0 0 0 0 018444

Unwanted newsgroups [Top 20]:

NewsgroupCount
ut.test 87
it-alt.sport.calcio.juventus 81
lada.talk 73
mpc.lists.freebsd.ports.bugs 43
it.annunci.varie 28
mozilla.dev.platform 27
it.annunci.commerciali 27
mozilla.support.thunderbird 26
spline.eisfair 24
it.annunci.immobiliari 23
gmane.linux.alsa.devel 21
lada.auto 20
it.comp.os.win.windows10 20
cakewalk.audio 18
mpc.lists.freebsd.gnome 18
lada.photo 15
mozilla.dev.security.policy 13
mozilla.general 11
alt.survival 10
alt.windows7.general 10
TOTAL: 109 769

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 16259
EMP (phn path) 1518
EMP (phl) 110
EMP (phn nph) 85
Too many newsgroups 46
Binary Payload 21
User-issued cancel 18
Binary: non-binary distribution 5
HTML post 4
User-issued spam cancel 3
Too many newsgroups (low_xpost) 2
Too many newsgroups (meow) 1
TOTAL: 12 18072

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
linuxd-out.news.weretis.net 350
newsfeed.neva.ru 21
news.fcku.it 1
TOTAL: 3 372
TOTAL: 1 372

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nntp.pasdenom.info 36207 2363 18050 760 0 438 6%23:57:48
2news.fcku.it 27252 1316 17496 2113 0 48 4%23:59:54
3weretis.net 2644 118 2367 0 0 10 4%23:59:55
4neva.ru 26753 21 18936 128 0 38 0%23:59:55
5eternal-september 23275 19 18018 0 0 23 0%23:59:55
6news.killfile.org 2845 0 0 0 0 24099 0%23:59:55
7etla.org 0 0 0 0 0 21255 0%23:59:55
8news.netfront.net 2765 0 0 0 0 23983 0%23:59:54
9news.albasani.net 2850 0 0 0 0 23201 0%23:59:55
10news.stack.nl 2849 0 0 0 0 24089 0%23:59:55
11news.mixmin.net 0 0 0 0 0 0 0%00:10:00
12vc89.vc.panix.com 2839 0 0 0 0 24093 0%23:59:55
TOTAL: 12 130279 3837 74867 3001 0 141277 2%264:06:56
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nntp.pasdenom.info8.0 MB1.8 MB9.8 MB0.1 KB/s3.2 KB23:57:48
2news.fcku.it3.7 MB6.6 MB10.3 MB0.1 KB/s3.1 KB23:59:54
3weretis.net216.7 KB0.0 KB216.7 KB0.0 KB/s1.8 KB23:59:55
4eternal-september87.5 KB0.0 KB87.5 KB0.0 KB/s4.6 KB23:59:55
5neva.ru64.6 KB460.1 KB524.7 KB0.0 KB/s3.5 KB23:59:55
6news.killfile.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:55
7etla.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:55
8news.netfront.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:54
9news.albasani.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:55
10news.stack.nl0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:55
11news.mixmin.net0.0 KB0.0 KB0.0 KB0.0 KB/s000:10:00
12vc89.vc.panix.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:55
TOTAL: 1212.0 MB8.9 MB20.9 MB0.0 KB/s3.1 KB264:06:56
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1challenger.nielsenmedia.com 11 722.3 KB 5 0 003:15:38
2dslb-088-067-084-037.088.067.pools.vodafone-ip.de 117 23.4 KB 2 0 000:57:10
347-192-187-101.drr02.clwr.fl.frontiernet.net 4 13.3 KB 1 0 001:04:01
TOTAL: 3 132 1029.0 KB 8 0 005:16:50

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.nielsenmedia.com 11 722.3 KB 5 0 003:15:38
2*.088.067.pools.vodafone-ip.de 117 23.4 KB 2 0 000:57:10
3*.drr02.clwr.fl.frontiernet.net 4 13.3 KB 1 0 001:04:01
TOTAL: 3 132 1029.0 KB 8 0 005:16:50

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
challenger.nielsenmedia.com 0.752 0.044 0.00003:15:38
47-192-187-101.drr02.clwr.fl.frontiernet.net 0.272 0.024 0.00001:04:01
dslb-088-067-084-037.088.067.pools.vodafone-ip.de 12.684 3.312 0.00000:57:10
TOTAL: 3 13.708 3.380 0.00005:16:50

NNRP client timeouts [Top 20]:

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

Newsgroup request counts (by category):

CategoryCountPct
1comp 8 80.0%
2de 2 20.0%
TOTAL: 2 10100.0%

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

NewsgroupCount
1comp.lang.awk 8
2de.test 1
3de.soc.kontakte.misc 1
TOTAL: 3 10