Daily Usenet Report

Mar 30 00:01:01 -- Mar 31 00:01:02

Unknown entries from news log file:

First 5 / 5 lines (100.0%)

Mar 30 00:08:07 www innd: message repeated 2 times: [ ctlinnd command s]
Mar 30 15:36:17 www nnrpd[1999630]: unable to get certificates from '/news/etc/cert.pem'
Mar 30 15:36:17 www nnrpd[1999630]: error initializing TLS: [CA_file: ] [CA_path: /news/etc] [cert_file: /news/etc/cert.pem] [key_file: /news/etc/key.pem]
Mar 30 20:31:27 www nnrpd[2010102]: unable to get certificates from '/news/etc/cert.pem'
Mar 30 20:31:27 www nnrpd[2010102]: 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 20404 67.5%5.4 MB 78.9%
innd 7004 23.2%969.7 KB 13.8%
innfeed 2647 8.8%495.5 KB 7.1%
nnrpd 151 0.5%12.8 KB 0.2%
controlchan 1 0.0%0.2 KB 0.0%
TOTAL: 5 30207 100.0%6.9 MB100.0%

History cache:

ReasonCount%Count
Positive hits 118113 54.3%
Negative hits 79460 36.5%
Do not exist 20016 9.2%
Cache misses 21 0.0%
TOTAL: 4 217610 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.095 0.0%113 0.000 0.841 4.000
article cleanup00:00:00.330 0.0%20139 0.000 0.016 0.084
article logging00:00:00.994 0.0%20395 0.008 0.049 0.194
article parse00:00:01.130 0.0%59447 0.000 0.019 0.048
article write00:00:10.984 0.0%11635 0.340 0.944 4.552
artlog/artcncl00:00:00.000 0.0%17 0.000 0.000 0.000
artlog/artparse00:00:00.000 0.0%2 0.000 0.000 0.000
data move00:00:00.452 0.0%242584 0.000 0.002 0.007
hisgrep/artcncl00:00:00.038 0.0%130 0.000 0.292 1.000
hishave/artcncl00:00:00.000 0.0%17 0.000 0.000 0.000
hishave/artparse00:00:00.000 0.0%1 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:11.342 0.0%218607 0.004 0.052 0.186
history sync00:00:00.065 0.0%356 0.000 0.183 5.000
history write00:00:12.174 0.0%20139 0.093 0.604 1.029
hiswrite/artparse00:00:00.001 0.0%1 1.000 1.000 1.000
idle23:57:10.312 99.7%241701 150.637 356.764 1108.590
nntp read00:00:12.300 0.0%243485 0.023 0.051 0.133
overview write00:00:08.994 0.0%11635 0.212 0.773 4.862
perl filter00:00:54.275 0.1%20138 2.077 2.695 4.457
python filter00:00:03.034 0.0%20138 0.079 0.151 0.390
site send00:00:04.437 0.0%23270 0.041 0.191 0.484
TOTAL: 24:00:47.03823:59:10.957 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.115 0.0%11633 0.000 0.010 0.066
article prepare00:00:00.006 0.0%35340 0.000 0.000 0.005
article read00:00:01.445 0.0%5301 0.064 0.273 2.032
backlog stats00:00:00.681 0.0%281683 0.000 0.002 0.007
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:06.187 0.0%191413 0.015 0.032 0.055
data write00:00:28.470 0.0%180522 0.116 0.158 0.234
idle23:55:03.423 99.9%281683 152.688 305.675 860.910
status file00:00:00.218 0.0%200 0.000 1.090 4.000
TOTAL: 23:55:53.65123:55:40.545100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle166:41:39.654100.0%10358 20.667 57935.862 58019.587
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:04.215 0.0%20838 0.000 0.202 0.250
readart00:00:00.117 0.0%489 0.239 0.239 0.239
TOTAL: 166:41:49.299166:41:43.986100.0%----

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 19793 6562 12758 473 33%43:47:31
2usenet.blueworldhosting.com 288 13417 2452 10345 620 18%23:45:01
3newsfeed.xs3.de 2 10107 746 9341 20 7%23:59:47
4outgoing.news.lysator.liu.se 2 12704 704 11294 706 5%23:59:51
5usenet.network 1 11906 691 11152 63 5%23:59:57
6endofthelinebbs.peers.news.panix.com 122 17309 123 11319 5867 0%41:02:42
7glockenspiel.complete.org 2 10630 118 10375 137 1%24:01:44
8news.samoylyk.net 2 10334 99 10231 4 0%23:59:50
9news.netfront.net 1 13060 6 12480 574 0%22:16:35
10news.bbs.nz 2 10565 3 10562 0 0%25:41:56
11news.furie.org.uk 2 5593 1 5591 1 0%23:59:14
12news.nk.ca 2 0 0 0 0 0%00:20:00
13localhost 25 0 0 0 0 0%00:00:00
14eotl-out.news.tnetconsulting.net 1 0 0 0 0 0%00:10:16
TOTAL: 14 456 135418 11505 115448 8465 8%301:04:24
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1endofthelinebbs-out.news.weretis.net25.5 MB0.0 KB1.1 MB26.6 MB 95%3.9 KB
2usenet.blueworldhosting.com17.9 MB0.0 KB2.5 MB20.4 MB 87%6.8 KB
3usenet.network8.7 MB0.0 KB1.2 MB9.9 MB 88%13.4 KB
4newsfeed.xs3.de2.2 MB0.0 KB55.3 KB2.3 MB 97%3.0 KB
5outgoing.news.lysator.liu.se1.4 MB0.0 KB2.5 MB3.9 MB 35%2.8 KB
6news.samoylyk.net818.8 KB0.0 KB5.9 KB824.7 KB 99%8.0 KB
7glockenspiel.complete.org771.2 KB0.0 KB405.7 KB1.1 MB 65%4.6 KB
8endofthelinebbs.peers.news.panix.com523.9 KB0.0 KB37.5 MB38.0 MB 1%6.5 KB
9news.bbs.nz15.4 KB0.0 KB0.0 KB15.4 KB100%5.1 KB
10news.netfront.net15.1 KB0.0 KB183.7 MB183.8 MB 0%324.4 KB
11news.furie.org.uk3.0 KB0.0 KB11.8 KB14.8 KB 20%7.4 KB
12news.nk.ca0.0 KB0.0 KB0.0 KB0.0 KB 0%0
13localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
14eotl-out.news.tnetconsulting.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1457.8 MB0.0 KB229.0 MB286.8 MB 20%14.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Mar 30 00:01:01 - 00:59:59 338 2.9% 0.101.6 MB 2.7% 0.45
Mar 30 01:00:00 - 01:59:59 398 3.4% 0.111.8 MB 3.1% 0.51
Mar 30 02:00:00 - 02:59:59 549 4.7% 0.151.9 MB 3.2% 0.53
Mar 30 03:00:00 - 03:59:59 565 4.9% 0.162.3 MB 3.9% 0.65
Mar 30 04:00:00 - 04:59:59 656 5.6% 0.183.3 MB 5.7% 0.94
Mar 30 05:00:00 - 05:59:59 550 4.7% 0.151.6 MB 2.8% 0.47
Mar 30 06:00:00 - 06:59:59 515 4.4% 0.142.2 MB 3.7% 0.61
Mar 30 07:00:00 - 07:59:59 552 4.7% 0.152.3 MB 3.9% 0.64
Mar 30 08:00:00 - 08:59:59 501 4.3% 0.143.7 MB 6.3% 1.05
Mar 30 09:00:00 - 09:59:59 642 5.5% 0.182.4 MB 4.1% 0.68
Mar 30 10:00:00 - 10:59:59 789 6.8% 0.223.7 MB 6.4% 1.06
Mar 30 11:00:00 - 11:59:59 602 5.2% 0.172.5 MB 4.2% 0.70
Mar 30 12:00:00 - 12:59:59 657 5.7% 0.182.9 MB 4.9% 0.82
Mar 30 13:00:00 - 13:59:59 606 5.2% 0.174.2 MB 7.1% 1.19
Mar 30 14:00:00 - 14:59:59 581 5.0% 0.164.0 MB 6.8% 1.12
Mar 30 15:00:00 - 15:59:59 495 4.3% 0.142.8 MB 4.9% 0.81
Mar 30 16:00:00 - 16:59:59 494 4.2% 0.142.1 MB 3.6% 0.60
Mar 30 17:00:00 - 17:59:59 320 2.8% 0.091.7 MB 2.8% 0.47
Mar 30 18:00:00 - 18:59:59 351 3.0% 0.102.5 MB 4.3% 0.71
Mar 30 19:00:00 - 19:59:59 451 3.9% 0.133.2 MB 5.5% 0.91
Mar 30 20:00:00 - 20:59:59 259 2.2% 0.07918.9 KB 1.5% 0.26
Mar 30 21:00:00 - 21:59:59 203 1.7% 0.06689.3 KB 1.1% 0.19
Mar 30 22:00:00 - 22:59:59 240 2.1% 0.071.3 MB 2.2% 0.36
Mar 30 23:00:00 - 23:59:59 302 2.6% 0.083.2 MB 5.4% 0.91
Mar 31 00:00:00 - 00:01:02 9 0.1% 0.1534.5 KB 0.1% 0.56
TOTAL: 24:00:01 11625 100.0% 0.1358.6 MB 100.0% 0.69
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1endofthelinebbs.peers.news.panix.com 5850 5849 0 0 0 0 0 0 1
2endofthelinebbs-out.news.weretis.net 700 0 0 0 0 0 0 0 700
3outgoing.news.lysator.liu.se 693 0 0 0 0 0 0 0 693
4news.netfront.net 632 0 0 0 0 0 0 0 632
5usenet.blueworldhosting.com 620 7 0 0 1 0 0 0 612
6glockenspiel.complete.org 138 0 0 1 0 0 0 0 137
7usenet.network 68 0 0 0 0 0 0 0 68
8newsfeed.xs3.de 40 0 0 0 0 0 0 0 40
9news.samoylyk.net 20 0 0 0 0 0 0 0 20
10news.furie.org.uk 1 0 0 0 0 0 0 0 1
TOTAL: 10 8762 5856 0 1 1 0 0 0 2904

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.binaries.backup 5240
alt.binaries.ftd 414
finet.binaries.keskustelu 43
alt.binaries.bloaf 40
alt.binaries.pictures.nude.celebrities.fake 15
alt.binaries.pictures.scenic 14
alt.binaries.nospam.female.bodyhair.pubes 11
alt.binaries.test.yenc 9
alt.binaries.ect 6
alt.binaries.sounds.lossless 5
rocksolid.feeds.news 5
alt.binaries.nospam.female.bodyhair 5
alt.binaries.erotica.collections.rars 4
afj.test 4
alt.binaries.e-book.flood 3
alt.binaries.pictures.young.celebrities 3
alt.binaries.adan 2
alt.binaries.pictures.purebeauty 2
alt.binaries.sounds.lossless.classical 2
alt.binaries.sounds.holland 2
TOTAL: 41 5856

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

