Daily Usenet report: Oct 17 03:00:01

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Oct 17 03:04:28 news innd: message repeated 2 times: [ ctlinnd command s]

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	125838	71.6%	17.1 MB	75.9%
innd	47530	27.1%	5.2 MB	23.1%
innfeed	2217	1.3%	207.6 KB	0.9%
nnrpd	114	0.1%	12.2 KB	0.1%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 5	175700	100.0%	22.5 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	125654	49.4%
Negative hits	125634	49.4%
Cache misses	2392	0.9%
Positive hits	465	0.2%
TOTAL: 4	254145	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.141	0.0%	209	0.000	0.675	36.000
article cleanup	00:00:00.456	0.0%	125746	0.000	0.004	0.500
article logging	00:00:01.960	0.0%	125810	0.000	0.016	0.500
article parse	00:00:01.155	0.0%	360486	0.000	0.003	0.500
article write	00:01:07.091	0.1%	86143	0.000	0.779	103.333
artlog/artparse	00:00:00.000	0.0%	8	0.000	0.000	0.000
data move	00:00:00.186	0.0%	378238	0.000	0.000	0.706
hisgrep/artcncl	00:00:00.031	0.0%	209	0.000	0.148	2.000
hishave/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:07:31.444	0.5%	254364	0.000	1.775	75.000
history sync	00:00:00.696	0.0%	1060	0.000	0.657	215.000
history write	00:03:16.583	0.2%	125754	0.000	1.563	76.000
hiswrite/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	23:44:07.138	98.9%	371382	64.437	230.079	60060.000
nntp read	00:00:02.700	0.0%	370162	0.000	0.007	2.000
overview write	00:00:16.443	0.0%	86143	0.000	0.191	154.000
perl filter	00:02:54.955	0.2%	125746	0.000	1.391	453.000
python filter	00:00:05.819	0.0%	241621	0.000	0.024	5.400
site send	00:00:00.695	0.0%	86143	0.000	0.008	1.000
TOTAL: 23:59:49.381	23:59:27.493	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.152	0.0%	86123	0.000	0.002	0.250
article prepare	00:00:00.023	0.0%	319328	0.000	0.000	0.050
article read	00:00:06.703	0.0%	79575	0.000	0.084	6.000
backlog stats	00:00:00.112	0.0%	424061	0.000	0.000	0.200
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.599	0.0%	252392	0.000	0.006	0.286
data write	00:00:02.437	0.0%	166778	0.000	0.015	0.333
idle	23:59:06.970	100.0%	424061	59.888	203.619	30099.500
status file	00:00:00.169	0.0%	190	0.000	0.889	11.667
TOTAL: 23:59:22.753	23:59:18.165	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:14.285	54.8%	9	63.500	1587.222	10050.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.000	0.0%	74	0.000	0.000	0.000
TOTAL: 00:00:26.079	00:00:14.285	54.8%	-	-	-	-

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	116027	77202	2857	35968	66%	10:33:02
2	usenet.blueworldhosting.com	288	12735	9051	0	3684	71%	23:48:31
3	localhost	25	0	0	0	0	0%	00:00:00
TOTAL: 3		314	128762	86253	2857	39652	66%	34:21:33

Incoming Volume (INN):

