usenet.goja.nl.eu.org Daily Usenet report

Dec 16 01:00:03 -- Dec 17 00:04:59

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

Dec 16 22:07:11 goja innd[58649]: filter: No Cancel-Key[sha1:RU1KaTlZTnlWNU5zekVpN0lvaVM1REMyUC9jPQ==^M \x09sha1:UTz/OO2gpNJplRZAOn5wbTAM2k8=] matches Cancel-Lock[sha1:tt4f21hRtkyMjsCbx+OzJ8ClfQs=] target=<10hshl0$320u1$1@dont-email.me>
Dec 17 00:03:00 goja news2mail[47785]: end
Dec 17 00:03:00 goja news2mail[59289]: begin

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 15444 47.2%1.7 MB 44.1%
innd 12998 39.7%1.6 MB 42.5%
innfeed 4201 12.8%518.5 KB 13.2%
nocem 56 0.2%6.7 KB 0.2%
inn 6 0.0%1.4 KB 0.0%
news2mail 2 0.0%0.1 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 7 32708 100.0%3.8 MB100.0%

History cache:

ReasonCount%Count
Positive hits 107019 64.5%
Negative hits 42594 25.7%
Do not exist 16158 9.7%
Cache misses 57 0.0%
TOTAL: 4 165828 100.0%

innd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.001 0.0%3 0.000 0.333 1.000
article cancel00:00:00.000 0.0%19 0.000 0.000 0.000
article cleanup00:00:00.205 0.0%16117 0.000 0.013 0.060
article logging00:00:00.263 0.0%16145 0.000 0.016 0.050
article parse00:00:00.521 0.0%35907 0.000 0.015 0.046
article write00:00:02.968 0.0%14479 0.078 0.205 0.835
artlog/artcncl/perl00:00:00.000 0.0%3 0.000 0.000 0.000
artlog/artparse00:00:00.000 0.0%4 0.000 0.000 0.000
data move00:00:00.148 0.0%150400 0.000 0.001 0.004
hisgrep/artcncl/perl00:00:00.000 0.0%3 0.000 0.000 0.000
hisgrep/perl00:00:00.002 0.0%169 0.000 0.012 1.000
hishave/artcncl/perl00:00:00.000 0.0%3 0.000 0.000 0.000
hishave/artparse00: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:00:01.017 0.0%165821 0.001 0.006 0.014
history sync00:00:00.199 0.0%388 0.000 0.513 6.333
history write00:00:01.495 0.0%16117 0.022 0.093 0.455
hiswrite/artparse00:00:00.000 0.0%4 0.000 0.000 0.000
idle22:33:57.039 98.0%159250 145.690 510.123 1077.573
nntp read00:00:04.557 0.0%158549 0.007 0.029 0.075
overview write00:00:02.191 0.0%14479 0.039 0.151 1.077
perl filter00:00:32.294 0.0%16117 1.289 2.004 2.877
python filter00:00:00.785 0.0%16117 0.008 0.049 0.110
site send00:00:01.988 0.0%29006 0.021 0.069 0.211
TOTAL: 2422:34:45.673 98.1%----

innfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.063 0.0%18716 0.000 0.003 0.055
article prepare00:00:00.047 0.0%196184 0.000 0.000 0.002
article read00:00:01.038 0.0%13473 0.000 0.077 0.190
backlog stats00:00:00.593 0.0%377951 0.000 0.002 0.029
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:22.801 0.0%234148 0.008 0.097 0.333
data write00:00:05.848 0.0%228422 0.010 0.026 0.163
idle23:00:51.550 99.8%377951 79.786 219.212 420.228
status file00:00:00.536 0.0%737 0.000 0.727 10.000
TOTAL: 923:01:22.476 99.9%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle23:20:53.831 97.8%15317 66.500 5487.617 10885.457
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:30:55.825 2.2%25416838 0.000 0.073 0.600
readart00:00:00.013 0.0%62 0.000 0.210 0.400
TOTAL: 423:51:49.669100.0%----

Control commands to innd:

CommandNumber
flush 6
flushlogs 2
go 2
logmode 2
lowmark 1
mode 144
name 2
pause 2
paused 2
reload 693
reserve 2
TOTAL: 11 858

