Daily Usenet report: Oct 6 03:00:02

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Oct 6 03:07:50 news innd: message repeated 2 times: [ ctlinnd command s]

Log entries by program:

Program name	Lines	%Lines	Size	%Size
innd	11515	46.7%	1.8 MB	48.5%
inn	10724	43.5%	1.7 MB	44.9%
innfeed	2235	9.1%	233.6 KB	6.0%
nnrpd	180	0.7%	18.5 KB	0.5%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 5	24655	100.0%	3.8 MB	100.0%

History cache:

Reason	Count	%Count
Negative hits	15352	39.2%
Positive hits	13095	33.5%
Do not exist	10673	27.3%
Cache misses	11	0.0%
TOTAL: 4	39131	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.023	0.0%	4	0.000	5.750	21.000
article cleanup	00:00:00.048	0.0%	10680	0.000	0.004	1.000
article logging	00:00:00.192	0.0%	10729	0.000	0.018	1.000
article parse	00:00:00.089	0.0%	13953	0.000	0.006	1.000
article write	00:01:23.809	0.1%	8704	0.000	9.629	173.667
artlog/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:00:00.347	0.0%	37651	0.000	0.009	1.077
hisgrep/artcncl	00:00:00.001	0.0%	4	0.000	0.250	1.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:58.850	0.1%	39160	0.000	1.503	27.500
history sync	00:00:00.317	0.0%	1610	0.000	0.197	138.000
history write	00:00:22.218	0.0%	10679	0.000	2.081	104.333
idle	23:55:51.603	99.8%	40538	389.539	2125.206	60061.000
nntp read	00:00:00.599	0.0%	38840	0.000	0.015	4.800
overview write	00:00:06.790	0.0%	8704	0.000	0.780	73.000
perl filter	00:00:26.067	0.0%	10679	0.000	2.441	163.000
python filter	00:00:00.945	0.0%	10679	0.000	0.088	17.000
site send	00:00:00.081	0.0%	8704	0.000	0.009	1.000
TOTAL: 23:59:26.612	23:59:11.979	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.019	0.0%	8721	0.000	0.002	1.000
article prepare	00:00:00.002	0.0%	5924	0.000	0.000	0.250
article read	00:00:00.281	0.0%	1281	0.000	0.219	38.000
backlog stats	00:00:00.033	0.0%	49568	0.000	0.001	0.500
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.236	0.0%	29622	0.000	0.008	0.333
data write	00:00:00.271	0.0%	21245	0.000	0.013	0.500
idle	23:59:42.988	100.0%	49568	342.567	1742.717	30100.000
status file	00:00:00.294	0.0%	159	0.000	1.849	84.000
TOTAL: 23:59:45.158	23:59:44.124	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:30.902	43.6%	41	27.286	753.707	10050.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.001	0.0%	156	0.000	0.006	0.250
TOTAL: 00:01:10.867	00:00:30.903	43.6%	-	-	-	-

Control commands to INND:

Command	Number
flush	2
flushlogs	2
go	2
logmode	2
lowmark	1
mode	146
name	2
pause	2
paused	2
reload	2
reserve	2
TOTAL: 11	165

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	usenet.blueworldhosting.com	288	10676	5701	3055	1920	53%	23:48:45
2	news.sklaff.dev	3	9793	1944	7791	58	19%	23:41:32
3	news.sklaffkom.se	1	3439	1073	2366	0	31%	24:54:49
4	localhost	25	0	0	0	0	0%	00:00:00
5	news.thebunker.nu	4	0	0	0	0	0%	00:00:00
TOTAL: 5		321	23908	8718	13212	1978	36%	72:25:06

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	usenet.blueworldhosting.com	16.6 MB	4.4 KB	4.1 MB	20.7 MB	80%	2.8 KB
2	news.sklaff.dev	4.9 MB	0.0 KB	187.8 KB	5.1 MB	96%	2.6 KB
3	news.sklaffkom.se	1.4 MB	0.0 KB	0.0 KB	1.4 MB	100%	1.3 KB
4	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
5	news.thebunker.nu	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 5		22.9 MB	4.4 KB	4.3 MB	27.2 MB	84%	2.6 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Oct 6 03:00:02 - 03:59:59	222	2.6%	0.06	405.8 KB	1.7%	0.11
Oct 6 04:00:00 - 04:59:59	194	2.2%	0.05	529.1 KB	2.3%	0.15
Oct 6 05:00:00 - 05:59:59	252	2.9%	0.07	776.3 KB	3.3%	0.22
Oct 6 06:00:00 - 06:59:59	238	2.7%	0.07	638.2 KB	2.7%	0.18
Oct 6 07:00:00 - 07:59:59	252	2.9%	0.07	655.1 KB	2.8%	0.18
Oct 6 08:00:00 - 08:59:59	331	3.8%	0.09	844.7 KB	3.6%	0.23
Oct 6 09:00:00 - 09:59:59	394	4.5%	0.11	779.6 KB	3.3%	0.22
Oct 6 10:00:00 - 10:59:59	388	4.5%	0.11	902.5 KB	3.9%	0.25
Oct 6 11:00:00 - 11:59:59	381	4.4%	0.11	874.7 KB	3.7%	0.24
Oct 6 12:00:00 - 12:59:59	415	4.8%	0.12	1.1 MB	4.8%	0.31
Oct 6 13:00:00 - 13:59:59	460	5.3%	0.13	1.2 MB	5.4%	0.35
Oct 6 14:00:00 - 14:59:59	402	4.6%	0.11	1.3 MB	5.7%	0.37
Oct 6 15:00:00 - 15:59:59	443	5.1%	0.12	1.2 MB	5.4%	0.35
Oct 6 16:00:00 - 16:59:59	473	5.4%	0.13	1.2 MB	5.4%	0.35
Oct 6 17:00:00 - 17:59:59	467	5.4%	0.13	1.2 MB	5.1%	0.33
Oct 6 18:00:00 - 18:59:59	483	5.6%	0.13	1.2 MB	5.4%	0.35
Oct 6 19:00:00 - 19:59:59	461	5.3%	0.13	1.0 MB	4.5%	0.29
Oct 6 20:00:00 - 20:59:59	463	5.3%	0.13	1.3 MB	5.6%	0.36
Oct 6 21:00:00 - 21:59:59	446	5.1%	0.12	1.4 MB	6.1%	0.40
Oct 6 22:00:00 - 22:59:59	389	4.5%	0.11	953.5 KB	4.1%	0.26
Oct 6 23:00:00 - 23:59:59	349	4.0%	0.10	1.3 MB	5.6%	0.36
Oct 7 00:00:00 - 00:59:59	282	3.2%	0.08	790.8 KB	3.4%	0.22
Oct 7 01:00:00 - 01:59:59	261	3.0%	0.07	673.2 KB	2.9%	0.19
Oct 7 02:00:00 - 03:00:01	253	2.9%	0.07	719.9 KB	3.1%	0.20
TOTAL: 23:59:59	8699	100.0%	0.10	22.8 MB	100.0%	0.27

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	usenet.blueworldhosting.com	1956	473	1	1482
2	news.sklaff.dev	69	0	0	69
TOTAL: 2		2025	473	1	1551

Unwanted newsgroups [Top 20]:

Newsgroup	Count
de.comm.provider.usenet	41
pl.sci.fizyka	21
de.alt.comm.android	19
de.alt.arnooo	15
de.rec.tv.serien	14
uk.telecom.mobile	14
aus.computers	11
hispagatos.mastodon.tag.hacking	11
free.it.scienza.fisica	10
it.comp.os.linux.iniziare	10
pl.soc.religia	10
de.rec.tv.technik	9
fr.rec.moto	9
de.etc.finanz.banken+broker	8
de.rec.heimwerken	8
linux.ubuntu.security.announce	8
fr.soc.religion	7
it.hobby.motociclismo	7
it.sport.motociclismo	7
uk.telecom.voip	7
TOTAL: 136	473

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	963
EMP (phn path)	255
Too many newsgroups	224
EMP (phl)	33
User-issued cancel	13
Too many newsgroups (meow)	7
HTML Multipart	4
Scoring filter	3
TOTAL: 8	1502

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	usenet.blueworldhosting.com	38
	news.sklaff.dev	11
	TOTAL: 2	49
TOTAL: 1		49

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	sklaff.dev	8304	352	6390	0	3	4%	23:58:54
2	sklaffkom.se	9157	166	6502	958	18	1%	23:59:57
3	usenet.blueworldhosting.com	3018	5	2887	0	0	0%	23:59:41
4	thebunker.nu	0	0	0	0	8699	0%	23:59:57
TOTAL: 4		20479	523	15779	958	8720	2%	95:58:29

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	sklaff.dev	574.7 KB	0.0 KB	574.7 KB	1.6 KB	23:58:54
2	sklaffkom.se	151.7 KB	2.7 MB	2.8 MB	2.6 KB	23:59:57
3	usenet.blueworldhosting.com	4.3 KB	0.0 KB	4.3 KB	0.9 KB	23:59:41
4	thebunker.nu	0.0 KB	0.0 KB	0.0 KB	0	23:59:57
TOTAL: 4		730.7 KB	2.7 MB	3.4 MB	2.3 KB	95:58:29

