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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	19102	46.4%	4.8 MB	61.6%
innd	17668	42.9%	2.3 MB	29.3%
innfeed	3418	8.3%	628.9 KB	7.8%
nnrpd	938	2.3%	101.5 KB	1.3%
nocem	31	0.1%	3.5 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	41158	100.0%	7.9 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	305128	57.1%
Negative hits	206295	38.6%
Do not exist	18435	3.4%
Cache misses	4901	0.9%
TOTAL: 4	534759	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.594	0.0%	44	0.000	13.500	29.500
article cleanup	00:00:00.106	0.0%	18061	0.000	0.006	0.034
article logging	00:00:00.305	0.0%	18574	0.000	0.016	0.159
article parse	00:00:01.460	0.0%	64248	0.000	0.023	0.202
article write	00:00:22.711	0.0%	14714	0.200	1.543	29.425
artlog/artcncl	00:00:00.003	0.0%	44	0.000	0.068	1.000
artlog/artparse	00:00:00.004	0.0%	416	0.000	0.010	0.200
data move	00:00:00.189	0.0%	507247	0.000	0.000	0.003
hisgrep/artcncl	00:00:00.048	0.0%	41	0.000	1.171	14.000
hishave/artcncl	00:00:00.088	0.0%	44	0.000	2.000	15.667
hishave/artparse	00:00:00.000	0.0%	413	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:22.529	0.0%	534887	0.003	0.042	0.262
history sync	00:00:00.904	0.0%	359	0.000	2.518	15.000
history write	00:00:35.584	0.0%	18044	0.442	1.972	10.976
hiswrite/artcncl	00:00:00.008	0.0%	3	2.667	2.667	2.667
hiswrite/artparse	00:00:00.900	0.0%	405	0.000	2.222	19.000
idle	23:47:54.338	99.8%	512971	54.113	167.016	532.451
nntp read	00:00:01.945	0.0%	515705	0.001	0.004	0.008
overview write	00:00:44.480	0.1%	14714	0.340	3.023	49.902
perl filter	00:00:23.483	0.0%	18041	0.994	1.302	2.087
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.249	0.0%	29459	0.000	0.008	0.030
TOTAL: 23:51:00.389	23:50:29.928	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.032	0.0%	22382	0.000	0.001	0.024
article prepare	00:00:00.002	0.0%	18028	0.000	0.000	0.004
article read	00:00:00.298	0.0%	1970	0.000	0.151	8.200
backlog stats	00:00:00.205	0.0%	355376	0.000	0.001	0.003
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.221	0.0%	274185	0.000	0.004	0.012
data write	00:00:01.505	0.0%	260850	0.002	0.006	0.012
idle	23:55:11.822	100.0%	355376	101.119	242.312	777.733
status file	00:00:00.164	0.0%	230	0.000	0.713	2.000
TOTAL: 23:55:21.605	23:55:15.249	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	41:05:32.731	99.8%	602	61.500	245735.434	600174.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.010	0.0%	1339	0.000	0.007	0.167
readart	00:00:00.041	0.0%	13	0.000	3.154	6.833
TOTAL: 41:10:29.165	41:05:32.782	99.8%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeeds.xmission.com	3	14512	4040	10450	22	27%	24:58:35
2	news-out.aioe.org	2	14393	3325	10963	105	23%	24:09:58
3	feeder.eternal-september.org	3	17284	1976	14905	403	11%	24:36:21
4	csiph-out.feeder.erje.net	1440	74353	1135	72758	460	1%	118:42:58
5	news-out.mixmin.net	1	15673	962	14174	537	6%	23:59:48
6	newsfeed.fu-berlin.de	4	16539	819	15465	255	4%	27:09:02
7	csiph-out.news.weretis.net	3	29818	790	28937	91	2%	47:59:49
8	csiph-out.news.xs4all.nl	861	17096	700	15268	1128	4%	71:27:49
9	newsfeed.neva.ru	146	16074	539	15113	422	3%	71:38:00
10	news.fcku.it	11	1636	178	1457	1	10%	21:13:29
11	csiph-out.feed.uzoreto.com	864	23766	162	23297	307	0%	71:16:04
12	csiph-out.news.tnetconsulting.net	2	14513	93	14398	22	0%	23:59:56
13	news-out.neodome.net	1	16034	87	15931	16	0%	23:59:54
14	nntp.pasdenom.info	2	9811	58	9741	12	0%	23:58:26
15	news.swapon.de	6	1569	31	1537	1	1%	23:20:48
16	news.freedyn.net	2	19114	21	19055	38	0%	13:02:04
17	news.samoylyk.net	2	14921	9	14902	10	0%	23:59:39
18	news.bbs.nz	1	13857	5	13852	0	0%	23:59:52
19	localhost	31	5	5	0	0	100%	00:00:04
20	xanadu-bbs.net	31	476	0	476	0	0%	23:33:13
TOTAL: 20		3416	331444	14935	312679	3830	4%	707:05:49

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeeds.xmission.com	11.6 MB	0.0 KB	1.2 MB	12.8 MB	90%	3.2 KB
2	news-out.aioe.org	7.9 MB	2.8 KB	271.9 KB	8.2 MB	96%	2.4 KB
3	csiph-out.feeder.erje.net	6.9 MB	8.3 KB	10.8 MB	17.7 MB	38%	11.4 KB
4	feeder.eternal-september.org	4.9 MB	4.0 KB	4.5 MB	9.4 MB	51%	4.0 KB
5	news-out.mixmin.net	2.7 MB	2.8 KB	1.0 MB	3.7 MB	72%	2.6 KB
6	csiph-out.news.weretis.net	2.3 MB	2.8 KB	1.3 MB	3.6 MB	63%	4.2 KB
7	csiph-out.news.xs4all.nl	2.1 MB	2.8 KB	9.6 MB	11.7 MB	17%	6.5 KB
8	newsfeed.fu-berlin.de	1.9 MB	0.0 KB	692.1 KB	2.6 MB	73%	2.5 KB
9	newsfeed.neva.ru	1.4 MB	8.5 KB	1.1 MB	2.5 MB	55%	2.7 KB
10	csiph-out.feed.uzoreto.com	798.1 KB	2.8 KB	19.5 MB	20.3 MB	3%	44.3 KB
11	csiph-out.news.tnetconsulting.net	341.3 KB	0.0 KB	50.6 KB	391.9 KB	87%	3.4 KB
12	news.fcku.it	295.5 KB	0.0 KB	1.3 KB	296.7 KB	99%	1.7 KB
13	news-out.neodome.net	266.5 KB	2.8 KB	43.4 KB	312.7 KB	85%	3.0 KB
14	nntp.pasdenom.info	150.4 KB	2.0 KB	18.6 KB	171.0 KB	87%	2.4 KB
15	news.freedyn.net	106.7 KB	4.0 KB	145.2 KB	255.9 KB	41%	4.3 KB
16	news.swapon.de	76.6 KB	2.8 KB	2.8 KB	82.2 KB	93%	2.6 KB
17	news.samoylyk.net	24.4 KB	2.8 KB	4.8 MB	4.8 MB	0%	258.4 KB
18	localhost	10.2 KB	0.0 KB	0.0 KB	10.2 KB	100%	2.0 KB
19	news.bbs.nz	8.0 KB	0.0 KB	0.0 KB	8.0 KB	100%	1.6 KB
20	xanadu-bbs.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 20		43.7 MB	49.3 KB	55.1 MB	98.8 MB	44%	5.4 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Mar 1 04:15:00 - 04:59:59	202	1.4%	0.07	637.5 KB	1.4%	0.24
Mar 1 05:00:00 - 05:59:59	333	2.3%	0.09	1.0 MB	2.4%	0.30
Mar 1 06:00:00 - 06:59:59	338	2.3%	0.09	1.0 MB	2.4%	0.29
Mar 1 07:00:00 - 07:59:59	390	2.6%	0.11	1.7 MB	3.9%	0.47
Mar 1 08:00:00 - 08:59:59	625	4.2%	0.17	2.0 MB	4.5%	0.56
Mar 1 09:00:00 - 09:59:59	769	5.2%	0.21	2.0 MB	4.7%	0.57
Mar 1 10:00:00 - 10:59:59	670	4.5%	0.19	1.7 MB	4.0%	0.48
Mar 1 11:00:00 - 11:59:59	705	4.8%	0.20	2.2 MB	5.1%	0.62
Mar 1 12:00:00 - 12:59:59	659	4.5%	0.18	1.6 MB	3.8%	0.46
Mar 1 13:00:00 - 13:59:59	739	5.0%	0.21	1.9 MB	4.4%	0.53
Mar 1 14:00:00 - 14:59:59	716	4.9%	0.20	1.7 MB	4.0%	0.49
Mar 1 15:00:00 - 15:59:59	759	5.1%	0.21	2.5 MB	5.8%	0.71
Mar 1 16:00:00 - 16:59:59	752	5.1%	0.21	2.1 MB	4.8%	0.59
Mar 1 17:00:00 - 17:59:59	846	5.7%	0.23	2.6 MB	6.0%	0.73
Mar 1 18:00:00 - 18:59:59	851	5.8%	0.24	2.5 MB	5.8%	0.70
Mar 1 19:00:00 - 19:59:59	948	6.4%	0.26	2.9 MB	6.9%	0.84
Mar 1 20:00:00 - 20:59:59	909	6.2%	0.25	2.4 MB	5.6%	0.69
Mar 1 21:00:00 - 21:59:59	777	5.3%	0.22	2.2 MB	5.2%	0.64
Mar 1 22:00:00 - 22:59:59	663	4.5%	0.18	1.7 MB	3.9%	0.48
Mar 1 23:00:00 - 23:59:59	514	3.5%	0.14	1.7 MB	4.1%	0.50
Mar 2 00:00:00 - 00:59:59	449	3.0%	0.12	1.3 MB	3.1%	0.37
Mar 2 01:00:00 - 01:59:59	363	2.5%	0.10	1.0 MB	2.4%	0.29
Mar 2 02:00:00 - 02:59:59	376	2.5%	0.10	1.1 MB	2.5%	0.30
Mar 2 03:00:00 - 03:59:59	332	2.3%	0.09	1.3 MB	2.9%	0.36
Mar 2 04:00:00 - 04:15:00	70	0.5%	0.08	196.9 KB	0.4%	0.22
TOTAL: 24:00:00	14755	100.0%	0.17	42.9 MB	100.0%	0.51

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.news.xs4all.nl	1131	36	1	1094
2	newsfeed.fu-berlin.de	601	32	0	569
3	news-out.mixmin.net	543	2	1	540
4	csiph-out.feeder.erje.net	461	43	3	415
5	newsfeed.neva.ru	419	18	3	398
6	feeder.eternal-september.org	409	28	2	379
7	csiph-out.feed.uzoreto.com	308	8	1	299
8	news-out.aioe.org	192	79	1	112
9	csiph-out.news.weretis.net	106	41	1	64
10	news.freedyn.net	40	2	2	36
11	newsfeeds.xmission.com	22	4	0	18
12	csiph-out.news.tnetconsulting.net	18	15	1	2
13	news-out.neodome.net	16	1	1	14
14	news.swapon.de	14	0	1	13
15	nntp.pasdenom.info	12	0	1	11
16	news.samoylyk.net	10	0	1	9
17	news.fcku.it	1	1	0	0
TOTAL: 17		4303	310	20	3973

