Daily Usenet report: Dec 6 03:00:01

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Dec 6 03:30:49 news innd: message repeated 2 times: [ ctlinnd command s]

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	202641	70.3%	28.1 MB	74.7%
innd	83124	28.8%	9.3 MB	24.7%
innfeed	2298	0.8%	232.5 KB	0.6%
nnrpd	226	0.1%	23.8 KB	0.1%
controlchan	1	0.0%	0.1 KB	0.0%
rnews	1	0.0%	0.1 KB	0.0%
TOTAL: 6	288291	100.0%	37.6 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	202618	49.8%
Negative hits	202571	49.8%
Cache misses	1363	0.3%
Positive hits	427	0.1%
TOTAL: 4	406979	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.264	0.0%	12	0.000	22.000	45.000
article cleanup	00:00:00.917	0.0%	202595	0.000	0.005	0.143
article logging	00:00:02.961	0.0%	202641	0.000	0.015	0.125
article parse	00:00:01.731	0.0%	592868	0.000	0.003	0.050
article write	00:08:11.041	0.6%	130663	0.000	3.758	701.000
artlog/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
artlog/artwrite	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:00:00.250	0.0%	601442	0.000	0.000	1.500
hisgrep/artcncl	00:00:00.002	0.0%	12	0.000	0.167	1.000
hishave/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
hissync/artwrite	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:18:59.068	1.3%	406979	0.000	2.799	21.821
history sync	00:00:00.032	0.0%	493	0.000	0.065	20.000
history write	00:03:17.144	0.2%	202594	0.000	0.973	31.000
hiswrite/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	23:23:34.031	97.5%	601342	19.922	140.043	60060.000
nntp read	00:00:05.150	0.0%	600233	0.000	0.009	7.500
overview write	00:00:22.567	0.0%	130663	0.000	0.173	58.000
perl filter	00:04:30.146	0.3%	202594	0.000	1.333	41.000
python filter	00:00:10.406	0.0%	397180	0.000	0.026	0.347
site send	00:00:01.027	0.0%	130663	0.000	0.008	0.091
TOTAL: 23:59:59.213	23:59:16.737	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.206	0.0%	130663	0.000	0.002	0.056
article prepare	00:00:00.029	0.0%	596392	0.000	0.000	0.006
article read	00:00:54.637	0.1%	119291	0.000	0.458	6.000
backlog stats	00:00:00.200	0.0%	728055	0.000	0.000	0.013
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:02.978	0.0%	443292	0.000	0.007	0.250
data write	00:00:04.553	0.0%	313506	0.000	0.015	0.333
idle	23:58:33.463	99.9%	728055	21.051	118.553	30100.000
status file	00:00:00.492	0.0%	196	0.000	2.510	202.500
TOTAL: 23:59:43.639	23:59:36.558	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:27.588	49.4%	82	25.143	336.439	6104.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.001	0.0%	308	0.000	0.003	0.021
TOTAL: 00:00:55.802	00:00:27.589	49.4%	-	-	-	-

Control commands to INND:

Command	Number
flush	2
flushlogs	2
go	1
logmode	2
lowmark	1
mode	144
name	2
pause	1
paused	1
reload	2
TOTAL: 10	158

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	chimia.se	3	194586	122555	1789	70242	62%	23:20:34
2	usenet.blueworldhosting.com	732	9796	8106	0	1690	82%	23:02:09
3	localhost	24	0	0	0	0	0%	00:00:01
4	news.thebunker.nu	6	0	0	0	0	0%	00:00:00
TOTAL: 4		765	204382	130661	1789	71932	63%	46:22:44

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	chimia.se	260.1 MB	10.7 KB	139.9 MB	400.0 MB	65%	2.1 KB
2	usenet.blueworldhosting.com	17.7 MB	0.0 KB	3.4 MB	21.1 MB	83%	2.2 KB
3	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
4	news.thebunker.nu	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 4		277.7 MB	10.7 KB	143.3 MB	421.1 MB	65%	2.1 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Dec 6 03:00:01 - 03:59:59	4289	3.3%	1.19	10.9 MB	3.9%	3.09
Dec 6 04:00:00 - 04:59:59	6343	4.9%	1.76	12.9 MB	4.6%	3.67
Dec 6 05:00:00 - 05:59:59	6194	4.7%	1.72	12.8 MB	4.6%	3.64
Dec 6 06:00:00 - 06:59:59	6433	4.9%	1.79	13.9 MB	5.0%	3.96
Dec 6 07:00:00 - 07:59:59	6051	4.6%	1.68	11.2 MB	4.0%	3.18
Dec 6 08:00:00 - 08:59:59	6252	4.8%	1.74	11.6 MB	4.2%	3.31
Dec 6 09:00:00 - 09:59:59	5573	4.3%	1.55	10.5 MB	3.8%	2.99
Dec 6 10:00:00 - 10:59:59	5273	4.0%	1.46	10.7 MB	3.8%	3.04
Dec 6 11:00:00 - 11:59:59	5547	4.2%	1.54	11.1 MB	4.0%	3.17
Dec 6 12:00:00 - 12:59:59	5625	4.3%	1.56	11.6 MB	4.2%	3.30
Dec 6 13:00:00 - 13:59:59	5430	4.2%	1.51	11.4 MB	4.1%	3.23
Dec 6 14:00:00 - 14:59:59	7511	5.7%	2.09	25.0 MB	9.0%	7.11
Dec 6 15:00:00 - 15:59:59	8856	6.8%	2.46	20.1 MB	7.2%	5.72
Dec 6 16:00:00 - 16:59:59	8170	6.3%	2.27	18.6 MB	6.7%	5.29
Dec 6 17:00:00 - 17:59:59	7654	5.9%	2.13	15.4 MB	5.5%	4.37
Dec 6 18:00:00 - 18:59:59	8107	6.2%	2.25	16.2 MB	5.8%	4.60
Dec 6 19:00:00 - 19:59:59	7509	5.7%	2.09	14.9 MB	5.4%	4.24
Dec 6 20:00:00 - 20:59:59	6603	5.1%	1.83	12.9 MB	4.7%	3.68
Dec 6 21:00:00 - 21:59:59	2524	1.9%	0.70	5.0 MB	1.8%	1.42
Dec 6 22:00:00 - 22:59:59	1599	1.2%	0.44	3.1 MB	1.1%	0.87
Dec 6 23:00:00 - 23:59:59	3192	2.4%	0.89	6.4 MB	2.3%	1.81
Dec 7 00:00:00 - 00:59:59	2349	1.8%	0.65	4.4 MB	1.6%	1.26
Dec 7 01:00:00 - 01:59:59	2539	1.9%	0.71	5.3 MB	1.9%	1.52
Dec 7 02:00:00 - 03:00:02	1040	0.8%	0.29	1.9 MB	0.7%	0.54
TOTAL: 24:00:01	130663	100.0%	1.51	277.7 MB	100.0%	3.29

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	chimia.se	70247	0	1	2	70244
2	usenet.blueworldhosting.com	1731	327	0	0	1404
TOTAL: 2		71978	327	1	2	71648

Unwanted newsgroups [Top 20]:

Newsgroup	Count
de.sci.ing.elektrotechnik	28
hispagatos.hacking.ransomware	20
newsreader.test	17
uk.tech.broadcast	13
free.it.scienza.fisica	12
pl.comp.pecet	11
linux.debian.devel.mentors	10
linux.debian.maint.python	10
uk.telecom.voip	10
linux.debian.project	9
muc.lists.netbsd.port.mips	9
hispagatos.mastodon.tag.hacking	8
muc.lists.freebsd.multimedia	7
muc.lists.netbsd.port.sparc	7
de.etc.post	6
fido7.starper.limited	6
free.willey	6
pl.misc.kolej	6
bln.test	5
de.rec.sport.fussball	5
TOTAL: 105	327

