Daily Usenet Report

Aug 12 00:01:01 -- Aug 13 00:01:01

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Aug 12 08:12:13 newsfeed innd: message repeated 2 times: [ ctlinnd command s]

Log entries by program:

Program nameLines%LinesSize%Size
inn 10959 32.9%4.4 MB 59.4%
innd 9109 27.4%1.3 MB 17.1%
nnrpd 8516 25.6%883.0 KB 11.7%
innfeed 4143 12.5%794.2 KB 10.6%
cnfsstat 432 1.3%63.5 KB 0.8%
nocem 112 0.3%22.2 KB 0.3%
controlchan 1 0.0%0.2 KB 0.0%
TOTAL: 7 33272 100.0%7.3 MB100.0%

History cache:

ReasonCount%Count
Positive hits 140818 61.2%
Negative hits 78643 34.2%
Do not exist 10538 4.6%
Cache misses 53 0.0%
TOTAL: 4 230052 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.383 0.0%329 0.000 1.164 9.000
article cleanup00:00:00.102 0.0%10568 0.000 0.010 0.074
article logging00:00:00.470 0.0%10658 0.000 0.044 0.185
article parse00:00:00.821 0.0%54152 0.000 0.015 0.073
article write00:00:02.564 0.0%9028 0.043 0.284 3.548
artlog/artcncl00:00:00.007 0.0%297 0.000 0.024 0.333
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:02.106 0.0%276724 0.000 0.008 0.292
hisgrep/artcncl00:00:00.185 0.0%325 0.000 0.569 6.000
hishave/artcncl00:00:00.027 0.0%298 0.000 0.091 2.667
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:03:28.472 0.2%230237 0.070 0.905 4.528
history sync00:00:00.078 0.0%387 0.000 0.202 1.667
history write00:02:58.633 0.2%10546 3.232 16.938 111.167
hiswrite/artcncl00:00:00.026 0.0%5 5.200 5.200 5.200
idle23:34:20.817 98.5%265456 73.887 319.679 2552.566
nntp read00:00:05.619 0.0%268791 0.002 0.021 0.210
overview write00:12:25.003 0.9%9028 0.328 82.521 8011.154
perl filter00:01:58.100 0.1%10546 1.530 11.199 52.309
python filter00:00:01.818 0.0%10546 0.000 0.172 4.301
site send00:00:01.093 0.0%18113 0.000 0.060 0.169
TOTAL: 23:56:23.54723:55:26.324 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:04.218 0.0%4617880 0.000 0.001 0.002
article prepare00:00:00.016 0.0%69288 0.000 0.000 0.004
article read00:00:01.168 0.0%6096 0.000 0.192 0.852
backlog stats00:00:01.978 0.0%1897084 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:11.818 0.0%1075982 0.006 0.011 0.043
data write00:00:13.070 0.0%1069891 0.007 0.012 0.024
idle23:47:58.616 99.8%1897084 34.517 45.163 56.857
status file00:00:00.373 0.0%290 0.971 1.286 28.000
TOTAL: 23:50:10.73323:48:31.257 99.9%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:21:46.657 67.5%8244 0.000 158.498 10047.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.283 0.0%16540 0.000 0.017 1.000
TOTAL: 00:32:16.02400:21:46.940 67.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 4 17567 2863 14131 573 16%46:27:42
2outgoing.news.lysator.liu.se 2 7975 1511 6390 74 18%23:59:50
3usenet.blueworldhosting.com 716 10283 1107 8727 449 10%23:57:23
4news.hispagatos.org 6 8999 580 8397 22 6%24:26:18
5usenet.goja.nl.eu.org 11 9406 513 8811 82 5%25:45:14
6nntp.comgw.net 2 9825 400 9299 126 4%24:09:01
7usenet.network 2 7718 379 7331 8 4%23:59:48
8news.corradoroberto.it 7 1263 308 955 0 24%25:02:26
9endoftheline-out.news.chmurka.net 3 5869 304 5562 3 5%24:08:50
10newsfeed.xs3.de 2 7783 227 7502 54 2%23:59:45
11i2pn.org 1 9512 218 9277 17 2%23:59:55
12newsfeed.bofh.team 2 10459 201 10248 10 1%23:59:47
13endofthelinebbs.peers.news.panix.com 25 9064 156 8877 31 1%24:04:35
14news.samoylyk.net 4 8845 154 8686 5 1%24:47:53
15news.netfront.net 1 6816 8 6706 102 0%24:26:51
16news.bbs.nz 2 9720 7 9713 0 0%23:58:58
17glockenspiel.complete.org 2 8638 3 8525 110 0%24:01:06
18news.furie.org.uk 175 5800 2 5796 2 0%22:19:52
19photonic.trudheim.com 1 1617 0 1617 0 0%23:59:57
20eotl-out.news.tnetconsulting.net 1 0 0 0 0 0%00:10:03
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 981 157159 8941 146550 1668 5%482:15:26
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1endofthelinebbs-out.news.weretis.net170.0 MB0.0 KB15.0 MB185.1 MB 91%55.1 KB
2usenet.blueworldhosting.com16.8 MB0.0 KB3.5 MB20.3 MB 82%13.4 KB
3outgoing.news.lysator.liu.se5.2 MB0.0 KB151.0 KB5.3 MB 97%3.4 KB
4usenet.network3.9 MB13.9 KB7.9 KB3.9 MB 99%10.3 KB
5news.corradoroberto.it1.9 MB0.0 KB0.0 KB1.9 MB100%6.4 KB
6nntp.comgw.net1.9 MB0.0 KB672.5 KB2.5 MB 74%5.0 KB
7news.samoylyk.net1.8 MB0.0 KB25.2 KB1.8 MB 98%11.7 KB
8news.hispagatos.org1.8 MB0.0 KB47.9 KB1.8 MB 97%3.1 KB
9usenet.goja.nl.eu.org1.5 MB0.0 KB112.8 KB1.6 MB 93%2.7 KB
10endoftheline-out.news.chmurka.net1.0 MB6.4 KB2.8 KB1.0 MB 99%3.5 KB
11i2pn.org874.6 KB0.0 KB27.4 KB902.0 KB 96%3.8 KB
12newsfeed.bofh.team759.0 KB2.5 KB11.1 KB772.7 KB 98%3.7 KB
13newsfeed.xs3.de639.0 KB0.0 KB225.7 KB864.7 KB 73%3.1 KB
14endofthelinebbs.peers.news.panix.com619.8 KB10.4 KB39.3 KB669.5 KB 92%3.6 KB
15glockenspiel.complete.org31.1 KB0.0 KB6.4 MB6.4 MB 0%58.4 KB
16news.bbs.nz25.8 KB0.0 KB0.0 KB25.8 KB100%3.7 KB
17news.netfront.net13.3 KB34.2 KB583.3 KB630.9 KB 2%5.7 KB
18news.furie.org.uk5.1 KB0.0 KB1.4 KB6.5 KB 77%1.6 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.nk.ca0.0 KB0.0 KB0.0 KB0.0 KB 0%0
22news.nntp4.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
23photonic.trudheim.com0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 23208.7 MB67.4 KB26.8 MB235.6 MB 88%22.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 12 00:01:01 - 00:59:59 219 2.4% 0.06615.2 KB 0.3% 0.17
Aug 12 01:00:00 - 01:59:59 293 3.2% 0.081.8 MB 0.9% 0.52
Aug 12 02:00:00 - 02:59:59 346 3.8% 0.101.9 MB 0.9% 0.54
Aug 12 03:00:00 - 03:59:59 374 4.1% 0.101.2 MB 0.6% 0.33
Aug 12 04:00:00 - 04:59:59 354 3.9% 0.101.2 MB 0.6% 0.34
Aug 12 05:00:00 - 05:59:59 333 3.7% 0.091.1 MB 0.5% 0.31
Aug 12 06:00:00 - 06:59:59 379 4.2% 0.111.2 MB 0.6% 0.34
Aug 12 07:00:00 - 07:59:59 331 3.7% 0.091.3 MB 0.6% 0.37
Aug 12 08:00:00 - 08:59:59 397 4.4% 0.111.5 MB 0.7% 0.43
Aug 12 09:00:00 - 09:59:59 434 4.8% 0.121.3 MB 0.6% 0.37
Aug 12 10:00:00 - 10:59:59 466 5.2% 0.132.2 MB 1.1% 0.64
Aug 12 11:00:00 - 11:59:59 389 4.3% 0.111.5 MB 0.7% 0.42
Aug 12 12:00:00 - 12:59:59 421 4.7% 0.121.8 MB 0.9% 0.52
Aug 12 13:00:00 - 13:59:59 385 4.3% 0.111.4 MB 0.7% 0.39
Aug 12 14:00:00 - 14:59:59 400 4.4% 0.111.4 MB 0.7% 0.41
Aug 12 15:00:00 - 15:59:59 460 5.1% 0.131.8 MB 0.9% 0.51
Aug 12 16:00:00 - 16:59:59 536 5.9% 0.1524.2 MB 11.5% 6.88
Aug 12 17:00:00 - 17:59:59 608 6.7% 0.1735.1 MB 16.7% 10.00
Aug 12 18:00:00 - 18:59:59 470 5.2% 0.1333.3 MB 15.9% 9.47
Aug 12 19:00:00 - 19:59:59 456 5.0% 0.1336.9 MB 17.6% 10.51
Aug 12 20:00:00 - 20:59:59 425 4.7% 0.1235.5 MB 16.9% 10.11
Aug 12 21:00:00 - 21:59:59 279 3.1% 0.0820.5 MB 9.8% 5.84
Aug 12 22:00:00 - 22:59:59 107 1.2% 0.03430.3 KB 0.2% 0.12
Aug 12 23:00:00 - 23:59:59 166 1.8% 0.05602.3 KB 0.3% 0.17
Aug 13 00:00:00 - 00:01:01 5 0.1% 0.0814.8 KB 0.0% 0.24
TOTAL: 24:00:00 9033 100.0% 0.10209.9 MB 100.0% 2.49
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.5235698.45
CYCTXT1TEXT5.0 GB3.8 GB 76.1% 0 4.15 14.62
TOTAL: 3-3077.0 GB100.0 GB 3.2% 1 1.79-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1endofthelinebbs-out.news.weretis.net 569 0 0 0 0 0 0 0 569
2usenet.blueworldhosting.com 485 2 0 0 0 0 0 0 483
3nntp.comgw.net 121 0 0 0 0 0 0 0 121
4news.netfront.net 106 0 0 11 0 0 0 0 95
5usenet.goja.nl.eu.org 86 0 0 0 0 0 0 0 86
6outgoing.news.lysator.liu.se 74 0 0 0 0 0 0 0 74
7newsfeed.xs3.de 57 0 0 0 0 0 0 0 57
8endofthelinebbs.peers.news.panix.com 32 1 0 3 0 0 0 0 28
9glockenspiel.complete.org 29 0 0 0 0 0 0 0 29
10news.hispagatos.org 23 0 0 0 0 0 0 0 23
11i2pn.org 18 0 0 0 0 0 0 0 18
12newsfeed.bofh.team 11 0 0 1 0 0 0 0 10
13usenet.network 9 0 0 5 0 0 0 0 4
14news.samoylyk.net 4 0 0 0 0 0 0 0 4
15endoftheline-out.news.chmurka.net 3 0 0 2 0 0 0 0 1
16news.furie.org.uk 2 0 0 0 0 0 0 0 2
TOTAL: 16 1629 3 0 22 0 0 0 0 1604

