Daily Usenet report for csiph.com: Apr 1 04:15:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	24256	48.1%	6.3 MB	64.3%
innd	17363	34.4%	2.3 MB	23.5%
innfeed	7959	15.8%	1.1 MB	11.3%
nnrpd	744	1.5%	81.8 KB	0.8%
nocem	83	0.2%	8.0 KB	0.1%
controlchan	1	0.0%	0.2 KB	0.0%
TOTAL: 6	50406	100.0%	9.8 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	399272	57.0%
Negative hits	277697	39.7%
Do not exist	22830	3.3%
Cache misses	380	0.1%
TOTAL: 4	700179	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.576	0.0%	47	0.000	12.255	28.000
article cleanup	00:00:00.128	0.0%	22501	0.000	0.006	0.038
article logging	00:00:00.366	0.0%	23068	0.000	0.016	0.356
article parse	00:00:01.395	0.0%	70782	0.000	0.020	0.304
article write	00:00:10.236	0.0%	19318	0.172	0.530	12.702
artlog/artcncl	00:00:00.004	0.0%	47	0.000	0.085	1.000
artlog/artparse	00:00:00.010	0.0%	578	0.000	0.017	0.250
data move	00:00:00.226	0.0%	652914	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.038	0.0%	43	0.000	0.884	3.100
hishave/artcncl	00:00:00.005	0.0%	47	0.000	0.106	0.400
hishave/artparse	00:00:00.000	0.0%	576	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:09.628	0.0%	705485	0.001	0.014	0.166
history sync	00:00:01.112	0.0%	369	0.000	3.014	52.000
history write	00:00:17.966	0.0%	22440	0.047	0.801	6.370
hiswrite/artcncl	00:00:00.000	0.0%	4	0.000	0.000	0.000
hiswrite/artparse	00:00:00.733	0.0%	576	0.000	1.273	21.500
idle	23:58:34.646	99.8%	659049	71.478	130.968	530.346
nntp read	00:00:02.430	0.0%	660844	0.001	0.004	0.009
overview write	00:00:27.756	0.0%	19318	0.147	1.437	21.383
perl filter	00:00:29.318	0.0%	22438	1.066	1.307	2.067
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.294	0.0%	38719	0.000	0.008	0.045
TOTAL: 24:00:54.355	24:00:16.867	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.038	0.0%	20154	0.000	0.002	0.014
article prepare	00:00:00.004	0.0%	10788	0.000	0.000	0.036
article read	00:00:00.208	0.0%	1274	0.000	0.163	6.286
backlog stats	00:00:00.237	0.0%	423438	0.000	0.001	0.002
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.531	0.0%	335276	0.002	0.005	0.011
data write	00:00:01.896	0.0%	320684	0.001	0.006	0.011
idle	23:54:27.546	100.0%	423438	111.983	203.259	654.674
status file	00:00:01.308	0.0%	2132	0.000	0.614	2.000
TOTAL: 23:54:39.955	23:54:32.768	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	32:25:47.772	99.8%	462	0.000	252700.805	442904.750
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.004	0.0%	1058	0.000	0.004	0.143
readart	00:00:00.127	0.0%	7	0.000	18.143	42.000
TOTAL: 32:29:49.884	32:25:47.903	99.8%	-	-	-	-

Control commands to INND:

Command	Number
flush	5
flushlogs	2
go	2
logmode	2
lowmark	1
mode	136
pause	2
paused	2
reload	2
reserve	2
TOTAL: 10	156

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeeds.xmission.com	3	18365	4189	14103	73	22%	22:49:44
2	news-out.aioe.org	2	19583	4069	15149	365	20%	24:09:02
3	feeder.eternal-september.org	3	21726	2684	18788	254	12%	24:50:05
4	csiph-out.feeder.erje.net	1440	96698	1554	94668	476	1%	118:47:18
5	csiph-out.news.weretis.net	3	53037	1247	51601	189	2%	60:57:11
6	csiph-out.news.xs4all.nl	861	21048	1109	19125	814	5%	71:26:34
7	newsfeed.neva.ru	151	19797	1044	18477	276	5%	71:48:24
8	news-out.mixmin.net	3	20370	992	18879	499	4%	24:08:53
9	newsfeed.fu-berlin.de	23	20139	967	18913	259	4%	28:37:33
10	news.fcku.it	11	2812	361	2448	3	12%	22:38:31
11	news.freedyn.net	2	22244	354	21752	138	1%	23:59:58
12	csiph-out.feed.uzoreto.com	864	29646	310	28998	338	1%	71:11:54
13	csiph-out.news.tnetconsulting.net	2	18217	302	17865	50	1%	22:53:52
14	news-out.neodome.net	3	20611	106	20459	46	0%	24:05:52
15	nntp.pasdenom.info	6	13961	87	13860	14	0%	23:56:06
16	news.bbs.nz	2	18096	40	18056	0	0%	23:59:51
17	news.swapon.de	5	1723	35	1687	1	2%	24:24:20
18	news.samoylyk.net	1	19521	4	19513	4	0%	23:59:53
19	xanadu-bbs.net	1	3	0	3	0	0%	00:09:59
20	localhost	26	0	0	0	0	0%	00:00:00
TOTAL: 20		3412	437597	19454	414344	3799	4%	708:55:00

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeeds.xmission.com	12.4 MB	0.0 KB	5.3 MB	17.7 MB	70%	4.3 KB
2	news-out.aioe.org	9.1 MB	7.2 KB	854.8 KB	10.0 MB	91%	2.3 KB
3	csiph-out.feeder.erje.net	8.5 MB	16.0 KB	9.4 MB	17.9 MB	47%	9.1 KB
4	feeder.eternal-september.org	6.5 MB	11.7 KB	2.0 MB	8.5 MB	76%	3.0 KB
5	csiph-out.news.weretis.net	3.5 MB	18.9 KB	2.7 MB	6.3 MB	56%	4.5 KB
6	news-out.mixmin.net	3.3 MB	7.3 KB	1.0 MB	4.3 MB	75%	3.0 KB
7	csiph-out.news.xs4all.nl	2.9 MB	1.4 KB	12.3 MB	15.3 MB	19%	8.1 KB
8	newsfeed.neva.ru	2.3 MB	14.5 KB	1.1 MB	3.4 MB	67%	2.7 KB
9	newsfeed.fu-berlin.de	2.2 MB	0.0 KB	719.4 KB	2.9 MB	76%	2.5 KB
10	news.freedyn.net	1.2 MB	8.8 KB	1.9 MB	3.1 MB	39%	6.4 KB
11	csiph-out.feed.uzoreto.com	1.0 MB	11.2 KB	9.5 MB	10.5 MB	9%	16.6 KB
12	csiph-out.news.tnetconsulting.net	970.2 KB	3.1 KB	165.9 KB	1.1 MB	85%	3.2 KB
13	news.fcku.it	627.1 KB	2.8 KB	3.7 KB	633.7 KB	98%	1.7 KB
14	news-out.neodome.net	288.9 KB	4.9 KB	1.3 MB	1.6 MB	17%	10.7 KB
15	nntp.pasdenom.info	196.4 KB	2.9 KB	22.5 KB	221.8 KB	88%	2.2 KB
16	news.swapon.de	80.4 KB	0.0 KB	4.4 KB	84.9 KB	94%	2.4 KB
17	news.bbs.nz	70.0 KB	0.0 KB	0.0 KB	70.0 KB	100%	1.8 KB
18	news.samoylyk.net	6.1 KB	1.4 KB	190.2 KB	197.7 KB	3%	24.7 KB
19	xanadu-bbs.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
20	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 20		55.4 MB	112.2 KB	48.4 MB	103.9 MB	53%	4.6 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Apr 1 04:15:00 - 04:59:59	206	1.1%	0.08	639.9 KB	1.1%	0.24
Apr 1 05:00:00 - 05:59:59	378	1.9%	0.10	1.0 MB	1.8%	0.29
Apr 1 06:00:00 - 06:59:59	642	3.3%	0.18	2.3 MB	4.2%	0.67
Apr 1 07:00:00 - 07:59:59	744	3.8%	0.21	2.1 MB	3.7%	0.59
Apr 1 08:00:00 - 08:59:59	921	4.7%	0.26	2.3 MB	4.1%	0.65
Apr 1 09:00:00 - 09:59:59	1118	5.7%	0.31	2.8 MB	5.0%	0.80
Apr 1 10:00:00 - 10:59:59	1037	5.3%	0.29	2.9 MB	5.2%	0.83
Apr 1 11:00:00 - 11:59:59	926	4.7%	0.26	2.5 MB	4.4%	0.70
Apr 1 12:00:00 - 12:59:59	999	5.1%	0.28	2.5 MB	4.4%	0.70
Apr 1 13:00:00 - 13:59:59	1113	5.7%	0.31	2.8 MB	5.0%	0.80
Apr 1 14:00:00 - 14:59:59	1085	5.5%	0.30	3.3 MB	5.9%	0.94
Apr 1 15:00:00 - 15:59:59	1203	6.1%	0.33	3.1 MB	5.5%	0.88
Apr 1 16:00:00 - 16:59:59	1299	6.6%	0.36	3.4 MB	6.0%	0.95
Apr 1 17:00:00 - 17:59:59	1088	5.6%	0.30	2.7 MB	4.7%	0.76
Apr 1 18:00:00 - 18:59:59	1104	5.6%	0.31	3.1 MB	5.5%	0.88
Apr 1 19:00:00 - 19:59:59	1057	5.4%	0.29	3.0 MB	5.4%	0.86
Apr 1 20:00:00 - 20:59:59	911	4.7%	0.25	2.4 MB	4.4%	0.70
Apr 1 21:00:00 - 21:59:59	776	4.0%	0.22	2.2 MB	4.0%	0.64
Apr 1 22:00:00 - 22:59:59	627	3.2%	0.17	2.2 MB	4.0%	0.63
Apr 1 23:00:00 - 23:59:59	543	2.8%	0.15	2.1 MB	3.8%	0.61
Apr 2 00:00:00 - 00:59:59	433	2.2%	0.12	1.6 MB	2.9%	0.46
Apr 2 01:00:00 - 01:59:59	362	1.8%	0.10	1.1 MB	2.0%	0.33
Apr 2 02:00:00 - 02:59:59	331	1.7%	0.09	1.3 MB	2.3%	0.37
Apr 2 03:00:00 - 03:59:59	303	1.5%	0.08	886.7 KB	1.5%	0.25
Apr 2 04:00:00 - 04:15:00	383	2.0%	0.43	1.8 MB	3.3%	2.08
TOTAL: 24:00:00	19589	100.0%	0.23	56.2 MB	100.0%	0.67

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.news.xs4all.nl	816	74	1	741
2	newsfeed.fu-berlin.de	694	50	0	644
3	news-out.mixmin.net	499	4	5	490
4	news-out.aioe.org	434	114	4	316
5	csiph-out.feeder.erje.net	422	80	21	321
6	csiph-out.feed.uzoreto.com	340	14	7	319
7	newsfeed.neva.ru	276	46	9	221
8	feeder.eternal-september.org	239	43	7	189
9	csiph-out.news.weretis.net	182	68	10	104
10	news.freedyn.net	145	6	4	135
11	csiph-out.news.tnetconsulting.net	121	31	3	87
12	newsfeeds.xmission.com	88	2	0	86
13	news-out.neodome.net	46	2	3	41
14	nntp.pasdenom.info	14	0	2	12
15	news.samoylyk.net	4	0	1	3
16	news.swapon.de	4	0	0	4
17	news.fcku.it	3	0	2	1
TOTAL: 17		4327	534	79	3714

