Daily Usenet Report

Aug 16 00:01:02 -- Aug 17 00:01:02

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Aug 16 08:14:46 newsfeed innd: message repeated 2 times: [ ctlinnd command s]

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 8612 29.1%885.6 KB 13.6%
inn 8566 29.0%3.5 MB 55.4%
innd 7739 26.2%1.1 MB 17.1%
innfeed 4108 13.9%826.5 KB 12.6%
cnfsstat 432 1.5%66.0 KB 1.0%
nocem 87 0.3%22.6 KB 0.3%
controlchan 1 0.0%0.2 KB 0.0%
TOTAL: 7 29545 100.0%6.4 MB100.0%

History cache:

ReasonCount%Count
Positive hits 110389 58.3%
Negative hits 70954 37.4%
Do not exist 8119 4.3%
Cache misses 40 0.0%
TOTAL: 4 189502 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.235 0.0%367 0.000 0.640 13.000
article cleanup00:00:00.144 0.0%8187 0.000 0.018 0.519
article logging00:00:00.495 0.0%8210 0.000 0.060 1.741
article parse00:00:00.209 0.0%11880 0.000 0.018 0.080
article write00:00:02.116 0.0%7247 0.029 0.292 2.773
artlog/artcncl00:00:00.011 0.0%340 0.000 0.032 1.000
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:01.509 0.0%191426 0.000 0.008 0.219
hisgrep/artcncl00:00:00.100 0.0%369 0.000 0.271 8.000
hishave/artcncl00:00:00.001 0.0%340 0.000 0.003 0.125
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:02:20.975 0.2%190865 0.082 0.739 5.126
history sync00:00:00.076 0.0%399 0.000 0.190 1.250
history write00:01:59.054 0.1%8186 2.883 14.544 104.148
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:44:59.146 98.9%190313 72.436 449.255 1348.813
nntp read00:00:02.936 0.0%191970 0.002 0.015 0.229
overview write00:09:53.816 0.7%7247 0.615 81.940 6879.500
perl filter00:00:37.845 0.0%8186 1.566 4.623 95.609
python filter00:00:03.316 0.0%8186 0.000 0.405 10.485
site send00:00:00.971 0.0%14540 0.000 0.067 0.226
TOTAL: 24:01:05.31324:00:02.955 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:04.763 0.0%4861979 0.001 0.001 0.002
article prepare00:00:00.003 0.0%43040 0.000 0.000 0.008
article read00:00:00.566 0.0%4147 0.000 0.136 0.368
backlog stats00:00:02.025 0.0%2149292 0.000 0.001 0.002
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:12.818 0.0%1329796 0.006 0.010 0.027
data write00:00:13.360 0.0%1325443 0.007 0.010 0.025
idle23:47:26.650 99.8%2149292 29.551 39.849 49.087
status file00:00:00.322 0.0%256 1.000 1.258 17.000
TOTAL: 23:50:06.22023:48:00.507 99.9%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle68:22:02.069 99.8%12743 19.500 19314.296 54920.134
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.382 0.0%25607 0.000 0.015 0.500
readart00:00:00.108 0.0%58 1.862 1.862 1.862
TOTAL: 68:32:15.76068:22:02.559 99.8%----

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 13546 1903 11251 392 14%52:03:40
2outgoing.news.lysator.liu.se 2 6635 1615 4963 57 24%23:59:09
3usenet.blueworldhosting.com 719 8047 838 7041 168 10%23:57:38
4news.hispagatos.org 7 7295 505 6778 12 6%24:34:24
5usenet.goja.nl.eu.org 11 7293 404 6813 76 5%24:03:02
6nntp.comgw.net 2 7319 379 6838 102 5%23:59:53
7news.corradoroberto.it 6 1343 372 971 0 27%23:52:47
8usenet.network 1 5683 338 5341 4 5%23:59:57
9i2pn.org 2 7299 228 7066 5 3%23:59:39
10newsfeed.bofh.team 1 8029 204 7821 4 2%23:59:58
11endoftheline-out.news.chmurka.net 1 3615 164 3450 1 4%23:59:56
12news.samoylyk.net 1 6329 161 6163 5 2%23:59:47
13endofthelinebbs.peers.news.panix.com 25 7980 142 7825 13 1%24:10:42
14newsfeed.xs3.de 1 5979 64 5839 76 1%23:59:53
15news.furie.org.uk 2 4193 15 4177 1 0%23:39:30
16news.bbs.nz 1 6284 5 6279 0 0%23:59:36
17glockenspiel.complete.org 2 5517 4 5513 0 0%24:00:32
18photonic.trudheim.com 4 1375 2 1373 0 0%17:11:39
19news.netfront.net 1 5239 0 5197 42 0%24:26:51
20eotl-out.news.tnetconsulting.net 1 0 0 0 0 0%00:10:05
21localhost 7 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 803 119000 7343 110699 958 6%478:38:50
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1endofthelinebbs-out.news.weretis.net6.3 MB0.0 KB758.5 KB7.0 MB 89%3.1 KB
2outgoing.news.lysator.liu.se5.4 MB0.0 KB101.7 KB5.5 MB 98%3.4 KB
3usenet.network3.5 MB0.0 KB4.6 KB3.5 MB 99%10.4 KB
4news.corradoroberto.it2.4 MB0.0 KB0.0 KB2.4 MB100%6.6 KB
5usenet.blueworldhosting.com2.2 MB0.0 KB316.5 KB2.6 MB 87%2.6 KB
6news.hispagatos.org1.5 MB3.4 KB15.9 KB1.5 MB 98%3.1 KB
7usenet.goja.nl.eu.org1.2 MB0.0 KB84.3 KB1.3 MB 93%2.7 KB
8nntp.comgw.net989.1 KB0.0 KB198.6 KB1.2 MB 83%2.5 KB
9i2pn.org806.8 KB0.0 KB9.2 KB815.9 KB 98%3.5 KB
10news.samoylyk.net708.6 KB0.0 KB8.9 KB717.4 KB 98%4.3 KB
11endoftheline-out.news.chmurka.net672.3 KB0.0 KB3.7 KB676.0 KB 99%4.1 KB
12newsfeed.bofh.team565.1 KB0.0 KB8.6 KB573.7 KB 98%2.8 KB
13endofthelinebbs.peers.news.panix.com430.0 KB0.0 KB21.0 KB451.0 KB 95%2.9 KB
14newsfeed.xs3.de178.6 KB0.0 KB333.3 KB511.8 KB 34%3.7 KB
15news.furie.org.uk50.4 KB0.0 KB0.8 KB51.2 KB 98%3.2 KB
16glockenspiel.complete.org8.8 KB0.0 KB0.0 KB8.8 KB100%2.2 KB
17news.bbs.nz7.3 KB0.0 KB0.0 KB7.3 KB100%1.5 KB
18photonic.trudheim.com5.8 KB0.0 KB0.0 KB5.8 KB100%2.9 KB
19eotl-out.news.tnetconsulting.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
20localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
21news.netfront.net0.0 KB0.0 KB107.0 KB107.0 KB 0%2.5 KB
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: 2326.9 MB3.4 KB1.9 MB28.8 MB 93%3.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 16 00:01:02 - 00:59:59 150 2.1% 0.04554.8 KB 2.1% 0.16
Aug 16 01:00:00 - 01:59:59 208 2.9% 0.06673.6 KB 2.5% 0.19
Aug 16 02:00:00 - 02:59:59 286 3.9% 0.08965.7 KB 3.6% 0.27
Aug 16 03:00:00 - 03:59:59 330 4.5% 0.091.0 MB 4.0% 0.30
Aug 16 04:00:00 - 04:59:59 330 4.5% 0.091.2 MB 4.8% 0.35
Aug 16 05:00:00 - 05:59:59 313 4.3% 0.09929.0 KB 3.5% 0.26
Aug 16 06:00:00 - 06:59:59 364 5.0% 0.101.2 MB 4.6% 0.35
Aug 16 07:00:00 - 07:59:59 418 5.8% 0.121.3 MB 4.9% 0.37
Aug 16 08:00:00 - 08:59:59 465 6.4% 0.131.8 MB 6.7% 0.50
Aug 16 09:00:00 - 09:59:59 398 5.5% 0.111.5 MB 5.8% 0.43
Aug 16 10:00:00 - 10:59:59 463 6.4% 0.131.8 MB 6.7% 0.50
Aug 16 11:00:00 - 11:59:59 409 5.6% 0.111.4 MB 5.5% 0.41
Aug 16 12:00:00 - 12:59:59 363 5.0% 0.101.5 MB 5.6% 0.41
Aug 16 13:00:00 - 13:59:59 405 5.6% 0.111.6 MB 5.9% 0.44
Aug 16 14:00:00 - 14:59:59 292 4.0% 0.08826.6 KB 3.1% 0.23
Aug 16 15:00:00 - 15:59:59 376 5.2% 0.101.5 MB 5.6% 0.42
Aug 16 16:00:00 - 16:59:59 345 4.8% 0.101.3 MB 5.1% 0.38
Aug 16 17:00:00 - 17:59:59 298 4.1% 0.08940.3 KB 3.5% 0.26
Aug 16 18:00:00 - 18:59:59 180 2.5% 0.05871.7 KB 3.3% 0.24
Aug 16 19:00:00 - 19:59:59 126 1.7% 0.04413.7 KB 1.5% 0.11
Aug 16 20:00:00 - 20:59:59 232 3.2% 0.06715.4 KB 2.7% 0.20
Aug 16 21:00:00 - 21:59:59 175 2.4% 0.05654.6 KB 2.4% 0.18
Aug 16 22:00:00 - 22:59:59 143 2.0% 0.04851.1 KB 3.2% 0.24
Aug 16 23:00:00 - 23:59:59 176 2.4% 0.05879.4 KB 3.3% 0.24
Aug 17 00:00:00 - 00:01:02 18 0.2% 0.2934.2 KB 0.1% 0.55
TOTAL: 24:00:00 7263 100.0% 0.0826.2 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 GB96.3 GB 6.3% 0 0.4838663.95
CYCTXT1TEXT5.0 GB3.8 GB 76.3% 0 0.03 2217.21
TOTAL: 3-3077.0 GB100.2 GB 3.3% 1 0.36-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1endofthelinebbs-out.news.weretis.net 401 0 0 0 0 0 0 0 401
2usenet.blueworldhosting.com 174 1 0 0 0 0 0 0 173
3nntp.comgw.net 96 0 0 0 0 0 0 0 96
4newsfeed.xs3.de 76 0 0 0 0 0 0 0 76
5usenet.goja.nl.eu.org 76 0 0 0 0 0 0 0 76
6outgoing.news.lysator.liu.se 57 0 0 0 0 0 0 0 57
7news.netfront.net 37 0 0 0 0 0 0 0 37
8endofthelinebbs.peers.news.panix.com 13 0 0 0 0 0 0 0 13
9news.hispagatos.org 12 0 0 1 0 0 0 0 11
10i2pn.org 5 0 0 0 0 0 0 0 5
11news.samoylyk.net 5 0 0 0 0 0 0 0 5
12newsfeed.bofh.team 4 0 0 0 0 0 0 0 4
13usenet.network 4 0 0 0 0 0 0 0 4
14endoftheline-out.news.chmurka.net 1 0 0 0 0 0 0 0 1
15news.corradoroberto.it 1 0 0 0 0 0 0 0 1
16news.furie.org.uk 1 0 0 0 0 0 0 0 1
TOTAL: 16 963 1 0 1 0 0 0 0 961

