Daily Usenet Report

Sep 15 00:01:02 -- Sep 16 00:01:01

Unknown entries from news log file:

First 4 / 4 lines (100.0%)

Sep 15 00:04:49 www innd: message repeated 2 times: [ ctlinnd command s]
Sep 15 08:29:56 www nnrpd[826249]: unable to get certificates from '/news/etc/cert.pem'
Sep 15 08:29:56 www nnrpd[826249]: error initializing TLS: [CA_file: ] [CA_path: /news/etc] [cert_file: /news/etc/cert.pem] [key_file: /news/etc/key.pem]
Sep 15 10:00:08 www pgpverify[828520]: pgpverify: verification failed

Log entries by program:

Program nameLines%LinesSize%Size
inn 14338 70.7%3.2 MB 78.0%
innd 3900 19.2%566.8 KB 13.4%
innfeed 2000 9.9%356.4 KB 8.4%
controlchan 24 0.1%5.5 KB 0.1%
nnrpd 23 0.1%2.4 KB 0.1%
pgpverify 1 0.0%0.4 KB 0.0%
TOTAL: 6 20286 100.0%4.1 MB100.0%

History cache:

ReasonCount%Count
Positive hits 86900 53.9%
Negative hits 60160 37.3%
Do not exist 14024 8.7%
Cache misses 117 0.1%
TOTAL: 4 161201 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.142 0.0%71 0.000 2.000 7.000
article cleanup00:00:00.299 0.0%14079 0.000 0.021 0.064
article logging00:00:00.647 0.0%14282 0.000 0.045 0.124
article parse00:00:00.457 0.0%20643 0.000 0.022 0.146
article write00:00:09.424 0.0%12040 0.408 0.783 2.207
artlog/artcncl00:00:00.000 0.0%71 0.000 0.000 0.000
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.218 0.0%165315 0.000 0.001 0.010
hisgrep/artcncl00:00:00.023 0.0%71 0.000 0.324 2.000
hishave/artcncl00:00:00.003 0.0%71 0.000 0.042 1.000
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.832 0.0%161693 0.006 0.036 0.083
history sync00:00:00.078 0.0%395 0.000 0.197 2.667
history write00:00:07.053 0.0%14079 0.057 0.501 1.420
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:38.711 99.8%161090 217.532 535.842 1629.560
nntp read00:00:07.353 0.0%163796 0.024 0.045 0.088
overview write00:00:07.123 0.0%12040 0.260 0.592 2.429
perl filter00:00:37.315 0.0%14079 2.067 2.650 4.025
python filter00:00:02.367 0.0%14079 0.083 0.168 0.442
site send00:00:05.268 0.0%24082 0.087 0.219 0.500
TOTAL: 24:01:10.03124:00:02.313 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.178 0.0%13793 0.000 0.013 0.129
article prepare00:00:00.003 0.0%13486 0.000 0.000 0.017
article read00:00:00.706 0.0%1945 0.077 0.363 6.000
backlog stats00:00:00.390 0.0%222774 0.000 0.002 0.007
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:05.303 0.0%147840 0.019 0.036 0.050
data write00:00:19.775 0.0%136307 0.099 0.145 0.234
idle23:56:54.687100.0%222774 192.225 387.005 1016.722
status file00:00:00.182 0.0%175 0.000 1.040 6.000
TOTAL: 23:57:30.90323:57:21.224100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:11.252 94.0%8 26.000 1406.500 9809.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.000 0.0%16 0.000 0.000 0.000
TOTAL: 00:00:11.97200:00:11.252 94.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
1peer.alt119.net 3 13469 3997 9012 460 29%24:08:57
2usenet.blueworldhosting.com 5 13685 3953 8677 1055 28%25:08:47
3endofthelinebbs-out.news.weretis.net 5 20137 3808 15780 549 18%42:00:59
4newsfeed.xs3.de 1 10968 256 10707 5 2%23:59:55
5news.samoylyk.net 1 11201 44 11157 0 0%23:59:52
6news.furie.org.uk 2 5824 21 5803 0 0%23:59:38
7news.bbs.nz 2 11718 20 11698 0 0%23:59:30
8glockenspiel.complete.org 4 13601 20 13580 1 0%27:23:47
9localhost 25 0 0 0 0 0%00:00:00
10news.nk.ca 2 0 0 0 0 0%00:20:01
11eotl-out.news.tnetconsulting.net 1 0 0 0 0 0%00:10:15
TOTAL: 11 51 100603 12119 86414 2070 12%215:11:41
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1usenet.blueworldhosting.com22.9 MB0.0 KB2.5 MB25.5 MB 90%5.2 KB
2endofthelinebbs-out.news.weretis.net12.5 MB0.0 KB1.1 MB13.6 MB 92%3.2 KB
3peer.alt119.net9.7 MB0.0 KB1.2 MB10.9 MB 88%2.5 KB
4newsfeed.xs3.de1.2 MB0.0 KB11.1 KB1.2 MB 99%4.9 KB
5glockenspiel.complete.org300.6 KB0.0 KB5.0 KB305.7 KB 98%14.6 KB
6news.samoylyk.net134.6 KB0.0 KB0.0 KB134.6 KB100%3.1 KB
7news.furie.org.uk65.1 KB0.0 KB0.0 KB65.1 KB100%3.1 KB
8news.bbs.nz40.5 KB0.0 KB0.0 KB40.5 KB100%2.0 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.9 MB0.0 KB4.9 MB51.8 MB 90%3.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 15 00:01:02 - 00:59:59 326 2.7% 0.091.2 MB 2.6% 0.34
Sep 15 01:00:00 - 01:59:59 439 3.6% 0.121.1 MB 2.5% 0.32
Sep 15 02:00:00 - 02:59:59 578 4.8% 0.161.9 MB 4.2% 0.54
Sep 15 03:00:00 - 03:59:59 540 4.5% 0.151.7 MB 3.8% 0.49
Sep 15 04:00:00 - 04:59:59 679 5.6% 0.193.4 MB 7.5% 0.96
Sep 15 05:00:00 - 05:59:59 617 5.1% 0.172.3 MB 5.0% 0.65
Sep 15 06:00:00 - 06:59:59 606 5.0% 0.172.2 MB 4.8% 0.61
Sep 15 07:00:00 - 07:59:59 641 5.3% 0.182.2 MB 4.8% 0.62
Sep 15 08:00:00 - 08:59:59 708 5.9% 0.202.3 MB 5.1% 0.65
Sep 15 09:00:00 - 09:59:59 799 6.6% 0.223.6 MB 7.9% 1.02
Sep 15 10:00:00 - 10:59:59 755 6.3% 0.213.0 MB 6.6% 0.84
Sep 15 11:00:00 - 11:59:59 709 5.9% 0.202.6 MB 5.7% 0.73
Sep 15 12:00:00 - 12:59:59 600 5.0% 0.171.7 MB 3.8% 0.49
Sep 15 13:00:00 - 13:59:59 649 5.4% 0.182.3 MB 5.1% 0.66
Sep 15 14:00:00 - 14:59:59 512 4.3% 0.141.7 MB 3.8% 0.48
Sep 15 15:00:00 - 15:59:59 482 4.0% 0.131.5 MB 3.4% 0.43
Sep 15 16:00:00 - 16:59:59 355 2.9% 0.101.1 MB 2.5% 0.33
Sep 15 17:00:00 - 17:59:59 406 3.4% 0.111.7 MB 3.8% 0.48
Sep 15 18:00:00 - 18:59:59 373 3.1% 0.102.1 MB 4.6% 0.59
Sep 15 19:00:00 - 19:59:59 305 2.5% 0.081.9 MB 4.3% 0.55
Sep 15 20:00:00 - 20:59:59 231 1.9% 0.061.1 MB 2.4% 0.31
Sep 15 21:00:00 - 21:59:59 263 2.2% 0.071.0 MB 2.3% 0.29
Sep 15 22:00:00 - 22:59:59 195 1.6% 0.05592.0 KB 1.3% 0.16
Sep 15 23:00:00 - 23:59:59 255 2.1% 0.07941.2 KB 2.0% 0.26
Sep 16 00:00:00 - 00:01:01 13 0.1% 0.2157.3 KB 0.1% 0.94
TOTAL: 23:59:59 12036 100.0% 0.1445.0 MB 100.0% 0.53
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1usenet.blueworldhosting.com 1034 134 0 0 0 0 0 0 900
2endofthelinebbs-out.news.weretis.net 700 0 0 0 0 0 0 0 700
3peer.alt119.net 431 7 0 0 0 0 0 0 424
4glockenspiel.complete.org 56 0 0 0 0 0 0 0 56
5newsfeed.xs3.de 9 0 0 0 0 0 0 0 9
6news.samoylyk.net 1 0 0 0 0 0 0 0 1
TOTAL: 6 2231 141 0 0 0 0 0 0 2090