Unwanted newsgroups [Top 20]:

Newsgroup	Count
alt.computer.workshop	110
alt.bbs.synchronet	56
spline.eisfair	37
alt.politics.usa	25
alt.survival	23
mozilla.general	16
alt.binaries.pictures.purebeauty	16
lada.auto	14
mozilla.support.thunderbird	14
alt.windows7.general	14
lada.talk	12
cakewalk.audio	10
mozilla.support.seamonkey	9
alt.music.pink-floyd.publius	8
alt.binaries.ebooks	7
0.akita-inu	6
mozilla.support.firefox	6
oesterreich.tratsch	6
nyc.forsale	6
alt.silly-group.radish-therapy	6
TOTAL: 104	534

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	1787
EMP (phn path)	394
EMP (phl)	125
0	106
Too many newsgroups	90
HTML Multipart	29
EMP (phn nph)	18
Scoring filter	10
Binary Payload	6
Binary: misplaced binary	3
HTML post	1
TOTAL: 11	2569

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	csiph-out.feeder.erje.net	45
	TOTAL: 1	45
Huge articles
	csiph-out.feeder.erje.net	160
	csiph-out.news.xs4all.nl	139
	csiph-out.feed.uzoreto.com	112
	newsfeeds.xmission.com	70
	csiph-out.news.weretis.net	32
	news.freedyn.net	26
	news-out.neodome.net	19
	feeder.eternal-september.org	7
	csiph-out.news.tnetconsulting.net	4
	news.samoylyk.net	3
	TOTAL: 12	576
