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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	24177	51.5%	6.2 MB	66.7%
innd	18206	38.8%	2.4 MB	25.4%
innfeed	3423	7.3%	625.6 KB	6.5%
nnrpd	1080	2.3%	121.4 KB	1.3%
nocem	78	0.2%	8.6 KB	0.1%
TOTAL: 5	46964	100.0%	9.3 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	402068	56.9%
Negative hits	280194	39.7%
Do not exist	23497	3.3%
Cache misses	405	0.1%
TOTAL: 4	706164	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.201	0.0%	22	0.000	9.136	34.000
article cleanup	00:00:00.117	0.0%	22693	0.000	0.005	0.026
article logging	00:00:00.364	0.0%	23306	0.000	0.016	0.622
article parse	00:00:01.307	0.0%	83052	0.000	0.016	0.052
article write	00:00:07.929	0.0%	19165	0.157	0.414	18.564
artlog/artcncl	00:00:00.000	0.0%	22	0.000	0.000	0.000
artlog/artparse	00:00:00.010	0.0%	861	0.000	0.012	0.250
data move	00:00:00.251	0.0%	665698	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.005	0.0%	22	0.000	0.227	1.000
hishave/artcncl	00:00:00.004	0.0%	22	0.000	0.182	1.000
hishave/artparse	00:00:00.000	0.0%	853	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:03.707	0.0%	707424	0.001	0.005	0.142
history sync	00:00:00.996	0.0%	375	0.000	2.656	9.667
history write	00:00:10.746	0.0%	22697	0.043	0.473	1.521
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
hiswrite/artparse	00:00:00.492	0.0%	853	0.000	0.577	7.000
idle	23:58:58.230	99.9%	672908	65.578	128.306	429.238
nntp read	00:00:02.568	0.0%	674230	0.002	0.004	0.007
overview write	00:00:28.210	0.0%	19165	0.098	1.472	23.073
perl filter	00:00:29.797	0.0%	22689	1.080	1.313	1.979
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.300	0.0%	38408	0.000	0.008	0.031
TOTAL: 24:01:06.078	24:00:25.234	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.044	0.0%	19345	0.000	0.002	0.019
article prepare	00:00:00.001	0.0%	15444	0.000	0.000	0.005
article read	00:00:00.253	0.0%	1453	0.000	0.174	15.000
backlog stats	00:00:00.207	0.0%	444323	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.577	0.0%	353529	0.001	0.004	0.010
data write	00:00:01.953	0.0%	338791	0.001	0.006	0.013
idle	23:53:29.262	100.0%	444323	119.612	193.574	558.981
status file	00:00:00.153	0.0%	254	0.000	0.602	2.000
TOTAL: 23:53:40.671	23:53:33.450	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	46:31:22.126	99.8%	749	20.500	223607.645	600167.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.018	0.0%	1725	0.000	0.010	0.200
readart	00:00:00.600	0.0%	62	0.000	9.677	43.000
TOTAL: 46:36:17.369	46:31:22.744	99.8%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeeds.xmission.com	2	18690	4571	14059	60	24%	24:23:26
2	news-out.aioe.org	6	19662	3919	15504	239	19%	24:20:44
3	feeder.eternal-september.org	4	21476	2823	18413	240	13%	24:41:56
4	csiph-out.feeder.erje.net	1440	97956	1372	95257	1327	1%	118:42:54
5	csiph-out.news.weretis.net	3	43423	1286	41899	238	2%	51:41:11
6	csiph-out.news.xs4all.nl	860	21128	1151	19114	863	5%	71:25:49
7	newsfeed.fu-berlin.de	13	20350	1014	18899	437	4%	28:08:12
8	news-out.mixmin.net	2	20264	1006	18824	434	4%	24:08:50
9	newsfeed.neva.ru	146	19234	988	17909	337	5%	71:27:35
10	news.freedyn.net	2	22138	337	21605	196	1%	24:09:02
11	csiph-out.feed.uzoreto.com	864	32032	294	31438	300	0%	71:07:41
12	news.fcku.it	11	2213	266	1946	1	12%	22:21:54
13	csiph-out.news.tnetconsulting.net	2	18868	162	18690	16	0%	23:59:49
14	news-out.neodome.net	3	20220	124	20080	16	0%	24:08:28
15	news.swapon.de	5	3733	114	3612	7	3%	45:12:22
16	nntp.pasdenom.info	2	13397	77	13297	23	0%	23:58:43
17	news.bbs.nz	1	18548	23	18524	1	0%	23:59:52
18	localhost	40	14	14	0	0	100%	00:00:04
19	news.samoylyk.net	2	19535	12	19521	2	0%	24:57:06
20	xanadu-bbs.net	23	550	0	550	0	0%	21:22:42
TOTAL: 20		3431	433431	19553	409141	4737	4%	744:18:20

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeeds.xmission.com	13.0 MB	6.7 KB	3.8 MB	16.9 MB	77%	3.7 KB
2	news-out.aioe.org	9.3 MB	0.0 KB	435.7 KB	9.7 MB	95%	2.4 KB
3	csiph-out.feeder.erje.net	8.2 MB	2.0 KB	58.2 MB	66.5 MB	12%	25.2 KB
4	feeder.eternal-september.org	6.9 MB	0.6 KB	1.2 MB	8.1 MB	85%	2.7 KB
5	csiph-out.news.weretis.net	3.8 MB	6.7 KB	2.7 MB	6.5 MB	58%	4.4 KB
6	csiph-out.news.xs4all.nl	3.3 MB	0.0 KB	9.6 MB	12.9 MB	25%	6.6 KB
7	news-out.mixmin.net	2.7 MB	0.0 KB	934.3 KB	3.6 MB	74%	2.5 KB
8	newsfeed.fu-berlin.de	2.4 MB	2.2 KB	1.0 MB	3.4 MB	70%	2.4 KB
9	newsfeed.neva.ru	2.1 MB	0.0 KB	834.1 KB	3.0 MB	72%	2.3 KB
10	news.freedyn.net	1.1 MB	0.6 KB	839.5 KB	1.9 MB	57%	3.7 KB
11	csiph-out.feed.uzoreto.com	878.5 KB	0.0 KB	5.4 MB	6.2 MB	13%	10.8 KB
12	csiph-out.news.tnetconsulting.net	620.2 KB	0.6 KB	118.0 KB	738.9 KB	83%	4.2 KB
13	news.fcku.it	443.3 KB	0.0 KB	0.7 KB	443.9 KB	99%	1.7 KB
14	news-out.neodome.net	409.0 KB	0.6 KB	141.3 KB	550.8 KB	74%	3.9 KB
15	news.swapon.de	329.3 KB	0.0 KB	2.7 MB	3.0 MB	10%	25.6 KB
16	nntp.pasdenom.info	157.9 KB	0.0 KB	32.3 KB	190.2 KB	83%	1.9 KB
17	news.bbs.nz	34.0 KB	0.6 KB	0.6 KB	35.2 KB	96%	1.5 KB
18	news.samoylyk.net	32.2 KB	0.6 KB	1.7 KB	34.5 KB	93%	2.5 KB
19	localhost	22.9 KB	0.0 KB	0.0 KB	22.9 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		55.6 MB	21.3 KB	87.9 MB	143.6 MB	38%	6.1 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Apr 7 04:15:00 - 04:59:59	229	1.2%	0.08	657.9 KB	1.2%	0.24
Apr 7 05:00:00 - 05:59:59	410	2.1%	0.11	1.2 MB	2.2%	0.35
Apr 7 06:00:00 - 06:59:59	596	3.1%	0.17	2.4 MB	4.4%	0.69
Apr 7 07:00:00 - 07:59:59	736	3.8%	0.20	2.1 MB	3.9%	0.61
Apr 7 08:00:00 - 08:59:59	811	4.2%	0.23	2.4 MB	4.5%	0.69
Apr 7 09:00:00 - 09:59:59	935	4.9%	0.26	2.5 MB	4.5%	0.70
Apr 7 10:00:00 - 10:59:59	913	4.8%	0.25	2.6 MB	4.8%	0.74
Apr 7 11:00:00 - 11:59:59	934	4.9%	0.26	2.5 MB	4.6%	0.71
Apr 7 12:00:00 - 12:59:59	891	4.6%	0.25	2.3 MB	4.2%	0.65
Apr 7 13:00:00 - 13:59:59	1058	5.5%	0.29	2.6 MB	4.8%	0.74
Apr 7 14:00:00 - 14:59:59	1168	6.1%	0.32	3.3 MB	6.1%	0.94
Apr 7 15:00:00 - 15:59:59	1196	6.2%	0.33	3.0 MB	5.5%	0.85
Apr 7 16:00:00 - 16:59:59	1154	6.0%	0.32	3.2 MB	5.8%	0.91
Apr 7 17:00:00 - 17:59:59	1166	6.1%	0.32	3.0 MB	5.6%	0.86
Apr 7 18:00:00 - 18:59:59	1154	6.0%	0.32	3.4 MB	6.2%	0.97
Apr 7 19:00:00 - 19:59:59	1016	5.3%	0.28	2.7 MB	4.9%	0.77
Apr 7 20:00:00 - 20:59:59	914	4.8%	0.25	2.7 MB	5.0%	0.77
Apr 7 21:00:00 - 21:59:59	868	4.5%	0.24	2.4 MB	4.3%	0.67
Apr 7 22:00:00 - 22:59:59	666	3.5%	0.18	2.3 MB	4.3%	0.67
Apr 7 23:00:00 - 23:59:59	523	2.7%	0.15	1.6 MB	2.9%	0.45
Apr 8 00:00:00 - 00:59:59	480	2.5%	0.13	1.3 MB	2.4%	0.37
Apr 8 01:00:00 - 01:59:59	465	2.4%	0.13	1.4 MB	2.5%	0.38
Apr 8 02:00:00 - 02:59:59	432	2.3%	0.12	1.6 MB	3.0%	0.47
Apr 8 03:00:00 - 03:59:59	372	1.9%	0.10	1.1 MB	2.0%	0.31
Apr 8 04:00:00 - 04:15:00	75	0.4%	0.08	239.0 KB	0.4%	0.27
TOTAL: 24:00:00	19162	100.0%	0.22	54.5 MB	100.0%	0.65

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.feeder.erje.net	1035	65	1	969
2	csiph-out.news.xs4all.nl	861	36	0	825
3	newsfeed.fu-berlin.de	832	51	1	780
4	news-out.mixmin.net	416	4	0	412
5	news-out.aioe.org	369	47	0	322
6	newsfeed.neva.ru	336	107	0	229
7	csiph-out.feed.uzoreto.com	297	10	0	287
8	csiph-out.news.weretis.net	260	88	1	171
9	feeder.eternal-september.org	249	20	0	229
10	news.freedyn.net	192	7	0	185
11	newsfeeds.xmission.com	69	9	1	59
12	nntp.pasdenom.info	23	0	0	23
13	csiph-out.news.tnetconsulting.net	21	15	0	6
14	news.swapon.de	15	0	0	15
15	news-out.neodome.net	15	1	0	14
16	news.fcku.it	1	0	0	1
17	news.samoylyk.net	1	0	0	1
TOTAL: 17		4992	460	4	4528

