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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	18279	46.7%	4.8 MB	62.3%
innd	16522	42.2%	2.2 MB	28.4%
innfeed	3484	8.9%	634.4 KB	8.1%
nnrpd	847	2.2%	91.8 KB	1.2%
nocem	25	0.1%	3.0 KB	0.0%
controlchan	1	0.0%	0.2 KB	0.0%
TOTAL: 6	39158	100.0%	7.7 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	311497	58.2%
Negative hits	205568	38.4%
Do not exist	17583	3.3%
Cache misses	239	0.0%
TOTAL: 4	534887	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.479	0.0%	41	0.000	11.683	56.500
article cleanup	00:00:00.111	0.0%	17394	0.000	0.006	0.028
article logging	00:00:00.266	0.0%	17900	0.000	0.015	0.417
article parse	00:00:00.924	0.0%	50990	0.000	0.018	0.180
article write	00:00:25.197	0.0%	15099	0.178	1.669	44.823
artlog/artcncl	00:00:00.001	0.0%	41	0.000	0.024	1.000
artlog/artparse	00:00:00.002	0.0%	342	0.000	0.006	1.000
data move	00:00:00.137	0.0%	500887	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.120	0.0%	37	0.000	3.243	23.250
hishave/artcncl	00:00:00.018	0.0%	41	0.000	0.439	3.750
hishave/artparse	00:00:00.000	0.0%	338	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:13.142	0.0%	538355	0.002	0.024	0.579
history sync	00:00:00.860	0.0%	341	0.000	2.522	22.750
history write	00:00:19.783	0.0%	17383	0.151	1.138	19.651
hiswrite/artcncl	00:00:00.006	0.0%	4	0.333	1.500	5.000
hiswrite/artparse	00:00:00.472	0.0%	338	0.000	1.396	48.000
idle	23:57:23.892	99.8%	504819	95.963	170.841	471.612
nntp read	00:00:01.886	0.0%	507592	0.001	0.004	0.007
overview write	00:01:14.469	0.1%	15099	0.114	4.932	254.677
perl filter	00:00:24.293	0.0%	17379	1.175	1.398	1.948
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.245	0.0%	30223	0.000	0.008	0.032
TOTAL: 24:00:40.696	24:00:06.303	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.045	0.0%	15259	0.000	0.003	0.046
article prepare	00:00:00.001	0.0%	12592	0.000	0.000	0.007
article read	00:00:00.285	0.0%	1617	0.000	0.176	2.722
backlog stats	00:00:00.211	0.0%	352386	0.000	0.001	0.004
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.297	0.0%	277229	0.000	0.005	0.010
data write	00:00:01.485	0.0%	264859	0.001	0.006	0.012
idle	23:54:53.173	100.0%	352386	131.801	244.315	656.615
status file	00:00:00.193	0.0%	265	0.000	0.728	5.750
TOTAL: 23:55:02.409	23:54:56.690	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	38:21:35.623	99.8%	503	274.667	274543.982	600189.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.010	0.0%	1171	0.000	0.009	0.167
readart	00:00:00.352	0.0%	33	10.667	10.667	10.667
TOTAL: 38:25:24.615	38:21:35.985	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	14665	3839	10768	58	26%	24:16:18
2	news-out.mixmin.net	2	15865	2970	12628	267	18%	24:08:53
3	feeder.eternal-september.org	5	18155	2341	15742	72	12%	28:12:31
4	news-out.aioe.org	2	14732	1116	13558	58	7%	23:59:57
5	newsfeed.neva.ru	143	16385	990	15142	253	6%	72:04:12
6	csiph-out.news.weretis.net	3	31681	834	30463	384	2%	48:47:34
7	csiph-out.news.xs4all.nl	861	16208	796	14665	747	4%	71:27:44
8	newsfeed.fu-berlin.de	9	13225	744	12390	91	5%	21:04:24
9	csiph-out.feeder.erje.net	1440	75652	663	74765	224	0%	118:41:19
10	news.fcku.it	10	1999	322	1671	6	16%	22:39:02
11	csiph-out.feed.uzoreto.com	864	22710	180	22167	363	0%	71:12:20
12	news-out.neodome.net	2	16290	153	16048	89	0%	23:59:53
13	news.freedyn.net	2	17651	70	17493	88	0%	23:59:46
14	nntp.pasdenom.info	2	10000	46	9935	19	0%	23:58:56
15	news.swapon.de	5	1598	33	1564	1	2%	23:47:38
16	csiph-out.news.tnetconsulting.net	2	15289	24	15208	57	0%	23:59:49
17	news.samoylyk.net	3	14826	14	14811	1	0%	24:57:12
18	news.bbs.nz	1	14555	13	14542	0	0%	23:59:53
19	xanadu-bbs.net	26	583	0	581	2	0%	22:19:59
20	localhost	26	0	0	0	0	0%	00:00:07
TOTAL: 20		3411	332069	15148	314141	2780	4%	717:37:27

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeeds.xmission.com	11.6 MB	0.0 KB	3.7 MB	15.3 MB	75%	4.0 KB
2	feeder.eternal-september.org	6.5 MB	0.0 KB	609.0 KB	7.1 MB	91%	3.0 KB
3	news-out.mixmin.net	5.8 MB	2.7 KB	896.3 KB	6.7 MB	86%	2.1 KB
4	csiph-out.feeder.erje.net	3.9 MB	8.2 KB	3.0 MB	6.9 MB	56%	8.0 KB
5	news-out.aioe.org	3.5 MB	2.7 KB	157.9 KB	3.7 MB	95%	3.2 KB
6	newsfeed.neva.ru	2.8 MB	8.2 KB	748.3 KB	3.6 MB	79%	2.9 KB
7	csiph-out.news.weretis.net	2.7 MB	2.7 KB	2.8 MB	5.5 MB	49%	4.6 KB
8	csiph-out.news.xs4all.nl	2.1 MB	0.0 KB	3.8 MB	5.9 MB	35%	3.9 KB
9	newsfeed.fu-berlin.de	1.9 MB	0.0 KB	335.2 KB	2.2 MB	85%	2.7 KB
10	news-out.neodome.net	734.0 KB	2.7 KB	517.8 KB	1.2 MB	58%	5.2 KB
11	csiph-out.feed.uzoreto.com	689.3 KB	5.5 KB	9.6 MB	10.3 MB	6%	19.4 KB
12	news.fcku.it	543.6 KB	0.0 KB	7.2 KB	550.7 KB	98%	1.7 KB
13	news.freedyn.net	499.3 KB	2.7 KB	2.8 MB	3.3 MB	14%	21.1 KB
14	news.swapon.de	135.3 KB	0.0 KB	29.8 KB	165.1 KB	81%	4.9 KB
15	nntp.pasdenom.info	118.3 KB	0.0 KB	33.2 KB	151.4 KB	78%	2.3 KB
16	csiph-out.news.tnetconsulting.net	96.2 KB	2.6 KB	256.5 KB	355.3 KB	27%	4.4 KB
17	news.samoylyk.net	40.1 KB	2.7 KB	2.7 KB	45.6 KB	88%	3.0 KB
18	news.bbs.nz	30.0 KB	0.0 KB	0.0 KB	30.0 KB	100%	2.3 KB
19	xanadu-bbs.net	0.0 KB	0.0 KB	3.8 KB	3.8 KB	0%	1.9 KB
20	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 20		43.6 MB	40.7 KB	29.2 MB	72.9 MB	59%	4.2 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Sep 1 04:15:00 - 04:59:59	312	2.1%	0.12	1.4 MB	3.3%	0.54
Sep 1 05:00:00 - 05:59:59	358	2.4%	0.10	1.2 MB	2.7%	0.33
Sep 1 06:00:00 - 06:59:59	545	3.6%	0.15	1.5 MB	3.5%	0.43
Sep 1 07:00:00 - 07:59:59	653	4.3%	0.18	1.9 MB	4.4%	0.54
Sep 1 08:00:00 - 08:59:59	629	4.2%	0.17	1.5 MB	3.5%	0.43
Sep 1 09:00:00 - 09:59:59	669	4.4%	0.19	1.6 MB	3.7%	0.46
Sep 1 10:00:00 - 10:59:59	794	5.3%	0.22	2.0 MB	4.5%	0.56
Sep 1 11:00:00 - 11:59:59	629	4.2%	0.17	1.6 MB	3.6%	0.45
Sep 1 12:00:00 - 12:59:59	673	4.5%	0.19	1.9 MB	4.3%	0.53
Sep 1 13:00:00 - 13:59:59	697	4.6%	0.19	1.8 MB	4.2%	0.52
Sep 1 14:00:00 - 14:59:59	835	5.5%	0.23	2.4 MB	5.6%	0.69
Sep 1 15:00:00 - 15:59:59	897	5.9%	0.25	2.6 MB	6.0%	0.74
Sep 1 16:00:00 - 16:59:59	980	6.5%	0.27	3.1 MB	7.2%	0.89
Sep 1 17:00:00 - 17:59:59	890	5.9%	0.25	2.5 MB	5.8%	0.72
Sep 1 18:00:00 - 18:59:59	867	5.7%	0.24	2.2 MB	5.0%	0.62
Sep 1 19:00:00 - 19:59:59	809	5.4%	0.22	2.3 MB	5.4%	0.67
Sep 1 20:00:00 - 20:59:59	703	4.7%	0.20	1.9 MB	4.4%	0.54
Sep 1 21:00:00 - 21:59:59	551	3.7%	0.15	1.6 MB	3.7%	0.46
Sep 1 22:00:00 - 22:59:59	579	3.8%	0.16	1.8 MB	4.1%	0.51
Sep 1 23:00:00 - 23:59:59	454	3.0%	0.13	1.5 MB	3.4%	0.42
Sep 2 00:00:00 - 00:59:59	355	2.4%	0.10	1.1 MB	2.6%	0.32
Sep 2 01:00:00 - 01:59:59	416	2.8%	0.12	1.5 MB	3.4%	0.42
Sep 2 02:00:00 - 02:59:59	359	2.4%	0.10	996.5 KB	2.2%	0.28
Sep 2 03:00:00 - 03:59:59	312	2.1%	0.09	857.8 KB	1.9%	0.24
Sep 2 04:00:00 - 04:15:00	129	0.9%	0.14	647.6 KB	1.5%	0.72
TOTAL: 24:00:00	15095	100.0%	0.17	43.4 MB	100.0%	0.51

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.news.xs4all.nl	752	35	0	717
2	newsfeed.fu-berlin.de	509	38	0	471
3	csiph-out.feed.uzoreto.com	364	14	2	348
4	csiph-out.news.weretis.net	350	100	1	249
5	news-out.mixmin.net	311	10	1	300
6	newsfeed.neva.ru	250	48	3	199
7	csiph-out.feeder.erje.net	154	34	3	117
8	news-out.neodome.net	91	1	1	89
9	news.freedyn.net	85	0	1	84
10	news-out.aioe.org	79	52	1	26
11	feeder.eternal-september.org	67	41	0	26
12	newsfeeds.xmission.com	60	10	0	50
13	csiph-out.news.tnetconsulting.net	33	21	1	11
14	nntp.pasdenom.info	19	0	0	19
15	news.swapon.de	10	0	0	10
16	news.fcku.it	6	6	0	0
17	xanadu-bbs.net	2	0	0	2
18	news.samoylyk.net	1	0	1	0
TOTAL: 18		3143	410	15	2718

