Daily Usenet Report

Oct 4 00:01:02 -- Oct 5 00:01:02

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Oct 4 08:12:17 newsfeed innd: message repeated 2 times: [ ctlinnd command s]
Oct 5 00:00:01 newsfeed nnrpd[3580268]: localhost auth: program exited with status 8

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 22728 51.3%2.7 MB 32.4%
inn 8975 20.3%3.7 MB 43.7%
innd 7975 18.0%1.1 MB 13.7%
innfeed 4141 9.3%803.9 KB 9.4%
cnfsstat 432 1.0%63.8 KB 0.7%
nocem 48 0.1%5.1 KB 0.1%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 7 44300 100.0%8.4 MB100.0%

History cache:

ReasonCount%Count
Positive hits 123262 59.4%
Negative hits 75473 36.4%
Do not exist 8813 4.2%
Cache misses 22 0.0%
TOTAL: 4 207570 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.094 0.0%38 0.000 2.474 8.000
article cleanup00:00:00.106 0.0%8835 0.000 0.012 0.082
article logging00:00:00.400 0.0%8953 0.000 0.045 0.185
article parse00:00:00.200 0.0%13282 0.000 0.015 0.077
article write00:00:02.235 0.0%7623 0.000 0.293 3.684
artlog/artcncl00:00:00.000 0.0%5 0.000 0.000 0.000
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.729 0.0%207678 0.000 0.004 0.224
hisgrep/artcncl00:00:00.072 0.0%42 0.000 1.714 6.000
hishave/artcncl00:00:00.000 0.0%5 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:38.477 0.2%208096 0.095 0.762 5.772
history sync00:00:00.063 0.0%391 0.000 0.161 1.000
history write00:01:55.599 0.1%8835 3.074 13.084 102.214
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:41:29.700 99.3%211960 84.105 402.386 1651.213
nntp read00:00:05.032 0.0%208287 0.000 0.024 1.068
overview write00:04:07.301 0.3%7623 0.556 32.441 1312.319
perl filter00:00:28.898 0.0%8835 1.585 3.271 17.240
python filter00:00:01.904 0.0%8835 0.000 0.216 28.316
site send00:00:01.209 0.0%15292 0.000 0.079 0.300
TOTAL: 23:52:00.74223:50:52.019 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.021 0.0%8487 0.000 0.002 0.042
article prepare00:00:00.007 0.0%61104 0.000 0.000 0.011
article read00:00:00.752 0.0%5352 0.000 0.141 0.556
backlog stats00:00:00.402 0.0%274830 0.000 0.001 0.009
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.600 0.0%191703 0.000 0.014 0.055
data write00:00:03.528 0.0%187517 0.004 0.019 0.036
idle23:58:25.030100.0%274830 117.679 314.031 1508.595
status file00:00:00.332 0.0%282 0.667 1.177 10.000
TOTAL: 23:58:47.85023:58:32.672100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:41:24.663 66.2%16812 0.500 147.791 5486.500
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:04.631 0.1%112565 0.000 0.041 1.333
TOTAL: 01:02:34.50500:41:29.294 66.3%----

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
1outgoing.news.lysator.liu.se 1 6300 1447 4842 11 22%23:59:57
2usenet.goja.nl.eu.org 11 8143 1360 6523 260 16%25:58:50
3usenet.blueworldhosting.com 715 8661 859 7407 395 9%23:56:02
4endofthelinebbs-out.news.weretis.net 4 14142 854 13092 196 6%48:33:37
5news.hispagatos.org 5 7946 532 7374 40 6%24:26:21
6news.corradoroberto.it 7 1571 505 1066 0 32%24:46:56
7usenet.network 2 6214 423 5786 5 6%23:59:53
8i2pn.org 1 7879 398 7406 75 5%23:59:55
9nntp.comgw.net 1 7896 361 7383 152 4%23:59:57
10endoftheline-out.news.chmurka.net 1 3759 250 3509 0 6%23:59:56
11newsfeed.xs3.de 2 6145 175 5967 3 2%23:59:43
12endofthelinebbs.peers.news.panix.com 25 8023 163 7855 5 2%23:55:02
13newsfeed.bofh.team 1 8594 118 8465 11 1%23:59:55
14news.samoylyk.net 2 6682 98 6584 0 1%23:59:17
15news.netfront.net 1 4572 74 4446 52 1%25:54:54
16news.furie.org.uk 2 8040 62 7976 2 0%47:59:51
17news.nntp4.net 2 6708 21 6687 0 0%23:59:42
18news.bbs.nz 2 10786 11 10774 1 0%37:21:14
19glockenspiel.complete.org 6 7027 8 7019 0 0%28:02:16
20eotl-out.news.tnetconsulting.net 1 0 0 0 0 0%00:10:03
21localhost 27 0 0 0 0 0%00:00:00
22news.nk.ca 2 0 0 0 0 0%00:20:11
TOTAL: 22 821 139088 7719 130161 1208 5%527:23:32
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1outgoing.news.lysator.liu.se4.2 MB0.0 KB11.7 KB4.2 MB 99%3.0 KB
2usenet.network4.1 MB0.0 KB5.0 KB4.2 MB 99%9.9 KB
3usenet.goja.nl.eu.org3.5 MB0.0 KB390.9 KB3.9 MB 90%2.5 KB
4news.corradoroberto.it3.4 MB0.0 KB0.0 KB3.4 MB100%6.9 KB
5endofthelinebbs-out.news.weretis.net2.7 MB0.0 KB429.9 KB3.1 MB 86%3.0 KB
6usenet.blueworldhosting.com2.1 MB0.0 KB724.9 KB2.8 MB 74%2.3 KB
7news.hispagatos.org1.5 MB0.0 KB60.0 KB1.6 MB 96%2.8 KB
8nntp.comgw.net1.2 MB0.0 KB338.4 KB1.6 MB 78%3.1 KB
9i2pn.org1.2 MB0.0 KB99.6 KB1.3 MB 92%2.8 KB
10endoftheline-out.news.chmurka.net979.8 KB0.0 KB0.0 KB979.8 KB100%3.9 KB
11endofthelinebbs.peers.news.panix.com542.7 KB0.0 KB16.0 KB558.7 KB 97%3.3 KB
12newsfeed.xs3.de518.5 KB0.0 KB6.8 KB525.3 KB 98%3.0 KB
13news.samoylyk.net383.7 KB0.0 KB0.0 KB383.7 KB100%3.9 KB
14newsfeed.bofh.team281.2 KB0.0 KB11.5 KB292.8 KB 96%2.3 KB
15news.furie.org.uk253.0 KB0.0 KB1.5 KB254.5 KB 99%4.0 KB
16news.netfront.net146.5 KB0.0 KB180.0 KB326.5 KB 44%2.6 KB
17glockenspiel.complete.org104.9 KB0.0 KB0.0 KB104.9 KB100%13.1 KB
18news.bbs.nz59.4 KB1.4 KB0.0 KB60.8 KB 97%5.1 KB
19news.nntp4.net44.5 KB0.0 KB0.0 KB44.5 KB100%2.1 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
TOTAL: 2227.2 MB1.4 KB2.2 MB29.4 MB 92%3.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 4 00:01:02 - 00:59:59 134 1.8% 0.04427.9 KB 1.5% 0.12
Oct 4 01:00:00 - 01:59:59 201 2.6% 0.06564.3 KB 2.0% 0.16
Oct 4 02:00:00 - 02:59:59 341 4.5% 0.091.2 MB 4.4% 0.34
Oct 4 03:00:00 - 03:59:59 398 5.2% 0.111.3 MB 4.7% 0.37
Oct 4 04:00:00 - 04:59:59 346 4.5% 0.101.3 MB 4.6% 0.36
Oct 4 05:00:00 - 05:59:59 390 5.1% 0.111.4 MB 5.0% 0.40
Oct 4 06:00:00 - 06:59:59 448 5.9% 0.121.6 MB 6.0% 0.47
Oct 4 07:00:00 - 07:59:59 378 5.0% 0.101.4 MB 5.0% 0.39
Oct 4 08:00:00 - 08:59:59 472 6.2% 0.131.4 MB 5.0% 0.39
Oct 4 09:00:00 - 09:59:59 434 5.7% 0.121.5 MB 5.3% 0.41
Oct 4 10:00:00 - 10:59:59 481 6.3% 0.131.9 MB 7.1% 0.55
Oct 4 11:00:00 - 11:59:59 424 5.6% 0.121.3 MB 4.9% 0.38
Oct 4 12:00:00 - 12:59:59 434 5.7% 0.121.6 MB 5.8% 0.46
Oct 4 13:00:00 - 13:59:59 425 5.6% 0.121.3 MB 4.6% 0.36
Oct 4 14:00:00 - 14:59:59 438 5.7% 0.121.4 MB 4.9% 0.39
Oct 4 15:00:00 - 15:59:59 401 5.3% 0.111.2 MB 4.5% 0.35
Oct 4 16:00:00 - 16:59:59 343 4.5% 0.101.3 MB 4.9% 0.38
Oct 4 17:00:00 - 17:59:59 264 3.5% 0.071.3 MB 4.6% 0.36
Oct 4 18:00:00 - 18:59:59 232 3.0% 0.061.1 MB 4.1% 0.32
Oct 4 19:00:00 - 19:59:59 166 2.2% 0.05704.9 KB 2.5% 0.20
Oct 4 20:00:00 - 20:59:59 109 1.4% 0.03420.4 KB 1.5% 0.12
Oct 4 21:00:00 - 21:59:59 106 1.4% 0.03657.7 KB 2.3% 0.18
Oct 4 22:00:00 - 22:59:59 124 1.6% 0.03494.2 KB 1.7% 0.14
Oct 4 23:00:00 - 23:59:59 142 1.9% 0.04854.2 KB 3.0% 0.24
Oct 5 00:00:00 - 00:01:02 4 0.1% 0.0617.3 KB 0.1% 0.28
TOTAL: 24:00:00 7635 100.0% 0.0927.6 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 GB98.2 GB 6.4% 0 0.5036971.24
CYCTXT1TEXT5.0 GB3.9 GB 77.6% 0 0.03 2000.16
TOTAL: 3-3077.0 GB102.1 GB 3.3% 1 0.35-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1usenet.blueworldhosting.com 422 1 0 0 0 0 0 0 421
2usenet.goja.nl.eu.org 270 0 0 0 0 0 0 0 270
3endofthelinebbs-out.news.weretis.net 251 0 0 0 0 0 0 0 251
4nntp.comgw.net 148 0 0 0 0 0 0 0 148
5news.netfront.net 81 0 0 0 0 0 0 0 81
6i2pn.org 75 0 0 0 0 0 0 0 75
7news.hispagatos.org 41 28 0 0 0 0 0 0 13
8outgoing.news.lysator.liu.se 13 0 0 0 0 0 0 0 13
9endofthelinebbs.peers.news.panix.com 12 0 0 0 0 0 0 0 12
10newsfeed.bofh.team 12 1 0 0 0 0 0 0 11
11usenet.network 5 0 0 0 0 0 0 0 5
12newsfeed.xs3.de 3 0 0 0 0 0 0 0 3
13news.furie.org.uk 2 0 0 0 0 0 0 0 2
TOTAL: 13 1335 30 0 0 0 0 0 0 1305

