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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	24254	52.3%	6.3 MB	67.7%
innd	17482	37.7%	2.2 MB	23.9%
innfeed	3633	7.8%	696.2 KB	7.3%
nnrpd	983	2.1%	106.4 KB	1.1%
nocem	12	0.0%	1.3 KB	0.0%
controlchan	2	0.0%	0.2 KB	0.0%
TOTAL: 6	46366	100.0%	9.3 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	379681	54.9%
Negative hits	269425	39.0%
Do not exist	23410	3.4%
Cache misses	18463	2.7%
TOTAL: 4	690979	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.359	0.0%	35	0.000	10.257	16.000
article cleanup	00:00:00.120	0.0%	22478	0.000	0.005	0.022
article logging	00:00:00.517	0.0%	23218	0.000	0.022	2.589
article parse	00:00:01.434	0.0%	82890	0.000	0.017	0.046
article write	00:00:08.755	0.0%	19481	0.170	0.449	14.580
artlog/artcncl	00:00:00.000	0.0%	35	0.000	0.000	0.000
artlog/artparse	00:00:00.029	0.0%	1001	0.000	0.029	1.000
data move	00:00:00.244	0.0%	648384	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.017	0.0%	35	0.000	0.486	1.000
hishave/artcncl	00:00:00.005	0.0%	35	0.000	0.143	1.000
hishave/artparse	00:00:00.000	0.0%	998	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:04.197	0.0%	691803	0.001	0.006	0.035
history sync	00:00:01.467	0.0%	367	0.000	3.997	48.667
history write	00:00:14.520	0.0%	22478	0.074	0.646	2.030
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
hiswrite/artparse	00:00:00.605	0.0%	998	0.000	0.606	3.000
idle	23:58:42.589	99.8%	653898	67.601	132.012	381.216
nntp read	00:00:02.456	0.0%	655196	0.002	0.004	0.007
overview write	00:00:30.252	0.0%	19481	0.067	1.553	28.100
perl filter	00:00:29.731	0.0%	22475	1.063	1.323	1.727
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.303	0.0%	38972	0.000	0.008	0.031
TOTAL: 24:00:55.474	24:00:17.600	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.041	0.0%	19511	0.000	0.002	0.020
article prepare	00:00:00.001	0.0%	15608	0.000	0.000	0.004
article read	00:00:00.320	0.0%	1591	0.000	0.201	4.000
backlog stats	00:00:00.223	0.0%	450094	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.669	0.0%	357594	0.001	0.005	0.011
data write	00:00:01.955	0.0%	342760	0.001	0.006	0.014
idle	23:43:28.356	100.0%	450094	104.938	189.757	489.131
status file	00:00:00.186	0.0%	285	0.000	0.653	2.000
TOTAL: 23:43:44.492	23:43:32.751	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	46:01:55.078	99.8%	610	321.667	271664.062	600208.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:01.061	0.0%	1378	0.000	0.770	32.844
readart	00:00:00.218	0.0%	16	0.000	13.625	42.000
TOTAL: 46:06:52.622	46:01:56.357	99.8%	-	-	-	-

Control commands to INND:

Command	Number
flush	5
flushlogs	2
go	3
logmode	2
lowmark	1
mode	138
pause	3
paused	3
reload	4
reserve	2
TOTAL: 10	163

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeeds.xmission.com	3	18785	4605	14144	36	24%	24:50:32
2	news-out.aioe.org	4	18580	4112	14408	60	22%	24:12:11
3	feeder.eternal-september.org	4	20903	2884	17872	147	13%	23:28:37
4	csiph-out.news.weretis.net	5	36252	1271	34753	228	3%	43:45:07
5	csiph-out.news.xs4all.nl	861	20921	1194	18765	962	5%	71:28:30
6	newsfeed.neva.ru	149	19038	1035	17783	220	5%	72:05:10
7	newsfeed.fu-berlin.de	18	18475	1035	17170	270	5%	25:19:36
8	news-out.mixmin.net	3	20474	1031	19075	368	5%	24:08:18
9	csiph-out.feeder.erje.net	1152	78521	733	76432	1356	0%	94:57:57
10	news.freedyn.net	2	21849	389	21243	217	1%	23:48:12
11	csiph-out.feed.uzoreto.com	863	48215	366	47274	575	0%	71:21:52
12	news.fcku.it	13	2302	288	2013	1	12%	22:04:35
13	news-out.neodome.net	3	20799	103	20686	10	0%	24:09:00
14	csiph-out.news.tnetconsulting.net	1	18686	86	18552	48	0%	23:59:58
15	nntp.pasdenom.info	2	13599	85	13492	22	0%	23:58:23
16	news.swapon.de	4	2021	62	1958	1	3%	24:04:31
17	news.bbs.nz	1	18243	10	18233	0	0%	23:59:52
18	news.samoylyk.net	1	19128	8	19118	2	0%	23:59:51
19	localhost	28	2	2	0	0	100%	00:00:08
20	xanadu-bbs.net	82	751	0	751	0	0%	76:50:03
TOTAL: 20		3199	417544	19299	393722	4523	4%	742:32:23

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeeds.xmission.com	13.1 MB	0.0 KB	2.5 MB	15.6 MB	83%	3.4 KB
2	news-out.aioe.org	9.8 MB	0.0 KB	201.2 KB	10.0 MB	98%	2.5 KB
3	feeder.eternal-september.org	7.5 MB	2.5 KB	3.1 MB	10.6 MB	70%	3.6 KB
4	csiph-out.feeder.erje.net	6.5 MB	0.0 KB	60.5 MB	67.0 MB	9%	32.8 KB
5	csiph-out.news.weretis.net	3.6 MB	2.6 KB	2.0 MB	5.6 MB	63%	3.8 KB
6	csiph-out.news.xs4all.nl	3.1 MB	0.0 KB	11.4 MB	14.5 MB	21%	6.9 KB
7	news-out.mixmin.net	3.0 MB	0.0 KB	675.9 KB	3.7 MB	82%	2.7 KB
8	newsfeed.fu-berlin.de	2.7 MB	0.0 KB	677.1 KB	3.3 MB	80%	2.6 KB
9	newsfeed.neva.ru	2.3 MB	0.0 KB	761.4 KB	3.1 MB	75%	2.5 KB
10	news.freedyn.net	1.3 MB	2.6 KB	788.9 KB	2.1 MB	62%	3.5 KB
11	csiph-out.feed.uzoreto.com	981.9 KB	0.0 KB	9.2 MB	10.2 MB	9%	11.1 KB
12	news.fcku.it	503.4 KB	0.0 KB	96.5 KB	600.0 KB	83%	2.1 KB
13	news-out.neodome.net	390.9 KB	0.0 KB	23.1 KB	414.1 KB	94%	3.7 KB
14	csiph-out.news.tnetconsulting.net	315.9 KB	3.2 KB	602.7 KB	921.8 KB	34%	6.9 KB
15	nntp.pasdenom.info	179.2 KB	0.0 KB	33.6 KB	212.9 KB	84%	2.0 KB
16	news.swapon.de	170.4 KB	0.0 KB	1.4 KB	171.8 KB	99%	2.7 KB
17	news.samoylyk.net	22.9 KB	0.0 KB	4.0 KB	26.8 KB	85%	2.7 KB
18	news.bbs.nz	13.0 KB	0.0 KB	0.0 KB	13.0 KB	100%	1.3 KB
19	localhost	2.6 KB	0.0 KB	0.0 KB	2.6 KB	100%	1.3 KB
20	xanadu-bbs.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 20		55.5 MB	10.8 KB	92.5 MB	148.0 MB	37%	6.4 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Apr 15 04:15:00 - 04:59:59	300	1.5%	0.11	1.3 MB	2.3%	0.49
Apr 15 05:00:00 - 05:59:59	467	2.4%	0.13	1.3 MB	2.3%	0.37
Apr 15 06:00:00 - 06:59:59	557	2.9%	0.15	2.1 MB	3.7%	0.58
Apr 15 07:00:00 - 07:59:59	816	4.2%	0.23	2.2 MB	3.9%	0.62
Apr 15 08:00:00 - 08:59:59	907	4.7%	0.25	2.4 MB	4.3%	0.68
Apr 15 09:00:00 - 09:59:59	870	4.5%	0.24	2.2 MB	3.9%	0.61
Apr 15 10:00:00 - 10:59:59	998	5.1%	0.28	3.3 MB	6.0%	0.95
Apr 15 11:00:00 - 11:59:59	901	4.6%	0.25	2.2 MB	4.0%	0.63
Apr 15 12:00:00 - 12:59:59	1033	5.3%	0.29	2.5 MB	4.5%	0.72
Apr 15 13:00:00 - 13:59:59	1101	5.7%	0.31	2.9 MB	5.3%	0.84
Apr 15 14:00:00 - 14:59:59	1180	6.1%	0.33	3.9 MB	6.9%	1.10
Apr 15 15:00:00 - 15:59:59	1229	6.3%	0.34	3.4 MB	6.0%	0.96
Apr 15 16:00:00 - 16:59:59	1072	5.5%	0.30	2.8 MB	4.9%	0.79
Apr 15 17:00:00 - 17:59:59	1127	5.8%	0.31	2.8 MB	4.9%	0.78
Apr 15 18:00:00 - 18:59:59	1171	6.0%	0.33	3.4 MB	6.1%	0.96
Apr 15 19:00:00 - 19:59:59	1041	5.3%	0.29	2.9 MB	5.2%	0.83
Apr 15 20:00:00 - 20:59:59	978	5.0%	0.27	2.7 MB	4.8%	0.76
Apr 15 21:00:00 - 21:59:59	830	4.3%	0.23	2.3 MB	4.2%	0.66
Apr 15 22:00:00 - 22:59:59	670	3.4%	0.19	2.4 MB	4.3%	0.68
Apr 15 23:00:00 - 23:59:59	448	2.3%	0.12	1.3 MB	2.4%	0.38
Apr 16 00:00:00 - 00:59:59	431	2.2%	0.12	1.2 MB	2.2%	0.35
Apr 16 01:00:00 - 01:59:59	447	2.3%	0.12	1.4 MB	2.4%	0.39
Apr 16 02:00:00 - 02:59:59	422	2.2%	0.12	1.7 MB	3.0%	0.47
Apr 16 03:00:00 - 03:59:59	396	2.0%	0.11	1.1 MB	2.0%	0.33
Apr 16 04:00:00 - 04:15:00	85	0.4%	0.09	336.7 KB	0.6%	0.37
TOTAL: 24:00:00	19477	100.0%	0.23	55.9 MB	100.0%	0.66

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.news.xs4all.nl	964	36	0	928
2	csiph-out.feeder.erje.net	871	46	0	825
3	newsfeed.fu-berlin.de	784	13	0	771
4	csiph-out.feed.uzoreto.com	580	17	0	563
5	news-out.mixmin.net	387	2	0	385
6	csiph-out.news.weretis.net	247	79	1	167
7	newsfeed.neva.ru	218	62	0	156
8	news.freedyn.net	215	1	1	213
9	news-out.aioe.org	207	42	0	165
10	feeder.eternal-september.org	151	32	1	118
11	newsfeeds.xmission.com	41	3	0	38
12	csiph-out.news.tnetconsulting.net	28	27	0	1
13	nntp.pasdenom.info	22	0	0	22
14	news.swapon.de	14	0	0	14
15	news-out.neodome.net	10	1	0	9
16	news.samoylyk.net	3	0	0	3
17	news.fcku.it	1	0	0	1
TOTAL: 17		4743	361	3	4379

