Daily Usenet Report

Sep 16 00:01:02 -- Sep 17 00:01:01

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

Sep 16 08:15:27 newsfeed innd: message repeated 2 times: [ ctlinnd command s]
Sep 16 15:09:18 newsfeed nnrpd[542294]: 47.186.47.228 auth: program exited with status 8
Sep 17 00:00:01 newsfeed nnrpd[669909]: localhost auth: program exited with status 8

Log entries by program:

Program nameLines%LinesSize%Size
inn 8535 29.0%3.5 MB 55.6%
nnrpd 8414 28.6%865.1 KB 13.2%
innd 7940 27.0%1.1 MB 17.8%
innfeed 4065 13.8%797.5 KB 12.2%
cnfsstat 432 1.5%69.8 KB 1.1%
nocem 50 0.2%6.0 KB 0.1%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 7 29437 100.0%6.4 MB100.0%

History cache:

ReasonCount%Count
Positive hits 120849 60.4%
Negative hits 70979 35.5%
Do not exist 8359 4.2%
Cache misses 19 0.0%
TOTAL: 4 200206 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.106 0.0%36 0.000 2.944 10.000
article cleanup00:00:00.088 0.0%8416 0.000 0.010 0.143
article logging00:00:00.406 0.0%8540 0.000 0.048 0.229
article parse00:00:00.183 0.0%11935 0.000 0.015 0.105
article write00:00:02.889 0.0%7334 0.000 0.394 16.167
artlog/artcncl00:00:00.000 0.0%2 0.000 0.000 0.000
artlog/artparse00:00:00.001 0.0%2 0.000 0.500 1.000
data move00:00:01.358 0.0%199005 0.000 0.007 1.049
hisgrep/artcncl00:00:00.087 0.0%38 0.000 2.289 9.000
hishave/artcncl00:00:00.000 0.0%2 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:16.503 0.2%201214 0.088 0.678 4.331
history sync00:00:00.071 0.0%401 0.000 0.177 1.000
history write00:01:46.526 0.1%8403 3.043 12.677 127.567
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:45:17.579 98.9%198882 94.060 429.992 1691.603
nntp read00:00:03.996 0.0%200046 0.001 0.020 0.983
overview write00:10:12.410 0.7%7334 0.439 83.503 13389.000
perl filter00:00:30.266 0.0%8401 1.704 3.603 17.769
python filter00:00:02.855 0.0%8401 0.000 0.340 11.750
site send00:00:01.007 0.0%14717 0.000 0.068 0.250
TOTAL: 24:01:09.65224:00:16.331 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.025 0.0%8089 0.000 0.003 0.091
article prepare00:00:00.008 0.0%45792 0.000 0.000 0.005
article read00:00:00.469 0.0%3305 0.000 0.142 1.235
backlog stats00:00:00.401 0.0%267944 0.000 0.001 0.007
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.244 0.0%185549 0.000 0.012 0.039
data write00:00:03.161 0.0%181773 0.005 0.017 0.033
idle23:58:30.754100.0%267944 137.058 322.122 1000.121
status file00:00:00.356 0.0%252 0.667 1.413 18.000
TOTAL: 23:58:47.40623:58:37.418100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle01:05:24.690 76.9%8387 0.750 467.949900050.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:04.338 0.1%95674 0.000 0.045 0.500
readart00:00:00.111 0.0%88 1.261 1.261 1.261
TOTAL: 01:25:03.26001:05:29.139 77.0%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1endofthelinebbs-out.news.weretis.net 4 13938 1874 11724 340 13%46:50:04
2outgoing.news.lysator.liu.se 1 6073 1523 4531 19 25%23:59:55
3usenet.blueworldhosting.com 714 8212 948 6817 447 11%24:00:46
4news.hispagatos.org 6 7615 626 6957 32 8%24:26:14
5news.corradoroberto.it 4 1613 460 1153 0 28%22:05:24
6nntp.comgw.net 1 7780 328 7386 66 4%23:59:57
7usenet.goja.nl.eu.org 10 7318 304 6997 17 4%22:02:49
8endoftheline-out.news.chmurka.net 2 3892 296 3594 2 7%23:59:24
9i2pn.org 2 7583 291 7256 36 3%23:59:32
10usenet.network 1 5718 203 5513 2 3%23:59:57
11endofthelinebbs.peers.news.panix.com 25 7744 141 7583 20 1%23:54:11
12newsfeed.bofh.team 2 8237 120 8109 8 1%23:59:46
13newsfeed.xs3.de 2 6247 98 6147 2 1%23:59:47
14news.samoylyk.net 1 6891 79 6810 2 1%23:59:46
15news.netfront.net 1 6581 51 6444 86 0%22:58:35
16news.nntp4.net 1 6744 19 6724 1 0%23:59:53
17glockenspiel.complete.org 2 5630 15 5613 2 0%23:56:33
18news.bbs.nz 1 6515 6 6509 0 0%23:59:41
19news.furie.org.uk 2 5869 2 5830 37 0%23:56:36
20photonic.trudheim.com 2 1780 1 1779 0 0%23:54:23
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:14
TOTAL: 23 813 131980 7385 123476 1119 5%498:33:32
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1endofthelinebbs-out.news.weretis.net5.5 MB50.4 KB625.7 KB6.2 MB 89%2.9 KB
2outgoing.news.lysator.liu.se4.3 MB0.0 KB30.4 KB4.3 MB 99%2.9 KB
3usenet.blueworldhosting.com2.5 MB0.0 KB713.7 KB3.2 MB 77%2.3 KB
4news.corradoroberto.it2.3 MB0.0 KB0.0 KB2.3 MB100%5.2 KB
5usenet.network2.1 MB0.0 KB2.0 KB2.1 MB 99%10.3 KB
6news.hispagatos.org1.9 MB0.0 KB56.3 KB2.0 MB 97%3.1 KB
7endoftheline-out.news.chmurka.net1.2 MB0.0 KB1.8 KB1.2 MB 99%4.2 KB
8nntp.comgw.net1.0 MB0.0 KB151.4 KB1.2 MB 87%3.1 KB
9usenet.goja.nl.eu.org920.9 KB0.0 KB17.9 KB938.9 KB 98%2.9 KB
10i2pn.org905.1 KB0.0 KB50.8 KB956.0 KB 94%2.9 KB
11news.samoylyk.net686.0 KB0.0 KB1.8 KB687.8 KB 99%8.5 KB
12newsfeed.xs3.de365.1 KB0.0 KB2.4 KB367.5 KB 99%3.7 KB
13newsfeed.bofh.team345.2 KB2.9 KB14.6 KB362.7 KB 95%2.8 KB
14endofthelinebbs.peers.news.panix.com341.5 KB0.0 KB21.1 KB362.6 KB 94%2.3 KB
15news.netfront.net112.2 KB0.0 KB338.2 KB450.5 KB 24%3.3 KB
16news.nntp4.net41.8 KB0.0 KB1.4 KB43.2 KB 96%2.2 KB
17glockenspiel.complete.org39.5 KB0.0 KB1.4 KB41.0 KB 96%2.4 KB
18news.bbs.nz15.2 KB0.0 KB0.0 KB15.2 KB100%2.5 KB
19news.furie.org.uk13.4 KB0.0 KB25.9 KB39.3 KB 34%1.0 KB
20photonic.trudheim.com3.1 KB0.0 KB0.0 KB3.1 KB100%3.1 KB
21eotl-out.news.tnetconsulting.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
22localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
23news.nk.ca0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 2324.6 MB53.3 KB2.0 MB26.7 MB 92%3.2 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 16 00:01:02 - 00:59:59 178 2.4% 0.05577.0 KB 2.3% 0.16
Sep 16 01:00:00 - 01:59:59 248 3.4% 0.07699.4 KB 2.8% 0.19
Sep 16 02:00:00 - 02:59:59 337 4.6% 0.091017.4 KB 4.0% 0.28
Sep 16 03:00:00 - 03:59:59 363 5.0% 0.101.1 MB 4.6% 0.32
Sep 16 04:00:00 - 04:59:59 360 4.9% 0.101.4 MB 5.7% 0.40
Sep 16 05:00:00 - 05:59:59 338 4.6% 0.091.1 MB 4.3% 0.30
Sep 16 06:00:00 - 06:59:59 353 4.8% 0.10974.9 KB 3.9% 0.27
Sep 16 07:00:00 - 07:59:59 315 4.3% 0.09950.8 KB 3.8% 0.26
Sep 16 08:00:00 - 08:59:59 340 4.6% 0.09993.3 KB 3.9% 0.28
Sep 16 09:00:00 - 09:59:59 526 7.2% 0.151.5 MB 6.0% 0.42
Sep 16 10:00:00 - 10:59:59 449 6.1% 0.121.8 MB 7.4% 0.52
Sep 16 11:00:00 - 11:59:59 475 6.5% 0.131.9 MB 7.7% 0.54
Sep 16 12:00:00 - 12:59:59 451 6.2% 0.131.3 MB 5.5% 0.38
Sep 16 13:00:00 - 13:59:59 390 5.3% 0.111.3 MB 5.3% 0.37
Sep 16 14:00:00 - 14:59:59 386 5.3% 0.111.1 MB 4.5% 0.31
Sep 16 15:00:00 - 15:59:59 297 4.1% 0.081003.5 KB 4.0% 0.28
Sep 16 16:00:00 - 16:59:59 351 4.8% 0.101.1 MB 4.5% 0.31
Sep 16 17:00:00 - 17:59:59 296 4.0% 0.081006.1 KB 4.0% 0.28
Sep 16 18:00:00 - 18:59:59 170 2.3% 0.05639.1 KB 2.5% 0.18
Sep 16 19:00:00 - 19:59:59 130 1.8% 0.04582.3 KB 2.3% 0.16
Sep 16 20:00:00 - 20:59:59 154 2.1% 0.041.0 MB 4.2% 0.29
Sep 16 21:00:00 - 21:59:59 106 1.4% 0.03458.5 KB 1.8% 0.13
Sep 16 22:00:00 - 22:59:59 144 2.0% 0.04769.6 KB 3.0% 0.21
Sep 16 23:00:00 - 23:59:59 167 2.3% 0.05507.5 KB 2.0% 0.14
Sep 17 00:00:00 - 00:01:01 2 0.0% 0.0316.6 KB 0.1% 0.27
TOTAL: 23:59:59 7326 100.0% 0.0824.6 MB 100.0% 0.29
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.5 GB 6.3% 0 0.4640341.37
CYCTXT1TEXT5.0 GB3.9 GB 77.2% 0 0.03 2238.89
TOTAL: 3-3077.0 GB101.4 GB 3.3% 1 0.32-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1usenet.blueworldhosting.com 492 2 0 0 0 0 0 0 490
2endofthelinebbs-out.news.weretis.net 390 0 0 13 0 0 0 0 377
3news.netfront.net 92 0 0 0 0 0 0 0 92
4nntp.comgw.net 63 0 0 0 0 0 0 0 63
5i2pn.org 41 0 0 0 0 0 0 0 41
6usenet.goja.nl.eu.org 31 0 0 0 0 0 0 0 31
7news.hispagatos.org 29 17 0 0 0 0 0 0 12
8endofthelinebbs.peers.news.panix.com 28 0 0 0 0 0 0 0 28
9outgoing.news.lysator.liu.se 20 0 0 0 0 0 0 0 20
10newsfeed.bofh.team 9 0 0 2 0 0 0 0 7
11newsfeed.xs3.de 3 0 0 0 0 0 0 0 3
12endoftheline-out.news.chmurka.net 2 0 0 0 0 0 0 0 2
13news.nntp4.net 2 0 0 0 0 0 0 0 2
14news.samoylyk.net 2 0 0 0 0 0 0 0 2
15usenet.network 2 0 0 0 0 0 0 0 2
16news.furie.org.uk 1 0 0 0 0 0 0 0 1
TOTAL: 16 1207 19 0 15 0 0 0 0 1173

