Daily Usenet report

Jan 15 00:01:01 -- Jan 16 00:01:00

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

Jan 15 00:55:20 www innd: message repeated 2 times: [ ctlinnd command s]
Jan 15 06:11:39 www nnrpd[2808852]: net-188-216-31-233.cust.vodafonedsl.it rejected upgrade
Jan 15 06:14:40 www nnrpd[2811273]: net-188-216-31-233.cust.vodafonedsl.it rejected upgrade

Log entries by program:

Program nameLines%LinesSize%Size
inn 131818 93.2%29.7 MB 96.1%
innd 6097 4.3%752.7 KB 2.4%
nnrpd 2199 1.6%250.3 KB 0.8%
innfeed 1258 0.9%240.2 KB 0.8%
rnews 1 0.0%0.1 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 141374 100.0%30.9 MB100.0%

History cache:

ReasonCount%Count
Positive hits 148825 57.7%
Negative hits 92275 35.8%
Do not exist 16219 6.3%
Cache misses 702 0.3%
TOTAL: 4 258021 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:15.071 0.1%28880 0.256 0.522 2.365
article cleanup00:00:00.344 0.0%17167 0.010 0.020 0.046
article logging00:00:00.959 0.0%17175 0.034 0.056 0.089
article parse00:00:01.977 0.0%108471 0.007 0.018 0.024
article write00:00:16.599 0.1%13273 0.922 1.251 2.492
artlog/artcncl00:00:00.445 0.0%27414 0.005 0.016 0.032
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:01.206 0.0%376021 0.001 0.003 0.011
hisgrep/artcncl00:00:04.037 0.0%28853 0.031 0.140 1.401
hishave/artcncl00:00:00.229 0.0%28877 0.001 0.008 0.031
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:11.311 0.0%244928 0.012 0.046 0.133
history sync00:00:00.028 0.0%84 0.000 0.333 2.667
history write00:00:11.462 0.1%17167 0.274 0.668 2.072
hiswrite/artcncl00:00:00.026 0.0%44 0.000 0.591 1.000
idle06:13:31.904 98.3%344548 35.784 65.047 90.278
nntp read00:00:19.577 0.1%350439 0.027 0.056 0.102
overview write00:00:52.429 0.2%13273 0.773 3.950 105.933
perl filter00:02:27.629 0.6%17167 5.045 8.600 13.391
python filter00:00:02.666 0.0%17168 0.109 0.155 0.227
site send00:00:07.155 0.0%26891 0.117 0.266 0.809
TOTAL: 06:20:06.05806:18:25.054 99.6%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.107 0.0%13170 0.000 0.008 0.024
article prepare00:00:00.024 0.0%171120 0.000 0.000 0.000
article read00:00:04.944 0.0%12998 0.261 0.380 0.598
backlog stats00:00:00.780 0.0%434649 0.001 0.002 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:09.556 0.0%321596 0.022 0.030 0.107
data write00:00:48.321 0.2%304798 0.134 0.159 0.212
idle06:08:52.753 99.6%434649 41.466 50.921 65.801
status file00:00:00.146 0.0%147 0.667 0.993 5.000
TOTAL: 06:10:12.56206:09:56.631 99.9%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:05:20.513 70.2%2069 133.000 154.912 10051.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.427 0.1%4142 0.000 0.103 2.000
TOTAL: 00:07:36.76500:05:20.940 70.3%----

Control commands to INND:

CommandNumber
begin 2
feedinfo 1
flush 1
go 2
logmode 1
lowmark 1
mode 34
name 1
pause 1
paused 1
reload 2
reserve 2
shutdown 3
throttle 2
TOTAL: 14 54

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1endofthelinebbs-out.news.weretis.net 4 18788 5426 13157 205 28%13:12:52
2usenet.blueworldhosting.com 185 6180 1768 4189 223 28%06:07:44
3news.nntp4.net 0 12870 1695 11092 83 13%06:36:17
4nntp.comgw.net 0 11523 1190 9635 698 10%06:44:03
5newsfeed.xs3.de 0 10145 883 9225 37 8%06:59:50
6news.hispagatos.org 0 8109 699 7400 10 8%09:11:32
7paganini.bofh.team 0 17782 638 16607 537 3%07:55:32
8usenet.network 0 10594 401 10160 33 3%06:24:19
9usenet.goja.nl.eu.org 3 13591 375 13176 40 2%08:21:10
10endofthelinebbs.peers.news.panix.com 8 14397 359 14015 23 2%07:11:32
11endoftheline-out.news.chmurka.net 0 2878 276 2597 5 9%10:04:00
12glockenspiel.complete.org 2 30052 184 29860 8 0%22:41:53
13outgoing.news.lysator.liu.se 0 3760 87 3640 33 2%10:11:59
14i2pn.org 0 3441 52 3388 1 1%07:56:53
15194.87.241.33 6 147 51 31 65 34%06:10:05
16news.netfront.net 4 2163 17 84 2062 0%06:42:43
17news.bbs.nz 2 20086 6 20080 0 0%25:12:36
18news.samoylyk.net 0 3092 5 3086 1 0%08:56:46
19news.furie.org.uk 0 5233 3 5230 0 0%07:56:41
20localhost 9 1 1 0 0 100%00:00:00
21eotl-out.news.tnetconsulting.net 1 0 0 0 0 0%00:10:04
22news.nk.ca 1 0 0 0 0 0%00:10:00
TOTAL: 22 225 194832 14116 176652 4064 7%184:58:31
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1endofthelinebbs-out.news.weretis.net57.8 MB0.0 KB525.1 KB58.3 MB 99%10.6 KB
2news.nntp4.net20.8 MB0.0 KB721.4 KB21.5 MB 96%12.4 KB
3usenet.blueworldhosting.com15.0 MB0.0 KB1.9 MB16.9 MB 88%8.7 KB
4newsfeed.xs3.de11.1 MB0.0 KB376.6 KB11.5 MB 96%12.7 KB
5nntp.comgw.net8.5 MB0.0 KB4.4 MB13.0 MB 65%7.0 KB
6paganini.bofh.team5.3 MB0.0 KB2.0 MB7.3 MB 72%6.3 KB
7news.hispagatos.org3.9 MB0.0 KB9.3 KB3.9 MB 99%5.6 KB
8usenet.goja.nl.eu.org3.8 MB0.0 KB215.6 KB4.0 MB 94%9.9 KB
9endofthelinebbs.peers.news.panix.com2.9 MB0.0 KB222.5 KB3.1 MB 92%8.3 KB
10usenet.network2.7 MB0.0 KB130.2 KB2.9 MB 95%6.7 KB
11glockenspiel.complete.org1.8 MB0.0 KB68.7 KB1.8 MB 96%9.8 KB
12endoftheline-out.news.chmurka.net1.6 MB0.0 KB7.6 KB1.6 MB 99%6.0 KB
13i2pn.org601.2 KB0.0 KB1.1 KB602.4 KB 99%11.4 KB
14news.netfront.net381.2 KB0.0 KB681.0 MB681.4 MB 0%335.6 KB
15outgoing.news.lysator.liu.se239.1 KB0.0 KB79.0 KB318.1 KB 75%2.7 KB
16194.87.241.3398.6 KB0.0 KB96.4 KB195.0 KB 50%1.7 KB
17news.samoylyk.net19.0 KB0.0 KB0.9 KB19.9 KB 95%3.3 KB
18news.bbs.nz16.6 KB0.0 KB0.0 KB16.6 KB100%2.8 KB
19news.furie.org.uk16.4 KB0.0 KB0.0 KB16.4 KB100%5.5 KB
20localhost3.6 KB0.0 KB0.0 KB3.6 KB100%3.6 KB
21eotl-out.news.tnetconsulting.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
22news.nk.ca0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 22136.5 MB0.0 KB691.7 MB828.2 MB 16%46.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jan 15 00:01:01 - 00:59:59 1919 4.7% 0.5420.4 MB 5.6% 5.91
Jan 15 01:00:00 - 01:59:59 1942 4.8% 0.5420.2 MB 5.5% 5.74
Jan 15 02:00:00 - 02:59:59 2023 5.0% 0.5620.0 MB 5.5% 5.68
Jan 15 03:00:00 - 03:59:59 2159 5.3% 0.6020.6 MB 5.6% 5.86
Jan 15 04:00:00 - 04:59:59 2314 5.7% 0.6420.2 MB 5.5% 5.73
Jan 15 05:00:00 - 05:59:59 2226 5.5% 0.6220.8 MB 5.7% 5.92
Jan 15 06:00:00 - 06:59:59 422 1.0% 0.123.6 MB 1.0% 1.02
Jan 15 07:00:00 - 07:59:59 2633 6.5% 0.7318.8 MB 5.1% 5.34
Jan 15 08:00:00 - 08:59:59 1945 4.8% 0.5415.6 MB 4.3% 4.44
Jan 15 09:00:00 - 09:59:59 2054 5.1% 0.5719.4 MB 5.3% 5.51
Jan 15 10:00:00 - 10:59:59 1637 4.0% 0.4513.6 MB 3.7% 3.86
Jan 15 11:00:00 - 11:59:59 1560 3.9% 0.4314.5 MB 4.0% 4.11
Jan 15 12:00:00 - 12:59:59 1708 4.2% 0.4714.8 MB 4.0% 4.20
Jan 15 13:00:00 - 13:59:59 1494 3.7% 0.4113.0 MB 3.6% 3.70
Jan 15 14:00:00 - 14:59:59 1424 3.5% 0.4012.0 MB 3.3% 3.40
Jan 15 15:00:00 - 15:59:59 1579 3.9% 0.4414.6 MB 4.0% 4.15
Jan 15 16:00:00 - 16:59:59 1709 4.2% 0.4714.8 MB 4.1% 4.21
Jan 15 17:00:00 - 17:59:59 1678 4.1% 0.4715.0 MB 4.1% 4.27
Jan 15 18:00:00 - 18:59:59 1332 3.3% 0.3711.1 MB 3.0% 3.17
Jan 15 19:00:00 - 19:59:59 1184 2.9% 0.3310.5 MB 2.9% 3.00
Jan 15 20:00:00 - 20:59:59 1289 3.2% 0.3614.1 MB 3.9% 4.02
Jan 15 21:00:00 - 21:59:59 1579 3.9% 0.4412.3 MB 3.4% 3.51
Jan 15 22:00:00 - 22:59:59 1324 3.3% 0.3712.4 MB 3.4% 3.52
Jan 15 23:00:00 - 23:59:59 1282 3.2% 0.3613.3 MB 3.6% 3.78
Jan 16 00:00:00 - 00:01:00 25 0.1% 0.42206.5 KB 0.1% 3.44
TOTAL: 23:59:59 40441 100.0% 0.47365.7 MB 100.0% 4.33
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.netfront.net 7996 0 0 4 0 0 0 0 7992
2usenet.blueworldhosting.com 2575 67 0 2 0 0 0 0 2506
3nntp.comgw.net 1703 0 0 1 0 0 0 0 1702
4endofthelinebbs-out.news.weretis.net 1688 0 0 0 0 0 0 0 1688
5paganini.bofh.team 700 0 0 2 0 0 0 0 698
6usenet.goja.nl.eu.org 185 0 0 1 0 0 0 0 184
7194.87.241.33 169 0 0 0 0 0 0 0 169
8news.nntp4.net 149 0 0 1 0 0 0 0 148
9usenet.network 120 0 0 0 0 0 0 0 120
10outgoing.news.lysator.liu.se 96 0 0 0 0 0 0 0 96
11newsfeed.xs3.de 93 0 0 0 0 0 0 0 93
12endofthelinebbs.peers.news.panix.com 67 0 0 0 0 0 0 0 67
13news.corradoroberto.it 39 0 0 0 0 0 0 0 39
14glockenspiel.complete.org 38 0 0 0 0 0 0 0 38
15endoftheline-out.news.chmurka.net 12 0 0 0 0 0 0 0 12
16news.hispagatos.org 11 0 0 0 0 0 0 0 11
17i2pn.org 4 0 0 0 0 0 0 0 4
18news.furie.org.uk 2 0 0 1 0 0 0 0 1
19news.samoylyk.net 1 0 0 0 0 0 0 0 1
TOTAL: 19 15648 67 0 12 0 0 0 015569

