Daily Usenet report for news.niel.me

Jul 26 04:15:01 -- Jul 27 04:15:01

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Jul 26 15:23:26 rpi-studio innd: filter: No Cancel-Key[sha1:b3E5bFKI1izWY8riR0xebQz04mM=] matches Cancel-Lock[sha1:j10ZP1pkykTtc3BSQdEhhe1RLhk=] target=<sddv75$hqv$1@pi2.pasdenom.info>

Log entries by program:

Program nameLines%LinesSize%Size
inn 4469 41.6%788.0 KB 46.5%
innd 2356 21.9%376.0 KB 22.2%
nnrpd 2347 21.8%242.9 KB 14.3%
innfeed 1566 14.6%287.7 KB 17.0%
nocem 12 0.1%1.1 KB 0.1%
controlchan 1 0.0%0.2 KB 0.0%
TOTAL: 6 10751 100.0%1.7 MB100.0%

History cache:

ReasonCount%Count
Positive hits 23615 67.8%
Negative hits 6832 19.6%
Do not exist 4401 12.6%
Cache misses 3 0.0%
TOTAL: 4 34851 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.042 0.0%23 0.000 1.826 7.000
article cancel00:00:00.008 0.0%31 0.000 0.258 2.000
article cleanup00:00:00.087 0.0%4411 0.000 0.020 0.125
article logging00:00:00.352 0.0%4420 0.000 0.080 0.231
article parse00:00:00.725 0.0%7122 0.000 0.102 0.267
article write00:00:02.916 0.0%3930 0.194 0.742 3.902
artlog/artcncl00:00:00.000 0.0%31 0.000 0.000 0.000
artlog/artcncl/perl00:00:00.000 0.0%23 0.000 0.000 0.000
data move00:00:00.094 0.0%37716 0.000 0.002 0.011
hisgrep/artcncl00:00:00.001 0.0%28 0.000 0.036 1.000
hisgrep/artcncl/perl00:00:00.001 0.0%23 0.000 0.043 1.000
hisgrep/perl00:00:00.003 0.0%25 0.000 0.120 1.000
hishave/artcncl00:00:00.000 0.0%31 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.000 0.0%23 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.496 0.0%34905 0.000 0.014 0.044
history sync00:00:00.052 0.0%413 0.000 0.126 0.667
history write00:00:00.927 0.0%4411 0.000 0.210 0.562
hiswrite/artcncl00:00:00.001 0.0%3 0.000 0.333 1.000
idle24:00:28.539 99.9%37997 754.034 2274.615 6386.234
nntp read00:00:01.183 0.0%37491 0.000 0.032 0.060
overview write00:00:02.568 0.0%3930 0.067 0.653 4.211
perl filter00:00:21.173 0.0%4411 3.605 4.800 8.545
python filter00:00:00.012 0.0%7478 0.000 0.002 0.029
site send00:00:01.003 0.0%7870 0.000 0.127 0.467
TOTAL: 24:01:12.52324:01:00.183100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.053 0.0%3960 0.000 0.013 0.080
article prepare00:00:00.000 0.0%1672 0.000 0.000 0.000
article read00:00:00.061 0.0%351 0.000 0.174 3.000
backlog stats00:00:00.141 0.0%63654 0.000 0.002 0.010
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.841 0.0%35179 0.000 0.024 0.051
data write00:00:02.339 0.0%31209 0.020 0.075 0.152
idle23:50:28.682100.0%63654 707.432 1348.363 3141.484
status file00:00:00.428 0.0%168 1.000 2.548 9.000
TOTAL: 23:50:35.97623:50:32.545100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:21:56.255 87.7%1633 6.400 806.035 13830.971
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.144 0.0%4605 0.000 0.031 0.273
readart00:00:00.016 0.0%54 0.000 0.296 0.432
TOTAL: 00:25:00.62800:21:56.415 87.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 1 4038 1956 1991 91 48%23:57:02
2usenet.pasdenom.info 5 8499 783 7711 5 9%62:44:53
3feed-out.gegeweb.org 3 2567 558 2009 0 21%23:58:40
4nntp.terraraq.uk 2 4039 537 3159 343 13%27:36:35
5news.nntp4.net 2 3936 169 3740 27 4%23:27:01
6i2pn.org 1 4159 44 4098 17 1%23:59:57
7gegeweb-out.news.tnetconsulting.net 1 3972 17 3924 31 0%23:59:56
8localhost 33 3 3 0 0 100%00:00:00
TOTAL: 8 48 31213 4067 26632 514 13%209:44:04
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news-out.aioe.org6.3 MB0.0 KB326.2 KB6.6 MB 95%3.3 KB
2nntp.terraraq.uk4.9 MB0.0 KB2.5 MB7.4 MB 66%8.6 KB
3usenet.pasdenom.info1.9 MB0.0 KB8.8 KB1.9 MB 99%2.4 KB
4feed-out.gegeweb.org1.4 MB0.0 KB0.0 KB1.4 MB100%2.6 KB
5news.nntp4.net1.2 MB0.0 KB152.6 KB1.4 MB 89%7.2 KB
6i2pn.org169.0 KB0.0 KB52.7 KB221.8 KB 76%3.6 KB
7gegeweb-out.news.tnetconsulting.net58.3 KB0.0 KB98.3 KB156.6 KB 37%3.3 KB
8localhost6.7 KB0.0 KB0.0 KB6.7 KB100%2.2 KB
TOTAL: 815.9 MB0.0 KB3.1 MB19.0 MB 83%4.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jul 26 04:15:01 - 04:59:59 88 2.2% 0.03308.8 KB 2.1% 0.11
Jul 26 05:00:00 - 05:59:59 99 2.5% 0.03379.1 KB 2.5% 0.11
Jul 26 06:00:00 - 06:59:59 118 3.0% 0.03440.1 KB 3.0% 0.12
Jul 26 07:00:00 - 07:59:59 131 3.3% 0.041.1 MB 7.5% 0.31
Jul 26 08:00:00 - 08:59:59 136 3.5% 0.04695.3 KB 4.7% 0.19
Jul 26 09:00:00 - 09:59:59 117 3.0% 0.03439.9 KB 3.0% 0.12
Jul 26 10:00:00 - 10:59:59 96 2.4% 0.03308.0 KB 2.1% 0.09
Jul 26 11:00:00 - 11:59:59 141 3.6% 0.04469.8 KB 3.2% 0.13
Jul 26 12:00:00 - 12:59:59 151 3.8% 0.04455.1 KB 3.1% 0.13
Jul 26 13:00:00 - 13:59:59 154 3.9% 0.04482.4 KB 3.2% 0.13
Jul 26 14:00:00 - 14:59:59 157 4.0% 0.04668.3 KB 4.5% 0.19
Jul 26 15:00:00 - 15:59:59 168 4.3% 0.05518.2 KB 3.5% 0.14
Jul 26 16:00:00 - 16:59:59 182 4.6% 0.05606.8 KB 4.1% 0.17
Jul 26 17:00:00 - 17:59:59 198 5.0% 0.06682.8 KB 4.6% 0.19
Jul 26 18:00:00 - 18:59:59 242 6.2% 0.07977.3 KB 6.6% 0.27
Jul 26 19:00:00 - 19:59:59 248 6.3% 0.07816.1 KB 5.5% 0.23
Jul 26 20:00:00 - 20:59:59 217 5.5% 0.06600.7 KB 4.0% 0.17
Jul 26 21:00:00 - 21:59:59 197 5.0% 0.05765.7 KB 5.1% 0.21
Jul 26 22:00:00 - 22:59:59 249 6.3% 0.07704.8 KB 4.7% 0.20
Jul 26 23:00:00 - 23:59:59 206 5.2% 0.061.3 MB 8.8% 0.36
Jul 27 00:00:00 - 00:59:59 176 4.5% 0.05706.4 KB 4.7% 0.20
Jul 27 01:00:00 - 01:59:59 152 3.9% 0.04465.8 KB 3.1% 0.13
Jul 27 02:00:00 - 02:59:59 155 4.0% 0.04468.5 KB 3.1% 0.13
Jul 27 03:00:00 - 03:59:59 131 3.3% 0.04479.3 KB 3.2% 0.13
Jul 27 04:00:00 - 04:15:01 15 0.4% 0.0235.7 KB 0.2% 0.04
TOTAL: 24:00:00 3924 100.0% 0.0514.5 MB 100.0% 0.17
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1nntp.terraraq.uk 316 0 0 0 0 0 0 0 316
2news-out.aioe.org 99 1 0 0 0 0 0 0 98
3news.nntp4.net 36 0 0 0 0 0 0 0 36
4gegeweb-out.news.tnetconsulting.net 27 0 0 0 0 0 0 0 27
5i2pn.org 6 0 0 0 0 0 0 0 6
6usenet.pasdenom.info 5 0 0 0 0 0 0 0 5
7feed-out.gegeweb.org 2 0 0 0 0 0 0 0 2
TOTAL: 7 491 1 0 0 0 0 0 0 490

