Daily Usenet report for news.niel.me

May 7 04:15:02 -- May 8 04:15:02

Log entries by program:

Program nameLines%LinesSize%Size
inn 5009 44.4%836.9 KB 47.7%
innd 2753 24.4%444.1 KB 25.3%
nnrpd 1944 17.2%215.0 KB 12.2%
innfeed 1568 13.9%259.1 KB 14.8%
controlchan 1 0.0%0.0 KB 0.0%
nocem 1 0.0%0.1 KB 0.0%
TOTAL: 6 11276 100.0%1.7 MB100.0%

History cache:

ReasonCount%Count
Positive hits 24303 66.6%
Negative hits 7311 20.0%
Do not exist 4900 13.4%
Cache misses 3 0.0%
TOTAL: 4 36517 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.022 0.0%19 0.000 1.158 4.000
article cancel00:00:00.006 0.0%19 0.000 0.316 1.000
article cleanup00:00:00.102 0.0%4912 0.000 0.021 0.143
article logging00:00:00.359 0.0%4976 0.000 0.072 0.238
article parse00:00:00.743 0.0%8098 0.000 0.092 0.312
article write00:00:02.509 0.0%3933 0.000 0.638 2.100
artlog/artcncl00:00:00.000 0.0%19 0.000 0.000 0.000
artlog/artcncl/perl00:00:00.001 0.0%19 0.000 0.053 0.200
data move00:00:00.118 0.0%39684 0.000 0.003 0.031
hisgrep/artcncl00:00:00.002 0.0%19 0.000 0.105 1.000
hisgrep/artcncl/perl00:00:00.001 0.0%19 0.000 0.053 1.000
hisgrep/perl00:00:00.003 0.0%36 0.000 0.083 0.231
hishave/artcncl00:00:00.000 0.0%19 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.000 0.0%19 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.538 0.0%36570 0.000 0.015 0.043
history sync00:00:00.057 0.0%412 0.000 0.138 1.667
history write00:00:01.054 0.0%4912 0.000 0.215 0.727
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle24:00:28.144 99.9%40042 683.228 2158.437 9685.145
nntp read00:00:01.300 0.0%39565 0.000 0.033 0.071
overview write00:00:02.992 0.0%3933 0.059 0.761 6.143
perl filter00:00:21.195 0.0%4912 1.869 4.315 7.385
python filter00:00:00.023 0.0%8248 0.000 0.003 0.071
site send00:00:01.236 0.0%7870 0.000 0.157 0.426
TOTAL: 24:01:12.31824:01:00.405100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.035 0.0%3938 0.000 0.009 0.091
article prepare00:00:00.001 0.0%1928 0.000 0.001 0.083
article read00:00:00.068 0.0%406 0.000 0.167 7.000
backlog stats00:00:00.136 0.0%63361 0.000 0.002 0.010
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.818 0.0%35050 0.000 0.023 0.066
data write00:00:02.394 0.0%31110 0.020 0.077 0.145
idle23:50:56.131100.0%63361 646.553 1355.031 5268.202
status file00:00:00.401 0.0%180 1.000 2.228 6.000
TOTAL: 23:51:02.87223:50:59.984100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:51.551 75.6%1510 6.000 34.140 9327.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.129 0.2%3618 0.000 0.036 0.636
readart00:00:00.007 0.0%3 2.333 2.333 2.333
TOTAL: 00:01:08.17200:00:51.687 75.8%----

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 3970 1929 1962 79 48%24:51:32
2feed-out.gegeweb.org 2 2854 720 2132 2 25%23:59:45
3usenet.pasdenom.info 4 4398 695 3694 9 15%33:12:05
4nntp.terraraq.uk 1 4032 422 3254 356 10%25:22:23
5news.nntp4.net 1 3957 107 3357 493 2%20:28:47
6i2pn.org 1 4195 59 4114 22 1%23:59:58
7gegeweb-out.news.tnetconsulting.net 1 3821 22 3765 34 0%23:59:56
8localhost 25 0 0 0 0 0%00:00:00
TOTAL: 8 37 27227 3954 22278 995 14%175:54:26
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news-out.aioe.org6.2 MB0.0 KB426.9 KB6.6 MB 93%3.4 KB
2nntp.terraraq.uk3.4 MB0.0 KB1.2 MB4.6 MB 74%6.0 KB
3news.nntp4.net2.4 MB0.0 KB767.3 KB3.1 MB 76%5.4 KB
4feed-out.gegeweb.org1.9 MB0.0 KB2.9 KB1.9 MB 99%2.7 KB
5usenet.pasdenom.info1.8 MB0.0 KB18.8 KB1.8 MB 99%2.7 KB
6gegeweb-out.news.tnetconsulting.net200.1 KB0.0 KB204.8 KB404.9 KB 49%7.2 KB
7i2pn.org162.0 KB0.0 KB71.2 KB233.2 KB 69%2.9 KB
8localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 816.0 MB0.0 KB2.6 MB18.7 MB 86%3.9 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 7 04:15:02 - 04:59:59 76 1.9% 0.03213.0 KB 1.4% 0.08
May 7 05:00:00 - 05:59:59 89 2.3% 0.02296.2 KB 1.9% 0.08
May 7 06:00:00 - 06:59:59 66 1.7% 0.02231.5 KB 1.5% 0.06
May 7 07:00:00 - 07:59:59 145 3.7% 0.04436.9 KB 2.9% 0.12
May 7 08:00:00 - 08:59:59 85 2.2% 0.02312.5 KB 2.1% 0.09
May 7 09:00:00 - 09:59:59 94 2.4% 0.03227.8 KB 1.5% 0.06
May 7 10:00:00 - 10:59:59 137 3.5% 0.04560.4 KB 3.7% 0.16
May 7 11:00:00 - 11:59:59 105 2.7% 0.03366.4 KB 2.4% 0.10
May 7 12:00:00 - 12:59:59 138 3.5% 0.04356.0 KB 2.3% 0.10
May 7 13:00:00 - 13:59:59 165 4.2% 0.05833.2 KB 5.5% 0.23
May 7 14:00:00 - 14:59:59 185 4.7% 0.05848.0 KB 5.6% 0.24
May 7 15:00:00 - 15:59:59 238 6.1% 0.07876.3 KB 5.8% 0.24
May 7 16:00:00 - 16:59:59 216 5.5% 0.06550.1 KB 3.6% 0.15
May 7 17:00:00 - 17:59:59 242 6.2% 0.07779.2 KB 5.1% 0.22
May 7 18:00:00 - 18:59:59 217 5.5% 0.06680.6 KB 4.5% 0.19
May 7 19:00:00 - 19:59:59 244 6.2% 0.071.7 MB 11.3% 0.48
May 7 20:00:00 - 20:59:59 213 5.4% 0.06798.3 KB 5.2% 0.22
May 7 21:00:00 - 21:59:59 224 5.7% 0.061.7 MB 11.3% 0.48
May 7 22:00:00 - 22:59:59 261 6.6% 0.07973.7 KB 6.4% 0.27
May 7 23:00:00 - 23:59:59 256 6.5% 0.07695.8 KB 4.6% 0.19
May 8 00:00:00 - 00:59:59 139 3.5% 0.04474.2 KB 3.1% 0.13
May 8 01:00:00 - 01:59:59 144 3.7% 0.04430.2 KB 2.8% 0.12
May 8 02:00:00 - 02:59:59 116 3.0% 0.03419.1 KB 2.8% 0.12
May 8 03:00:00 - 03:59:59 111 2.8% 0.03329.0 KB 2.2% 0.09
May 8 04:00:00 - 04:15:02 22 0.6% 0.0283.9 KB 0.6% 0.09
TOTAL: 24:00:00 3928 100.0% 0.0514.9 MB 100.0% 0.18
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 518 0 0 0 0 0 0 0 518
2nntp.terraraq.uk 345 0 0 0 0 0 0 0 345
3news-out.aioe.org 137 3 0 0 0 0 0 0 134
4gegeweb-out.news.tnetconsulting.net 14 0 0 0 0 0 0 0 14
5i2pn.org 11 0 0 0 0 0 0 0 11
6usenet.pasdenom.info 10 0 0 0 0 0 0 0 10
7feed-out.gegeweb.org 8 0 0 0 0 0 0 0 8
TOTAL: 7 1043 3 0 0 0 0 0 0 1040

