Daily Usenet Report

May 1 00:01:02 -- May 2 00:01:01

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

May 1 06:30:02 newsfeed pgpverify[1147226]: pgpverify: verification failed
May 2 00:00:01 newsfeed nnrpd[1501156]: localhost auth: program exited with status 8

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 25153 53.3%3.0 MB 35.2%
innd 8795 18.6%1.2 MB 14.7%
inn 7901 16.7%3.2 MB 38.3%
innfeed 4644 9.8%920.9 KB 10.7%
cnfsstat 576 1.2%86.9 KB 1.0%
nocem 92 0.2%9.5 KB 0.1%
controlchan 12 0.0%2.4 KB 0.0%
pgpverify 1 0.0%0.1 KB 0.0%
TOTAL: 8 47174 100.0%8.4 MB100.0%

History cache:

ReasonCount%Count
Positive hits 113400 62.3%
Negative hits 60715 33.4%
Do not exist 7824 4.3%
Cache misses 17 0.0%
TOTAL: 4 181956 100.0%

innd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.267 0.0%50 0.000 5.340 32.500
article cleanup00:00:00.341 0.0%7846 0.000 0.043 3.049
article logging00:00:00.434 0.0%7888 0.000 0.055 0.585
article parse00:00:00.182 0.0%13188 0.000 0.014 0.074
article write00:00:02.914 0.0%6295 0.000 0.463 7.239
artlog/artcncl00:00:00.000 0.0%14 0.000 0.000 0.000
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.336 0.0%185439 0.000 0.002 0.036
hisgrep/artcncl00:00:00.202 0.0%60 0.000 3.367 9.750
hishave/artcncl00:00:00.000 0.0%14 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:17.132 0.2%182498 0.099 0.751 4.833
history sync00:00:00.072 0.0%396 0.000 0.182 1.000
history write00:02:01.087 0.1%7846 3.417 15.433 124.880
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:47:36.481 99.0%188649 63.125 454.052 1922.186
nntp read00:00:02.728 0.0%187003 0.004 0.015 0.044
overview write00:08:01.489 0.6%6295 0.500 76.488 6591.714
perl filter00:00:23.511 0.0%7846 1.434 2.997 15.549
python filter00:00:01.381 0.0%7846 0.000 0.176 8.585
site send00:00:01.201 0.0%12672 0.000 0.095 0.240
TOTAL: 2324:00:29.758 99.9%----

innfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.012 0.0%6943 0.000 0.002 0.040
article prepare00:00:00.008 0.0%50556 0.000 0.000 0.006
article read00:00:00.575 0.0%3996 0.000 0.144 0.333
backlog stats00:00:00.437 0.0%264289 0.000 0.002 0.008
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.548 0.0%181208 0.003 0.014 0.037
data write00:00:03.469 0.0%176885 0.010 0.020 0.040
idle23:50:02.543100.0%264289 153.506 324.654 1155.910
status file00:00:00.448 0.0%358 0.968 1.251 4.000
TOTAL: 923:50:10.040100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:56:52.082 99.9%16649 23.000 204.942183226.500
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:04.938 0.1%112107 0.000 0.044 0.667
TOTAL: 300:56:57.020100.0%----

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

Control channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
moderator@dana.de001101
TOTAL001101

Incoming feeds (innd):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1news.dne3.net 2 5679 1185 4466 28 20%23:13:35
2usenet.goja.nl.eu.org 10 6869 1112 5521 236 16%23:33:47
3usenet.blueworldhosting.com 718 7676 727 6339 610 9%23:50:14
4endofthelinebbs-out.news.weretis.net 2 10989 557 10370 62 5%45:32:49
5nntp.comgw.net 1 7020 415 6427 178 5%23:59:58
6news.corradoroberto.it 1 1732 272 1460 0 15%23:59:58
7news.hispagatos.org 5 7167 271 6812 84 3%24:26:25
8usenet.network 2 5133 253 4872 8 4%23:59:26
9i2pn.org 2 6872 223 6578 71 3%23:59:05
10194.87.241.33 41 342 167 113 62 48%15:20:03
11newsfeed.bofh.team 1 7646 153 7405 88 2%23:59:57
12endofthelinebbs.peers.news.panix.com 26 6664 146 6512 6 2%23:50:54
13newsfeed.xs3.de 1 5335 121 5212 2 2%23:59:55
14news.samoylyk.net 2 5628 117 5510 1 2%23:59:25
15endoftheline-out.news.chmurka.net 2 2990 88 2902 0 2%23:59:22
16peering.usenet.ovh 2 6873 86 6775 12 1%23:59:23
17news-out.tcpreset.net 2 5713 67 5633 13 1%23:59:51
18glockenspiel.complete.org 2 5270 65 5205 0 1%24:00:37
19news.furie.org.uk 1 3297 63 3234 0 1%23:59:57
20news.netfront.net 1 5682 20 5612 50 0%21:48:20
21outgoing.news.lysator.liu.se 1 3957 13 3942 2 0%23:59:56
22news.bbs.nz 1 6309 7 6302 0 0%24:14:36
23eotl-out.news.tnetconsulting.net 1 0 0 0 0 0%00:10:05
24localhost 30 0 0 0 0 0%00:00:00
25news.nk.ca 2 0 0 0 0 0%00:20:12
TOTAL: 25 859 124843 6128 117202 1513 4%538:17:50
Articles received by server

