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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	54715	48.5%	7.6 MB	59.2%
nnrpd	31911	28.3%	2.6 MB	20.5%
innd	24259	21.5%	2.3 MB	18.1%
innfeed	1899	1.7%	286.1 KB	2.2%
controlchan	11	0.0%	1.0 KB	0.0%
TOTAL: 5	112795	100.0%	12.8 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	263541	44.9%
Negative hits	261480	44.6%
Do not exist	53989	9.2%
Cache misses	7308	1.2%
TOTAL: 4	586318	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.132	0.0%	205	0.000	0.644	20.000
article cleanup	00:00:00.327	0.0%	53326	0.000	0.006	0.016
article logging	00:00:00.621	0.0%	53745	0.000	0.012	0.026
article parse	00:00:02.415	0.0%	287031	0.003	0.008	0.021
article write	00:00:06.261	0.0%	27338	0.159	0.229	0.338
artlog/artcncl	00:00:00.001	0.0%	165	0.000	0.006	0.100
artlog/artparse	00:00:00.011	0.0%	803	0.000	0.014	0.250
data move	00:00:00.322	0.0%	737123	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.006	0.0%	205	0.000	0.029	0.500
hishave/artcncl	00:00:00.002	0.0%	205	0.000	0.010	1.000
hishave/artparse	00:00:00.001	0.0%	803	0.000	0.001	0.125
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:01.420	0.0%	586751	0.000	0.002	0.009
history sync	00:00:00.476	0.0%	308	0.000	1.545	3.000
history write	00:00:13.240	0.0%	53318	0.082	0.248	0.314
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
hiswrite/artparse	00:00:00.205	0.0%	803	0.000	0.255	2.000
idle	23:57:32.544	99.8%	731453	41.650	117.919	335.035
nntp read	00:00:02.465	0.0%	730431	0.001	0.003	0.006
overview write	00:00:04.517	0.0%	27338	0.084	0.165	0.373
perl filter	00:01:49.432	0.1%	53318	1.068	2.052	3.569
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.492	0.0%	54686	0.000	0.009	0.038
TOTAL: 24:00:27.703	23:59:54.890	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.080	0.0%	35118	0.000	0.002	0.024
article prepare	00:00:00.001	0.0%	7650	0.000	0.000	0.013
article read	00:00:00.252	0.0%	1591	0.000	0.158	13.600
backlog stats	00:00:00.119	0.0%	296473	0.000	0.000	0.003
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.205	0.0%	227199	0.000	0.005	0.010
data write	00:00:01.767	0.0%	202175	0.004	0.009	0.015
idle	23:54:10.091	100.0%	296473	81.943	290.246	755.132
status file	00:00:00.099	0.0%	195	0.000	0.508	1.000
TOTAL: 23:54:17.318	23:54:13.614	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:02.960	0.0%	193359	0.006	0.015	0.034
idle	99:33:45.106	100.0%	224746	0.000	1594.801	600154.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:02.824	0.0%	450444	0.000	0.006	0.333
readart	00:00:00.006	0.0%	87	0.000	0.069	1.000
TOTAL: 99:35:08.162	99:33:50.896	100.0%	-	-	-	-

Control commands to INND:

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

Control Channel:

Sender	newgroup	rmgroup	Other	Bad PGP	DoIt	OK
153fishare@gmail.com	10	0	0	0	0	10
TOTAL	10	0	0	0	0	10

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	feeder.eternal-september.org	5	50143	6661	41088	2394	13%	25:26:32
2	au2pb.net	1	30742	5620	24122	1000	18%	24:41:09
3	xanadu-bbs.net	1	53648	4944	38445	10259	9%	23:52:16
4	news-out.mixmin.net	3	32344	3950	26339	2055	12%	24:09:32
5	newsfeed.neva.ru	140	68898	3066	55169	10663	4%	71:52:38
6	newsfeeds.xmission.com	1	27403	1693	25641	69	6%	22:38:36
7	newsfeed.fu-berlin.de	33	15671	660	14865	146	4%	16:53:18
8	nntp.pasdenom.info	5	32546	453	32024	69	1%	23:02:25
9	news.swapon.de	2	2576	432	2119	25	16%	22:37:36
10	localhost	49	14079	0	14079	0	0%	00:01:03
TOTAL: 10		240	328050	27479	273891	26680	8%	255:15:05

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	feeder.eternal-september.org	18.7 MB	27.6 KB	19.5 MB	38.2 MB	48%	4.3 KB
2	xanadu-bbs.net	13.9 MB	0.0 KB	141.3 MB	155.1 MB	8%	10.4 KB
3	au2pb.net	13.6 MB	43.4 KB	5.7 MB	19.3 MB	70%	3.0 KB
4	news-out.mixmin.net	10.6 MB	53.2 KB	6.3 MB	17.0 MB	62%	2.9 KB
5	newsfeed.neva.ru	8.7 MB	0.0 KB	83.0 MB	91.7 MB	9%	6.8 KB
6	newsfeeds.xmission.com	5.1 MB	0.0 KB	1.2 MB	6.3 MB	81%	3.7 KB
7	newsfeed.fu-berlin.de	1.5 MB	0.0 KB	342.7 KB	1.9 MB	82%	2.4 KB
8	news.swapon.de	1.1 MB	0.0 KB	61.0 KB	1.2 MB	94%	2.6 KB
9	nntp.pasdenom.info	967.5 KB	1.7 KB	277.2 KB	1.2 MB	77%	2.4 KB
10	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 10		74.2 MB	125.9 KB	257.6 MB	331.9 MB	22%	6.3 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Aug 25 04:15:00 - 04:59:59	361	1.3%	0.13	1.1 MB	1.5%	0.43
Aug 25 05:00:00 - 05:59:59	536	2.0%	0.15	1.4 MB	1.9%	0.40
Aug 25 06:00:00 - 06:59:59	816	3.0%	0.23	2.2 MB	2.9%	0.62
Aug 25 07:00:00 - 07:59:59	1105	4.0%	0.31	2.9 MB	3.9%	0.83
Aug 25 08:00:00 - 08:59:59	1224	4.5%	0.34	3.5 MB	4.8%	1.01
Aug 25 09:00:00 - 09:59:59	1393	5.1%	0.39	4.7 MB	6.3%	1.32
Aug 25 10:00:00 - 10:59:59	1389	5.1%	0.39	3.4 MB	4.5%	0.95
Aug 25 11:00:00 - 11:59:59	1290	4.7%	0.36	3.4 MB	4.5%	0.95
Aug 25 12:00:00 - 12:59:59	1477	5.4%	0.41	3.8 MB	5.1%	1.07
Aug 25 13:00:00 - 13:59:59	1349	4.9%	0.37	3.4 MB	4.6%	0.97
Aug 25 14:00:00 - 14:59:59	1464	5.4%	0.41	3.5 MB	4.7%	1.00
Aug 25 15:00:00 - 15:59:59	1608	5.9%	0.45	4.1 MB	5.5%	1.16
Aug 25 16:00:00 - 16:59:59	1632	6.0%	0.45	4.4 MB	6.0%	1.26
Aug 25 17:00:00 - 17:59:59	1539	5.6%	0.43	4.0 MB	5.3%	1.12
Aug 25 18:00:00 - 18:59:59	1539	5.6%	0.43	3.9 MB	5.2%	1.10
Aug 25 19:00:00 - 19:59:59	1433	5.2%	0.40	3.9 MB	5.2%	1.10
Aug 25 20:00:00 - 20:59:59	1479	5.4%	0.41	3.9 MB	5.3%	1.11
Aug 25 21:00:00 - 21:59:59	1333	4.9%	0.37	3.5 MB	4.7%	0.99
Aug 25 22:00:00 - 22:59:59	964	3.5%	0.27	2.6 MB	3.5%	0.73
Aug 25 23:00:00 - 23:59:59	792	2.9%	0.22	2.2 MB	3.0%	0.63
Aug 26 00:00:00 - 00:59:59	718	2.6%	0.20	2.2 MB	3.0%	0.63
Aug 26 01:00:00 - 01:59:59	619	2.3%	0.17	1.9 MB	2.6%	0.55
Aug 26 02:00:00 - 02:59:59	548	2.0%	0.15	2.0 MB	2.7%	0.56
Aug 26 03:00:00 - 03:59:59	562	2.1%	0.16	1.6 MB	2.2%	0.46
Aug 26 04:00:00 - 04:15:00	182	0.7%	0.20	557.1 KB	0.7%	0.62
TOTAL: 24:00:00	27352	100.0%	0.32	73.9 MB	100.0%	0.88

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	newsfeed.neva.ru	10776	1784	0	8992
2	xanadu-bbs.net	10331	973	0	9358
3	feeder.eternal-september.org	2403	301	1	2101
4	news-out.mixmin.net	2104	18	3	2083
5	au2pb.net	997	932	4	61
6	newsfeed.fu-berlin.de	343	18	0	325
7	news.swapon.de	115	0	0	115
8	newsfeeds.xmission.com	77	59	0	18
9	nntp.pasdenom.info	53	43	0	10
TOTAL: 9		27199	4128	8	23063

