Daily Usenet Report

Dec 4 00:01:01 -- Dec 5 00:01:02

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Dec 4 08:13:29 newsfeed innd: message repeated 2 times: [ ctlinnd command s]
Dec 5 00:00:02 newsfeed nnrpd[654974]: localhost auth: program exited with status 8

Log entries by program:

Program nameLines%LinesSize%Size
inn 9239 39.8%3.6 MB 61.9%
innd 9123 39.3%1.3 MB 22.9%
innfeed 4344 18.7%831.2 KB 13.9%
cnfsstat 432 1.9%64.0 KB 1.1%
nocem 56 0.2%7.2 KB 0.1%
nnrpd 38 0.2%4.3 KB 0.1%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 7 23233 100.0%5.8 MB100.0%

History cache:

ReasonCount%Count
Positive hits 119347 65.2%
Negative hits 54646 29.8%
Do not exist 9140 5.0%
Cache misses 7 0.0%
TOTAL: 4 183140 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.200 0.0%44 0.000 4.545 9.000
article cleanup00:00:00.113 0.0%9215 0.000 0.012 0.241
article logging00:00:00.488 0.0%9242 0.000 0.053 1.097
article parse00:00:00.222 0.0%15041 0.000 0.015 0.115
article write00:00:02.090 0.0%7188 0.000 0.291 4.583
artlog/artcncl00:00:00.000 0.0%6 0.000 0.000 0.000
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:02.379 0.0%186880 0.000 0.013 0.370
hisgrep/artcncl00:00:00.157 0.0%44 0.000 3.568 4.667
hishave/artcncl00:00:00.001 0.0%6 0.000 0.167 0.333
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:54.046 0.2%184488 0.117 0.943 7.448
history sync00:00:00.072 0.0%409 0.000 0.176 1.000
history write00:02:05.748 0.1%9215 3.231 13.646 115.047
hiswrite/artcncl00:00:00.004 0.0%1 4.000 4.000 4.000
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:50:30.124 99.2%180467 90.952 475.600 2293.812
nntp read00:00:03.959 0.0%187506 0.002 0.021 0.665
overview write00:04:26.967 0.3%7188 0.524 37.141 1754.349
perl filter00:00:32.859 0.0%9215 1.274 3.566 31.021
python filter00:00:02.019 0.0%9215 0.000 0.219 4.532
site send00:00:01.230 0.0%14428 0.000 0.085 3.625
TOTAL: 24:01:22.60824:00:42.678100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.022 0.0%7441 0.000 0.003 0.053
article prepare00:00:00.014 0.0%58868 0.000 0.000 0.006
article read00:00:00.740 0.0%4870 0.000 0.152 0.455
backlog stats00:00:00.460 0.0%279535 0.000 0.002 0.006
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.397 0.0%184819 0.000 0.013 0.057
data write00:00:03.368 0.0%179543 0.007 0.019 0.032
idle23:58:24.407100.0%279535 140.268 308.743 1404.664
status file00:00:00.517 0.0%377 1.000 1.371 36.000
TOTAL: 23:58:42.20623:58:31.925100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:30.003 4.3%15 0.250 2000.200 10050.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:04.074 0.6%78770 0.000 0.052 0.052
TOTAL: 00:11:34.12200:00:34.077 4.9%----

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 3 13782 3233 10114 435 23%47:17:29
2usenet.blueworldhosting.com 716 8916 875 7133 908 9%23:55:40
3news.corradoroberto.it 12 1258 439 819 0 34%23:45:32
4usenet.network 2 6028 428 5579 21 7%23:59:55
5glockenspiel.complete.org 2 4848 379 4468 1 7%20:07:04
6endoftheline-out.news.chmurka.net 1 3586 309 3277 0 8%23:59:57
7i2pn.org 1 7944 260 7629 55 3%23:59:56
8194.87.241.33 39 304 235 68 1 77%16:35:17
9nntp.comgw.net 1 8189 207 7790 192 2%23:59:57
10newsfeed.bofh.team 1 8673 166 8425 82 1%23:59:56
11usenet.goja.nl.eu.org 11 7948 150 7728 70 1%23:52:42
12endofthelinebbs.peers.news.panix.com 26 7624 109 7490 25 1%23:54:56
13news.netfront.net 1 7212 97 6962 153 1%24:50:52
14news.nntp4.net 1 6451 95 6327 29 1%23:59:54
15news.samoylyk.net 3 6663 80 6581 2 1%23:59:38
16newsfeed.xs3.de 1 6013 38 5955 20 0%23:59:54
17news.hispagatos.org 10 8351 20 8305 26 0%24:53:13
18news.bbs.nz 2 6254 4 6250 0 0%23:59:31
19news.furie.org.uk 1 3784 4 3780 0 0%23:59:57
20outgoing.news.lysator.liu.se 1 4123 1 4121 1 0%23:59:56
21eotl-out.news.tnetconsulting.net 1 0 0 0 0 0%00:10:08
22localhost 28 0 0 0 0 0%00:00:00
23news.nk.ca 2 0 0 0 0 0%00:20:12
TOTAL: 23 866 127951 7129 118801 2021 5%493:41:36
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1endofthelinebbs-out.news.weretis.net9.7 MB0.0 KB828.2 KB10.5 MB 92%2.9 KB
2usenet.network5.7 MB0.0 KB20.0 KB5.7 MB 99%13.0 KB
3news.corradoroberto.it2.2 MB0.0 KB0.0 KB2.2 MB100%5.2 KB
4usenet.blueworldhosting.com2.2 MB0.0 KB2.1 MB4.3 MB 51%2.5 KB
5glockenspiel.complete.org1.9 MB0.0 KB0.7 KB1.9 MB 99%5.0 KB
6194.87.241.331.5 MB0.0 KB1.5 KB1.5 MB 99%6.4 KB
7endoftheline-out.news.chmurka.net1.2 MB0.0 KB0.0 KB1.2 MB100%4.0 KB
8i2pn.org857.0 KB0.0 KB74.3 KB931.3 KB 92%3.0 KB
9nntp.comgw.net568.8 KB0.0 KB379.8 KB948.6 KB 59%2.4 KB
10usenet.goja.nl.eu.org523.8 KB0.0 KB91.6 KB615.5 KB 85%2.8 KB
11newsfeed.bofh.team450.9 KB0.0 KB125.3 KB576.2 KB 78%2.3 KB
12news.samoylyk.net326.2 KB0.0 KB2.6 KB328.8 KB 99%4.0 KB
13endofthelinebbs.peers.news.panix.com276.4 KB0.0 KB18.8 KB295.1 KB 93%2.2 KB
14news.nntp4.net254.6 KB0.0 KB87.9 KB342.5 KB 74%2.8 KB
15news.netfront.net214.3 KB0.0 KB5.4 MB5.6 MB 3%22.9 KB
16newsfeed.xs3.de170.9 KB0.0 KB83.2 KB254.1 KB 67%4.4 KB
17news.hispagatos.org74.4 KB0.0 KB38.3 KB112.7 KB 66%2.4 KB
18news.furie.org.uk24.1 KB0.0 KB0.0 KB24.1 KB100%6.0 KB
19news.bbs.nz7.7 KB0.0 KB0.0 KB7.7 KB100%1.9 KB
20outgoing.news.lysator.liu.se1.6 KB0.0 KB2.9 KB4.4 KB 35%2.2 KB
21eotl-out.news.tnetconsulting.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
22localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
23news.nk.ca0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 2328.1 MB0.0 KB9.2 MB37.3 MB 75%4.2 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Dec 4 00:01:01 - 00:59:59 165 2.3% 0.05693.8 KB 2.4% 0.20
Dec 4 01:00:00 - 01:59:59 245 3.4% 0.071.2 MB 4.4% 0.35
Dec 4 02:00:00 - 02:59:59 288 4.0% 0.081.1 MB 3.9% 0.31
Dec 4 03:00:00 - 03:59:59 357 5.0% 0.101.3 MB 4.8% 0.38
Dec 4 04:00:00 - 04:59:59 401 5.6% 0.111.7 MB 6.0% 0.48
Dec 4 05:00:00 - 05:59:59 433 6.0% 0.121.3 MB 4.6% 0.37
Dec 4 06:00:00 - 06:59:59 415 5.8% 0.121.7 MB 6.1% 0.48
Dec 4 07:00:00 - 07:59:59 423 5.9% 0.121.4 MB 4.8% 0.39
Dec 4 08:00:00 - 08:59:59 381 5.3% 0.111.6 MB 5.5% 0.44
Dec 4 09:00:00 - 09:59:59 434 6.0% 0.121.6 MB 5.7% 0.45
Dec 4 10:00:00 - 10:59:59 425 5.9% 0.121.6 MB 5.6% 0.45
Dec 4 11:00:00 - 11:59:59 481 6.7% 0.131.7 MB 6.2% 0.49
Dec 4 12:00:00 - 12:59:59 318 4.4% 0.091.0 MB 3.7% 0.30
Dec 4 13:00:00 - 13:59:59 348 4.8% 0.101.2 MB 4.2% 0.33
Dec 4 14:00:00 - 14:59:59 353 4.9% 0.101.3 MB 4.5% 0.36
Dec 4 15:00:00 - 15:59:59 331 4.6% 0.091.6 MB 5.8% 0.46
Dec 4 16:00:00 - 16:59:59 329 4.6% 0.091.7 MB 5.9% 0.47
Dec 4 17:00:00 - 17:59:59 221 3.1% 0.061.1 MB 4.0% 0.32
Dec 4 18:00:00 - 18:59:59 155 2.2% 0.04634.2 KB 2.2% 0.18
Dec 4 19:00:00 - 19:59:59 158 2.2% 0.04656.1 KB 2.3% 0.18
Dec 4 20:00:00 - 20:59:59 98 1.4% 0.03415.7 KB 1.4% 0.12
Dec 4 21:00:00 - 21:59:59 119 1.7% 0.03498.7 KB 1.7% 0.14
Dec 4 22:00:00 - 22:59:59 157 2.2% 0.04587.9 KB 2.0% 0.16
Dec 4 23:00:00 - 23:59:59 142 2.0% 0.04616.0 KB 2.1% 0.17
Dec 5 00:00:00 - 00:01:02 3 0.0% 0.0512.4 KB 0.0% 0.20
TOTAL: 24:00:01 7180 100.0% 0.0828.1 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 GB100.7 GB 6.6% 0 0.5037648.27
CYCTXT1TEXT5.0 GB4.0 GB 79.1% 0 0.03 2071.62
TOTAL: 3-3077.0 GB104.7 GB 3.4% 1 0.35-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1usenet.blueworldhosting.com 915 0 0 0 0 0 0 0 915
2endofthelinebbs-out.news.weretis.net 434 0 0 0 0 0 0 0 434
3nntp.comgw.net 200 0 0 0 0 0 0 0 200
4news.netfront.net 151 0 0 0 0 0 0 0 151
5usenet.goja.nl.eu.org 86 0 0 0 0 0 0 0 86
6newsfeed.bofh.team 79 1 0 0 0 0 0 0 78
7i2pn.org 54 0 0 0 0 0 0 0 54
8news.hispagatos.org 30 17 0 0 0 0 0 0 13
9news.nntp4.net 29 0 0 0 0 0 0 0 29
10endofthelinebbs.peers.news.panix.com 26 0 0 0 0 0 0 0 26
11usenet.network 21 0 0 0 0 0 0 0 21
12newsfeed.xs3.de 20 0 0 0 0 0 0 0 20
13glockenspiel.complete.org 4 0 0 0 0 0 0 0 4
14news.samoylyk.net 2 0 0 0 0 0 0 0 2
15194.87.241.33 1 0 0 0 0 0 0 0 1
16outgoing.news.lysator.liu.se 1 0 0 0 0 0 0 0 1
TOTAL: 16 2053 18 0 0 0 0 0 0 2035

