Daily Usenet Report

Oct 6 00:01:02 -- Oct 7 00:01:01

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Oct 6 08:12:24 newsfeed innd: message repeated 2 times: [ ctlinnd command s]
Oct 7 00:00:01 newsfeed nnrpd[653463]: localhost auth: program exited with status 8

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 22708 52.0%2.7 MB 34.0%
innd 8235 18.9%1.2 MB 14.6%
inn 8117 18.6%3.2 MB 40.5%
innfeed 4136 9.5%811.0 KB 10.0%
cnfsstat 432 1.0%63.9 KB 0.8%
nocem 22 0.1%2.6 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 7 43651 100.0%7.9 MB100.0%

History cache:

ReasonCount%Count
Positive hits 109317 60.1%
Negative hits 64672 35.5%
Do not exist 8002 4.4%
Cache misses 5 0.0%
TOTAL: 4 181996 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.130 0.0%62 0.000 2.097 19.000
article cleanup00:00:00.090 0.0%8021 0.000 0.011 0.243
article logging00:00:00.405 0.0%8093 0.000 0.050 0.214
article parse00:00:00.196 0.0%12387 0.000 0.016 0.069
article write00:00:02.099 0.0%6603 0.000 0.318 3.787
artlog/artcncl00:00:00.000 0.0%8 0.000 0.000 0.000
artlog/artparse00:00:00.000 0.0%1 0.000 0.000 0.000
data move00:00:00.713 0.0%182879 0.000 0.004 0.107
hisgrep/artcncl00:00:00.094 0.0%68 0.000 1.382 12.000
hishave/artcncl00:00:00.000 0.0%8 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:22.269 0.2%182500 0.102 0.780 5.245
history sync00:00:00.077 0.0%394 0.000 0.195 1.000
history write00:01:45.832 0.1%8022 2.769 13.193 84.471
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:52:33.253 99.4%188428 75.259 456.160 1935.368
nntp read00:00:02.908 0.0%183592 0.002 0.016 0.123
overview write00:03:22.436 0.2%6603 0.500 30.658 3447.667
perl filter00:00:29.192 0.0%8021 1.406 3.639 41.069
python filter00:00:01.692 0.0%8021 0.000 0.211 7.596
site send00:00:01.029 0.0%13225 0.000 0.078 0.225
TOTAL: 24:01:49.03324:00:42.415 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.021 0.0%7107 0.000 0.003 0.062
article prepare00:00:00.009 0.0%51896 0.000 0.000 0.008
article read00:00:00.621 0.0%4498 0.000 0.138 0.455
backlog stats00:00:00.349 0.0%243206 0.000 0.001 0.006
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.216 0.0%169463 0.000 0.013 0.047
data write00:00:02.955 0.0%162408 0.007 0.018 0.034
idle23:57:57.209100.0%243206 146.699 354.750 1487.124
status file00:00:00.365 0.0%290 1.000 1.259 24.000
TOTAL: 23:58:15.25823:58:03.745100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:42:03.232 66.2%16815 0.500 150.058 10051.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:04.531 0.1%112541 0.000 0.040 0.500
TOTAL: 01:03:32.40400:42:07.763 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 2 5653 1223 4426 4 21%23:59:30
2endofthelinebbs-out.news.weretis.net 4 12202 1066 10953 183 8%46:11:30
3usenet.blueworldhosting.com 716 7769 908 6280 581 11%23:57:52
4nntp.comgw.net 2 7262 676 6396 190 9%23:58:48
5usenet.goja.nl.eu.org 10 7163 583 6402 178 8%24:11:27
6news.hispagatos.org 6 7197 532 6639 26 7%24:25:56
7news.corradoroberto.it 14 1135 465 670 0 40%22:59:32
8i2pn.org 1 7022 355 6617 50 5%23:59:52
9usenet.network 1 5336 220 5115 1 4%23:59:57
10newsfeed.xs3.de 2 5732 218 5476 38 3%23:58:55
11endofthelinebbs.peers.news.panix.com 26 6984 118 6840 26 1%24:04:47
12newsfeed.bofh.team 1 7656 81 7562 13 1%23:59:56
13news.samoylyk.net 1 5793 71 5717 5 1%21:48:33
14news.netfront.net 1 4299 58 4152 89 1%23:22:00
15news.nntp4.net 1 6037 51 5986 0 0%23:59:53
16endoftheline-out.news.chmurka.net 2 3085 35 3050 0 1%23:59:19
17news.bbs.nz 1 6118 12 6105 1 0%23:59:48
18glockenspiel.complete.org 2 5193 10 5183 0 0%23:59:59
19news.furie.org.uk 3 6493 5 6488 0 0%47:59:50
20eotl-out.news.tnetconsulting.net 1 0 0 0 0 0%00:10:05
21localhost 28 0 0 0 0 0%00:00:00
22news.nk.ca 2 0 0 0 0 0%00:20:13
TOTAL: 22 827 118129 6687 110057 1385 5%499:27:42
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1endofthelinebbs-out.news.weretis.net4.6 MB0.0 KB336.9 KB4.9 MB 93%4.0 KB
2outgoing.news.lysator.liu.se3.5 MB0.0 KB9.1 KB3.6 MB 99%3.0 KB
3news.corradoroberto.it3.3 MB0.0 KB0.0 KB3.3 MB100%7.3 KB
4usenet.network2.2 MB0.0 KB60.3 KB2.3 MB 97%10.4 KB
5nntp.comgw.net2.2 MB0.0 KB290.0 KB2.5 MB 88%2.9 KB
6usenet.blueworldhosting.com2.1 MB0.0 KB1.4 MB3.5 MB 59%2.4 KB
7usenet.goja.nl.eu.org1.7 MB0.0 KB220.1 KB1.9 MB 88%2.6 KB
8news.hispagatos.org1.7 MB0.0 KB60.3 KB1.8 MB 96%3.3 KB
9i2pn.org996.6 KB0.0 KB82.2 KB1.1 MB 92%2.7 KB
10news.samoylyk.net770.8 KB0.0 KB5.5 KB776.3 KB 99%10.2 KB
11newsfeed.xs3.de559.5 KB0.0 KB75.4 KB634.9 KB 88%2.5 KB
12endofthelinebbs.peers.news.panix.com363.6 KB0.0 KB18.5 KB382.2 KB 95%2.7 KB
13newsfeed.bofh.team279.8 KB0.0 KB17.0 KB296.8 KB 94%3.2 KB
14news.netfront.net112.1 KB0.0 KB530.5 KB642.6 KB 17%4.4 KB
15news.nntp4.net112.0 KB0.0 KB0.0 KB112.0 KB100%2.2 KB
16glockenspiel.complete.org79.4 KB0.0 KB0.0 KB79.4 KB100%7.9 KB
17endoftheline-out.news.chmurka.net70.8 KB0.0 KB0.0 KB70.8 KB100%2.0 KB
18news.furie.org.uk49.3 KB0.0 KB0.0 KB49.3 KB100%9.9 KB
19news.bbs.nz25.7 KB0.0 KB1.2 KB26.9 KB 95%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: 2224.7 MB0.0 KB3.1 MB27.7 MB 88%3.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 6 00:01:02 - 00:59:59 147 2.2% 0.04516.2 KB 2.1% 0.15
Oct 6 01:00:00 - 01:59:59 217 3.3% 0.061.0 MB 4.2% 0.29
Oct 6 02:00:00 - 02:59:59 254 3.8% 0.07966.8 KB 3.9% 0.27
Oct 6 03:00:00 - 03:59:59 335 5.1% 0.09937.2 KB 3.7% 0.26
Oct 6 04:00:00 - 04:59:59 407 6.2% 0.111.7 MB 7.0% 0.49
Oct 6 05:00:00 - 05:59:59 365 5.5% 0.101.7 MB 6.8% 0.47
Oct 6 06:00:00 - 06:59:59 341 5.2% 0.091.1 MB 4.6% 0.32
Oct 6 07:00:00 - 07:59:59 367 5.5% 0.10959.0 KB 3.8% 0.27
Oct 6 08:00:00 - 08:59:59 327 4.9% 0.091.1 MB 4.6% 0.32
Oct 6 09:00:00 - 09:59:59 361 5.5% 0.101.0 MB 4.1% 0.29
Oct 6 10:00:00 - 10:59:59 365 5.5% 0.101.2 MB 4.7% 0.33
Oct 6 11:00:00 - 11:59:59 360 5.4% 0.101.8 MB 7.3% 0.51
Oct 6 12:00:00 - 12:59:59 428 6.5% 0.121.3 MB 5.5% 0.38
Oct 6 13:00:00 - 13:59:59 410 6.2% 0.111.3 MB 5.4% 0.38
Oct 6 14:00:00 - 14:59:59 326 4.9% 0.09982.7 KB 3.9% 0.27
Oct 6 15:00:00 - 15:59:59 364 5.5% 0.102.3 MB 9.5% 0.66
Oct 6 16:00:00 - 16:59:59 301 4.5% 0.081.1 MB 4.4% 0.31
Oct 6 17:00:00 - 17:59:59 270 4.1% 0.07979.3 KB 3.9% 0.27
Oct 6 18:00:00 - 18:59:59 128 1.9% 0.04475.6 KB 1.9% 0.13
Oct 6 19:00:00 - 19:59:59 116 1.8% 0.03441.2 KB 1.8% 0.12
Oct 6 20:00:00 - 20:59:59 95 1.4% 0.03304.3 KB 1.2% 0.08
Oct 6 21:00:00 - 21:59:59 79 1.2% 0.02348.6 KB 1.4% 0.10
Oct 6 22:00:00 - 22:59:59 94 1.4% 0.03387.8 KB 1.6% 0.11
Oct 6 23:00:00 - 23:59:59 153 2.3% 0.04591.5 KB 2.4% 0.16
Oct 7 00:00:00 - 00:01:01 7 0.1% 0.1113.6 KB 0.1% 0.22
TOTAL: 23:59:59 6617 100.0% 0.0824.4 MB 100.0% 0.29
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.3 GB 6.4% 0 0.4442812.17
CYCTXT1TEXT5.0 GB3.9 GB 77.7% 0 0.07 892.47
TOTAL: 3-3077.0 GB102.2 GB 3.3% 1 0.32-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1usenet.blueworldhosting.com 601 0 0 0 0 0 0 0 601
2endofthelinebbs-out.news.weretis.net 226 0 0 0 0 0 0 0 226
3nntp.comgw.net 208 0 0 0 0 0 0 0 208
4usenet.goja.nl.eu.org 183 0 0 0 0 0 0 0 183
5news.netfront.net 101 0 0 0 0 0 0 0 101
6i2pn.org 52 0 0 0 0 0 0 0 52
7newsfeed.xs3.de 42 0 0 0 0 0 0 0 42
8news.hispagatos.org 29 11 0 0 0 0 0 0 18
9endofthelinebbs.peers.news.panix.com 26 2 0 0 0 0 0 0 24
10newsfeed.bofh.team 13 0 0 0 0 0 0 0 13
11news.samoylyk.net 6 0 0 0 0 0 0 0 6
12outgoing.news.lysator.liu.se 4 0 0 0 0 0 0 0 4
13usenet.network 1 0 0 0 0 0 0 0 1
TOTAL: 13 1492 13 0 0 0 0 0 0 1479