Supposedly-moderated groups with unmoderated postings [Top 20]:

Groups	Count
news.newusers.questions	2
TOTAL: 1	2

INND Perl filter [Top 20]:

Reason	Count
EMP (phn path)	31333
EMP (phn nph)	28169
EMP (phl)	10145
EMP (md5)	1019
HTML Multipart	412
User-issued cancel	251
Too many newsgroups	115
Subject Rejected	71
MI5 Filter	41
Scoring filter	13
Too many newsgroups (low_xpost)	13
Too many newsgroups (meow)	8
HTML post	6
Binary: misplaced binary	3
Binary Image: misplaced gif	1
HTML Image Tags	1
Too many test groups in crosspost	1
TOTAL: 17	71602

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	usenet.blueworldhosting.com	1
	TOTAL: 1	1
Including strange strings
	usenet.blueworldhosting.com	41
	chimia.se	5
	TOTAL: 2	46
TOTAL: 2		47

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	sklaffkom.se	130774	1428	12684	116546	0	1%	23:38:00
2	usenet.blueworldhosting.com	33565	0	2441	31124	0	0%	05:06:20
3	sklaff.dev	0	0	0	0	130658	0%	23:57:44
4	thebunker.nu	0	0	0	0	130658	0%	23:59:58
TOTAL: 4		164339	1428	15125	147670	261316	0%	76:42:02

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	sklaffkom.se	2.3 MB	245.1 MB	247.4 MB	3.0 KB/s	2.1 KB	23:38:00
2	sklaff.dev	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:57:44
3	thebunker.nu	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:59:58
4	usenet.blueworldhosting.com	0.0 KB	73.4 MB	73.4 MB	4.1 KB/s	2.4 KB	05:06:20
TOTAL: 4		2.3 MB	318.5 MB	320.8 MB	1.2 KB/s	2.2 KB	76:42:02

Rnews connections rejected:

Reason	Conn
400 No space left on device writing SMstore file -- throttling	1
TOTAL: 1	1

NNRP readership statistics:

System		Conn	Elapsed
1	81-229-79-101-no600.tbcn.telia.com	6	00:00:02
2	167.94.138.190	3	00:00:05
3	26.149.216.162.bc.googleusercontent.com	2	00:00:08
4	4.210.203.35.bc.googleusercontent.com	2	00:00:11
5	athens.scan.bufferover.run	2	00:00:00
6	c-5eea5ba9-74736162.cust.telenor.se	2	00:00:01
7	prague.scan.bufferover.run	2	00:00:00
8	seamus.probe.onyphe.net	2	00:00:05
9	198.235.24.82	1	00:00:02
10	205.210.31.23	1	00:00:04
11	222.210.203.35.bc.googleusercontent.com	1	00:00:00
12	51.159.234.118	1	00:00:00
13	72.149.216.162.bc.googleusercontent.com	1	00:00:00
14	admired.monitoring.internet-measurement.com	1	00:00:00
15	advisable.monitoring.internet-measurement.com	1	00:00:03
16	approachable.monitoring.internet-measurement.com	1	00:00:00
17	energetic.monitoring.internet-measurement.com	1	00:00:00
18	hopper.probe.onyphe.net	1	00:00:00
19	limitless.monitoring.internet-measurement.com	1	00:00:03
20	mesmerizing.monitoring.internet-measurement.com	1	00:00:00
21	ray.probe.onyphe.net	1	00:00:06
22	streamlined.monitoring.internet-measurement.com	1	00:00:00
23	stupendous.monitoring.internet-measurement.com	1	00:00:00
TOTAL: 23		36	00:00:55

NNRP readership statistics (by domain):

