Daily Usenet report: Dec 29 02:30:00

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

Dec 29 08:14:45 spool1 ovsqlite-server[1201]: raw_len size 111497 for article 4147176: No such file or directory
Dec 29 08:14:45 spool1 ovsqlite-server[1201]: raw_len size 111497 for article 4147176: No such file or directory
Dec 29 08:14:45 spool1 ovsqlite-server[1201]: raw_len size 111497 for article 4147176: No such file or directory

Log entries by program:

Program name	Lines	%Lines	Size	%Size
innd	88082	48.4%	9.2 MB	37.6%
inn	67194	37.0%	8.6 MB	35.1%
nnrpd	23876	13.1%	2.2 MB	9.1%
nocem	2642	1.5%	4.4 MB	18.2%
innfeed	6	0.0%	0.4 KB	0.0%
ovsqlite-server	3	0.0%	0.3 KB	0.0%
controlchan	1	0.0%	0.0 KB	0.0%
TOTAL: 7	181804	100.0%	24.4 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	64177	49.1%
Do not exist	41901	32.1%
Negative hits	23755	18.2%
Cache misses	825	0.6%
TOTAL: 4	130658	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:39.279	0.0%	83277	0.211	0.472	1.662
article cleanup	00:00:00.092	0.0%	23774	0.000	0.004	0.034
article logging	00:00:00.209	0.0%	23798	0.000	0.009	0.035
article parse	00:00:00.335	0.0%	55724	0.000	0.006	0.022
article write	00:00:09.246	0.0%	21753	0.239	0.425	0.937
artlog/artcncl	00:00:00.138	0.0%	43043	0.000	0.003	0.015
artlog/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:00:00.065	0.0%	142158	0.000	0.000	0.004
hisgrep/artcncl	00:00:00.509	0.0%	65138	0.000	0.008	0.323
hishave/artcncl	00:00:04.821	0.0%	83145	0.025	0.058	0.165
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:10.531	0.0%	47551	0.120	0.221	0.340
history sync	00:00:05.923	0.0%	410	4.333	14.446	21.667
history write	00:00:43.613	0.1%	23774	1.200	1.834	2.418
hiswrite/artcncl	00:00:30.748	0.0%	18146	1.176	1.694	2.483
idle	23:48:41.212	99.8%	162897	168.552	526.230	908.517
nntp read	00:00:00.423	0.0%	160657	0.000	0.003	0.009
overview write	00:00:09.704	0.0%	21753	0.210	0.446	2.159
perl filter	00:00:06.374	0.0%	23237	0.113	0.274	0.458
python filter	00:00:18.991	0.0%	23774	0.411	0.799	1.192
site send	00:00:00.013	0.0%	1319	0.000	0.010	0.222
TOTAL: 23:51:18.747	23:51:42.226	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.000	0.0%	0	0.000	0.000	0.000
article prepare	00:00:00.000	0.0%	0	0.000	0.000	0.000
article read	00:00:00.000	0.0%	0	0.000	0.000	0.000
backlog stats	00:00:00.000	0.0%	1	0.000	0.000	0.000
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.000	0.0%	0	0.000	0.000	0.000
data write	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	23:59:56.490	100.0%	1	86396490.000	86396490.000	86396490.000
status file	00:00:00.000	0.0%	0	0.000	0.000	0.000
TOTAL: 23:59:56.490	23:59:56.490	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:00.008	0.0%	54	0.000	0.148	1.500
idle	184:18:26.713	71.5%	36432	8.000	18212.196	900017.500
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:45:28.138	0.3%	18406319	0.000	0.148	19.188
readart	00:08:22.964	0.1%	3044941	0.000	0.165	21.000
TOTAL: 257:40:55.790	185:12:17.823	71.9%	-	-	-	-

Control commands to INND:

Command	Number
flush	3
flushlogs	2
go	1
logmode	2
mode	149
name	2
pause	1
paused	1
reload	2
renumber	1
TOTAL: 10	164

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	diablo1.usenet.blueworldhosting.com	720	23910	21878	3	2029	91%	23:46:39
2	localhost	1	0	0	0	0	0%	00:00:00
TOTAL: 2		721	23910	21878	3	2029	91%	23:46:39

