Daily Usenet report: Nov 27 03:00:02

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

Nov 27 04:34:36 news innd: message repeated 2 times: [ ctlinnd command s]
Nov 27 22:32:40 news innd: message repeated 3 times: [ ctlinnd command s]
Nov 27 22:33:00 news innd: message repeated 8 times: [ ctlinnd command s]

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	150560	76.0%	22.4 MB	80.0%
innd	45027	22.7%	5.3 MB	19.1%
innfeed	2297	1.2%	240.3 KB	0.8%
nnrpd	252	0.1%	26.7 KB	0.1%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 5	198137	100.0%	28.0 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	150489	49.4%
Negative hits	150457	49.4%
Cache misses	2927	1.0%
Positive hits	544	0.2%
TOTAL: 4	304417	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.300	0.0%	33	0.000	9.091	54.000
article cleanup	00:00:00.672	0.0%	150604	0.000	0.004	0.231
article logging	00:00:02.185	0.0%	150646	0.000	0.015	0.333
article parse	00:00:01.353	0.0%	436705	0.000	0.003	0.091
article write	00:10:26.115	0.7%	118896	0.000	5.266	149.000
artlog/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:00:00.469	0.0%	444962	0.000	0.001	1.739
hisgrep/artcncl	00:00:00.001	0.0%	33	0.000	0.030	0.500
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:13:55.235	1.0%	304678	0.000	2.741	14.755
history sync	00:00:00.143	0.0%	764	0.000	0.187	26.000
history write	00:02:02.895	0.1%	150603	0.000	0.816	57.636
hiswrite/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	23:29:25.893	97.8%	446380	38.071	189.448	60060.000
nntp read	00:00:04.015	0.0%	444518	0.000	0.009	0.335
overview write	00:00:28.067	0.0%	118896	0.000	0.236	16.621
perl filter	00:03:16.076	0.2%	150603	0.402	1.302	51.000
python filter	00:00:08.607	0.0%	293165	0.000	0.029	1.000
site send	00:00:00.935	0.0%	118895	0.000	0.008	0.200
TOTAL: 24:00:32.075	23:59:52.961	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.160	0.0%	118721	0.000	0.001	0.053
article prepare	00:00:00.054	0.0%	611196	0.000	0.000	0.013
article read	00:01:21.364	0.1%	112042	0.000	0.726	26.500
backlog stats	00:00:00.179	0.0%	704927	0.000	0.000	0.016
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:02.805	0.0%	429348	0.000	0.007	0.091
data write	00:00:04.548	0.0%	311596	0.000	0.015	0.143
idle	23:57:37.206	99.9%	704927	40.769	122.363	20067.333
status file	00:00:00.198	0.0%	180	0.000	1.100	26.333
TOTAL: 23:59:13.409	23:59:06.514	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:38.670	51.4%	75	23.500	515.600	10050.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.002	0.0%	324	0.000	0.006	0.067
TOTAL: 00:01:15.191	00:00:38.672	51.4%	-	-	-	-

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	3	142535	110562	3468	28505	77%	23:46:13
2	usenet.blueworldhosting.com	1367	11511	8333	2	3176	72%	23:18:46
3	localhost	25	0	0	0	0	0%	00:00:00
4	news.thebunker.nu	7	0	0	0	0	0%	00:00:01
TOTAL: 4		1402	154046	118895	3470	31681	77%	47:05:00

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	chimia.se	241.8 MB	5.2 KB	57.6 MB	299.4 MB	80%	2.2 KB
2	usenet.blueworldhosting.com	20.7 MB	0.0 KB	7.9 MB	28.5 MB	72%	2.5 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		262.5 MB	5.2 KB	65.4 MB	327.9 MB	80%	2.2 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Nov 27 03:00:02 - 03:59:59	7988	6.7%	2.22	17.6 MB	6.7%	5.02
Nov 27 04:00:00 - 04:59:59	3400	2.9%	0.94	7.7 MB	2.9%	2.20
Nov 27 05:00:00 - 05:59:59	5605	4.7%	1.56	13.3 MB	5.1%	3.78
Nov 27 06:00:00 - 06:59:59	1853	1.6%	0.51	4.8 MB	1.8%	1.37
Nov 27 07:00:00 - 07:59:59	3011	2.5%	0.84	7.3 MB	2.8%	2.08
Nov 27 08:00:00 - 08:59:59	8066	6.8%	2.24	15.9 MB	6.1%	4.53
Nov 27 09:00:00 - 09:59:59	5545	4.7%	1.54	15.3 MB	5.8%	4.36
Nov 27 10:00:00 - 10:59:59	2057	1.7%	0.57	4.5 MB	1.7%	1.28
Nov 27 11:00:00 - 11:59:59	1864	1.6%	0.52	3.8 MB	1.5%	1.08
Nov 27 12:00:00 - 12:59:59	1897	1.6%	0.53	3.7 MB	1.4%	1.06
Nov 27 13:00:00 - 13:59:59	3048	2.6%	0.85	6.9 MB	2.6%	1.95
Nov 27 14:00:00 - 14:59:59	4556	3.8%	1.27	12.0 MB	4.6%	3.42
Nov 27 15:00:00 - 15:59:59	3627	3.1%	1.01	7.9 MB	3.0%	2.24
Nov 27 16:00:00 - 16:59:59	3497	2.9%	0.97	7.5 MB	2.9%	2.15
Nov 27 17:00:00 - 17:59:59	3151	2.7%	0.88	6.3 MB	2.4%	1.80
Nov 27 18:00:00 - 18:59:59	5461	4.6%	1.52	10.6 MB	4.0%	3.00
Nov 27 19:00:00 - 19:59:59	7106	6.0%	1.97	14.0 MB	5.3%	3.98
Nov 27 20:00:00 - 20:59:59	2539	2.1%	0.71	5.7 MB	2.2%	1.62
Nov 27 21:00:00 - 21:59:59	5072	4.3%	1.41	10.8 MB	4.1%	3.06
Nov 27 22:00:00 - 22:59:59	6719	5.7%	1.87	14.7 MB	5.6%	4.17
Nov 27 23:00:00 - 23:59:59	7846	6.6%	2.18	16.2 MB	6.2%	4.61
Nov 28 00:00:00 - 00:59:59	8583	7.2%	2.38	18.5 MB	7.0%	5.25
Nov 28 01:00:00 - 01:59:59	8326	7.0%	2.31	18.8 MB	7.2%	5.35
Nov 28 02:00:00 - 02:59:59	7967	6.7%	2.21	18.5 MB	7.0%	5.25
Nov 28 03:00:00 - 03:00:01	4	0.0%	4.00	7.9 KB	0.0%	7.90
TOTAL: 23:59:59	118788	100.0%	1.37	262.3 MB	100.0%	3.11

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	chimia.se	28564	0	1	28563
2	usenet.blueworldhosting.com	3208	307	0	2901
TOTAL: 2		31772	307	1	31464

