Daily Usenet Report

Feb 27 00:01:02 -- Feb 28 00:01:02

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

Feb 27 00:06:57 www innd: message repeated 2 times: [ ctlinnd command s]
Feb 27 16:12:41 www nnrpd[383811]: unable to get certificates from '/news/etc/cert.pem'
Feb 27 16:12:41 www nnrpd[383811]: error initializing TLS: [CA_file: ] [CA_path: /news/etc] [cert_file: /news/etc/cert.pem] [key_file: /news/etc/key.pem]

Log entries by program:

Program nameLines%LinesSize%Size
inn 23073 59.1%4.8 MB 68.8%
innd 13591 34.8%1.8 MB 25.1%
innfeed 2324 6.0%433.3 KB 6.0%
nnrpd 31 0.1%3.3 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 5 39020 100.0%7.0 MB100.0%

History cache:

ReasonCount%Count
Positive hits 95619 51.1%
Negative hits 68719 36.7%
Do not exist 22746 12.2%
Cache misses 47 0.0%
TOTAL: 4 187131 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.143 0.0%83 0.000 1.723 44.000
article cleanup00:00:00.483 0.0%22732 0.000 0.021 0.081
article logging00:00:00.981 0.0%22997 0.000 0.043 0.111
article parse00:00:08.154 0.0%463328 0.000 0.018 0.078
article write00:00:12.675 0.0%11396 0.284 1.112 2.526
artlog/artcncl00:00:00.000 0.0%83 0.000 0.000 0.000
data move00:00:01.340 0.0%637246 0.000 0.002 0.007
hisgrep/artcncl00:00:00.013 0.0%45 0.000 0.289 1.000
hishave/artcncl00:00:00.020 0.0%83 0.000 0.241 0.545
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:09.289 0.0%187417 0.005 0.050 0.126
history sync00:00:00.050 0.0%355 0.000 0.141 2.000
history write00:00:12.812 0.0%22728 0.053 0.564 0.940
hiswrite/artcncl00:00:00.016 0.0%38 0.364 0.421 1.000
idle23:56:08.807 99.7%592372 17.612 145.464 1460.630
nntp read00:01:04.459 0.1%603112 0.020 0.107 0.160
overview write00:00:07.349 0.0%11396 0.276 0.645 4.724
perl filter00:00:55.314 0.1%22728 1.650 2.434 6.365
python filter00:00:03.420 0.0%22728 0.090 0.150 0.433
site send00:00:04.370 0.0%22792 0.067 0.192 0.469
TOTAL: 24:00:46.04823:59:09.695 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.157 0.0%11696 0.000 0.013 0.125
article prepare00:00:00.010 0.0%31544 0.000 0.000 0.006
article read00:00:01.351 0.0%5103 0.044 0.265 3.267
backlog stats00:00:00.575 0.0%242684 0.000 0.002 0.009
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:05.791 0.0%161321 0.016 0.036 0.086
data write00:00:20.990 0.0%151279 0.089 0.139 0.234
idle23:56:02.728100.0%242684 215.764 355.041 983.549
status file00:00:00.194 0.0%190 0.000 1.021 5.000
TOTAL: 23:56:42.72523:56:31.796100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:13.761 91.4%10 26.500 1376.100 10051.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.001 0.0%29 0.000 0.034 0.167
TOTAL: 00:00:15.06200:00:13.762 91.4%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1endofthelinebbs-out.news.weretis.net 4 18944 6844 11619 481 36%39:45:03
2usenet.blueworldhosting.com 5 13120 3041 9328 751 23%23:44:42
3outgoing.news.lysator.liu.se 2 12933 643 11764 526 4%23:59:41
4newsfeed.xs3.de 1 10285 436 9839 10 4%23:59:55
5news.samoylyk.net 1 10677 88 10566 23 0%23:59:48
6glockenspiel.complete.org 1 10792 77 10679 36 0%23:59:53
7news.bbs.nz 4 15970 15 15955 0 0%35:58:49
8news.netfront.net 18 22745 13 13165 9567 0%31:46:53
9news.furie.org.uk 2 5716 11 5705 0 0%23:59:36
10localhost 25 0 0 0 0 0%00:00:00
11eotl-out.news.tnetconsulting.net 1 0 0 0 0 0%00:10:14
12news.nk.ca 2 0 0 0 0 0%00:21:11
TOTAL: 12 66 121182 11168 98620 11394 9%251:45:45
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1endofthelinebbs-out.news.weretis.net22.2 MB0.0 KB793.7 KB23.0 MB 96%3.2 KB
2usenet.blueworldhosting.com17.9 MB5.1 KB3.1 MB21.0 MB 85%5.7 KB
3newsfeed.xs3.de1.6 MB0.0 KB16.9 KB1.6 MB 98%3.7 KB
4outgoing.news.lysator.liu.se1.3 MB0.0 KB1.5 MB2.8 MB 46%2.5 KB
5news.samoylyk.net468.4 KB0.0 KB63.3 KB531.7 KB 88%4.8 KB
6glockenspiel.complete.org285.3 KB0.0 KB100.2 KB385.6 KB 74%3.4 KB
7news.bbs.nz57.2 KB0.0 KB0.0 KB57.2 KB100%3.8 KB
8news.furie.org.uk31.4 KB0.0 KB0.0 KB31.4 KB100%2.9 KB
9news.netfront.net28.6 KB0.0 KB3.4 GB3.4 GB 0%377.1 KB
10localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
11eotl-out.news.tnetconsulting.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
12news.nk.ca0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1243.9 MB5.1 KB3.5 GB3.5 GB 1%162.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Feb 27 00:01:02 - 00:59:59 239 2.1% 0.07719.2 KB 1.6% 0.20
Feb 27 01:00:00 - 01:59:59 389 3.4% 0.111.6 MB 3.6% 0.46
Feb 27 02:00:00 - 02:59:59 585 5.1% 0.161.7 MB 3.8% 0.49
Feb 27 03:00:00 - 03:59:59 590 5.2% 0.161.8 MB 4.1% 0.52
Feb 27 04:00:00 - 04:59:59 572 5.0% 0.162.1 MB 4.7% 0.61
Feb 27 05:00:00 - 05:59:59 561 4.9% 0.162.2 MB 5.0% 0.64
Feb 27 06:00:00 - 06:59:59 621 5.5% 0.172.9 MB 6.5% 0.83
Feb 27 07:00:00 - 07:59:59 519 4.6% 0.141.7 MB 3.7% 0.48
Feb 27 08:00:00 - 08:59:59 568 5.0% 0.162.3 MB 5.1% 0.65
Feb 27 09:00:00 - 09:59:59 720 6.3% 0.202.5 MB 5.6% 0.72
Feb 27 10:00:00 - 10:59:59 616 5.4% 0.172.0 MB 4.5% 0.58
Feb 27 11:00:00 - 11:59:59 661 5.8% 0.182.1 MB 4.7% 0.60
Feb 27 12:00:00 - 12:59:59 633 5.6% 0.182.9 MB 6.3% 0.81
Feb 27 13:00:00 - 13:59:59 628 5.5% 0.172.7 MB 5.9% 0.76
Feb 27 14:00:00 - 14:59:59 554 4.9% 0.151.6 MB 3.6% 0.46
Feb 27 15:00:00 - 15:59:59 533 4.7% 0.152.0 MB 4.4% 0.57
Feb 27 16:00:00 - 16:59:59 470 4.1% 0.131.6 MB 3.6% 0.46
Feb 27 17:00:00 - 17:59:59 377 3.3% 0.102.7 MB 6.0% 0.77
Feb 27 18:00:00 - 18:59:59 338 3.0% 0.091.1 MB 2.5% 0.32
Feb 27 19:00:00 - 19:59:59 259 2.3% 0.071.1 MB 2.4% 0.31
Feb 27 20:00:00 - 20:59:59 240 2.1% 0.071.3 MB 2.8% 0.36
Feb 27 21:00:00 - 21:59:59 259 2.3% 0.071.1 MB 2.4% 0.31
Feb 27 22:00:00 - 22:59:59 232 2.0% 0.062.0 MB 4.4% 0.56
Feb 27 23:00:00 - 23:59:59 218 1.9% 0.061.2 MB 2.7% 0.35
Feb 28 00:00:00 - 00:01:02 10 0.1% 0.1636.0 KB 0.1% 0.58
TOTAL: 24:00:00 11392 100.0% 0.1345.1 MB 100.0% 0.53
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.netfront.net 9475 0 0 0 0 0 0 0 9475
2usenet.blueworldhosting.com 774 19 0 1 0 0 0 0 754
3endofthelinebbs-out.news.weretis.net 737 0 0 1 0 0 0 0 736
4outgoing.news.lysator.liu.se 540 0 0 1 0 0 0 0 539
5glockenspiel.complete.org 33 0 0 0 0 0 0 0 33
6news.samoylyk.net 22 0 0 0 0 0 0 0 22
7newsfeed.xs3.de 17 0 0 1 0 0 0 0 16
TOTAL: 7 11598 19 0 4 0 0 0 011575

