Daily Usenet Report

Dec 15 00:01:01 -- Dec 16 00:01:01

Unknown entries from news log file:

First 4 / 4 lines (100.0%)

Dec 15 00:06:26 www innd: message repeated 2 times: [ ctlinnd command s]
Dec 15 06:39:42 www nnrpd[4127596]: unable to get certificates from '/news/etc/cert.pem'
Dec 15 06:39:42 www nnrpd[4127596]: error initializing TLS: [CA_file: ] [CA_path: /news/etc] [cert_file: /news/etc/cert.pem] [key_file: /news/etc/key.pem]
Dec 15 10:00:08 www pgpverify[4133913]: pgpverify: verification failed

Log entries by program:

Program nameLines%LinesSize%Size
inn 13617 68.2%3.6 MB 78.7%
innd 3982 19.9%587.9 KB 12.4%
innfeed 2329 11.7%411.0 KB 8.7%
controlchan 23 0.1%5.4 KB 0.1%
nnrpd 16 0.1%1.8 KB 0.0%
pgpverify 1 0.0%0.4 KB 0.0%
TOTAL: 6 19968 100.0%4.6 MB100.0%

History cache:

ReasonCount%Count
Positive hits 94677 57.2%
Negative hits 57527 34.8%
Do not exist 13217 8.0%
Cache misses 55 0.0%
TOTAL: 4 165476 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.136 0.0%62 0.000 2.194 6.500
article cleanup00:00:00.247 0.0%13261 0.000 0.019 0.098
article logging00:00:00.699 0.0%13564 0.000 0.052 0.120
article parse00:00:00.583 0.0%28201 0.000 0.021 0.071
article write00:00:12.593 0.0%11430 0.500 1.102 2.183
artlog/artcncl00:00:00.001 0.0%61 0.000 0.016 1.000
data move00:00:00.279 0.0%178526 0.000 0.002 0.017
hisgrep/artcncl00:00:00.022 0.0%62 0.000 0.355 2.000
hishave/artcncl00:00:00.017 0.0%62 0.000 0.274 0.750
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:07.399 0.0%165937 0.003 0.045 0.086
history sync00:00:00.059 0.0%397 0.000 0.149 1.000
history write00:00:07.327 0.0%13260 0.078 0.553 0.920
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:58:08.671 99.8%174881 209.888 493.414 1441.118
nntp read00:00:08.447 0.0%175976 0.029 0.048 0.139
overview write00:00:08.258 0.0%11430 0.308 0.722 4.227
perl filter00:00:39.665 0.0%13260 2.174 2.991 5.000
python filter00:00:02.402 0.0%13260 0.072 0.181 0.436
site send00:00:04.862 0.0%22862 0.064 0.213 1.181
TOTAL: 24:01:04.54223:59:41.667 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.131 0.0%11538 0.000 0.011 0.161
article prepare00:00:00.007 0.0%38404 0.000 0.000 0.008
article read00:00:01.674 0.0%6000 0.095 0.279 1.962
backlog stats00:00:00.494 0.0%246038 0.000 0.002 0.006
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:05.787 0.0%163876 0.023 0.035 0.080
data write00:00:23.737 0.0%153534 0.106 0.155 0.269
idle23:55:31.821100.0%246038 203.115 350.075 810.753
status file00:00:00.232 0.0%197 0.000 1.178 7.000
TOTAL: 23:56:14.74623:56:03.883100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:10.793 95.7%6 25.000 1798.833 10050.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.001 0.0%12 0.000 0.083 0.167
TOTAL: 00:00:11.28000:00:10.794 95.7%----

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
group-admin@isc.org002112
TOTAL002112

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1endofthelinebbs-out.news.weretis.net 5 22094 6441 15321 332 29%49:00:05
2usenet.blueworldhosting.com 5 12460 4061 7632 767 32%23:38:43
3newsfeed.xs3.de 1 10288 548 9735 5 5%23:59:57
4outgoing.news.lysator.liu.se 2 12227 241 11760 226 1%23:59:30
5news.samoylyk.net 2 10467 74 10392 1 0%23:59:51
6glockenspiel.complete.org 2 10947 22 10921 4 0%23:59:51
7news.bbs.nz 3 10680 13 10667 0 0%24:34:41
8news.furie.org.uk 1 6139 6 6133 0 0%23:59:51
9news.netfront.net 1 12537 4 12164 369 0%23:42:27
10eotl-out.news.tnetconsulting.net 2 0 0 0 0 0%00:20:04
11news.nk.ca 2 0 0 0 0 0%00:20:00
12localhost 25 0 0 0 0 0%00:00:00
TOTAL: 12 51 107839 11410 94725 1704 10%241:35:00
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1endofthelinebbs-out.news.weretis.net21.7 MB0.0 KB600.8 KB22.3 MB 97%3.4 KB
2usenet.blueworldhosting.com20.0 MB0.0 KB1.9 MB22.0 MB 91%4.7 KB
3newsfeed.xs3.de2.5 MB0.0 KB6.3 KB2.5 MB 99%4.6 KB
4news.samoylyk.net724.1 KB0.0 KB1.4 KB725.5 KB 99%9.7 KB
5outgoing.news.lysator.liu.se394.1 KB0.0 KB780.6 KB1.1 MB 33%2.5 KB
6glockenspiel.complete.org257.9 KB101.8 KB104.4 KB464.2 KB 55%17.9 KB
7news.bbs.nz36.5 KB0.0 KB0.0 KB36.5 KB100%2.8 KB
8news.furie.org.uk19.8 KB0.0 KB0.0 KB19.8 KB100%3.3 KB
9news.netfront.net8.6 KB0.0 KB70.0 MB70.0 MB 0%192.2 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: 1245.6 MB101.8 KB73.4 MB119.1 MB 38%9.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Dec 15 00:01:01 - 00:59:59 275 2.4% 0.081.1 MB 2.4% 0.31
Dec 15 01:00:00 - 01:59:59 414 3.6% 0.121.4 MB 3.2% 0.41
Dec 15 02:00:00 - 02:59:59 505 4.4% 0.141.4 MB 3.2% 0.41
Dec 15 03:00:00 - 03:59:59 558 4.9% 0.152.0 MB 4.4% 0.56
Dec 15 04:00:00 - 04:59:59 593 5.2% 0.161.6 MB 3.6% 0.46
Dec 15 05:00:00 - 05:59:59 557 4.9% 0.151.8 MB 4.0% 0.51
Dec 15 06:00:00 - 06:59:59 582 5.1% 0.162.0 MB 4.4% 0.56
Dec 15 07:00:00 - 07:59:59 556 4.9% 0.152.1 MB 4.6% 0.58
Dec 15 08:00:00 - 08:59:59 644 5.6% 0.183.4 MB 7.5% 0.96
Dec 15 09:00:00 - 09:59:59 712 6.2% 0.202.2 MB 4.8% 0.62
Dec 15 10:00:00 - 10:59:59 680 6.0% 0.192.9 MB 6.4% 0.82
Dec 15 11:00:00 - 11:59:59 637 5.6% 0.182.1 MB 4.7% 0.60
Dec 15 12:00:00 - 12:59:59 508 4.4% 0.142.3 MB 5.1% 0.66
Dec 15 13:00:00 - 13:59:59 564 4.9% 0.162.0 MB 4.4% 0.57
Dec 15 14:00:00 - 14:59:59 555 4.9% 0.151.7 MB 3.8% 0.48
Dec 15 15:00:00 - 15:59:59 552 4.8% 0.152.4 MB 5.3% 0.67
Dec 15 16:00:00 - 16:59:59 464 4.1% 0.131.6 MB 3.6% 0.46
Dec 15 17:00:00 - 17:59:59 403 3.5% 0.112.4 MB 5.4% 0.69
Dec 15 18:00:00 - 18:59:59 337 2.9% 0.091.5 MB 3.4% 0.44
Dec 15 19:00:00 - 19:59:59 323 2.8% 0.092.2 MB 4.9% 0.63
Dec 15 20:00:00 - 20:59:59 281 2.5% 0.081.1 MB 2.4% 0.30
Dec 15 21:00:00 - 21:59:59 224 2.0% 0.061.7 MB 3.7% 0.47
Dec 15 22:00:00 - 22:59:59 251 2.2% 0.071.2 MB 2.7% 0.35
Dec 15 23:00:00 - 23:59:59 241 2.1% 0.071004.7 KB 2.2% 0.28
Dec 16 00:00:00 - 00:01:01 8 0.1% 0.1346.4 KB 0.1% 0.76
TOTAL: 24:00:00 11424 100.0% 0.1345.0 MB 100.0% 0.53
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1usenet.blueworldhosting.com 841 16 0 0 0 0 0 0 825
2endofthelinebbs-out.news.weretis.net 566 0 0 0 0 0 0 0 566
3news.netfront.net 522 0 0 0 0 0 0 0 522
4outgoing.news.lysator.liu.se 159 0 0 0 0 0 0 0 159
5newsfeed.xs3.de 35 0 0 0 0 0 0 0 35
6glockenspiel.complete.org 4 0 0 1 0 0 0 0 3
7news.samoylyk.net 4 0 0 0 0 0 0 0 4
8news.bbs.nz 1 0 0 0 0 0 0 0 1
TOTAL: 8 2132 16 0 1 0 0 0 0 2115

