Daily Usenet Report

Aug 6 00:01:02 -- Aug 7 00:01:01

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

Aug 6 00:03:52 www innd: message repeated 2 times: [ ctlinnd command s]
Aug 6 13:00:54 www nnrpd[1723422]: unable to get certificates from '/news/etc/cert.pem'
Aug 6 13:00:54 www nnrpd[1723422]: 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 12600 68.8%2.9 MB 76.5%
innd 3647 19.9%524.9 KB 13.6%
innfeed 1972 10.8%375.7 KB 9.7%
nnrpd 91 0.5%7.8 KB 0.2%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 5 18311 100.0%3.8 MB100.0%

History cache:

ReasonCount%Count
Positive hits 75078 54.1%
Negative hits 51414 37.0%
Do not exist 12249 8.8%
Cache misses 37 0.0%
TOTAL: 4 138778 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.069 0.0%64 0.000 1.078 3.000
article cleanup00:00:00.288 0.0%12266 0.000 0.023 0.098
article logging00:00:00.572 0.0%12532 0.000 0.046 0.139
article parse00:00:00.470 0.0%18785 0.000 0.025 0.085
article write00:00:07.482 0.0%10517 0.374 0.711 2.947
artlog/artcncl00:00:00.001 0.0%64 0.000 0.016 1.000
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.191 0.0%141684 0.000 0.001 0.011
hisgrep/artcncl00:00:00.011 0.0%62 0.000 0.177 1.000
hishave/artcncl00:00:00.000 0.0%64 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:04.589 0.0%138965 0.004 0.033 0.082
history sync00:00:00.063 0.0%389 0.000 0.162 1.667
history write00:00:05.046 0.0%12266 0.057 0.411 0.750
hiswrite/artcncl00:00:00.001 0.0%2 0.000 0.500 1.000
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:58:56.199 99.9%139451 324.149 619.115 2272.708
nntp read00:00:04.814 0.0%140620 0.016 0.034 0.062
overview write00:00:07.184 0.0%10517 0.260 0.683 3.278
perl filter00:00:35.129 0.0%12266 2.075 2.864 6.912
python filter00:00:02.139 0.0%12266 0.075 0.174 0.379
site send00:00:03.285 0.0%21034 0.019 0.156 0.800
TOTAL: 24:01:04.22024:00:07.533 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.082 0.0%10909 0.000 0.008 0.125
article prepare00:00:00.001 0.0%10852 0.000 0.000 0.036
article read00:00:00.699 0.0%1809 0.000 0.386 10.800
backlog stats00:00:00.319 0.0%197757 0.000 0.002 0.008
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:03.632 0.0%130526 0.012 0.028 0.050
data write00:00:16.992 0.0%121159 0.049 0.140 0.284
idle23:57:40.794100.0%197757 245.903 436.196 1535.084
status file00:00:00.177 0.0%166 0.000 1.066 4.000
TOTAL: 23:58:10.40523:58:02.696100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:13.197 76.3%9 27.500 1466.333 10002.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.003 0.0%20 0.000 0.150 0.500
TOTAL: 00:00:17.30100:00:13.200 76.3%----

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 15998 4695 11057 246 29%35:34:26
2usenet.blueworldhosting.com 13 11939 3188 7837 914 26%25:49:17
3peer.alt119.net 3 11883 2087 9232 564 17%24:08:58
4newsfeed.xs3.de 2 9448 124 9323 1 1%23:59:44
5news.samoylyk.net 2 9618 85 9530 3 0%23:59:40
6glockenspiel.complete.org 1 10234 35 10197 2 0%23:59:54
7news.furie.org.uk 1 5350 23 5327 0 0%23:59:55
8news.bbs.nz 1 10055 6 10049 0 0%23:59:43
9localhost 25 0 0 0 0 0%00:00:00
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:01
TOTAL: 11 55 84525 10243 72552 1730 12%206:01:41
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1usenet.blueworldhosting.com18.5 MB0.0 KB2.2 MB20.7 MB 89%5.2 KB
2endofthelinebbs-out.news.weretis.net14.6 MB0.0 KB554.5 KB15.2 MB 96%3.1 KB
3peer.alt119.net4.5 MB0.0 KB1.6 MB6.1 MB 73%2.4 KB
4glockenspiel.complete.org2.0 MB0.0 KB4.6 KB2.0 MB 99%55.7 KB
5newsfeed.xs3.de746.2 KB0.0 KB1.2 KB747.4 KB 99%6.0 KB
6news.samoylyk.net598.3 KB1.8 MB1.8 MB4.1 MB 14%48.0 KB
7news.furie.org.uk86.3 KB0.0 KB0.0 KB86.3 KB100%3.8 KB
8news.bbs.nz9.1 KB0.0 KB0.0 KB9.1 KB100%1.5 KB
9localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
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
TOTAL: 1141.0 MB1.8 MB6.1 MB48.9 MB 83%4.2 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 6 00:01:02 - 00:59:59 199 1.9% 0.06609.0 KB 1.5% 0.17
Aug 6 01:00:00 - 01:59:59 317 3.0% 0.092.0 MB 5.0% 0.57
Aug 6 02:00:00 - 02:59:59 485 4.6% 0.131.8 MB 4.5% 0.52
Aug 6 03:00:00 - 03:59:59 511 4.9% 0.141.8 MB 4.5% 0.52
Aug 6 04:00:00 - 04:59:59 590 5.6% 0.161.5 MB 3.6% 0.42
Aug 6 05:00:00 - 05:59:59 514 4.9% 0.141.4 MB 3.5% 0.40
Aug 6 06:00:00 - 06:59:59 561 5.3% 0.161.7 MB 4.2% 0.48
Aug 6 07:00:00 - 07:59:59 515 4.9% 0.142.1 MB 5.1% 0.59
Aug 6 08:00:00 - 08:59:59 584 5.6% 0.162.5 MB 6.2% 0.71
Aug 6 09:00:00 - 09:59:59 629 6.0% 0.171.7 MB 4.3% 0.49
Aug 6 10:00:00 - 10:59:59 628 6.0% 0.172.0 MB 4.9% 0.57
Aug 6 11:00:00 - 11:59:59 534 5.1% 0.151.7 MB 4.2% 0.49
Aug 6 12:00:00 - 12:59:59 607 5.8% 0.172.7 MB 6.7% 0.77
Aug 6 13:00:00 - 13:59:59 486 4.6% 0.142.7 MB 6.7% 0.77
Aug 6 14:00:00 - 14:59:59 520 4.9% 0.141.7 MB 4.2% 0.48
Aug 6 15:00:00 - 15:59:59 484 4.6% 0.131.6 MB 4.0% 0.46
Aug 6 16:00:00 - 16:59:59 406 3.9% 0.111.8 MB 4.3% 0.50
Aug 6 17:00:00 - 17:59:59 384 3.6% 0.111.6 MB 3.9% 0.46
Aug 6 18:00:00 - 18:59:59 309 2.9% 0.092.6 MB 6.3% 0.73
Aug 6 19:00:00 - 19:59:59 254 2.4% 0.07936.5 KB 2.3% 0.26
Aug 6 20:00:00 - 20:59:59 394 3.7% 0.111.1 MB 2.7% 0.31
Aug 6 21:00:00 - 21:59:59 191 1.8% 0.05789.4 KB 1.9% 0.22
Aug 6 22:00:00 - 22:59:59 207 2.0% 0.061.5 MB 3.8% 0.44
Aug 6 23:00:00 - 23:59:59 204 1.9% 0.06736.9 KB 1.8% 0.20
Aug 7 00:00:00 - 00:01:01 8 0.1% 0.1315.3 KB 0.0% 0.25
TOTAL: 23:59:59 10521 100.0% 0.1240.6 MB 100.0% 0.48
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1usenet.blueworldhosting.com 929 110 0 0 0 0 0 0 819
2peer.alt119.net 583 14 0 0 0 0 0 0 569
3endofthelinebbs-out.news.weretis.net 495 6 0 0 0 0 0 0 489
4newsfeed.xs3.de 3 0 0 0 0 0 0 0 3
5glockenspiel.complete.org 3 0 0 0 0 0 0 0 3
6news.furie.org.uk 1 0 0 0 0 0 0 0 1
7news.samoylyk.net 1 1 0 0 0 0 0 0 0
TOTAL: 7 2015 131 0 0 0 0 0 0 1884

