Daily Usenet report: Dec 24 03:00:01

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Dec 24 03:08:47 news innd: message repeated 2 times: [ ctlinnd command s]

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	234072	59.6%	30.6 MB	65.3%
innd	132167	33.6%	13.7 MB	29.3%
nnrpd	24264	6.2%	2.3 MB	4.9%
innfeed	2407	0.6%	254.1 KB	0.5%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 5	392911	100.0%	46.9 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	234029	47.2%
Negative hits	233872	47.1%
Cache misses	27715	5.6%
Positive hits	420	0.1%
TOTAL: 4	496036	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.142	0.0%	14	0.000	10.143	45.000
article cleanup	00:00:00.880	0.0%	234036	0.000	0.004	0.124
article logging	00:00:03.527	0.0%	234132	0.000	0.015	0.337
article parse	00:00:02.392	0.0%	737446	0.000	0.003	0.053
article write	00:01:24.534	0.1%	110024	0.000	0.768	52.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.455	0.0%	829263	0.000	0.001	0.006
hisgrep/artcncl	00:00:00.035	0.0%	14	0.000	2.500	33.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:07:26.491	0.5%	496188	0.000	0.900	8.718
history sync	00:00:00.021	0.0%	314	0.000	0.067	7.000
history write	00:04:41.898	0.3%	234017	0.000	1.205	22.000
hiswrite/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	23:39:45.663	98.6%	771951	56.899	110.351	723.145
nntp read	00:00:05.967	0.0%	766609	0.000	0.008	0.157
overview write	00:00:21.126	0.0%	110024	0.000	0.192	31.000
perl filter	00:05:27.173	0.4%	234017	0.374	1.398	80.000
python filter	00:00:11.212	0.0%	496169	0.000	0.023	0.370
site send	00:00:00.889	0.0%	110024	0.000	0.008	0.200
TOTAL: 24:00:13.182	23:59:32.405	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.163	0.0%	109989	0.000	0.001	0.050
article prepare	00:00:00.023	0.0%	439460	0.000	0.000	0.006
article read	00:00:07.471	0.0%	109865	0.000	0.068	2.870
backlog stats	00:00:00.142	0.0%	554664	0.000	0.000	0.011
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:02.136	0.0%	329878	0.000	0.006	0.061
data write	00:00:03.469	0.0%	219956	0.000	0.016	0.100
idle	23:59:38.918	100.0%	554664	64.184	155.732	30096.500
status file	00:00:00.350	0.0%	203	0.000	1.724	122.000
TOTAL: 23:59:58.182	23:59:52.672	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	02:25:11.600	96.2%	24070	0.000	361.928	5499.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:03.976	0.0%	74160	0.000	0.054	4.704
readart	00:00:12.951	0.1%	2892	0.000	4.478	47.500
TOTAL: 02:30:57.269	02:25:28.527	96.4%	-	-	-	-

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	261838	109884	28038	123916	41%	23:58:34
2	localhost	25	0	0	0	0	0%	00:00:00
TOTAL: 2		25	261838	109884	28038	123916	41%	23:58:34

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	chimia.se	560.0 MB	232.3 KB	324.7 MB	885.0 MB	63%	3.9 KB
2	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 2		560.0 MB	232.3 KB	324.7 MB	885.0 MB	63%	3.9 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Dec 24 03:00:01 - 03:59:59	5246	4.8%	1.46	18.4 MB	3.3%	5.24
Dec 24 04:00:00 - 04:59:59	5487	5.0%	1.52	21.3 MB	3.8%	6.07
Dec 24 05:00:00 - 05:59:59	4746	4.3%	1.32	23.5 MB	4.2%	6.70
Dec 24 06:00:00 - 06:59:59	4902	4.5%	1.36	18.3 MB	3.3%	5.20
Dec 24 07:00:00 - 07:59:59	4024	3.7%	1.12	17.6 MB	3.1%	5.02
Dec 24 08:00:00 - 08:59:59	4855	4.4%	1.35	20.1 MB	3.6%	5.70
Dec 24 09:00:00 - 09:59:59	4784	4.3%	1.33	23.6 MB	4.2%	6.70
Dec 24 10:00:00 - 10:59:59	4670	4.2%	1.30	22.4 MB	4.0%	6.38
Dec 24 11:00:00 - 11:59:59	2850	2.6%	0.79	10.4 MB	1.9%	2.97
Dec 24 12:00:00 - 12:59:59	5020	4.6%	1.39	56.5 MB	10.1%	16.08
Dec 24 13:00:00 - 13:59:59	4420	4.0%	1.23	13.8 MB	2.5%	3.91
Dec 24 14:00:00 - 14:59:59	4195	3.8%	1.17	23.9 MB	4.3%	6.80
Dec 24 15:00:00 - 15:59:59	5057	4.6%	1.40	38.0 MB	6.8%	10.80
Dec 24 16:00:00 - 16:59:59	4284	3.9%	1.19	45.7 MB	8.2%	13.01
Dec 24 17:00:00 - 17:59:59	3738	3.4%	1.04	22.9 MB	4.1%	6.52
Dec 24 18:00:00 - 18:59:59	4595	4.2%	1.28	63.3 MB	11.3%	17.99
Dec 24 19:00:00 - 19:59:59	3911	3.6%	1.09	34.4 MB	6.1%	9.78
Dec 24 20:00:00 - 20:59:59	6167	5.6%	1.71	15.3 MB	2.7%	4.35
Dec 24 21:00:00 - 21:59:59	4758	4.3%	1.32	12.2 MB	2.2%	3.47
Dec 24 22:00:00 - 22:59:59	3099	2.8%	0.86	7.7 MB	1.4%	2.19
Dec 24 23:00:00 - 23:59:59	3267	3.0%	0.91	11.3 MB	2.0%	3.22
Dec 25 00:00:00 - 00:59:59	4456	4.1%	1.24	13.4 MB	2.4%	3.81
Dec 25 01:00:00 - 01:59:59	6174	5.6%	1.72	13.9 MB	2.5%	3.97
Dec 25 02:00:00 - 02:59:59	5282	4.8%	1.47	12.3 MB	2.2%	3.49
Dec 25 03:00:00 - 03:00:02	2	0.0%	1.00	3.7 KB	0.0%	1.85
TOTAL: 24:00:01	109989	100.0%	1.27	560.3 MB	100.0%	6.64

