Daily Usenet Report

Mar 28 00:01:01 -- Mar 29 00:01:01

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

Mar 28 00:08:16 www innd: message repeated 2 times: [ ctlinnd command s]
Mar 28 19:38:01 www nnrpd[1644311]: unable to get certificates from '/news/etc/cert.pem'
Mar 28 19:38:01 www nnrpd[1644311]: 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 71876 53.9%10.1 MB 63.1%
innd 58837 44.1%5.4 MB 33.9%
innfeed 2649 2.0%495.6 KB 3.0%
nnrpd 67 0.1%5.3 KB 0.0%
controlchan 1 0.0%0.2 KB 0.0%
TOTAL: 5 133430 100.0%16.0 MB100.0%

History cache:

ReasonCount%Count
Positive hits 217966 46.0%
Negative hits 183389 38.7%
Do not exist 71631 15.1%
Cache misses 1255 0.3%
TOTAL: 4 474241 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.059 0.0%172 0.000 0.343 3.000
article cleanup00:00:00.654 0.0%71602 0.000 0.009 0.120
article logging00:00:02.531 0.0%71873 0.007 0.035 0.103
article parse00:00:02.492 0.0%179894 0.000 0.014 0.045
article write00:00:14.123 0.0%11802 0.354 1.197 2.903
artlog/artcncl00:00:00.000 0.0%17 0.000 0.000 0.000
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.614 0.0%376843 0.000 0.002 0.009
hisgrep/artcncl00:00:00.024 0.0%189 0.000 0.127 1.000
hishave/artcncl00:00:00.000 0.0%17 0.000 0.000 0.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:11.275 0.0%474696 0.005 0.024 0.078
history sync00:00:00.043 0.0%361 0.000 0.119 1.000
history write00:00:28.290 0.0%71602 0.093 0.395 0.975
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:55:48.585 99.6%375922 45.443 229.166 1780.718
nntp read00:00:27.322 0.0%377978 0.035 0.072 0.154
overview write00:00:08.146 0.0%11802 0.161 0.690 7.250
perl filter00:01:20.768 0.1%71602 0.537 1.128 3.617
python filter00:00:04.910 0.0%71602 0.035 0.069 0.348
site send00:00:04.332 0.0%23604 0.049 0.184 0.683
TOTAL: 24:00:52.73623:58:54.168 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.112 0.0%11861 0.000 0.009 0.109
article prepare00:00:00.005 0.0%38572 0.000 0.000 0.004
article read00:00:01.522 0.0%5826 0.113 0.261 3.941
backlog stats00:00:00.758 0.0%285664 0.000 0.003 0.007
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:08.015 0.0%193872 0.020 0.041 0.076
data write00:00:26.078 0.0%183024 0.105 0.142 0.260
idle23:56:19.522 99.9%285664 167.008 301.681 1253.262
status file00:00:00.196 0.0%199 0.000 0.985 4.000
TOTAL: 23:57:08.15623:56:56.208100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:00.195 31.8%5 25.500 39.000 48.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.000 0.0%10 0.000 0.000 0.000
TOTAL: 00:00:00.61400:00:00.195 31.8%----

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 4 22432 6592 15466 374 29%51:43:54
2usenet.blueworldhosting.com 289 13211 3191 9215 805 24%23:46:56
3usenet.network 2 62162 661 48979 12522 1%23:59:55
4outgoing.news.lysator.liu.se 3 62991 601 26595 35795 0%24:19:39
5newsfeed.xs3.de 2 10255 396 9854 5 3%23:59:01
6endofthelinebbs.peers.news.panix.com 124 17531 222 11697 5612 1%41:40:49
7news.samoylyk.net 2 10494 122 10369 3 1%23:59:26
8news.bbs.nz 1 10603 16 10587 0 0%23:59:42
9glockenspiel.complete.org 2 3738 9 3679 50 0%08:49:21
10news.furie.org.uk 1 5515 2 5513 0 0%23:59:53
11news.netfront.net 2 65800 2 61271 4527 0%26:01:58
12eotl-out.news.tnetconsulting.net 1 0 0 0 0 0%00:10:31
13localhost 25 0 0 0 0 0%00:00:00
14news.nk.ca 2 0 0 0 0 0%00:20:02
TOTAL: 14 460 284732 11814 213225 59693 4%296:51:07
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1usenet.blueworldhosting.com22.2 MB0.0 KB4.9 MB27.1 MB 81%6.9 KB
2endofthelinebbs-out.news.weretis.net20.4 MB0.0 KB777.3 KB21.1 MB 96%3.1 KB
3usenet.network9.7 MB0.0 KB7.1 MB16.8 MB 57%1.3 KB
4newsfeed.xs3.de1.2 MB0.0 KB7.9 KB1.2 MB 99%3.2 KB
5outgoing.news.lysator.liu.se1.1 MB0.0 KB21.8 MB23.0 MB 4%0.6 KB
6endofthelinebbs.peers.news.panix.com886.6 KB0.0 KB33.7 MB34.5 MB 2%6.1 KB
7news.samoylyk.net530.8 KB0.0 KB3.6 KB534.3 KB 99%4.3 KB
8glockenspiel.complete.org36.2 KB0.0 KB93.6 KB129.8 KB 27%2.2 KB
9news.bbs.nz31.0 KB0.0 KB0.0 KB31.0 KB100%1.9 KB
10news.netfront.net10.3 KB0.0 KB701.5 MB701.5 MB 0%158.6 KB
11news.furie.org.uk3.9 KB0.0 KB0.0 KB3.9 KB100%1.9 KB
12eotl-out.news.tnetconsulting.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
13localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
14news.nk.ca0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1456.1 MB0.0 KB769.8 MB825.9 MB 6%11.8 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Mar 28 00:01:01 - 00:59:59 257 2.2% 0.071.0 MB 1.8% 0.29
Mar 28 01:00:00 - 01:59:59 365 3.1% 0.101.5 MB 2.7% 0.43
Mar 28 02:00:00 - 02:59:59 531 4.5% 0.151.6 MB 2.9% 0.46
Mar 28 03:00:00 - 03:59:59 496 4.2% 0.141.3 MB 2.3% 0.37
Mar 28 04:00:00 - 04:59:59 612 5.2% 0.172.2 MB 4.0% 0.63
Mar 28 05:00:00 - 05:59:59 631 5.3% 0.182.1 MB 3.7% 0.60
Mar 28 06:00:00 - 06:59:59 609 5.2% 0.172.3 MB 4.1% 0.65
Mar 28 07:00:00 - 07:59:59 558 4.7% 0.151.9 MB 3.5% 0.55
Mar 28 08:00:00 - 08:59:59 660 5.6% 0.183.5 MB 6.2% 0.98
Mar 28 09:00:00 - 09:59:59 677 5.7% 0.193.1 MB 5.5% 0.89
Mar 28 10:00:00 - 10:59:59 778 6.6% 0.223.1 MB 5.5% 0.88
Mar 28 11:00:00 - 11:59:59 660 5.6% 0.184.9 MB 8.7% 1.39
Mar 28 12:00:00 - 12:59:59 659 5.6% 0.183.9 MB 7.0% 1.11
Mar 28 13:00:00 - 13:59:59 643 5.4% 0.184.2 MB 7.4% 1.19
Mar 28 14:00:00 - 14:59:59 612 5.2% 0.172.7 MB 4.9% 0.78
Mar 28 15:00:00 - 15:59:59 582 4.9% 0.162.5 MB 4.5% 0.72
Mar 28 16:00:00 - 16:59:59 464 3.9% 0.132.4 MB 4.3% 0.69
Mar 28 17:00:00 - 17:59:59 428 3.6% 0.122.2 MB 3.8% 0.62
Mar 28 18:00:00 - 18:59:59 315 2.7% 0.092.3 MB 4.1% 0.66
Mar 28 19:00:00 - 19:59:59 285 2.4% 0.082.1 MB 3.7% 0.59
Mar 28 20:00:00 - 20:59:59 314 2.7% 0.091.4 MB 2.4% 0.39
Mar 28 21:00:00 - 21:59:59 168 1.4% 0.05584.0 KB 1.0% 0.16
Mar 28 22:00:00 - 22:59:59 221 1.9% 0.061.2 MB 2.2% 0.35
Mar 28 23:00:00 - 23:59:59 267 2.3% 0.072.1 MB 3.8% 0.60
Mar 29 00:00:00 - 00:01:01 9 0.1% 0.1517.0 KB 0.0% 0.28
TOTAL: 24:00:00 11801 100.0% 0.1456.2 MB 100.0% 0.67
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1outgoing.news.lysator.liu.se 35815 0 0 0 0 0 0 035815
2usenet.network 12518 0 0 0 0 0 0 012518
3endofthelinebbs.peers.news.panix.com 5563 5559 0 0 0 0 0 0 4
4news.netfront.net 4566 0 0 0 0 0 0 0 4566
5usenet.blueworldhosting.com 805 20 0 0 0 0 0 0 785
6endofthelinebbs-out.news.weretis.net 622 0 0 0 0 0 0 0 622
7glockenspiel.complete.org 141 0 0 0 0 0 0 0 141
8newsfeed.xs3.de 15 0 0 0 0 0 0 0 15
9news.samoylyk.net 13 0 0 0 0 0 0 0 13
TOTAL: 9 60058 5579 0 0 0 0 0 054479

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.binaries.backup 5224
alt.binaries.ftd 215
finet.binaries.keskustelu 29
alt.binaries.sounds.lossless 15
alt.culture.underwear 13
alt.binaries.e-book.magazines 10
alt.binaries.nospam.female.bodyhair 8
alt.binaries.test.yenc 8
alt.binaries.pictures.scenic 6
alt.binaries.pictures.earlmiller 6
rocksolid.feeds.news 5
alt.binaries.pictures.nude.celebrities.fake 5
alt.binaries.sounds.karaoke 3
alt.binaries.adan 3
alt.binaries.alt5 3
alt.binaries.nospam.female.bodyhair.pubes 2
alt.uhaqceby.ok.us 2
sympatico.support 2
alt.binaries.pictures.purebeauty 2
alt.binaries.sounds.mp3.new-age 2
TOTAL: 33 5579

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 51132
Too many newsgroups (low_xpost) 748
EMP (phn path) 584
Binary: misplaced binary fx05.ams4.POSTED 195
Binary: misplaced binary fx11.ams4.POSTED 178
Too many newsgroups 174
Binary: misplaced binary fx15.ams4.POSTED 170
EMP (phn nph) 134
Binary: misplaced binary fx01.ams4.POSTED 131
Binary: misplaced binary fx14.ams4.POSTED 127
Binary: misplaced binary fx02.ams4.POSTED 106
EMP (phl) 103
Binary: misplaced binary fx06.ams4.POSTED 78
Binary: misplaced binary fx03.ams4.POSTED 65
Binary: misplaced binary fx04.ams4.POSTED 63
Poison newsgroup 43
Binary: misplaced binary fx06.iad.POSTED 41
Scoring filter 38
Binary: misplaced binary fx12.ams4.POSTED 33
Binary: misplaced binary fx09.ams4.POSTED 32
TOTAL: 25 54208

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad command received
usenet.blueworldhosting.com 2
TOTAL: 1 2
Including strange strings
endofthelinebbs-out.news.weretis.net 247
newsfeed.xs3.de 10
news.samoylyk.net 9
outgoing.news.lysator.liu.se 4
endofthelinebbs.peers.news.panix.com 1
TOTAL: 5 271
TOTAL: 2 273

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.netfront.net 16141 4942 6846 9 0 4 30%23:59:38
2nyheter.lysator.liu.se 11400 2775 7819 606 0 0 24%23:59:56
3endofthelinebbs.peers.news.panix.com 11970 224 11565 1 0 0 1%23:59:56
4news.nk.ca 15345 128 11534 126 0 11 0%23:59:56
5news.furie.org.uk 7391 56 5887 83 0 0 0%23:59:56
6news.bbs.nz 22698 42 11605 144 0 30 0%23:59:55
7news.tnetconsulting.net 12842 35 11697 52 0 0 0%23:59:56
8news.quux.org 12197 21 11556 169 0 0 0%23:59:56
9usenet.network 13741 16 10631 5 0 0 0%23:58:48
10news.weretis.net 11931 12 11706 74 0 0 0%23:59:46
11news.samoylyk.net 14520 6 11663 3 0 0 0%23:59:56
12newsfeed.xs3.de 14515 1 11264 122 0 0 0%23:59:56
13usenet.blueworldhosting.com 9100 0 8215 0 0 30 0%23:59:56
14peer.alt119.net 0 0 0 0 0 11793 0%23:57:46
TOTAL: 14 173791 8258 131988 1394 0 11868 4%335:55:17
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.netfront.net25.9 MB145.8 KB26.0 MB0.3 KB/s5.4 KB23:59:38
2nyheter.lysator.liu.se16.8 MB5.9 MB22.7 MB0.3 KB/s6.9 KB23:59:56
3news.quux.org1.8 MB2.3 MB4.0 MB0.0 KB/s21.8 KB23:59:56
4news.samoylyk.net1.7 MB624.5 KB2.3 MB0.0 KB/s264.3 KB23:59:56
5endofthelinebbs.peers.news.panix.com1.1 MB0.6 KB1.1 MB0.0 KB/s4.9 KB23:59:56
6news.nk.ca643.1 KB5.7 MB6.4 MB0.1 KB/s25.6 KB23:59:56
7news.furie.org.uk635.7 KB1.5 MB2.1 MB0.0 KB/s15.6 KB23:59:56
8news.bbs.nz152.4 KB6.1 MB6.2 MB0.1 KB/s34.2 KB23:59:55
9news.tnetconsulting.net125.7 KB555.2 KB680.9 KB0.0 KB/s7.8 KB23:59:56
10usenet.network71.7 KB21.7 KB93.3 KB0.0 KB/s4.4 KB23:58:48
11news.weretis.net44.9 KB5.4 MB5.5 MB0.1 KB/s65.0 KB23:59:46
12newsfeed.xs3.de1.2 KB2.3 MB2.3 MB0.0 KB/s19.5 KB23:59:56
13usenet.blueworldhosting.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:56
14peer.alt119.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:46
TOTAL: 1448.9 MB30.5 MB79.4 MB0.1 KB/s8.4 KB335:55:17
Outgoing feeds (innfeed) by Volume

NNRP readership statistics (by domain):

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

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
scanner-04.ch1.censys-scanner.com 0.149 0.089 0.00000:00:00
192.241.219.17 0.111 0.049 0.00000:00:00
TOTAL: 2 0.260 0.138 0.00000:00:00

Curious NNRP server explorers [Top 20]:

SystemConn
192.241.219.17 1
scanner-04.ch1.censys-scanner.com 1
TOTAL: 2 2

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

SystemConn
192.241.219.17 1
scanner-04.ch1.censys-scanner.com 1
TOTAL: 2 2

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

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

Newsgroup request counts (by hierarchy):

HierarchyCountPct
1alt 2100.0%
TOTAL: 1 2100.0%

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

NewsgroupCount
1alt.music.lyrics 2
TOTAL: 1 2