Daily Usenet report for paganini.linuxd.org

May 8 00:00:02 -- May 9 00:00:03

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

May 8 04:50:58 paganini overchan[3222]: input line too long, skipping
May 8 18:26:26 paganini overchan[3222]: input line too long, skipping
May 9 00:00:03 paganini overchan[15066]: 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 101464 50.2%12.5 MB 43.8%
nnrpd 51071 25.3%5.9 MB 20.6%
inn 35423 17.5%8.2 MB 28.5%
innd 14149 7.0%2.0 MB 7.1%
nocem 56 0.0%8.8 KB 0.0%
overchan 4 0.0%0.5 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 7 202168 100.0%28.6 MB100.0%

History cache:

ReasonCount%Count
Positive hits 121367 54.8%
Negative hits 65378 29.5%
Do not exist 34724 15.7%
Cache misses 79 0.0%
TOTAL: 4 221548 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.621 0.0%166 0.000 3.741 55.700
article cleanup00:00:00.249 0.0%34923 0.000 0.007 0.031
article logging00:00:00.309 0.0%35278 0.000 0.009 0.026
article parse00:00:00.929 0.0%64500 0.000 0.014 0.036
article write00:01:00.498 0.1%22244 0.196 2.720 37.854
artlog/artcncl00:00:00.003 0.0%155 0.000 0.019 1.000
data move00:00:00.122 0.0%227025 0.000 0.001 0.002
hisgrep/artcncl00:00:00.003 0.0%164 0.000 0.018 0.056
hishave/artcncl00:00:00.000 0.0%166 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:10.852 0.0%222799 0.012 0.049 0.274
history sync00:00:00.026 0.0%309 0.000 0.084 0.500
history write00:00:34.385 0.0%34900 0.040 0.985 4.169
hiswrite/artcncl00:00:00.000 0.0%2 0.000 0.000 0.000
idle23:56:21.110 99.7%225468 169.423 382.232 1155.328
nntp read00:00:01.704 0.0%233292 0.002 0.007 0.016
overview write00:00:23.021 0.0%22244 0.000 1.035 8.276
perl filter00:01:09.220 0.1%34899 0.865 1.983 3.637
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.496 0.0%66869 0.000 0.022 0.047
TOTAL: 24:00:21.57323:59:44.548100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.099 0.0%36843 0.000 0.003 0.012
article prepare00:00:00.006 0.0%34900 0.000 0.000 0.005
article read00:00:01.996 0.0%6877 0.000 0.290 7.514
backlog stats00:00:00.230 0.0%349216 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.566 0.0%191880 0.002 0.008 0.024
data write00:00:02.954 0.0%169968 0.007 0.017 0.028
idle23:42:37.249 99.3%349216 168.850 244.425 457.164
status file00:09:55.677 0.7%42391 6.468 14.052 25.037
TOTAL: 23:53:03.05123:52:39.777100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle04:22:28.540 99.8%51614 37.563 305.121600363.333
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:01.047 0.0%104804 0.000 0.010 0.167
readart00:00:00.098 0.0%18 0.000 5.444 16.000
TOTAL: 04:22:58.17104:22:29.685 99.8%----

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 48785 19295 27444 2046 39%47:46:59
2newsfeed.neva.ru 147 77505 2248 64818 10439 2%71:59:47
3news.fcku.it 2 9836 495 9190 151 5%26:51:28
4nntp.pasdenom.info 4 19445 191 19249 5 0%26:03:41
5localhost 25 0 0 0 0 0%00:00:00
TOTAL: 5 182 155571 22229 120701 12641 14%172:41:55
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1linuxd-out.news.weretis.net58.8 MB7.1 KB12.3 MB71.0 MB 82%3.4 KB
2newsfeed.neva.ru6.5 MB43.6 KB76.6 MB83.2 MB 7%6.7 KB
3news.fcku.it1.1 MB0.0 KB1.9 MB3.0 MB 37%4.8 KB
4nntp.pasdenom.info390.4 KB0.0 KB140.3 KB530.7 KB 73%2.7 KB
5localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 566.8 MB50.7 KB90.9 MB157.8 MB 42%4.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 8 00:00:02 - 00:59:59 930 4.2% 0.262.7 MB 4.1% 0.78
May 8 01:00:00 - 01:59:59 591 2.7% 0.161.7 MB 2.6% 0.49
May 8 02:00:00 - 02:59:59 428 1.9% 0.121.4 MB 2.1% 0.40
May 8 03:00:00 - 03:59:59 423 1.9% 0.121.4 MB 2.1% 0.40
May 8 04:00:00 - 04:59:59 389 1.8% 0.111.4 MB 2.1% 0.39
May 8 05:00:00 - 05:59:59 514 2.3% 0.141.7 MB 2.6% 0.49
May 8 06:00:00 - 06:59:59 500 2.3% 0.141.6 MB 2.4% 0.45
May 8 07:00:00 - 07:59:59 564 2.5% 0.162.2 MB 3.3% 0.63
May 8 08:00:00 - 08:59:59 639 2.9% 0.181.9 MB 2.8% 0.54
May 8 09:00:00 - 09:59:59 899 4.1% 0.252.8 MB 4.2% 0.79
May 8 10:00:00 - 10:59:59 1068 4.8% 0.303.6 MB 5.4% 1.02
May 8 11:00:00 - 11:59:59 1152 5.2% 0.323.2 MB 4.8% 0.92
May 8 12:00:00 - 12:59:59 1015 4.6% 0.282.9 MB 4.4% 0.83
May 8 13:00:00 - 13:59:59 986 4.4% 0.272.7 MB 4.0% 0.77
May 8 14:00:00 - 14:59:59 1065 4.8% 0.302.9 MB 4.4% 0.84
May 8 15:00:00 - 15:59:59 1175 5.3% 0.333.3 MB 5.0% 0.95
May 8 16:00:00 - 16:59:59 1321 6.0% 0.373.8 MB 5.6% 1.07
May 8 17:00:00 - 17:59:59 1319 5.9% 0.373.9 MB 5.8% 1.11
May 8 18:00:00 - 18:59:59 1411 6.4% 0.394.6 MB 7.0% 1.32
May 8 19:00:00 - 19:59:59 1348 6.1% 0.373.7 MB 5.5% 1.05
May 8 20:00:00 - 20:59:59 1161 5.2% 0.323.2 MB 4.8% 0.91
May 8 21:00:00 - 21:59:59 1138 5.1% 0.323.3 MB 5.0% 0.94
May 8 22:00:00 - 22:59:59 1064 4.8% 0.303.4 MB 5.2% 0.98
May 8 23:00:00 - 23:59:59 1078 4.9% 0.303.2 MB 4.7% 0.90
May 9 00:00:00 - 00:00:03 13 0.1% 4.3363.4 KB 0.1% 21.12
TOTAL: 24:00:01 22191 100.0% 0.2666.8 MB 100.0% 0.79
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 10509 221 0 20 0 0 0 010268
2linuxd-out.news.weretis.net 2376 370 0 3 0 0 0 0 2003
3news.fcku.it 150 8 0 0 0 0 0 0 142
4nntp.pasdenom.info 59 0 0 0 0 1 0 0 58
TOTAL: 4 13094 599 0 23 0 1 0 012471

