Daily Usenet Report

Sep 14 00:01:02 -- Sep 15 00:01:02

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

Sep 14 08:12:15 newsfeed innd: message repeated 2 times: [ ctlinnd command s]
Sep 14 16:01:05 newsfeed pgpverify[3495885]: pgpverify: verification failed
Sep 15 00:00:01 newsfeed nnrpd[3607313]: localhost auth: program exited with status 8

Log entries by program:

Program nameLines%LinesSize%Size
inn 8461 28.5%3.4 MB 54.2%
nnrpd 8419 28.3%882.8 KB 13.7%
innd 8190 27.6%1.2 MB 18.4%
innfeed 4163 14.0%814.9 KB 12.6%
cnfsstat 432 1.5%63.4 KB 1.0%
nocem 45 0.2%5.4 KB 0.1%
controlchan 12 0.0%2.7 KB 0.0%
pgpverify 1 0.0%0.1 KB 0.0%
TOTAL: 8 29723 100.0%6.3 MB100.0%

History cache:

ReasonCount%Count
Positive hits 117413 61.1%
Negative hits 66400 34.6%
Do not exist 8286 4.3%
Cache misses 6 0.0%
TOTAL: 4 192105 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.184 0.0%46 0.000 4.000 14.000
article cleanup00:00:00.079 0.0%8337 0.000 0.009 0.045
article logging00:00:00.495 0.0%8435 0.000 0.059 1.320
article parse00:00:00.219 0.0%11644 0.000 0.019 0.075
article write00:00:02.310 0.0%7073 0.000 0.327 3.175
artlog/artcncl00:00:00.000 0.0%7 0.000 0.000 0.000
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:01.690 0.0%191357 0.000 0.009 0.416
hisgrep/artcncl00:00:00.150 0.0%53 0.000 2.830 10.000
hishave/artcncl00:00:00.000 0.0%7 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:30.594 0.2%193357 0.094 0.779 4.548
history sync00:00:00.080 0.0%398 0.000 0.201 1.000
history write00:01:48.662 0.1%8337 2.979 13.034 110.167
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:35.373 99.1%190873 90.235 449.070 1908.000
nntp read00:00:03.938 0.0%192474 0.004 0.020 0.424
overview write00:06:38.222 0.5%7073 0.803 56.302 3086.400
perl filter00:00:30.553 0.0%8337 1.565 3.665 34.359
python filter00:00:01.474 0.0%8337 0.000 0.177 5.594
site send00:00:01.208 0.0%14191 0.000 0.085 0.369
TOTAL: 24:01:08.06824:00:15.231 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.024 0.0%7979 0.000 0.003 0.077
article prepare00:00:00.011 0.0%45548 0.000 0.000 0.009
article read00:00:00.469 0.0%3536 0.000 0.133 0.417
backlog stats00:00:00.359 0.0%256674 0.000 0.001 0.009
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.435 0.0%176520 0.003 0.014 0.045
data write00:00:03.104 0.0%174171 0.009 0.018 0.033
idle23:58:59.277100.0%256674 147.951 336.377 1143.709
status file00:00:00.331 0.0%292 0.889 1.134 5.000
TOTAL: 23:59:16.84023:59:06.010100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:24:36.782 57.0%8317 0.500 177.562 10051.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:04.358 0.2%95432 0.000 0.046 1.000
TOTAL: 00:43:08.67000:24:41.140 57.2%----

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
newgroups-request@fido7.org001101
TOTAL001101

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1outgoing.news.lysator.liu.se 1 6237 1340 4820 77 21%23:59:58
2usenet.blueworldhosting.com 718 8114 1059 6489 566 13%23:52:01
3news.hispagatos.org 6 7520 761 6707 52 10%24:26:22
4endofthelinebbs-out.news.weretis.net 4 12210 703 11339 168 5%42:40:49
5usenet.goja.nl.eu.org 11 7809 660 7061 88 8%25:28:39
6news.corradoroberto.it 10 1379 551 828 0 39%24:05:56
7newsfeed.xs3.de 1 5940 461 5450 29 7%23:59:53
8nntp.comgw.net 1 7744 447 7166 131 5%23:59:57
9i2pn.org 1 7521 191 7303 27 2%23:59:54
10newsfeed.bofh.team 1 8148 176 7963 9 2%23:59:57
11usenet.network 2 5297 147 5149 1 2%23:59:52
12endofthelinebbs.peers.news.panix.com 26 7493 146 7335 12 1%23:54:14
13endoftheline-out.news.chmurka.net 1 3516 123 3392 1 3%23:59:55
14news.samoylyk.net 3 6549 105 6442 2 1%23:58:18
15news.nntp4.net 2 6246 88 6156 2 1%23:59:52
16news.netfront.net 1 5837 18 5731 88 0%20:50:48
17glockenspiel.complete.org 2 5720 18 5700 2 0%23:59:32
18news.bbs.nz 2 6597 8 6589 0 0%23:59:25
19news.furie.org.uk 1 3764 3 3760 1 0%23:59:55
20photonic.trudheim.com 2 1814 0 1813 1 0%22:17:59
21eotl-out.news.tnetconsulting.net 1 0 0 0 0 0%00:10:05
22localhost 26 0 0 0 0 0%00:00:00
23news.nk.ca 2 0 0 0 0 0%00:20:18
TOTAL: 23 825 125455 7005 117193 1257 5%496:03:39
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1outgoing.news.lysator.liu.se3.9 MB0.0 KB112.4 KB4.0 MB 97%2.9 KB
2news.corradoroberto.it2.9 MB0.0 KB0.0 KB2.9 MB100%5.3 KB
3usenet.blueworldhosting.com2.8 MB0.0 KB909.5 KB3.7 MB 75%2.3 KB
4news.hispagatos.org2.4 MB0.0 KB87.8 KB2.5 MB 96%3.2 KB
5endofthelinebbs-out.news.weretis.net2.2 MB0.0 KB494.3 KB2.7 MB 82%3.2 KB
6usenet.goja.nl.eu.org1.9 MB0.0 KB138.5 KB2.0 MB 93%2.8 KB
7newsfeed.xs3.de1.4 MB0.0 KB46.1 KB1.5 MB 96%3.1 KB
8nntp.comgw.net1.4 MB0.0 KB300.9 KB1.7 MB 82%3.0 KB
9usenet.network1.2 MB0.0 KB0.8 KB1.2 MB 99%8.4 KB
10i2pn.org690.8 KB0.0 KB35.2 KB726.0 KB 95%3.3 KB
11endoftheline-out.news.chmurka.net460.3 KB0.0 KB0.8 KB461.1 KB 99%3.7 KB
12newsfeed.bofh.team452.6 KB0.0 KB13.9 KB466.5 KB 97%2.5 KB
13news.samoylyk.net435.2 KB0.0 KB1.4 KB436.6 KB 99%4.1 KB
14endofthelinebbs.peers.news.panix.com379.4 KB0.0 KB37.5 KB416.9 KB 90%2.6 KB
15news.nntp4.net218.4 KB0.0 KB1.9 KB220.4 KB 99%2.4 KB
16glockenspiel.complete.org127.3 KB0.0 KB1.5 KB128.8 KB 98%6.4 KB
17news.netfront.net81.4 KB0.0 KB226.6 KB308.0 KB 26%2.9 KB
18news.furie.org.uk16.9 KB0.0 KB11.0 KB27.9 KB 60%7.0 KB
19news.bbs.nz16.3 KB0.0 KB0.0 KB16.3 KB100%2.0 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
23photonic.trudheim.com0.0 KB0.0 KB2.3 KB2.3 KB 0%2.3 KB
TOTAL: 2322.9 MB0.0 KB2.4 MB25.3 MB 90%3.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 14 00:01:02 - 00:59:59 148 2.1% 0.04455.7 KB 1.9% 0.13
Sep 14 01:00:00 - 01:59:59 261 3.7% 0.07789.1 KB 3.3% 0.22
Sep 14 02:00:00 - 02:59:59 345 4.9% 0.101.1 MB 4.7% 0.31
Sep 14 03:00:00 - 03:59:59 386 5.4% 0.111.3 MB 5.6% 0.38
Sep 14 04:00:00 - 04:59:59 365 5.1% 0.101.0 MB 4.4% 0.30
Sep 14 05:00:00 - 05:59:59 299 4.2% 0.08866.7 KB 3.6% 0.24
Sep 14 06:00:00 - 06:59:59 306 4.3% 0.09924.8 KB 3.8% 0.26
Sep 14 07:00:00 - 07:59:59 361 5.1% 0.101000.7 KB 4.1% 0.28
Sep 14 08:00:00 - 08:59:59 330 4.7% 0.09906.8 KB 3.8% 0.25
Sep 14 09:00:00 - 09:59:59 363 5.1% 0.101001.5 KB 4.2% 0.28
Sep 14 10:00:00 - 10:59:59 367 5.2% 0.101.1 MB 4.6% 0.31
Sep 14 11:00:00 - 11:59:59 305 4.3% 0.081.1 MB 4.5% 0.30
Sep 14 12:00:00 - 12:59:59 390 5.5% 0.111.2 MB 5.3% 0.35
Sep 14 13:00:00 - 13:59:59 444 6.3% 0.121.5 MB 6.5% 0.43
Sep 14 14:00:00 - 14:59:59 332 4.7% 0.091.1 MB 4.7% 0.31
Sep 14 15:00:00 - 15:59:59 479 6.8% 0.131.8 MB 7.8% 0.52
Sep 14 16:00:00 - 16:59:59 365 5.1% 0.101.3 MB 5.7% 0.38
Sep 14 17:00:00 - 17:59:59 254 3.6% 0.07840.1 KB 3.5% 0.23
Sep 14 18:00:00 - 18:59:59 160 2.3% 0.04563.8 KB 2.3% 0.16
Sep 14 19:00:00 - 19:59:59 166 2.3% 0.05722.5 KB 3.0% 0.20
Sep 14 20:00:00 - 20:59:59 227 3.2% 0.061.2 MB 4.9% 0.33
Sep 14 21:00:00 - 21:59:59 162 2.3% 0.04640.8 KB 2.7% 0.18
Sep 14 22:00:00 - 22:59:59 110 1.6% 0.03698.2 KB 2.9% 0.19
Sep 14 23:00:00 - 23:59:59 152 2.1% 0.04535.1 KB 2.2% 0.15
Sep 15 00:00:00 - 00:01:02 14 0.2% 0.2326.5 KB 0.1% 0.43
TOTAL: 24:00:00 7091 100.0% 0.0823.6 MB 100.0% 0.28
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.4 GB 6.3% 0 0.4541855.33
CYCTXT1TEXT5.0 GB3.9 GB 77.2% 0 0.03 2098.06
TOTAL: 3-3077.0 GB101.3 GB 3.3% 1 0.32-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1usenet.blueworldhosting.com 604 0 0 0 0 0 0 0 604
2endofthelinebbs-out.news.weretis.net 213 0 0 0 0 0 0 0 213
3nntp.comgw.net 137 0 0 0 0 0 0 0 137
4usenet.goja.nl.eu.org 96 0 0 0 0 0 0 0 96
5news.netfront.net 85 0 0 0 0 0 0 0 85
6outgoing.news.lysator.liu.se 78 0 0 0 0 0 0 0 78
7news.hispagatos.org 54 14 0 0 0 0 0 0 40
8newsfeed.xs3.de 35 0 0 0 0 0 0 0 35
9i2pn.org 28 0 0 0 0 0 0 0 28
10endofthelinebbs.peers.news.panix.com 15 0 0 0 0 0 0 0 15
11newsfeed.bofh.team 10 1 0 0 0 0 0 0 9
12news.nntp4.net 2 0 0 0 0 0 0 0 2
13news.samoylyk.net 2 0 0 0 0 0 0 0 2
14endoftheline-out.news.chmurka.net 1 0 0 0 0 0 0 0 1
15news.furie.org.uk 1 0 0 0 0 0 0 0 1
16photonic.trudheim.com 1 0 0 0 0 0 0 0 1
17usenet.network 1 0 0 0 0 0 0 0 1
TOTAL: 17 1363 15 0 0 0 0 0 0 1348

