Daily Usenet report for csiph.com: Aug 16 04:15:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	46716	43.8%	6.3 MB	53.6%
nnrpd	35140	32.9%	2.9 MB	25.2%
innd	23023	21.6%	2.2 MB	19.2%
innfeed	1768	1.7%	243.3 KB	2.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 5	106648	100.0%	11.7 MB	100.0%

History cache:

Reason	Count	%Count
Negative hits	219143	46.7%
Positive hits	200676	42.7%
Do not exist	45622	9.7%
Cache misses	4157	0.9%
TOTAL: 4	469598	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:02.286	0.0%	693	0.000	3.299	20.000
article cleanup	00:00:00.247	0.0%	44751	0.000	0.006	0.029
article logging	00:00:00.626	0.0%	45133	0.000	0.014	0.032
article parse	00:00:02.646	0.0%	282927	0.002	0.009	0.018
article write	00:00:05.627	0.0%	23372	0.127	0.241	0.424
artlog/artcncl	00:00:00.006	0.0%	434	0.000	0.014	1.000
artlog/artparse	00:00:00.012	0.0%	1209	0.000	0.010	0.500
data move	00:00:00.264	0.0%	642070	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.017	0.0%	661	0.000	0.026	0.500
hishave/artcncl	00:00:00.002	0.0%	693	0.000	0.003	0.100
hishave/artparse	00:00:00.002	0.0%	1209	0.000	0.002	1.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:01.243	0.0%	470378	0.001	0.003	0.008
history sync	00:00:00.486	0.0%	354	0.000	1.373	8.250
history write	00:00:09.941	0.0%	44724	0.080	0.222	0.352
hiswrite/artcncl	00:00:00.007	0.0%	32	0.000	0.219	2.000
hiswrite/artparse	00:00:00.245	0.0%	1175	0.000	0.209	2.000
idle	23:58:03.768	99.8%	639790	24.441	134.863	621.237
nntp read	00:00:02.124	0.0%	638616	0.001	0.003	0.007
overview write	00:00:09.034	0.0%	23372	0.111	0.387	2.038
perl filter	00:01:40.143	0.1%	44724	0.885	2.239	4.986
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.467	0.0%	46744	0.000	0.010	0.035
TOTAL: 24:00:50.357	24:00:19.193	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.055	0.0%	24072	0.000	0.002	0.013
article prepare	00:00:00.000	0.0%	8468	0.000	0.000	0.000
article read	00:00:00.274	0.0%	1802	0.000	0.152	15.000
backlog stats	00:00:00.072	0.0%	241734	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.036	0.0%	179403	0.000	0.006	0.013
data write	00:00:01.408	0.0%	157263	0.002	0.009	0.019
idle	23:53:40.371	100.0%	241734	188.885	355.847	1309.168
status file	00:00:00.092	0.0%	202	0.000	0.455	1.000
TOTAL: 23:53:49.568	23:53:43.308	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:00.141	0.0%	5472	0.000	0.026	0.120
idle	72:37:47.518	99.9%	39327	0.000	6648.550	600734.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.603	0.0%	79801	0.000	0.008	1.366
readart	00:00:08.746	0.0%	10974	0.000	0.797	1.880
TOTAL: 72:40:00.872	72:37:57.008	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	au2pb.net	2	24421	6117	17833	471	25%	24:42:52
2	feeder.eternal-september.org	2	41531	5948	32605	2978	14%	23:59:43
3	news-out.mixmin.net	5	29146	3677	22756	2713	12%	24:21:42
4	xanadu-bbs.net	96	46513	3211	35944	7358	6%	92:49:40
5	newsfeeds.xmission.com	1	21842	1899	19921	22	8%	22:39:41
6	newsfeed.neva.ru	146	52892	1747	42080	9065	3%	71:59:43
7	nntp.pasdenom.info	3	22855	404	22392	59	1%	25:46:42
8	news.swapon.de	3	2384	386	1953	45	16%	23:09:41
9	localhost	48	9519	0	9519	0	0%	00:00:58
TOTAL: 9		306	251103	23389	205003	22711	9%	309:30:42

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	feeder.eternal-september.org	16.0 MB	23.7 KB	41.8 MB	57.8 MB	27%	6.6 KB
2	au2pb.net	15.8 MB	1.7 KB	5.8 MB	21.7 MB	73%	3.4 KB
3	news-out.mixmin.net	10.2 MB	4.7 KB	6.6 MB	16.8 MB	60%	2.7 KB
4	xanadu-bbs.net	9.2 MB	261.1 KB	169.7 MB	179.2 MB	5%	17.4 KB
5	newsfeeds.xmission.com	5.6 MB	0.0 KB	284.6 KB	5.9 MB	95%	3.1 KB
6	newsfeed.neva.ru	5.3 MB	0.0 KB	76.7 MB	82.1 MB	6%	7.8 KB
7	news.swapon.de	1.1 MB	0.0 KB	617.6 KB	1.7 MB	64%	4.0 KB
8	nntp.pasdenom.info	923.6 KB	0.0 KB	899.0 KB	1.8 MB	50%	3.9 KB
9	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 9		64.1 MB	291.1 KB	302.4 MB	366.8 MB	17%	8.1 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Aug 16 04:15:00 - 04:59:59	259	1.1%	0.10	885.7 KB	1.4%	0.33
Aug 16 05:00:00 - 05:59:59	512	2.2%	0.14	2.8 MB	4.3%	0.78
Aug 16 06:00:00 - 06:59:59	667	2.9%	0.19	1.6 MB	2.4%	0.44
Aug 16 07:00:00 - 07:59:59	763	3.3%	0.21	1.9 MB	2.9%	0.54
Aug 16 08:00:00 - 08:59:59	1036	4.4%	0.29	2.7 MB	4.3%	0.77
Aug 16 09:00:00 - 09:59:59	1088	4.7%	0.30	2.8 MB	4.4%	0.80
Aug 16 10:00:00 - 10:59:59	1062	4.5%	0.29	2.9 MB	4.5%	0.82
Aug 16 11:00:00 - 11:59:59	1250	5.3%	0.35	3.3 MB	5.2%	0.94
Aug 16 12:00:00 - 12:59:59	1042	4.5%	0.29	2.6 MB	4.1%	0.74
Aug 16 13:00:00 - 13:59:59	1052	4.5%	0.29	2.8 MB	4.4%	0.80
Aug 16 14:00:00 - 14:59:59	1167	5.0%	0.32	2.9 MB	4.5%	0.82
Aug 16 15:00:00 - 15:59:59	1293	5.5%	0.36	3.6 MB	5.7%	1.03
Aug 16 16:00:00 - 16:59:59	1571	6.7%	0.44	3.5 MB	5.5%	1.00
Aug 16 17:00:00 - 17:59:59	1512	6.5%	0.42	4.4 MB	6.9%	1.25
Aug 16 18:00:00 - 18:59:59	1279	5.5%	0.36	3.0 MB	4.8%	0.86
Aug 16 19:00:00 - 19:59:59	1312	5.6%	0.36	3.4 MB	5.4%	0.97
Aug 16 20:00:00 - 20:59:59	1285	5.5%	0.36	3.4 MB	5.3%	0.97
Aug 16 21:00:00 - 21:59:59	1221	5.2%	0.34	3.6 MB	5.6%	1.02
Aug 16 22:00:00 - 22:59:59	865	3.7%	0.24	2.3 MB	3.5%	0.64
Aug 16 23:00:00 - 23:59:59	648	2.8%	0.18	1.7 MB	2.7%	0.50
Aug 17 00:00:00 - 00:59:59	716	3.1%	0.20	2.0 MB	3.2%	0.58
Aug 17 01:00:00 - 01:59:59	549	2.3%	0.15	1.5 MB	2.4%	0.43
Aug 17 02:00:00 - 02:59:59	517	2.2%	0.14	2.2 MB	3.5%	0.63
Aug 17 03:00:00 - 03:59:59	555	2.4%	0.15	1.5 MB	2.4%	0.44
Aug 17 04:00:00 - 04:15:00	163	0.7%	0.18	508.4 KB	0.8%	0.56
TOTAL: 24:00:00	23384	100.0%	0.27	63.8 MB	100.0%	0.76

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	newsfeed.neva.ru	9005	679	0	8326
2	xanadu-bbs.net	7257	318	19	6920
3	feeder.eternal-september.org	3108	217	4	2887
4	news-out.mixmin.net	2748	9	2	2737
5	au2pb.net	588	408	1	179
6	news.swapon.de	110	0	0	110
7	nntp.pasdenom.info	50	30	0	20
8	newsfeeds.xmission.com	28	18	0	10
TOTAL: 8		22894	1679	26	21189

