Daily Usenet report: Jun 17 02:34:00

Unknown entries from news log file:

First 7 / 7 lines (100.0%)

Jun 17 02:35:35 spool1 innd[17969]: failed to import external filter_innd python module
Jun 17 02:35:35 spool1 innd[17969]: python filter object is not defined
Jun 17 03:06:39 spool1 innd[17969]: failed to reimport external python module
Jun 17 03:07:44 spool1 innd[17969]: failed to reimport external python module
Jun 17 03:09:18 spool1 innd[17969]: failed to reimport external python module
Jun 17 03:09:38 spool1 innd[63604]: failed to import external filter_innd python module
Jun 17 03:09:38 spool1 innd[63604]: python filter object is not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2217930	94.9%	203.2 MB	94.2%
nnrpd	70437	3.0%	6.9 MB	3.2%
innd	48826	2.1%	5.5 MB	2.5%
innfeed	289	0.0%	29.9 KB	0.0%
controlchan	6	0.0%	0.3 KB	0.0%
nocem	6	0.0%	0.4 KB	0.0%
TOTAL: 6	2337494	100.0%	215.7 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	2185364	48.5%
Negative hits	2158936	47.9%
Cache misses	157139	3.5%
Positive hits	1648	0.0%
TOTAL: 4	4503087	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:01.634	0.0%	1081	0.000	1.512	194.000
article cleanup	00:00:12.061	0.0%	2186693	0.000	0.006	0.029
article logging	00:00:59.776	0.1%	2187233	0.009	0.027	0.075
article parse	00:02:32.579	0.2%	12479877	0.000	0.012	0.019
article write	00:43:48.291	3.1%	2052173	0.202	1.281	10.062
artlog/artcncl	00:00:00.001	0.0%	139	0.000	0.007	0.250
artlog/artparse	00:00:00.006	0.0%	375	0.000	0.016	0.182
data move	00:00:20.356	0.0%	13272599	0.000	0.002	0.009
hisgrep/artcncl	00:00:00.417	0.0%	1219	0.000	0.342	3.672
hishave/artcncl	00:00:00.000	0.0%	139	0.000	0.000	0.000
history grep	00:00:21.691	0.0%	138993	0.053	0.156	2.020
history lookup	00:01:54.687	0.1%	4507634	0.000	0.025	1.171
history sync	00:00:01.257	0.0%	328	0.000	3.832	127.500
history write	00:14:28.642	1.0%	2052173	0.246	0.423	8.260
idle	20:38:16.272	86.6%	10339151	0.295	7.186	1785.765
nntp read	00:04:32.909	0.3%	12861782	0.003	0.021	0.042
overview write	00:11:39.505	0.8%	2052173	0.102	0.341	4.561
perl filter	00:01:03.011	0.1%	2152967	0.009	0.029	0.129
python filter	01:41:07.000	7.1%	4419335	0.000	1.373	27.235
site send	00:00:46.439	0.1%	1949620	0.000	0.024	1.000
TOTAL: 23:50:28.853	23:42:06.534	99.4%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.000	0.0%	2	0.000	0.000	0.000
article prepare	00:00:00.000	0.0%	8	0.000	0.000	0.000
article read	00:00:00.037	0.0%	2	0.000	18.500	37.000
backlog stats	00:00:00.002	0.0%	3751	0.000	0.001	0.038
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.000	0.0%	21	0.000	0.000	0.000
data write	00:00:00.000	0.0%	19	0.000	0.000	0.000
idle	23:28:46.845	100.0%	3751	15357.195	22534.483	24079.440
status file	00:00:00.010	0.0%	29	0.000	0.345	1.000
TOTAL: 23:28:46.948	23:28:46.894	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:00.000	0.0%	0	0.000	0.000	0.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:22:02.886	0.7%	13227207	0.000	0.100	1107.421
readart	00:00:07.967	0.0%	533	0.000	14.947	355.000
TOTAL: 55:35:59.441	00:22:10.853	0.7%	-	-	-	-

Control commands to INND:

Command	Number
flush	5
flushlogs	2
go	2
logmode	2
lowmark	1
mode	148
name	2
newgroup	1
pause	2
paused	2
perl	1
python	2
reload	46
reserve	2
xexec	3
TOTAL: 15	221

Newsgroups created:

Group	Mode
comp.sys.apple	y
TOTAL	1

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	localhost	64	2262908	2068849	160626	33433	91%	125:18:13
2	feed1.usenet.blueworldhosting.com	581	113224	11543	0	101681	10%	126:30:03
TOTAL: 2		645	2376132	2080392	160626	135114	87%	251:48:16

Incoming Volume (INN):

