Daily Usenet Report

Apr 3 00:01:02 -- Apr 4 00:01:01

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Apr 3 08:18:55 newsfeed innd: message repeated 2 times: [ ctlinnd command s]
Apr 4 00:00:01 newsfeed nnrpd[1592189]: localhost auth: program exited with status 8

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 25457 53.5%3.0 MB 34.0%
innd 8566 18.0%1.2 MB 13.7%
inn 8113 17.0%3.6 MB 40.8%
innfeed 4830 10.1%940.2 KB 10.4%
cnfsstat 576 1.2%86.7 KB 1.0%
nocem 70 0.1%8.6 KB 0.1%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 7 47613 100.0%8.8 MB100.0%

History cache:

ReasonCount%Count
Positive hits 125822 63.5%
Negative hits 64377 32.5%
Do not exist 8022 4.0%
Cache misses 11 0.0%
TOTAL: 4 198232 100.0%

innd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.199 0.0%45 1.000 4.422 17.000
article cleanup00:00:00.322 0.0%8072 0.000 0.040 4.881
article logging00:00:00.411 0.0%8110 0.000 0.051 0.222
article parse00:00:00.167 0.0%12353 0.000 0.014 0.071
article write00:00:02.217 0.0%6744 0.000 0.329 8.303
artlog/artcncl00:00:00.000 0.0%4 0.000 0.000 0.000
artlog/artparse00:00:00.000 0.0%1 0.000 0.000 0.000
data move00:00:00.262 0.0%202072 0.000 0.001 0.024
hisgrep/artcncl00:00:00.163 0.0%49 0.000 3.327 9.000
hishave/artcncl00:00:00.000 0.0%4 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:02:17.914 0.2%198776 0.090 0.694 4.683
history sync00:00:00.069 0.0%402 0.000 0.172 1.000
history write00:02:02.770 0.1%8045 3.294 15.260 102.222
idle23:49:38.517 99.2%205594 71.106 417.223 1377.493
nntp read00:00:02.771 0.0%203628 0.001 0.014 0.122
overview write00:05:48.603 0.4%6744 0.522 51.691 7560.000
perl filter00:00:20.044 0.0%8044 1.452 2.492 9.861
python filter00:00:00.901 0.0%8045 0.000 0.112 1.700
site send00:00:01.019 0.0%13551 0.000 0.075 0.296
TOTAL: 2024:00:16.349 99.9%----

innfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.011 0.0%6820 0.000 0.002 0.067
article prepare00:00:00.010 0.0%48708 0.000 0.000 0.013
article read00:00:00.549 0.0%4125 0.000 0.133 0.429
backlog stats00:00:00.480 0.0%294711 0.000 0.002 0.006
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.616 0.0%201985 0.000 0.013 0.043
data write00:00:03.778 0.0%196866 0.006 0.019 0.033
idle23:59:01.463100.0%294711 138.604 292.970 1064.541
status file00:00:00.537 0.0%390 1.000 1.377 9.000
TOTAL: 923:59:09.444100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:54:59.876 99.9%16701 58.000 197.586166049.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:04.335 0.1%112260 0.000 0.039 1.000
TOTAL: 300:55:04.211100.0%----

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 (innd):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1endofthelinebbs-out.news.weretis.net 3 14167 2043 11760 364 14%53:01:21
2news.dne3.net 2 6138 1492 4565 81 24%19:50:47
3usenet.blueworldhosting.com 715 7918 633 6846 439 7%23:56:02
4usenet.network 2 5719 364 5342 13 6%23:59:57
5news.corradoroberto.it 5 1887 292 1595 0 15%23:54:45
6usenet.goja.nl.eu.org 10 6853 271 6507 75 3%22:11:31
7nntp.comgw.net 2 7323 242 6981 100 3%23:59:36
8i2pn.org 2 7021 236 6743 42 3%23:59:33
9news.hispagatos.org 5 7321 212 7069 40 2%24:26:24
10newsfeed.bofh.team 1 7883 183 7649 51 2%23:59:57
11glockenspiel.complete.org 2 5566 172 5392 2 3%24:00:16
12194.87.241.33 39 306 130 107 69 42%16:17:47
13endoftheline-out.news.chmurka.net 1 3371 105 3266 0 3%23:59:56
14endofthelinebbs.peers.news.panix.com 24 7193 104 7082 7 1%23:55:51
15news.samoylyk.net 2 6249 94 6151 4 1%23:57:55
16peering.usenet.ovh 2 7177 80 7092 5 1%23:59:41
17newsfeed.xs3.de 1 5802 63 5735 4 1%23:59:55
18news-out.tcpreset.net 2 6272 30 6233 9 0%23:15:48
19news.bbs.nz 2 6413 26 6387 0 0%23:59:29
20news.furie.org.uk 1 3586 18 3568 0 0%23:59:57
21outgoing.news.lysator.liu.se 1 4196 5 4188 3 0%23:59:56
22news.netfront.net 1 6036 4 6006 26 0%24:07:20
23localhost 27 1 1 0 0 100%00:00:01
24eotl-out.news.tnetconsulting.net 1 0 0 0 0 0%00:10:07
25news.nk.ca 2 0 0 0 0 0%00:20:11
TOTAL: 25 855 134398 6800 126264 1334 5%543:24:03
Articles received by server

