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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	42357	45.1%	6.2 MB	56.8%
nnrpd	31930	34.0%	2.6 MB	24.3%
innd	17830	19.0%	1.8 MB	16.4%
innfeed	1872	2.0%	271.1 KB	2.4%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 5	93990	100.0%	10.8 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	227602	47.2%
Negative hits	208982	43.4%
Do not exist	41644	8.6%
Cache misses	3784	0.8%
TOTAL: 4	482012	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.432	0.0%	335	0.000	1.290	36.000
article cleanup	00:00:00.255	0.0%	41057	0.000	0.006	0.028
article logging	00:00:00.532	0.0%	41444	0.000	0.013	0.041
article parse	00:00:01.862	0.0%	213488	0.003	0.009	0.022
article write	00:00:05.706	0.0%	23356	0.125	0.244	0.347
artlog/artcncl	00:00:00.004	0.0%	209	0.000	0.019	0.500
artlog/artparse	00:00:00.004	0.0%	717	0.000	0.006	0.143
data move	00:00:00.242	0.0%	611503	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.003	0.0%	314	0.000	0.010	0.125
hishave/artcncl	00:00:00.004	0.0%	335	0.000	0.012	1.000
hishave/artparse	00:00:00.000	0.0%	717	0.000	0.000	0.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:01.255	0.0%	482547	0.001	0.003	0.008
history sync	00:00:00.550	0.0%	336	0.000	1.637	3.333
history write	00:00:10.812	0.0%	41051	0.060	0.263	0.351
hiswrite/artcncl	00:00:00.001	0.0%	21	0.000	0.048	0.059
hiswrite/artparse	00:00:00.214	0.0%	714	0.000	0.300	3.000
idle	23:58:15.228	99.8%	602259	31.925	143.286	457.970
nntp read	00:00:02.053	0.0%	600791	0.001	0.003	0.005
overview write	00:00:04.046	0.0%	23356	0.103	0.173	0.360
perl filter	00:01:24.454	0.1%	41051	0.959	2.057	4.111
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.423	0.0%	46712	0.000	0.009	0.022
TOTAL: 24:00:38.337	24:00:08.080	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.056	0.0%	23305	0.000	0.002	0.023
article prepare	00:00:00.001	0.0%	5948	0.000	0.000	0.007
article read	00:00:00.175	0.0%	1063	0.000	0.165	9.000
backlog stats	00:00:00.089	0.0%	265157	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.071	0.0%	202422	0.002	0.005	0.013
data write	00:00:01.516	0.0%	180352	0.002	0.008	0.016
idle	23:53:40.870	100.0%	265157	196.297	324.415	826.496
status file	00:00:00.081	0.0%	185	0.000	0.438	1.000
TOTAL: 23:53:48.213	23:53:43.859	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:00.117	0.0%	8330	0.000	0.014	0.043
idle	21:58:09.565	99.9%	39743	0.000	1990.025	600123.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.543	0.0%	80456	0.000	0.007	0.167
readart	00:00:00.011	0.0%	93	0.000	0.118	1.000
TOTAL: 21:59:16.347	21:58:10.236	99.9%	-	-	-	-

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	feeder.eternal-september.org	2	38321	6165	29906	2250	16%	24:13:34
2	au2pb.net	1	25305	5039	19581	685	19%	25:04:14
3	xanadu-bbs.net	1	41441	3625	30457	7359	8%	23:55:25
4	news-out.mixmin.net	4	28877	3338	22811	2728	11%	24:12:23
5	newsfeeds.xmission.com	1	24315	1959	22170	186	8%	25:52:46
6	newsfeed.neva.ru	155	50178	1578	43626	4974	3%	72:02:22
7	newsfeed.fu-berlin.de	42	25659	1030	24388	241	4%	29:01:33
8	nntp.pasdenom.info	3	33267	715	32468	84	2%	34:41:45
9	news.swapon.de	1	2295	204	2077	14	8%	22:32:48
10	localhost	48	13533	0	13533	0	0%	00:00:59
TOTAL: 10		258	283191	23653	241017	18521	8%	281:37:49

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	feeder.eternal-september.org	16.8 MB	21.6 KB	14.1 MB	30.9 MB	54%	3.8 KB
2	au2pb.net	13.3 MB	33.0 KB	3.3 MB	16.7 MB	79%	3.0 KB
3	news-out.mixmin.net	11.1 MB	32.9 KB	8.3 MB	19.4 MB	57%	3.3 KB
4	xanadu-bbs.net	9.9 MB	0.0 KB	110.7 MB	120.6 MB	8%	11.2 KB
5	newsfeeds.xmission.com	5.7 MB	11.5 KB	845.7 KB	6.5 MB	87%	3.1 KB
6	newsfeed.neva.ru	5.2 MB	0.0 KB	44.4 MB	49.5 MB	10%	7.7 KB
7	newsfeed.fu-berlin.de	2.3 MB	0.0 KB	748.1 KB	3.0 MB	75%	2.4 KB
8	nntp.pasdenom.info	1.6 MB	0.0 KB	1.1 MB	2.8 MB	58%	3.5 KB
9	news.swapon.de	525.3 KB	0.0 KB	134.4 KB	659.7 KB	79%	3.0 KB
10	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 10		66.4 MB	99.0 KB	183.6 MB	250.1 MB	26%	6.1 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Sep 20 04:15:00 - 04:59:59	359	1.5%	0.13	1.1 MB	1.7%	0.43
Sep 20 05:00:00 - 05:59:59	532	2.3%	0.15	1.6 MB	2.4%	0.45
Sep 20 06:00:00 - 06:59:59	564	2.4%	0.16	1.5 MB	2.3%	0.43
Sep 20 07:00:00 - 07:59:59	771	3.3%	0.21	2.1 MB	3.1%	0.59
Sep 20 08:00:00 - 08:59:59	1048	4.5%	0.29	3.1 MB	4.7%	0.88
Sep 20 09:00:00 - 09:59:59	1019	4.4%	0.28	2.6 MB	4.0%	0.75
Sep 20 10:00:00 - 10:59:59	1000	4.3%	0.28	2.4 MB	3.7%	0.70
Sep 20 11:00:00 - 11:59:59	1019	4.4%	0.28	2.7 MB	4.1%	0.78
Sep 20 12:00:00 - 12:59:59	1186	5.1%	0.33	3.1 MB	4.7%	0.87
Sep 20 13:00:00 - 13:59:59	1190	5.1%	0.33	3.4 MB	5.1%	0.96
Sep 20 14:00:00 - 14:59:59	1270	5.4%	0.35	3.4 MB	5.2%	0.98
Sep 20 15:00:00 - 15:59:59	1346	5.8%	0.37	3.9 MB	5.9%	1.10
Sep 20 16:00:00 - 16:59:59	1308	5.6%	0.36	3.5 MB	5.3%	1.00
Sep 20 17:00:00 - 17:59:59	1298	5.6%	0.36	3.3 MB	5.1%	0.95
Sep 20 18:00:00 - 18:59:59	1311	5.6%	0.36	3.5 MB	5.4%	1.01
Sep 20 19:00:00 - 19:59:59	1302	5.6%	0.36	3.5 MB	5.3%	1.00
Sep 20 20:00:00 - 20:59:59	1279	5.5%	0.36	3.4 MB	5.2%	0.97
Sep 20 21:00:00 - 21:59:59	1273	5.5%	0.35	3.6 MB	5.4%	1.01
Sep 20 22:00:00 - 22:59:59	1091	4.7%	0.30	3.2 MB	4.8%	0.90
Sep 20 23:00:00 - 23:59:59	888	3.8%	0.25	2.6 MB	4.0%	0.75
Sep 21 00:00:00 - 00:59:59	597	2.6%	0.17	2.4 MB	3.7%	0.69
Sep 21 01:00:00 - 01:59:59	484	2.1%	0.13	1.5 MB	2.3%	0.43
Sep 21 02:00:00 - 02:59:59	498	2.1%	0.14	1.9 MB	2.9%	0.54
Sep 21 03:00:00 - 03:59:59	548	2.3%	0.15	1.9 MB	2.8%	0.53
Sep 21 04:00:00 - 04:15:00	176	0.8%	0.20	551.3 KB	0.8%	0.61
TOTAL: 24:00:00	23357	100.0%	0.27	65.8 MB	100.0%	0.78

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	xanadu-bbs.net	7384	536	0	6848
2	newsfeed.neva.ru	4912	608	0	4304
3	news-out.mixmin.net	2746	10	2	2734
4	feeder.eternal-september.org	2257	192	1	2064
5	au2pb.net	678	621	2	55
6	newsfeed.fu-berlin.de	549	38	0	511
7	newsfeeds.xmission.com	179	167	1	11
8	nntp.pasdenom.info	64	49	0	15
9	news.swapon.de	23	0	0	23
TOTAL: 9		18792	2221	6	16565