Unwanted newsgroups [Top 20]:

Newsgroup	Count
alt.bbs.synchronet	43
alt.computer.workshop	34
mozilla.support.seamonkey	23
it-alt.sport.calcio.juventus	22
alt.survival	17
alt.binaries.pictures.purebeauty	16
spline.eisfair	12
alt.music.pink-floyd.publius	10
mozilla.support.firefox	8
mozilla.dev.apps.seamonkey	7
lada.talk	5
oesterreich.tratsch	5
alt.politics.usa	5
alt.politics	5
mozilla.support.thunderbird	5
hannover.kreatives_schreiben	4
it-alt.comp.software.mozilla	4
alt.windows7.general	4
alt.philosophy	4
alt.english.usage	4
TOTAL: 77	310

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	2409
EMP (phn path)	284
EMP (phl)	129
EMP (phn nph)	108
0	53
Too many newsgroups	29
HTML Multipart	12
Scoring filter	8
Binary Payload	7
Binary: misplaced binary	2
Too many newsgroups (meow)	2
Too many newsgroups (low_xpost)	1
TOTAL: 12	3044

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	194
	csiph-out.news.xs4all.nl	96
	csiph-out.feed.uzoreto.com	72
	newsfeeds.xmission.com	16
	csiph-out.news.weretis.net	15
	feeder.eternal-september.org	11
	news.samoylyk.net	5
	news-out.mixmin.net	3
	news.freedyn.net	1
	TOTAL: 9	413
