Daily Usenet Report

Jul 17 00:01:02 -- Jul 18 00:01:01

Unknown entries from news log file:

First 5 / 5 lines (100.0%)

Jul 17 00:03:48 www innd: message repeated 2 times: [ ctlinnd command s]
Jul 17 00:19:53 www nnrpd[965369]: unable to get certificates from '/news/etc/cert.pem'
Jul 17 00:19:53 www nnrpd[965369]: error initializing TLS: [CA_file: ] [CA_path: /news/etc] [cert_file: /news/etc/cert.pem] [key_file: /news/etc/key.pem]
Jul 17 04:27:10 www nnrpd[971329]: unable to get certificates from '/news/etc/cert.pem'
Jul 17 04:27:10 www nnrpd[971329]: 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 12750 68.1%2.9 MB 76.0%
innd 3939 21.0%585.2 KB 14.9%
innfeed 2014 10.8%351.0 KB 9.0%
nnrpd 22 0.1%2.4 KB 0.1%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 5 18726 100.0%3.8 MB100.0%

History cache:

ReasonCount%Count
Positive hits 76437 54.4%
Negative hits 51573 36.7%
Do not exist 12387 8.8%
Cache misses 187 0.1%
TOTAL: 4 140584 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.045 0.0%43 0.000 1.047 7.000
article cleanup00:00:00.297 0.0%12410 0.000 0.024 0.154
article logging00:00:00.575 0.0%12718 0.000 0.045 0.135
article parse00:00:00.557 0.0%29435 0.000 0.019 0.131
article write00:00:07.216 0.0%10428 0.366 0.692 2.310
artlog/artcncl00:00:00.000 0.0%43 0.000 0.000 0.000
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.259 0.0%153303 0.000 0.002 0.009
hisgrep/artcncl00:00:00.004 0.0%43 0.000 0.093 1.000
hishave/artcncl00:00:00.001 0.0%43 0.000 0.023 0.200
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.174 0.0%140849 0.004 0.030 0.074
history sync00:00:00.069 0.0%390 0.000 0.177 1.000
history write00:00:04.582 0.0%12410 0.088 0.369 0.810
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:58:51.233 99.8%150500 50.767 573.629 1856.669
nntp read00:00:05.957 0.0%151782 0.017 0.039 0.079
overview write00:00:07.389 0.0%10428 0.194 0.709 12.463
perl filter00:00:35.770 0.0%12410 1.444 2.882 7.122
python filter00:00:02.227 0.0%12410 0.059 0.179 0.479
site send00:00:03.684 0.0%20856 0.021 0.177 0.444
TOTAL: 24:01:03.18924:00:04.039 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.132 0.0%15641 0.000 0.008 0.149
article prepare00:00:00.003 0.0%12616 0.000 0.000 0.013
article read00:00:00.721 0.0%2091 0.000 0.345 4.000
backlog stats00:00:00.327 0.0%198203 0.000 0.002 0.005
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:03.695 0.0%130568 0.009 0.028 0.052
data write00:00:17.169 0.0%121094 0.063 0.142 0.219
idle23:55:59.264100.0%198203 216.742 434.702 1277.326
status file00:00:00.191 0.0%181 0.000 1.055 4.000
TOTAL: 23:56:29.51423:56:21.502100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:00.502 48.5%9 30.000 55.778 64.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.000 0.0%18 0.000 0.000 0.000
TOTAL: 00:00:01.03500:00:00.502 48.5%----

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 5 18576 5095 13201 280 27%46:19:41
2usenet.blueworldhosting.com 18 12246 3119 7746 1381 25%25:27:03
3peer.alt119.net 3 11734 1943 9492 299 16%21:59:59
4newsfeed.xs3.de 1 9662 169 9492 1 1%23:59:53
5news.samoylyk.net 1 10085 44 10030 11 0%23:59:51
6glockenspiel.complete.org 2 9832 34 9797 1 0%23:59:40
7news.bbs.nz 1 9374 17 9357 0 0%22:48:14
8news.furie.org.uk 1 6025 7 6017 1 0%23:59:57
9localhost 25 0 0 0 0 0%00:00:00
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
TOTAL: 11 61 87534 10428 75132 1974 11%213:14:22
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1usenet.blueworldhosting.com18.2 MB0.0 KB37.7 MB55.9 MB 32%12.7 KB
2endofthelinebbs-out.news.weretis.net17.0 MB0.0 KB462.2 KB17.5 MB 97%3.3 KB
3peer.alt119.net4.7 MB0.0 KB485.7 KB5.2 MB 90%2.4 KB
4newsfeed.xs3.de897.6 KB0.0 KB1.2 KB898.8 KB 99%5.3 KB
5glockenspiel.complete.org246.9 KB8.7 KB8.7 KB264.3 KB 93%7.6 KB
6news.samoylyk.net240.2 KB0.0 KB19.3 KB259.5 KB 92%4.7 KB
7news.bbs.nz53.6 KB0.0 KB0.0 KB53.6 KB100%3.2 KB
8news.furie.org.uk19.3 KB0.0 KB2.2 KB21.5 KB 89%2.7 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.3 MB8.7 KB38.6 MB80.0 MB 51%6.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jul 17 00:01:02 - 00:59:59 267 2.6% 0.08957.5 KB 2.3% 0.27
Jul 17 01:00:00 - 01:59:59 272 2.6% 0.08796.2 KB 1.9% 0.22
Jul 17 02:00:00 - 02:59:59 466 4.5% 0.133.1 MB 7.6% 0.89
Jul 17 03:00:00 - 03:59:59 484 4.6% 0.131.2 MB 3.0% 0.35
Jul 17 04:00:00 - 04:59:59 584 5.6% 0.161.6 MB 4.0% 0.47
Jul 17 05:00:00 - 05:59:59 555 5.3% 0.151.9 MB 4.5% 0.53
Jul 17 06:00:00 - 06:59:59 517 5.0% 0.141.9 MB 4.6% 0.53
Jul 17 07:00:00 - 07:59:59 515 4.9% 0.141.5 MB 3.6% 0.43
Jul 17 08:00:00 - 08:59:59 505 4.8% 0.142.0 MB 4.8% 0.56
Jul 17 09:00:00 - 09:59:59 493 4.7% 0.141.9 MB 4.7% 0.55
Jul 17 10:00:00 - 10:59:59 516 5.0% 0.141.5 MB 3.8% 0.44
Jul 17 11:00:00 - 11:59:59 579 5.6% 0.162.9 MB 7.0% 0.82
Jul 17 12:00:00 - 12:59:59 544 5.2% 0.151.9 MB 4.5% 0.53
Jul 17 13:00:00 - 13:59:59 532 5.1% 0.152.1 MB 5.1% 0.59
Jul 17 14:00:00 - 14:59:59 526 5.0% 0.152.1 MB 5.2% 0.61
Jul 17 15:00:00 - 15:59:59 567 5.4% 0.161.8 MB 4.4% 0.51
Jul 17 16:00:00 - 16:59:59 456 4.4% 0.132.7 MB 6.5% 0.76
Jul 17 17:00:00 - 17:59:59 400 3.8% 0.111.5 MB 3.6% 0.42
Jul 17 18:00:00 - 18:59:59 350 3.4% 0.101.3 MB 3.2% 0.37
Jul 17 19:00:00 - 19:59:59 279 2.7% 0.08856.9 KB 2.0% 0.24
Jul 17 20:00:00 - 20:59:59 265 2.5% 0.07973.6 KB 2.3% 0.27
Jul 17 21:00:00 - 21:59:59 254 2.4% 0.073.0 MB 7.2% 0.85
Jul 17 22:00:00 - 22:59:59 219 2.1% 0.06992.5 KB 2.4% 0.28
Jul 17 23:00:00 - 23:59:59 268 2.6% 0.07797.5 KB 1.9% 0.22
Jul 18 00:00:00 - 00:01:01 7 0.1% 0.1128.6 KB 0.1% 0.47
TOTAL: 23:59:59 10420 100.0% 0.1241.2 MB 100.0% 0.49
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1usenet.blueworldhosting.com 1412 85 0 0 0 0 0 0 1327
2endofthelinebbs-out.news.weretis.net 543 0 0 0 0 0 0 0 543
3peer.alt119.net 311 1 0 0 0 0 0 0 310
4news.samoylyk.net 11 0 0 0 0 0 0 0 11
5newsfeed.xs3.de 8 0 0 0 0 0 0 0 8
6news.furie.org.uk 1 1 0 0 0 0 0 0 0
7glockenspiel.complete.org 1 0 0 0 0 0 0 0 1
TOTAL: 7 2287 87 0 0 0 0 0 0 2200

