Daily Usenet report for news.niel.me

May 3 04:15:01 -- May 4 04:15:01

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

May 4 01:30:02 rpi-studio innd: filter: No Cancel-Key[sha1:mlN3pHaX2B+tV++o/c5PteMxj14=] matches Cancel-Lock[sha1:CQ/Kj23hxeEjOr2sxw9OilUps84=] target=<de-gruppen-finden-27.04.2024@dnqmail.priggish.de>

Log entries by program:

Program nameLines%LinesSize%Size
inn 2469 29.4%452.3 KB 34.0%
innd 2205 26.3%384.5 KB 28.9%
innfeed 1935 23.0%293.5 KB 22.1%
nnrpd 1788 21.3%198.6 KB 14.9%
controlchan 1 0.0%0.0 KB 0.0%
nocem 1 0.0%0.1 KB 0.0%
TOTAL: 6 8399 100.0%1.3 MB100.0%

History cache:

ReasonCount%Count
Positive hits 12573 62.2%
Negative hits 5194 25.7%
Do not exist 2427 12.0%
Cache misses 30 0.1%
TOTAL: 4 20224 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.018 0.0%15 1.000 1.200 2.000
article cancel00:00:00.004 0.0%16 0.000 0.250 1.000
article cleanup00:00:00.053 0.0%2431 0.000 0.022 0.333
article logging00:00:00.164 0.0%2432 0.000 0.067 0.333
article parse00:00:00.307 0.0%6041 0.000 0.051 0.333
article write00:00:01.049 0.0%2154 0.000 0.487 1.091
artlog/artcncl00:00:00.002 0.0%16 0.000 0.125 1.000
artlog/artcncl/perl00:00:00.001 0.0%15 0.000 0.067 0.333
data move00:00:00.107 0.0%21437 0.000 0.005 0.051
hisgrep/artcncl00:00:00.000 0.0%16 0.000 0.000 0.000
hisgrep/artcncl/perl00:00:00.000 0.0%15 0.000 0.000 0.000
hisgrep/perl00:00:00.002 0.0%16 0.000 0.125 1.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.305 0.0%20205 0.000 0.015 0.057
history sync00:00:00.048 0.0%399 0.000 0.120 1.000
history write00:00:00.388 0.0%2428 0.000 0.160 0.667
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle24:00:48.918100.0%23946 1332.944 3610.161 15000.200
nntp read00:00:00.542 0.0%23240 0.000 0.023 0.065
overview write00:00:01.033 0.0%2154 0.000 0.480 6.333
perl filter00:00:09.590 0.0%2428 2.200 3.950 15.200
python filter00:00:00.008 0.0%2428 0.000 0.003 0.167
site send00:00:00.681 0.0%4331 0.000 0.157 0.500
TOTAL: 24:01:12.70424:01:03.220100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.023 0.0%2574 0.000 0.009 0.250
article prepare00:00:00.002 0.0%924 0.000 0.002 0.019
article read00:00:00.035 0.0%226 0.000 0.155 6.000
backlog stats00:00:00.122 0.0%29823 0.000 0.004 0.034
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.327 0.0%15348 0.000 0.021 0.088
data write00:00:00.789 0.0%13624 0.000 0.058 0.133
idle23:51:05.829100.0%29823 1616.560 2879.181 7711.231
status file00:00:00.578 0.0%299 0.000 1.933 7.000
TOTAL: 23:51:13.80223:51:07.705100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:36.705 29.2%1446 10.200 25.384 10050.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.107 0.1%3199 0.000 0.033 0.273
TOTAL: 00:02:05.65300:00:36.812 29.3%----

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
1feed-out.gegeweb.org 2 2143 992 1151 0 46%23:59:44
2news.nntp4.net 1 1665 285 1242 138 17%17:14:11
3gegeweb-out.news.tnetconsulting.net 2 1983 234 1693 56 11%27:14:30
4usenet.pasdenom.info 3 1022 191 821 10 18%19:17:00
5news.glou.org 2 1730 154 1515 61 8%24:48:36
6i2pn.org 5 3464 154 3308 2 4%42:39:04
7nntp.terraraq.uk 1 1899 74 1823 2 3%22:22:51
8news.samoylyk.net 3 2773 35 2738 0 1%30:28:08
9localhost 25 0 0 0 0 0%00:00:00
TOTAL: 9 44 16679 2119 14291 269 12%208:04:04
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1feed-out.gegeweb.org3.3 MB0.0 KB0.0 KB3.3 MB100%3.4 KB
2news.nntp4.net1.3 MB1.9 KB505.2 KB1.8 MB 72%4.3 KB
3news.glou.org734.7 KB0.0 KB175.4 KB910.1 KB 80%4.2 KB
4gegeweb-out.news.tnetconsulting.net627.5 KB5.7 KB181.5 KB814.6 KB 77%2.8 KB
5nntp.terraraq.uk524.7 KB2.7 KB6.3 KB533.6 KB 98%7.0 KB
6usenet.pasdenom.info504.0 KB0.0 KB13.2 KB517.2 KB 97%2.6 KB
7i2pn.org387.5 KB0.0 KB3.2 KB390.7 KB 99%2.5 KB
8news.samoylyk.net260.2 KB0.0 KB0.0 KB260.2 KB100%7.4 KB
9localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 97.6 MB10.3 KB884.6 KB8.4 MB 89%3.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 3 04:15:01 - 04:59:59 40 1.9% 0.01116.1 KB 1.4% 0.04
May 3 05:00:00 - 05:59:59 54 2.5% 0.01187.2 KB 2.3% 0.05
May 3 06:00:00 - 06:59:59 32 1.5% 0.0186.3 KB 1.1% 0.02
May 3 07:00:00 - 07:59:59 51 2.4% 0.01185.1 KB 2.3% 0.05
May 3 08:00:00 - 08:59:59 39 1.8% 0.01107.5 KB 1.3% 0.03
May 3 09:00:00 - 09:59:59 83 3.8% 0.02251.1 KB 3.1% 0.07
May 3 10:00:00 - 10:59:59 62 2.9% 0.02191.2 KB 2.4% 0.05
May 3 11:00:00 - 11:59:59 114 5.3% 0.03456.9 KB 5.7% 0.13
May 3 12:00:00 - 12:59:59 66 3.1% 0.02241.0 KB 3.0% 0.07
May 3 13:00:00 - 13:59:59 90 4.2% 0.03326.7 KB 4.1% 0.09
May 3 14:00:00 - 14:59:59 98 4.5% 0.03447.8 KB 5.6% 0.12
May 3 15:00:00 - 15:59:59 103 4.8% 0.03405.6 KB 5.1% 0.11
May 3 16:00:00 - 16:59:59 123 5.7% 0.03394.8 KB 4.9% 0.11
May 3 17:00:00 - 17:59:59 100 4.6% 0.03422.8 KB 5.3% 0.12
May 3 18:00:00 - 18:59:59 108 5.0% 0.03374.4 KB 4.7% 0.10
May 3 19:00:00 - 19:59:59 170 7.9% 0.05741.3 KB 9.3% 0.21
May 3 20:00:00 - 20:59:59 142 6.6% 0.04497.7 KB 6.2% 0.14
May 3 21:00:00 - 21:59:59 129 6.0% 0.04515.6 KB 6.4% 0.14
May 3 22:00:00 - 22:59:59 116 5.4% 0.03350.1 KB 4.4% 0.10
May 3 23:00:00 - 23:59:59 116 5.4% 0.03490.5 KB 6.1% 0.14
May 4 00:00:00 - 00:59:59 104 4.8% 0.03337.3 KB 4.2% 0.09
May 4 01:00:00 - 01:59:59 88 4.1% 0.02499.9 KB 6.2% 0.14
May 4 02:00:00 - 02:59:59 59 2.7% 0.02151.5 KB 1.9% 0.04
May 4 03:00:00 - 03:59:59 52 2.4% 0.01147.8 KB 1.8% 0.04
May 4 04:00:00 - 04:15:01 21 1.0% 0.0280.9 KB 1.0% 0.09
TOTAL: 24:00:00 2160 100.0% 0.037.8 MB 100.0% 0.09
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 156 0 0 1 0 0 0 0 155
2news.glou.org 61 0 0 0 0 0 0 0 61
3gegeweb-out.news.tnetconsulting.net 48 0 0 2 0 0 0 0 46
4usenet.pasdenom.info 12 0 0 0 0 0 0 0 12
5nntp.terraraq.uk 1 0 0 0 0 0 0 0 1
TOTAL: 5 278 0 0 3 0 0 0 0 275

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 146
EMP (phn path) 61
Bad path (news.giganews.com.POSTED) 56
Cancels abusifs 10
EMP (md5) 1
TOTAL: 5 274

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news.nntp4.net 1
TOTAL: 1 1
TOTAL: 1 1

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1i2pn.org 1767 59 789 85 0 1578 3%23:45:44
2news.gegeweb.org 1191 23 1132 0 0 0 1%23:54:49
3news.samoylyk.net 2713 12 2117 0 0 2 0%23:59:18
4news.tnetconsulting.net 3715 11 2143 3 0 20 0%23:59:44
5news.nntp4.net 1782 1 1689 0 0 0 0%23:57:23
6news.aioe.org 0 0 0 0 0 1732 0%24:00:00
7nntp.terraraq.uk 1264 0 1207 0 0 0 0%23:51:31
8news.pasdenom.info 1681 0 1619 0 0 0 0%23:57:23
TOTAL: 8 14113 106 10696 88 0 3332 0%191:25:52
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1i2pn.org175.3 KB382.2 KB557.5 KB0.0 KB/s3.9 KB23:45:44
2news.gegeweb.org48.9 KB0.0 KB48.9 KB0.0 KB/s2.1 KB23:54:49
3news.samoylyk.net38.5 KB0.0 KB38.5 KB0.0 KB/s3.2 KB23:59:18
4news.tnetconsulting.net30.1 KB6.6 KB36.7 KB0.0 KB/s2.6 KB23:59:44
5news.nntp4.net2.0 KB0.0 KB2.0 KB0.0 KB/s2.0 KB23:57:23
6news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:00
7nntp.terraraq.uk0.0 KB0.0 KB0.0 KB0.0 KB/s023:51:31
8news.pasdenom.info0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:23
TOTAL: 8294.9 KB388.8 KB683.7 KB0.0 KB/s3.5 KB191:25:52
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1107.170.248.44 1 00.0 KB 0 0 000:00:09
2staunch.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
3esteemed.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:03
4mail.gegeweb.eu 288 00.0 KB 0 0 000:01:33
5104.152.52.124 1 00.0 KB 0 0 000:00:10
6104.152.52.199 1 00.0 KB 0 0 000:00:00
7adroit.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:05
8162.211.203.35.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:01
9wondrous.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
1020.149.216.162.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
11regal.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
12ingenious.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
TOTAL: 12 299 00.0 KB 0 0 000:02:05

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.monitoring.internet-measurement.com 6 00.0 KB 0 0 000:00:08
2*.149.216.162.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
3*.211.203.35.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:01
4*.gegeweb.eu 288 00.0 KB 0 0 000:01:33
5unresolved 3 00.0 KB 0 0 000:00:20
TOTAL: 5 299 00.0 KB 0 0 000:02:05

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.085 4.287 1.47500:01:33
104.152.52.124 0.023 0.023 0.00000:00:10
107.170.248.44 0.021 0.033 0.00000:00:09
adroit.monitoring.internet-measurement.com 0.049 0.023 0.00000:00:05
esteemed.monitoring.internet-measurement.com 0.012 0.012 0.00000:00:03
162.211.203.35.bc.googleusercontent.com 0.036 0.005 0.00000:00:01
20.149.216.162.bc.googleusercontent.com 0.013 0.013 0.00000:00:00
104.152.52.199 0.024 0.023 0.00000:00:00
staunch.monitoring.internet-measurement.com 0.042 0.023 0.00000:00:00
wondrous.monitoring.internet-measurement.com 0.032 0.028 0.00000:00:00
regal.monitoring.internet-measurement.com 0.039 0.018 0.00000:00:00
TOTAL: 11 4.376 4.488 1.47500:02:05

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
162.211.203.35.bc.googleusercontent.com 3
20.149.216.162.bc.googleusercontent.com 3
TOTAL: 2 6

NNRP unrecognized commands (by command):

CommandCount
User-Agent: Expanse, a Palo Alto Network... 2
GET / HTTP/1.1 2
Host: 45.13.105.36:119 1
Host: 45.13.105.36:563 1
TOTAL: 4 6