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

Aug 13 01:00:02 -- Aug 14 00:04:52

Unknown entries from news log file:

First 4 / 4 lines (100.0%)

Aug 13 11:01:12 goja innd[59605]: filter: No Cancel-Key[sha1:K143cmiyST4dKWLtMxcaVGx18YM= sha256:I6ym3W0+o9a99L9tS9pmgohCEOvfgljcI8dyGHHbtuc=] matches Cancel-Lock[sha1:gSY3oDZQbZn//cAPD+HJ2rgQKUU= sha256:SyC3eZL104yzZY0pfozzGM1h8GEo8w8qL0jKrMeaqAU=] target=<115k13n$1g8cb$2@dont-email.me>
Aug 13 16:03:44 goja innd[59605]: filter: No Cancel-Key[sha1:kf1eaKpqfKwfVkA8xBKWfLbcWTw= sha256:iuevyIw2AJv+P+SvT7fhSZaPor1p5F/UeW8lYt8B6mI=] matches Cancel-Lock[sha1:ClkxtcRnP9QUTJkxdA6qOvBWRQs= sha256:RJq1PraqCgbHUHG4aygEHKv5K9yL9nU3mv+27ynEt/g=] target=<115kipt$1mo4o$1@dont-email.me>
Aug 14 00:03:00 goja news2mail[99890]: begin
Aug 14 00:03:00 goja news2mail[48960]: end

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 11952 46.3%1.3 MB 42.9%
innd 9900 38.3%1.2 MB 41.7%
innfeed 3925 15.2%463.7 KB 15.2%
nocem 26 0.1%2.8 KB 0.1%
inn 11 0.0%2.4 KB 0.1%
news2mail 2 0.0%0.3 KB 0.0%
controlchan 1 0.0%0.0 KB 0.0%
TOTAL: 7 25817 100.0%3.0 MB100.0%

History cache:

ReasonCount%Count
Positive hits 87171 65.5%
Negative hits 28599 21.5%
Do not exist 17231 13.0%
Cache misses 21 0.0%
TOTAL: 4 133022 100.0%

innd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.015 0.0%15 0.000 1.000 1.167
article cancel00:00:00.001 0.0%34 0.000 0.029 1.000
article cleanup00:00:00.274 0.0%17225 0.000 0.016 0.057
article logging00:00:00.339 0.0%17255 0.000 0.020 0.056
article parse00:00:00.768 0.0%37488 0.000 0.020 0.049
article write00:00:03.090 0.0%16037 0.072 0.193 0.504
artlog/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
artlog/artcncl/perl00:00:00.000 0.0%15 0.000 0.000 0.000
artlog/artparse00:00:00.000 0.0%4 0.000 0.000 0.000
data move00:00:00.251 0.0%142411 0.000 0.002 0.008
hisgrep/artcncl00:00:00.000 0.0%35 0.000 0.000 0.000
hisgrep/artcncl/perl00:00:00.000 0.0%15 0.000 0.000 0.000
hisgrep/perl00:00:00.002 0.0%48 0.000 0.042 0.167
hishave/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.001 0.0%15 0.000 0.067 0.083
hishave/artparse00:00:00.000 0.0%3 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:01.187 0.0%133003 0.002 0.009 0.022
history sync00:00:00.148 0.0%348 0.000 0.425 11.667
history write00:00:01.774 0.0%17226 0.047 0.103 0.255
hiswrite/artparse00:00:00.001 0.0%3 0.000 0.333 1.000
idle22:57:53.266 99.1%146440 292.550 564.554 1256.135
nntp read00:00:02.122 0.0%148197 0.006 0.014 0.037
overview write00:00:03.135 0.0%16037 0.070 0.195 0.664
perl filter00:00:58.215 0.1%17225 2.584 3.380 4.323
python filter00:00:01.034 0.0%17225 0.000 0.060 0.126
site send00:00:01.102 0.0%32095 0.005 0.034 0.113
TOTAL: 2722:59:06.725 99.1%----

innfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.084 0.0%16623 0.000 0.005 0.029
article prepare00:00:00.042 0.0%168960 0.000 0.000 0.003
article read00:00:01.502 0.0%15889 0.029 0.095 0.455
backlog stats00:00:00.461 0.0%294218 0.000 0.002 0.005
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:03.904 0.0%178157 0.011 0.022 0.064
data write00:00:03.997 0.0%164343 0.014 0.024 0.040
idle23:04:11.611 99.9%294218 128.508 282.279 581.690
status file00:00:00.635 0.0%683 0.000 0.930 2.000
TOTAL: 923:04:22.236100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle22:55:19.450 98.4%13074 46.500 6311.722 10440.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:22:32.147 1.6%25230495 0.000 0.054 0.333
readart00:00:00.168 0.0%206 0.000 0.816 0.877
TOTAL: 423:17:51.765100.0%----

Control commands to innd:

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

Incoming feeds (innd):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1goja-out.feeder.erje.net 577 29305 12575 16180 550 42%145:39:55
2goja-out.news.weretis.net 3 9181 1604 7448 129 17%41:48:07
3newsfeed.bofh.team 11 11881 703 11154 24 5%48:23:08
4news.samoylyk.net 2 16957 343 16613 1 2%24:45:50
5newsfeed.endofthelinebbs.com 2 4850 165 4683 2 3%23:59:18
6news.nntp4.net 1 11815 163 11396 256 1%39:48:55
7news.1d4.us 1 5136 143 4710 283 2%35:32:53
8pasdenom.info 2 3365 143 3217 5 4%23:52:51
9news.chmurka.net 2 2853 103 2750 0 3%24:00:12
10news.furie.org.uk 2 2614 63 2538 13 2%23:59:15
11nntp.terraraq.uk 3 2796 51 2745 0 1%23:55:13
12news.quux.org 2 4612 39 4572 1 0%24:00:46
13newsfeed.dotsrc.org 205 540 8 532 0 1%22:51:54
14news.bbs.nz 2 5310 6 5304 0 0%23:59:42
15goja-out.news.tnetconsulting.net 2 3115 1 3113 1 0%23:59:20
16localhost 1 0 0 0 0 0%00:00:00
TOTAL: 16 818 114330 16110 96955 1265 14%550:37:19
Articles received by server

Incoming volume (innd):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1goja-out.feeder.erje.net38.0 MB0.0 KB2.8 MB40.7 MB 93%3.2 KB
2goja-out.news.weretis.net4.9 MB0.0 KB356.8 KB5.2 MB 93%3.1 KB
3newsfeed.bofh.team2.7 MB0.0 KB989.6 KB3.7 MB 73%5.2 KB
4news.samoylyk.net1.7 MB0.0 KB1.6 KB1.7 MB 99%5.0 KB
5news.nntp4.net519.4 KB0.0 KB2.5 MB3.0 MB 17%7.3 KB
6pasdenom.info431.8 KB0.0 KB6.1 KB437.8 KB 98%3.0 KB
7newsfeed.endofthelinebbs.com387.4 KB0.0 KB8.3 KB395.7 KB 97%2.4 KB
8newsfeed.dotsrc.org316.4 KB0.0 KB0.0 KB316.4 KB100%39.6 KB
9news.1d4.us307.2 KB0.0 KB943.3 KB1.2 MB 24%2.9 KB
10news.furie.org.uk241.7 KB0.0 KB9.3 KB251.0 KB 96%3.3 KB
11news.chmurka.net228.2 KB0.0 KB0.0 KB228.2 KB100%2.2 KB
12nntp.terraraq.uk198.1 KB0.0 KB0.0 KB198.1 KB100%3.9 KB
13news.quux.org96.6 KB0.0 KB2.1 KB98.6 KB 97%2.5 KB
14news.bbs.nz9.5 KB0.0 KB0.0 KB9.5 KB100%1.6 KB
15goja-out.news.tnetconsulting.net4.4 KB0.0 KB2.3 KB6.7 KB 65%3.4 KB
16localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1649.9 MB0.0 KB7.5 MB57.4 MB 86%3.4 KB
Incoming volume received by server

Incoming articles (innd):

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 14 00:00:02 - 00:04:52 11 100.0% 0.0419.4 KB 100.0% 0.07
TOTAL: 00:04:50 11 100.0% 0.0419.4 KB 100.0% 0.07
Incoming articles
Incoming articles (size)

Perl filter (innd) [Top 20]:

ReasonCount
EMP (phn path) 205
EMP (md5) 109
Too many newsgroups 83
Too many newsgroups (meow) 9
HTML Multipart 3
Cancel of non-existing ID <115j7io$4cm$1@reader1.panix.com> 1
Cancel of non-existing ID <115ji3d$71e$1@news.kraft-s.ru> 1
Cancel of non-existing ID <115jkla$9jh$1@news.kraft-s.ru> 1
Cancel of non-existing ID <115jl01$9op$1@news.kraft-s.ru> 1
Cancel of non-existing ID <115jn44$bt3$1@news.kraft-s.ru> 1
Cancel of non-existing ID <115jpt5$ej1$1@news.kraft-s.ru> 1
Cancel of non-existing ID <115jrfg$g1e$1@news.kraft-s.ru> 1
Cancel of non-existing ID <115jsrd$h8n$1@news.kraft-s.ru> 1
Cancel of non-existing ID <115jvf5$bsn$8@news.kraft-s.ru> 1
Cancel of non-existing ID <115kipt$1mo4o$1@dont-email.me> 1
Cancel of non-existing ID <115kkbt$8pu$1@news.kraft-s.ru> 1
Cancel of non-existing ID <6a7debd3bbfab@samaranews.ru> 1
Cancel of non-existing ID <6a7debd79fb82@samaranews.ru> 1
No Cancel-Key matches Cancel-Lock. target=<115k13n$1g8cb$2@dont-email.me> 1
TOTAL: 19 423

NoCeM on spool:

Issuer (type)NoticesBad PGPCancelSkipTotal
robot@pasdenom.info (spam2)15001919
robot@pasdenom.info (spam3)30044
robot@pasdenom.info (spam4)30044
nocem@eternal-september.org (misplaced_binary)10011
TOTAL: 422002828

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad command received
newsfeed.dotsrc.org 34
TOTAL: 1 34
Huge articles
newsfeed.bofh.team 2
news.1d4.us 1
TOTAL: 2 3
TOTAL: 2 37

Outgoing feeds (innfeed) by articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.bbs.nz 20904 10283 5614 58 0 71 49%23:08:40
2news.chmurka.net 14220 10061 2850 28 0 90 70%23:08:50
3news.1d4.us 6342 3731 1925 2 0 0 58%23:06:26
4newsfeed.dotsrc.org 6207 2694 673 2369 0 112 43%23:07:42
5news.furie.org.uk 1896 961 687 0 0 0 50%22:52:22
6nntp.terraraq.uk 2820 411 1451 316 0 2 14%23:05:49
7newsfeed.bofh.team 5431 305 4872 0 0 0 5%23:04:12
8pasdenom.info 7449 214 3962 99 0 20 2%23:07:02
9feeder.erje.net 4037 164 3013 36 0 0 4%23:05:24
10news.nntp4.net 18379 105 5581 10240 0 75 0%23:09:37
11newsfeed.endofthelinebbs.com 10535 69 5492 33 0 231 0%23:07:10
12news.quux.org 9894 68 5594 32 0 50 0%23:06:02
13news.samoylyk.net 9328 45 5351 7 0 13 0%23:08:29
14weretis.net 4121 28 3908 4 0 0 0%23:03:41
15tnetconsulting.net 2588 2 1465 8 0 4268 0%23:07:11
16gijs.erje.net 0 0 0 0 0 5716 0%23:09:55
TOTAL: 16 124151 29141 52438 13232 0 10648 23%369:38:32
Outgoing feeds (innfeed) by articles

Outgoing feeds (innfeed) by volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.chmurka.net31.1 MB390.6 KB31.4 MB0.4 KB/s3.2 KB23:08:50
2news.bbs.nz28.2 MB185.0 KB28.3 MB0.3 KB/s2.8 KB23:08:40
3news.1d4.us10.1 MB8.7 KB10.1 MB0.1 KB/s2.8 KB23:06:26
4newsfeed.dotsrc.org7.0 MB5.9 MB12.9 MB0.2 KB/s2.6 KB23:07:42
5news.furie.org.uk3.2 MB0.0 KB3.2 MB0.0 KB/s3.5 KB22:52:22
6nntp.terraraq.uk1.3 MB423.8 KB1.7 MB0.0 KB/s2.4 KB23:05:49
7pasdenom.info962.5 KB129.9 KB1.1 MB0.0 KB/s3.5 KB23:07:02
8newsfeed.bofh.team784.8 KB0.0 KB784.8 KB0.0 KB/s2.6 KB23:04:12
9feeder.erje.net580.0 KB144.9 KB724.9 KB0.0 KB/s3.6 KB23:05:24
10news.quux.org326.3 KB71.7 KB398.0 KB0.0 KB/s4.0 KB23:06:02
11news.nntp4.net315.2 KB32.3 MB32.6 MB0.4 KB/s3.2 KB23:09:37
12news.samoylyk.net204.2 KB17.9 KB222.1 KB0.0 KB/s4.3 KB23:08:29
13weretis.net128.0 KB9.4 KB137.4 KB0.0 KB/s4.3 KB23:03:41
14newsfeed.endofthelinebbs.com118.1 KB87.8 KB205.9 KB0.0 KB/s2.0 KB23:07:10
15tnetconsulting.net103.0 KB35.4 KB138.4 KB0.0 KB/s13.8 KB23:07:11
16gijs.erje.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:09:55
TOTAL: 1684.3 MB39.7 MB123.9 MB0.1 KB/s3.0 KB369:38:32
Outgoing feeds (innfeed) by volume

NNRP readership statistics [Top 100]:

SystemConnArtsSizeGroupsPostRejElapsed
166.61.98.95 4 1141.2 MB 3 0 000:02:58
22603:6010:6802:4ca5:1a03:73ff:fe28:be0f 4 92250.9 KB 4 0 000:01:25
TOTAL: 2 8 2061.4 MB 7 0 000:04:24

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

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 288 2061.4 MB 7 0 000:25:20
2*.stehlik.co.uk 445 00.0 KB 0 0 022:51:39
3*.66.censys-scanner.com 9 00.0 KB 0 0 000:00:29
4*.erje.net 3 00.0 KB 0 0 000:00:01
5*.monitoring.internet-measurement.com 2 00.0 KB 0 0 000:00:03
6*.stretchoid.com 2 00.0 KB 0 0 000:00:10
7*.scanner.modat.io 1 00.0 KB 0 0 000:00:00
TOTAL: 7 750 2061.4 MB 7 0 023:17:45

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
toma-03.stehlik.co.uk 53.587 30.833 75.48822:51:39
2a03:cfc0:8000:b::c303:dce8 29.074 17.476 0.00000:20:49
66.61.98.95 0.445 0.094 134.86000:02:58
2603:6010:6802:4ca5:1a03:73ff:fe28:be0f 0.407 0.116 35.36200:01:25
177.172.132.66.censys-scanner.com 0.185 0.040 0.00000:00:12
82.195.132.66.censys-scanner.com 0.161 0.069 0.00000:00:11
azpdwssr8f6n.stretchoid.com 0.140 0.028 0.00000:00:10
227.224.132.66.censys-scanner.com 0.198 0.037 0.00000:00:05
2001:41d0:33d:9200::40f 0.055 0.021 0.00000:00:03
r5-176-b0.monitoring.internet-measurement.com 0.070 0.014 0.00000:00:01
r4-128-80.monitoring.internet-measurement.com 0.061 0.015 0.00000:00:01
kotz.erje.net 0.181 0.032 0.00000:00:01
205.210.31.152 0.062 0.016 0.00000:00:01
2001:41d0:33d:9200::404 0.058 0.022 0.00000:00:00
194.88.98.110 0.074 0.016 0.00000:00:00
5.226.140.42 0.070 0.015 0.00000:00:00
o011.scanner.modat.io 0.065 0.007 0.00000:00:00
91.238.181.94 0.067 0.015 0.00000:00:00
TOTAL: 18 84.960 48.866 245.71023:17:45

Curious NNRP explorers [Top 20]:

SystemConn
toma-03.stehlik.co.uk 445
2a03:cfc0:8000:b::c303:dce8 274
177.172.132.66.censys-scanner.com 3
227.224.132.66.censys-scanner.com 3
82.195.132.66.censys-scanner.com 3
kotz.erje.net 3
azpdwssr8f6n.stretchoid.com 2
194.88.98.110 1
2001:41d0:33d:9200::404 1
2001:41d0:33d:9200::40f 1
205.210.31.152 1
5.226.140.42 1
91.238.181.94 1
o011.scanner.modat.io 1
r4-128-80.monitoring.internet-measurement.com 1
r5-176-b0.monitoring.internet-measurement.com 1
TOTAL: 16 742

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

SystemConn
2001:41d0:33d:9200::404 4
91.238.181.94 1
azpdwssr8f6n.stretchoid.com 1
TOTAL: 3 6

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

CommandCount
?$?,?r?s?^S^B^S^A?^T?^G?^R?^S?'?/?^T?(?0?`?a... 1
?@?M-^BF/l->??ms^L?3?2.? 1
?M-^PM-?D~?!?Q?<"?(?M-^\?^A<$M-^L^D2? 1
MGLNDD_116.202.108.142_119 1
^C 1
^V^C^C^Bj^A 1
TOTAL: 6 6

NNRP client timeouts [Top 20]:

SystemConnPeer
5.226.140.42 1 1
91.238.181.94 1 1
TOTAL: 2 2 12

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

HierarchyCountPct
1linux 90 43.7%
2comp 82 39.8%
3rec 26 12.6%
4alt 8 3.9%
TOTAL: 4 206100.0%

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

NewsgroupCount
1linux.debian.bugs.dist 89
2comp.os.linux.misc 82
3rec.arts.poems 16
4rec.games.trivia 9
5alt.food.fast-food 8
6linux.debian.news.french 1
7rec.autos.sport.f1 1
TOTAL: 7 206