Unwanted newsgroups [Top 20]:

NewsgroupCount
hispagatos.hacking.ctf 13
hispagatos.mastodon.tag.hacking 3
gigapost.testing 1
hispagatos.hacking.news 1
TOTAL: 4 18

INND Perl filter [Top 20]:

ReasonCount
EMP (phn path) 1131
EMP (phr path) 291
EMP (md5) 249
Binary: misplaced binary 111
EMP (phn nph) 75
Too many newsgroups 73
User-issued cancel 58
Too many newsgroups (meow) 15
HTML Multipart 2
EMP (fsl) 1
HTML post 1
Subject (LSDQv9C+0YXQvtGC0LvQuNCy0YvQuSDQv9C+0L/R) 1
TOTAL: 12 2008

NoCeM on Spool:

Issuer (type)NoticesBad PGPCancelSkipTotal
i2pn2-nocem@i2pn2.org (spam)30505
i2pn2-nocem@i2pn2.org (multipost)40004545
i2pn2-nocem@i2pn2.org (rmp)50099
robot@pasdenom.info (spam3)20033
robot@pasdenom.info (spam2)20022
TOTAL: 552055964

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
endofthelinebbs-out.news.weretis.net 16
usenet.blueworldhosting.com 7
usenet.goja.nl.eu.org 3
endofthelinebbs.peers.news.panix.com 1
TOTAL: 4 27
TOTAL: 1 27

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nyheter.lysator.liu.se 7589 3479 3260 440 0 0 45%23:59:54
2news.netfront.net 11683 1909 5186 0 0 5 16%23:59:52
3news.furie.org.uk 4829 714 2752 18 0 0 14%23:59:38
4usenet.network 10714 500 5972 33 0 4 4%23:59:48
5endofthelinebbs.peers.news.panix.com 7451 493 6667 17 0 0 6%23:59:54
6usenet.goja.nl.eu.org 8289 458 6020 365 0 0 5%23:59:25
7newsfeed.bofh.team 8310 329 6665 0 0 0 3%23:59:54
8news.bbs.nz 12959 257 6229 689 0 86 1%23:59:54
9news.nntp4.net 8449 246 6413 399 0 5 2%23:59:35
10news.corradoroberto.it 1292 244 653 0 0 0 18%23:06:58
11news.hispagatos.org 8706 171 6789 196 0 15 1%23:59:54
12news.nk.ca 9682 168 6099 799 0 28 1%23:59:54
13i2pn.org 8003 155 6686 62 0 53 1%23:58:32
14nntp.comgw.net 7952 141 6627 194 0 2 1%23:58:35
15news.tnetconsulting.net 8335 77 6773 326 0 17 0%23:59:54
16news.weretis.net 7534 76 6896 207 0 9 1%23:59:54
17news.quux.org 5572 76 4357 790 0 1 1%23:57:38
18newsfeed.xs3.de 8939 50 6776 302 0 0 0%23:59:48
19news.samoylyk.net 9522 41 6801 232 0 37 0%23:59:54
20news.chmurka.net 4115 26 2996 0 0 0 0%23:58:42
21ddt.demos.su 83 22 45 0 0 0 26%05:01:48
22usenet.blueworldhosting.com 6190 18 6048 0 0 0 0%23:59:54
23feed.opticnetworks.net 0 0 0 0 0 7180 0%23:59:54
24photonic.trudheim.com 0 0 0 0 0 7176 0%23:59:54
TOTAL: 24 166198 9650 116710 5069 0 14618 5%555:59:07
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nyheter.lysator.liu.se12.0 MB5.2 MB17.3 MB0.2 KB/s4.5 KB23:59:54
2news.netfront.net10.6 MB0.0 KB10.6 MB0.1 KB/s5.7 KB23:59:52
3news.furie.org.uk4.7 MB79.9 KB4.8 MB0.1 KB/s6.7 KB23:59:38
4endofthelinebbs.peers.news.panix.com2.8 MB51.2 KB2.9 MB0.0 KB/s5.7 KB23:59:54
5newsfeed.bofh.team2.2 MB0.0 KB2.2 MB0.0 KB/s7.0 KB23:59:54
6usenet.network1.9 MB84.5 KB2.0 MB0.0 KB/s3.9 KB23:59:48
7news.quux.org1.1 MB5.5 MB6.6 MB0.1 KB/s7.8 KB23:57:38
8usenet.goja.nl.eu.org981.1 KB3.9 MB4.9 MB0.1 KB/s6.1 KB23:59:25
9news.samoylyk.net961.1 KB2.0 MB2.9 MB0.0 KB/s11.1 KB23:59:54
10news.bbs.nz827.1 KB5.3 MB6.1 MB0.1 KB/s6.6 KB23:59:54
11news.nntp4.net694.2 KB4.5 MB5.1 MB0.1 KB/s8.1 KB23:59:35
12news.corradoroberto.it608.0 KB0.0 KB608.0 KB0.0 KB/s2.5 KB23:06:58
13news.hispagatos.org413.5 KB2.0 MB2.4 MB0.0 KB/s6.7 KB23:59:54
14i2pn.org410.3 KB274.1 KB684.3 KB0.0 KB/s3.2 KB23:58:32
15news.nk.ca339.1 KB6.3 MB6.6 MB0.1 KB/s7.0 KB23:59:54
16news.tnetconsulting.net307.6 KB2.3 MB2.6 MB0.0 KB/s6.5 KB23:59:54
17nntp.comgw.net302.3 KB2.8 MB3.1 MB0.0 KB/s9.3 KB23:58:35
18news.weretis.net276.5 KB3.0 MB3.2 MB0.0 KB/s11.7 KB23:59:54
19newsfeed.xs3.de186.0 KB2.5 MB2.7 MB0.0 KB/s7.8 KB23:59:48
20news.chmurka.net116.1 KB0.0 KB116.1 KB0.0 KB/s4.5 KB23:58:42
21usenet.blueworldhosting.com46.6 KB0.0 KB46.6 KB0.0 KB/s2.6 KB23:59:54
22ddt.demos.su32.9 KB0.0 KB32.9 KB0.0 KB/s1.5 KB05:01:48
23feed.opticnetworks.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:54
24photonic.trudheim.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:54
TOTAL: 2441.8 MB45.7 MB87.5 MB0.0 KB/s6.1 KB555:59:07
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1203.55.131.4 1 00.0 KB 0 0 000:00:00
2205.210.31.43 1 00.0 KB 0 0 000:00:10
3205.210.31.92 1 00.0 KB 0 0 000:00:10
4206.168.34.196 1 00.0 KB 0 0 000:00:00
591.238.181.34 1 00.0 KB 0 0 000:00:00
6azpdcsb36.stretchoid.com 1 00.0 KB 0 0 000:00:09
7azpdwg38.stretchoid.com 1 00.0 KB 0 0 000:00:00
8localhost 1 00.0 KB 0 0 000:11:03
TOTAL: 8 8 00.0 KB 0 0 000:11:34

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 5 00.0 KB 0 0 000:00:21
2*.stretchoid.com 2 00.0 KB 0 0 000:00:09
3? 1 00.0 KB 0 0 000:11:03
TOTAL: 3 8 00.0 KB 0 0 000:11:34

NNRP auth users [Top 20]:

UserConn
getlist 1
TOTAL: 1 1

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
localhost 179.256 370.446 0.07500:11:03
205.210.31.43 0.004 0.026 0.00000:00:10
205.210.31.92 0.000 0.017 0.00000:00:10
azpdcsb36.stretchoid.com 0.008 0.019 0.00000:00:09
206.168.34.196 0.019 0.012 0.00000:00:00
203.55.131.4 0.003 0.013 0.00000:00:00
91.238.181.34 0.000 0.017 0.00000:00:00
azpdwg38.stretchoid.com 0.004 0.012 0.00000:00:00
TOTAL: 8 179.294 370.562 0.07500:11:34

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

SystemConn
206.168.34.196 1
91.238.181.34 1
azpdwg38.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
91.238.181.34 1 1
TOTAL: 1 1 1