Daily Usenet report for csiph.com: Dec 9 04:15:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	45395	48.0%	6.9 MB	60.6%
nnrpd	32082	33.9%	2.7 MB	23.8%
innd	15232	16.1%	1.5 MB	13.5%
innfeed	1845	2.0%	248.6 KB	2.1%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 5	94555	100.0%	11.3 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	248478	47.7%
Negative hits	227576	43.7%
Do not exist	44451	8.5%
Cache misses	101	0.0%
TOTAL: 4	520606	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.359	0.0%	153	0.000	2.346	12.000
article cleanup	00:00:00.286	0.0%	43491	0.000	0.007	0.027
article logging	00:00:00.572	0.0%	44056	0.000	0.013	0.034
article parse	00:00:04.093	0.0%	339979	0.002	0.012	0.073
article write	00:01:08.545	0.1%	27388	0.300	2.503	8.550
artlog/artcncl	00:00:00.001	0.0%	144	0.000	0.007	1.000
artlog/artparse	00:00:00.015	0.0%	1252	0.000	0.012	1.000
data move	00:00:00.334	0.0%	792774	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.032	0.0%	153	0.000	0.209	5.000
hishave/artcncl	00:00:00.001	0.0%	153	0.000	0.007	0.071
hishave/artparse	00:00:00.001	0.0%	1252	0.000	0.001	0.077
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:05.666	0.0%	522091	0.001	0.011	0.167
history sync	00:00:01.914	0.0%	355	0.000	5.392	54.500
history write	00:00:50.356	0.1%	43490	0.049	1.158	11.180
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
hiswrite/artparse	00:00:01.323	0.0%	1251	0.000	1.058	15.143
idle	23:55:39.818	99.6%	769369	15.473	111.962	354.564
nntp read	00:00:02.331	0.0%	771836	0.001	0.003	0.006
overview write	00:01:06.258	0.1%	27388	0.415	2.419	23.840
perl filter	00:01:15.501	0.1%	43490	1.007	1.736	3.033
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.489	0.0%	54776	0.000	0.009	0.030
TOTAL: 24:00:52.111	24:00:17.895	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.077	0.0%	27404	0.000	0.003	0.020
article prepare	00:00:00.002	0.0%	4400	0.000	0.000	0.031
article read	00:00:00.154	0.0%	861	0.000	0.179	22.000
backlog stats	00:00:00.109	0.0%	287526	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.214	0.0%	228032	0.000	0.005	0.013
data write	00:00:01.550	0.0%	205485	0.002	0.008	0.015
idle	23:54:22.286	100.0%	287526	152.628	299.320	657.062
status file	00:00:00.088	0.0%	189	0.000	0.466	1.000
TOTAL: 23:54:29.357	23:54:25.480	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:00.291	0.0%	9831	0.006	0.030	0.047
idle	47:45:36.270	99.9%	41381	0.000	4154.957	600163.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.523	0.0%	83931	0.000	0.006	0.500
readart	00:00:00.147	0.0%	137	0.000	1.073	54.000
TOTAL: 47:47:02.693	47:45:37.231	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	39778	7208	31169	1401	18%	24:30:20
2	au2pb.net	1	30059	5139	24154	766	17%	23:33:35
3	news-out.mixmin.net	4	32042	4622	24811	2609	14%	24:17:58
4	xanadu-bbs.net	1	45115	3157	33651	8307	6%	24:37:14
5	newsfeed.neva.ru	147	57482	2650	51006	3826	4%	72:18:31
6	newsfeeds.xmission.com	1	27957	2632	24906	419	9%	23:01:43
7	newsfeed.fu-berlin.de	62	31170	1444	29461	265	4%	35:18:22
8	nntp.pasdenom.info	3	28544	213	28262	69	0%	24:09:30
9	news.swapon.de	1	2160	194	1954	12	8%	20:50:05
10	localhost	26	0	0	0	0	0%	00:00:01
TOTAL: 10		250	294307	27259	249374	17674	9%	272:37:19

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	feeder.eternal-september.org	18.8 MB	0.0 KB	19.5 MB	38.3 MB	49%	4.6 KB
2	au2pb.net	14.2 MB	18.0 KB	6.0 MB	20.2 MB	70%	3.5 KB
3	news-out.mixmin.net	12.8 MB	0.0 KB	5.2 MB	18.1 MB	71%	2.6 KB
4	xanadu-bbs.net	9.0 MB	16.8 KB	451.0 MB	459.9 MB	1%	41.1 KB
5	newsfeeds.xmission.com	8.5 MB	0.0 KB	4.6 MB	13.0 MB	64%	4.4 KB
6	newsfeed.neva.ru	7.6 MB	0.0 KB	21.4 MB	29.0 MB	26%	4.6 KB
7	newsfeed.fu-berlin.de	3.3 MB	0.0 KB	786.7 KB	4.0 MB	80%	2.4 KB
8	nntp.pasdenom.info	473.5 KB	0.0 KB	1.0 MB	1.5 MB	30%	5.5 KB
9	news.swapon.de	459.9 KB	0.0 KB	32.3 KB	492.2 KB	93%	2.4 KB
10	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 10		75.1 MB	34.7 KB	509.5 MB	584.6 MB	12%	13.3 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Dec 9 04:15:00 - 04:59:59	421	1.5%	0.16	1.3 MB	1.7%	0.50
Dec 9 05:00:00 - 05:59:59	608	2.2%	0.17	2.2 MB	2.9%	0.62
Dec 9 06:00:00 - 06:59:59	530	1.9%	0.15	1.8 MB	2.4%	0.52
Dec 9 07:00:00 - 07:59:59	681	2.5%	0.19	1.7 MB	2.2%	0.47
Dec 9 08:00:00 - 08:59:59	1007	3.7%	0.28	2.6 MB	3.4%	0.74
Dec 9 09:00:00 - 09:59:59	1218	4.4%	0.34	3.3 MB	4.3%	0.93
Dec 9 10:00:00 - 10:59:59	1381	5.0%	0.38	4.0 MB	5.3%	1.13
Dec 9 11:00:00 - 11:59:59	1069	3.9%	0.30	2.7 MB	3.6%	0.76
Dec 9 12:00:00 - 12:59:59	1251	4.6%	0.35	3.1 MB	4.0%	0.87
Dec 9 13:00:00 - 13:59:59	1411	5.2%	0.39	4.3 MB	5.8%	1.23
Dec 9 14:00:00 - 14:59:59	1250	4.6%	0.35	3.0 MB	4.0%	0.85
Dec 9 15:00:00 - 15:59:59	1535	5.6%	0.43	3.9 MB	5.1%	1.10
Dec 9 16:00:00 - 16:59:59	1825	6.7%	0.51	4.9 MB	6.5%	1.40
Dec 9 17:00:00 - 17:59:59	1646	6.0%	0.46	4.3 MB	5.6%	1.21
Dec 9 18:00:00 - 18:59:59	1720	6.3%	0.48	4.7 MB	6.2%	1.33
Dec 9 19:00:00 - 19:59:59	1553	5.7%	0.43	4.0 MB	5.3%	1.13
Dec 9 20:00:00 - 20:59:59	1553	5.7%	0.43	4.2 MB	5.5%	1.18
Dec 9 21:00:00 - 21:59:59	1443	5.3%	0.40	3.8 MB	5.1%	1.08
Dec 9 22:00:00 - 22:59:59	1362	5.0%	0.38	3.8 MB	5.0%	1.07
Dec 9 23:00:00 - 23:59:59	1036	3.8%	0.29	3.2 MB	4.2%	0.90
Dec 10 00:00:00 - 00:59:59	789	2.9%	0.22	2.5 MB	3.3%	0.71
Dec 10 01:00:00 - 01:59:59	782	2.9%	0.22	2.3 MB	3.0%	0.65
Dec 10 02:00:00 - 02:59:59	619	2.3%	0.17	1.9 MB	2.5%	0.54
Dec 10 03:00:00 - 03:59:59	561	2.0%	0.16	1.8 MB	2.4%	0.51
Dec 10 04:00:00 - 04:15:00	123	0.4%	0.14	450.9 KB	0.6%	0.50
TOTAL: 24:00:00	27374	100.0%	0.32	75.4 MB	100.0%	0.89

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	xanadu-bbs.net	7948	708	0	7240
2	newsfeed.neva.ru	3813	1596	0	2217
3	news-out.mixmin.net	2643	4	0	2639
4	feeder.eternal-september.org	1451	229	0	1222
5	au2pb.net	777	711	1	65
6	newsfeed.fu-berlin.de	700	39	0	661
7	newsfeeds.xmission.com	429	380	0	49
8	nntp.pasdenom.info	66	45	0	21
9	news.swapon.de	50	0	0	50
TOTAL: 9		17877	3712	1	14164