Unwanted newsgroups [Top 20]:

NewsgroupCount
talk.english.tg 56
talk.generic.ua.ws 13
at.jobs 12
att.jobs 10
grisbi.bugsreports 9
rocksolid.feeds.news 5
talk.english.tw 4
aus.jobs 4
news.oriens-occasus.ru 2
1.test 1
talk.from.diary 1
aol.neighborhood.wi.milwaukee.jobs 1
clari.canada.general 1
aol.neighborhood.va.jobs 1
aol.neighborhood.de.jobs 1
fr.petites-annonces.informatique.materiel 1
panix.test 1
aol.neighborhood.wv.jobs 1
uk.local.bristol 1
aol.neighborhood.wa.seattle.jobs 1
TOTAL: 25 131

INND Perl filter [Top 20]:

ReasonCount
EMP (phn path) 754
EMP (md5) 516
Too many newsgroups 169
EMP (phn nph) 101
EMP (phl) 63
HTML Multipart 8
Scoring filter 5
EMP (fsl) 2
TOTAL: 8 1618

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
endofthelinebbs-out.news.weretis.net 242
peer.alt119.net 14
usenet.blueworldhosting.com 7
newsfeed.xs3.de 2
news.furie.org.uk 1
TOTAL: 5 266
TOTAL: 1 266

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1peer.alt119.net 9423 1021 7391 15 0 47 10%23:59:56
2news.bbs.nz 19633 918 9453 141 0 208 4%23:59:56
3news.nk.ca 13977 296 10133 73 0 24 2%23:59:56
4news.quux.org 11036 61 10307 121 0 11 0%23:59:56
5news.furie.org.uk 8226 27 5628 7 0 3 0%23:59:56
6news.tnetconsulting.net 12182 12 10501 0 0 50 0%23:59:50
7usenet.blueworldhosting.com 8082 9 7345 5 0 18 0%23:59:36
8newsfeed.xs3.de 13049 2 10334 3 0 20 0%23:59:56
9news.weretis.net 10668 2 10517 1 0 4 0%23:59:56
10news.samoylyk.net 13149 1 10431 2 0 14 0%23:59:56
TOTAL: 10 119425 2349 92040 368 0 399 1%239:58:54
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1peer.alt119.net6.1 MB62.2 KB6.2 MB0.1 KB/s6.1 KB23:59:56
2news.bbs.nz4.1 MB661.7 KB4.7 MB0.1 KB/s4.6 KB23:59:56
3news.nk.ca2.3 MB233.9 KB2.6 MB0.0 KB/s7.1 KB23:59:56
4news.quux.org843.7 KB721.8 KB1.5 MB0.0 KB/s8.6 KB23:59:56
5news.furie.org.uk229.0 KB46.5 KB275.5 KB0.0 KB/s8.1 KB23:59:56
6news.tnetconsulting.net44.1 KB0.0 KB44.1 KB0.0 KB/s3.7 KB23:59:50
7usenet.blueworldhosting.com12.2 KB12.4 KB24.6 KB0.0 KB/s1.8 KB23:59:36
8newsfeed.xs3.de10.0 KB7.8 KB17.8 KB0.0 KB/s3.6 KB23:59:56
9news.samoylyk.net4.0 KB5.4 KB9.5 KB0.0 KB/s3.2 KB23:59:56
10news.weretis.net4.0 KB390.9 KB394.9 KB0.0 KB/s131.6 KB23:59:56
TOTAL: 1013.7 MB2.1 MB15.8 MB0.0 KB/s6.0 KB239:58:54
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
147.186.11.199 1 00.0 KB 4 0 000:00:00
TOTAL: 1 1 00.0 KB 4 0 000:00:17

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
2unresolved 4 00.0 KB 4 0 000:00:16
TOTAL: 2 5 00.0 KB 4 0 000:00:17