Unwanted newsgroups [Top 20]:

Newsgroup	Count
fa.linux.kernel	179
alt.politics	125
it-alt.sport.calcio.juventus	120
mailing.freebsd.svn-ports-all	119
mailing.freebsd.svn-ports-head	118
lada.talk	109
mailing.openbsd.misc	68
mozilla.dev.tree-alerts	65
mailing.freebsd.pkg-fallout	65
pld.cvs.commit	63
mailing.openbsd.ports-changes	58
alt.windows7.general	58
alt.survival	57
mailing.freebsd.svn-src-all	48
mailing.freebsd.svn-src-head	45
fa.freebsd.cvs-all	45
mailing.freebsd.ports-bugs	28
mpc.lists.freebsd.ports.bugs	28
nemo.bavardages	27
ut.test	23
TOTAL: 225	2221

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	11653
EMP (phn path)	2473
EMP (phl)	904
PFM bot misc	209
EMP (phn nph)	106
Too many newsgroups	35
HTML post	29
HTML Multipart	22
Binary Image: misplaced jpg	21
HTML Image Tags	4
Binary: non-binary distribution	1
Binary Image: misplaced jpeg	1
Binary: misplaced rar	1
Too many newsgroups (low_xpost)	1
Binary: misplaced JvQ5	1
TOTAL: 15	15461

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Huge articles
	xanadu-bbs.net	570
	feeder.eternal-september.org	52
	news-out.mixmin.net	52
	au2pb.net	25
	nntp.pasdenom.info	11
	newsfeeds.xmission.com	6
	news.swapon.de	1
	TOTAL: 7	717
