Daily Usenet Report

Nov 27 00:01:02 -- Nov 28 00:01:01

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

Nov 27 00:06:08 www innd: message repeated 2 times: [ ctlinnd command s]
Nov 27 06:06:36 www nnrpd[840260]: unable to get certificates from '/news/etc/cert.pem'
Nov 27 06:06:36 www nnrpd[840260]: 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 11717 48.5%3.2 MB 67.3%
nnrpd 6677 27.6%692.5 KB 14.3%
innd 3446 14.3%471.1 KB 9.7%
innfeed 2322 9.6%416.5 KB 8.6%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 5 24163 100.0%4.7 MB100.0%

History cache:

ReasonCount%Count
Positive hits 79745 56.0%
Negative hits 51184 35.9%
Do not exist 11515 8.1%
Cache misses 27 0.0%
TOTAL: 4 142471 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.077 0.0%40 0.000 1.925 4.000
article cleanup00:00:00.223 0.0%11533 0.000 0.019 0.095
article logging00:00:00.553 0.0%11635 0.000 0.048 0.154
article parse00:00:00.333 0.0%17973 0.000 0.019 0.059
article write00:00:08.534 0.0%10074 0.312 0.847 3.542
artlog/artcncl00:00:00.000 0.0%40 0.000 0.000 0.000
data move00:00:00.187 0.0%144897 0.000 0.001 0.005
hisgrep/artcncl00:00:00.015 0.0%40 0.000 0.375 1.100
hishave/artcncl00:00:00.009 0.0%40 0.000 0.225 1.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:06.672 0.0%142654 0.002 0.047 0.085
history sync00:00:00.045 0.0%381 0.000 0.118 1.000
history write00:00:06.985 0.0%11533 0.044 0.606 0.962
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:48:38.271 99.8%146877 283.640 583.606 1966.230
nntp read00:00:08.204 0.0%143191 0.028 0.057 0.096
overview write00:00:05.738 0.0%10074 0.170 0.570 6.875
perl filter00:00:29.449 0.0%11533 1.680 2.553 6.033
python filter00:00:01.630 0.0%11533 0.020 0.141 0.324
site send00:00:03.812 0.0%20148 0.029 0.189 0.530
TOTAL: 23:50:59.27323:49:50.737 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.059 0.0%10369 0.000 0.006 0.056
article prepare00:00:00.004 0.0%29824 0.000 0.000 0.011
article read00:00:01.069 0.0%4863 0.060 0.220 2.118
backlog stats00:00:00.459 0.0%213926 0.000 0.002 0.009
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:07.197 0.0%142701 0.024 0.050 0.085
data write00:00:16.525 0.0%134298 0.078 0.123 0.260
idle23:55:54.532100.0%213926 219.502 402.731 1182.864
status file00:00:00.187 0.0%184 0.000 1.016 4.000
TOTAL: 23:56:31.11323:56:20.032100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:31:28.423 40.5%6581 0.000 286.951 5971.500
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:01.260 0.0%13163 0.000 0.096 3.333
TOTAL: 01:17:37.19900:31:29.683 40.6%----

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 17960 6159 11391 410 34%45:06:37
2usenet.blueworldhosting.com 4 11381 2943 8056 382 25%24:57:05
3outgoing.news.lysator.liu.se 1 11276 603 10195 478 5%23:59:57
4newsfeed.xs3.de 1 9199 290 8908 1 3%23:59:54
5news.samoylyk.net 2 9426 60 9364 2 0%23:59:38
6glockenspiel.complete.org 1 9103 34 9067 2 0%23:59:54
7news.bbs.nz 1 3352 5 3347 0 0%11:54:53
8news.netfront.net 1 10920 3 10778 139 0%22:30:47
9news.nk.ca 2 0 0 0 0 0%00:20:01
10eotl-out.news.tnetconsulting.net 1 0 0 0 0 0%00:10:03
11localhost 25 0 0 0 0 0%00:00:00
122001:470:1f1d:50e::1 0 919 0 919 0 0%06:11:50
TOTAL: 12 43 83536 10097 72025 1414 12%207:10:39
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1endofthelinebbs-out.news.weretis.net22.1 MB0.0 KB829.9 KB23.0 MB 96%3.6 KB
2usenet.blueworldhosting.com18.4 MB0.0 KB981.0 KB19.4 MB 95%6.0 KB
3newsfeed.xs3.de2.3 MB0.0 KB1.3 KB2.3 MB 99%8.0 KB
4outgoing.news.lysator.liu.se1.0 MB0.0 KB1.2 MB2.3 MB 46%2.1 KB
5news.samoylyk.net570.4 KB0.0 KB2.5 KB572.9 KB 99%9.2 KB
6glockenspiel.complete.org487.4 KB3.3 KB7.3 KB498.0 KB 97%13.8 KB
7news.bbs.nz12.4 KB0.0 KB0.0 KB12.4 KB100%2.5 KB
8news.netfront.net6.2 KB0.0 KB438.7 KB444.9 KB 1%3.1 KB
9news.nk.ca0.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
11localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
122001:470:1f1d:50e::10.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1245.0 MB3.3 KB3.4 MB48.4 MB 92%4.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Nov 27 00:01:02 - 00:59:59 188 1.9% 0.05581.3 KB 1.3% 0.16
Nov 27 01:00:00 - 01:59:59 319 3.2% 0.091.0 MB 2.3% 0.29
Nov 27 02:00:00 - 02:59:59 433 4.3% 0.121.9 MB 4.3% 0.53
Nov 27 03:00:00 - 03:59:59 515 5.1% 0.142.7 MB 6.1% 0.76
Nov 27 04:00:00 - 04:59:59 515 5.1% 0.142.8 MB 6.3% 0.79
Nov 27 05:00:00 - 05:59:59 480 4.7% 0.131.5 MB 3.4% 0.43
Nov 27 06:00:00 - 06:59:59 530 5.2% 0.151.7 MB 3.8% 0.48
Nov 27 07:00:00 - 07:59:59 513 5.1% 0.141.7 MB 3.8% 0.47
Nov 27 08:00:00 - 08:59:59 559 5.5% 0.161.7 MB 3.9% 0.49
Nov 27 09:00:00 - 09:59:59 552 5.5% 0.152.0 MB 4.6% 0.57
Nov 27 10:00:00 - 10:59:59 681 6.7% 0.194.8 MB 10.9% 1.36
Nov 27 11:00:00 - 11:59:59 601 5.9% 0.172.2 MB 5.0% 0.63
Nov 27 12:00:00 - 12:59:59 638 6.3% 0.182.2 MB 4.9% 0.62
Nov 27 13:00:00 - 13:59:59 487 4.8% 0.142.4 MB 5.5% 0.68
Nov 27 14:00:00 - 14:59:59 465 4.6% 0.131.6 MB 3.6% 0.45
Nov 27 15:00:00 - 15:59:59 445 4.4% 0.121.3 MB 3.1% 0.38
Nov 27 16:00:00 - 16:59:59 439 4.3% 0.121.5 MB 3.4% 0.42
Nov 27 17:00:00 - 17:59:59 386 3.8% 0.113.3 MB 7.4% 0.93
Nov 27 18:00:00 - 18:59:59 338 3.3% 0.091.1 MB 2.6% 0.32
Nov 27 19:00:00 - 19:59:59 249 2.5% 0.07930.1 KB 2.1% 0.26
Nov 27 20:00:00 - 20:59:59 179 1.8% 0.051.4 MB 3.2% 0.40
Nov 27 21:00:00 - 21:59:59 166 1.6% 0.051007.1 KB 2.2% 0.28
Nov 27 22:00:00 - 22:59:59 176 1.7% 0.052.0 MB 4.6% 0.58
Nov 27 23:00:00 - 23:59:59 257 2.5% 0.07742.4 KB 1.7% 0.21
Nov 28 00:00:00 - 00:01:01 4 0.0% 0.0720.2 KB 0.0% 0.33
TOTAL: 23:59:59 10115 100.0% 0.1243.9 MB 100.0% 0.52
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1outgoing.news.lysator.liu.se 548 0 0 0 0 0 0 0 548
2endofthelinebbs-out.news.weretis.net 504 0 0 0 0 0 0 0 504
3usenet.blueworldhosting.com 388 9 0 0 0 0 0 0 379
4news.netfront.net 118 0 0 0 0 0 0 0 118
5news.samoylyk.net 3 0 0 0 0 0 0 0 3
6newsfeed.xs3.de 1 0 0 0 0 0 0 0 1
TOTAL: 6 1562 9 0 0 0 0 0 0 1553

