Daily Usenet report for csiph.com: Oct 2 04:15:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	46937	48.0%	7.0 MB	60.0%
nnrpd	32124	32.8%	2.8 MB	24.4%
innd	16858	17.2%	1.5 MB	13.3%
innfeed	1918	2.0%	280.9 KB	2.4%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 5	97838	100.0%	11.6 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	262518	48.5%
Negative hits	228112	42.1%
Do not exist	46094	8.5%
Cache misses	4656	0.9%
TOTAL: 4	541380	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.581	0.0%	228	0.000	2.548	28.000
article cleanup	00:00:00.276	0.0%	45544	0.000	0.006	0.027
article logging	00:00:00.571	0.0%	46114	0.000	0.012	0.048
article parse	00:00:01.831	0.0%	218088	0.000	0.008	0.014
article write	00:00:07.519	0.0%	27312	0.112	0.275	0.514
artlog/artcncl	00:00:00.003	0.0%	195	0.000	0.015	1.000
artlog/artparse	00:00:00.003	0.0%	614	0.000	0.005	0.333
data move	00:00:00.252	0.0%	681099	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.002	0.0%	228	0.000	0.009	1.000
hishave/artcncl	00:00:00.000	0.0%	228	0.000	0.000	0.000
hishave/artparse	00:00:00.002	0.0%	614	0.000	0.003	1.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:01.323	0.0%	541472	0.000	0.002	0.007
history sync	00:00:00.630	0.0%	348	0.000	1.810	3.667
history write	00:00:12.658	0.0%	45540	0.077	0.278	0.354
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
hiswrite/artparse	00:00:00.106	0.0%	611	0.000	0.173	3.000
idle	23:58:05.829	99.8%	667984	31.656	129.173	394.816
nntp read	00:00:02.317	0.0%	666418	0.001	0.003	0.007
overview write	00:00:06.386	0.0%	27312	0.074	0.234	3.024
perl filter	00:01:21.871	0.1%	45540	1.020	1.798	3.869
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.477	0.0%	54624	0.000	0.009	0.030
TOTAL: 24:00:41.949	24:00:02.637	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.065	0.0%	27599	0.000	0.002	0.020
article prepare	00:00:00.001	0.0%	7184	0.000	0.000	0.031
article read	00:00:00.233	0.0%	1347	0.000	0.173	66.000
backlog stats	00:00:00.107	0.0%	309627	0.000	0.000	0.002
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.293	0.0%	236089	0.000	0.005	0.015
data write	00:00:01.733	0.0%	212514	0.001	0.008	0.015
idle	23:54:36.355	100.0%	309627	163.514	278.000	954.571
status file	00:00:00.101	0.0%	204	0.000	0.495	1.000
TOTAL: 23:54:44.410	23:54:39.888	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:00.798	0.0%	31416	0.000	0.025	0.041
idle	123:44:51.753	100.0%	62774	0.000	7096.756	601490.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:01.574	0.0%	126522	0.000	0.012	6.759
readart	00:00:02.348	0.0%	3478	0.000	0.675	71.000
TOTAL: 123:46:34.384	123:44:56.473	100.0%	-	-	-	-

Control commands to INND:

Command	Number
L	1
flush	4
flushlogs	2
go	2
logmode	2
mode	146
pause	2
paused	2
reload	2
reserve	2
TOTAL: 10	165

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	feeder.eternal-september.org	4	41143	6668	32711	1764	16%	23:48:31
2	au2pb.net	1	29846	6552	22392	902	21%	23:46:24
3	xanadu-bbs.net	1	45758	4079	33542	8137	8%	23:50:19
4	news-out.mixmin.net	4	32729	4071	25872	2786	12%	24:19:34
5	newsfeed.neva.ru	151	58535	2718	51112	4705	4%	72:42:56
6	newsfeeds.xmission.com	1	28468	1465	26881	122	5%	24:22:47
7	newsfeed.fu-berlin.de	54	30036	1238	28529	269	4%	29:54:47
8	news.swapon.de	2	2110	187	1921	2	8%	25:17:44
9	nntp.pasdenom.info	4	19505	137	19344	24	0%	18:32:34
10	localhost	50	13519	0	13519	0	0%	00:01:03
TOTAL: 10		272	301649	27115	255823	18711	8%	266:36:39

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	feeder.eternal-september.org	18.6 MB	0.0 KB	10.4 MB	29.0 MB	64%	3.5 KB
2	au2pb.net	17.6 MB	3.8 KB	3.6 MB	21.2 MB	82%	2.9 KB
3	news-out.mixmin.net	13.1 MB	3.8 KB	7.6 MB	20.6 MB	63%	3.1 KB
4	xanadu-bbs.net	11.7 MB	0.0 KB	115.7 MB	127.4 MB	9%	10.7 KB
5	newsfeed.neva.ru	8.9 MB	5.5 KB	22.7 MB	31.7 MB	28%	4.4 KB
6	newsfeeds.xmission.com	4.6 MB	0.0 KB	1.2 MB	5.7 MB	79%	3.7 KB
7	newsfeed.fu-berlin.de	2.8 MB	0.0 KB	840.9 KB	3.6 MB	77%	2.5 KB
8	news.swapon.de	456.6 KB	0.0 KB	25.9 KB	482.5 KB	94%	2.6 KB
9	nntp.pasdenom.info	303.4 KB	0.0 KB	345.5 KB	648.9 KB	46%	4.0 KB
10	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 10		78.0 MB	13.1 KB	162.3 MB	240.3 MB	32%	5.4 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Oct 2 04:15:00 - 04:59:59	511	1.9%	0.19	1.9 MB	2.4%	0.72
Oct 2 05:00:00 - 05:59:59	631	2.3%	0.18	2.3 MB	2.9%	0.66
Oct 2 06:00:00 - 06:59:59	874	3.2%	0.24	3.5 MB	4.4%	0.99
Oct 2 07:00:00 - 07:59:59	1298	4.8%	0.36	3.5 MB	4.5%	1.01
Oct 2 08:00:00 - 08:59:59	1319	4.8%	0.37	3.3 MB	4.2%	0.93
Oct 2 09:00:00 - 09:59:59	1396	5.1%	0.39	4.0 MB	5.1%	1.14
Oct 2 10:00:00 - 10:59:59	1290	4.7%	0.36	3.5 MB	4.4%	0.98
Oct 2 11:00:00 - 11:59:59	1290	4.7%	0.36	3.5 MB	4.5%	1.00
Oct 2 12:00:00 - 12:59:59	1380	5.1%	0.38	3.5 MB	4.4%	0.98
Oct 2 13:00:00 - 13:59:59	1602	5.9%	0.45	4.3 MB	5.4%	1.21
Oct 2 14:00:00 - 14:59:59	1569	5.7%	0.44	4.6 MB	5.9%	1.32
Oct 2 15:00:00 - 15:59:59	1491	5.5%	0.41	4.1 MB	5.2%	1.15
Oct 2 16:00:00 - 16:59:59	1602	5.9%	0.45	4.2 MB	5.3%	1.19
Oct 2 17:00:00 - 17:59:59	1533	5.6%	0.43	4.2 MB	5.3%	1.20
Oct 2 18:00:00 - 18:59:59	1509	5.5%	0.42	4.3 MB	5.5%	1.22
Oct 2 19:00:00 - 19:59:59	1365	5.0%	0.38	3.5 MB	4.4%	0.98
Oct 2 20:00:00 - 20:59:59	1337	4.9%	0.37	3.6 MB	4.6%	1.03
Oct 2 21:00:00 - 21:59:59	1251	4.6%	0.35	3.7 MB	4.7%	1.04
Oct 2 22:00:00 - 22:59:59	1011	3.7%	0.28	3.3 MB	4.1%	0.93
Oct 2 23:00:00 - 23:59:59	765	2.8%	0.21	2.5 MB	3.2%	0.72
Oct 3 00:00:00 - 00:59:59	662	2.4%	0.18	2.3 MB	2.9%	0.64
Oct 3 01:00:00 - 01:59:59	517	1.9%	0.14	1.6 MB	2.0%	0.45
Oct 3 02:00:00 - 02:59:59	463	1.7%	0.13	1.7 MB	2.1%	0.48
Oct 3 03:00:00 - 03:59:59	502	1.8%	0.14	1.5 MB	1.9%	0.44
Oct 3 04:00:00 - 04:15:00	132	0.5%	0.15	489.0 KB	0.6%	0.54
TOTAL: 24:00:00	27300	100.0%	0.32	78.7 MB	100.0%	0.93

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	xanadu-bbs.net	8221	663	0	7558
2	newsfeed.neva.ru	4718	1776	1	2941
3	news-out.mixmin.net	2813	10	1	2802
4	feeder.eternal-september.org	1869	241	0	1628
5	au2pb.net	960	878	1	81
6	newsfeed.fu-berlin.de	685	38	0	647
7	newsfeeds.xmission.com	123	108	0	15
8	nntp.pasdenom.info	33	28	1	4
9	news.swapon.de	20	0	0	20
TOTAL: 9		19442	3742	4	15696