Incoming volume (innd):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1endofthelinebbs-out.news.weretis.net6.1 MB8.7 KB502.4 KB6.6 MB 92%2.8 KB
2news.dne3.net4.1 MB13.8 KB135.8 KB4.2 MB 96%2.8 KB
3usenet.network3.4 MB12.8 KB33.4 KB3.5 MB 98%9.4 KB
4usenet.blueworldhosting.com1.6 MB0.0 KB894.2 KB2.4 MB 64%2.3 KB
5news.corradoroberto.it1.5 MB0.0 KB0.0 KB1.5 MB100%5.1 KB
6glockenspiel.complete.org848.5 KB8.6 KB0.0 KB857.1 KB 98%4.9 KB
7usenet.goja.nl.eu.org827.3 KB8.6 KB115.8 KB951.7 KB 86%2.8 KB
8nntp.comgw.net781.0 KB8.6 KB374.2 KB1.1 MB 67%3.4 KB
9newsfeed.bofh.team712.6 KB12.8 KB57.7 KB783.1 KB 90%3.3 KB
10i2pn.org683.9 KB8.6 KB55.6 KB748.1 KB 91%2.7 KB
11news.hispagatos.org597.1 KB8.6 KB110.0 KB715.8 KB 83%2.8 KB
12news.samoylyk.net370.2 KB8.6 KB2.1 KB380.9 KB 97%3.9 KB
13endoftheline-out.news.chmurka.net325.4 KB0.0 KB0.0 KB325.4 KB100%3.1 KB
14194.87.241.33276.4 KB0.0 KB93.2 KB369.6 KB 74%1.9 KB
15newsfeed.xs3.de276.0 KB8.6 KB7.6 KB292.3 KB 94%4.4 KB
16endofthelinebbs.peers.news.panix.com250.8 KB0.0 KB6.5 KB257.3 KB 97%2.3 KB
17peering.usenet.ovh225.9 KB0.0 KB7.5 KB233.4 KB 96%2.7 KB
18news.furie.org.uk111.1 KB0.0 KB0.0 KB111.1 KB100%6.2 KB
19news-out.tcpreset.net100.1 KB8.7 KB6.1 KB114.9 KB 87%2.9 KB
20news.bbs.nz44.1 KB0.0 KB0.0 KB44.1 KB100%1.7 KB
21news.netfront.net34.3 KB8.8 KB369.5 KB412.6 KB 8%13.8 KB
22outgoing.news.lysator.liu.se18.1 KB8.6 KB1.2 KB28.0 KB 64%3.5 KB
23localhost1.2 KB0.0 KB0.0 KB1.2 KB100%1.2 KB
24eotl-out.news.tnetconsulting.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
25news.nk.ca0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 2523.0 MB134.5 KB2.7 MB25.8 MB 88%3.2 KB
Incoming volume received by server

