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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	44013	45.5%	6.6 MB	57.8%
nnrpd	32466	33.5%	2.7 MB	23.7%
innd	18456	19.1%	1.8 MB	16.0%
innfeed	1843	1.9%	287.6 KB	2.5%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 5	96779	100.0%	11.4 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	225903	48.1%
Negative hits	200444	42.6%
Do not exist	43293	9.2%
Cache misses	421	0.1%
TOTAL: 4	470061	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.462	0.0%	222	0.000	2.081	22.000
article cleanup	00:00:00.239	0.0%	38890	0.000	0.006	0.019
article logging	00:00:00.583	0.0%	39354	0.000	0.015	0.047
article parse	00:00:11.102	0.0%	1040294	0.003	0.011	0.779
article write	00:01:13.091	0.1%	24033	0.180	3.041	9.580
artlog/artcncl	00:00:00.002	0.0%	145	0.000	0.014	0.500
artlog/artparse	00:00:00.047	0.0%	4483	0.000	0.010	0.500
data move	00:00:00.785	0.0%	1460010	0.000	0.001	0.002
hisgrep/artcncl	00:00:00.043	0.0%	217	0.000	0.198	10.000
hishave/artcncl	00:00:00.002	0.0%	222	0.000	0.009	0.125
hishave/artparse	00:00:00.014	0.0%	4483	0.000	0.003	0.091
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:05.321	0.0%	466188	0.001	0.011	0.077
history sync	00:00:02.776	0.0%	350	0.000	7.931	87.000
history write	00:00:57.299	0.1%	38877	0.033	1.474	13.743
hiswrite/artcncl	00:00:00.000	0.0%	5	0.000	0.000	0.000
hiswrite/artparse	00:00:03.474	0.0%	4482	0.000	0.775	908.000
idle	23:55:17.571	99.6%	1418522	12.582	60.709	428.803
nntp read	00:00:04.215	0.0%	1421346	0.001	0.003	0.006
overview write	00:01:09.574	0.1%	24033	0.138	2.895	15.961
perl filter	00:01:07.920	0.1%	38877	0.922	1.747	3.466
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.426	0.0%	48066	0.000	0.009	0.029
TOTAL: 24:00:49.218	24:00:14.946	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.088	0.0%	23977	0.000	0.004	0.027
article prepare	00:00:00.000	0.0%	4612	0.000	0.000	0.000
article read	00:00:00.298	0.0%	959	0.000	0.311	15.000
backlog stats	00:00:00.108	0.0%	263163	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.120	0.0%	204856	0.001	0.005	0.019
data write	00:00:01.381	0.0%	183376	0.001	0.008	0.016
idle	23:54:40.694	100.0%	263163	193.872	327.100	1206.783
status file	00:00:00.081	0.0%	176	0.000	0.460	1.000
TOTAL: 23:54:47.655	23:54:43.770	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:01.700	0.0%	35276	0.000	0.048	1.000
idle	125:56:07.353	99.9%	66800	1.000	6786.936	600169.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.769	0.0%	134701	0.000	0.006	0.071
readart	00:00:00.013	0.0%	105	0.000	0.124	4.000
TOTAL: 126:05:45.350	125:56:09.835	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	26166	6092	19330	744	23%	24:15:08
2	feeder.eternal-september.org	1	36147	5937	28512	1698	16%	24:34:03
3	news-out.mixmin.net	3	30185	4163	22878	3144	13%	25:20:54
4	newsfeeds.xmission.com	1	23004	2813	19719	472	12%	22:48:46
5	newsfeed.neva.ru	143	52149	1718	47074	3357	3%	72:17:18
6	xanadu-bbs.net	9	42605	1533	31478	9594	3%	28:28:53
7	newsfeed.fu-berlin.de	27	25409	1213	24032	164	4%	26:14:41
8	nntp.pasdenom.info	3	23709	247	23392	70	1%	24:09:14
9	news.swapon.de	2	2268	173	2085	10	7%	23:49:42
10	localhost	26	0	0	0	0	0%	00:00:00
TOTAL: 10		216	261642	23889	218500	19253	9%	271:58:39

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	feeder.eternal-september.org	16.3 MB	3.4 KB	24.5 MB	40.7 MB	39%	5.5 KB
2	au2pb.net	15.3 MB	3.4 KB	6.7 MB	22.0 MB	69%	3.3 KB
3	news-out.mixmin.net	15.3 MB	12.0 KB	6.8 MB	22.1 MB	69%	3.1 KB
4	newsfeeds.xmission.com	8.5 MB	0.0 KB	6.1 MB	14.5 MB	58%	4.5 KB
5	newsfeed.neva.ru	5.1 MB	135.4 KB	19.4 MB	24.6 MB	20%	5.0 KB
6	xanadu-bbs.net	5.0 MB	16.3 KB	1.5 GB	1.5 GB	0%	138.8 KB
7	newsfeed.fu-berlin.de	2.7 MB	0.0 KB	444.8 KB	3.1 MB	85%	2.3 KB
8	nntp.pasdenom.info	533.9 KB	0.0 KB	1.3 MB	1.8 MB	29%	5.8 KB
9	news.swapon.de	446.8 KB	0.0 KB	23.9 KB	470.7 KB	94%	2.6 KB
10	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 10		69.1 MB	170.5 KB	1.5 GB	1.6 GB	4%	38.9 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Dec 13 04:15:00 - 04:59:59	246	1.0%	0.09	737.6 KB	1.0%	0.27
Dec 13 05:00:00 - 05:59:59	413	1.7%	0.11	1.3 MB	1.9%	0.38
Dec 13 06:00:00 - 06:59:59	449	1.9%	0.12	1.5 MB	2.1%	0.42
Dec 13 07:00:00 - 07:59:59	528	2.2%	0.15	1.5 MB	2.2%	0.43
Dec 13 08:00:00 - 08:59:59	826	3.4%	0.23	2.7 MB	3.9%	0.78
Dec 13 09:00:00 - 09:59:59	820	3.4%	0.23	1.8 MB	2.6%	0.51
Dec 13 10:00:00 - 10:59:59	1104	4.6%	0.31	2.7 MB	3.9%	0.78
Dec 13 11:00:00 - 11:59:59	1034	4.3%	0.29	2.5 MB	3.6%	0.72
Dec 13 12:00:00 - 12:59:59	1029	4.3%	0.29	2.5 MB	3.6%	0.71
Dec 13 13:00:00 - 13:59:59	1075	4.5%	0.30	2.9 MB	4.2%	0.83
Dec 13 14:00:00 - 14:59:59	1064	4.4%	0.30	3.1 MB	4.4%	0.88
Dec 13 15:00:00 - 15:59:59	1319	5.5%	0.37	3.7 MB	5.3%	1.05
Dec 13 16:00:00 - 16:59:59	1318	5.5%	0.37	3.5 MB	5.0%	0.99
Dec 13 17:00:00 - 17:59:59	1299	5.4%	0.36	3.5 MB	5.0%	0.99
Dec 13 18:00:00 - 18:59:59	1312	5.5%	0.36	3.3 MB	4.7%	0.94
Dec 13 19:00:00 - 19:59:59	1496	6.2%	0.42	3.6 MB	5.2%	1.03
Dec 13 20:00:00 - 20:59:59	1446	6.0%	0.40	3.7 MB	5.3%	1.06
Dec 13 21:00:00 - 21:59:59	1311	5.4%	0.36	3.3 MB	4.7%	0.93
Dec 13 22:00:00 - 22:59:59	1208	5.0%	0.34	3.4 MB	4.9%	0.97
Dec 13 23:00:00 - 23:59:59	977	4.1%	0.27	3.0 MB	4.3%	0.85
Dec 14 00:00:00 - 00:59:59	682	2.8%	0.19	1.8 MB	2.6%	0.52
Dec 14 01:00:00 - 01:59:59	692	2.9%	0.19	2.0 MB	2.9%	0.58
Dec 14 02:00:00 - 02:59:59	889	3.7%	0.25	4.1 MB	5.8%	1.16
Dec 14 03:00:00 - 03:59:59	1169	4.9%	0.32	6.0 MB	8.6%	1.72
Dec 14 04:00:00 - 04:15:00	360	1.5%	0.40	1.7 MB	2.4%	1.90
TOTAL: 24:00:00	24066	100.0%	0.28	70.0 MB	100.0%	0.83

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	xanadu-bbs.net	9698	304	1	9393
2	newsfeed.neva.ru	3349	686	8	2655
3	news-out.mixmin.net	3147	6	2	3139
4	feeder.eternal-september.org	1722	192	1	1529
5	au2pb.net	752	662	1	89
6	newsfeed.fu-berlin.de	545	32	0	513
7	newsfeeds.xmission.com	478	412	0	66
8	nntp.pasdenom.info	69	55	0	14
9	news.swapon.de	42	0	0	42
TOTAL: 9		19802	2349	13	17440