Unwanted newsgroups [Top 20]:

NewsgroupCount
rocksolid.feeds.news 5
harvard.forsale 3
gun.general 2
alt.privacy.anom-server 1
panix.chat 1
httpsdrlukehealthcare.com 1
ct.jobs 1
alt.sex.fetish.feet.toes 1
rec.autos.vw 1
TOTAL: 9 16

INND Perl filter [Top 20]:

ReasonCount
EMP (phn path) 589
EMP (md5) 409
Binary: misplaced binary 245
EMP (phn nph) 214
EMP (phl) 174
Too many newsgroups 148
Too many newsgroups (low_xpost) 30
HTML Multipart 2
Scoring filter 1
TOTAL: 9 1812

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
endofthelinebbs-out.news.weretis.net 235
usenet.blueworldhosting.com 32
newsfeed.xs3.de 30
news.samoylyk.net 3
outgoing.news.lysator.liu.se 2
news.bbs.nz 1
TOTAL: 6 303
TOTAL: 1 303

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.netfront.net 15058 5443 5966 11 0 11 36%23:59:51
2nyheter.lysator.liu.se 11567 3690 7501 15 0 0 31%23:59:56
3news.nk.ca 15322 80 11252 37 0 13 0%23:59:56
4news.furie.org.uk 8811 80 6451 6 0 0 0%23:59:56
5news.bbs.nz 22380 54 11305 49 0 87 0%23:59:54
6news.quux.org 11753 33 11248 118 0 0 0%23:59:39
7usenet.blueworldhosting.com 7614 3 7271 0 0 0 0%23:57:37
8news.weretis.net 11459 2 11420 0 0 0 0%23:59:34
9peer.alt119.net 0 0 0 0 0 11424 0%23:57:47
10news.samoylyk.net 14620 0 11348 0 0 0 0%23:59:56
11newsfeed.xs3.de 14020 0 10872 0 0 0 0%23:59:56
12news.tnetconsulting.net 12095 0 11421 0 0 14 0%23:59:56
TOTAL: 12 144699 9385 106055 236 0 11549 6%287:53:58
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.netfront.net22.9 MB118.6 KB23.0 MB0.3 KB/s4.3 KB23:59:51
2nyheter.lysator.liu.se17.9 MB127.8 KB18.0 MB0.2 KB/s5.0 KB23:59:56
3news.furie.org.uk5.6 MB65.6 KB5.6 MB0.1 KB/s66.9 KB23:59:56
4news.bbs.nz315.6 KB191.9 KB507.5 KB0.0 KB/s4.9 KB23:59:54
5news.nk.ca265.5 KB184.4 KB449.9 KB0.0 KB/s3.8 KB23:59:56
6news.quux.org156.7 KB363.5 KB520.2 KB0.0 KB/s3.4 KB23:59:39
7usenet.blueworldhosting.com7.6 KB0.0 KB7.6 KB0.0 KB/s2.5 KB23:57:37
8news.weretis.net2.7 KB0.0 KB2.7 KB0.0 KB/s1.3 KB23:59:34
9peer.alt119.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:47
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:59:56
12news.tnetconsulting.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:56
TOTAL: 1247.0 MB1.0 MB48.1 MB0.0 KB/s5.1 KB287:53:58
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1192.241.195.140 1 00.0 KB 0 0 000:00:00
245.134.212.69 1 00.0 KB 0 0 000:00:10
3scanner-09.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
TOTAL: 3 3 00.0 KB 0 0 000:00:11

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 2 00.0 KB 0 0 000:00:10
2*.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
TOTAL: 2 3 00.0 KB 0 0 000:00:11

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
45.134.212.69 0.081 0.045 0.00000:00:10
scanner-09.ch1.censys-scanner.com 0.093 0.043 0.00000:00:00
192.241.195.140 0.103 0.032 0.00000:00:00
TOTAL: 3 0.277 0.120 0.00000:00:11

NNRP unrecognized commands (by host):

SystemConn
192.241.195.140 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