Daily Usenet Report

Aug 15 00:01:02 -- Aug 16 00:01:01

Unknown entries from news log file:

First 4 / 4 lines (100.0%)

Aug 15 00:04:13 www innd: message repeated 2 times: [ ctlinnd command s]
Aug 15 10:00:08 www pgpverify[2034158]: pgpverify: verification failed
Aug 15 17:44:47 www nnrpd[2044666]: unable to get certificates from '/news/etc/cert.pem'
Aug 15 17:44:47 www nnrpd[2044666]: 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 13375 70.2%3.1 MB 77.7%
innd 3623 19.0%527.5 KB 13.0%
innfeed 2006 10.5%368.1 KB 9.1%
controlchan 24 0.1%5.1 KB 0.1%
nnrpd 20 0.1%2.2 KB 0.1%
pgpverify 1 0.0%0.4 KB 0.0%
TOTAL: 6 19049 100.0%4.0 MB100.0%

History cache:

ReasonCount%Count
Positive hits 81159 54.4%
Negative hits 55036 36.9%
Do not exist 12941 8.7%
Cache misses 93 0.1%
TOTAL: 4 149229 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.103 0.0%68 0.000 1.515 18.000
article cleanup00:00:00.320 0.0%12970 0.000 0.025 0.103
article logging00:00:00.719 0.0%13306 0.000 0.054 0.121
article parse00:00:00.488 0.0%19988 0.000 0.024 0.097
article write00:00:08.528 0.0%11249 0.377 0.758 3.890
artlog/artcncl00:00:00.003 0.0%66 0.000 0.045 0.500
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.237 0.0%152423 0.000 0.002 0.010
hisgrep/artcncl00:00:00.011 0.0%65 0.000 0.169 2.000
hishave/artcncl00:00:00.001 0.0%68 0.000 0.015 0.500
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:05.052 0.0%149552 0.003 0.034 0.092
history sync00:00:00.084 0.0%405 0.000 0.207 4.000
history write00:00:05.749 0.0%12970 0.069 0.443 0.824
hiswrite/artcncl00:00:00.000 0.0%3 0.000 0.000 0.000
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:58:38.236 99.8%147938 337.514 583.476 2115.085
nntp read00:00:07.044 0.0%150586 0.020 0.047 0.082
overview write00:00:07.925 0.0%11249 0.255 0.705 3.931
perl filter00:00:40.136 0.0%12970 2.084 3.095 5.650
python filter00:00:02.423 0.0%12970 0.075 0.187 0.500
site send00:00:04.483 0.0%22500 0.039 0.199 0.580
TOTAL: 24:01:08.79824:00:01.542 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.112 0.0%11608 0.000 0.010 0.120
article prepare00:00:00.003 0.0%13700 0.000 0.000 0.009
article read00:00:00.888 0.0%2307 0.071 0.385 8.600
backlog stats00:00:00.378 0.0%214317 0.000 0.002 0.006
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:05.458 0.0%142374 0.018 0.038 0.062
data write00:00:20.236 0.0%131356 0.088 0.154 0.290
idle23:57:09.032100.0%214317 213.308 402.343 1288.255
status file00:00:00.202 0.0%174 0.000 1.161 5.000
TOTAL: 23:57:45.44123:57:36.309100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:10.298 95.0%6 43.333 1716.333 10040.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.000 0.0%21 0.000 0.000 0.000
TOTAL: 00:00:10.84200:00:10.298 95.0%----

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 4 19853 5211 14451 191 26%42:50:33
2usenet.blueworldhosting.com 14 12743 3724 7897 1122 29%25:28:16
3peer.alt119.net 2 12557 2105 10053 399 16%24:08:59
4newsfeed.xs3.de 2 10118 112 10006 0 1%23:58:44
5glockenspiel.complete.org 1 9740 67 9672 1 0%23:59:56
6news.samoylyk.net 2 10466 30 10436 0 0%23:56:23
7news.furie.org.uk 1 6206 28 6178 0 0%23:59:54
8news.bbs.nz 1 9856 15 9841 0 0%23:59:42
9localhost 25 0 0 0 0 0%00:00:00
10news.nk.ca 2 0 0 0 0 0%00:20:02
11eotl-out.news.tnetconsulting.net 1 0 0 0 0 0%00:10:12
TOTAL: 11 55 91539 11292 78534 1713 12%212:52:41
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1usenet.blueworldhosting.com23.6 MB0.0 KB2.8 MB26.4 MB 89%5.6 KB
2endofthelinebbs-out.news.weretis.net16.2 MB0.0 KB541.7 KB16.7 MB 96%3.2 KB
3peer.alt119.net5.4 MB0.0 KB1.0 MB6.5 MB 84%2.6 KB
4newsfeed.xs3.de566.6 KB0.0 KB0.0 KB566.6 KB100%5.1 KB
5glockenspiel.complete.org314.4 KB0.0 KB7.4 KB321.9 KB 97%4.7 KB
6news.furie.org.uk230.9 KB0.0 KB0.0 KB230.9 KB100%8.2 KB
7news.samoylyk.net93.1 KB0.0 KB0.0 KB93.1 KB100%3.1 KB
8news.bbs.nz38.0 KB0.0 KB0.0 KB38.0 KB100%2.5 KB
9localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
10news.nk.ca0.0 KB0.0 KB0.0 KB0.0 KB 0%0
11eotl-out.news.tnetconsulting.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1146.5 MB0.0 KB4.3 MB50.8 MB 91%4.0 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 15 00:01:02 - 00:59:59 239 2.1% 0.071.1 MB 2.4% 0.32
Aug 15 01:00:00 - 01:59:59 376 3.3% 0.101.5 MB 3.1% 0.42
Aug 15 02:00:00 - 02:59:59 472 4.2% 0.132.8 MB 6.0% 0.80
Aug 15 03:00:00 - 03:59:59 563 5.0% 0.162.1 MB 4.6% 0.61
Aug 15 04:00:00 - 04:59:59 569 5.1% 0.161.6 MB 3.5% 0.46
Aug 15 05:00:00 - 05:59:59 494 4.4% 0.141.5 MB 3.2% 0.43
Aug 15 06:00:00 - 06:59:59 650 5.8% 0.183.5 MB 7.6% 1.00
Aug 15 07:00:00 - 07:59:59 590 5.2% 0.161.8 MB 3.8% 0.51
Aug 15 08:00:00 - 08:59:59 606 5.4% 0.172.4 MB 5.2% 0.69
Aug 15 09:00:00 - 09:59:59 649 5.8% 0.182.2 MB 4.7% 0.63
Aug 15 10:00:00 - 10:59:59 610 5.4% 0.173.4 MB 7.3% 0.97
Aug 15 11:00:00 - 11:59:59 717 6.4% 0.203.0 MB 6.4% 0.85
Aug 15 12:00:00 - 12:59:59 596 5.3% 0.172.2 MB 4.8% 0.64
Aug 15 13:00:00 - 13:59:59 608 5.4% 0.172.4 MB 5.1% 0.68
Aug 15 14:00:00 - 14:59:59 529 4.7% 0.151.9 MB 4.0% 0.53
Aug 15 15:00:00 - 15:59:59 492 4.4% 0.141.5 MB 3.3% 0.43
Aug 15 16:00:00 - 16:59:59 494 4.4% 0.141.8 MB 3.9% 0.51
Aug 15 17:00:00 - 17:59:59 452 4.0% 0.131.4 MB 3.0% 0.40
Aug 15 18:00:00 - 18:59:59 329 2.9% 0.092.5 MB 5.4% 0.72
Aug 15 19:00:00 - 19:59:59 342 3.0% 0.101.7 MB 3.7% 0.49
Aug 15 20:00:00 - 20:59:59 257 2.3% 0.07988.9 KB 2.1% 0.27
Aug 15 21:00:00 - 21:59:59 214 1.9% 0.06846.9 KB 1.8% 0.24
Aug 15 22:00:00 - 22:59:59 195 1.7% 0.05821.6 KB 1.7% 0.23
Aug 15 23:00:00 - 23:59:59 199 1.8% 0.061.5 MB 3.2% 0.43
Aug 16 00:00:00 - 00:01:01 6 0.1% 0.1041.5 KB 0.1% 0.68
TOTAL: 23:59:59 11248 100.0% 0.1346.6 MB 100.0% 0.55
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1usenet.blueworldhosting.com 1124 115 0 0 0 0 0 0 1009
2endofthelinebbs-out.news.weretis.net 483 1 0 0 0 0 0 0 482
3peer.alt119.net 445 17 0 0 0 0 0 0 428
4news.samoylyk.net 6 0 0 0 0 0 0 0 6
5newsfeed.xs3.de 2 0 0 0 0 0 0 0 2
6glockenspiel.complete.org 1 0 0 0 0 0 0 0 1
TOTAL: 6 2061 133 0 0 0 0 0 0 1928

