Daily Usenet report: Oct 9 03:00:01

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Oct 9 03:03:57 news innd: message repeated 2 times: [ ctlinnd command s]

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	83097	75.5%	14.0 MB	80.2%
innd	24364	22.1%	3.2 MB	18.4%
innfeed	2327	2.1%	232.6 KB	1.3%
nnrpd	220	0.2%	21.7 KB	0.1%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 5	110009	100.0%	17.4 MB	100.0%

History cache:

Reason	Count	%Count
Negative hits	85438	47.4%
Do not exist	82929	46.0%
Positive hits	11624	6.5%
Cache misses	153	0.1%
TOTAL: 4	180144	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.061	0.0%	17	0.000	3.588	24.000
article cleanup	00:00:00.351	0.0%	83164	0.000	0.004	0.500
article logging	00:00:01.446	0.0%	83222	0.000	0.017	1.000
article parse	00:00:00.738	0.0%	231947	0.000	0.003	0.500
article write	00:02:28.484	0.2%	69037	0.000	2.151	155.500
artlog/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:00:00.173	0.0%	249664	0.000	0.001	0.423
hisgrep/artcncl	00:00:00.002	0.0%	17	0.000	0.118	1.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:05:56.435	0.4%	180616	0.000	1.973	60.500
history sync	00:00:00.306	0.0%	1193	0.000	0.256	228.000
history write	00:02:21.903	0.2%	83164	0.000	1.706	99.667
idle	23:46:32.980	99.1%	253517	93.240	337.622	60060.000
nntp read	00:00:01.979	0.0%	252244	0.000	0.008	2.625
overview write	00:00:21.728	0.0%	69037	0.000	0.315	81.761
perl filter	00:01:49.075	0.1%	83164	0.000	1.312	230.000
python filter	00:00:04.636	0.0%	156214	0.000	0.030	56.600
site send	00:00:00.532	0.0%	69037	0.000	0.008	0.333
TOTAL: 23:59:59.013	23:59:40.829	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.085	0.0%	69210	0.000	0.001	0.250
article prepare	00:00:00.038	0.0%	729064	0.000	0.000	0.001
article read	00:00:07.842	0.0%	63499	0.000	0.123	15.333
backlog stats	00:00:00.205	0.0%	697640	0.000	0.000	0.250
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:02.788	0.0%	445973	0.000	0.006	0.167
data write	00:00:04.306	0.0%	378835	0.000	0.011	0.400
idle	23:58:39.007	100.0%	697640	31.362	123.730	30099.000
status file	00:00:00.472	0.0%	183	0.000	2.579	197.000
TOTAL: 23:59:01.357	23:58:54.743	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:37.924	67.8%	53	29.000	715.547	10049.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.001	0.0%	291	0.000	0.003	0.008
readart	00:00:00.287	0.5%	30	9.567	9.567	9.567
TOTAL: 00:00:55.938	00:00:38.212	68.3%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	chimia.se	3	72832	60335	518	11979	82%	07:25:42
2	usenet.blueworldhosting.com	288	10564	6170	2368	2026	58%	23:43:26
3	news.sklaff.dev	1	8452	1244	7143	65	14%	21:39:55
4	news.sklaffkom.se	15	2739	1052	1687	0	38%	24:34:59
5	localhost	25	0	0	0	0	0%	00:00:00
TOTAL: 5		332	94587	68801	11716	14070	72%	77:24:02

Incoming Volume (INN):

