Daily Usenet Report

Sep 25 00:01:01 -- Sep 26 00:01:02

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Sep 25 08:11:45 newsfeed innd: message repeated 2 times: [ ctlinnd command s]
Sep 26 00:00:02 newsfeed nnrpd[2017884]: localhost auth: program exited with status 8

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 13010 37.6%1.5 MB 20.7%
inn 8893 25.7%3.7 MB 51.7%
innd 7950 23.0%1.1 MB 15.9%
innfeed 4234 12.2%786.8 KB 10.8%
cnfsstat 432 1.2%67.7 KB 0.9%
nocem 46 0.1%5.2 KB 0.1%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 7 34566 100.0%7.1 MB100.0%

History cache:

ReasonCount%Count
Positive hits 126453 58.5%
Negative hits 81116 37.5%
Do not exist 8732 4.0%
Cache misses 32 0.0%
TOTAL: 4 216333 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.169 0.0%48 0.000 3.521 10.000
article cleanup00:00:00.163 0.0%8863 0.000 0.018 0.495
article logging00:00:00.445 0.0%8893 0.000 0.050 0.632
article parse00:00:00.204 0.0%12204 0.000 0.017 0.105
article write00:00:02.351 0.0%7678 0.000 0.306 5.920
artlog/artcncl00:00:00.000 0.0%5 0.000 0.000 0.000
artlog/artparse00:00:00.000 0.0%1 0.000 0.000 0.000
data move00:00:00.992 0.0%219341 0.000 0.005 0.153
hisgrep/artcncl00:00:00.134 0.0%53 0.000 2.528 7.000
hishave/artcncl00:00:00.000 0.0%5 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:02:33.051 0.2%218436 0.088 0.701 4.743
history sync00:00:00.059 0.0%395 0.000 0.149 0.667
history write00:02:11.539 0.2%8818 3.167 14.917 136.961
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:48:06.507 99.1%220340 81.825 388.883 1612.439
nntp read00:00:03.991 0.0%220218 0.001 0.018 0.944
overview write00:06:33.727 0.5%7678 0.562 51.280 6312.795
perl filter00:00:27.984 0.0%8816 1.646 3.174 17.855
python filter00:00:01.263 0.0%8816 0.000 0.143 3.654
site send00:00:01.359 0.0%15401 0.000 0.088 0.265
TOTAL: 24:01:03.81724:00:03.938 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.021 0.0%10675 0.000 0.002 0.125
article prepare00:00:00.007 0.0%40850 0.000 0.000 0.006
article read00:00:00.522 0.0%3663 0.000 0.143 0.933
backlog stats00:00:00.380 0.0%260372 0.000 0.001 0.008
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.334 0.0%183643 0.001 0.013 0.094
data write00:00:03.294 0.0%178456 0.008 0.018 0.089
idle23:49:49.326100.0%260372 144.855 329.488 1279.876
status file00:00:00.377 0.0%319 0.500 1.182 3.000
TOTAL: 23:50:05.96323:49:56.261100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle155:07:10.014 99.8%20934 0.250 26675.743 56544.774
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:04.330 0.0%120745 0.000 0.036 0.333
readart00:00:00.157 0.0%114 1.377 1.377 1.377
TOTAL: 155:26:06.739155:07:14.501 99.8%----

Control commands to INND:

CommandNumber
flush 5
flushlogs 2
go 2
logmode 2
lowmark 1
mode 98
name 2
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 120

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1endofthelinebbs-out.news.weretis.net 3 12873 1814 10756 303 14%44:06:08
2outgoing.news.lysator.liu.se 2 6584 1730 4841 13 26%23:58:50
3usenet.blueworldhosting.com 721 8630 736 7483 411 8%23:46:58
4nntp.comgw.net 2 8129 619 7346 164 7%23:59:56
5news.hispagatos.org 6 8063 512 7537 14 6%24:26:09
6usenet.goja.nl.eu.org 10 7674 466 7152 56 6%22:14:40
7i2pn.org 11 7892 407 7425 60 5%23:58:42
8usenet.network 2 6139 287 5833 19 4%23:59:37
9news.corradoroberto.it 6 1377 280 1097 0 20%23:24:56
10endoftheline-out.news.chmurka.net 1 3918 240 3677 1 6%23:59:56
11endofthelinebbs.peers.news.panix.com 27 8109 147 7946 16 1%24:10:33
12newsfeed.bofh.team 1 8594 120 8465 9 1%23:59:55
13news.netfront.net 1 6524 89 6341 94 1%24:58:30
14news.samoylyk.net 2 6991 78 6910 3 1%23:59:34
15news.furie.org.uk 2 7400 33 7363 4 0%47:59:48
16news.nntp4.net 2 6717 22 6692 3 0%23:59:51
17news.bbs.nz 2 6799 17 6779 3 0%23:59:28
18glockenspiel.complete.org 2 5944 8 5932 4 0%24:00:31
19newsfeed.xs3.de 2 6362 6 6353 3 0%23:59:52
20eotl-out.news.tnetconsulting.net 1 0 0 0 0 0%00:10:05
21localhost 26 0 0 0 0 0%00:00:00
22news.nk.ca 2 0 0 0 0 0%00:20:12
TOTAL: 22 834 134719 7611 125928 1180 5%499:34:11
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1endofthelinebbs-out.news.weretis.net5.3 MB11.9 KB451.0 KB5.7 MB 92%2.8 KB
2outgoing.news.lysator.liu.se5.0 MB6.6 KB9.7 KB5.0 MB 99%3.0 KB
3usenet.network2.3 MB3.9 KB15.9 KB2.3 MB 99%7.7 KB
4nntp.comgw.net2.0 MB7.7 KB260.2 KB2.3 MB 88%3.0 KB
5usenet.blueworldhosting.com1.8 MB0.0 KB1.3 MB3.0 MB 57%2.7 KB
6news.hispagatos.org1.5 MB8.0 KB23.8 KB1.6 MB 98%3.0 KB
7news.corradoroberto.it1.5 MB0.0 KB0.0 KB1.5 MB100%5.4 KB
8usenet.goja.nl.eu.org1.5 MB8.0 KB49.8 KB1.5 MB 96%3.0 KB
9i2pn.org1.2 MB3.8 KB93.2 KB1.2 MB 92%2.7 KB
10endoftheline-out.news.chmurka.net838.9 KB3.9 KB0.0 KB842.9 KB 99%3.5 KB
11endofthelinebbs.peers.news.panix.com395.5 KB4.0 KB32.9 KB432.4 KB 91%2.7 KB
12glockenspiel.complete.org341.9 KB3.9 KB2.1 KB347.8 KB 98%29.0 KB
13newsfeed.bofh.team325.3 KB8.0 KB33.6 KB366.8 KB 88%2.8 KB
14news.samoylyk.net311.5 KB4.0 KB0.8 KB316.3 KB 98%3.9 KB
15news.netfront.net207.8 KB4.4 KB389.3 KB601.5 KB 34%3.3 KB
16news.furie.org.uk153.7 KB8.3 KB0.0 KB162.0 KB 94%4.4 KB
17news.nntp4.net57.2 KB7.9 KB0.0 KB65.1 KB 87%2.6 KB
18news.bbs.nz41.9 KB4.0 KB0.8 KB46.7 KB 89%2.3 KB
19newsfeed.xs3.de14.6 KB7.9 KB0.0 KB22.5 KB 64%2.5 KB
20eotl-out.news.tnetconsulting.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
21localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
22news.nk.ca0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 2224.6 MB106.3 KB2.6 MB27.3 MB 90%3.2 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 25 00:01:01 - 00:59:59 161 2.1% 0.05511.9 KB 2.0% 0.14
Sep 25 01:00:00 - 01:59:59 223 2.9% 0.061.0 MB 4.0% 0.29
Sep 25 02:00:00 - 02:59:59 341 4.4% 0.09980.6 KB 3.8% 0.27
Sep 25 03:00:00 - 03:59:59 408 5.3% 0.111.1 MB 4.2% 0.30
Sep 25 04:00:00 - 04:59:59 335 4.4% 0.091.0 MB 4.0% 0.28
Sep 25 05:00:00 - 05:59:59 330 4.3% 0.091.2 MB 4.6% 0.33
Sep 25 06:00:00 - 06:59:59 465 6.1% 0.131.5 MB 5.8% 0.41
Sep 25 07:00:00 - 07:59:59 484 6.3% 0.131.3 MB 5.3% 0.38
Sep 25 08:00:00 - 08:59:59 417 5.4% 0.121.2 MB 4.9% 0.35
Sep 25 09:00:00 - 09:59:59 514 6.7% 0.141.6 MB 6.4% 0.46
Sep 25 10:00:00 - 10:59:59 526 6.9% 0.151.6 MB 6.3% 0.45
Sep 25 11:00:00 - 11:59:59 461 6.0% 0.131.4 MB 5.6% 0.40
Sep 25 12:00:00 - 12:59:59 373 4.9% 0.101.2 MB 4.7% 0.34
Sep 25 13:00:00 - 13:59:59 439 5.7% 0.121.5 MB 5.8% 0.41
Sep 25 14:00:00 - 14:59:59 459 6.0% 0.131.3 MB 5.1% 0.37
Sep 25 15:00:00 - 15:59:59 384 5.0% 0.111.4 MB 5.7% 0.41
Sep 25 16:00:00 - 16:59:59 350 4.6% 0.101.4 MB 5.7% 0.41
Sep 25 17:00:00 - 17:59:59 246 3.2% 0.071.1 MB 4.6% 0.33
Sep 25 18:00:00 - 18:59:59 160 2.1% 0.04613.0 KB 2.4% 0.17
Sep 25 19:00:00 - 19:59:59 124 1.6% 0.03490.7 KB 1.9% 0.14
Sep 25 20:00:00 - 20:59:59 135 1.8% 0.04620.1 KB 2.4% 0.17
Sep 25 21:00:00 - 21:59:59 108 1.4% 0.03380.2 KB 1.5% 0.11
Sep 25 22:00:00 - 22:59:59 93 1.2% 0.03356.7 KB 1.4% 0.10
Sep 25 23:00:00 - 23:59:59 136 1.8% 0.04539.1 KB 2.1% 0.15
Sep 26 00:00:00 - 00:01:02 4 0.1% 0.0616.7 KB 0.1% 0.27
TOTAL: 24:00:01 7676 100.0% 0.0925.2 MB 100.0% 0.30
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
CYCNGS1NGS1536.0 GB48.0 MB 0.0% 1 0.00 0.00
CYCNGS2NGS1536.0 GB97.8 GB 6.4% 0 0.4739277.68
CYCTXT1TEXT5.0 GB3.9 GB 77.4% 0 0.03 2039.73
TOTAL: 3-3077.0 GB101.8 GB 3.3% 1 0.32-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1usenet.blueworldhosting.com 418 0 0 0 0 0 0 0 418
2endofthelinebbs-out.news.weretis.net 317 0 0 6 0 0 0 0 311
3nntp.comgw.net 167 0 0 3 0 0 0 0 164
4news.netfront.net 94 0 0 2 0 0 0 0 92
5usenet.goja.nl.eu.org 65 0 0 3 0 0 0 0 62
6i2pn.org 60 0 0 2 0 0 0 0 58
7usenet.network 20 0 0 2 0 0 0 0 18
8endofthelinebbs.peers.news.panix.com 17 0 0 2 0 0 0 0 15
9outgoing.news.lysator.liu.se 14 0 0 3 0 0 0 0 11
10news.hispagatos.org 12 6 0 3 0 0 0 0 3
11newsfeed.bofh.team 8 0 0 3 0 0 0 0 5
12glockenspiel.complete.org 4 0 0 2 0 0 0 0 2
13news.furie.org.uk 4 0 0 4 0 0 0 0 0
14news.nntp4.net 3 0 0 3 0 0 0 0 0
15news.samoylyk.net 3 0 0 2 0 0 0 0 1
16newsfeed.xs3.de 3 0 0 3 0 0 0 0 0
17news.bbs.nz 2 0 0 2 0 0 0 0 0
18endoftheline-out.news.chmurka.net 1 0 0 1 0 0 0 0 0
TOTAL: 18 1212 6 0 46 0 0 0 0 1160

