Daily Usenet report for paganini.linuxd.org

Oct 31 00:00:02 -- Nov 1 00:00:02

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Nov 1 00:00:02 paganini overchan[19298]: 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 103155 45.9%12.7 MB 41.4%
nnrpd 66402 29.6%7.3 MB 23.8%
inn 38202 17.0%8.3 MB 27.2%
innd 16712 7.4%2.3 MB 7.5%
nocem 47 0.0%7.7 KB 0.0%
controlchan 5 0.0%0.6 KB 0.0%
overchan 2 0.0%0.4 KB 0.0%
TOTAL: 7 224525 100.0%30.7 MB100.0%

History cache:

ReasonCount%Count
Positive hits 127543 51.6%
Negative hits 82097 33.2%
Do not exist 37614 15.2%
Cache misses 86 0.0%
TOTAL: 4 247340 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.238 0.0%152 0.000 1.566 17.571
article cleanup00:00:00.260 0.0%37713 0.000 0.007 0.024
article logging00:00:00.450 0.0%38154 0.000 0.012 0.348
article parse00:00:00.970 0.0%82633 0.000 0.012 0.032
article write00:01:01.838 0.1%22052 0.100 2.804 82.239
artlog/artcncl00:00:00.002 0.0%137 0.000 0.015 0.143
data move00:00:00.160 0.0%264073 0.000 0.001 0.004
hisgrep/artcncl00:00:00.003 0.0%152 0.000 0.020 0.333
hishave/artcncl00:00:00.003 0.0%152 0.000 0.020 0.500
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:14.570 0.0%249099 0.018 0.058 0.913
history sync00:00:00.057 0.0%406 0.000 0.140 5.667
history write00:00:27.574 0.0%37687 0.010 0.732 2.943
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:57:01.215 99.7%261475 188.613 329.749 1149.040
nntp read00:00:01.958 0.0%271522 0.001 0.007 0.015
overview write00:00:17.646 0.0%22052 0.031 0.800 3.719
perl filter00:01:25.318 0.1%37687 1.000 2.264 4.797
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.464 0.0%66464 0.000 0.022 0.052
TOTAL: 24:01:11.72924:00:33.726100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.074 0.0%40129 0.000 0.002 0.012
article prepare00:00:00.002 0.0%12724 0.000 0.000 0.009
article read00:00:03.633 0.0%2901 0.000 1.252 61.182
backlog stats00:00:00.219 0.0%333183 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.440 0.0%185362 0.002 0.008 0.021
data write00:00:03.017 0.0%163623 0.009 0.018 0.036
idle23:42:36.001 99.3%333183 124.579 256.184 502.679
status file00:09:52.531 0.7%43109 8.728 13.745 45.246
TOTAL: 23:52:59.56123:52:36.917100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle04:42:02.228 99.5%93845 31.667 180.321600509.333
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:02.473 0.0%188026 0.000 0.013 11.189
readart00:00:16.420 0.1%24216 0.048 0.678 4.317
TOTAL: 04:43:26.19604:42:21.121 99.6%----

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
usenet@film.rlss.okayama-u.ac.jp001011
TOTAL001011

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1linuxd-out.news.weretis.net 5 49714 18769 28793 2152 37%48:18:37
2newsfeed.neva.ru 146 73968 2957 57963 13048 3%71:22:27
3news.fcku.it 2 8243 284 7816 143 3%23:38:21
4nntp.pasdenom.info 2 51392 117 50990 285 0%39:31:52
5localhost 25 0 0 0 0 0%00:00:00
TOTAL: 5 180 183317 22127 145562 15628 12%182:51:17
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1linuxd-out.news.weretis.net60.2 MB44.4 KB14.5 MB74.7 MB 80%3.7 KB
2newsfeed.neva.ru9.0 MB22.2 KB105.5 MB114.5 MB 7%7.3 KB
3news.fcku.it1.3 MB0.0 KB1.1 MB2.4 MB 54%5.8 KB
4nntp.pasdenom.info363.1 KB71.7 KB2.0 MB2.4 MB 14%6.2 KB
5localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 570.9 MB138.3 KB123.0 MB194.1 MB 36%5.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 31 00:00:02 - 00:59:59 771 3.5% 0.212.1 MB 3.0% 0.60
Oct 31 01:00:00 - 01:59:59 597 2.7% 0.172.2 MB 3.1% 0.63
Oct 31 02:00:00 - 02:59:59 595 2.7% 0.172.1 MB 3.0% 0.59
Oct 31 03:00:00 - 03:59:59 416 1.9% 0.121.3 MB 1.8% 0.37
Oct 31 04:00:00 - 04:59:59 418 1.9% 0.121.5 MB 2.1% 0.43
Oct 31 05:00:00 - 05:59:59 369 1.7% 0.101.5 MB 2.1% 0.43
Oct 31 06:00:00 - 06:59:59 395 1.8% 0.111.3 MB 1.9% 0.38
Oct 31 07:00:00 - 07:59:59 479 2.2% 0.132.0 MB 2.8% 0.56
Oct 31 08:00:00 - 08:59:59 655 3.0% 0.182.6 MB 3.6% 0.73
Oct 31 09:00:00 - 09:59:59 877 4.0% 0.242.5 MB 3.6% 0.72
Oct 31 10:00:00 - 10:59:59 1072 4.9% 0.303.1 MB 4.4% 0.88
Oct 31 11:00:00 - 11:59:59 1005 4.6% 0.283.2 MB 4.5% 0.90
Oct 31 12:00:00 - 12:59:59 1020 4.6% 0.283.3 MB 4.7% 0.94
Oct 31 13:00:00 - 13:59:59 1030 4.7% 0.293.0 MB 4.3% 0.85
Oct 31 14:00:00 - 14:59:59 1067 4.8% 0.302.9 MB 4.2% 0.83
Oct 31 15:00:00 - 15:59:59 1164 5.3% 0.323.7 MB 5.3% 1.07
Oct 31 16:00:00 - 16:59:59 1331 6.0% 0.373.9 MB 5.5% 1.11
Oct 31 17:00:00 - 17:59:59 1247 5.7% 0.354.1 MB 5.8% 1.16
Oct 31 18:00:00 - 18:59:59 1316 6.0% 0.373.6 MB 5.1% 1.02
Oct 31 19:00:00 - 19:59:59 1474 6.7% 0.415.0 MB 7.0% 1.41
Oct 31 20:00:00 - 20:59:59 1386 6.3% 0.395.4 MB 7.6% 1.53
Oct 31 21:00:00 - 21:59:59 1278 5.8% 0.353.7 MB 5.2% 1.05
Oct 31 22:00:00 - 22:59:59 1031 4.7% 0.293.3 MB 4.6% 0.93
Oct 31 23:00:00 - 23:59:59 1017 4.6% 0.283.2 MB 4.5% 0.91
Nov 1 00:00:00 - 00:00:02 16 0.1% 8.00104.5 KB 0.1% 52.24
TOTAL: 24:00:00 22026 100.0% 0.2570.5 MB 100.0% 0.84
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 13112 374 0 10 0 0 0 012728
2linuxd-out.news.weretis.net 2557 507 0 5 0 0 0 0 2045
3nntp.pasdenom.info 223 0 0 11 0 0 0 0 212
4news.fcku.it 146 1 0 0 0 0 0 0 145
TOTAL: 4 16038 882 0 26 0 0 0 015130

