Daily Usenet report: Nov 25 03:00:02

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Nov 25 03:52:50 news innd: message repeated 2 times: [ ctlinnd command s]

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	265622	64.5%	34.0 MB	67.9%
innd	143355	34.8%	15.7 MB	31.5%
innfeed	2613	0.6%	279.7 KB	0.5%
nnrpd	238	0.1%	24.4 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 5	411829	100.0%	50.0 MB	100.0%

History cache:

Reason	Count	%Count
Negative hits	265480	49.7%
Do not exist	265413	49.7%
Positive hits	1618	0.3%
Cache misses	1210	0.2%
TOTAL: 4	533721	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.106	0.0%	93	0.000	1.140	39.500
article cleanup	00:00:01.241	0.0%	265618	0.000	0.005	1.000
article logging	00:00:03.903	0.0%	265684	0.000	0.015	0.122
article parse	00:00:02.373	0.0%	787077	0.000	0.003	0.016
article write	00:17:49.196	1.2%	137484	0.000	7.777	189.333
artlog/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:00:00.328	0.0%	806954	0.000	0.000	0.056
hisgrep/artcncl	00:00:00.012	0.0%	93	0.000	0.129	5.500
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:22:19.283	1.5%	534189	0.000	2.507	77.000
history sync	00:00:00.012	0.0%	308	0.000	0.039	1.000
history write	00:03:36.376	0.3%	265617	0.000	0.815	13.393
idle	23:09:00.084	96.4%	798179	74.262	104.413	20209.667
nntp read	00:00:06.522	0.0%	797008	0.000	0.008	0.159
overview write	00:00:44.196	0.1%	137484	0.000	0.321	138.241
perl filter	00:05:25.688	0.4%	265617	0.117	1.226	60.000
python filter	00:00:14.677	0.0%	523033	0.000	0.028	0.667
site send	00:00:01.115	0.0%	137484	0.000	0.008	1.000
TOTAL: 24:00:19.265	23:59:25.112	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.197	0.0%	137463	0.000	0.001	0.034
article prepare	00:00:00.042	0.0%	566232	0.000	0.000	0.004
article read	00:01:09.681	0.1%	134253	0.000	0.519	11.750
backlog stats	00:00:00.195	0.0%	711601	0.000	0.000	0.040
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:02.871	0.0%	425121	0.000	0.007	0.154
data write	00:00:04.705	0.0%	287785	0.000	0.016	0.250
idle	23:58:29.278	99.9%	711601	38.971	121.289	30099.500
status file	00:00:00.502	0.0%	312	0.000	1.609	38.500
TOTAL: 23:59:55.143	23:59:47.471	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:14.194	21.7%	64	24.000	221.781	3744.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.005	0.0%	257	0.000	0.019	0.500
TOTAL: 00:01:05.525	00:00:14.199	21.7%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	chimia.se	2	257159	129162	1336	126661	50%	23:51:43
2	usenet.blueworldhosting.com	1364	9534	7824	353	1357	82%	23:50:06
3	news.sklaffkom.se	3	1774	539	1235	0	30%	25:27:00
4	localhost	25	0	0	0	0	0%	00:00:00
5	news.thebunker.nu	7	0	0	0	0	0%	00:00:01
TOTAL: 5		1401	268467	137525	2924	128018	51%	73:08:50

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	chimia.se	304.9 MB	3.8 KB	296.9 MB	601.8 MB	50%	2.4 KB
2	usenet.blueworldhosting.com	19.6 MB	0.0 KB	3.0 MB	22.7 MB	86%	2.5 KB
3	news.sklaffkom.se	833.6 KB	0.0 KB	0.0 KB	833.6 KB	100%	1.5 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		325.3 MB	3.8 KB	300.0 MB	625.3 MB	52%	2.4 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Nov 25 03:00:02 - 03:59:59	4608	3.4%	1.28	10.2 MB	3.1%	2.91
Nov 25 04:00:00 - 04:59:59	5990	4.4%	1.66	12.7 MB	3.9%	3.62
Nov 25 05:00:00 - 05:59:59	5775	4.2%	1.60	12.5 MB	3.9%	3.57
Nov 25 06:00:00 - 06:59:59	5362	3.9%	1.49	12.5 MB	3.8%	3.55
Nov 25 07:00:00 - 07:59:59	5668	4.1%	1.57	12.7 MB	3.9%	3.62
Nov 25 08:00:00 - 08:59:59	5126	3.7%	1.42	12.5 MB	3.9%	3.57
Nov 25 09:00:00 - 09:59:59	5694	4.1%	1.58	13.1 MB	4.0%	3.71
Nov 25 10:00:00 - 10:59:59	5534	4.0%	1.54	13.4 MB	4.1%	3.82
Nov 25 11:00:00 - 11:59:59	6051	4.4%	1.68	14.8 MB	4.6%	4.21
Nov 25 12:00:00 - 12:59:59	5183	3.8%	1.44	12.8 MB	3.9%	3.63
Nov 25 13:00:00 - 13:59:59	6846	5.0%	1.90	19.5 MB	6.0%	5.55
Nov 25 14:00:00 - 14:59:59	1155	0.8%	0.32	4.4 MB	1.4%	1.26
Nov 25 15:00:00 - 15:59:59	371	0.3%	0.10	984.1 KB	0.3%	0.27
Nov 25 16:00:00 - 16:59:59	4778	3.5%	1.33	12.1 MB	3.7%	3.44
Nov 25 17:00:00 - 17:59:59	7591	5.5%	2.11	24.4 MB	7.5%	6.93
Nov 25 18:00:00 - 18:59:59	8775	6.4%	2.44	25.9 MB	8.0%	7.36
Nov 25 19:00:00 - 19:59:59	6893	5.0%	1.91	17.6 MB	5.4%	5.02
Nov 25 20:00:00 - 20:59:59	7741	5.6%	2.15	19.4 MB	6.0%	5.53
Nov 25 21:00:00 - 21:59:59	6063	4.4%	1.68	11.5 MB	3.5%	3.27
Nov 25 22:00:00 - 22:59:59	5954	4.3%	1.65	11.0 MB	3.4%	3.13
Nov 25 23:00:00 - 23:59:59	6021	4.4%	1.67	10.8 MB	3.3%	3.08
Nov 26 00:00:00 - 00:59:59	5453	4.0%	1.51	10.3 MB	3.2%	2.94
Nov 26 01:00:00 - 01:59:59	6731	4.9%	1.87	13.9 MB	4.3%	3.94
Nov 26 02:00:00 - 02:59:59	8080	5.9%	2.24	16.2 MB	5.0%	4.61
Nov 26 03:00:00 - 03:00:02	6	0.0%	3.00	9.4 KB	0.0%	4.72
TOTAL: 24:00:00	137449	100.0%	1.59	325.3 MB	100.0%	3.86

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	chimia.se	126766	0	1	1	126764
2	usenet.blueworldhosting.com	1407	410	0	1	996
TOTAL: 2		128173	410	1	2	127760

