Daily Usenet Report

Feb 7 00:01:01 -- Feb 8 00:01:02

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

Feb 7 00:06:35 www innd: message repeated 2 times: [ ctlinnd command s]
Feb 7 16:24:55 www nnrpd[873125]: unable to get certificates from '/news/etc/cert.pem'
Feb 7 16:24:55 www nnrpd[873125]: 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 14728 66.4%3.8 MB 77.2%
innd 5095 23.0%713.4 KB 14.2%
innfeed 2327 10.5%427.9 KB 8.5%
nnrpd 14 0.1%1.6 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 5 22165 100.0%4.9 MB100.0%

History cache:

ReasonCount%Count
Positive hits 94167 57.6%
Negative hits 54955 33.6%
Do not exist 14472 8.8%
Cache misses 29 0.0%
TOTAL: 4 163623 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.090 0.0%49 0.000 1.837 21.000
article cleanup00:00:00.321 0.0%14525 0.000 0.022 0.091
article logging00:00:00.578 0.0%14683 0.000 0.039 0.118
article parse00:00:01.624 0.0%91207 0.000 0.018 0.082
article write00:00:11.814 0.0%11581 0.474 1.020 3.333
artlog/artcncl00:00:00.000 0.0%47 0.000 0.000 0.000
data move00:00:00.578 0.0%238811 0.000 0.002 0.009
hisgrep/artcncl00:00:00.018 0.0%49 0.000 0.367 2.000
hishave/artcncl00:00:00.002 0.0%49 0.000 0.041 1.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:07.582 0.0%164152 0.007 0.046 0.081
history sync00:00:00.056 0.0%382 0.000 0.147 1.000
history write00:00:08.119 0.0%14523 0.208 0.559 0.970
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:58:11.500 99.8%230405 54.689 374.521 2301.165
nntp read00:00:15.763 0.0%231123 0.020 0.068 0.186
overview write00:00:06.731 0.0%11581 0.161 0.581 5.033
perl filter00:00:36.099 0.0%14523 1.768 2.486 6.051
python filter00:00:02.810 0.0%14523 0.064 0.193 0.612
site send00:00:03.643 0.0%23162 0.010 0.157 0.462
TOTAL: 24:00:58.91323:59:47.328 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.127 0.0%12060 0.000 0.011 0.111
article prepare00:00:00.010 0.0%38964 0.000 0.000 0.007
article read00:00:01.518 0.0%6291 0.059 0.241 2.167
backlog stats00:00:00.527 0.0%249825 0.000 0.002 0.008
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:04.693 0.0%165434 0.014 0.028 0.047
data write00:00:20.989 0.0%154854 0.074 0.136 0.226
idle23:57:23.004100.0%249825 173.070 345.214 963.989
status file00:00:00.181 0.0%194 0.000 0.933 5.000
TOTAL: 23:58:01.25923:57:51.049100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:10.595 96.2%7 24.333 1513.571 5234.500
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.001 0.0%43 0.000 0.023 0.167
TOTAL: 00:00:11.00900:00:10.596 96.2%----

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 3 22422 6257 16004 161 27%51:32:50
2usenet.blueworldhosting.com 8 13138 4334 7994 810 32%25:34:01
3newsfeed.xs3.de 1 10382 570 9812 0 5%23:59:54
4outgoing.news.lysator.liu.se 2 12324 514 11614 196 4%23:59:53
5glockenspiel.complete.org 2 10488 59 10428 1 0%23:59:49
6news.samoylyk.net 1 10595 59 10536 0 0%23:59:52
7news.bbs.nz 4 12576 10 12566 0 0%31:55:47
8news.furie.org.uk 2 6151 3 6148 0 0%23:59:26
9news.netfront.net 2 15791 2 13846 1943 0%28:42:20
10localhost 25 0 0 0 0 0%00:00:00
11eotl-out.news.tnetconsulting.net 2 0 0 0 0 0%00:20:05
12news.nk.ca 3 0 0 0 0 0%00:30:03
TOTAL: 12 55 113867 11808 98948 3111 10%258:34:00
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1usenet.blueworldhosting.com25.0 MB0.0 KB3.1 MB28.1 MB 88%5.6 KB
2endofthelinebbs-out.news.weretis.net20.0 MB0.0 KB354.0 KB20.4 MB 98%3.3 KB
3newsfeed.xs3.de2.1 MB0.0 KB0.0 KB2.1 MB100%3.8 KB
4outgoing.news.lysator.liu.se938.3 KB0.0 KB605.9 KB1.5 MB 60%2.2 KB
5news.samoylyk.net327.2 KB0.0 KB0.0 KB327.2 KB100%5.5 KB
6glockenspiel.complete.org290.5 KB1.5 KB1.5 KB293.5 KB 98%4.9 KB
7news.bbs.nz50.2 KB0.0 KB0.0 KB50.2 KB100%5.0 KB
8news.netfront.net7.3 KB0.0 KB646.7 MB646.7 MB 0%340.5 KB
9news.furie.org.uk6.1 KB0.0 KB0.0 KB6.1 KB100%2.0 KB
10localhost0.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
12news.nk.ca0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1248.7 MB1.5 KB650.7 MB699.4 MB 6%48.0 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Feb 7 00:01:01 - 00:59:59 292 2.5% 0.082.1 MB 4.3% 0.60
Feb 7 01:00:00 - 01:59:59 373 3.2% 0.101.3 MB 2.7% 0.37
Feb 7 02:00:00 - 02:59:59 525 4.5% 0.152.2 MB 4.6% 0.62
Feb 7 03:00:00 - 03:59:59 602 5.2% 0.172.1 MB 4.3% 0.59
Feb 7 04:00:00 - 04:59:59 602 5.2% 0.171.8 MB 3.8% 0.52
Feb 7 05:00:00 - 05:59:59 608 5.3% 0.172.6 MB 5.4% 0.74
Feb 7 06:00:00 - 06:59:59 643 5.6% 0.183.5 MB 7.2% 0.99
Feb 7 07:00:00 - 07:59:59 546 4.7% 0.151.8 MB 3.7% 0.51
Feb 7 08:00:00 - 08:59:59 556 4.8% 0.152.2 MB 4.7% 0.64
Feb 7 09:00:00 - 09:59:59 678 5.9% 0.192.3 MB 4.8% 0.65
Feb 7 10:00:00 - 10:59:59 836 7.2% 0.233.0 MB 6.2% 0.85
Feb 7 11:00:00 - 11:59:59 583 5.0% 0.162.8 MB 5.7% 0.78
Feb 7 12:00:00 - 12:59:59 524 4.5% 0.152.7 MB 5.7% 0.78
Feb 7 13:00:00 - 13:59:59 644 5.6% 0.182.9 MB 6.0% 0.82
Feb 7 14:00:00 - 14:59:59 585 5.1% 0.162.0 MB 4.2% 0.58
Feb 7 15:00:00 - 15:59:59 511 4.4% 0.141.8 MB 3.8% 0.52
Feb 7 16:00:00 - 16:59:59 537 4.6% 0.151.8 MB 3.7% 0.50
Feb 7 17:00:00 - 17:59:59 438 3.8% 0.122.7 MB 5.5% 0.76
Feb 7 18:00:00 - 18:59:59 327 2.8% 0.09960.8 KB 2.0% 0.27
Feb 7 19:00:00 - 19:59:59 289 2.5% 0.081.3 MB 2.7% 0.37
Feb 7 20:00:00 - 20:59:59 217 1.9% 0.06662.0 KB 1.3% 0.18
Feb 7 21:00:00 - 21:59:59 234 2.0% 0.07776.3 KB 1.6% 0.22
Feb 7 22:00:00 - 22:59:59 196 1.7% 0.052.0 MB 4.1% 0.57
Feb 7 23:00:00 - 23:59:59 221 1.9% 0.06924.1 KB 1.9% 0.26
Feb 8 00:00:00 - 00:01:02 7 0.1% 0.1120.3 KB 0.0% 0.33
TOTAL: 24:00:01 11574 100.0% 0.1348.0 MB 100.0% 0.57
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.netfront.net 1783 0 0 0 0 0 0 0 1783
2usenet.blueworldhosting.com 797 56 0 0 0 0 0 0 741
3endofthelinebbs-out.news.weretis.net 290 0 0 0 0 0 0 0 290
4outgoing.news.lysator.liu.se 218 0 0 0 0 0 0 0 218
5newsfeed.xs3.de 15 0 0 0 0 0 0 0 15
6news.samoylyk.net 3 0 0 1 0 0 0 0 2
7glockenspiel.complete.org 1 0 0 1 0 0 0 0 0
TOTAL: 7 3107 56 0 2 0 0 0 0 3049