Unwanted newsgroups [Top 20]:

Newsgroup	Count
lada.talk	156
fa.linux.kernel	155
ut.test	150
alt.politics.scorched-earth	116
alt.politics	95
mailing.freebsd.pkg-fallout	58
mpc.lists.freebsd.ports.bugs	55
alt.windows7.general	45
alt.survival	41
mozilla.support.thunderbird	40
lada.auto	34
it-alt.sport.calcio.juventus	33
free.it.calcio.juventus	31
gmane.comp.gis.openstreetmap	25
lada.commerce	25
fa.freebsd.cvs-all	20
fa.freebsd.stable	19
mailing.freebsd.svn-ports-all	18
lada.kitchen	18
mailing.freebsd.svn-ports-head	17
TOTAL: 185	1679

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	15607
EMP (phn path)	2614
EMP (phl)	1020
PFM bot misc	202
Too many newsgroups	72
Binary Image: misplaced jpg	26
EMP (phn nph)	23
HTML Multipart	20
HTML post	8
Too many newsgroups (low_xpost)	2
U2 violation - invalid distribution	2
Binary: misplaced par2	1
TOTAL: 12	19597

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Huge articles
	xanadu-bbs.net	864
	feeder.eternal-september.org	235
	news-out.mixmin.net	48
	au2pb.net	42
	nntp.pasdenom.info	11
	news.swapon.de	6
	newsfeeds.xmission.com	4
	TOTAL: 7	1210