Unwanted newsgroups [Top 20]:

Newsgroup	Count
fa.linux.kernel	735
lada.talk	222
lada.auto	203
alt.politics	131
pld.cvs.commit	131
ut.test	107
mozilla.dev.tree-alerts	100
it-alt.sport.calcio.juventus	89
mailing.gcc.gcc-cvs	75
mailing.freebsd.pkg-fallout	70
mpc.lists.nanog	67
mailing.openbsd.source-changes	66
mailing.freebsd.svn-src-all	66
fa.freebsd.cvs-all	62
mailing.freebsd.svn-ports-all	61
mailing.freebsd.svn-ports-head	57
alt.politics.scorched-earth	45
fa.openbsd.source-changes	44
lada.photo	43
mailing.freebsd.svn-src-head	41
TOTAL: 260	3742

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	11006
EMP (phn path)	2073
EMP (phl)	895
EMP (phn nph)	303
PFM bot misc	79
Too many newsgroups	42
HTML Multipart	42
HTML post	37
Binary Image: misplaced jpg	26
Binary: misplaced zip	4
Binary: misplaced rar	2
Binary Payload	1
Binary: misplaced nzbz	1
Too many newsgroups (meow)	1
TOTAL: 14	14512

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Huge articles
	xanadu-bbs.net	483
	feeder.eternal-september.org	49
	news-out.mixmin.net	44
	au2pb.net	18
	newsfeeds.xmission.com	12
	newsfeed.fu-berlin.de	5
	nntp.pasdenom.info	3
	TOTAL: 7	614
Including strange strings
	newsfeed.fu-berlin.de	399
	feeder.eternal-september.org	57
	au2pb.net	53
	news-out.mixmin.net	24
	news.swapon.de	18
	xanadu-bbs.net	10
	newsfeed.neva.ru	7
	newsfeeds.xmission.com	2
	TOTAL: 8	570
