Daily Usenet Report

Aug 18 00:01:01 -- Aug 19 00:01:01

Log entries by program:

Program nameLines%LinesSize%Size
inn 8471 29.0%3.5 MB 55.4%
nnrpd 8351 28.6%862.5 KB 13.3%
innd 7777 26.6%1.1 MB 17.3%
innfeed 4089 14.0%818.8 KB 12.6%
cnfsstat 432 1.5%65.1 KB 1.0%
nocem 85 0.3%21.5 KB 0.3%
controlchan 1 0.0%0.2 KB 0.0%
TOTAL: 7 29206 100.0%6.3 MB100.0%

History cache:

ReasonCount%Count
Positive hits 109402 59.8%
Negative hits 65288 35.7%
Do not exist 8103 4.4%
Cache misses 70 0.0%
TOTAL: 4 182863 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.438 0.0%391 0.000 1.120 14.000
article cleanup00:00:00.104 0.0%8104 0.000 0.013 0.157
article logging00:00:00.511 0.0%8147 0.000 0.063 1.086
article parse00:00:00.209 0.0%13889 0.000 0.015 0.069
article write00:00:02.201 0.0%7153 0.000 0.308 3.163
artlog/artcncl00:00:00.007 0.0%351 0.000 0.020 0.250
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.789 0.0%183705 0.000 0.004 0.285
hisgrep/artcncl00:00:00.202 0.0%377 0.000 0.536 11.000
hishave/artcncl00:00:00.030 0.0%351 0.000 0.085 1.867
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:02:22.878 0.2%183369 0.084 0.779 5.703
history sync00:00:00.064 0.0%396 0.000 0.162 1.500
history write00:01:58.448 0.1%8104 3.152 14.616 128.353
hiswrite/artcncl00:00:00.048 0.0%15 3.200 3.200 3.200
idle23:44:37.581 98.8%184494 79.323 463.308 1402.458
nntp read00:00:03.169 0.0%184528 0.005 0.017 0.553
overview write00:12:08.343 0.8%7153 0.860 101.823 11170.321
perl filter00:00:28.564 0.0%8104 1.304 3.525 39.955
python filter00:00:01.788 0.0%8104 0.000 0.221 7.788
site send00:00:00.882 0.0%14351 0.000 0.061 0.242
TOTAL: 24:02:36.32024:01:46.256 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:04.762 0.0%4850012 0.000 0.001 0.002
article prepare00:00:00.010 0.0%46312 0.000 0.000 0.005
article read00:00:00.567 0.0%4167 0.000 0.136 0.455
backlog stats00:00:02.143 0.0%2388190 0.000 0.001 0.002
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:14.195 0.0%1563451 0.005 0.009 0.019
data write00:00:14.746 0.0%1560182 0.005 0.009 0.015
idle23:47:40.565 99.8%2388190 28.143 35.868 47.916
status file00:00:00.338 0.0%247 0.667 1.368 33.000
TOTAL: 23:50:09.74723:48:17.326 99.9%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:22:10.870 71.6%8277 10.500 160.791 10050.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.270 0.0%16686 0.000 0.016 0.333
TOTAL: 00:30:59.90200:22:11.140 71.6%----

Control commands to INND:

CommandNumber
flush 5
flushlogs 2
go 2
logmode 2
lowmark 1
mode 100
name 2
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 122

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1endofthelinebbs-out.news.weretis.net 2 13218 2372 10492 354 17%50:21:20
2outgoing.news.lysator.liu.se 2 6134 1537 4523 74 25%23:59:44
3usenet.blueworldhosting.com 716 7779 825 6729 225 10%23:55:23
4news.corradoroberto.it 4 1365 462 903 0 33%24:45:47
5news.hispagatos.org 5 7017 448 6558 11 6%24:26:18
6nntp.comgw.net 1 7223 370 6762 91 5%23:59:56
7usenet.goja.nl.eu.org 10 7244 220 6990 34 3%23:41:37
8i2pn.org 1 7148 208 6929 11 2%23:59:55
9newsfeed.bofh.team 1 7830 157 7667 6 2%23:59:55
10usenet.network 2 5488 147 5338 3 2%23:59:27
11endofthelinebbs.peers.news.panix.com 26 7635 124 7500 11 1%23:53:36
12endoftheline-out.news.chmurka.net 2 3776 117 3656 3 3%23:59:52
13news.samoylyk.net 1 6423 33 6389 1 0%23:59:49
14newsfeed.xs3.de 1 6116 29 6086 1 0%23:59:54
15news.netfront.net 1 4837 21 4706 110 0%21:53:57
16glockenspiel.complete.org 2 5424 14 5409 1 0%24:01:34
17photonic.trudheim.com 1 1419 7 1412 0 0%20:28:56
18news.bbs.nz 1 6290 5 6285 0 0%23:59:41
19news.furie.org.uk 3 3989 0 3989 0 0%24:21:06
20eotl-out.news.tnetconsulting.net 1 0 0 0 0 0%00:10:04
21localhost 8 0 0 0 0 0%00:00:00
22news.nk.ca 2 0 0 0 0 0%00:20:11
23news.nntp4.net 1 0 0 0 0 0%00:10:01
TOTAL: 23 794 116355 7096 108323 936 6%478:28:03
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1endofthelinebbs-out.news.weretis.net10.4 MB0.0 KB582.4 KB10.9 MB 94%4.1 KB
2outgoing.news.lysator.liu.se4.6 MB0.0 KB98.4 KB4.7 MB 97%3.0 KB
3news.corradoroberto.it2.7 MB0.0 KB0.0 KB2.7 MB100%6.0 KB
4usenet.blueworldhosting.com2.3 MB0.0 KB466.3 KB2.8 MB 83%2.7 KB
5nntp.comgw.net1.3 MB0.0 KB172.0 KB1.5 MB 88%3.4 KB
6news.hispagatos.org1.3 MB0.0 KB45.3 KB1.4 MB 96%3.1 KB
7usenet.network1.2 MB0.0 KB3.3 KB1.2 MB 99%8.4 KB
8i2pn.org752.8 KB0.0 KB30.7 KB783.6 KB 96%3.6 KB
9usenet.goja.nl.eu.org582.6 KB0.0 KB40.6 KB623.2 KB 93%2.5 KB
10newsfeed.bofh.team562.4 KB0.0 KB8.0 KB570.5 KB 98%3.5 KB
11news.samoylyk.net523.4 KB0.0 KB0.7 KB524.1 KB 99%15.4 KB
12endofthelinebbs.peers.news.panix.com331.6 KB0.0 KB9.9 KB341.5 KB 97%2.5 KB
13endoftheline-out.news.chmurka.net323.0 KB0.0 KB2.1 KB325.1 KB 99%2.7 KB
14news.netfront.net196.7 KB0.0 KB5.2 MB5.4 MB 3%42.1 KB
15newsfeed.xs3.de101.6 KB0.0 KB3.7 KB105.3 KB 96%3.5 KB
16glockenspiel.complete.org35.5 KB0.0 KB0.7 KB36.2 KB 97%2.4 KB
17photonic.trudheim.com17.7 KB0.0 KB0.0 KB17.7 KB100%2.5 KB
18news.bbs.nz9.3 KB0.0 KB0.0 KB9.3 KB100%1.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.furie.org.uk0.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: 2327.3 MB0.0 KB6.6 MB33.9 MB 80%4.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 18 00:01:01 - 00:59:59 185 2.6% 0.05566.1 KB 1.9% 0.16
Aug 18 01:00:00 - 01:59:59 204 2.9% 0.061.2 MB 4.0% 0.33
Aug 18 02:00:00 - 02:59:59 240 3.4% 0.071.1 MB 3.8% 0.31
Aug 18 03:00:00 - 03:59:59 297 4.2% 0.08779.8 KB 2.6% 0.22
Aug 18 04:00:00 - 04:59:59 333 4.7% 0.09940.2 KB 3.2% 0.26
Aug 18 05:00:00 - 05:59:59 424 5.9% 0.121.3 MB 4.6% 0.38
Aug 18 06:00:00 - 06:59:59 450 6.3% 0.121.5 MB 5.0% 0.42
Aug 18 07:00:00 - 07:59:59 316 4.4% 0.091.4 MB 4.9% 0.41
Aug 18 08:00:00 - 08:59:59 354 5.0% 0.101.4 MB 4.8% 0.39
Aug 18 09:00:00 - 09:59:59 358 5.0% 0.101.1 MB 3.6% 0.30
Aug 18 10:00:00 - 10:59:59 400 5.6% 0.114.1 MB 14.3% 1.18
Aug 18 11:00:00 - 11:59:59 368 5.2% 0.102.4 MB 8.1% 0.67
Aug 18 12:00:00 - 12:59:59 463 6.5% 0.131.3 MB 4.5% 0.37
Aug 18 13:00:00 - 13:59:59 464 6.5% 0.131.5 MB 5.1% 0.42
Aug 18 14:00:00 - 14:59:59 404 5.7% 0.111.1 MB 3.9% 0.33
Aug 18 15:00:00 - 15:59:59 413 5.8% 0.111.5 MB 5.3% 0.44
Aug 18 16:00:00 - 16:59:59 280 3.9% 0.081.4 MB 4.9% 0.40
Aug 18 17:00:00 - 17:59:59 245 3.4% 0.07865.3 KB 2.9% 0.24
Aug 18 18:00:00 - 18:59:59 183 2.6% 0.05566.7 KB 1.9% 0.16
Aug 18 19:00:00 - 19:59:59 151 2.1% 0.04520.8 KB 1.8% 0.14
Aug 18 20:00:00 - 20:59:59 149 2.1% 0.04772.7 KB 2.6% 0.21
Aug 18 21:00:00 - 21:59:59 115 1.6% 0.03428.1 KB 1.4% 0.12
Aug 18 22:00:00 - 22:59:59 138 1.9% 0.04634.8 KB 2.1% 0.18
Aug 18 23:00:00 - 23:59:59 200 2.8% 0.06791.9 KB 2.7% 0.22
Aug 19 00:00:00 - 00:01:01 7 0.1% 0.1115.4 KB 0.1% 0.25
TOTAL: 24:00:00 7141 100.0% 0.0829.0 MB 100.0% 0.34
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.4937790.22
CYCTXT1TEXT5.0 GB3.8 GB 76.4% 0 0.06 967.25
TOTAL: 3-3077.0 GB100.2 GB 3.3% 1 0.35-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1endofthelinebbs-out.news.weretis.net 378 0 0 0 0 0 0 0 378
2usenet.blueworldhosting.com 238 2 0 0 0 0 0 0 236
3news.netfront.net 119 0 0 0 0 0 0 0 119
4nntp.comgw.net 98 0 0 0 0 0 0 0 98
5outgoing.news.lysator.liu.se 74 0 0 0 0 0 0 0 74
6usenet.goja.nl.eu.org 32 0 0 0 0 0 0 0 32
7endofthelinebbs.peers.news.panix.com 12 0 0 0 0 0 0 0 12
8news.hispagatos.org 12 0 0 0 0 0 0 0 12
9i2pn.org 11 0 0 0 0 0 0 0 11
10newsfeed.bofh.team 6 0 0 0 0 0 0 0 6
11endoftheline-out.news.chmurka.net 3 0 0 0 0 0 0 0 3
12usenet.network 3 0 0 0 0 0 0 0 3
13glockenspiel.complete.org 1 0 0 0 0 0 0 0 1
14news.corradoroberto.it 1 0 0 0 0 0 0 0 1
15news.samoylyk.net 1 0 0 0 0 0 0 0 1
16newsfeed.xs3.de 1 0 0 0 0 0 0 0 1
TOTAL: 16 990 2 0 0 0 0 0 0 988