Unwanted newsgroups [Top 20]:

Newsgroup	Count
lada.talk	35
mozilla.general	20
alt.politics.usa	19
alt.windows7.general	18
mozilla.support.thunderbird	15
alt.music.pink-floyd.publius	15
alt.bbs.synchronet	15
lada.auto	15
alt.computer.workshop	12
it-alt.comp.software.mozilla	9
alt.survival	8
alt.binaries.pictures.purebeauty	7
cakewalk.audio	7
mozilla.dev.apps.seamonkey	7
oesterreich.tratsch	7
alt.paranormal.spells	6
it-alt.sport.calcio.juventus	6
alt.binaries.ebooks	6
spline.eisfair	6
0.akita-inu	4
TOTAL: 97	361

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	1727
EMP (phn path)	395
EMP (phl)	259
Too many newsgroups	90
EMP (phn nph)	59
0	46
HTML Multipart	37
Binary: misplaced binary	6
Too many newsgroups (meow)	3
Scoring filter	2
Too many newsgroups (low_xpost)	1
HTML post	1
TOTAL: 12	2626

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	csiph-out.feeder.erje.net	36
	TOTAL: 1	36
Huge articles
	csiph-out.feeder.erje.net	711
	csiph-out.news.xs4all.nl	127
	csiph-out.feed.uzoreto.com	104
	newsfeeds.xmission.com	33
	csiph-out.news.weretis.net	16
	feeder.eternal-september.org	9
	news.freedyn.net	4
	news-out.mixmin.net	2
	news.fcku.it	1
	newsfeed.fu-berlin.de	1
	TOTAL: 10	1008
