Daily Usenet Report

Jan 8 00:01:01 -- Jan 9 00:01:01

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Jan 8 14:00:03 newsfeed controlchan[2249910]: Unknown "tags" control by robomod@news.nic.it
Jan 9 00:00:01 newsfeed nnrpd[2827856]: localhost auth: program exited with status 8

Log entries by program:

Program nameLines%LinesSize%Size
inn 10443 44.1%3.8 MB 64.2%
innd 8290 35.0%1.2 MB 20.3%
innfeed 4390 18.6%849.3 KB 14.0%
cnfsstat 432 1.8%75.5 KB 1.2%
nnrpd 56 0.2%6.1 KB 0.1%
nocem 49 0.2%5.5 KB 0.1%
controlchan 2 0.0%0.2 KB 0.0%
TOTAL: 7 23662 100.0%5.9 MB100.0%

History cache:

ReasonCount%Count
Positive hits 116464 60.2%
Negative hits 52334 27.0%
Cache misses 14378 7.4%
Do not exist 10336 5.3%
TOTAL: 4 193512 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.107 0.0%24 0.000 4.458 8.000
article cleanup00:00:00.806 0.0%10382 0.000 0.078 3.505
article logging00:00:00.772 0.0%10421 0.000 0.074 3.088
article parse00:00:00.278 0.0%17865 0.000 0.016 0.303
article write00:00:02.524 0.0%7379 0.000 0.342 6.373
artlog/artcncl00:00:00.000 0.0%2 0.000 0.000 0.000
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.632 0.0%183679 0.000 0.003 0.046
hisgrep/artcncl00:00:00.084 0.0%26 0.000 3.231 3.833
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:05:00.946 0.4%194205 0.107 1.550 10.755
history sync00:00:00.053 0.0%395 0.000 0.134 1.667
history write00:02:35.005 0.2%10375 3.293 14.940 112.091
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:38:28.270 99.1%176936 92.436 481.012 1692.475
nntp read00:00:03.828 0.0%184148 0.000 0.021 0.295
overview write00:03:32.084 0.2%7379 0.524 28.742 1160.197
perl filter00:00:38.189 0.0%10375 1.115 3.681 26.051
python filter00:00:01.897 0.0%10375 0.000 0.183 4.173
site send00:00:01.142 0.0%14807 0.000 0.077 0.273
TOTAL: 23:51:07.37323:50:26.617100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.035 0.0%27384 0.000 0.001 0.062
article prepare00:00:00.006 0.0%70568 0.000 0.000 0.004
article read00:00:02.644 0.0%6664 0.000 0.397 1.562
backlog stats00:00:00.420 0.0%278587 0.000 0.002 0.007
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.374 0.0%186798 0.000 0.013 0.051
data write00:00:03.363 0.0%181891 0.005 0.018 0.034
idle23:57:36.025100.0%278587 64.523 309.620 1260.658
status file00:00:00.474 0.0%392 1.000 1.209 8.000
TOTAL: 23:57:56.31123:57:45.341100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:35.779 4.7%19 0.000 1883.105 10059.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:03.525 0.5%78837 0.000 0.045 0.500
TOTAL: 00:12:36.65700:00:39.304 5.2%----

Control commands to INND:

