Daily Usenet Report

Jan 16 00:01:01 -- Jan 17 00:01:01

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

Jan 16 00:07:00 www innd: message repeated 2 times: [ ctlinnd command s]
Jan 16 07:28:20 www nnrpd[463581]: unable to get certificates from '/news/etc/cert.pem'
Jan 16 07:28:20 www nnrpd[463581]: 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 17273 76.1%4.3 MB 83.1%
innd 3091 13.6%474.4 KB 8.9%
innfeed 2321 10.2%425.4 KB 8.0%
nnrpd 14 0.1%1.5 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 5 22700 100.0%5.2 MB100.0%

History cache:

ReasonCount%Count
Positive hits 100425 61.6%
Negative hits 48731 29.9%
Do not exist 13752 8.4%
Cache misses 99 0.1%
TOTAL: 4 163007 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.320 0.0%136 0.000 2.353 3.220
article cleanup00:00:00.278 0.0%16853 0.000 0.016 0.063
article logging00:00:00.822 0.0%17113 0.000 0.048 0.119
article parse00:00:00.565 0.0%27493 0.000 0.021 0.070
article write00:00:10.985 0.0%12851 0.314 0.855 2.560
artlog/artcncl00:00:00.003 0.0%136 0.000 0.022 0.500
data move00:00:00.235 0.0%171318 0.000 0.001 0.007
hisgrep/artcncl00:00:00.070 0.0%136 0.000 0.515 0.805
hishave/artcncl00:00:00.028 0.0%136 0.000 0.206 0.667
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:07.775 0.0%163294 0.005 0.048 0.090
history sync00:00:00.065 0.0%400 0.000 0.163 1.000
history write00:00:07.741 0.0%13787 0.050 0.561 0.952
idle23:58:24.798 99.8%167142 262.924 516.356 1658.608
nntp read00:00:07.828 0.0%168180 0.027 0.047 0.090
overview write00:00:07.694 0.0%12851 0.206 0.599 5.568
perl filter00:00:39.173 0.0%13787 1.947 2.841 5.971
python filter00:00:02.363 0.0%13787 0.093 0.171 0.432
site send00:00:04.024 0.0%25702 0.029 0.157 0.500
TOTAL: 24:01:02.09723:59:54.767 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.206 0.0%13519 0.000 0.015 0.108
article prepare00:00:00.006 0.0%35080 0.000 0.000 0.010
article read00:00:01.463 0.0%5698 0.043 0.257 2.882
backlog stats00:00:00.557 0.0%288062 0.000 0.002 0.005
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:06.873 0.0%187539 0.022 0.037 0.066
data write00:00:23.533 0.0%176239 0.094 0.134 0.201
idle23:55:26.559 99.9%288062 155.432 298.986 926.283
status file00:00:00.182 0.0%187 0.000 0.973 3.000
TOTAL: 23:56:10.95523:55:59.379100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:01.962 74.8%6 26.500 327.000 1790.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.000 0.0%12 0.000 0.000 0.000
TOTAL: 00:00:02.62400:00:01.962 74.8%----

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 24860 9414 13755 1691 37%55:52:06
2usenet.blueworldhosting.com 4 13155 2234 9574 1347 16%23:49:19
3outgoing.news.lysator.liu.se 2 13296 995 11887 414 7%24:09:03
4newsfeed.xs3.de 1 10826 298 10387 141 2%23:59:53
5news.netfront.net 2 24202 68 23873 261 0%44:28:19
6news.samoylyk.net 1 11090 43 11032 15 0%23:59:50
7glockenspiel.complete.org 2 9981 24 9957 0 0%23:59:49
8news.bbs.nz 2 14247 14 14233 0 0%31:17:48
9news.furie.org.uk 2 5837 3 5833 1 0%23:59:36
10eotl-out.news.tnetconsulting.net 1 0 0 0 0 0%00:10:03
11news.nk.ca 2 0 0 0 0 0%00:20:03
12localhost 25 0 0 0 0 0%00:00:00
TOTAL: 12 48 127494 13093 110531 3870 10%276:05:49
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1endofthelinebbs-out.news.weretis.net32.8 MB11.7 MB11.9 MB56.4 MB 58%5.2 KB
2usenet.blueworldhosting.com14.7 MB3.7 MB4.5 MB22.9 MB 64%6.6 KB
3outgoing.news.lysator.liu.se1.9 MB107.3 KB1.7 MB3.6 MB 51%2.6 KB
4newsfeed.xs3.de1.2 MB604.8 KB612.1 KB2.4 MB 50%5.6 KB
5news.samoylyk.net462.1 KB147.4 KB154.6 KB764.1 KB 60%13.2 KB
6glockenspiel.complete.org257.4 KB0.0 KB0.0 KB257.4 KB100%10.7 KB
7news.netfront.net189.5 KB0.0 KB27.6 MB27.8 MB 0%86.4 KB
8news.bbs.nz43.0 KB0.0 KB0.0 KB43.0 KB100%3.1 KB
9news.furie.org.uk8.0 KB3.1 KB3.1 KB14.2 KB 56%3.5 KB
10eotl-out.news.tnetconsulting.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
11news.nk.ca0.0 KB0.0 KB0.0 KB0.0 KB 0%0
12localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1251.5 MB16.2 MB46.5 MB114.2 MB 45%6.9 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jan 16 00:01:01 - 00:59:59 257 2.0% 0.071.2 MB 2.4% 0.35
Jan 16 01:00:00 - 01:59:59 339 2.6% 0.09787.2 KB 1.5% 0.22
Jan 16 02:00:00 - 02:59:59 495 3.9% 0.141.4 MB 2.8% 0.41
Jan 16 03:00:00 - 03:59:59 642 5.0% 0.183.1 MB 6.1% 0.88
Jan 16 04:00:00 - 04:59:59 701 5.5% 0.193.0 MB 5.9% 0.86
Jan 16 05:00:00 - 05:59:59 677 5.3% 0.192.2 MB 4.3% 0.62
Jan 16 06:00:00 - 06:59:59 716 5.6% 0.202.2 MB 4.3% 0.62
Jan 16 07:00:00 - 07:59:59 551 4.3% 0.151.9 MB 3.7% 0.53
Jan 16 08:00:00 - 08:59:59 528 4.1% 0.152.0 MB 3.8% 0.56
Jan 16 09:00:00 - 09:59:59 930 7.2% 0.264.2 MB 8.3% 1.20
Jan 16 10:00:00 - 10:59:59 728 5.7% 0.202.2 MB 4.4% 0.64
Jan 16 11:00:00 - 11:59:59 921 7.2% 0.262.8 MB 5.6% 0.80
Jan 16 12:00:00 - 12:59:59 766 6.0% 0.212.1 MB 4.2% 0.60
Jan 16 13:00:00 - 13:59:59 676 5.3% 0.193.5 MB 7.0% 1.01
Jan 16 14:00:00 - 14:59:59 564 4.4% 0.161.8 MB 3.6% 0.52
Jan 16 15:00:00 - 15:59:59 725 5.6% 0.203.5 MB 6.9% 0.99
Jan 16 16:00:00 - 16:59:59 483 3.8% 0.131.7 MB 3.4% 0.49
Jan 16 17:00:00 - 17:59:59 353 2.7% 0.102.6 MB 5.1% 0.74
Jan 16 18:00:00 - 18:59:59 355 2.8% 0.103.3 MB 6.5% 0.95
Jan 16 19:00:00 - 19:59:59 371 2.9% 0.101.4 MB 2.8% 0.41
Jan 16 20:00:00 - 20:59:59 246 1.9% 0.07756.4 KB 1.5% 0.21
Jan 16 21:00:00 - 21:59:59 237 1.8% 0.07769.3 KB 1.5% 0.21
Jan 16 22:00:00 - 22:59:59 271 2.1% 0.081.3 MB 2.5% 0.36
Jan 16 23:00:00 - 23:59:59 312 2.4% 0.091.0 MB 2.0% 0.29
Jan 17 00:00:00 - 00:01:01 11 0.1% 0.1832.5 KB 0.1% 0.53
TOTAL: 24:00:00 12855 100.0% 0.1550.9 MB 100.0% 0.60
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1endofthelinebbs-out.news.weretis.net 2054 0 0 1714 0 0 0 0 340
2usenet.blueworldhosting.com 1431 8 0 1136 11 0 0 0 276
3outgoing.news.lysator.liu.se 480 0 0 61 0 0 0 0 419
4newsfeed.xs3.de 162 0 0 153 0 0 0 0 9
5news.netfront.net 127 0 0 0 0 0 0 0 127
6news.samoylyk.net 20 0 0 16 0 0 0 0 4
7glockenspiel.complete.org 7 0 0 7 0 0 0 0 0
8news.furie.org.uk 1 0 0 1 0 0 0 0 0
TOTAL: 8 4282 8 0 3088 11 0 0 0 1175

