Daily Usenet Report

Aug 17 00:01:02 -- Aug 18 00:01:01

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Aug 17 08:15:49 newsfeed innd: message repeated 2 times: [ ctlinnd command s]

Log entries by program:

Program nameLines%LinesSize%Size
inn 8339 28.5%3.4 MB 54.3%
nnrpd 8326 28.5%841.5 KB 13.2%
innd 7922 27.1%1.1 MB 17.9%
innfeed 4068 13.9%831.1 KB 13.0%
cnfsstat 432 1.5%66.8 KB 1.0%
nocem 123 0.4%31.7 KB 0.5%
controlchan 1 0.0%0.2 KB 0.0%
TOTAL: 7 29211 100.0%6.2 MB100.0%

History cache:

ReasonCount%Count
Positive hits 106476 59.9%
Negative hits 63261 35.6%
Do not exist 7808 4.4%
Cache misses 76 0.0%
TOTAL: 4 177621 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.420 0.0%472 0.000 0.890 11.000
article cleanup00:00:00.130 0.0%7850 0.000 0.017 0.262
article logging00:00:00.409 0.0%7883 0.000 0.052 0.212
article parse00:00:00.191 0.0%11561 0.000 0.017 0.191
article write00:00:02.080 0.0%6855 0.000 0.303 2.796
artlog/artcncl00:00:00.011 0.0%438 0.000 0.025 0.250
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:01.107 0.0%180487 0.000 0.006 0.685
hisgrep/artcncl00:00:00.174 0.0%452 0.000 0.385 8.000
hishave/artcncl00:00:00.044 0.0%441 0.000 0.100 1.870
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:02:19.177 0.2%178626 0.090 0.779 5.276
history sync00:00:00.084 0.0%401 0.000 0.209 1.667
history write00:01:44.644 0.1%7845 3.096 13.339 110.632
hiswrite/artcncl00:00:00.060 0.0%20 3.000 3.000 3.000
idle23:39:04.560 98.9%179893 91.982 473.307 1618.849
nntp read00:00:03.144 0.0%181028 0.005 0.017 0.136
overview write00:10:18.691 0.7%6855 0.714 90.254 10969.393
perl filter00:00:38.547 0.0%7845 1.517 4.914 46.667
python filter00:00:05.282 0.0%7845 0.000 0.673 21.884
site send00:00:00.898 0.0%13771 0.000 0.065 0.241
TOTAL: 23:55:18.89023:54:19.653 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:04.719 0.0%4898574 0.000 0.001 0.002
article prepare00:00:00.005 0.0%43416 0.000 0.000 0.006
article read00:00:00.504 0.0%3860 0.000 0.131 0.400
backlog stats00:00:02.358 0.0%2576262 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:14.584 0.0%1748187 0.005 0.008 0.026
data write00:00:15.728 0.0%1745159 0.006 0.009 0.018
idle23:46:53.263 99.8%2576262 27.124 33.232 66.083
status file00:00:00.293 0.0%234 0.750 1.252 9.000
TOTAL: 23:50:10.23623:47:31.454 99.8%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:22:20.887 70.5%8263 13.000 162.276 10049.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.246 0.0%16587 0.000 0.015 1.000
TOTAL: 00:31:41.76200:22:21.133 70.5%----

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 12348 1881 10128 339 15%44:38:27
2outgoing.news.lysator.liu.se 2 6322 1389 4891 42 21%23:59:55
3usenet.blueworldhosting.com 720 7614 816 6582 216 10%23:49:57
4nntp.comgw.net 2 7169 541 6450 178 7%23:59:43
5news.corradoroberto.it 6 1283 494 789 0 38%23:12:34
6news.hispagatos.org 6 6965 492 6455 18 7%24:26:11
7i2pn.org 2 6960 230 6722 8 3%23:59:42
8usenet.goja.nl.eu.org 10 6997 201 6767 29 2%22:24:27
9newsfeed.bofh.team 2 7680 179 7494 7 2%23:59:54
10usenet.network 1 5570 178 5392 0 3%23:59:58
11newsfeed.xs3.de 1 5757 132 5583 42 2%23:59:55
12endofthelinebbs.peers.news.panix.com 28 7544 130 7397 17 1%24:34:20
13endoftheline-out.news.chmurka.net 2 3853 110 3739 4 2%23:59:36
14news.samoylyk.net 2 6410 31 6377 2 0%23:58:56
15news.netfront.net 2 7078 15 6948 115 0%31:47:08
16news.bbs.nz 1 6569 12 6556 1 0%23:59:35
17glockenspiel.complete.org 2 5791 9 5782 0 0%23:56:33
18news.furie.org.uk 1 4097 3 4093 1 0%23:59:54
19photonic.trudheim.com 3 2030 3 2027 0 0%27:29:10
20eotl-out.news.tnetconsulting.net 1 0 0 0 0 0%00:10:05
21localhost 10 0 0 0 0 0%00:00:01
22news.nk.ca 2 0 0 0 0 0%00:20:15
23news.nntp4.net 1 0 0 0 0 0%00:10:00
TOTAL: 23 810 118037 6846 110172 1019 5%486:56:16
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1endofthelinebbs-out.news.weretis.net5.7 MB0.0 KB586.8 KB6.2 MB 90%2.9 KB
2outgoing.news.lysator.liu.se4.9 MB0.0 KB72.9 KB5.0 MB 98%3.6 KB
3usenet.network2.6 MB0.0 KB0.0 KB2.6 MB100%14.9 KB
4news.corradoroberto.it2.5 MB0.0 KB0.0 KB2.5 MB100%5.2 KB
5usenet.blueworldhosting.com2.1 MB0.0 KB719.5 KB2.8 MB 74%2.8 KB
6nntp.comgw.net1.7 MB0.0 KB463.9 KB2.2 MB 79%3.1 KB
7news.hispagatos.org1.5 MB0.0 KB34.4 KB1.6 MB 97%3.1 KB
8i2pn.org990.4 KB0.0 KB13.5 KB1003.9 KB 98%4.2 KB
9usenet.goja.nl.eu.org590.8 KB0.0 KB35.7 KB626.5 KB 94%2.7 KB
10newsfeed.xs3.de509.1 KB0.0 KB168.4 KB677.5 KB 75%3.9 KB
11newsfeed.bofh.team453.8 KB6.0 KB17.2 KB477.1 KB 95%2.6 KB
12endoftheline-out.news.chmurka.net446.0 KB7.8 KB7.2 KB461.0 KB 96%4.0 KB
13endofthelinebbs.peers.news.panix.com365.5 KB6.0 KB98.4 KB469.8 KB 77%3.2 KB
14news.samoylyk.net93.5 KB0.0 KB1.5 KB95.0 KB 98%2.9 KB
15glockenspiel.complete.org65.0 KB0.0 KB0.0 KB65.0 KB100%7.2 KB
16news.netfront.net49.4 KB0.0 KB1.1 MB1.2 MB 4%9.4 KB
17news.bbs.nz26.0 KB1.2 KB0.0 KB27.2 KB 95%2.1 KB
18news.furie.org.uk11.2 KB6.0 KB0.0 KB17.2 KB 65%4.3 KB
19photonic.trudheim.com6.5 KB0.0 KB0.0 KB6.5 KB100%2.2 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: 2324.6 MB27.1 KB3.3 MB27.9 MB 88%3.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 17 00:01:02 - 00:59:59 235 3.4% 0.07766.2 KB 3.1% 0.22
Aug 17 01:00:00 - 01:59:59 246 3.6% 0.071013.5 KB 4.1% 0.28
Aug 17 02:00:00 - 02:59:59 280 4.1% 0.08803.1 KB 3.3% 0.22
Aug 17 03:00:00 - 03:59:59 375 5.5% 0.101.3 MB 5.6% 0.38
Aug 17 04:00:00 - 04:59:59 347 5.1% 0.101.2 MB 5.2% 0.35
Aug 17 05:00:00 - 05:59:59 368 5.4% 0.101.0 MB 4.2% 0.28
Aug 17 06:00:00 - 06:59:59 292 4.3% 0.08926.4 KB 3.8% 0.26
Aug 17 07:00:00 - 07:59:59 319 4.7% 0.091.2 MB 4.9% 0.34
Aug 17 08:00:00 - 08:59:59 408 5.9% 0.111.7 MB 7.3% 0.50
Aug 17 09:00:00 - 09:59:59 395 5.8% 0.111.5 MB 6.1% 0.42
Aug 17 10:00:00 - 10:59:59 409 6.0% 0.111.8 MB 7.4% 0.51
Aug 17 11:00:00 - 11:59:59 395 5.8% 0.111.4 MB 6.0% 0.41
Aug 17 12:00:00 - 12:59:59 343 5.0% 0.101021.0 KB 4.2% 0.28
Aug 17 13:00:00 - 13:59:59 435 6.3% 0.121.5 MB 6.3% 0.43
Aug 17 14:00:00 - 14:59:59 403 5.9% 0.111.3 MB 5.5% 0.37
Aug 17 15:00:00 - 15:59:59 275 4.0% 0.08835.5 KB 3.4% 0.23
Aug 17 16:00:00 - 16:59:59 231 3.4% 0.061.0 MB 4.2% 0.29
Aug 17 17:00:00 - 17:59:59 255 3.7% 0.07863.4 KB 3.5% 0.24
Aug 17 18:00:00 - 18:59:59 176 2.6% 0.05530.8 KB 2.2% 0.15
Aug 17 19:00:00 - 19:59:59 142 2.1% 0.04509.8 KB 2.1% 0.14
Aug 17 20:00:00 - 20:59:59 125 1.8% 0.03377.0 KB 1.5% 0.10
Aug 17 21:00:00 - 21:59:59 147 2.1% 0.04581.7 KB 2.4% 0.16
Aug 17 22:00:00 - 22:59:59 89 1.3% 0.02319.2 KB 1.3% 0.09
Aug 17 23:00:00 - 23:59:59 164 2.4% 0.05572.6 KB 2.3% 0.16
Aug 18 00:00:00 - 00:01:01 4 0.1% 0.0710.1 KB 0.0% 0.17
TOTAL: 23:59:59 6858 100.0% 0.0823.9 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 GB96.3 GB 6.3% 0 0.4442024.31
CYCTXT1TEXT5.0 GB3.8 GB 76.3% 0 0.03 2277.37
TOTAL: 3-3077.0 GB100.2 GB 3.3% 1 0.32-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1endofthelinebbs-out.news.weretis.net 350 0 0 0 0 0 0 0 350
2usenet.blueworldhosting.com 225 2 0 0 0 0 0 0 223
3nntp.comgw.net 179 0 0 0 0 0 0 0 179
4news.netfront.net 96 0 0 0 0 0 0 0 96
5outgoing.news.lysator.liu.se 44 0 0 0 0 0 0 0 44
6newsfeed.xs3.de 42 0 0 0 0 0 0 0 42
7usenet.goja.nl.eu.org 35 0 0 0 0 0 0 0 35
8endofthelinebbs.peers.news.panix.com 19 0 0 1 0 0 0 0 18
9news.hispagatos.org 18 0 0 0 0 0 0 0 18
10i2pn.org 8 0 0 0 0 0 0 0 8
11newsfeed.bofh.team 8 0 0 1 0 0 0 0 7
12endoftheline-out.news.chmurka.net 4 0 0 1 0 0 0 0 3
13news.samoylyk.net 2 0 0 0 0 0 0 0 2
14news.bbs.nz 1 0 0 1 0 0 0 0 0
15news.furie.org.uk 1 0 0 1 0 0 0 0 0
TOTAL: 15 1032 2 0 5 0 0 0 0 1025