Including strange strings
	newsfeed.fu-berlin.de	310
	feeder.eternal-september.org	21
	news-out.mixmin.net	16
	au2pb.net	15
	news.swapon.de	9
	xanadu-bbs.net	8
	newsfeed.neva.ru	4
	newsfeeds.xmission.com	4
	TOTAL: 8	387
TOTAL: 2		1104

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	usenet.pasdenom.info	28491	309	21979	526	11	1%	23:59:57
2	au2pb	18998	189	18127	122	0	0%	23:59:57
3	xanadu-bbs	20976	78	19602	40	5	0%	23:59:55
4	fu-berlin.de	21966	41	21901	24	0	0%	23:59:44
5	eternal-september	17579	13	16782	1	0	0%	23:59:55
6	news.mixmin.net	20512	13	19877	12	0	0%	23:59:56
7	xmission	27262	7	21446	0	0	0%	23:59:57
8	neva.ru	22610	5	21565	104	0	0%	23:59:44
9	news.swapon.de	2196	0	2184	3	0	0%	23:59:29
TOTAL: 9		180590	655	163463	832	16	0%	215:58:34

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	usenet.pasdenom.info	991.1 KB	1.0 MB	2.0 MB	2.4 KB	23:59:57
2	au2pb	968.2 KB	309.5 KB	1.2 MB	4.1 KB	23:59:57
3	xanadu-bbs	416.9 KB	82.8 KB	499.7 KB	4.2 KB	23:59:55
4	fu-berlin.de	218.1 KB	34.3 KB	252.5 KB	3.9 KB	23:59:44
5	news.mixmin.net	67.7 KB	20.7 KB	88.3 KB	3.5 KB	23:59:56
6	eternal-september	64.5 KB	1.4 KB	65.9 KB	4.7 KB	23:59:55
7	xmission	28.7 KB	0.0 KB	28.7 KB	4.1 KB	23:59:57
8	neva.ru	15.6 KB	415.5 KB	431.1 KB	4.0 KB	23:59:44
9	news.swapon.de	0.0 KB	12.4 KB	12.4 KB	4.1 KB	23:59:29
TOTAL: 9		2.7 MB	1.9 MB	4.6 MB	3.2 KB	215:58:34

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	202.89.176.220	288	93	325.1 KB	81	0	0	04:40:15
TOTAL: 1		288	93	325.1 KB	81	0	0	21:59:12

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	unresolved	327	93	325.1 KB	81	13:15:43
2	*.dynamic.caiway.nl	8	0	0.0 KB	0	00:00:00
3	*.br.br.cox.net	1	0	0.0 KB	0	00:01:00
4	*.tampfl.dsl-w.verizon.net	12	0	0.0 KB	0	02:01:11
5	*.chello.nl	15	0	0.0 KB	0	04:50:15
6	*.ip-188-165-239.eu	2	0	0.0 KB	0	00:02:04
7	*.bbox.io	3	0	0.0 KB	0	00:30:18
8	*.tu.ok.cox.net	2	0	0.0 KB	0	01:18:37
TOTAL: 8		370	93	325.1 KB	81	21:59:12

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
162.212.88.198	0.370	0.143	0.000	06:39:31
dhcp-089-099-203-254.chello.nl	1.172	0.267	0.000	04:50:15
202.89.176.220	28.719	5.865	0.705	04:40:15
pool-71-98-160-84.tampfl.dsl-w.verizon.net	0.993	0.188	0.000	02:01:11
71.94.21.184	0.607	0.316	0.000	01:55:55
ip72-222-107-224.tu.ok.cox.net	0.120	0.074	0.000	01:18:37
tempe0.bbox.io	0.176	0.054	0.000	00:30:18
ns342002.ip-188-165-239.eu	0.173	0.075	0.000	00:02:04
ip70-186-189-240.br.br.cox.net	0.154	0.015	0.000	00:01:00
69.160.37.54	1.839	0.414	0.000	00:00:02
TOTAL: 10	34.323	7.411	0.705	21:59:12