Unwanted newsgroups [Top 20]:

NewsgroupCount
de.sci.announce 64
dbase.programming 1
test.news 1
fido7.anekdot 1
TOTAL: 4 67

INND Perl filter [Top 20]:

ReasonCount
Binary: misplaced binary 2028
EMP (md5) 844
EMP (phr nph) 371
EMP (phn path) 320
EMP (phr path) 80
Subject (lSDguY) 24
Subject (lSDguKfguK3guKXguYD) 9
Subject (lSDguKvguKfguKIg4Lih4Lix4LmI4LiZ4LiE4LiH4LiX4Li) 5
Too many newsgroups 5
Subject (lSDguYDguKfguYfguJr) 5
Subject (LSDguJzguKXguJrguK3guKXguKr) 4
Subject (lSDguKrguKXguY) 4
Subject (LSDguY) 4
Subject (lSDguYDguKfguYfguJrguJXguKPguI) 3
User-issued cancel 3
Subject (lSDguYDguITguKPguJTguL) 3
Subject (LSDguYDguKfguYfguJo) 3
EMP (fsl) 3
Subject (lSDguYDguYAg4LiV4LiBIOC4h+C5iOC4suC4oizguKrguKXguY) 3
Subject (Buy Xanax) 3
TOTAL: 137 3848

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
usenet.blueworldhosting.com 11
endofthelinebbs-out.news.weretis.net 10
nntp.comgw.net 4
usenet.network 3
news.hispagatos.org 2
usenet.goja.nl.eu.org 1
TOTAL: 6 31
TOTAL: 1 31

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.netfront.net 12994 12989 0 3 0 0 99%06:18:31
2nyheter.lysator.liu.se 12999 10639 1951 328 0 0 81%06:18:31
3endofthelinebbs.peers.news.panix.com 13441 3697 9282 25 0 0 27%06:18:31
4usenet.network 14731 2783 9660 45 0 0 18%06:18:31
5news.quux.org 13910 2103 10576 270 0 0 15%06:18:31
6news.nntp4.net 12249 639 10362 139 0 0 5%06:18:31
7news.hispagatos.org 14108 511 11379 547 0 0 3%06:18:31
8paganini.bofh.team 14848 311 12694 0 0 1 2%06:18:31
9news.bbs.nz 23190 222 11649 1136 0 39 0%06:18:31
10news.furie.org.uk 3817 204 3325 7 0 0 5%06:18:31
11usenet.blueworldhosting.com 11403 137 10688 0 0 0 1%06:18:31
12ddt.demos.su 250 134 116 0 0 0 53%06:08:40
13news.weretis.net 13497 127 12169 709 0 0 0%06:18:31
14usenet.goja.nl.eu.org 14223 93 12198 425 0 5 0%06:18:31
15nntp.comgw.net 14744 83 12627 295 0 0 0%06:18:31
16news.nk.ca 18609 37 11473 1482 0 11 0%06:18:31
17newsfeed.xs3.de 13905 34 11846 287 0 0 0%06:18:31
18i2pn.org 20782 31 11716 1158 0 111 0%06:18:29
19news.chmurka.net 3759 20 3473 10 0 0 0%06:18:31
20news.tnetconsulting.net 15196 7 12046 952 0 0 0%06:18:31
21news.samoylyk.net 15621 3 12802 196 0 0 0%06:18:31
TOTAL: 21 278276 34804 192032 8014 0 167 12%132:18:58
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.netfront.net125.5 MB24.8 KB125.5 MB5.7 KB/s9.9 KB06:18:31
2nyheter.lysator.liu.se114.9 MB1.7 MB116.6 MB5.3 KB/s10.9 KB06:18:31
3endofthelinebbs.peers.news.panix.com40.3 MB283.8 KB40.6 MB1.8 KB/s11.2 KB06:18:31
4usenet.network31.6 MB483.3 KB32.0 MB1.4 KB/s11.6 KB06:18:31
5news.quux.org22.6 MB1.1 MB23.7 MB1.1 KB/s10.2 KB06:18:31
6news.hispagatos.org8.4 MB4.1 MB12.5 MB0.6 KB/s12.1 KB06:18:31
7news.nntp4.net6.9 MB298.1 KB7.2 MB0.3 KB/s9.5 KB06:18:31
8news.furie.org.uk2.3 MB53.4 KB2.3 MB0.1 KB/s11.2 KB06:18:31
9news.bbs.nz2.1 MB9.1 MB11.1 MB0.5 KB/s8.4 KB06:18:31
10paganini.bofh.team1.9 MB0.0 KB1.9 MB0.1 KB/s6.3 KB06:18:31
11news.weretis.net1.1 MB6.4 MB7.5 MB0.3 KB/s9.2 KB06:18:31
12usenet.goja.nl.eu.org1.0 MB3.1 MB4.1 MB0.2 KB/s8.0 KB06:18:31
13nntp.comgw.net851.3 KB1.6 MB2.4 MB0.1 KB/s6.6 KB06:18:31
14newsfeed.xs3.de421.0 KB1.5 MB1.9 MB0.1 KB/s6.1 KB06:18:31
15usenet.blueworldhosting.com300.4 KB0.0 KB300.4 KB0.0 KB/s2.2 KB06:18:31
16ddt.demos.su290.0 KB0.0 KB290.0 KB0.0 KB/s2.2 KB06:08:40
17news.chmurka.net127.9 KB275.5 KB403.4 KB0.0 KB/s13.4 KB06:18:31
18news.nk.ca116.2 KB12.2 MB12.3 MB0.6 KB/s8.3 KB06:18:31
19i2pn.org105.3 KB11.6 MB11.7 MB0.5 KB/s10.1 KB06:18:29
20news.tnetconsulting.net30.1 KB8.8 MB8.8 MB0.4 KB/s9.4 KB06:18:31
21news.samoylyk.net25.7 KB978.5 KB1004.2 KB0.0 KB/s5.0 KB06:18:31
TOTAL: 21360.8 MB63.4 MB424.2 MB0.9 KB/s10.1 KB132:18:58
Outgoing feeds (innfeed) by Volume

Rnews connections rejected:

ReasonConn
400 upgrade 1
TOTAL: 1 1

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.cust.vodafonedsl.it 689 00.0 KB 0 0 000:06:50
TOTAL: 1 689 00.0 KB 4 0 000:06:50

NNRP auth users [Top 20]:

UserConn
crashtestdummy 1
TOTAL: 1 1

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
net-188-216-31-233.cust.vodafonedsl.it 69.990 33.596 0.00000:06:50
bbs.endofthelinebbs.com 0.340 0.175 0.99700:00:41
TOTAL: 2 70.330 33.771 0.99700:07:32

Curious NNRP server explorers [Top 20]:

SystemConn
net-188-216-31-233.cust.vodafonedsl.it 689
bbs.endofthelinebbs.com 1
TOTAL: 2 690

NNRP no permission clients [Top 20]:

SystemConn
bbs.endofthelinebbs.com 2
TOTAL: 1 2

Newsgroup request counts (by hierarchy):

HierarchyCountPct
1news 3 50.0%
2comp 3 50.0%
TOTAL: 2 6100.0%

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

NewsgroupCount
1comp.sys.acorn.networking 3
2news.answers 2
3news.admin.peering 1
TOTAL: 3 6