Daily Usenet report

Jun 7 00:01:02 -- Jun 8 00:01:01

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Jun 7 00:28:55 www innd: message repeated 2 times: [ ctlinnd command s]

Log entries by program:

Program nameLines%LinesSize%Size
inn 19809 54.4%5.3 MB 70.0%
innd 13155 36.1%1.6 MB 21.2%
innfeed 3436 9.4%682.7 KB 8.8%
nnrpd 12 0.0%1.3 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 5 36413 100.0%7.6 MB100.0%

History cache:

ReasonCount%Count
Positive hits 154084 54.1%
Negative hits 111328 39.1%
Do not exist 19532 6.9%
Cache misses 67 0.0%
TOTAL: 4 285011 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.207 0.0%66 0.000 3.136 14.000
article cleanup00:00:00.430 0.0%19645 0.000 0.022 0.096
article logging00:00:01.048 0.0%19799 0.000 0.053 0.167
article parse00:00:05.119 0.0%259145 0.000 0.020 0.104
article write00:00:19.183 0.0%11155 0.845 1.720 6.865
artlog/artcncl00:00:00.000 0.0%14 0.000 0.000 0.000
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:01.681 0.0%528506 0.000 0.003 0.015
hisgrep/artcncl00:00:00.054 0.0%80 0.000 0.675 3.500
hishave/artcncl00:00:00.000 0.0%14 0.000 0.000 0.000
hishave/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:13.130 0.0%286885 0.013 0.046 0.270
history sync00:00:00.131 0.0%377 0.000 0.347 1.333
history write00:00:14.550 0.0%19622 0.388 0.742 2.580
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:54:38.160 99.6%496082 21.627 173.516 1092.745
nntp read00:00:41.527 0.0%504888 0.021 0.082 0.172
overview write00:01:49.694 0.1%11155 0.826 9.834 2039.929
perl filter00:00:38.601 0.0%19622 1.315 1.967 4.928
python filter00:00:02.710 0.0%19622 0.051 0.138 0.407
site send00:00:05.706 0.0%22310 0.056 0.256 0.591
TOTAL: 24:00:55.61023:58:51.931 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.153 0.0%11354 0.000 0.013 0.179
article prepare00:00:00.017 0.0%86596 0.000 0.000 0.019
article read00:00:03.930 0.0%11089 0.168 0.354 1.532
backlog stats00:00:00.684 0.0%340158 0.000 0.002 0.005
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:06.723 0.0%248724 0.011 0.027 0.042
data write00:00:34.928 0.0%238442 0.097 0.146 0.316
idle23:55:42.941 99.9%340158 145.127 253.244 785.948
status file00:00:00.234 0.0%211 0.000 1.109 4.000
TOTAL: 23:56:44.01623:56:29.610100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:09.752 94.5%4 0.000 2438.000 9701.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.000 0.0%9 0.000 0.000 0.000
TOTAL: 00:00:10.32000:00:09.752 94.5%----

Control commands to INND:

CommandNumber
flush 4
flushlogs 2
go 2
logmode 2
lowmark 1
mode 144
name 2
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 165

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1usenet.blueworldhosting.com 288 12321 3174 8479 668 25%23:44:52
2endofthelinebbs-out.news.weretis.net 4 18774 2881 15493 400 15%42:47:37
3outgoing.news.lysator.liu.se 1 10118 2267 6900 951 22%23:59:57
4usenet.goja.nl.eu.org 11 11646 876 10702 68 7%21:55:52
5usenet.network 2 11480 658 10737 85 5%23:59:56
6paganini.bofh.team 1 12412 291 12047 74 2%23:58:56
7endoftheline-out.news.chmurka.net 1 4624 247 4373 4 5%23:59:59
8endofthelinebbs.peers.news.panix.com 24 11278 187 11082 9 1%23:57:35
9i2pn.org 1 11163 143 11015 5 1%23:59:51
10newsfeed.xs3.de 2 9753 118 9635 0 1%23:59:25
11nntp.alphanet.ch 22 7268 84 7183 1 1%23:56:48
12news.nntp4.net 1 10217 69 10148 0 0%23:59:54
13glockenspiel.complete.org 2 4224 11 4190 23 0%11:35:39
14news.bbs.nz 1 10324 9 10315 0 0%23:59:39
15news.samoylyk.net 1 10306 6 10300 0 0%23:59:48
16news.furie.org.uk 1 5296 3 5293 0 0%23:59:56
17news.netfront.net 38 6791 0 650 6141 0%17:42:27
18localhost 25 0 0 0 0 0%00:00:00
19news.nk.ca 2 0 0 0 0 0%00:20:00
20eotl-out.news.tnetconsulting.net 1 0 0 0 0 0%00:10:14
TOTAL: 20 429 167995 11024 148542 8429 6%406:08:25
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1usenet.blueworldhosting.com21.5 MB0.0 KB2.8 MB24.2 MB 88%6.5 KB
2endofthelinebbs-out.news.weretis.net13.4 MB0.0 KB555.2 KB13.9 MB 96%4.3 KB
3outgoing.news.lysator.liu.se5.8 MB3.0 MB143.0 MB151.9 MB 3%48.3 KB
4usenet.network2.9 MB0.0 KB144.7 KB3.1 MB 95%4.2 KB
5usenet.goja.nl.eu.org2.6 MB0.0 KB146.9 KB2.8 MB 94%3.0 KB
6endoftheline-out.news.chmurka.net840.6 KB0.0 KB3.1 KB843.7 KB 99%3.4 KB
7paganini.bofh.team836.1 KB0.0 KB117.3 KB953.3 KB 87%2.6 KB
8endofthelinebbs.peers.news.panix.com662.9 KB0.0 KB39.7 KB702.6 KB 94%3.6 KB
9i2pn.org650.5 KB0.0 KB14.3 KB664.9 KB 97%4.5 KB
10newsfeed.xs3.de567.1 KB0.0 KB0.0 KB567.1 KB100%4.8 KB
11nntp.alphanet.ch384.8 KB0.0 KB1.0 KB385.8 KB 99%4.5 KB
12news.nntp4.net254.0 KB0.0 KB0.0 KB254.0 KB100%3.7 KB
13glockenspiel.complete.org86.0 KB0.0 KB42.4 KB128.4 KB 66%3.8 KB
14news.samoylyk.net43.8 KB0.0 KB0.0 KB43.8 KB100%7.3 KB
15news.bbs.nz14.2 KB0.0 KB0.0 KB14.2 KB100%1.6 KB
16news.furie.org.uk7.1 KB0.0 KB0.0 KB7.1 KB100%2.4 KB
17news.netfront.net0.0 KB5.7 MB2.0 GB2.0 GB 0%343.2 KB
18localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
19news.nk.ca0.0 KB0.0 KB0.0 KB0.0 KB 0%0
20eotl-out.news.tnetconsulting.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 2050.4 MB8.7 MB2.1 GB2.2 GB 2%118.9 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jun 7 00:01:02 - 00:59:59 301 2.7% 0.091.4 MB 2.8% 0.41
Jun 7 01:00:00 - 01:59:59 410 3.7% 0.111.6 MB 3.1% 0.45
Jun 7 02:00:00 - 02:59:59 458 4.1% 0.133.2 MB 6.2% 0.90
Jun 7 03:00:00 - 03:59:59 615 5.5% 0.173.0 MB 5.9% 0.85
Jun 7 04:00:00 - 04:59:59 528 4.7% 0.151.9 MB 3.7% 0.53
Jun 7 05:00:00 - 05:59:59 576 5.2% 0.162.0 MB 3.9% 0.56
Jun 7 06:00:00 - 06:59:59 546 4.9% 0.153.5 MB 6.9% 1.00
Jun 7 07:00:00 - 07:59:59 605 5.4% 0.172.5 MB 4.9% 0.71
Jun 7 08:00:00 - 08:59:59 593 5.3% 0.162.1 MB 4.1% 0.59
Jun 7 09:00:00 - 09:59:59 690 6.2% 0.193.3 MB 6.5% 0.94
Jun 7 10:00:00 - 10:59:59 624 5.6% 0.171.8 MB 3.5% 0.50
Jun 7 11:00:00 - 11:59:59 543 4.9% 0.151.8 MB 3.6% 0.52
Jun 7 12:00:00 - 12:59:59 601 5.4% 0.172.1 MB 4.2% 0.61
Jun 7 13:00:00 - 13:59:59 666 6.0% 0.182.9 MB 5.7% 0.82
Jun 7 14:00:00 - 14:59:59 467 4.2% 0.133.0 MB 5.9% 0.85
Jun 7 15:00:00 - 15:59:59 492 4.4% 0.141.8 MB 3.5% 0.51
Jun 7 16:00:00 - 16:59:59 427 3.8% 0.122.1 MB 4.1% 0.60
Jun 7 17:00:00 - 17:59:59 453 4.1% 0.132.1 MB 4.1% 0.60
Jun 7 18:00:00 - 18:59:59 361 3.2% 0.101.4 MB 2.8% 0.40
Jun 7 19:00:00 - 19:59:59 257 2.3% 0.07878.0 KB 1.7% 0.24
Jun 7 20:00:00 - 20:59:59 235 2.1% 0.07991.5 KB 1.9% 0.28
Jun 7 21:00:00 - 21:59:59 235 2.1% 0.072.1 MB 4.1% 0.59
Jun 7 22:00:00 - 22:59:59 208 1.9% 0.062.3 MB 4.6% 0.67
Jun 7 23:00:00 - 23:59:59 267 2.4% 0.071.1 MB 2.2% 0.32
Jun 8 00:00:00 - 00:01:01 6 0.1% 0.1015.5 KB 0.0% 0.25
TOTAL: 23:59:59 11164 100.0% 0.1350.7 MB 100.0% 0.60
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.netfront.net 6141 0 0 15 0 0 0 0 6126
2outgoing.news.lysator.liu.se 946 0 0 8 0 0 0 0 938
3usenet.blueworldhosting.com 675 12 0 0 0 0 0 0 663
4endofthelinebbs-out.news.weretis.net 507 0 0 0 0 0 0 0 507
5glockenspiel.complete.org 88 0 0 0 0 0 0 0 88
6usenet.goja.nl.eu.org 88 0 0 0 0 0 0 0 88
7usenet.network 83 71 0 0 0 0 0 0 12
8paganini.bofh.team 73 0 0 0 0 0 0 0 73
9endofthelinebbs.peers.news.panix.com 11 6 0 0 0 0 0 0 5
10endoftheline-out.news.chmurka.net 8 0 0 0 0 0 0 0 8
11i2pn.org 4 0 0 0 0 0 0 0 4
12newsfeed.xs3.de 3 0 0 0 0 0 0 0 3
13news.samoylyk.net 2 0 0 0 0 0 0 0 2
14news.nntp4.net 1 0 0 0 0 0 0 0 1
15nntp.alphanet.ch 1 0 0 0 0 0 0 0 1
TOTAL: 15 8631 89 0 23 0 0 0 0 8519