Curious NNRP server explorers [Top 20]:

System	Conn
69.160.37.54	25
dhcp-089-099-203-254.chello.nl	15
pool-71-98-160-84.tampfl.dsl-w.verizon.net	12
041-020-158-163.dynamic.caiway.nl	8
162.212.88.198	8
71.94.21.184	6
tempe0.bbox.io	3
ip72-222-107-224.tu.ok.cox.net	2
ns342002.ip-188-165-239.eu	2
ip70-186-189-240.br.br.cox.net	1
TOTAL: 10	82

NNRP unrecognized commands (by host):

System	Conn
71.94.21.184	6
TOTAL: 1	6

NNRP unrecognized commands (by command):

Command	Count
XFEATURE COMPRESS GZIP	6
TOTAL: 1	6

NNRP client timeouts [Top 20]:

System	Conn	Peer
dhcp-089-099-203-254.chello.nl	7	0
pool-71-98-160-84.tampfl.dsl-w.verizon.net	4	0
ip72-222-107-224.tu.ok.cox.net	2	0
tempe0.bbox.io	1	0
TOTAL: 4	14	0

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	comp.arch	42
2	comp.arch.embedded	24
3	comp.os.vms	20
4	comp.os.linux.networking	3
5	comp.os.os2.ecomstation	2
6	comp.ai.philosophy	1
7	comp.os.os2.apps	1
TOTAL: 7		93

Daily Usenet report for csiph.com

Sep 20 04:15:00 -- Sep 21 04:15:00