Unwanted newsgroups [Top 20]:

NewsgroupCount
hispagatos.hacking.ctf 11
hispagatos.hacking.news 5
hispagatos.hacking.exploits 1
soc.culture.africa 1
soc.culture.russia 1
TOTAL: 5 19

INND Perl filter [Top 20]:

ReasonCount
EMP (phn path) 460
EMP (phr path) 346
Too many newsgroups 127
EMP (md5) 63
Too many newsgroups (meow) 25
User-issued cancel 16
HTML Multipart 6
Binary: misplaced binary 3
hierarchy violation - crosspost outside sdnet 1
TOTAL: 9 1047

NoCeM on Spool:

Issuer (type)NoticesBad PGPCancelSkipTotal
i2pn2-nocem@i2pn2.org (multipost)3800148148
i2pn2-nocem@i2pn2.org (rmp)6004545
robot@pasdenom.info (spam3)30044
robot@pasdenom.info (spam2)20022
TOTAL: 44900199199

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
endofthelinebbs-out.news.weretis.net 55
usenet.blueworldhosting.com 45
usenet.goja.nl.eu.org 8
endofthelinebbs.peers.news.panix.com 7
i2pn.org 4
newsfeed.xs3.de 1
newsfeed.bofh.team 1
outgoing.news.lysator.liu.se 1
news.netfront.net 1
news.nntp4.net 1
TOTAL: 10 124
No colon-space in header field
usenet.blueworldhosting.com 2
TOTAL: 1 2
TOTAL: 2 126

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nyheter.lysator.liu.se 6020 1717 3788 296 0 0 28%23:58:19
2news.netfront.net 12103 1686 5583 4 0 49 13%23:59:53
3news.furie.org.uk 4347 719 2727 31 0 1 16%23:56:37
4photonic.trudheim.com 7740 471 5656 1193 0 101 6%23:59:53
5usenet.network 8044 455 6283 39 0 15 5%23:59:53
6news.hispagatos.org 8112 454 6175 121 0 17 5%23:59:54
7usenet.goja.nl.eu.org 8248 344 6489 106 0 19 4%23:59:51
8endofthelinebbs.peers.news.panix.com 7576 338 6984 1 0 0 4%23:59:49
9news.bbs.nz 13534 281 6667 369 0 156 2%23:59:53
10news.nk.ca 10682 232 6553 455 0 53 2%23:59:54
11newsfeed.bofh.team 8363 177 6918 1 0 20 2%23:59:54
12news.nntp4.net 8527 145 7106 37 0 25 1%23:59:54
13i2pn.org 8249 139 6840 49 0 120 1%23:59:03
14nntp.comgw.net 8139 132 6807 56 0 25 1%23:59:54
15news.weretis.net 7621 122 7131 72 0 4 1%23:59:54
16news.tnetconsulting.net 8381 116 7028 178 0 29 1%23:59:54
17news.quux.org 7774 85 6815 410 0 6 1%23:59:21
18news.chmurka.net 3967 57 3281 1 0 21 1%23:59:54
19news.corradoroberto.it 1116 54 928 15 0 0 4%23:39:57
20newsfeed.xs3.de 8783 53 7015 153 0 22 0%23:59:54
21news.samoylyk.net 8822 24 7133 60 0 68 0%23:59:54
22usenet.blueworldhosting.com 6406 1 6102 0 0 14 0%23:59:53
23feed.opticnetworks.net 0 0 0 0 0 7326 0%23:59:54
TOTAL: 23 172554 7802 130009 3647 0 8091 4%551:31:16
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.netfront.net7.5 MB20.8 KB7.5 MB0.1 KB/s4.6 KB23:59:53
2nyheter.lysator.liu.se5.1 MB2.2 MB7.3 MB0.1 KB/s3.7 KB23:58:19
3news.furie.org.uk3.5 MB109.3 KB3.6 MB0.0 KB/s4.9 KB23:56:37
4photonic.trudheim.com2.8 MB3.0 MB5.8 MB0.1 KB/s3.6 KB23:59:53
5endofthelinebbs.peers.news.panix.com1.5 MB2.9 KB1.5 MB0.0 KB/s4.6 KB23:59:49
6usenet.network1.5 MB87.0 KB1.6 MB0.0 KB/s3.3 KB23:59:53
7news.hispagatos.org1.4 MB799.8 KB2.2 MB0.0 KB/s3.9 KB23:59:54
8newsfeed.bofh.team1.0 MB1.6 KB1.0 MB0.0 KB/s5.8 KB23:59:54
9news.bbs.nz936.1 KB1.8 MB2.7 MB0.0 KB/s4.3 KB23:59:53
10usenet.goja.nl.eu.org736.0 KB1013.4 KB1.7 MB0.0 KB/s3.9 KB23:59:51
11news.quux.org727.3 KB1.7 MB2.5 MB0.0 KB/s5.1 KB23:59:21
12news.weretis.net661.0 KB853.8 KB1.5 MB0.0 KB/s7.8 KB23:59:54
13news.tnetconsulting.net553.7 KB947.9 KB1.5 MB0.0 KB/s5.1 KB23:59:54
14news.nk.ca541.7 KB2.1 MB2.7 MB0.0 KB/s4.0 KB23:59:54
15i2pn.org500.4 KB246.9 KB747.3 KB0.0 KB/s4.0 KB23:59:03
16news.nntp4.net431.1 KB465.1 KB896.2 KB0.0 KB/s4.9 KB23:59:54
17nntp.comgw.net371.7 KB801.0 KB1.1 MB0.0 KB/s6.2 KB23:59:54
18news.samoylyk.net365.8 KB177.5 KB543.3 KB0.0 KB/s6.5 KB23:59:54
19newsfeed.xs3.de262.2 KB967.3 KB1.2 MB0.0 KB/s6.0 KB23:59:54
20news.corradoroberto.it190.3 KB49.7 KB240.0 KB0.0 KB/s3.5 KB23:39:57
21news.chmurka.net179.8 KB1.6 KB181.4 KB0.0 KB/s3.1 KB23:59:54
22usenet.blueworldhosting.com1.1 KB0.0 KB1.1 KB0.0 KB/s1.1 KB23:59:53
23feed.opticnetworks.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:54
TOTAL: 2330.6 MB17.3 MB47.9 MB0.0 KB/s4.3 KB551:31:16
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
147.186.47.228 1 4201.7 KB 2 0 000:12:35
TOTAL: 1 1 4201.7 KB 2 0 001:25:01

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 8 4201.7 KB 2 0 000:43:00
2*.demos.su2758 00.0 KB 0 0 000:29:24
3*.do.binaryedge.ninja 3 00.0 KB 0 0 000:00:04
4? 2 00.0 KB 0 0 000:12:16
5*.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
6*.stretchoid.com 1 00.0 KB 0 0 000:00:09
7*.survey.inspici.com 1 00.0 KB 0 0 000:00:04
TOTAL: 72774 4201.7 KB 2 0 001:25:01

