Daily Usenet report for news.niel.me

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

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

Jul 24 10:20:09 rpi-studio innd: filter: No Cancel-Key[sha1:ZtCIr8vB4cEMJP3S9CqEd7Pfapw=] matches Cancel-Lock[sha256:t2Tfsmm6fozbTPHyVegVeF/YF3znwphgGqgzVahlVfg=] target=<sdgic0$qlm$1@dont-email.me>
Jul 24 14:55:23 rpi-studio innd: filter: No Cancel-Key[sha1:j6DX6k8zNi92wtSYWapUsOMX6Ws=] matches Cancel-Lock[sha1:IDDW7VDbB3a663sYX7+Y4+fFUE0=] target=<sdh12i$i1p$1@dont-email.me>
Jul 24 18:02:45 rpi-studio innd: filter: No Cancel-Key[sha1:monCLperso] matches Cancel-Lock[sha1:monCLperso] target=<sdhdh4$8ds$1@dont-email.me>

Log entries by program:

Program nameLines%LinesSize%Size
inn 4280 41.6%743.8 KB 45.7%
innd 2365 23.0%395.6 KB 24.3%
nnrpd 2085 20.3%209.9 KB 12.9%
innfeed 1552 15.1%275.9 KB 17.0%
nocem 9 0.1%1.1 KB 0.1%
controlchan 1 0.0%0.2 KB 0.0%
TOTAL: 6 10292 100.0%1.6 MB100.0%

History cache:

ReasonCount%Count
Positive hits 22163 68.3%
Negative hits 6136 18.9%
Do not exist 4159 12.8%
Cache misses 1 0.0%
TOTAL: 4 32459 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.062 0.0%41 0.000 1.512 6.000
article cancel00:00:00.011 0.0%54 0.000 0.204 1.000
article cleanup00:00:00.095 0.0%4171 0.000 0.023 0.154
article logging00:00:00.349 0.0%4181 0.000 0.083 0.235
article parse00:00:00.808 0.0%7069 0.000 0.114 0.277
article write00:00:03.688 0.0%3637 0.091 1.014 37.743
artlog/artcncl00:00:00.003 0.0%53 0.000 0.057 1.000
artlog/artcncl/perl00:00:00.006 0.0%41 0.000 0.146 1.000
data move00:00:00.096 0.0%35583 0.000 0.003 0.013
hisgrep/artcncl00:00:00.001 0.0%53 0.000 0.019 0.250
hisgrep/artcncl/perl00:00:00.000 0.0%41 0.000 0.000 0.000
hisgrep/perl00:00:00.001 0.0%53 0.000 0.019 1.000
hishave/artcncl00:00:00.000 0.0%54 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.000 0.0%41 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.451 0.0%32475 0.000 0.014 0.034
history sync00:00:00.056 0.0%409 0.000 0.137 1.000
history write00:00:00.961 0.0%4171 0.000 0.230 2.833
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
idle24:00:25.192 99.9%35640 941.005 2424.949 9531.667
nntp read00:00:01.181 0.0%35195 0.000 0.034 0.092
overview write00:00:02.698 0.0%3637 0.038 0.742 8.714
perl filter00:00:21.089 0.0%4171 3.273 5.056 11.900
python filter00:00:00.017 0.0%7055 0.000 0.002 0.034
site send00:00:01.269 0.0%7285 0.000 0.174 0.500
TOTAL: 24:01:09.48224:00:58.034100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.035 0.0%3629 0.000 0.010 0.125
article prepare00:00:00.004 0.0%1384 0.000 0.003 0.062
article read00:00:00.052 0.0%312 0.000 0.167 7.000
backlog stats00:00:00.121 0.0%58664 0.000 0.002 0.014
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.785 0.0%32359 0.005 0.024 0.068
data write00:00:02.315 0.0%28699 0.028 0.081 0.142
idle23:50:45.893100.0%58664 772.456 1463.349 4230.183
status file00:00:00.481 0.0%168 1.000 2.863 79.000
TOTAL: 23:50:53.09723:50:49.686100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:01:59.295 39.8%1550 6.400 76.965 9192.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.101 0.0%3989 0.000 0.025 0.273
readart00:00:00.020 0.0%15 1.333 1.333 1.333
TOTAL: 00:04:59.91300:01:59.416 39.8%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1news-out.aioe.org 1 3813 1868 1838 107 48%25:00:30
2usenet.pasdenom.info 5 8457 897 7556 4 10%66:58:05
3feed-out.gegeweb.org 2 2449 588 1861 0 24%23:58:44
4nntp.terraraq.uk 2 4285 496 3468 321 11%29:25:11
5news.nntp4.net 4 7485 247 7200 38 3%46:11:48
6i2pn.org 2 3799 60 3646 93 1%23:59:50
7gegeweb-out.news.tnetconsulting.net 1 3797 21 3754 22 0%23:59:55
8localhost 27 0 0 0 0 0%00:00:00
TOTAL: 8 44 34085 4177 29323 585 12%239:34:03
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1nntp.terraraq.uk6.9 MB0.0 KB2.9 MB9.9 MB 70%12.3 KB
2news.nntp4.net6.3 MB0.0 KB213.9 KB6.5 MB 96%23.3 KB
3news-out.aioe.org5.6 MB0.0 KB346.1 KB5.9 MB 94%3.1 KB
4usenet.pasdenom.info2.1 MB0.0 KB8.1 KB2.1 MB 99%2.4 KB
5feed-out.gegeweb.org1.6 MB0.0 KB0.0 KB1.6 MB100%2.7 KB
6i2pn.org291.9 KB0.0 KB289.3 KB581.2 KB 50%3.8 KB
7gegeweb-out.news.tnetconsulting.net195.9 KB0.0 KB86.0 KB281.9 KB 69%6.6 KB
8localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 822.9 MB0.0 KB3.9 MB26.7 MB 85%5.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jul 24 04:15:01 - 04:59:59 62 1.7% 0.02623.3 KB 3.9% 0.23
Jul 24 05:00:00 - 05:59:59 134 3.7% 0.04884.5 KB 5.6% 0.25
Jul 24 06:00:00 - 06:59:59 113 3.1% 0.03315.8 KB 2.0% 0.09
Jul 24 07:00:00 - 07:59:59 65 1.8% 0.02301.0 KB 1.9% 0.08
Jul 24 08:00:00 - 08:59:59 124 3.4% 0.03375.4 KB 2.4% 0.10
Jul 24 09:00:00 - 09:59:59 175 4.8% 0.05548.5 KB 3.5% 0.15
Jul 24 10:00:00 - 10:59:59 156 4.3% 0.04418.3 KB 2.6% 0.12
Jul 24 11:00:00 - 11:59:59 128 3.5% 0.04346.7 KB 2.2% 0.10
Jul 24 12:00:00 - 12:59:59 105 2.9% 0.03290.5 KB 1.8% 0.08
Jul 24 13:00:00 - 13:59:59 104 2.9% 0.03979.7 KB 6.2% 0.27
Jul 24 14:00:00 - 14:59:59 128 3.5% 0.04367.6 KB 2.3% 0.10
Jul 24 15:00:00 - 15:59:59 162 4.4% 0.04648.6 KB 4.1% 0.18
Jul 24 16:00:00 - 16:59:59 159 4.4% 0.04637.4 KB 4.0% 0.18
Jul 24 17:00:00 - 17:59:59 158 4.3% 0.04526.4 KB 3.3% 0.15
Jul 24 18:00:00 - 18:59:59 188 5.2% 0.05628.2 KB 4.0% 0.17
Jul 24 19:00:00 - 19:59:59 235 6.5% 0.07898.1 KB 5.7% 0.25
Jul 24 20:00:00 - 20:59:59 251 6.9% 0.071.4 MB 9.2% 0.40
Jul 24 21:00:00 - 21:59:59 198 5.4% 0.06636.9 KB 4.0% 0.18
Jul 24 22:00:00 - 22:59:59 201 5.5% 0.06621.0 KB 3.9% 0.17
Jul 24 23:00:00 - 23:59:59 208 5.7% 0.06532.2 KB 3.4% 0.15
Jul 25 00:00:00 - 00:59:59 178 4.9% 0.051.1 MB 7.1% 0.31
Jul 25 01:00:00 - 01:59:59 149 4.1% 0.04646.6 KB 4.1% 0.18
Jul 25 02:00:00 - 02:59:59 123 3.4% 0.031.1 MB 7.1% 0.31
Jul 25 03:00:00 - 03:59:59 109 3.0% 0.03770.3 KB 4.9% 0.21
Jul 25 04:00:00 - 04:15:02 30 0.8% 0.0393.5 KB 0.6% 0.10
TOTAL: 24:00:01 3643 100.0% 0.0415.4 MB 100.0% 0.18
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1nntp.terraraq.uk 293 0 0 0 0 0 0 0 293
2news-out.aioe.org 112 1 0 0 0 0 0 0 111
3i2pn.org 89 0 0 0 0 0 0 0 89
4news.nntp4.net 27 3 0 0 0 0 0 0 24
5gegeweb-out.news.tnetconsulting.net 18 0 0 0 0 0 0 0 18
6usenet.pasdenom.info 4 0 0 0 0 0 0 0 4
TOTAL: 6 543 4 0 0 0 0 0 0 539

