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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	67999	49.1%	10.0 MB	60.9%
innd	36663	26.5%	3.5 MB	21.1%
nnrpd	31921	23.1%	2.7 MB	16.3%
innfeed	1867	1.3%	285.7 KB	1.7%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 5	138451	100.0%	16.5 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	274933	45.8%
Negative hits	243630	40.6%
Do not exist	73561	12.2%
Cache misses	8599	1.4%
TOTAL: 4	600723	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.387	0.0%	165	0.000	2.345	25.000
article cleanup	00:00:00.275	0.0%	46867	0.000	0.006	0.015
article logging	00:00:00.644	0.0%	47404	0.000	0.014	0.119
article parse	00:00:49.221	0.1%	3507598	0.005	0.014	0.059
article write	00:01:23.460	0.1%	28960	0.143	2.882	8.742
artlog/artcncl	00:00:00.001	0.0%	150	0.000	0.007	0.056
artlog/artparse	00:00:00.240	0.0%	20282	0.000	0.012	0.143
data move	00:00:03.069	0.0%	3961841	0.000	0.001	0.001
hisgrep/artcncl	00:00:00.054	0.0%	163	0.000	0.331	10.000
hishave/artcncl	00:00:00.000	0.0%	165	0.000	0.000	0.000
hishave/artparse	00:00:00.074	0.0%	20257	0.000	0.004	0.029
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:02.720	0.0%	582127	0.001	0.005	0.041
history sync	00:00:02.258	0.0%	301	0.000	7.502	95.500
history write	00:01:01.069	0.1%	46862	0.121	1.303	7.653
hiswrite/artcncl	00:00:00.000	0.0%	2	0.000	0.000	0.000
hiswrite/artparse	00:00:21.324	0.0%	20251	0.000	1.053	14.000
idle	23:42:59.164	99.5%	3914846	8.567	21.809	253.837
nntp read	00:00:12.638	0.0%	3921490	0.002	0.003	0.005
overview write	00:01:16.053	0.1%	28960	0.403	2.626	16.142
perl filter	00:01:21.001	0.1%	46862	1.092	1.729	2.861
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.509	0.0%	57920	0.000	0.009	0.022
TOTAL: 23:50:20.625	23:49:34.161	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.078	0.0%	29193	0.000	0.003	0.019
article prepare	00:00:00.002	0.0%	7370	0.000	0.000	0.019
article read	00:00:00.392	0.0%	1617	0.000	0.242	45.000
backlog stats	00:00:00.115	0.0%	321686	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.384	0.0%	245704	0.001	0.006	0.010
data write	00:00:01.648	0.0%	224881	0.003	0.007	0.013
idle	23:54:00.591	100.0%	321686	160.444	267.468	704.331
status file	00:00:00.094	0.0%	196	0.000	0.480	1.000
TOTAL: 23:54:08.689	23:54:04.304	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:00.351	0.0%	8961	0.018	0.039	0.154
idle	43:11:44.867	99.9%	40444	0.000	3844.943	601244.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.470	0.0%	81996	0.000	0.006	0.667
readart	00:00:00.251	0.0%	134	0.000	1.873	49.000
TOTAL: 43:13:14.379	43:11:45.939	99.9%	-	-	-	-

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	31716	7708	22516	1492	24%	23:32:20
2	feeder.eternal-september.org	1	43077	6997	32628	3452	16%	23:38:42
3	news-out.mixmin.net	2	34531	4718	26768	3045	13%	24:08:55
4	newsfeeds.xmission.com	1	30747	3958	26549	240	12%	24:55:27
5	newsfeed.neva.ru	154	57468	2744	47811	6913	4%	72:00:40
6	newsfeed.fu-berlin.de	63	31721	1253	30123	345	3%	34:42:05
7	xanadu-bbs.net	40	73330	1077	47326	24927	1%	97:05:15
8	news.swapon.de	3	2410	224	2175	11	9%	25:13:14
9	nntp.pasdenom.info	4	30093	188	29732	173	0%	24:05:42
10	localhost	26	0	0	0	0	0%	00:00:00
TOTAL: 10		295	335093	28867	265628	40598	8%	349:22:20

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	au2pb.net	20.3 MB	15.6 KB	9.4 MB	29.6 MB	68%	3.3 KB
2	feeder.eternal-september.org	19.6 MB	36.5 KB	30.0 MB	49.6 MB	39%	4.9 KB
3	news-out.mixmin.net	15.2 MB	15.5 KB	6.2 MB	21.4 MB	70%	2.8 KB
4	newsfeeds.xmission.com	11.1 MB	13.4 KB	5.0 MB	16.1 MB	68%	3.9 KB
5	newsfeed.neva.ru	8.7 MB	0.0 KB	53.9 MB	62.6 MB	13%	6.6 KB
6	xanadu-bbs.net	3.2 MB	0.0 KB	6.6 GB	6.6 GB	0%	265.9 KB
7	newsfeed.fu-berlin.de	3.0 MB	0.0 KB	1.1 MB	4.0 MB	73%	2.6 KB
8	news.swapon.de	555.2 KB	0.0 KB	25.9 KB	581.1 KB	95%	2.5 KB
9	nntp.pasdenom.info	500.8 KB	0.0 KB	3.3 MB	3.7 MB	13%	10.6 KB
10	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 10		82.0 MB	81.0 KB	6.7 GB	6.8 GB	1%	102.3 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Dec 3 04:15:00 - 04:59:59	378	1.3%	0.14	1.3 MB	1.6%	0.49
Dec 3 05:00:00 - 05:59:59	645	2.2%	0.18	2.3 MB	2.8%	0.65
Dec 3 06:00:00 - 06:59:59	623	2.1%	0.17	2.0 MB	2.4%	0.56
Dec 3 07:00:00 - 07:59:59	828	2.9%	0.23	2.3 MB	2.8%	0.66
Dec 3 08:00:00 - 08:59:59	1145	3.9%	0.32	3.7 MB	4.4%	1.04
Dec 3 09:00:00 - 09:59:59	1292	4.4%	0.36	3.2 MB	3.9%	0.92
Dec 3 10:00:00 - 10:59:59	1427	4.9%	0.40	3.6 MB	4.4%	1.03
Dec 3 11:00:00 - 11:59:59	1445	5.0%	0.40	4.0 MB	4.8%	1.13
Dec 3 12:00:00 - 12:59:59	1339	4.6%	0.37	3.6 MB	4.4%	1.02
Dec 3 13:00:00 - 13:59:59	1515	5.2%	0.42	3.7 MB	4.5%	1.06
Dec 3 14:00:00 - 14:59:59	1699	5.8%	0.47	4.4 MB	5.4%	1.26
Dec 3 15:00:00 - 15:59:59	1691	5.8%	0.47	4.9 MB	5.9%	1.39
Dec 3 16:00:00 - 16:59:59	1615	5.6%	0.45	4.2 MB	5.1%	1.19
Dec 3 17:00:00 - 17:59:59	1786	6.1%	0.50	4.9 MB	6.0%	1.40
Dec 3 18:00:00 - 18:59:59	1629	5.6%	0.45	4.4 MB	5.3%	1.24
Dec 3 19:00:00 - 19:59:59	1660	5.7%	0.46	4.3 MB	5.2%	1.23
Dec 3 20:00:00 - 20:59:59	1496	5.1%	0.42	4.0 MB	4.8%	1.13
Dec 3 21:00:00 - 21:59:59	1394	4.8%	0.39	4.0 MB	4.8%	1.13
Dec 3 22:00:00 - 22:59:59	1206	4.2%	0.34	3.3 MB	4.0%	0.95
Dec 3 23:00:00 - 23:59:59	974	3.4%	0.27	3.4 MB	4.2%	0.98
Dec 4 00:00:00 - 00:59:59	896	3.1%	0.25	2.8 MB	3.4%	0.80
Dec 4 01:00:00 - 01:59:59	894	3.1%	0.25	3.3 MB	4.0%	0.95
Dec 4 02:00:00 - 02:59:59	654	2.3%	0.18	2.1 MB	2.5%	0.60
Dec 4 03:00:00 - 03:59:59	677	2.3%	0.19	2.2 MB	2.7%	0.64
Dec 4 04:00:00 - 04:15:00	142	0.5%	0.16	462.7 KB	0.5%	0.51
TOTAL: 24:00:00	29050	100.0%	0.34	82.4 MB	100.0%	0.98

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	xanadu-bbs.net	22709	163	0	22546
2	newsfeed.neva.ru	6842	1506	0	5336
3	feeder.eternal-september.org	3428	308	1	3119
4	news-out.mixmin.net	3049	6	2	3041
5	au2pb.net	1552	1386	1	165
6	newsfeed.fu-berlin.de	727	42	0	685
7	newsfeeds.xmission.com	274	184	1	89
8	nntp.pasdenom.info	175	137	0	38
9	news.swapon.de	43	0	0	43
TOTAL: 9		38799	3732	5	35062

