Daily Usenet report: Dec 19 03:00:02

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Dec 19 04:13:45 news innd: message repeated 2 times: [ ctlinnd command s]

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	222090	61.1%	25.6 MB	63.8%
innd	134459	37.0%	13.9 MB	34.5%
nnrpd	4521	1.2%	448.6 KB	1.1%
innfeed	2400	0.7%	254.2 KB	0.6%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 5	363471	100.0%	40.2 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	221907	50.0%
Negative hits	221841	50.0%
Cache misses	212	0.0%
Positive hits	12	0.0%
TOTAL: 4	443972	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.192	0.0%	12	0.000	16.000	93.000
article cleanup	00:00:00.975	0.0%	222068	0.000	0.004	0.147
article logging	00:00:03.442	0.0%	222087	0.000	0.015	0.671
article parse	00:00:01.904	0.0%	669033	0.000	0.003	0.014
article write	00:05:52.478	0.4%	94755	0.000	3.720	31.795
artlog/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
artlog/artwrite	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:00:00.263	0.0%	676298	0.000	0.000	0.007
hisgrep/artcncl	00:00:00.003	0.0%	12	0.000	0.250	0.750
hishave/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
hissync/artwrite	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:17:42.954	1.2%	444360	0.000	2.392	11.152
history sync	00:00:00.005	0.0%	293	0.000	0.017	1.000
history write	00:04:23.070	0.3%	222068	0.018	1.185	7.525
hiswrite/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	23:26:14.905	97.7%	670838	96.750	125.775	397.993
nntp read	00:00:05.426	0.0%	669282	0.000	0.008	0.137
overview write	00:00:09.643	0.0%	94755	0.000	0.102	24.940
perl filter	00:04:32.553	0.3%	222068	0.369	1.227	7.489
python filter	00:00:11.522	0.0%	444360	0.000	0.026	0.342
site send	00:00:00.747	0.0%	94755	0.000	0.008	0.066
TOTAL: 23:59:57.480	23:59:20.082	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.122	0.0%	94697	0.000	0.001	0.034
article prepare	00:00:00.031	0.0%	378788	0.000	0.000	0.008
article read	00:00:53.656	0.1%	94697	0.000	0.567	7.208
backlog stats	00:00:00.145	0.0%	478436	0.000	0.000	0.016
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.908	0.0%	284125	0.000	0.007	0.039
data write	00:00:02.950	0.0%	189487	0.000	0.016	0.067
idle	23:57:56.121	99.9%	478436	89.284	180.329	618.381
status file	00:00:00.110	0.0%	196	0.000	0.561	10.750
TOTAL: 23:58:59.652	23:58:55.043	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:48:15.455	94.3%	3231	21.000	896.148	900050.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.723	0.0%	11833	0.000	0.061	4.339
readart	00:00:03.183	0.1%	630	0.000	5.052	101.500
TOTAL: 00:51:11.599	00:48:19.361	94.4%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	chimia.se	0	222224	94738	224	127262	42%	23:59:32
2	localhost	25	0	0	0	0	0%	00:00:00
TOTAL: 2		25	222224	94738	224	127262	42%	23:59:32

Incoming Volume (INN):

Server		AcceptVol	RejVol	TotalVol	%Acc	Vol/Art
1	chimia.se	208.2 MB	259.4 MB	467.6 MB	44%	2.2 KB
2	localhost	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 2		208.2 MB	259.4 MB	467.6 MB	44%	2.2 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Dec 19 03:00:02 - 03:59:59	4212	4.4%	1.17	9.5 MB	4.6%	2.71
Dec 19 04:00:00 - 04:59:59	4370	4.6%	1.21	9.5 MB	4.6%	2.70
Dec 19 05:00:00 - 05:59:59	4541	4.8%	1.26	9.7 MB	4.6%	2.75
Dec 19 06:00:00 - 06:59:59	4167	4.4%	1.16	9.1 MB	4.4%	2.58
Dec 19 07:00:00 - 07:59:59	3934	4.2%	1.09	8.5 MB	4.1%	2.42
Dec 19 08:00:00 - 08:59:59	3236	3.4%	0.90	7.6 MB	3.7%	2.17
Dec 19 09:00:00 - 09:59:59	3387	3.6%	0.94	7.9 MB	3.8%	2.24
Dec 19 10:00:00 - 10:59:59	2350	2.5%	0.65	5.4 MB	2.6%	1.53
Dec 19 11:00:00 - 11:59:59	4075	4.3%	1.13	9.5 MB	4.6%	2.72
Dec 19 12:00:00 - 12:59:59	2816	3.0%	0.78	6.7 MB	3.2%	1.92
Dec 19 13:00:00 - 13:59:59	3932	4.1%	1.09	10.0 MB	4.8%	2.83
Dec 19 14:00:00 - 14:59:59	4227	4.5%	1.17	11.2 MB	5.4%	3.18
Dec 19 15:00:00 - 15:59:59	4540	4.8%	1.26	10.2 MB	4.9%	2.92
Dec 19 16:00:00 - 16:59:59	4567	4.8%	1.27	10.1 MB	4.8%	2.87
Dec 19 17:00:00 - 17:59:59	5846	6.2%	1.62	11.4 MB	5.5%	3.26
Dec 19 18:00:00 - 18:59:59	4915	5.2%	1.37	9.5 MB	4.6%	2.71
Dec 19 19:00:00 - 19:59:59	5376	5.7%	1.49	10.3 MB	4.9%	2.93
Dec 19 20:00:00 - 20:59:59	4402	4.6%	1.22	8.8 MB	4.2%	2.50
Dec 19 21:00:00 - 21:59:59	3111	3.3%	0.86	6.5 MB	3.1%	1.84
Dec 19 22:00:00 - 22:59:59	2769	2.9%	0.77	5.6 MB	2.7%	1.58
Dec 19 23:00:00 - 23:59:59	2682	2.8%	0.74	5.9 MB	2.8%	1.68
Dec 20 00:00:00 - 00:59:59	3404	3.6%	0.95	7.7 MB	3.7%	2.18
Dec 20 01:00:00 - 01:59:59	3975	4.2%	1.10	8.8 MB	4.2%	2.51
Dec 20 02:00:00 - 02:59:59	3915	4.1%	1.09	8.8 MB	4.2%	2.51
Dec 20 03:00:00 - 03:00:01	4	0.0%	4.00	10.1 KB	0.0%	10.08
TOTAL: 23:59:59	94753	100.0%	1.10	208.2 MB	100.0%	2.47

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other
1	chimia.se	127337	0	0	0	0	0	0	0	127337
TOTAL: 1		127337	0	0	0	0	0	0	0	127337