Unwanted newsgroups [Top 20]:

NewsgroupCount
news.test 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 206
Bad path (news.giganews.com.POSTED) 119
EMP (phn nph) 103
EMP (md5) 50
Cancel of non-existing ID <im8i5hF4ljvU1@mid.individual.net> 1
Cancels abusifs 1
User-issued spam cancel 1
TOTAL: 7 481

NoCeM on Spool:

IdGoodBadUniqueTotal
bleachbot@httrack.com7077
TOTAL: 17077

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news-out.aioe.org 7
feed-out.gegeweb.org 2
TOTAL: 2 9
TOTAL: 1 9

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1i2pn.org 7133 178 3521 140 0 0 2%23:59:56
2news.tnetconsulting.net 6804 39 3860 24 0 0 0%23:59:54
3news.pasdenom.info 4780 14 3004 7 0 2 0%23:59:56
4news.gegeweb.org 3444 5 3360 0 0 0 0%23:59:19
5news.nntp4.net 4580 5 3750 0 0 43 0%23:59:56
6nntp.terraraq.uk 2542 3 2385 0 0 0 0%23:59:56
7news.aioe.org 1720 3 1574 0 0 0 0%23:58:02
TOTAL: 7 31003 247 21454 171 0 45 0%167:56:59
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1i2pn.org371.6 KB280.4 KB652.0 KB0.0 KB/s2.1 KB23:59:56
2news.tnetconsulting.net88.9 KB59.6 KB148.5 KB0.0 KB/s2.4 KB23:59:54
3news.pasdenom.info41.1 KB47.9 KB89.0 KB0.0 KB/s4.2 KB23:59:56
4news.gegeweb.org23.9 KB0.0 KB23.9 KB0.0 KB/s4.8 KB23:59:19
5news.nntp4.net10.5 KB0.0 KB10.5 KB0.0 KB/s2.1 KB23:59:56
6news.aioe.org6.7 KB0.0 KB6.7 KB0.0 KB/s2.2 KB23:58:02
7nntp.terraraq.uk5.9 KB0.0 KB5.9 KB0.0 KB/s2.0 KB23:59:56
TOTAL: 7548.6 KB387.9 KB936.5 KB0.0 KB/s2.2 KB167:56:59
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1108b-gniel 7 3365.1 KB 10 3 000:21:46
TOTAL: 1 7 3365.1 KB 10 3 000:24:59

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1? 7 3365.1 KB 10 3 000:21:46
2*.gegeweb.eu 288 00.0 KB 0 0 000:02:57
3unresolved 16 00.0 KB 0 0 000:00:15
TOTAL: 3 311 3365.1 KB 10 3 000:24: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
108b-gniel 0.406 0.255 0.00000:21:46
mail.gegeweb.eu 8.301 9.313 3.38200:02:57
123.160.221.44 0.812 0.471 0.00000:00:14
88.165.5.23 0.054 0.066 0.00000:00:01
TOTAL: 4 9.573 10.105 3.38200:24:59