Unwanted newsgroups [Top 20]:

Newsgroup	Count
fa.linux.kernel	874
lada.talk	202
mailing.freebsd.pkg-fallout	192
ut.test	177
mailing.freebsd.svn-ports-all	136
lada.auto	134
mailing.freebsd.svn-ports-head	131
alt.politics	128
alt.survival	106
it-alt.sport.calcio.juventus	98
alt.job	73
alt.politics.scorched-earth	69
mailing.freebsd.ports-bugs	64
mailing.openbsd.ports-changes	58
mailing.database.pgsql-general	58
pld.cvs.commit	55
free.it.calcio.juventus	52
mailing.gcc.gcc-cvs	46
mailing.openbsd.source-changes	45
fa.openbsd.source-changes	45
TOTAL: 272	4128

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	17796
EMP (phn path)	2778
EMP (phl)	877
EMP (phn nph)	153
PFM bot misc	113
HTML Multipart	58
Too many newsgroups	40
Binary Image: misplaced jpg	18
HTML Image Tags	3
HTML post	3
UUencoded txt	2
EMP (fsl)	1
Binary Payload	1
Too many newsgroups (meow)	1
Binary: non-binary distribution	1
TOTAL: 15	21845

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Huge articles
	xanadu-bbs.net	664
	news-out.mixmin.net	51
	feeder.eternal-september.org	43
	au2pb.net	29
	newsfeeds.xmission.com	12
	TOTAL: 5	799
Including strange strings
	newsfeed.fu-berlin.de	192
	news.swapon.de	90
	feeder.eternal-september.org	54
	news-out.mixmin.net	43
	xanadu-bbs.net	19
	au2pb.net	13
	newsfeed.neva.ru	4
	newsfeeds.xmission.com	4
	TOTAL: 8	419
