Daily Usenet Report

Aug 10 00:01:02 -- Aug 11 00:01:01

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Aug 10 08:17:23 newsfeed innd: message repeated 2 times: [ ctlinnd command s]

Log entries by program:

Program nameLines%LinesSize%Size
innd 8510 28.3%1.2 MB 19.1%
inn 8437 28.1%3.3 MB 53.3%
nnrpd 8411 28.0%856.1 KB 13.4%
innfeed 4182 13.9%815.8 KB 12.8%
cnfsstat 432 1.4%63.1 KB 1.0%
nocem 96 0.3%21.9 KB 0.3%
controlchan 1 0.0%0.2 KB 0.0%
TOTAL: 7 30069 100.0%6.2 MB100.0%

History cache:

ReasonCount%Count
Positive hits 109183 58.4%
Negative hits 69552 37.2%
Do not exist 8019 4.3%
Cache misses 48 0.0%
TOTAL: 4 186802 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.269 0.0%341 0.000 0.789 12.000
article cleanup00:00:00.086 0.0%8057 0.000 0.011 0.077
article logging00:00:00.361 0.0%8116 0.000 0.044 0.192
article parse00:00:00.206 0.0%14696 0.000 0.014 0.071
article write00:00:02.047 0.0%6785 0.000 0.302 3.688
artlog/artcncl00:00:00.012 0.0%328 0.000 0.037 0.333
artlog/artparse00:00:00.000 0.0%1 0.000 0.000 0.000
data move00:00:00.352 0.0%188846 0.000 0.002 0.038
hisgrep/artcncl00:00:00.120 0.0%344 0.000 0.349 12.000
hishave/artcncl00:00:00.018 0.0%328 0.000 0.055 2.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:02:05.861 0.1%187378 0.092 0.672 4.824
history sync00:00:00.428 0.0%395 0.000 1.084 88.750
history write00:01:47.151 0.1%8058 3.218 13.297 131.952
hiswrite/artcncl00:00:00.003 0.0%1 3.000 3.000 3.000
idle23:52:02.571 99.4%189439 88.456 453.563 2345.770
nntp read00:00:02.737 0.0%189314 0.002 0.014 0.236
overview write00:03:41.635 0.3%6785 0.880 32.665 2150.412
perl filter00:00:28.196 0.0%8057 1.730 3.500 32.483
python filter00:00:02.755 0.0%8057 0.000 0.342 8.672
site send00:00:00.927 0.0%13620 0.000 0.068 0.250
TOTAL: 24:01:05.92324:00:15.735 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:04.712 0.0%4661290 0.000 0.001 0.002
article prepare00:00:00.002 0.0%31516 0.000 0.000 0.005
article read00:00:00.768 0.0%3627 0.000 0.212 7.000
backlog stats00:00:02.429 0.0%2643869 0.000 0.001 0.002
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:16.349 0.0%1860028 0.005 0.009 0.024
data write00:00:15.941 0.0%1856349 0.006 0.009 0.018
idle23:47:57.992 99.8%2643869 26.530 32.406 45.494
status file00:00:00.343 0.0%306 0.750 1.121 8.000
TOTAL: 23:50:16.01623:48:38.536 99.9%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:22:27.330 69.3%8350 21.000 161.357 10154.500
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.265 0.0%16757 0.000 0.016 0.333
TOTAL: 00:32:25.44200:22:27.595 69.3%----

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
1outgoing.news.lysator.liu.se 1 6804 1362 5279 163 20%23:59:57
2usenet.goja.nl.eu.org 10 7497 1098 6077 322 14%23:43:36
3endofthelinebbs-out.news.weretis.net 3 13365 972 12217 176 7%51:26:31
4usenet.blueworldhosting.com 719 7837 677 6861 299 8%23:52:05
5nntp.comgw.net 1 7545 635 6727 183 8%23:59:56
6news.hispagatos.org 6 7357 535 6805 17 7%24:26:16
7news.corradoroberto.it 10 1265 435 830 0 34%23:45:40
8newsfeed.bofh.team 1 7972 229 7726 17 2%23:59:55
9i2pn.org 2 7395 219 7163 13 2%23:59:54
10endoftheline-out.news.chmurka.net 2 3598 190 3406 2 5%23:59:41
11news.samoylyk.net 1 6307 152 6153 2 2%23:59:54
12usenet.network 2 5541 151 5389 1 2%23:59:18
13endofthelinebbs.peers.news.panix.com 24 7103 107 6989 7 1%23:54:38
14newsfeed.xs3.de 1 5733 29 5701 3 0%23:59:55
15news.netfront.net 2 10793 23 10671 99 0%43:50:15
16news.bbs.nz 1 6564 22 6542 0 0%23:59:45
17glockenspiel.complete.org 2 5610 9 5601 0 0%23:59:06
18photonic.trudheim.com 4 1883 6 1877 0 0%23:46:54
19news.furie.org.uk 97 3830 2 3827 1 0%23:55:55
20eotl-out.news.tnetconsulting.net 1 0 0 0 0 0%00:10:05
21localhost 9 0 0 0 0 0%00:00:00
22news.nk.ca 2 0 0 0 0 0%00:20:12
23news.nntp4.net 1 0 0 0 0 0%00:10:00
TOTAL: 23 902 123999 6853 115841 1305 5%503:19:28
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.corradoroberto.it5.4 MB0.0 KB0.0 KB5.4 MB100%12.7 KB
2outgoing.news.lysator.liu.se4.8 MB0.0 KB472.6 KB5.2 MB 91%3.5 KB
3endofthelinebbs-out.news.weretis.net3.8 MB0.0 KB246.0 KB4.0 MB 94%3.6 KB
4usenet.goja.nl.eu.org3.5 MB0.0 KB469.9 KB3.9 MB 88%2.8 KB
5nntp.comgw.net2.7 MB0.0 KB563.9 KB3.3 MB 83%4.1 KB
6news.samoylyk.net2.1 MB0.0 KB1.5 KB2.1 MB 99%13.7 KB
7usenet.network2.0 MB0.0 KB2.0 KB2.0 MB 99%13.5 KB
8usenet.blueworldhosting.com1.8 MB0.0 KB571.8 KB2.3 MB 76%2.5 KB
9news.hispagatos.org1.7 MB0.0 KB71.3 KB1.8 MB 96%3.2 KB
10i2pn.org756.8 KB0.0 KB16.0 KB772.8 KB 97%3.3 KB
11endoftheline-out.news.chmurka.net734.3 KB0.0 KB4.7 KB739.0 KB 99%3.8 KB
12newsfeed.bofh.team677.1 KB0.0 KB43.1 KB720.1 KB 94%2.9 KB
13endofthelinebbs.peers.news.panix.com395.4 KB0.0 KB14.3 KB409.8 KB 96%3.6 KB
14newsfeed.xs3.de121.3 KB0.0 KB6.5 KB127.9 KB 94%4.0 KB
15news.netfront.net84.1 KB0.0 KB658.2 KB742.3 KB 11%6.1 KB
16glockenspiel.complete.org61.7 KB0.0 KB0.0 KB61.7 KB100%6.9 KB
17news.bbs.nz58.0 KB0.0 KB0.0 KB58.0 KB100%2.6 KB
18photonic.trudheim.com30.5 KB0.0 KB0.0 KB30.5 KB100%5.1 KB
19news.furie.org.uk6.8 KB0.0 KB0.8 KB7.5 KB 89%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
23news.nntp4.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 2330.5 MB0.0 KB3.1 MB33.5 MB 90%4.2 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 10 00:01:02 - 00:59:59 161 2.4% 0.05849.1 KB 2.8% 0.24
Aug 10 01:00:00 - 01:59:59 305 4.5% 0.083.1 MB 10.2% 0.88
Aug 10 02:00:00 - 02:59:59 282 4.2% 0.081.0 MB 3.4% 0.29
Aug 10 03:00:00 - 03:59:59 381 5.6% 0.111.0 MB 3.4% 0.29
Aug 10 04:00:00 - 04:59:59 397 5.9% 0.111.3 MB 4.3% 0.37
Aug 10 05:00:00 - 05:59:59 321 4.7% 0.091.9 MB 6.4% 0.55
Aug 10 06:00:00 - 06:59:59 373 5.5% 0.101.7 MB 5.5% 0.47
Aug 10 07:00:00 - 07:59:59 363 5.4% 0.104.5 MB 14.9% 1.28
Aug 10 08:00:00 - 08:59:59 345 5.1% 0.101.2 MB 4.0% 0.34
Aug 10 09:00:00 - 09:59:59 307 4.5% 0.091.2 MB 4.0% 0.34
Aug 10 10:00:00 - 10:59:59 351 5.2% 0.101.5 MB 5.0% 0.43
Aug 10 11:00:00 - 11:59:59 319 4.7% 0.09971.9 KB 3.2% 0.27
Aug 10 12:00:00 - 12:59:59 453 6.7% 0.131.8 MB 5.9% 0.50
Aug 10 13:00:00 - 13:59:59 413 6.1% 0.111.5 MB 4.9% 0.42
Aug 10 14:00:00 - 14:59:59 305 4.5% 0.08966.1 KB 3.1% 0.27
Aug 10 15:00:00 - 15:59:59 335 4.9% 0.091.0 MB 3.5% 0.30
Aug 10 16:00:00 - 16:59:59 289 4.3% 0.08994.0 KB 3.2% 0.28
Aug 10 17:00:00 - 17:59:59 267 3.9% 0.07922.2 KB 3.0% 0.26
Aug 10 18:00:00 - 18:59:59 165 2.4% 0.05529.3 KB 1.7% 0.15
Aug 10 19:00:00 - 19:59:59 138 2.0% 0.04434.3 KB 1.4% 0.12
Aug 10 20:00:00 - 20:59:59 89 1.3% 0.02306.1 KB 1.0% 0.09
Aug 10 21:00:00 - 21:59:59 156 2.3% 0.04473.9 KB 1.5% 0.13
Aug 10 22:00:00 - 22:59:59 122 1.8% 0.03508.5 KB 1.6% 0.14
Aug 10 23:00:00 - 23:59:59 140 2.1% 0.04605.3 KB 2.0% 0.17
Aug 11 00:00:00 - 00:01:01 5 0.1% 0.0810.3 KB 0.0% 0.17
TOTAL: 23:59:59 6782 100.0% 0.0830.1 MB 100.0% 0.36
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 GB96.1 GB 6.3% 0 0.5236182.92
CYCTXT1TEXT5.0 GB3.6 GB 72.5% 0 0.03 1959.18
TOTAL: 3-3077.0 GB99.7 GB 3.2% 1 0.38-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1usenet.goja.nl.eu.org 352 0 0 0 0 0 0 0 352
2usenet.blueworldhosting.com 324 1 0 0 0 0 0 0 323
3nntp.comgw.net 181 0 0 0 0 0 0 0 181
4endofthelinebbs-out.news.weretis.net 180 0 0 0 0 0 0 0 180
5outgoing.news.lysator.liu.se 167 0 0 0 0 0 0 0 167
6news.netfront.net 61 0 0 0 0 0 0 0 61
7newsfeed.bofh.team 18 0 0 0 0 0 0 0 18
8news.hispagatos.org 15 0 0 0 0 0 0 0 15
9i2pn.org 14 0 0 0 0 0 0 0 14
10endofthelinebbs.peers.news.panix.com 9 0 0 0 0 0 0 0 9
11news.samoylyk.net 3 0 0 0 0 0 0 0 3
12newsfeed.xs3.de 3 0 0 0 0 0 0 0 3
13endoftheline-out.news.chmurka.net 2 0 0 0 0 0 0 0 2
14news.furie.org.uk 1 0 0 0 0 0 0 0 1
15usenet.network 1 0 0 0 0 0 0 0 1
TOTAL: 15 1331 1 0 0 0 0 0 0 1330