Unwanted newsgroups [Top 20]:

NewsgroupCount
hispagatos.hacking.ctf 13
hispagatos.hacking.news 1
soc.culture.russia 1
TOTAL: 3 15

INND Perl filter [Top 20]:

ReasonCount
EMP (phn path) 669
EMP (phr path) 327
EMP (md5) 113
Too many newsgroups 95
Too many newsgroups (meow) 22
User-issued cancel 12
HTML Multipart 6
EMP (fsl) 3
hierarchy violation - crosspost outside sdnet 2
Too many newsgroups (low_xpost) 1
TOTAL: 10 1250

NoCeM on Spool:

Issuer (type)NoticesBad PGPCancelSkipTotal
i2pn2-nocem@i2pn2.org (multipost)2900176176
i2pn2-nocem@i2pn2.org (rmp)10005454
robot@pasdenom.info (spam3)30066
robot@pasdenom.info (spam2)20022
TOTAL: 44400238238

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
usenet.blueworldhosting.com 38
endofthelinebbs-out.news.weretis.net 25
usenet.goja.nl.eu.org 15
nntp.comgw.net 7
newsfeed.xs3.de 6
endofthelinebbs.peers.news.panix.com 3
news.netfront.net 1
outgoing.news.lysator.liu.se 1
i2pn.org 1
newsfeed.bofh.team 1
TOTAL: 10 98
TOTAL: 1 98

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.netfront.net 11373 1837 5229 7 0 125 16%23:59:53
2nyheter.lysator.liu.se 6014 1489 3955 303 0 23 24%23:58:33
3news.furie.org.uk 3895 700 2740 7 0 6 17%23:59:53
4photonic.trudheim.com 7450 500 5368 1215 0 1 6%23:58:56
5usenet.network 7801 446 6033 32 0 0 5%23:59:53
6endofthelinebbs.peers.news.panix.com 7369 419 6664 4 0 9 5%23:59:25
7news.hispagatos.org 7628 417 5750 136 0 22 5%23:59:40
8usenet.goja.nl.eu.org 7721 311 6073 67 0 20 4%23:59:18
9news.bbs.nz 13095 262 6522 297 0 206 2%23:59:48
10news.nk.ca 10480 215 6386 436 0 73 2%23:59:53
11news.nntp4.net 8101 204 6754 18 0 17 2%23:59:15
12i2pn.org 7920 196 6626 66 0 137 2%23:58:34
13news.tnetconsulting.net 8115 180 6743 160 0 60 2%23:59:39
14news.weretis.net 7408 173 6848 66 0 33 2%23:59:53
15newsfeed.bofh.team 8187 155 6704 0 0 28 1%23:59:15
16news.quux.org 7631 126 6582 370 0 51 1%23:59:53
17nntp.comgw.net 7777 123 6462 35 0 11 1%23:58:00
18newsfeed.xs3.de 8141 68 6470 85 0 16 0%23:59:47
19news.corradoroberto.it 811 64 629 2 0 7 7%23:07:23
20news.samoylyk.net 8763 38 6800 122 0 49 0%23:59:53
21news.chmurka.net 3863 34 3245 0 0 0 0%23:59:40
22usenet.blueworldhosting.com 6035 1 5708 0 0 0 0%23:59:20
23feed.opticnetworks.net 0 0 0 0 0 7091 0%23:59:53
TOTAL: 23 165578 7958 124291 3428 0 7985 4%550:55:37
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.netfront.net7.3 MB24.7 KB7.3 MB0.1 KB/s4.0 KB23:59:53
2nyheter.lysator.liu.se5.2 MB1.5 MB6.7 MB0.1 KB/s3.8 KB23:58:33
3news.furie.org.uk3.7 MB70.1 KB3.7 MB0.0 KB/s5.4 KB23:59:53
4photonic.trudheim.com2.3 MB3.5 MB5.9 MB0.1 KB/s3.5 KB23:58:56
5endofthelinebbs.peers.news.panix.com1.8 MB5.5 KB1.8 MB0.0 KB/s4.3 KB23:59:25
6usenet.network1.5 MB98.7 KB1.6 MB0.0 KB/s3.4 KB23:59:53
7news.hispagatos.org1.4 MB937.6 KB2.4 MB0.0 KB/s4.4 KB23:59:40
8news.quux.org1.2 MB1.1 MB2.3 MB0.0 KB/s4.7 KB23:59:53
9newsfeed.bofh.team1.0 MB0.0 KB1.0 MB0.0 KB/s6.7 KB23:59:15
10news.nntp4.net994.7 KB123.6 KB1.1 MB0.0 KB/s5.0 KB23:59:15
11news.bbs.nz902.2 KB1.5 MB2.4 MB0.0 KB/s4.4 KB23:59:48
12news.tnetconsulting.net846.2 KB836.8 KB1.6 MB0.0 KB/s5.0 KB23:59:39
13news.weretis.net809.7 KB1.0 MB1.8 MB0.0 KB/s7.8 KB23:59:53
14news.samoylyk.net764.7 KB452.7 KB1.2 MB0.0 KB/s7.6 KB23:59:53
15i2pn.org747.2 KB243.4 KB990.6 KB0.0 KB/s3.8 KB23:58:34
16usenet.goja.nl.eu.org737.3 KB552.9 KB1.3 MB0.0 KB/s3.4 KB23:59:18
17news.nk.ca514.3 KB1.9 MB2.4 MB0.0 KB/s3.7 KB23:59:53
18nntp.comgw.net409.5 KB860.6 KB1.2 MB0.0 KB/s8.0 KB23:58:00
19newsfeed.xs3.de320.8 KB1015.2 KB1.3 MB0.0 KB/s8.7 KB23:59:47
20news.corradoroberto.it224.3 KB3.8 KB228.0 KB0.0 KB/s3.5 KB23:07:23
21news.chmurka.net105.9 KB0.0 KB105.9 KB0.0 KB/s3.1 KB23:59:40
22usenet.blueworldhosting.com2.2 KB0.0 KB2.2 KB0.0 KB/s2.2 KB23:59:20
23feed.opticnetworks.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:53
TOTAL: 2332.6 MB15.6 MB48.2 MB0.0 KB/s4.3 KB550:55:37
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ddt.demos.su2765 00.0 KB 0 0 000:29:11
2162.142.125.214 3 00.0 KB 0 0 000:00:04
347.237.126.78 2 00.0 KB 0 0 000:00:27
447.237.20.145 2 00.0 KB 0 0 000:00:23
547.237.96.159 2 00.0 KB 0 0 000:00:22
647.237.97.224 2 00.0 KB 0 0 000:00:21
747.237.98.204 2 00.0 KB 0 0 000:00:22
8104.152.52.124 1 00.0 KB 0 0 000:00:10
9104.152.52.201 1 00.0 KB 0 0 000:00:00
10147.185.132.213 1 00.0 KB 0 0 000:00:10
11179.60.149.8 1 00.0 KB 0 0 000:00:00
12205.210.31.76 1 00.0 KB 0 0 000:00:10
1347.237.127.5 1 00.0 KB 0 0 000:00:08
1447.237.14.149 1 00.0 KB 0 0 000:00:04
158.222.160.96 1 00.0 KB 0 0 000:00:02
1680.66.76.134 1 00.0 KB 0 0 000:00:00
17azpdwg66.stretchoid.com 1 00.0 KB 0 0 000:00:00
18localhost 1 00.0 KB 0 0 000:11:04
19server-0-3.survey.inspici.com 1 00.0 KB 0 0 000:00:04
TOTAL: 192790 00.0 KB 0 0 000:43:07

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.demos.su2765 00.0 KB 0 0 000:29:11
2unresolved 22 00.0 KB 0 0 000:02:46
3*.stretchoid.com 1 00.0 KB 0 0 000:00:00
4*.survey.inspici.com 1 00.0 KB 0 0 000:00:04
5? 1 00.0 KB 0 0 000:11:04
TOTAL: 52790 00.0 KB 0 0 000:43:07

