Daily Usenet Report

Sep 15 00:01:02 -- Sep 16 00:01:02

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Sep 15 10:00:10 newsfeed pgpverify[3991125]: pgpverify: verification failed
Sep 16 00:00:01 newsfeed nnrpd[39463]: localhost auth: program exited with status 8

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 8382 28.3%892.1 KB 14.1%
innd 8329 28.1%1.2 MB 19.2%
inn 8278 28.0%3.3 MB 53.1%
innfeed 4101 13.9%781.3 KB 12.4%
cnfsstat 432 1.5%63.8 KB 1.0%
nocem 48 0.2%5.9 KB 0.1%
controlchan 23 0.1%5.3 KB 0.1%
pgpverify 1 0.0%0.1 KB 0.0%
TOTAL: 8 29594 100.0%6.2 MB100.0%

History cache:

ReasonCount%Count
Positive hits 111769 61.2%
Negative hits 61925 33.9%
Do not exist 8067 4.4%
Cache misses 908 0.5%
TOTAL: 4 182669 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.211 0.0%55 0.000 3.836 9.500
article cleanup00:00:00.112 0.0%8135 0.000 0.014 0.091
article logging00:00:00.470 0.0%8260 0.000 0.057 1.594
article parse00:00:00.173 0.0%11773 0.000 0.015 0.058
article write00:00:02.411 0.0%6676 0.000 0.361 5.947
artlog/artcncl00:00:00.001 0.0%21 0.000 0.048 0.250
artlog/artparse00:00:00.000 0.0%1 0.000 0.000 0.000
data move00:00:00.260 0.0%183239 0.000 0.001 0.035
hisgrep/artcncl00:00:00.126 0.0%60 0.000 2.100 8.000
hishave/artcncl00:00:00.008 0.0%26 0.000 0.308 6.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:27.193 0.2%183340 0.102 0.803 5.134
history sync00:00:00.059 0.0%395 0.000 0.149 0.667
history write00:01:52.081 0.1%8096 3.063 13.844 107.492
hiswrite/artcncl00:00:00.015 0.0%2 3.000 7.500 12.000
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:39:57.810 99.0%184103 77.523 462.773 1339.130
nntp read00:00:05.678 0.0%184287 0.003 0.031 1.437
overview write00:09:14.715 0.6%6676 0.769 83.091 16004.800
perl filter00:00:25.949 0.0%8095 1.515 3.206 19.262
python filter00:00:02.257 0.0%8095 0.000 0.279 12.315
site send00:00:01.046 0.0%13392 0.000 0.078 0.233
TOTAL: 23:54:59.62623:54:10.575 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.025 0.0%7539 0.000 0.003 0.074
article prepare00:00:00.011 0.0%44472 0.000 0.000 0.006
article read00:00:00.482 0.0%3573 0.000 0.135 0.333
backlog stats00:00:00.358 0.0%252467 0.000 0.001 0.009
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.159 0.0%171340 0.000 0.013 0.050
data write00:00:02.984 0.0%166500 0.009 0.018 0.034
idle23:57:52.436100.0%252467 149.695 341.718 1644.389
status file00:00:00.305 0.0%260 0.750 1.173 4.000
TOTAL: 23:58:08.80923:57:58.760100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:52:01.555 72.8%8300 0.000 376.091900256.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:03.916 0.1%95408 0.000 0.041 1.000
TOTAL: 01:11:30.32200:52:05.471 72.8%----