Unwanted newsgroups [Top 20]:

Newsgroup	Count
alt.computer.workshop	62
alt.tv.comedy-central.daily-show	36
lada.talk	32
mozilla.support.thunderbird	30
scinet.stats	27
it-alt.sport.calcio.juventus	23
alt.bbs.synchronet	21
alt.politics	16
alt.politics.usa	14
mozilla.support.seamonkey	11
cakewalk.audio	10
alt.binaries.pictures.purebeauty	9
alt.philosophy	9
alt.survival	7
lada.auto	5
alt.culture	5
mozilla.community.sweden	4
alt.politics.republican	4
fido7.ru.android	4
oesterreich.tratsch	3
TOTAL: 77	410

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	1093
EMP (phn path)	396
EMP (phl)	168
EMP (phn nph)	71
Too many newsgroups	68
0	40
HTML Multipart	18
Binary: misplaced binary	9
Binary Payload	7
TOTAL: 9	1870

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	csiph-out.feeder.erje.net	115
	csiph-out.news.xs4all.nl	13
	csiph-out.feed.uzoreto.com	13
	TOTAL: 3	141
Huge articles
	csiph-out.feed.uzoreto.com	121
	csiph-out.feeder.erje.net	55
	newsfeeds.xmission.com	48
	news.freedyn.net	39
	csiph-out.news.xs4all.nl	33
	csiph-out.news.weretis.net	19
	news-out.mixmin.net	9
	news-out.neodome.net	8
	feeder.eternal-september.org	5
	csiph-out.news.tnetconsulting.net	1
	TOTAL: 11	339