Unwanted newsgroups [Top 20]:

Newsgroup	Count
fa.linux.kernel	828
ut.test	195
alt.politics	128
mailing.freebsd.pkg-fallout	123
lada.auto	110
mailing.freebsd.ports-bugs	98
lada.talk	98
mailing.openbsd.source-changes	82
mailing.freebsd.svn-src-all	81
fa.freebsd.cvs-all	76
pld.cvs.commit	71
mailing.freebsd.svn-src-head	69
alt.survival	68
mozilla.dev.tree-alerts	60
fa.openbsd.source-changes	57
mailing.openssl.users	42
mailing.freebsd.svn-ports-all	42
alt.politics.scorched-earth	40
gmane.linux.alsa.devel	39
mpc.lists.nanog	39
TOTAL: 259	3732

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	9948
EMP (phn path)	2506
EMP (phl)	988
EMP (phn nph)	260
PFM bot misc	167
Binary: misplaced rar	128
HTML Multipart	114
Too many newsgroups	101
User-issued spam cancel	8
Binary: misplaced pdf	7
HTML post	6
Binary Image: misplaced jpg	4
Too many newsgroups (low_xpost)	2
Binary: misplaced rev	2
U2 violation - invalid distribution	1
HTML Image Tags	1
TOTAL: 16	14243

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad command received
	xanadu-bbs.net	318
	TOTAL: 1	318