Unwanted newsgroups [Top 20]:

Newsgroup	Count
de.comm.provider.mail	41
hispagatos.hacking.ransomware	25
pl.sci.fizyka	18
hispagatos.mastodon.tag.hacking	14
uk.telecom.mobile	13
de.rec.musik.hifi	12
de.comm.infosystems.www.authoring.misc	11
aus.computers	10
it.discussioni.geometri	10
perl.modules	10
pl.comp.pecet	10
de.comm.software.newsreader	9
fido7.altyn.local	7
muc.lists.freebsd.multimedia	7
muc.lists.netbsd.tech.kern	7
de.admin.net-abuse.mail	6
fido7.xsu.cellular	6
fr.comp.os.unix	6
free.willey	6
it.comp.aiuto	6
TOTAL: 115	410

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

Groups	Count
news.newusers.questions	1
rec.sport.pro-wrestling.moderated	1
TOTAL: 2	2

INND Perl filter [Top 20]:

Reason	Count
EMP (phn path)	47513
EMP (phn nph)	34297
HTML Multipart	27273
EMP (phl)	12182
EMP (md5)	5002
Too many newsgroups (meow)	1140
Too many newsgroups	93
Subject Rejected	90
Scoring filter	37
Too many newsgroups (low_xpost)	28
MI5 Filter	20
User-issued cancel	13
Binary: misplaced binary	2
HTML post	2
U2 violation - invalid distribution	2
TOTAL: 15	127694

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	chimia.se	9
	TOTAL: 1	9
Including strange strings
	usenet.blueworldhosting.com	50
	chimia.se	16
	TOTAL: 2	66
