Daily Usenet report for news.niel.me

Apr 3 04:15:01 -- Apr 4 04:15:02

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Apr 3 16:37:53 rpi-studio innd: filter: No Cancel-Key[sha1:5qLGJPSNVX+p+C5Z/pp8SVN4TpA= sha256:gmaFr68KrGarqqkHd8LRZUkFDnF1kNOTi+g3Lv2TjOc=] matches Cancel-Lock[sha1:ls5+ghjD9067f4kqXRpRNHJBaao= sha256:uWR50l/CmcnoYGGXFPyiSkmDKY8R7EPC67u6IWb5eaU=] target=<uujphc$qmb$1@rasp.pasdenom.info>
Apr 4 03:16:47 rpi-studio innd: filter: No Cancel-Key[sha1:nLvljychO4QU80VKuHmWoOAKhaU= sha256:tE0SBVGUc3T+30T/mVtYV/zXewfvBftmRlZaa6Lw3fI=] matches Cancel-Lock[sha1:kR9Ihrs6FyDKq8V44/5cStdfkTM= sha256:FsgrRerbmrGj7m3aw5dyiuiPgrwSplO+CnpZ9JpVzVc=] target=<uuksnu$1ee7$2@nnrp.usenet.blueworldhosting.com>

Log entries by program:

Program nameLines%LinesSize%Size
innd 2305 27.4%389.5 KB 29.9%
nnrpd 2283 27.1%247.8 KB 19.0%
inn 1951 23.2%362.9 KB 27.9%
innfeed 1877 22.3%301.9 KB 23.2%
nocem 1 0.0%0.1 KB 0.0%
controlchan 1 0.0%0.0 KB 0.0%
TOTAL: 6 8418 100.0%1.3 MB100.0%

History cache:

ReasonCount%Count
Positive hits 10243 64.5%
Negative hits 3714 23.4%
Do not exist 1920 12.1%
Cache misses 3 0.0%
TOTAL: 4 15880 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.012 0.0%8 0.500 1.500 5.000
article cancel00:00:00.001 0.0%8 0.000 0.125 1.000
article cleanup00:00:00.048 0.0%1925 0.000 0.025 0.286
article logging00:00:00.154 0.0%1925 0.000 0.080 0.333
article parse00:00:00.225 0.0%3942 0.000 0.057 1.000
article write00:00:01.033 0.0%1576 0.000 0.655 2.200
artlog/artcncl00:00:00.000 0.0%8 0.000 0.000 0.000
artlog/artcncl/perl00:00:00.000 0.0%8 0.000 0.000 0.000
data move00:00:00.090 0.0%16434 0.000 0.005 0.043
hisgrep/artcncl00:00:00.000 0.0%8 0.000 0.000 0.000
hisgrep/artcncl/perl00:00:00.000 0.0%8 0.000 0.000 0.000
hisgrep/perl00:00:00.000 0.0%10 0.000 0.000 0.000
hishave/artcncl00:00:00.000 0.0%8 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.000 0.0%8 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.265 0.0%15886 0.000 0.017 0.079
history sync00:00:00.056 0.0%349 0.000 0.160 1.000
history write00:00:00.375 0.0%1925 0.000 0.195 0.529
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:50:37.492100.0%18705 1779.748 4589.013 40020.733
nntp read00:00:00.479 0.0%17978 0.000 0.027 0.111
overview write00:00:01.006 0.0%1576 0.000 0.638 8.000
perl filter00:00:09.517 0.0%1925 3.364 4.944 16.000
python filter00:00:00.011 0.0%1925 0.000 0.006 0.167
site send00:00:00.731 0.0%3190 0.000 0.229 0.667
TOTAL: 23:51:01.49223:50:51.495100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.011 0.0%1578 0.000 0.007 1.000
article prepare00:00:00.001 0.0%716 0.000 0.001 0.250
article read00:00:00.036 0.0%172 0.000 0.209 7.000
backlog stats00:00:00.138 0.0%29586 0.000 0.005 0.030
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.338 0.0%14541 0.000 0.023 0.071
data write00:00:00.811 0.0%13031 0.000 0.062 0.125
idle23:50:49.780100.0%29586 1276.923 2901.703 9690.113
status file00:00:00.530 0.0%276 0.000 1.920 7.000
TOTAL: 23:50:54.22023:50:51.645100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:38.987 28.3%1453 10.200 26.832 10050.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.095 0.1%3292 0.000 0.029 1.000
TOTAL: 00:02:17.74800:00:39.082 28.4%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1feed-out.gegeweb.org 4 1525 790 735 0 51%23:54:33
2usenet.pasdenom.info 7 1491 205 1262 24 13%31:45:23
3gegeweb-out.news.tnetconsulting.net 3 1346 177 1134 35 13%23:58:20
4news.glou.org 2 1691 112 1459 120 6%23:59:01
5nntp.terraraq.uk 3 1541 95 1415 31 6%28:10:59
6news.nntp4.net 2 1590 82 1349 159 5%21:16:54
7i2pn.org 2 195 26 169 0 13%04:27:47
8news.samoylyk.net 3 1771 7 1762 2 0%28:57:26
9localhost 25 0 0 0 0 0%00:00:00
TOTAL: 9 51 11150 1494 9285 371 13%186:30:23
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1feed-out.gegeweb.org2.5 MB0.0 KB0.0 KB2.5 MB100%3.3 KB
2gegeweb-out.news.tnetconsulting.net570.8 KB0.0 KB99.6 KB670.4 KB 85%3.2 KB
3news.glou.org501.2 KB0.0 KB262.7 KB763.9 KB 65%3.3 KB
4usenet.pasdenom.info484.9 KB0.0 KB34.4 KB519.2 KB 93%2.3 KB
5news.nntp4.net284.2 KB0.0 KB992.6 KB1.2 MB 22%5.3 KB
6nntp.terraraq.uk221.4 KB0.0 KB58.3 KB279.7 KB 79%2.2 KB
7i2pn.org79.4 KB0.0 KB0.0 KB79.4 KB100%3.1 KB
8news.samoylyk.net28.6 KB0.0 KB4.2 KB32.8 KB 87%3.6 KB
9localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 94.7 MB0.0 KB1.4 MB6.1 MB 76%3.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Apr 3 04:15:01 - 04:59:59 28 1.8% 0.0177.9 KB 1.6% 0.03
Apr 3 05:00:00 - 05:59:59 60 3.8% 0.02140.2 KB 2.8% 0.04
Apr 3 06:00:00 - 06:59:59 32 2.0% 0.01133.4 KB 2.7% 0.04
Apr 3 07:00:00 - 07:59:59 32 2.0% 0.01114.0 KB 2.3% 0.03
Apr 3 08:00:00 - 08:59:59 36 2.3% 0.0198.6 KB 2.0% 0.03
Apr 3 09:00:00 - 09:59:59 33 2.1% 0.0194.6 KB 1.9% 0.03
Apr 3 10:00:00 - 10:59:59 28 1.8% 0.01116.4 KB 2.3% 0.03
Apr 3 11:00:00 - 11:59:59 75 4.7% 0.02227.3 KB 4.6% 0.06
Apr 3 12:00:00 - 12:59:59 77 4.9% 0.02204.3 KB 4.1% 0.06
Apr 3 13:00:00 - 13:59:59 68 4.3% 0.02180.1 KB 3.6% 0.05
Apr 3 14:00:00 - 14:59:59 68 4.3% 0.02188.0 KB 3.8% 0.05
Apr 3 15:00:00 - 15:59:59 84 5.3% 0.02191.9 KB 3.8% 0.05
Apr 3 16:00:00 - 16:59:59 91 5.7% 0.03239.9 KB 4.8% 0.07
Apr 3 17:00:00 - 17:59:59 102 6.4% 0.03363.6 KB 7.3% 0.10
Apr 3 18:00:00 - 18:59:59 70 4.4% 0.02291.1 KB 5.8% 0.08
Apr 3 19:00:00 - 19:59:59 71 4.5% 0.02230.7 KB 4.6% 0.06
Apr 3 20:00:00 - 20:59:59 111 7.0% 0.03328.2 KB 6.6% 0.09
Apr 3 21:00:00 - 21:59:59 77 4.9% 0.02224.6 KB 4.5% 0.06
Apr 3 22:00:00 - 22:59:59 105 6.6% 0.03353.0 KB 7.1% 0.10
Apr 3 23:00:00 - 23:59:59 66 4.2% 0.02215.0 KB 4.3% 0.06
Apr 4 00:00:00 - 00:59:59 69 4.4% 0.02354.1 KB 7.1% 0.10
Apr 4 01:00:00 - 01:59:59 78 4.9% 0.02258.2 KB 5.2% 0.07
Apr 4 02:00:00 - 02:59:59 59 3.7% 0.02194.8 KB 3.9% 0.05
Apr 4 03:00:00 - 03:59:59 53 3.3% 0.01138.1 KB 2.8% 0.04
Apr 4 04:00:00 - 04:15:02 13 0.8% 0.0137.3 KB 0.7% 0.04
TOTAL: 24:00:01 1586 100.0% 0.024.9 MB 100.0% 0.06
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 168 0 0 0 0 0 0 0 168
2news.glou.org 120 0 0 0 0 0 0 0 120
3gegeweb-out.news.tnetconsulting.net 31 0 0 0 0 0 0 0 31
4nntp.terraraq.uk 16 0 0 0 0 0 0 0 16
5usenet.pasdenom.info 12 0 0 0 0 0 0 0 12
6news.samoylyk.net 2 0 0 0 0 0 0 0 2
TOTAL: 6 349 0 0 0 0 0 0 0 349

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 155
EMP (phn path) 118
Bad path (news.giganews.com.POSTED) 64
Cancels abusifs 6
HTML Multipart 2
EMP (md5) 2
No Cancel-Key matches Cancel-Lock. target=<uuksnu$1ee7$2@nnrp.usenet.blueworldhosting.com> 1
No Cancel-Key matches Cancel-Lock. target=<uujphc$qmb$1@rasp.pasdenom.info> 1
TOTAL: 8 349

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1i2pn.org 2281 107 1322 1 0 0 4%23:57:04
2news.gegeweb.org 836 46 733 0 0 0 5%23:23:28
3news.tnetconsulting.net 2642 15 1569 1 0 0 0%23:57:02
4news.samoylyk.net 2274 5 1573 0 0 2 0%23:54:50
5nntp.terraraq.uk 1291 2 1197 0 0 0 0%23:51:00
6news.pasdenom.info 1806 1 1561 0 0 0 0%23:56:56
7news.nntp4.net 1658 1 1501 0 0 0 0%23:56:56
8news.aioe.org 0 0 0 0 0 1251 0%23:59:57
TOTAL: 8 12788 177 9456 2 0 1253 1%190:57:13
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1i2pn.org258.6 KB10.8 KB269.4 KB0.0 KB/s2.5 KB23:57:04
2news.gegeweb.org121.8 KB0.0 KB121.8 KB0.0 KB/s2.6 KB23:23:28
3news.nntp4.net96.3 KB0.0 KB96.3 KB0.0 KB/s96.3 KB23:56:56
4news.tnetconsulting.net34.4 KB3.4 KB37.8 KB0.0 KB/s2.4 KB23:57:02
5news.samoylyk.net14.9 KB0.0 KB14.9 KB0.0 KB/s3.0 KB23:54:50
6nntp.terraraq.uk11.8 KB0.0 KB11.8 KB0.0 KB/s5.9 KB23:51:00
7news.pasdenom.info4.5 KB0.0 KB4.5 KB0.0 KB/s4.5 KB23:56:56
8news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:57
TOTAL: 8542.2 KB14.2 KB556.5 KB0.0 KB/s3.1 KB190:57:13
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
188-165-5-23.subs.proxad.net 2 00.0 KB 0 0 000:00:01
2207.90.244.14 1 00.0 KB 0 0 000:00:03
3104.156.155.24 85 00.0 KB 0 0 000:00:23
4107.170.235.34 1 00.0 KB 0 0 000:00:00
580.66.88.204 1 00.0 KB 0 0 000:00:00
6104.152.52.153 1 00.0 KB 0 0 000:00:10
755.149.216.162.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
8lputeaux-658-1-30-140.w80-13.abo.wanadoo.fr 1 00.0 KB 0 0 000:00:10
9mail.gegeweb.eu 288 00.0 KB 0 0 000:01:25
10194.165.16.10 1 00.0 KB 0 0 000:00:01
TOTAL: 10 382 00.0 KB 0 0 000:02:17

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.subs.proxad.net 2 00.0 KB 0 0 000:00:01
2*.149.216.162.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
3*.gegeweb.eu 288 00.0 KB 0 0 000:01:25
4unresolved 90 00.0 KB 0 0 000:00:39
5*.w80-13.abo.wanadoo.fr 1 00.0 KB 0 0 000:00:10
TOTAL: 5 382 00.0 KB 0 0 000:02:17