TOTAL: 2		1218

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	usenet.pasdenom.info	31624	241	25764	952	0	7677	0%	23:59:57
2	au2pb	22912	212	21362	239	0	2	0%	23:59:58
3	xanadu-bbs	23599	86	22283	31	0	6	0%	23:59:58
4	fu-berlin.de	25587	38	25524	21	0	4	0%	23:59:57
5	news.mixmin.net	23968	15	23221	13	0	4	0%	23:59:39
6	xmission	30902	13	25466	3	0	114	0%	23:59:58
7	neva.ru	24967	3	24053	40	0	49	0%	23:59:57
8	eternal-september	21412	2	20341	5	1	6	0%	23:59:49
9	news.swapon.de	2208	0	2186	2	0	0	0%	23:52:20
TOTAL: 9		207179	610	190200	1306	1	7862	0%	215:51:33

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	au2pb	927.4 KB	811.6 KB	1.7 MB	3.9 KB	23:59:58
2	usenet.pasdenom.info	834.9 KB	1.8 MB	2.6 MB	2.2 KB	23:59:57
3	xanadu-bbs	524.3 KB	57.0 KB	581.4 KB	5.0 KB	23:59:58
4	fu-berlin.de	436.2 KB	24.0 KB	460.2 KB	7.8 KB	23:59:57
5	news.mixmin.net	80.7 KB	29.8 KB	110.5 KB	3.9 KB	23:59:39
6	xmission	46.0 KB	39.4 KB	85.3 KB	5.3 KB	23:59:58
7	eternal-september	9.8 KB	7.2 KB	17.0 KB	2.4 KB	23:59:49
8	neva.ru	8.8 KB	167.6 KB	176.4 KB	4.1 KB	23:59:57
9	news.swapon.de	0.0 KB	4.6 KB	4.6 KB	2.3 KB	23:52:20
TOTAL: 9		2.8 MB	2.9 MB	5.7 MB	3.0 KB	215:51:33

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	202.89.176.220	288	87	294.3 KB	78	0	0	04:22:40
TOTAL: 1		288	87	294.3 KB	78	0	0	99:35:04

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	unresolved	323	87	294.3 KB	78	53:44:44
2	*.tampfl.dsl-w.verizon.net	11	0	0.0 KB	0	01:13:36
3	*.dynamic.caiway.nl	8	0	0.0 KB	0	41:08:20
4	*.nielsenmedia.com	9	0	0.0 KB	0	01:07:39
5	*.chello.nl	7	0	0.0 KB	0	02:20:21
6	*.br.br.cox.net	1	0	0.0 KB	0	00:00:22
TOTAL: 6		359	87	294.3 KB	78	99:35:04

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
041-020-158-163.dynamic.caiway.nl	3.487	5.760	0.000	41:08:20
71.94.21.184	1.207	1.475	0.000	24:59:21
162.212.88.198	0.767	0.392	0.000	24:22:40
202.89.176.220	28.453	5.607	0.705	04:22:40
dhcp-089-099-203-254.chello.nl	0.571	0.080	0.000	02:20:21
pool-71-98-160-84.tampfl.dsl-w.verizon.net	0.938	0.163	0.000	01:13:36
challenger.nielsenmedia.com	0.661	0.138	0.000	01:07:39
ip70-172-227-76.br.br.cox.net	0.104	0.015	0.000	00:00:22
69.160.37.54	1.826	0.386	0.000	00:00:02
TOTAL: 9	38.014	14.016	0.705	99:35:04

Curious NNRP server explorers [Top 20]:

System	Conn
69.160.37.54	25
pool-71-98-160-84.tampfl.dsl-w.verizon.net	11
challenger.nielsenmedia.com	9
162.212.88.198	8
041-020-158-163.dynamic.caiway.nl	8
dhcp-089-099-203-254.chello.nl	7
71.94.21.184	2
ip70-172-227-76.br.br.cox.net	1
TOTAL: 8	71

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
041-020-158-163.dynamic.caiway.nl	8	0
dhcp-089-099-203-254.chello.nl	4	0
challenger.nielsenmedia.com	2	0
pool-71-98-160-84.tampfl.dsl-w.verizon.net	2	0
71.94.21.184	2	0
TOTAL: 5	18	0

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	comp.arch	65
2	comp.os.vms	16
3	comp.ai.neural-nets	3
4	comp.ai.philosophy	2
5	comp.os.os2.misc	1
TOTAL: 5		87

Daily Usenet report for csiph.com

Aug 25 04:15:00 -- Aug 26 04:15:00