Daily Usenet report: Oct 16 03:00:01

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Oct 16 03:03:53 news innd: message repeated 2 times: [ ctlinnd command s]

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	170606	72.4%	23.0 MB	76.3%
innd	62407	26.5%	6.9 MB	22.9%
innfeed	2227	0.9%	217.5 KB	0.7%
nnrpd	255	0.1%	25.6 KB	0.1%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 5	235496	100.0%	30.2 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	170478	49.7%
Negative hits	170422	49.7%
Cache misses	1433	0.4%
Positive hits	378	0.1%
TOTAL: 4	342711	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.157	0.0%	87	0.000	1.805	29.000
article cleanup	00:00:00.731	0.0%	170450	0.000	0.004	0.333
article logging	00:00:02.695	0.0%	170496	0.000	0.016	1.000
article parse	00:00:01.477	0.0%	497497	0.000	0.003	1.000
article write	00:03:19.023	0.2%	116673	0.000	1.706	157.000
artlog/artparse	00:00:00.000	0.0%	2	0.000	0.000	0.000
data move	00:00:00.380	0.0%	508077	0.000	0.001	6.188
hisgrep/artcncl	00:00:00.012	0.0%	87	0.000	0.138	2.000
hishave/artparse	00:00:00.000	0.0%	1	0.000	0.000	0.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:11:51.212	0.8%	342714	0.000	2.075	33.250
history sync	00:00:00.316	0.0%	807	0.000	0.392	201.000
history write	00:04:11.716	0.3%	170450	0.000	1.477	50.667
hiswrite/artparse	00:00:00.000	0.0%	1	0.000	0.000	0.000
idle	23:36:03.780	98.3%	505125	48.862	168.203	60061.000
nntp read	00:00:03.660	0.0%	504165	0.000	0.007	0.250
overview write	00:00:21.402	0.0%	116673	0.000	0.183	88.000
perl filter	00:03:36.388	0.3%	170449	0.000	1.270	420.000
python filter	00:00:08.973	0.0%	332322	0.000	0.027	16.000
site send	00:00:00.903	0.0%	116672	0.000	0.008	1.000
TOTAL: 24:00:08.687	23:59:42.825	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.211	0.0%	116655	0.000	0.002	0.500
article prepare	00:00:00.030	0.0%	442164	0.000	0.000	0.004
article read	00:00:10.438	0.0%	110126	0.000	0.095	27.667
backlog stats	00:00:00.158	0.0%	577121	0.000	0.000	0.167
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:02.138	0.0%	344328	0.000	0.006	0.500
data write	00:00:03.281	0.0%	228149	0.000	0.014	1.000
idle	23:58:39.470	100.0%	577121	61.166	149.569	30100.000
status file	00:00:00.139	0.0%	185	0.000	0.751	49.000
TOTAL: 23:59:01.599	23:58:55.865	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:23.486	66.9%	20	59.000	1174.300	10039.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.002	0.0%	156	0.000	0.013	1.000
TOTAL: 00:00:35.111	00:00:23.488	66.9%	-	-	-	-

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	1	161810	108171	1809	51830	66%	15:01:29
2	usenet.blueworldhosting.com	288	10386	8475	0	1911	81%	23:43:39
3	localhost	25	0	0	0	0	0%	00:00:00
TOTAL: 3		314	172196	116646	1809	53741	67%	38:45:08

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	chimia.se	219.9 MB	2.8 KB	91.9 MB	311.9 MB	70%	2.0 KB
2	usenet.blueworldhosting.com	21.9 MB	0.0 KB	4.2 MB	26.1 MB	83%	2.6 KB
3	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 3		241.8 MB	2.8 KB	96.2 MB	338.0 MB	71%	2.0 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Oct 16 03:00:01 - 03:59:59	226	0.2%	0.06	563.4 KB	0.2%	0.16
Oct 16 04:00:00 - 04:59:59	195	0.2%	0.05	349.1 KB	0.1%	0.10
Oct 16 05:00:00 - 05:59:59	242	0.2%	0.07	599.7 KB	0.2%	0.17
Oct 16 06:00:00 - 06:59:59	246	0.2%	0.07	465.8 KB	0.2%	0.13
Oct 16 07:00:00 - 07:59:59	278	0.2%	0.08	678.1 KB	0.3%	0.19
Oct 16 08:00:00 - 08:59:59	304	0.3%	0.08	573.9 KB	0.2%	0.16
Oct 16 09:00:00 - 09:59:59	375	0.3%	0.10	1.1 MB	0.5%	0.31
Oct 16 10:00:00 - 10:59:59	447	0.4%	0.12	1.1 MB	0.5%	0.31
Oct 16 11:00:00 - 11:59:59	655	0.6%	0.18	1.3 MB	0.5%	0.38
Oct 16 12:00:00 - 12:59:59	8272	7.1%	2.30	15.1 MB	6.2%	4.28
Oct 16 13:00:00 - 13:59:59	7745	6.6%	2.15	13.8 MB	5.7%	3.94
Oct 16 14:00:00 - 14:59:59	7141	6.1%	1.98	12.5 MB	5.2%	3.55
Oct 16 15:00:00 - 15:59:59	7108	6.1%	1.97	12.7 MB	5.3%	3.63
Oct 16 16:00:00 - 16:59:59	6600	5.7%	1.83	11.7 MB	4.8%	3.32
Oct 16 17:00:00 - 17:59:59	6941	5.9%	1.93	12.7 MB	5.2%	3.60
Oct 16 18:00:00 - 18:59:59	7080	6.1%	1.97	11.8 MB	4.9%	3.37
Oct 16 19:00:00 - 19:59:59	7395	6.3%	2.05	12.4 MB	5.1%	3.52
Oct 16 20:00:00 - 20:59:59	7126	6.1%	1.98	12.4 MB	5.1%	3.54
Oct 16 21:00:00 - 21:59:59	7126	6.1%	1.98	12.2 MB	5.1%	3.48
Oct 16 22:00:00 - 22:59:59	6922	5.9%	1.92	11.6 MB	4.8%	3.31
Oct 16 23:00:00 - 23:59:59	7961	6.8%	2.21	23.8 MB	9.8%	6.78
Oct 17 00:00:00 - 00:59:59	9604	8.2%	2.67	26.6 MB	11.0%	7.56
Oct 17 01:00:00 - 01:59:59	8369	7.2%	2.32	21.9 MB	9.1%	6.24
Oct 17 02:00:00 - 02:59:59	8363	7.2%	2.32	23.9 MB	9.9%	6.81
Oct 17 03:00:00 - 03:00:01	3	0.0%	3.00	4.4 KB	0.0%	4.40
TOTAL: 24:00:00	116724	100.0%	1.35	242.0 MB	100.0%	2.87

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	chimia.se	51942	0	1	51941
2	usenet.blueworldhosting.com	1940	295	0	1645
TOTAL: 2		53882	295	1	53586

