Daily Usenet report

Jun 27 00:01:02 -- Jun 28 00:01:02

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Jun 27 00:29:32 www innd: message repeated 2 times: [ ctlinnd command s]

Log entries by program:

Program nameLines%LinesSize%Size
inn 14301 53.0%5.1 MB 72.3%
innd 8700 32.2%1.2 MB 17.2%
innfeed 3687 13.7%729.4 KB 10.2%
nnrpd 293 1.1%25.6 KB 0.4%
controlchan 1 0.0%0.2 KB 0.0%
TOTAL: 5 26982 100.0%7.0 MB100.0%

History cache:

ReasonCount%Count
Positive hits 164105 56.3%
Negative hits 113161 38.9%
Do not exist 13995 4.8%
Cache misses 15 0.0%
TOTAL: 4 291276 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.092 0.0%41 0.000 2.244 9.000
article cleanup00:00:00.261 0.0%14074 0.000 0.019 0.077
article logging00:00:00.703 0.0%14245 0.000 0.049 0.136
article parse00:00:00.608 0.0%30279 0.000 0.020 0.083
article write00:00:16.747 0.0%12000 0.798 1.396 3.593
artlog/artcncl00:00:00.000 0.0%7 0.000 0.000 0.000
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.311 0.0%295878 0.000 0.001 0.007
hisgrep/artcncl00:00:00.017 0.0%48 0.000 0.354 2.000
hishave/artcncl00:00:00.000 0.0%7 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:10.849 0.0%292685 0.007 0.037 0.119
history sync00:00:00.123 0.0%397 0.000 0.310 1.000
history write00:00:09.889 0.0%14072 0.303 0.703 2.355
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:47:35.831 99.8%289717 137.460 295.653 1374.158
nntp read00:00:09.924 0.0%295077 0.014 0.034 0.135
overview write00:00:22.800 0.0%12000 0.705 1.900 28.770
perl filter00:00:24.373 0.0%14072 1.311 1.732 3.733
python filter00:00:01.791 0.0%14073 0.052 0.127 0.400
site send00:00:04.709 0.0%24000 0.059 0.196 0.729
TOTAL: 23:51:04.92723:49:19.028 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.135 0.0%12405 0.000 0.011 0.123
article prepare00:00:00.015 0.0%88936 0.000 0.000 0.002
article read00:00:03.802 0.0%12029 0.111 0.316 1.100
backlog stats00:00:00.775 0.0%353447 0.000 0.002 0.009
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:07.239 0.0%261929 0.006 0.028 0.052
data write00:00:34.432 0.0%251770 0.105 0.137 0.209
idle23:55:50.172 99.9%353447 132.583 243.743 909.183
status file00:00:00.265 0.0%284 0.000 0.933 9.000
TOTAL: 23:56:52.05823:56:36.835100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:12.260 52.1%39 19.500 314.359 4845.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.006 0.0%140 0.000 0.043 0.333
TOTAL: 00:00:23.53300:00:12.266 52.1%----

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
1endofthelinebbs-out.news.weretis.net 9 24596 3770 20509 317 15%54:11:57
2usenet.blueworldhosting.com 720 13295 2589 10158 548 19%23:46:36
3outgoing.news.lysator.liu.se 3 10707 2205 8193 309 20%24:08:51
4usenet.goja.nl.eu.org 12 13048 1171 11701 176 8%24:17:54
5usenet.network 1 10184 628 9210 346 6%21:02:49
6endofthelinebbs.peers.news.panix.com 25 12072 363 11682 27 3%23:56:33
7paganini.bofh.team 2 13263 358 12833 72 2%23:58:47
8endoftheline-out.news.chmurka.net 1 4528 251 4272 5 5%23:59:57
9newsfeed.xs3.de 2 10239 246 9993 0 2%23:59:53
10i2pn.org 1 12105 238 11850 17 1%23:59:52
11glockenspiel.complete.org 2 10806 99 10617 90 0%24:00:23
12news.nntp4.net 2 11073 92 10977 4 0%23:59:24
13nntp.alphanet.ch 24 8582 79 8483 20 0%23:47:12
14194.87.241.33 35 117 55 61 1 47%09:15:35
15news.samoylyk.net 2 10913 15 10897 1 0%23:59:42
16news.bbs.nz 4 18264 15 18249 0 0%40:19:16
17news.furie.org.uk 2 5350 10 5339 1 0%23:59:40
18localhost 26 1 1 0 0 100%00:00:00
19news.netfront.net 34 220 0 21 199 0%07:04:59
20news.nk.ca 2 0 0 0 0 0%00:20:02
21eotl-out.news.tnetconsulting.net 1 0 0 0 0 0%00:10:15
TOTAL: 21 910 189363 12185 175045 2133 6%444:19:37
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1endofthelinebbs-out.news.weretis.net21.1 MB483.3 KB482.2 KB22.0 MB 95%5.5 KB
2usenet.blueworldhosting.com20.6 MB0.0 KB1.8 MB22.3 MB 92%7.3 KB
3outgoing.news.lysator.liu.se5.3 MB0.0 KB1.1 MB6.4 MB 82%2.6 KB
4usenet.goja.nl.eu.org3.6 MB0.0 KB385.7 KB4.0 MB 90%3.0 KB
5usenet.network2.2 MB0.0 KB766.9 KB2.9 MB 74%3.1 KB
6newsfeed.xs3.de1.8 MB0.0 KB0.0 KB1.8 MB100%7.4 KB
7paganini.bofh.team1.5 MB0.0 KB344.4 KB1.9 MB 82%4.5 KB
8nntp.alphanet.ch1.4 MB0.0 KB63.7 KB1.4 MB 95%14.8 KB
9endofthelinebbs.peers.news.panix.com1.4 MB0.0 KB98.0 KB1.4 MB 93%3.8 KB
10i2pn.org1004.2 KB1.5 KB71.5 KB1.1 MB 93%4.2 KB
11endoftheline-out.news.chmurka.net777.4 KB0.0 KB3.9 KB781.4 KB 99%3.1 KB
12glockenspiel.complete.org564.8 KB0.0 KB226.2 KB791.0 KB 71%4.2 KB
13news.nntp4.net263.4 KB0.0 KB37.3 KB300.7 KB 87%3.1 KB
14194.87.241.33172.7 KB0.0 KB3.0 KB175.8 KB 98%3.1 KB
15news.samoylyk.net76.4 KB0.0 KB483.2 KB559.6 KB 13%35.0 KB
16news.bbs.nz43.1 KB0.0 KB0.0 KB43.1 KB100%2.9 KB
17news.furie.org.uk33.3 KB0.0 KB1.4 KB34.7 KB 95%3.2 KB
18localhost1.2 KB0.0 KB0.0 KB1.2 KB100%1.2 KB
19news.netfront.net0.0 KB0.0 KB109.5 MB109.5 MB 0%563.4 KB
20news.nk.ca0.0 KB0.0 KB0.0 KB0.0 KB 0%0
21eotl-out.news.tnetconsulting.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 2161.6 MB484.8 KB115.2 MB177.3 MB 34%12.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jun 27 00:01:02 - 00:59:59 423 3.5% 0.121.5 MB 2.5% 0.44
Jun 27 01:00:00 - 01:59:59 493 4.1% 0.143.8 MB 6.2% 1.09
Jun 27 02:00:00 - 02:59:59 561 4.7% 0.163.3 MB 5.4% 0.94
Jun 27 03:00:00 - 03:59:59 544 4.5% 0.152.3 MB 3.8% 0.66
Jun 27 04:00:00 - 04:59:59 607 5.0% 0.171.8 MB 2.9% 0.50
Jun 27 05:00:00 - 05:59:59 582 4.8% 0.162.3 MB 3.7% 0.64
Jun 27 06:00:00 - 06:59:59 584 4.9% 0.162.1 MB 3.4% 0.59
Jun 27 07:00:00 - 07:59:59 542 4.5% 0.154.4 MB 7.1% 1.25
Jun 27 08:00:00 - 08:59:59 664 5.5% 0.182.5 MB 4.0% 0.70
Jun 27 09:00:00 - 09:59:59 716 5.9% 0.203.1 MB 5.0% 0.87
Jun 27 10:00:00 - 10:59:59 683 5.7% 0.193.1 MB 5.0% 0.88
Jun 27 11:00:00 - 11:59:59 643 5.3% 0.182.1 MB 3.5% 0.61
Jun 27 12:00:00 - 12:59:59 710 5.9% 0.203.7 MB 6.0% 1.05
Jun 27 13:00:00 - 13:59:59 751 6.2% 0.212.4 MB 3.9% 0.68
Jun 27 14:00:00 - 14:59:59 627 5.2% 0.173.8 MB 6.2% 1.08
Jun 27 15:00:00 - 15:59:59 618 5.1% 0.175.2 MB 8.4% 1.47
Jun 27 16:00:00 - 16:59:59 471 3.9% 0.132.2 MB 3.6% 0.64
Jun 27 17:00:00 - 17:59:59 416 3.5% 0.123.4 MB 5.5% 0.97
Jun 27 18:00:00 - 18:59:59 313 2.6% 0.091.6 MB 2.6% 0.46
Jun 27 19:00:00 - 19:59:59 240 2.0% 0.07961.4 KB 1.5% 0.27
Jun 27 20:00:00 - 20:59:59 150 1.2% 0.04744.8 KB 1.2% 0.21
Jun 27 21:00:00 - 21:59:59 183 1.5% 0.05810.8 KB 1.3% 0.23
Jun 27 22:00:00 - 22:59:59 244 2.0% 0.073.5 MB 5.7% 1.01
Jun 27 23:00:00 - 23:59:59 269 2.2% 0.071.0 MB 1.7% 0.29
Jun 28 00:00:00 - 00:01:02 6 0.0% 0.1021.1 KB 0.0% 0.34
TOTAL: 24:00:00 12040 100.0% 0.1461.6 MB 100.0% 0.73
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1usenet.blueworldhosting.com 549 22 0 0 2 0 0 0 525
2endofthelinebbs-out.news.weretis.net 499 0 0 1 0 0 0 0 498
3usenet.network 346 67 0 0 0 0 0 0 279
4outgoing.news.lysator.liu.se 297 0 0 0 0 0 0 0 297
5news.netfront.net 199 0 0 0 0 0 0 0 199
6usenet.goja.nl.eu.org 166 0 0 0 0 0 0 0 166
7glockenspiel.complete.org 59 0 0 0 0 0 0 0 59
8paganini.bofh.team 58 0 0 0 0 0 0 0 58
9endofthelinebbs.peers.news.panix.com 27 9 0 0 0 0 0 0 18
10nntp.alphanet.ch 20 0 0 0 0 0 0 0 20
11i2pn.org 16 0 0 1 0 0 0 0 15
12news.nntp4.net 7 0 0 0 0 0 0 0 7
13endoftheline-out.news.chmurka.net 5 0 0 0 0 0 0 0 5
14news.samoylyk.net 3 0 0 0 0 0 0 0 3
15news.furie.org.uk 1 0 0 0 0 0 0 0 1
16newsfeed.xs3.de 1 0 0 0 0 0 0 0 1
TOTAL: 16 2253 98 0 2 2 0 0 0 2151