Incoming articles (innd):

DateArticles%ArtsArt/secSize%SizeKB/sec
Apr 3 00:01:02 - 00:59:59 169 2.5% 0.05387.5 KB 1.7% 0.11
Apr 3 01:00:00 - 01:59:59 258 3.8% 0.07704.0 KB 3.0% 0.20
Apr 3 02:00:00 - 02:59:59 256 3.8% 0.07730.5 KB 3.1% 0.20
Apr 3 03:00:00 - 03:59:59 345 5.1% 0.10976.7 KB 4.2% 0.27
Apr 3 04:00:00 - 04:59:59 290 4.3% 0.08927.8 KB 4.0% 0.26
Apr 3 05:00:00 - 05:59:59 292 4.3% 0.08939.6 KB 4.0% 0.26
Apr 3 06:00:00 - 06:59:59 361 5.4% 0.10932.0 KB 4.0% 0.26
Apr 3 07:00:00 - 07:59:59 317 4.7% 0.09945.1 KB 4.0% 0.26
Apr 3 08:00:00 - 08:59:59 344 5.1% 0.101.1 MB 5.0% 0.32
Apr 3 09:00:00 - 09:59:59 376 5.6% 0.101.2 MB 5.4% 0.35
Apr 3 10:00:00 - 10:59:59 438 6.5% 0.121.3 MB 5.5% 0.36
Apr 3 11:00:00 - 11:59:59 337 5.0% 0.091019.6 KB 4.4% 0.28
Apr 3 12:00:00 - 12:59:59 366 5.4% 0.101.1 MB 4.8% 0.31
Apr 3 13:00:00 - 13:59:59 369 5.5% 0.101.6 MB 7.2% 0.47
Apr 3 14:00:00 - 14:59:59 416 6.2% 0.121.5 MB 6.5% 0.42
Apr 3 15:00:00 - 15:59:59 320 4.7% 0.09936.7 KB 4.0% 0.26
Apr 3 16:00:00 - 16:59:59 351 5.2% 0.101.4 MB 6.0% 0.39
Apr 3 17:00:00 - 17:59:59 305 4.5% 0.081.7 MB 7.3% 0.47
Apr 3 18:00:00 - 18:59:59 170 2.5% 0.05706.0 KB 3.0% 0.20
Apr 3 19:00:00 - 19:59:59 125 1.9% 0.03458.8 KB 2.0% 0.13
Apr 3 20:00:00 - 20:59:59 125 1.9% 0.03511.2 KB 2.2% 0.14
Apr 3 21:00:00 - 21:59:59 127 1.9% 0.04513.2 KB 2.2% 0.14
Apr 3 22:00:00 - 22:59:59 108 1.6% 0.03506.5 KB 2.2% 0.14
Apr 3 23:00:00 - 23:59:59 175 2.6% 0.051.1 MB 4.6% 0.30
Apr 4 00:00:00 - 00:01:01 4 0.1% 0.0721.0 KB 0.1% 0.34
TOTAL: 23:59:59 6744 100.0% 0.0822.9 MB 100.0% 0.27
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 GB105.8 GB 6.9% 0 0.4343523.00
CYCNGS3NGS1536.0 GB48.0 MB 0.0% 0 0.00 0.00
CYCTXT1TEXT5.0 GB4.2 GB 83.6% 0 0.02 2713.45
TOTAL: 4-4613.0 GB110.1 GB 2.4% 1 0.31-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1usenet.blueworldhosting.com 449 1 0 0 0 0 0 0 448
2endofthelinebbs-out.news.weretis.net 343 0 0 2 0 0 0 0 341
3nntp.comgw.net 113 0 0 2 0 0 0 0 111
4news.dne3.net 97 0 0 4 0 0 0 0 93
5usenet.goja.nl.eu.org 77 0 0 2 0 0 0 0 75
6194.87.241.33 69 0 0 0 0 0 0 0 69
7newsfeed.bofh.team 55 0 0 1 0 0 0 0 54
8news.hispagatos.org 48 13 0 2 0 0 0 0 33
9i2pn.org 40 0 0 2 0 0 0 0 38
10news.netfront.net 17 0 0 2 0 0 0 0 15
11usenet.network 15 0 0 1 0 0 0 0 14
12news-out.tcpreset.net 12 0 0 2 0 0 0 0 10
13endofthelinebbs.peers.news.panix.com 9 2 0 0 0 0 0 0 7
14peering.usenet.ovh 5 4 0 0 0 0 0 0 1
15news.samoylyk.net 4 0 0 2 0 0 0 0 2
16newsfeed.xs3.de 4 0 0 2 0 0 0 0 2
17glockenspiel.complete.org 3 0 0 2 0 0 0 0 1
18outgoing.news.lysator.liu.se 3 0 0 2 0 0 0 0 1
19news.corradoroberto.it 2 0 0 0 0 0 0 0 2
TOTAL: 19 1365 20 0 28 0 0 0 0 1317