Including strange strings
	feeder.eternal-september.org	136
	au2pb.net	128
	news.swapon.de	62
	news-out.mixmin.net	31
	newsfeed.neva.ru	12
	newsfeeds.xmission.com	5
	nntp.pasdenom.info	5
	xanadu-bbs.net	3
	TOTAL: 8	382
TOTAL: 2		1592

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	usenet.pasdenom.info	28535	317	21499	1172	6	1%	23:59:54
2	xanadu-bbs	21727	155	20009	63	759	0%	23:59:55
3	au2pb	18035	132	17069	150	1	0%	23:59:51
4	xmission	26504	23	21191	4	3	0%	23:59:28
5	news.mixmin.net	20181	17	19502	15	6	0%	23:59:47
6	eternal-september	17894	4	17041	2	4	0%	23:59:53
7	neva.ru	22416	3	21472	55	1	0%	23:59:54
8	news.swapon.de	1982	1	1967	5	0	0%	23:49:54
TOTAL: 8		157274	652	139750	1466	780	0%	191:48:36

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	usenet.pasdenom.info	980.5 KB	2.1 MB	3.0 MB	2.1 KB	23:59:54
2	xanadu-bbs	562.6 KB	144.9 KB	707.6 KB	3.2 KB	23:59:55
3	au2pb	550.0 KB	402.0 KB	952.0 KB	3.4 KB	23:59:51
4	news.mixmin.net	106.3 KB	29.2 KB	135.4 KB	4.2 KB	23:59:47
5	xmission	46.6 KB	10.0 KB	56.7 KB	2.1 KB	23:59:28
6	neva.ru	20.8 KB	237.4 KB	258.2 KB	4.5 KB	23:59:54
7	eternal-september	13.3 KB	2.6 KB	16.0 KB	2.7 KB	23:59:53
8	news.swapon.de	3.0 KB	39.9 KB	42.9 KB	7.2 KB	23:49:54
TOTAL: 8		2.2 MB	2.9 MB	5.1 MB	2.5 KB	191:48:36

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Elapsed
1	71.94.21.184	10	26	24.2 KB	2	04:21:21
2	202.89.176.220	288	25	79.8 KB	21	04:27:53
TOTAL: 2		298	51	104.0 KB	23	72:39:53

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	unresolved	377	51	104.0 KB	23	13:14:59
2	*.bbox.io	292	0	0.0 KB	0	48:32:08
3	*.189.193.178.dynamic.wline.res.cust.swisscom.ch	1	0	0.0 KB	0	00:30:03
4	*.tampfl.dsl-w.verizon.net	11	0	0.0 KB	0	02:38:13
5	*.dynamic.upc.nl	2	0	0.0 KB	0	00:00:35
6	*.chello.nl	20	0	0.0 KB	0	07:43:53
TOTAL: 6		703	51	104.0 KB	23	72:39:53

