Daily Usenet report: Dec 25 03:00:02

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Dec 25 03:09:58 news innd: message repeated 2 times: [ ctlinnd command s]

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	226781	63.6%	31.0 MB	69.6%
innd	106846	30.0%	11.4 MB	25.6%
nnrpd	20479	5.7%	1.9 MB	4.2%
innfeed	2423	0.7%	251.6 KB	0.6%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 5	356530	100.0%	44.6 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	226683	46.2%
Negative hits	226473	46.2%
Cache misses	32679	6.7%
Positive hits	4708	1.0%
TOTAL: 4	490543	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.133	0.0%	95	0.000	1.400	33.000
article cleanup	00:00:01.160	0.0%	226601	0.000	0.005	0.174
article logging	00:00:03.558	0.0%	226644	0.000	0.016	0.500
article parse	00:00:02.090	0.0%	692349	0.000	0.003	0.111
article write	00:01:14.133	0.1%	127869	0.000	0.580	399.000
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.317	0.0%	756110	0.000	0.000	0.010
hisgrep/artcncl	00:00:00.049	0.0%	95	0.000	0.516	19.000
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:04:18.868	0.3%	490559	0.000	0.528	10.143
history sync	00:00:00.012	0.0%	323	0.000	0.037	2.000
history write	00:03:37.224	0.3%	226562	0.000	0.959	38.000
hiswrite/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	23:43:44.700	98.9%	735241	89.791	116.186	60051.000
nntp read	00:00:06.398	0.0%	730678	0.000	0.009	0.156
overview write	00:00:25.349	0.0%	127869	0.000	0.198	56.000
perl filter	00:04:54.228	0.3%	226562	0.342	1.299	221.500
python filter	00:00:12.908	0.0%	490520	0.000	0.026	0.395
site send	00:00:01.010	0.0%	127869	0.000	0.008	0.200
TOTAL: 23:59:21.514	23:58:42.137	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.214	0.0%	127857	0.000	0.002	0.059
article prepare	00:00:00.041	0.0%	509980	0.000	0.000	0.004
article read	00:00:08.964	0.0%	127495	0.000	0.070	1.907
backlog stats	00:00:00.161	0.0%	643372	0.000	0.000	0.500
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:02.543	0.0%	383171	0.000	0.007	0.067
data write	00:00:04.034	0.0%	255378	0.000	0.016	0.083
idle	23:58:44.496	100.0%	643372	63.142	134.175	30100.000
status file	00:00:00.251	0.0%	215	0.000	1.167	32.000
TOTAL: 23:59:07.094	23:59:00.704	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	02:29:46.105	96.8%	21706	16.000	413.992	10913.286
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:05.502	0.1%	68635	0.000	0.080	9.370
readart	00:00:11.814	0.1%	4339	0.000	2.723	38.500
TOTAL: 02:34:39.731	02:30:03.421	97.0%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	chimia.se	0	264235	127991	37435	98809	48%	24:00:50
2	localhost	25	0	0	0	0	0%	00:00:00
TOTAL: 2		25	264235	127991	37435	98809	48%	24:00:50

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	chimia.se	325.1 MB	393.6 KB	311.5 MB	637.0 MB	51%	2.9 KB
2	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 2		325.1 MB	393.6 KB	311.5 MB	637.0 MB	51%	2.9 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Dec 25 03:00:02 - 03:59:59	1824	1.4%	0.51	5.1 MB	1.6%	1.44
Dec 25 04:00:00 - 04:59:59	3882	3.0%	1.08	10.6 MB	3.3%	3.01
Dec 25 05:00:00 - 05:59:59	4296	3.4%	1.19	12.0 MB	3.7%	3.43
Dec 25 06:00:00 - 06:59:59	1605	1.3%	0.45	4.7 MB	1.4%	1.33
Dec 25 07:00:00 - 07:59:59	1969	1.5%	0.55	5.6 MB	1.7%	1.60
Dec 25 08:00:00 - 08:59:59	5278	4.1%	1.47	10.9 MB	3.4%	3.10
Dec 25 09:00:00 - 09:59:59	6234	4.9%	1.73	11.2 MB	3.5%	3.20
Dec 25 10:00:00 - 10:59:59	5782	4.5%	1.61	10.1 MB	3.1%	2.87
Dec 25 11:00:00 - 11:59:59	5349	4.2%	1.49	10.1 MB	3.1%	2.87
Dec 25 12:00:00 - 12:59:59	8515	6.7%	2.37	20.2 MB	6.2%	5.76
Dec 25 13:00:00 - 13:59:59	7472	5.8%	2.08	15.4 MB	4.7%	4.38
Dec 25 14:00:00 - 14:59:59	6746	5.3%	1.87	14.6 MB	4.5%	4.15
Dec 25 15:00:00 - 15:59:59	7250	5.7%	2.01	15.7 MB	4.8%	4.47
Dec 25 16:00:00 - 16:59:59	8372	6.5%	2.33	29.2 MB	9.0%	8.32
Dec 25 17:00:00 - 17:59:59	6695	5.2%	1.86	27.3 MB	8.4%	7.76
Dec 25 18:00:00 - 18:59:59	7123	5.6%	1.98	17.7 MB	5.4%	5.03
Dec 25 19:00:00 - 19:59:59	5555	4.3%	1.54	16.4 MB	5.1%	4.67
Dec 25 20:00:00 - 20:59:59	4986	3.9%	1.39	13.2 MB	4.1%	3.76
Dec 25 21:00:00 - 21:59:59	5909	4.6%	1.64	14.4 MB	4.4%	4.09
Dec 25 22:00:00 - 22:59:59	5540	4.3%	1.54	14.4 MB	4.4%	4.10
Dec 25 23:00:00 - 23:59:59	4475	3.5%	1.24	11.1 MB	3.4%	3.15
Dec 26 00:00:00 - 00:59:59	4527	3.5%	1.26	12.8 MB	3.9%	3.64
Dec 26 01:00:00 - 01:59:59	3737	2.9%	1.04	9.9 MB	3.1%	2.82
Dec 26 02:00:00 - 02:59:59	4792	3.7%	1.33	12.3 MB	3.8%	3.50
Dec 26 03:00:00 - 03:00:01	1	0.0%	1.00	1.0 KB	0.0%	1.04
TOTAL: 23:59:59	127914	100.0%	1.48	325.0 MB	100.0%	3.85