Control commands to INND:

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
group-admin@isc.org002112
TOTAL002112

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1outgoing.news.lysator.liu.se 2 6045 1401 4569 75 23%23:59:26
2endofthelinebbs-out.news.weretis.net 3 13194 1065 11879 250 8%50:43:24
3usenet.blueworldhosting.com 720 7830 1011 6172 647 12%23:56:56
4nntp.comgw.net 2 7271 612 6556 103 8%23:59:43
5news.hispagatos.org 5 7140 515 6590 35 7%24:26:19
6usenet.goja.nl.eu.org 11 7401 410 6915 76 5%24:14:24
7newsfeed.bofh.team 2 7766 385 7332 49 4%23:59:54
8news.corradoroberto.it 7 1115 374 741 0 33%24:01:27
9i2pn.org 2 7222 256 6932 34 3%23:59:39
10endofthelinebbs.peers.news.panix.com 25 7043 171 6855 17 2%23:54:58
11usenet.network 2 5265 146 5114 5 2%23:59:57
12news.nntp4.net 2 6041 54 5984 3 0%23:59:51
13endoftheline-out.news.chmurka.net 1 3477 52 3422 3 1%23:59:55
14news.samoylyk.net 2 6237 45 6192 0 0%23:59:43
15newsfeed.xs3.de 2 5735 39 5693 3 0%23:59:54
16news.netfront.net 1 5615 19 5491 105 0%22:58:35
17glockenspiel.complete.org 2 5186 15 5169 2 0%24:02:24
18news.bbs.nz 2 6065 9 6054 2 0%23:59:16
19news.furie.org.uk 2 1354 0 1352 2 0%06:34:10
20photonic.trudheim.com 3 1200 0 1199 1 0%18:23:29
21eotl-out.news.tnetconsulting.net 1 0 0 0 0 0%00:10:04
22localhost 31 0 0 0 0 0%00:00:00
23news.nk.ca 2 0 0 0 0 0%00:20:19
TOTAL: 23 832 118202 6579 110211 1412 5%483:43:47
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1outgoing.news.lysator.liu.se3.8 MB27.1 KB118.1 KB4.0 MB 96%2.8 KB
2endofthelinebbs-out.news.weretis.net3.8 MB65.6 KB527.3 KB4.3 MB 86%3.4 KB
3news.corradoroberto.it2.5 MB0.0 KB0.0 KB2.5 MB100%6.9 KB
4nntp.comgw.net2.5 MB32.8 KB289.2 KB2.8 MB 88%4.0 KB
5usenet.blueworldhosting.com2.5 MB0.0 KB1.3 MB3.8 MB 64%2.3 KB
6news.hispagatos.org1.7 MB27.1 KB41.6 KB1.7 MB 96%3.2 KB
7usenet.network1.5 MB27.0 KB6.0 KB1.6 MB 97%10.6 KB
8usenet.goja.nl.eu.org1.4 MB22.8 KB112.4 KB1.5 MB 91%3.2 KB
9newsfeed.bofh.team1.2 MB32.8 KB68.6 KB1.3 MB 92%3.0 KB
10i2pn.org794.2 KB27.0 KB41.3 KB862.5 KB 92%3.0 KB
11endofthelinebbs.peers.news.panix.com451.2 KB27.0 KB78.1 KB556.2 KB 81%3.0 KB
12newsfeed.xs3.de432.5 KB22.8 KB1.0 KB456.3 KB 94%10.9 KB
13news.samoylyk.net200.1 KB0.0 KB0.0 KB200.1 KB100%4.4 KB
14news.nntp4.net127.9 KB32.8 KB0.0 KB160.7 KB 79%2.8 KB
15glockenspiel.complete.org120.4 KB27.0 KB0.0 KB147.5 KB 81%8.7 KB
16endoftheline-out.news.chmurka.net114.5 KB15.8 KB0.6 KB131.0 KB 87%2.4 KB
17news.netfront.net87.1 KB27.1 KB410.9 KB525.1 KB 16%4.2 KB
18news.bbs.nz24.3 KB27.1 KB0.0 KB51.4 KB 47%4.7 KB
19eotl-out.news.tnetconsulting.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
20localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
21news.furie.org.uk0.0 KB27.2 KB0.0 KB27.2 KB 0%13.6 KB
22news.nk.ca0.0 KB0.0 KB0.0 KB0.0 KB 0%0
23photonic.trudheim.com0.0 KB17.0 KB0.0 KB17.0 KB 0%17.0 KB
TOTAL: 2323.0 MB486.0 KB3.0 MB26.5 MB 86%3.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 15 00:01:02 - 00:59:59 147 2.2% 0.04712.2 KB 3.0% 0.20
Sep 15 01:00:00 - 01:59:59 180 2.7% 0.05859.4 KB 3.7% 0.24
Sep 15 02:00:00 - 02:59:59 237 3.6% 0.07811.3 KB 3.5% 0.23
Sep 15 03:00:00 - 03:59:59 257 3.9% 0.07801.8 KB 3.4% 0.22
Sep 15 04:00:00 - 04:59:59 353 5.3% 0.10948.4 KB 4.0% 0.26
Sep 15 05:00:00 - 05:59:59 338 5.1% 0.09956.4 KB 4.1% 0.27
Sep 15 06:00:00 - 06:59:59 252 3.8% 0.07899.5 KB 3.8% 0.25
Sep 15 07:00:00 - 07:59:59 325 4.9% 0.09963.8 KB 4.1% 0.27
Sep 15 08:00:00 - 08:59:59 325 4.9% 0.09922.9 KB 3.9% 0.26
Sep 15 09:00:00 - 09:59:59 408 6.1% 0.111008.1 KB 4.3% 0.28
Sep 15 10:00:00 - 10:59:59 383 5.7% 0.111.4 MB 6.1% 0.40
Sep 15 11:00:00 - 11:59:59 375 5.6% 0.101.0 MB 4.4% 0.29
Sep 15 12:00:00 - 12:59:59 383 5.7% 0.112.6 MB 11.2% 0.73
Sep 15 13:00:00 - 13:59:59 370 5.5% 0.101.2 MB 5.3% 0.35
Sep 15 14:00:00 - 14:59:59 379 5.7% 0.111.1 MB 4.8% 0.31
Sep 15 15:00:00 - 15:59:59 339 5.1% 0.091.1 MB 5.0% 0.33
Sep 15 16:00:00 - 16:59:59 298 4.5% 0.081.1 MB 4.8% 0.31
Sep 15 17:00:00 - 17:59:59 216 3.2% 0.06806.2 KB 3.4% 0.22
Sep 15 18:00:00 - 18:59:59 233 3.5% 0.06846.7 KB 3.6% 0.24
Sep 15 19:00:00 - 19:59:59 207 3.1% 0.06815.3 KB 3.5% 0.23
Sep 15 20:00:00 - 20:59:59 137 2.1% 0.04527.9 KB 2.2% 0.15
Sep 15 21:00:00 - 21:59:59 145 2.2% 0.04598.8 KB 2.5% 0.17
Sep 15 22:00:00 - 22:59:59 157 2.4% 0.04545.1 KB 2.3% 0.15
Sep 15 23:00:00 - 23:59:59 222 3.3% 0.06670.6 KB 2.9% 0.19
Sep 16 00:00:00 - 00:01:02 5 0.1% 0.0845.1 KB 0.2% 0.73
TOTAL: 24:00:00 6671 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 GB97.5 GB 6.3% 0 0.4343790.82
CYCTXT1TEXT5.0 GB3.9 GB 77.2% 0 0.03 2348.23
TOTAL: 3-3077.0 GB101.4 GB 3.3% 1 0.29-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1usenet.blueworldhosting.com 693 1 0 0 0 0 0 0 692
2endofthelinebbs-out.news.weretis.net 307 0 0 6 0 0 0 0 301
3nntp.comgw.net 112 0 0 3 0 0 0 0 109
4news.netfront.net 111 0 0 2 0 0 0 0 109
5usenet.goja.nl.eu.org 85 0 0 2 0 0 0 0 83
6outgoing.news.lysator.liu.se 77 0 0 2 0 0 0 0 75
7newsfeed.bofh.team 53 0 0 3 0 0 0 0 50
8news.furie.org.uk 38 0 0 2 0 0 0 0 36
9news.hispagatos.org 37 13 0 2 0 0 0 0 22
10i2pn.org 34 0 0 2 0 0 0 0 32
11endofthelinebbs.peers.news.panix.com 18 0 0 2 0 0 0 0 16
12usenet.network 5 0 0 2 0 0 0 0 3
13glockenspiel.complete.org 4 0 0 2 0 0 0 0 2
14endoftheline-out.news.chmurka.net 3 0 0 2 0 0 0 0 1
15news.nntp4.net 3 0 0 3 0 0 0 0 0
16newsfeed.xs3.de 3 0 0 2 0 0 0 0 1
17news.bbs.nz 2 0 0 2 0 0 0 0 0
18photonic.trudheim.com 1 0 0 1 0 0 0 0 0
TOTAL: 18 1586 14 0 40 0 0 0 0 1532

