Daily Usenet Report

Feb 3 00:01:01 -- Feb 4 00:01:01

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

Feb 3 00:06:34 www innd: message repeated 2 times: [ ctlinnd command s]
Feb 3 07:42:55 www nnrpd[158705]: unable to get certificates from '/news/etc/cert.pem'
Feb 3 07:42:55 www nnrpd[158705]: 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 21044 61.1%4.6 MB 72.5%
innd 10861 31.5%1.3 MB 20.7%
innfeed 2446 7.1%442.4 KB 6.7%
nnrpd 77 0.2%6.6 KB 0.1%
controlchan 2 0.0%0.1 KB 0.0%
TOTAL: 5 34430 100.0%6.4 MB100.0%

History cache:

ReasonCount%Count
Positive hits 93999 53.5%
Negative hits 61206 34.8%
Do not exist 20472 11.7%
Cache misses 44 0.0%
TOTAL: 4 175721 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.209 0.0%49 0.000 4.265 88.000
article cleanup00:00:00.520 0.0%20672 0.000 0.025 0.072
article logging00:00:00.978 0.0%20945 0.000 0.047 0.114
article parse00:00:04.736 0.0%314529 0.005 0.015 0.057
article write00:00:09.270 0.0%12176 0.327 0.761 2.898
artlog/artcncl00:00:00.000 0.0%48 0.000 0.000 0.000
data move00:00:01.788 0.0%482439 0.000 0.004 0.012
hisgrep/artcncl00:00:00.011 0.0%48 0.000 0.229 1.000
hishave/artcncl00:00:00.003 0.0%49 0.000 0.061 1.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:08.470 0.0%176612 0.004 0.048 0.118
history sync00:00:00.054 0.0%365 0.000 0.148 1.000
history write00:00:10.614 0.0%20672 0.093 0.513 1.010
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
idle23:56:53.692 99.7%452642 8.703 190.468 1013.378
nntp read00:00:46.472 0.1%455662 0.038 0.102 0.160
overview write00:00:12.927 0.0%12176 0.148 1.062 144.073
perl filter00:00:46.768 0.1%20672 1.052 2.262 4.554
python filter00:00:04.257 0.0%20674 0.074 0.206 0.704
site send00:00:04.264 0.0%24352 0.045 0.175 0.464
TOTAL: 24:00:49.95223:59:25.033 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.190 0.0%12702 0.000 0.015 0.062
article prepare00:00:00.010 0.0%35024 0.000 0.000 0.007
article read00:00:01.661 0.0%5677 0.062 0.293 2.111
backlog stats00:00:00.550 0.0%273397 0.000 0.002 0.007
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:06.346 0.0%177260 0.015 0.036 0.053
data write00:00:24.634 0.0%166711 0.103 0.148 0.249
idle23:46:02.438 99.9%273397 162.893 312.960 1334.611
status file00:00:00.228 0.0%221 0.000 1.032 5.000
TOTAL: 23:46:49.84923:46:36.057100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:03.749 80.4%7 28.500 535.571 1703.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.000 0.0%14 0.000 0.000 0.000
TOTAL: 00:00:04.66200:00:03.749 80.4%----

Control commands to INND:

CommandNumber
begin 1
drop 1
flush 4
flushlogs 2
go 2
logmode 2
lowmark 1
mode 146
name 2
pause 2
paused 2
reload 2
reserve 2
shutdown 3
TOTAL: 14 172

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1endofthelinebbs-out.news.weretis.net 6 22599 7698 14898 3 34%51:54:47
2usenet.blueworldhosting.com 42 15925 3258 8969 3698 20%24:33:55
3outgoing.news.lysator.liu.se 2 12536 884 11555 97 7%23:59:28
4newsfeed.xs3.de 2 10455 307 10148 0 2%23:59:25
5news.samoylyk.net 2 10728 120 10608 0 1%23:59:34
6glockenspiel.complete.org 2 7449 43 7405 1 0%17:56:07
7news.netfront.net 1 17495 28 12722 4745 0%24:14:05
8news.bbs.nz 3 6418 9 6409 0 0%15:21:49
9localhost 27 2 2 0 0 100%00:00:00
10news.furie.org.uk 2 5939 2 5937 0 0%23:59:25
11eotl-out.news.tnetconsulting.net 1 0 0 0 0 0%00:10:04
12news.nk.ca 1 0 0 0 0 0%00:10:02
TOTAL: 12 91 109546 12351 88651 8544 11%230:18:41
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1endofthelinebbs-out.news.weretis.net25.0 MB0.0 KB11.0 KB25.0 MB 99%3.3 KB
2usenet.blueworldhosting.com20.2 MB0.0 KB360.3 MB380.5 MB 5%56.0 KB
3outgoing.news.lysator.liu.se2.1 MB0.0 KB1.0 MB3.1 MB 67%3.3 KB
4newsfeed.xs3.de1.6 MB0.0 KB0.0 KB1.6 MB100%5.4 KB
5news.samoylyk.net1.2 MB0.0 KB0.0 KB1.2 MB100%10.0 KB
6news.netfront.net161.1 KB0.0 KB1.5 GB1.5 GB 0%329.7 KB
7glockenspiel.complete.org153.7 KB0.0 KB5.0 KB158.7 KB 96%3.6 KB
8news.bbs.nz34.6 KB0.0 KB0.0 KB34.6 KB100%3.8 KB
9news.furie.org.uk4.1 KB0.0 KB0.0 KB4.1 KB100%2.0 KB
10localhost4.0 KB0.0 KB0.0 KB4.0 KB100%2.0 KB
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: 1250.4 MB0.0 KB1.9 GB1.9 GB 2%95.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Feb 3 00:01:01 - 00:59:59 274 2.2% 0.081.2 MB 2.5% 0.35
Feb 3 01:00:00 - 01:59:59 365 3.0% 0.101.4 MB 2.7% 0.39
Feb 3 02:00:00 - 02:59:59 555 4.5% 0.152.5 MB 5.0% 0.71
Feb 3 03:00:00 - 03:59:59 544 4.4% 0.152.7 MB 5.4% 0.76
Feb 3 04:00:00 - 04:59:59 578 4.7% 0.161.6 MB 3.2% 0.45
Feb 3 05:00:00 - 05:59:59 597 4.9% 0.172.1 MB 4.4% 0.61
Feb 3 06:00:00 - 06:59:59 648 5.3% 0.182.0 MB 4.0% 0.56
Feb 3 07:00:00 - 07:59:59 694 5.7% 0.191.8 MB 3.6% 0.50
Feb 3 08:00:00 - 08:59:59 747 6.1% 0.213.8 MB 7.6% 1.07
Feb 3 09:00:00 - 09:59:59 657 5.4% 0.182.6 MB 5.3% 0.74
Feb 3 10:00:00 - 10:59:59 765 6.3% 0.212.5 MB 5.0% 0.71
Feb 3 11:00:00 - 11:59:59 795 6.5% 0.223.1 MB 6.4% 0.89
Feb 3 12:00:00 - 12:59:59 637 5.2% 0.183.6 MB 7.2% 1.01
Feb 3 13:00:00 - 13:59:59 691 5.6% 0.192.2 MB 4.4% 0.62
Feb 3 14:00:00 - 14:59:59 589 4.8% 0.162.3 MB 4.6% 0.64
Feb 3 15:00:00 - 15:59:59 575 4.7% 0.162.3 MB 4.7% 0.65
Feb 3 16:00:00 - 16:59:59 475 3.9% 0.132.0 MB 4.1% 0.57
Feb 3 17:00:00 - 17:59:59 442 3.6% 0.121.9 MB 3.8% 0.54
Feb 3 18:00:00 - 18:59:59 295 2.4% 0.081.0 MB 2.1% 0.30
Feb 3 19:00:00 - 19:59:59 264 2.2% 0.07885.8 KB 1.8% 0.25
Feb 3 20:00:00 - 20:59:59 348 2.8% 0.101.2 MB 2.5% 0.35
Feb 3 21:00:00 - 21:59:59 330 2.7% 0.093.1 MB 6.4% 0.89
Feb 3 22:00:00 - 22:59:59 171 1.4% 0.05721.0 KB 1.4% 0.20
Feb 3 23:00:00 - 23:59:59 197 1.6% 0.05957.6 KB 1.9% 0.27
Feb 4 00:00:00 - 00:01:01 5 0.0% 0.0841.4 KB 0.1% 0.68
TOTAL: 24:00:00 12238 100.0% 0.1449.3 MB 100.0% 0.58
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.netfront.net 4752 0 0 0 0 0 0 0 4752
2usenet.blueworldhosting.com 3658 16 0 0 1 0 0 0 3641
3endofthelinebbs-out.news.weretis.net 252 0 0 0 0 0 0 0 252
4outgoing.news.lysator.liu.se 82 0 0 0 0 0 0 0 82
5newsfeed.xs3.de 9 0 0 0 0 0 0 0 9
6news.samoylyk.net 4 0 0 0 0 0 0 0 4
7glockenspiel.complete.org 1 1 0 0 0 0 0 0 0
TOTAL: 7 8758 17 0 0 1 0 0 0 8740

Unwanted newsgroups [Top 20]:

NewsgroupCount
rocksolid.feeds.news 5
sympatico.highspeed 5
de.org.politik.misc 2
a.b.erotica 1
panix.test 1
zarkopinkashotmail.com 1
alt.sex.buxom 1
de.comp.sys.handhelds.palm-pilot 1
TOTAL: 8 17

Supposedly-moderated groups with unmoderated postings [Top 20]:

GroupsCount
alt.hackers 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
Binary: misplaced binary 4431
Binary: misplaced binary fx16.iad.POSTED 684
Binary: misplaced binary fx18.iad.POSTED 627
Binary: misplaced binary fx47.iad.POSTED 361
EMP (md5) 337
Binary: misplaced binary fx41.iad.POSTED 326
Binary: misplaced binary fx43.iad.POSTED 322
Binary: misplaced binary fx48.iad.POSTED 265
Binary: misplaced binary fx11.iad.POSTED 234
Binary: misplaced binary fx17.iad.POSTED 187
Binary: misplaced binary fx14.iad.POSTED 143
Binary: misplaced binary fx08.iad.POSTED 135
Binary: misplaced binary fx15.iad.POSTED 135
Binary: misplaced binary fx12.iad.POSTED 57
Too many newsgroups 53
Binary: misplaced binary fx40.iad.POSTED 34
EMP (phl) 29
Scoring filter 27
Binary: misplaced binary fx03.ams4.POSTED 22
Binary: misplaced binary fx05.ams4.POSTED 16
TOTAL: 30 8466

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
endofthelinebbs-out.news.weretis.net 249
usenet.blueworldhosting.com 11
newsfeed.xs3.de 9
news.samoylyk.net 4
outgoing.news.lysator.liu.se 1
TOTAL: 5 274
TOTAL: 1 274

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.netfront.net 17644 5335 6863 6 0 16 30%23:59:37
2nyheter.lysator.liu.se 11678 2828 8509 6 0 0 24%23:59:37
3news.furie.org.uk 9119 118 6215 18 0 0 1%23:59:37
4news.nk.ca 16345 74 12054 11 0 17 0%23:59:37
5news.quux.org 13229 48 11953 199 0 7 0%23:59:37
6usenet.blueworldhosting.com 12347 39 8823 4 0 400 0%23:59:37
7news.bbs.nz 23788 31 12105 73 0 116 0%23:59:37
8news.weretis.net 12323 6 12222 8 0 0 0%23:59:38
9news.samoylyk.net 14882 3 12109 4 0 0 0%23:59:37
10news.tnetconsulting.net 14737 3 12230 0 0 24 0%23:59:38
11newsfeed.xs3.de 14621 1 11903 18 0 0 0%23:59:37
12peer.alt119.net 0 0 0 0 0 12230 0%23:55:18
TOTAL: 12 160713 8486 114986 347 0 12810 5%287:51:07
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.netfront.net24.2 MB12.4 KB24.2 MB0.3 KB/s4.6 KB23:59:37
2nyheter.lysator.liu.se15.2 MB90.3 KB15.2 MB0.2 KB/s5.5 KB23:59:37
3news.furie.org.uk2.1 MB99.4 KB2.2 MB0.0 KB/s16.5 KB23:59:37
4news.quux.org434.4 KB922.0 KB1.3 MB0.0 KB/s5.5 KB23:59:37
5news.nk.ca394.3 KB125.7 KB519.9 KB0.0 KB/s6.1 KB23:59:37
6news.bbs.nz227.4 KB489.1 KB716.5 KB0.0 KB/s6.9 KB23:59:37
7usenet.blueworldhosting.com127.2 KB37.2 KB164.4 KB0.0 KB/s3.8 KB23:59:37
8news.weretis.net11.4 KB37.9 KB49.3 KB0.0 KB/s3.5 KB23:59:38
9news.samoylyk.net8.8 KB17.7 KB26.5 KB0.0 KB/s3.8 KB23:59:37
10news.tnetconsulting.net7.3 KB0.0 KB7.3 KB0.0 KB/s2.4 KB23:59:38
11newsfeed.xs3.de2.8 KB61.9 KB64.7 KB0.0 KB/s3.4 KB23:59:37
12peer.alt119.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:55:18
TOTAL: 1242.6 MB1.8 MB44.5 MB0.0 KB/s5.2 KB287:51:07
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
147.186.32.124 1 00.0 KB 2 0 000:00:00
TOTAL: 1 1 00.0 KB 2 0 000:00:04

NNRP readership statistics (by domain):

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

NNRP auth users [Top 20]:

UserConn
nelgin 1
TOTAL: 1 1

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
admirable.monitoring.internet-measurement.com 0.103 0.047 0.00000:00:01
calm.monitoring.internet-measurement.com 0.094 0.056 0.00000:00:01
scanner-04.ch1.censys-scanner.com 0.096 0.048 0.00000:00:00
192.241.207.96 0.077 0.031 0.00000:00:00
TOTAL: 4 0.370 0.182 0.00000:00:04

Curious NNRP server explorers [Top 20]:

SystemConn
calm.monitoring.internet-measurement.com 1
admirable.monitoring.internet-measurement.com 1
scanner-04.ch1.censys-scanner.com 1
192.241.207.96 1
TOTAL: 4 4

NNRP unrecognized commands (by host):

SystemConn
192.241.207.96 1
scanner-04.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

Newsgroup request counts (by category):

CategoryCountPct
1dfw 1 50.0%
2alt 1 50.0%
TOTAL: 2 2100.0%

Newsgroup request counts (by newsgroup) [Top 100]:

NewsgroupCount
1alt.genealogy 1
2dfw.test 1
TOTAL: 2 2