Server		AcceptVol	RejVol	TotalVol	%Acc	Vol/Art
1	chimia.se	103.5 MB	22.1 MB	125.6 MB	82%	1.8 KB
2	usenet.blueworldhosting.com	16.4 MB	4.9 MB	21.3 MB	76%	2.7 KB
3	news.sklaff.dev	4.9 MB	148.9 KB	5.0 MB	97%	3.9 KB
4	news.sklaffkom.se	1.2 MB	0.0 KB	1.2 MB	100%	1.1 KB
5	localhost	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 5		126.0 MB	27.2 MB	153.1 MB	82%	1.9 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Oct 9 03:00:01 - 03:59:59	8713	12.6%	2.42	16.7 MB	13.2%	4.76
Oct 9 04:00:00 - 04:59:59	6975	10.1%	1.94	14.6 MB	11.6%	4.16
Oct 9 05:00:00 - 05:59:59	195	0.3%	0.05	364.8 KB	0.3%	0.10
Oct 9 06:00:00 - 06:59:59	228	0.3%	0.06	485.8 KB	0.4%	0.13
Oct 9 07:00:00 - 07:59:59	255	0.4%	0.07	556.5 KB	0.4%	0.15
Oct 9 08:00:00 - 08:59:59	307	0.4%	0.09	638.1 KB	0.5%	0.18
Oct 9 09:00:00 - 09:59:59	369	0.5%	0.10	773.0 KB	0.6%	0.21
Oct 9 10:00:00 - 10:59:59	463	0.7%	0.13	1.8 MB	1.4%	0.51
Oct 9 11:00:00 - 11:59:59	413	0.6%	0.11	928.6 KB	0.7%	0.26
Oct 9 12:00:00 - 12:59:59	779	1.1%	0.22	1.4 MB	1.1%	0.39
Oct 9 13:00:00 - 13:59:59	441	0.6%	0.12	1.2 MB	0.9%	0.33
Oct 9 14:00:00 - 14:59:59	362	0.5%	0.10	927.2 KB	0.7%	0.26
Oct 9 15:00:00 - 15:59:59	385	0.6%	0.11	787.0 KB	0.6%	0.22
Oct 9 16:00:00 - 16:59:59	364	0.5%	0.10	993.7 KB	0.8%	0.28
Oct 9 17:00:00 - 17:59:59	397	0.6%	0.11	1.0 MB	0.8%	0.30
Oct 9 18:00:00 - 18:59:59	464	0.7%	0.13	1.3 MB	1.1%	0.38
Oct 9 19:00:00 - 19:59:59	426	0.6%	0.12	1.1 MB	0.8%	0.30
Oct 9 20:00:00 - 20:59:59	734	1.1%	0.20	2.9 MB	2.3%	0.82
Oct 9 21:00:00 - 21:59:59	6310	9.2%	1.75	10.4 MB	8.2%	2.96
Oct 9 22:00:00 - 22:59:59	8501	12.3%	2.36	14.2 MB	11.3%	4.05
Oct 9 23:00:00 - 23:59:59	8078	11.7%	2.24	13.8 MB	10.9%	3.93
Oct 10 00:00:00 - 00:59:59	8065	11.7%	2.24	13.5 MB	10.7%	3.84
Oct 10 01:00:00 - 01:59:59	8117	11.8%	2.25	13.6 MB	10.8%	3.86
Oct 10 02:00:00 - 03:00:01	7610	11.0%	2.11	12.5 MB	9.9%	3.57
TOTAL: 24:00:00	68951	100.0%	0.80	126.3 MB	100.0%	1.50

Sites sending bad articles:

Server		Total	Group	Other
1	chimia.se	11996	0	11996
2	usenet.blueworldhosting.com	2060	428	1632
3	news.sklaff.dev	90	0	90
TOTAL: 3		14146	428	13718

Unwanted newsgroups [Top 20]:

Newsgroup	Count
de.alt.comm.android	36
nz.general	17
de.etc.finanz.banken+broker	14
fr.rec.bricolage	14
it.discussioni.geometri	14
cn.culture.arts.story	13
hispagatos.mastodon.tag.hacking	12
uk.telecom.mobile	12
de.alt.arnooo	10
de.etc.bahn.bahnpolitik	10
de.newusers.infos	10
can.politics	9
de.rec.heimwerken	9
sfnet.huuhaa	9
fr.misc.tabac	7
free.willey	7
hispagatos.hacking.ransomware	7
de.comp.os.unix.linux.hardware	6
linux.debian.devel.mentors	6
fido7.su.tormoz	5
TOTAL: 128	428

INND Perl filter [Top 20]:

Reason	Count
EMP (phn path)	6487
EMP (phn nph)	3819
EMP (phl)	1941
EMP (md5)	1160
Too many newsgroups	189
HTML Multipart	31
User-issued cancel	28
Too many newsgroups (meow)	2
Binary: misplaced binary	1
HTML post	1
Too many newsgroups (low_xpost)	1
TOTAL: 11	13660

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	chimia.se	4
	TOTAL: 1	4
Including strange strings
	usenet.blueworldhosting.com	34
	news.sklaff.dev	24
	TOTAL: 2	58