Unwanted newsgroups [Top 20]:

NewsgroupCount
panix.test 20
panix.staff.general 9
panix.chat 5
rocksolid.feeds.news 5
panix.staff.tech-staff 4
panix.questions 4
panix.staff.netbsd.current-users 2
panix.staff.netbsd.users 2
ee.arvutid 1
alt.alt.alt 1
alt.bestjobsusa.houston.jobs 1
panix.staff.netbsd.tech 1
panix.staff.netbsd.announce 1
TOTAL: 13 56

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 796
EMP (phn path) 270
Binary: misplaced binary fx14.ams4.POSTED 261
Binary: misplaced binary fx11.iad.POSTED 261
Binary: misplaced binary fx15.ams4.POSTED 159
Binary: misplaced binary fx05.ams4.POSTED 149
Binary: misplaced binary fx09.ams4.POSTED 134
Binary: misplaced binary fx03.ams4.POSTED 134
Binary: misplaced binary fx10.iad.POSTED 126
Binary: misplaced binary fx01.ams4.POSTED 101
Binary: misplaced binary fx06.ams4.POSTED 101
Binary: misplaced binary fx08.ams4.POSTED 94
Binary: misplaced binary fx04.ams4.POSTED 81
Too many newsgroups 53
EMP (phl) 32
Binary: misplaced binary fx11.ams4.POSTED 31
Binary: misplaced binary fx09.iad.POSTED 27
Binary: misplaced binary fx12.ams4.POSTED 26
Binary: misplaced binary fx02.ams4.POSTED 25
Scoring filter 18
TOTAL: 25 2891

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
endofthelinebbs-out.news.weretis.net 133
newsfeed.xs3.de 15
usenet.blueworldhosting.com 7
news.samoylyk.net 2
outgoing.news.lysator.liu.se 1
TOTAL: 5 158
TOTAL: 1 158

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.netfront.net 15443 5937 5627 8 0 7 38%23:59:56
2nyheter.lysator.liu.se 11614 3335 7703 11 0 0 28%23:59:57
3news.quux.org 11842 43 11266 185 0 0 0%23:59:57
4news.bbs.nz 22047 37 11383 140 0 442 0%23:59:57
5news.nk.ca 15238 17 11471 9 0 16 0%23:59:57
6news.furie.org.uk 8064 13 6355 2 0 4 0%23:59:57
7usenet.blueworldhosting.com 8422 6 7341 0 0 17 0%23:59:57
8news.weretis.net 11649 1 11568 1 0 0 0%23:59:57
9peer.alt119.net 0 0 0 0 0 11566 0%23:57:48
10newsfeed.xs3.de 14483 0 10987 5 0 0 0%23:59:46
11news.tnetconsulting.net 12677 0 11568 1 0 10 0%23:59:57
12news.samoylyk.net 15068 0 11509 1 0 0 0%23:59:57
TOTAL: 12 146547 9389 106778 363 0 12062 6%287:57:03
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.netfront.net26.2 MB21.7 KB26.2 MB0.3 KB/s4.5 KB23:59:56
2nyheter.lysator.liu.se17.2 MB90.4 KB17.2 MB0.2 KB/s5.3 KB23:59:57
3news.quux.org294.6 KB779.6 KB1.0 MB0.0 KB/s4.7 KB23:59:57
4news.bbs.nz194.9 KB592.4 KB787.4 KB0.0 KB/s4.4 KB23:59:57
5news.furie.org.uk163.6 KB23.0 KB186.7 KB0.0 KB/s12.4 KB23:59:57
6news.nk.ca43.6 KB30.4 KB74.0 KB0.0 KB/s2.8 KB23:59:57
7usenet.blueworldhosting.com15.2 KB0.0 KB15.2 KB0.0 KB/s2.5 KB23:59:57
8news.weretis.net1.2 KB5.1 KB6.3 KB0.0 KB/s3.2 KB23:59:57
9peer.alt119.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:48
10newsfeed.xs3.de0.0 KB24.7 KB24.7 KB0.0 KB/s4.9 KB23:59:46
11news.tnetconsulting.net0.0 KB5.3 KB5.3 KB0.0 KB/s5.3 KB23:59:57
12news.samoylyk.net0.0 KB2.5 KB2.5 KB0.0 KB/s2.5 KB23:59:57
TOTAL: 1244.0 MB1.5 MB45.6 MB0.0 KB/s4.8 KB287:57:03
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1scanner-26.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
2sh-phx-us-gp1-wk107.internet-census.org 1 00.0 KB 0 0 000:00:10
3198.199.112.71 1 00.0 KB 0 0 000:00:00
TOTAL: 3 3 00.0 KB 0 0 000:00:10

NNRP readership statistics (by domain):

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

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
sh-phx-us-gp1-wk107.internet-census.org 0.077 0.058 0.00000:00:10
198.199.112.71 0.067 0.041 0.00000:00:00
scanner-26.ch1.censys-scanner.com 0.078 0.017 0.00000:00:00
TOTAL: 3 0.222 0.116 0.00000:00:10

NNRP unrecognized commands (by host):

SystemConn
198.199.112.71 1
scanner-26.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