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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	48274	48.0%	7.1 MB	59.9%
nnrpd	31873	31.7%	2.6 MB	22.2%
innd	18528	18.4%	1.8 MB	15.4%
innfeed	1895	1.9%	298.5 KB	2.5%
controlchan	3	0.0%	0.3 KB	0.0%
TOTAL: 5	100573	100.0%	11.9 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	263359	47.4%
Negative hits	239978	43.2%
Do not exist	47361	8.5%
Cache misses	4637	0.8%
TOTAL: 4	555335	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.425	0.0%	197	0.000	2.157	33.000
article cleanup	00:00:00.264	0.0%	46352	0.000	0.006	0.022
article logging	00:00:00.585	0.0%	46828	0.000	0.012	0.033
article parse	00:00:02.812	0.0%	320691	0.002	0.009	0.017
article write	00:00:06.482	0.0%	27393	0.150	0.237	0.385
artlog/artcncl	00:00:00.003	0.0%	161	0.000	0.019	1.000
artlog/artparse	00:00:00.011	0.0%	1282	0.000	0.009	0.250
data move	00:00:00.318	0.0%	789192	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.005	0.0%	196	0.000	0.026	1.000
hishave/artcncl	00:00:00.000	0.0%	197	0.000	0.000	0.000
hishave/artparse	00:00:00.006	0.0%	1282	0.000	0.005	1.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:01.329	0.0%	556749	0.001	0.002	0.008
history sync	00:00:00.458	0.0%	309	0.000	1.482	3.000
history write	00:00:11.797	0.0%	46351	0.063	0.255	0.328
hiswrite/artcncl	00:00:00.000	0.0%	1	0.000	0.000	0.000
hiswrite/artparse	00:00:00.337	0.0%	1282	0.000	0.263	2.000
idle	23:57:53.752	99.8%	774286	28.774	111.424	336.574
nntp read	00:00:02.620	0.0%	772968	0.001	0.003	0.006
overview write	00:00:04.439	0.0%	27393	0.097	0.162	0.343
perl filter	00:01:25.558	0.1%	46351	1.035	1.846	3.894
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.524	0.0%	54787	0.000	0.010	0.032
TOTAL: 24:00:29.254	23:59:51.725	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.069	0.0%	27041	0.000	0.003	0.022
article prepare	00:00:00.000	0.0%	7560	0.000	0.000	0.000
article read	00:00:00.329	0.0%	1534	0.000	0.214	11.500
backlog stats	00:00:00.101	0.0%	304652	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.237	0.0%	232974	0.001	0.005	0.011
data write	00:00:01.738	0.0%	208603	0.002	0.008	0.019
idle	23:43:07.930	100.0%	304652	155.892	280.280	612.373
status file	00:00:00.089	0.0%	172	0.000	0.517	1.000
TOTAL: 23:43:18.165	23:43:11.493	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:00.096	0.0%	3970	0.008	0.024	0.059
idle	24:57:45.828	99.9%	35314	0.000	2544.765	600204.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.464	0.0%	71449	0.000	0.006	0.500
readart	00:00:00.097	0.0%	51	0.000	1.902	47.000
TOTAL: 24:59:04.505	24:57:46.485	99.9%	-	-	-	-

Control commands to INND:

Command	Number
L	1
flush	4
flushlogs	2
go	2
logmode	2
mode	146
newgroup	1
pause	2
paused	2
reload	2
reserve	2
TOTAL: 11	166

Newsgroups created:

Group	Mode
alt.binaries.3d.daz-studio	y
TOTAL	1

Control Channel:

Sender	newgroup	rmgroup	Other	Bad PGP	DoIt	OK
ignore@domain.com	1	0	0	0	1	1
TOTAL	1	0	0	0	1	1

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	feeder.eternal-september.org	5	41997	7539	32345	2113	17%	23:44:25
2	xanadu-bbs.net	1	47629	5459	34000	8170	11%	24:05:40
3	au2pb.net	2	29819	3841	25188	790	12%	23:29:55
4	news-out.mixmin.net	5	32720	3197	27686	1837	9%	24:15:14
5	newsfeed.neva.ru	148	57421	3144	47430	6847	5%	71:52:38
6	newsfeeds.xmission.com	3	27802	2013	25723	66	7%	23:25:09
7	newsfeed.fu-berlin.de	63	31957	1196	30429	332	3%	35:09:12
8	nntp.pasdenom.info	6	34652	545	34029	78	1%	29:08:18
9	news.swapon.de	1	2764	354	2390	20	12%	24:47:49
10	localhost	50	14502	0	14502	0	0%	00:01:03
TOTAL: 10		284	321263	27288	273722	20253	8%	279:59:23

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	feeder.eternal-september.org	21.6 MB	0.0 KB	11.8 MB	33.4 MB	64%	3.5 KB
2	xanadu-bbs.net	15.7 MB	0.0 KB	243.5 MB	259.2 MB	6%	19.5 KB
3	au2pb.net	11.1 MB	40.8 KB	5.0 MB	16.1 MB	68%	3.6 KB
4	news-out.mixmin.net	9.8 MB	0.0 KB	7.0 MB	16.8 MB	58%	3.4 KB
5	newsfeed.neva.ru	9.5 MB	0.0 KB	40.1 MB	49.6 MB	19%	5.1 KB
6	newsfeeds.xmission.com	5.6 MB	0.0 KB	1.2 MB	6.9 MB	82%	3.4 KB
7	newsfeed.fu-berlin.de	2.8 MB	0.0 KB	841.3 KB	3.7 MB	77%	2.5 KB
8	nntp.pasdenom.info	1.1 MB	0.0 KB	295.2 KB	1.4 MB	79%	2.3 KB
9	news.swapon.de	891.6 KB	0.0 KB	211.3 KB	1.1 MB	80%	2.9 KB
10	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 10		78.1 MB	40.8 KB	310.0 MB	388.1 MB	20%	8.4 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Sep 3 04:15:00 - 04:59:59	459	1.7%	0.17	1.5 MB	1.9%	0.57
Sep 3 05:00:00 - 05:59:59	689	2.5%	0.19	2.3 MB	2.9%	0.64
Sep 3 06:00:00 - 06:59:59	869	3.2%	0.24	2.6 MB	3.4%	0.75
Sep 3 07:00:00 - 07:59:59	1186	4.3%	0.33	3.3 MB	4.2%	0.93
Sep 3 08:00:00 - 08:59:59	1178	4.3%	0.33	3.0 MB	3.9%	0.86
Sep 3 09:00:00 - 09:59:59	1229	4.5%	0.34	3.0 MB	3.8%	0.86
Sep 3 10:00:00 - 10:59:59	1304	4.8%	0.36	3.5 MB	4.5%	1.00
Sep 3 11:00:00 - 11:59:59	1391	5.1%	0.39	3.7 MB	4.7%	1.06
Sep 3 12:00:00 - 12:59:59	1337	4.9%	0.37	3.6 MB	4.6%	1.03
Sep 3 13:00:00 - 13:59:59	1462	5.3%	0.41	3.8 MB	4.8%	1.07
Sep 3 14:00:00 - 14:59:59	1681	6.1%	0.47	5.5 MB	7.0%	1.56
Sep 3 15:00:00 - 15:59:59	1529	5.6%	0.42	4.3 MB	5.5%	1.22
Sep 3 16:00:00 - 16:59:59	1598	5.8%	0.44	4.6 MB	5.9%	1.32
Sep 3 17:00:00 - 17:59:59	1517	5.5%	0.42	4.1 MB	5.2%	1.16
Sep 3 18:00:00 - 18:59:59	1536	5.6%	0.43	4.1 MB	5.2%	1.17
Sep 3 19:00:00 - 19:59:59	1361	5.0%	0.38	3.8 MB	4.8%	1.07
Sep 3 20:00:00 - 20:59:59	1391	5.1%	0.39	4.0 MB	5.1%	1.14
Sep 3 21:00:00 - 21:59:59	1315	4.8%	0.37	3.9 MB	4.9%	1.10
Sep 3 22:00:00 - 22:59:59	1049	3.8%	0.29	3.2 MB	4.0%	0.90
Sep 3 23:00:00 - 23:59:59	732	2.7%	0.20	2.2 MB	2.7%	0.61
Sep 4 00:00:00 - 00:59:59	734	2.7%	0.20	2.2 MB	2.8%	0.63
Sep 4 01:00:00 - 01:59:59	563	2.1%	0.16	1.6 MB	2.1%	0.46
Sep 4 02:00:00 - 02:59:59	559	2.0%	0.16	2.4 MB	3.0%	0.67
Sep 4 03:00:00 - 03:59:59	561	2.0%	0.16	1.9 MB	2.4%	0.54
Sep 4 04:00:00 - 04:15:00	175	0.6%	0.19	517.9 KB	0.6%	0.58
TOTAL: 24:00:00	27405	100.0%	0.32	78.5 MB	100.0%	0.93

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	xanadu-bbs.net	8180	847	0	7333
2	newsfeed.neva.ru	6833	1440	0	5393
3	feeder.eternal-september.org	2180	286	0	1894
4	news-out.mixmin.net	1854	9	0	1845
5	au2pb.net	804	744	1	59
6	newsfeed.fu-berlin.de	658	28	0	630
7	newsfeeds.xmission.com	79	56	0	23
8	nntp.pasdenom.info	77	71	0	6
9	news.swapon.de	44	0	0	44
TOTAL: 9		20709	3481	1	17227