Unwanted newsgroups [Top 20]:

NewsgroupCount
hispagatos.hacking.ctf 13
alt.checkmate.alt.usenet.kooks 1
TOTAL: 2 14

INND Perl filter [Top 20]:

ReasonCount
EMP (phn path) 663
EMP (phr path) 399
EMP (md5) 200
Too many newsgroups 98
Too many newsgroups (meow) 20
User-issued cancel 16
HTML Multipart 10
TOTAL: 7 1406

NoCeM on Spool:

Issuer (type)NoticesBad PGPCancelSkipTotal
nocem@eternal-september.org (bot)2011011
i2pn2-nocem@i2pn2.org (spam)50606
robot@pasdenom.info (spam)20202
i2pn2-nocem@i2pn2.org (rmp)14005959
i2pn2-nocem@i2pn2.org (multipost)9003030
robot@pasdenom.info (spam3)5001010
robot@pasdenom.info (spam2)10011
TOTAL: 738019100119

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
endofthelinebbs-out.news.weretis.net 48
usenet.blueworldhosting.com 46
usenet.goja.nl.eu.org 13
nntp.comgw.net 9
newsfeed.bofh.team 4
news.hispagatos.org 2
outgoing.news.lysator.liu.se 2
endofthelinebbs.peers.news.panix.com 1
TOTAL: 8 125
No colon-space in header field
usenet.blueworldhosting.com 1
TOTAL: 1 1
TOTAL: 2 126

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.netfront.net 10651 1982 4657 2 0 11 18%23:59:53
2nyheter.lysator.liu.se 5490 1449 3603 215 0 0 26%23:59:53
3news.furie.org.uk 3993 841 2368 35 0 36 21%23:59:53
4photonic.trudheim.com 9563 464 5080 1109 0 690 4%23:59:53
5usenet.network 7494 397 5691 37 0 0 5%23:59:50
6news.hispagatos.org 7323 385 5581 110 0 2 5%23:59:53
7endofthelinebbs.peers.news.panix.com 6869 341 6325 0 0 0 4%23:59:53
8usenet.goja.nl.eu.org 7459 309 5896 58 0 0 4%23:59:53
9news.nk.ca 9606 283 5919 404 0 8 2%23:59:53
10news.bbs.nz 12339 227 6184 233 0 69 1%23:59:53
11news.nntp4.net 7511 209 6347 13 0 1 2%23:59:49
12i2pn.org 7214 187 6175 33 0 14 2%23:59:53
13newsfeed.bofh.team 7343 169 6100 0 0 0 2%23:59:53
14news.tnetconsulting.net 7365 134 6368 161 0 9 1%23:59:53
15news.weretis.net 6904 119 6471 65 0 0 1%23:59:49
16nntp.comgw.net 6967 114 5919 41 0 0 1%23:59:43
17news.quux.org 7063 107 6208 322 0 0 1%23:59:53
18newsfeed.xs3.de 7940 89 6430 86 0 0 1%23:59:53
19news.corradoroberto.it 834 84 571 1 0 8 10%23:15:46
20news.chmurka.net 3856 62 3209 1 0 0 1%23:59:53
21news.samoylyk.net 8863 37 6348 215 0 22 0%23:59:32
22usenet.blueworldhosting.com 5765 1 5346 0 0 0 0%23:59:50
23feed.opticnetworks.net 0 0 0 0 0 6671 0%23:59:53
TOTAL: 23 158412 7990 116796 3141 0 7541 5%551:12:27
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.netfront.net8.2 MB7.1 KB8.2 MB0.1 KB/s4.2 KB23:59:53
2nyheter.lysator.liu.se4.9 MB1.4 MB6.3 MB0.1 KB/s3.9 KB23:59:53
3news.furie.org.uk4.0 MB162.5 KB4.1 MB0.0 KB/s4.8 KB23:59:53
4photonic.trudheim.com2.5 MB3.1 MB5.6 MB0.1 KB/s3.6 KB23:59:53
5news.hispagatos.org1.4 MB705.2 KB2.1 MB0.0 KB/s4.3 KB23:59:53
6endofthelinebbs.peers.news.panix.com1.3 MB0.0 KB1.3 MB0.0 KB/s4.0 KB23:59:53
7usenet.network1.2 MB85.5 KB1.3 MB0.0 KB/s3.1 KB23:59:50
8newsfeed.bofh.team894.8 KB0.0 KB894.8 KB0.0 KB/s5.3 KB23:59:53
9news.nntp4.net845.3 KB261.0 KB1.1 MB0.0 KB/s5.0 KB23:59:49
10news.quux.org813.3 KB1.1 MB1.9 MB0.0 KB/s4.5 KB23:59:53
11usenet.goja.nl.eu.org778.2 KB345.8 KB1.1 MB0.0 KB/s3.1 KB23:59:53
12i2pn.org646.3 KB183.0 KB829.3 KB0.0 KB/s3.8 KB23:59:53
13news.nk.ca639.7 KB1.5 MB2.2 MB0.0 KB/s3.2 KB23:59:53
14news.bbs.nz629.5 KB888.0 KB1.5 MB0.0 KB/s3.3 KB23:59:53
15news.tnetconsulting.net593.7 KB676.3 KB1.2 MB0.0 KB/s4.3 KB23:59:53
16news.weretis.net548.5 KB763.7 KB1.3 MB0.0 KB/s7.1 KB23:59:49
17nntp.comgw.net461.3 KB433.7 KB895.0 KB0.0 KB/s5.8 KB23:59:43
18newsfeed.xs3.de413.3 KB550.8 KB964.1 KB0.0 KB/s5.5 KB23:59:53
19news.corradoroberto.it279.4 KB1.9 KB281.4 KB0.0 KB/s3.3 KB23:15:46
20news.chmurka.net217.0 KB11.0 KB228.0 KB0.0 KB/s3.6 KB23:59:53
21news.samoylyk.net94.1 KB854.7 KB948.8 KB0.0 KB/s3.8 KB23:59:32
22usenet.blueworldhosting.com4.8 KB0.0 KB4.8 KB0.0 KB/s4.8 KB23:59:50
23feed.opticnetworks.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:53
TOTAL: 2331.2 MB12.9 MB44.1 MB0.0 KB/s4.1 KB551:12:27
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ddt.demos.su2761 00.0 KB 0 0 000:28:54
2206.168.34.45 5 00.0 KB 0 0 000:00:46
3182.237.2.205 2 00.0 KB 0 0 000:00:12
469.10.48.174 2 00.0 KB 0 0 000:30:00
5198.235.24.239 1 00.0 KB 0 0 000:00:10
6205.210.31.192 1 00.0 KB 0 0 000:00:07
771.6.134.233 1 00.0 KB 0 0 000:00:00
880.66.76.121 1 00.0 KB 0 0 000:00:00
991.238.181.35 1 00.0 KB 0 0 000:00:00
10azpdwgb35.stretchoid.com 1 00.0 KB 0 0 000:00:00
11localhost 1 00.0 KB 0 0 000:11:11
12server-0-3.survey.inspici.com 1 00.0 KB 0 0 000:00:03
13vivacious.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
TOTAL: 132779 00.0 KB 0 0 001:11:28

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.demos.su2761 00.0 KB 0 0 000:28:54
2unresolved 14 00.0 KB 0 0 000:31:17
3*.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
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
6? 1 00.0 KB 0 0 000:11:11
TOTAL: 62779 00.0 KB 0 0 001:11:28