Unwanted newsgroups [Top 20]:

NewsgroupCount
hispagatos.mastodon.tag.hacking 12
fr.soc.esoterisme 4
hispagatos.mastodon.tag.hackers 2
atl.binaries.android 1
soc.culture.russia 1
TOTAL: 5 20

Perl filter (innd) [Top 20]:

ReasonCount
EMP (phn path) 582
EMP (phr path) 313
Too many newsgroups 205
EMP (md5) 102
User-issued cancel 37
Angle-bracket bot 17
Too many newsgroups (meow) 17
HTML Multipart 5
TOTAL: 8 1278

NoCeM on spool:

Issuer (type)NoticesBad PGPCancelSkipTotal
robot@pasdenom.info (spam2)42004949
robot@pasdenom.info (spam3)7002929
robot@pasdenom.info (spam4)7001515
i2pn2-nocem@i2pn2.org (multipost)10001111
i2pn2-nocem@i2pn2.org (rmp)30077
TOTAL: 56900111111

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
nntp.comgw.net 11
usenet.blueworldhosting.com 10
endofthelinebbs-out.news.weretis.net 4
newsfeed.bofh.team 3
news.dne3.net 3
usenet.goja.nl.eu.org 2
usenet.network 2
news.corradoroberto.it 2
endofthelinebbs.peers.news.panix.com 1
TOTAL: 9 38
No colon-space in header field
usenet.blueworldhosting.com 1
TOTAL: 1 1
TOTAL: 2 39