Incoming volume (innd):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.dne3.net3.4 MB0.0 KB27.9 KB3.4 MB 99%2.9 KB
2usenet.network3.1 MB0.0 KB15.7 KB3.1 MB 99%12.2 KB
3usenet.goja.nl.eu.org3.0 MB0.0 KB267.2 KB3.3 MB 92%2.5 KB
4endofthelinebbs-out.news.weretis.net2.4 MB0.0 KB178.6 KB2.6 MB 93%4.3 KB
5news.corradoroberto.it2.1 MB0.0 KB0.0 KB2.1 MB100%8.1 KB
6nntp.comgw.net1.6 MB0.0 KB445.0 KB2.0 MB 78%3.5 KB
7usenet.blueworldhosting.com1.6 MB0.0 KB1.2 MB2.8 MB 55%2.1 KB
8news.samoylyk.net1.0 MB0.0 KB1.2 KB1.0 MB 99%8.9 KB
9glockenspiel.complete.org962.4 KB0.0 KB0.0 KB962.4 KB100%14.8 KB
10194.87.241.33911.5 KB0.0 KB77.4 KB988.9 KB 92%4.3 KB
11i2pn.org911.2 KB0.0 KB104.9 KB1016.1 KB 89%3.5 KB
12news.hispagatos.org784.0 KB0.0 KB119.7 KB903.7 KB 86%2.5 KB
13newsfeed.bofh.team448.3 KB0.0 KB103.6 KB551.9 KB 81%2.3 KB
14endofthelinebbs.peers.news.panix.com425.8 KB0.0 KB8.0 KB433.7 KB 98%2.9 KB
15newsfeed.xs3.de402.7 KB0.0 KB5.4 KB408.0 KB 98%3.3 KB
16peering.usenet.ovh364.0 KB0.0 KB14.6 KB378.6 KB 96%3.9 KB
17news.furie.org.uk235.9 KB0.0 KB0.0 KB235.9 KB100%3.7 KB
18news-out.tcpreset.net233.6 KB0.0 KB12.8 KB246.4 KB 94%3.1 KB
19endoftheline-out.news.chmurka.net227.5 KB0.0 KB0.0 KB227.5 KB100%2.6 KB
20news.netfront.net55.0 KB0.0 KB1.4 MB1.4 MB 3%20.7 KB
21outgoing.news.lysator.liu.se32.6 KB0.0 KB2.9 KB35.5 KB 91%2.4 KB
22news.bbs.nz17.2 KB0.0 KB0.0 KB17.2 KB100%2.5 KB
23eotl-out.news.tnetconsulting.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
24localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
25news.nk.ca0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 2524.1 MB0.0 KB3.9 MB28.0 MB 85%3.8 KB
Incoming volume received by server

Incoming articles (innd):

