Daily Usenet report: Nov 14 03:00:01

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Nov 14 04:16:22 news innd: message repeated 2 times: [ ctlinnd command s]
Nov 14 22:00:51 news pgpverify[3307641]: pgpverify: verification failed

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	152947	71.0%	21.3 MB	74.6%
innd	60061	27.9%	7.0 MB	24.5%
innfeed	2373	1.1%	249.6 KB	0.9%
nnrpd	117	0.1%	12.2 KB	0.0%
controlchan	12	0.0%	2.5 KB	0.0%
pgpverify	1	0.0%	0.1 KB	0.0%
TOTAL: 6	215511	100.0%	28.5 MB	100.0%

History cache:

Reason	Count	%Count
Negative hits	153394	38.9%
Do not exist	152736	38.7%
Cache misses	84237	21.4%
Positive hits	4006	1.0%
TOTAL: 4	394373	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.610	0.0%	93	0.000	6.559	230.000
article cleanup	00:00:00.685	0.0%	152783	0.000	0.004	0.200
article logging	00:00:02.310	0.0%	152892	0.000	0.015	0.250
article parse	00:00:01.366	0.0%	449331	0.000	0.003	1.000
article write	00:51:30.774	3.6%	108167	0.000	28.574	975.333
artlog/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:00:00.349	0.0%	561444	0.000	0.001	0.392
hisgrep/artcncl	00:00:00.002	0.0%	93	0.000	0.022	1.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:18:08.661	1.3%	394842	0.000	2.757	14.526
history sync	00:00:00.011	0.0%	313	0.000	0.035	1.000
history write	00:03:26.889	0.2%	152780	0.000	1.354	36.231
idle	22:37:35.427	94.3%	564352	20.260	144.334	20161.667
nntp read	00:00:05.059	0.0%	563783	0.000	0.009	7.636
overview write	00:00:38.124	0.0%	108167	0.000	0.352	138.800
perl filter	00:05:55.836	0.4%	152780	0.195	2.329	35.889
python filter	00:00:09.088	0.0%	381468	0.000	0.024	0.653
site send	00:00:00.910	0.0%	108165	0.000	0.008	0.333
TOTAL: 24:00:18.028	23:57:36.101	99.8%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.142	0.0%	108155	0.000	0.001	0.062
article prepare	00:00:00.037	0.0%	442288	0.000	0.000	0.003
article read	00:05:15.439	0.4%	101829	0.000	3.098	33.700
backlog stats	00:00:00.160	0.0%	557942	0.000	0.000	0.050
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:02.393	0.0%	334481	0.000	0.007	0.091
data write	00:00:03.511	0.0%	227151	0.000	0.015	0.200
idle	23:53:58.532	99.6%	557942	39.056	154.207	30100.500
status file	00:00:00.105	0.0%	193	0.000	0.544	12.667
TOTAL: 23:59:26.300	23:59:20.319	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:13.770	16.7%	10	66.500	1377.000	10050.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.000	0.0%	82	0.000	0.000	0.000
TOTAL: 00:01:22.428	00:00:13.770	16.7%	-	-	-	-

Control commands to INND:

Command	Number
flush	2
flushlogs	2
go	3
logmode	2
lowmark	1
mode	141
name	2
pause	3
paused	3
reload	2
reserve	2
TOTAL: 11	163

Control Channel:

Sender	newgroup	rmgroup	Other	Bad PGP	DoIt	OK
newgroups-request@fido7.org	0	0	1	1	0	1
TOTAL	0	0	1	1	0	1

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	chimia.se	30	228633	100380	85313	42940	43%	21:20:56
2	usenet.blueworldhosting.com	1546	9265	5695	1878	1692	61%	37:01:01
3	news.sklaffkom.se	3	3437	2168	1269	0	63%	25:32:56
4	localhost	24	0	0	0	0	0%	00:00:00
TOTAL: 4		1603	241335	108243	88460	44632	44%	83:54:53

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	chimia.se	256.3 MB	15.2 KB	90.5 MB	346.8 MB	73%	2.5 KB
2	usenet.blueworldhosting.com	16.2 MB	0.0 KB	3.3 MB	19.5 MB	83%	2.7 KB
3	news.sklaffkom.se	3.1 MB	0.0 KB	0.0 KB	3.1 MB	100%	1.5 KB
4	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 4		275.6 MB	15.2 KB	93.8 MB	369.4 MB	74%	2.5 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Nov 14 03:00:01 - 03:59:59	1188	1.1%	0.33	2.6 MB	0.0%	0.74
Nov 14 04:00:00 - 04:59:59	711	0.7%	0.20	1.5 MB	0.0%	0.42
Nov 14 05:00:00 - 05:59:59	1001	0.9%	0.28	2.2 MB	93.1%	0.61
Nov 14 06:00:00 - 06:59:59	656	0.6%	0.18	1.4 MB	61.7%	0.41
Nov 14 07:00:00 - 07:59:59	1042	1.0%	0.29	2.4 MB	105.4%	0.70
Nov 14 08:00:00 - 08:59:59	1148	1.1%	0.32	2.5 MB	106.4%	0.70
Nov 14 09:00:00 - 09:59:59	897	0.8%	0.25	1.8 MB	78.9%	0.52
Nov 14 10:00:00 - 10:59:59	1076	1.0%	0.30	2.3 MB	100.0%	0.66
Nov 14 11:00:00 - 11:59:59	6587	6.1%	1.83	16.2 MB	698.5%	4.61
Nov 14 12:00:00 - 12:59:59	10333	9.5%	2.87	29.2 MB	1257.8%	8.30
Nov 14 13:00:00 - 13:59:59	9663	8.9%	2.68	22.0 MB	948.6%	6.26
Nov 14 14:00:00 - 14:59:59	9383	8.7%	2.61	30.4 MB	1312.7%	8.66
Nov 14 15:00:00 - 15:59:59	8274	7.6%	2.30	20.4 MB	879.3%	5.80
Nov 14 16:00:00 - 16:59:59	5798	5.4%	1.61	13.4 MB	575.9%	3.80
Nov 14 17:00:00 - 17:59:59	0	0.0%	0.00	0.0 KB	0.0%	0.00
Nov 14 18:00:00 - 18:59:59	0	0.0%	0.00	0.0 KB	0.0%	0.00
Nov 14 19:00:00 - 19:59:59	4681	4.3%	1.30	9.7 MB	420.2%	2.77
Nov 14 20:00:00 - 20:59:59	6340	5.9%	1.76	14.3 MB	615.6%	4.06
Nov 14 21:00:00 - 21:59:59	4217	3.9%	1.17	8.9 MB	382.2%	2.52
Nov 14 22:00:00 - 22:59:59	6867	6.3%	1.91	18.2 MB	786.1%	5.19
Nov 14 23:00:00 - 23:59:59	7203	6.7%	2.00	19.8 MB	854.6%	5.64
Nov 15 00:00:00 - 00:59:59	7312	6.8%	2.03	20.7 MB	891.4%	5.88
Nov 15 01:00:00 - 01:59:59	6607	6.1%	1.84	20.1 MB	868.2%	5.73
Nov 15 02:00:00 - 02:59:59	7221	6.7%	2.01	15.5 MB	666.7%	4.40
Nov 15 03:00:00 - 03:00:02	1	0.0%	0.50	1.9 KB	0.1%	0.97
TOTAL: 24:00:01	108206	100.0%	1.25	2.3 MB	100.0%	0.03

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	chimia.se	42988	0	3	9	42976
2	usenet.blueworldhosting.com	1753	310	0	0	1443
TOTAL: 2		44741	310	3	9	44419

Unwanted newsgroups [Top 20]:

Newsgroup	Count
de.comp.hardware.netzwerke.misc	21
hispagatos.hacking.ransomware	14
hispagatos.mastodon.tag.hacking	12
it.comp.os.linux.iniziare	12
it.sport.motociclismo	12
alt.test.9	11
spline.fli4l.geschnatter	9
aus.computers	8
muc.lists.netbsd.tech.userlevel	8
de.comm.infosystems.www.authoring.misc	7
it.hobby.motociclismo	6
dk.livssyn.kristendom	5
fido7.su.cars	5
relcom.wheels	5
sfnet.huuhaa	5
alt.my.job.sucks	4
aus.test	4
fido7.starper.limited	4
fido7.su.tormoz	4
fr.comp.infosystemes.www.navigateurs	4
TOTAL: 114	310

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