Incoming feeds (innd):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1goja-out.feeder.erje.net 1117 29276 7824 20819 633 26%96:08:51
2goja-out.news.weretis.net 5 18707 3863 14417 427 20%48:32:37
3news.nntp4.net 2 6294 534 5540 220 8%20:42:11
4news.quux.org 2 7004 446 6557 1 6%22:09:31
5news.samoylyk.net 2 8823 430 8390 3 4%24:09:53
6pasdenom.info 1 5299 411 4888 0 7%27:10:53
7newsfeed.endofthelinebbs.com 2 4815 300 4491 24 6%22:24:52
8newsfeed.bofh.team 2 8958 219 8593 146 2%22:02:57
9news.1d4.us 1 4616 155 4338 123 3%19:38:19
10news.bbs.nz 2 8128 113 8015 0 1%23:59:13
11nntp.terraraq.uk 1 2834 67 2766 1 2%23:59:56
12news.chmurka.net 1 1258 44 1214 0 3%05:50:06
13goja-out.news.tnetconsulting.net 2 3546 14 3532 0 0%23:59:50
14news.furie.org.uk 2 4654 10 4643 1 0%23:57:02
15newsfeed.dotsrc.org 245 1645 4 1641 0 0%23:08:42
16localhost 1 0 0 0 0 0%00:00:00
TOTAL: 16 1388 115857 14434 99844 1579 12%427:54:53
Articles received by server

Incoming volume (innd):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1goja-out.feeder.erje.net28.3 MB0.0 KB1.5 MB29.8 MB 94%3.6 KB
2goja-out.news.weretis.net7.8 MB0.0 KB776.6 KB8.5 MB 91%2.0 KB
3news.samoylyk.net5.4 MB0.0 KB5.9 KB5.4 MB 99%12.9 KB
4news.nntp4.net1.6 MB0.0 KB1.4 MB3.0 MB 53%4.1 KB
5news.quux.org1.1 MB0.0 KB1.2 KB1.1 MB 99%2.6 KB
6newsfeed.endofthelinebbs.com634.3 KB0.0 KB412.5 KB1.0 MB 60%3.2 KB
7pasdenom.info633.5 KB0.0 KB0.0 KB633.5 KB100%1.5 KB
8newsfeed.bofh.team550.7 KB0.0 KB4.5 MB5.0 MB 10%14.1 KB
9nntp.terraraq.uk272.3 KB0.0 KB81.0 KB353.2 KB 77%5.2 KB
10news.1d4.us240.1 KB0.0 KB320.1 KB560.3 KB 42%2.0 KB
11news.bbs.nz194.3 KB0.0 KB0.0 KB194.3 KB100%1.7 KB
12news.chmurka.net124.4 KB0.0 KB0.0 KB124.4 KB100%2.8 KB
13goja-out.news.tnetconsulting.net86.9 KB0.0 KB0.0 KB86.9 KB100%6.2 KB
14news.furie.org.uk50.6 KB15.3 KB0.0 KB65.9 KB 76%6.0 KB
15newsfeed.dotsrc.org40.1 KB0.0 KB0.0 KB40.1 KB100%10.0 KB
16localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1646.9 MB15.3 KB9.0 MB55.9 MB 83%3.6 KB
Incoming volume received by server

Incoming articles (innd):

DateArticles%ArtsArt/secSize%SizeKB/sec
Dec 17 00:00:03 - 00:04:59 6 100.0% 0.0216.0 KB 100.0% 0.05
TOTAL: 00:04:56 6 100.0% 0.0216.0 KB 100.0% 0.05
Incoming articles
Incoming articles (size)

Perl filter (innd) [Top 20]:

ReasonCount
EMP (phn path) 536
EMP (md5) 327
Too many newsgroups 50
Binary: misplaced binary 44
Angle-bracket bot 20
Too many newsgroups (meow) 18
Cancel of non-existing ID <10004n1$1vq4b$1@dont-email.me> 1
Cancel of non-existing ID <10005k4$1vq3m$1@dont-email.me> 1
Cancel of non-existing ID <1001v8m$2fq89$1@dont-email.me> 1
Cancel of non-existing ID <1002dvh$2j055$1@dont-email.me> 1
Cancel of non-existing ID <1007u59$3skoj$1@dont-email.me> 1
Cancel of non-existing ID <1007v3g$3skoj$2@dont-email.me> 1
Cancel of non-existing ID <100a1ik$d7pf$1@dont-email.me> 1
Cancel of non-existing ID <100a5km$e20b$1@dont-email.me> 1
Cancel of non-existing ID <100aa7p$f1kg$1@dont-email.me> 1
Cancel of non-existing ID <100gbi3$1rcuv$1@dont-email.me> 1
Cancel of non-existing ID <100hqem$27fs0$1@dont-email.me> 1
Cancel of non-existing ID <100hrdq$27fs0$2@dont-email.me> 1
Cancel of non-existing ID <100qiat$80c9$1@dont-email.me> 1
Cancel of non-existing ID <100qiv1$80c9$2@dont-email.me> 1
TOTAL: 157 1146

NoCeM on spool:

Issuer (type)NoticesBad PGPCancelSkipTotal
nocem@eternal-september.org (misplaced_binary)600101101
robot@pasdenom.info (spam2)26002626
robot@pasdenom.info (spam3)6001818
robot@pasdenom.info (spam4)40099
TOTAL: 44200154154

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad command received
newsfeed.dotsrc.org 28
TOTAL: 1 28
Huge articles
newsfeed.bofh.team 4
TOTAL: 1 4
TOTAL: 2 32

Outgoing feeds (innfeed) by articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1peer.alt119.net 15709 10900 2791 872 0 180 69%23:08:21
2news.chmurka.net 13933 5808 4916 23 0 49 41%23:07:34
3news.bbs.nz 20816 5623 8614 183 0 796 27%22:54:15
4newsfeed.dotsrc.org 9763 4563 1813 2859 0 128 46%23:07:23
5news.1d4.us 10280 4542 4514 4 0 237 44%23:08:01
6pasdenom.info 9805 2637 4436 433 0 164 26%23:08:18
7news.furie.org.uk 2523 1053 967 3 0 144 41%23:01:42
8news.nntp4.net 16086 768 7885 5306 0 182 4%23:08:38
9feeder.erje.net 8003 441 6016 117 0 100 5%23:06:41
10nntp.terraraq.uk 6223 386 3400 1259 0 92 6%23:03:10
11news.quux.org 14102 309 8324 101 0 386 2%23:07:34
12news.samoylyk.net 13199 229 8320 50 0 123 1%23:07:17
13weretis.net 5446 166 4685 65 0 132 3%23:06:18
14newsfeed.bofh.team 12845 127 8603 0 0 324 0%23:06:30
15tnetconsulting.net 14775 90 8919 236 0 434 0%23:08:19
16newsfeed.endofthelinebbs.com 15348 85 8828 33 0 762 0%23:07:25
17i2pn.org 0 0 0 0 0 9238 0%23:10:00
TOTAL: 17 188856 37727 93031 11544 0 13471 19%392:47:26
Outgoing feeds (innfeed) by articles

Outgoing feeds (innfeed) by volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1peer.alt119.net32.5 MB3.2 MB35.8 MB0.4 KB/s3.1 KB23:08:21
2news.chmurka.net19.9 MB1.9 MB21.8 MB0.3 KB/s3.8 KB23:07:34
3news.bbs.nz14.3 MB362.3 KB14.7 MB0.2 KB/s2.6 KB22:54:15
4news.1d4.us12.1 MB31.1 KB12.1 MB0.1 KB/s2.7 KB23:08:01
5newsfeed.dotsrc.org11.6 MB6.7 MB18.3 MB0.2 KB/s2.5 KB23:07:23
6pasdenom.info8.0 MB1.3 MB9.3 MB0.1 KB/s3.1 KB23:08:18
7news.furie.org.uk4.7 MB4.5 KB4.7 MB0.1 KB/s4.5 KB23:01:42
8feeder.erje.net2.0 MB562.3 KB2.6 MB0.0 KB/s4.8 KB23:06:41
9news.nntp4.net1.9 MB21.2 MB23.1 MB0.3 KB/s3.9 KB23:08:38
10news.quux.org1.5 MB173.3 KB1.7 MB0.0 KB/s4.2 KB23:07:34
11nntp.terraraq.uk1017.8 KB1.2 MB2.2 MB0.0 KB/s1.3 KB23:03:10
12tnetconsulting.net663.2 KB945.4 KB1.6 MB0.0 KB/s4.9 KB23:08:19
13newsfeed.endofthelinebbs.com583.8 KB56.3 KB640.1 KB0.0 KB/s5.4 KB23:07:25
14weretis.net530.1 KB112.2 KB642.3 KB0.0 KB/s2.8 KB23:06:18
15newsfeed.bofh.team502.5 KB0.0 KB502.5 KB0.0 KB/s4.0 KB23:06:30
16news.samoylyk.net435.0 KB88.9 KB523.9 KB0.0 KB/s1.9 KB23:07:17
17i2pn.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:10:00
TOTAL: 17112.2 MB37.8 MB150.0 MB0.1 KB/s3.1 KB392:47:26
Outgoing feeds (innfeed) by volume