Unwanted newsgroups [Top 20]:

NewsgroupCount
soc.culture.mexico 1
soc.culture.russia 1
TOTAL: 2 2

INND Perl filter [Top 20]:

ReasonCount
EMP (phr path) 387
EMP (phn path) 292
Too many newsgroups 130
EMP (md5) 111
EMP (phn nph) 51
User-issued cancel 16
HTML Multipart 3
EMP (phl) 2
TOTAL: 8 992

NoCeM on Spool:

Issuer (type)NoticesBad PGPCancelSkipTotal
i2pn2-nocem@i2pn2.org (spam)5904520452
robot@pasdenom.info (spam3)30033
robot@pasdenom.info (spam2)10011
TOTAL: 36304524456

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
endofthelinebbs-out.news.weretis.net 15
usenet.blueworldhosting.com 9
usenet.goja.nl.eu.org 3
nntp.comgw.net 2
outgoing.news.lysator.liu.se 2
newsfeed.bofh.team 1
endofthelinebbs.peers.news.panix.com 1
TOTAL: 7 33
TOTAL: 1 33

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.netfront.net 10516 2510 4336 0 0 54 23%23:59:52
2nyheter.lysator.liu.se 5680 1204 3992 272 0 27 21%23:59:39
3news.furie.org.uk 4655 612 3112 11 0 2 13%23:59:27
4photonic.trudheim.com 7273 607 5545 701 0 0 8%23:59:52
5news.hispagatos.org 7361 442 5832 119 0 0 6%23:59:52
6endofthelinebbs.peers.news.panix.com 7078 409 6443 2 0 0 5%23:59:52
7usenet.network 7145 349 5796 68 0 8 4%23:59:48
8news.bbs.nz 12613 290 6277 286 0 122 2%23:59:50
9usenet.goja.nl.eu.org 7602 253 6295 67 0 0 3%23:59:19
10news.tnetconsulting.net 7581 233 6531 92 0 12 3%23:57:32
11news.quux.org 7321 175 6436 241 0 1 2%23:59:47
12news.nk.ca 10306 171 6139 467 0 78 1%23:59:52
13news.weretis.net 7085 169 6618 70 0 3 2%23:59:52
14news.corradoroberto.it 1123 164 633 0 0 3 14%23:35:10
15newsfeed.bofh.team 7594 152 6476 0 0 2 2%23:59:52
16i2pn.org 7586 143 6425 48 0 75 1%23:59:52
17newsfeed.xs3.de 7944 101 6567 55 0 2 1%23:59:31
18news.chmurka.net 4309 101 3417 0 0 0 2%23:59:52
19nntp.comgw.net 7212 100 6197 41 0 0 1%23:59:52
20news.samoylyk.net 8549 79 6640 116 0 75 0%23:59:52
21usenet.blueworldhosting.com 6130 1 5862 0 0 2 0%23:59:39
22news.nntp4.net4932392 0 0 0 04932211 0%23:59:52
23feed.opticnetworks.net 0 0 0 0 0 6858 0%23:59:52
TOTAL: 235085055 8265 115569 2656 04939535 0%551:27:58
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.netfront.net9.4 MB0.0 KB9.4 MB0.1 KB/s3.8 KB23:59:52
2nyheter.lysator.liu.se5.0 MB1.7 MB6.7 MB0.1 KB/s4.7 KB23:59:39
3news.furie.org.uk3.3 MB119.8 KB3.4 MB0.0 KB/s5.6 KB23:59:27
4photonic.trudheim.com2.7 MB2.3 MB5.0 MB0.1 KB/s3.9 KB23:59:52
5endofthelinebbs.peers.news.panix.com1.9 MB6.3 KB1.9 MB0.0 KB/s4.8 KB23:59:52
6news.hispagatos.org1.8 MB802.6 KB2.5 MB0.0 KB/s4.7 KB23:59:52
7news.quux.org1.7 MB1.0 MB2.8 MB0.0 KB/s6.8 KB23:59:47
8usenet.network1.3 MB150.0 KB1.5 MB0.0 KB/s3.6 KB23:59:48
9news.tnetconsulting.net1.3 MB556.0 KB1.8 MB0.0 KB/s5.7 KB23:57:32
10news.samoylyk.net1.2 MB316.7 KB1.5 MB0.0 KB/s8.1 KB23:59:52
11news.bbs.nz1.1 MB2.1 MB3.2 MB0.0 KB/s5.7 KB23:59:50
12newsfeed.bofh.team1.1 MB0.0 KB1.1 MB0.0 KB/s7.3 KB23:59:52
13news.weretis.net1.0 MB1.3 MB2.3 MB0.0 KB/s9.7 KB23:59:52
14usenet.goja.nl.eu.org960.9 KB538.9 KB1.5 MB0.0 KB/s4.7 KB23:59:19
15newsfeed.xs3.de621.1 KB1.1 MB1.7 MB0.0 KB/s11.3 KB23:59:31
16nntp.comgw.net602.1 KB1.1 MB1.7 MB0.0 KB/s12.0 KB23:59:52
17i2pn.org525.2 KB192.6 KB717.8 KB0.0 KB/s3.8 KB23:59:52
18news.corradoroberto.it506.0 KB0.0 KB506.0 KB0.0 KB/s3.1 KB23:35:10
19news.nk.ca367.9 KB2.5 MB2.9 MB0.0 KB/s4.7 KB23:59:52
20news.chmurka.net344.5 KB0.0 KB344.5 KB0.0 KB/s3.4 KB23:59:52
21usenet.blueworldhosting.com4.0 KB0.0 KB4.0 KB0.0 KB/s4.0 KB23:59:39
22feed.opticnetworks.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:52
23news.nntp4.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:52
TOTAL: 2336.7 MB15.8 MB52.5 MB0.0 KB/s4.9 KB551:27:58
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ddt.demos.su2753 00.0 KB 0 0 000:31:11
2162.142.125.222 3 00.0 KB 0 0 000:00:04
3167.94.138.54 1 00.0 KB 0 0 000:00:00
4181.210.203.35.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
5194.165.16.10 1 00.0 KB 0 0 000:00:01
6198.235.24.20 1 00.0 KB 0 0 000:00:10
7205.210.31.82 1 00.0 KB 0 0 000:00:08
891.238.181.33 1 00.0 KB 0 0 000:00:00
9azpdcg19.stretchoid.com 1 00.0 KB 0 0 000:00:00
10grand.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:03
TOTAL: 102764 00.0 KB 0 0 000:31:40

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.demos.su2753 00.0 KB 0 0 000:31:11
2unresolved 8 00.0 KB 0 0 000:00:25
3*.210.203.35.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
4*.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:03
5*.stretchoid.com 1 00.0 KB 0 0 000:00:00
TOTAL: 52764 00.0 KB 0 0 000:31:40

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
ddt.demos.su 9.677 36.652 0.00000:31:11
198.235.24.20 0.000 0.016 0.00000:00:10
205.210.31.82 0.003 0.013 0.00000:00:08
162.142.125.222 0.013 0.052 0.00000:00:04
grand.monitoring.internet-measurement.com 0.006 0.012 0.00000:00:03
194.165.16.10 0.000 0.017 0.00000:00:01
167.94.138.54 0.007 0.022 0.00000:00:00
91.238.181.33 0.000 0.016 0.00000:00:00
181.210.203.35.bc.googleusercontent.com 0.000 0.016 0.00000:00:00
azpdcg19.stretchoid.com 0.000 0.016 0.00000:00:00
TOTAL: 10 9.706 36.832 0.00000:31:40

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

SystemConn
181.210.203.35.bc.googleusercontent.com 4
162.142.125.222 1
167.94.138.54 1
194.165.16.10 1
91.238.181.33 1
azpdcg19.stretchoid.com 1
TOTAL: 6 9

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

CommandCount
#003 2
EHLO www.censys.io 2
Accept-Encoding: gzip 1
GET / HTTP/1.1 1
Host: 144.172.126.95:119 1
MGLNDD_144.172.126.95_119 1
User-Agent: Expanse, a Palo Alto Network... 1
TOTAL: 7 9

NNRP client timeouts [Top 20]:

SystemConnPeer
162.142.125.222 1 2
194.165.16.10 1 1
91.238.181.33 1 1
TOTAL: 3 3 5