Unwanted newsgroups [Top 20]:

Newsgroup	Count
fa.linux.kernel	1047
lada.talk	262
mailing.freebsd.pkg-fallout	210
ut.test	144
alt.politics	110
mailing.freebsd.svn-ports-all	92
mailing.freebsd.svn-ports-head	88
lada.auto	71
mailing.freebsd.ports-bugs	64
it-alt.sport.calcio.juventus	64
alt.survival	55
mailing.gcc.gcc-cvs	49
mailing.freebsd.svn-src-all	45
gmane.linux.alsa.devel	44
mailing.openbsd.source-changes	43
mailing.freebsd.svn-src-head	42
fa.freebsd.cvs-all	42
alt.windows7.general	40
mailing.database.pgsql-general	33
alt.politics.scorched-earth	30
TOTAL: 248	3712

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	8943
EMP (phn path)	1842
EMP (phl)	885
EMP (phn nph)	166
Binary: misplaced rar	162
PFM bot misc	134
HTML Multipart	101
Too many newsgroups	100
HTML post	9
User-issued spam cancel	6
Binary: misplaced par2	3
Binary: misplaced nfo	2
Binary Payload	2
Too many newsgroups (low_xpost)	2
Binary Image: misplaced jpg	1
TOTAL: 15	12358

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Huge articles
	xanadu-bbs.net	1039
	feeder.eternal-september.org	106
	newsfeeds.xmission.com	41
	au2pb.net	28
	news-out.mixmin.net	15
	nntp.pasdenom.info	11
	newsfeed.fu-berlin.de	2
	TOTAL: 7	1242
