Daily Usenet Report

Dec 21 00:01:01 -- Dec 22 00:01:01

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Dec 21 08:19:30 newsfeed innd: message repeated 2 times: [ ctlinnd command s]
Dec 22 00:00:01 newsfeed nnrpd[852545]: localhost auth: program exited with status 8

Log entries by program:

Program nameLines%LinesSize%Size
inn 9031 39.3%3.3 MB 60.1%
innd 8839 38.5%1.3 MB 23.4%
innfeed 4468 19.4%834.7 KB 14.8%
cnfsstat 432 1.9%68.5 KB 1.2%
nnrpd 164 0.7%17.2 KB 0.3%
nocem 41 0.2%5.5 KB 0.1%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 7 22976 100.0%5.5 MB100.0%

History cache:

ReasonCount%Count
Positive hits 107448 66.0%
Negative hits 46424 28.5%
Do not exist 8923 5.5%
Cache misses 30 0.0%
TOTAL: 4 162825 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.140 0.0%28 0.000 5.000 14.000
article cleanup00:00:00.214 0.0%8973 0.000 0.024 0.742
article logging00:00:00.419 0.0%9028 0.000 0.046 0.288
article parse00:00:00.245 0.0%13805 0.000 0.018 0.263
article write00:00:02.029 0.0%6447 0.000 0.315 3.214
artlog/artcncl00:00:00.000 0.0%6 0.000 0.000 0.000
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:01.746 0.0%165911 0.000 0.011 0.476
hisgrep/artcncl00:00:00.115 0.0%29 0.000 3.966 12.000
hishave/artcncl00:00:00.001 0.0%6 0.000 0.167 0.500
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:41.725 0.2%163542 0.124 0.989 6.124
history sync00:00:00.065 0.0%399 0.000 0.163 1.000
history write00:02:12.536 0.2%8962 2.974 14.789 130.812
hiswrite/artcncl00:00:00.001 0.0%1 1.000 1.000 1.000
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:46:12.929 99.0%159962 80.554 534.958 3895.838
nntp read00:00:03.758 0.0%167020 0.003 0.023 0.358
overview write00:08:09.667 0.6%6447 0.696 75.953 3075.574
perl filter00:00:49.453 0.1%8956 1.250 5.522 103.756
python filter00:00:02.466 0.0%8956 0.000 0.275 4.207
site send00:00:01.090 0.0%12931 0.000 0.084 0.307
TOTAL: 24:01:03.53324:00:18.599 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.025 0.0%6687 0.000 0.004 0.056
article prepare00:00:00.005 0.0%52428 0.000 0.000 0.003
article read00:00:00.844 0.0%5095 0.000 0.166 1.595
backlog stats00:00:00.357 0.0%233076 0.000 0.002 0.008
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.191 0.0%154036 0.000 0.014 0.061
data write00:00:02.883 0.0%150411 0.000 0.019 0.038
idle23:57:46.281100.0%233076 170.495 370.121 2084.163
status file00:00:00.597 0.0%440 0.833 1.357 12.000
TOTAL: 23:58:04.16223:57:53.183100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:01:19.505 9.7%52 0.000 1528.942 10052.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:04.158 0.5%79012 0.000 0.053 0.500
TOTAL: 00:13:43.08700:01:23.663 10.2%----

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 3 13630 1907 11195 528 13%49:08:19
2glockenspiel.complete.org 2 5336 1575 3757 4 29%25:35:49
3usenet.blueworldhosting.com 566 8727 837 6688 1202 9%23:37:59
4news.corradoroberto.it 11 1036 439 597 0 42%22:52:07
5nntp.comgw.net 2 8362 308 7809 245 3%23:57:21
6usenet.goja.nl.eu.org 11 7979 289 7548 142 3%22:13:27
7i2pn.org 2 8029 224 7660 145 2%23:59:53
8194.87.241.33 38 342 214 127 1 62%16:34:56
9newsfeed.bofh.team 2 8634 205 8380 49 2%23:59:37
10usenet.network 1 5848 124 5722 2 2%23:59:58
11news.nntp4.net 2 6258 109 6140 9 1%23:58:40
12endoftheline-out.news.chmurka.net 2 3376 95 3280 1 2%23:59:49
13news.netfront.net 2 7459 87 7216 156 1%25:23:58
14newsfeed.xs3.de 1 5854 76 5773 5 1%23:59:55
15endofthelinebbs.peers.news.panix.com 27 7342 44 7290 8 0%23:52:04
16news.bbs.nz 2 6732 13 6717 2 0%23:59:13
17news.hispagatos.org 5 8189 8 8153 28 0%24:26:19
18news.furie.org.uk 1 3274 6 3268 0 0%23:59:57
19outgoing.news.lysator.liu.se 4 2111 4 2106 1 0%23:30:04
20eotl-out.news.tnetconsulting.net 1 0 0 0 0 0%00:10:08
21localhost 29 0 0 0 0 0%00:00:00
22news.nk.ca 2 0 0 0 0 0%00:20:11
TOTAL: 22 716 118518 6564 109426 2528 5%473:39:44
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1endofthelinebbs-out.news.weretis.net6.7 MB11.9 KB878.4 KB7.6 MB 88%3.2 KB
2glockenspiel.complete.org4.6 MB6.0 KB2.6 KB4.6 MB 99%3.0 KB
3nntp.comgw.net3.0 MB5.9 KB369.0 KB3.4 MB 89%6.2 KB
4news.corradoroberto.it2.8 MB0.0 KB0.0 KB2.8 MB100%6.4 KB
5194.87.241.332.0 MB0.0 KB1.7 KB2.0 MB 99%9.5 KB
6usenet.blueworldhosting.com2.0 MB0.0 KB2.4 MB4.3 MB 45%2.2 KB
7usenet.network1.9 MB598.0 KB1.2 KB2.4 MB 75%19.8 KB
8i2pn.org1.1 MB0.0 KB208.4 KB1.3 MB 84%3.6 KB
9usenet.goja.nl.eu.org826.5 KB5.9 KB207.7 KB1.0 MB 79%2.4 KB
10newsfeed.bofh.team553.8 KB0.0 KB91.4 KB645.3 KB 85%2.5 KB
11newsfeed.xs3.de396.5 KB0.0 KB11.5 KB408.0 KB 97%5.0 KB
12endoftheline-out.news.chmurka.net307.3 KB0.0 KB0.8 KB308.0 KB 99%3.2 KB
13news.nntp4.net274.8 KB5.9 KB16.2 KB296.9 KB 92%2.5 KB
14news.netfront.net157.4 KB0.0 KB548.3 KB705.7 KB 22%2.9 KB
15endofthelinebbs.peers.news.panix.com112.4 KB6.0 KB8.0 KB126.3 KB 88%2.4 KB
16news.furie.org.uk59.4 KB0.0 KB0.0 KB59.4 KB100%9.9 KB
17news.bbs.nz37.4 KB6.0 KB1.2 KB44.5 KB 83%3.0 KB
18news.hispagatos.org15.4 KB6.0 KB39.1 KB60.5 KB 25%1.7 KB
19outgoing.news.lysator.liu.se6.1 KB6.0 KB0.0 KB12.1 KB 50%2.4 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: 2226.6 MB657.6 KB4.7 MB31.9 MB 83%3.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Dec 21 00:01:01 - 00:59:59 118 1.8% 0.03606.6 KB 2.3% 0.17
Dec 21 01:00:00 - 01:59:59 226 3.5% 0.062.0 MB 7.6% 0.56
Dec 21 02:00:00 - 02:59:59 294 4.6% 0.081.1 MB 4.1% 0.31
Dec 21 03:00:00 - 03:59:59 286 4.4% 0.081.1 MB 4.2% 0.31
Dec 21 04:00:00 - 04:59:59 359 5.6% 0.101.1 MB 4.3% 0.31
Dec 21 05:00:00 - 05:59:59 318 4.9% 0.091.6 MB 6.0% 0.44
Dec 21 06:00:00 - 06:59:59 320 5.0% 0.09918.4 KB 3.5% 0.26
Dec 21 07:00:00 - 07:59:59 326 5.1% 0.09961.3 KB 3.6% 0.27
Dec 21 08:00:00 - 08:59:59 337 5.2% 0.091.4 MB 5.3% 0.39
Dec 21 09:00:00 - 09:59:59 419 6.5% 0.121.4 MB 5.4% 0.40
Dec 21 10:00:00 - 10:59:59 345 5.4% 0.101.1 MB 4.1% 0.30
Dec 21 11:00:00 - 11:59:59 437 6.8% 0.121.4 MB 5.5% 0.40
Dec 21 12:00:00 - 12:59:59 382 5.9% 0.111.6 MB 6.2% 0.46
Dec 21 13:00:00 - 13:59:59 320 5.0% 0.091.4 MB 5.5% 0.40
Dec 21 14:00:00 - 14:59:59 352 5.5% 0.101.6 MB 6.0% 0.45
Dec 21 15:00:00 - 15:59:59 316 4.9% 0.091.0 MB 3.9% 0.28
Dec 21 16:00:00 - 16:59:59 305 4.7% 0.081.0 MB 4.0% 0.29
Dec 21 17:00:00 - 17:59:59 278 4.3% 0.081.6 MB 6.3% 0.47
Dec 21 18:00:00 - 18:59:59 182 2.8% 0.05550.2 KB 2.1% 0.15
Dec 21 19:00:00 - 19:59:59 143 2.2% 0.041.2 MB 4.7% 0.35
Dec 21 20:00:00 - 20:59:59 88 1.4% 0.02382.9 KB 1.4% 0.11
Dec 21 21:00:00 - 21:59:59 94 1.5% 0.03475.3 KB 1.8% 0.13
Dec 21 22:00:00 - 22:59:59 89 1.4% 0.02322.4 KB 1.2% 0.09
Dec 21 23:00:00 - 23:59:59 109 1.7% 0.03323.2 KB 1.2% 0.09
Dec 22 00:00:00 - 00:01:01 4 0.1% 0.0712.7 KB 0.0% 0.21
TOTAL: 24:00:00 6447 100.0% 0.0726.0 MB 100.0% 0.31
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 GB101.4 GB 6.6% 0 0.4640383.89
CYCTXT1TEXT5.0 GB4.0 GB 79.7% 0 0.03 2063.55
TOTAL: 3-3077.0 GB105.4 GB 3.4% 1 0.33-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1usenet.blueworldhosting.com 1216 0 0 0 0 0 0 0 1216
2endofthelinebbs-out.news.weretis.net 550 0 0 2 0 0 0 0 548
3nntp.comgw.net 255 0 0 1 0 0 0 0 254
4i2pn.org 149 0 0 0 0 0 0 0 149
5usenet.goja.nl.eu.org 148 0 0 1 0 0 0 0 147
6news.netfront.net 135 0 0 0 0 0 0 0 135
7newsfeed.bofh.team 51 0 0 0 0 0 0 0 51
8news.hispagatos.org 29 14 0 1 0 0 0 0 14
9glockenspiel.complete.org 9 0 0 1 0 0 0 0 8
10news.nntp4.net 9 0 0 1 0 0 0 0 8
11endofthelinebbs.peers.news.panix.com 8 0 0 1 0 0 0 0 7
12newsfeed.xs3.de 7 0 0 0 0 0 0 0 7
13news.bbs.nz 5 0 0 1 0 0 0 0 4
14news.corradoroberto.it 2 0 0 0 0 0 0 0 2
15usenet.network 2 0 0 1 0 0 0 0 1
16194.87.241.33 1 0 0 0 0 0 0 0 1
17endoftheline-out.news.chmurka.net 1 0 0 0 0 0 0 0 1
18outgoing.news.lysator.liu.se 1 0 0 1 0 0 0 0 0
TOTAL: 18 2578 14 0 11 0 0 0 0 2553