Sites sending bad articles:

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

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

Groups	Count
news.newusers.questions	1
TOTAL: 1	1

INND Perl filter [Top 20]:

Reason	Count
EMP (phn path)	79165
EMP (phn nph)	14693
EMP (phl)	3844
EMP (md5)	441
HTML Multipart	321
Too many newsgroups (meow)	82
MI5 Filter	56
Too many newsgroups (low_xpost)	46
Too many newsgroups	37
HTML post	23
Subject Rejected	14
Scoring filter	12
Binary: misplaced binary	8
Excessive Supersedes (66.57.92.44)	7
PFM bot misc	5
HTML Image Tags	4
Bad path (newsfeed.slurp.net)	3
Excessive Supersedes (81-86-124-89.dsl.pipex.com)	3
Bad path (news3.cnt.ru)	2
Binary Image: misplaced gif	2
TOTAL: 33	98784

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	chimia.se	892
	TOTAL: 1	892
Including strange strings
	chimia.se	43
	TOTAL: 1	43
TOTAL: 2		935

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	sklaffkom.se	127826	1542	274	126010	0	1%	23:30:31
2	sklaff.dev	0	0	0	0	127826	0%	23:57:41
3	thebunker.nu	0	0	0	0	127826	0%	23:59:57
4	usenet.blueworldhosting.com	0	0	0	0	94150	0%	23:59:57
TOTAL: 4		127826	1542	274	126010	349802	1%	95:28:06

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	sklaffkom.se	4.1 MB	318.7 MB	322.8 MB	3.9 KB/s	2.6 KB	23:30:31
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	0.0 KB	0.0 KB	0.0 KB/s	0	23:59:57
TOTAL: 4		4.1 MB	318.7 MB	322.8 MB	1.0 KB/s	2.6 KB	95:28:06

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	66.61.98.95	2162	4305	18.1 MB	1072	0	0	02:33:02
TOTAL: 1		2162	4305	18.1 MB	1072	0	0	02:34:39

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	unresolved	2190	4305	18.1 MB	1072	02:33:44
2	*.monitoring.internet-measurement.com	7	0	0.0 KB	0	00:00:08
3	*.210.203.35.bc.googleusercontent.com	4	0	0.0 KB	0	00:00:24
4	*.stretchoid.com	4	0	0.0 KB	0	00:00:20
5	*.ip.linodeusercontent.com	2	0	0.0 KB	0	00:00:00
6	*.211.203.35.bc.googleusercontent.com	1	0	0.0 KB	0	00:00:00
7	*.scanner.modat.io	1	0	0.0 KB	0	00:00:00
TOTAL: 7		2209	4305	18.1 MB	1072	02:34:39

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
66.61.98.95	19.951	13.187	02:33:02
37.210.203.35.bc.googleusercontent.com	0.081	0.011	00:00:24
147.185.133.212	0.083	0.006	00:00:17
azpdcs2vie1e.stretchoid.com	0.014	0.010	00:00:10
azpdsssyxvsv.stretchoid.com	0.014	0.014	00:00:10
206.168.34.121	0.053	0.017	00:00:07
104.152.52.204	0.088	0.015	00:00:04
104.152.52.205	0.009	0.002	00:00:03
polished.monitoring.internet-measurement.com	0.067	0.010	00:00:03
breezy.monitoring.internet-measurement.com	0.041	0.005	00:00:03
205.210.31.168	0.007	0.006	00:00:02
sizable.monitoring.internet-measurement.com	0.009	0.004	00:00:01
104.152.52.213	0.041	0.004	00:00:01
205.210.31.35	0.007	0.004	00:00:01
104.152.52.206	0.043	0.003	00:00:00
104.152.52.201	0.299	0.025	00:00:00
104.152.52.210	0.048	0.008	00:00:00
66.132.153.121	0.038	0.006	00:00:00
104.152.52.211	0.044	0.002	00:00:00
104.152.52.209	0.036	0.010	00:00:00
TOTAL: 30	21.225	13.403	02:34:39

