Daily Usenet report: Oct 12 03:00:01

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Oct 12 03:03:49 news innd: message repeated 2 times: [ ctlinnd command s]

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	215743	78.2%	36.0 MB	83.3%
innd	57462	20.8%	6.9 MB	16.0%
innfeed	2373	0.9%	266.3 KB	0.6%
nnrpd	423	0.2%	47.1 KB	0.1%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 5	276002	100.0%	43.3 MB	100.0%

History cache:

Reason	Count	%Count
Negative hits	217304	49.1%
Do not exist	215556	48.7%
Positive hits	9851	2.2%
Cache misses	221	0.0%
TOTAL: 4	442932	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.115	0.0%	18	0.000	6.389	32.000
article cleanup	00:00:00.995	0.0%	215606	0.000	0.005	0.333
article logging	00:00:03.560	0.0%	215700	0.000	0.017	1.000
article parse	00:00:01.933	0.0%	627879	0.000	0.003	0.333
article write	00:04:00.704	0.3%	168589	0.000	1.428	132.000
artlog/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:00:00.359	0.0%	647485	0.000	0.001	0.857
hisgrep/artcncl	00:00:00.004	0.0%	18	0.000	0.222	1.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:13:56.279	1.0%	443046	0.000	1.888	21.000
history sync	00:00:00.279	0.0%	571	0.000	0.489	122.500
history write	00:05:35.030	0.4%	215606	0.000	1.554	37.000
idle	23:30:14.074	97.9%	647381	58.949	130.702	60060.000
nntp read	00:00:05.134	0.0%	646602	0.000	0.008	1.364
overview write	00:00:23.116	0.0%	168589	0.000	0.137	133.000
perl filter	00:04:35.855	0.3%	215606	0.000	1.279	193.000
python filter	00:00:11.721	0.0%	420212	0.000	0.028	2.429
site send	00:00:01.371	0.0%	168589	0.000	0.008	0.333
TOTAL: 23:59:45.657	23:59:10.529	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.272	0.0%	168646	0.000	0.002	0.667
article prepare	00:00:00.092	0.0%	1805704	0.000	0.000	0.003
article read	00:00:18.159	0.0%	162440	0.000	0.112	12.000
backlog stats	00:00:00.446	0.0%	1691546	0.000	0.000	0.125
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:06.383	0.0%	1084807	0.000	0.006	0.333
data write	00:00:10.480	0.0%	917993	0.000	0.011	0.500
idle	23:58:59.927	99.9%	1691546	31.329	51.042	30099.500
status file	00:00:00.082	0.0%	181	0.000	0.453	9.500
TOTAL: 23:59:50.591	23:59:35.841	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:19.043	54.7%	160	23.000	119.019	3138.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.006	0.0%	474	0.000	0.013	0.333
TOTAL: 00:00:34.832	00:00:19.049	54.7%	-	-	-	-

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	204495	160527	295	43673	78%	18:53:06
2	usenet.blueworldhosting.com	288	11229	5873	2190	3166	52%	23:38:27
3	news.sklaff.dev	1	10080	2137	7790	153	21%	24:24:27
4	localhost	25	0	0	0	0	0%	00:00:00
5	news.thebunker.nu	3	0	0	0	0	0%	00:00:00
TOTAL: 5		318	225804	168537	10275	46992	74%	66:56:00

Incoming Volume (INN):