Unwanted newsgroups [Top 20]:

NewsgroupCount
soc.culture.africa 3
TOTAL: 1 3

INND Perl filter [Top 20]:

ReasonCount
EMP (phn path) 584
EMP (phr path) 555
EMP (md5) 205
Too many newsgroups 80
EMP (phn nph) 56
User-issued cancel 21
EMP (fsl) 8
HTML Multipart 3
Binary: misplaced binary 1
hierarchy violation - crosspost outside sdnet 1
TOTAL: 10 1514

NoCeM on Spool:

Issuer (type)NoticesBad PGPCancelSkipTotal
i2pn2-nocem@i2pn2.org (spam)5402970297
robot@pasdenom.info (spam3)30033
TOTAL: 25702973300

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
endofthelinebbs-out.news.weretis.net 40
usenet.blueworldhosting.com 36
usenet.goja.nl.eu.org 6
newsfeed.xs3.de 3
newsfeed.bofh.team 1
glockenspiel.complete.org 1
usenet.network 1
i2pn.org 1
endofthelinebbs.peers.news.panix.com 1
TOTAL: 9 90
TOTAL: 1 90

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.netfront.net 12838 4360 4665 0 0 23 33%23:59:51
2nyheter.lysator.liu.se 7828 2421 4593 505 0 0 30%23:59:28
3news.furie.org.uk 6923 1499 3867 11 0 0 21%23:59:18
4news.hispagatos.org 10233 1135 7053 252 0 0 11%23:59:32
5photonic.trudheim.com 9460 614 6337 2072 0 0 6%23:59:51
6usenet.network 8354 468 6573 38 0 0 5%23:59:51
7usenet.goja.nl.eu.org 9384 265 7253 195 0 1 2%23:59:51
8news.bbs.nz 16780 233 8384 405 0 86 1%23:59:51
9news.nk.ca 14368 214 8131 602 0 41 1%23:59:51
10newsfeed.bofh.team 11059 202 8540 1 0 1 1%23:59:30
11i2pn.org 9018 149 7525 51 0 29 1%23:59:51
12news.tnetconsulting.net 9203 96 7978 223 0 10 1%23:59:51
13news.corradoroberto.it 859 87 650 0 0 1 10%22:57:38
14news.weretis.net 9317 85 8801 146 0 0 0%23:59:44
15news.quux.org 9518 83 8489 426 0 0 0%23:59:29
16nntp.comgw.net 10792 79 8453 113 0 1 0%23:59:51
17news.chmurka.net 6937 75 4965 2 0 2 1%23:58:59
18newsfeed.xs3.de 11345 51 8612 151 0 1 0%23:59:34
19news.samoylyk.net 11386 23 8795 32 0 117 0%23:59:51
20news.nntp4.net4648653 0 0 0 04648650 0%23:59:51
21usenet.blueworldhosting.com 7233 0 6759 1 0 7 0%23:59:34
22endofthelinebbs.peers.news.panix.com 0 0 0 0 0 8298 0%23:59:51
23feed.opticnetworks.net 0 0 0 0 0 9033 0%23:57:41
TOTAL: 234841488 12139 136423 5226 04666301 0%550:48:39
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.netfront.net171.0 MB0.0 KB171.0 MB2.0 KB/s40.2 KB23:59:51
2nyheter.lysator.liu.se143.2 MB3.8 MB147.0 MB1.7 KB/s51.5 KB23:59:28
3news.furie.org.uk133.8 MB95.9 KB133.9 MB1.6 KB/s90.8 KB23:59:18
4news.hispagatos.org112.3 MB1.8 MB114.0 MB1.4 KB/s84.2 KB23:59:32
5usenet.network4.1 MB133.6 KB4.2 MB0.0 KB/s8.5 KB23:59:51
6photonic.trudheim.com4.0 MB145.8 MB149.8 MB1.8 KB/s57.1 KB23:59:51
7newsfeed.bofh.team1.6 MB2.2 KB1.6 MB0.0 KB/s7.8 KB23:59:30
8news.quux.org1.5 MB2.6 MB4.1 MB0.0 KB/s8.2 KB23:59:29
9news.nk.ca1.3 MB4.1 MB5.5 MB0.1 KB/s6.8 KB23:59:51
10usenet.goja.nl.eu.org1.3 MB1.8 MB3.1 MB0.0 KB/s6.9 KB23:59:51
11news.bbs.nz1.2 MB4.1 MB5.3 MB0.1 KB/s8.5 KB23:59:51
12news.samoylyk.net1011.1 KB267.8 KB1.2 MB0.0 KB/s23.3 KB23:59:51
13news.chmurka.net830.4 KB193.0 KB1023.4 KB0.0 KB/s13.3 KB23:58:59
14i2pn.org673.2 KB237.3 KB910.5 KB0.0 KB/s4.6 KB23:59:51
15news.tnetconsulting.net636.8 KB1.9 MB2.5 MB0.0 KB/s8.0 KB23:59:51
16news.weretis.net616.8 KB2.8 MB3.4 MB0.0 KB/s15.1 KB23:59:44
17nntp.comgw.net607.1 KB1.5 MB2.1 MB0.0 KB/s11.1 KB23:59:51
18newsfeed.xs3.de600.2 KB1.2 MB1.8 MB0.0 KB/s9.0 KB23:59:34
19news.corradoroberto.it335.4 KB0.0 KB335.4 KB0.0 KB/s3.9 KB22:57:38
20endofthelinebbs.peers.news.panix.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:51
21feed.opticnetworks.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:41
22news.nntp4.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:51
23usenet.blueworldhosting.com0.0 KB42.8 KB42.8 KB0.0 KB/s42.8 KB23:59:34
TOTAL: 23580.4 MB172.4 MB752.8 MB0.4 KB/s44.4 KB550:48:39
Outgoing feeds (innfeed) by Volume

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.demos.su2748 00.0 KB 0 0 000:31:51
2unresolved 8 00.0 KB 2 0 000:00:20
3*.stretchoid.com 1 00.0 KB 0 0 000:00:00
4? 1 00.0 KB 0 0 000:00:01
TOTAL: 42758 00.0 KB 2 0 000:32:14

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
ddt.demos.su 9.638 37.810 0.00000:31:51
198.235.24.241 0.000 0.016 0.00000:00:10
147.185.132.106 0.003 0.014 0.00000:00:05
167.94.145.111 0.016 0.050 0.00000:00:03
2607:ff10:c8:594::d 0.005 0.011 0.00000:00:01
194.165.16.73 0.009 0.009 0.00000:00:00
91.238.181.31 0.000 0.017 0.00000:00:00
205.210.31.245 0.000 0.016 0.00000:00:00
azpdwgb82.stretchoid.com 0.004 0.013 0.00000:00:00
TOTAL: 9 9.675 37.956 0.00000:32:14

Curious NNRP server explorers [Top 20]:

SystemConn
ddt.demos.su 2748
167.94.145.111 3
147.185.132.106 1
194.165.16.73 1
198.235.24.241 1
205.210.31.245 1
2607:ff10:c8:594::d 1
91.238.181.31 1
azpdwgb82.stretchoid.com 1
TOTAL: 9 2758

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

SystemConn
167.94.145.111 1
194.165.16.73 1
91.238.181.31 1
azpdwgb82.stretchoid.com 1
TOTAL: 4 4

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

CommandCount
#003 2
EHLO www.censys.io 1
MGLNDD_144.172.126.95_119 1
TOTAL: 3 4

NNRP client timeouts [Top 20]:

SystemConnPeer
167.94.145.111 1 2
194.165.16.73 1 1
91.238.181.31 1 1
TOTAL: 3 3 6

Newsgroup request counts (by hierarchy):

HierarchyCountPct
1news 5100.0%
TOTAL: 1 5100.0%

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

NewsgroupCount
1news.software.nntp 4
2news.admin.peering 1
TOTAL: 2 5