Daily Usenet Report

Oct 5 00:01:02 -- Oct 6 00:01:02

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Oct 5 08:13:04 newsfeed innd: message repeated 2 times: [ ctlinnd command s]
Oct 6 00:00:01 newsfeed nnrpd[26176]: localhost auth: program exited with status 8

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 22423 52.2%2.7 MB 33.9%
inn 8031 18.7%3.3 MB 41.3%
innd 7877 18.4%1.1 MB 14.2%
innfeed 4110 9.6%800.9 KB 9.9%
cnfsstat 432 1.0%63.6 KB 0.8%
nocem 45 0.1%5.1 KB 0.1%
controlchan 1 0.0%0.2 KB 0.0%
TOTAL: 7 42919 100.0%7.9 MB100.0%

History cache:

ReasonCount%Count
Positive hits 112007 60.1%
Negative hits 66313 35.6%
Do not exist 7909 4.2%
Cache misses 9 0.0%
TOTAL: 4 186238 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.138 0.0%59 0.000 2.339 6.000
article cleanup00:00:00.095 0.0%7956 0.000 0.012 0.079
article logging00:00:00.407 0.0%8036 0.000 0.051 0.539
article parse00:00:00.172 0.0%11327 0.000 0.015 0.059
article write00:00:02.424 0.0%6863 0.000 0.353 14.500
artlog/artcncl00:00:00.000 0.0%4 0.000 0.000 0.000
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.858 0.0%188929 0.000 0.005 0.257
hisgrep/artcncl00:00:00.118 0.0%62 0.000 1.903 6.000
hishave/artcncl00:00:00.000 0.0%4 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:11.563 0.2%187415 0.092 0.702 5.232
history sync00:00:00.073 0.0%401 0.000 0.182 1.000
history write00:01:36.249 0.1%7956 3.227 12.098 166.160
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:53:22.459 99.5%194421 75.535 442.352 1626.306
nntp read00:00:03.085 0.0%189904 0.003 0.016 0.219
overview write00:01:57.648 0.1%6863 0.763 17.142 1057.797
perl filter00:00:38.210 0.0%7956 1.551 4.803 105.079
python filter00:00:01.322 0.0%7956 0.000 0.166 1.854
site send00:00:01.127 0.0%13769 0.000 0.082 0.250
TOTAL: 24:01:04.97923:59:55.948 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.012 0.0%7229 0.000 0.002 0.069
article prepare00:00:00.007 0.0%52312 0.000 0.000 0.008
article read00:00:00.639 0.0%4975 0.000 0.128 0.353
backlog stats00:00:00.359 0.0%250045 0.000 0.001 0.009
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.152 0.0%172641 0.002 0.012 0.043
data write00:00:03.101 0.0%168488 0.007 0.018 0.040
idle23:58:49.683100.0%250045 188.289 345.257 1281.226
status file00:00:00.341 0.0%266 0.667 1.282 24.000
TOTAL: 23:59:06.49823:58:56.294100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:41:06.764 67.8%16695 1.000 147.755 10050.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:04.399 0.1%112198 0.000 0.039 1.500
TOTAL: 01:00:37.98500:41:11.163 67.9%----

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 5532 1154 4371 7 20%23:58:36
2usenet.goja.nl.eu.org 10 6860 947 5705 208 13%21:56:55
3usenet.blueworldhosting.com 719 7781 904 6494 383 11%23:54:22
4news.hispagatos.org 7 7163 644 6498 21 8%24:35:17
5endofthelinebbs-out.news.weretis.net 3 12531 595 11795 141 4%48:20:56
6nntp.comgw.net 3 7170 492 6546 132 6%23:49:17
7i2pn.org 1 7312 410 6834 68 5%23:59:55
8news.corradoroberto.it 5 1134 371 763 0 32%24:24:19
9newsfeed.xs3.de 2 5932 265 5629 38 4%23:59:16
10newsfeed.bofh.team 2 7741 163 7571 7 2%23:59:41
11usenet.network 1 5415 155 5258 2 2%23:59:57
12endoftheline-out.news.chmurka.net 1 3440 143 3296 1 4%23:59:55
13endofthelinebbs.peers.news.panix.com 26 7169 135 7024 10 1%24:04:48
14news.netfront.net 2 7301 110 7052 139 1%38:19:24
15news.samoylyk.net 3 6377 96 6280 1 1%26:10:48
16news.furie.org.uk 3 7115 80 7034 1 1%47:59:40
17news.nntp4.net 1 5982 69 5912 1 1%23:59:53
18glockenspiel.complete.org 2 4225 25 4200 0 0%19:52:45
19news.bbs.nz 1 2330 6 2324 0 0%10:42:55
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:12
TOTAL: 22 824 118510 6764 110586 1160 5%502:38:54
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1outgoing.news.lysator.liu.se3.6 MB0.0 KB7.0 KB3.6 MB 99%3.2 KB
2usenet.goja.nl.eu.org2.8 MB0.0 KB341.5 KB3.2 MB 89%2.8 KB
3usenet.blueworldhosting.com2.3 MB0.0 KB733.5 KB3.1 MB 76%2.4 KB
4news.hispagatos.org2.3 MB0.0 KB23.1 KB2.3 MB 99%3.6 KB
5news.corradoroberto.it2.1 MB0.0 KB0.0 KB2.1 MB100%5.8 KB
6endofthelinebbs-out.news.weretis.net2.0 MB0.0 KB198.7 KB2.2 MB 91%3.0 KB
7usenet.network2.0 MB0.0 KB2.8 KB2.0 MB 99%12.8 KB
8i2pn.org1.7 MB0.0 KB87.4 KB1.8 MB 95%3.8 KB
9nntp.comgw.net1.6 MB0.0 KB252.2 KB1.8 MB 86%3.0 KB
10newsfeed.xs3.de713.9 KB0.0 KB65.4 KB779.4 KB 91%2.6 KB
11news.samoylyk.net627.3 KB0.0 KB1.2 KB628.5 KB 99%6.5 KB
12endoftheline-out.news.chmurka.net619.6 KB0.0 KB0.8 KB620.3 KB 99%4.3 KB
13newsfeed.bofh.team413.5 KB0.0 KB11.0 KB424.5 KB 97%2.5 KB
14endofthelinebbs.peers.news.panix.com405.5 KB0.0 KB9.4 KB414.9 KB 97%2.9 KB
15news.furie.org.uk293.8 KB0.0 KB0.8 KB294.6 KB 99%3.6 KB
16news.netfront.net195.9 KB0.0 KB503.5 KB699.4 KB 28%2.8 KB
17news.nntp4.net167.2 KB0.0 KB1.3 KB168.5 KB 99%2.4 KB
18glockenspiel.complete.org100.1 KB0.0 KB0.0 KB100.1 KB100%4.0 KB
19news.bbs.nz20.9 KB0.0 KB0.0 KB20.9 KB100%3.5 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: 2223.9 MB0.0 KB2.2 MB26.1 MB 91%3.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 5 00:01:02 - 00:59:59 136 2.0% 0.04736.8 KB 3.0% 0.21
Oct 5 01:00:00 - 01:59:59 215 3.1% 0.06805.3 KB 3.3% 0.22
Oct 5 02:00:00 - 02:59:59 290 4.2% 0.081.4 MB 6.0% 0.41
Oct 5 03:00:00 - 03:59:59 391 5.7% 0.111.1 MB 4.5% 0.30
Oct 5 04:00:00 - 04:59:59 304 4.4% 0.08861.2 KB 3.5% 0.24
Oct 5 05:00:00 - 05:59:59 332 4.8% 0.091.2 MB 4.8% 0.33
Oct 5 06:00:00 - 06:59:59 311 4.5% 0.09942.3 KB 3.9% 0.26
Oct 5 07:00:00 - 07:59:59 359 5.2% 0.101.2 MB 5.2% 0.35
Oct 5 08:00:00 - 08:59:59 369 5.4% 0.101.1 MB 4.8% 0.33
Oct 5 09:00:00 - 09:59:59 351 5.1% 0.101.3 MB 5.4% 0.37
Oct 5 10:00:00 - 10:59:59 390 5.7% 0.111.3 MB 5.5% 0.37
Oct 5 11:00:00 - 11:59:59 338 4.9% 0.091.3 MB 5.5% 0.37
Oct 5 12:00:00 - 12:59:59 345 5.0% 0.101.2 MB 5.1% 0.35
Oct 5 13:00:00 - 13:59:59 399 5.8% 0.111.2 MB 5.0% 0.34
Oct 5 14:00:00 - 14:59:59 372 5.4% 0.101.1 MB 4.8% 0.32
Oct 5 15:00:00 - 15:59:59 347 5.1% 0.10911.6 KB 3.7% 0.25
Oct 5 16:00:00 - 16:59:59 337 4.9% 0.091.4 MB 5.9% 0.40
Oct 5 17:00:00 - 17:59:59 254 3.7% 0.07837.3 KB 3.4% 0.23
Oct 5 18:00:00 - 18:59:59 203 3.0% 0.06751.6 KB 3.1% 0.21
Oct 5 19:00:00 - 19:59:59 146 2.1% 0.04622.2 KB 2.5% 0.17
Oct 5 20:00:00 - 20:59:59 129 1.9% 0.04562.2 KB 2.3% 0.16
Oct 5 21:00:00 - 21:59:59 199 2.9% 0.06864.7 KB 3.5% 0.24
Oct 5 22:00:00 - 22:59:59 163 2.4% 0.05544.1 KB 2.2% 0.15
Oct 5 23:00:00 - 23:59:59 176 2.6% 0.05738.0 KB 3.0% 0.20
Oct 6 00:00:00 - 00:01:02 2 0.0% 0.035.7 KB 0.0% 0.09
TOTAL: 24:00:00 6858 100.0% 0.0823.9 MB 100.0% 0.28
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.4442025.65
CYCTXT1TEXT5.0 GB3.9 GB 77.7% 0 0.03 2049.11
TOTAL: 3-3077.0 GB102.2 GB 3.3% 1 0.31-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1usenet.blueworldhosting.com 405 0 0 0 1 0 0 0 404
2usenet.goja.nl.eu.org 222 0 0 0 0 0 0 0 222
3endofthelinebbs-out.news.weretis.net 182 0 0 0 0 0 0 0 182
4nntp.comgw.net 127 0 0 0 0 0 0 0 127
5i2pn.org 68 0 0 0 0 0 0 0 68
6news.netfront.net 62 0 0 0 0 0 0 0 62
7newsfeed.xs3.de 42 0 0 0 0 0 0 0 42
8news.hispagatos.org 21 10 0 0 0 0 0 0 11
9endofthelinebbs.peers.news.panix.com 17 2 0 0 0 0 0 0 15
10newsfeed.bofh.team 8 1 0 0 0 0 0 0 7
11outgoing.news.lysator.liu.se 8 0 0 0 0 0 0 0 8
12usenet.network 2 0 0 0 0 0 0 0 2
13endoftheline-out.news.chmurka.net 1 0 0 0 0 0 0 0 1
14news.bbs.nz 1 0 0 0 0 0 0 0 1
15news.furie.org.uk 1 0 0 0 0 0 0 0 1
16news.nntp4.net 1 0 0 0 0 0 0 0 1
17news.samoylyk.net 1 0 0 0 0 0 0 0 1
TOTAL: 17 1169 13 0 0 1 0 0 0 1155

