Daily Usenet report for paganini.linuxd.org

Oct 22 00:00:02 -- Oct 23 00:00:02

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Oct 23 00:00:02 paganini overchan[19941]: 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 103534 62.7%12.8 MB 54.6%
inn 40018 24.2%8.0 MB 34.0%
innd 20961 12.7%2.6 MB 11.2%
nnrpd 476 0.3%66.8 KB 0.3%
nocem 49 0.0%8.5 KB 0.0%
overchan 2 0.0%0.3 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 7 165041 100.0%23.5 MB100.0%

History cache:

ReasonCount%Count
Positive hits 130090 51.2%
Negative hits 84744 33.3%
Do not exist 39371 15.5%
Cache misses 71 0.0%
TOTAL: 4 254276 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.467 0.0%145 0.000 3.221 37.000
article cleanup00:00:00.262 0.0%39480 0.000 0.007 0.026
article logging00:00:00.346 0.0%39910 0.000 0.009 0.026
article parse00:00:01.118 0.0%98753 0.000 0.011 0.059
article write00:00:56.975 0.1%19774 0.104 2.881 112.718
artlog/artcncl00:00:00.001 0.0%145 0.000 0.007 0.143
data move00:00:00.165 0.0%262265 0.000 0.001 0.002
hisgrep/artcncl00:00:00.000 0.0%143 0.000 0.000 0.000
hishave/artcncl00:00:00.001 0.0%145 0.000 0.007 1.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:12.564 0.0%255150 0.016 0.049 0.516
history sync00:00:00.018 0.0%303 0.000 0.059 1.000
history write00:00:23.442 0.0%39466 0.016 0.594 2.746
hiswrite/artcncl00:00:00.000 0.0%2 0.000 0.000 0.000
idle23:55:56.217 99.7%261728 168.981 329.182 1356.959
nntp read00:00:01.966 0.0%274058 0.000 0.007 0.016
overview write00:00:19.634 0.0%19774 0.015 0.993 5.974
perl filter00:01:50.779 0.1%39466 1.130 2.807 20.564
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.277 0.0%59535 0.000 0.021 0.049
TOTAL: 24:00:21.62223:59:45.232100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.098 0.0%39399 0.000 0.002 0.017
article prepare00:00:00.003 0.0%14156 0.000 0.000 0.007
article read00:00:01.311 0.0%3026 0.000 0.433 18.091
backlog stats00:00:00.204 0.0%326884 0.000 0.001 0.002
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.347 0.0%175556 0.002 0.008 0.016
data write00:00:02.747 0.0%155843 0.008 0.018 0.035
idle23:43:30.007 99.3%326884 102.607 261.285 485.766
status file00:09:34.730 0.7%43265 8.350 13.284 23.241
TOTAL: 23:53:24.50323:53:10.447100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle03:47:53.913 99.9%444 21.000 30797.101600236.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.016 0.0%1117 0.000 0.014 0.500
readart00:00:00.083 0.0%804 0.066 0.103 0.805
TOTAL: 03:48:09.64203:47:54.012 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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1linuxd-out.news.weretis.net 4 45100 16791 25818 2491 37%47:34:11
2newsfeed.neva.ru 147 77538 2409 58813 16316 3%71:46:43
3news.fcku.it 2 8103 452 7495 156 5%25:18:18
4nntp.pasdenom.info 3 41368 67 40572 729 0%24:33:55
5localhost 25 0 0 0 0 0%00:00:00
TOTAL: 5 181 172109 19719 132698 19692 11%169:13:07
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1linuxd-out.news.weretis.net53.3 MB11.5 KB17.2 MB70.4 MB 75%3.7 KB
2newsfeed.neva.ru7.2 MB25.5 KB151.5 MB158.7 MB 4%8.7 KB
3news.fcku.it2.2 MB0.0 KB4.5 MB6.6 MB 32%11.2 KB
4nntp.pasdenom.info161.1 KB0.0 KB3.2 MB3.4 MB 4%4.4 KB
5localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 562.8 MB37.1 KB176.4 MB239.2 MB 26%6.2 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 22 00:00:02 - 00:59:59 772 3.9% 0.212.3 MB 3.6% 0.64
Oct 22 01:00:00 - 01:59:59 730 3.7% 0.202.1 MB 3.4% 0.61
Oct 22 02:00:00 - 02:59:59 597 3.0% 0.172.0 MB 3.2% 0.57
Oct 22 03:00:00 - 03:59:59 465 2.4% 0.131.4 MB 2.3% 0.40
Oct 22 04:00:00 - 04:59:59 406 2.1% 0.111.8 MB 2.8% 0.50
Oct 22 05:00:00 - 05:59:59 421 2.1% 0.121.3 MB 2.0% 0.36
Oct 22 06:00:00 - 06:59:59 392 2.0% 0.111.1 MB 1.8% 0.32
Oct 22 07:00:00 - 07:59:59 441 2.2% 0.121.3 MB 2.0% 0.36
Oct 22 08:00:00 - 08:59:59 534 2.7% 0.151.9 MB 3.0% 0.54
Oct 22 09:00:00 - 09:59:59 838 4.2% 0.232.2 MB 3.5% 0.62
Oct 22 10:00:00 - 10:59:59 970 4.9% 0.273.9 MB 6.2% 1.11
Oct 22 11:00:00 - 11:59:59 889 4.5% 0.252.6 MB 4.1% 0.73
Oct 22 12:00:00 - 12:59:59 872 4.4% 0.244.6 MB 7.3% 1.31
Oct 22 13:00:00 - 13:59:59 902 4.6% 0.253.6 MB 5.7% 1.01
Oct 22 14:00:00 - 14:59:59 1056 5.3% 0.292.6 MB 4.2% 0.75
Oct 22 15:00:00 - 15:59:59 943 4.8% 0.262.6 MB 4.2% 0.75
Oct 22 16:00:00 - 16:59:59 1058 5.4% 0.293.3 MB 5.3% 0.95
Oct 22 17:00:00 - 17:59:59 1074 5.4% 0.303.3 MB 5.3% 0.95
Oct 22 18:00:00 - 18:59:59 1091 5.5% 0.303.4 MB 5.4% 0.97
Oct 22 19:00:00 - 19:59:59 1313 6.6% 0.363.4 MB 5.4% 0.96
Oct 22 20:00:00 - 20:59:59 1080 5.5% 0.302.9 MB 4.5% 0.81
Oct 22 21:00:00 - 21:59:59 978 4.9% 0.272.6 MB 4.1% 0.74
Oct 22 22:00:00 - 22:59:59 1039 5.3% 0.294.2 MB 6.7% 1.20
Oct 22 23:00:00 - 23:59:59 905 4.6% 0.252.5 MB 3.9% 0.70
Oct 23 00:00:00 - 00:00:02 3 0.0% 1.5015.2 KB 0.0% 7.61
TOTAL: 24:00:00 19769 100.0% 0.2362.8 MB 100.0% 0.74
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 16292 266 0 9 0 0 0 016017
2linuxd-out.news.weretis.net 2921 453 0 4 0 0 0 0 2464
3nntp.pasdenom.info 737 0 0 1 0 0 0 0 736
4news.fcku.it 154 0 0 0 0 0 0 0 154
TOTAL: 4 20104 719 0 14 0 0 0 019371