Unwanted newsgroups [Top 20]:

NewsgroupCount
talk.english.tg 47
talk.generic.ua.ws 12
talk.ukrainian.tg 7
rocksolid.feeds.news 5
alt.alt.alt 4
talk.english.tw 3
ee.arvutid 2
talk.from.diary 1
grisbi.test 1
b69db6a12e9634a686190b38eb7fa935sale.craigslist.org 1
talk.from.war.diary 1
bb24a7e0d72f35ac87f30b82940f8deesale.craigslist.org 1
news.oriens-occasus.ru 1
alt.music.pink-floyd.publius 1
TOTAL: 14 87

INND Perl filter [Top 20]:

ReasonCount
EMP (phn path) 760
EMP (md5) 373
Binary: misplaced binary 272
EMP (phn nph) 200
EMP (phl) 199
Too many newsgroups 79
HTML Multipart 6
hierarchy violation - crosspost outside sdnet 1
Scoring filter 1
MID-Bot 1
TOTAL: 10 1892

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
endofthelinebbs-out.news.weretis.net 271
usenet.blueworldhosting.com 16
peer.alt119.net 12
newsfeed.xs3.de 7
glockenspiel.complete.org 1
news.samoylyk.net 1
TOTAL: 6 308
TOTAL: 1 308

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1peer.alt119.net 9354 1732 6717 4 0 1723 18%23:59:56
2news.bbs.nz 19812 631 9648 129 0 93 3%23:59:21
3news.nk.ca 14043 297 9994 104 0 32 2%23:59:56
4news.quux.org 11048 92 10174 115 0 4 0%23:59:47
5news.furie.org.uk 8769 19 5793 1 0 37 0%23:59:56
6news.tnetconsulting.net 11759 14 10400 1 0 12 0%23:59:56
7usenet.blueworldhosting.com 7786 2 7240 2 0 0 0%23:59:33
8news.weretis.net 10527 0 10418 1 0 0 0%23:59:56
9news.samoylyk.net 16295 0 13667 4 0 22 0%23:59:42
10newsfeed.xs3.de 12755 0 10226 9 0 18 0%23:59:45
TOTAL: 10 122148 2787 94277 370 0 1941 2%239:57:48
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1peer.alt119.net8.5 MB13.0 KB8.5 MB0.1 KB/s5.0 KB23:59:56
2news.bbs.nz3.8 MB720.7 KB4.5 MB0.1 KB/s6.0 KB23:59:21
3news.nk.ca2.5 MB483.8 KB2.9 MB0.0 KB/s7.5 KB23:59:56
4news.quux.org2.1 MB372.6 KB2.5 MB0.0 KB/s12.4 KB23:59:47
5news.tnetconsulting.net127.7 KB9.1 KB136.9 KB0.0 KB/s9.1 KB23:59:56
6news.furie.org.uk78.0 KB69.5 KB147.5 KB0.0 KB/s7.4 KB23:59:56
7usenet.blueworldhosting.com3.5 KB4.2 KB7.8 KB0.0 KB/s1.9 KB23:59:33
8news.weretis.net0.0 KB357.4 KB357.4 KB0.0 KB/s357.4 KB23:59:56
9news.samoylyk.net0.0 KB9.5 KB9.5 KB0.0 KB/s2.4 KB23:59:42
10newsfeed.xs3.de0.0 KB22.4 KB22.4 KB0.0 KB/s2.5 KB23:59:45
TOTAL: 1017.0 MB2.0 MB19.0 MB0.0 KB/s6.2 KB239:57:48
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1192.241.213.224 1 00.0 KB 0 0 000:00:00
2scanner-26.ch1.censys-scanner.com 3 00.0 KB 0 0 000:00:00
TOTAL: 2 4 00.0 KB 0 0 000:00:01

NNRP readership statistics (by domain):

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

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
scanner-26.ch1.censys-scanner.com 0.255 0.127 0.00000:00:00
192.241.213.224 0.075 0.057 0.00000:00:00
TOTAL: 2 0.330 0.184 0.00000:00:01

NNRP unrecognized commands (by host):

SystemConn
scanner-26.ch1.censys-scanner.com 2
192.241.213.224 1
TOTAL: 2 3

NNRP unrecognized commands (by command):

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