Sites sending bad articles:

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

INND Perl filter [Top 20]:

Reason	Count
EMP (phn path)	76015
EMP (phn nph)	26729
EMP (phl)	20150
EMP (md5)	396
HTML Multipart	295
Too many newsgroups (meow)	136
Subject Rejected	92
Too many newsgroups (low_xpost)	65
Scoring filter	40
MI5 Filter	26
HTML post	8
Binary: misplaced binary	5
hierarchy violation - crosspost outside netscape	3
hierarchy violation - crosspost outside sdnet	3
Too many newsgroups	2
Binary Image: misplaced gif	1
HTML Image Tags	1
HTML file attachment	1
TOTAL: 18	123968

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	chimia.se	993
	TOTAL: 1	993
Including strange strings
	chimia.se	96
	TOTAL: 1	96
TOTAL: 2		1089

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	sklaffkom.se	109989	54	124	109811	0	0%	23:57:10
2	sklaff.dev	0	0	0	0	109989	0%	23:57:43
3	thebunker.nu	0	0	0	0	109989	0%	23:59:58
4	usenet.blueworldhosting.com	0	0	0	0	97028	0%	23:59:58
TOTAL: 4		109989	54	124	109811	317006	0%	95:54:49

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	sklaffkom.se	309.6 KB	559.4 MB	559.7 MB	6.6 KB/s	5.2 KB	23:57:10
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:58
4	usenet.blueworldhosting.com	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:59:58
TOTAL: 4		309.6 KB	559.4 MB	559.7 MB	1.7 KB/s	5.2 KB	95:54:49

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	66.61.98.95	2577	2832	12.9 MB	1292	0	0	02:29:49
TOTAL: 1		2577	2832	12.9 MB	1292	0	0	02:30:56

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	unresolved	2587	2832	12.9 MB	1292	02:30:14
2	*.211.203.35.bc.googleusercontent.com	6	0	0.0 KB	0	00:00:35
3	*.scanner.modat.io	5	0	0.0 KB	0	00:00:00
4	*.ip.linodeusercontent.com	4	0	0.0 KB	0	00:00:06
TOTAL: 4		2602	2832	12.9 MB	1292	02:30:56

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
66.61.98.95	23.824	15.596	02:29:49
61.211.203.35.bc.googleusercontent.com	0.250	0.027	00:00:35
147.185.133.101	0.082	0.009	00:00:11
45-79-5-11.ip.linodeusercontent.com	0.008	0.003	00:00:05
147.185.133.100	0.040	0.004	00:00:05
199.45.155.66	0.059	0.014	00:00:04
205.210.31.253	0.007	0.005	00:00:02
198.235.24.67	0.005	0.006	00:00:01
o020.scanner.modat.io	0.196	0.021	00:00:00
172-236-228-208.ip.linodeusercontent.com	0.082	0.009	00:00:00
147.185.132.53	0.042	0.004	00:00:00
207.90.244.28	0.007	0.005	00:00:00
45-33-12-122.ip.linodeusercontent.com	0.040	0.002	00:00:00
TOTAL: 13	24.642	15.705	02:30:56

