Daily Usenet report for paganini.linuxd.org

May 12 00:00:06 -- May 13 00:00:05

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

May 12 04:27:56 paganini overchan[28959]: input line too long, skipping
May 13 00:00:05 paganini overchan[13080]: 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 83753 46.3%10.4 MB 40.5%
nnrpd 53804 29.7%6.2 MB 24.1%
inn 31527 17.4%7.4 MB 28.8%
innd 11737 6.5%1.7 MB 6.6%
nocem 62 0.0%9.7 KB 0.0%
overchan 3 0.0%0.2 KB 0.0%
controlchan 1 0.0%0.0 KB 0.0%
TOTAL: 7 180887 100.0%25.7 MB100.0%

History cache:

ReasonCount%Count
Positive hits 107916 54.5%
Negative hits 59148 29.9%
Do not exist 30827 15.6%
Cache misses 91 0.0%
TOTAL: 4 197982 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.011 0.0%163 0.000 6.202 36.400
article cleanup00:00:00.213 0.0%30904 0.000 0.007 0.032
article logging00:00:00.710 0.0%31389 0.000 0.023 1.098
article parse00:00:00.704 0.0%57782 0.000 0.012 0.042
article write00:00:48.849 0.1%20279 0.183 2.409 10.830
artlog/artcncl00:00:00.001 0.0%163 0.000 0.006 0.100
data move00:00:00.278 0.0%202568 0.000 0.001 0.061
hisgrep/artcncl00:00:00.029 0.0%162 0.000 0.179 2.000
hishave/artcncl00:00:00.060 0.0%163 0.000 0.368 4.615
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:10.886 0.0%198445 0.015 0.055 0.507
history sync00:00:00.020 0.0%407 0.000 0.049 0.667
history write00:00:29.280 0.0%30903 0.019 0.947 3.430
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
idle23:57:30.301 99.7%201288 233.000 428.492 1341.566
nntp read00:00:01.842 0.0%208660 0.002 0.009 0.053
overview write00:00:21.503 0.0%20279 0.000 1.060 4.127
perl filter00:01:02.859 0.1%30903 1.152 2.034 5.993
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:02.442 0.0%61160 0.004 0.040 1.143
TOTAL: 24:01:08.33624:00:30.988100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.081 0.0%36122 0.000 0.002 0.014
article prepare00:00:00.002 0.0%29760 0.000 0.000 0.007
article read00:00:04.258 0.0%5712 0.000 0.745 22.579
backlog stats00:00:00.219 0.0%312072 0.000 0.001 0.002
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.317 0.0%172094 0.001 0.008 0.020
data write00:00:02.675 0.0%151996 0.006 0.018 0.032
idle23:44:45.019 99.4%312072 99.651 273.927 527.640
status file00:08:24.693 0.6%34881 8.047 14.469 36.127
TOTAL: 23:53:36.68323:53:18.264100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle03:47:51.570 99.9%54287 35.032 251.839600108.333
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:01.118 0.0%110006 0.000 0.010 0.019
readart00:00:00.000 0.0%5 0.000 0.000 0.000
TOTAL: 03:48:10.09203:47:52.688 99.9%----

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 4 43647 16947 25215 1485 38%48:25:54
2newsfeed.neva.ru 148 68606 2476 57262 8868 3%72:12:37
3news.fcku.it 2 7406 932 6216 258 12%23:54:40
4nntp.pasdenom.info 2 21452 43 21393 16 0%24:15:14
5localhost 25 0 0 0 0 0%00:00:00
TOTAL: 5 181 141111 20398 110086 10627 14%168:48:25
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1linuxd-out.news.weretis.net52.3 MB0.0 KB8.0 MB60.2 MB 86%3.3 KB
2newsfeed.neva.ru6.2 MB9.3 KB67.8 MB73.9 MB 8%6.7 KB
3news.fcku.it2.8 MB0.0 KB1.8 MB4.6 MB 60%4.0 KB
4nntp.pasdenom.info142.5 KB0.0 KB138.5 KB280.9 KB 50%4.8 KB
5localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 561.4 MB9.3 KB77.7 MB139.1 MB 44%4.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 12 00:00:06 - 00:59:59 801 4.0% 0.222.4 MB 3.9% 0.68
May 12 01:00:00 - 01:59:59 577 2.8% 0.161.8 MB 2.9% 0.51
May 12 02:00:00 - 02:59:59 535 2.6% 0.151.6 MB 2.6% 0.45
May 12 03:00:00 - 03:59:59 474 2.3% 0.131.5 MB 2.5% 0.44
May 12 04:00:00 - 04:59:59 421 2.1% 0.121.6 MB 2.7% 0.47
May 12 05:00:00 - 05:59:59 385 1.9% 0.111.3 MB 2.1% 0.36
May 12 06:00:00 - 06:59:59 410 2.0% 0.111.3 MB 2.2% 0.38
May 12 07:00:00 - 07:59:59 587 2.9% 0.162.1 MB 3.5% 0.60
May 12 08:00:00 - 08:59:59 709 3.5% 0.202.0 MB 3.3% 0.57
May 12 09:00:00 - 09:59:59 871 4.3% 0.242.8 MB 4.5% 0.78
May 12 10:00:00 - 10:59:59 933 4.6% 0.262.5 MB 4.2% 0.72
May 12 11:00:00 - 11:59:59 953 4.7% 0.262.5 MB 4.1% 0.71
May 12 12:00:00 - 12:59:59 882 4.4% 0.242.9 MB 4.7% 0.82
May 12 13:00:00 - 13:59:59 1092 5.4% 0.303.4 MB 5.6% 0.96
May 12 14:00:00 - 14:59:59 919 4.5% 0.263.2 MB 5.2% 0.90
May 12 15:00:00 - 15:59:59 1025 5.1% 0.282.8 MB 4.6% 0.80
May 12 16:00:00 - 16:59:59 1209 6.0% 0.344.2 MB 6.8% 1.18
May 12 17:00:00 - 17:59:59 1255 6.2% 0.353.4 MB 5.6% 0.97
May 12 18:00:00 - 18:59:59 1308 6.5% 0.363.5 MB 5.8% 1.00
May 12 19:00:00 - 19:59:59 1050 5.2% 0.293.0 MB 4.9% 0.85
May 12 20:00:00 - 20:59:59 1015 5.0% 0.283.1 MB 5.1% 0.88
May 12 21:00:00 - 21:59:59 979 4.8% 0.272.7 MB 4.5% 0.78
May 12 22:00:00 - 22:59:59 924 4.6% 0.262.5 MB 4.2% 0.72
May 12 23:00:00 - 23:59:59 930 4.6% 0.262.7 MB 4.4% 0.76
May 13 00:00:00 - 00:00:05 9 0.0% 1.8042.2 KB 0.1% 8.44
TOTAL: 23:59:59 20253 100.0% 0.2360.8 MB 100.0% 0.72
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 8904 375 0 1 0 0 0 0 8528
2linuxd-out.news.weretis.net 1935 493 0 0 0 0 0 0 1442
3news.fcku.it 251 28 0 0 0 0 0 0 223
4nntp.pasdenom.info 20 1 0 0 0 0 0 0 19
TOTAL: 4 11110 897 0 1 0 0 0 010212

