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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	45172	48.4%	6.5 MB	59.7%
nnrpd	31571	33.8%	2.6 MB	24.3%
innd	14972	16.0%	1.5 MB	13.8%
innfeed	1707	1.8%	231.6 KB	2.1%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 5	93423	100.0%	10.9 MB	100.0%

History cache:

Reason	Count	%Count
Negative hits	224880	45.5%
Positive hits	221474	44.8%
Do not exist	44695	9.0%
Cache misses	3546	0.7%
TOTAL: 4	494595	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.171	0.0%	257	0.000	0.665	27.000
article cleanup	00:00:00.263	0.0%	43848	0.000	0.006	0.024
article logging	00:00:00.584	0.0%	44007	0.000	0.013	0.039
article parse	00:00:02.361	0.0%	244150	0.002	0.010	0.023
article write	00:00:06.539	0.0%	26965	0.156	0.242	0.405
artlog/artcncl	00:00:00.003	0.0%	200	0.000	0.015	0.500
artlog/artparse	00:00:00.013	0.0%	985	0.000	0.013	0.667
data move	00:00:00.242	0.0%	659866	0.000	0.000	0.001
hisgrep/artcncl	00:00:00.003	0.0%	253	0.000	0.012	0.200
hishave/artcncl	00:00:00.002	0.0%	257	0.000	0.008	0.100
hishave/artparse	00:00:00.003	0.0%	985	0.000	0.003	0.500
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:01.209	0.0%	494971	0.001	0.002	0.007
history sync	00:00:00.513	0.0%	363	0.000	1.413	3.000
history write	00:00:10.131	0.0%	43847	0.085	0.231	0.295
hiswrite/artcncl	00:00:00.000	0.0%	4	0.000	0.000	0.000
hiswrite/artparse	00:00:00.264	0.0%	985	0.000	0.268	2.000
idle	23:58:44.293	99.8%	650187	31.390	132.768	387.802
nntp read	00:00:02.105	0.0%	648606	0.000	0.003	0.007
overview write	00:00:04.566	0.0%	26965	0.100	0.169	0.422
perl filter	00:01:14.284	0.1%	43847	1.000	1.694	3.835
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.513	0.0%	53930	0.000	0.010	0.034
TOTAL: 24:00:57.027	24:00:28.062	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.065	0.0%	26901	0.000	0.002	0.020
article prepare	00:00:00.001	0.0%	8084	0.000	0.000	0.012
article read	00:00:00.258	0.0%	1618	0.000	0.159	6.714
backlog stats	00:00:00.091	0.0%	279725	0.000	0.000	0.004
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.151	0.0%	207642	0.001	0.006	0.014
data write	00:00:01.589	0.0%	182349	0.001	0.009	0.018
idle	23:53:41.062	100.0%	279725	179.976	307.520	713.905
status file	00:00:00.076	0.0%	177	0.000	0.429	1.000
TOTAL: 23:53:47.789	23:53:44.293	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:00.646	0.0%	28866	0.000	0.022	0.076
idle	87:22:38.713	100.0%	59772	0.000	5262.643	600128.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:11.753	0.0%	166155	0.000	0.071	55.045
readart	00:00:00.216	0.0%	94	0.000	2.298	60.000
TOTAL: 87:24:23.949	87:22:51.328	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	1	29558	6938	21394	1226	23%	23:44:38
2	feeder.eternal-september.org	5	39254	6200	31282	1772	15%	23:49:17
3	xanadu-bbs.net	0	44838	4375	34347	6116	9%	24:56:17
4	news-out.mixmin.net	5	31315	3664	25530	2121	11%	24:24:44
5	newsfeed.neva.ru	144	55871	3141	46262	6468	5%	71:49:42
6	newsfeeds.xmission.com	1	28157	1829	26244	84	6%	25:29:06
7	nntp.pasdenom.info	3	27945	460	27423	62	1%	24:26:01
8	news.swapon.de	1	2451	326	2110	15	13%	24:46:57
9	localhost	50	10044	0	10044	0	0%	00:01:01
TOTAL: 9		210	269433	26933	224636	17864	9%	243:27:43

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	feeder.eternal-september.org	18.8 MB	9.9 KB	13.5 MB	32.2 MB	58%	4.1 KB
2	au2pb.net	16.5 MB	0.0 KB	8.3 MB	24.9 MB	66%	3.1 KB
3	xanadu-bbs.net	12.6 MB	0.0 KB	137.5 MB	150.1 MB	8%	14.6 KB
4	news-out.mixmin.net	12.5 MB	0.0 KB	6.1 MB	18.6 MB	67%	3.3 KB
5	newsfeed.neva.ru	9.1 MB	0.0 KB	39.1 MB	48.3 MB	18%	5.1 KB
6	newsfeeds.xmission.com	5.6 MB	0.0 KB	1.7 MB	7.2 MB	77%	3.9 KB
7	nntp.pasdenom.info	1011.0 KB	0.0 KB	514.3 KB	1.5 MB	66%	2.9 KB
8	news.swapon.de	853.2 KB	0.0 KB	40.0 KB	893.2 KB	95%	2.6 KB
9	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 9		76.9 MB	9.9 KB	206.7 MB	283.6 MB	27%	6.5 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Aug 18 04:15:00 - 04:59:59	402	1.5%	0.15	1.2 MB	1.6%	0.45
Aug 18 05:00:00 - 05:59:59	617	2.3%	0.17	1.9 MB	2.4%	0.53
Aug 18 06:00:00 - 06:59:59	694	2.6%	0.19	3.0 MB	3.9%	0.86
Aug 18 07:00:00 - 07:59:59	1153	4.3%	0.32	3.5 MB	4.5%	0.99
Aug 18 08:00:00 - 08:59:59	1274	4.7%	0.35	3.9 MB	5.1%	1.12
Aug 18 09:00:00 - 09:59:59	1234	4.6%	0.34	3.7 MB	4.8%	1.05
Aug 18 10:00:00 - 10:59:59	1176	4.4%	0.33	3.0 MB	3.9%	0.85
Aug 18 11:00:00 - 11:59:59	1316	4.9%	0.37	3.8 MB	4.9%	1.07
Aug 18 12:00:00 - 12:59:59	1448	5.4%	0.40	3.9 MB	5.1%	1.11
Aug 18 13:00:00 - 13:59:59	1305	4.8%	0.36	3.5 MB	4.5%	0.99
Aug 18 14:00:00 - 14:59:59	1492	5.5%	0.41	4.0 MB	5.3%	1.15
Aug 18 15:00:00 - 15:59:59	1489	5.5%	0.41	3.8 MB	5.0%	1.09
Aug 18 16:00:00 - 16:59:59	1702	6.3%	0.47	4.5 MB	5.9%	1.29
Aug 18 17:00:00 - 17:59:59	1656	6.1%	0.46	4.8 MB	6.3%	1.37
Aug 18 18:00:00 - 18:59:59	1487	5.5%	0.41	4.2 MB	5.5%	1.20
Aug 18 19:00:00 - 19:59:59	1402	5.2%	0.39	3.9 MB	5.0%	1.10
Aug 18 20:00:00 - 20:59:59	1334	4.9%	0.37	3.6 MB	4.7%	1.03
Aug 18 21:00:00 - 21:59:59	1235	4.6%	0.34	3.1 MB	4.1%	0.90
Aug 18 22:00:00 - 22:59:59	1166	4.3%	0.32	3.0 MB	4.0%	0.87
Aug 18 23:00:00 - 23:59:59	804	3.0%	0.22	2.4 MB	3.2%	0.69
Aug 19 00:00:00 - 00:59:59	705	2.6%	0.20	2.1 MB	2.7%	0.60
Aug 19 01:00:00 - 01:59:59	612	2.3%	0.17	1.9 MB	2.4%	0.53
Aug 19 02:00:00 - 02:59:59	532	2.0%	0.15	1.7 MB	2.2%	0.49
Aug 19 03:00:00 - 03:59:59	563	2.1%	0.16	1.8 MB	2.4%	0.53
Aug 19 04:00:00 - 04:15:00	154	0.6%	0.17	440.5 KB	0.6%	0.49
TOTAL: 24:00:00	26952	100.0%	0.31	76.8 MB	100.0%	0.91

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	newsfeed.neva.ru	6456	1634	0	4822
2	xanadu-bbs.net	6083	990	0	5093
3	news-out.mixmin.net	2160	19	0	2141
4	feeder.eternal-september.org	1830	380	1	1449
5	au2pb.net	1270	1229	0	41
6	newsfeeds.xmission.com	94	62	0	32
7	news.swapon.de	65	0	0	65
8	nntp.pasdenom.info	62	51	0	11
TOTAL: 8		18020	4365	1	13654