Unwanted newsgroups [Top 20]:

NewsgroupCount
hispagatos.mastodon.tag.hacking 12
hispagatos.hacking.news 1
hispagatos.mastodon.tag.hackers 1
TOTAL: 3 14

INND Perl filter [Top 20]:

ReasonCount
EMP (phn path) 1709
EMP (phr path) 348
EMP (md5) 247
Too many newsgroups 107
EMP (fsl) 37
Too many newsgroups (meow) 24
User-issued cancel 14
Binary: misplaced binary 3
EMP (phn nph) 2
hierarchy violation - crosspost outside sdnet 1
TOTAL: 10 2492

NoCeM on Spool:

Issuer (type)NoticesBad PGPCancelSkipTotal
i2pn2-nocem@i2pn2.org (spam)30404
i2pn2-nocem@i2pn2.org (multipost)16001919
i2pn2-nocem@i2pn2.org (rmp)9001414
robot@pasdenom.info (spam3)50088
robot@pasdenom.info (spam2)40044
TOTAL: 537044549

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Article posted in the future
usenet.blueworldhosting.com 6
TOTAL: 1 6
Including strange strings
endofthelinebbs-out.news.weretis.net 25
usenet.blueworldhosting.com 15
glockenspiel.complete.org 6
usenet.goja.nl.eu.org 3
nntp.comgw.net 2
news.corradoroberto.it 2
newsfeed.xs3.de 1
endofthelinebbs.peers.news.panix.com 1
TOTAL: 8 55
TOTAL: 2 61

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nyheter.lysator.liu.se 6797 4255 2009 179 0 0 62%23:59:40
2news.netfront.net 10298 1811 4547 1 0 18 17%23:58:08
3endofthelinebbs.peers.news.panix.com 6630 1048 5360 19 0 0 15%23:58:24
4news.furie.org.uk 4001 765 2208 11 0 0 19%23:58:31
5news.hispagatos.org 8350 469 5826 120 0 7 5%23:59:52
6usenet.goja.nl.eu.org 7197 431 5587 78 0 0 5%23:59:38
7newsfeed.bofh.team 7242 259 5964 0 0 0 3%23:59:52
8news.corradoroberto.it 1032 246 448 0 0 0 23%22:44:58
9usenet.network 8492 226 5843 16 0 0 2%23:59:09
10news.tnetconsulting.net 7215 206 6046 174 0 10 2%23:59:30
11news.quux.org 4965 201 4104 360 0 0 4%23:59:52
12news.nntp4.net 7331 199 6095 9 0 0 2%23:59:33
13news.bbs.nz 11872 193 5899 330 0 81 1%23:59:52
14news.weretis.net 6721 190 6145 111 0 3 2%23:59:50
15i2pn.org 7115 166 5973 41 0 62 2%23:59:23
16nntp.comgw.net 6781 163 5896 72 0 0 2%23:59:52
17newsfeed.xs3.de 7857 118 6072 156 0 0 1%23:59:52
18news.nk.ca 8708 73 5885 401 0 26 0%23:59:52
19ddt.demos.su 91 19 70 0 0 0 20%08:40:12
20news.chmurka.net 4077 11 2955 0 0 6 0%23:58:33
21usenet.blueworldhosting.com 5898 8 5423 0 0 31 0%23:59:53
22feed.opticnetworks.net 0 0 0 0 0 6447 0%23:59:52
23news.samoylyk.net 0 0 0 0 0 6447 0%23:59:53
24photonic.trudheim.com 0 0 0 0 0 6424 0%23:59:52
TOTAL: 24 138670 11057 98355 2078 0 19562 7%559:14:03
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nyheter.lysator.liu.se19.4 MB1.2 MB20.6 MB0.2 KB/s4.8 KB23:59:40
2news.netfront.net11.8 MB1.9 KB11.8 MB0.1 KB/s6.7 KB23:58:08
3news.furie.org.uk5.6 MB117.1 KB5.7 MB0.1 KB/s7.6 KB23:58:31
4news.quux.org3.8 MB1.1 MB4.9 MB0.1 KB/s8.9 KB23:59:52
5endofthelinebbs.peers.news.panix.com3.4 MB136.6 KB3.5 MB0.0 KB/s3.4 KB23:58:24
6news.hispagatos.org2.5 MB1.1 MB3.6 MB0.0 KB/s6.3 KB23:59:52
7newsfeed.bofh.team1.9 MB0.0 KB1.9 MB0.0 KB/s7.4 KB23:59:52
8news.nntp4.net1.3 MB70.0 KB1.4 MB0.0 KB/s6.8 KB23:59:33
9nntp.comgw.net1.3 MB2.6 MB3.9 MB0.0 KB/s16.9 KB23:59:52
10news.weretis.net1.1 MB3.4 MB4.5 MB0.1 KB/s15.3 KB23:59:50
11usenet.goja.nl.eu.org1.1 MB647.3 KB1.8 MB0.0 KB/s3.6 KB23:59:38
12news.bbs.nz1.1 MB3.0 MB4.0 MB0.0 KB/s7.8 KB23:59:52
13news.tnetconsulting.net970.0 KB978.1 KB1.9 MB0.0 KB/s5.1 KB23:59:30
14usenet.network890.1 KB43.5 KB933.6 KB0.0 KB/s3.9 KB23:59:09
15newsfeed.xs3.de862.9 KB1.0 MB1.9 MB0.0 KB/s6.9 KB23:59:52
16ddt.demos.su852.7 KB0.0 KB852.7 KB0.0 KB/s44.9 KB08:40:12
17news.corradoroberto.it615.9 KB0.0 KB615.9 KB0.0 KB/s2.5 KB22:44:58
18i2pn.org573.6 KB167.6 KB741.2 KB0.0 KB/s3.6 KB23:59:23
19news.nk.ca194.8 KB3.9 MB4.1 MB0.0 KB/s8.9 KB23:59:52
20usenet.blueworldhosting.com66.7 KB0.0 KB66.7 KB0.0 KB/s8.3 KB23:59:53
21news.chmurka.net43.3 KB0.0 KB43.3 KB0.0 KB/s3.9 KB23:58:33
22feed.opticnetworks.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:52
23news.samoylyk.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:53
24photonic.trudheim.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:52
TOTAL: 2459.2 MB19.4 MB78.6 MB0.0 KB/s6.1 KB559:14:03
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1167.94.138.194 5 00.0 KB 0 0 000:00:07
2206.168.34.70 5 00.0 KB 0 0 000:00:54
3152.32.236.116 3 00.0 KB 0 0 000:00:10
4167.94.146.60 3 00.0 KB 0 0 000:00:03
5185.91.127.81 3 00.0 KB 0 0 000:00:00
6185.7.214.101 2 00.0 KB 0 0 000:00:10
7147.185.132.159 1 00.0 KB 0 0 000:00:09
8183.216.120.128 1 00.0 KB 0 0 000:00:01
9198.235.24.176 1 00.0 KB 0 0 000:00:10
10206.168.34.218 1 00.0 KB 0 0 000:00:18
11206.168.34.63 1 00.0 KB 0 0 000:00:16
12azpdcgc19.stretchoid.com 1 00.0 KB 0 0 000:00:00
13azpdcsb30.stretchoid.com 1 00.0 KB 0 0 000:00:09
14hopeful.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
15localhost 1 00.0 KB 0 0 000:11:09
TOTAL: 15 30 00.0 KB 0 0 000:13:43

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 26 00.0 KB 0 0 000:02:22
2*.stretchoid.com 2 00.0 KB 0 0 000:00:10
3*.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
4? 1 00.0 KB 0 0 000:11:09
TOTAL: 4 30 00.0 KB 0 0 000:13:43