NNRP auth users [Top 20]:

UserConn
mailman 288
TOTAL: 1 288

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
mail.gegeweb.eu 4.331 4.226 1.56900:01:25
104.156.155.24 2.340 1.019 0.00000:00:23
lputeaux-658-1-30-140.w80-13.abo.wanadoo.fr 0.035 0.021 0.00000:00:10
104.152.52.153 0.020 0.029 0.00000:00:10
207.90.244.14 0.023 0.027 0.00000:00:03
88-165-5-23.subs.proxad.net 0.036 0.040 0.00000:00:01
194.165.16.10 0.017 0.012 0.00000:00:01
55.149.216.162.bc.googleusercontent.com 0.034 0.007 0.00000:00:00
80.66.88.204 0.021 0.003 0.00000:00:00
107.170.235.34 0.029 0.025 0.00000:00:00
TOTAL: 10 6.886 5.409 1.56900:02:17

NNRP unrecognized commands (by host):

SystemConn
55.149.216.162.bc.googleusercontent.com 3
107.170.235.34 1
80.66.88.204 1
TOTAL: 3 5

NNRP unrecognized commands (by command):

CommandCount
User-Agent: Expanse, a Palo Alto Network... 1
#003 1
GET / HTTP/1.1 1
Host: 45.13.105.36:563 1
MGLNDD_45.13.105.36_119 1
TOTAL: 5 5

NNRP client timeouts [Top 20]:

SystemConnPeer
80.66.88.204 1 1
TOTAL: 1 1 1