Daily Usenet report: Nov 29 03:00:02

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Nov 29 04:35:50 news innd: message repeated 2 times: [ ctlinnd command s]

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	268120	67.2%	37.0 MB	72.1%
innd	127740	32.0%	14.0 MB	27.3%
innfeed	2401	0.6%	249.3 KB	0.5%
nnrpd	650	0.2%	71.9 KB	0.1%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 5	398912	100.0%	51.4 MB	100.0%

History cache:

Reason	Count	%Count
Negative hits	268268	49.6%
Do not exist	267907	49.5%
Positive hits	3426	0.6%
Cache misses	1752	0.3%
TOTAL: 4	541353	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.077	0.0%	9	0.000	8.556	46.000
article cleanup	00:00:01.428	0.0%	268082	0.000	0.005	0.115
article logging	00:00:03.893	0.0%	268126	0.000	0.015	0.239
article parse	00:00:02.438	0.0%	789795	0.000	0.003	0.015
article write	00:15:21.469	1.1%	155732	0.009	5.917	83.538
artlog/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:00:00.544	0.0%	807475	0.000	0.001	0.273
hisgrep/artcncl	00:00:00.001	0.0%	9	0.000	0.111	1.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:21:57.947	1.5%	541715	0.000	2.433	10.306
history sync	00:00:00.010	0.0%	306	0.000	0.033	1.000
history write	00:03:39.981	0.3%	268081	0.000	0.821	8.761
hiswrite/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	23:10:58.434	96.6%	804936	53.609	103.683	60045.000
nntp read	00:00:07.563	0.0%	803884	0.000	0.009	0.275
overview write	00:00:24.241	0.0%	155732	0.000	0.156	14.809
perl filter	00:06:14.372	0.4%	268081	0.487	1.396	38.000
python filter	00:00:15.847	0.0%	528355	0.000	0.030	0.342
site send	00:00:01.320	0.0%	155732	0.000	0.008	0.078
TOTAL: 24:00:07.382	23:59:09.565	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.234	0.0%	155674	0.000	0.002	0.025
article prepare	00:00:00.041	0.0%	818932	0.000	0.000	0.003
article read	00:02:13.299	0.2%	149128	0.000	0.894	12.412
backlog stats	00:00:00.256	0.0%	938028	0.000	0.000	0.006
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:03.836	0.0%	571710	0.000	0.007	0.030
data write	00:00:06.097	0.0%	416408	0.000	0.015	0.107
idle	23:56:26.935	99.8%	938028	39.612	91.881	30097.000
status file	00:00:00.049	0.0%	176	0.000	0.278	3.000
TOTAL: 23:59:00.484	23:58:50.747	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:25.086	31.0%	42	16.500	597.286	10013.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.003	0.0%	359	0.000	0.008	0.091
TOTAL: 00:01:20.882	00:00:25.089	31.0%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	chimia.se	1	260450	147667	1944	110839	56%	23:56:56
2	usenet.blueworldhosting.com	1369	9744	5384	2763	1597	55%	23:48:40
3	news.sklaffkom.se	1	3286	2808	477	1	85%	24:24:28
4	localhost	25	0	0	0	0	0%	00:00:00
5	news.thebunker.nu	1	0	0	0	0	0%	00:00:00
TOTAL: 5		1397	273480	155859	5184	112437	56%	72:10:04

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	chimia.se	324.9 MB	3.8 KB	247.6 MB	572.5 MB	56%	2.3 KB
2	usenet.blueworldhosting.com	15.3 MB	0.0 KB	3.4 MB	18.7 MB	81%	2.7 KB
3	news.sklaffkom.se	4.1 MB	0.0 KB	4.9 KB	4.1 MB	99%	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		344.4 MB	3.8 KB	251.0 MB	595.4 MB	57%	2.3 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Nov 29 03:00:02 - 03:59:59	6212	4.0%	1.73	12.3 MB	3.6%	3.51
Nov 29 04:00:00 - 04:59:59	6126	3.9%	1.70	12.3 MB	3.6%	3.51
Nov 29 05:00:00 - 05:59:59	7400	4.8%	2.06	14.4 MB	4.2%	4.10
Nov 29 06:00:00 - 06:59:59	7295	4.7%	2.03	14.4 MB	4.2%	4.10
Nov 29 07:00:00 - 07:59:59	7059	4.5%	1.96	14.3 MB	4.2%	4.07
Nov 29 08:00:00 - 08:59:59	7093	4.6%	1.97	14.3 MB	4.2%	4.07
Nov 29 09:00:00 - 09:59:59	6792	4.4%	1.89	14.3 MB	4.1%	4.05
Nov 29 10:00:00 - 10:59:59	6240	4.0%	1.73	13.2 MB	3.8%	3.74
Nov 29 11:00:00 - 11:59:59	6154	4.0%	1.71	13.2 MB	3.8%	3.76
Nov 29 12:00:00 - 12:59:59	6194	4.0%	1.72	14.5 MB	4.2%	4.14
Nov 29 13:00:00 - 13:59:59	5458	3.5%	1.52	12.5 MB	3.6%	3.55
Nov 29 14:00:00 - 14:59:59	5547	3.6%	1.54	12.9 MB	3.7%	3.67
Nov 29 15:00:00 - 15:59:59	5647	3.6%	1.57	13.2 MB	3.8%	3.76
Nov 29 16:00:00 - 16:59:59	5817	3.7%	1.62	13.9 MB	4.0%	3.95
Nov 29 17:00:00 - 17:59:59	5981	3.8%	1.66	14.7 MB	4.3%	4.17
Nov 29 18:00:00 - 18:59:59	7419	4.8%	2.06	17.4 MB	5.1%	4.95
Nov 29 19:00:00 - 19:59:59	8021	5.2%	2.23	17.7 MB	5.1%	5.02
Nov 29 20:00:00 - 20:59:59	6657	4.3%	1.85	15.0 MB	4.4%	4.27
Nov 29 21:00:00 - 21:59:59	6545	4.2%	1.82	14.7 MB	4.3%	4.18
Nov 29 22:00:00 - 22:59:59	6425	4.1%	1.78	14.8 MB	4.3%	4.20
Nov 29 23:00:00 - 23:59:59	6435	4.1%	1.79	14.2 MB	4.1%	4.04
Nov 30 00:00:00 - 00:59:59	6737	4.3%	1.87	16.4 MB	4.8%	4.68
Nov 30 01:00:00 - 01:59:59	6500	4.2%	1.81	15.4 MB	4.5%	4.37
Nov 30 02:00:00 - 02:59:59	5950	3.8%	1.65	14.1 MB	4.1%	4.00
Nov 30 03:00:00 - 03:00:01	6	0.0%	6.00	12.0 KB	0.0%	11.98
TOTAL: 23:59:59	155710	100.0%	1.80	344.1 MB	100.0%	4.08

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	chimia.se	110768	0	1	110767
2	usenet.blueworldhosting.com	1641	291	0	1350
3	news.sklaffkom.se	1	0	0	1
TOTAL: 3		112410	291	1	112118

