Daily Usenet Report

Dec 3 00:01:02 -- Dec 4 00:01:02

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

Dec 3 00:06:20 www innd: message repeated 2 times: [ ctlinnd command s]
Dec 3 16:09:40 www nnrpd[2037475]: unable to get certificates from '/news/etc/cert.pem'
Dec 3 16:09:40 www nnrpd[2037475]: 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 12031 66.9%3.2 MB 77.6%
innd 3580 19.9%517.5 KB 12.1%
innfeed 2341 13.0%439.0 KB 10.3%
nnrpd 23 0.1%2.4 KB 0.1%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 5 17976 100.0%4.2 MB100.0%

History cache:

ReasonCount%Count
Positive hits 85574 57.3%
Negative hits 51937 34.8%
Do not exist 11751 7.9%
Cache misses 25 0.0%
TOTAL: 4 149287 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.064 0.0%68 0.000 0.941 6.000
article cleanup00:00:00.231 0.0%11772 0.000 0.020 0.085
article logging00:00:00.604 0.0%11966 0.000 0.050 0.160
article parse00:00:00.359 0.0%17736 0.000 0.020 0.068
article write00:00:08.712 0.0%10334 0.384 0.843 2.062
artlog/artcncl00:00:00.000 0.0%68 0.000 0.000 0.000
data move00:00:00.229 0.0%150905 0.000 0.002 0.016
hisgrep/artcncl00:00:00.003 0.0%68 0.000 0.044 1.000
hishave/artcncl00:00:00.004 0.0%68 0.000 0.059 1.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:06.726 0.0%149482 0.005 0.045 0.079
history sync00:00:00.073 0.0%397 0.000 0.184 1.333
history write00:00:06.978 0.0%11772 0.085 0.593 1.087
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:58:22.588 99.8%148358 288.504 581.718 2198.524
nntp read00:00:06.898 0.0%149083 0.028 0.046 0.078
overview write00:00:07.249 0.0%10334 0.212 0.701 4.136
perl filter00:00:36.043 0.0%11772 2.376 3.062 5.531
python filter00:00:02.096 0.0%11772 0.075 0.178 0.486
site send00:00:04.173 0.0%20668 0.066 0.202 0.540
TOTAL: 24:00:55.92023:59:43.030 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.123 0.0%10640 0.000 0.012 0.175
article prepare00:00:00.007 0.0%32964 0.000 0.000 0.011
article read00:00:01.611 0.0%5292 0.067 0.304 5.273
backlog stats00:00:00.603 0.0%218064 0.000 0.003 0.010
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:05.807 0.0%144795 0.020 0.040 0.069
data write00:00:20.905 0.0%136319 0.071 0.153 0.402
idle23:54:54.114100.0%218064 207.117 394.811 1142.177
status file00:00:00.220 0.0%200 0.000 1.100 6.000
TOTAL: 23:55:33.84723:55:23.390100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:11.897 92.2%8 26.000 1487.125 10005.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.015 0.1%16 0.000 0.938 4.000
TOTAL: 00:00:12.89900:00:11.912 92.3%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1endofthelinebbs-out.news.weretis.net 4 20717 6000 14416 301 28%51:46:55
2usenet.blueworldhosting.com 5 11187 3205 7551 431 28%22:58:33
3outgoing.news.lysator.liu.se 2 11659 576 10526 557 4%23:58:59
4newsfeed.xs3.de 2 9350 464 8882 4 4%23:58:53
5news.samoylyk.net 1 9768 53 9701 14 0%23:59:43
6glockenspiel.complete.org 2 10326 31 10293 2 0%23:59:51
7news.bbs.nz 1 5064 8 5056 0 0%14:30:24
8news.furie.org.uk 2 5330 4 5326 0 0%23:59:34
9news.netfront.net 1 10928 2 10806 120 0%21:21:08
10localhost 25 0 0 0 0 0%00:00:00
11news.nk.ca 2 0 0 0 0 0%00:20:01
12eotl-out.news.tnetconsulting.net 1 0 0 0 0 0%00:10:05
TOTAL: 12 48 94329 10343 82557 1429 10%231:04:06
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1endofthelinebbs-out.news.weretis.net20.8 MB0.0 KB570.0 KB21.4 MB 97%3.5 KB
2usenet.blueworldhosting.com17.9 MB0.0 KB1.1 MB19.0 MB 94%5.4 KB
3newsfeed.xs3.de1.7 MB0.0 KB11.0 KB1.7 MB 99%3.7 KB
4outgoing.news.lysator.liu.se1.0 MB0.0 KB2.2 MB3.2 MB 31%2.9 KB
5glockenspiel.complete.org347.4 KB3.4 KB7.3 KB358.1 KB 97%10.9 KB
6news.samoylyk.net188.1 KB0.0 KB16.9 KB205.0 KB 91%3.1 KB
7news.bbs.nz19.1 KB0.0 KB0.0 KB19.1 KB100%2.4 KB
8news.furie.org.uk12.7 KB0.0 KB0.0 KB12.7 KB100%3.2 KB
9news.netfront.net4.3 KB0.0 KB346.6 KB351.0 KB 1%2.9 KB
10localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
11news.nk.ca0.0 KB0.0 KB0.0 KB0.0 KB 0%0
12eotl-out.news.tnetconsulting.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1242.0 MB3.4 KB4.2 MB46.2 MB 90%4.0 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Dec 3 00:01:02 - 00:59:59 244 2.4% 0.07697.5 KB 1.6% 0.20
Dec 3 01:00:00 - 01:59:59 275 2.7% 0.08761.8 KB 1.8% 0.21
Dec 3 02:00:00 - 02:59:59 534 5.2% 0.151.6 MB 3.9% 0.47
Dec 3 03:00:00 - 03:59:59 537 5.2% 0.151.4 MB 3.4% 0.41
Dec 3 04:00:00 - 04:59:59 576 5.6% 0.162.0 MB 4.7% 0.57
Dec 3 05:00:00 - 05:59:59 555 5.4% 0.151.8 MB 4.3% 0.52
Dec 3 06:00:00 - 06:59:59 528 5.1% 0.153.0 MB 7.0% 0.85
Dec 3 07:00:00 - 07:59:59 447 4.3% 0.121.4 MB 3.4% 0.41
Dec 3 08:00:00 - 08:59:59 417 4.0% 0.121.4 MB 3.3% 0.40
Dec 3 09:00:00 - 09:59:59 474 4.6% 0.132.3 MB 5.4% 0.66
Dec 3 10:00:00 - 10:59:59 515 5.0% 0.142.6 MB 6.2% 0.75
Dec 3 11:00:00 - 11:59:59 563 5.5% 0.161.8 MB 4.2% 0.51
Dec 3 12:00:00 - 12:59:59 712 6.9% 0.203.7 MB 8.8% 1.06
Dec 3 13:00:00 - 13:59:59 536 5.2% 0.152.3 MB 5.3% 0.64
Dec 3 14:00:00 - 14:59:59 507 4.9% 0.141.8 MB 4.2% 0.50
Dec 3 15:00:00 - 15:59:59 541 5.2% 0.152.4 MB 5.6% 0.68
Dec 3 16:00:00 - 16:59:59 485 4.7% 0.132.1 MB 4.9% 0.59
Dec 3 17:00:00 - 17:59:59 327 3.2% 0.092.3 MB 5.4% 0.65
Dec 3 18:00:00 - 18:59:59 291 2.8% 0.081.3 MB 3.0% 0.37
Dec 3 19:00:00 - 19:59:59 296 2.9% 0.081.0 MB 2.4% 0.29
Dec 3 20:00:00 - 20:59:59 384 3.7% 0.111.2 MB 2.9% 0.35
Dec 3 21:00:00 - 21:59:59 180 1.7% 0.05638.0 KB 1.5% 0.18
Dec 3 22:00:00 - 22:59:59 197 1.9% 0.052.0 MB 4.7% 0.56
Dec 3 23:00:00 - 23:59:59 200 1.9% 0.06930.7 KB 2.1% 0.26
Dec 4 00:00:00 - 00:01:02 3 0.0% 0.0510.1 KB 0.0% 0.16
TOTAL: 24:00:00 10324 100.0% 0.1242.4 MB 100.0% 0.50
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1outgoing.news.lysator.liu.se 558 0 0 0 0 0 0 0 558
2usenet.blueworldhosting.com 477 6 0 0 1 0 0 0 470
3endofthelinebbs-out.news.weretis.net 447 0 0 0 0 0 0 0 447
4news.netfront.net 131 0 0 0 0 0 0 0 131
5news.samoylyk.net 14 0 0 0 0 0 0 0 14
6newsfeed.xs3.de 11 0 0 0 0 0 0 0 11
7glockenspiel.complete.org 1 0 0 0 0 0 0 0 1
TOTAL: 7 1639 6 0 0 1 0 0 0 1632