Unwanted newsgroups [Top 20]:

NewsgroupCount
talk.english.tg 51
at.jobs 16
att.jobs 15
talk.generic.ua.ws 13
aus.jobs 8
talk.english.tw 7
rocksolid.feeds.news 5
news.oriens-occasus.ru 5
al.christnet.bible 3
alt.alt.alt.alt 1
alt.music.pink-floyd.publius 1
a.b.e-book.flood 1
talk.from.war.diary 1
grisbi.test 1
fr.petites-annonces.immobilier 1
alt.alt.alt 1
1.test 1
alt.christnet.eucharist 1
fr.petites-annonces.informatique.materiel 1
TOTAL: 19 133

INND Perl filter [Top 20]:

ReasonCount
EMP (phn path) 651
EMP (md5) 398
EMP (phl) 238
Too many newsgroups 172
EMP (phn nph) 110
HTML Multipart 10
Scoring filter 8
MID-Bot 3
User-issued spam cancel 2
TOTAL: 9 1592

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
endofthelinebbs-out.news.weretis.net 290
usenet.blueworldhosting.com 21
peer.alt119.net 17
news.samoylyk.net 6
newsfeed.xs3.de 2
TOTAL: 5 336
TOTAL: 1 336

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1peer.alt119.net 10454 1972 7218 28 0 0 18%23:59:40
2news.bbs.nz 21364 685 10406 140 0 191 3%23:59:53
3news.nk.ca 15279 293 10847 96 0 19 1%23:59:56
4news.quux.org 11885 37 11074 124 0 0 0%23:59:56
5news.furie.org.uk 9297 20 6446 3 0 9 0%23:59:42
6news.tnetconsulting.net 12446 7 11238 1 0 8 0%23:59:56
7usenet.blueworldhosting.com 8029 4 7539 0 0 0 0%23:59:56
8news.weretis.net 11343 1 11245 1 0 0 0%23:59:51
9newsfeed.xs3.de 14267 0 11046 9 0 0 0%23:59:56
10news.samoylyk.net 14417 0 11214 5 0 139 0%23:59:56
TOTAL: 10 128781 3019 98273 407 0 366 2%239:58:42
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1peer.alt119.net10.6 MB64.0 KB10.7 MB0.1 KB/s5.5 KB23:59:40
2news.bbs.nz4.6 MB581.5 KB5.2 MB0.1 KB/s6.4 KB23:59:53
3news.nk.ca3.0 MB315.6 KB3.3 MB0.0 KB/s8.8 KB23:59:56
4news.quux.org786.6 KB362.5 KB1.1 MB0.0 KB/s7.1 KB23:59:56
5news.furie.org.uk132.7 KB10.9 KB143.6 KB0.0 KB/s6.2 KB23:59:42
6news.tnetconsulting.net34.9 KB3.5 KB38.3 KB0.0 KB/s4.8 KB23:59:56
7usenet.blueworldhosting.com11.9 KB0.0 KB11.9 KB0.0 KB/s3.0 KB23:59:56
8news.weretis.net1.6 KB4.8 KB6.5 KB0.0 KB/s3.2 KB23:59:51
9newsfeed.xs3.de0.0 KB34.5 KB34.5 KB0.0 KB/s3.8 KB23:59:56
10news.samoylyk.net0.0 KB14.8 KB14.8 KB0.0 KB/s3.0 KB23:59:56
TOTAL: 1019.2 MB1.4 MB20.5 MB0.0 KB/s6.1 KB239:58:42
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1scanner-04.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
294.102.61.41 1 00.0 KB 0 0 000:00:00
3107.170.197.164 1 00.0 KB 0 0 000:00:10
TOTAL: 3 3 00.0 KB 0 0 000:00:10

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:10

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
107.170.197.164 0.077 0.040 0.00000:00:10
94.102.61.41 0.098 0.051 0.00000:00:00
scanner-04.ch1.censys-scanner.com 0.075 0.056 0.00000:00:00
TOTAL: 3 0.250 0.147 0.00000:00:10

NNRP unrecognized commands (by host):

SystemConn
94.102.61.41 5
scanner-04.ch1.censys-scanner.com 1
TOTAL: 2 6

NNRP unrecognized commands (by command):

CommandCount
Host: 192.138.210.162:119 1
Accept: */* 1
GET / HTTP/1.1 1
Accept-Encoding: gzip 1
User-Agent: Mozilla/5.0 (Windows NT 10.0... 1
EHLO www.censys.io 1
TOTAL: 6 6