Incoming Volume (INN):

Server		AcceptVol	RejVol	TotalVol	%Acc	Vol/Art
1	diablo1.usenet.blueworldhosting.com	100.6 MB	7.0 MB	107.5 MB	93%	4.6 KB
2	localhost	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 2		100.6 MB	7.0 MB	107.5 MB	93%	4.6 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Dec 29 02:30:00 - 02:59:59	438	2.0%	0.24	2.1 MB	2.1%	1.19
Dec 29 03:00:00 - 03:59:59	1201	5.5%	0.33	6.2 MB	6.2%	1.78
Dec 29 04:00:00 - 04:59:59	1018	4.7%	0.28	6.0 MB	5.9%	1.70
Dec 29 05:00:00 - 05:59:59	1042	4.8%	0.29	5.5 MB	5.5%	1.56
Dec 29 06:00:00 - 06:59:59	939	4.3%	0.26	5.5 MB	5.5%	1.56
Dec 29 07:00:00 - 07:59:59	928	4.2%	0.26	4.4 MB	4.4%	1.26
Dec 29 08:00:00 - 08:59:59	2380	10.9%	0.66	6.9 MB	6.8%	1.95
Dec 29 09:00:00 - 09:59:59	1203	5.5%	0.33	5.0 MB	4.9%	1.41
Dec 29 10:00:00 - 10:59:59	1235	5.6%	0.34	5.3 MB	5.2%	1.50
Dec 29 11:00:00 - 11:59:59	1043	4.8%	0.29	4.5 MB	4.5%	1.28
Dec 29 12:00:00 - 12:59:59	1099	5.0%	0.31	4.0 MB	4.0%	1.15
Dec 29 13:00:00 - 13:59:59	938	4.3%	0.26	4.0 MB	4.0%	1.13
Dec 29 14:00:00 - 14:59:59	989	4.5%	0.27	4.0 MB	4.0%	1.13
Dec 29 15:00:00 - 15:59:59	865	4.0%	0.24	4.2 MB	4.2%	1.20
Dec 29 16:00:00 - 16:59:59	1000	4.6%	0.28	4.5 MB	4.5%	1.29
Dec 29 17:00:00 - 17:59:59	656	3.0%	0.18	3.2 MB	3.1%	0.90
Dec 29 18:00:00 - 18:59:59	607	2.8%	0.17	3.0 MB	3.0%	0.86
Dec 29 19:00:00 - 19:59:59	477	2.2%	0.13	2.4 MB	2.4%	0.69
Dec 29 20:00:00 - 20:59:59	481	2.2%	0.13	2.8 MB	2.8%	0.79
Dec 29 21:00:00 - 21:59:59	488	2.2%	0.14	2.7 MB	2.7%	0.78
Dec 29 22:00:00 - 22:59:59	599	2.7%	0.17	3.1 MB	3.1%	0.87
Dec 29 23:00:00 - 23:59:59	577	2.6%	0.16	3.0 MB	3.0%	0.85
Dec 30 00:00:00 - 00:59:59	547	2.5%	0.15	2.8 MB	2.8%	0.79
Dec 30 01:00:00 - 01:59:59	714	3.3%	0.20	3.6 MB	3.6%	1.03
Dec 30 02:00:00 - 02:30:00	415	1.9%	0.23	1.9 MB	1.9%	1.06
TOTAL: 24:00:00	21879	100.0%	0.25	100.6 MB	100.0%	1.19

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other
1	diablo1.usenet.blueworldhosting.com	2053	1491	0	0	1	0	0	0	561
TOTAL: 1		2053	1491	0	0	1	0	0	0	561

Unwanted newsgroups [Top 20]:

Newsgroup	Count
de.sci.announce	463
de.sci.medizin	349
fido7.pravda.news	189
kraft.competent	72
fido7.pushkin.local	69
fido7.ukrnews	50
adobe.atm.type.windows	37
odessa.news	31
adobe.acrobat.reader	29
borland.public.delphi.graphics	28
perl.cpan	28
kraft.talks	23
kraft.vehicles	22
mailing.unix.stunnel-users	20
fido7.altyn.local	15
kraft.politics	15
fido7.lorapvt.horo	12
kraft.books	8
fido7.f715.techinfo	6
fido7.fidonet.online	3
TOTAL: 35	1491

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

Groups	Count
uk.religion.christian	1
TOTAL: 1	1

INND Python filter [Top 20]:

Reason	Count
EMP Body Reject	329
EMP FSL Reject	87
Bad Subject (Buy Xanax)	28
Bad Body	22
Bad Subject (Buy Magic Mushrooms)	11
Bad Subject (MAGIC MUSHROOMS)	10
Bad Subject (Buy Adderall)	8
Bad From (cruzzsandra243)	7
Bad Subject (NYALABET)	6
Bad From (sammypratt02@gmail.com)	5
Bad Subject (Magic Mushroom Chocolate)	5
Bad Subject (Magic Mushrooms Online)	5
Bad Subject (Solution Manual )	4
Bad Subject (Buy magic mushrooms)	2
Bad Subject (Solution manual )	2
Bad Subject (Buy Hydrocodone)	2
Bad Subject (Buy MDMA Online)	2
Bad Subject (Buy Cocaine)	1
Bad Subject (Codeine Online)	1
TOTAL: 19	537

NoCeM on Spool:

Id	Good	Unique	Total
nocem@usenet.ovh	415	25282	25282
i2pn2-nocem@i2pn2.org	288	32831	32831
nocem@chmurka.net	288	14078	14078
nocem@eternal-september.org	242	11175	11175
robot@pasdenom.info	88	103	103
TOTAL: 5	1321	83469	83469

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	diablo1.usenet.blueworldhosting.com	24
	TOTAL: 1	24
TOTAL: 1		24

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	tmo-086-131.customers.d1-online.com	17	176	461.6 KB	25	0	00:10:07
2	023-084-030-207.res.spectrum.com	193	45	101.5 KB	10	1	52:14:42
3	151.31.152.60	6	44	77.7 KB	9	5	01:31:56
4	82-132-232-152.dab.02.net	3	16	45.2 KB	2	0	00:39:50
5	aorleans-651-1-26-102.w90-20.abo.wanadoo.fr	7	14	20.8 KB	0	0	00:00:13
6	blfd-1-67-55-187-105.dsl.netins.net	9	12	23.6 KB	5	0	00:06:46
7	otaku.sdf.org	3	10	20.0 KB	3	2	00:23:47
8	h69-131-21-232.cntcnh.broadband.dynamic.tds.net	1	7	13.1 KB	3	0	00:02:33
9	nat64.discard.me.uk	96	7	45.9 KB	6	0	00:06:13
10	pool-96-250-110-74.nycmny.fios.verizon.net	3	5	9.3 KB	1	1	01:40:54
11	s0106f4c1144790e4.ed.shawcable.net	1	2	6.1 KB	0	0	10:09:38
12	071-093-230-190.res.spectrum.com	1	2	1.2 KB	1	0	00:00:02
13	64-147-199-59.gpon.dynamic.ctstelecom.net	1	2	4.2 KB	1	0	00:00:49
14	72.168.176.34	2	1	1.9 KB	1	0	00:27:55
15	174-086-128-189.res.spectrum.com	6	1	1.5 KB	1	0	12:16:14
16	23.129.64.228	1	0	0.0 KB	0	1	00:30:02
17	49.77.34.131	20	0	0.0 KB	0	20	01:30:22
TOTAL: 17		370	344	833.5 KB	68	30	257:40:53

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.customers.d1-online.com	17	176	461.6 KB	25	0	00:10:07
2	*.res.spectrum.com	200	48	104.2 KB	12	1	64:30:59
3	unresolved	68	45	79.6 KB	10	26	150:22:40
4	*.dab.02.net	3	16	45.2 KB	2	0	00:39:50
5	*.w90-20.abo.wanadoo.fr	7	14	20.8 KB	0	0	00:00:13
6	*.dsl.netins.net	9	12	23.6 KB	5	0	00:06:46
7	*.sdf.org	3	10	20.0 KB	3	2	00:23:47
8	*.cntcnh.broadband.dynamic.tds.net	1	7	13.1 KB	3	0	00:02:33
9	*.discard.me.uk	96	7	45.9 KB	6	0	00:06:13
10	*.nycmny.fios.verizon.net	3	5	9.3 KB	1	1	01:40:54
11	*.ed.shawcable.net	1	2	6.1 KB	0	0	10:09:38
12	*.gpon.dynamic.ctstelecom.net	1	2	4.2 KB	1	0	00:00:49
13	*.range86-144.btcentralplus.com	8	0	0.0 KB	0	0	03:14:43
14	*.ch1.censys-scanner.com	1	0	0.0 KB	0	0	00:00:00
15	*.net.vodafone.it	1	0	0.0 KB	0	0	00:00:01
16	*.hr.hr.cox.net	3	0	0.0 KB	0	0	00:20:40
17	*.stehlik.co.uk	480	0	0.0 KB	0	0	24:09:52
18	*.bbmk.org	2	0	0.0 KB	0	0	00:00:07
19	*.150.216.162.bc.googleusercontent.com	1	0	0.0 KB	0	0	00:00:00
20	*.hsd1.il.comcast.net	1	0	0.0 KB	0	0	00:00:00
21	*.hsd1.co.comcast.net	6	0	0.0 KB	0	0	01:40:47
22	*.26.65.37.rev.sfr.net	1	0	0.0 KB	0	0	00:00:02
TOTAL: 22		913	344	833.5 KB	68	30	257:40:53