Including strange strings
	newsfeed.fu-berlin.de	432
	feeder.eternal-september.org	44
	news.swapon.de	36
	news-out.mixmin.net	32
	newsfeeds.xmission.com	6
	xanadu-bbs.net	5
	au2pb.net	5
	newsfeed.neva.ru	2
	nntp.pasdenom.info	2
	TOTAL: 9	564
TOTAL: 2		1806

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	usenet.pasdenom.info	31065	129	26498	537	1	0%	23:59:57
2	au2pb	22776	117	21944	97	0	0%	23:59:49
3	xanadu-bbs	25768	86	24091	40	7	0%	23:59:57
4	fu-berlin.de	25527	24	25486	17	0	0%	23:59:44
5	eternal-september	20958	7	19365	2	0	0%	23:59:48
6	xmission	27432	7	24453	0	0	0%	23:59:58
7	neva.ru	26040	4	24528	28	0	0%	23:59:57
8	news.mixmin.net	23825	3	22656	0	66	0%	23:59:57
9	news.swapon.de	2246	1	2194	5	0	0%	23:59:19
TOTAL: 9		205637	378	191215	726	74	0%	215:58:26

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	xanadu-bbs	595.9 KB	70.5 KB	666.5 KB	5.3 KB	23:59:57
2	usenet.pasdenom.info	580.5 KB	1.2 MB	1.8 MB	2.8 KB	23:59:57
3	au2pb	509.6 KB	388.7 KB	898.2 KB	4.2 KB	23:59:49
4	fu-berlin.de	157.4 KB	21.6 KB	178.9 KB	4.4 KB	23:59:44
5	neva.ru	28.0 KB	202.6 KB	230.6 KB	7.2 KB	23:59:57
6	eternal-september	22.1 KB	2.8 KB	24.9 KB	2.8 KB	23:59:48
7	xmission	20.3 KB	0.0 KB	20.3 KB	2.9 KB	23:59:58
8	news.mixmin.net	8.7 KB	0.0 KB	8.7 KB	2.9 KB	23:59:57
9	news.swapon.de	2.7 KB	18.2 KB	20.8 KB	3.5 KB	23:59:19
TOTAL: 9		1.9 MB	1.9 MB	3.8 MB	3.5 KB	215:58:26

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Rej	Elapsed
1	202.89.176.220	288	131	403.0 KB	122	0	04:31:50
2	187.a2c-250-241.astra2connect.com	14	5	7.5 KB	4	1	01:10:16
3	tempe0.bbox.io	16	1	2.3 KB	1	0	05:19:08
TOTAL: 3		318	137	412.9 KB	127	1	47:46:58

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Rej	Elapsed
1	unresolved	329	131	403.0 KB	122	0	33:59:18
2	*.a2c-250-241.astra2connect.com	14	5	7.5 KB	4	1	01:10:16
3	*.bbox.io	16	1	2.3 KB	1	0	05:19:08
4	*.248.91.75.dynamic.ip.windstream.net	2	0	0.0 KB	0	0	01:43:50
5	*.nielsenmedia.com	4	0	0.0 KB	0	0	01:38:03
6	*.tampfl.dsl-w.verizon.net	3	0	0.0 KB	0	0	00:43:11
7	*.chello.nl	8	0	0.0 KB	0	0	03:13:10
TOTAL: 7		376	137	412.9 KB	127	1	47:46:58

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
216.246.166.29	1.119	0.547	0.000	29:27:25
tempe0.bbox.io	1.463	0.317	0.000	05:19:08
202.89.176.220	31.186	6.518	0.744	04:31:50
dhcp-089-099-203-254.chello.nl	0.709	0.157	0.000	03:13:10
h130.248.91.75.dynamic.ip.windstream.net	0.113	0.069	0.000	01:43:50
challenger.nielsenmedia.com	0.336	0.063	0.000	01:38:03
187.a2c-250-241.astra2connect.com	1.337	0.299	0.000	01:10:16
pool-71-98-160-84.tampfl.dsl-w.verizon.net	0.277	0.056	0.000	00:43:11
69.160.37.54	1.992	0.496	0.000	00:00:02
TOTAL: 9	38.532	8.522	0.744	47:46:58

