Daily Usenet Report

Sep 26 00:01:02 -- Sep 27 00:01:01

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Sep 26 08:12:37 newsfeed innd: message repeated 2 times: [ ctlinnd command s]
Sep 27 00:00:01 newsfeed nnrpd[2655687]: localhost auth: program exited with status 8

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 16768 45.1%2.0 MB 26.9%
inn 8092 21.8%3.4 MB 46.4%
innd 7774 20.9%1.1 MB 15.4%
innfeed 4065 10.9%778.2 KB 10.4%
cnfsstat 432 1.2%63.0 KB 0.8%
nocem 28 0.1%3.5 KB 0.0%
controlchan 1 0.0%0.0 KB 0.0%
TOTAL: 7 37160 100.0%7.3 MB100.0%

History cache:

ReasonCount%Count
Positive hits 115577 58.2%
Negative hits 74835 37.7%
Do not exist 7998 4.0%
Cache misses 6 0.0%
TOTAL: 4 198416 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.121 0.0%32 0.000 3.781 11.000
article cleanup00:00:00.327 0.0%8067 0.000 0.041 3.041
article logging00:00:00.641 0.0%8088 0.000 0.079 4.528
article parse00:00:00.174 0.0%12151 0.000 0.014 0.074
article write00:00:02.276 0.0%7029 0.000 0.324 5.909
artlog/artcncl00:00:00.000 0.0%2 0.000 0.000 0.000
artlog/artparse00:00:00.000 0.0%1 0.000 0.000 0.000
data move00:00:01.823 0.0%202514 0.000 0.009 0.376
hisgrep/artcncl00:00:00.092 0.0%34 0.000 2.706 8.333
hishave/artcncl00:00:00.000 0.0%2 0.000 0.000 0.000
hishave/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:02:30.424 0.2%199957 0.078 0.752 6.117
history sync00:00:00.078 0.0%393 0.000 0.198 1.000
history write00:02:05.179 0.1%8062 3.150 15.527 124.080
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:47:08.829 99.0%204581 90.140 418.557 1477.956
nntp read00:00:07.477 0.0%203299 0.002 0.037 1.345
overview write00:07:56.079 0.6%7029 0.750 67.731 4044.800
perl filter00:00:32.350 0.0%8061 1.676 4.013 37.857
python filter00:00:02.179 0.0%8061 0.000 0.270 7.604
site send00:00:01.335 0.0%14085 0.000 0.095 4.118
TOTAL: 24:01:29.10624:00:29.384 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.023 0.0%12186 0.000 0.002 0.059
article prepare00:00:00.010 0.0%40552 0.000 0.000 0.018
article read00:00:01.031 0.0%3173 0.000 0.325 15.952
backlog stats00:00:00.342 0.0%245925 0.000 0.001 0.006
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.227 0.0%172649 0.004 0.013 0.048
data write00:00:03.009 0.0%167624 0.007 0.018 0.042
idle23:58:59.975100.0%245925 145.580 351.083 1537.369
status file00:00:00.311 0.0%249 1.000 1.249 7.000
TOTAL: 23:59:16.40823:59:06.928100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:33:48.352 63.3%13346 0.750 151.982 10050.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:04.447 0.1%105496 0.000 0.042 1.000
TOTAL: 00:53:22.02900:33:52.799 63.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 4 14649 1793 12547 309 12%54:11:49
2outgoing.news.lysator.liu.se 1 6013 1561 4428 24 25%23:59:57
3usenet.blueworldhosting.com 716 7876 722 6891 263 9%23:59:29
4news.hispagatos.org 5 7309 592 6711 6 8%24:26:18
5nntp.comgw.net 2 7400 535 6662 203 7%23:59:53
6usenet.goja.nl.eu.org 11 7530 393 7066 71 5%25:51:23
7i2pn.org 3 7220 319 6841 60 4%23:59:38
8news.corradoroberto.it 6 1226 222 1003 1 18%23:39:13
9usenet.network 2 5370 205 5162 3 3%23:59:37
10endoftheline-out.news.chmurka.net 2 3702 195 3505 2 5%23:59:40
11newsfeed.bofh.team 1 7846 125 7709 12 1%23:59:55
12endofthelinebbs.peers.news.panix.com 25 7393 109 7276 8 1%23:55:34
13news.samoylyk.net 1 6246 84 6160 2 1%23:59:50
14newsfeed.xs3.de 1 5819 69 5748 2 1%23:59:53
15news.nntp4.net 2 6055 49 6006 0 0%23:59:39
16glockenspiel.complete.org 2 6036 30 6004 2 0%23:58:34
17news.furie.org.uk 4 6797 24 6772 1 0%47:59:06
18news.bbs.nz 1 6716 18 6698 0 0%23:59:44
19eotl-out.news.tnetconsulting.net 1 0 0 0 0 0%00:10:05
20localhost 26 0 0 0 0 0%00:00:00
21news.nk.ca 2 0 0 0 0 0%00:20:11
TOTAL: 21 818 121203 7045 113189 969 5%488:29:28
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1endofthelinebbs-out.news.weretis.net5.1 MB3.9 KB636.9 KB5.7 MB 89%2.8 KB
2outgoing.news.lysator.liu.se4.8 MB0.0 KB24.6 KB4.9 MB 99%3.1 KB
3usenet.network2.2 MB0.0 KB4.8 KB2.2 MB 99%10.7 KB
4usenet.blueworldhosting.com1.8 MB0.0 KB690.0 KB2.5 MB 73%2.6 KB
5nntp.comgw.net1.8 MB0.0 KB434.4 KB2.2 MB 80%3.0 KB
6news.hispagatos.org1.7 MB0.0 KB16.2 KB1.7 MB 99%2.9 KB
7news.corradoroberto.it1.3 MB0.0 KB1.8 KB1.3 MB 99%6.2 KB
8usenet.goja.nl.eu.org1.3 MB0.0 KB84.7 KB1.4 MB 94%3.0 KB
9i2pn.org1.1 MB355.7 KB101.1 KB1.6 MB 71%4.2 KB
10endoftheline-out.news.chmurka.net595.4 KB355.7 KB0.6 KB951.7 KB 62%4.8 KB
11newsfeed.bofh.team493.5 KB355.7 KB15.9 KB865.1 KB 57%6.3 KB
12newsfeed.xs3.de483.4 KB0.0 KB2.2 KB485.6 KB 99%6.8 KB
13news.samoylyk.net480.4 KB355.7 KB0.6 KB836.8 KB 57%9.7 KB
14endofthelinebbs.peers.news.panix.com265.6 KB0.0 KB47.2 KB312.8 KB 84%2.7 KB
15glockenspiel.complete.org208.1 KB0.0 KB3.6 KB211.7 KB 98%6.6 KB
16news.nntp4.net158.7 KB0.0 KB0.0 KB158.7 KB100%3.2 KB
17news.furie.org.uk86.3 KB355.7 KB0.0 KB442.1 KB 19%17.7 KB
18news.bbs.nz43.5 KB0.0 KB0.0 KB43.5 KB100%2.4 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
TOTAL: 2123.9 MB1.7 MB2.0 MB27.7 MB 86%3.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 26 00:01:02 - 00:59:59 136 1.9% 0.04395.7 KB 1.6% 0.11
Sep 26 01:00:00 - 01:59:59 246 3.5% 0.07735.7 KB 3.1% 0.20
Sep 26 02:00:00 - 02:59:59 308 4.4% 0.09855.9 KB 3.6% 0.24
Sep 26 03:00:00 - 03:59:59 431 6.1% 0.121.2 MB 5.2% 0.35
Sep 26 04:00:00 - 04:59:59 365 5.2% 0.101.3 MB 5.4% 0.36
Sep 26 05:00:00 - 05:59:59 376 5.3% 0.101.1 MB 4.8% 0.32
Sep 26 06:00:00 - 06:59:59 371 5.3% 0.101.1 MB 4.7% 0.32
Sep 26 07:00:00 - 07:59:59 331 4.7% 0.09996.4 KB 4.2% 0.28
Sep 26 08:00:00 - 08:59:59 378 5.4% 0.101.0 MB 4.4% 0.29
Sep 26 09:00:00 - 09:59:59 309 4.4% 0.09934.8 KB 3.9% 0.26
Sep 26 10:00:00 - 10:59:59 441 6.3% 0.121.4 MB 6.0% 0.40
Sep 26 11:00:00 - 11:59:59 417 5.9% 0.121.3 MB 5.7% 0.38
Sep 26 12:00:00 - 12:59:59 395 5.6% 0.111.3 MB 5.5% 0.37
Sep 26 13:00:00 - 13:59:59 387 5.5% 0.111.3 MB 5.7% 0.38
Sep 26 14:00:00 - 14:59:59 364 5.2% 0.101.3 MB 5.5% 0.36
Sep 26 15:00:00 - 15:59:59 352 5.0% 0.101.7 MB 7.2% 0.48
Sep 26 16:00:00 - 16:59:59 319 4.5% 0.091.2 MB 5.0% 0.33
Sep 26 17:00:00 - 17:59:59 254 3.6% 0.071.4 MB 5.9% 0.40
Sep 26 18:00:00 - 18:59:59 165 2.3% 0.05508.2 KB 2.1% 0.14
Sep 26 19:00:00 - 19:59:59 145 2.1% 0.04539.8 KB 2.2% 0.15
Sep 26 20:00:00 - 20:59:59 137 1.9% 0.04481.6 KB 2.0% 0.13
Sep 26 21:00:00 - 21:59:59 116 1.7% 0.03497.9 KB 2.1% 0.14
Sep 26 22:00:00 - 22:59:59 115 1.6% 0.03422.1 KB 1.8% 0.12
Sep 26 23:00:00 - 23:59:59 169 2.4% 0.05586.2 KB 2.4% 0.16
Sep 27 00:00:00 - 00:01:01 3 0.0% 0.056.4 KB 0.0% 0.10
TOTAL: 23:59:59 7030 100.0% 0.0823.4 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 GB97.9 GB 6.4% 0 0.4541680.23
CYCTXT1TEXT5.0 GB3.9 GB 77.4% 0 0.03 2055.20
TOTAL: 3-3077.0 GB101.8 GB 3.3% 1 0.32-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1endofthelinebbs-out.news.weretis.net 313 0 0 0 0 0 0 0 313
2usenet.blueworldhosting.com 270 0 0 0 0 0 0 0 270
3nntp.comgw.net 205 0 0 0 0 0 0 0 205
4news.netfront.net 78 0 0 0 0 0 0 0 78
5usenet.goja.nl.eu.org 64 0 0 0 0 0 0 0 64
6i2pn.org 61 0 0 1 0 0 0 0 60
7outgoing.news.lysator.liu.se 26 0 0 0 0 0 0 0 26
8newsfeed.bofh.team 12 0 0 1 0 0 0 0 11
9endofthelinebbs.peers.news.panix.com 9 1 0 0 0 0 0 0 8
10news.hispagatos.org 9 0 0 0 0 0 0 0 9
11glockenspiel.complete.org 3 0 0 1 0 0 0 0 2
12endoftheline-out.news.chmurka.net 2 0 0 1 0 0 0 0 1
13news.samoylyk.net 2 0 0 1 0 0 0 0 1
14newsfeed.xs3.de 2 0 0 0 0 0 0 0 2
15usenet.network 2 0 0 0 0 0 0 0 2
16news.corradoroberto.it 1 0 0 0 0 0 0 0 1
17news.furie.org.uk 1 0 0 1 0 0 0 0 0
TOTAL: 17 1060 1 0 6 0 0 0 0 1053

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.paradox 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (phn path) 413
EMP (phr path) 330
EMP (md5) 114
Too many newsgroups 92
User-issued cancel 49
Too many newsgroups (meow) 15
Binary: misplaced binary 9
HTML Multipart 5
EMP (fsl) 2
Too many newsgroups (low_xpost) 1
TOTAL: 10 1030