Huge articles
	xanadu-bbs.net	19986
	feeder.eternal-september.org	115
	au2pb.net	69
	newsfeeds.xmission.com	60
	nntp.pasdenom.info	26
	news-out.mixmin.net	19
	newsfeed.fu-berlin.de	3
	TOTAL: 7	20278
Including strange strings
	newsfeed.fu-berlin.de	381
	au2pb.net	44
	news.swapon.de	32
	feeder.eternal-september.org	29
	newsfeeds.xmission.com	26
	news-out.mixmin.net	22
	newsfeed.neva.ru	2
	xanadu-bbs.net	1
	TOTAL: 8	537
TOTAL: 3		21133

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	xanadu-bbs	36071	209	27211	539	1	14	0%	23:59:56
2	usenet.pasdenom.info	32935	197	28030	631	0	184	0%	23:59:57
3	au2pb	21986	137	21078	49	0	0	0%	23:59:37
4	fu-berlin.de	27399	23	27360	16	0	0	0%	23:59:57
5	neva.ru	27477	9	26016	35	0	0	0%	23:59:50
6	xmission	30879	8	24885	0	0	0	0%	23:59:44
7	eternal-september	22375	5	21304	0	0	0	0%	23:59:57
8	news.mixmin.net	25299	3	24274	0	0	0	0%	23:59:45
9	news.swapon.de	2153	0	2147	1	0	0	0%	23:58:50
TOTAL: 9		226574	591	202305	1271	1	198	0%	215:57:33

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	xanadu-bbs	1.3 MB	1.2 MB	2.5 MB	3.4 KB	23:59:56
2	usenet.pasdenom.info	879.0 KB	1.4 MB	2.3 MB	2.8 KB	23:59:57
3	au2pb	661.1 KB	214.9 KB	876.0 KB	4.7 KB	23:59:37
4	fu-berlin.de	159.6 KB	18.4 KB	178.0 KB	4.6 KB	23:59:57
5	neva.ru	43.7 KB	143.2 KB	186.8 KB	4.2 KB	23:59:50
6	eternal-september	35.7 KB	0.0 KB	35.7 KB	7.1 KB	23:59:57
7	xmission	20.1 KB	0.0 KB	20.1 KB	2.5 KB	23:59:44
8	news.mixmin.net	17.1 KB	0.0 KB	17.1 KB	5.7 KB	23:59:45
9	news.swapon.de	0.0 KB	1.8 KB	1.8 KB	1.8 KB	23:58:50
TOTAL: 9		3.1 MB	3.0 MB	6.1 MB	3.4 KB	215:57:33

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Elapsed
1	202.89.176.220	288	114	326.3 KB	108	04:18:41
2	187.a2c-250-241.astra2connect.com	6	17	24.7 KB	2	02:05:28
3	92-108-162-83.dynamic.upc.nl	2	3	4.3 KB	1	00:03:42
TOTAL: 3		296	134	355.2 KB	111	43:13:10

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	unresolved	320	114	326.3 KB	108	31:31:26
2	*.a2c-250-241.astra2connect.com	6	17	24.7 KB	2	02:05:28
3	*.dynamic.upc.nl	2	3	4.3 KB	1	00:03:42
4	*.tampfl.dsl-w.verizon.net	2	0	0.0 KB	0	00:53:18
5	*.bbox.io	4	0	0.0 KB	0	01:30:11
6	*.chello.nl	14	0	0.0 KB	0	04:47:39
7	*.149.22.98.dynamic.ip.windstream.net	1	0	0.0 KB	0	02:21:23
TOTAL: 7		349	134	355.2 KB	111	43:13:10

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	0.476	0.318	0.000	25:39:55
dhcp-089-099-203-254.chello.nl	1.102	0.263	0.000	04:47:39
202.89.176.220	30.658	6.663	0.739	04:18:41
h188.149.22.98.dynamic.ip.windstream.net	0.188	0.113	0.000	02:21:23
187.a2c-250-241.astra2connect.com	0.774	0.085	0.000	02:05:28
138.108.60.60	0.292	0.047	0.000	01:32:47
tempe0.bbox.io	0.438	0.097	0.000	01:30:11
pool-71-98-160-84.tampfl.dsl-w.verizon.net	0.171	0.016	0.000	00:53:18
92-108-162-83.dynamic.upc.nl	0.206	0.025	0.000	00:03:42
69.160.37.54	2.109	0.441	0.000	00:00:02
TOTAL: 10	36.414	8.068	0.739	43:13:10

