Daily Usenet report for news.niel.me

Oct 11 04:15:02 -- Oct 12 04:15:01

Log entries by program:

Program nameLines%LinesSize%Size
inn 5320 42.3%897.2 KB 46.5%
innd 3748 29.8%567.2 KB 29.4%
nnrpd 1952 15.5%213.5 KB 11.1%
innfeed 1560 12.4%252.4 KB 13.1%
nocem 1 0.0%0.2 KB 0.0%
controlchan 1 0.0%0.0 KB 0.0%
TOTAL: 6 12582 100.0%1.9 MB100.0%

History cache:

ReasonCount%Count
Positive hits 24187 64.6%
Negative hits 7977 21.3%
Do not exist 5258 14.0%
Cache misses 12 0.0%
TOTAL: 4 37434 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.739 0.0%15 1.000 49.267 719.000
article cancel00:00:00.005 0.0%16 0.000 0.312 1.000
article cleanup00:00:00.113 0.0%5269 0.000 0.021 0.182
article logging00:00:00.430 0.0%5294 0.000 0.081 0.250
article parse00:00:00.994 0.0%9383 0.000 0.106 0.235
article write00:00:03.052 0.0%4471 0.143 0.683 4.861
artlog/artcncl00:00:00.001 0.0%16 0.000 0.062 1.000
artlog/artcncl/perl00:00:00.001 0.0%15 0.000 0.067 0.143
data move00:00:00.114 0.0%41832 0.000 0.003 0.015
hisgrep/artcncl00:00:00.001 0.0%16 0.000 0.062 0.143
hisgrep/artcncl/perl00:00:00.001 0.0%15 0.000 0.067 1.000
hisgrep/perl00:00:00.000 0.0%16 0.000 0.000 0.000
hishave/artcncl00:00:00.000 0.0%16 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.000 0.0%15 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.569 0.0%37486 0.000 0.015 0.038
history sync00:00:00.054 0.0%411 0.000 0.131 1.000
history write00:00:01.206 0.0%5269 0.053 0.229 0.635
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle24:00:20.346 99.9%42212 742.981 2047.293 7141.917
nntp read00:00:01.421 0.0%41631 0.008 0.034 0.090
overview write00:00:02.956 0.0%4471 0.053 0.661 5.647
perl filter00:00:24.618 0.0%5269 2.688 4.672 27.312
python filter00:00:00.007 0.0%5269 0.000 0.001 0.050
site send00:00:01.657 0.0%8946 0.000 0.185 0.440
TOTAL: 24:01:13.21824:00:58.285100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.059 0.0%4590 0.000 0.013 0.167
article prepare00:00:00.001 0.0%1148 0.000 0.001 0.083
article read00:00:00.047 0.0%257 0.000 0.183 7.000
backlog stats00:00:00.118 0.0%63323 0.000 0.002 0.010
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.861 0.0%36815 0.004 0.023 0.081
data write00:00:02.371 0.0%32266 0.026 0.073 0.119
idle23:58:08.891100.0%63323 682.392 1362.679 5481.491
status file00:00:00.467 0.0%174 1.000 2.684 16.500
TOTAL: 23:58:16.32623:58:12.815100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:05:07.383 75.1%1224 19.250 251.130 6804.400
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.105 0.0%2995 0.000 0.035 1.000
readart00:00:00.029 0.0%21 1.357 1.381 1.429
TOTAL: 00:06:49.36500:05:07.517 75.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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1news-out.aioe.org 1 4926 2413 2373 140 48%25:57:41
2i2pn.org 2 4699 1012 3558 129 21%23:08:32
3feed-out.gegeweb.org 291 3092 378 2692 22 12%23:55:56
4news.nntp4.net 2 4874 341 4373 160 6%23:11:13
5nntp.terraraq.uk 3 2909 237 2429 243 8%19:41:52
6usenet.pasdenom.info 4 6048 160 5885 3 2%38:49:33
7gegeweb-out.news.tnetconsulting.net 1 4193 19 4170 4 0%23:57:16
8localhost 25 0 0 0 0 0%00:00:00
TOTAL: 8 329 30741 4560 25480 701 14%178:42:03
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news-out.aioe.org8.0 MB0.0 KB398.0 KB8.4 MB 95%3.4 KB
2i2pn.org3.7 MB0.0 KB540.0 KB4.2 MB 87%3.8 KB
3news.nntp4.net3.6 MB0.0 KB354.2 KB3.9 MB 91%8.0 KB
4nntp.terraraq.uk2.4 MB0.0 KB1.2 MB3.6 MB 66%7.8 KB
5feed-out.gegeweb.org1.2 MB0.0 KB24.4 KB1.2 MB 97%3.0 KB
6usenet.pasdenom.info362.2 KB0.0 KB10.2 KB372.4 KB 97%2.3 KB
7gegeweb-out.news.tnetconsulting.net360.1 KB0.0 KB9.3 KB369.4 KB 97%16.1 KB
8localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 819.6 MB0.0 KB2.5 MB22.1 MB 88%4.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 11 04:15:02 - 04:59:59 132 3.0% 0.05386.3 KB 1.9% 0.14
Oct 11 05:00:00 - 05:59:59 79 1.8% 0.02242.9 KB 1.2% 0.07
Oct 11 06:00:00 - 06:59:59 92 2.1% 0.03601.5 KB 2.9% 0.17
Oct 11 07:00:00 - 07:59:59 111 2.5% 0.03323.0 KB 1.5% 0.09
Oct 11 08:00:00 - 08:59:59 140 3.1% 0.04506.3 KB 2.4% 0.14
Oct 11 09:00:00 - 09:59:59 116 2.6% 0.03420.7 KB 2.0% 0.12
Oct 11 10:00:00 - 10:59:59 184 4.1% 0.051.2 MB 5.8% 0.34
Oct 11 11:00:00 - 11:59:59 169 3.8% 0.05673.4 KB 3.2% 0.19
Oct 11 12:00:00 - 12:59:59 146 3.3% 0.04489.9 KB 2.3% 0.14
Oct 11 13:00:00 - 13:59:59 135 3.0% 0.04389.8 KB 1.9% 0.11
Oct 11 14:00:00 - 14:59:59 224 5.0% 0.06758.9 KB 3.6% 0.21
Oct 11 15:00:00 - 15:59:59 227 5.1% 0.061.3 MB 6.5% 0.38
Oct 11 16:00:00 - 16:59:59 196 4.4% 0.05702.1 KB 3.4% 0.20
Oct 11 17:00:00 - 17:59:59 222 5.0% 0.06926.2 KB 4.4% 0.26
Oct 11 18:00:00 - 18:59:59 300 6.7% 0.08907.4 KB 4.3% 0.25
Oct 11 19:00:00 - 19:59:59 254 5.7% 0.072.2 MB 10.7% 0.62
Oct 11 20:00:00 - 20:59:59 289 6.5% 0.081.2 MB 5.9% 0.34
Oct 11 21:00:00 - 21:59:59 270 6.0% 0.071.3 MB 6.4% 0.37
Oct 11 22:00:00 - 22:59:59 213 4.8% 0.06704.9 KB 3.4% 0.20
Oct 11 23:00:00 - 23:59:59 263 5.9% 0.07884.8 KB 4.2% 0.25
Oct 12 00:00:00 - 00:59:59 207 4.6% 0.062.2 MB 10.7% 0.62
Oct 12 01:00:00 - 01:59:59 197 4.4% 0.051.1 MB 5.6% 0.32
Oct 12 02:00:00 - 02:59:59 131 2.9% 0.04534.3 KB 2.6% 0.15
Oct 12 03:00:00 - 03:59:59 128 2.9% 0.04488.9 KB 2.3% 0.14
Oct 12 04:00:00 - 04:15:01 41 0.9% 0.05138.8 KB 0.7% 0.15
TOTAL: 23:59:59 4466 100.0% 0.0520.4 MB 100.0% 0.24
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1nntp.terraraq.uk 337 0 0 0 0 0 0 0 337
2news.nntp4.net 157 0 0 0 0 0 0 0 157
3news-out.aioe.org 156 2 0 0 0 0 0 0 154
4i2pn.org 138 0 0 0 0 0 0 0 138
5feed-out.gegeweb.org 24 0 0 0 0 0 0 0 24
6gegeweb-out.news.tnetconsulting.net 8 0 0 0 0 0 0 0 8
7usenet.pasdenom.info 3 0 0 0 0 0 0 0 3
TOTAL: 7 823 2 0 0 0 0 0 0 821