Unwanted newsgroups [Top 20]:

NewsgroupCount
odessa.news 33
perl.cpan 30
alfanet.nocem 25
kraft.binary 3
alt.reddit.usenet 1
soc.genealogy 1
alt.energy 1
alt.penthouse.sex.first-time 1
alt.test.test.test.test 1
alt.personals.sex 1
alt.bestjobsusa.portland.jobs 1
TOTAL: 11 98

Supposedly-moderated groups with unmoderated postings [Top 20]:

GroupsCount
alt.penthouse.sex.spanking 2
TOTAL: 1 2

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 776
EMP (phn path) 458
EMP (phr path) 341
Binary: misplaced binary 198
EMP (phn nph) 120
Too many newsgroups 47
User-issued cancel 15
EMP (phl) 9
HTML Multipart 8
Binary Image: misplaced jpg 7
Subject (Sex dating sites) 1
TOTAL: 11 1980

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
endofthelinebbs-out.news.weretis.net 156
usenet.network 4
usenet.goja.nl.eu.org 4
news.samoylyk.net 2
outgoing.news.lysator.liu.se 1
endoftheline-out.news.chmurka.net 1
news.nntp4.net 1
usenet.blueworldhosting.com 1
newsfeed.xs3.de 1
TOTAL: 9 171
TOTAL: 1 171

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.netfront.net 12041 12039 0 0 0 0 99%23:59:47
2nyheter.lysator.liu.se 10428 2421 6911 501 0 0 23%23:59:38
3endofthelinebbs.peers.news.panix.com 12234 690 11278 50 0 0 5%23:58:30
4paganini.bofh.team 14011 525 11509 0 0 0 3%23:59:55
5usenet.blueworldhosting.com 8960 352 8081 0 0 1 3%23:59:55
6ddt.demos.su 619 329 275 0 0 0 53%21:23:54
7news.nk.ca 15611 174 11322 494 0 19 1%23:59:55
8news.bbs.nz 23257 132 11457 434 0 152 0%23:59:55
9news.chmurka.net 5246 95 4012 1 0 0 1%23:59:55
10news.furie.org.uk 7142 85 5055 72 0 0 1%23:59:09
11news.tnetconsulting.net 12692 80 11505 430 0 3 0%23:59:55
12news.quux.org 12327 55 11470 473 0 0 0%23:59:55
13usenet.network 13887 50 10947 11 0 0 0%23:59:00
14i2pn.org 11902 39 11208 358 0 0 0%23:59:55
15news.weretis.net 12242 35 11607 392 0 164 0%23:59:55
16news.nntp4.net 13940 12 11511 356 0 4 0%23:59:55
17usenet.goja.nl.eu.org 12799 4 10407 403 0 15 0%23:59:55
18alphanet.ch 14664 4 11558 392 0 0 0%23:59:08
19newsfeed.xs3.de 13724 3 11371 417 0 0 0%23:59:10
20news.samoylyk.net 14435 3 11687 336 0 21 0%23:59:52
TOTAL: 20 242161 17127 183171 5120 0 379 7%477:17:13
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.netfront.net61.6 MB0.0 KB61.6 MB0.7 KB/s5.2 KB23:59:47
2nyheter.lysator.liu.se18.7 MB2.1 MB20.8 MB0.2 KB/s7.3 KB23:59:38
3news.furie.org.uk3.0 MB601.7 KB3.5 MB0.0 KB/s23.1 KB23:59:09
4paganini.bofh.team2.0 MB0.0 KB2.0 MB0.0 KB/s4.0 KB23:59:55
5endofthelinebbs.peers.news.panix.com1.8 MB78.0 KB1.9 MB0.0 KB/s2.6 KB23:58:30
6news.nk.ca828.1 KB1.9 MB2.7 MB0.0 KB/s4.1 KB23:59:55
7news.bbs.nz772.5 KB2.0 MB2.8 MB0.0 KB/s5.0 KB23:59:55
8usenet.blueworldhosting.com703.5 KB0.0 KB703.5 KB0.0 KB/s2.0 KB23:59:55
9ddt.demos.su662.5 KB0.0 KB662.5 KB0.0 KB/s2.0 KB21:23:54
10news.tnetconsulting.net328.0 KB1.3 MB1.6 MB0.0 KB/s3.3 KB23:59:55
11news.chmurka.net252.8 KB1.4 KB254.2 KB0.0 KB/s2.6 KB23:59:55
12news.quux.org251.3 KB1.6 MB1.8 MB0.0 KB/s3.6 KB23:59:55
13i2pn.org219.0 KB746.7 KB965.7 KB0.0 KB/s2.4 KB23:59:55
14usenet.network179.8 KB37.1 KB216.8 KB0.0 KB/s3.6 KB23:59:00
15news.weretis.net135.9 KB1.1 MB1.2 MB0.0 KB/s2.9 KB23:59:55
16news.nntp4.net39.5 KB790.4 KB829.9 KB0.0 KB/s2.3 KB23:59:55
17usenet.goja.nl.eu.org11.3 KB1.2 MB1.2 MB0.0 KB/s3.0 KB23:59:55
18alphanet.ch7.0 KB1.3 MB1.3 MB0.0 KB/s3.3 KB23:59:08
19news.samoylyk.net6.4 KB671.3 KB677.8 KB0.0 KB/s2.0 KB23:59:52
20newsfeed.xs3.de6.0 KB1.2 MB1.3 MB0.0 KB/s3.1 KB23:59:10
TOTAL: 2091.4 MB16.5 MB107.9 MB0.1 KB/s5.0 KB477:17:13
Outgoing feeds (innfeed) by Volume

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1? 15 00.0 KB 0 0 000:00:09
2*.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
3unresolved 4 00.0 KB 5 0 000:00:10
4*.ip-145-239-154.eu 2 00.0 KB 0 0 000:00:01
TOTAL: 4 22 00.0 KB 5 0 000:00:23

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
2607:ff10:c8:594::d 1.521 0.635 0.00000:00:09
138.68.63.7 0.083 0.058 0.00000:00:04
138.197.192.230 0.081 0.043 0.00000:00:04
composed.monitoring.internet-measurement.com 0.079 0.061 0.00000:00:01
ns31410048.ip-145-239-154.eu 0.108 0.037 0.00000:00:01
147.78.47.10 0.090 0.049 0.00000:00:00
162.243.151.22 0.069 0.077 0.00000:00:00
TOTAL: 7 2.031 0.960 0.00000:00:23