Unwanted newsgroups [Top 20]:

NewsgroupCount
help.gnu.emacs 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (phn path) 708
EMP (phr path) 325
Too many newsgroups 72
EMP (md5) 63
EMP (phn nph) 52
EMP (phl) 26
User-issued cancel 17
EMP (fsl) 3
HTML Multipart 3
Cancel for rejected article 1
TOTAL: 10 1270

NoCeM on Spool:

Issuer (type)NoticesBad PGPCancelSkipTotal
i2pn2-nocem@i2pn2.org (spam)4403180318
nocem@eternal-september.org (bot)10101
robot@pasdenom.info (spam)10101
robot@pasdenom.info (spam3)20033
robot@pasdenom.info (spam2)10011
TOTAL: 54903204324

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
usenet.blueworldhosting.com 25
endofthelinebbs-out.news.weretis.net 18
usenet.goja.nl.eu.org 6
outgoing.news.lysator.liu.se 4
nntp.comgw.net 3
endofthelinebbs.peers.news.panix.com 2
newsfeed.bofh.team 1
TOTAL: 7 59
No colon-space in header field
usenet.blueworldhosting.com 1
TOTAL: 1 1
TOTAL: 2 60

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.netfront.net 10349 2548 4215 0 0 44 24%23:59:52
2nyheter.lysator.liu.se 5653 859 4244 314 0 0 15%23:59:52
3news.furie.org.uk 4227 426 3035 18 0 0 10%23:59:52
4photonic.trudheim.com 7295 373 5915 482 0 0 5%23:59:35
5news.hispagatos.org 7077 304 5815 102 0 0 4%23:59:43
6usenet.network 7064 265 5995 26 0 2 3%23:58:28
7usenet.goja.nl.eu.org 6212 182 5358 60 0 5 2%23:57:18
8news.nk.ca 10055 152 6122 419 0 67 1%23:59:52
9news.bbs.nz 12731 140 6415 213 0 199 1%23:59:51
10news.tnetconsulting.net 7732 86 6610 69 0 26 1%23:59:32
11newsfeed.bofh.team 7081 82 6416 0 0 0 1%23:59:42
12i2pn.org 7758 77 6395 53 0 156 0%23:59:43
13news.quux.org 7291 62 6500 208 0 8 0%23:59:52
14news.weretis.net 7078 61 6657 63 0 10 0%23:59:51
15nntp.comgw.net 6675 52 6078 24 0 2 0%23:59:52
16news.corradoroberto.it 723 51 555 3 0 4 7%22:25:46
17news.chmurka.net 3706 39 3131 0 0 0 1%23:59:52
18newsfeed.xs3.de 7512 35 6644 55 0 8 0%23:59:52
19news.samoylyk.net 7481 29 6579 16 0 63 0%23:59:52
20usenet.blueworldhosting.com 6300 4 5936 0 0 8 0%23:58:22
21news.nntp4.net4692031 0 0 0 04692004 0%23:59:52
22endofthelinebbs.peers.news.panix.com 0 0 0 0 0 6766 0%23:59:52
23feed.opticnetworks.net 0 0 0 0 0 6782 0%23:59:45
TOTAL: 234832031 5827 108615 2125 04706154 0%550:16:08
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.netfront.net13.5 MB0.0 KB13.5 MB0.2 KB/s5.4 KB23:59:52
2nyheter.lysator.liu.se4.8 MB1.8 MB6.6 MB0.1 KB/s5.8 KB23:59:52
3news.furie.org.uk3.3 MB375.1 KB3.6 MB0.0 KB/s8.4 KB23:59:52
4photonic.trudheim.com2.8 MB1.5 MB4.3 MB0.1 KB/s5.2 KB23:59:35
5news.hispagatos.org1.3 MB662.4 KB2.0 MB0.0 KB/s5.0 KB23:59:43
6news.quux.org1.2 MB821.1 KB2.0 MB0.0 KB/s7.5 KB23:59:52
7usenet.network1.1 MB55.2 KB1.2 MB0.0 KB/s4.1 KB23:58:28
8news.samoylyk.net995.5 KB262.5 KB1.2 MB0.0 KB/s28.0 KB23:59:52
9newsfeed.bofh.team658.1 KB0.0 KB658.1 KB0.0 KB/s8.0 KB23:59:42
10i2pn.org534.6 KB417.3 KB951.9 KB0.0 KB/s7.3 KB23:59:43
11news.tnetconsulting.net529.1 KB491.8 KB1020.9 KB0.0 KB/s6.6 KB23:59:32
12usenet.goja.nl.eu.org515.6 KB518.6 KB1.0 MB0.0 KB/s4.3 KB23:57:18
13news.bbs.nz483.9 KB2.2 MB2.6 MB0.0 KB/s7.7 KB23:59:51
14news.weretis.net376.4 KB1.8 MB2.1 MB0.0 KB/s17.6 KB23:59:51
15nntp.comgw.net295.8 KB1007.3 KB1.3 MB0.0 KB/s17.1 KB23:59:52
16news.nk.ca292.0 KB2.2 MB2.5 MB0.0 KB/s4.5 KB23:59:52
17newsfeed.xs3.de268.7 KB1.1 MB1.4 MB0.0 KB/s15.8 KB23:59:52
18news.corradoroberto.it204.2 KB5.9 KB210.1 KB0.0 KB/s3.9 KB22:25:46
19news.chmurka.net110.1 KB0.0 KB110.1 KB0.0 KB/s2.8 KB23:59:52
20usenet.blueworldhosting.com16.6 KB0.0 KB16.6 KB0.0 KB/s4.2 KB23:58:22
21endofthelinebbs.peers.news.panix.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:52
22feed.opticnetworks.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:45
23news.nntp4.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:52
TOTAL: 2333.2 MB15.1 MB48.3 MB0.0 KB/s6.2 KB550:16:08
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ddt.demos.su2782 00.0 KB 0 0 000:31:25
2167.94.146.56 3 00.0 KB 0 0 000:00:03
3104.152.52.216 1 00.0 KB 0 0 000:00:00
4104.152.52.224 1 00.0 KB 0 0 000:00:10
5104.168.58.11 1 00.0 KB 0 0 000:00:10
6147.185.132.177 1 00.0 KB 0 0 000:00:10
7205.210.31.146 1 00.0 KB 0 0 000:00:01
869.12.83.50 1 00.0 KB 0 0 000:00:20
980.66.76.134 1 00.0 KB 0 0 000:00:00
10delightful.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
TOTAL: 102793 00.0 KB 0 0 000:32:23

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.demos.su2782 00.0 KB 0 0 000:31:25
2unresolved 10 00.0 KB 0 0 000:00:56
3*.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
TOTAL: 32793 00.0 KB 0 0 000:32:23

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
ddt.demos.su 9.954 37.672 0.00000:31:25
69.12.83.50 0.007 0.010 0.00000:00:20
104.168.58.11 0.004 0.013 0.00000:00:10
104.152.52.224 0.000 0.016 0.00000:00:10
147.185.132.177 0.000 0.016 0.00000:00:10
167.94.146.56 0.031 0.040 0.00000:00:03
delightful.monitoring.internet-measurement.com 0.000 0.016 0.00000:00:01
205.210.31.146 0.004 0.012 0.00000:00:01
80.66.76.134 0.005 0.011 0.00000:00:00
104.152.52.216 0.003 0.013 0.00000:00:00
TOTAL: 10 10.008 37.819 0.00000:32:23

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

SystemConn
69.12.83.50 3
167.94.146.56 1
80.66.76.134 1
TOTAL: 3 5

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

CommandCount
#003 1
#023#001#023#002#023#003#001 1
#026#003#001 1
EHLO www.censys.io 1
À#024 1
TOTAL: 5 5

NNRP client timeouts [Top 20]:

SystemConnPeer
167.94.146.56 1 2
69.12.83.50 1 1
80.66.76.134 1 1
TOTAL: 3 3 5
innreport from INN 2.8.0 (20240622 prerelease) based on initial work (©) 1996-2001 by Fabien Tassin <fta@sofaraway.org> and enhanced by several contributors since then