Unwanted newsgroups [Top 20]:

NewsgroupCount
ut.test 104
lada.auto 83
lada.talk 79
it-alt.sport.calcio.juventus 44
gmane.comp.gis.openstreetmap.tagging 36
mpc.lists.freebsd.ports.bugs 29
mozilla.support.firefox 28
it.annunci.commerciali 26
mozilla.dev.platform 25
it.annunci.varie 24
it.annunci.immobiliari 23
spline.eisfair 18
mozilla.dev.security.policy 16
lada.commerce 16
mpc.lists.freebsd.x11 16
it.comp.os.win.windows10 16
gmane.linux.alsa.devel 16
alt.survival 12
gmane.linux.drivers.devicetree 12
mozilla.support.seamonkey 12
TOTAL: 107 897

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 8585
EMP (phn path) 936
EMP (phl) 69
Too many newsgroups 62
Binary Payload 19
User-issued cancel 17
Binary: non-binary distribution 15
EMP (phn nph) 8
User-issued spam cancel 5
Too many newsgroups (meow) 5
HTML post 4
Binary Image: misplaced png 1
Binary Image: misplaced jpg 1
TOTAL: 13 9727

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
linuxd-out.news.weretis.net 456
newsfeed.neva.ru 27
news.fcku.it 2
TOTAL: 3 485
TOTAL: 1 485

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nntp.pasdenom.info 34429 2941 16342 930 0 431 8%23:57:40
2news.fcku.it 24123 1144 16217 1933 0 36 4%23:59:44
3weretis.net 7315 232 6815 0 0 254 3%23:59:47
4neva.ru 25503 41 17482 250 0 25 0%23:59:47
5eternal-september 22089 12 16986 0 0 21 0%23:59:47
6news.netfront.net 2766 0 0 0 0 22972 0%23:59:46
7etla.org 0 0 0 0 0 20253 0%23:59:47
8news.killfile.org 2849 0 0 0 0 23101 0%23:59:47
9news.stack.nl 2859 0 0 0 0 23098 0%23:59:47
10news.mixmin.net 0 0 0 0 0 0 0%00:10:00
11vc89.vc.panix.com 2842 0 0 0 0 23094 0%23:59:47
12news.albasani.net 330 0 0 0 0 20430 0%23:59:47
TOTAL: 12 125105 4370 73842 3113 0 133715 3%264:05:26
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nntp.pasdenom.info9.4 MB2.0 MB11.4 MB0.1 KB/s3.0 KB23:57:40
2news.fcku.it2.9 MB5.5 MB8.4 MB0.1 KB/s2.8 KB23:59:44
3weretis.net409.7 KB0.0 KB409.7 KB0.0 KB/s1.8 KB23:59:47
4neva.ru105.5 KB627.5 KB733.0 KB0.0 KB/s2.5 KB23:59:47
5eternal-september38.6 KB0.0 KB38.6 KB0.0 KB/s3.2 KB23:59:47
6news.netfront.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:46
7etla.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:47
8news.killfile.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:47
9news.stack.nl0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:47
10news.mixmin.net0.0 KB0.0 KB0.0 KB0.0 KB/s000:10:00
11vc89.vc.panix.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:47
12news.albasani.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:47
TOTAL: 1212.9 MB8.1 MB21.0 MB0.0 KB/s2.9 KB264:05:26
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1dslb-088-067-084-037.088.067.pools.vodafone-ip.de 97 39.5 KB 3 0 000:45:51
2challenger.nielsenmedia.com 11 12.5 KB 1 0 002:29:11
347-192-187-101.drr02.clwr.fl.frontiernet.net 2 12.5 KB 1 0 000:33:06
TOTAL: 3 110 514.5 KB 5 0 003:48:09

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.088.067.pools.vodafone-ip.de 97 39.5 KB 3 0 000:45:51
2*.drr02.clwr.fl.frontiernet.net 2 12.5 KB 1 0 000:33:06
3*.nielsenmedia.com 11 12.5 KB 1 0 002:29:11
TOTAL: 3 110 514.5 KB 5 0 003:48:09

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
challenger.nielsenmedia.com 0.572 0.016 0.00002:29:11
dslb-088-067-084-037.088.067.pools.vodafone-ip.de 10.324 2.696 0.00000:45:51
47-192-187-101.drr02.clwr.fl.frontiernet.net 0.180 0.012 0.00000:33:06
TOTAL: 3 11.076 2.724 0.00003:48:09

NNRP client timeouts [Top 20]:

SystemConnPeer
challenger.nielsenmedia.com 4 0
47-192-187-101.drr02.clwr.fl.frontiernet.net 1 0
TOTAL: 2 5 0

Newsgroup request counts (by category):

CategoryCountPct
1comp 2 40.0%
2ger 1 20.0%
3control 1 20.0%
4de 1 20.0%
TOTAL: 4 5100.0%

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

NewsgroupCount
1comp.lang.awk 2
2ger.ct 1
3control.cancel 1
4de.soc.politik.misc 1
TOTAL: 4 5