Unwanted newsgroups [Top 20]:

Newsgroup	Count
fa.linux.kernel	253
ut.test	217
mailing.freebsd.ports-bugs	174
mailing.freebsd.pkg-fallout	136
alt.politics	127
lada.talk	109
it-alt.sport.calcio.juventus	86
mailing.freebsd.svn-ports-all	59
mailing.freebsd.svn-ports-head	57
pld.cvs.commit	46
mailing.openbsd.source-changes	42
alt.politics.scorched-earth	42
fa.freebsd.cvs-all	41
mailing.freebsd.svn-src-all	41
lada.auto	36
mailing.freebsd.kde	34
fa.netbsd.bugs	32
mailing.freebsd.svn-src-head	31
alt.survival	30
mozilla.general	27
TOTAL: 200	2349

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	8448
EMP (phn path)	2352
EMP (phl)	1082
EMP (phn nph)	247
PFM bot misc	113
Binary: misplaced rar	92
Too many newsgroups	75
HTML Multipart	28
Binary: misplaced rev	15
Binary Image: misplaced jpg	10
HTML post	8
HTML Image Tags	6
Binary: misplaced par2	6
Too many newsgroups (low_xpost)	5
Binary: misplaced cst	1
Binary Image: misplaced gif	1
Binary Image: misplaced png	1
User-issued spam cancel	1
U2 violation - invalid distribution	1
Binary: misplaced PAR2	1
TOTAL: 20	12493

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Huge articles
	xanadu-bbs.net	4192
	feeder.eternal-september.org	159
	newsfeeds.xmission.com	57
	au2pb.net	38
	news-out.mixmin.net	25
	nntp.pasdenom.info	11
	newsfeed.fu-berlin.de	1
	TOTAL: 7	4483