Unwanted newsgroups [Top 20]:

NewsgroupCount
ut.test 168
lada.talk 66
lada.auto 64
it-alt.sport.calcio.juventus 61
spline.eisfair 35
mozilla.support.seamonkey 28
gmane.linux.kernel 23
alt.windows7.general 19
it.annunci.varie 18
it.annunci.immobiliari 18
it.annunci.commerciali 18
mozilla.dev.platform 15
mozilla.support.firefox 14
cakewalk.audio 14
alt.survival 14
mozilla.dev.security.policy 13
it.comp.os.win.windows10 13
alt.pl.nieruchomosci.gielda 12
mozilla.compatibility 12
mozilla.reps.council 11
TOTAL: 118 882

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 11722
EMP (phn path) 2128
EMP (phl) 511
EMP (phn nph) 194
Too many newsgroups 80
Binary Payload 17
User-issued cancel 16
Binary: non-binary distribution 8
HTML post 4
Binary Image: misplaced jpg 2
User-issued spam cancel 1
Binary: misplaced par2 1
HTML file attachment 1
Too many newsgroups (meow) 1
Too many test groups in crosspost 1
TOTAL: 15 14687

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nntp.pasdenom.info 38620 473 21114 1291 0 2980 1%23:57:40
2news.fcku.it 28656 461 20508 769 0 194 1%23:59:45
3weretis.net 3652 64 3229 0 0 8 1%23:59:47
4neva.ru 26585 23 18896 106 0 37 0%23:59:41
5eternal-september 24516 12 18761 0 0 25 0%23:59:47
6news.stack.nl 2857 0 0 0 0 24836 0%23:59:47
7etla.org 0 0 0 0 0 22026 0%23:59:47
8news.albasani.net 2859 0 0 0 0 24046 0%23:59:47
9news.mixmin.net 0 0 0 0 0 0 0%00:10:00
10news.netfront.net 2667 0 0 0 0 24620 0%23:59:46
11news.killfile.org 2848 0 0 0 0 24873 0%23:59:47
12vc89.vc.panix.com 2838 0 0 0 0 24863 0%23:59:47
TOTAL: 12 136098 1033 82508 2166 0 148508 0%264:05:21
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nntp.pasdenom.info2.0 MB2.0 MB4.0 MB0.0 KB/s2.3 KB23:57:40
2news.fcku.it1.9 MB3.3 MB5.2 MB0.1 KB/s4.3 KB23:59:45
3weretis.net369.2 KB0.0 KB369.2 KB0.0 KB/s5.8 KB23:59:47
4neva.ru239.7 KB463.6 KB703.3 KB0.0 KB/s5.5 KB23:59:41
5eternal-september28.4 KB0.0 KB28.4 KB0.0 KB/s2.4 KB23:59:47
6news.stack.nl0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:47
7etla.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:47
8news.albasani.net0.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
10news.netfront.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:46
11news.killfile.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:47
12vc89.vc.panix.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:47
TOTAL: 124.6 MB5.7 MB10.2 MB0.0 KB/s3.3 KB264:05:21
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1mtrlpq2314w-lp140-01-50-101-182-89.dsl.bell.ca 120 1630.4 KB 16 0 002:41:12
TOTAL: 1 120 1630.4 KB 16 0 004:43:25

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.dsl.bell.ca 120 1630.4 KB 16 0 002:41:12
2*.nielsenmedia.com 3 00.0 KB 0 0 001:00:04
3unresolved 6 00.0 KB 0 0 001:01:17
4*.188.110.pools.vodafone-ip.de 135 00.0 KB 0 0 000:00:50
TOTAL: 4 264 1630.4 KB 16 0 004:43:25

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
mtrlpq2314w-lp140-01-50-101-182-89.dsl.bell.ca 14.404 4.932 0.00002:41:12
47.192.187.101 0.308 0.024 0.00001:00:24
challenger.nielsenmedia.com 0.212 0.008 0.00001:00:04
196.52.20.49 0.132 0.024 0.00000:00:53
dslb-188-110-188-212.188.110.pools.vodafone-ip.de 7.196 0.520 0.00000:00:50
TOTAL: 5 22.252 5.508 0.00004:43:25

Curious NNRP server explorers [Top 20]:

SystemConn
dslb-188-110-188-212.188.110.pools.vodafone-ip.de 135
47.192.187.101 5
challenger.nielsenmedia.com 3
196.52.20.49 1
TOTAL: 4 144

NNRP client timeouts [Top 20]:

SystemConnPeer
47.192.187.101 2 0
challenger.nielsenmedia.com 2 0
TOTAL: 2 4 0

Newsgroup request counts (by category):

CategoryCountPct
1de 6 37.5%
2uk 3 18.8%
3alt 3 18.8%
4it 1 6.2%
5misc 1 6.2%
6fr 1 6.2%
7rec 1 6.2%
TOTAL: 7 16100.0%

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

NewsgroupCount
1uk.politics.misc 2
2de.comp.os.ms-windows.misc 2
3alt.drugs.hard 1
4rec.arts.tv 1
5uk.rec.motorcycles 1
6it.tlc.cellulari.android 1
7alt.happy.valley 1
8de.sci.mathematik 1
9de.sci.chemie 1
10fr.rec.loisirs-creatifs 1
11misc.survivalism 1
12de.etc.finanz.banken+broker 1
13alt.home.repair 1
14de.soc.politik.misc 1
TOTAL: 14 16