Daily Usenet Report

Feb 21 00:01:01 -- Feb 22 00:01:02

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

Feb 21 00:07:20 www innd: message repeated 2 times: [ ctlinnd command s]
Feb 21 17:27:18 www nnrpd[3494833]: unable to get certificates from '/news/etc/cert.pem'
Feb 21 17:27:18 www nnrpd[3494833]: 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 15518 65.3%3.9 MB 76.0%
innd 5904 24.8%820.4 KB 15.7%
innfeed 2329 9.8%426.1 KB 8.2%
nnrpd 26 0.1%3.0 KB 0.1%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 5 23778 100.0%5.1 MB100.0%

History cache:

ReasonCount%Count
Positive hits 95891 56.5%
Negative hits 58736 34.6%
Do not exist 15183 8.9%
Cache misses 45 0.0%
TOTAL: 4 169855 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.088 0.0%60 0.000 1.467 4.000
article cleanup00:00:00.310 0.0%15246 0.000 0.020 0.080
article logging00:00:00.686 0.0%15469 0.000 0.044 0.114
article parse00:00:02.044 0.0%107702 0.000 0.019 0.130
article write00:00:13.917 0.0%11513 0.402 1.209 2.773
artlog/artcncl00:00:00.001 0.0%52 0.000 0.019 1.000
data move00:00:00.484 0.0%265027 0.000 0.002 0.007
hisgrep/artcncl00:00:00.015 0.0%59 0.000 0.254 1.000
hishave/artcncl00:00:00.011 0.0%60 0.000 0.183 1.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:09.173 0.0%170604 0.017 0.054 0.128
history sync00:00:00.057 0.0%386 0.000 0.148 1.000
history write00:00:09.297 0.0%15239 0.286 0.610 1.070
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
idle23:57:51.447 99.8%254696 57.622 338.723 1685.646
nntp read00:00:19.024 0.0%255615 0.019 0.074 0.199
overview write00:00:07.662 0.0%11513 0.184 0.666 6.789
perl filter00:00:39.916 0.0%15239 1.601 2.619 4.580
python filter00:00:02.818 0.0%15239 0.083 0.185 0.545
site send00:00:03.978 0.0%23026 0.063 0.173 0.580
TOTAL: 24:01:00.96623:59:40.928 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.163 0.0%11763 0.000 0.014 0.107
article prepare00:00:00.005 0.0%39716 0.000 0.000 0.005
article read00:00:01.559 0.0%5880 0.105 0.265 1.880
backlog stats00:00:00.495 0.0%256999 0.000 0.002 0.006
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:05.299 0.0%167231 0.012 0.032 0.046
data write00:00:22.729 0.0%156652 0.099 0.145 0.208
idle23:55:53.929100.0%256999 208.802 335.231 1066.255
status file00:00:00.192 0.0%196 0.000 0.980 5.000
TOTAL: 23:56:35.19123:56:24.371100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:13.487 91.6%9 20.333 1498.556 10046.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.001 0.0%18 0.000 0.056 0.500
TOTAL: 00:00:14.72100:00:13.488 91.6%----

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 22781 6164 16125 492 27%49:36:15
2usenet.blueworldhosting.com 4 12976 4174 7980 822 32%23:39:48
3outgoing.news.lysator.liu.se 2 12657 596 11807 254 4%23:59:50
4newsfeed.xs3.de 1 10490 369 10118 3 3%23:59:55
5news.samoylyk.net 1 10505 70 10433 2 0%23:59:50
6glockenspiel.complete.org 2 11267 37 11155 75 0%23:59:50
7news.netfront.net 2 15344 8 13133 2203 0%25:08:44
8news.bbs.nz 4 10671 7 10664 0 0%26:30:15
9news.furie.org.uk 2 5750 5 5743 2 0%23:59:39
10localhost 25 0 0 0 0 0%00:00:00
11eotl-out.news.tnetconsulting.net 1 0 0 0 0 0%00:10:15
12news.nk.ca 2 0 0 0 0 0%00:21:09
TOTAL: 12 49 112441 11430 97158 3853 10%245:25:30
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1usenet.blueworldhosting.com27.9 MB0.0 KB3.4 MB31.3 MB 89%6.4 KB
2endofthelinebbs-out.news.weretis.net18.5 MB26.2 KB962.5 KB19.4 MB 95%3.0 KB
3newsfeed.xs3.de1.2 MB0.0 KB3.6 KB1.2 MB 99%3.3 KB
4outgoing.news.lysator.liu.se1.0 MB0.0 KB591.9 KB1.6 MB 64%1.9 KB
5news.samoylyk.net210.4 KB12.3 KB12.3 KB235.1 KB 89%3.3 KB
6glockenspiel.complete.org188.4 KB14.8 KB179.9 KB383.1 KB 49%3.4 KB
7news.netfront.net33.0 KB0.0 KB733.1 MB733.1 MB 0%339.5 KB
8news.furie.org.uk21.1 KB4.7 KB4.7 KB30.6 KB 69%4.4 KB
9news.bbs.nz15.9 KB0.0 KB0.0 KB15.9 KB100%2.3 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: 1249.0 MB58.1 KB738.2 MB787.3 MB 6%52.8 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Feb 21 00:01:01 - 00:59:59 233 2.0% 0.07739.1 KB 1.4% 0.21
Feb 21 01:00:00 - 01:59:59 385 3.3% 0.111.7 MB 3.4% 0.48
Feb 21 02:00:00 - 02:59:59 598 5.2% 0.174.1 MB 8.2% 1.16
Feb 21 03:00:00 - 03:59:59 577 5.0% 0.161.6 MB 3.2% 0.45
Feb 21 04:00:00 - 04:59:59 656 5.7% 0.182.0 MB 4.1% 0.58
Feb 21 05:00:00 - 05:59:59 569 4.9% 0.162.1 MB 4.2% 0.60
Feb 21 06:00:00 - 06:59:59 573 5.0% 0.161.9 MB 3.8% 0.54
Feb 21 07:00:00 - 07:59:59 578 5.0% 0.162.9 MB 5.7% 0.81
Feb 21 08:00:00 - 08:59:59 574 5.0% 0.163.1 MB 6.2% 0.88
Feb 21 09:00:00 - 09:59:59 719 6.3% 0.203.2 MB 6.4% 0.90
Feb 21 10:00:00 - 10:59:59 532 4.6% 0.152.2 MB 4.5% 0.64
Feb 21 11:00:00 - 11:59:59 740 6.4% 0.212.2 MB 4.5% 0.64
Feb 21 12:00:00 - 12:59:59 598 5.2% 0.171.6 MB 3.2% 0.45
Feb 21 13:00:00 - 13:59:59 580 5.0% 0.161.6 MB 3.3% 0.47
Feb 21 14:00:00 - 14:59:59 565 4.9% 0.163.4 MB 6.8% 0.97
Feb 21 15:00:00 - 15:59:59 535 4.7% 0.152.3 MB 4.7% 0.66
Feb 21 16:00:00 - 16:59:59 440 3.8% 0.121.6 MB 3.3% 0.46
Feb 21 17:00:00 - 17:59:59 400 3.5% 0.111.8 MB 3.6% 0.52
Feb 21 18:00:00 - 18:59:59 306 2.7% 0.092.7 MB 5.5% 0.78
Feb 21 19:00:00 - 19:59:59 274 2.4% 0.081.3 MB 2.6% 0.37
Feb 21 20:00:00 - 20:59:59 241 2.1% 0.07761.5 KB 1.5% 0.21
Feb 21 21:00:00 - 21:59:59 316 2.7% 0.091.5 MB 3.0% 0.43
Feb 21 22:00:00 - 22:59:59 227 2.0% 0.061.6 MB 3.2% 0.45
Feb 21 23:00:00 - 23:59:59 277 2.4% 0.081.9 MB 3.8% 0.54
Feb 22 00:00:00 - 00:01:02 7 0.1% 0.1123.0 KB 0.0% 0.37
TOTAL: 24:00:01 11500 100.0% 0.1349.9 MB 100.0% 0.59
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.netfront.net 2144 0 0 0 0 0 0 0 2144
2usenet.blueworldhosting.com 843 16 0 0 0 0 0 0 827
3endofthelinebbs-out.news.weretis.net 706 0 0 2 0 0 0 0 704
4outgoing.news.lysator.liu.se 237 0 0 0 0 0 0 0 237
5glockenspiel.complete.org 23 0 0 1 0 0 0 0 22
6newsfeed.xs3.de 9 0 0 0 0 0 0 0 9
7news.samoylyk.net 2 0 0 2 0 0 0 0 0
8news.furie.org.uk 2 0 0 2 0 0 0 0 0
TOTAL: 8 3966 16 0 7 0 0 0 0 3943