Including strange strings
	newsfeed.fu-berlin.de	371
	feeder.eternal-september.org	33
	news.swapon.de	32
	au2pb.net	17
	news-out.mixmin.net	9
	newsfeed.neva.ru	1
	nntp.pasdenom.info	1
	TOTAL: 7	464
TOTAL: 2		4947

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	usenet.pasdenom.info	28325	119	23039	659	2	0%	23:59:57
2	au2pb	18367	73	17819	75	0	0%	23:59:53
3	xanadu-bbs	24432	61	22413	58	6	0%	23:59:57
4	fu-berlin.de	22461	23	22422	15	0	0%	23:59:57
5	xmission	24137	13	20889	1	0	0%	23:59:57
6	eternal-september	19097	6	17649	3	0	0%	23:59:57
7	neva.ru	23904	6	22150	38	1	0%	23:59:10
8	news.mixmin.net	20753	2	19799	0	1	0%	23:59:57
9	news.swapon.de	2158	1	2114	0	0	0%	23:59:13
TOTAL: 9		183634	304	168294	849	10	0%	215:57:58

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	usenet.pasdenom.info	540.0 KB	1.3 MB	1.8 MB	2.4 KB	23:59:57
2	xanadu-bbs	417.2 KB	119.7 KB	536.9 KB	4.5 KB	23:59:57
3	au2pb	346.7 KB	283.0 KB	629.8 KB	4.3 KB	23:59:53
4	fu-berlin.de	137.2 KB	23.3 KB	160.5 KB	4.2 KB	23:59:57
5	neva.ru	38.1 KB	182.0 KB	220.1 KB	5.0 KB	23:59:10
6	xmission	24.8 KB	3.3 KB	28.0 KB	2.0 KB	23:59:57
7	eternal-september	23.9 KB	26.3 KB	50.2 KB	5.6 KB	23:59:57
8	news.mixmin.net	4.6 KB	0.0 KB	4.6 KB	2.3 KB	23:59:57
9	news.swapon.de	2.1 KB	0.0 KB	2.1 KB	2.1 KB	23:59:13
TOTAL: 9		1.5 MB	1.9 MB	3.4 MB	3.0 KB	215:57:58

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	202.89.176.220	288	105	310.2 KB	101	0	0	04:20:44
TOTAL: 1		288	105	310.2 KB	101	0	0	126:05:40

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	unresolved	438	105	310.2 KB	101	117:13:48
2	*.tampfl.dsl-w.verizon.net	7	0	0.0 KB	0	03:17:02
3	*.133.22.98.dynamic.ip.windstream.net	3	0	0.0 KB	0	02:02:34
4	*.bbox.io	2	0	0.0 KB	0	01:00:00
5	*.chello.nl	6	0	0.0 KB	0	02:32:14
TOTAL: 5		456	105	310.2 KB	101	126:05:40

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
63.142.120.8	8.806	3.095	0.000	94:26:17
216.246.166.29	1.966	0.953	0.000	18:16:24
202.89.176.220	30.499	6.220	0.743	04:20:44
pool-71-98-160-84.tampfl.dsl-w.verizon.net	0.592	0.110	0.000	03:17:02
dhcp-089-099-203-254.chello.nl	0.469	0.095	0.000	02:32:14
h29.133.22.98.dynamic.ip.windstream.net	0.275	0.093	0.000	02:02:34
tempe0.bbox.io	0.248	0.045	0.000	01:00:00
89.99.203.254	0.070	0.007	0.000	00:10:18
69.160.37.54	1.947	0.414	0.000	00:00:02
TOTAL: 9	44.872	11.032	0.743	126:05:40