Unwanted newsgroups [Top 20]:

NewsgroupCount
hispagatos.hacking.ctf 23
hispagatos.hacking.news 4
hispagatos.hacking.exploits 1
soc.culture.africa 1
soc.culture.russia 1
TOTAL: 5 30

INND Perl filter [Top 20]:

ReasonCount
EMP (phn path) 652
EMP (phr path) 286
Too many newsgroups 95
EMP (md5) 86
User-issued cancel 27
Subject (LsDvhiePbokJjoAZwazgK@spot.net> Pearl) 20
EMP (fsl) 14
Too many newsgroups (meow) 5
EMP (phl) 1
HTML Multipart 1
TOTAL: 10 1187

NoCeM on Spool:

Issuer (type)NoticesBad PGPCancelSkipTotal
i2pn2-nocem@i2pn2.org (spam)10101
i2pn2-nocem@i2pn2.org (multipost)3500177177
i2pn2-nocem@i2pn2.org (rmp)30077
robot@pasdenom.info (spam3)40055
robot@pasdenom.info (spam2)30044
TOTAL: 54601193194

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
endofthelinebbs-out.news.weretis.net 66
usenet.blueworldhosting.com 27
usenet.goja.nl.eu.org 11
endofthelinebbs.peers.news.panix.com 6
news.hispagatos.org 3
outgoing.news.lysator.liu.se 2
nntp.comgw.net 1
newsfeed.bofh.team 1
newsfeed.xs3.de 1
TOTAL: 9 118
TOTAL: 1 118

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.netfront.net 10310 4221 3356 0 0 36 40%23:59:48
2nyheter.lysator.liu.se 6363 1571 4100 517 0 1 24%23:59:48
3news.furie.org.uk 4212 814 2889 26 0 6 19%23:58:50
4photonic.trudheim.com 7993 660 5836 1128 0 0 8%23:59:48
5endofthelinebbs.peers.news.panix.com 7927 491 7133 5 0 1 6%23:59:13
6news.hispagatos.org 8405 340 6512 224 0 20 4%23:59:48
7usenet.network 7975 333 6565 38 0 15 4%23:59:26
8usenet.goja.nl.eu.org 7374 327 5629 248 0 23 4%23:59:48
9newsfeed.bofh.team 8696 254 7180 0 0 30 2%23:59:44
10news.bbs.nz 13702 249 6771 605 0 406 1%23:59:48
11news.nk.ca 11362 150 6780 663 0 61 1%23:59:48
12news.tnetconsulting.net 8841 140 7213 274 0 17 1%23:59:44
13news.weretis.net 7974 140 7340 153 0 7 1%23:59:48
14news.nntp4.net 8769 127 7406 51 0 30 1%23:59:26
15i2pn.org 8618 127 7055 33 0 88 1%23:59:48
16nntp.comgw.net 8327 124 7030 120 0 29 1%23:59:28
17news.quux.org 8142 98 6951 579 0 20 1%23:59:48
18news.corradoroberto.it 1015 59 823 15 0 0 5%23:04:33
19news.chmurka.net 3947 49 3186 0 0 1 1%23:55:41
20newsfeed.xs3.de 8927 48 7152 264 0 23 0%23:59:44
21news.samoylyk.net 8779 14 7476 25 0 53 0%23:59:39
22usenet.blueworldhosting.com 6897 1 6522 0 0 0 0%23:59:23
23feed.opticnetworks.net 0 0 0 0 0 7635 0%23:59:48
TOTAL: 23 174555 10337 130905 4968 0 8502 5%550:52:39
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.netfront.net16.0 MB0.0 KB16.0 MB0.2 KB/s3.9 KB23:59:48
2news.furie.org.uk5.8 MB223.7 KB6.0 MB0.1 KB/s7.4 KB23:58:50
3nyheter.lysator.liu.se5.0 MB4.2 MB9.2 MB0.1 KB/s4.5 KB23:59:48
4photonic.trudheim.com4.2 MB3.0 MB7.3 MB0.1 KB/s4.2 KB23:59:48
5endofthelinebbs.peers.news.panix.com2.5 MB8.6 KB2.5 MB0.0 KB/s5.2 KB23:59:13
6newsfeed.bofh.team1.6 MB0.0 KB1.6 MB0.0 KB/s6.3 KB23:59:44
7usenet.network1.2 MB124.7 KB1.3 MB0.0 KB/s3.6 KB23:59:26
8news.quux.org1.1 MB3.5 MB4.6 MB0.1 KB/s6.9 KB23:59:48
9news.hispagatos.org1.0 MB1.6 MB2.6 MB0.0 KB/s4.8 KB23:59:48
10news.bbs.nz860.4 KB4.1 MB4.9 MB0.1 KB/s5.9 KB23:59:48
11news.weretis.net835.7 KB2.3 MB3.1 MB0.0 KB/s11.0 KB23:59:48
12usenet.goja.nl.eu.org755.2 KB2.4 MB3.2 MB0.0 KB/s5.6 KB23:59:48
13news.tnetconsulting.net728.2 KB1.7 MB2.4 MB0.0 KB/s6.0 KB23:59:44
14news.samoylyk.net661.1 KB155.1 KB816.3 KB0.0 KB/s20.9 KB23:59:39
15news.nntp4.net429.1 KB658.8 KB1.1 MB0.0 KB/s6.1 KB23:59:26
16nntp.comgw.net404.4 KB1.8 MB2.2 MB0.0 KB/s9.2 KB23:59:28
17i2pn.org373.8 KB209.8 KB583.5 KB0.0 KB/s3.6 KB23:59:48
18news.nk.ca322.8 KB4.5 MB4.9 MB0.1 KB/s6.1 KB23:59:48
19newsfeed.xs3.de270.8 KB2.0 MB2.3 MB0.0 KB/s7.6 KB23:59:44
20news.corradoroberto.it209.4 KB43.8 KB253.2 KB0.0 KB/s3.4 KB23:04:33
21news.chmurka.net183.6 KB0.0 KB183.6 KB0.0 KB/s3.7 KB23:55:41
22usenet.blueworldhosting.com4.2 KB0.0 KB4.2 KB0.0 KB/s4.2 KB23:59:23
23feed.opticnetworks.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:48
TOTAL: 2344.4 MB32.6 MB77.0 MB0.0 KB/s5.2 KB550:52:39
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
12001:470:28:a8:ca7f:54ff:fe03:41e02786 00.0 KB 0 0 000:20:20
2ddt.demos.su2780 00.0 KB 0 0 000:30:06
3139-144-52-241.ip.linodeusercontent.com 112 00.0 KB 0 0 000:00:35
4206.168.34.118 3 00.0 KB 0 0 000:00:05
5147.185.132.162 1 00.0 KB 0 0 000:00:00
6147.45.112.147 1 00.0 KB 0 0 000:00:00
7198.235.24.118 1 00.0 KB 0 0 000:00:00
8azpdwgb59.stretchoid.com 1 00.0 KB 0 0 000:00:00
9fabulous.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
10li1721-54.members.linode.com 1 00.0 KB 0 0 000:00:00
11localhost 1 00.0 KB 0 0 000:11:16
12server-0-3.survey.inspici.com 1 00.0 KB 0 0 000:00:03
TOTAL: 125689 00.0 KB 0 0 001:02:31

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1?2787 00.0 KB 0 0 000:31:37
2*.demos.su2780 00.0 KB 0 0 000:30:06
3*.ip.linodeusercontent.com 112 00.0 KB 0 0 000:00:35
4unresolved 6 00.0 KB 0 0 000:00:06
5*.members.linode.com 1 00.0 KB 0 0 000:00:00
6*.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
7*.stretchoid.com 1 00.0 KB 0 0 000:00:00
8*.survey.inspici.com 1 00.0 KB 0 0 000:00:03
TOTAL: 85689 00.0 KB 0 0 001:02:31

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.671 36.734 0.00000:30:06
2001:470:28:a8:ca7f:54ff:fe03:41e0 10.066 36.832 0.00000:20:20
localhost 180.783 369.632 0.08200:11:16
139-144-52-241.ip.linodeusercontent.com 1.722 1.824 0.00000:00:35
206.168.34.118 0.025 0.039 0.00000:00:05
server-0-3.survey.inspici.com 0.008 0.008 0.00000:00:03
fabulous.monitoring.internet-measurement.com 0.004 0.012 0.00000:00:01
147.185.132.162 0.005 0.011 0.00000:00:00
li1721-54.members.linode.com 0.004 0.012 0.00000:00:00
147.45.112.147 0.004 0.012 0.00000:00:00
198.235.24.118 0.005 0.014 0.00000:00:00
azpdwgb59.stretchoid.com 0.004 0.015 0.00000:00:00
TOTAL: 12 202.301 445.145 0.08201:02:31

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

SystemConn
147.45.112.147 1
206.168.34.118 1
azpdwgb59.stretchoid.com 1
TOTAL: 3 3

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

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

NNRP client timeouts [Top 20]:

SystemConnPeer
139-144-52-241.ip.linodeusercontent.com 1 1
147.45.112.147 1 1
206.168.34.118 1 2
TOTAL: 3 3 6