INND Perl filter [Top 20]:

Reason	Count
EMP (phn path)	103560
EMP (phn nph)	15708
EMP (phl)	6915
HTML Multipart	583
EMP (md5)	466
Subject Rejected	42
Too many newsgroups (low_xpost)	30
Binary: misplaced binary	5
HTML post	5
Scoring filter	2
HTML Image Tags	1
Too many newsgroups (meow)	1
TOTAL: 12	127318

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	chimia.se	19
	TOTAL: 1	19
TOTAL: 1		19

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Reject	Spool	%Took	Elapsed
1	sklaffkom.se	94753	50	94703	0	0%	23:59:57
2	sklaff.dev	0	0	0	94753	0%	23:57:43
3	thebunker.nu	0	0	0	94753	0%	23:59:55
4	usenet.blueworldhosting.com	0	0	0	0	0%	23:59:57
TOTAL: 4		94753	50	94703	189506	0%	95:57:32

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	sklaffkom.se	235.3 KB	208.3 MB	208.5 MB	2.5 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:55
4	usenet.blueworldhosting.com	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:59:57
TOTAL: 4		235.3 KB	208.3 MB	208.5 MB	0.6 KB/s	2.3 KB	95:57:32

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	66.61.98.95	682	624	5.6 MB	294	0	0	00:20:11
TOTAL: 1		682	624	5.6 MB	294	0	0	00:51:11

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	unresolved	707	624	5.6 MB	294	00:50:39
2	*.monitoring.internet-measurement.com	7	0	0.0 KB	0	00:00:07
3	*.150.216.162.bc.googleusercontent.com	3	0	0.0 KB	0	00:00:10
4	*.stretchoid.com	2	0	0.0 KB	0	00:00:10
5	*.210.203.35.bc.googleusercontent.com	1	0	0.0 KB	0	00:00:00
6	*.shodan.io	1	0	0.0 KB	0	00:00:03
TOTAL: 6		721	624	5.6 MB	294	00:51:11

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
218.75.38.213	0.008	0.005	00:30:00
66.61.98.95	6.233	3.719	00:20:11
147.185.133.166	0.084	0.008	00:00:11
azpdcgjzisk4.stretchoid.com	0.011	0.011	00:00:10
4.150.216.162.bc.googleusercontent.com	0.080	0.010	00:00:09
104.152.52.233	0.008	0.004	00:00:03
census6.shodan.io	0.007	0.004	00:00:03
revolutionary.monitoring.internet-measurement.com	0.041	0.004	00:00:03
198.235.24.150	0.006	0.004	00:00:02
thoughtful.monitoring.internet-measurement.com	0.043	0.004	00:00:02
147.185.132.204	0.006	0.007	00:00:02
reassuring.monitoring.internet-measurement.com	0.007	0.004	00:00:01
104.152.52.226	0.042	0.004	00:00:01
104.152.52.230	0.003	0.009	00:00:01
66.132.153.135	0.042	0.008	00:00:00
104.152.52.223	0.384	0.037	00:00:00
104.152.52.215	0.041	0.005	00:00:00
104.152.52.238	0.007	0.005	00:00:00
104.152.52.217	0.038	0.007	00:00:00
79.150.216.162.bc.googleusercontent.com	0.042	0.005	00:00:00
TOTAL: 27	7.340	3.898	00:51:11