Unwanted newsgroups [Top 20]:

NewsgroupCount
rec.travel.world 1
fr.petites-annonces.divers 1
news.test 1
TOTAL: 3 3

INND Perl filter [Top 20]:

ReasonCount
User-issued spam cancel 341
Too many newsgroups 218
EMP (phn nph) 157
Bad path (news.giganews.com.POSTED) 130
EMP (md5) 50
EMP (phl) 47
EMP (phn path) 14
Cancel of <s73mod$2dp$4@dont-email.me> without Cancel-Key 1
Cancel of <s6pcjj$cnc$4@dont-email.me> without Cancel-Key 1
Cancel of <s71jkk$99d$5@dont-email.me> without Cancel-Key 1
Cancel of <s6nfce$pb9$6@dont-email.me> without Cancel-Key 1
Cancel of <s71t2v$5eb$1@dont-email.me> without Cancel-Key 1
Cancel of <s73nn4$b6h$4@dont-email.me> without Cancel-Key 1
Cancel of non-existing ID <609533a8$0$6178$426a74cc@news.free.fr> 1
Cancel of <s7255p$lr3$6@dont-email.me> without Cancel-Key 1
Cancel of <s6pk8b$8lt$5@dont-email.me> without Cancel-Key 1
Cancel of <s716nj$89m$4@dont-email.me> without Cancel-Key 1
Cancel of <s72121$vnt$4@dont-email.me> without Cancel-Key 1
Cancel of <s723gp$grd$1@dont-email.me> without Cancel-Key 1
Cancel for rejected article 1
TOTAL: 26 976

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news-out.aioe.org 50
nntp.terraraq.uk 8
feed-out.gegeweb.org 6
TOTAL: 3 64
TOTAL: 1 64

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1i2pn.org 7211 172 3515 171 0 0 2%23:59:58
2news.tnetconsulting.net 6971 69 3828 29 0 23 0%23:59:58
3news.pasdenom.info 4612 18 3006 5 0 0 0%23:59:58
4nntp.terraraq.uk 2643 14 2377 0 0 0 0%23:59:21
5news.nntp4.net 4317 3 3810 0 0 0 0%23:59:40
6news.aioe.org 1757 1 1610 0 0 0 0%23:47:43
7news.gegeweb.org 3296 0 3202 0 0 0 0%23:59:55
TOTAL: 7 30807 277 21348 205 0 23 0%167:46:33
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1i2pn.org467.0 KB370.9 KB837.9 KB0.0 KB/s2.4 KB23:59:58
2news.tnetconsulting.net207.8 KB75.4 KB283.2 KB0.0 KB/s2.9 KB23:59:58
3news.pasdenom.info78.3 KB26.3 KB104.5 KB0.0 KB/s4.5 KB23:59:58
4nntp.terraraq.uk32.3 KB0.0 KB32.3 KB0.0 KB/s2.3 KB23:59:21
5news.nntp4.net11.2 KB0.0 KB11.2 KB0.0 KB/s3.7 KB23:59:40
6news.aioe.org1.3 KB0.0 KB1.3 KB0.0 KB/s1.3 KB23:47:43
7news.gegeweb.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:55
TOTAL: 7797.9 KB472.6 KB1.2 MB0.0 KB/s2.6 KB167:46:33
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1192.168.1.41 3 22.6 KB 2 0 000:00:30
TOTAL: 1 3 22.6 KB 2 0 000:01:07

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 7 22.6 KB 2 0 000:00:41
2*.w90-44.abo.wanadoo.fr 1 00.0 KB 0 0 000:00:00
3*.ch1.censys-scanner.com 3 00.0 KB 0 0 000:00:01
4*.gegeweb.eu 288 00.0 KB 0 0 000:00:23
TOTAL: 4 299 22.6 KB 2 0 000:01:07