Unwanted newsgroups [Top 20]:

NewsgroupCount
de.alt.rec.flugsimulation 5
rocksolid.feeds.news 5
mvp070808gmail.com 1
de.org.politik.misc 1
panix.chat 1
alt.entrepreneurs 1
ee.arvutid 1
ludovicm1412gmail.com 1
TOTAL: 8 16

INND Perl filter [Top 20]:

ReasonCount
EMP (phn path) 729
EMP (md5) 571
Binary: misplaced binary fx04.ams4.POSTED 488
Binary: misplaced binary fx15.ams4.POSTED 481
Binary: misplaced binary fx14.ams4.POSTED 260
Binary: misplaced binary fx01.ams4.POSTED 189
Binary: misplaced binary fx03.ams4.POSTED 156
EMP (phl) 133
Binary: misplaced binary fx05.ams4.POSTED 122
Binary: misplaced binary fx06.ams4.POSTED 113
Binary: misplaced binary fx11.ams4.POSTED 82
Binary: misplaced binary fx09.ams4.POSTED 77
Too many newsgroups 70
Binary: misplaced binary fx02.ams4.POSTED 51
Binary: misplaced binary fx08.ams4.POSTED 48
Binary: misplaced binary fx13.ams4.POSTED 42
EMP (phn nph) 42
Scoring filter 23
Binary: misplaced binary fx07.ams4.POSTED 15
Binary: misplaced binary fx12.ams4.POSTED 11
TOTAL: 25 3718

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
endofthelinebbs-out.news.weretis.net 210
usenet.blueworldhosting.com 8
newsfeed.xs3.de 6
outgoing.news.lysator.liu.se 1
TOTAL: 4 225
TOTAL: 1 225

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.netfront.net 16006 5488 5994 10 0 5 34%23:59:57
2nyheter.lysator.liu.se 11101 3710 7158 19 0 0 33%23:59:46
3news.nk.ca 15427 242 11107 111 0 222 1%23:59:57
4usenet.blueworldhosting.com 7952 22 7223 0 0 0 0%23:59:57
5news.bbs.nz 22456 16 11394 71 0 33 0%23:59:57
6news.quux.org 11939 15 11259 197 0 0 0%23:59:57
7news.furie.org.uk 9280 13 5925 4 0 0 0%23:59:57
8news.tnetconsulting.net 12045 2 11490 0 0 0 0%23:59:49
9news.samoylyk.net 15006 1 11424 3 0 12 0%23:59:54
10news.weretis.net 11545 1 11491 3 0 0 0%23:59:55
11peer.alt119.net 0 0 0 0 0 11496 0%23:57:48
12newsfeed.xs3.de 14737 0 11123 5 0 0 0%23:59:28
TOTAL: 12 147494 9510 105588 423 0 11768 6%287:56:22
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.netfront.net25.9 MB35.9 KB25.9 MB0.3 KB/s4.8 KB23:59:57
2nyheter.lysator.liu.se19.9 MB93.0 KB20.0 MB0.2 KB/s5.5 KB23:59:46
3news.nk.ca1.1 MB445.7 KB1.6 MB0.0 KB/s4.5 KB23:59:57
4news.furie.org.uk272.4 KB42.6 KB315.0 KB0.0 KB/s18.5 KB23:59:57
5news.quux.org268.0 KB790.2 KB1.0 MB0.0 KB/s5.0 KB23:59:57
6usenet.blueworldhosting.com110.9 KB0.0 KB110.9 KB0.0 KB/s5.0 KB23:59:57
7news.bbs.nz86.8 KB738.9 KB825.6 KB0.0 KB/s9.5 KB23:59:57
8news.tnetconsulting.net20.0 KB0.0 KB20.0 KB0.0 KB/s10.0 KB23:59:49
9news.samoylyk.net2.2 KB11.6 KB13.8 KB0.0 KB/s3.5 KB23:59:54
10news.weretis.net2.1 KB16.1 KB18.2 KB0.0 KB/s4.5 KB23:59:55
11peer.alt119.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:48
12newsfeed.xs3.de0.0 KB25.5 KB25.5 KB0.0 KB/s5.1 KB23:59:28
TOTAL: 1247.7 MB2.1 MB49.9 MB0.0 KB/s5.1 KB287:56:22
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1104.152.52.124 1 00.0 KB 0 0 000:00:00
2scanner-29.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
3hearty.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
4profound.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
5104.152.52.216 1 00.0 KB 0 0 000:00:10
6107.170.233.15 1 00.0 KB 0 0 000:00:00
TOTAL: 6 6 00.0 KB 0 0 000:00:14

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 3 00.0 KB 0 0 000:00:10
2*.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
3*.monitoring.internet-measurement.com 2 00.0 KB 0 0 000:00:03
TOTAL: 3 6 00.0 KB 0 0 000:00:14

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
104.152.52.216 0.080 0.049 0.00000:00:10
profound.monitoring.internet-measurement.com 0.092 0.041 0.00000:00:01
hearty.monitoring.internet-measurement.com 0.060 0.037 0.00000:00:01
107.170.233.15 0.102 0.034 0.00000:00:00
scanner-29.ch1.censys-scanner.com 0.086 0.025 0.00000:00:00
104.152.52.124 0.083 0.027 0.00000:00:00
TOTAL: 6 0.503 0.213 0.00000:00:14

NNRP unrecognized commands (by host):

SystemConn
107.170.233.15 1
scanner-29.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