NNRP auth users [Top 20]:

User	Conn
jesse	193
moses	20
marco	20
tdc	12
jojo	9
serendipity	6
richs	3
emfril	3
kym	3
reino	2
marcj	2
chrisd	1
pikus	1
TOTAL: 13	275

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
82.66.65.176	0.097	0.076	0.010	144:30:36
023-084-030-207.res.spectrum.com	10.073	1.388	0.399	52:14:42
toma-03.stehlik.co.uk	22.468	12.707	0.000	24:09:52
174-086-128-189.res.spectrum.com	0.262	0.017	0.000	12:16:14
s0106f4c1144790e4.ed.shawcable.net	0.057	0.033	0.008	10:09:38
host86-144-217-94.range86-144.btcentralplus.com	0.257	0.075	0.000	03:14:43
pool-96-250-110-74.nycmny.fios.verizon.net	0.131	0.024	0.015	01:40:54
c-76-154-98-211.hsd1.co.comcast.net	0.243	0.064	0.030	01:40:47
151.31.152.60	0.383	0.016	0.030	01:31:56
49.77.34.131	0.909	0.108	0.100	01:30:22
212.102.44.169	0.268	0.039	0.030	01:19:22
82-132-232-152.dab.02.net	0.139	0.046	0.015	00:39:50
23.129.64.228	0.042	0.008	0.005	00:30:02
202.107.207.227	0.023	0.016	0.000	00:30:00
72.168.176.34	0.334	0.231	0.000	00:27:55
otaku.sdf.org	0.898	1.179	0.015	00:23:47
ip98-166-83-190.hr.hr.cox.net	16.752	101.022	0.000	00:20:40
tmo-086-131.customers.d1-online.com	0.680	0.236	0.000	00:10:07
blfd-1-67-55-187-105.dsl.netins.net	0.420	0.057	0.044	00:06:46
nat64.discard.me.uk	3.405	1.115	0.000	00:06:13
TOTAL: 40	61.550	121.329	0.812	257:40:53

Curious NNRP server explorers [Top 20]:

System	Conn
toma-03.stehlik.co.uk	480
93.188.96.156	20
host86-144-217-94.range86-144.btcentralplus.com	8
212.102.44.169	6
c-76-154-98-211.hsd1.co.comcast.net	6
ip98-166-83-190.hr.hr.cox.net	3
katara.bbmk.org	2
167.94.146.56	2
165.154.224.52	2
82.66.65.176	2
scanner-05.ch1.censys-scanner.com	1
60.150.216.162.bc.googleusercontent.com	1
118.123.105.92	1
c-67-186-122-142.hsd1.il.comcast.net	1
162.243.151.17	1
202.107.207.227	1
176.113.115.184	1
192.241.193.119	1
45.227.254.48	1
106.26.65.37.rev.sfr.net	1
TOTAL: 22	543

NNRP gethostbyaddr failures [Top 20]:

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

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

System	Conn
60.150.216.162.bc.googleusercontent.com	3
165.154.224.52	2
scanner-05.ch1.censys-scanner.com	1
202.107.207.227	1
176.113.115.184	1
162.243.151.17	1
167.94.146.56	1
TOTAL: 7	10

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

Command	Count
EHLO www.censys.io	2
^C	1
GET / HTTP/1.1	1
GET / HTTP/1.0	1
User-Agent: Expanse, a Palo Alto Network...	1
^A	1
MGLNDD_199.102.165.15_119	1
^V^C^A	1
Host: 199.102.165.15:119	1
TOTAL: 9	10

NNRP client timeouts [Top 20]:

System	Conn	Peer
023-084-030-207.res.spectrum.com	193	153
49.77.34.131	19	19
151.31.152.60	6	6
host86-144-217-94.range86-144.btcentralplus.com	6	0
212.102.44.169	4	2
pool-96-250-110-74.nycmny.fios.verizon.net	2	0
82.66.65.176	2	0
c-76-154-98-211.hsd1.co.comcast.net	2	0
165.154.224.52	1	1
167.94.146.56	1	2
23.129.64.228	1	0
82-132-232-152.dab.02.net	1	0
176.113.115.184	1	1
202.107.207.227	1	0
TOTAL: 14	240	184

Newsgroup request counts (by hierarchy):

Hierarchy		Count	Pct
1	de	93	30.1%
2	it	54	17.5%
3	comp	38	12.3%
4	alt	31	10.0%
5	ger	23	7.4%
6	fr	20	6.5%
7	rec	16	5.2%
8	news	14	4.5%
9	hiv	10	3.2%
10	sci	5	1.6%
11	junk	2	0.6%
12	24hoursupport	2	0.6%
13	eternal-september	1	0.3%
TOTAL: 13		309	100.0%

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

Newsgroup		Count
1	it.hobby.fai-da-te	25
2	ger.ct	23
3	de.sci.electronics	20
4	fr.lettres.langue.francaise	19
5	comp.lang.lisp	16
6	rec.crafts.metalworking	16
7	de.comp.os.unix.linux.misc	16
8	de.etc.sprache.deutsch	12
9	comp.lang.python	11
10	it.comp.hardware	11
11	hiv.aids.law	10
12	it.cultura.linguistica.italiano	10
13	alt.global-warming	10
14	news.admin.announce	10
15	de.rec.film.misc	9
16	de.sci.physik	8
17	de.talk.jokes	7
18	comp.os.linux.misc	6
19	alt.comp.software.firefox	5
20	alt.usage.english	5
21	alt.privacy.anon-server	5
22	alt.fan.pratchett	5
23	it.comp.sicurezza.varie	4
24	news.admin.peering	4
25	de.alt.folklore.computer	4
26	it.hobby.elettronica	4
27	de.rec.heimwerken	4
28	de.comp.hardware.misc	3
29	sci.physics.research	3
30	de.etc.haushalt	3
31	24hoursupport.helpdesk	2
32	junk	2
33	comp.text.tex	2
34	de.comm.software.mozilla.mailnews	2
35	de.rec.fotografie	2
36	sci.electronics.design	2
37	de.sci.mathematik	2
38	fr.soc.politique	1
39	eternal-september.info	1
40	de.alt.netdigest	1
41	alt.folklore.computers	1
42	comp.lang.fortran	1
43	comp.mobile.android	1
44	comp.lang.mumps	1
TOTAL: 44		309

Daily Usenet report

Dec 29 02:30:00 -- Dec 30 02:30:00