Unwanted newsgroups [Top 20]:

Newsgroup	Count
alt.computer.workshop	53
lada.talk	42
lada.auto	40
spline.eisfair	39
mozilla.general	31
mozilla.support.thunderbird	27
mozilla.support.seamonkey	25
alt.bbs.synchronet	25
alt.politics	14
alt.windows7.general	14
alt.politics.usa	12
alt.survival	10
alt.binaries.pictures.purebeauty	9
mozilla.dev.servo	6
mozilla.dev.apps.seamonkey	5
mozilla.dev.platform	5
oesterreich.tratsch	5
alt.binaries.sounds.radio.bbc.highspeed	5
alt.philosophy	4
rocksolid.nodes.announce	4
TOTAL: 77	460

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	1781
EMP (phn path)	506
EMP (phl)	282
EMP (phn nph)	258
0	125
Too many newsgroups	48
HTML Multipart	19
Binary Payload	14
Scoring filter	12
Too many newsgroups (meow)	5
Too many newsgroups (low_xpost)	4
Binary: misplaced binary	3
TOTAL: 12	3057

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	660
	csiph-out.news.xs4all.nl	59
	newsfeeds.xmission.com	53
	csiph-out.feed.uzoreto.com	36
	csiph-out.news.weretis.net	19
	feeder.eternal-september.org	8
	csiph-out.news.tnetconsulting.net	6
	news.swapon.de	5
	news.freedyn.net	4
	news-out.neodome.net	2
	TOTAL: 11	854