Unwanted newsgroups [Top 20]:

NewsgroupCount
ut.test 102
lada.talk 53
it.comp.os.win.windows10 49
it-alt.sport.calcio.juventus 29
spline.eisfair 29
alt.windows7.general 28
mozilla.dev.security.policy 25
mozilla.dev.tech.network 24
cakewalk.audio 13
alt.pl.nieruchomosci.gielda 12
mozilla.support.firefox 11
mpc.lists.freebsd.gnome 10
spline.fli4l 10
mozilla.dev.platform 9
alt.survival 9
mozilla.support.thunderbird 8
oesterreich.tratsch 8
lada.photo 8
mozilla.support.seamonkey 7
alt.politics 6
TOTAL: 99 599

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 10807
EMP (phn path) 964
EMP (phn nph) 173
EMP (phl) 75
Too many newsgroups 51
User-issued cancel 19
Binary Payload 15
Binary Image: misplaced jpg 5
HTML post 3
Binary: non-binary distribution 2
Too many newsgroups (meow) 2
HTML Multipart without Text/Plain. 1
TOTAL: 12 12117

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nntp.pasdenom.info 36625 3955 17031 1087 0 506 10%23:57:44
2news.fcku.it 28749 1346 18455 1994 0 44 4%23:59:49
3weretis.net 2936 150 2577 0 0 31 5%23:46:51
4eternal-september 24133 30 18712 0 0 23 0%23:59:51
5neva.ru 28625 20 19736 186 0 45 0%23:59:43
6news.stack.nl 2855 0 0 0 0 25034 0%23:59:51
7etla.org 0 0 0 0 0 22190 0%23:59:51
8vc89.vc.panix.com 2842 0 0 0 0 25031 0%23:59:51
9news.killfile.org 2851 0 0 0 0 25040 0%23:59:51
10news.mixmin.net 0 0 0 0 0 0 0%00:10:00
11news.netfront.net 2765 0 0 0 0 24894 0%23:59:51
12news.albasani.net 2860 0 0 0 0 24292 0%23:59:51
TOTAL: 12 135241 5501 76511 3267 0 147130 4%263:53:04
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nntp.pasdenom.info12.7 MB2.9 MB15.6 MB0.2 KB/s3.2 KB23:57:44
2news.fcku.it3.8 MB6.5 MB10.4 MB0.1 KB/s3.2 KB23:59:49
3weretis.net263.7 KB0.0 KB263.7 KB0.0 KB/s1.8 KB23:46:51
4neva.ru220.3 KB457.7 KB678.0 KB0.0 KB/s3.3 KB23:59:43
5eternal-september126.7 KB0.0 KB126.7 KB0.0 KB/s4.2 KB23:59:51
6news.stack.nl0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:51
7etla.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:51
8vc89.vc.panix.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:51
9news.killfile.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:51
10news.mixmin.net0.0 KB0.0 KB0.0 KB0.0 KB/s000:10:00
11news.netfront.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:51
12news.albasani.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:51
TOTAL: 1217.1 MB9.9 MB27.0 MB0.0 KB/s3.2 KB263:53:04
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1challenger.nielsenmedia.com 10 1053.7 KB 3 0 002:16:45
2dslb-188-099-023-198.188.099.pools.vodafone-ip.de 37 47.5 KB 1 0 000:16:22
347-192-187-101.drr02.clwr.fl.frontiernet.net 9 26.5 KB 1 0 001:19:54
4dslb-088-067-084-037.088.067.pools.vodafone-ip.de 55 22.8 KB 2 0 000:29:56
TOTAL: 4 111 1870.5 KB 7 0 004:22:57

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.nielsenmedia.com 10 1053.7 KB 3 0 002:16:45
2*.188.099.pools.vodafone-ip.de 37 47.5 KB 1 0 000:16:22
3*.088.067.pools.vodafone-ip.de 55 22.8 KB 2 0 000:29:56
4*.drr02.clwr.fl.frontiernet.net 9 26.5 KB 1 0 001:19:54
TOTAL: 4 111 1870.5 KB 7 0 004:22:57

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
challenger.nielsenmedia.com 0.724 0.052 0.00002:16:45
47-192-187-101.drr02.clwr.fl.frontiernet.net 0.556 0.040 0.00001:19:54
dslb-088-067-084-037.088.067.pools.vodafone-ip.de 5.964 1.428 0.00000:29:56
dslb-188-099-023-198.188.099.pools.vodafone-ip.de 3.860 1.100 0.00000:16:22
TOTAL: 4 11.104 2.620 0.00004:22:57

NNRP client timeouts [Top 20]:

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

Newsgroup request counts (by category):

CategoryCountPct
1comp 12 66.7%
2de 6 33.3%
TOTAL: 2 18100.0%

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

NewsgroupCount
1comp.lang.awk 12
2de.talk.tagesgeschehen 4
3de.rec.garten 1
4de.rec.fotografie 1
TOTAL: 4 18