Server		AcceptVol	RejVol	TotalVol	%Acc	Vol/Art
1	chimia.se	316.1 MB	88.1 MB	404.1 MB	78%	2.0 KB
2	usenet.blueworldhosting.com	14.9 MB	5.0 MB	19.8 MB	75%	2.2 KB
3	news.sklaff.dev	4.7 MB	328.5 KB	5.0 MB	93%	2.2 KB
4	localhost	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
TOTAL: 5		335.6 MB	93.3 MB	428.9 MB	78%	2.0 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Oct 12 03:00:01 - 03:59:59	210	0.1%	0.06	528.9 KB	0.2%	0.15
Oct 12 04:00:00 - 04:59:59	226	0.1%	0.06	419.8 KB	0.1%	0.12
Oct 12 05:00:00 - 05:59:59	235	0.1%	0.07	445.2 KB	0.1%	0.12
Oct 12 06:00:00 - 06:59:59	205	0.1%	0.06	395.9 KB	0.1%	0.11
Oct 12 07:00:00 - 07:59:59	200	0.1%	0.06	294.3 KB	0.1%	0.08
Oct 12 08:00:00 - 08:59:59	8219	4.9%	2.28	15.8 MB	4.7%	4.48
Oct 12 09:00:00 - 09:59:59	9263	5.5%	2.57	17.8 MB	5.3%	5.08
Oct 12 10:00:00 - 10:59:59	8446	5.0%	2.35	16.3 MB	4.9%	4.64
Oct 12 11:00:00 - 11:59:59	8506	5.0%	2.36	16.7 MB	5.0%	4.76
Oct 12 12:00:00 - 12:59:59	8852	5.3%	2.46	17.6 MB	5.3%	5.02
Oct 12 13:00:00 - 13:59:59	9340	5.5%	2.59	18.2 MB	5.4%	5.17
Oct 12 14:00:00 - 14:59:59	9004	5.3%	2.50	17.2 MB	5.1%	4.90
Oct 12 15:00:00 - 15:59:59	8670	5.1%	2.41	16.8 MB	5.0%	4.78
Oct 12 16:00:00 - 16:59:59	8675	5.1%	2.41	16.8 MB	5.0%	4.79
Oct 12 17:00:00 - 17:59:59	8767	5.2%	2.44	17.1 MB	5.1%	4.87
Oct 12 18:00:00 - 18:59:59	9037	5.4%	2.51	17.8 MB	5.3%	5.06
Oct 12 19:00:00 - 19:59:59	9098	5.4%	2.53	18.2 MB	5.4%	5.18
Oct 12 20:00:00 - 20:59:59	8971	5.3%	2.49	18.6 MB	5.6%	5.30
Oct 12 21:00:00 - 21:59:59	8956	5.3%	2.49	18.5 MB	5.5%	5.26
Oct 12 22:00:00 - 22:59:59	9072	5.4%	2.52	19.7 MB	5.9%	5.60
Oct 12 23:00:00 - 23:59:59	9110	5.4%	2.53	18.3 MB	5.4%	5.20
Oct 13 00:00:00 - 00:59:59	9530	5.7%	2.65	19.6 MB	5.8%	5.57
Oct 13 01:00:00 - 01:59:59	8903	5.3%	2.47	18.2 MB	5.4%	5.17
Oct 13 02:00:00 - 02:59:59	7107	4.2%	1.97	14.5 MB	4.3%	4.11
Oct 13 03:00:00 - 03:00:01	4	0.0%	4.00	9.1 KB	0.0%	9.14
TOTAL: 24:00:00	168606	100.0%	1.95	335.8 MB	100.0%	3.98

Sites sending bad articles:

Server		Total	Group	Other
1	chimia.se	43719	0	43719
2	usenet.blueworldhosting.com	3251	331	2920
3	news.sklaff.dev	167	0	167
TOTAL: 3		47137	331	46806

Unwanted newsgroups [Top 20]:

Newsgroup	Count
de.alt.arnooo	20
de.rec.tv.technik	20
de.comm.software.newsserver	13
de.rec.film.misc	12
it.sport.motociclismo	12
de.rec.motorrad	11
fr.comp.usenet.serveurs	10
de.comp.os.unix.shell	8
de.etc.finanz.banken+broker	8
pl.rec.fantastyka.sf-f	8
fr.comp.mail	7
hispagatos.hacking.ransomware	7
linux.debian.user.italian	7
wny.test	7
microsoft.public.de.money	6
de.comp.os.unix.apps.misc	5
de.comp.os.unix.linux.hardware	5
de.soc.recht.strafrecht	5
it.comp.os.linux.iniziare	5
rwth.test	5
TOTAL: 124	331

INND Perl filter [Top 20]:

Reason	Count
EMP (phn nph)	27531
EMP (phn path)	9750
EMP (phl)	6238
EMP (md5)	2736
Too many newsgroups	196
Subject Rejected	116
HTML Multipart	82
User-issued cancel	16
Scoring filter	14
MI5 Filter	11
Too many newsgroups (low_xpost)	9
HTML Image Tags	6
Too many newsgroups (meow)	5
Binary: misplaced binary	2
TOTAL: 14	46712

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	chimia.se	2
	TOTAL: 1	2
Including strange strings
	usenet.blueworldhosting.com	80
	news.sklaff.dev	14
	TOTAL: 2	94