Outgoing feeds (innfeed) by articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nyheter.lysator.liu.se 7117 2706 3683 344 0 0 38%23:59:53
2news.netfront.net 11126 1729 4990 0 0 7 15%23:59:47
3news.furie.org.uk 4216 882 2419 2 0 0 20%23:59:51
4photonic.trudheim.com 7607 649 4617 1456 0 0 8%23:59:53
5endofthelinebbs.peers.news.panix.com 7158 373 6351 11 0 0 5%23:59:53
6peering.usenet.ovh 7410 357 6326 38 0 0 4%23:59:49
7news.dne3.net 5330 321 4676 115 0 0 6%23:58:49
8usenet.goja.nl.eu.org 7831 237 6090 25 0 0 3%23:57:25
9news.nntp4.net 7810 219 6304 1 0 15 2%23:59:53
10news.nk.ca 9889 87 6247 312 0 10 0%23:59:53
11i2pn.org 7203 81 6376 13 0 15 1%23:59:53
12news.tcpreset.net 8115 77 5822 791 0 1 0%23:59:53
13newsfeed.bofh.team 7771 71 6474 0 0 0 0%23:59:53
14news.hispagatos.org 7596 62 6400 34 0 0 0%23:59:16
15news.bbs.nz 12505 53 6263 384 0 32 0%23:59:48
16usenet.network 7485 42 5835 10 0 0 0%23:59:50
17nntp.comgw.net 6939 41 6411 23 0 0 0%23:59:51
18news.quux.org 6877 21 6238 241 0 0 0%23:59:53
19news.tnetconsulting.net 8923 19 6556 159 0 3 0%23:59:53
20news.samoylyk.net 8571 19 6505 15 0 0 0%23:58:49
21news.weretis.net 7073 19 6578 125 0 0 0%23:59:46
22usenet.blueworldhosting.com 6557 15 5913 0 0 0 0%23:59:53
23news.chmurka.net 4345 15 3086 0 0 0 0%23:59:32
24newsfeed.xs3.de 8440 14 6500 132 0 0 0%23:59:53
25news.corradoroberto.it 1158 7 823 0 0 0 0%23:04:35
26ddt.demos.su 64 7 57 0 0 0 10%07:19:49
27feed.opticnetworks.net 0 0 0 0 0 6738 0%23:59:53
TOTAL: 27 185116 8123 137540 4231 0 6821 4%630:15:26
Outgoing feeds (innfeed) by articles

Outgoing feeds (innfeed) by volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nyheter.lysator.liu.se7.9 MB3.1 MB11.0 MB0.1 KB/s3.7 KB23:59:53
2news.netfront.net7.1 MB0.0 KB7.1 MB0.1 KB/s4.2 KB23:59:47
3news.furie.org.uk4.6 MB10.7 KB4.6 MB0.1 KB/s5.3 KB23:59:51
4peering.usenet.ovh2.7 MB120.2 KB2.8 MB0.0 KB/s7.3 KB23:59:49
5photonic.trudheim.com2.2 MB3.6 MB5.8 MB0.1 KB/s2.8 KB23:59:53
6endofthelinebbs.peers.news.panix.com2.0 MB26.0 KB2.0 MB0.0 KB/s5.3 KB23:59:53
7news.dne3.net625.8 KB1.4 MB2.0 MB0.0 KB/s4.7 KB23:58:49
8news.samoylyk.net459.8 KB40.1 KB499.9 KB0.0 KB/s14.7 KB23:58:49
9news.quux.org454.5 KB1.3 MB1.7 MB0.0 KB/s6.6 KB23:59:53
10ddt.demos.su434.9 KB0.0 KB434.9 KB0.0 KB/s62.1 KB07:19:49
11news.nntp4.net391.4 KB0.6 KB392.0 KB0.0 KB/s1.8 KB23:59:53
12usenet.goja.nl.eu.org389.9 KB227.1 KB617.0 KB0.0 KB/s2.4 KB23:57:25
13newsfeed.bofh.team340.9 KB0.0 KB340.9 KB0.0 KB/s4.8 KB23:59:53
14i2pn.org255.8 KB93.1 KB348.8 KB0.0 KB/s3.7 KB23:59:53
15news.tcpreset.net183.2 KB3.8 MB3.9 MB0.0 KB/s4.7 KB23:59:53
16news.nk.ca162.2 KB1.7 MB1.8 MB0.0 KB/s4.7 KB23:59:53
17news.hispagatos.org141.6 KB247.2 KB388.7 KB0.0 KB/s4.0 KB23:59:16
18news.bbs.nz134.9 KB2.1 MB2.2 MB0.0 KB/s5.1 KB23:59:48
19usenet.network91.5 KB47.3 KB138.8 KB0.0 KB/s2.7 KB23:59:50
20nntp.comgw.net73.7 KB655.1 KB728.8 KB0.0 KB/s11.4 KB23:59:51
21news.weretis.net42.4 KB1.5 MB1.5 MB0.0 KB/s11.0 KB23:59:46
22newsfeed.xs3.de37.8 KB990.1 KB1.0 MB0.0 KB/s7.0 KB23:59:53
23news.tnetconsulting.net34.3 KB1.4 MB1.4 MB0.0 KB/s8.0 KB23:59:53
24news.chmurka.net22.9 KB0.0 KB22.9 KB0.0 KB/s1.5 KB23:59:32
25usenet.blueworldhosting.com22.6 KB0.0 KB22.6 KB0.0 KB/s1.5 KB23:59:53
26news.corradoroberto.it11.1 KB0.0 KB11.1 KB0.0 KB/s1.6 KB23:04:35
27feed.opticnetworks.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:53
TOTAL: 2730.7 MB22.1 MB52.7 MB0.0 KB/s4.4 KB630:15:26
Outgoing feeds (innfeed) by volume