NNRP auth users [Top 20]:

UserConn
getlist 1
TOTAL: 1 1

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
ddt.demos.su 9.774 36.228 0.00000:29:11
localhost 178.824 369.901 0.09100:11:04
47.237.126.78 0.004 0.028 0.00000:00:27
47.237.20.145 0.012 0.020 0.00000:00:23
47.237.96.159 0.004 0.028 0.00000:00:22
47.237.98.204 0.006 0.026 0.00000:00:22
47.237.97.224 0.004 0.028 0.00000:00:21
205.210.31.76 0.004 0.012 0.00000:00:10
104.152.52.124 0.004 0.012 0.00000:00:10
147.185.132.213 0.000 0.016 0.00000:00:10
47.237.127.5 0.003 0.013 0.00000:00:08
162.142.125.214 0.019 0.046 0.00000:00:04
47.237.14.149 0.008 0.008 0.00000:00:04
server-0-3.survey.inspici.com 0.003 0.015 0.00000:00:04
8.222.160.96 0.004 0.012 0.00000:00:02
80.66.76.134 0.000 0.016 0.00000:00:00
azpdwg66.stretchoid.com 0.004 0.012 0.00000:00:00
179.60.149.8 0.004 0.012 0.00000:00:00
104.152.52.201 0.004 0.015 0.00000:00:00
TOTAL: 19 188.685 406.448 0.09100:43:07

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

SystemConn
162.142.125.214 1
179.60.149.8 1
80.66.76.134 1
azpdwg66.stretchoid.com 1
TOTAL: 4 4

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

CommandCount
#003 2
EHLO www.censys.io 1
MGLNDD_144.172.126.95_119 1
TOTAL: 3 4

NNRP client timeouts [Top 20]:

SystemConnPeer
162.142.125.214 1 2
179.60.149.8 1 1
80.66.76.134 1 1
TOTAL: 3 3 5