Including strange strings
	newsfeed.fu-berlin.de	426
	news-out.aioe.org	82
	csiph-out.news.weretis.net	21
	newsfeeds.xmission.com	15
	news-out.mixmin.net	8
	csiph-out.news.xs4all.nl	4
	news.swapon.de	3
	csiph-out.feed.uzoreto.com	3
	csiph-out.feeder.erje.net	3
	news.freedyn.net	2
	TOTAL: 10	567
No colon-space in header
	csiph-out.news.xs4all.nl	1
	csiph-out.feeder.erje.net	1
	TOTAL: 2	2
TOTAL: 4		1190

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.bbs.nz	37162	544	18506	15	0	1%	23:59:56
2	news.samoylyk.net	20512	513	19068	4	0	2%	23:59:45
3	fu-berlin.de	18476	482	17994	0	0	2%	23:59:54
4	news.freedyn.net	19599	480	18663	31	0	2%	23:59:46
5	tnet	20656	146	18948	0	45	0%	23:59:56
6	newsfeed.xs4all.nl	19016	79	18157	13	115	0%	23:59:55
7	neva.ru	17960	29	17701	76	0	0%	23:59:56
8	xmission	18159	25	14666	3	0	0%	23:59:51
9	aioe	14650	23	14168	4	0	0%	23:59:41
10	erje	20187	21	17723	21	0	0%	23:59:56
11	news.mixmin.net	18497	16	17809	0	0	0%	23:59:41
12	news.uzoreto.com	18823	16	18505	121	0	0%	23:59:55
13	neodome.net	20031	15	19426	0	0	0%	23:59:55
14	usenet.pasdenom.info	19432	13	18704	8	384	0%	23:59:56
15	eternal-september	16787	6	16203	1	0	0%	23:59:56
16	news.fcku.it	2298	0	2294	0	0	0%	21:50:25
17	weretis.net	17880	0	17592	1	0	0%	23:59:47
18	xanadu-bbs	627	0	0	0	20216	0%	23:58:43
19	news.swapon.de	1780	0	1728	0	0	0%	23:27:03
TOTAL: 19		322532	2408	287855	298	20760	0%	453:13:57

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	news.freedyn.net	5.3 MB	48.5 KB	5.3 MB	0.1 KB/s	10.7 KB	23:59:46
2	news.samoylyk.net	5.2 MB	4.5 KB	5.2 MB	0.1 KB/s	10.4 KB	23:59:45
3	fu-berlin.de	5.2 MB	0.0 KB	5.2 MB	0.1 KB/s	11.0 KB	23:59:54
4	news.bbs.nz	1.5 MB	44.4 KB	1.6 MB	0.0 KB/s	2.9 KB	23:59:56
5	tnet	421.4 KB	0.0 KB	421.4 KB	0.0 KB/s	2.9 KB	23:59:56
6	newsfeed.xs4all.nl	300.3 KB	47.7 KB	348.1 KB	0.0 KB/s	3.8 KB	23:59:55
7	erje	96.7 KB	202.2 KB	298.9 KB	0.0 KB/s	7.1 KB	23:59:56
8	neva.ru	55.1 KB	131.9 KB	187.0 KB	0.0 KB/s	1.8 KB	23:59:56
9	xmission	53.4 KB	4.9 KB	58.3 KB	0.0 KB/s	2.1 KB	23:59:51
10	aioe	35.8 KB	7.0 KB	42.8 KB	0.0 KB/s	1.6 KB	23:59:41
11	news.uzoreto.com	28.0 KB	443.6 KB	471.6 KB	0.0 KB/s	3.4 KB	23:59:55
12	usenet.pasdenom.info	26.6 KB	31.4 KB	58.0 KB	0.0 KB/s	2.8 KB	23:59:56
13	news.mixmin.net	21.7 KB	0.0 KB	21.7 KB	0.0 KB/s	1.4 KB	23:59:41
14	neodome.net	21.1 KB	0.0 KB	21.1 KB	0.0 KB/s	1.4 KB	23:59:55
15	eternal-september	19.2 KB	5.7 KB	24.8 KB	0.0 KB/s	3.5 KB	23:59:56
16	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	21:50:25
17	weretis.net	0.0 KB	1.7 KB	1.7 KB	0.0 KB/s	1.7 KB	23:59:47
18	xanadu-bbs	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:58:43
19	news.swapon.de	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:27:03
TOTAL: 19		18.3 MB	973.3 KB	19.2 MB	0.0 KB/s	7.3 KB	453:13:57

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Elapsed
1	5-168-143-94.cust.centrio.cz	2	3	10.0 KB	2	01:00:07
2	96-42-18-55.dhcp.mdsn.wi.charter.com	4	2	3.2 KB	1	01:32:19
3	a131033.upc-a.chello.nl	29	2	3.2 KB	2	04:44:46
TOTAL: 3		35	7	16.3 KB	5	32:29:49

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	*.cust.centrio.cz	2	3	10.0 KB	2	01:00:07
2	*.upc-a.chello.nl	29	2	3.2 KB	2	04:44:46
3	*.dhcp.mdsn.wi.charter.com	4	2	3.2 KB	1	01:32:19
4	unresolved	64	0	0.0 KB	0	19:26:59
5	*.ph.ph.cox.net	4	0	0.0 KB	0	02:00:15
6	*.net.upcbroadband.cz	12	0	0.0 KB	0	03:45:19
7	*.us-west-1.compute.amazonaws.com	1	0	0.0 KB	0	00:00:00
TOTAL: 7		116	7	16.3 KB	5	32:29:49