DateArticles%ArtsArt/secSize%SizeKB/sec
May 1 00:01:02 - 00:59:59 177 2.8% 0.05738.2 KB 2.9% 0.21
May 1 01:00:00 - 01:59:59 277 4.4% 0.08928.7 KB 3.7% 0.26
May 1 02:00:00 - 02:59:59 357 5.7% 0.101020.2 KB 4.0% 0.28
May 1 03:00:00 - 03:59:59 287 4.6% 0.08839.8 KB 3.3% 0.23
May 1 04:00:00 - 04:59:59 379 6.0% 0.111.3 MB 5.5% 0.38
May 1 05:00:00 - 05:59:59 380 6.0% 0.111.6 MB 6.4% 0.45
May 1 06:00:00 - 06:59:59 308 4.9% 0.091.1 MB 4.7% 0.33
May 1 07:00:00 - 07:59:59 314 5.0% 0.091.2 MB 5.1% 0.36
May 1 08:00:00 - 08:59:59 362 5.8% 0.101.3 MB 5.3% 0.37
May 1 09:00:00 - 09:59:59 375 6.0% 0.101.3 MB 5.3% 0.37
May 1 10:00:00 - 10:59:59 346 5.5% 0.102.3 MB 9.2% 0.64
May 1 11:00:00 - 11:59:59 333 5.3% 0.091.6 MB 6.7% 0.47
May 1 12:00:00 - 12:59:59 247 3.9% 0.07812.8 KB 3.2% 0.23
May 1 13:00:00 - 13:59:59 250 4.0% 0.07872.9 KB 3.5% 0.24
May 1 14:00:00 - 14:59:59 244 3.9% 0.07693.1 KB 2.8% 0.19
May 1 15:00:00 - 15:59:59 290 4.6% 0.08969.3 KB 3.8% 0.27
May 1 16:00:00 - 16:59:59 246 3.9% 0.07966.7 KB 3.8% 0.27
May 1 17:00:00 - 17:59:59 265 4.2% 0.071.5 MB 6.2% 0.43
May 1 18:00:00 - 18:59:59 184 2.9% 0.051.1 MB 4.5% 0.32
May 1 19:00:00 - 19:59:59 160 2.5% 0.04606.0 KB 2.4% 0.17
May 1 20:00:00 - 20:59:59 125 2.0% 0.03462.4 KB 1.8% 0.13
May 1 21:00:00 - 21:59:59 125 2.0% 0.03531.8 KB 2.1% 0.15
May 1 22:00:00 - 22:59:59 137 2.2% 0.04545.5 KB 2.2% 0.15
May 1 23:00:00 - 23:59:59 120 1.9% 0.03358.0 KB 1.4% 0.10
May 2 00:00:00 - 00:01:01 5 0.1% 0.0840.4 KB 0.2% 0.66
TOTAL: 23:59:59 6293 100.0% 0.0724.6 MB 100.0% 0.29
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 GB106.8 GB 7.0% 0 0.4541616.28
CYCNGS3NGS1536.0 GB48.0 MB 0.0% 0 0.00 0.00
CYCTXT1TEXT5.0 GB4.2 GB 84.3% 0 0.02 2920.81
TOTAL: 4-4613.0 GB111.2 GB 2.4% 1 0.34-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1usenet.blueworldhosting.com 615 0 0 0 0 0 0 0 615
2usenet.goja.nl.eu.org 238 0 0 0 0 0 0 0 238
3nntp.comgw.net 191 0 0 0 0 0 0 0 191
4endofthelinebbs-out.news.weretis.net 95 0 0 0 0 0 0 0 95
5newsfeed.bofh.team 91 6 0 0 0 0 0 0 85
6i2pn.org 83 0 0 0 0 0 0 0 83
7news.hispagatos.org 72 0 0 0 0 0 0 0 72
8news.netfront.net 72 0 0 0 0 0 0 0 72
9194.87.241.33 62 0 0 0 0 0 0 0 62
10news.dne3.net 28 0 0 0 0 0 0 0 28
11news-out.tcpreset.net 15 0 0 0 0 0 0 0 15
12peering.usenet.ovh 12 0 0 0 0 0 0 0 12
13usenet.network 8 0 0 0 0 0 0 0 8
14endofthelinebbs.peers.news.panix.com 6 0 0 0 0 0 0 0 6
15newsfeed.xs3.de 2 0 0 0 0 0 0 0 2
16outgoing.news.lysator.liu.se 2 0 0 0 0 0 0 0 2
17glockenspiel.complete.org 1 0 0 0 0 0 0 0 1
18news.samoylyk.net 1 0 0 0 0 0 0 0 1
TOTAL: 18 1594 6 0 0 0 0 0 0 1588

Unwanted newsgroups [Top 20]:

NewsgroupCount
soc.culture.russia 4
alt.asshole 1
soc.culture.africa 1
TOTAL: 3 6

Perl filter (innd) [Top 20]:

ReasonCount
EMP (phn path) 789
EMP (phr path) 288
Too many newsgroups 237
EMP (md5) 151
User-issued cancel 33
Angle-bracket bot 28
Too many newsgroups (meow) 12
Binary: misplaced binary 6
Subject (LSDQu9GP0LPRg9GI0Lr) 2
TOTAL: 9 1546

NoCeM on spool:

Issuer (type)NoticesBad PGPCancelSkipTotal
robot@pasdenom.info (spam)40404
robot@pasdenom.info (spam2)63009191
i2pn2-nocem@i2pn2.org (multipost)15001919
i2pn2-nocem@i2pn2.org (rmp)10055
robot@pasdenom.info (spam4)30033
robot@pasdenom.info (spam3)10011
TOTAL: 68704119123

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
nntp.comgw.net 21
usenet.blueworldhosting.com 6
newsfeed.bofh.team 3
endofthelinebbs-out.news.weretis.net 3
news.netfront.net 2
usenet.goja.nl.eu.org 2
news-out.tcpreset.net 2
endofthelinebbs.peers.news.panix.com 2
usenet.network 1
TOTAL: 9 42
TOTAL: 1 42

Outgoing feeds (innfeed) by articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nyheter.lysator.liu.se 6664 2547 3448 280 0 0 38%23:59:52
2news.netfront.net 10251 1643 4628 0 0 15 16%23:59:47
3news.furie.org.uk 3890 886 2052 22 0 0 22%23:59:44
4photonic.trudheim.com 9896 602 4242 1439 0 544 6%23:59:52
5endofthelinebbs.peers.news.panix.com 6612 450 5831 2 0 0 6%23:59:52
6news.dne3.net 5241 411 4468 155 0 0 7%23:59:47
7peering.usenet.ovh 6978 373 5844 60 0 0 5%23:59:52
8usenet.goja.nl.eu.org 6279 341 4684 39 0 0 5%23:59:52
9news.nntp4.net 6913 330 5738 11 0 18 4%23:59:52
10newsfeed.bofh.team 7157 107 6008 0 0 0 1%23:59:52
11news.tcpreset.net 7709 106 5268 822 0 1 1%23:59:52
12news.hispagatos.org 7036 79 5883 71 0 0 1%23:59:52
13nntp.comgw.net 6375 79 5762 36 0 0 1%23:59:52
14i2pn.org 6795 77 5919 50 0 38 1%23:57:30
15news.nk.ca 8556 62 5602 454 0 8 0%23:59:52
16usenet.network 7796 58 5738 21 0 0 0%23:58:51
17news.chmurka.net 4100 27 2850 0 0 0 0%23:59:52
18news.quux.org 6380 24 5624 328 0 0 0%23:59:52
19news.weretis.net 6583 19 6105 163 0 0 0%23:59:30
20news.tnetconsulting.net 8993 17 6056 209 0 27 0%23:59:52
21news.samoylyk.net 7880 15 6015 62 0 0 0%23:59:21
22newsfeed.xs3.de 7873 15 5974 167 0 0 0%23:59:52
23news.bbs.nz 4207 14 2051 227 0 4003 0%23:59:52
24usenet.blueworldhosting.com 5877 12 5334 0 0 0 0%23:59:52
25ddt.demos.su 42 8 34 0 0 0 19%05:33:22
26news.corradoroberto.it 772 1 578 0 0 1 0%22:43:40
TOTAL: 26 166855 8303 121736 4618 0 4655 4%604:09:16
Outgoing feeds (innfeed) by articles