TOTAL: 2		96

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	sklaff.dev	156326	435	5097	149483	11555	0%	23:59:57
2	sklaffkom.se	169692	298	6263	162045	8	0%	23:59:57
3	usenet.blueworldhosting.com	141267	1	1980	139179	1	0%	22:34:25
4	thebunker.nu	0	0	0	0	168606	0%	23:59:57
TOTAL: 4		467285	734	13340	450707	180170	0%	94:34:16

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	sklaff.dev	822.4 KB	294.5 MB	295.3 MB	3.5 KB/s	2.0 KB	23:59:57
2	sklaffkom.se	288.6 KB	320.0 MB	320.2 MB	3.8 KB/s	2.0 KB	23:59:57
3	usenet.blueworldhosting.com	3.0 KB	273.8 MB	273.8 MB	3.5 KB/s	2.0 KB	22:34:25
4	thebunker.nu	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:59:57
TOTAL: 4		1.1 MB	888.3 MB	889.4 MB	2.7 KB/s	2.0 KB	94:34:16

NNRP readership statistics:

System		Conn	Elapsed
1	172-233-58-223.ip.linodeusercontent.com	86	00:00:12
2	c-5eea45bc-74736162.cust.telenor.se	4	00:00:04
3	81-229-79-101-no600.tbcn.telia.com	3	00:00:01
4	147.185.132.176	2	00:00:01
5	192.211.203.35.bc.googleusercontent.com	2	00:00:00
6	montoya.probe.onyphe.net	2	00:00:03
7	147.185.133.127	1	00:00:00
8	180.210.203.35.bc.googleusercontent.com	1	00:00:00
9	194.164.107.4	1	00:00:00
10	205.210.31.105	1	00:00:00
11	205.210.31.37	1	00:00:02
12	206.168.34.35	1	00:00:00
13	charlize.probe.onyphe.net	1	00:00:03
14	comprehensive.monitoring.internet-measurement.com	1	00:00:01
TOTAL: 14		107	00:00:34

NNRP readership statistics (by domain):

System		Conn	Elapsed
1	*.ip.linodeusercontent.com	86	00:00:12
2	unresolved	7	00:00:05
3	*.cust.telenor.se	4	00:00:04
4	*.probe.onyphe.net	3	00:00:06
5	*.tbcn.telia.com	3	00:00:01
6	*.211.203.35.bc.googleusercontent.com	2	00:00:00
7	*.210.203.35.bc.googleusercontent.com	1	00:00:00
8	*.monitoring.internet-measurement.com	1	00:00:01
TOTAL: 8		107	00:00:34

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
172-233-58-223.ip.linodeusercontent.com	3.791	0.495	0.000	00:00:12
c-5eea45bc-74736162.cust.telenor.se	0.033	0.026	0.177	00:00:04
montoya.probe.onyphe.net	0.018	0.005	0.000	00:00:03
charlize.probe.onyphe.net	0.044	0.004	0.000	00:00:03
205.210.31.37	0.004	0.009	0.000	00:00:02
comprehensive.monitoring.internet-measurement.com	0.005	0.006	0.000	00:00:01
81-229-79-101-no600.tbcn.telia.com	0.032	0.015	0.060	00:00:01
147.185.132.176	0.098	0.009	0.000	00:00:01
192.211.203.35.bc.googleusercontent.com	0.089	0.009	0.000	00:00:00
147.185.133.127	0.041	0.005	0.000	00:00:00
206.168.34.35	0.035	0.011	0.000	00:00:00
205.210.31.105	0.008	0.005	0.000	00:00:00
180.210.203.35.bc.googleusercontent.com	0.040	0.008	0.000	00:00:00
194.164.107.4	0.008	0.006	0.000	00:00:00
TOTAL: 14	4.246	0.613	0.237	00:00:34

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.132.176	4
147.185.133.127	4
180.210.203.35.bc.googleusercontent.com	4
192.211.203.35.bc.googleusercontent.com	4
montoya.probe.onyphe.net	3
206.168.34.35	1
TOTAL: 6	20

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
User-Agent: Hello from Palo Alto Network...	2
User-Agent: curl/7.68.0	2
#026#003#003#001¨#001	1
EHLO www.censys.io	1
¯uk‚ ½ÝóÐAËÑÒÉO#001Ÿô!ímÌ0#020ˆë“·»Xç–ÿ#035¾20	1
À$ÀÀ¯À,ÀrÀsÌ©#023#002#023#001Ì#024À#007À#022À#023À'À/À#024À(À0À`Àa...	1
TOTAL: 10	20

NNRP client timeouts [Top 20]:

System	Conn	Peer
147.185.132.176	1	2
147.185.133.127	1	1
172-233-58-223.ip.linodeusercontent.com	1	1
180.210.203.35.bc.googleusercontent.com	1	1
192.211.203.35.bc.googleusercontent.com	1	2
TOTAL: 5	5	10

Daily Usenet report

Oct 12 03:00:01 -- Oct 13 03:00:01