Unwanted newsgroups [Top 20]:

Newsgroup	Count
fa.linux.kernel	634
lada.talk	251
ut.test	205
mailing.freebsd.svn-ports-all	129
mailing.freebsd.svn-ports-head	126
alt.politics	123
alt.politics.scorched-earth	89
lada.auto	84
it-alt.sport.calcio.juventus	72
mailing.freebsd.pkg-fallout	65
mailing.gcc.gcc-cvs	54
mozilla.general	49
mailing.openbsd.source-changes	44
mailing.freebsd.ports-bugs	41
fa.freebsd.cvs-all	37
mailing.freebsd.svn-src-all	37
alt.windows7.general	33
fa.openbsd.source-changes	32
alt.job	30
mpc.lists.freebsd.ports.bugs	28
TOTAL: 267	3481

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	11663
EMP (phn path)	2390
EMP (phl)	731
EMP (phn nph)	274
PFM bot misc	242
Too many newsgroups	89
HTML Multipart	49
Binary Image: misplaced jpg	19
HTML Image Tags	6
HTML post	2
Too many newsgroups (meow)	2
Binary Payload	1
TOTAL: 12	15468

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Huge articles
	xanadu-bbs.net	1132
	news-out.mixmin.net	65
	feeder.eternal-september.org	39
	au2pb.net	32
	newsfeeds.xmission.com	12
	news.swapon.de	2
	newsfeed.fu-berlin.de	2
	TOTAL: 7	1284
Including strange strings
	newsfeed.fu-berlin.de	342
	xanadu-bbs.net	40
	feeder.eternal-september.org	28
	news.swapon.de	24
	news-out.mixmin.net	17
	newsfeeds.xmission.com	11
	au2pb.net	9
	newsfeed.neva.ru	3
	nntp.pasdenom.info	1
	TOTAL: 9	475