NoCeM on Spool:

Issuer (type)NoticesBad PGPCancelSkipTotal
i2pn2-nocem@i2pn2.org (multipost)16008585
i2pn2-nocem@i2pn2.org (rmp)30077
robot@pasdenom.info (spam3)50077
robot@pasdenom.info (spam2)30033
TOTAL: 42700102102

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
endofthelinebbs-out.news.weretis.net 8
usenet.blueworldhosting.com 7
outgoing.news.lysator.liu.se 2
news.netfront.net 2
endofthelinebbs.peers.news.panix.com 1
i2pn.org 1
usenet.goja.nl.eu.org 1
TOTAL: 7 22
No colon-space in header field
usenet.blueworldhosting.com 1
TOTAL: 1 1
TOTAL: 2 23

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.netfront.net 11471 1747 5215 0 0 1 15%23:59:53
2nyheter.lysator.liu.se 5611 1291 3867 308 0 0 23%23:59:53
3news.furie.org.uk 3420 964 2145 12 0 0 28%23:59:22
4endofthelinebbs.peers.news.panix.com 7241 385 6635 5 0 0 5%23:59:22
5usenet.goja.nl.eu.org 7318 380 6087 92 0 0 5%23:59:30
6news.hispagatos.org 7320 348 5906 172 0 0 4%23:59:53
7usenet.network 6978 243 6076 40 0 0 3%23:59:53
8photonic.trudheim.com 9396 231 8411 494 0 2978 2%23:59:50
9newsfeed.bofh.team 7677 216 6616 0 0 0 2%23:59:53
10nntp.comgw.net 7185 149 6284 60 0 0 2%23:58:54
11news.nk.ca 10062 147 6370 466 0 16 1%23:59:53
12news.nntp4.net 7783 139 6804 29 0 0 1%23:59:53
13news.bbs.nz 12852 135 6341 532 0 23 1%23:59:53
14i2pn.org 7703 115 6521 51 0 15 1%23:59:53
15news.tnetconsulting.net 7973 87 6764 173 0 7 1%23:59:53
16news.corradoroberto.it 1068 78 846 0 0 0 7%23:31:32
17news.weretis.net 7167 65 6859 104 0 0 0%23:59:52
18news.quux.org 7378 64 6478 448 0 0 0%23:59:53
19newsfeed.xs3.de 7911 47 6665 241 0 0 0%23:59:53
20news.chmurka.net 3789 27 3235 1 0 0 0%23:59:53
21news.samoylyk.net 7887 13 6879 38 0 1 0%23:59:53
22usenet.blueworldhosting.com 6462 1 6140 0 0 6 0%23:59:13
23feed.opticnetworks.net 0 0 0 0 0 7030 0%23:59:53
TOTAL: 23 161652 6872 127144 3266 0 10077 4%551:25:50
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.netfront.net7.2 MB0.0 KB7.2 MB0.1 KB/s4.2 KB23:59:53
2news.furie.org.uk5.5 MB131.0 KB5.7 MB0.1 KB/s6.0 KB23:59:22
3nyheter.lysator.liu.se3.9 MB2.3 MB6.2 MB0.1 KB/s4.0 KB23:59:53
4endofthelinebbs.peers.news.panix.com1.7 MB8.9 KB1.7 MB0.0 KB/s4.4 KB23:59:22
5photonic.trudheim.com1.2 MB1.4 MB2.6 MB0.0 KB/s3.7 KB23:59:50
6news.hispagatos.org1.1 MB1.2 MB2.4 MB0.0 KB/s4.7 KB23:59:53
7newsfeed.bofh.team1.0 MB0.0 KB1.0 MB0.0 KB/s4.8 KB23:59:53
8usenet.network833.6 KB88.7 KB922.4 KB0.0 KB/s3.3 KB23:59:53
9usenet.goja.nl.eu.org824.5 KB841.8 KB1.6 MB0.0 KB/s3.5 KB23:59:30
10nntp.comgw.net674.9 KB553.0 KB1.2 MB0.0 KB/s5.9 KB23:58:54
11news.nk.ca667.5 KB2.0 MB2.6 MB0.0 KB/s4.4 KB23:59:53
12news.quux.org595.5 KB1.9 MB2.5 MB0.0 KB/s4.9 KB23:59:53
13news.bbs.nz543.2 KB2.2 MB2.8 MB0.0 KB/s4.2 KB23:59:53
14newsfeed.xs3.de516.3 KB905.8 KB1.4 MB0.0 KB/s4.9 KB23:59:53
15news.tnetconsulting.net425.9 KB1.1 MB1.5 MB0.0 KB/s5.9 KB23:59:53
16i2pn.org417.3 KB223.0 KB640.2 KB0.0 KB/s3.9 KB23:59:53
17news.nntp4.net406.9 KB293.7 KB700.5 KB0.0 KB/s4.2 KB23:59:53
18news.weretis.net336.6 KB1.4 MB1.8 MB0.0 KB/s10.7 KB23:59:52
19news.samoylyk.net305.6 KB122.4 KB428.0 KB0.0 KB/s8.4 KB23:59:53
20news.corradoroberto.it249.3 KB0.0 KB249.3 KB0.0 KB/s3.2 KB23:31:32
21news.chmurka.net87.8 KB2.9 KB90.7 KB0.0 KB/s3.2 KB23:59:53
22usenet.blueworldhosting.com1.1 KB0.0 KB1.1 KB0.0 KB/s1.1 KB23:59:13
23feed.opticnetworks.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:53
TOTAL: 2328.5 MB16.6 MB45.1 MB0.0 KB/s4.6 KB551:25:50
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ddt.demos.su2762 00.0 KB 0 0 000:28:23
22001:470:28:a8:ca7f:54ff:fe03:41e01684 00.0 KB 0 0 000:12:17
3167.94.138.112 3 00.0 KB 0 0 000:00:04
4118.193.36.107 1 00.0 KB 0 0 000:00:00
5147.185.132.94 1 00.0 KB 0 0 000:00:10
6198.235.24.109 1 00.0 KB 0 0 000:00:10
7206.168.34.205 1 00.0 KB 0 0 000:00:00
891.238.181.32 1 00.0 KB 0 0 000:00:00
9azpdcgb71.stretchoid.com 1 00.0 KB 0 0 000:00:00
10azpdss48.stretchoid.com 1 00.0 KB 0 0 000:00:09
11localhost 1 00.0 KB 0 0 000:11:59
12server-0-3.survey.inspici.com 1 00.0 KB 0 0 000:00:03
TOTAL: 124458 00.0 KB 0 0 000:53:20

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.demos.su2762 00.0 KB 0 0 000:28:23
2?1685 00.0 KB 0 0 000:24:17
3unresolved 8 00.0 KB 0 0 000:00:26
4*.stretchoid.com 2 00.0 KB 0 0 000:00:10
5*.survey.inspici.com 1 00.0 KB 0 0 000:00:03
TOTAL: 54458 00.0 KB 0 0 000:53:20