Server		AcceptVol	RejVol	TotalVol	%Acc	Vol/Art
1	chimia.se	203.5 MB	87.9 MB	291.4 MB	69%	2.6 KB
2	usenet.blueworldhosting.com	23.4 MB	6.3 MB	29.6 MB	78%	2.4 KB
3	localhost	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 3		226.9 MB	94.2 MB	321.1 MB	70%	2.6 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Oct 17 03:00:01 - 03:59:59	256	0.3%	0.07	520.5 KB	0.2%	0.14
Oct 17 04:00:00 - 04:59:59	204	0.2%	0.06	350.9 KB	0.2%	0.10
Oct 17 05:00:00 - 05:59:59	247	0.3%	0.07	533.0 KB	0.2%	0.15
Oct 17 06:00:00 - 06:59:59	219	0.3%	0.06	581.8 KB	0.3%	0.16
Oct 17 07:00:00 - 07:59:59	273	0.3%	0.08	556.3 KB	0.2%	0.15
Oct 17 08:00:00 - 08:59:59	356	0.4%	0.10	1.1 MB	0.5%	0.33
Oct 17 09:00:00 - 09:59:59	402	0.5%	0.11	927.8 KB	0.4%	0.26
Oct 17 10:00:00 - 10:59:59	480	0.6%	0.13	1.2 MB	0.5%	0.33
Oct 17 11:00:00 - 11:59:59	455	0.5%	0.13	1.1 MB	0.5%	0.31
Oct 17 12:00:00 - 12:59:59	435	0.5%	0.12	1.2 MB	0.5%	0.34
Oct 17 13:00:00 - 13:59:59	482	0.6%	0.13	1.3 MB	0.6%	0.38
Oct 17 14:00:00 - 14:59:59	424	0.5%	0.12	1006.3 KB	0.4%	0.28
Oct 17 15:00:00 - 15:59:59	412	0.5%	0.11	940.6 KB	0.4%	0.26
Oct 17 16:00:00 - 16:59:59	3681	4.3%	1.02	9.6 MB	4.2%	2.74
Oct 17 17:00:00 - 17:59:59	7592	8.8%	2.11	20.6 MB	9.1%	5.86
Oct 17 18:00:00 - 18:59:59	6188	7.2%	1.72	16.0 MB	7.0%	4.54
Oct 17 19:00:00 - 19:59:59	6348	7.4%	1.76	17.0 MB	7.5%	4.84
Oct 17 20:00:00 - 20:59:59	9010	10.5%	2.50	28.4 MB	12.5%	8.06
Oct 17 21:00:00 - 21:59:59	10004	11.6%	2.78	24.7 MB	10.9%	7.03
Oct 17 22:00:00 - 22:59:59	7980	9.3%	2.22	20.5 MB	9.0%	5.83
Oct 17 23:00:00 - 23:59:59	9014	10.5%	2.50	21.9 MB	9.6%	6.22
Oct 18 00:00:00 - 00:59:59	7126	8.3%	1.98	17.7 MB	7.8%	5.04
Oct 18 01:00:00 - 01:59:59	6723	7.8%	1.87	17.1 MB	7.6%	4.88
Oct 18 02:00:00 - 02:59:59	7892	9.2%	2.19	22.3 MB	9.8%	6.33
Oct 18 03:00:00 - 03:00:01	5	0.0%	5.00	14.1 KB	0.0%	14.05
TOTAL: 24:00:00	86208	100.0%	1.00	227.0 MB	100.0%	2.69

Sites sending bad articles:

Server		Total	Group	Other
1	chimia.se	35884	0	35884
2	usenet.blueworldhosting.com	3746	370	3376
TOTAL: 2		39630	370	39260

Unwanted newsgroups [Top 20]:

Newsgroup	Count
linux.gentoo.user	25
de.comm.provider.misc	22
hispagatos.hacking.ransomware	20
de.rec.tv.technik	16
de.etc.finanz.banken+broker	12
it.discussioni.geometri	12
de.comm.software.crosspoint	11
it.sport.motociclismo	10
sfnet.huuhaa	10
nz.general	9
de.comp.sys.mac.misc	8
fr.comp.sys.mac.communication	8
linux.debian.ports.hurd	8
newsreader.test	7
alt.my.job.sucks	6
de.rec.garten	6
fr.rec.moto	6
free.it.scienza.fisica	6
uk.telecom.mobile	6
dk.kultur.sprog	5
TOTAL: 113	370

INND Perl filter [Top 20]:

Reason	Count
EMP (phn path)	12825
EMP (phn nph)	11867
EMP (phl)	11638
EMP (md5)	2554
Too many newsgroups	155
Subject Rejected	52
MI5 Filter	19
Excessive Supersedes (82.68.34.86)	14
HTML post	14
User-issued cancel	14
HTML Multipart	10
EMP (fsl)	9
Excessive Supersedes (bronze.lcs.mit.edu)	5
Scoring filter	3
Too many newsgroups (low_xpost)	3
Excessive Supersedes (194.214.18.252)	2
Binary: misplaced binary	1
Excessive Supersedes (windlord.stanford.edu)	1
HTML file attachment	1
PFM bot misc	1
TOTAL: 20	39188

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	chimia.se	1
	TOTAL: 1	1
Including strange strings
	usenet.blueworldhosting.com	55
	chimia.se	9
	TOTAL: 2	64
No colon-space in header field
	usenet.blueworldhosting.com	8
	TOTAL: 1	8