Curious NNRP server explorers [Top 20]:

System	Conn
104.152.52.201	5
104.152.52.204	3
206.168.34.121	3
104.152.52.200	2
104.152.52.210	2
147.185.133.212	2
172-236-228-229.ip.linodeusercontent.com	2
37.210.203.35.bc.googleusercontent.com	2
azpdcs2vie1e.stretchoid.com	2
azpdsssyxvsv.stretchoid.com	2
104.152.52.205	1
104.152.52.206	1
104.152.52.207	1
104.152.52.209	1
104.152.52.211	1
104.152.52.213	1
104.152.52.223	1
198.235.24.227	1
205.210.31.168	1
205.210.31.35	1
TOTAL: 32	47

NNRP gethostbyaddr failures [Top 20]:

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

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

System	Conn
104.152.52.207	12
172-236-228-229.ip.linodeusercontent.com	7
104.152.52.204	5
104.152.52.213	5
147.185.133.212	4
206.211.203.35.bc.googleusercontent.com	4
252.210.203.35.bc.googleusercontent.com	4
37.210.203.35.bc.googleusercontent.com	4
51.210.203.35.bc.googleusercontent.com	4
104.152.52.206	2
104.152.52.210	2
104.152.52.205	1
206.168.34.121	1
66.132.153.121	1
azpdcs2vie1e.stretchoid.com	1
azpdsssyxvsv.stretchoid.com	1
TOTAL: 16	58

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

Command	Count
GET / HTTP/1.1	8
Accept: /	5
Accept-Encoding: gzip	4
Host: 109.238.130.155:563	4
User-Agent: Hello from Palo Alto Network...	3
Connection: close	2
EHLO 109.238.130.155	2
EHLO www.censys.io	2
Host: 109.238.130.155	2
Host: 109.238.130.155:119	2
MAIL FROM:<relaycheck_please_ignore@prot...	2
MGLNDD_109.238.130.155_119	2
User-Agent: curl/7.61.1	2
User-Agent: curl/7.68.0	2
#001	1
#021ì	1
#025[	1
#025´<Ì9•À#002\|!#014ƒä #010ùg\|yÖ ïâ@ñ€z#025Ñ#004Êi~îˆÆ¥Ãª...	1
#026#003#001	1
#026#003#001#005Ê#001	1
TOTAL: 30	58

NNRP client timeouts [Top 20]:

System	Conn	Peer
104.152.52.206	1	1
104.152.52.213	1	1
147.185.133.212	1	2
206.168.34.121	1	2
206.211.203.35.bc.googleusercontent.com	1	1
252.210.203.35.bc.googleusercontent.com	1	1
37.210.203.35.bc.googleusercontent.com	1	2
TOTAL: 7	7	16

Newsgroup request counts (by hierarchy):