NNRP readership statistics:

System		Conn	Elapsed
1	47.251.53.147	4	00:00:00
2	81-229-79-101-no600.tbcn.telia.com	4	00:00:01
3	147.185.132.227	2	00:00:01
4	153.211.203.35.bc.googleusercontent.com	2	00:00:00
5	azpdsgkn8wmd.stretchoid.com	2	00:00:10
6	azpdsgrkwm75.stretchoid.com	2	00:00:10
7	147.185.132.247	1	00:00:00
8	167.94.138.125	1	00:00:01
9	205.210.31.176	1	00:00:03
10	205.210.31.68	1	00:00:03
11	47.250.81.123	1	00:00:29
12	63.210.203.35.bc.googleusercontent.com	1	00:00:00
13	cabrera.probe.onyphe.net	1	00:00:03
14	grey.probe.onyphe.net	1	00:00:03
15	radiant.monitoring.internet-measurement.com	1	00:00:01
TOTAL: 15		25	00:01:10

NNRP readership statistics (by domain):

System		Conn	Elapsed
1	unresolved	11	00:00:39
2	*.stretchoid.com	4	00:00:20
3	*.tbcn.telia.com	4	00:00:01
4	*.211.203.35.bc.googleusercontent.com	2	00:00:00
5	*.probe.onyphe.net	2	00:00:06
6	*.210.203.35.bc.googleusercontent.com	1	00:00:00
7	*.monitoring.internet-measurement.com	1	00:00:01
TOTAL: 7		25	00:01:10

NNRP auth users [Top 20]:

User	Conn
peterlondon	4
TOTAL: 1	4

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
47.250.81.123	0.045	0.002	0.000	00:00:29
azpdsgrkwm75.stretchoid.com	0.016	0.011	0.000	00:00:10
azpdsgkn8wmd.stretchoid.com	0.014	0.008	0.000	00:00:10
205.210.31.68	0.010	0.007	0.000	00:00:03
cabrera.probe.onyphe.net	0.042	0.004	0.000	00:00:03
205.210.31.176	0.005	0.008	0.000	00:00:03
grey.probe.onyphe.net	0.040	0.006	0.000	00:00:03
radiant.monitoring.internet-measurement.com	0.009	0.004	0.000	00:00:01
81-229-79-101-no600.tbcn.telia.com	0.036	0.016	0.078	00:00:01
167.94.138.125	0.047	0.009	0.000	00:00:01
147.185.132.227	0.078	0.013	0.000	00:00:01
153.211.203.35.bc.googleusercontent.com	0.078	0.016	0.000	00:00:00
147.185.132.247	0.063	0.011	0.000	00:00:00
47.251.53.147	0.157	0.020	0.000	00:00:00
63.210.203.35.bc.googleusercontent.com	0.038	0.007	0.000	00:00:00
TOTAL: 15	0.678	0.142	0.078	00:01:10

NNRP gethostbyaddr failures [Top 20]:

System	Conn
? (can't getpeername)	12
TOTAL: 1	12

NNRP unrecognized commands (by host) [Top 20]:

System	Conn
147.185.132.227	4
147.185.132.247	4
153.211.203.35.bc.googleusercontent.com	4
47.250.81.123	4
63.210.203.35.bc.googleusercontent.com	4
167.94.138.125	1
azpdsgkn8wmd.stretchoid.com	1
azpdsgrkwm75.stretchoid.com	1
TOTAL: 8	23

NNRP unrecognized commands (by command) [Top 20]:

Command	Count
GET / HTTP/1.1	5
Host: 109.238.130.155:563	5
Accept: /	3
Accept-Encoding: gzip	2
MGLNDD_109.238.130.155_119	2
User-Agent: Hello from Palo Alto Network...	2
User-Agent: curl/7.68.0	2
EHLO www.censys.io	1
User-Agent: curl/7.64.1	1
TOTAL: 9	23

NNRP client timeouts [Top 20]:

System	Conn	Peer
147.185.132.227	1	2
147.185.132.247	1	1
153.211.203.35.bc.googleusercontent.com	1	2
47.250.81.123	1	1
63.210.203.35.bc.googleusercontent.com	1	1
TOTAL: 5	5	11

Daily Usenet report

Oct 6 03:00:02 -- Oct 7 03:00:01