Unwanted newsgroups [Top 20]:

Newsgroup	Count
free.it.scienza.fisica	22
hispagatos.hacking.ransomware	19
de.comm.software.crosspoint	12
de.comp.os.unix.shell	12
de.newusers.infos	10
de.rec.film.misc	10
fr.comp.usenet.lecteurs-de-news	10
fr.comp.sys.mac.materiel	8
sfnet.huuhaa	8
fr.comp.sys.mac.communication	7
pl.comp.os.ms-windows.winnt	7
uk.rec.gardening	7
de.rec.tv.technik	6
fido7.ru.sex.condoms	6
fido7.su.comp.old	6
fr.rec.moto	6
linux.ubuntu.security.announce	6
de.alt.fan.aldi	4
de.etc.finanz.banken+broker	4
free.willey	4
TOTAL: 106	295

INND Perl filter [Top 20]:

Reason	Count
EMP (phn path)	28265
EMP (phn nph)	20544
EMP (phl)	2491
EMP (md5)	1311
Too many newsgroups	489
HTML Multipart	150
Too many newsgroups (meow)	114
Subject Rejected	54
MI5 Filter	45
Excessive Supersedes (cascade.mit.edu)	19
HTML post	19
Too many newsgroups (low_xpost)	12
User-issued cancel	12
Scoring filter	6
EMP (phr path)	2
Adult group ECP	1
Binary Image: misplaced jpg	1
Binary: misplaced binary	1
HTML Image Tags	1
NewsAgent	1
TOTAL: 20	53538

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	chimia.se	18
	TOTAL: 1	18
Huge articles
	chimia.se	1
	TOTAL: 1	1
Including strange strings
	usenet.blueworldhosting.com	29
	chimia.se	17
	TOTAL: 2	46
No colon-space in header field
	usenet.blueworldhosting.com	1
	TOTAL: 1	1
TOTAL: 4		66

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	sklaffkom.se	117323	278	6531	109901	7	0%	23:59:57
2	usenet.blueworldhosting.com	439	0	6	433	0	0%	01:12:53
3	sklaff.dev	0	0	0	0	116710	0%	23:57:43
4	thebunker.nu	0	0	0	0	116710	0%	23:59:57
TOTAL: 4		117762	278	6537	110334	233427	0%	73:10:30

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	sklaffkom.se	261.1 KB	227.3 MB	227.6 MB	2.7 KB/s	2.1 KB	23:59:57
2	sklaff.dev	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:57:43
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	6.8 MB	6.8 MB	1.6 KB/s	16.2 KB	01:12:53
TOTAL: 4		261.1 KB	234.2 MB	234.4 MB	0.9 KB/s	2.2 KB	73:10:30

NNRP readership statistics:

System		Conn	Elapsed
1	104.152.52.114	8	00:00:01
2	104.152.52.202	4	00:00:00
3	104.152.52.105	2	00:00:00
4	104.152.52.113	2	00:00:01
5	179.150.216.162.bc.googleusercontent.com	2	00:00:01
6	61.210.203.35.bc.googleusercontent.com	2	00:00:00
7	azpdsgepdp5r.stretchoid.com	2	00:00:10
8	104.152.52.100	1	00:00:01
9	104.152.52.115	1	00:00:01
10	104.152.52.121	1	00:00:00
11	104.152.52.130	1	00:00:01
12	104.152.52.136	1	00:00:00
13	104.152.52.138	1	00:00:00
14	104.152.52.143	1	00:00:01
15	104.152.52.237	1	00:00:00
16	147.185.132.195	1	00:00:03
17	147.185.132.39	1	00:00:03
18	205.210.31.171	1	00:00:00
19	252.210.203.35.bc.googleusercontent.com	1	00:00:00
20	43.210.203.35.bc.googleusercontent.com	1	00:00:00
21	70.211.203.35.bc.googleusercontent.com	1	00:00:00
22	scanner-201.ch1.censys-scanner.com	1	00:00:03
TOTAL: 22		37	00:00:35

NNRP readership statistics (by domain):

System		Conn	Elapsed
1	unresolved	27	00:00:19
2	*.210.203.35.bc.googleusercontent.com	4	00:00:01
3	*.150.216.162.bc.googleusercontent.com	2	00:00:01
4	*.stretchoid.com	2	00:00:10
5	*.211.203.35.bc.googleusercontent.com	1	00:00:00
6	*.ch1.censys-scanner.com	1	00:00:03
TOTAL: 6		37	00:00:35

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
azpdsgepdp5r.stretchoid.com	0.013	0.011	00:00:10
147.185.132.195	0.008	0.006	00:00:03
147.185.132.39	0.007	0.008	00:00:03
scanner-201.ch1.censys-scanner.com	0.041	0.004	00:00:03
104.152.52.143	0.007	0.005	00:00:01
104.152.52.113	0.082	0.006	00:00:01
104.152.52.100	0.037	0.007	00:00:01
104.152.52.114	0.391	0.048	00:00:01
104.152.52.115	0.037	0.006	00:00:01
104.152.52.130	0.007	0.004	00:00:01
179.150.216.162.bc.googleusercontent.com	0.119	0.008	00:00:01
61.210.203.35.bc.googleusercontent.com	0.084	0.006	00:00:00
104.152.52.237	0.075	0.005	00:00:00
104.152.52.121	0.038	0.007	00:00:00
104.152.52.202	0.281	0.027	00:00:00
104.152.52.138	0.007	0.004	00:00:00
205.210.31.171	0.004	0.008	00:00:00
70.211.203.35.bc.googleusercontent.com	0.040	0.006	00:00:00
43.210.203.35.bc.googleusercontent.com	0.043	0.007	00:00:00
252.210.203.35.bc.googleusercontent.com	0.040	0.008	00:00:00
TOTAL: 22	1.481	0.208	00:00:35

NNRP gethostbyaddr failures [Top 20]:

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

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

System	Conn
104.152.52.100	5
104.152.52.130	5
104.152.52.114	4
179.150.216.162.bc.googleusercontent.com	4
252.210.203.35.bc.googleusercontent.com	4
43.210.203.35.bc.googleusercontent.com	4
61.210.203.35.bc.googleusercontent.com	4
70.211.203.35.bc.googleusercontent.com	4
104.152.52.136	2
104.152.52.138	2
104.152.52.237	2
104.152.52.143	1
azpdsgepdp5r.stretchoid.com	1
scanner-201.ch1.censys-scanner.com	1
TOTAL: 14	43

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

Command	Count
GET / HTTP/1.1	7
Host: 109.238.130.155:563	5
Accept: /	4
EHLO 109.238.130.155	4
MAIL FROM:<relaycheck_please_ignore@prot...	4
Accept-Encoding: gzip	3
User-Agent: Hello from Palo Alto Network...	3
Connection: close	2
Host: 109.238.130.155	2
User-Agent: curl/7.61.1	2
User-Agent: curl/7.68.0	2
#026#003#001	1
EHLO www.censys.io	1
MGLNDD_109.238.130.155_119	1
SSH-2.0-Go	1
À#024#023#001#023#002#023#003#001	1
TOTAL: 16	43

NNRP client timeouts [Top 20]:

System	Conn	Peer
104.152.52.100	1	1
104.152.52.114	1	2
104.152.52.237	1	1
179.150.216.162.bc.googleusercontent.com	1	2
252.210.203.35.bc.googleusercontent.com	1	1
43.210.203.35.bc.googleusercontent.com	1	1
61.210.203.35.bc.googleusercontent.com	1	2
70.211.203.35.bc.googleusercontent.com	1	1
TOTAL: 8	8	16

Daily Usenet report

Oct 16 03:00:01 -- Oct 17 03:00:01