Daily Usenet report for news.niel.me

May 22 04:15:02 -- May 23 04:15:01

Log entries by program:

Program nameLines%LinesSize%Size
inn 4626 43.2%789.8 KB 46.8%
innd 2560 23.9%403.4 KB 23.9%
nnrpd 1949 18.2%206.7 KB 12.3%
innfeed 1561 14.6%285.4 KB 16.9%
nocem 5 0.0%0.5 KB 0.0%
controlchan 1 0.0%0.2 KB 0.0%
TOTAL: 6 10702 100.0%1.6 MB100.0%

History cache:

ReasonCount%Count
Positive hits 23077 66.5%
Negative hits 7054 20.3%
Do not exist 4563 13.2%
Cache misses 2 0.0%
TOTAL: 4 34696 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.033 0.0%16 0.000 2.062 16.000
article cancel00:00:00.003 0.0%19 0.000 0.158 1.000
article cleanup00:00:00.095 0.0%4579 0.000 0.021 0.143
article logging00:00:00.365 0.0%4600 0.000 0.079 0.235
article parse00:00:00.728 0.0%7673 0.000 0.095 0.405
article write00:00:02.725 0.0%3852 0.182 0.707 7.400
artlog/artcncl00:00:00.000 0.0%16 0.000 0.000 0.000
artlog/artcncl/perl00:00:00.002 0.0%16 0.000 0.125 1.000
data move00:00:00.098 0.0%37911 0.000 0.003 0.014
hisgrep/artcncl00:00:00.000 0.0%19 0.000 0.000 0.000
hisgrep/artcncl/perl00:00:00.000 0.0%16 0.000 0.000 0.000
hisgrep/perl00:00:00.001 0.0%19 0.000 0.053 0.200
hishave/artcncl00:00:00.000 0.0%19 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.000 0.0%16 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.502 0.0%34805 0.000 0.014 0.056
history sync00:00:00.064 0.0%409 0.000 0.156 8.500
history write00:00:01.046 0.0%4579 0.050 0.228 0.714
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle24:00:25.666 99.9%38357 872.164 2253.191 8837.088
nntp read00:00:01.253 0.0%37747 0.006 0.033 0.078
overview write00:00:02.745 0.0%3852 0.118 0.713 5.200
perl filter00:00:23.304 0.0%4579 3.340 5.089 32.389
python filter00:00:00.022 0.0%7578 0.000 0.003 0.059
site send00:00:01.111 0.0%7711 0.000 0.144 0.463
TOTAL: 24:01:12.42624:00:59.763100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.057 0.0%3830 0.000 0.015 0.133
article prepare00:00:00.002 0.0%1792 0.000 0.001 0.028
article read00:00:00.063 0.0%390 0.000 0.162 7.000
backlog stats00:00:00.128 0.0%63048 0.000 0.002 0.011
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.771 0.0%34694 0.000 0.022 0.059
data write00:00:02.244 0.0%30800 0.025 0.073 0.119
idle23:50:07.209100.0%63048 539.984 1360.982 3810.785
status file00:00:00.326 0.0%165 0.000 1.976 7.000
TOTAL: 23:50:13.64623:50:10.800100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:08:14.833 96.5%1528 6.400 323.844 12754.241
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.117 0.0%3679 0.000 0.032 0.182
readart00:00:00.013 0.0%27 0.000 0.481 0.800
TOTAL: 00:08:32.73900:08:14.963 96.5%----

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 3 3645 1841 1731 73 50%24:32:31
2feed-out.gegeweb.org 2 2791 661 2130 0 23%23:59:58
3usenet.pasdenom.info 6 5583 545 5035 3 9%43:43:23
4nntp.terraraq.uk 2 4139 520 3066 553 12%26:16:52
5i2pn.org 2 7984 221 7743 20 2%45:49:18
6news.nntp4.net 3 4051 205 3728 118 5%23:02:16
7gegeweb-out.news.tnetconsulting.net 1 4150 17 4107 26 0%23:59:51
8localhost 27 0 0 0 0 0%00:00:00
TOTAL: 8 46 32343 4010 27540 793 12%211:24:09
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news-out.aioe.org6.2 MB0.0 KB292.5 KB6.4 MB 95%3.4 KB
2nntp.terraraq.uk2.8 MB0.0 KB3.4 MB6.2 MB 45%5.9 KB
3usenet.pasdenom.info1.5 MB0.0 KB8.9 KB1.5 MB 99%2.7 KB
4feed-out.gegeweb.org1.4 MB0.0 KB0.0 KB1.4 MB100%2.2 KB
5news.nntp4.net1.1 MB0.0 KB368.2 KB1.4 MB 74%4.5 KB
6i2pn.org796.4 KB0.0 KB72.5 KB868.9 KB 91%3.6 KB
7gegeweb-out.news.tnetconsulting.net151.9 KB0.0 KB135.0 KB287.0 KB 52%6.7 KB
8localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 813.9 MB0.0 KB4.2 MB18.1 MB 76%3.9 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 22 04:15:02 - 04:59:59 97 2.5% 0.04303.0 KB 2.2% 0.11
May 22 05:00:00 - 05:59:59 108 2.8% 0.03573.1 KB 4.2% 0.16
May 22 06:00:00 - 06:59:59 204 5.3% 0.06638.2 KB 4.6% 0.18
May 22 07:00:00 - 07:59:59 114 3.0% 0.03468.9 KB 3.4% 0.13
May 22 08:00:00 - 08:59:59 104 2.7% 0.03461.0 KB 3.3% 0.13
May 22 09:00:00 - 09:59:59 127 3.3% 0.04788.5 KB 5.7% 0.22
May 22 10:00:00 - 10:59:59 96 2.5% 0.03432.6 KB 3.1% 0.12
May 22 11:00:00 - 11:59:59 132 3.4% 0.04410.6 KB 3.0% 0.11
May 22 12:00:00 - 12:59:59 115 3.0% 0.03349.2 KB 2.5% 0.10
May 22 13:00:00 - 13:59:59 117 3.0% 0.03331.0 KB 2.4% 0.09
May 22 14:00:00 - 14:59:59 160 4.2% 0.04523.3 KB 3.8% 0.15
May 22 15:00:00 - 15:59:59 169 4.4% 0.05447.7 KB 3.2% 0.12
May 22 16:00:00 - 16:59:59 162 4.2% 0.04532.1 KB 3.9% 0.15
May 22 17:00:00 - 17:59:59 212 5.5% 0.06622.9 KB 4.5% 0.17
May 22 18:00:00 - 18:59:59 233 6.1% 0.06692.2 KB 5.0% 0.19
May 22 19:00:00 - 19:59:59 195 5.1% 0.05750.3 KB 5.4% 0.21
May 22 20:00:00 - 20:59:59 218 5.7% 0.06693.6 KB 5.0% 0.19
May 22 21:00:00 - 21:59:59 274 7.1% 0.08883.3 KB 6.4% 0.25
May 22 22:00:00 - 22:59:59 251 6.5% 0.07787.3 KB 5.7% 0.22
May 22 23:00:00 - 23:59:59 178 4.6% 0.05963.6 KB 7.0% 0.27
May 23 00:00:00 - 00:59:59 190 4.9% 0.05706.4 KB 5.1% 0.20
May 23 01:00:00 - 01:59:59 150 3.9% 0.04522.0 KB 3.8% 0.14
May 23 02:00:00 - 02:59:59 121 3.1% 0.03491.5 KB 3.6% 0.14
May 23 03:00:00 - 03:59:59 96 2.5% 0.03312.3 KB 2.3% 0.09
May 23 04:00:00 - 04:15:01 24 0.6% 0.03104.1 KB 0.8% 0.12
TOTAL: 23:59:59 3847 100.0% 0.0413.5 MB 100.0% 0.16
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1nntp.terraraq.uk 505 0 0 0 0 0 0 0 505
2news.nntp4.net 123 1 0 0 0 0 0 0 122
3news-out.aioe.org 94 3 0 0 0 0 0 0 91
4i2pn.org 11 0 0 0 0 0 0 0 11
5gegeweb-out.news.tnetconsulting.net 8 0 0 0 0 0 0 0 8
6usenet.pasdenom.info 6 0 0 0 0 0 0 0 6
TOTAL: 6 747 4 0 0 0 0 0 0 743

