Daily Usenet report for paganini.linuxd.org

Mar 17 00:00:02 -- Mar 18 00:00:02

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

Mar 17 13:10:01 paganini pgpverify[29853]: pgpverify: verification failed
Mar 17 19:51:09 paganini overchan[30971]: input line too long, skipping
Mar 18 00:00:02 paganini overchan[12061]: 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 101152 63.2%12.6 MB 52.7%
inn 41105 25.7%9.0 MB 37.7%
innd 17262 10.8%2.2 MB 9.3%
nnrpd 435 0.3%62.1 KB 0.3%
nocem 84 0.1%14.6 KB 0.1%
controlchan 4 0.0%0.5 KB 0.0%
overchan 3 0.0%0.3 KB 0.0%
pgpverify 1 0.0%0.2 KB 0.0%
TOTAL: 8 160046 100.0%24.0 MB100.0%

History cache:

ReasonCount%Count
Positive hits 133327 53.6%
Negative hits 74950 30.1%
Do not exist 40299 16.2%
Cache misses 76 0.0%
TOTAL: 4 248652 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.669 0.0%178 0.000 3.758 26.833
article cleanup00:00:00.257 0.0%40444 0.000 0.006 0.026
article logging00:00:00.771 0.0%40995 0.000 0.019 0.562
article parse00:00:01.124 0.0%83922 0.000 0.013 0.041
article write00:00:53.841 0.1%23923 0.105 2.251 12.467
artlog/artcncl00:00:00.001 0.0%168 0.000 0.006 0.100
data move00:00:00.174 0.0%256490 0.000 0.001 0.004
hisgrep/artcncl00:00:00.002 0.0%178 0.000 0.011 0.077
hishave/artcncl00:00:00.003 0.0%178 0.000 0.017 0.250
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:12.790 0.0%249592 0.015 0.051 0.262
history sync00:00:00.034 0.0%392 0.000 0.087 5.667
history write00:00:39.651 0.0%40444 0.029 0.980 4.904
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:56:49.605 99.7%252488 151.228 341.440 1279.307
nntp read00:00:01.821 0.0%261462 0.001 0.007 0.019
overview write00:00:24.788 0.0%23923 0.008 1.036 6.703
perl filter00:01:25.469 0.1%40444 1.000 2.113 16.774
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.228 0.0%71952 0.000 0.017 0.053
TOTAL: 24:01:04.17424:00:32.228100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.099 0.0%38685 0.000 0.003 0.016
article prepare00:00:00.004 0.0%48244 0.000 0.000 0.005
article read00:00:02.486 0.0%9159 0.000 0.271 7.325
backlog stats00:00:00.259 0.0%381190 0.000 0.001 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.588 0.0%209250 0.003 0.008 0.021
data write00:00:03.190 0.0%185812 0.009 0.017 0.040
idle23:42:25.803 99.2%381190 153.184 223.893 453.596
status file00:10:34.706 0.7%42266 6.997 15.017 25.360
TOTAL: 23:53:20.69323:53:08.135100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle03:48:21.840 99.9%375 27.333 36538.240600126.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.008 0.0%980 0.000 0.008 0.167
readart00:00:00.002 0.0%4 0.500 0.500 0.500
TOTAL: 03:48:31.39803:48:21.850 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
newsmaster@carnet.hr000100
TOTAL000100

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1linuxd-out.news.weretis.net 4 54328 20440 30985 2903 37%48:22:00
2newsfeed.neva.ru 143 90197 3053 73623 13521 3%72:09:33
3news.fcku.it 2 9292 505 8618 169 5%30:04:45
4nntp.pasdenom.info 3 22823 42 22778 3 0%24:24:41
5localhost 25 0 0 0 0 0%00:00:00
TOTAL: 5 177 176640 24040 136004 16596 13%175:00:59
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1linuxd-out.news.weretis.net63.3 MB0.0 KB24.5 MB87.8 MB 72%3.9 KB
2newsfeed.neva.ru8.0 MB0.0 KB116.0 MB124.0 MB 6%7.7 KB
3news.fcku.it1.7 MB0.0 KB488.8 KB2.2 MB 78%3.4 KB
4nntp.pasdenom.info99.8 KB0.0 KB143.3 KB243.1 KB 41%5.4 KB
5localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 573.2 MB0.0 KB141.1 MB214.3 MB 34%5.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Mar 17 00:00:02 - 00:59:59 793 3.3% 0.222.8 MB 3.8% 0.80
Mar 17 01:00:00 - 01:59:59 695 2.9% 0.192.1 MB 2.9% 0.60
Mar 17 02:00:00 - 02:59:59 625 2.6% 0.172.0 MB 2.8% 0.58
Mar 17 03:00:00 - 03:59:59 648 2.7% 0.183.3 MB 4.5% 0.93
Mar 17 04:00:00 - 04:59:59 450 1.9% 0.121.4 MB 1.9% 0.40
Mar 17 05:00:00 - 05:59:59 461 1.9% 0.131.6 MB 2.1% 0.44
Mar 17 06:00:00 - 06:59:59 511 2.1% 0.141.6 MB 2.1% 0.44
Mar 17 07:00:00 - 07:59:59 600 2.5% 0.172.1 MB 2.8% 0.58
Mar 17 08:00:00 - 08:59:59 658 2.8% 0.181.9 MB 2.6% 0.53
Mar 17 09:00:00 - 09:59:59 994 4.2% 0.283.0 MB 4.2% 0.86
Mar 17 10:00:00 - 10:59:59 1045 4.4% 0.292.8 MB 3.8% 0.78
Mar 17 11:00:00 - 11:59:59 1134 4.7% 0.323.1 MB 4.3% 0.88
Mar 17 12:00:00 - 12:59:59 1154 4.8% 0.322.8 MB 3.9% 0.81
Mar 17 13:00:00 - 13:59:59 1010 4.2% 0.282.6 MB 3.6% 0.75
Mar 17 14:00:00 - 14:59:59 1267 5.3% 0.353.9 MB 5.4% 1.12
Mar 17 15:00:00 - 15:59:59 1315 5.5% 0.373.3 MB 4.6% 0.94
Mar 17 16:00:00 - 16:59:59 1387 5.8% 0.393.7 MB 5.2% 1.07
Mar 17 17:00:00 - 17:59:59 1484 6.2% 0.413.9 MB 5.3% 1.10
Mar 17 18:00:00 - 18:59:59 1451 6.1% 0.404.0 MB 5.5% 1.14
Mar 17 19:00:00 - 19:59:59 1347 5.6% 0.374.2 MB 5.8% 1.21
Mar 17 20:00:00 - 20:59:59 1407 5.9% 0.394.1 MB 5.6% 1.17
Mar 17 21:00:00 - 21:59:59 1227 5.1% 0.343.7 MB 5.1% 1.06
Mar 17 22:00:00 - 22:59:59 1110 4.6% 0.314.0 MB 5.5% 1.14
Mar 17 23:00:00 - 23:59:59 1114 4.7% 0.314.8 MB 6.5% 1.35
Mar 18 00:00:00 - 00:00:02 3 0.0% 1.509.6 KB 0.0% 4.79
TOTAL: 24:00:00 23890 100.0% 0.2872.7 MB 100.0% 0.86
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 13503 546 0 0 0 0 0 012957
2linuxd-out.news.weretis.net 3426 725 0 0 0 0 0 0 2701
3news.fcku.it 113 4 0 0 0 0 0 0 109
4nntp.pasdenom.info 5 0 0 0 0 0 0 0 5
TOTAL: 4 17047 1275 0 0 0 0 0 015772