Unwanted newsgroups [Top 20]:

Newsgroup	Count
fa.linux.kernel	539
lada.talk	297
mailing.freebsd.pkg-fallout	243
ut.test	169
alt.politics.scorched-earth	162
mailing.freebsd.svn-ports-all	153
lada.auto	148
mailing.freebsd.svn-ports-head	146
alt.politics	108
alt.job	99
alt.windows7.general	90
lada.commerce	75
free.it.calcio.juventus	63
alt.survival	59
mailing.freebsd.ports-bugs	58
mpc.lists.freebsd.ports.bugs	58
mailing.freebsd.svn-src-all	51
mailing.gcc.gcc-cvs	51
fa.freebsd.cvs-all	51
mailing.freebsd.svn-src-head	39
TOTAL: 285	4365

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	9644
EMP (phn path)	1750
EMP (phl)	753
PFM bot misc	135
Too many newsgroups	79
HTML Multipart	64
EMP (phn nph)	45
Binary Image: misplaced jpg	19
EMP (fsl)	10
HTML post	7
HTML Image Tags	3
TOTAL: 11	12509

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Huge articles
	xanadu-bbs.net	849
	feeder.eternal-september.org	51
	news-out.mixmin.net	51
	newsfeeds.xmission.com	16
	au2pb.net	14
	nntp.pasdenom.info	4
	TOTAL: 6	985