Unwanted newsgroups [Top 20]:

Newsgroup	Count
de.comp.hardware.misc	22
de.comm.provider.mail	20
hispagatos.hacking.ransomware	16
de.rec.musik.hifi	13
de.soc.verkehr	11
de.comm.infosystems.www.authoring.misc	10
de.alt.comm.android	9
pl.comp.os.ms-windows.winnt	9
uk.tech.broadcast	8
fido7.starper.limited	6
fr.rec.photo.materiel	6
muc.lists.freebsd.emulation	6
aus.computers	5
de.sci.physik	5
free.it.scienza.fisica	5
hispagatos.mastodon.tag.hacking	5
linux.debian.project	5
microsoft.public.windowsxp.general	5
de.comm.software.browser.misc	4
fido7.altyn.local	4
TOTAL: 98	291

INND Perl filter [Top 20]:

Reason	Count
EMP (phn path)	54553
EMP (phn nph)	40702
EMP (phl)	15226
EMP (md5)	1201
HTML Multipart	117
Subject Rejected	110
Too many newsgroups	103
Too many newsgroups (meow)	21
User-issued cancel	14
HTML post	11
Too many newsgroups (low_xpost)	10
Scoring filter	3
Binary: misplaced binary	2
Too many test groups in crosspost	1
TOTAL: 14	112074

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	sklaffkom.se	152986	1383	3738	147811	35	0%	23:59:57
2	usenet.blueworldhosting.com	58877	0	2643	55686	7	0%	23:59:54
3	sklaff.dev	0	0	0	0	155701	0%	23:57:43
4	thebunker.nu	0	0	0	0	155701	0%	23:59:57
TOTAL: 4		211863	1383	6381	203497	311444	0%	95:57:31

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	sklaffkom.se	2.5 MB	326.4 MB	328.9 MB	3.9 KB/s	2.3 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	127.3 MB	127.3 MB	1.5 KB/s	2.3 KB	23:59:54
TOTAL: 4		2.5 MB	453.7 MB	456.2 MB	1.4 KB/s	2.3 KB	95:57:31