Including strange strings
	newsfeed.fu-berlin.de	383
	news-out.aioe.org	90
	news.swapon.de	13
	csiph-out.news.weretis.net	11
	news-out.mixmin.net	8
	csiph-out.news.xs4all.nl	4
	csiph-out.feed.uzoreto.com	2
	csiph-out.feeder.erje.net	1
	feeder.eternal-september.org	1
	TOTAL: 9	513
No colon-space in header
	csiph-out.feeder.erje.net	2
	csiph-out.news.xs4all.nl	1
	TOTAL: 2	3
TOTAL: 4		974

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	17209	774	13979	2	0	4%	23:59:56
2	news.freedyn.net	16509	481	15839	12	5872	2%	23:58:42
3	news.bbs.nz	27828	452	13852	5	0	1%	23:59:56
4	news.samoylyk.net	15339	439	14305	2	38	2%	23:59:56
5	fu-berlin.de	13871	437	13433	0	0	3%	23:59:56
6	erje	17733	299	12455	798	0	1%	23:59:53
7	tnet	15314	184	14136	0	0	1%	23:59:56
8	usenet.pasdenom.info	14798	114	14102	41	14	0%	23:59:56
9	newsfeed.xs4all.nl	14465	37	13869	8	115	0%	23:59:55
10	aioe	10879	32	10409	0	0	0%	23:59:39
11	neva.ru	13695	30	13432	153	0	0%	23:59:56
12	news.uzoreto.com	14290	23	14020	146	0	0%	23:59:55
13	news.mixmin.net	13679	10	13150	1	0	0%	23:59:56
14	neodome.net	15180	9	14625	0	0	0%	23:59:55
15	weretis.net	13672	6	13502	1	0	0%	23:59:56
16	news.swapon.de	1707	6	1677	0	0	0%	23:56:15
17	xmission	11906	5	10399	1	0	0%	23:59:56
18	eternal-september	12738	5	12196	1	0	0%	23:59:56
19	news.fcku.it	1340	0	1336	0	0	0%	21:27:49
TOTAL: 19		262152	3343	230716	1171	6039	1%	453:21:19

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	5.9 MB	8.4 KB	5.9 MB	0.1 KB/s	7.8 KB	23:59:56
2	fu-berlin.de	5.0 MB	0.0 KB	5.0 MB	0.1 KB/s	11.7 KB	23:59:56
3	news.samoylyk.net	5.0 MB	1.7 KB	5.0 MB	0.1 KB/s	11.6 KB	23:59:56
4	news.freedyn.net	3.3 MB	16.3 KB	3.3 MB	0.0 KB/s	6.9 KB	23:58:42
5	news.bbs.nz	1.1 MB	15.7 KB	1.1 MB	0.0 KB/s	2.5 KB	23:59:56
6	erje	663.0 KB	2.5 MB	3.2 MB	0.0 KB/s	3.0 KB	23:59:53
7	tnet	425.9 KB	0.0 KB	425.9 KB	0.0 KB/s	2.3 KB	23:59:56
8	usenet.pasdenom.info	394.3 KB	111.9 KB	506.2 KB	0.0 KB/s	3.3 KB	23:59:56
9	newsfeed.xs4all.nl	87.4 KB	50.6 KB	138.0 KB	0.0 KB/s	3.1 KB	23:59:55
10	aioe	70.7 KB	0.0 KB	70.7 KB	0.0 KB/s	2.2 KB	23:59:39
11	neva.ru	54.1 KB	348.5 KB	402.6 KB	0.0 KB/s	2.2 KB	23:59:56
12	news.uzoreto.com	46.3 KB	420.9 KB	467.2 KB	0.0 KB/s	2.8 KB	23:59:55
13	news.mixmin.net	20.4 KB	4.4 KB	24.8 KB	0.0 KB/s	2.3 KB	23:59:56
14	neodome.net	14.9 KB	0.0 KB	14.9 KB	0.0 KB/s	1.7 KB	23:59:55
15	weretis.net	12.2 KB	4.5 KB	16.7 KB	0.0 KB/s	2.4 KB	23:59:56
16	news.swapon.de	11.6 KB	0.0 KB	11.6 KB	0.0 KB/s	1.9 KB	23:56:15
17	xmission	10.3 KB	2.9 KB	13.1 KB	0.0 KB/s	2.2 KB	23:59:56
18	eternal-september	10.3 KB	0.7 KB	11.0 KB	0.0 KB/s	1.8 KB	23:59:56
19	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	21:27:49
TOTAL: 19		22.1 MB	3.5 MB	25.6 MB	0.0 KB/s	5.8 KB	453:21:19

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	68-190-164-53.dhcp.eucl.wi.charter.com	32	7	12.0 KB	6	5	4	09:37:31
2	ip72-222-200-117.ph.ph.cox.net	7	6	7.7 KB	1	0	0	02:40:44
TOTAL: 2		39	13	19.7 KB	7	5	4	41:10:28

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.dhcp.eucl.wi.charter.com	32	7	12.0 KB	6	5	4	09:37:31
2	*.ph.ph.cox.net	7	6	7.7 KB	1	0	0	02:40:44
3	*.upc-a.chello.nl	25	0	0.0 KB	0	0	0	03:51:53
4	unresolved	75	0	0.0 KB	0	0	0	24:30:16
5	*.security.ipip.net	1	0	0.0 KB	0	0	0	00:00:00
6	*.hsd1.wa.comcast.net	1	0	0.0 KB	0	0	0	00:30:01
TOTAL: 6		141	13	19.7 KB	7	5	4	41:10:28