Unwanted newsgroups [Top 20]:

NewsgroupCount
rocksolid.feeds.news 5
test 2
alt.its.just.a.test 1
alt.all-your-base-are-belong-to-us 1
alt.freemasonry.uk 1
gun.general 1
soc.culture.germany 1
alt.french 1
alt.sex.fetish.feet.toes 1
soc.culture.france 1
soc.culutre.china 1
panix.questions 1
soc.culture.mexico 1
alt.soc.germans 1
TOTAL: 14 19

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups (low_xpost) 3597
EMP (md5) 812
EMP (phn path) 784
Binary: misplaced binary fx06.ams4.POSTED 497
Binary: misplaced binary fx09.iad.POSTED 439
Binary: misplaced binary fx17.iad.POSTED 426
Binary: misplaced binary fx05.ams4.POSTED 330
Binary: misplaced binary fx18.iad.POSTED 327
Binary: misplaced binary fx14.iad.POSTED 280
Binary: misplaced binary fx15.iad.POSTED 231
Binary: misplaced binary fx10.iad.POSTED 226
Binary: misplaced binary fx13.iad.POSTED 214
Binary: misplaced binary fx03.iad.POSTED 198
Binary: misplaced binary fx01.ams4.POSTED 188
Binary: misplaced binary fx03.ams4.POSTED 167
Binary: misplaced binary fx16.iad.POSTED 164
Binary: misplaced binary fx14.ams4.POSTED 163
Binary: misplaced binary fx12.ams4.POSTED 161
Binary: misplaced binary fx39.iad.POSTED 142
Binary: misplaced binary fx38.iad.POSTED 130
TOTAL: 51 11310

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
endofthelinebbs-out.news.weretis.net 248
usenet.blueworldhosting.com 9
newsfeed.xs3.de 6
outgoing.news.lysator.liu.se 2
TOTAL: 4 265
TOTAL: 1 265

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.netfront.net 15507 4736 6627 16 0 8 30%23:59:43
2nyheter.lysator.liu.se 11065 2751 7995 6 0 0 24%23:59:49
3news.nk.ca 14383 108 11180 65 0 252 0%23:59:56
4news.furie.org.uk 8660 71 5894 12 0 3 0%23:59:56
5usenet.blueworldhosting.com 10471 40 8235 1 0 0 0%23:59:56
6news.bbs.nz 22093 12 11296 60 0 59 0%23:59:56
7news.quux.org 11628 5 11207 22 0 0 0%23:59:24
8news.tnetconsulting.net 12159 1 11384 0 0 1 0%23:59:56
9news.weretis.net 11471 1 11385 1 0 0 0%23:59:56
10peer.alt119.net 0 0 0 0 0 11389 0%23:57:46
11newsfeed.xs3.de 13237 0 10970 0 0 0 0%23:59:56
12news.samoylyk.net 13796 0 11301 1 0 0 0%23:59:49
TOTAL: 12 144470 7725 107474 184 0 11712 5%287:56:03
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.netfront.net18.0 MB67.1 KB18.1 MB0.2 KB/s3.9 KB23:59:43
2nyheter.lysator.liu.se11.8 MB25.4 KB11.8 MB0.1 KB/s4.4 KB23:59:49
3news.furie.org.uk995.7 KB45.2 KB1.0 MB0.0 KB/s12.5 KB23:59:56
4news.nk.ca396.1 KB366.1 KB762.1 KB0.0 KB/s4.4 KB23:59:56
5usenet.blueworldhosting.com127.1 KB1.2 KB128.3 KB0.0 KB/s3.1 KB23:59:56
6news.bbs.nz44.3 KB340.2 KB384.5 KB0.0 KB/s5.3 KB23:59:56
7news.quux.org12.3 KB122.7 KB135.0 KB0.0 KB/s5.0 KB23:59:24
8news.weretis.net1.4 KB5.1 KB6.5 KB0.0 KB/s3.3 KB23:59:56
9news.tnetconsulting.net0.9 KB0.0 KB0.9 KB0.0 KB/s0.9 KB23:59:56
10peer.alt119.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:46
11newsfeed.xs3.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:56
12news.samoylyk.net0.0 KB4.4 KB4.4 KB0.0 KB/s4.4 KB23:59:49
TOTAL: 1231.3 MB977.4 KB32.3 MB0.0 KB/s4.2 KB287:56:03
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1198.199.117.146 1 00.0 KB 0 0 000:00:00
2scanner-05.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
3fabulous.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:02
4independent.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
5146.190.252.105 1 00.0 KB 0 0 000:00:10
694.102.61.41 1 00.0 KB 0 0 000:00:00
TOTAL: 6 6 00.0 KB 0 0 000:00:15

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.monitoring.internet-measurement.com 2 00.0 KB 0 0 000:00:03
2*.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
3unresolved 3 00.0 KB 0 0 000:00:10
TOTAL: 3 6 00.0 KB 0 0 000:00:15

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
146.190.252.105 0.119 0.008 0.00000:00:10
fabulous.monitoring.internet-measurement.com 0.087 0.024 0.00000:00:02
independent.monitoring.internet-measurement.com 0.102 0.040 0.00000:00:01
scanner-05.ch1.censys-scanner.com 0.115 0.033 0.00000:00:00
94.102.61.41 0.105 0.017 0.00000:00:00
198.199.117.146 0.082 0.033 0.00000:00:00
TOTAL: 6 0.610 0.155 0.00000:00:15

NNRP unrecognized commands (by host):

SystemConn
94.102.61.41 5
198.199.117.146 1
scanner-05.ch1.censys-scanner.com 1
TOTAL: 3 7

NNRP unrecognized commands (by command):

CommandCount
Host: 192.138.210.162:119 1
EHLO www.censys.io 1
MGLNDD_192.138.210.162_119 1
Accept-Encoding: gzip 1
User-Agent: Mozilla/5.0 (Windows NT 10.0... 1
GET / HTTP/1.1 1
Accept: */* 1
TOTAL: 7 7