TOTAL: 2		75

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	sklaffkom.se	138882	4356	2875	129861	20	3%	23:59:57
2	usenet.blueworldhosting.com	7709	0	343	7348	0	0%	17:15:39
3	sklaff.dev	0	0	0	0	137447	0%	23:57:43
4	thebunker.nu	0	0	0	0	137447	0%	23:59:57
TOTAL: 4		146591	4356	3218	137209	274914	2%	89:13:16

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	sklaffkom.se	9.8 MB	308.4 MB	318.1 MB	3.8 KB/s	2.4 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	21.6 MB	21.6 MB	0.4 KB/s	3.0 KB	17:15:39
TOTAL: 4		9.8 MB	330.0 MB	339.8 MB	1.1 KB/s	2.5 KB	89:13:16

NNRP readership statistics:

System		Conn	Elapsed
1	81-229-79-101-no600.tbcn.telia.com	7	00:00:02
2	n31.scanner.modat.io	5	00:00:00
3	147.185.133.104	4	00:00:28
4	212.102.40.218	4	00:00:00
5	167.94.138.182	3	00:00:06
6	167.94.138.204	2	00:00:04
7	230.211.203.35.bc.googleusercontent.com	2	00:00:11
8	147.185.132.237	1	00:00:00
9	166.149.216.162.bc.googleusercontent.com	1	00:00:00
10	172-236-228-39.ip.linodeusercontent.com	1	00:00:00
11	193.32.162.213	1	00:00:06
12	198.235.24.254	1	00:00:00
13	205.210.31.224	1	00:00:01
14	95.211.203.35.bc.googleusercontent.com	1	00:00:00
TOTAL: 14		34	00:01:05

NNRP readership statistics (by domain):

System		Conn	Elapsed
1	unresolved	17	00:00:48
2	*.tbcn.telia.com	7	00:00:02
3	*.scanner.modat.io	5	00:00:00
4	*.211.203.35.bc.googleusercontent.com	3	00:00:12
5	*.149.216.162.bc.googleusercontent.com	1	00:00:00
6	*.ip.linodeusercontent.com	1	00:00:00
TOTAL: 6		34	00:01:05

NNRP auth users [Top 20]:

User	Conn
peterlondon	7
TOTAL: 1	7

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
147.185.133.104	0.161	0.021	0.000	00:00:28
230.211.203.35.bc.googleusercontent.com	0.080	0.013	0.000	00:00:11
193.32.162.213	0.010	0.002	0.000	00:00:06
167.94.138.182	0.057	0.012	0.000	00:00:06
167.94.138.204	0.049	0.008	0.000	00:00:04
81-229-79-101-no600.tbcn.telia.com	0.055	0.041	0.181	00:00:02
205.210.31.224	0.007	0.005	0.000	00:00:01
172-236-228-39.ip.linodeusercontent.com	0.041	0.006	0.000	00:00:00
n31.scanner.modat.io	0.203	0.017	0.000	00:00:00
198.235.24.254	0.006	0.007	0.000	00:00:00
166.149.216.162.bc.googleusercontent.com	0.042	0.005	0.000	00:00:00
212.102.40.218	0.154	0.019	0.000	00:00:00
95.211.203.35.bc.googleusercontent.com	0.038	0.009	0.000	00:00:00
147.185.132.237	0.005	0.007	0.000	00:00:00
TOTAL: 14	0.908	0.172	0.181	00:01:05

NNRP gethostbyaddr failures [Top 20]:

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

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

System	Conn
147.185.133.104	8
166.149.216.162.bc.googleusercontent.com	4
230.211.203.35.bc.googleusercontent.com	4
95.211.203.35.bc.googleusercontent.com	4
167.94.138.182	1
167.94.138.204	1
n31.scanner.modat.io	1
TOTAL: 7	23

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

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

NNRP client timeouts [Top 20]:

System	Conn	Peer
147.185.133.104	2	4
166.149.216.162.bc.googleusercontent.com	1	1
167.94.138.182	1	2
230.211.203.35.bc.googleusercontent.com	1	2
95.211.203.35.bc.googleusercontent.com	1	1
n31.scanner.modat.io	1	1
TOTAL: 6	7	15

Daily Usenet report

Nov 25 03:00:02 -- Nov 26 03:00:02