Daily Usenet report for news.niel.me

Jun 30 04:15:02 -- Jul 1 04:15:01

Log entries by program:

Program nameLines%LinesSize%Size
inn 5046 46.0%889.0 KB 50.2%
innd 2513 22.9%396.0 KB 22.4%
nnrpd 1833 16.7%195.9 KB 11.1%
innfeed 1548 14.1%286.5 KB 16.2%
nocem 19 0.2%1.7 KB 0.1%
controlchan 6 0.1%1.2 KB 0.1%
TOTAL: 6 10965 100.0%1.7 MB100.0%

History cache:

ReasonCount%Count
Positive hits 27200 68.6%
Negative hits 7475 18.8%
Do not exist 4994 12.6%
Cache misses 3 0.0%
TOTAL: 4 39672 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.028 0.0%14 1.000 2.000 9.000
article cancel00:00:00.010 0.0%29 0.000 0.345 1.000
article cleanup00:00:00.112 0.0%4998 0.000 0.022 0.095
article logging00:00:00.399 0.0%5004 0.000 0.080 0.214
article parse00:00:00.773 0.0%8084 0.000 0.096 0.196
article write00:00:02.913 0.0%4469 0.242 0.652 3.409
artlog/artcncl00:00:00.004 0.0%29 0.000 0.138 1.000
artlog/artcncl/perl00:00:00.002 0.0%14 0.000 0.143 0.500
data move00:00:00.100 0.0%42046 0.000 0.002 0.012
hisgrep/artcncl00:00:00.001 0.0%18 0.000 0.056 1.000
hisgrep/artcncl/perl00:00:00.000 0.0%14 0.000 0.000 0.000
hisgrep/perl00:00:00.001 0.0%16 0.000 0.062 1.000
hishave/artcncl00:00:00.000 0.0%29 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.000 0.0%14 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.595 0.0%39745 0.000 0.015 0.043
history sync00:00:00.042 0.0%412 0.000 0.102 0.667
history write00:00:01.059 0.0%4998 0.033 0.212 1.143
hiswrite/artcncl00:00:00.004 0.0%11 0.000 0.364 1.000
idle24:00:30.822 99.9%43020 937.741 2009.085 5006.492
nntp read00:00:01.345 0.0%42635 0.004 0.032 0.083
overview write00:00:02.753 0.0%4469 0.136 0.616 6.048
perl filter00:00:22.859 0.0%4998 3.562 4.574 9.700
python filter00:00:00.015 0.0%8743 0.000 0.002 0.036
site send00:00:01.251 0.0%8958 0.000 0.140 0.462
TOTAL: 24:01:18.78324:01:05.088100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.052 0.0%4454 0.000 0.012 0.111
article prepare00:00:00.003 0.0%1912 0.000 0.002 0.050
article read00:00:00.073 0.0%409 0.000 0.178 7.000
backlog stats00:00:00.149 0.0%71181 0.000 0.002 0.016
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.925 0.0%39888 0.000 0.023 0.051
data write00:00:02.618 0.0%35378 0.045 0.074 0.121
idle23:50:21.244100.0%71181 537.275 1205.676 2970.975
status file00:00:00.446 0.0%167 1.000 2.671 9.000
TOTAL: 23:50:28.59523:50:25.510100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:09:33.903 97.1%1493 6.400 384.396 13182.429
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.121 0.0%3436 0.000 0.035 0.273
readart00:00:00.030 0.0%24 1.250 1.250 1.250
TOTAL: 00:09:51.23000:09:34.054 97.1%----

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
us-control@lists.killfile.org001001
TOTAL001001

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1news-out.aioe.org 5 4577 2313 2203 61 50%25:13:57
2usenet.pasdenom.info 10 8339 966 7368 5 11%53:35:15
3feed-out.gegeweb.org 3 3083 736 2347 0 23%23:59:11
4news.nntp4.net 7 4473 310 4042 121 6%23:30:28
5nntp.terraraq.uk 5 3396 238 2921 237 7%21:53:10
6i2pn.org 5 7813 125 7676 12 1%43:08:55
7gegeweb-out.news.tnetconsulting.net 6 6882 45 6721 116 0%38:08:38
8localhost 30 0 0 0 0 0%00:00:00
TOTAL: 8 71 38563 4733 33278 552 12%229:29:34
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news-out.aioe.org6.8 MB0.0 KB182.7 KB7.0 MB 97%3.0 KB
2news.nntp4.net3.1 MB0.0 KB862.6 KB4.0 MB 78%9.4 KB
3usenet.pasdenom.info2.4 MB0.0 KB10.5 KB2.4 MB 99%2.5 KB
4feed-out.gegeweb.org1.8 MB0.0 KB0.0 KB1.8 MB100%2.6 KB
5nntp.terraraq.uk1.2 MB0.0 KB1.1 MB2.3 MB 52%4.9 KB
6i2pn.org500.4 KB3.5 KB82.8 KB586.8 KB 85%4.3 KB
7gegeweb-out.news.tnetconsulting.net267.0 KB0.0 KB396.6 KB663.5 KB 40%4.1 KB
8localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 816.1 MB3.5 KB2.6 MB18.7 MB 86%3.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jun 30 04:15:02 - 04:59:59 75 1.7% 0.03265.4 KB 1.7% 0.10
Jun 30 05:00:00 - 05:59:59 91 2.0% 0.03368.1 KB 2.3% 0.10
Jun 30 06:00:00 - 06:59:59 108 2.4% 0.03538.0 KB 3.4% 0.15
Jun 30 07:00:00 - 07:59:59 110 2.5% 0.03405.8 KB 2.5% 0.11
Jun 30 08:00:00 - 08:59:59 146 3.3% 0.04539.8 KB 3.4% 0.15
Jun 30 09:00:00 - 09:59:59 158 3.5% 0.04468.4 KB 2.9% 0.13
Jun 30 10:00:00 - 10:59:59 179 4.0% 0.051.3 MB 8.5% 0.37
Jun 30 11:00:00 - 11:59:59 170 3.8% 0.05581.0 KB 3.7% 0.16
Jun 30 12:00:00 - 12:59:59 164 3.7% 0.05467.2 KB 2.9% 0.13
Jun 30 13:00:00 - 13:59:59 141 3.2% 0.04344.8 KB 2.2% 0.10
Jun 30 14:00:00 - 14:59:59 190 4.3% 0.05539.0 KB 3.4% 0.15
Jun 30 15:00:00 - 15:59:59 194 4.3% 0.05603.5 KB 3.8% 0.17
Jun 30 16:00:00 - 16:59:59 218 4.9% 0.06572.6 KB 3.6% 0.16
Jun 30 17:00:00 - 17:59:59 245 5.5% 0.07783.9 KB 4.9% 0.22
Jun 30 18:00:00 - 18:59:59 263 5.9% 0.07748.9 KB 4.7% 0.21
Jun 30 19:00:00 - 19:59:59 221 4.9% 0.06595.7 KB 3.7% 0.17
Jun 30 20:00:00 - 20:59:59 228 5.1% 0.06663.1 KB 4.2% 0.18
Jun 30 21:00:00 - 21:59:59 316 7.1% 0.091.2 MB 7.9% 0.35
Jun 30 22:00:00 - 22:59:59 297 6.6% 0.081.4 MB 8.8% 0.39
Jun 30 23:00:00 - 23:59:59 260 5.8% 0.07821.3 KB 5.2% 0.23
Jul 1 00:00:00 - 00:59:59 149 3.3% 0.04608.5 KB 3.8% 0.17
Jul 1 01:00:00 - 01:59:59 187 4.2% 0.05565.8 KB 3.6% 0.16
Jul 1 02:00:00 - 02:59:59 147 3.3% 0.04561.1 KB 3.5% 0.16
Jul 1 03:00:00 - 03:59:59 183 4.1% 0.05756.5 KB 4.8% 0.21
Jul 1 04:00:00 - 04:15:01 29 0.6% 0.03102.7 KB 0.6% 0.11
TOTAL: 23:59:59 4469 100.0% 0.0515.5 MB 100.0% 0.18
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1nntp.terraraq.uk 244 0 0 0 0 0 0 0 244
2news.nntp4.net 114 0 0 0 0 0 0 0 114
3gegeweb-out.news.tnetconsulting.net 101 0 0 0 0 0 0 0 101
4news-out.aioe.org 59 1 0 0 0 0 0 0 58
5i2pn.org 8 0 0 0 0 0 0 0 8
6usenet.pasdenom.info 7 0 0 0 0 0 0 0 7
7feed-out.gegeweb.org 2 0 0 0 0 0 0 0 2
TOTAL: 7 535 1 0 0 0 0 0 0 534