Curious NNRP server explorers [Top 20]:

System	Conn
69.160.37.54	25
dhcp-089-099-203-254.chello.nl	14
tempe0.bbox.io	4
216.246.166.29	4
138.108.60.60	3
pool-71-98-160-84.tampfl.dsl-w.verizon.net	2
h188.149.22.98.dynamic.ip.windstream.net	1
TOTAL: 7	53

NNRP client timeouts [Top 20]:

System	Conn	Peer
dhcp-089-099-203-254.chello.nl	8	0
187.a2c-250-241.astra2connect.com	4	0
tempe0.bbox.io	3	0
138.108.60.60	3	0
h188.149.22.98.dynamic.ip.windstream.net	2	0
pool-71-98-160-84.tampfl.dsl-w.verizon.net	1	0
TOTAL: 6	21	0

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	comp.os.vms	27
2	comp.arch	26
3	comp.sys.ibm.ps2.hardware	20
4	comp.arch.fpga	14
5	comp.sys.ibm.pc.games.action	11
6	comp.arch.embedded	10
7	comp.os.os2.misc	6
8	comp.ai.philosophy	6
9	comp.sys.ibm.pc.games.war-historical	5
10	comp.os.os2.apps	2
11	comp.os.os2.programmer.misc	2
12	comp.ai.alife	1
13	comp.ai.fuzzy	1
14	comp.os.os2.advocacy	1
15	comp.ai.genetic	1
16	comp.sys.ibm.as400.misc	1
TOTAL: 16		134

Daily Usenet report for csiph.com

Dec 3 04:15:00 -- Dec 4 04:15:00