Curious NNRP server explorers [Top 20]:

System	Conn
104.152.52.223	7
147.185.133.166	2
4.150.216.162.bc.googleusercontent.com	2
azpdcgjzisk4.stretchoid.com	2
104.152.52.215	1
104.152.52.217	1
104.152.52.219	1
104.152.52.220	1
104.152.52.222	1
104.152.52.224	1
104.152.52.226	1
104.152.52.230	1
104.152.52.233	1
104.152.52.238	1
104.152.52.243	1
131.210.203.35.bc.googleusercontent.com	1
147.185.132.204	1
198.235.24.150	1
205.210.31.232	1
218.75.38.213	1
TOTAL: 30	39

NNRP gethostbyaddr failures [Top 20]:

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

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

System	Conn
104.152.52.243	10
104.152.52.226	5
104.152.52.230	5
131.210.203.35.bc.googleusercontent.com	4
147.185.133.166	4
4.150.216.162.bc.googleusercontent.com	4
79.150.216.162.bc.googleusercontent.com	4
104.152.52.215	2
104.152.52.238	2
104.152.52.233	1
218.75.38.213	1
66.132.153.135	1
azpdcgjzisk4.stretchoid.com	1
TOTAL: 13	44

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

Command	Count
GET / HTTP/1.1	6
Accept: /	4
Host: 109.238.130.155:563	4
Accept-Encoding: gzip	2
Connection: close	2
EHLO 109.238.130.155	2
Host: 109.238.130.155	2
MAIL FROM:<relaycheck_please_ignore@prot...	2
User-Agent: Hello from Palo Alto Network...	2
User-Agent: curl/7.61.1	2
User-Agent: curl/7.68.0	2
#021ì	1
#026#003#001#005Ê#001	1
7	1
7tÏÁ£#020	1
EHLO www.censys.io	1
GET / HTTP/1.0	1
MGLNDD_109.238.130.155_119	1
SSH-2.0-Go	1
q#014~#014È{Z¼2ØX«cÀ¿p'	1
TOTAL: 25	44

NNRP client timeouts [Top 20]:

System	Conn	Peer
104.152.52.215	1	1
104.152.52.226	1	1
131.210.203.35.bc.googleusercontent.com	1	1
147.185.133.166	1	2
218.75.38.213	1	0
4.150.216.162.bc.googleusercontent.com	1	2
79.150.216.162.bc.googleusercontent.com	1	1
TOTAL: 7	7	14

Newsgroup request counts (by hierarchy):

Hierarchy		Count	Pct
1	rec	504	80.8%
2	alt	80	12.8%
3	comp	30	4.8%
4	fido7	4	0.6%
5	misc	2	0.3%
6	sci	2	0.3%
7	soc	2	0.3%
TOTAL: 7		624	100.0%

Newsgroup request counts (by newsgroup) [Top 100]:

Newsgroup		Count
1	rec.collecting	476
2	alt.sex.swingers	22
3	alt.jobs.jobsearch	14
4	alt.image.medical	4
5	alt.sex.movies	4
6	alt.society.futures	4
7	comp.protocols.kerberos	4
8	fido7.ukrnews	4
9	rec.autos.sport.indy	4
10	alt.anagrams	2
11	alt.animals.whales	2
12	alt.circus.arts	2
13	alt.cobol	2
14	alt.comics.image	2
15	alt.comp.periphs.videocards.matrox	2
16	alt.cybercafes	2
17	alt.fan.jiro-nakamura	2
18	alt.fan.richard-nixon	2
19	alt.fishing	2
20	alt.home.lawn.garden	2
21	alt.military.cadet	2
22	alt.org.sierra-club	2
23	alt.os.windows95	2
24	alt.philosophy.objectivism	2
25	alt.sb.programmer	2
26	comp.arch.arithmetic	2
27	comp.databases.ingres	2
28	comp.dcom.telecom	2
29	comp.home.automation	2
30	comp.infosystems.www.browsers.mac	2
31	comp.infosystems.www.servers.misc	2
32	comp.lang.forth.mac	2
33	comp.lang.java.advocacy	2
34	comp.lang.pascal.ansi-iso	2
35	comp.lang.php	2
36	comp.os.os2.beta	2
37	comp.security.unix	2
38	comp.sys.mentor	2
39	misc.fitness.misc	2
40	rec.audio.misc	2
41	rec.autos.4x4	2
42	rec.aviation.products	2
43	rec.collecting.books	2
44	rec.crafts.textiles.sewing	2
45	rec.games.board	2
46	rec.games.roguelike.rogue	2
47	rec.games.trading-cards.marketplace.misc	2
48	rec.music.country.western	2
49	rec.music.funky	2
50	rec.photo.marketplace	2
51	rec.video.production	2
52	sci.med.diseases.cancer	2
53	soc.culture.scientists	2
TOTAL: 53		624

Daily Usenet report

Dec 19 03:00:02 -- Dec 20 03:00:01