NNRP auth users [Top 20]:

UserConn
getlist 1
nelgin 1
TOTAL: 2 2

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
60.190.248.11 0.004 0.012 0.00000:30:00
ddt.demos.su 9.408 36.869 0.00000:29:24
47.186.47.228 0.000 0.072 0.09200:12:35
localhost 184.888 366.192 0.07500:12:01
240e:d9:d800:200::d4 0.004 0.012 0.00000:00:14
198.235.24.197 0.000 0.016 0.00000:00:10
198.235.24.29 0.003 0.013 0.00000:00:10
azpdcsc41.stretchoid.com 0.003 0.014 0.00000:00:09
prod-beryllium-nyc1-90.do.binaryedge.ninja 0.003 0.045 0.00000:00:04
server-0-3.survey.inspici.com 0.006 0.011 0.00000:00:04
167.94.138.115 0.035 0.030 0.00000:00:03
glamorous.monitoring.internet-measurement.com 0.000 0.017 0.00000:00:01
80.66.76.121 0.007 0.009 0.00000:00:00
TOTAL: 13 194.361 403.312 0.16701:25:01

Curious NNRP server explorers [Top 20]:

SystemConn
ddt.demos.su 2758
167.94.138.115 3
prod-beryllium-nyc1-90.do.binaryedge.ninja 3
198.235.24.197 1
198.235.24.29 1
240e:d9:d800:200::d4 1
60.190.248.11 1
80.66.76.121 1
azpdcsc41.stretchoid.com 1
glamorous.monitoring.internet-measurement.com 1
localhost 1
server-0-3.survey.inspici.com 1
TOTAL: 12 2773

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

SystemConn
167.94.138.115 1
60.190.248.11 1
80.66.76.121 1
TOTAL: 3 3

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

CommandCount
#003 1
EHLO www.censys.io 1
GET / HTTP/1.0 1
TOTAL: 3 3

NNRP client timeouts [Top 20]:

SystemConnPeer
167.94.138.115 1 2
60.190.248.11 1 0
80.66.76.121 1 1
TOTAL: 3 3 3

Newsgroup request counts (by hierarchy):

HierarchyCountPct
1news 4100.0%
TOTAL: 1 4100.0%

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

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