GroupsCount
rec.guns 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 893
EMP (phn path) 745
Too many newsgroups 189
EMP (phn nph) 122
Binary: misplaced binary fx07.ams4.POSTED 100
Binary: misplaced binary fx12.ams4.POSTED 93
EMP (phl) 80
Binary: misplaced binary fx01.ams4.POSTED 53
Binary: misplaced binary fx15.ams4.POSTED 50
Binary: misplaced binary fx13.ams4.POSTED 37
Too many newsgroups (low_xpost) 35
Binary: misplaced binary fx05.ams4.POSTED 33
Binary: misplaced binary fx06.ams4.POSTED 32
Binary: misplaced binary fx11.ams4.POSTED 31
Binary: misplaced binary fx02.ams4.POSTED 30
Binary: misplaced binary fx09.iad.POSTED 28
Binary: misplaced binary fx08.ams4.POSTED 25
Binary: misplaced binary fx03.ams4.POSTED 22
Scoring filter 13
Binary: misplaced binary fx04.ams4.POSTED 12
TOTAL: 25 2646

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad command received
usenet.blueworldhosting.com 6
TOTAL: 1 6
Huge articles
usenet.network 1
TOTAL: 1 1
Including strange strings
endofthelinebbs-out.news.weretis.net 220
newsfeed.xs3.de 19
news.samoylyk.net 16
glockenspiel.complete.org 1
TOTAL: 4 256
No colon-space in header field
usenet.blueworldhosting.com 1
TOTAL: 1 1
TOTAL: 4 264

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.netfront.net 15983 4377 7230 12 0 0 27%23:59:55
2nyheter.lysator.liu.se 11160 2233 8221 478 0 0 20%23:59:55
3endofthelinebbs.peers.news.panix.com 11961 404 11205 5 0 0 3%23:59:55
4news.nk.ca 14493 101 11401 101 0 5 0%23:59:55
5news.furie.org.uk 7644 53 5925 206 0 0 0%23:59:48
6news.bbs.nz 22487 31 11424 159 0 13 0%23:59:52
7news.quux.org 12007 16 11342 171 0 0 0%23:59:55
8news.tnetconsulting.net 12673 16 11511 83 0 0 0%23:59:49
9usenet.network 12939 12 10438 9 0 10 0%23:59:50
10news.weretis.net 11811 8 11487 126 0 0 0%23:59:49
11news.samoylyk.net 13619 3 11516 4 0 0 0%23:59:55
12peer.alt119.net 0 0 0 0 0 11617 0%23:57:47
13newsfeed.xs3.de 13140 0 10630 245 0 0 0%23:59:55
14usenet.blueworldhosting.com 12232 0 8741 0 0 0 0%23:59:30
TOTAL: 14 172149 7254 131071 1599 0 11645 4%335:55:50
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.netfront.net22.6 MB156.2 KB22.7 MB0.3 KB/s5.3 KB23:59:55
2nyheter.lysator.liu.se11.4 MB4.6 MB16.0 MB0.2 KB/s6.0 KB23:59:55
3news.furie.org.uk1.7 MB2.3 MB4.0 MB0.0 KB/s15.9 KB23:59:48
4endofthelinebbs.peers.news.panix.com1.5 MB6.2 KB1.6 MB0.0 KB/s3.9 KB23:59:55
5news.quux.org704.3 KB1.5 MB2.2 MB0.0 KB/s12.2 KB23:59:55
6news.samoylyk.net650.1 KB5.1 KB655.2 KB0.0 KB/s93.6 KB23:59:55
7news.nk.ca627.5 KB3.1 MB3.7 MB0.0 KB/s18.8 KB23:59:55
8news.bbs.nz151.4 KB4.2 MB4.3 MB0.1 KB/s23.2 KB23:59:52
9news.tnetconsulting.net129.0 KB758.8 KB887.8 KB0.0 KB/s9.0 KB23:59:49
10usenet.network38.1 KB29.5 KB67.6 KB0.0 KB/s3.2 KB23:59:50
11news.weretis.net28.9 KB4.2 MB4.2 MB0.1 KB/s32.4 KB23:59:49
12peer.alt119.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:47
13newsfeed.xs3.de0.0 KB2.9 MB2.9 MB0.0 KB/s11.9 KB23:59:55
14usenet.blueworldhosting.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:30
TOTAL: 1439.5 MB23.7 MB63.2 MB0.1 KB/s7.3 KB335:55:50
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
147.189.156.66 1 996.7 KB 1 0 0166:41:43
TOTAL: 1 1 996.7 KB 1 0 0166:41:49

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 2 996.7 KB 1 0 0166:41:44
2*.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
3*.ip-145-239-154.eu 4 00.0 KB 0 0 000:00:02
4*.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
TOTAL: 4 8 996.7 KB 1 0 0166:41:49