Server		AcceptVol	RejVol	TotalVol	%Acc	Vol/Art
1	localhost	5.2 GB	1.1 GB	6.3 GB	82%	3.1 KB
2	feed1.usenet.blueworldhosting.com	48.6 MB	41.1 GB	41.2 GB	0%	381.2 KB
TOTAL: 2		5.3 GB	42.2 GB	47.5 GB	11%	22.5 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jun 17 02:34:00 - 02:59:59	4834	0.2%	3.10	11.2 MB	0.2%	7.35
Jun 17 03:00:00 - 03:59:59	3824	0.2%	1.06	9.4 MB	0.2%	2.66
Jun 17 04:00:00 - 04:59:59	18357	0.9%	5.10	51.6 MB	1.0%	14.68
Jun 17 05:00:00 - 05:59:59	18658	0.9%	5.18	50.2 MB	0.9%	14.28
Jun 17 06:00:00 - 06:59:59	18305	0.9%	5.08	65.3 MB	1.2%	18.57
Jun 17 07:00:00 - 07:59:59	14704	0.7%	4.08	50.4 MB	0.9%	14.33
Jun 17 08:00:00 - 08:59:59	16876	0.8%	4.69	72.0 MB	1.3%	20.48
Jun 17 09:00:00 - 09:59:59	3070	0.1%	0.85	10.9 MB	0.2%	3.11
Jun 17 10:00:00 - 10:59:59	673	0.0%	0.19	3.1 MB	0.1%	0.88
Jun 17 11:00:00 - 11:59:59	678	0.0%	0.19	2.9 MB	0.1%	0.81
Jun 17 12:00:00 - 12:59:59	497	0.0%	0.14	1.4 MB	0.0%	0.41
Jun 17 13:00:00 - 13:59:59	623	0.0%	0.17	2.0 MB	0.0%	0.56
Jun 17 14:00:00 - 14:59:59	1524	0.1%	0.42	5.7 MB	0.1%	1.62
Jun 17 15:00:00 - 15:59:59	7911	0.4%	2.20	61.7 MB	1.1%	17.54
Jun 17 16:00:00 - 16:59:59	13215	0.6%	3.67	26.3 MB	0.5%	7.49
Jun 17 17:00:00 - 17:59:59	24873	1.2%	6.91	45.1 MB	0.8%	12.82
Jun 17 18:00:00 - 18:59:59	32234	1.5%	8.95	66.0 MB	1.2%	18.77
Jun 17 19:00:00 - 19:59:59	40040	1.9%	11.12	86.0 MB	1.6%	24.47
Jun 17 20:00:00 - 20:59:59	167014	8.0%	46.39	374.2 MB	6.9%	106.43
Jun 17 21:00:00 - 21:59:59	327676	15.7%	91.02	852.3 MB	15.8%	242.43
Jun 17 22:00:00 - 22:59:59	316673	15.2%	87.96	813.8 MB	15.1%	231.49
Jun 17 23:00:00 - 23:59:59	302486	14.5%	84.02	846.8 MB	15.7%	240.87
Jun 18 00:00:00 - 00:59:59	299490	14.4%	83.19	723.7 MB	13.4%	205.86
Jun 18 01:00:00 - 01:59:59	290028	13.9%	80.56	775.5 MB	14.4%	220.58
Jun 18 02:00:00 - 02:34:00	157971	7.6%	77.44	387.3 MB	7.2%	194.42
TOTAL: 24:00:00	2082234	100.0%	24.10	5.3 GB	100.0%	63.94

Sites sending bad articles:

Server		Total	Group	Dist	Unapp	Other
1	feed1.usenet.blueworldhosting.com	101638	100479	0	0	1159
2	localhost	33918	160	5	145	33608
TOTAL: 2		135556	100639	5	145	34767

Unwanted newsgroups [Top 20]:

Newsgroup	Count
alt.binaries.bloaf	54898
alt.binaries.backup	43695
alt.binaries.boneless	645
talk.ukrainian.tg	392
al.binaries.test	327
alt.binaries.ftd	190
alt	135
talk.english.tg	69
alt.binaries.pictures.erotica.vintage	37
talk.generic.ua.ws	26
alt.binaries.e-book	25
comp.sys.apple	20
finet.binaries.keskustelu	17
alt.binaries.nospam.female.bodyhair	13
talk.english.tw	11
alt.binaries.pictures.teen-starlets	8
alt.binaries.sounds.lossless	8
alt.binaries.e-book.magazines	7
alt.binaries.pictures.vehicles	5
alt.binaries.pictures.earlmiller	5
TOTAL: 77	100639

Unwanted distributions [Top 20]:

Distribution	Count
local	5
TOTAL: 1	5

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

Groups	Count
alt.alien.moderated	23
perl.beginners	20
alt.music.sultans-of-ping	17
comp.risks	15
comp.ai	11
linux.samba	7
comp.sys.atari.announce	5
uk.legal.moderated	5
alt.emergency-services.moderated	3
comp.unix.bsd.openbsd.announce	3
comp.lang.ml	2
comp.sys.sun.announce	2
linux.debian.ports.ia64	2
comp.lang.asm.x86	2
comp.unix.bsd.freebsd.announce	2
comp.infosystems.kiosks	2
comp.ai.vision	2
perl.macosx	2
perl.dbi.users	2
alt.penthouse.sex.anal	2
TOTAL: 36	145