TOTAL: 2		1184

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	au2pb	21626	264	20278	133	0	1%	23:58:55
2	usenet.pasdenom.info	34349	195	26182	796	95	0%	23:59:57
3	xanadu-bbs	24941	121	23045	29	21	0%	23:59:57
4	fu-berlin.de	25679	35	25611	33	0	0%	23:59:49
5	neva.ru	25816	28	24299	105	223	0%	23:59:57
6	news.mixmin.net	23908	16	23034	21	0	0%	23:59:57
7	xmission	32707	12	25721	0	0	0%	23:59:51
8	eternal-september	21241	4	20011	5	0	0%	23:59:57
9	news.swapon.de	1964	0	1946	0	0	0%	23:52:47
TOTAL: 9		212231	675	190127	1122	339	0%	215:51:07

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	au2pb	1.1 MB	348.9 KB	1.4 MB	3.7 KB	23:58:55
2	usenet.pasdenom.info	861.0 KB	1.8 MB	2.6 MB	2.7 KB	23:59:57
3	xanadu-bbs	692.4 KB	53.1 KB	745.5 KB	5.0 KB	23:59:57
4	fu-berlin.de	200.4 KB	43.9 KB	244.3 KB	3.6 KB	23:59:49
5	neva.ru	99.8 KB	498.0 KB	597.8 KB	4.5 KB	23:59:57
6	news.mixmin.net	96.3 KB	37.6 KB	133.9 KB	3.6 KB	23:59:57
7	xmission	54.1 KB	0.0 KB	54.1 KB	4.5 KB	23:59:51
8	eternal-september	21.9 KB	8.4 KB	30.4 KB	3.4 KB	23:59:57
9	news.swapon.de	0.0 KB	0.0 KB	0.0 KB	0	23:52:47
TOTAL: 9		3.1 MB	2.7 MB	5.8 MB	3.3 KB	215:51:07

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Elapsed
1	202.89.176.220	284	49	139.6 KB	45	19:43:43
2	challenger.nielsenmedia.com	4	1	2.3 KB	1	00:38:32
3	dhcp-089-099-203-254.chello.nl	34	1	3.0 KB	1	12:28:11
TOTAL: 3		322	51	145.0 KB	47	123:46:29

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	unresolved	375	49	139.6 KB	45	107:12:13
2	*.nielsenmedia.com	4	1	2.3 KB	1	00:38:32
3	*.chello.nl	34	1	3.0 KB	1	12:28:11
4	*.shodan.io	1	0	0.0 KB	0	00:00:00
5	*.tu.ok.cox.net	1	0	0.0 KB	0	01:14:26
6	*.tampfl.dsl-w.verizon.net	10	0	0.0 KB	0	01:43:04
TOTAL: 6		425	51	145.0 KB	47	123:46:29

NNRP auth users [Top 20]:

User	Conn
moussa	284
TOTAL: 1	284

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
108.175.241.207	5.462	2.039	0.000	57:33:55
162.212.88.198	0.445	0.425	0.000	29:54:24
202.89.176.220	26.380	6.234	0.724	19:43:43
dhcp-089-099-203-254.chello.nl	2.758	0.533	0.000	12:28:11
pool-71-98-160-84.tampfl.dsl-w.verizon.net	0.753	0.204	0.000	01:43:04
ip72-222-107-224.tu.ok.cox.net	0.089	0.064	0.000	01:14:26
challenger.nielsenmedia.com	0.382	0.055	0.000	00:38:32
tempe0.bbox.io	0.094	0.016	0.000	00:30:00
173.0.15.135	0.156	0.202	0.000	00:00:07
69.160.37.54	1.843	0.434	0.000	00:00:02
census9.shodan.io	0.065	0.008	0.000	00:00:00
TOTAL: 11	38.427	10.214	0.724	123:46:29

Curious NNRP server explorers [Top 20]:

System	Conn
108.175.241.207	65
69.160.37.54	25
pool-71-98-160-84.tampfl.dsl-w.verizon.net	10
173.0.15.135	1
ip72-222-107-224.tu.ok.cox.net	1
census9.shodan.io	1
TOTAL: 6	103

NNRP client timeouts [Top 20]:

System	Conn	Peer
dhcp-089-099-203-254.chello.nl	21	0
pool-71-98-160-84.tampfl.dsl-w.verizon.net	3	0
tempe0.bbox.io	1	0
challenger.nielsenmedia.com	1	0
TOTAL: 4	26	0

Newsgroup request counts (by category):

Category		Count	Pct
1	comp	51	100.0%
TOTAL: 1		51	100.0%

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

Newsgroup		Count
1	comp.os.vms	12
2	comp.arch.embedded	10
3	comp.sys.ibm.pc.hardware.storage	7
4	comp.arch	7
5	comp.sys.ibm.pc.games.action	6
6	comp.os.linux.networking	4
7	comp.os.os2.misc	1
8	comp.sys.ibm.as400.misc	1
9	comp.lang.awk	1
10	comp.sys.ibm.ps2.hardware	1
11	comp.arch.fpga	1
TOTAL: 11		51

Daily Usenet report for csiph.com

Oct 2 04:15:00 -- Oct 3 04:15:00