NNRP auth users [Top 20]:

UserConn
getlist 1
TOTAL: 1 1

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
localhost 181.849 372.800 0.08000:11:09
206.168.34.70 0.050 0.122 0.00000:00:54
206.168.34.218 0.014 0.023 0.00000:00:18
206.168.34.63 0.014 0.014 0.00000:00:16
185.7.214.101 0.005 0.027 0.00000:00:10
152.32.236.116 0.019 0.043 0.00000:00:10
198.235.24.176 0.007 0.010 0.00000:00:10
azpdcsb30.stretchoid.com 0.003 0.013 0.00000:00:09
147.185.132.159 0.010 0.027 0.00000:00:09
167.94.138.194 0.036 0.057 0.00000:00:07
167.94.146.60 0.009 0.055 0.00000:00:03
hopeful.monitoring.internet-measurement.com 0.004 0.058 0.00000:00:01
183.216.120.128 0.004 0.015 0.00000:00:01
185.91.127.81 0.006 0.047 0.00000:00:00
azpdcgc19.stretchoid.com 0.011 0.005 0.00000:00:00
TOTAL: 15 182.041 373.316 0.08000:13:43

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

SystemConn
206.168.34.70 5
185.91.127.81 4
152.32.236.116 3
167.94.138.194 2
167.94.146.60 1
185.7.214.101 1
206.168.34.218 1
206.168.34.63 1
azpdcgc19.stretchoid.com 1
TOTAL: 9 19

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

CommandCount
EHLO www.censys.io 5
#026#003#001 2
#003 1
#023#003#023#001#023#002#001 1
#026#003#001#001#027#001 1
CONNECT api.ip.pn:443 HTTP/1.1 1
Connection: close 1
GET / HTTP/1.1 1
Host: 144.172.126.95:119 1
Host: api.ip.pn 1
MGLNDD_144.172.126.95_119 1
User-Agent: Mozilla/5.0 1
À#024 1
ÖÑä 1
TOTAL: 14 19

NNRP client timeouts [Top 20]:

SystemConnPeer
206.168.34.70 3 3
167.94.138.194 1 3
167.94.146.60 1 2
185.7.214.101 1 1
TOTAL: 4 6 12