Including strange strings
	news.swapon.de	56
	news-out.mixmin.net	38
	feeder.eternal-september.org	33
	au2pb.net	17
	newsfeeds.xmission.com	9
	xanadu-bbs.net	5
	newsfeed.neva.ru	2
	TOTAL: 7	160
TOTAL: 2		1145

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	usenet.pasdenom.info	33215	405	25166	945	4	1%	23:59:58
2	au2pb	20875	214	19585	176	0	1%	23:59:58
3	xanadu-bbs	24127	109	22416	35	9	0%	23:59:37
4	news.mixmin.net	23945	33	23138	13	0	0%	23:59:55
5	eternal-september	21355	9	20283	2	0	0%	23:59:58
6	neva.ru	24682	6	23510	64	0	0%	23:59:57
7	xmission	31716	2	25080	0	0	0%	23:59:57
8	news.swapon.de	2255	0	2203	13	0	0%	23:55:14
TOTAL: 8		182170	778	161381	1248	13	0%	191:54:34

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	usenet.pasdenom.info	1.3 MB	1.8 MB	3.1 MB	2.4 KB	23:59:58
2	au2pb	871.8 KB	537.4 KB	1.4 MB	3.6 KB	23:59:58
3	xanadu-bbs	630.1 KB	67.9 KB	698.0 KB	4.8 KB	23:59:37
4	news.mixmin.net	201.2 KB	27.2 KB	228.3 KB	5.0 KB	23:59:55
5	eternal-september	38.2 KB	1.9 KB	40.1 KB	3.6 KB	23:59:58
6	neva.ru	31.3 KB	286.3 KB	317.6 KB	4.5 KB	23:59:57
7	xmission	6.9 KB	0.0 KB	6.9 KB	3.5 KB	23:59:57
8	news.swapon.de	0.0 KB	31.6 KB	31.6 KB	2.4 KB	23:55:14
TOTAL: 8		3.1 MB	2.7 MB	5.8 MB	2.9 KB	191:54:34

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Elapsed
1	202.89.176.220	283	78	232.3 KB	71	04:17:56
2	challenger.nielsenmedia.com	7	9	15.5 KB	3	01:48:08
3	dhcp-089-099-203-254.chello.nl	7	4	7.2 KB	4	01:25:33
4	tempe0.bbox.io	6	3	5.4 KB	3	00:35:08
TOTAL: 4		303	94	260.3 KB	81	87:24:19

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	unresolved	368	78	232.3 KB	71	81:47:04
2	*.nielsenmedia.com	7	9	15.5 KB	3	01:48:08
3	*.chello.nl	7	4	7.2 KB	4	01:25:33
4	*.bbox.io	6	3	5.4 KB	3	00:35:08
5	*.dynamic.upc.nl	2	0	0.0 KB	0	00:30:07
6	*.dsl.klmzmi.ameritech.net	4	0	0.0 KB	0	00:00:35
7	*.tampfl.dsl-w.verizon.net	8	0	0.0 KB	0	00:17:37
8	*.189.193.178.dynamic.wline.res.cust.swisscom.ch	2	0	0.0 KB	0	01:00:03
TOTAL: 8		404	94	260.3 KB	81	87:24:19