Including strange strings
	newsfeed.fu-berlin.de	431
	news-out.aioe.org	129
	csiph-out.news.weretis.net	12
	news.swapon.de	10
	news-out.mixmin.net	9
	newsfeeds.xmission.com	7
	newsfeed.neva.ru	5
	csiph-out.news.xs4all.nl	4
	csiph-out.feeder.erje.net	2
	csiph-out.feed.uzoreto.com	1
	TOTAL: 10	610
No colon-space in header
	csiph-out.news.xs4all.nl	4
	csiph-out.feeder.erje.net	3
	TOTAL: 2	7
TOTAL: 4		1516

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	22974	998	18155	9	47	4%	23:59:56
2	news.freedyn.net	19213	511	18253	22	0	2%	23:59:50
3	news.samoylyk.net	19770	510	18636	6	26	2%	23:59:55
4	fu-berlin.de	18033	499	17534	0	0	2%	23:59:55
5	news.bbs.nz	36287	433	18201	3	7	1%	23:59:55
6	tnet	20229	140	18522	0	0	0%	23:59:56
7	newsfeed.xs4all.nl	18580	72	17782	16	111	0%	23:59:55
8	xmission	17026	46	14074	2	0	0%	23:59:49
9	neva.ru	17570	41	17307	97	0	0%	23:59:55
10	aioe	14598	33	13995	0	0	0%	23:59:55
11	usenet.pasdenom.info	19459	30	18536	15	21	0%	23:59:55
12	news.mixmin.net	18373	23	17377	0	0	0%	23:59:23
13	neodome.net	19606	22	18962	0	1	0%	23:59:54
14	news.uzoreto.com	19002	21	18394	13	0	0%	23:59:55
15	weretis.net	17614	16	17340	0	0	0%	23:59:56
16	eternal-september	16255	16	15603	0	0	0%	23:59:55
17	news.swapon.de	1876	16	1824	0	0	0%	23:47:27
18	erje	17799	15	17397	235	0	0%	23:59:53
19	news.fcku.it	1854	1	1845	0	0	0%	21:44:54
TOTAL: 19		336118	3443	299737	418	213	1%	453:30:13

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	7.1 MB	26.4 KB	7.1 MB	0.1 KB/s	7.3 KB	23:59:56
2	news.freedyn.net	5.8 MB	39.2 KB	5.8 MB	0.1 KB/s	11.1 KB	23:59:50
3	news.samoylyk.net	5.7 MB	6.4 KB	5.7 MB	0.1 KB/s	11.3 KB	23:59:55
4	fu-berlin.de	5.7 MB	0.0 KB	5.7 MB	0.1 KB/s	11.6 KB	23:59:55
5	news.bbs.nz	1.2 MB	45.6 KB	1.2 MB	0.0 KB/s	2.8 KB	23:59:55
6	tnet	394.1 KB	0.0 KB	394.1 KB	0.0 KB/s	2.8 KB	23:59:56
7	newsfeed.xs4all.nl	163.7 KB	44.4 KB	208.1 KB	0.0 KB/s	2.4 KB	23:59:55
8	xmission	120.0 KB	4.3 KB	124.4 KB	0.0 KB/s	2.6 KB	23:59:49
9	neva.ru	78.9 KB	273.3 KB	352.2 KB	0.0 KB/s	2.6 KB	23:59:55
10	usenet.pasdenom.info	66.0 KB	19.5 KB	85.5 KB	0.0 KB/s	1.9 KB	23:59:55
11	aioe	58.1 KB	0.0 KB	58.1 KB	0.0 KB/s	1.8 KB	23:59:55
12	news.uzoreto.com	39.6 KB	24.5 KB	64.1 KB	0.0 KB/s	1.9 KB	23:59:55
13	neodome.net	38.8 KB	0.0 KB	38.8 KB	0.0 KB/s	1.8 KB	23:59:54
14	news.mixmin.net	36.6 KB	0.0 KB	36.6 KB	0.0 KB/s	1.6 KB	23:59:23
15	erje	29.9 KB	800.7 KB	830.6 KB	0.0 KB/s	3.3 KB	23:59:53
16	eternal-september	27.7 KB	0.0 KB	27.7 KB	0.0 KB/s	1.7 KB	23:59:55
17	news.swapon.de	27.7 KB	0.0 KB	27.7 KB	0.0 KB/s	1.7 KB	23:47:27
18	weretis.net	26.8 KB	0.0 KB	26.8 KB	0.0 KB/s	1.7 KB	23:59:56
19	news.fcku.it	1.3 KB	0.0 KB	1.3 KB	0.0 KB/s	1.3 KB	21:44:54
TOTAL: 19		26.5 MB	1.3 MB	27.7 MB	0.0 KB/s	7.4 KB	453:30:13

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	a131033.upc-a.chello.nl	35	36	83.1 KB	7	0	0	07:31:06
2	96-42-18-55.dhcp.mdsn.wi.charter.com	42	25	49.9 KB	18	14	12	11:34:47
3	5-168-143-94.cust.centrio.cz	4	1	3.5 KB	1	0	0	02:00:09
TOTAL: 3		81	62	136.5 KB	26	14	12	46:36:16

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.upc-a.chello.nl	35	36	83.1 KB	7	0	0	07:31:06
2	*.dhcp.mdsn.wi.charter.com	42	25	49.9 KB	18	14	12	11:34:47
3	*.cust.centrio.cz	4	1	3.5 KB	1	0	0	02:00:09
4	unresolved	78	0	0.0 KB	0	0	0	24:00:03
5	*.ph.ph.cox.net	3	0	0.0 KB	0	0	0	01:30:09
TOTAL: 5		162	62	136.5 KB	26	14	12	46:36:16