NNRP auth users [Top 20]:

UserConn
mailman 288
TOTAL: 1 288

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
192.168.1.41 0.083 0.115 0.00000:00:30
mail.gegeweb.eu 8.075 8.564 3.12900:00:23
192.241.215.91 0.030 0.022 0.00000:00:09
88.165.5.23 0.082 0.090 0.00000:00:01
scanner-08.ch1.censys-scanner.com 0.049 0.068 0.00000:00:00
scanner-05.ch1.censys-scanner.com 0.018 0.018 0.00000:00:00
amontsouris-654-1-142-252.w90-44.abo.wanadoo.fr 0.020 0.039 0.00000:00:00
TOTAL: 7 8.357 8.916 3.12900:01:07

Curious NNRP server explorers [Top 20]:

SystemConn
mail.gegeweb.eu 288
88.165.5.23 3
scanner-08.ch1.censys-scanner.com 2
192.241.215.91 1
amontsouris-654-1-142-252.w90-44.abo.wanadoo.fr 1
scanner-05.ch1.censys-scanner.com 1
TOTAL: 6 296

NNRP unrecognized commands (by host):

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

NNRP unrecognized commands (by command):

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

Newsgroup request counts (by category):

CategoryCountPct
1fr 1 50.0%
2grisbi 1 50.0%
TOTAL: 2 2100.0%

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

NewsgroupCount
1grisbi.test 1
2fr.usenet.forums.evolution 1
TOTAL: 2 2