TOTAL: 2		1759

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	usenet.pasdenom.info	34113	375	25650	935	3	1%	23:59:47
2	au2pb	24776	165	23186	152	0	0%	23:59:53
3	xanadu-bbs	23386	83	21824	45	8	0%	23:59:53
4	xmission	30449	37	25168	4	0	0%	23:59:53
5	fu-berlin.de	25869	32	25813	24	0	0%	23:59:51
6	news.mixmin.net	24991	9	24094	21	0	0%	23:59:51
7	eternal-september	20594	6	19357	0	0	0%	23:59:53
8	neva.ru	25229	2	24067	35	0	0%	23:59:45
9	news.swapon.de	2383	1	2356	5	0	0%	23:59:51
TOTAL: 9		211790	710	191515	1221	11	0%	215:58:37

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	usenet.pasdenom.info	1.3 MB	2.3 MB	3.5 MB	2.7 KB	23:59:47
2	au2pb	752.7 KB	677.4 KB	1.4 MB	4.5 KB	23:59:53
3	xanadu-bbs	522.8 KB	85.4 KB	608.2 KB	4.8 KB	23:59:53
4	fu-berlin.de	411.7 KB	30.8 KB	442.5 KB	7.9 KB	23:59:51
5	xmission	121.2 KB	88.6 KB	209.9 KB	5.1 KB	23:59:53
6	news.mixmin.net	53.5 KB	59.2 KB	112.7 KB	3.8 KB	23:59:51
7	eternal-september	28.8 KB	0.0 KB	28.8 KB	4.8 KB	23:59:53
8	neva.ru	8.1 KB	197.8 KB	205.8 KB	5.6 KB	23:59:45
9	news.swapon.de	5.2 KB	11.1 KB	16.2 KB	2.7 KB	23:59:51
TOTAL: 9		3.1 MB	3.4 MB	6.5 MB	3.4 KB	215:58:37

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Elapsed
1	202.89.176.220	288	41	122.0 KB	40	04:26:07
2	challenger.nielsenmedia.com	8	6	11.2 KB	2	01:49:27
3	pool-71-98-160-84.tampfl.dsl-w.verizon.net	7	4	7.8 KB	3	02:07:02
TOTAL: 3		303	51	140.9 KB	45	24:59:00

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	unresolved	325	41	122.0 KB	40	12:11:54
2	*.nielsenmedia.com	8	6	11.2 KB	2	01:49:27
3	*.tampfl.dsl-w.verizon.net	7	4	7.8 KB	3	02:07:02
4	*.chello.nl	17	0	0.0 KB	0	07:50:13
5	*.bbox.io	3	0	0.0 KB	0	00:30:17
6	*.tu.ok.cox.net	1	0	0.0 KB	0	00:30:05
TOTAL: 6		361	51	140.9 KB	45	24:59:00

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
dhcp-089-099-203-254.chello.nl	1.334	0.277	0.000	07:50:13
162.212.88.198	1.019	0.354	0.000	07:45:45
202.89.176.220	26.119	5.950	0.696	04:26:07
pool-71-98-160-84.tampfl.dsl-w.verizon.net	0.707	0.119	0.000	02:07:02
challenger.nielsenmedia.com	0.948	0.148	0.000	01:49:27
tempe0.bbox.io	0.221	0.063	0.000	00:30:17
ip72-222-107-224.tu.ok.cox.net	0.101	0.008	0.000	00:30:05
69.160.37.54	2.038	0.342	0.000	00:00:02
TOTAL: 8	32.487	7.261	0.696	24:59:00

Curious NNRP server explorers [Top 20]:

System	Conn
69.160.37.54	25
dhcp-089-099-203-254.chello.nl	17
162.212.88.198	12
tempe0.bbox.io	3
ip72-222-107-224.tu.ok.cox.net	1
TOTAL: 5	58

NNRP client timeouts [Top 20]:

System	Conn	Peer
dhcp-089-099-203-254.chello.nl	15	0
162.212.88.198	4	0
pool-71-98-160-84.tampfl.dsl-w.verizon.net	3	0
challenger.nielsenmedia.com	3	0
ip72-222-107-224.tu.ok.cox.net	1	0
tempe0.bbox.io	1	0
TOTAL: 6	27	0

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	comp.os.vms	19
2	comp.sys.ibm.pc.games.action	10
3	comp.lang.awk	9
4	comp.arch.embedded	2
5	comp.arch	2
6	comp.ai.neural-nets	1
7	comp.sys.ibm.pc.hardware.networking	1
8	comp.sys.ibm.as400.misc	1
9	comp.sys.ibm.pc.games.rpg	1
10	comp.sys.ibm.pc.games.war-historical	1
11	comp.answers	1
12	comp.ai.genetic	1
13	comp.ai.edu	1
TOTAL: 13		50

Daily Usenet report for csiph.com

Sep 3 04:15:00 -- Sep 4 04:15:00