Unwanted newsgroups [Top 20]:

NewsgroupCount
hispagatos.hacking.news 6
TOTAL: 1 6

INND Perl filter [Top 20]:

ReasonCount
EMP (phn path) 423
EMP (phr path) 368
EMP (md5) 197
Too many newsgroups 94
User-issued cancel 40
Binary: misplaced binary 4
HTML Multipart 2
TOTAL: 7 1128

NoCeM on Spool:

Issuer (type)NoticesBad PGPCancelSkipTotal
i2pn2-nocem@i2pn2.org (multipost)3000119119
i2pn2-nocem@i2pn2.org (rmp)12006262
robot@pasdenom.info (spam3)30055
TOTAL: 34500186186

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
endofthelinebbs-out.news.weretis.net 17
usenet.blueworldhosting.com 7
nntp.comgw.net 2
usenet.goja.nl.eu.org 1
endofthelinebbs.peers.news.panix.com 1
outgoing.news.lysator.liu.se 1
glockenspiel.complete.org 1
TOTAL: 7 30
No colon-space in header field
usenet.blueworldhosting.com 1
TOTAL: 1 1
TOTAL: 2 31

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.netfront.net 12310 2222 5365 1 0 8 18%23:59:55
2nyheter.lysator.liu.se 6170 1303 4264 378 0 2 21%23:59:55
3news.furie.org.uk 4046 914 2467 13 0 1 22%23:58:22
4usenet.goja.nl.eu.org 7724 365 6586 118 0 0 4%23:58:54
5endofthelinebbs.peers.news.panix.com 7902 349 7321 3 0 0 4%23:59:55
6news.hispagatos.org 8132 253 6720 188 0 0 3%23:59:55
7usenet.network 7826 209 6719 27 0 0 2%23:59:55
8newsfeed.bofh.team 8142 183 7224 0 0 2 2%23:59:05
9news.bbs.nz 14053 173 6944 554 0 59 1%23:59:55
10news.nk.ca 11121 155 6933 534 0 47 1%23:59:55
11news.nntp4.net 8412 142 7473 16 0 0 1%23:59:55
12nntp.comgw.net 7698 112 6875 66 0 0 1%23:59:55
13i2pn.org 8420 111 7093 44 0 34 1%23:59:55
14photonic.trudheim.com 5793 105 5095 362 3 4966 1%23:59:55
15news.corradoroberto.it 1118 85 901 1 0 0 7%23:11:31
16news.tnetconsulting.net 8744 81 7416 174 0 12 0%23:59:02
17news.weretis.net 7923 59 7511 103 0 0 0%23:59:47
18news.quux.org 8078 57 7161 443 0 0 0%23:59:14
19newsfeed.xs3.de 8623 38 7401 201 0 0 0%23:59:41
20news.chmurka.net 4032 32 3455 1 0 0 0%23:59:55
21news.samoylyk.net 8475 27 7497 53 0 0 0%23:59:55
22usenet.blueworldhosting.com 7102 0 6731 0 0 0 0%23:59:55
23feed.opticnetworks.net 0 0 0 0 0 7676 0%23:59:55
TOTAL: 23 171844 6975 135152 3280 3 12807 4%551:04:21
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.netfront.net8.8 MB2.1 KB8.8 MB0.1 KB/s4.0 KB23:59:55
2news.furie.org.uk5.1 MB393.9 KB5.4 MB0.1 KB/s6.0 KB23:58:22
3nyheter.lysator.liu.se4.1 MB2.7 MB6.8 MB0.1 KB/s4.1 KB23:59:55
4endofthelinebbs.peers.news.panix.com1.5 MB4.7 KB1.5 MB0.0 KB/s4.4 KB23:59:55
5newsfeed.bofh.team1022.8 KB0.0 KB1022.8 KB0.0 KB/s5.6 KB23:59:05
6news.hispagatos.org915.3 KB1.4 MB2.3 MB0.0 KB/s5.3 KB23:59:55
7usenet.goja.nl.eu.org787.8 KB1.0 MB1.8 MB0.0 KB/s3.8 KB23:58:54
8usenet.network769.8 KB84.6 KB854.4 KB0.0 KB/s3.6 KB23:59:55
9news.nntp4.net711.3 KB181.3 KB892.7 KB0.0 KB/s5.6 KB23:59:55
10news.bbs.nz663.0 KB2.5 MB3.1 MB0.0 KB/s4.4 KB23:59:55
11photonic.trudheim.com559.5 KB864.8 KB1.4 MB0.0 KB/s3.0 KB23:59:55
12news.quux.org432.9 KB1.8 MB2.2 MB0.0 KB/s4.5 KB23:59:14
13news.nk.ca405.4 KB2.3 MB2.7 MB0.0 KB/s4.1 KB23:59:55
14news.tnetconsulting.net403.4 KB1.1 MB1.5 MB0.0 KB/s6.0 KB23:59:02
15news.weretis.net361.2 KB1.2 MB1.6 MB0.0 KB/s10.1 KB23:59:47
16nntp.comgw.net348.7 KB710.0 KB1.0 MB0.0 KB/s5.9 KB23:59:55
17i2pn.org345.7 KB274.8 KB620.5 KB0.0 KB/s4.0 KB23:59:55
18news.corradoroberto.it273.0 KB2.0 KB275.0 KB0.0 KB/s3.2 KB23:11:31
19newsfeed.xs3.de271.6 KB979.1 KB1.2 MB0.0 KB/s5.2 KB23:59:41
20news.samoylyk.net240.7 KB221.9 KB462.6 KB0.0 KB/s5.8 KB23:59:55
21news.chmurka.net207.2 KB2.2 KB209.3 KB0.0 KB/s6.3 KB23:59:55
22feed.opticnetworks.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:55
23usenet.blueworldhosting.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:55
TOTAL: 2328.0 MB17.7 MB45.6 MB0.0 KB/s4.6 KB551:04:21
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ddt.demos.su2764 00.0 KB 0 0 000:28:37
22001:470:28:a8:ca7f:54ff:fe03:41e0 928 00.0 KB 0 0 000:06:51
3ec2-3-23-132-121.us-east-2.compute.amazonaws.com 4 00.0 KB 0 0 000:00:00
4147.185.132.63 1 00.0 KB 0 0 000:00:10
5185.242.226.41 1 00.0 KB 0 0 000:00:00
6205.210.31.79 1 00.0 KB 0 0 000:00:10
791.238.181.31 1 00.0 KB 0 0 000:00:00
8azpdcgc71.stretchoid.com 1 00.0 KB 0 0 000:00:00
9localhost 1 00.0 KB 0 0 000:11:06
10server-0-3.survey.inspici.com 1 00.0 KB 0 0 000:00:03
11stupendous.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
12thorough.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
TOTAL: 123705 1294.4 KB 0 1 0155:26:04

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 4 1294.4 KB 0 1 0154:39:22
2*.demos.su2764 00.0 KB 0 0 000:28:37
3? 929 00.0 KB 0 0 000:17:58
4*.us-east-2.compute.amazonaws.com 4 00.0 KB 0 0 000:00:00
5*.monitoring.internet-measurement.com 2 00.0 KB 0 0 000:00:02
6*.stretchoid.com 1 00.0 KB 0 0 000:00:00
7*.survey.inspici.com 1 00.0 KB 0 0 000:00:03
TOTAL: 73705 1294.4 KB 0 1 0155:26:04