Unwanted newsgroups [Top 20]:

NewsgroupCount
lada.talk 193
ut.test 155
it-alt.sport.calcio.juventus 125
mozilla.general 74
mpc.lists.nanog 56
mozilla.dev.platform 49
lada.auto 36
mpc.lists.freebsd.ports.bugs 35
it.comp.os.win.windows10 35
it.annunci.immobiliari 35
it.annunci.varie 33
it.annunci.commerciali 31
mozilla.support.firefox 26
mozilla.dev.servo 21
alt.survival 20
gmane.linux.alsa.devel 20
gmane.comp.gis.openstreetmap.imports 15
gmane.comp.gis.openstreetmap.tagging 15
alt.politics.scorched-earth 13
mozilla.dev.security.policy 12
TOTAL: 115 1275

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 12556
EMP (phn path) 2378
EMP (phr path) 66
Too many newsgroups 49
User-issued cancel 41
EMP (phn nph) 40
Binary Payload 39
EMP (phl) 35
Too many newsgroups (meow) 7
HTML post 5
Binary: non-binary distribution 4
Binary: misplaced pdf 2
Too many newsgroups (low_xpost) 1
TOTAL: 13 15223

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
linuxd-out.news.weretis.net 516
newsfeed.neva.ru 30
news.fcku.it 3
TOTAL: 3 549
TOTAL: 1 549

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nntp.pasdenom.info 40955 3290 19550 974 0 524 8%23:57:48
2news.fcku.it 30514 3184 16072 4247 0 88 10%23:59:55
3weretis.net 3623 109 3369 0 0 4 3%23:59:55
4eternal-september 28117 74 20635 2 0 161 0%23:59:55
5neva.ru 31404 72 20594 160 0 42 0%23:59:55
6news.stack.nl 2851 0 0 0 0 26722 0%23:59:55
7news.albasani.net 2859 0 0 0 0 25688 0%23:59:55
8news.mixmin.net 0 0 0 0 0 0 0%00:10:00
9news.killfile.org 2848 0 0 0 0 26737 0%23:59:55
10vc89.vc.panix.com 2834 0 0 0 0 26723 0%23:59:55
11news.netfront.net 2741 0 0 0 0 26565 0%23:59:54
12etla.org 0 0 0 0 0 23890 0%23:59:55
TOTAL: 12 148746 6729 80220 5383 0 157144 4%264:06:57
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nntp.pasdenom.info10.7 MB3.2 MB13.9 MB0.2 KB/s3.3 KB23:57:48
2news.fcku.it8.8 MB13.7 MB22.5 MB0.3 KB/s3.1 KB23:59:55
3neva.ru299.6 KB698.8 KB998.4 KB0.0 KB/s4.3 KB23:59:55
4eternal-september284.3 KB30.5 KB314.8 KB0.0 KB/s4.1 KB23:59:55
5weretis.net175.3 KB0.0 KB175.3 KB0.0 KB/s1.6 KB23:59:55
6news.stack.nl0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:55
7news.albasani.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:55
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:55
10vc89.vc.panix.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:55
11news.netfront.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:54
12etla.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:55
TOTAL: 1220.2 MB17.7 MB37.9 MB0.0 KB/s3.2 KB264:06:57
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1challenger.nielsenmedia.com 24 411.0 KB 2 0 003:48:15
TOTAL: 1 24 411.0 KB 2 0 003:48:31

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.nielsenmedia.com 24 411.0 KB 2 0 003:48:15
2*.092.073.pools.vodafone-ip.de 107 00.0 KB 0 0 000:00:15
TOTAL: 2 131 411.0 KB 2 0 003:48:31

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
challenger.nielsenmedia.com 1.544 0.068 0.00003:48:15
dslb-092-073-008-096.092.073.pools.vodafone-ip.de 5.664 0.340 0.00000:00:15
TOTAL: 2 7.208 0.408 0.00003:48:31

Curious NNRP server explorers [Top 20]:

SystemConn
dslb-092-073-008-096.092.073.pools.vodafone-ip.de 107
TOTAL: 1 107

NNRP client timeouts [Top 20]:

SystemConnPeer
challenger.nielsenmedia.com 7 1
TOTAL: 1 7 1

Newsgroup request counts (by category):

CategoryCountPct
1comp 4100.0%
TOTAL: 1 4100.0%

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

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