Including strange strings
	newsfeed.fu-berlin.de	403
	news-out.mixmin.net	45
	news-out.aioe.org	24
	csiph-out.news.weretis.net	14
	news.swapon.de	9
	csiph-out.news.xs4all.nl	4
	feeder.eternal-september.org	4
	newsfeeds.xmission.com	2
	TOTAL: 8	505
No colon-space in header
	csiph-out.news.xs4all.nl	4
	TOTAL: 1	4
TOTAL: 4		989

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	18773	1201	13884	10	0	6%	23:59:56
2	news.bbs.nz	28648	468	14212	22	1	1%	23:59:52
3	fu-berlin.de	14155	379	13776	0	0	2%	23:59:53
4	news.samoylyk.net	15566	359	14722	2	51	2%	23:59:56
5	tnet	15949	140	14577	0	0	0%	23:59:56
6	news.freedyn.net	15074	71	14741	1	0	0%	23:59:56
7	newsfeed.xs4all.nl	14665	45	14148	19	128	0%	23:59:55
8	eternal-september	13189	41	12374	5	0	0%	23:59:52
9	xmission	13303	37	10805	9	0	0%	23:59:56
10	erje	14823	24	14308	30	0	0%	23:59:56
11	usenet.pasdenom.info	15190	22	14635	13	11	0%	23:59:56
12	neva.ru	13580	18	13346	142	0	0%	23:59:13
13	neodome.net	15247	15	14841	0	0	0%	23:53:32
14	news.uzoreto.com	14838	15	14541	59	0	0%	23:59:49
15	news.mixmin.net	11773	15	11515	2	0	0%	23:59:55
16	aioe	11220	8	10754	0	0	0%	23:59:56
17	news.fcku.it	1483	1	1478	0	0	0%	21:52:44
18	weretis.net	13919	0	13786	0	0	0%	23:59:56
19	news.swapon.de	1624	0	1607	0	0	0%	23:51:58
TOTAL: 19		263019	2859	234050	314	191	1%	453:36:07

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	5.8 MB	68.8 KB	5.9 MB	0.1 KB/s	5.0 KB	23:59:56
2	fu-berlin.de	3.2 MB	0.0 KB	3.2 MB	0.0 KB/s	8.6 KB	23:59:53
3	news.samoylyk.net	3.0 MB	2.4 KB	3.0 MB	0.0 KB/s	8.6 KB	23:59:56
4	news.bbs.nz	1.3 MB	383.8 KB	1.7 MB	0.0 KB/s	3.6 KB	23:59:52
5	news.freedyn.net	1.0 MB	1.0 KB	1.0 MB	0.0 KB/s	14.5 KB	23:59:56
6	tnet	470.8 KB	0.0 KB	470.8 KB	0.0 KB/s	3.4 KB	23:59:56
7	eternal-september	189.3 KB	20.5 KB	209.8 KB	0.0 KB/s	4.6 KB	23:59:52
8	xmission	107.8 KB	17.4 KB	125.2 KB	0.0 KB/s	2.7 KB	23:59:56
9	newsfeed.xs4all.nl	107.6 KB	83.2 KB	190.8 KB	0.0 KB/s	3.0 KB	23:59:55
10	neva.ru	77.3 KB	365.3 KB	442.6 KB	0.0 KB/s	2.8 KB	23:59:13
11	usenet.pasdenom.info	58.0 KB	382.0 KB	440.1 KB	0.0 KB/s	12.6 KB	23:59:56
12	erje	41.7 KB	220.8 KB	262.5 KB	0.0 KB/s	4.9 KB	23:59:56
13	news.uzoreto.com	34.6 KB	209.1 KB	243.6 KB	0.0 KB/s	3.3 KB	23:59:49
14	news.mixmin.net	31.4 KB	78.5 KB	110.0 KB	0.0 KB/s	6.5 KB	23:59:55
15	neodome.net	30.0 KB	0.0 KB	30.0 KB	0.0 KB/s	2.0 KB	23:53:32
16	aioe	18.9 KB	0.0 KB	18.9 KB	0.0 KB/s	2.4 KB	23:59:56
17	news.fcku.it	2.0 KB	0.0 KB	2.0 KB	0.0 KB/s	2.0 KB	21:52:44
18	weretis.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:59:56
19	news.swapon.de	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:51:58
TOTAL: 19		15.5 MB	1.8 MB	17.3 MB	0.0 KB/s	5.6 KB	453:36:07

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	ip72-222-200-117.ph.ph.cox.net	5	33	80.8 KB	2	0	0	01:42:02
TOTAL: 1		5	33	80.8 KB	2	0	0	38:25:23

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	*.ph.ph.cox.net	5	33	80.8 KB	2	01:42:02
2	unresolved	59	0	0.0 KB	0	18:23:42
3	*.net.upcbroadband.cz	14	0	0.0 KB	0	04:26:19
4	*.res.spectrum.com	22	0	0.0 KB	0	08:20:25
5	*.upc-a.chello.nl	34	0	0.0 KB	0	05:32:53
TOTAL: 5		134	33	80.8 KB	2	38:25:23

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
91.187.33.87	3.409	0.971	18:23:29
096-042-018-019.res.spectrum.com	1.392	0.313	08:20:25
a131033.upc-a.chello.nl	2.089	0.484	05:32:53
ip-89-176-128-12.net.upcbroadband.cz	0.888	0.191	04:26:19
ip72-222-200-117.ph.ph.cox.net	0.326	0.057	01:42:02
192.241.219.136	0.071	0.008	00:00:09
8.44.58.66	0.129	0.022	00:00:02
TOTAL: 7	8.304	2.046	38:25:23

Curious NNRP server explorers [Top 20]:

System	Conn
91.187.33.87	56
a131033.upc-a.chello.nl	34
096-042-018-019.res.spectrum.com	22
ip-89-176-128-12.net.upcbroadband.cz	14
8.44.58.66	2
192.241.219.136	1
TOTAL: 6	129

NNRP client timeouts [Top 20]:

System	Conn	Peer
096-042-018-019.res.spectrum.com	13	0
ip72-222-200-117.ph.ph.cox.net	3	0
TOTAL: 2	16	0

Newsgroup request counts (by category):

Category		Count	Pct
1	news	25	75.8%
2	comp	8	24.2%
TOTAL: 2		33	100.0%

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

Newsgroup		Count
1	news.software.nntp	25
2	comp.sys.ibm.ps2.hardware	8
TOTAL: 2		33

Daily Usenet report for csiph.com

Sep 1 04:15:00 -- Sep 2 04:15:00