Unwanted newsgroups [Top 20]:

NewsgroupCount
rocksolid.feeds.news 5
panix.user.movies 1
panix.test 1
gugsevtiscali.it 1
gun.general 1
TOTAL: 5 9

INND Perl filter [Top 20]:

ReasonCount
EMP (phn path) 746
EMP (md5) 395
EMP (phl) 196
EMP (phn nph) 68
Too many newsgroups 33
Scoring filter 11
U2 violation - invalid distribution 2
TOTAL: 7 1451

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
endofthelinebbs-out.news.weretis.net 93
usenet.blueworldhosting.com 7
news.samoylyk.net 1
outgoing.news.lysator.liu.se 1
TOTAL: 4 102
TOTAL: 1 102

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.netfront.net 13826 4539 5569 4 0 7 32%23:59:53
2nyheter.lysator.liu.se 9901 2419 7060 10 0 0 24%23:59:53
3news.nk.ca 13280 191 9835 29 0 14 1%23:59:54
4news.quux.org 10561 59 9966 70 0 0 0%23:59:54
5news.furie.org.uk 6844 49 5359 5 0 10 0%23:59:45
6news.bbs.nz 19807 29 10038 38 0 207 0%23:59:53
7usenet.blueworldhosting.com 7770 15 7160 1 0 10 0%23:59:54
8news.tnetconsulting.net 10956 8 10100 0 0 19 0%23:59:09
9news.weretis.net 10178 1 10112 0 0 0 0%23:59:54
10news.samoylyk.net 12602 0 10051 0 0 0 0%23:59:46
11newsfeed.xs3.de 12215 0 9808 0 0 0 0%23:59:54
12peer.alt119.net 0 0 0 0 0 10112 0%23:57:47
TOTAL: 12 127940 7310 95058 157 0 10379 5%287:55:36
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.netfront.net25.1 MB8.3 KB25.2 MB0.3 KB/s5.7 KB23:59:53
2nyheter.lysator.liu.se14.9 MB519.9 KB15.4 MB0.2 KB/s6.5 KB23:59:53
3news.furie.org.uk3.9 MB293.5 KB4.2 MB0.0 KB/s79.4 KB23:59:45
4news.nk.ca738.5 KB115.8 KB854.3 KB0.0 KB/s3.9 KB23:59:54
5news.quux.org381.7 KB396.4 KB778.1 KB0.0 KB/s6.0 KB23:59:54
6news.bbs.nz235.5 KB317.9 KB553.4 KB0.0 KB/s8.3 KB23:59:53
7news.tnetconsulting.net50.2 KB0.0 KB50.2 KB0.0 KB/s6.3 KB23:59:09
8usenet.blueworldhosting.com31.9 KB19.6 KB51.4 KB0.0 KB/s3.2 KB23:59:54
9news.weretis.net1.8 KB0.0 KB1.8 KB0.0 KB/s1.8 KB23:59:54
10news.samoylyk.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:46
11newsfeed.xs3.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:54
12peer.alt119.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:47
TOTAL: 1245.4 MB1.6 MB47.0 MB0.0 KB/s6.4 KB287:55:36
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1freeq.furie.org.uk2111 00.0 KB 0 0 001:07:36
22001:470:1f1d:50e::1 84 00.0 KB 0 0 000:09:50
3scanner-26.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
TOTAL: 32196 00.0 KB 0 0 001:17:26

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
2? 84 00.0 KB 0 0 000:09:50
3*.furie.org.uk2111 00.0 KB 0 0 001:07:36
TOTAL: 32196 00.0 KB 0 0 001:17:26

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
freeq.furie.org.uk 182.419 57.670 0.00001:07:36
2001:470:1f1d:50e::1 7.248 2.445 0.00000:09:50
scanner-26.ch1.censys-scanner.com 0.091 0.030 0.00000:00:00
TOTAL: 3 189.758 60.145 0.00001:17:26

NNRP unrecognized commands (by host):

SystemConn
scanner-26.ch1.censys-scanner.com 1
TOTAL: 1 1

NNRP unrecognized commands (by command):

CommandCount
EHLO www.censys.io 1
TOTAL: 1 1