Groups	Count
comp.ai	9
TOTAL: 1	9

INND Perl filter [Top 20]:

Reason	Count
EMP (phn path)	27879
EMP (phn nph)	11484
EMP (phl)	2011
EMP (md5)	1948
HTML Multipart	293
Too many newsgroups (meow)	236
Too many newsgroups (low_xpost)	224
Too many newsgroups	88
MI5 Filter	39
Scoring filter	37
HTML post	28
User-issued cancel	20
Subject Rejected	10
EMP (fsl)	9
Binary: misplaced binary	2
MID-Bot	1
hierarchy violation - crosspost outside netscape	1
TOTAL: 17	44310

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	chimia.se	14
	TOTAL: 1	14
Including strange strings
	usenet.blueworldhosting.com	61
	chimia.se	48
	TOTAL: 2	109
TOTAL: 2		123

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	sklaffkom.se	106421	2964	4199	98903	0	2%	21:49:54
2	usenet.blueworldhosting.com	10815	0	1980	8754	0	0%	21:35:53
3	sklaff.dev	0	0	0	0	108196	0%	23:57:43
4	thebunker.nu	0	0	0	0	108196	0%	23:59:59
TOTAL: 4		117236	2964	6179	107657	216392	2%	91:23:29

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	sklaffkom.se	10.0 MB	251.2 MB	261.1 MB	3.4 KB/s	2.6 KB	21:49:54
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:59
4	usenet.blueworldhosting.com	0.0 KB	30.7 MB	30.7 MB	0.4 KB/s	3.6 KB	21:35:53
TOTAL: 4		10.0 MB	281.9 MB	291.9 MB	0.9 KB/s	2.7 KB	91:23:29

NNRP readership statistics:

System		Conn	Elapsed
1	101.149.216.162.bc.googleusercontent.com	4	00:00:37
2	147.185.132.241	2	00:00:07
3	azpdsgw6rekv.stretchoid.com	2	00:00:11
4	147.185.132.35	1	00:00:00
5	167.94.138.205	1	00:00:00
6	198.235.24.238	1	00:00:00
7	205.210.31.103	1	00:00:00
8	205.210.31.148	1	00:00:02
9	35.203.210.163	1	00:00:20
10	51.159.234.118	1	00:00:00
11	71.6.134.235	1	00:00:00
TOTAL: 11		16	00:01:22

NNRP readership statistics (by domain):

System		Conn	Elapsed
1	unresolved	10	00:00:32
2	*.149.216.162.bc.googleusercontent.com	4	00:00:37
3	*.stretchoid.com	2	00:00:11
TOTAL: 3		16	00:01:22

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
101.149.216.162.bc.googleusercontent.com	0.163	0.030	00:00:37
35.203.210.163	0.042	0.007	00:00:20
azpdsgw6rekv.stretchoid.com	0.013	0.011	00:00:11
147.185.132.241	0.086	0.006	00:00:07
205.210.31.148	0.009	0.008	00:00:02
71.6.134.235	0.008	0.005	00:00:00
167.94.138.205	0.036	0.011	00:00:00
147.185.132.35	0.040	0.009	00:00:00
198.235.24.238	0.007	0.009	00:00:00
205.210.31.103	0.007	0.005	00:00:00
51.159.234.118	0.039	0.006	00:00:00
TOTAL: 11	0.450	0.107	00:01:22

NNRP gethostbyaddr failures [Top 20]:

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

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

System	Conn
101.149.216.162.bc.googleusercontent.com	8
147.185.132.241	4
147.185.132.35	4
35.203.210.163	4
167.94.138.205	1
azpdsgw6rekv.stretchoid.com	1
TOTAL: 6	22

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
User-Agent: Hello from Palo Alto Network...	2
EHLO www.censys.io	1
MGLNDD_109.238.130.155_119	1
TOTAL: 8	22

NNRP client timeouts [Top 20]:

System	Conn	Peer
101.149.216.162.bc.googleusercontent.com	2	4
147.185.132.241	1	2
147.185.132.35	1	1
35.203.210.163	1	1
TOTAL: 4	5	11

Daily Usenet report

Nov 14 03:00:01 -- Nov 15 03:00:02