TOTAL: 3		73

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	sklaffkom.se	86856	530	6548	79129	0	0%	23:59:57
2	usenet.blueworldhosting.com	258	0	1	257	0	0%	01:06:34
3	sklaff.dev	0	0	0	0	86207	0%	23:57:42
4	thebunker.nu	0	0	0	0	86207	0%	23:59:57
TOTAL: 4		87114	530	6549	79386	172414	0%	73:04:10

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	sklaffkom.se	609.1 KB	210.9 MB	211.5 MB	2.5 KB/s	2.7 KB	23:59:57
2	sklaff.dev	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:57:42
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	2.3 MB	2.3 MB	0.6 KB/s	9.2 KB	01:06:34
TOTAL: 4		609.1 KB	213.2 MB	213.8 MB	0.8 KB/s	2.7 KB	73:04:10

NNRP readership statistics:

System		Conn	Elapsed
1	109.210.203.35.bc.googleusercontent.com	2	00:00:00
2	180.149.216.162.bc.googleusercontent.com	2	00:00:01
3	azpdcsntzeye.stretchoid.com	2	00:00:10
4	198.235.24.174	1	00:00:00
5	198.235.24.51	1	00:00:01
6	206.168.34.218	1	00:00:03
7	248.150.216.162.bc.googleusercontent.com	1	00:00:00
8	42.149.216.162.bc.googleusercontent.com	1	00:00:00
9	awesome.monitoring.internet-measurement.com	1	00:00:00
10	effortless.monitoring.internet-measurement.com	1	00:00:03
11	equitable.monitoring.internet-measurement.com	1	00:00:00
12	kind.monitoring.internet-measurement.com	1	00:00:00
13	sage.monitoring.internet-measurement.com	1	00:00:03
14	scanner-07.ch1.censys-scanner.com	1	00:00:01
15	sweet.monitoring.internet-measurement.com	1	00:00:00
TOTAL: 15		18	00:00:26

NNRP readership statistics (by domain):

System		Conn	Elapsed
1	*.monitoring.internet-measurement.com	6	00:00:06
2	*.149.216.162.bc.googleusercontent.com	3	00:00:01
3	unresolved	3	00:00:05
4	*.210.203.35.bc.googleusercontent.com	2	00:00:00
5	*.stretchoid.com	2	00:00:10
6	*.150.216.162.bc.googleusercontent.com	1	00:00:00
7	*.ch1.censys-scanner.com	1	00:00:01
TOTAL: 7		18	00:00:26

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
azpdcsntzeye.stretchoid.com	0.016	0.009	00:00:10
206.168.34.218	0.038	0.006	00:00:03
effortless.monitoring.internet-measurement.com	0.040	0.006	00:00:03
sage.monitoring.internet-measurement.com	0.056	0.011	00:00:03
198.235.24.51	0.006	0.009	00:00:01
scanner-07.ch1.censys-scanner.com	0.047	0.005	00:00:01
180.149.216.162.bc.googleusercontent.com	0.082	0.006	00:00:01
109.210.203.35.bc.googleusercontent.com	0.081	0.008	00:00:00
248.150.216.162.bc.googleusercontent.com	0.054	0.010	00:00:00
42.149.216.162.bc.googleusercontent.com	0.040	0.007	00:00:00
198.235.24.174	0.007	0.006	00:00:00
sweet.monitoring.internet-measurement.com	0.053	0.008	00:00:00
equitable.monitoring.internet-measurement.com	0.041	0.005	00:00:00
awesome.monitoring.internet-measurement.com	0.040	0.004	00:00:00
TOTAL: 14	0.601	0.100	00:00:26

NNRP gethostbyaddr failures [Top 20]:

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

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

System	Conn
109.210.203.35.bc.googleusercontent.com	4
180.149.216.162.bc.googleusercontent.com	4
248.150.216.162.bc.googleusercontent.com	4
42.149.216.162.bc.googleusercontent.com	4
206.168.34.218	1
azpdcsntzeye.stretchoid.com	1
scanner-07.ch1.censys-scanner.com	1
TOTAL: 7	19

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

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

NNRP client timeouts [Top 20]:

System	Conn	Peer
109.210.203.35.bc.googleusercontent.com	1	2
180.149.216.162.bc.googleusercontent.com	1	2
248.150.216.162.bc.googleusercontent.com	1	1
42.149.216.162.bc.googleusercontent.com	1	1
TOTAL: 4	4	9

Daily Usenet report

Oct 17 03:00:01 -- Oct 18 03:00:01