NNRP readership statistics:

System		Conn	Elapsed
1	96-126-106-7.ip.linodeusercontent.com	62	00:00:12
2	prod34client01.academyforinternetresearch.org	62	00:00:12
3	167.94.146.53	3	00:00:04
4	206.168.34.43	3	00:00:05
5	72.210.203.35.bc.googleusercontent.com	2	00:00:07
6	82.210.203.35.bc.googleusercontent.com	2	00:00:16
7	azpdss774pa9.stretchoid.com	2	00:00:10
8	c-5eea46c0-74736162.cust.telenor.se	2	00:00:04
9	147.185.133.120	1	00:00:00
10	147.185.133.149	1	00:00:05
11	166.211.203.35.bc.googleusercontent.com	1	00:00:00
12	194.164.107.5	1	00:00:00
13	198.235.24.252	1	00:00:00
14	198.235.24.93	1	00:00:01
15	81-229-79-101-no600.tbcn.telia.com	1	00:00:00
TOTAL: 15		145	00:01:20

NNRP readership statistics (by domain):

System		Conn	Elapsed
1	*.academyforinternetresearch.org	62	00:00:12
2	*.ip.linodeusercontent.com	62	00:00:12
3	unresolved	11	00:00:17
4	*.210.203.35.bc.googleusercontent.com	4	00:00:23
5	*.cust.telenor.se	2	00:00:04
6	*.stretchoid.com	2	00:00:10
7	*.211.203.35.bc.googleusercontent.com	1	00:00:00
8	*.tbcn.telia.com	1	00:00:00
TOTAL: 8		145	00:01:20

NNRP auth users [Top 20]:

User	Conn
peterlondon	3
TOTAL: 1	3

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
82.210.203.35.bc.googleusercontent.com	0.081	0.008	0.000	00:00:16
prod34client01.academyforinternetresearch.org	2.696	0.298	0.000	00:00:12
96-126-106-7.ip.linodeusercontent.com	2.765	0.349	0.000	00:00:12
azpdss774pa9.stretchoid.com	0.012	0.013	0.000	00:00:10
72.210.203.35.bc.googleusercontent.com	0.084	0.007	0.000	00:00:07
147.185.133.149	0.043	0.007	0.000	00:00:05
206.168.34.43	0.052	0.018	0.000	00:00:05
167.94.146.53	0.067	0.013	0.000	00:00:04
c-5eea46c0-74736162.cust.telenor.se	0.013	0.013	0.044	00:00:04
198.235.24.93	0.006	0.007	0.000	00:00:01
198.235.24.252	0.007	0.004	0.000	00:00:00
147.185.133.120	0.044	0.003	0.000	00:00:00
194.164.107.5	0.005	0.008	0.000	00:00:00
81-229-79-101-no600.tbcn.telia.com	0.009	0.005	0.019	00:00:00
166.211.203.35.bc.googleusercontent.com	0.008	0.006	0.000	00:00:00
TOTAL: 15	5.892	0.759	0.063	00:01:20

NNRP gethostbyaddr failures [Top 20]:

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

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

System	Conn
147.185.133.120	4
147.185.133.149	4
166.211.203.35.bc.googleusercontent.com	4
72.210.203.35.bc.googleusercontent.com	4
82.210.203.35.bc.googleusercontent.com	4
167.94.146.53	1
206.168.34.43	1
azpdss774pa9.stretchoid.com	1
TOTAL: 8	23

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

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

NNRP client timeouts [Top 20]:

System	Conn	Peer
147.185.133.120	1	1
147.185.133.149	1	1
167.94.146.53	1	2
206.168.34.43	1	2
72.210.203.35.bc.googleusercontent.com	1	2
82.210.203.35.bc.googleusercontent.com	1	2
TOTAL: 6	6	16

Daily Usenet report

Nov 29 03:00:02 -- Nov 30 03:00:01