Unwanted newsgroups [Top 20]:

NewsgroupCount
soc.culture.russia 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (phn path) 372
EMP (phr path) 329
EMP (phn nph) 117
Too many newsgroups 55
EMP (md5) 40
EMP (fsl) 13
User-issued cancel 5
HTML Multipart 4
Cancel for rejected article 2
Too many newsgroups (meow) 1
TOTAL: 10 938

NoCeM on Spool:

Issuer (type)NoticesBad PGPCancelSkipTotal
i2pn2-nocem@i2pn2.org (spam)4003380338
robot@pasdenom.info (spam3)30077
robot@pasdenom.info (spam2)30033
TOTAL: 346033810348

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
endofthelinebbs-out.news.weretis.net 14
usenet.blueworldhosting.com 6
news.corradoroberto.it 1
news.hispagatos.org 1
usenet.goja.nl.eu.org 1
TOTAL: 5 23
TOTAL: 1 23

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.netfront.net 10801 3017 4243 0 0 31 27%23:59:53
2nyheter.lysator.liu.se 5830 953 4273 418 0 1 16%23:59:53
3news.furie.org.uk 4711 576 3259 6 0 2 12%23:59:45
4photonic.trudheim.com 7736 486 6111 660 0 0 6%23:59:42
5endofthelinebbs.peers.news.panix.com 7528 397 6861 0 0 0 5%23:59:21
6usenet.goja.nl.eu.org 7531 287 6385 155 0 10 3%23:59:53
7news.hispagatos.org 7851 275 6243 213 0 6 3%23:59:53
8usenet.network 7211 220 6175 58 0 0 3%23:59:37
9news.nk.ca 10747 158 6378 638 0 410 1%23:59:53
10newsfeed.bofh.team 7753 156 6822 0 0 0 2%23:59:41
11i2pn.org 8017 155 6793 63 0 61 1%23:59:33
12news.bbs.nz 12789 136 6799 315 0 101 1%23:59:45
13news.chmurka.net 3909 120 3289 0 0 0 3%23:59:53
14news.tnetconsulting.net 8241 105 6979 170 0 24 1%23:59:53
15news.quux.org 7891 81 6788 383 0 2 1%23:59:43
16news.corradoroberto.it 932 63 729 6 0 0 6%23:33:36
17news.weretis.net 7473 61 7060 141 0 0 0%23:59:53
18nntp.comgw.net 7634 41 6724 109 0 0 0%23:59:53
19newsfeed.xs3.de 8168 34 7021 123 0 2 0%23:59:53
20news.samoylyk.net 7997 20 7014 21 0 21 0%23:59:53
21news.nntp4.net4895182 0 0 0 04895116 0%23:59:53
22usenet.blueworldhosting.com 6566 0 6245 0 0 0 0%23:59:42
23feed.opticnetworks.net 0 0 0 0 0 7263 0%23:59:53
TOTAL: 235052498 7341 122191 3479 04903050 0%551:28:54
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.netfront.net12.0 MB0.0 KB12.0 MB0.1 KB/s4.1 KB23:59:53
2nyheter.lysator.liu.se4.2 MB3.2 MB7.3 MB0.1 KB/s5.5 KB23:59:53
3news.furie.org.uk3.4 MB40.4 KB3.4 MB0.0 KB/s6.1 KB23:59:45
4photonic.trudheim.com2.9 MB2.6 MB5.5 MB0.1 KB/s4.9 KB23:59:42
5endofthelinebbs.peers.news.panix.com2.3 MB0.0 KB2.3 MB0.0 KB/s6.0 KB23:59:21
6newsfeed.bofh.team1.5 MB0.0 KB1.5 MB0.0 KB/s10.0 KB23:59:41
7news.quux.org1.3 MB2.3 MB3.6 MB0.0 KB/s7.9 KB23:59:43
8news.samoylyk.net1013.0 KB73.4 KB1.1 MB0.0 KB/s26.5 KB23:59:53
9news.hispagatos.org992.4 KB1.9 MB2.9 MB0.0 KB/s6.1 KB23:59:53
10usenet.network759.8 KB128.2 KB888.0 KB0.0 KB/s3.2 KB23:59:37
11usenet.goja.nl.eu.org667.2 KB1.6 MB2.3 MB0.0 KB/s5.2 KB23:59:53
12news.bbs.nz606.0 KB2.8 MB3.4 MB0.0 KB/s7.7 KB23:59:45
13i2pn.org518.3 KB310.9 KB829.2 KB0.0 KB/s3.8 KB23:59:33
14news.tnetconsulting.net485.5 KB1.4 MB1.9 MB0.0 KB/s7.0 KB23:59:53
15news.chmurka.net428.3 KB0.0 KB428.3 KB0.0 KB/s3.6 KB23:59:53
16news.nk.ca376.6 KB4.0 MB4.4 MB0.1 KB/s5.6 KB23:59:53
17news.weretis.net262.9 KB2.4 MB2.7 MB0.0 KB/s13.5 KB23:59:53
18news.corradoroberto.it229.4 KB29.5 KB258.9 KB0.0 KB/s3.8 KB23:33:36
19newsfeed.xs3.de141.7 KB1.9 MB2.0 MB0.0 KB/s13.2 KB23:59:53
20nntp.comgw.net141.5 KB1.8 MB2.0 MB0.0 KB/s13.5 KB23:59:53
21feed.opticnetworks.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:53
22news.nntp4.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:53
23usenet.blueworldhosting.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:42
TOTAL: 2334.1 MB26.5 MB60.6 MB0.0 KB/s5.7 KB551:28:54
Outgoing feeds (innfeed) by Volume

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 47 735.7 KB 3 0 068:00:36
2*.demos.su2752 00.0 KB 0 0 000:31:35
3*.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
TOTAL: 32800 735.7 KB 3 0 068:32:13

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
47.189.156.68 0.183 0.481 0.12167:54:10
ddt.demos.su 9.814 36.898 0.00000:31:35
47.237.96.200 0.019 0.060 0.00000:00:50
8.219.239.193 0.007 0.023 0.00000:00:27
47.237.69.21 0.005 0.026 0.00000:00:27
47.237.127.95 0.009 0.040 0.00000:00:27
47.237.127.235 0.005 0.025 0.00000:00:27
47.237.96.146 0.008 0.024 0.00000:00:26
47.237.96.30 0.010 0.021 0.00000:00:23
47.237.96.74 0.009 0.022 0.00000:00:21
47.237.124.184 0.013 0.053 0.00000:00:20
47.237.96.169 0.019 0.018 0.00000:00:20
47.237.116.54 0.011 0.020 0.00000:00:15
47.237.125.10 0.008 0.008 0.00000:00:10
47.237.66.68 0.000 0.016 0.00000:00:10
147.185.132.120 0.008 0.008 0.00000:00:10
198.235.24.109 0.004 0.012 0.00000:00:10
47.237.106.52 0.004 0.012 0.00000:00:10
47.237.97.104 0.004 0.012 0.00000:00:09
47.237.96.252 0.004 0.012 0.00000:00:09
TOTAL: 30 10.187 37.980 0.12168:32:13

Curious NNRP server explorers [Top 20]:

SystemConn
ddt.demos.su 2752
47.237.96.200 5
47.237.124.184 4
167.94.145.98 3
47.237.127.95 3
47.237.116.54 2
47.237.127.235 2
47.237.69.21 2
47.237.96.146 2
47.237.96.169 2
47.237.96.171 2
47.237.96.30 2
47.237.96.74 2
8.219.239.193 2
147.185.132.120 1
179.60.149.54 1
198.235.24.109 1
47.237.106.52 1
47.237.117.21 1
47.237.124.33 1
TOTAL: 29 2800

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

SystemConn
167.94.145.98 1
179.60.149.54 1
TOTAL: 2 2

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

CommandCount
#003 1
EHLO www.censys.io 1
TOTAL: 2 2

NNRP client timeouts [Top 20]:

SystemConnPeer
167.94.145.98 1 2
179.60.149.54 1 1
TOTAL: 2 2 11

Newsgroup request counts (by hierarchy):

HierarchyCountPct
1news 2 66.7%
2alt 1 33.3%
TOTAL: 2 3100.0%

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

NewsgroupCount
1alt.music.lyrics 1
2news.admin.peering 1
3news.answers 1
TOTAL: 3 3