Unwanted newsgroups [Top 20]:

NewsgroupCount
odessa.news 37
perl.cpan 31
alfanet.nocem 15
alt.energy 2
alt.alt.sqwarch 1
alt.true.crime 1
soc.culture.russia 1
alt.bestjobsusa.portland.jobs 1
TOTAL: 8 89

INND Perl filter [Top 20]:

ReasonCount
Binary: misplaced binary 5859
Too many newsgroups 840
EMP (md5) 583
EMP (phn path) 336
EMP (phl) 333
EMP (phr path) 292
EMP (phn nph) 74
Too many newsgroups (meow) 35
User-issued cancel 10
Malformed article 2
hierarchy violation - crosspost outside sdnet 1
HTML Multipart 1
TOTAL: 12 8366

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
endofthelinebbs-out.news.weretis.net 113
usenet.goja.nl.eu.org 16
usenet.blueworldhosting.com 8
usenet.network 4
newsfeed.xs3.de 3
endoftheline-out.news.chmurka.net 3
news.samoylyk.net 2
outgoing.news.lysator.liu.se 2
news.nntp4.net 1
endofthelinebbs.peers.news.panix.com 1
TOTAL: 10 153
TOTAL: 1 153

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.netfront.net 11123 11088 0 34 0 16 99%24:02:06
2nyheter.lysator.liu.se 9209 2876 5298 651 0 0 31%24:02:06
3endofthelinebbs.peers.news.panix.com 11220 590 10526 4 0 0 5%24:02:06
4paganini.bofh.team 13672 539 10634 0 0 3 3%24:02:06
5usenet.blueworldhosting.com 7878 416 7081 0 0 0 5%24:03:10
6news.nk.ca 14835 86 10497 517 0 11 0%24:08:15
7news.bbs.nz 21426 44 10541 515 0 61 0%23:59:54
8news.furie.org.uk 7064 41 4962 32 0 0 0%24:02:06
9news.chmurka.net 5584 39 4105 6 0 0 0%23:58:57
10news.tnetconsulting.net 11859 37 10605 476 0 8 0%24:02:06
11usenet.network 13400 31 10071 10 0 0 0%24:02:06
12i2pn.org 11009 22 10410 416 0 0 0%24:01:48
13news.quux.org 11294 21 10558 494 0 0 0%24:01:30
14news.nntp4.net 13692 13 10550 422 0 0 0%24:01:33
15news.weretis.net 11221 12 10642 454 0 0 0%23:59:52
16alphanet.ch 13439 4 10546 485 0 25 0%24:01:55
17news.samoylyk.net 13926 4 10704 406 0 22 0%24:01:58
18usenet.goja.nl.eu.org 13006 3 9750 461 0 16 0%24:00:21
19newsfeed.xs3.de 13906 2 10513 472 0 52 0%23:59:54
TOTAL: 19 228763 15868 167993 5855 0 214 6%456:33:49
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.netfront.net50.2 MB557.4 KB50.7 MB0.6 KB/s4.7 KB24:02:06
2nyheter.lysator.liu.se19.1 MB2.5 MB21.6 MB0.3 KB/s6.3 KB24:02:06
3paganini.bofh.team2.3 MB0.0 KB2.3 MB0.0 KB/s4.4 KB24:02:06
4endofthelinebbs.peers.news.panix.com1.7 MB11.7 KB1.7 MB0.0 KB/s3.0 KB24:02:06
5usenet.blueworldhosting.com818.3 KB0.0 KB818.3 KB0.0 KB/s2.0 KB24:03:10
6news.furie.org.uk688.6 KB443.2 KB1.1 MB0.0 KB/s15.5 KB24:02:06
7news.nntp4.net634.1 KB824.6 KB1.4 MB0.0 KB/s3.4 KB24:01:33
8news.quux.org459.2 KB1.4 MB1.9 MB0.0 KB/s3.7 KB24:01:30
9news.nk.ca452.0 KB2.5 MB3.0 MB0.0 KB/s5.0 KB24:08:15
10news.samoylyk.net399.0 KB801.3 KB1.2 MB0.0 KB/s2.9 KB24:01:58
11news.tnetconsulting.net370.4 KB1.3 MB1.6 MB0.0 KB/s3.2 KB24:02:06
12news.bbs.nz361.9 KB1.9 MB2.3 MB0.0 KB/s4.2 KB23:59:54
13news.chmurka.net234.7 KB11.7 KB246.4 KB0.0 KB/s5.5 KB23:58:57
14usenet.network107.6 KB80.4 KB188.0 KB0.0 KB/s4.6 KB24:02:06
15i2pn.org66.6 KB826.9 KB893.4 KB0.0 KB/s2.0 KB24:01:48
16news.weretis.net45.1 KB2.0 MB2.1 MB0.0 KB/s4.5 KB23:59:52
17usenet.goja.nl.eu.org14.9 KB1.5 MB1.5 MB0.0 KB/s3.3 KB24:00:21
18alphanet.ch12.7 KB2.1 MB2.2 MB0.0 KB/s4.5 KB24:01:55
19newsfeed.xs3.de10.9 KB1.7 MB1.7 MB0.0 KB/s3.7 KB23:59:54
TOTAL: 1977.9 MB20.4 MB98.3 MB0.1 KB/s4.6 KB456:33:49
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1162.243.144.9 1 00.0 KB 0 0 000:00:09
2ec2-44-242-136-139.us-west-2.compute.amazonaws.com 1 00.0 KB 0 0 000:00:00
3192.241.206.91 1 00.0 KB 0 0 000:00:00
TOTAL: 3 3 00.0 KB 0 0 000:00:10

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 2 00.0 KB 0 0 000:00:10
2*.us-west-2.compute.amazonaws.com 1 00.0 KB 0 0 000:00:00
TOTAL: 2 3 00.0 KB 0 0 000:00:10

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
162.243.144.9 0.089 0.048 0.00000:00:09
192.241.206.91 0.093 0.075 0.00000:00:00
ec2-44-242-136-139.us-west-2.compute.amazonaws.com 0.071 0.069 0.00000:00:00
TOTAL: 3 0.253 0.192 0.00000:00:10

NNRP unrecognized commands (by host) [Top 20]:

SystemConn
192.241.206.91 1
TOTAL: 1 1

NNRP unrecognized commands (by command) [Top 20]:

CommandCount
MGLNDD_192.138.210.162_119 1
TOTAL: 1 1