Daily Usenet Report

Aug 19 00:01:01 -- Aug 20 00:01:01

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Aug 19 08:20:18 newsfeed innd: message repeated 2 times: [ ctlinnd command s]

Log entries by program:

Program nameLines%LinesSize%Size
inn 8690 29.4%3.6 MB 55.9%
nnrpd 8395 28.4%869.8 KB 13.2%
innd 7843 26.5%1.1 MB 17.3%
innfeed 4082 13.8%801.8 KB 12.2%
cnfsstat 432 1.5%65.2 KB 1.0%
nocem 98 0.3%23.8 KB 0.4%
controlchan 1 0.0%0.2 KB 0.0%
TOTAL: 7 29541 100.0%6.4 MB100.0%

History cache:

ReasonCount%Count
Positive hits 111321 59.1%
Negative hits 68560 36.4%
Do not exist 8297 4.4%
Cache misses 46 0.0%
TOTAL: 4 188224 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.364 0.0%410 0.000 3.327 86.667
article cleanup00:00:00.108 0.0%8337 0.000 0.013 0.704
article logging00:00:00.405 0.0%8374 0.000 0.048 0.231
article parse00:00:00.204 0.0%12413 0.000 0.016 0.064
article write00:00:02.014 0.0%7314 0.042 0.275 2.177
artlog/artcncl00:00:00.008 0.0%316 0.000 0.025 0.200
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:01.960 0.0%192217 0.000 0.010 0.779
hisgrep/artcncl00:00:00.571 0.0%389 0.000 1.468 27.333
hishave/artcncl00:00:00.053 0.0%356 0.000 0.149 2.500
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:02:24.311 0.2%189263 0.081 0.762 5.118
history sync00:00:00.074 0.0%403 0.000 0.184 1.000
history write00:01:50.790 0.1%8327 3.167 13.305 88.214
hiswrite/artcncl00:00:00.073 0.0%25 2.556 2.920 3.500
idle23:46:05.314 99.0%191661 115.076 446.441 1844.522
nntp read00:00:02.976 0.0%192484 0.002 0.015 0.234
overview write00:09:15.908 0.6%7314 0.787 76.006 9135.161
perl filter00:00:31.049 0.0%8327 1.759 3.729 37.174
python filter00:00:00.983 0.0%8327 0.000 0.118 0.671
site send00:00:00.868 0.0%14679 0.000 0.059 0.197
TOTAL: 24:01:07.88024:00:19.033 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:04.385 0.0%4774017 0.000 0.001 0.002
article prepare00:00:00.005 0.0%47176 0.000 0.000 0.003
article read00:00:00.533 0.0%3918 0.000 0.136 0.320
backlog stats00:00:01.948 0.0%1964688 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:12.678 0.0%1149311 0.006 0.011 0.042
data write00:00:12.494 0.0%1143969 0.007 0.011 0.020
idle23:45:51.114 99.7%1964688 29.142 43.544 56.544
status file00:00:00.300 0.0%241 0.667 1.245 7.000
TOTAL: 23:50:09.35823:46:23.457 99.7%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:22:36.083 69.5%8326 20.000 162.873 10050.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.276 0.0%16756 0.000 0.016 1.167
TOTAL: 00:32:31.65400:22:36.359 69.5%----

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 2 13709 2372 10965 372 17%51:03:59
2outgoing.news.lysator.liu.se 2 6236 1554 4629 53 24%23:59:37
3usenet.blueworldhosting.com 719 8068 676 7136 256 8%23:52:58
4news.hispagatos.org 6 7082 498 6573 11 7%24:26:17
5usenet.network 2 5698 475 5222 1 8%23:59:56
6nntp.comgw.net 2 7404 419 6829 156 5%23:59:34
7news.corradoroberto.it 3 1412 363 1049 0 25%25:14:27
8i2pn.org 2 7105 260 6829 16 3%23:59:15
9usenet.goja.nl.eu.org 12 7667 182 7449 36 2%25:57:32
10endoftheline-out.news.chmurka.net 1 3817 160 3657 0 4%23:59:56
11newsfeed.bofh.team 2 8102 128 7970 4 1%23:59:43
12news.samoylyk.net 3 6424 112 6307 5 1%23:58:25
13endofthelinebbs.peers.news.panix.com 25 7881 105 7764 12 1%23:56:45
14newsfeed.xs3.de 2 6036 95 5937 4 1%23:59:44
15glockenspiel.complete.org 2 5695 27 5667 1 0%23:58:09
16news.netfront.net 1 5090 24 4956 110 0%21:53:57
17news.bbs.nz 2 6350 12 6338 0 0%23:59:23
18photonic.trudheim.com 2 1911 5 1904 2 0%23:59:54
19news.furie.org.uk 1 4382 2 4380 0 0%23:38:26
20eotl-out.news.tnetconsulting.net 1 0 0 0 0 0%00:10:04
21localhost 5 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 800 120069 7469 111561 1039 6%484:38:13
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1endofthelinebbs-out.news.weretis.net7.1 MB2.0 KB569.6 KB7.7 MB 92%2.9 KB
2usenet.network5.7 MB0.0 KB0.8 KB5.7 MB 99%12.2 KB
3outgoing.news.lysator.liu.se5.5 MB2.1 KB67.2 KB5.6 MB 98%3.5 KB
4news.corradoroberto.it2.1 MB0.0 KB0.0 KB2.1 MB100%5.9 KB
5usenet.blueworldhosting.com1.7 MB0.0 KB480.1 KB2.2 MB 78%2.4 KB
6news.hispagatos.org1.5 MB0.0 KB31.4 KB1.6 MB 98%3.2 KB
7glockenspiel.complete.org1.5 MB2.0 KB0.0 KB1.5 MB 99%53.8 KB
8nntp.comgw.net1.1 MB0.0 KB414.5 KB1.5 MB 73%2.7 KB
9i2pn.org908.5 KB2.0 KB30.5 KB940.9 KB 96%3.4 KB
10endoftheline-out.news.chmurka.net693.4 KB0.0 KB0.0 KB693.4 KB100%4.3 KB
11news.samoylyk.net630.4 KB2.0 KB3.7 KB636.1 KB 99%5.4 KB
12usenet.goja.nl.eu.org525.3 KB2.1 KB38.4 KB565.8 KB 92%2.6 KB
13newsfeed.xs3.de355.0 KB2.0 KB3.9 KB361.0 KB 98%3.6 KB
14endofthelinebbs.peers.news.panix.com344.0 KB2.1 KB19.8 KB365.8 KB 94%3.1 KB
15newsfeed.bofh.team337.9 KB2.1 KB4.5 KB344.4 KB 98%2.6 KB
16news.netfront.net58.4 KB2.1 KB690.7 KB751.2 KB 7%5.6 KB
17news.bbs.nz27.3 KB0.0 KB0.0 KB27.3 KB100%2.3 KB
18photonic.trudheim.com20.3 KB0.0 KB4.3 KB24.6 KB 82%3.5 KB
19news.furie.org.uk10.0 KB0.0 KB0.0 KB10.0 KB100%5.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
23news.nntp4.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 2330.0 MB20.5 KB2.3 MB32.4 MB 92%3.9 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 19 00:01:01 - 00:59:59 202 2.8% 0.06603.3 KB 2.1% 0.17
Aug 19 01:00:00 - 01:59:59 227 3.1% 0.06684.4 KB 2.4% 0.19
Aug 19 02:00:00 - 02:59:59 279 3.8% 0.081.2 MB 4.1% 0.33
Aug 19 03:00:00 - 03:59:59 369 5.0% 0.101.3 MB 4.6% 0.37
Aug 19 04:00:00 - 04:59:59 350 4.8% 0.101.3 MB 4.7% 0.38
Aug 19 05:00:00 - 05:59:59 327 4.5% 0.091.3 MB 4.7% 0.38
Aug 19 06:00:00 - 06:59:59 351 4.8% 0.102.0 MB 7.3% 0.58
Aug 19 07:00:00 - 07:59:59 339 4.6% 0.091.3 MB 4.7% 0.38
Aug 19 08:00:00 - 08:59:59 401 5.5% 0.111.5 MB 5.3% 0.43
Aug 19 09:00:00 - 09:59:59 440 6.0% 0.121.9 MB 6.6% 0.53
Aug 19 10:00:00 - 10:59:59 468 6.4% 0.131.8 MB 6.3% 0.50
Aug 19 11:00:00 - 11:59:59 446 6.1% 0.121.9 MB 6.7% 0.54
Aug 19 12:00:00 - 12:59:59 402 5.5% 0.111.1 MB 3.8% 0.31
Aug 19 13:00:00 - 13:59:59 375 5.1% 0.101.7 MB 6.0% 0.48
Aug 19 14:00:00 - 14:59:59 414 5.7% 0.121.4 MB 4.9% 0.40
Aug 19 15:00:00 - 15:59:59 316 4.3% 0.091.1 MB 3.9% 0.31
Aug 19 16:00:00 - 16:59:59 315 4.3% 0.091.1 MB 4.0% 0.32
Aug 19 17:00:00 - 17:59:59 219 3.0% 0.06947.3 KB 3.3% 0.26
Aug 19 18:00:00 - 18:59:59 195 2.7% 0.05706.6 KB 2.5% 0.20
Aug 19 19:00:00 - 19:59:59 230 3.1% 0.061.1 MB 3.9% 0.31
Aug 19 20:00:00 - 20:59:59 162 2.2% 0.04684.3 KB 2.4% 0.19
Aug 19 21:00:00 - 21:59:59 174 2.4% 0.05540.2 KB 1.9% 0.15
Aug 19 22:00:00 - 22:59:59 162 2.2% 0.04575.9 KB 2.0% 0.16
Aug 19 23:00:00 - 23:59:59 143 2.0% 0.04520.2 KB 1.8% 0.14
Aug 20 00:00:00 - 00:01:01 7 0.1% 0.1116.7 KB 0.1% 0.27
TOTAL: 24:00:00 7313 100.0% 0.0828.1 MB 100.0% 0.33
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.4 GB 6.3% 0 0.5037262.27
CYCTXT1TEXT5.0 GB3.8 GB 76.4% 0 0.03 2101.30
TOTAL: 3-3077.0 GB100.3 GB 3.3% 1 0.35-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1endofthelinebbs-out.news.weretis.net 389 0 0 1 0 0 0 0 388
2usenet.blueworldhosting.com 270 1 0 0 1 0 0 0 268
3nntp.comgw.net 153 0 0 0 0 0 0 0 153
4news.netfront.net 101 0 0 1 0 0 0 0 100
5outgoing.news.lysator.liu.se 53 0 0 1 0 0 0 0 52
6usenet.goja.nl.eu.org 38 0 0 1 0 0 0 0 37
7i2pn.org 16 0 0 1 0 0 0 0 15
8endofthelinebbs.peers.news.panix.com 12 0 0 1 0 0 0 0 11
9news.hispagatos.org 11 0 0 0 0 0 0 0 11
10news.samoylyk.net 5 0 0 1 0 0 0 0 4
11newsfeed.bofh.team 4 0 0 1 0 0 0 0 3
12newsfeed.xs3.de 4 0 0 1 0 0 0 0 3
13photonic.trudheim.com 2 0 0 0 0 0 0 0 2
14endoftheline-out.news.chmurka.net 1 0 0 0 0 0 0 0 1
15glockenspiel.complete.org 1 0 0 1 0 0 0 0 0
16usenet.network 1 0 0 0 0 0 0 0 1
TOTAL: 16 1061 1 0 10 1 0 0 0 1049