Curious NNRP server explorers [Top 20]:

System	Conn
69.160.37.54	25
216.246.166.29	16
dhcp-089-099-203-254.chello.nl	8
challenger.nielsenmedia.com	4
pool-71-98-160-84.tampfl.dsl-w.verizon.net	3
h130.248.91.75.dynamic.ip.windstream.net	2
TOTAL: 6	58

NNRP client timeouts [Top 20]:

System	Conn	Peer
tempe0.bbox.io	10	0
216.246.166.29	8	4
dhcp-089-099-203-254.chello.nl	6	0
challenger.nielsenmedia.com	3	0
pool-71-98-160-84.tampfl.dsl-w.verizon.net	1	0
h130.248.91.75.dynamic.ip.windstream.net	1	0
187.a2c-250-241.astra2connect.com	1	0
TOTAL: 7	30	4

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	comp.os.vms	45
2	comp.arch	37
3	comp.sys.ibm.pc.games.action	18
4	comp.arch.embedded	8
5	comp.ai.philosophy	8
6	comp.sys.ibm.ps2.hardware	7
7	comp.sys.ibm.as400.misc	4
8	comp.os.linux.networking	2
9	comp.os.os2.announce	2
10	comp.arch.fpga	1
11	comp.os.os2.misc	1
12	comp.ai.edu	1
13	comp.unix.aix	1
14	comp.ai.nat-lang	1
15	comp.os.msdos.misc	1
TOTAL: 15		137

Daily Usenet report for csiph.com

Dec 9 04:15:00 -- Dec 10 04:15:00