Daily Usenet report for paganini.linuxd.org

Oct 16 00:00:02 -- Oct 17 00:00:01

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Oct 17 00:00:01 paganini overchan[20301]: 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 103622 60.5%12.4 MB 51.3%
inn 43058 25.2%8.5 MB 35.1%
innd 23922 14.0%3.2 MB 13.3%
nnrpd 501 0.3%68.5 KB 0.3%
nocem 55 0.0%8.0 KB 0.0%
overchan 2 0.0%0.3 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 7 171161 100.0%24.2 MB100.0%

History cache:

ReasonCount%Count
Positive hits 187625 63.4%
Negative hits 65749 22.2%
Do not exist 42443 14.3%
Cache misses 74 0.0%
TOTAL: 4 295891 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.266 0.0%156 0.000 1.705 19.400
article cleanup00:00:00.294 0.0%42595 0.000 0.007 0.028
article logging00:00:00.540 0.0%42948 0.000 0.013 0.336
article parse00:00:00.722 0.0%55365 0.000 0.013 0.065
article write00:00:42.405 0.0%20018 0.090 2.118 22.760
artlog/artcncl00:00:00.002 0.0%146 0.000 0.014 0.250
data move00:00:00.138 0.0%306244 0.000 0.000 0.004
hisgrep/artcncl00:00:00.004 0.0%154 0.000 0.026 0.250
hishave/artcncl00:00:00.002 0.0%156 0.000 0.013 0.333
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:23.981 0.0%297401 0.013 0.081 4.048
history sync00:00:00.356 0.0%304 0.000 1.171 159.000
history write00:00:47.408 0.1%42594 0.011 1.113 5.547
hiswrite/artcncl00:00:00.000 0.0%2 0.000 0.000 0.000
idle23:56:25.851 99.7%297917 126.787 289.295 1284.113
nntp read00:00:01.894 0.0%307020 0.002 0.006 0.014
overview write00:00:16.986 0.0%20018 0.016 0.849 4.099
perl filter00:00:59.961 0.1%42594 0.911 1.408 4.615
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.206 0.0%60194 0.000 0.020 0.066
TOTAL: 24:00:21.43223:59:42.016100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.087 0.0%36493 0.000 0.002 0.014
article prepare00:00:00.002 0.0%17448 0.000 0.000 0.008
article read00:00:01.684 0.0%3079 0.000 0.547 20.966
backlog stats00:00:00.188 0.0%331016 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.404 0.0%178246 0.003 0.008 0.020
data write00:00:02.876 0.0%158217 0.010 0.018 0.039
idle23:43:01.948 99.3%331016 107.955 257.939 480.370
status file00:10:00.382 0.7%43330 8.877 13.856 46.476
TOTAL: 23:53:28.16723:53:08.571100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle01:46:57.491 99.7%460 27.333 13951.067450257.250
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.017 0.0%1218 0.000 0.014 0.250
readart00:00:00.000 0.0%2 0.000 0.000 0.000
TOTAL: 01:47:13.87701:46:57.508 99.7%----

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 6 73263 16344 40795 16124 22%48:53:32
2newsfeed.neva.ru 141 107684 2031 100138 5515 1%71:46:42
3news.fcku.it 1 7094 1611 5215 268 22%23:26:08
4nntp.pasdenom.info 3 25813 14 25355 444 0%21:07:30
5localhost 25 0 0 0 0 0%00:00:00
TOTAL: 5 176 213854 20000 171503 22351 9%165:13:52
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1linuxd-out.news.weretis.net52.4 MB0.0 KB17.0 MB69.4 MB 75%2.2 KB
2newsfeed.neva.ru5.4 MB0.0 KB12.3 MB17.7 MB 30%2.4 KB
3news.fcku.it5.0 MB0.0 KB3.1 MB8.1 MB 61%4.4 KB
4nntp.pasdenom.info32.5 KB0.0 KB2.4 MB2.4 MB 1%5.4 KB
5localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 562.8 MB0.0 KB34.8 MB97.7 MB 64%2.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 16 00:00:02 - 00:59:59 782 3.9% 0.223.2 MB 5.1% 0.91
Oct 16 01:00:00 - 01:59:59 514 2.6% 0.142.0 MB 3.2% 0.57
Oct 16 02:00:00 - 02:59:59 472 2.4% 0.131.5 MB 2.4% 0.43
Oct 16 03:00:00 - 03:59:59 510 2.5% 0.142.2 MB 3.6% 0.64
Oct 16 04:00:00 - 04:59:59 417 2.1% 0.121.2 MB 1.9% 0.35
Oct 16 05:00:00 - 05:59:59 349 1.7% 0.101.2 MB 1.9% 0.33
Oct 16 06:00:00 - 06:59:59 388 1.9% 0.111.1 MB 1.8% 0.32
Oct 16 07:00:00 - 07:59:59 448 2.2% 0.121.8 MB 2.8% 0.50
Oct 16 08:00:00 - 08:59:59 433 2.2% 0.121.2 MB 1.9% 0.33
Oct 16 09:00:00 - 09:59:59 641 3.2% 0.181.7 MB 2.8% 0.49
Oct 16 10:00:00 - 10:59:59 746 3.7% 0.211.7 MB 2.7% 0.49
Oct 16 11:00:00 - 11:59:59 811 4.0% 0.232.2 MB 3.4% 0.61
Oct 16 12:00:00 - 12:59:59 822 4.1% 0.232.6 MB 4.1% 0.73
Oct 16 13:00:00 - 13:59:59 928 4.6% 0.262.2 MB 3.5% 0.62
Oct 16 14:00:00 - 14:59:59 1011 5.0% 0.282.4 MB 3.8% 0.68
Oct 16 15:00:00 - 15:59:59 1056 5.3% 0.292.5 MB 3.9% 0.70
Oct 16 16:00:00 - 16:59:59 1239 6.2% 0.346.5 MB 10.3% 1.84
Oct 16 17:00:00 - 17:59:59 1156 5.8% 0.324.5 MB 7.1% 1.28
Oct 16 18:00:00 - 18:59:59 1262 6.3% 0.353.9 MB 6.1% 1.10
Oct 16 19:00:00 - 19:59:59 1210 6.0% 0.343.4 MB 5.5% 0.98
Oct 16 20:00:00 - 20:59:59 1453 7.3% 0.404.1 MB 6.5% 1.16
Oct 16 21:00:00 - 21:59:59 1091 5.4% 0.304.6 MB 7.3% 1.31
Oct 16 22:00:00 - 22:59:59 1263 6.3% 0.352.8 MB 4.5% 0.80
Oct 16 23:00:00 - 23:59:59 1019 5.1% 0.282.5 MB 4.0% 0.72
Oct 17 00:00:00 - 00:00:01 4 0.0% 4.0020.3 KB 0.0% 20.35
TOTAL: 23:59:59 20025 100.0% 0.2362.9 MB 100.0% 0.75
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1linuxd-out.news.weretis.net 16570 302 0 0 0 0 0 016268
2newsfeed.neva.ru 5535 374 0 0 0 0 0 0 5161
3nntp.pasdenom.info 503 0 0 1 0 0 0 0 502
4news.fcku.it 279 0 0 0 0 0 0 0 279
TOTAL: 4 22887 676 0 1 0 0 0 022210