NNRP auth users [Top 20]:

User	Conn
moussa	288
TOTAL: 1	288

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
tempe0.bbox.io	22.956	4.665	0.000	48:32:08
dhcp-089-099-203-254.chello.nl	1.559	0.285	0.000	07:43:53
202.89.176.220	25.426	5.237	0.687	04:27:53
108.175.241.207	3.444	0.901	0.000	04:25:43
71.94.21.184	1.282	0.851	0.000	04:21:21
pool-71-98-160-84.tampfl.dsl-w.verizon.net	0.774	0.181	0.000	02:38:13
30.189.193.178.dynamic.wline.res.cust.swisscom.ch	0.106	0.015	0.000	00:30:03
92-108-162-83.dynamic.upc.nl	0.148	0.031	0.000	00:00:35
69.160.37.54	1.940	0.299	0.000	00:00:02
TOTAL: 9	57.635	12.465	0.687	72:39:53

Curious NNRP server explorers [Top 20]:

System	Conn
tempe0.bbox.io	292
108.175.241.207	50
69.160.37.54	25
dhcp-089-099-203-254.chello.nl	20
pool-71-98-160-84.tampfl.dsl-w.verizon.net	11
162.212.88.198	4
92-108-162-83.dynamic.upc.nl	2
30.189.193.178.dynamic.wline.res.cust.swisscom.ch	1
TOTAL: 8	405

NNRP unrecognized commands (by host):

System	Conn
71.94.21.184	5
TOTAL: 1	5

NNRP unrecognized commands (by command):

Command	Count
XFEATURE COMPRESS GZIP	5
TOTAL: 1	5

NNRP client timeouts [Top 20]:

System	Conn	Peer
dhcp-089-099-203-254.chello.nl	14	0
pool-71-98-160-84.tampfl.dsl-w.verizon.net	5	0
tempe0.bbox.io	1	0
30.189.193.178.dynamic.wline.res.cust.swisscom.ch	1	0
TOTAL: 4	21	0

Newsgroup request counts (by category):

Category		Count	Pct
1	alt	26	51.0%
2	comp	25	49.0%
TOTAL: 2		51	100.0%

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

Newsgroup		Count
1	alt.free.newsservers	25
2	comp.os.vms	15
3	comp.arch	4
4	comp.sys.ibm.pc.games.rpg	2
5	comp.os.os2.announce	2
6	comp.arch.embedded	2
7	alt.test	1
TOTAL: 7		51

Daily Usenet report for csiph.com

Aug 16 04:15:00 -- Aug 17 04:15:00