Unwanted newsgroups [Top 20]:

NewsgroupCount
talk.english.tg 56
talk.generic.ua.ws 17
talk.english.tw 15
at.jobs 9
att.jobs 7
panix.chat 7
1.test 6
aus.jobs 5
rocksolid.feeds.news 4
al.christnet.bible 3
talk.from.diary 2
alt.alt.alt.alt 1
panix.chat.politics 1
grisbi.test 1
alt.alt.alt 1
trollnet.cinema 1
talk.politics 1
talk.from.war.diary 1
fr.petites-annonces.informatique.materiel 1
alt.radio.networks 1
TOTAL: 21 141

INND Perl filter [Top 20]:

ReasonCount
EMP (phn path) 968
EMP (md5) 461
EMP (phl) 210
Too many newsgroups 133
EMP (phn nph) 101
Scoring filter 9
HTML post 2
HTML Multipart 2
TOTAL: 8 1886

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
endofthelinebbs-out.news.weretis.net 159
usenet.blueworldhosting.com 22
peer.alt119.net 18
newsfeed.xs3.de 4
news.samoylyk.net 1
TOTAL: 5 204
TOTAL: 1 204

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.bbs.nz 22034 1324 10522 168 1 50 6%23:59:41
2peer.alt119.net 10031 1304 6754 11 0 0 12%23:59:42
3news.nk.ca 15873 218 11686 73 0 9 1%23:59:55
4news.quux.org 13557 108 11792 114 0 1698 0%23:59:55
5news.furie.org.uk 9104 24 6156 8 0 7 0%23:59:54
6usenet.blueworldhosting.com 8708 6 8192 1 0 5 0%23:59:55
7news.tnetconsulting.net 13179 5 12024 0 0 0 0%23:59:48
8news.weretis.net 12130 1 12028 1 0 0 0%23:59:55
9newsfeed.xs3.de 14899 1 11769 5 0 0 0%23:59:55
10news.samoylyk.net 15171 1 11991 1 0 3 0%23:59:33
TOTAL: 10 134686 2992 102914 382 1 1772 2%239:58:13
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1peer.alt119.net6.3 MB41.9 KB6.3 MB0.1 KB/s4.9 KB23:59:42
2news.bbs.nz5.7 MB763.2 KB6.4 MB0.1 KB/s4.4 KB23:59:41
3news.nk.ca1.2 MB236.9 KB1.5 MB0.0 KB/s5.1 KB23:59:55
4news.quux.org876.9 KB400.9 KB1.2 MB0.0 KB/s5.8 KB23:59:55
5news.furie.org.uk215.8 KB59.6 KB275.5 KB0.0 KB/s8.6 KB23:59:54
6news.tnetconsulting.net22.1 KB0.0 KB22.1 KB0.0 KB/s4.4 KB23:59:48
7usenet.blueworldhosting.com12.5 KB14.9 KB27.4 KB0.0 KB/s3.9 KB23:59:55
8news.weretis.net3.1 KB2.9 KB6.0 KB0.0 KB/s3.0 KB23:59:55
9news.samoylyk.net2.7 KB1.6 KB4.2 KB0.0 KB/s2.1 KB23:59:33
10newsfeed.xs3.de1.8 KB18.1 KB19.9 KB0.0 KB/s3.3 KB23:59:55
TOTAL: 1014.3 MB1.5 MB15.8 MB0.0 KB/s4.8 KB239:58:13
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1192.241.219.31 1 00.0 KB 0 0 000:00:09
2scanner-26.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
3192.241.203.28 1 00.0 KB 0 0 000:00:00
450.31.21.10 2 00.0 KB 0 0 000:00:01
TOTAL: 4 5 00.0 KB 0 0 000:00:11

NNRP readership statistics (by domain):

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

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
192.241.219.31 0.079 0.034 0.00000:00:09
50.31.21.10 0.163 0.055 0.00000:00:01
scanner-26.ch1.censys-scanner.com 0.072 0.043 0.00000:00:00
192.241.203.28 0.105 0.044 0.00000:00:00
TOTAL: 4 0.419 0.176 0.00000:00:11

NNRP unrecognized commands (by host):

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

NNRP unrecognized commands (by command):

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