Curious NNRP server explorers [Top 20]:

System	Conn
63.142.120.8	100
69.160.37.54	25
216.246.166.29	24
pool-71-98-160-84.tampfl.dsl-w.verizon.net	7
dhcp-089-099-203-254.chello.nl	6
h29.133.22.98.dynamic.ip.windstream.net	3
tempe0.bbox.io	2
89.99.203.254	1
TOTAL: 8	168

NNRP client timeouts [Top 20]:

System	Conn	Peer
63.142.120.8	50	0
pool-71-98-160-84.tampfl.dsl-w.verizon.net	6	0
dhcp-089-099-203-254.chello.nl	5	0
h29.133.22.98.dynamic.ip.windstream.net	3	0
tempe0.bbox.io	2	0
TOTAL: 5	66	0

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	comp.arch	46
2	comp.os.vms	24
3	comp.sys.ibm.pc.games.action	11
4	comp.ai.philosophy	9
5	comp.os.msdos.misc	7
6	comp.arch.embedded	2
7	comp.ai.neural-nets	2
8	comp.sys.ibm.as400.misc	1
9	comp.sys.ibm.pc.games.rpg	1
10	comp.answers	1
11	comp.sys.ibm.pc.hardware.storage	1
TOTAL: 11		105

Daily Usenet report for csiph.com

Dec 13 04:15:00 -- Dec 14 04:15:00