Curious NNRP server explorers [Top 20]:

System	Conn
61.211.203.35.bc.googleusercontent.com	6
o020.scanner.modat.io	5
199.45.155.66	3
147.185.133.101	2
172-236-228-208.ip.linodeusercontent.com	2
147.185.132.53	1
147.185.133.100	1
198.235.24.67	1
205.210.31.253	1
207.90.244.28	1
45-33-12-122.ip.linodeusercontent.com	1
45-79-5-11.ip.linodeusercontent.com	1
TOTAL: 12	25

NNRP gethostbyaddr failures [Top 20]:

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

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

System	Conn
61.211.203.35.bc.googleusercontent.com	12
172-236-228-208.ip.linodeusercontent.com	5
147.185.132.53	4
147.185.133.100	4
147.185.133.101	4
199.45.155.66	1
o020.scanner.modat.io	1
TOTAL: 7	31

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

Command	Count
GET / HTTP/1.1	7
Host: 109.238.130.155:563	7
Accept: /	5
User-Agent: curl/7.68.0	4
Accept-Encoding: gzip	3
User-Agent: Hello from Palo Alto Network...	2
EHLO www.censys.io	1
HELO	1
User-Agent: Mozilla/5.0 (Macintosh; Inte...	1
TOTAL: 9	31

NNRP client timeouts [Top 20]:

System	Conn	Peer
61.211.203.35.bc.googleusercontent.com	3	6
147.185.132.53	1	1
147.185.133.100	1	1
147.185.133.101	1	2
172-236-228-208.ip.linodeusercontent.com	1	1
199.45.155.66	1	2
o020.scanner.modat.io	1	1
TOTAL: 7	9	17

Newsgroup request counts (by hierarchy):

Hierarchy		Count	Pct
1	alt	1370	48.4%
2	comp	666	23.5%
3	rec	398	14.1%
4	sci	210	7.4%
5	soc	88	3.1%
6	misc	46	1.6%
7	news	34	1.2%
8	de	10	0.4%
9	humanities	10	0.4%
TOTAL: 9		2832	100.0%

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

Newsgroup		Count
1	alt.arts.poetry.comments	40
2	soc.culture.polish	32
3	alt.comp.software.thunderbird	20
4	alt.misc.forteana	20
5	alt.org.promisekeepers	20
6	comp.theory	20
7	news.lists.filters	20
8	alt.journalism.gonzo	16
9	alt.christnet.racism	12
10	alt.running.out.of.newsgroup.names	12
11	alt.agriculture.beef	10
12	alt.culture.internet	10
13	alt.games.omega	10
14	alt.industrial.computing	10
15	alt.microcontrollers.8bit	10
16	alt.pl.zbluzgaj	10
17	comp.sys.ibm.pc.hardware.cd-rom	10
18	humanities.design.misc	10
19	rec.arts.disney.animation	10
20	sci.physics.electromag	10
21	alt.bonsai	8
22	alt.business.internal-audit	8
23	alt.cable-ip	8
24	alt.cellular.tech	8
25	alt.chinchilla	8
26	alt.cuddle	8
27	alt.fishing	8
28	alt.folklore.military	8
29	alt.hemp	8
30	alt.humor.oracle	8
31	alt.music.celine-dion	8
32	alt.music.techno	8
33	alt.pets.arachnids	8
34	alt.sex.beastiality	8
35	alt.sex.breast	8
36	alt.sys.perq	8
37	alt.tv.magnum-pi	8
38	alt.video.avid_editors	8
39	alt.zines	8
40	comp.ai.doc-analysis.ocr	8
41	comp.groupware.lotus-notes.admin	8
42	comp.infosystems.www.servers.ms-windows	8
43	comp.lang.java.programmer	8
44	comp.software.licensing	8
45	comp.sys.newton.misc	8
46	comp.sys.newton.programmer	8
47	comp.sys.palmtops	8
48	news.admin.hierarchies	8
49	rec.aquaria.freshwater.cichlids	8
50	rec.aquaria.freshwater.misc	8
51	rec.collecting.sport.football	8
52	rec.collecting.sport.hockey	8
53	rec.games.board.ce	8
54	rec.music.classical.performing	8
55	rec.skiing.backcountry	8
56	sci.bio.entomology.homoptera	8
57	sci.space.science	8
58	alt.amateur-comp	6
59	alt.animals.dolphins	6
60	alt.art.marketplace	6
61	alt.business.multi-level.exceltel	6
62	alt.comp.compression	6
63	alt.comp.dcom.sys.xyplex	6
64	alt.comp.hardware.aptiva	6
65	alt.comp.periphs.cdr	6
66	alt.comp.periphs.videocards.matrox	6
67	alt.corel.graphics	6
68	alt.culture.lounge	6
69	alt.dcom.telecom.ip	6
70	alt.fan.amy-fisher	6
71	alt.fan.beable	6
72	alt.fan.hello-kitty	6
73	alt.fan.michael-bolton	6
74	alt.fan.woody-allen	6
75	alt.games.programming	6
76	alt.games.quake2	6
77	alt.geek	6
78	alt.graphics.pixutils	6
79	alt.humor.best-of-usenet.d	6
80	alt.kids-talk	6
81	alt.mining.recreational	6
82	alt.missing-kids	6
83	alt.music.beastie-boys	6
84	alt.music.brian-eno	6
85	alt.music.hardcore	6
86	alt.music.marillion	6
87	alt.music.nirvana	6
88	alt.music.producer	6
89	alt.music.rage-machine	6
90	alt.personals.transgendered	6
91	alt.politics.perot	6
92	alt.psychology.help	6
93	alt.sex.erotica.marketplace	6
94	alt.sex.passwords	6
95	alt.sports.basketball.nba.det-pistons	6
96	alt.stagecraft	6
97	alt.startrek.creative	6
98	alt.sys.pc-clone.gateway2000	6
99	alt.thebird	6
100	alt.tv.mtv-europe	6
TOTAL: 751		2832

Daily Usenet report

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