Daily Usenet report for paganini.linuxd.org

May 6 00:00:02 -- May 7 00:00:02

Unknown entries from news log file:

First 5 / 5 lines (100.0%)

May 6 00:55:14 paganini overchan[11379]: input line too long, skipping
May 6 01:55:44 paganini overchan[11379]: input line too long, skipping
May 6 05:37:59 paganini overchan[11379]: input line too long, skipping
May 6 22:31:22 paganini overchan[11379]: input line too long, skipping
May 7 00:00:02 paganini overchan[24095]: 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 101415 51.0%12.6 MB 45.3%
nnrpd 61051 30.7%7.0 MB 25.4%
inn 26661 13.4%6.5 MB 23.5%
innd 9510 4.8%1.6 MB 5.8%
nocem 47 0.0%8.3 KB 0.0%
overchan 6 0.0%1.0 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 7 198691 100.0%27.8 MB100.0%

History cache:

ReasonCount%Count
Positive hits 95367 57.0%
Negative hits 45629 27.3%
Do not exist 26152 15.6%
Cache misses 60 0.0%
TOTAL: 4 167208 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.468 0.0%142 0.000 3.296 74.000
article cleanup00:00:00.196 0.0%26265 0.000 0.007 0.040
article logging00:00:00.218 0.0%26532 0.000 0.008 0.039
article parse00:00:00.561 0.0%39882 0.000 0.014 0.040
article write00:00:49.527 0.1%18112 0.109 2.734 41.900
artlog/artcncl00:00:00.001 0.0%142 0.000 0.007 0.333
data move00:00:00.096 0.0%178248 0.000 0.001 0.004
hisgrep/artcncl00:00:00.003 0.0%141 0.000 0.021 0.200
hishave/artcncl00:00:00.001 0.0%142 0.000 0.007 0.056
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:07.979 0.0%167880 0.014 0.048 0.512
history sync00:00:00.072 0.0%299 0.000 0.241 16.333
history write00:00:28.731 0.0%26265 0.027 1.094 6.861
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
idle23:57:01.038 99.8%174904 281.461 492.962 1229.170
nntp read00:00:01.296 0.0%179610 0.000 0.007 0.017
overview write00:00:16.790 0.0%18112 0.000 0.927 4.864
perl filter00:00:55.571 0.1%26265 1.228 2.116 10.022
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.132 0.0%54502 0.000 0.021 0.052
TOTAL: 24:00:18.03023:59:43.680100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.089 0.0%32376 0.000 0.003 0.013
article prepare00:00:00.004 0.0%36476 0.000 0.000 0.005
article read00:00:01.561 0.0%7212 0.000 0.216 3.658
backlog stats00:00:00.205 0.0%311193 0.000 0.001 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.352 0.0%167497 0.002 0.008 0.019
data write00:00:02.910 0.0%149493 0.009 0.019 0.038
idle23:43:35.717 99.3%311193 184.949 274.478 455.819
status file00:09:53.083 0.7%42399 9.412 13.988 27.507
TOTAL: 23:53:52.45323:53:34.921100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle05:03:45.592 99.8%61612 36.845 295.812600445.333
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:01.250 0.0%124912 0.000 0.010 0.167
readart00:00:00.034 0.0%7 0.000 4.857 34.000
TOTAL: 05:04:17.97505:03:46.876 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 37917 15857 20926 1134 41%48:01:22
2newsfeed.neva.ru 146 60761 1799 52164 6798 2%71:54:14
3news.fcku.it 1 5679 364 5127 188 6%24:12:56
4nntp.pasdenom.info 2 20714 43 20662 9 0%23:38:05
5localhost 25 0 0 0 0 0%00:00:00
TOTAL: 5 178 125071 18063 98879 8129 14%167:46:37
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1linuxd-out.news.weretis.net61.1 MB0.0 KB4.8 MB65.9 MB 92%4.0 KB
2newsfeed.neva.ru4.7 MB0.0 KB26.6 MB31.4 MB 15%3.7 KB
3news.fcku.it1.1 MB0.0 KB2.6 MB3.7 MB 30%6.9 KB
4nntp.pasdenom.info99.6 KB0.0 KB257.2 KB356.8 KB 27%6.9 KB
5localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 567.1 MB0.0 KB34.3 MB101.4 MB 66%4.0 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 6 00:00:02 - 00:59:59 708 3.9% 0.202.5 MB 3.7% 0.71
May 6 01:00:00 - 01:59:59 690 3.8% 0.192.2 MB 3.2% 0.62
May 6 02:00:00 - 02:59:59 532 2.9% 0.151.9 MB 2.8% 0.53
May 6 03:00:00 - 03:59:59 504 2.8% 0.141.5 MB 2.3% 0.44
May 6 04:00:00 - 04:59:59 409 2.3% 0.111.2 MB 1.8% 0.35
May 6 05:00:00 - 05:59:59 384 2.1% 0.111.2 MB 1.8% 0.35
May 6 06:00:00 - 06:59:59 388 2.1% 0.111.6 MB 2.4% 0.46
May 6 07:00:00 - 07:59:59 426 2.4% 0.121.4 MB 2.1% 0.40
May 6 08:00:00 - 08:59:59 466 2.6% 0.131.3 MB 2.0% 0.38
May 6 09:00:00 - 09:59:59 795 4.4% 0.222.8 MB 4.2% 0.79
May 6 10:00:00 - 10:59:59 863 4.8% 0.242.4 MB 3.6% 0.69
May 6 11:00:00 - 11:59:59 689 3.8% 0.192.1 MB 3.1% 0.60
May 6 12:00:00 - 12:59:59 758 4.2% 0.212.2 MB 3.2% 0.62
May 6 13:00:00 - 13:59:59 788 4.4% 0.221.9 MB 2.8% 0.54
May 6 14:00:00 - 14:59:59 832 4.6% 0.234.2 MB 6.2% 1.19
May 6 15:00:00 - 15:59:59 1046 5.8% 0.2911.1 MB 16.5% 3.15
May 6 16:00:00 - 16:59:59 976 5.4% 0.274.2 MB 6.2% 1.19
May 6 17:00:00 - 17:59:59 1134 6.3% 0.323.6 MB 5.4% 1.03
May 6 18:00:00 - 18:59:59 932 5.2% 0.262.8 MB 4.2% 0.81
May 6 19:00:00 - 19:59:59 1045 5.8% 0.293.1 MB 4.6% 0.89
May 6 20:00:00 - 20:59:59 1052 5.8% 0.292.9 MB 4.3% 0.83
May 6 21:00:00 - 21:59:59 1009 5.6% 0.283.0 MB 4.4% 0.85
May 6 22:00:00 - 22:59:59 848 4.7% 0.242.3 MB 3.5% 0.67
May 6 23:00:00 - 23:59:59 821 4.5% 0.233.7 MB 5.4% 1.04
May 7 00:00:00 - 00:00:02 2 0.0% 1.003.5 KB 0.0% 1.73
TOTAL: 24:00:00 18097 100.0% 0.2167.1 MB 100.0% 0.80
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 6812 298 0 0 0 0 0 0 6514
2linuxd-out.news.weretis.net 1393 326 0 0 0 0 0 0 1067
3news.fcku.it 209 11 0 0 0 0 0 0 198
4nntp.pasdenom.info 8 0 0 0 0 0 0 0 8
TOTAL: 4 8422 635 0 0 0 0 0 0 7787