Hierarchy		Count	Pct
1	soc	2008	46.6%
2	alt	1077	25.0%
3	comp	492	11.4%
4	rec	384	8.9%
5	sci	156	3.6%
6	linux	74	1.7%
7	misc	58	1.3%
8	fr	20	0.5%
9	free	20	0.5%
10	de	6	0.1%
11	news	4	0.1%
12	swnet	4	0.1%
13	talk	2	0.0%
TOTAL: 13		4305	100.0%

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

Newsgroup		Count
1	soc.culture.polish	1968
2	linux.kernel.netdev	54
3	alt.sex.femdom	40
4	alt.misc.forteana	20
5	fr.soc.politique	20
6	free.usenet	20
7	linux.debian.changes.devel	20
8	alt.culture.outerspace	14
9	alt.politics.uk	14
10	rec.toys.cars	12
11	alt.org.pugwash	10
12	alt.tv.x-files	10
13	comp.os.msdos.desqview	10
14	comp.sys.amiga.applications	10
15	alt.agriculture.ratite	8
16	alt.art.caricature	8
17	alt.building.construction	8
18	alt.cdr.panasonic	8
19	alt.cellular.nokia	8
20	alt.cobol	8
21	alt.comedy.marx-bros	8
22	alt.cyberworld	8
23	alt.food.sugar-cereals	8
24	alt.html.webedit	8
25	alt.internet.media-coverage	8
26	alt.rock-n-roll.metal.metallica	8
27	alt.running.out.of.newsgroup.names	8
28	alt.sailing.asa	8
29	comp.graphics.rendering.renderman	8
30	comp.sys.ibm.pc.soundcard.misc	8
31	comp.unix.aix	8
32	rec.arts.comics.dc.vertigo	8
33	rec.arts.movies.production	8
34	rec.arts.sf.tv.babylon5	8
35	rec.music.funky	8
36	sci.engr.control	8
37	sci.stat.edu	8
38	alt.animals.bears	6
39	alt.autos.rod-n-custom	6
40	alt.beer.home-brewing	6
41	alt.business.multilevel	6
42	alt.circus.arts	6
43	alt.comics.alan-moore	6
44	alt.comp.freeware.games	6
45	alt.current-events.net-abuse	6
46	alt.current-events.net-abuse.spam	6
47	alt.cyberpunk.movement	6
48	alt.destroy.microsoft	6
49	alt.elvis.king	6
50	alt.fan.elvis-presley	6
51	alt.games.programming	6
52	alt.hackers	6
53	alt.landscape.architecture	6
54	alt.memetics	6
55	alt.missing-kids	6
56	alt.music.country.classic	6
57	alt.music.producer	6
58	alt.online-service.compuserve	6
59	alt.peeves	6
60	alt.philosophy.law	6
61	alt.sex.passwords	6
62	alt.sys.pdp11	6
63	alt.sys.perq	6
64	alt.teens	6
65	alt.toys.gi-joe	6
66	alt.tv.star-trek.ds9	6
67	alt.ultra-conservatives.crazies-with-guns	6
68	alt.www.sites	6
69	comp.cog-eng	6
70	comp.databases.ingres	6
71	comp.databases.xbase.misc	6
72	comp.infosystems.kiosks	6
73	comp.infosystems.www.browsers.mac	6
74	comp.infosystems.www.servers.misc	6
75	comp.lang.beta	6
76	comp.lsi.testing	6
77	comp.org.ieee	6
78	comp.os.os2.setup.video	6
79	comp.parallel.mpi	6
80	comp.programming.contests	6
81	comp.sys.amiga.programmer	6
82	comp.sys.mac.hypercard	6
83	misc.education.medical	6
84	misc.invest.technical	6
85	rec.aquaria.misc	6
86	rec.arts.sf.starwars.collecting.vintage	6
87	rec.autos.makers.ford.explorer	6
88	rec.autos.makers.mazda.miata	6
89	rec.autos.sport.tech	6
90	rec.boats.building	6
91	rec.collecting.sport.hockey	6
92	rec.games.frp.gurps	6
93	rec.games.roguelike.misc	6
94	rec.music.artists.debbie-gibson	6
95	rec.music.bluenote	6
96	rec.music.gdead	6
97	rec.photo.marketplace	6
98	rec.video.cable-tv	6
99	sci.crypt.research	6
100	sci.med.informatics	6
TOTAL: 669		4305

Daily Usenet report

Dec 25 03:00:02 -- Dec 26 03:00:01