NNRP auth users [Top 20]:

UserConn
getlist 1
TOTAL: 1 1

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
69.10.48.174 0.007 0.029 0.00000:30:00
ddt.demos.su 9.610 36.512 0.00000:28:54
localhost 183.652 368.202 0.08000:11:11
206.168.34.45 0.031 0.078 0.00000:00:46
182.237.2.205 0.008 0.024 0.00000:00:12
198.235.24.239 0.008 0.008 0.00000:00:10
205.210.31.192 0.003 0.013 0.00000:00:07
server-0-3.survey.inspici.com 0.000 0.018 0.00000:00:03
vivacious.monitoring.internet-measurement.com 0.006 0.011 0.00000:00:01
71.6.134.233 0.006 0.011 0.00000:00:00
80.66.76.121 0.005 0.011 0.00000:00:00
91.238.181.35 0.007 0.011 0.00000:00:00
azpdwgb35.stretchoid.com 0.000 0.016 0.00000:00:00
TOTAL: 13 193.343 404.944 0.08001:11:28

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

SystemConn
206.168.34.45 3
182.237.2.205 2
80.66.76.121 1
91.238.181.35 1
azpdwgb35.stretchoid.com 1
TOTAL: 5 8

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

CommandCount
#003 2
#001 1
#026#003#001 1
EHLO www.censys.io 1
GET / HTTP/1.1 1
Host: 144.172.126.95:119 1
MGLNDD_144.172.126.95_119 1
TOTAL: 7 8

NNRP client timeouts [Top 20]:

SystemConnPeer
206.168.34.45 2 2
182.237.2.205 1 1
69.10.48.174 1 0
80.66.76.121 1 1
91.238.181.35 1 1
TOTAL: 5 6 6