NNRP auth users [Top 20]:

User	Conn
ohlandl	12
ctomczyk	4
TOTAL: 2	16

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
91.187.33.87	5.277	1.163	0.000	23:59:48
96-42-18-55.dhcp.mdsn.wi.charter.com	3.600	0.692	0.031	11:34:47
a131033.upc-a.chello.nl	2.652	0.559	0.000	07:31:06
5-168-143-94.cust.centrio.cz	0.349	0.054	0.011	02:00:09
ip72-222-200-117.ph.ph.cox.net	0.308	0.068	0.000	01:30:09
162.243.130.199	0.063	0.016	0.000	00:00:09
94.160.106.47	0.145	0.008	0.000	00:00:02
5.87.144.222	0.064	0.016	0.000	00:00:01
5.87.162.100	0.055	0.024	0.000	00:00:01
45.13.93.82	0.076	0.000	0.000	00:00:00
TOTAL: 10	12.589	2.600	0.042	46:36:16

Curious NNRP server explorers [Top 20]:

System	Conn
91.187.33.87	72
ip72-222-200-117.ph.ph.cox.net	3
94.160.106.47	2
5.87.144.222	1
45.13.93.82	1
162.243.130.199	1
5.87.162.100	1
TOTAL: 7	81

NNRP unrecognized commands (by host):

System	Conn
45.13.93.82	3
TOTAL: 1	3

NNRP unrecognized commands (by command):

Command	Count
CONNECT ip.ws.126.net:443 HTTP/1.1	1
Host: ip.ws.126.net:443	1
User-Agent: Go-http-client/1.1	1
TOTAL: 3	3

NNRP client timeouts [Top 20]:

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

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	comp.sys.ibm.ps2.hardware	61
2	comp.lang.javascript	1
TOTAL: 2		62

Daily Usenet report for csiph.com

Apr 7 04:15:00 -- Apr 8 04:15:00