Unwanted newsgroups [Top 20]:

NewsgroupCount
news.test 1
fr.petites-annonces.divers 1
TOTAL: 2 2

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 246
EMP (phn nph) 193
Bad path (news.giganews.com.POSTED) 160
EMP (md5) 121
User-issued spam cancel 44
EMP (phl) 32
TOTAL: 6 796

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1i2pn.org 6302 79 3251 16 0 67 1%23:59:56
2news.tnetconsulting.net 7428 39 4418 5 0 54 0%23:59:25
3news.pasdenom.info 5260 21 3692 27 0 4 0%23:59:56
4news.gegeweb.org 4255 15 3936 82 0 0 0%23:59:56
5news.aioe.org 1813 3 1701 0 0 0 0%23:50:16
6nntp.terraraq.uk 2820 0 2764 0 0 3 0%23:58:58
7news.nntp4.net 4619 0 4123 0 0 1 0%23:57:04
TOTAL: 7 32497 157 23885 130 0 129 0%167:45:31
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1i2pn.org238.8 KB30.3 KB269.1 KB0.0 KB/s2.8 KB23:59:56
2news.tnetconsulting.net149.4 KB13.9 KB163.3 KB0.0 KB/s3.7 KB23:59:25
3news.pasdenom.info88.0 KB1.2 MB1.3 MB0.0 KB/s27.9 KB23:59:56
4news.gegeweb.org51.7 KB308.0 KB359.7 KB0.0 KB/s3.7 KB23:59:56
5news.aioe.org10.8 KB0.0 KB10.8 KB0.0 KB/s3.6 KB23:50:16
6nntp.terraraq.uk0.0 KB0.0 KB0.0 KB0.0 KB/s023:58:58
7news.nntp4.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:04
TOTAL: 7538.7 KB1.6 MB2.1 MB0.0 KB/s7.5 KB167:45:31
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1108b-gniel 2 1763.4 KB 9 0 000:04:42
TOTAL: 1 2 1763.4 KB 9 0 000:06:48

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1? 2 1763.4 KB 9 0 000:04:42
2*.gegeweb.eu 288 00.0 KB 0 0 000:01:59
3*.208-100-26.static.steadfastdns.net 10 00.0 KB 0 0 000:00:03
4unresolved 5 00.0 KB 0 0 000:00:03
TOTAL: 4 305 1763.4 KB 9 0 000:06:48

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.087 0.066 0.00000:04:42
sys.gegeweb.eu 8.098 8.669 3.01900:01:59
ip244.208-100-26.static.steadfastdns.net 0.186 0.153 0.00000:00:03
23.129.64.188 0.029 0.029 0.00000:00:02
94.102.49.159 0.056 0.019 0.00000:00:00
167.94.138.114 0.039 0.029 0.00000:00:00
45.146.166.156 0.067 0.055 0.00000:00:00
TOTAL: 7 8.562 9.020 3.01900:06:48

Curious NNRP server explorers [Top 20]:

SystemConn
sys.gegeweb.eu 288
ip244.208-100-26.static.steadfastdns.net 10
45.146.166.156 2
23.129.64.188 1
167.94.138.114 1
94.102.49.159 1
TOTAL: 6 303

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
45.146.166.156 1
167.94.138.114 1
TOTAL: 2 2

NNRP unrecognized commands (by command):

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

NNRP client timeouts [Top 20]:

SystemConnPeer
45.146.166.156 1 1
TOTAL: 1 1 1

Newsgroup request counts (by category):

CategoryCountPct
1fr 11 64.7%
2grisbi 3 17.6%
3comp 3 17.6%
TOTAL: 3 17100.0%

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

NewsgroupCount
1fr.rec.sport.cyclisme 4
2fr.comp.usenet.lecteurs-de-news 3
3comp.sys.raspberry-pi 3
4grisbi.bugsreports 2
5fr.usenet.distribution 2
6grisbi.test 1
7fr.usenet.forums.evolution 1
8fr.usenet.documents 1
TOTAL: 8 17