NNRP auth users [Top 20]:

User	Conn
moussa	283
TOTAL: 1	283

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
108.175.241.207	4.295	1.639	0.000	45:26:31
162.212.88.198	0.663	0.549	0.000	27:40:39
71.94.21.184	0.213	0.223	0.000	04:21:55
202.89.176.220	26.990	5.570	0.688	04:17:56
challenger.nielsenmedia.com	0.769	0.102	0.000	01:48:08
dhcp-089-099-203-254.chello.nl	0.686	0.127	0.000	01:25:33
30.189.193.178.dynamic.wline.res.cust.swisscom.ch	0.267	0.015	0.000	01:00:03
tempe0.bbox.io	0.502	0.087	0.000	00:35:08
92-108-162-83.dynamic.upc.nl	0.159	0.031	0.000	00:30:07
pool-71-98-160-84.tampfl.dsl-w.verizon.net	0.558	0.093	0.000	00:17:37
adsl-69-208-66-77.dsl.klmzmi.ameritech.net	0.375	0.124	0.000	00:00:35
69.160.37.54	1.975	0.341	0.000	00:00:02
TOTAL: 12	37.452	8.901	0.688	87:24:19

Curious NNRP server explorers [Top 20]:

System	Conn
108.175.241.207	50
69.160.37.54	25
162.212.88.198	8
pool-71-98-160-84.tampfl.dsl-w.verizon.net	8
adsl-69-208-66-77.dsl.klmzmi.ameritech.net	4
30.189.193.178.dynamic.wline.res.cust.swisscom.ch	2
71.94.21.184	2
92-108-162-83.dynamic.upc.nl	2
TOTAL: 8	101

NNRP unrecognized commands (by host):

System	Conn
71.94.21.184	2
TOTAL: 1	2

NNRP unrecognized commands (by command):

Command	Count
XFEATURE COMPRESS GZIP	2
TOTAL: 1	2

NNRP client timeouts [Top 20]:

System	Conn	Peer
challenger.nielsenmedia.com	3	0
30.189.193.178.dynamic.wline.res.cust.swisscom.ch	2	0
dhcp-089-099-203-254.chello.nl	2	0
71.94.21.184	1	0
92-108-162-83.dynamic.upc.nl	1	0
tempe0.bbox.io	1	0
TOTAL: 6	10	0

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	comp.os.vms	28
2	comp.arch	23
3	comp.sys.ibm.ps2.hardware	10
4	comp.lang.awk	9
5	comp.arch.embedded	7
6	comp.sys.ibm.pc.hardware.chips	6
7	comp.arch.fpga	5
8	comp.os.os2.apps	2
9	comp.sys.ibm.as400.misc	2
10	comp.ai.neural-nets	1
11	comp.sys.ibm.pc.games.action	1
TOTAL: 11		94

Daily Usenet report for csiph.com

Aug 18 04:15:00 -- Aug 19 04:15:00