Unwanted newsgroups [Top 20]:

NewsgroupCount
ut.test 89
it-alt.sport.calcio.juventus 75
lada.talk 67
mpc.lists.freebsd.ports.bugs 37
lada.commerce 36
lada.auto 26
alt.survival 25
it.comp.os.win.windows10 24
alt.windows7.general 19
cakewalk.audio 15
alt.personals.ad 14
mozilla.support.seamonkey 14
lada.mobile 14
mozilla.support.thunderbird 13
lada.photo 11
spline.eisfair 11
mozilla.support.firefox 7
alt.politics 7
mozilla.dev.l10n 6
lada.kitchen 6
TOTAL: 77 635

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 6509
EMP (phn path) 762
EMP (phl) 78
Too many newsgroups 73
EMP (phn nph) 55
Binary Payload 24
User-issued cancel 9
HTML post 7
Binary: non-binary distribution 3
Angle-bracket bot 1
Too many newsgroups (low_xpost) 1
TOTAL: 11 7522

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
linuxd-out.news.weretis.net 251
newsfeed.neva.ru 12
news.fcku.it 2
TOTAL: 3 265
TOTAL: 1 265

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nntp.pasdenom.info 29674 3438 13470 1022 0 160 11%23:57:42
2news.fcku.it 23646 1729 13350 2666 0 33 7%23:59:49
3eternal-september 19544 78 15418 2 0 6 0%23:59:46
4weretis.net 2397 70 2161 0 0 4 2%23:59:49
5neva.ru 23966 36 16125 103 0 21 0%23:59:49
6news.stack.nl 2860 0 0 0 0 20896 0%23:59:49
7news.netfront.net 2765 0 0 0 0 20814 0%23:59:49
8news.albasani.net 2859 0 0 0 0 20250 0%23:59:49
9news.killfile.org 2850 0 0 0 0 20946 0%23:59:49
10vc89.vc.panix.com 2841 0 0 0 0 20937 0%23:59:49
11news.mixmin.net 0 0 0 0 0 0 0%00:10:01
12etla.org 0 0 0 0 0 18097 0%23:59:49
TOTAL: 12 113402 5351 60524 3793 0 122164 4%264:05:50
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nntp.pasdenom.info11.8 MB2.3 MB14.1 MB0.2 KB/s3.2 KB23:57:42
2news.fcku.it4.8 MB7.9 MB12.7 MB0.2 KB/s3.0 KB23:59:49
3eternal-september244.5 KB4.2 KB248.8 KB0.0 KB/s3.1 KB23:59:46
4weretis.net96.2 KB0.0 KB96.2 KB0.0 KB/s1.4 KB23:59:49
5neva.ru92.1 KB433.8 KB525.9 KB0.0 KB/s3.8 KB23:59:49
6news.stack.nl0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:49
7news.netfront.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:49
8news.albasani.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:49
9news.killfile.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:49
10vc89.vc.panix.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:49
11news.mixmin.net0.0 KB0.0 KB0.0 KB0.0 KB/s000:10:01
12etla.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:49
TOTAL: 1217.0 MB10.6 MB27.6 MB0.0 KB/s3.1 KB264:05:50
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1dslb-188-099-023-198.188.099.pools.vodafone-ip.de 110 59.4 KB 5 0 000:50:00
2challenger.nielsenmedia.com 16 27.1 KB 2 0 003:09:55
TOTAL: 2 126 716.5 KB 7 0 005:04:17

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.188.099.pools.vodafone-ip.de 110 59.4 KB 5 0 000:50:00
2*.nielsenmedia.com 16 27.1 KB 2 0 003:09:55
3*.drr02.clwr.fl.frontiernet.net 6 00.0 KB 0 0 001:04:22
TOTAL: 3 132 716.5 KB 7 0 005:04:17

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
challenger.nielsenmedia.com 1.068 0.080 0.00003:09:55
47-192-187-101.drr02.clwr.fl.frontiernet.net 0.464 0.028 0.00001:04:22
dslb-188-099-023-198.188.099.pools.vodafone-ip.de 11.932 2.768 0.00000:50:00
TOTAL: 3 13.464 2.876 0.00005:04:17

Curious NNRP server explorers [Top 20]:

SystemConn
47-192-187-101.drr02.clwr.fl.frontiernet.net 6
TOTAL: 1 6

NNRP client timeouts [Top 20]:

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

Newsgroup request counts (by category):

CategoryCountPct
1de 3 42.9%
2comp 2 28.6%
3ger 1 14.3%
4alt 1 14.3%
TOTAL: 4 7100.0%

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

NewsgroupCount
1comp.lang.awk 2
2de.talk.tagesgeschehen 1
3ger.ct 1
4alt.test 1
5de.etc.finanz.banken+broker 1
6de.soc.politik.misc 1
TOTAL: 6 7