Curious NNRP server explorers [Top 20]:

SystemConn
mail.gegeweb.eu 288
123.160.221.44 14
88.165.5.23 2
TOTAL: 3 304

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
123.160.221.44 112
TOTAL: 1 112

NNRP unrecognized commands (by command):

CommandCount
Connection: keep-alive 14
Accept: text/html,application/xhtml+xml,... 14
User-Agent: Chrome/54.0 (Windows NT 10.0... 14
Cache-Control: max-age=0 14
Accept-Charset: GBK,utf-8;q=0.7,*;q=0.3 14
Connection: close 14
Accept-Language: zh-CN,zh;q=0.8 14
Host: mastodon.stoneartprod.xyz:563 1
Host: jitsi.niel.me:563 1
Host: news.niel.me:563 1
Host: 189-232-73-185.ftth.cust.kwaoo.net... 1
Host: niel.io:563 1
Host: 185.73.232.189:563 1
Host: stoneartprod.xyz:563 1
Host: mastodon.gegeweb.org:563 1
Host: home.niel.me:563 1
Host: jamulus.gegeweb.org:563 1
Host: jamulus.niel.me:563 1
Host: mastodon.gegeweb.eu:563 1
Host: home.gegeweb.org:563 1
Host: gegeweb.me:563 1
TOTAL: 21 112

Newsgroup request counts (by category):

CategoryCountPct
1fr 32 97.0%
2grisbi 1 3.0%
TOTAL: 2 33100.0%

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

NewsgroupCount
1fr.usenet.forums.evolution 29
2fr.comp.os.mac-os.x 2
3grisbi.test 1
4fr.comp.os.linux.debats 1
TOTAL: 4 33