NNRP auth users [Top 20]:

UserConn
getlist 1
TOTAL: 1 1

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
ddt.demos.su 9.461 36.781 0.00000:28:23
2001:470:28:a8:ca7f:54ff:fe03:41e0 5.580 21.527 0.00000:12:17
localhost 179.043 370.130 0.07400:11:59
147.185.132.94 0.004 0.012 0.00000:00:10
198.235.24.109 0.004 0.012 0.00000:00:10
azpdss48.stretchoid.com 0.003 0.018 0.00000:00:09
167.94.138.112 0.020 0.045 0.00000:00:04
server-0-3.survey.inspici.com 0.004 0.012 0.00000:00:03
118.193.36.107 0.000 0.016 0.00000:00:00
206.168.34.205 0.014 0.014 0.00000:00:00
91.238.181.32 0.000 0.016 0.00000:00:00
azpdcgb71.stretchoid.com 0.005 0.011 0.00000:00:00
TOTAL: 12 194.138 428.594 0.07400:53:20

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

SystemConn
167.94.138.112 1
206.168.34.205 1
91.238.181.32 1
azpdcgb71.stretchoid.com 1
TOTAL: 4 4

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

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

NNRP client timeouts [Top 20]:

SystemConnPeer
167.94.138.112 1 2
91.238.181.32 1 1
TOTAL: 2 2 3