NNRP connection statistics (by domain) [Top 100]:

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved2792 00.0 KB 5 0 000:21:01
2*.nntp4.net2785 00.0 KB 0 0 000:22:42
3*.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
4*.compute.amazonaws.com 1 00.0 KB 0 0 000:00:00
5*.stretchoid.com 1 00.0 KB 0 0 000:00:09
6*localhost 1 00.0 KB 0 0 000:11:07
TOTAL: 65581 00.0 KB 5 0 000:55:01

NNRP auth users [Top 20]:

UserConn
getlist 1
TOTAL: 1 1

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
news.nntp4.net 10.543 28.265 0.00000:22:42
2a0e:73c2:8000:802c::2 10.750 28.440 0.00000:20:40
localhost 186.482 371.726 0.07500:11:07
167.94.138.59 0.013 0.045 0.00000:00:11
azpdesl87976.stretchoid.com 0.003 0.010 0.00000:00:09
205.210.31.71 0.009 0.004 0.00000:00:04
205.210.31.80 0.000 0.013 0.00000:00:02
2a06:4882:b000::d9 0.000 0.013 0.00000:00:01
194.165.16.164 0.000 0.014 0.00000:00:00
167.211.203.35.bc.googleusercontent.com 0.004 0.009 0.00000:00:00
ec2-18-144-79-190.us-west-1.compute.amazonaws.com 0.008 0.008 0.00000:00:00
TOTAL: 11 207.812 428.547 0.07500:55:01

Curious NNRP explorers [Top 20]:

SystemConn
news.nntp4.net 2785
2a0e:73c2:8000:802c::2 2784
167.94.138.59 4
167.211.203.35.bc.googleusercontent.com 1
194.165.16.164 1
205.210.31.71 1
205.210.31.80 1
2a06:4882:b000::d9 1
azpdesl87976.stretchoid.com 1
ec2-18-144-79-190.us-west-1.compute.amazonaws.com 1
localhost 1
TOTAL: 11 5581

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

SystemConn
167.211.203.35.bc.googleusercontent.com 4
194.165.16.164 1
TOTAL: 2 5

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

CommandCount
#003 1
Accept-Encoding: gzip 1
GET / HTTP/1.1 1
Host: 144.172.126.95:119 1
User-Agent: Expanse, a Palo Alto Network... 1
TOTAL: 5 5

NNRP client timeouts [Top 20]:

SystemConnPeer
167.94.138.59 1 4
194.165.16.164 1 1
TOTAL: 2 2 7

Newsgroup request counts (by hierarchy) [Top 100]:

HierarchyCountPct
1news 8100.0%
TOTAL: 1 8100.0%

Newsgroup request counts (by newsgroup) [Top 100]:

NewsgroupCount
1news.admin.peering 4
2news.software.nntp 3
3news.admin.net-abuse.usenet 1
TOTAL: 3 8