Daily Usenet report for news.niel.me

Jun 19 04:15:01 -- Jun 20 04:15:02

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Jun 19 12:45:55 rpi-studio innd: filter: No Cancel-Key[sha256:TKm00no9yOBtSX6n3/YGa2jKAjH2Vfq1qUJYszEwxlo=] matches Cancel-Lock[sha256:wRKvQQ/y5REf3a1gbvCfDz6YSFKmWjc5byI5n4FIKdY="] target=<sakhp4$oom$1@shakotay.alphanet.ch>

Log entries by program:

Program nameLines%LinesSize%Size
inn 4212 41.6%726.0 KB 45.2%
innd 2454 24.2%397.8 KB 24.8%
nnrpd 1932 19.1%217.1 KB 13.5%
innfeed 1527 15.1%265.9 KB 16.5%
controlchan 1 0.0%0.2 KB 0.0%
nocem 1 0.0%0.1 KB 0.0%
TOTAL: 6 10127 100.0%1.6 MB100.0%

History cache:

ReasonCount%Count
Positive hits 21729 68.0%
Negative hits 6074 19.0%
Do not exist 4155 13.0%
Cache misses 3 0.0%
TOTAL: 4 31961 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.026 0.0%21 0.000 1.238 3.000
article cancel00:00:00.001 0.0%22 0.000 0.045 0.500
article cleanup00:00:00.083 0.0%4161 0.000 0.020 0.143
article logging00:00:00.359 0.0%4171 0.000 0.086 0.286
article parse00:00:00.748 0.0%6928 0.000 0.108 0.320
article write00:00:02.285 0.0%3507 0.176 0.652 6.955
artlog/artcncl00:00:00.000 0.0%22 0.000 0.000 0.000
artlog/artcncl/perl00:00:00.001 0.0%21 0.000 0.048 1.000
data move00:00:00.082 0.0%34624 0.000 0.002 0.033
hisgrep/artcncl00:00:00.000 0.0%22 0.000 0.000 0.000
hisgrep/artcncl/perl00:00:00.001 0.0%21 0.000 0.048 1.000
hisgrep/perl00:00:00.001 0.0%22 0.000 0.045 1.000
hishave/artcncl00:00:00.000 0.0%22 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.000 0.0%21 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.479 0.0%31965 0.000 0.015 0.045
history sync00:00:00.058 0.0%407 0.000 0.143 0.667
history write00:00:00.916 0.0%4161 0.030 0.220 2.500
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle24:00:29.564100.0%34994 709.489 2469.840 10003.933
nntp read00:00:01.127 0.0%34480 0.006 0.033 0.104
overview write00:00:02.809 0.0%3507 0.077 0.801 13.000
perl filter00:00:19.329 0.0%4161 2.029 4.645 13.500
python filter00:00:00.017 0.0%7114 0.000 0.002 0.057
site send00:00:01.316 0.0%7018 0.000 0.188 0.500
TOTAL: 24:01:09.65424:00:59.202100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.038 0.0%3559 0.000 0.011 0.091
article prepare00:00:00.002 0.0%1900 0.000 0.001 0.125
article read00:00:00.061 0.0%411 0.000 0.148 4.000
backlog stats00:00:00.117 0.0%56622 0.000 0.002 0.012
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.699 0.0%31001 0.000 0.023 0.063
data write00:00:02.113 0.0%27474 0.032 0.077 0.147
idle23:50:26.586100.0%56622 622.943 1515.782 4615.954
status file00:00:00.416 0.0%169 1.000 2.462 7.000
TOTAL: 23:50:33.33423:50:30.032100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:01:13.574 76.0%1492 6.400 49.312 3610.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.113 0.1%3499 0.000 0.032 0.273
readart00:00:00.011 0.0%8 0.000 1.375 2.200
TOTAL: 00:01:36.84200:01:13.698 76.1%----

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 3528 1747 1702 79 49%23:55:32
2usenet.pasdenom.info 5 5756 612 5142 2 10%48:38:53
3feed-out.gegeweb.org 2 2477 578 1899 0 23%23:59:54
4nntp.terraraq.uk 1 3342 438 2614 290 13%25:56:04
5i2pn.org 3 7067 107 6943 17 1%45:42:36
6news.nntp4.net 2 3766 88 3433 245 2%23:44:05
7gegeweb-out.news.tnetconsulting.net 2 3358 18 3295 45 0%23:59:41
8localhost 25 0 0 0 0 0%00:00:00
TOTAL: 8 42 29294 3588 25028 678 12%215:56:45
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news-out.aioe.org5.8 MB0.0 KB347.8 KB6.1 MB 94%3.4 KB
2nntp.terraraq.uk2.6 MB0.0 KB2.8 MB5.4 MB 48%7.6 KB
3usenet.pasdenom.info1.7 MB0.0 KB5.7 KB1.7 MB 99%2.9 KB
4feed-out.gegeweb.org1.4 MB0.0 KB0.0 KB1.4 MB100%2.5 KB
5news.nntp4.net1.1 MB0.0 KB435.1 KB1.6 MB 72%4.8 KB
6i2pn.org455.8 KB0.0 KB47.1 KB502.9 KB 90%4.1 KB
7gegeweb-out.news.tnetconsulting.net104.3 KB0.0 KB157.0 KB261.3 KB 39%4.1 KB
8localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 813.2 MB0.0 KB3.7 MB16.9 MB 78%4.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jun 19 04:15:01 - 04:59:59 66 1.9% 0.02222.0 KB 1.7% 0.08
Jun 19 05:00:00 - 05:59:59 78 2.2% 0.02618.6 KB 4.6% 0.17
Jun 19 06:00:00 - 06:59:59 63 1.8% 0.02432.6 KB 3.2% 0.12
Jun 19 07:00:00 - 07:59:59 74 2.1% 0.02271.0 KB 2.0% 0.08
Jun 19 08:00:00 - 08:59:59 106 3.0% 0.03384.0 KB 2.9% 0.11
Jun 19 09:00:00 - 09:59:59 93 2.7% 0.03355.3 KB 2.6% 0.10
Jun 19 10:00:00 - 10:59:59 125 3.6% 0.03360.6 KB 2.7% 0.10
Jun 19 11:00:00 - 11:59:59 110 3.1% 0.03303.6 KB 2.3% 0.08
Jun 19 12:00:00 - 12:59:59 189 5.4% 0.051.4 MB 10.9% 0.41
Jun 19 13:00:00 - 13:59:59 124 3.5% 0.03402.1 KB 3.0% 0.11
Jun 19 14:00:00 - 14:59:59 146 4.2% 0.04416.2 KB 3.1% 0.12
Jun 19 15:00:00 - 15:59:59 134 3.8% 0.04453.5 KB 3.4% 0.13
Jun 19 16:00:00 - 16:59:59 185 5.3% 0.05511.4 KB 3.8% 0.14
Jun 19 17:00:00 - 17:59:59 151 4.3% 0.04659.5 KB 4.9% 0.18
Jun 19 18:00:00 - 18:59:59 237 6.8% 0.07792.0 KB 5.9% 0.22
Jun 19 19:00:00 - 19:59:59 220 6.3% 0.06741.8 KB 5.5% 0.21
Jun 19 20:00:00 - 20:59:59 283 8.1% 0.08897.1 KB 6.7% 0.25
Jun 19 21:00:00 - 21:59:59 195 5.6% 0.05706.0 KB 5.3% 0.20
Jun 19 22:00:00 - 22:59:59 157 4.5% 0.04562.8 KB 4.2% 0.16
Jun 19 23:00:00 - 23:59:59 175 5.0% 0.05598.8 KB 4.5% 0.17
Jun 20 00:00:00 - 00:59:59 228 6.5% 0.06754.6 KB 5.6% 0.21
Jun 20 01:00:00 - 01:59:59 124 3.5% 0.03344.9 KB 2.6% 0.10
Jun 20 02:00:00 - 02:59:59 87 2.5% 0.02263.8 KB 2.0% 0.07
Jun 20 03:00:00 - 03:59:59 113 3.2% 0.03807.0 KB 6.0% 0.22
Jun 20 04:00:00 - 04:15:02 42 1.2% 0.05108.7 KB 0.8% 0.12
TOTAL: 24:00:01 3505 100.0% 0.0413.1 MB 100.0% 0.16
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1nntp.terraraq.uk 290 0 0 0 0 0 0 0 290
2news.nntp4.net 245 0 0 0 0 0 0 0 245
3news-out.aioe.org 86 1 0 0 0 0 0 0 85
4gegeweb-out.news.tnetconsulting.net 28 0 0 0 0 0 0 0 28
5i2pn.org 11 0 0 0 0 0 0 0 11
6usenet.pasdenom.info 2 0 0 0 0 0 0 0 2
7feed-out.gegeweb.org 2 0 0 0 0 0 0 0 2
TOTAL: 7 664 1 0 0 0 0 0 0 663

Unwanted newsgroups [Top 20]:

NewsgroupCount
news.test 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 194
User-issued spam cancel 174
Bad path (news.giganews.com.POSTED) 153
EMP (phn nph) 68
EMP (md5) 37
EMP (phl) 27
TOTAL: 6 653

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news-out.aioe.org 7
feed-out.gegeweb.org 2
nntp.terraraq.uk 1
TOTAL: 3 10
TOTAL: 1 10

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1i2pn.org 6348 219 3079 128 0 44 3%23:59:52
2news.tnetconsulting.net 6121 63 3423 19 0 41 1%23:59:57
3nntp.terraraq.uk 2384 17 2130 0 0 0 0%23:58:24
4news.pasdenom.info 4257 17 2701 7 0 4 0%23:59:57
5news.gegeweb.org 3007 5 2921 0 0 0 0%23:59:29
6news.aioe.org 1462 1 1338 0 0 3 0%23:55:33
7news.nntp4.net 3905 0 3416 0 0 0 0%23:59:57
TOTAL: 7 27484 322 19008 154 0 92 1%167:53:09
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1i2pn.org536.2 KB278.9 KB815.1 KB0.0 KB/s2.3 KB23:59:52
2news.tnetconsulting.net248.2 KB49.8 KB298.0 KB0.0 KB/s3.6 KB23:59:57
3nntp.terraraq.uk56.0 KB0.0 KB56.0 KB0.0 KB/s3.3 KB23:58:24
4news.pasdenom.info49.7 KB103.7 KB153.3 KB0.0 KB/s6.4 KB23:59:57
5news.gegeweb.org16.1 KB0.0 KB16.1 KB0.0 KB/s3.2 KB23:59:29
6news.aioe.org2.2 KB0.0 KB2.2 KB0.0 KB/s2.2 KB23:55:33
7news.nntp4.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:57
TOTAL: 7908.4 KB432.3 KB1.3 MB0.0 KB/s2.8 KB167:53:09
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1mbp-gniel.niel.me 2 820.0 KB 4 0 000:00:58
TOTAL: 1 2 820.0 KB 4 0 000:01:36

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.niel.me 2 820.0 KB 4 0 000:00:58
2*.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
3*.gegeweb.eu 288 00.0 KB 0 0 000:00:25
4unresolved 1 00.0 KB 0 0 000:00:00
5*.208-100-26.static.steadfastdns.net 10 00.0 KB 0 0 000:00:05
6*.census.shodan.io 1 00.0 KB 0 0 000:00:05
TOTAL: 6 303 820.0 KB 4 0 000:01:36

NNRP auth users [Top 20]:

UserConn
mailman 288
TOTAL: 1 288

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
mbp-gniel.niel.me 0.055 0.098 0.00000:00:58
mail.gegeweb.eu 8.217 8.952 2.98200:00:25
ip244.208-100-26.static.steadfastdns.net 0.113 0.238 0.00000:00:05
sky.census.shodan.io 0.025 0.034 0.00000:00:05
scanner-21.ch1.censys-scanner.com 0.027 0.027 0.00000:00:00
88.165.5.23 0.030 0.030 0.00000:00:00
TOTAL: 6 8.467 9.379 2.98200:01:36

Curious NNRP server explorers [Top 20]:

SystemConn
mail.gegeweb.eu 288
ip244.208-100-26.static.steadfastdns.net 10
scanner-21.ch1.censys-scanner.com 1
88.165.5.23 1
sky.census.shodan.io 1
TOTAL: 5 301

NNRP gethostbyaddr failures [Top 20]:

SystemConn
? (can't getpeername) 20
TOTAL: 1 20

NNRP client timeouts [Top 20]:

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

Newsgroup request counts (by category):

CategoryCountPct
1grisbi 4 50.0%
2news 3 37.5%
3fr 1 12.5%
TOTAL: 3 8100.0%

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

NewsgroupCount
1grisbi.user.french 3
2news.admin.peering 3
3grisbi.test 1
4fr.comp.usenet.serveurs 1
TOTAL: 4 8
innreport from INN 2.6.4 based on work (c) 1996-1999 by Fabien Tassin <fta@sofaraway.org>
Local contact: usenet@niel.me