Unwanted newsgroups [Top 20]:

Newsgroup	Count
hispagatos.hacking.ransomware	14
cn.culture.arts.story	13
fr.comp.sys.pc	11
de.newusers.infos	10
de.sci.physik	10
fido7.altyn.local	10
de.comm.provider.mail	9
hispagatos.mastodon.tag.hacking	9
pl.sci.fizyka	9
fr.rec.moto	8
fido7.ru.sex.condoms	7
fido7.xsu.cellular	7
microsoft.public.windowsxp.general	7
de.rec.musik.hifi	6
it-alt.comp.software.mozilla	5
it.comp.aiuto	5
pl.comp.os.ms-windows.winnt	5
uk.tech.broadcast	5
uk.telecom.mobile	5
de.comm.software.newsreader	4
TOTAL: 120	307

INND Perl filter [Top 20]:

Reason	Count
EMP (phn path)	18746
EMP (phn nph)	8471
EMP (phl)	2346
EMP (md5)	1370
HTML Multipart	200
Too many newsgroups	106
MI5 Filter	51
Too many newsgroups (meow)	42
HTML post	27
Too many newsgroups (low_xpost)	20
Scoring filter	15
User-issued cancel	13
Subject Rejected	10
HTML file attachment	3
Bad path (quark.idirect.com.POSTED)	1
PFM bot misc	1
TOTAL: 16	31422

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	chimia.se	27
	TOTAL: 1	27
Including strange strings
	usenet.blueworldhosting.com	31
	chimia.se	11
	TOTAL: 2	42
TOTAL: 2		69

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	sklaffkom.se	118795	1574	6677	110520	5	1%	23:59:57
2	usenet.blueworldhosting.com	40851	0	3	40847	0	0%	09:56:06
3	sklaff.dev	0	0	0	0	118771	0%	23:57:41
4	thebunker.nu	0	0	0	0	118771	0%	23:59:57
TOTAL: 4		159646	1574	6680	151367	237547	0%	81:53:41

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	sklaffkom.se	4.8 MB	242.5 MB	247.2 MB	2.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:41
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	97.5 MB	97.5 MB	2.8 KB/s	2.4 KB	09:56:06
TOTAL: 4		4.8 MB	340.0 MB	344.7 MB	1.2 KB/s	2.3 KB	81:53:41

NNRP readership statistics:

System		Conn	Elapsed
1	81-229-79-101-no600.tbcn.telia.com	7	00:00:03
2	scanner-06.ch1.censys-scanner.com	5	00:00:09
3	101.36.114.124	3	00:00:10
4	167.94.146.57	3	00:00:03
5	147.185.133.243	2	00:00:13
6	194.149.216.162.bc.googleusercontent.com	2	00:00:14
7	azpdesvv0owh.stretchoid.com	2	00:00:10
8	jersey.scan.bufferover.run	2	00:00:00
9	104.152.52.56	1	00:00:00
10	148.149.216.162.bc.googleusercontent.com	1	00:00:00
11	198.235.24.144	1	00:00:01
12	198.235.24.54	1	00:00:00
13	198.235.24.97	1	00:00:01
14	45-56-79-53.ip.linodeusercontent.com	1	00:00:00
15	73.150.216.162.bc.googleusercontent.com	1	00:00:00
16	adroit.monitoring.internet-measurement.com	1	00:00:03
17	brisk.monitoring.internet-measurement.com	1	00:00:00
18	cheerful.monitoring.internet-measurement.com	1	00:00:03
19	consistent.monitoring.internet-measurement.com	1	00:00:00
20	n34.scanner.modat.io	1	00:00:00
21	polished.monitoring.internet-measurement.com	1	00:00:00
22	realized.monitoring.internet-measurement.com	1	00:00:00
TOTAL: 22		40	00:01:15

NNRP readership statistics (by domain):

System		Conn	Elapsed
1	unresolved	12	00:00:29
2	*.tbcn.telia.com	7	00:00:03
3	*.monitoring.internet-measurement.com	6	00:00:06
4	*.ch1.censys-scanner.com	5	00:00:09
5	*.149.216.162.bc.googleusercontent.com	3	00:00:15
6	*.scan.bufferover.run	2	00:00:00
7	*.stretchoid.com	2	00:00:10
8	*.150.216.162.bc.googleusercontent.com	1	00:00:00
9	*.ip.linodeusercontent.com	1	00:00:00
10	*.scanner.modat.io	1	00:00:00
TOTAL: 10		40	00:01:15

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
194.149.216.162.bc.googleusercontent.com	0.084	0.007	0.000	00:00:14
147.185.133.243	0.087	0.006	0.000	00:00:13
101.36.114.124	0.019	0.015	0.000	00:00:10
azpdesvv0owh.stretchoid.com	0.012	0.011	0.000	00:00:10
scanner-06.ch1.censys-scanner.com	0.074	0.019	0.000	00:00:09
81-229-79-101-no600.tbcn.telia.com	0.054	0.044	0.145	00:00:03
167.94.146.57	0.056	0.014	0.000	00:00:03
cheerful.monitoring.internet-measurement.com	0.040	0.003	0.000	00:00:03
adroit.monitoring.internet-measurement.com	0.041	0.006	0.000	00:00:03
198.235.24.97	0.006	0.007	0.000	00:00:01
198.235.24.144	0.007	0.005	0.000	00:00:01
73.150.216.162.bc.googleusercontent.com	0.049	0.005	0.000	00:00:00
148.149.216.162.bc.googleusercontent.com	0.042	0.005	0.000	00:00:00
jersey.scan.bufferover.run	0.083	0.007	0.000	00:00:00
198.235.24.54	0.006	0.008	0.000	00:00:00
104.152.52.56	0.006	0.008	0.000	00:00:00
consistent.monitoring.internet-measurement.com	0.041	0.003	0.000	00:00:00
n34.scanner.modat.io	0.006	0.006	0.000	00:00:00
brisk.monitoring.internet-measurement.com	0.039	0.003	0.000	00:00:00
45-56-79-53.ip.linodeusercontent.com	0.039	0.005	0.000	00:00:00
TOTAL: 20	0.791	0.187	0.145	00:01:15

NNRP gethostbyaddr failures [Top 20]:

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

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

System	Conn
jersey.scan.bufferover.run	5
147.185.133.243	4
148.149.216.162.bc.googleusercontent.com	4
194.149.216.162.bc.googleusercontent.com	4
73.150.216.162.bc.googleusercontent.com	4
scanner-06.ch1.censys-scanner.com	3
101.36.114.124	2
167.94.146.57	1
azpdesvv0owh.stretchoid.com	1
TOTAL: 9	28

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

Command	Count
GET / HTTP/1.1	5
Host: 109.238.130.155:563	5
Accept-Encoding: gzip	3
Accept: /	3
EHLO www.censys.io	2
User-Agent: Hello from Palo Alto Network...	2
User-Agent: curl/7.68.0	2
#023#003#023#001#023#002#001	1
#026#003#001	1
#026#003#001#001#027#001	1
MGLNDD_109.238.130.155_119	1
User-Agent: Mozilla/5.0 (Macintosh; Inte...	1
À#024	1
TOTAL: 13	28

NNRP client timeouts [Top 20]:

System	Conn	Peer
scanner-06.ch1.censys-scanner.com	2	4
147.185.133.243	1	2
148.149.216.162.bc.googleusercontent.com	1	1
167.94.146.57	1	2
194.149.216.162.bc.googleusercontent.com	1	2
73.150.216.162.bc.googleusercontent.com	1	1
jersey.scan.bufferover.run	1	1
TOTAL: 7	8	17

Daily Usenet report

Nov 27 03:00:02 -- Nov 28 03:00:01