Unwanted newsgroups [Top 20]:

NewsgroupCount
ut.test 155
lada.talk 102
it-alt.sport.calcio.juventus 54
alt.survival 39
lada.photo 35
lada.auto 23
mpc.lists.freebsd.ports.bugs 22
alt.windows7.general 20
spline.eisfair.dev 20
mozilla.dev.security.policy 14
mozilla.support.seamonkey 14
alt.politics 10
cakewalk.audio 9
oesterreich.tratsch 8
mozilla.general 7
alt.philosophy 6
lada.commerce 6
mpc.lists.freebsd.wireless 5
eagle.support.eng 5
spline.fli4l 5
TOTAL: 86 676

INND Perl filter [Top 20]:

ReasonCount
EMP (phn path) 16541
EMP (md5) 4379
EMP (phl) 707
EMP (phn nph) 132
Too many newsgroups 47
User-issued cancel 20
Binary: non-binary distribution 10
Binary Payload 9
Too many newsgroups (low_xpost) 4
HTML post 4
Binary Image: misplaced jpg 3
Binary: misplaced ARJ 1
TOTAL: 12 21857

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
linuxd-out.news.weretis.net 325
newsfeed.neva.ru 24
news.fcku.it 4
TOTAL: 3 353
TOTAL: 1 353

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nntp.pasdenom.info 34926 1233 18524 219 0 2321 3%23:57:40
2news.fcku.it 23183 689 16454 1171 0 32 2%23:59:47
3weretis.net 4225 469 3297 0 0 12 11%23:58:26
4neva.ru 27725 385 17395 200 0 88 1%23:59:45
5eternal-september 23188 10 17346 0 0 14 0%23:59:47
6news.killfile.org 2847 0 0 0 0 22871 0%23:59:47
7news.netfront.net 2760 0 0 0 0 22717 0%23:59:47
8vc89.vc.panix.com 2838 0 0 0 0 22862 0%23:59:47
9news.mixmin.net 0 0 0 0 0 0 0%00:10:00
10etla.org 0 0 0 0 0 20025 0%23:59:47
11news.albasani.net 2859 0 0 0 0 22108 0%23:59:47
12news.stack.nl 2834 0 0 0 0 22745 0%23:59:47
TOTAL: 12 127385 2786 73016 1590 0 135795 2%264:04:07
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nntp.pasdenom.info5.7 MB379.7 KB6.1 MB0.1 KB/s4.3 KB23:57:40
2news.fcku.it4.1 MB5.0 MB9.1 MB0.1 KB/s5.0 KB23:59:47
3neva.ru1.5 MB1.1 MB2.6 MB0.0 KB/s4.5 KB23:59:45
4weretis.net1.3 MB0.0 KB1.3 MB0.0 KB/s2.9 KB23:58:26
5eternal-september27.8 KB0.0 KB27.8 KB0.0 KB/s2.8 KB23:59:47
6news.killfile.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:47
7news.netfront.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:47
8vc89.vc.panix.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:47
9news.mixmin.net0.0 KB0.0 KB0.0 KB0.0 KB/s000:10:00
10etla.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:47
11news.albasani.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:47
12news.stack.nl0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:47
TOTAL: 1212.6 MB6.5 MB19.1 MB0.0 KB/s4.5 KB264:04:07
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
147.192.187.101 7 12.4 KB 1 0 001:16:28
2challenger.nielsenmedia.com 2 12.4 KB 1 0 000:30:12
TOTAL: 2 9 24.7 KB 2 0 001:47:13

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.nielsenmedia.com 2 12.4 KB 1 0 000:30:12
2unresolved 9 12.4 KB 1 0 001:16:29
3*.208-100-26.static.steadfastdns.net 2 00.0 KB 0 0 000:00:01
4*.188.110.pools.vodafone-ip.de 144 00.0 KB 0 0 000:00:29
TOTAL: 4 157 24.7 KB 2 0 001:47:13

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
47.192.187.101 0.460 0.032 0.00001:16:28
challenger.nielsenmedia.com 0.188 0.008 0.00000:30:12
dslb-188-110-188-212.188.110.pools.vodafone-ip.de 7.592 0.504 0.00000:00:29
ip232.208-100-26.static.steadfastdns.net 0.104 0.012 0.00000:00:01
185.100.87.191 0.104 0.008 0.00000:00:01
TOTAL: 5 8.448 0.564 0.00001:47:13

Curious NNRP server explorers [Top 20]:

SystemConn
dslb-188-110-188-212.188.110.pools.vodafone-ip.de 144
ip232.208-100-26.static.steadfastdns.net 2
185.100.87.191 2
TOTAL: 3 148

NNRP client timeouts [Top 20]:

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

Newsgroup request counts (by category):

CategoryCountPct
1comp 2100.0%
TOTAL: 1 2100.0%

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

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