Outgoing feeds (innfeed) by volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nyheter.lysator.liu.se9.0 MB2.5 MB11.5 MB0.1 KB/s4.2 KB23:59:52
2news.netfront.net8.5 MB0.0 KB8.5 MB0.1 KB/s5.3 KB23:59:47
3news.furie.org.uk4.6 MB51.4 KB4.6 MB0.1 KB/s5.2 KB23:59:44
4peering.usenet.ovh2.9 MB223.2 KB3.1 MB0.0 KB/s7.4 KB23:59:52
5endofthelinebbs.peers.news.panix.com2.8 MB3.5 KB2.8 MB0.0 KB/s6.4 KB23:59:52
6photonic.trudheim.com2.8 MB4.2 MB7.0 MB0.1 KB/s3.5 KB23:59:52
7news.quux.org1.1 MB1.2 MB2.3 MB0.0 KB/s6.7 KB23:59:52
8news.samoylyk.net1.1 MB119.4 KB1.2 MB0.0 KB/s15.7 KB23:59:21
9news.dne3.net806.7 KB2.2 MB2.9 MB0.0 KB/s5.3 KB23:59:47
10ddt.demos.su693.6 KB0.0 KB693.6 KB0.0 KB/s86.7 KB05:33:22
11news.tcpreset.net631.0 KB3.2 MB3.8 MB0.0 KB/s4.2 KB23:59:52
12news.nntp4.net614.2 KB48.3 KB662.5 KB0.0 KB/s1.9 KB23:59:52
13usenet.goja.nl.eu.org524.9 KB294.7 KB819.6 KB0.0 KB/s2.2 KB23:59:52
14newsfeed.bofh.team427.3 KB0.0 KB427.3 KB0.0 KB/s4.0 KB23:59:52
15news.hispagatos.org179.9 KB398.3 KB578.2 KB0.0 KB/s3.9 KB23:59:52
16usenet.network163.5 KB87.0 KB250.5 KB0.0 KB/s3.2 KB23:58:51
17news.chmurka.net144.4 KB0.0 KB144.4 KB0.0 KB/s5.3 KB23:59:52
18i2pn.org138.9 KB243.4 KB382.3 KB0.0 KB/s3.0 KB23:57:30
19nntp.comgw.net134.6 KB1.2 MB1.3 MB0.0 KB/s11.9 KB23:59:52
20news.nk.ca121.2 KB2.5 MB2.6 MB0.0 KB/s5.2 KB23:59:52
21news.weretis.net95.6 KB2.3 MB2.4 MB0.0 KB/s13.6 KB23:59:30
22news.tnetconsulting.net52.8 KB1.6 MB1.6 MB0.0 KB/s7.3 KB23:59:52
23newsfeed.xs3.de45.8 KB1.0 MB1.1 MB0.0 KB/s6.0 KB23:59:52
24usenet.blueworldhosting.com42.1 KB0.0 KB42.1 KB0.0 KB/s3.5 KB23:59:52
25news.bbs.nz37.2 KB1.1 MB1.1 MB0.0 KB/s4.7 KB23:59:52
26news.corradoroberto.it0.7 KB0.0 KB0.7 KB0.0 KB/s0.7 KB22:43:40
TOTAL: 2637.6 MB24.3 MB61.9 MB0.0 KB/s4.9 KB604:09:16
Outgoing feeds (innfeed) by volume

NNRP readership statistics [Top 100]:

SystemConnArtsSizeGroupsPostRejElapsed
12a0e:73c2:8000:802c::22778 00.0 KB 0 0 000:21:05
2news.nntp4.net2775 00.0 KB 0 0 000:23:14
3147.185.132.195 1 00.0 KB 0 0 000:00:03
4198.235.24.39 1 00.0 KB 0 0 000:00:00
520.163.61.136 1 00.0 KB 0 0 000:00:09
6205.210.31.243 1 00.0 KB 0 0 000:00:03
7208.149.216.162.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
845.227.254.152 1 00.0 KB 0 0 000:00:00
971.6.134.232 1 00.0 KB 0 0 000:00:00
10localhost 1 00.0 KB 0 0 000:12:17
TOTAL: 105561 00.0 KB 0 0 000:56:54

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

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved2784 00.0 KB 0 0 000:21:22
2*.nntp4.net2775 00.0 KB 0 0 000:23:14
3*.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
4*localhost 1 00.0 KB 0 0 000:12:17
TOTAL: 45561 00.0 KB 0 0 000:56:54

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.497 29.159 0.00000:23:14
2a0e:73c2:8000:802c::2 9.935 29.873 0.00000:21:05
localhost 180.101 372.418 0.07500:12:17
20.163.61.136 0.005 0.010 0.00000:00:09
205.210.31.243 0.000 0.013 0.00000:00:03
147.185.132.195 0.007 0.007 0.00000:00:03
198.235.24.39 0.005 0.008 0.00000:00:00
45.227.254.152 0.000 0.013 0.00000:00:00
71.6.134.232 0.009 0.004 0.00000:00:00
208.149.216.162.bc.googleusercontent.com 0.004 0.009 0.00000:00:00
TOTAL: 10 200.563 431.514 0.07500:56:54

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

SystemConn
208.149.216.162.bc.googleusercontent.com 4
45.227.254.152 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
45.227.254.152 1 1
TOTAL: 1 1 4