CommandNumber
flush 5
flushlogs 2
go 2
logmode 2
lowmark 1
mode 99
name 2
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 121

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1endofthelinebbs-out.news.weretis.net 3 13977 1873 11714 390 13%49:51:56
2glockenspiel.complete.org 2 5531 1743 3783 5 31%23:45:54
3usenet.blueworldhosting.com 303 9078 1074 7072 932 11%23:43:38
4nntp.comgw.net 1 8309 537 7449 323 6%23:59:57
5news.corradoroberto.it 7 1384 534 850 0 38%23:35:10
6usenet.network 2 6034 411 5623 0 6%23:59:15
7endoftheline-out.news.chmurka.net 1 3477 262 3215 0 7%23:59:57
8i2pn.org 2 8030 213 7754 63 2%23:59:46
9newsfeed.bofh.team 2 8811 194 8592 25 2%23:59:35
10194.87.241.33 47 261 164 97 0 62%15:15:51
11usenet.goja.nl.eu.org 10 8012 156 7813 43 1%23:55:10
12news.samoylyk.net 2 18736 78 18316 342 0%08:48:14
13news.nntp4.net 2 6433 68 6351 14 1%23:59:52
14endofthelinebbs.peers.news.panix.com 22 8092 55 8034 3 0%23:55:12
15newsfeed.xs3.de 2 5930 48 5862 20 0%23:58:43
16outgoing.news.lysator.liu.se 1 4043 37 3281 725 0%23:59:57
17news.hispagatos.org 6 8279 32 8200 47 0%24:26:06
18news.netfront.net 1 6685 30 6606 49 0%23:49:07
19news.bbs.nz 2 6574 12 6562 0 0%23:59:30
20news.furie.org.uk 2 3778 9 3767 2 0%23:59:53
21eotl-out.news.tnetconsulting.net 1 0 0 0 0 0%00:10:03
22localhost 26 0 0 0 0 0%00:00:00
23news.nk.ca 2 0 0 0 0 0%00:20:11
TOTAL: 23 449 141454 7530 130941 2983 5%481:32:57
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1endofthelinebbs-out.news.weretis.net6.2 MB0.0 KB722.2 KB6.9 MB 89%3.1 KB
2glockenspiel.complete.org5.2 MB0.0 KB5.3 KB5.2 MB 99%3.0 KB
3usenet.network5.0 MB0.0 KB0.0 KB5.0 MB100%12.5 KB
4news.corradoroberto.it4.4 MB0.0 KB0.0 KB4.4 MB100%8.5 KB
5usenet.blueworldhosting.com2.6 MB0.0 KB2.0 MB4.6 MB 55%2.3 KB
6nntp.comgw.net2.5 MB291.9 KB637.0 KB3.4 MB 72%4.0 KB
7endoftheline-out.news.chmurka.net1.1 MB0.0 KB0.0 KB1.1 MB100%4.3 KB
8news.samoylyk.net1.0 MB290.4 KB616.8 KB1.9 MB 53%4.6 KB
9newsfeed.bofh.team636.9 KB290.4 KB51.1 KB978.5 KB 65%4.5 KB
10i2pn.org525.6 KB0.0 KB89.5 KB615.1 KB 85%2.2 KB
11194.87.241.33517.4 KB0.0 KB0.0 KB517.4 KB100%3.2 KB
12newsfeed.xs3.de493.8 KB290.4 KB88.7 KB873.0 KB 56%12.8 KB
13usenet.goja.nl.eu.org463.1 KB0.0 KB84.9 KB548.0 KB 84%2.8 KB
14endofthelinebbs.peers.news.panix.com210.7 KB0.0 KB3.3 KB214.0 KB 98%3.7 KB
15news.nntp4.net182.6 KB0.0 KB53.3 KB235.8 KB 77%2.9 KB
16news.hispagatos.org122.0 KB0.0 KB60.3 KB182.3 KB 66%2.3 KB
17outgoing.news.lysator.liu.se103.6 KB290.5 KB696.8 KB1.1 MB 9%1.4 KB
18news.netfront.net84.3 KB0.0 KB194.6 KB278.9 KB 30%3.5 KB
19news.furie.org.uk38.1 KB290.5 KB0.7 KB329.2 KB 11%29.9 KB
20news.bbs.nz18.8 KB0.0 KB0.0 KB18.8 KB100%1.6 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: 2331.2 MB1.7 MB5.2 MB38.1 MB 81%3.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jan 8 00:01:01 - 00:59:59 157 2.1% 0.04615.1 KB 2.0% 0.17
Jan 8 01:00:00 - 01:59:59 214 2.9% 0.06708.5 KB 2.3% 0.20
Jan 8 02:00:00 - 02:59:59 307 4.2% 0.091.7 MB 5.7% 0.49
Jan 8 03:00:00 - 03:59:59 422 5.7% 0.121.4 MB 4.4% 0.38
Jan 8 04:00:00 - 04:59:59 406 5.5% 0.111.3 MB 4.2% 0.36
Jan 8 05:00:00 - 05:59:59 378 5.1% 0.101.2 MB 3.8% 0.33
Jan 8 06:00:00 - 06:59:59 362 4.9% 0.101.3 MB 4.2% 0.37
Jan 8 07:00:00 - 07:59:59 436 5.9% 0.121.5 MB 4.9% 0.42
Jan 8 08:00:00 - 08:59:59 402 5.4% 0.111.3 MB 4.2% 0.37
Jan 8 09:00:00 - 09:59:59 416 5.6% 0.121.5 MB 4.9% 0.43
Jan 8 10:00:00 - 10:59:59 459 6.2% 0.131.9 MB 6.3% 0.55
Jan 8 11:00:00 - 11:59:59 385 5.2% 0.111.2 MB 3.9% 0.34
Jan 8 12:00:00 - 12:59:59 418 5.7% 0.121.8 MB 5.7% 0.50
Jan 8 13:00:00 - 13:59:59 463 6.3% 0.134.2 MB 13.7% 1.19
Jan 8 14:00:00 - 14:59:59 379 5.1% 0.111.2 MB 3.8% 0.33
Jan 8 15:00:00 - 15:59:59 330 4.5% 0.091.3 MB 4.4% 0.38
Jan 8 16:00:00 - 16:59:59 338 4.6% 0.091.6 MB 5.4% 0.47
Jan 8 17:00:00 - 17:59:59 276 3.7% 0.081.5 MB 4.8% 0.42
Jan 8 18:00:00 - 18:59:59 168 2.3% 0.05858.2 KB 2.7% 0.24
Jan 8 19:00:00 - 19:59:59 153 2.1% 0.04904.5 KB 2.9% 0.25
Jan 8 20:00:00 - 20:59:59 146 2.0% 0.04443.7 KB 1.4% 0.12
Jan 8 21:00:00 - 21:59:59 124 1.7% 0.03613.3 KB 2.0% 0.17
Jan 8 22:00:00 - 22:59:59 113 1.5% 0.03348.0 KB 1.1% 0.10
Jan 8 23:00:00 - 23:59:59 134 1.8% 0.04371.2 KB 1.2% 0.10
Jan 9 00:00:00 - 00:01:01 4 0.1% 0.079.2 KB 0.0% 0.15
TOTAL: 24:00:00 7390 100.0% 0.0930.5 MB 100.0% 0.36
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 GB102.0 GB 6.6% 0 0.5335040.11
CYCTXT1TEXT5.0 GB4.0 GB 80.0% 0 0.03 2052.50
TOTAL: 3-3077.0 GB106.1 GB 3.4% 1 0.37-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1usenet.blueworldhosting.com 951 1 0 0 0 0 0 0 950
2outgoing.news.lysator.liu.se 726 0 0 1 0 0 0 0 725
3endofthelinebbs-out.news.weretis.net 427 0 0 0 0 0 0 0 427
4news.samoylyk.net 342 0 0 1 0 0 0 0 341
5nntp.comgw.net 331 0 0 2 0 0 0 0 329
6i2pn.org 63 0 0 0 0 0 0 0 63
7news.hispagatos.org 48 37 0 0 0 0 0 0 11
8news.netfront.net 47 0 0 0 0 0 0 0 47
9usenet.goja.nl.eu.org 44 0 0 0 0 0 0 0 44
10newsfeed.bofh.team 25 0 0 1 0 0 0 0 24
11newsfeed.xs3.de 20 0 0 1 0 0 0 0 19
12news.nntp4.net 14 0 0 0 0 0 0 0 14
13glockenspiel.complete.org 8 0 0 0 0 0 0 0 8
14endofthelinebbs.peers.news.panix.com 3 0 0 0 0 0 0 0 3
15news.furie.org.uk 2 0 0 1 0 0 0 0 1
TOTAL: 15 3051 38 0 7 0 0 0 0 3006