System		Conn	Elapsed
1	*.monitoring.internet-measurement.com	8	00:00:06
2	*.tbcn.telia.com	6	00:00:02
3	unresolved	6	00:00:12
4	*.probe.onyphe.net	4	00:00:12
5	*.scan.bufferover.run	4	00:00:00
6	*.149.216.162.bc.googleusercontent.com	3	00:00:08
7	*.210.203.35.bc.googleusercontent.com	3	00:00:11
8	*.cust.telenor.se	2	00:00:01
TOTAL: 8		36	00:00:55

NNRP auth users [Top 20]:

User	Conn
peterlondon	8
TOTAL: 1	8

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
4.210.203.35.bc.googleusercontent.com	0.077	0.013	0.000	00:00:11
26.149.216.162.bc.googleusercontent.com	0.082	0.009	0.000	00:00:08
ray.probe.onyphe.net	0.007	0.006	0.000	00:00:06
167.94.138.190	0.056	0.015	0.000	00:00:05
seamus.probe.onyphe.net	0.013	0.012	0.000	00:00:05
205.210.31.23	0.008	0.004	0.000	00:00:04
limitless.monitoring.internet-measurement.com	0.036	0.008	0.000	00:00:03
advisable.monitoring.internet-measurement.com	0.042	0.006	0.000	00:00:03
198.235.24.82	0.006	0.008	0.000	00:00:02
81-229-79-101-no600.tbcn.telia.com	0.061	0.030	0.174	00:00:02
c-5eea5ba9-74736162.cust.telenor.se	0.014	0.017	0.062	00:00:01
hopper.probe.onyphe.net	0.007	0.007	0.000	00:00:00
72.149.216.162.bc.googleusercontent.com	0.039	0.005	0.000	00:00:00
prague.scan.bufferover.run	0.015	0.007	0.000	00:00:00
222.210.203.35.bc.googleusercontent.com	0.041	0.005	0.000	00:00:00
athens.scan.bufferover.run	0.011	0.014	0.000	00:00:00
51.159.234.118	0.038	0.005	0.000	00:00:00
streamlined.monitoring.internet-measurement.com	0.039	0.005	0.000	00:00:00
admired.monitoring.internet-measurement.com	0.046	0.005	0.000	00:00:00
TOTAL: 19	0.638	0.181	0.236	00:00:55

NNRP gethostbyaddr failures [Top 20]:

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

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

System	Conn
prague.scan.bufferover.run	8
athens.scan.bufferover.run	7
222.210.203.35.bc.googleusercontent.com	4
26.149.216.162.bc.googleusercontent.com	4
4.210.203.35.bc.googleusercontent.com	4
72.149.216.162.bc.googleusercontent.com	4
hopper.probe.onyphe.net	2
seamus.probe.onyphe.net	2
167.94.138.190	1
TOTAL: 9	36

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

Command	Count
GET / HTTP/1.1	5
Host: 109.238.130.155:563	4
#001	3
Accept-Encoding: gzip	3
Accept: /	3
#026#003#001#001	2
#026#003#003#001¨#001	2
User-Agent: Hello from Palo Alto Network...	2
User-Agent: curl/7.68.0	2
À#024	2
À$À(À#À'	2
À$ÀÀ¯À,ÀrÀsÌ©#023#002#023#001Ì#024À#007À#022À#023À'À/À#024À(À0À`Àa...	2
#026#003#001	1
EHLO www.censys.io	1
Host: 109.238.130.155:119	1
User-Agent: Mozilla/5.0 (Macintosh; Inte...	1
TOTAL: 16	36

NNRP client timeouts [Top 20]:

System	Conn	Peer
167.94.138.190	1	2
222.210.203.35.bc.googleusercontent.com	1	1
26.149.216.162.bc.googleusercontent.com	1	2
4.210.203.35.bc.googleusercontent.com	1	2
72.149.216.162.bc.googleusercontent.com	1	1
TOTAL: 5	5	11

Daily Usenet report

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