Unwanted newsgroups [Top 20]:

NewsgroupCount
rocksolid.feeds.news 5
nyu.test 2
gun.general 1
TOTAL: 3 8

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

GroupsCount
misc.taxes.moderated 11
TOTAL: 1 11

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 446
EMP (phn path) 167
EMP (phn nph) 130
Too many newsgroups 97
Binary: misplaced binary 52
Scoring filter 13
EMP (phl) 9
HTML Multipart 2
Too many newsgroups (meow) 1
TOTAL: 9 917

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
endofthelinebbs-out.news.weretis.net 240
newsfeed.xs3.de 8
usenet.blueworldhosting.com 4
outgoing.news.lysator.liu.se 3
news.samoylyk.net 3
TOTAL: 5 258
TOTAL: 1 258

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.netfront.net 18148 5287 7542 2 0 100 29%23:59:48
2nyheter.lysator.liu.se 12197 2940 8869 5 0 0 24%23:59:56
3news.furie.org.uk 8111 177 6055 9 0 6 2%23:59:56
4usenet.blueworldhosting.com 11643 62 9378 0 0 38 0%23:59:56
5news.nk.ca 19311 56 12741 30 0 214 0%23:59:56
6news.bbs.nz 24909 51 12752 36 0 221 0%23:59:56
7news.quux.org 14592 15 12693 114 0 10 0%23:59:55
8news.tnetconsulting.net 16949 4 12847 0 0 102 0%23:59:56
9news.weretis.net 12870 1 12849 2 0 0 0%23:59:56
10newsfeed.xs3.de 15013 0 12557 0 0 0 0%23:59:31
11peer.alt119.net 0 0 0 0 0 12848 0%23:57:47
12news.samoylyk.net 15518 0 12811 0 0 0 0%23:59:56
TOTAL: 12 169261 8593 121094 198 0 13539 5%287:56:29
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.netfront.net23.6 MB3.5 KB23.6 MB0.3 KB/s4.6 KB23:59:48
2nyheter.lysator.liu.se15.1 MB108.1 KB15.2 MB0.2 KB/s5.3 KB23:59:56
3news.furie.org.uk5.8 MB64.2 KB5.8 MB0.1 KB/s32.1 KB23:59:56
4news.nk.ca564.4 KB180.1 KB744.5 KB0.0 KB/s8.7 KB23:59:56
5news.bbs.nz365.8 KB471.1 KB836.9 KB0.0 KB/s9.6 KB23:59:56
6news.quux.org246.3 KB1.1 MB1.3 MB0.0 KB/s10.6 KB23:59:55
7usenet.blueworldhosting.com166.7 KB0.0 KB166.7 KB0.0 KB/s2.7 KB23:59:56
8news.tnetconsulting.net14.8 KB0.0 KB14.8 KB0.0 KB/s3.7 KB23:59:56
9news.weretis.net0.9 KB6.9 KB7.8 KB0.0 KB/s2.6 KB23:59:56
10newsfeed.xs3.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:31
11peer.alt119.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:47
12news.samoylyk.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:56
TOTAL: 1245.7 MB1.9 MB47.7 MB0.0 KB/s5.6 KB287:56:29
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1buoyant.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:02
2scanner-09.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
3192.241.217.9 1 00.0 KB 0 0 000:00:00
TOTAL: 3 3 00.0 KB 0 0 000:00:02

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:02
3unresolved 1 00.0 KB 0 0 000:00:00
TOTAL: 3 3 00.0 KB 0 0 000:00:02

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
buoyant.monitoring.internet-measurement.com 0.101 0.046 0.00000:00:02
scanner-09.ch1.censys-scanner.com 0.102 0.044 0.00000:00:00
192.241.217.9 0.083 0.022 0.00000:00:00
TOTAL: 3 0.286 0.112 0.00000:00:02

NNRP unrecognized commands (by host):

SystemConn
192.241.217.9 1
scanner-09.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