Unwanted newsgroups [Top 20]:

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

INND Perl filter [Top 20]:

ReasonCount
EMP (phn path) 403
EMP (phr path) 329
Binary: misplaced binary 71
Too many newsgroups 61
EMP (md5) 48
User-issued cancel 15
HTML Multipart 9
Binary Image: misplaced jpg 8
hierarchy violation - crosspost outside sdnet 1
TOTAL: 9 945

NoCeM on Spool:

Issuer (type)NoticesBad PGPCancelSkipTotal
i2pn2-nocem@i2pn2.org (spam)4103390339
robot@pasdenom.info (spam3)20022
TOTAL: 24303392341

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
endofthelinebbs-out.news.weretis.net 24
usenet.blueworldhosting.com 13
endofthelinebbs.peers.news.panix.com 2
nntp.comgw.net 2
usenet.goja.nl.eu.org 1
news.corradoroberto.it 1
TOTAL: 6 43
TOTAL: 1 43

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.netfront.net 10831 2743 4377 0 0 77 25%23:59:53
2nyheter.lysator.liu.se 5740 1379 3947 274 0 13 24%23:59:53
3photonic.trudheim.com 7437 694 5618 815 0 14 9%23:58:51
4news.furie.org.uk 4451 556 3125 7 0 1 12%23:59:53
5news.hispagatos.org 7762 496 6046 111 0 19 6%23:59:53
6usenet.network 7554 386 6126 40 0 30 5%23:59:21
7endofthelinebbs.peers.news.panix.com 7353 383 6731 5 0 0 5%23:59:53
8news.bbs.nz 13126 283 6522 323 0 171 2%23:59:53
9usenet.goja.nl.eu.org 7994 257 6543 83 0 13 3%23:59:37
10news.tnetconsulting.net 7882 196 6833 88 0 45 2%23:59:53
11i2pn.org 7965 189 6637 59 0 125 2%23:59:53
12news.nk.ca 10678 178 6386 480 0 114 1%23:59:53
13news.corradoroberto.it 1172 171 668 1 0 3 14%23:36:51
14newsfeed.bofh.team 8073 159 6761 0 0 30 1%23:59:53
15news.quux.org 7533 152 6658 298 0 0 2%23:59:53
16news.weretis.net 7356 150 6911 78 0 0 2%23:59:50
17nntp.comgw.net 7708 105 6604 42 0 0 1%23:59:27
18news.chmurka.net 4429 96 3509 2 0 4 2%23:59:53
19newsfeed.xs3.de 8397 87 6942 62 0 23 1%23:59:46
20news.samoylyk.net 9038 28 6926 135 0 136 0%23:59:44
21news.nntp4.net4880221 0 0 0 04880203 0%23:59:53
22usenet.blueworldhosting.com 6428 0 6072 0 0 27 0%23:59:46
23feed.opticnetworks.net 0 0 0 0 0 7141 0%23:59:53
TOTAL: 235039128 8688 119942 2903 04888189 0%551:31:35
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.netfront.net13.6 MB0.0 KB13.6 MB0.2 KB/s5.1 KB23:59:53
2nyheter.lysator.liu.se8.8 MB1.8 MB10.6 MB0.1 KB/s6.5 KB23:59:53
3news.hispagatos.org5.3 MB585.3 KB5.9 MB0.1 KB/s10.0 KB23:59:53
4news.furie.org.uk4.3 MB20.6 KB4.3 MB0.1 KB/s7.8 KB23:59:53
5photonic.trudheim.com3.2 MB5.0 MB8.2 MB0.1 KB/s5.5 KB23:58:51
6newsfeed.bofh.team1.8 MB0.0 KB1.8 MB0.0 KB/s11.8 KB23:59:53
7news.bbs.nz1.8 MB1.9 MB3.7 MB0.0 KB/s6.3 KB23:59:53
8endofthelinebbs.peers.news.panix.com1.6 MB7.0 KB1.7 MB0.0 KB/s4.4 KB23:59:53
9usenet.network1.6 MB125.7 KB1.7 MB0.0 KB/s4.1 KB23:59:21
10nntp.comgw.net1.5 MB551.8 KB2.0 MB0.0 KB/s14.2 KB23:59:27
11news.quux.org1.1 MB1.1 MB2.2 MB0.0 KB/s5.0 KB23:59:53
12usenet.goja.nl.eu.org1012.6 KB601.6 KB1.6 MB0.0 KB/s4.7 KB23:59:37
13news.tnetconsulting.net913.7 KB551.0 KB1.4 MB0.0 KB/s5.2 KB23:59:53
14news.weretis.net775.3 KB696.7 KB1.4 MB0.0 KB/s6.5 KB23:59:50
15i2pn.org722.1 KB284.3 KB1006.3 KB0.0 KB/s4.1 KB23:59:53
16newsfeed.xs3.de679.0 KB592.6 KB1.2 MB0.0 KB/s8.5 KB23:59:46
17news.corradoroberto.it620.7 KB5.9 KB626.6 KB0.0 KB/s3.6 KB23:36:51
18news.nk.ca572.4 KB2.0 MB2.5 MB0.0 KB/s3.9 KB23:59:53
19news.chmurka.net421.9 KB134.3 KB556.2 KB0.0 KB/s5.7 KB23:59:53
20news.samoylyk.net382.9 KB2.0 MB2.4 MB0.0 KB/s15.0 KB23:59:44
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:46
TOTAL: 2350.5 MB17.9 MB68.4 MB0.0 KB/s6.0 KB551:31:35
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ddt.demos.su2755 00.0 KB 0 0 000:29:55
2167.94.138.56 3 00.0 KB 0 0 000:00:03
3199.45.154.155 3 00.0 KB 0 0 000:00:04
4172-232-203-103.ip.linodeusercontent.com 2 00.0 KB 0 0 000:00:18
5147.185.132.73 1 00.0 KB 0 0 000:00:05
6205.210.31.250 1 00.0 KB 0 0 000:00:10
7218.75.38.213 1 00.0 KB 0 0 000:00:10
888.214.25.64 1 00.0 KB 0 0 000:00:00
991.238.181.35 1 00.0 KB 0 0 000:00:00
10azpdsg30.stretchoid.com 1 00.0 KB 0 0 000:00:00
11azpdwsb5.stretchoid.com 1 00.0 KB 0 0 000:00:09
TOTAL: 112770 00.0 KB 0 0 000:30:58

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.demos.su2755 00.0 KB 0 0 000:29:55
2unresolved 11 00.0 KB 0 0 000:00:34
3*.ip.linodeusercontent.com 2 00.0 KB 0 0 000:00:18
4*.stretchoid.com 2 00.0 KB 0 0 000:00:09
TOTAL: 42770 00.0 KB 0 0 000:30:58

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
ddt.demos.su 9.900 36.439 0.00000:29:55
172-232-203-103.ip.linodeusercontent.com 0.005 0.028 0.00000:00:18
205.210.31.250 0.008 0.008 0.00000:00:10
218.75.38.213 0.004 0.012 0.00000:00:10
azpdwsb5.stretchoid.com 0.000 0.017 0.00000:00:09
147.185.132.73 0.005 0.010 0.00000:00:05
199.45.154.155 0.018 0.045 0.00000:00:04
167.94.138.56 0.016 0.045 0.00000:00:03
88.214.25.64 0.000 0.016 0.00000:00:00
91.238.181.35 0.008 0.008 0.00000:00:00
azpdsg30.stretchoid.com 0.000 0.016 0.00000:00:00
? 0.000 0.015 0.00000:00:00
TOTAL: 12 9.964 36.659 0.00000:30:58

NNRP gethostbyaddr failures [Top 20]:

SystemConn
? (can't getpeername) 1
TOTAL: 1 1

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

SystemConn
167.94.138.56 1
199.45.154.155 1
88.214.25.64 1
91.238.181.35 1
azpdsg30.stretchoid.com 1
TOTAL: 5 5

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

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

NNRP client timeouts [Top 20]:

SystemConnPeer
167.94.138.56 1 2
199.45.154.155 1 2
88.214.25.64 1 1
91.238.181.35 1 1
azpdsg30.stretchoid.com 1 1
TOTAL: 5 5 8