Curious NNRP server explorers [Top 20]:

SystemConn
2607:ff10:c8:594::d 15
ns31410048.ip-145-239-154.eu 2
composed.monitoring.internet-measurement.com 1
138.68.63.7 1
147.78.47.10 1
162.243.151.22 1
138.197.192.230 1
TOTAL: 7 22

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

SystemConn
2607:ff10:c8:594::d 36
ns31410048.ip-145-239-154.eu 1
162.243.151.22 1
147.78.47.10 1
TOTAL: 4 39

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

CommandCount
#023#003#023#001#023#002#001 5
Accept-Encoding: gzip 5
Accept: */* 5
User-Agent: Mozilla/5.0 (Windows NT 10.0... 5
GET / HTTP/1.1 5
#026#003#001 5
Host: [2604:880:52:292::1]:119 5
#026#003 1
MGLNDD_192.138.210.162_119 1
ªªX§àD#013¯ðÁ¸R 1
#003 1
TOTAL: 11 39

NNRP client timeouts [Top 20]:

SystemConnPeer
147.78.47.10 1 1
TOTAL: 1 1 1

Newsgroup request counts (by hierarchy):

HierarchyCountPct
1news 11 84.6%
2comp 2 15.4%
TOTAL: 2 13100.0%

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

NewsgroupCount
1news.admin.peering 8
2news.admin.net-abuse.usenet 3
3comp.sys.cbm 2
TOTAL: 3 13