Including strange strings
	newsfeed.fu-berlin.de	517
	news-out.aioe.org	149
	csiph-out.news.weretis.net	27
	news.swapon.de	13
	news-out.mixmin.net	13
	csiph-out.news.xs4all.nl	6
	newsfeed.neva.ru	5
	newsfeeds.xmission.com	5
	news.freedyn.net	3
	csiph-out.feed.uzoreto.com	3
	TOTAL: 11	742
No colon-space in header
	csiph-out.feeder.erje.net	1
	TOTAL: 1	1
TOTAL: 4		1787

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	23709	1167	18308	2	7	4%	23:59:48
2	fu-berlin.de	18160	576	17584	0	0	3%	23:59:49
3	news.samoylyk.net	20047	550	18903	15	0	2%	23:59:48
4	news.freedyn.net	19447	523	18478	10	25	2%	23:59:49
5	news.bbs.nz	36841	435	18417	27	1	1%	23:59:49
6	tnet	20239	191	18699	1	0	0%	23:59:43
7	xmission	16430	83	14245	8	0	0%	23:59:49
8	newsfeed.xs4all.nl	18738	56	18046	12	103	0%	23:59:41
9	usenet.pasdenom.info	19680	20	18782	1	27	0%	23:59:49
10	neva.ru	17804	15	17525	133	0	0%	23:59:49
11	erje	21431	11	18615	22	1	0%	23:59:49
12	neodome.net	19920	11	19334	0	0	0%	23:59:47
13	aioe	14468	11	13891	0	0	0%	23:59:49
14	news.uzoreto.com	18763	11	18474	20	0	0%	23:59:48
15	news.mixmin.net	18110	10	17546	0	0	0%	23:59:40
16	weretis.net	17800	3	17512	3	0	0%	23:59:49
17	news.swapon.de	2022	3	1991	0	0	0%	23:54:08
18	eternal-september	16279	2	15722	0	0	0%	23:59:29
19	news.fcku.it	1945	0	1938	0	0	0%	21:21:54
TOTAL: 19		341833	3678	304010	254	164	1%	453:12:07

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	7.7 MB	4.8 KB	7.7 MB	0.1 KB/s	6.8 KB	23:59:48
2	fu-berlin.de	6.2 MB	0.0 KB	6.2 MB	0.1 KB/s	11.0 KB	23:59:49
3	news.samoylyk.net	6.1 MB	64.3 KB	6.2 MB	0.1 KB/s	11.2 KB	23:59:48
4	news.freedyn.net	5.8 MB	13.6 KB	5.8 MB	0.1 KB/s	11.1 KB	23:59:49
5	news.bbs.nz	1.1 MB	68.8 KB	1.2 MB	0.0 KB/s	2.6 KB	23:59:49
6	tnet	434.4 KB	1.0 KB	435.5 KB	0.0 KB/s	2.3 KB	23:59:43
7	newsfeed.xs4all.nl	267.4 KB	41.1 KB	308.5 KB	0.0 KB/s	4.5 KB	23:59:41
8	xmission	219.0 KB	12.2 KB	231.2 KB	0.0 KB/s	2.5 KB	23:59:49
9	usenet.pasdenom.info	48.6 KB	3.3 KB	51.9 KB	0.0 KB/s	2.5 KB	23:59:49
10	neva.ru	40.3 KB	274.1 KB	314.5 KB	0.0 KB/s	2.1 KB	23:59:49
11	erje	19.9 KB	111.7 KB	131.6 KB	0.0 KB/s	4.0 KB	23:59:49
12	aioe	16.2 KB	0.0 KB	16.2 KB	0.0 KB/s	1.5 KB	23:59:49
13	neodome.net	15.2 KB	0.0 KB	15.2 KB	0.0 KB/s	1.4 KB	23:59:47
14	news.mixmin.net	14.7 KB	0.0 KB	14.7 KB	0.0 KB/s	1.5 KB	23:59:40
15	news.uzoreto.com	14.7 KB	122.7 KB	137.4 KB	0.0 KB/s	4.4 KB	23:59:48
16	news.swapon.de	11.9 KB	0.0 KB	11.9 KB	0.0 KB/s	4.0 KB	23:54:08
17	weretis.net	3.8 KB	21.4 KB	25.2 KB	0.0 KB/s	4.2 KB	23:59:49
18	eternal-september	2.6 KB	0.0 KB	2.6 KB	0.0 KB/s	1.3 KB	23:59:29
19	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	21:21:54
TOTAL: 19		28.0 MB	738.9 KB	28.7 MB	0.0 KB/s	7.5 KB	453:12:07

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	96-42-18-55.dhcp.mdsn.wi.charter.com	24	9	22.6 KB	6	2	2	05:59:13
2	a131033.upc-a.chello.nl	49	5	14.1 KB	4	0	0	11:25:33
3	5-168-143-94.cust.centrio.cz	3	2	8.9 KB	2	0	0	01:30:07
TOTAL: 3		76	16	45.7 KB	12	2	2	46:06:51

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.dhcp.mdsn.wi.charter.com	24	9	22.6 KB	6	2	2	05:59:13
2	*.upc-a.chello.nl	49	5	14.1 KB	4	0	0	11:25:33
3	*.cust.centrio.cz	3	2	8.9 KB	2	0	0	01:30:07
4	unresolved	76	0	0.0 KB	0	0	0	23:59:51
5	*.dip0.t-ipconnect.de	1	0	0.0 KB	0	0	0	00:00:06
6	*.ph.ph.cox.net	8	0	0.0 KB	0	0	0	03:11:58
TOTAL: 6		161	16	45.7 KB	12	2	2	46:06:51