Unwanted newsgroups [Top 20]:

NewsgroupCount
ut.test 125
it-alt.sport.calcio.juventus 112
mpc.lists.nanog 60
alt.survival 43
lada.talk 38
mozilla.support.firefox 32
alt.windows7.general 28
mozilla.dev.security.policy 14
it.comp.os.win.windows10 13
mozilla.dev.platform 11
spline.fli4l.geschnatter 11
spline.fli4l 10
mpc.lists.freebsd.wireless 10
alt.computer.workshop 9
cakewalk.audio 9
lada.auto 7
mozilla.support.seamonkey 7
alt.politics 7
alt.pub.cafe-bob 6
mozilla.tools.taskcluster 6
TOTAL: 97 719

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 15300
EMP (phn path) 2757
EMP (phl) 634
EMP (phn nph) 139
Too many newsgroups 44
User-issued cancel 34
Poison newsgroup 9
Binary Payload 9
HTML post 7
Binary Image: misplaced jpg 3
Binary: non-binary distribution 3
User-issued spam cancel 2
TOTAL: 12 18941

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
linuxd-out.news.weretis.net 400
newsfeed.neva.ru 29
news.fcku.it 1
TOTAL: 3 430
TOTAL: 1 430

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.fcku.it 26083 921 17150 1406 0 49 3%24:05:38
2nntp.pasdenom.info 36699 761 21529 236 0 2655 2%23:56:12
3weretis.net 3107 95 2721 0 0 0 3%23:59:09
4neva.ru 25958 36 17341 91 0 37 0%24:07:20
5eternal-september 22518 10 16898 1 0 31 0%24:07:25
6vc89.vc.panix.com 2835 0 0 0 0 22589 0%23:58:14
7news.stack.nl 2853 0 0 0 0 22542 0%23:58:14
8etla.org 0 0 0 0 0 19897 0%24:07:28
9news.netfront.net 2738 0 0 0 0 22437 0%23:58:08
10news.mixmin.net 0 0 0 0 0 0 0%00:10:00
11news.albasani.net 2847 0 0 0 0 21800 0%23:57:55
12news.killfile.org 2845 0 0 0 0 22599 0%23:58:17
TOTAL: 12 128483 1823 75639 1734 0 134636 1%264:24:00
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nntp.pasdenom.info3.2 MB400.3 KB3.6 MB0.0 KB/s3.7 KB23:56:12
2news.fcku.it2.6 MB5.3 MB7.9 MB0.1 KB/s3.5 KB24:05:38
3neva.ru680.0 KB504.7 KB1.2 MB0.0 KB/s9.3 KB24:07:20
4weretis.net388.2 KB0.0 KB388.2 KB0.0 KB/s4.1 KB23:59:09
5eternal-september22.2 KB1.1 KB23.3 KB0.0 KB/s2.1 KB24:07:25
6vc89.vc.panix.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:58:14
7news.stack.nl0.0 KB0.0 KB0.0 KB0.0 KB/s023:58:14
8etla.org0.0 KB0.0 KB0.0 KB0.0 KB/s024:07:28
9news.netfront.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:58:08
10news.mixmin.net0.0 KB0.0 KB0.0 KB0.0 KB/s000:10:00
11news.albasani.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:55
12news.killfile.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:58:17
TOTAL: 126.9 MB6.1 MB13.0 MB0.0 KB/s3.7 KB264:24:00
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1challenger.nielsenmedia.com 8 00.0 KB 0 0 002:00:23
2196.52.18.18 2 00.0 KB 0 0 000:00:10
3dslb-188-110-188-212.188.110.pools.vodafone-ip.de 121 00.0 KB 0 0 000:00:25
447.192.187.101 11 00.0 KB 0 0 001:47:08
TOTAL: 4 142 00.0 KB 0 0 003:48:09

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.nielsenmedia.com 8 00.0 KB 0 0 002:00:23
2*.188.110.pools.vodafone-ip.de 121 00.0 KB 0 0 000:00:25
3unresolved 13 00.0 KB 0 0 001:47:19
TOTAL: 3 142 00.0 KB 0 0 003:48:09

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
challenger.nielsenmedia.com 0.496 0.064 0.00002:00:23
47.192.187.101 0.736 0.048 0.00001:47:08
dslb-188-110-188-212.188.110.pools.vodafone-ip.de 6.444 0.400 0.00000:00:25
196.52.18.18 0.184 0.012 0.00000:00:10
TOTAL: 4 7.860 0.524 0.00003:48:09

NNRP client timeouts [Top 20]:

SystemConnPeer
challenger.nielsenmedia.com 4 1
47.192.187.101 3 0
TOTAL: 2 7 1