Unwanted newsgroups [Top 20]:

NewsgroupCount
france.aquitaine.agen 1
news.test 1
france.lorraine 1
france.admin.accueil 1
TOTAL: 4 4

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 218
EMP (phn nph) 119
Bad path (news.giganews.com.POSTED) 94
EMP (md5) 80
User-issued spam cancel 8
EMP (phl) 2
HTML Multipart 1
Cancel of non-existing ID <60fc497b$0$12681$426a74cc@news.free.fr> 1
Cancel of <sdh6kd$jar$1@pi2.pasdenom.info> without Cancel-Key 1
Cancel of non-existing ID <im1usfF5qi1U1@mid.individual.net> 1
Cancel of non-existing ID <sdh9fh$8k2$1@shakotay.alphanet.ch> 1
No Cancel-Key matches Cancel-Lock. target=<sdhdh4$8ds$1@dont-email.me> 1
Cancel of non-existing ID <sdha3c$aqo$1@shakotay.alphanet.ch> 1
HTML post 1
TOTAL: 14 529

NoCeM on Spool:

IdGoodBadUniqueTotal
bleachbot@httrack.com7077
TOTAL: 17077

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news-out.aioe.org 9
news.nntp4.net 1
TOTAL: 2 10
TOTAL: 1 10

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1i2pn.org 6623 143 3272 134 0 0 2%23:59:57
2news.tnetconsulting.net 6347 22 3607 14 0 0 0%23:59:57
3news.pasdenom.info 4329 17 2801 4 0 3 0%23:59:57
4news.gegeweb.org 3142 6 3062 0 0 0 0%23:59:57
5news.aioe.org 1505 2 1428 0 0 0 0%23:55:54
6nntp.terraraq.uk 2549 2 2367 0 0 0 0%23:59:54
7news.nntp4.net 4024 2 3532 0 0 0 0%23:59:57
TOTAL: 7 28519 194 20069 152 0 3 0%167:55:33
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1i2pn.org320.5 KB264.9 KB585.3 KB0.0 KB/s2.1 KB23:59:57
2news.tnetconsulting.net52.1 KB32.3 KB84.4 KB0.0 KB/s2.3 KB23:59:57
3news.pasdenom.info47.0 KB11.1 KB58.1 KB0.0 KB/s2.8 KB23:59:57
4news.gegeweb.org41.2 KB0.0 KB41.2 KB0.0 KB/s6.9 KB23:59:57
5nntp.terraraq.uk24.3 KB0.0 KB24.3 KB0.0 KB/s12.2 KB23:59:54
6news.nntp4.net6.3 KB0.0 KB6.3 KB0.0 KB/s3.2 KB23:59:57
7news.aioe.org6.2 KB0.0 KB6.2 KB0.0 KB/s3.1 KB23:55:54
TOTAL: 7497.6 KB308.3 KB805.9 KB0.0 KB/s2.3 KB167:55:33
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1108b-gniel 6 1122.6 KB 3 0 000:01:39
TOTAL: 1 6 1122.6 KB 3 0 000:04:59

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1? 6 1122.6 KB 3 0 000:01:39
2unresolved 3 00.0 KB 0 0 000:00:16
3*.ch1.censys-scanner.com 2 00.0 KB 0 0 000:00:01
4*.gegeweb.eu 288 00.0 KB 0 0 000:03:01
TOTAL: 4 299 1122.6 KB 3 0 000:04:59

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 8.406 9.211 3.36000:03:01
108b-gniel 0.178 0.219 0.00000:01:39
192.241.210.88 0.061 0.000 0.00000:00:09
45.72.85.181 0.070 0.020 0.00000:00:06
scanner-07.ch1.censys-scanner.com 0.035 0.035 0.00000:00:00
scanner-21.ch1.censys-scanner.com 0.013 0.013 0.00000:00:00
88.165.5.23 0.041 0.025 0.00000:00:00
TOTAL: 7 8.804 9.523 3.36000:04:59

Curious NNRP server explorers [Top 20]:

SystemConn
mail.gegeweb.eu 288
88.165.5.23 1
192.241.210.88 1
scanner-07.ch1.censys-scanner.com 1
45.72.85.181 1
scanner-21.ch1.censys-scanner.com 1
TOTAL: 6 293

NNRP unrecognized commands (by host):

SystemConn
scanner-07.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 1

Newsgroup request counts (by category):

CategoryCountPct
1fr 10 90.9%
2grisbi 1 9.1%
TOTAL: 2 11100.0%

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

NewsgroupCount
1fr.comp.os.mac-os.x 7
2fr.usenet.forums.evolution 3
3grisbi.test 1
TOTAL: 3 11