NNRP auth users [Top 20]:

User	Conn
ohlandl	4
TOTAL: 1	4

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
91.187.33.87	4.921	1.116	0.000	24:30:14
68-190-164-53.dhcp.eucl.wi.charter.com	2.240	0.458	0.012	09:37:31
a131033.upc-a.chello.nl	1.546	0.347	0.000	03:51:53
ip72-222-200-117.ph.ph.cox.net	0.652	0.104	0.000	02:40:44
c-73-140-175-55.hsd1.wa.comcast.net	0.054	0.023	0.000	00:30:01
122.228.19.79	0.061	0.015	0.000	00:00:02
scan-141.security.ipip.net	0.061	0.023	0.000	00:00:00
TOTAL: 7	9.535	2.086	0.012	41:10:28

Curious NNRP server explorers [Top 20]:

System	Conn
91.187.33.87	74
a131033.upc-a.chello.nl	25
c-73-140-175-55.hsd1.wa.comcast.net	1
122.228.19.79	1
scan-141.security.ipip.net	1
TOTAL: 5	102

NNRP unrecognized commands (by host):

System	Conn
122.228.19.79	5
scan-141.security.ipip.net	4
TOTAL: 2	9

NNRP unrecognized commands (by command):

Command	Count
Host: 69.160.37.58:119	2
GET / HTTP/1.1	2
User-Agent: HTTP Banner Detection (https...	1
Accept: /	1
User-Agent: Mozilla/5.0 (Macintosh; Inte...	1
Connection: close	1
Connection: keep-alive	1
TOTAL: 7	9

NNRP client timeouts [Top 20]:

System	Conn	Peer
68-190-164-53.dhcp.eucl.wi.charter.com	11	0
ip72-222-200-117.ph.ph.cox.net	4	0
c-73-140-175-55.hsd1.wa.comcast.net	1	0
91.187.33.87	1	0
TOTAL: 4	17	0

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	comp.sys.ibm.ps2.hardware	13
TOTAL: 1		13

Daily Usenet report for csiph.com

Mar 1 04:15:00 -- Mar 2 04:15:00