NNRP auth users [Top 20]:

UserConn
nelgin 1
TOTAL: 1 1

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
47.189.156.66 3.310 6.002 0.005166:41:43
ns31410049.ip-145-239-154.eu 0.398 0.107 0.00000:00:02
celebrated.monitoring.internet-measurement.com 0.085 0.069 0.00000:00:01
198.199.106.243 0.077 0.030 0.00000:00:00
scanner-08.ch1.censys-scanner.com 0.067 0.025 0.00000:00:00
TOTAL: 5 3.937 6.233 0.005166:41:49

Curious NNRP server explorers [Top 20]:

SystemConn
ns31410049.ip-145-239-154.eu 4
celebrated.monitoring.internet-measurement.com 1
scanner-08.ch1.censys-scanner.com 1
198.199.106.243 1
TOTAL: 4 7

NNRP unrecognized commands (by host) [Top 20]:

SystemConn
ns31410049.ip-145-239-154.eu 4
scanner-08.ch1.censys-scanner.com 1
198.199.106.243 1
TOTAL: 3 6

NNRP unrecognized commands (by command) [Top 20]:

CommandCount
EHLO www.censys.io 1
#026#003#001 1
À#024 1
#026#003#001#002 1
#026#003 1
MGLNDD_192.138.210.162_119 1
TOTAL: 6 6

NNRP client timeouts [Top 20]:

SystemConnPeer
47.189.156.66 1 0
ns31410049.ip-145-239-154.eu 1 1
TOTAL: 2 2 1

Newsgroup request counts (by hierarchy):

HierarchyCountPct
1news 2100.0%
TOTAL: 1 2100.0%

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

NewsgroupCount
1news.software.nntp 2
TOTAL: 1 2