TOTAL: 2		62

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	sklaff.dev	69532	7484	5860	54207	101	10%	23:59:57
2	sklaffkom.se	69060	751	5027	62208	80	1%	23:59:57
3	usenet.blueworldhosting.com	65496	0	5045	57615	77	0%	23:57:58
4	thebunker.nu	0	0	0	0	68950	0%	23:59:57
TOTAL: 4		204088	8235	15932	174030	69208	4%	95:57:49

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	sklaff.dev	16.2 MB	90.4 MB	106.7 MB	1.3 KB/s	1.8 KB	23:59:57
2	sklaffkom.se	798.3 KB	109.4 MB	110.1 MB	1.3 KB/s	1.8 KB	23:59:57
3	thebunker.nu	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:59:57
4	usenet.blueworldhosting.com	0.0 KB	98.3 MB	98.3 MB	1.2 KB/s	1.7 KB	23:57:58
TOTAL: 4		17.0 MB	298.1 MB	315.1 MB	0.9 KB/s	1.8 KB	95:57:49

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	syn-097-079-029-163.biz.spectrum.com	1	30	49.5 KB	1	0	0	00:00:10
TOTAL: 1		1	30	49.5 KB	1	0	0	00:00:55

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	*.biz.spectrum.com	1	30	49.5 KB	1	00:00:10
2	unresolved	24	0	0.0 KB	0	00:00:20
3	*.210.203.35.bc.googleusercontent.com	4	0	0.0 KB	0	00:00:02
4	*.stretchoid.com	2	0	0.0 KB	0	00:00:10
5	*.internet-census.org	1	0	0.0 KB	0	00:00:10
6	*.ip.linodeusercontent.com	1	0	0.0 KB	0	00:00:00
7	*.monitoring.internet-measurement.com	1	0	0.0 KB	0	00:00:01
TOTAL: 7		34	30	49.5 KB	1	00:00:55

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
syn-097-079-029-163.biz.spectrum.com	0.010	0.013	00:00:10
sh-chi-us-gp1-wk136b.internet-census.org	0.005	0.008	00:00:10
azpdss251azz.stretchoid.com	0.016	0.006	00:00:10
147.185.133.201	0.043	0.004	00:00:05
104.152.52.73	0.073	0.012	00:00:05
104.152.52.70	0.083	0.007	00:00:02
104.152.52.67	0.050	0.014	00:00:02
104.152.52.63	0.008	0.004	00:00:01
sensitive.monitoring.internet-measurement.com	0.007	0.006	00:00:01
205.210.31.226	0.011	0.009	00:00:01
172.210.203.35.bc.googleusercontent.com	0.080	0.010	00:00:01
150.210.203.35.bc.googleusercontent.com	0.081	0.011	00:00:00
104.152.52.68	0.041	0.005	00:00:00
104.152.52.60	0.308	0.031	00:00:00
206.168.34.209	0.044	0.008	00:00:00
104.152.52.69	0.007	0.005	00:00:00
198.235.24.138	0.007	0.004	00:00:00
147.185.133.30	0.042	0.005	00:00:00
104.152.52.61	0.009	0.003	00:00:00
45-33-109-17.ip.linodeusercontent.com	0.039	0.005	00:00:00
TOTAL: 22	1.011	0.178	00:00:55

Curious NNRP server explorers [Top 20]:

System	Conn
104.152.52.60	5
104.152.52.63	2
104.152.52.67	2
104.152.52.70	2
104.152.52.73	2
150.210.203.35.bc.googleusercontent.com	2
172.210.203.35.bc.googleusercontent.com	2
azpdss251azz.stretchoid.com	2
104.152.52.55	1
104.152.52.61	1
104.152.52.65	1
104.152.52.68	1
104.152.52.69	1
147.185.133.201	1
147.185.133.30	1
198.235.24.138	1
198.235.24.180	1
205.210.31.226	1
206.168.34.209	1
45-33-109-17.ip.linodeusercontent.com	1
TOTAL: 22	33

NNRP gethostbyaddr failures [Top 20]:

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

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

System	Conn
104.152.52.67	5
104.152.52.70	5
147.185.133.201	4
147.185.133.30	4
150.210.203.35.bc.googleusercontent.com	4
172.210.203.35.bc.googleusercontent.com	4
104.152.52.61	3
104.152.52.68	2
104.152.52.69	2
104.152.52.63	1
206.168.34.209	1
azpdss251azz.stretchoid.com	1
TOTAL: 12	36

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

Command	Count
GET / HTTP/1.1	6
Accept: /	4
Host: 109.238.130.155:563	4
Accept-Encoding: gzip	2
Connection: close	2
EHLO 109.238.130.155	2
Host: 109.238.130.155	2
MAIL FROM:<relaycheck_please_ignore@prot...	2
User-Agent: Hello from Palo Alto Network...	2
User-Agent: curl/7.61.1	2
User-Agent: curl/7.68.0	2
#026#003#001#001#004#001	1
EHLO www.censys.io	1
MGLNDD_109.238.130.155_119	1
SSH-2.0-Go	1
±á#036#021¤0Èk¾ˆŒ Âô#025	1
À#024#023#001#023#002#023#003#001	1
TOTAL: 17	36

NNRP client timeouts [Top 20]:

System	Conn	Peer
104.152.52.68	1	1
104.152.52.70	1	2
147.185.133.201	1	1
147.185.133.30	1	1
150.210.203.35.bc.googleusercontent.com	1	2
172.210.203.35.bc.googleusercontent.com	1	2
TOTAL: 6	6	14

Newsgroup request counts (by hierarchy):

Hierarchy		Count	Pct
1	comp	30	100.0%
TOTAL: 1		30	100.0%

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

Newsgroup		Count
1	comp.lang.awk	30
TOTAL: 1		30

Daily Usenet report

Oct 9 03:00:01 -- Oct 10 03:00:01