Unwanted newsgroups [Top 20]:

NewsgroupCount
fr.petites-annonces.divers 2
fr.petites-annonces.informatique.materiel 1
news.test 1
TOTAL: 3 4

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 249
EMP (phl) 165
EMP (md5) 124
Bad path (news.giganews.com.POSTED) 112
EMP (phn nph) 58
User-issued spam cancel 11
HTML Multipart 1
Cancel of non-existing ID <822d4bb0-1d52-46e7-b9fd-d51786f24fadn@googlegroups.com> 1
Cancel of non-existing ID <60a93c67$0$21597$426a74cc@news.free.fr> 1
Cancel of non-existing ID <60a8afc6$0$12712$426a74cc@news.free.fr> 1
TOTAL: 10 723

NoCeM on Spool:

IdGoodBadUniqueTotal
bleachbot@httrack.com3033
TOTAL: 13033

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news-out.aioe.org 19
i2pn.org 1
TOTAL: 2 20
TOTAL: 1 20

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1i2pn.org 6912 158 3448 110 0 0 2%23:59:57
2news.tnetconsulting.net 6742 81 3743 22 0 1 1%23:59:57
3news.pasdenom.info 4684 50 2973 6 0 1 1%23:59:57
4news.gegeweb.org 3283 13 3163 0 0 0 0%23:59:57
5news.aioe.org 2132 3 1727 0 0 0 0%23:55:08
6news.nntp4.net 4313 3 3681 0 0 0 0%23:59:25
7nntp.terraraq.uk 2553 2 2291 0 0 0 0%23:59:27
TOTAL: 7 30619 310 21026 138 0 2 1%167:53:48
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1i2pn.org346.2 KB221.0 KB567.1 KB0.0 KB/s2.1 KB23:59:57
2news.tnetconsulting.net288.0 KB74.5 KB362.5 KB0.0 KB/s3.5 KB23:59:57
3news.pasdenom.info136.3 KB23.7 KB160.0 KB0.0 KB/s2.9 KB23:59:57
4news.gegeweb.org40.6 KB0.0 KB40.6 KB0.0 KB/s3.1 KB23:59:57
5news.aioe.org15.8 KB0.0 KB15.8 KB0.0 KB/s5.3 KB23:55:08
6news.nntp4.net10.5 KB0.0 KB10.5 KB0.0 KB/s3.5 KB23:59:25
7nntp.terraraq.uk3.3 KB0.0 KB3.3 KB0.0 KB/s1.6 KB23:59:27
TOTAL: 7840.6 KB319.2 KB1.1 MB0.0 KB/s2.6 KB167:53:48
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1mbp-gniel.niel.me 3 1627.8 KB 5 0 000:07:53
TOTAL: 1 3 1627.8 KB 5 0 000:08:32

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.niel.me 3 1627.8 KB 5 0 000:07:53
2*.gegeweb.eu 288 00.0 KB 0 0 000:00:25
3unresolved 6 00.0 KB 0 0 000:00:12
4*.ch1.censys-scanner.com 2 00.0 KB 0 0 000:00:01
TOTAL: 4 299 1627.8 KB 5 0 000:08:32

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.141 0.084 0.00000:07:53
mail.gegeweb.eu 7.897 8.899 3.00900:00:25
192.241.210.108 0.032 0.021 0.00000:00:09
88.165.5.23 0.116 0.062 0.00000:00:01
scanner-04.ch1.censys-scanner.com 0.042 0.031 0.00000:00:00
scanner-21.ch1.censys-scanner.com 0.031 0.021 0.00000:00:00
45.141.87.59 0.034 0.022 0.00000:00:00
94.232.46.213 0.038 0.019 0.00000:00:00
TOTAL: 8 8.331 9.159 3.00900:08:32

Curious NNRP server explorers [Top 20]:

SystemConn
mail.gegeweb.eu 288
88.165.5.23 3
45.141.87.59 1
192.241.210.108 1
scanner-21.ch1.censys-scanner.com 1
94.232.46.213 1
scanner-04.ch1.censys-scanner.com 1
TOTAL: 7 296

NNRP unrecognized commands (by host):

SystemConn
scanner-04.ch1.censys-scanner.com 1
94.232.46.213 1
45.141.87.59 1
TOTAL: 3 3

NNRP unrecognized commands (by command):

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

NNRP client timeouts [Top 20]:

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

Newsgroup request counts (by category):

CategoryCountPct
1fr 15 93.8%
2comp 1 6.2%
TOTAL: 2 16100.0%

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

NewsgroupCount
1fr.usenet.forums.evolution 12
2fr.comp.os.linux.debats 3
3comp.sys.raspberry-pi 1
TOTAL: 3 16