Unwanted newsgroups [Top 20]:

NewsgroupCount
hispagatos.mastodon.tag.hacking 16
hispagatos.hacking.ctf 11
hispagatos.hacking.news 7
hispagatos.mastodon.tag.hackers 3
soc.culture.russia 1
TOTAL: 5 38

INND Perl filter [Top 20]:

ReasonCount
EMP (phn path) 1378
EMP (phr path) 1018
EMP (md5) 215
Too many newsgroups 177
EMP (phn nph) 127
Too many newsgroups (meow) 27
EMP (fsl) 12
User-issued cancel 7
HTML Multipart 4
Angle-bracket bot 2
TOTAL: 10 2967

NoCeM on Spool:

Issuer (type)NoticesBad PGPCancelSkipTotal
i2pn2-nocem@i2pn2.org (multipost)39004444
i2pn2-nocem@i2pn2.org (rmp)20077
robot@pasdenom.info (spam3)40066
robot@pasdenom.info (spam2)30033
TOTAL: 448006060

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
usenet.blueworldhosting.com 19
endofthelinebbs-out.news.weretis.net 9
usenet.goja.nl.eu.org 4
glockenspiel.complete.org 3
nntp.comgw.net 3
outgoing.news.lysator.liu.se 1
TOTAL: 6 39
TOTAL: 1 39

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nyheter.lysator.liu.se 7838 4205 2664 484 0 0 53%23:59:52
2news.netfront.net 11709 2340 5019 1 0 11 19%23:58:39
3endofthelinebbs.peers.news.panix.com 7653 1369 6010 2 0 0 17%23:59:53
4news.furie.org.uk 4637 995 2443 17 0 2 21%23:59:53
5usenet.goja.nl.eu.org 8506 503 6287 248 0 0 5%23:59:53
6newsfeed.bofh.team 8314 350 6836 0 0 0 4%23:59:12
7news.hispagatos.org 8801 234 6728 380 0 1 2%23:59:53
8news.bbs.nz 13339 213 6480 685 0 103 1%23:59:53
9news.nntp4.net 8521 211 7088 7 0 6 2%23:58:46
10news.corradoroberto.it 1346 209 658 0 0 0 15%22:51:55
11news.tnetconsulting.net 8238 207 6798 374 0 14 2%23:59:53
12usenet.network 9091 204 6473 65 0 0 2%23:58:08
13news.weretis.net 7749 182 6873 333 0 1 2%23:59:53
14news.quux.org 5926 179 4653 644 0 3 3%23:57:20
15nntp.comgw.net 7785 143 6545 176 0 0 1%23:59:40
16newsfeed.xs3.de 9193 135 6865 330 0 0 1%23:59:37
17i2pn.org 8028 125 6956 68 0 69 1%23:59:53
18news.nk.ca 9782 101 6477 721 0 58 1%23:59:53
19news.samoylyk.net 23164 20 21018 1218 0 4736 0%23:59:53
20ddt.demos.su 49 6 42 0 0 0 12%06:14:41
21usenet.blueworldhosting.com 6787 4 6171 1 0 0 0%23:57:23
22news.chmurka.net 3850 4 2921 0 0 0 0%23:59:53
23feed.opticnetworks.net 0 0 0 0 0 7390 0%23:59:53
24photonic.trudheim.com 0 0 0 0 0 7383 0%23:59:53
TOTAL: 24 180306 11939 132005 5754 0 19777 6%556:53:42
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nyheter.lysator.liu.se14.7 MB4.3 MB19.0 MB0.2 KB/s4.2 KB23:59:52
2news.netfront.net14.4 MB13.5 KB14.4 MB0.2 KB/s6.3 KB23:58:39
3news.furie.org.uk7.5 MB99.1 KB7.6 MB0.1 KB/s7.7 KB23:59:53
4endofthelinebbs.peers.news.panix.com7.3 MB3.5 KB7.3 MB0.1 KB/s5.5 KB23:59:53
5newsfeed.bofh.team3.4 MB0.0 KB3.4 MB0.0 KB/s10.0 KB23:59:12
6news.quux.org2.2 MB3.6 MB5.9 MB0.1 KB/s7.3 KB23:57:20
7news.hispagatos.org1.8 MB3.4 MB5.2 MB0.1 KB/s8.7 KB23:59:53
8usenet.goja.nl.eu.org1.8 MB2.4 MB4.2 MB0.1 KB/s5.8 KB23:59:53
9news.tnetconsulting.net1.7 MB3.4 MB5.0 MB0.1 KB/s8.9 KB23:59:53
10news.nntp4.net1.6 MB57.5 KB1.7 MB0.0 KB/s7.8 KB23:58:46
11usenet.network1.6 MB125.6 KB1.7 MB0.0 KB/s6.5 KB23:58:08
12nntp.comgw.net1.3 MB2.5 MB3.7 MB0.0 KB/s11.9 KB23:59:40
13newsfeed.xs3.de1.2 MB2.7 MB4.0 MB0.0 KB/s8.7 KB23:59:37
14news.weretis.net1.1 MB4.8 MB5.9 MB0.1 KB/s11.8 KB23:59:53
15news.bbs.nz956.3 KB5.6 MB6.5 MB0.1 KB/s7.4 KB23:59:53
16i2pn.org826.4 KB308.6 KB1.1 MB0.0 KB/s5.9 KB23:59:53
17ddt.demos.su732.6 KB0.0 KB732.6 KB0.0 KB/s122.1 KB06:14:41
18news.corradoroberto.it486.2 KB0.0 KB486.2 KB0.0 KB/s2.3 KB22:51:55
19news.samoylyk.net225.1 KB10.6 MB10.8 MB0.1 KB/s9.0 KB23:59:53
20news.nk.ca203.4 KB4.8 MB5.0 MB0.1 KB/s6.2 KB23:59:53
21usenet.blueworldhosting.com19.0 KB26.4 KB45.4 KB0.0 KB/s9.1 KB23:57:23
22news.chmurka.net13.3 KB0.0 KB13.3 KB0.0 KB/s3.3 KB23:59:53
23feed.opticnetworks.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:53
24photonic.trudheim.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:53
TOTAL: 2465.0 MB48.7 MB113.7 MB0.1 KB/s6.6 KB556:53:42
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1206.168.34.86 5 00.0 KB 0 0 000:00:52
2198.235.24.31 1 00.0 KB 0 0 000:00:10
3198.235.24.82 1 00.0 KB 0 0 000:00:10
478.150.216.162.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
5azpdegb29.stretchoid.com 1 00.0 KB 0 0 000:00:00
6azpdssc25.stretchoid.com 1 00.0 KB 0 0 000:00:09
7localhost 1 00.0 KB 0 0 000:11:14
TOTAL: 7 11 00.0 KB 0 0 000:12:36

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 7 00.0 KB 0 0 000:01:12
2*.stretchoid.com 2 00.0 KB 0 0 000:00:09
3*.150.216.162.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
4? 1 00.0 KB 0 0 000:11:14
TOTAL: 4 11 00.0 KB 0 0 000:12:36

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 182.036 369.325 0.07400:11:14
206.168.34.86 0.043 0.069 0.00000:00:52
198.235.24.82 0.000 0.043 0.00000:00:10
198.235.24.31 0.013 0.004 0.00000:00:10
azpdssc25.stretchoid.com 0.011 0.014 0.00000:00:09
azpdegb29.stretchoid.com 0.000 0.026 0.00000:00:00
78.150.216.162.bc.googleusercontent.com 0.000 0.023 0.00000:00:00
TOTAL: 7 182.103 369.504 0.07400:12:36

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

SystemConn
78.150.216.162.bc.googleusercontent.com 4
206.168.34.86 3
azpdegb29.stretchoid.com 1
TOTAL: 3 8

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

CommandCount
GET / HTTP/1.1 2
Host: 144.172.126.95:119 2
Accept-Encoding: gzip 1
EHLO www.censys.io 1
MGLNDD_144.172.126.95_119 1
User-Agent: Expanse, a Palo Alto Network... 1
TOTAL: 6 8

NNRP client timeouts [Top 20]:

SystemConnPeer
206.168.34.86 2 2
TOTAL: 1 2 2