Unwanted newsgroups [Top 20]:

NewsgroupCount
soc.culture.mexico 1
TOTAL: 1 1

Supposedly-moderated groups with unmoderated postings [Top 20]:

GroupsCount
soc.feminism 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (phn path) 379
EMP (phr path) 350
EMP (md5) 170
Too many newsgroups 86
Too many newsgroups (meow) 15
User-issued cancel 8
EMP (fsl) 3
HTML Multipart 1
TOTAL: 8 1012

NoCeM on Spool:

Issuer (type)NoticesBad PGPCancelSkipTotal
i2pn2-nocem@i2pn2.org (spam)4603520352
robot@pasdenom.info (spam3)4001010
robot@pasdenom.info (spam2)10011
TOTAL: 351035211363

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
endofthelinebbs-out.news.weretis.net 20
usenet.blueworldhosting.com 14
usenet.goja.nl.eu.org 2
nntp.comgw.net 1
TOTAL: 4 37
TOTAL: 1 37

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.netfront.net 11454 2510 4779 0 0 5 21%23:59:54
2nyheter.lysator.liu.se 6328 1233 3951 577 0 29 19%23:59:54
3photonic.trudheim.com 7794 691 5894 703 0 0 8%23:59:54
4news.furie.org.uk 5086 650 3488 8 0 0 12%23:59:43
5news.hispagatos.org 8030 406 6172 245 0 0 5%23:59:54
6endofthelinebbs.peers.news.panix.com 7547 387 6918 1 0 0 5%23:59:54
7usenet.network 7232 322 5946 33 0 1 4%23:59:06
8usenet.goja.nl.eu.org 8114 212 6579 243 0 0 2%23:58:41
9news.bbs.nz 13209 205 6530 563 0 39 1%23:59:44
10newsfeed.bofh.team 8144 187 6895 2 0 0 2%23:59:54
11i2pn.org 7953 148 6839 55 0 7 1%23:59:54
12news.nk.ca 10833 133 6382 689 0 36 1%23:59:54
13news.corradoroberto.it 1030 94 779 5 0 0 9%23:36:17
14news.tnetconsulting.net 8177 70 7013 221 0 0 0%23:59:38
15news.quux.org 7752 63 6758 485 0 0 0%23:59:54
16news.weretis.net 7536 55 7082 170 0 0 0%23:59:07
17nntp.comgw.net 7865 50 6729 124 0 0 0%23:58:48
18news.chmurka.net 4468 44 3537 7 0 0 0%23:59:54
19newsfeed.xs3.de 8620 26 7016 161 0 0 0%23:59:04
20news.samoylyk.net 8462 12 7139 24 0 9 0%23:59:54
21news.nntp4.net4805351 0 0 0 04805290 0%23:59:54
22usenet.blueworldhosting.com 6855 0 6452 0 0 0 0%23:59:38
23feed.opticnetworks.net 0 0 0 0 0 7313 0%23:59:54
TOTAL: 234967840 7498 122878 4316 04812729 0%551:28:28
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.netfront.net12.2 MB0.0 KB12.2 MB0.1 KB/s5.0 KB23:59:54
2nyheter.lysator.liu.se4.9 MB5.2 MB10.0 MB0.1 KB/s5.7 KB23:59:54
3photonic.trudheim.com4.2 MB2.5 MB6.7 MB0.1 KB/s4.9 KB23:59:54
4news.furie.org.uk4.0 MB32.9 KB4.0 MB0.0 KB/s6.3 KB23:59:43
5endofthelinebbs.peers.news.panix.com2.1 MB3.6 KB2.1 MB0.0 KB/s5.4 KB23:59:54
6newsfeed.bofh.team1.8 MB3.6 KB1.8 MB0.0 KB/s9.6 KB23:59:54
7news.quux.org1.3 MB3.4 MB4.8 MB0.1 KB/s8.9 KB23:59:54
8news.hispagatos.org1.3 MB2.3 MB3.6 MB0.0 KB/s5.7 KB23:59:54
9news.samoylyk.net1.1 MB287.2 KB1.3 MB0.0 KB/s38.2 KB23:59:54
10usenet.network977.9 KB62.7 KB1.0 MB0.0 KB/s2.9 KB23:59:06
11news.bbs.nz648.5 KB5.3 MB6.0 MB0.1 KB/s8.0 KB23:59:44
12i2pn.org571.1 KB251.1 KB822.2 KB0.0 KB/s4.1 KB23:59:54
13usenet.goja.nl.eu.org520.0 KB2.2 MB2.7 MB0.0 KB/s6.1 KB23:58:41
14news.corradoroberto.it353.4 KB15.7 KB369.1 KB0.0 KB/s3.7 KB23:36:17
15news.tnetconsulting.net298.1 KB1.7 MB2.0 MB0.0 KB/s6.9 KB23:59:38
16news.nk.ca278.9 KB5.4 MB5.7 MB0.1 KB/s7.1 KB23:59:54
17news.weretis.net211.0 KB2.7 MB2.9 MB0.0 KB/s13.0 KB23:59:07
18nntp.comgw.net189.2 KB2.3 MB2.5 MB0.0 KB/s14.5 KB23:58:48
19news.chmurka.net143.1 KB22.0 KB165.1 KB0.0 KB/s3.2 KB23:59:54
20newsfeed.xs3.de138.1 KB1.7 MB1.9 MB0.0 KB/s10.3 KB23:59:04
21feed.opticnetworks.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:54
22news.nntp4.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:54
23usenet.blueworldhosting.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:38
TOTAL: 2336.9 MB35.4 MB72.4 MB0.0 KB/s6.3 KB551:28:28
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ddt.demos.su2770 00.0 KB 0 0 000:31:49
2152.32.185.141 3 00.0 KB 0 0 000:00:10
3167.94.138.59 3 00.0 KB 0 0 000:00:07
4167.94.146.60 3 00.0 KB 0 0 000:00:03
5147.185.132.66 1 00.0 KB 0 0 000:00:02
6194.165.16.76 1 00.0 KB 0 0 000:00:01
7198.235.24.150 1 00.0 KB 0 0 000:00:10
871.6.134.232 1 00.0 KB 0 0 000:00:00
9azpdwg25.stretchoid.com 1 00.0 KB 0 0 000:00:00
10cheerful.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
11sprightly.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:02
TOTAL: 112786 00.0 KB 0 0 000:32:30

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.demos.su2770 00.0 KB 0 0 000:31:49
2unresolved 13 00.0 KB 0 0 000:00:35
3*.monitoring.internet-measurement.com 2 00.0 KB 0 0 000:00:04
4*.stretchoid.com 1 00.0 KB 0 0 000:00:00
TOTAL: 42786 00.0 KB 0 0 000:32:30

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
ddt.demos.su 9.554 37.004 0.00000:31:49
152.32.185.141 0.000 0.051 0.00000:00:10
198.235.24.150 0.000 0.016 0.00000:00:10
167.94.138.59 0.016 0.051 0.00000:00:07
167.94.146.60 0.010 0.054 0.00000:00:03
sprightly.monitoring.internet-measurement.com 0.004 0.013 0.00000:00:02
147.185.132.66 0.000 0.016 0.00000:00:02
cheerful.monitoring.internet-measurement.com 0.004 0.012 0.00000:00:01
194.165.16.76 0.000 0.016 0.00000:00:01
azpdwg25.stretchoid.com 0.005 0.011 0.00000:00:00
71.6.134.232 0.007 0.010 0.00000:00:00
TOTAL: 11 9.600 37.254 0.00000:32:30

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

SystemConn
152.32.185.141 2
167.94.138.59 1
167.94.146.60 1
194.165.16.76 1
azpdwg25.stretchoid.com 1
TOTAL: 5 6

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

CommandCount
EHLO www.censys.io 2
#003 1
#026#003#001#001#027#001 1
MGLNDD_144.172.126.95_119 1
À#024 1
TOTAL: 5 6

NNRP client timeouts [Top 20]:

SystemConnPeer
167.94.138.59 1 2
167.94.146.60 1 2
194.165.16.76 1 1
TOTAL: 3 3 6