NNRP auth users [Top 20]:

User	Conn
ctomczyk	2
TOTAL: 1	2

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
91.187.33.87	3.811	0.952	0.000	19:26:44
a131033.upc-a.chello.nl	1.910	0.458	0.000	04:44:46
ip-89-176-128-154.net.upcbroadband.cz	0.733	0.214	0.000	03:45:19
ip72-222-200-117.ph.ph.cox.net	0.426	0.075	0.000	02:00:15
96-42-18-55.dhcp.mdsn.wi.charter.com	0.331	0.078	0.000	01:32:19
5-168-143-94.cust.centrio.cz	0.217	0.025	0.005	01:00:07
162.243.129.90	0.071	0.008	0.000	00:00:09
94.160.239.106	0.121	0.030	0.000	00:00:02
94.160.125.100	0.063	0.016	0.000	00:00:01
94.160.18.53	0.072	0.008	0.000	00:00:01
ec2-54-241-107-77.us-west-1.compute.amazonaws.com	0.060	0.017	0.000	00:00:00
TOTAL: 11	7.815	1.881	0.005	32:29:49

Curious NNRP server explorers [Top 20]:

System	Conn
91.187.33.87	59
ip-89-176-128-154.net.upcbroadband.cz	12
ip72-222-200-117.ph.ph.cox.net	4
94.160.239.106	2
162.243.129.90	1
ec2-54-241-107-77.us-west-1.compute.amazonaws.com	1
94.160.125.100	1
94.160.18.53	1
TOTAL: 8	81

NNRP client timeouts [Top 20]:

System	Conn	Peer
ip72-222-200-117.ph.ph.cox.net	4	0
96-42-18-55.dhcp.mdsn.wi.charter.com	2	0
5-168-143-94.cust.centrio.cz	2	0
TOTAL: 3	8	0

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	comp.sys.ibm.ps2.hardware	4
2	comp.lang.javascript	3
TOTAL: 2		7

Daily Usenet report for csiph.com

Apr 1 04:15:00 -- Apr 2 04:15:00