Unwanted newsgroups [Top 20]:

NewsgroupCount
hispagatos.hacking.ctf 9
a.b.mp3.audiobooks 2
hispagatos.hacking.news 1
soc.culture.russia 1
TOTAL: 4 13

Supposedly-moderated groups with unmoderated postings [Top 20]:

GroupsCount
rec.radio.broadcasting 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (phn path) 577
EMP (phr path) 292
EMP (md5) 91
Too many newsgroups 85
User-issued cancel 23
Binary: misplaced binary 4
HTML Multipart 2
EMP (fsl) 1
TOTAL: 8 1075

NoCeM on Spool:

Issuer (type)NoticesBad PGPCancelSkipTotal
i2pn2-nocem@i2pn2.org (spam)10101
i2pn2-nocem@i2pn2.org (multipost)3000140140
i2pn2-nocem@i2pn2.org (rmp)40099
robot@pasdenom.info (spam3)40077
robot@pasdenom.info (spam2)40044
TOTAL: 54301160161

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
endofthelinebbs-out.news.weretis.net 33
usenet.blueworldhosting.com 22
usenet.goja.nl.eu.org 9
endofthelinebbs.peers.news.panix.com 8
newsfeed.xs3.de 4
newsfeed.bofh.team 1
nntp.comgw.net 1
news.netfront.net 1
outgoing.news.lysator.liu.se 1
TOTAL: 9 80
TOTAL: 1 80

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.netfront.net 9223 3873 2925 0 0 15 41%23:59:52
2nyheter.lysator.liu.se 5890 1614 3846 240 0 0 27%23:59:52
3news.furie.org.uk 3808 689 2472 10 0 3 18%23:59:39
4photonic.trudheim.com 7243 544 5189 1123 0 0 7%23:59:02
5usenet.goja.nl.eu.org 6942 395 5333 87 0 11 5%23:59:52
6news.hispagatos.org 7381 370 5665 103 0 1 5%23:59:52
7endofthelinebbs.peers.news.panix.com 7119 360 6488 5 0 0 5%23:59:52
8usenet.network 7369 260 6041 19 0 6 3%23:59:52
9news.bbs.nz 12609 230 6168 448 0 63 1%23:58:21
10newsfeed.bofh.team 7849 183 6427 0 0 13 2%23:59:52
11news.nk.ca 10318 177 6134 514 0 17 1%23:59:52
12news.nntp4.net 7927 137 6619 14 0 14 1%23:59:51
13nntp.comgw.net 7434 130 6203 49 0 114 1%23:59:52
14news.tnetconsulting.net 7767 106 6599 147 0 14 1%23:59:52
15news.weretis.net 7098 105 6688 64 0 0 1%23:58:54
16i2pn.org 7430 98 6282 49 0 64 1%23:59:32
17news.quux.org 7220 88 6281 453 0 0 1%23:59:52
18newsfeed.xs3.de 7986 60 6323 195 0 13 0%23:59:52
19news.chmurka.net 3637 48 3019 0 0 0 1%23:59:52
20news.corradoroberto.it 723 43 582 7 0 1 5%22:57:01
21news.samoylyk.net 8011 20 6713 24 0 15 0%23:59:52
22usenet.blueworldhosting.com 5993 1 5695 0 0 0 0%23:59:43
23feed.opticnetworks.net 0 0 0 0 0 6858 0%23:59:52
TOTAL: 23 156977 9531 117692 3551 0 7222 6%550:50:03
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.netfront.net13.6 MB0.0 KB13.6 MB0.2 KB/s3.6 KB23:59:52
2nyheter.lysator.liu.se5.6 MB1.5 MB7.1 MB0.1 KB/s3.9 KB23:59:52
3news.furie.org.uk4.2 MB113.8 KB4.3 MB0.1 KB/s6.3 KB23:59:39
4photonic.trudheim.com2.3 MB3.3 MB5.6 MB0.1 KB/s3.5 KB23:59:02
5news.quux.org1.5 MB1.5 MB3.0 MB0.0 KB/s5.6 KB23:59:52
6endofthelinebbs.peers.news.panix.com1.4 MB4.9 KB1.4 MB0.0 KB/s4.0 KB23:59:52
7news.hispagatos.org1.2 MB730.5 KB1.9 MB0.0 KB/s4.1 KB23:59:52
8news.samoylyk.net1.1 MB43.6 KB1.2 MB0.0 KB/s27.3 KB23:59:52
9newsfeed.bofh.team956.3 KB0.0 KB956.3 KB0.0 KB/s5.2 KB23:59:52
10news.nk.ca949.9 KB2.5 MB3.4 MB0.0 KB/s5.0 KB23:59:52
11nntp.comgw.net877.2 KB868.5 KB1.7 MB0.0 KB/s9.8 KB23:59:52
12usenet.network843.7 KB36.4 KB880.1 KB0.0 KB/s3.2 KB23:59:52
13usenet.goja.nl.eu.org821.5 KB794.9 KB1.6 MB0.0 KB/s3.4 KB23:59:52
14news.bbs.nz712.8 KB2.5 MB3.2 MB0.0 KB/s4.8 KB23:58:21
15news.nntp4.net645.1 KB264.4 KB909.5 KB0.0 KB/s6.0 KB23:59:51
16news.weretis.net489.4 KB1.5 MB1.9 MB0.0 KB/s11.8 KB23:58:54
17news.tnetconsulting.net477.9 KB759.8 KB1.2 MB0.0 KB/s4.9 KB23:59:52
18i2pn.org291.3 KB122.9 KB414.2 KB0.0 KB/s2.8 KB23:59:32
19newsfeed.xs3.de263.5 KB1.1 MB1.4 MB0.0 KB/s5.5 KB23:59:52
20news.chmurka.net192.0 KB0.0 KB192.0 KB0.0 KB/s4.0 KB23:59:52
21news.corradoroberto.it156.7 KB17.2 KB174.0 KB0.0 KB/s3.5 KB22:57:01
22usenet.blueworldhosting.com4.5 KB0.0 KB4.5 KB0.0 KB/s4.5 KB23:59:43
23feed.opticnetworks.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:52
TOTAL: 2338.4 MB17.5 MB55.9 MB0.0 KB/s4.4 KB550:50:03
Outgoing feeds (innfeed) by Volume

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1?2792 00.0 KB 0 0 000:31:08
2*.demos.su2774 00.0 KB 0 0 000:28:26
3unresolved 13 00.0 KB 1 0 000:00:57
4*.stretchoid.com 1 00.0 KB 0 0 000:00:00
5*.survey.inspici.com 1 00.0 KB 0 0 000:00:03
TOTAL: 55581 00.0 KB 1 0 001:00:35

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.787 36.656 0.00000:28:26
2001:470:28:a8:ca7f:54ff:fe03:41e0 9.990 36.854 0.00000:19:56
localhost 179.099 370.555 0.07700:11:10
8.219.246.7 0.007 0.028 0.00000:00:18
198.235.24.40 0.005 0.010 0.00000:00:10
205.210.31.248 0.005 0.011 0.00000:00:10
104.152.52.234 0.004 0.012 0.00000:00:10
199.45.154.158 0.024 0.074 0.00000:00:08
server-0-3.survey.inspici.com 0.004 0.012 0.00000:00:03
2607:ff10:c8:594::e 0.011 0.005 0.00000:00:01
91.238.181.71 0.000 0.017 0.00000:00:00
91.238.181.35 0.004 0.012 0.00000:00:00
azpdwgc61.stretchoid.com 0.000 0.016 0.00000:00:00
104.152.52.201 0.005 0.011 0.00000:00:00
TOTAL: 14 198.945 444.273 0.07701:00:35

Curious NNRP server explorers [Top 20]:

SystemConn
2001:470:28:a8:ca7f:54ff:fe03:41e0 2790
ddt.demos.su 2774
199.45.154.158 5
8.219.246.7 2
104.152.52.201 1
104.152.52.234 1
198.235.24.40 1
205.210.31.248 1
2607:ff10:c8:594::e 1
91.238.181.35 1
91.238.181.71 1
azpdwgc61.stretchoid.com 1
localhost 1
server-0-3.survey.inspici.com 1
TOTAL: 14 5581

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

SystemConn
199.45.154.158 2
91.238.181.35 1
91.238.181.71 1
azpdwgc61.stretchoid.com 1
TOTAL: 4 5

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

CommandCount
#003 2
#026#003#001 1
EHLO www.censys.io 1
MGLNDD_144.172.126.95_119 1
TOTAL: 4 5

NNRP client timeouts [Top 20]:

SystemConnPeer
199.45.154.158 1 3
91.238.181.35 1 1
91.238.181.71 1 1
TOTAL: 3 3 5

Newsgroup request counts (by hierarchy):

HierarchyCountPct
1news 5100.0%
TOTAL: 1 5100.0%

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

NewsgroupCount
1news.admin.peering 5
TOTAL: 1 5