NNRP auth users [Top 20]:

UserConn
getlist 1
TOTAL: 1 1

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
47.186.47.228 0.370 0.991 0.096154:39:01
ddt.demos.su 9.507 36.716 0.00000:28:37
localhost 178.406 369.393 0.07800:11:06
2001:470:28:a8:ca7f:54ff:fe03:41e0 3.504 12.876 0.00000:06:51
147.185.132.63 0.003 0.013 0.00000:00:10
205.210.31.79 0.000 0.016 0.00000:00:10
server-0-3.survey.inspici.com 0.000 0.016 0.00000:00:03
thorough.monitoring.internet-measurement.com 0.004 0.012 0.00000:00:01
ec2-3-23-132-121.us-east-2.compute.amazonaws.com 0.007 0.060 0.00000:00:00
stupendous.monitoring.internet-measurement.com 0.004 0.016 0.00000:00:00
91.238.181.31 0.000 0.016 0.00000:00:00
185.242.226.41 0.000 0.017 0.00000:00:00
azpdcgc71.stretchoid.com 0.008 0.008 0.00000:00:00
TOTAL: 13 191.813 420.150 0.174155:26:04

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

SystemConn
ec2-3-23-132-121.us-east-2.compute.amazonaws.com 9
185.242.226.41 5
91.238.181.31 1
azpdcgc71.stretchoid.com 1
TOTAL: 4 16

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

CommandCount
#001 2
#026#003#001 2
Accept-Encoding: gzip 2
Accept: */* 2
GET / HTTP/1.1 2
Host: 144.172.126.95:119 2
#003 1
MGLNDD_144.172.126.95_119 1
User-Agent: Mozilla/5.0 (Macintosh; Inte... 1
User-Agent: Mozilla/5.0 (Windows NT 10.0... 1
TOTAL: 10 16

NNRP client timeouts [Top 20]:

SystemConnPeer
91.238.181.31 1 1
TOTAL: 1 1 1