Unwanted newsgroups [Top 20]:

NewsgroupCount
rocksolid.feeds.news 4
gun.general 1
harvard.forsale 1
TOTAL: 3 6

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

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

INND Perl filter [Top 20]:

ReasonCount
EMP (phn path) 692
EMP (md5) 306
EMP (phl) 227
Too many newsgroups 184
EMP (phn nph) 22
HTML Multipart 5
U2 violation - invalid distribution 1
Scoring filter 1
TOTAL: 8 1438

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
endofthelinebbs-out.news.weretis.net 148
usenet.blueworldhosting.com 36
newsfeed.xs3.de 7
outgoing.news.lysator.liu.se 3
TOTAL: 4 194
TOTAL: 1 194

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.netfront.net 13545 5086 5227 9 0 68 37%23:59:15
2nyheter.lysator.liu.se 10185 2776 6930 47 0 0 27%23:59:34
3news.nk.ca 13786 57 10165 18 0 68 0%23:59:56
4news.furie.org.uk 6625 41 5471 1 0 0 0%23:59:56
5news.quux.org 10637 28 10173 99 0 0 0%23:59:50
6news.bbs.nz 20233 27 10230 54 0 176 0%23:59:15
7news.tnetconsulting.net 11026 3 10318 0 0 3 0%23:59:51
8news.weretis.net 10351 1 10321 0 0 0 0%23:59:56
9usenet.blueworldhosting.com 7245 1 6970 0 0 12 0%23:59:15
10news.samoylyk.net 13056 0 10267 0 0 0 0%23:59:56
11newsfeed.xs3.de 12536 0 9859 0 0 0 0%23:57:57
12peer.alt119.net 0 0 0 0 0 10319 0%23:57:48
TOTAL: 12 129225 8020 95931 228 0 10646 6%287:52:29
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.netfront.net25.7 MB15.8 KB25.7 MB0.3 KB/s5.2 KB23:59:15
2nyheter.lysator.liu.se17.8 MB280.1 KB18.0 MB0.2 KB/s6.5 KB23:59:34
3news.furie.org.uk3.2 MB12.3 KB3.2 MB0.0 KB/s78.7 KB23:59:56
4news.bbs.nz200.8 KB218.2 KB419.0 KB0.0 KB/s5.2 KB23:59:15
5news.quux.org197.7 KB451.5 KB649.2 KB0.0 KB/s5.1 KB23:59:50
6news.nk.ca171.0 KB95.8 KB266.9 KB0.0 KB/s3.6 KB23:59:56
7news.tnetconsulting.net20.5 KB0.0 KB20.5 KB0.0 KB/s6.8 KB23:59:51
8usenet.blueworldhosting.com1.2 KB0.0 KB1.2 KB0.0 KB/s1.2 KB23:59:15
9news.weretis.net1.1 KB0.0 KB1.1 KB0.0 KB/s1.1 KB23:59:56
10news.samoylyk.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:56
11newsfeed.xs3.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:57
12peer.alt119.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:48
TOTAL: 1247.2 MB1.0 MB48.3 MB0.0 KB/s6.0 KB287:52:29
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1jovial.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
2192.241.212.45 1 00.0 KB 0 0 000:00:00
3scanner-25.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
4104.156.155.31 2 00.0 KB 0 0 000:00:10
TOTAL: 4 5 00.0 KB 0 0 000:00:12

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
2*.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
3unresolved 3 00.0 KB 0 0 000:00:10
TOTAL: 3 5 00.0 KB 0 0 000:00:12

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
104.156.155.31 0.189 0.103 0.00000:00:10
jovial.monitoring.internet-measurement.com 0.088 0.064 0.00000:00:01
scanner-25.ch1.censys-scanner.com 0.096 0.043 0.00000:00:00
192.241.212.45 0.110 0.032 0.00000:00:00
TOTAL: 4 0.483 0.242 0.00000:00:12

NNRP unrecognized commands (by host):

SystemConn
192.241.212.45 1
scanner-25.ch1.censys-scanner.com 1
TOTAL: 2 2

NNRP unrecognized commands (by command):

CommandCount
EHLO www.censys.io 1
MGLNDD_192.138.210.162_119 1
TOTAL: 2 2