NNRP auth users [Top 20]:

User	Conn
ctomczyk	3
ohlandl	2
TOTAL: 2	5

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
91.187.33.87	4.824	1.279	0.000	23:59:46
a131033.upc-a.chello.nl	3.300	0.839	0.000	11:25:33
96-42-18-55.dhcp.mdsn.wi.charter.com	1.796	0.425	0.005	05:59:13
ip72-222-200-117.ph.ph.cox.net	0.592	0.131	0.000	03:11:58
5-168-143-94.cust.centrio.cz	0.290	0.024	0.007	01:30:07
p2e5b5ddd.dip0.t-ipconnect.de	0.123	0.023	0.000	00:00:06
94.166.147.170	0.059	0.017	0.000	00:00:01
94.166.225.232	0.069	0.008	0.000	00:00:01
94.163.87.152	0.051	0.029	0.000	00:00:01
94.166.254.167	0.061	0.015	0.000	00:00:01
TOTAL: 10	11.165	2.790	0.012	46:06:51

Curious NNRP server explorers [Top 20]:

System	Conn
91.187.33.87	72
ip72-222-200-117.ph.ph.cox.net	8
94.163.87.152	1
94.166.254.167	1
p2e5b5ddd.dip0.t-ipconnect.de	1
94.166.225.232	1
94.166.147.170	1
TOTAL: 7	85

NNRP client timeouts [Top 20]:

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

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	comp.sys.ibm.ps2.hardware	14
2	comp.lang.javascript	2
TOTAL: 2		16

Daily Usenet report for csiph.com

Apr 15 04:15:00 -- Apr 16 04:15:00