NNRP auth users [Top 20]:

UserConn
nelgin 1
TOTAL: 1 1

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
27.124.5.27 0.143 0.061 0.00000:00:16
scanner-06.ch1.censys-scanner.com 0.082 0.036 0.00000:00:00
192.241.222.233 0.076 0.045 0.00000:00:00
TOTAL: 3 0.301 0.142 0.00000:00:17

Curious NNRP server explorers [Top 20]:

SystemConn
27.124.5.27 2
scanner-06.ch1.censys-scanner.com 1
192.241.222.233 1
TOTAL: 3 4

NNRP unrecognized commands (by host):

SystemConn
27.124.5.27 2
scanner-06.ch1.censys-scanner.com 1
192.241.222.233 1
TOTAL: 3 4

NNRP unrecognized commands (by command):

CommandCount
MGLNDD_192.138.210.162_119 1
EHLO www.censys.io 1
#026#003#001 1
#001 1
TOTAL: 4 4

NNRP client timeouts [Top 20]:

SystemConnPeer
27.124.5.27 1 1
TOTAL: 1 1 1

Newsgroup request counts (by category):

CategoryCountPct
1comp 4 50.0%
2dfw 2 25.0%
3news 2 25.0%
TOTAL: 3 8100.0%

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

NewsgroupCount
1comp.sys.acorn.networking 4
2news.admin.peering 2
3dfw.games 1
4dfw.general 1
TOTAL: 4 8