Daily Usenet report for news.niel.me

May 17 04:15:02 -- May 18 04:15:01

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

May 18 01:30:02 rpi-studio innd: filter: No Cancel-Key[sha1:DwwPMxC0ynAdsTO/gogYY//XiPc=] matches Cancel-Lock[sha1:LtkTY9Ypc1kGZaNuDtCnMu6DGgc=] target=<de-gruppen-finden-11.05.2024@dnqmail.priggish.de>

Log entries by program:

Program nameLines%LinesSize%Size
inn 2683 31.3%492.0 KB 35.7%
innd 2285 26.7%386.7 KB 28.1%
nnrpd 1868 21.8%204.9 KB 14.9%
innfeed 1732 20.2%292.3 KB 21.2%
controlchan 1 0.0%0.2 KB 0.0%
nocem 1 0.0%0.2 KB 0.0%
TOTAL: 6 8570 100.0%1.3 MB100.0%

History cache:

ReasonCount%Count
Positive hits 14413 60.1%
Negative hits 6916 28.8%
Do not exist 2653 11.1%
Cache misses 2 0.0%
TOTAL: 4 23984 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.005 0.0%9 0.000 0.556 1.000
article cancel00:00:00.003 0.0%10 0.000 0.300 1.000
article cleanup00:00:00.049 0.0%2667 0.000 0.018 0.167
article logging00:00:00.202 0.0%2667 0.000 0.076 0.300
article parse00:00:00.424 0.0%9172 0.000 0.046 0.333
article write00:00:01.163 0.0%2314 0.000 0.503 1.263
artlog/artcncl00:00:00.001 0.0%10 0.000 0.100 1.000
artlog/artcncl/perl00:00:00.000 0.0%9 0.000 0.000 0.000
data move00:00:00.163 0.0%28505 0.000 0.006 0.030
hisgrep/artcncl00:00:00.000 0.0%10 0.000 0.000 0.000
hisgrep/artcncl/perl00:00:00.000 0.0%9 0.000 0.000 0.000
hisgrep/perl00:00:00.001 0.0%10 0.000 0.100 1.000
hishave/artcncl00:00:00.000 0.0%10 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.000 0.0%9 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.391 0.0%24033 0.000 0.016 0.051
history sync00:00:00.056 0.0%407 0.000 0.138 1.000
history write00:00:00.428 0.0%2663 0.000 0.161 0.600
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle24:00:51.412100.0%30768 207.408 2809.783 10910.309
nntp read00:00:00.791 0.0%30044 0.000 0.026 0.075
overview write00:00:00.790 0.0%2314 0.000 0.341 3.800
perl filter00:00:11.100 0.0%2663 1.753 4.168 9.167
python filter00:00:00.010 0.0%2663 0.000 0.004 0.200
site send00:00:00.796 0.0%4650 0.000 0.171 0.625
TOTAL: 24:01:15.87724:01:07.785100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.030 0.0%2389 0.000 0.013 0.200
article prepare00:00:00.002 0.0%844 0.000 0.002 0.031
article read00:00:00.043 0.0%202 0.000 0.213 8.000
backlog stats00:00:00.177 0.0%35032 0.000 0.005 0.062
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.435 0.0%18740 0.000 0.023 0.063
data write00:00:00.838 0.0%16749 0.015 0.050 0.143
idle23:50:05.352100.0%35032 816.663 2449.342 7513.425
status file00:00:00.396 0.0%208 0.000 1.904 3.200
TOTAL: 23:50:14.75523:50:07.273100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:30.547 18.4%1443 19.400 21.169 1161.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.094 0.1%3214 0.000 0.029 0.364
TOTAL: 00:02:45.70500:00:30.641 18.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
1feed-out.gegeweb.org 3 2242 1205 1036 1 53%23:58:04
2news.nntp4.net 2 2751 400 2195 156 14%26:25:51
3usenet.pasdenom.info 3 2464 308 2143 13 12%43:12:49
4gegeweb-out.news.tnetconsulting.net 1 1635 244 1325 66 14%21:11:15
5i2pn.org 2 1952 114 1829 9 5%22:55:50
6nntp.terraraq.uk 3 3611 109 3501 1 3%44:50:46
7news.glou.org 2 1992 93 1791 108 4%23:59:39
8news.samoylyk.net 2 1945 21 1924 0 1%22:30:35
9localhost 25 0 0 0 0 0%00:00:01
TOTAL: 9 43 18592 2494 15744 354 13%229:04:50
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1feed-out.gegeweb.org5.0 MB0.0 KB2.2 KB5.0 MB 99%4.2 KB
2news.nntp4.net4.2 MB3.4 KB697.7 KB4.9 MB 85%8.9 KB
3gegeweb-out.news.tnetconsulting.net812.1 KB3.4 KB213.0 KB1.0 MB 78%3.3 KB
4usenet.pasdenom.info763.7 KB3.4 KB27.7 KB794.7 KB 96%2.5 KB
5i2pn.org363.7 KB0.0 KB21.0 KB384.6 KB 94%3.1 KB
6news.glou.org304.9 KB0.0 KB280.3 KB585.2 KB 52%2.9 KB
7nntp.terraraq.uk271.4 KB0.0 KB2.7 KB274.0 KB 99%2.5 KB
8news.samoylyk.net155.2 KB0.0 KB0.0 KB155.2 KB100%7.4 KB
9localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 911.8 MB10.1 KB1.2 MB13.0 MB 90%4.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 17 04:15:02 - 04:59:59 54 2.3% 0.02270.4 KB 2.1% 0.10
May 17 05:00:00 - 05:59:59 64 2.8% 0.02249.0 KB 2.0% 0.07
May 17 06:00:00 - 06:59:59 70 3.0% 0.02239.4 KB 1.9% 0.07
May 17 07:00:00 - 07:59:59 57 2.5% 0.02185.8 KB 1.5% 0.05
May 17 08:00:00 - 08:59:59 67 2.9% 0.02207.3 KB 1.6% 0.06
May 17 09:00:00 - 09:59:59 95 4.1% 0.03382.3 KB 3.0% 0.11
May 17 10:00:00 - 10:59:59 73 3.2% 0.02347.5 KB 2.7% 0.10
May 17 11:00:00 - 11:59:59 87 3.8% 0.02340.4 KB 2.7% 0.09
May 17 12:00:00 - 12:59:59 93 4.0% 0.03315.0 KB 2.5% 0.09
May 17 13:00:00 - 13:59:59 94 4.1% 0.03378.3 KB 3.0% 0.11
May 17 14:00:00 - 14:59:59 114 4.9% 0.03485.9 KB 3.8% 0.13
May 17 15:00:00 - 15:59:59 81 3.5% 0.02606.9 KB 4.8% 0.17
May 17 16:00:00 - 16:59:59 135 5.8% 0.04442.7 KB 3.5% 0.12
May 17 17:00:00 - 17:59:59 127 5.5% 0.04433.5 KB 3.4% 0.12
May 17 18:00:00 - 18:59:59 126 5.4% 0.04541.5 KB 4.2% 0.15
May 17 19:00:00 - 19:59:59 87 3.8% 0.02354.0 KB 2.8% 0.10
May 17 20:00:00 - 20:59:59 124 5.4% 0.03388.3 KB 3.0% 0.11
May 17 21:00:00 - 21:59:59 110 4.8% 0.03383.2 KB 3.0% 0.11
May 17 22:00:00 - 22:59:59 212 9.2% 0.064.6 MB 37.2% 1.32
May 17 23:00:00 - 23:59:59 112 4.8% 0.03320.4 KB 2.5% 0.09
May 18 00:00:00 - 00:59:59 97 4.2% 0.03279.3 KB 2.2% 0.08
May 18 01:00:00 - 01:59:59 77 3.3% 0.02259.9 KB 2.0% 0.07
May 18 02:00:00 - 02:59:59 69 3.0% 0.02219.0 KB 1.7% 0.06
May 18 03:00:00 - 03:59:59 80 3.5% 0.02358.8 KB 2.8% 0.10
May 18 04:00:00 - 04:15:01 7 0.3% 0.0123.3 KB 0.2% 0.03
TOTAL: 23:59:59 2312 100.0% 0.0312.5 MB 100.0% 0.15
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 155 0 0 1 0 0 0 0 154
2news.glou.org 108 0 0 0 0 0 0 0 108
3gegeweb-out.news.tnetconsulting.net 78 0 0 1 0 0 0 0 77
4usenet.pasdenom.info 8 0 0 1 0 0 0 0 7
5i2pn.org 1 0 0 0 0 0 0 0 1
6news.samoylyk.net 1 0 0 1 0 0 0 0 0
7feed-out.gegeweb.org 1 0 0 0 0 0 0 0 1
TOTAL: 7 352 0 0 4 0 0 0 0 348

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 118
EMP (phn path) 110
Bad path (news.giganews.com.POSTED) 84
EMP (md5) 31
Cancels abusifs 4
Cancel for rejected article 1
TOTAL: 6 348

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1i2pn.org 3618 101 2044 34 0 48 2%23:59:56
2news.gegeweb.org 1173 50 1074 0 0 0 4%23:51:46
3news.tnetconsulting.net 3879 14 2283 4 0 35 0%23:59:54
4news.samoylyk.net 2870 7 2279 0 0 0 0%23:58:17
5news.pasdenom.info 1972 0 1827 1 0 0 0%23:59:56
6news.aioe.org 0 0 0 0 0 1903 0%23:59:59
7nntp.terraraq.uk 1494 0 1403 1 0 0 0%23:59:45
8news.nntp4.net 1991 0 1905 0 0 0 0%23:59:55
TOTAL: 8 16997 172 12815 40 0 1986 1%191:49:28
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.gegeweb.org310.4 KB0.0 KB310.4 KB0.0 KB/s6.2 KB23:51:46
2i2pn.org276.3 KB416.1 KB692.4 KB0.0 KB/s5.1 KB23:59:56
3news.tnetconsulting.net41.2 KB11.2 KB52.4 KB0.0 KB/s2.9 KB23:59:54
4news.samoylyk.net17.1 KB0.0 KB17.1 KB0.0 KB/s2.4 KB23:58:17
5news.pasdenom.info0.0 KB3.4 KB3.4 KB0.0 KB/s3.4 KB23:59:56
6news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:59
7nntp.terraraq.uk0.0 KB9.3 KB9.3 KB0.0 KB/s9.3 KB23:59:45
8news.nntp4.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:55
TOTAL: 8645.1 KB440.0 KB1.1 MB0.0 KB/s5.1 KB191:49:28
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1sturdy.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
2208.100.26.237 10 00.0 KB 0 0 000:00:08
3mail.gegeweb.eu 288 00.0 KB 0 0 000:02:12
4energetic.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
580.66.76.134 1 00.0 KB 0 0 000:00:00
6cute.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:03
745.55.0.9 1 00.0 KB 0 0 000:00:00
8shiny.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
9stirring.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:10
1011.210.203.35.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
11honourable.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:05
TOTAL: 11 307 00.0 KB 0 0 000:02:45

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.monitoring.internet-measurement.com 6 00.0 KB 0 0 000:00:21
2unresolved 12 00.0 KB 0 0 000:00:10
3*.210.203.35.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
4*.gegeweb.eu 288 00.0 KB 0 0 000:02:12
TOTAL: 4 307 00.0 KB 0 0 000:02:45

NNRP auth users [Top 20]:

UserConn
mailman 288
TOTAL: 1 288

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
mail.gegeweb.eu 4.304 4.244 1.54800:02:12
stirring.monitoring.internet-measurement.com 0.053 0.022 0.00000:00:10
208.100.26.237 0.286 0.127 0.00000:00:08
honourable.monitoring.internet-measurement.com 0.036 0.005 0.00000:00:05
cute.monitoring.internet-measurement.com 0.035 0.023 0.00000:00:03
shiny.monitoring.internet-measurement.com 0.020 0.033 0.00000:00:01
11.210.203.35.bc.googleusercontent.com 0.057 0.034 0.00000:00:00
80.66.76.134 0.018 0.009 0.00000:00:00
45.55.0.9 0.016 0.008 0.00000:00:00
sturdy.monitoring.internet-measurement.com 0.038 0.026 0.00000:00:00
energetic.monitoring.internet-measurement.com 0.034 0.025 0.00000:00:00
TOTAL: 11 4.897 4.556 1.54800:02:45

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
stirring.monitoring.internet-measurement.com 6
11.210.203.35.bc.googleusercontent.com 3
45.55.0.9 1
TOTAL: 3 10

NNRP unrecognized commands (by command):

CommandCount
Host: 45.13.105.36:563 2
GET / HTTP/1.1 2
MGLNDD_45.13.105.36_119 1
Accept: */* 1
User-Agent: Mozilla/5.0 (compatible; Int... 1
Accept-Encoding: gzip 1
User-Agent: Expanse, a Palo Alto Network... 1
Connection: close 1
TOTAL: 8 10