NNRP readership statistics [Top 100]:

SystemConnArtsSizeGroupsPostRejElapsed
12603:6010:6800:36:1a03:73ff:fe28:be0f 542 62150.9 KB 7 0 000:28:53
TOTAL: 1 542 62150.9 KB 7 0 000:28:53

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

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 846 62150.9 KB 7 0 000:51:20
2*.stehlik.co.uk 469 00.0 KB 0 0 022:59:58
3*.academyforinternetresearch.org 19 00.0 KB 0 0 000:00:10
4*.stretchoid.com 2 00.0 KB 0 0 000:00:10
TOTAL: 41336 62150.9 KB 7 0 023:51:40

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
toma-03.stehlik.co.uk 56.322 26.466 105.38722:59:58
2603:6010:6800:36:1a03:73ff:fe28:be0f 42.392 8.169 24.05700:28:53
2a03:cfc0:8000:b::c303:dce8 32.840 16.694 0.00000:21:32
66.61.98.95 1.317 0.233 0.00000:00:24
199.45.155.106 0.271 0.068 0.00000:00:14
165.154.11.170 0.255 0.037 0.00000:00:11
prod52client01.academyforinternetresearch.org 1.391 0.307 0.00000:00:10
azpdwssr8f6n.stretchoid.com 0.150 0.040 0.00000:00:10
147.185.132.129 0.062 0.008 0.00000:00:03
195.3.220.232 0.079 0.022 0.00000:00:00
198.235.24.77 0.083 0.000 0.00000:00:00
TOTAL: 11 135.162 52.044 129.44423:51:40

Curious NNRP explorers [Top 20]:

SystemConn
toma-03.stehlik.co.uk 469
2a03:cfc0:8000:b::c303:dce8 276
prod52client01.academyforinternetresearch.org 19
66.61.98.95 18
199.45.155.106 4
165.154.11.170 3
azpdwssr8f6n.stretchoid.com 2
147.185.132.129 1
195.3.220.232 1
198.235.24.77 1
TOTAL: 10 794

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

SystemConn
prod52client01.academyforinternetresearch.org 7
165.154.11.170 2
azpdwssr8f6n.stretchoid.com 1
TOTAL: 3 10

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

CommandCount
?^T 3
^V^C^A 2
^V^C^A^B 2
MGLNDD_116.202.108.142_119 1
^H^K^H^D^H^E^H^F^D^A^E^A^F^A^C^C^C^A^C^B^D^B^E^B^F^B 1
^V^C^A^A^W^A 1
TOTAL: 6 10

NNRP client timeouts [Top 20]:

SystemConnPeer
prod52client01.academyforinternetresearch.org 2 2
199.45.155.106 1 4
TOTAL: 2 3 8

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

HierarchyCountPct
1de 32 51.6%
2muc 10 16.1%
3alt 6 9.7%
4comp 4 6.5%
5linux 4 6.5%
6rec 4 6.5%
7uk 2 3.2%
TOTAL: 7 62100.0%

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

NewsgroupCount
1de.talk.jokes 32
2muc.lists.netbsd.port.m68k 10
3alt.comp.microsoft.windows 6
4comp.lang.misc 4
5linux.debian.devel.mentors 4
6rec.aviation.military 4
7uk.rec.waterways 2
TOTAL: 7 62