Unwanted newsgroups [Top 20]:

NewsgroupCount
news.test 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 217
EMP (phn nph) 101
Bad path (news.giganews.com.POSTED) 94
EMP (md5) 89
EMP (phl) 20
User-issued spam cancel 3
Cancel of <sbi2lb$mtri$1@pasdenom.info> without Cancel-Key 1
Too many test groups in crosspost 1
HTML Multipart 1
Cancel of <sbi27d$fg1$1@pi2.pasdenom.info> without Cancel-Key 1
TOTAL: 10 528

NoCeM on Spool:

IdGoodBadUniqueTotal
bleachbot@httrack.com1401414
TOTAL: 11401414

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
feed-out.gegeweb.org 2
news-out.aioe.org 2
usenet.pasdenom.info 2
TOTAL: 3 6
TOTAL: 1 6

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1i2pn.org 8125 207 4048 136 0 0 2%23:59:51
2news.tnetconsulting.net 7960 67 4380 22 0 0 0%23:59:57
3news.pasdenom.info 5304 22 3491 8 0 0 0%23:59:57
4news.gegeweb.org 3792 8 3715 0 0 0 0%23:59:57
5news.aioe.org 1962 3 1804 1 0 0 0%23:56:31
6nntp.terraraq.uk 3154 3 2808 0 0 0 0%23:59:57
7news.nntp4.net 4835 1 4180 0 0 0 0%23:59:56
TOTAL: 7 35132 311 24426 167 0 0 0%167:56:06
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1i2pn.org480.6 KB276.5 KB757.1 KB0.0 KB/s2.2 KB23:59:51
2news.tnetconsulting.net191.9 KB56.1 KB248.0 KB0.0 KB/s2.8 KB23:59:57
3news.gegeweb.org89.5 KB0.0 KB89.5 KB0.0 KB/s11.2 KB23:59:57
4news.pasdenom.info45.2 KB112.9 KB158.1 KB0.0 KB/s5.3 KB23:59:57
5nntp.terraraq.uk15.4 KB0.0 KB15.4 KB0.0 KB/s5.1 KB23:59:57
6news.aioe.org5.2 KB4.4 KB9.6 KB0.0 KB/s2.4 KB23:56:31
7news.nntp4.net3.3 KB0.0 KB3.3 KB0.0 KB/s3.3 KB23:59:56
TOTAL: 7831.1 KB449.9 KB1.3 MB0.0 KB/s2.7 KB167:56:06
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1mbp-gniel.niel.me 1 1528.9 KB 6 0 000:09:13
TOTAL: 1 1 1528.9 KB 6 0 000:09:50

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.niel.me 1 1528.9 KB 6 0 000:09:13
2*.ch1.censys-scanner.com 3 00.0 KB 0 0 000:00:01
3unresolved 4 00.0 KB 0 0 000:00:13
4*.gegeweb.eu 288 00.0 KB 0 0 000:00:22
TOTAL: 4 296 1528.9 KB 6 0 000:09:50

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.046 0.046 0.00000:09:13
mail.gegeweb.eu 8.511 8.712 3.09800:00:22
192.241.213.194 0.019 0.039 0.00000:00:09
221.226.241.26 0.083 0.024 0.00000:00:01
scanner-05.ch1.censys-scanner.com 0.064 0.064 0.00000:00:01
195.3.147.58 0.033 0.025 0.00000:00:01
scanner-21.ch1.censys-scanner.com 0.023 0.035 0.00000:00:00
88.165.5.23 0.000 0.057 0.00000:00:00
TOTAL: 8 8.779 9.002 3.09800:09:50

Curious NNRP server explorers [Top 20]:

SystemConn
mail.gegeweb.eu 288
scanner-05.ch1.censys-scanner.com 2
192.241.213.194 1
221.226.241.26 1
scanner-21.ch1.censys-scanner.com 1
195.3.147.58 1
88.165.5.23 1
TOTAL: 7 295

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

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

NNRP unrecognized commands (by command):

CommandCount
#003 1
EHLO www.censys.io 1
TOTAL: 2 2

NNRP client timeouts [Top 20]:

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

Newsgroup request counts (by category):

CategoryCountPct
1fr 10 66.7%
2news 3 20.0%
3grisbi 2 13.3%
TOTAL: 3 15100.0%

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

NewsgroupCount
1fr.usenet.forums.evolution 6
2fr.comp.usenet.serveurs 3
3grisbi.test 2
4news.announce.newgroups 2
5news.admin.announce 1
6fr.misc.transport.velo 1
TOTAL: 6 15
innreport from INN 2.6.4 based on work (c) 1996-1999 by Fabien Tassin <fta@sofaraway.org>
Local contact: usenet@niel.me