Unwanted newsgroups [Top 20]:

NewsgroupCount
hispagatos.hacking.ctf 11
adminrosettamassagedubai.com 1
atl.binaries.android 1
TOTAL: 3 13

INND Perl filter [Top 20]:

ReasonCount
EMP (phn path) 567
EMP (md5) 421
EMP (phr path) 305
Too many newsgroups 51
User-issued cancel 33
HTML Multipart 12
Too many newsgroups (low_xpost) 7
Binary Image: misplaced jpg 3
EMP (fsl) 3
Binary: misplaced binary 2
Too many newsgroups (meow) 2
TOTAL: 11 1406

NoCeM on Spool:

Issuer (type)NoticesBad PGPCancelSkipTotal
i2pn2-nocem@i2pn2.org (spam)20202
i2pn2-nocem@i2pn2.org (multipost)7006262
robot@pasdenom.info (spam3)30099
i2pn2-nocem@i2pn2.org (rmp)20055
robot@pasdenom.info (spam2)50055
TOTAL: 519028183

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
endofthelinebbs-out.news.weretis.net 32
usenet.blueworldhosting.com 20
usenet.goja.nl.eu.org 10
nntp.comgw.net 4
newsfeed.xs3.de 4
news.hispagatos.org 2
TOTAL: 6 72
No colon-space in header field
usenet.blueworldhosting.com 1
TOTAL: 1 1
TOTAL: 2 73

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.netfront.net 9074 3518 3041 1 0 22 38%23:59:12
2nyheter.lysator.liu.se 5618 1540 3592 266 0 0 27%23:59:47
3news.furie.org.uk 3501 503 2458 7 0 17 14%23:59:51
4photonic.trudheim.com 7015 461 5018 1130 0 0 6%23:55:24
5usenet.goja.nl.eu.org 7026 422 5489 106 0 5 6%23:59:51
6endofthelinebbs.peers.news.panix.com 6991 421 6170 11 0 9 6%23:59:12
7news.hispagatos.org 7359 345 5728 110 0 7 4%23:59:51
8usenet.network 7122 313 5799 16 0 8 4%23:59:51
9news.bbs.nz 12014 303 5782 517 0 125 2%23:59:51
10newsfeed.bofh.team 7489 214 6200 1 0 17 2%23:59:44
11news.nk.ca 9669 186 5851 508 0 62 1%23:59:51
12news.nntp4.net 7543 163 6356 24 0 14 2%23:59:47
13news.tnetconsulting.net 7614 151 6277 174 0 24 1%23:59:51
14nntp.comgw.net 6801 146 5724 55 0 7 2%23:59:30
15news.weretis.net 6997 145 6390 80 0 5 2%23:59:51
16i2pn.org 7401 111 6050 59 0 107 1%23:59:51
17news.quux.org 7039 91 6027 485 0 22 1%23:59:51
18newsfeed.xs3.de 7744 65 6119 209 0 6 0%23:59:09
19news.chmurka.net 3335 38 2790 6 0 0 1%23:59:15
20news.samoylyk.net 7778 28 6470 22 0 41 0%23:59:51
21news.corradoroberto.it 582 22 485 17 0 0 3%22:01:46
22usenet.blueworldhosting.com 5806 1 5461 0 0 0 0%23:59:44
23feed.opticnetworks.net 0 0 0 0 0 6617 0%23:59:51
TOTAL: 23 151518 9187 113277 3804 0 7115 6%549:50:42
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.netfront.net13.2 MB1.5 KB13.3 MB0.2 KB/s3.9 KB23:59:12
2nyheter.lysator.liu.se5.3 MB1.9 MB7.2 MB0.1 KB/s4.1 KB23:59:47
3news.furie.org.uk4.2 MB204.2 KB4.4 MB0.1 KB/s8.9 KB23:59:51
4photonic.trudheim.com2.2 MB3.6 MB5.8 MB0.1 KB/s3.7 KB23:55:24
5news.hispagatos.org1.8 MB1.0 MB2.9 MB0.0 KB/s6.5 KB23:59:51
6endofthelinebbs.peers.news.panix.com1.8 MB15.9 KB1.8 MB0.0 KB/s4.2 KB23:59:12
7newsfeed.bofh.team1.7 MB2.7 KB1.7 MB0.0 KB/s8.3 KB23:59:44
8usenet.network1.1 MB31.6 KB1.2 MB0.0 KB/s3.6 KB23:59:51
9news.bbs.nz1.1 MB2.3 MB3.4 MB0.0 KB/s4.2 KB23:59:51
10news.nntp4.net1015.7 KB388.2 KB1.4 MB0.0 KB/s7.5 KB23:59:47
11usenet.goja.nl.eu.org897.6 KB841.7 KB1.7 MB0.0 KB/s3.3 KB23:59:51
12nntp.comgw.net747.7 KB799.4 KB1.5 MB0.0 KB/s7.7 KB23:59:30
13news.tnetconsulting.net711.3 KB795.4 KB1.5 MB0.0 KB/s4.6 KB23:59:51
14news.weretis.net692.8 KB1.6 MB2.2 MB0.0 KB/s10.2 KB23:59:51
15news.quux.org650.1 KB1.9 MB2.5 MB0.0 KB/s4.4 KB23:59:51
16news.samoylyk.net535.4 KB222.5 KB757.9 KB0.0 KB/s15.2 KB23:59:51
17news.nk.ca410.2 KB2.3 MB2.7 MB0.0 KB/s3.9 KB23:59:51
18i2pn.org324.4 KB408.1 KB732.4 KB0.0 KB/s4.3 KB23:59:51
19newsfeed.xs3.de259.3 KB1.1 MB1.3 MB0.0 KB/s5.0 KB23:59:09
20news.chmurka.net130.6 KB359.1 KB489.7 KB0.0 KB/s11.1 KB23:59:15
21news.corradoroberto.it70.3 KB51.8 KB122.1 KB0.0 KB/s3.1 KB22:01:46
22usenet.blueworldhosting.com4.2 KB0.0 KB4.2 KB0.0 KB/s4.2 KB23:59:44
23feed.opticnetworks.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:51
TOTAL: 2338.8 MB19.6 MB58.5 MB0.0 KB/s4.6 KB549:50:42
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
12001:470:28:a8:ca7f:54ff:fe03:41e02799 00.0 KB 0 0 000:20:37
2ddt.demos.su2769 00.0 KB 0 0 000:29:10
3139-144-52-241.ip.linodeusercontent.com 105 00.0 KB 0 0 000:00:20
4ec2-13-58-97-162.us-east-2.compute.amazonaws.com 4 00.0 KB 0 0 000:00:00
5167.94.145.108 3 00.0 KB 0 0 000:00:03
6147.45.112.151 1 00.0 KB 0 0 000:00:00
7198.235.24.201 1 00.0 KB 0 0 000:00:02
8198.235.24.218 1 00.0 KB 0 0 000:00:10
947.236.157.60 1 00.0 KB 0 0 000:00:03
1047.245.121.208 1 00.0 KB 0 0 000:00:00
1180.66.76.134 1 00.0 KB 0 0 000:00:00
12azpdws71.stretchoid.com 1 00.0 KB 0 0 000:00:09
13cozy.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
14localhost 1 00.0 KB 0 0 000:12:44
15server-0-3.survey.inspici.com 1 00.0 KB 0 0 000:00:03
TOTAL: 155690 00.0 KB 0 0 001:03:29

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1?2800 00.0 KB 0 0 000:33:21
2*.demos.su2769 00.0 KB 0 0 000:29:10
3*.ip.linodeusercontent.com 105 00.0 KB 0 0 000:00:20
4unresolved 9 00.0 KB 0 0 000:00:21
5*.us-east-2.compute.amazonaws.com 4 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:09
8*.survey.inspici.com 1 00.0 KB 0 0 000:00:03
TOTAL: 85690 00.0 KB 0 0 001:03:29

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.619 36.607 0.00000:29:10
2001:470:28:a8:ca7f:54ff:fe03:41e0 9.886 36.969 0.00000:20:37
localhost 181.060 368.683 0.07500:12:44
139-144-52-241.ip.linodeusercontent.com 1.727 1.629 0.00000:00:20
198.235.24.218 0.003 0.014 0.00000:00:10
azpdws71.stretchoid.com 0.000 0.016 0.00000:00:09
167.94.145.108 0.027 0.035 0.00000:00:03
47.236.157.60 0.008 0.008 0.00000:00:03
server-0-3.survey.inspici.com 0.000 0.018 0.00000:00:03
198.235.24.201 0.000 0.016 0.00000:00:02
cozy.monitoring.internet-measurement.com 0.000 0.017 0.00000:00:01
47.245.121.208 0.004 0.012 0.00000:00:00
ec2-13-58-97-162.us-east-2.compute.amazonaws.com 0.016 0.048 0.00000:00:00
80.66.76.134 0.003 0.013 0.00000:00:00
147.45.112.151 0.005 0.011 0.00000:00:00
TOTAL: 15 202.358 444.096 0.07501:03:29

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

SystemConn
ec2-13-58-97-162.us-east-2.compute.amazonaws.com 3
147.45.112.151 1
167.94.145.108 1
80.66.76.134 1
TOTAL: 4 6

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

CommandCount
#003 2
#026#003#001 2
#001 1
EHLO www.censys.io 1
TOTAL: 4 6

NNRP client timeouts [Top 20]:

SystemConnPeer
139-144-52-241.ip.linodeusercontent.com 1 1
147.45.112.151 1 1
167.94.145.108 1 2
80.66.76.134 1 1
TOTAL: 4 4 6