Daily Usenet report for news.niel.me

Jul 25 04:15:02 -- Jul 26 04:15:01

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Jul 25 11:20:11 rpi-studio innd: filter: No Cancel-Key[sha1:AfJFE3dsATcfjAKwuczcB/Yc/EI=] matches Cancel-Lock[sha1:yOqB40N+yhdDkDNCfPTkPmIZO0k=] target=<sdj7av$gnv$1@shakotay.alphanet.ch>
Jul 25 12:49:24 rpi-studio innd: filter: No Cancel-Key[sha1:rDUHTphbk8o7bbq1bpO1jm81iKc=] matches Cancel-Lock[sha1:k7cr9z6ccUCbbKkptLPxcvvIezk= sha1:S2etVFdwYRjKMs0yEssc3/X+63c=] target=<sdjfg2$tm7$1@pi2.pasdenom.info>

Log entries by program:

Program nameLines%LinesSize%Size
inn 4637 43.0%799.7 KB 47.1%
innd 2442 22.6%402.8 KB 23.7%
nnrpd 2119 19.7%226.4 KB 13.3%
innfeed 1562 14.5%265.4 KB 15.6%
nocem 22 0.2%2.3 KB 0.1%
controlchan 1 0.0%0.0 KB 0.0%
TOTAL: 6 10783 100.0%1.7 MB100.0%

History cache:

ReasonCount%Count
Positive hits 24586 67.7%
Negative hits 7221 19.9%
Do not exist 4523 12.4%
Cache misses 2 0.0%
TOTAL: 4 36332 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.043 0.0%32 0.000 1.344 15.000
article cancel00:00:00.012 0.0%55 0.000 0.218 1.000
article cleanup00:00:00.085 0.0%4532 0.000 0.019 0.192
article logging00:00:00.354 0.0%4554 0.000 0.078 0.400
article parse00:00:00.778 0.0%7567 0.000 0.103 0.250
article write00:00:02.608 0.0%3969 0.229 0.657 2.250
artlog/artcncl00:00:00.003 0.0%55 0.000 0.055 1.000
artlog/artcncl/perl00:00:00.000 0.0%32 0.000 0.000 0.000
data move00:00:00.114 0.0%39229 0.000 0.003 0.016
hisgrep/artcncl00:00:00.003 0.0%49 0.000 0.061 1.000
hisgrep/artcncl/perl00:00:00.002 0.0%32 0.000 0.062 1.000
hisgrep/perl00:00:00.005 0.0%40 0.000 0.125 1.000
hishave/artcncl00:00:00.000 0.0%55 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.000 0.0%32 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.525 0.0%36382 0.000 0.014 0.070
history sync00:00:00.053 0.0%415 0.000 0.128 1.000
history write00:00:01.026 0.0%4532 0.000 0.226 0.889
hiswrite/artcncl00:00:00.000 0.0%6 0.000 0.000 0.000
idle24:00:28.180 99.9%39648 715.155 2179.888 8833.132
nntp read00:00:01.291 0.0%39221 0.000 0.033 0.068
overview write00:00:02.814 0.0%3969 0.071 0.709 7.333
perl filter00:00:21.196 0.0%4532 2.939 4.677 11.500
python filter00:00:00.012 0.0%7692 0.000 0.002 0.071
site send00:00:01.338 0.0%7959 0.000 0.168 0.500
TOTAL: 24:01:14.46624:01:00.442100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.041 0.0%3999 0.000 0.010 0.143
article prepare00:00:00.003 0.0%1224 0.000 0.002 0.083
article read00:00:00.045 0.0%261 0.000 0.172 8.000
backlog stats00:00:00.125 0.0%62883 0.000 0.002 0.011
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.838 0.0%35000 0.000 0.024 0.066
data write00:00:02.481 0.0%30994 0.036 0.080 0.155
idle23:56:43.938100.0%62883 596.437 1370.862 4351.362
status file00:00:00.414 0.0%167 0.000 2.479 11.000
TOTAL: 23:56:51.40723:56:47.885100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.001 0.0%5 0.200 0.200 0.200
idle00:08:14.290 74.6%1603 6.400 308.353 10050.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.131 0.0%4171 0.000 0.031 0.273
readart00:00:00.030 0.0%130 0.000 0.231 0.641
TOTAL: 00:11:02.19100:08:14.452 74.7%----

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
1news-out.aioe.org 2 4032 1901 2016 115 47%23:19:57
2feed-out.gegeweb.org 2 2882 596 2286 0 20%23:59:56
3usenet.pasdenom.info 4 4095 594 3498 3 14%33:12:42
4nntp.terraraq.uk 2 3206 417 2517 272 13%22:46:25
5news.nntp4.net 8 4307 216 3988 103 5%24:45:31
6i2pn.org 1 3580 46 3463 71 1%23:59:57
7gegeweb-out.news.tnetconsulting.net 2 3308 14 3273 21 0%23:59:54
8localhost 29 0 0 0 0 0%00:00:00
TOTAL: 8 50 25410 3784 21041 585 14%176:04:22
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news-out.aioe.org5.5 MB0.0 KB416.4 KB5.9 MB 93%3.0 KB
2nntp.terraraq.uk4.1 MB0.0 KB1.3 MB5.4 MB 76%8.0 KB
3news.nntp4.net1.9 MB0.0 KB331.4 KB2.2 MB 85%7.1 KB
4usenet.pasdenom.info1.6 MB0.0 KB6.8 KB1.6 MB 99%2.7 KB
5feed-out.gegeweb.org1.5 MB0.0 KB0.0 KB1.5 MB100%2.6 KB
6i2pn.org176.4 KB0.0 KB310.5 KB486.9 KB 36%4.2 KB
7gegeweb-out.news.tnetconsulting.net40.9 KB0.0 KB73.4 KB114.3 KB 35%3.3 KB
8localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 814.7 MB0.0 KB2.4 MB17.1 MB 85%4.0 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jul 25 04:15:02 - 04:59:59 70 1.8% 0.03189.5 KB 1.2% 0.07
Jul 25 05:00:00 - 05:59:59 97 2.4% 0.03308.0 KB 1.9% 0.09
Jul 25 06:00:00 - 06:59:59 61 1.5% 0.02478.2 KB 3.0% 0.13
Jul 25 07:00:00 - 07:59:59 70 1.8% 0.02198.3 KB 1.3% 0.06
Jul 25 08:00:00 - 08:59:59 85 2.1% 0.02270.5 KB 1.7% 0.08
Jul 25 09:00:00 - 09:59:59 106 2.7% 0.03262.7 KB 1.7% 0.07
Jul 25 10:00:00 - 10:59:59 146 3.7% 0.04383.6 KB 2.4% 0.11
Jul 25 11:00:00 - 11:59:59 195 4.9% 0.05732.4 KB 4.6% 0.20
Jul 25 12:00:00 - 12:59:59 204 5.1% 0.06675.1 KB 4.3% 0.19
Jul 25 13:00:00 - 13:59:59 191 4.8% 0.051.2 MB 7.5% 0.33
Jul 25 14:00:00 - 14:59:59 140 3.5% 0.04505.9 KB 3.2% 0.14
Jul 25 15:00:00 - 15:59:59 212 5.3% 0.06655.0 KB 4.1% 0.18
Jul 25 16:00:00 - 16:59:59 194 4.9% 0.05672.9 KB 4.3% 0.19
Jul 25 17:00:00 - 17:59:59 224 5.6% 0.06812.5 KB 5.1% 0.23
Jul 25 18:00:00 - 18:59:59 241 6.1% 0.071.4 MB 9.4% 0.41
Jul 25 19:00:00 - 19:59:59 241 6.1% 0.07757.9 KB 4.8% 0.21
Jul 25 20:00:00 - 20:59:59 168 4.2% 0.05498.6 KB 3.2% 0.14
Jul 25 21:00:00 - 21:59:59 235 5.9% 0.07807.6 KB 5.1% 0.22
Jul 25 22:00:00 - 22:59:59 225 5.7% 0.061.1 MB 7.4% 0.32
Jul 25 23:00:00 - 23:59:59 218 5.5% 0.06630.2 KB 4.0% 0.18
Jul 26 00:00:00 - 00:59:59 194 4.9% 0.05774.3 KB 4.9% 0.22
Jul 26 01:00:00 - 01:59:59 132 3.3% 0.04431.8 KB 2.7% 0.12
Jul 26 02:00:00 - 02:59:59 158 4.0% 0.04648.9 KB 4.1% 0.18
Jul 26 03:00:00 - 03:59:59 131 3.3% 0.041.2 MB 7.6% 0.34
Jul 26 04:00:00 - 04:15:01 27 0.7% 0.0395.3 KB 0.6% 0.11
TOTAL: 23:59:59 3965 100.0% 0.0515.4 MB 100.0% 0.18
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1nntp.terraraq.uk 292 0 0 0 0 0 0 0 292
2news-out.aioe.org 135 1 0 0 0 0 0 0 134
3news.nntp4.net 104 0 0 0 0 0 0 0 104
4gegeweb-out.news.tnetconsulting.net 34 0 0 0 0 0 0 0 34
5i2pn.org 17 0 0 0 0 0 0 0 17
6usenet.pasdenom.info 3 0 0 0 0 0 0 0 3
TOTAL: 6 585 1 0 0 0 0 0 0 584

Unwanted newsgroups [Top 20]:

NewsgroupCount
news.test 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 213
Bad path (news.giganews.com.POSTED) 125
EMP (phn nph) 125
EMP (md5) 70
EMP (phl) 18
User-issued spam cancel 7
Cancel for rejected article 1
Cancel of <sdjfs6$uhb$1@pi2.pasdenom.info> without Cancel-Key 1
Cancel of non-existing ID <sdj78k$gll$1@shakotay.alphanet.ch> 1
No Cancel-Key matches Cancel-Lock. target=<sdjfg2$tm7$1@pi2.pasdenom.info> 1
TOTAL: 10 562

NoCeM on Spool:

IdGoodBadUniqueTotal
bleachbot@httrack.com1801818
TOTAL: 11801818

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news-out.aioe.org 19
nntp.terraraq.uk 2
news.nntp4.net 1
TOTAL: 3 22
TOTAL: 1 22

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1i2pn.org 7317 133 3673 80 0 0 1%23:59:44
2news.tnetconsulting.net 6874 39 3909 15 0 0 0%23:59:45
3news.pasdenom.info 4734 18 3034 9 0 0 0%23:59:56
4news.gegeweb.org 3458 5 3361 0 0 37 0%23:59:56
5nntp.terraraq.uk 2581 5 2359 0 0 1 0%23:59:56
6news.nntp4.net 4070 2 3744 0 0 0 0%23:59:56
7news.aioe.org 1813 0 1648 0 0 0 0%23:59:56
TOTAL: 7 30847 202 21728 104 0 38 0%167:59:09
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1i2pn.org305.5 KB159.7 KB465.2 KB0.0 KB/s2.2 KB23:59:44
2news.tnetconsulting.net114.4 KB40.4 KB154.9 KB0.0 KB/s2.9 KB23:59:45
3news.pasdenom.info39.9 KB27.6 KB67.5 KB0.0 KB/s2.5 KB23:59:56
4news.gegeweb.org31.0 KB0.0 KB31.0 KB0.0 KB/s6.2 KB23:59:56
5nntp.terraraq.uk26.3 KB0.0 KB26.3 KB0.0 KB/s5.3 KB23:59:56
6news.nntp4.net4.9 KB0.0 KB4.9 KB0.0 KB/s2.4 KB23:59:56
7news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:56
TOTAL: 7521.9 KB227.8 KB749.7 KB0.0 KB/s2.4 KB167:59:09
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1108b-gniel 6 3461.8 KB 5 0 000:07:42
TOTAL: 1 6 3461.8 KB 5 0 000:11:01

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1? 6 3461.8 KB 5 0 000:07:42
2*.gegeweb.eu 288 00.0 KB 0 0 000:02:53
3*.w92-154.abo.wanadoo.fr 1 00.0 KB 0 0 000:00:10
4*.zbau.f3netze.de 1 00.0 KB 0 0 000:00:02
5unresolved 3 00.0 KB 0 0 000:00:11
6*.ch1.censys-scanner.com 3 00.0 KB 0 0 000:00:01
TOTAL: 6 302 3461.8 KB 5 0 000:11:01

NNRP auth users [Top 20]:

UserConn
mailman 288
TOTAL: 1 288

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
108b-gniel 0.235 0.234 0.00000:07:42
mail.gegeweb.eu 8.458 9.008 3.20100:02:53
167.71.213.152 0.029 0.029 0.00000:00:10
lstlambert-656-1-48-236.w92-154.abo.wanadoo.fr 0.010 0.048 0.00000:00:10
tor-exit-2.zbau.f3netze.de 0.010 0.049 0.00000:00:02
88.165.5.23 0.050 0.070 0.00000:00:01
scanner-21.ch1.censys-scanner.com 0.043 0.017 0.00000:00:00
scanner-05.ch1.censys-scanner.com 0.051 0.039 0.00000:00:00
TOTAL: 8 8.886 9.494 3.20100:11:01

Curious NNRP server explorers [Top 20]:

SystemConn
mail.gegeweb.eu 288
88.165.5.23 2
scanner-05.ch1.censys-scanner.com 2
tor-exit-2.zbau.f3netze.de 1
lstlambert-656-1-48-236.w92-154.abo.wanadoo.fr 1
scanner-21.ch1.censys-scanner.com 1
167.71.213.152 1
TOTAL: 7 296

NNRP unrecognized commands (by host):

SystemConn
scanner-05.ch1.censys-scanner.com 1
TOTAL: 1 1

NNRP unrecognized commands (by command):

CommandCount
EHLO www.censys.io 1
TOTAL: 1 1

NNRP client timeouts [Top 20]:

SystemConnPeer
scanner-21.ch1.censys-scanner.com 1 1
TOTAL: 1 1 2

Newsgroup request counts (by category):

CategoryCountPct
1fr 33 97.1%
2grisbi 1 2.9%
TOTAL: 2 34100.0%

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

NewsgroupCount
1fr.usenet.forums.evolution 30
2fr.comp.usenet.serveurs 3
3grisbi.test 1
TOTAL: 3 34