INND Python filter [Top 20]:

Reason	Count
EMP Body Reject	6145
Bad From (MI5Victim@mi5.gov.uk)	5160
Binary (yEnc)	4830
EMP FSL Reject	4320
OS2 Crosspost	2919
Crosspost Low Limit Exceeded	2560
Bad Subject (=?UTF-8)	2538
AUK Bad Crosspost	1696
HTML Misplaced	1205
Binary (base64)	890
Snipe Forge	643
Binary (uuEnc)	344
Bad From (Test User <test-user@nospam.example>)	280
OS2 Followup	79
Bad From (no_email@invalid.invalid)	73
Bad From (keystonemeds@protonmail.com)	20
Bad From (FBInCIAnNSATerroristSlayer@yahoo.com)	14
Bad From (nukleus@invalid.addr)	14
Bad From (PHARMA GRADE)	13
Bad From (huhai102@gmail.com)	11
TOTAL: 41	33826

NoCeM on Spool:

Id	Good	Bad	Unique	Total
bleachbot@httrack.com	1	0	1	1
TOTAL: 1	1	0	1	1

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	localhost	408
	TOTAL: 1	408
Including strange strings
	localhost	455
	feed1.usenet.blueworldhosting.com	87
	TOTAL: 2	542
TOTAL: 2		950

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	feed1.usenet.blueworldhosting.com	2	2	0	0	0	0	100%	00:59:39
TOTAL: 1		2	2	0	0	0	0	100%	00:59:39

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	feed1.usenet.blueworldhosting.com	3.2 KB	0.0 KB	3.2 KB	0.0 KB/s	1.6 KB	00:59:39
TOTAL: 1		3.2 KB	0.0 KB	3.2 KB	0.0 KB/s	1.6 KB	00:59:39

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	023-084-030-207.res.spectrum.com	118	532	23.5 MB	487	2	8	33:36:11
2	c-73-247-170-28.hsd1.il.comcast.net	4	1	34.7 KB	1	0	0	00:02:31
TOTAL: 2		122	533	23.6 MB	488	2	8	55:35:53

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.res.spectrum.com	118	532	23.5 MB	487	2	8	33:36:11
2	*.hsd1.il.comcast.net	4	1	34.7 KB	1	0	0	00:02:31
3	*.stehlik.co.uk	954	0	0.0 KB	0	0	0	21:57:04
4	unresolved	13	0	0.0 KB	0	0	0	00:00:05
TOTAL: 4		1089	533	23.6 MB	488	2	8	55:35:53

NNRP auth users [Top 20]:

User	Conn
jesse	81
TOTAL: 1	81

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
023-084-030-207.res.spectrum.com	19.379	17.450	0.432	33:36:11
toma-03.stehlik.co.uk	197.030	66.615	0.000	21:57:04
c-73-247-170-28.hsd1.il.comcast.net	0.463	0.113	0.000	00:02:31
208.100.26.235	0.866	0.102	0.000	00:00:03
141.105.66.247	0.064	0.016	0.000	00:00:01
TOTAL: 5	217.802	84.296	0.432	55:35:53

Curious NNRP server explorers [Top 20]:

System	Conn
toma-03.stehlik.co.uk	954
208.100.26.235	12
141.105.66.247	1
TOTAL: 3	967

NNRP gethostbyaddr failures [Top 20]:

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

NNRP client timeouts [Top 20]:

System	Conn	Peer
023-084-030-207.res.spectrum.com	101	78
toma-03.stehlik.co.uk	2	2
TOTAL: 2	103	80

Newsgroup request counts (by hierarchy):

Hierarchy		Count	Pct
1	news	336	61.2%
2	alt	123	22.4%
3	comp	81	14.8%
4	misc	8	1.5%
5	rec	1	0.2%
TOTAL: 5		549	100.0%

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

Newsgroup		Count
1	news.software.nntp	202
2	news.groups	66
3	alt.binaries.documentaries	51
4	comp.internet.services.google	34
5	alt.security	27
6	news.admin.peering	26
7	news.software.readers	22
8	news.admin.technical	20
9	comp.unix.aix	20
10	comp.unix.admin	18
11	alt.config	13
12	alt.usenet.peering	13
13	alt.folklore.computers	11
14	misc.test	8
15	comp.unix.bsd.freebsd.misc	7
16	alt.usenet.reposts	6
17	alt.culture.usenet	2
18	comp.sys.apple	1
19	rec.food.chocolate	1
20	comp.sys.apple2	1
TOTAL: 20		549

Daily Usenet report

Jun 17 02:34:00 -- Jun 18 02:34:00