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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	17981	45.5%	4.6 MB	60.7%
innd	17020	43.1%	2.3 MB	30.0%
innfeed	3504	8.9%	612.4 KB	7.9%
nnrpd	969	2.5%	105.8 KB	1.4%
nocem	40	0.1%	5.1 KB	0.1%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	39515	100.0%	7.6 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	293842	56.9%
Negative hits	205355	39.7%
Do not exist	17406	3.4%
Cache misses	245	0.0%
TOTAL: 4	516848	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.547	0.0%	33	0.000	16.576	95.500
article cleanup	00:00:00.094	0.0%	17085	0.000	0.006	0.039
article logging	00:00:00.260	0.0%	17610	0.000	0.015	0.107
article parse	00:00:00.674	0.0%	54484	0.000	0.012	0.034
article write	00:00:05.570	0.0%	14183	0.163	0.393	8.000
artlog/artcncl	00:00:00.000	0.0%	33	0.000	0.000	0.000
artlog/artparse	00:00:00.003	0.0%	338	0.000	0.009	0.333
data move	00:00:00.170	0.0%	483874	0.000	0.000	0.001
hisgrep/artcncl	00:00:00.009	0.0%	33	0.000	0.273	1.000
hishave/artcncl	00:00:00.020	0.0%	33	0.000	0.606	5.000
hishave/artparse	00:00:00.000	0.0%	335	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.674	0.0%	517677	0.001	0.007	0.074
history sync	00:00:00.727	0.0%	382	0.000	1.903	14.000
history write	00:00:08.429	0.0%	17087	0.032	0.493	6.973
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
hiswrite/artparse	00:00:00.164	0.0%	335	0.000	0.490	4.000
idle	23:59:21.292	99.9%	492178	85.632	175.468	536.399
nntp read	00:00:01.838	0.0%	492023	0.001	0.004	0.008
overview write	00:00:28.031	0.0%	14183	0.134	1.976	84.128
perl filter	00:00:23.223	0.0%	17084	1.054	1.359	1.980
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.232	0.0%	28406	0.000	0.008	0.043
TOTAL: 24:01:04.796	24:00:34.957	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.020	0.0%	14288	0.000	0.001	0.018
article prepare	00:00:00.002	0.0%	14100	0.000	0.000	0.031
article read	00:00:00.233	0.0%	1436	0.000	0.162	15.333
backlog stats	00:00:00.158	0.0%	327125	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.128	0.0%	259193	0.001	0.004	0.009
data write	00:00:01.447	0.0%	247587	0.001	0.006	0.013
idle	23:54:01.966	100.0%	327125	134.753	263.025	795.346
status file	00:00:00.175	0.0%	271	0.000	0.646	2.000
TOTAL: 23:54:10.939	23:54:05.129	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	45:18:54.166	99.8%	636	1390.273	256500.261	600192.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.014	0.0%	1452	0.000	0.010	0.167
readart	00:00:00.349	0.0%	29	0.000	12.034	42.000
TOTAL: 45:23:49.243	45:18:54.529	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	13590	3531	10026	33	25%	23:51:57
2	news-out.aioe.org	3	13599	2367	11171	61	17%	24:09:41
3	feeder.eternal-september.org	4	15549	1967	13338	244	12%	23:50:44
4	news-out.mixmin.net	2	14908	1052	13512	344	7%	24:08:55
5	csiph-out.feeder.erje.net	1440	71416	891	70085	440	1%	118:47:08
6	newsfeed.fu-berlin.de	9	12517	804	11636	77	6%	22:17:53
7	csiph-out.news.xs4all.nl	861	15907	800	14089	1018	5%	71:28:31
8	csiph-out.news.weretis.net	2	40374	742	39359	273	1%	62:28:11
9	newsfeed.neva.ru	143	14730	667	13796	267	4%	71:54:28
10	news.freedyn.net	2	16675	648	15864	163	3%	24:09:59
11	news.fcku.it	14	1696	278	1416	2	16%	22:40:59
12	csiph-out.feed.uzoreto.com	863	22717	166	22273	278	0%	71:16:46
13	news-out.neodome.net	1	15127	111	15010	6	0%	23:59:53
14	csiph-out.news.tnetconsulting.net	2	15045	102	14901	42	0%	23:59:55
15	news.swapon.de	7	1204	20	1184	0	1%	23:35:59
16	news.bbs.nz	1	14527	13	14514	0	0%	23:59:54
17	nntp.pasdenom.info	5	9333	11	9304	18	0%	23:56:42
18	news.samoylyk.net	2	13766	8	13758	0	0%	23:59:53
19	localhost	32	6	6	0	0	100%	00:00:04
20	xanadu-bbs.net	35	496	0	496	0	0%	22:12:49
TOTAL: 20		3430	323182	14184	305732	3266	4%	726:50:21

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeeds.xmission.com	10.0 MB	0.0 KB	1.8 MB	11.9 MB	84%	3.4 KB
2	news-out.aioe.org	6.0 MB	0.0 KB	301.6 KB	6.3 MB	95%	2.7 KB
3	csiph-out.feeder.erje.net	5.9 MB	0.0 KB	9.1 MB	15.0 MB	39%	11.5 KB
4	feeder.eternal-september.org	5.0 MB	1.4 KB	956.0 KB	5.9 MB	84%	2.7 KB
5	news-out.mixmin.net	3.6 MB	0.0 KB	674.4 KB	4.3 MB	84%	3.1 KB
6	csiph-out.news.xs4all.nl	2.7 MB	0.0 KB	12.7 MB	15.4 MB	17%	8.7 KB
7	csiph-out.news.weretis.net	2.3 MB	0.0 KB	2.2 MB	4.5 MB	51%	4.6 KB
8	news.freedyn.net	2.1 MB	0.0 KB	1.4 MB	3.6 MB	59%	4.5 KB
9	newsfeed.fu-berlin.de	2.0 MB	0.0 KB	178.3 KB	2.2 MB	91%	2.5 KB
10	newsfeed.neva.ru	1.7 MB	0.0 KB	1.1 MB	2.8 MB	60%	3.1 KB
11	csiph-out.feed.uzoreto.com	572.4 KB	0.0 KB	7.5 MB	8.1 MB	6%	18.6 KB
12	news.fcku.it	437.8 KB	0.0 KB	1.7 KB	439.6 KB	99%	1.6 KB
13	news-out.neodome.net	341.1 KB	0.0 KB	7.1 KB	348.3 KB	97%	3.0 KB
14	csiph-out.news.tnetconsulting.net	290.3 KB	0.0 KB	84.6 KB	374.9 KB	77%	2.6 KB
15	news.swapon.de	61.3 KB	0.0 KB	0.0 KB	61.3 KB	100%	3.1 KB
16	news.bbs.nz	34.1 KB	0.0 KB	0.0 KB	34.1 KB	100%	2.6 KB
17	news.samoylyk.net	25.2 KB	0.0 KB	0.0 KB	25.2 KB	100%	3.1 KB
18	nntp.pasdenom.info	18.3 KB	0.0 KB	36.3 KB	54.6 KB	33%	1.9 KB
19	localhost	7.9 KB	0.0 KB	0.0 KB	7.9 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		43.1 MB	1.4 KB	38.1 MB	81.2 MB	53%	4.8 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Mar 7 04:15:00 - 04:59:59	172	1.2%	0.06	531.4 KB	1.2%	0.20
Mar 7 05:00:00 - 05:59:59	287	2.0%	0.08	887.4 KB	2.0%	0.25
Mar 7 06:00:00 - 06:59:59	387	2.7%	0.11	1.2 MB	2.9%	0.35
Mar 7 07:00:00 - 07:59:59	491	3.5%	0.14	2.2 MB	5.2%	0.64
Mar 7 08:00:00 - 08:59:59	630	4.4%	0.17	2.0 MB	4.5%	0.56
Mar 7 09:00:00 - 09:59:59	696	4.9%	0.19	1.9 MB	4.5%	0.55
Mar 7 10:00:00 - 10:59:59	619	4.4%	0.17	1.6 MB	3.6%	0.44
Mar 7 11:00:00 - 11:59:59	645	4.5%	0.18	2.2 MB	5.2%	0.64
Mar 7 12:00:00 - 12:59:59	655	4.6%	0.18	1.7 MB	3.8%	0.47
Mar 7 13:00:00 - 13:59:59	670	4.7%	0.19	1.8 MB	4.1%	0.50
Mar 7 14:00:00 - 14:59:59	664	4.7%	0.18	1.9 MB	4.4%	0.55
Mar 7 15:00:00 - 15:59:59	802	5.7%	0.22	2.7 MB	6.2%	0.77
Mar 7 16:00:00 - 16:59:59	800	5.6%	0.22	2.3 MB	5.3%	0.66
Mar 7 17:00:00 - 17:59:59	846	6.0%	0.23	2.4 MB	5.5%	0.68
Mar 7 18:00:00 - 18:59:59	811	5.7%	0.23	2.1 MB	4.8%	0.59
Mar 7 19:00:00 - 19:59:59	906	6.4%	0.25	3.1 MB	7.1%	0.87
Mar 7 20:00:00 - 20:59:59	690	4.9%	0.19	1.9 MB	4.5%	0.55
Mar 7 21:00:00 - 21:59:59	746	5.3%	0.21	2.0 MB	4.7%	0.57
Mar 7 22:00:00 - 22:59:59	523	3.7%	0.15	1.4 MB	3.3%	0.40
Mar 7 23:00:00 - 23:59:59	534	3.8%	0.15	2.0 MB	4.6%	0.57
Mar 8 00:00:00 - 00:59:59	469	3.3%	0.13	1.4 MB	3.3%	0.41
Mar 8 01:00:00 - 01:59:59	390	2.7%	0.11	1.1 MB	2.6%	0.32
Mar 8 02:00:00 - 02:59:59	320	2.3%	0.09	989.1 KB	2.2%	0.27
Mar 8 03:00:00 - 03:59:59	348	2.5%	0.10	1.7 MB	4.0%	0.49
Mar 8 04:00:00 - 04:15:00	81	0.6%	0.09	247.1 KB	0.6%	0.27
TOTAL: 24:00:00	14182	100.0%	0.16	43.3 MB	100.0%	0.51

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.news.xs4all.nl	1022	73	0	949
2	newsfeed.fu-berlin.de	502	35	0	467
3	csiph-out.feeder.erje.net	440	53	0	387
4	news-out.mixmin.net	354	16	0	338
5	csiph-out.feed.uzoreto.com	279	15	0	264
6	newsfeed.neva.ru	268	30	0	238
7	feeder.eternal-september.org	252	25	1	226
8	csiph-out.news.weretis.net	243	143	0	100
9	news.freedyn.net	173	14	0	159
10	news-out.aioe.org	136	59	0	77
11	newsfeeds.xmission.com	38	8	0	30
12	csiph-out.news.tnetconsulting.net	27	23	0	4
13	nntp.pasdenom.info	18	0	0	18
14	news-out.neodome.net	7	0	0	7
15	news.swapon.de	5	0	0	5
16	news.fcku.it	2	1	0	1
TOTAL: 16		3766	495	1	3270

Unwanted newsgroups [Top 20]:

Newsgroup	Count
alt.computer.workshop	112
spline.eisfair	41
mozilla.support.seamonkey	32
alt.reddit.entitledparents	27
alt.reddit.maliciouscompliance	25
alt.binaries.pictures.purebeauty	21
lada.talk	20
alt.politics.usa	14
alt.survival	14
it-alt.sport.calcio.juventus	12
alt.politics	11
alt.religion	10
alt.tv.star-trek	9
alt.bbs.synchronet	8
mozilla.support.thunderbird	7
mozilla.general	7
at.jobs	6
alt.philosophy	5
mozilla.dev.security.policy	5
alt.windows7.general	5
TOTAL: 87	495

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	1843
EMP (phl)	231
EMP (phn path)	163
0	65
EMP (phn nph)	51
HTML Multipart	19
Too many newsgroups	14
Scoring filter	7
Too many newsgroups (low_xpost)	6
Too many newsgroups (meow)	5
Binary: misplaced binary	2
HTML post	1
TOTAL: 12	2407

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	csiph-out.feeder.erje.net	50
	csiph-out.news.xs4all.nl	1
	csiph-out.feed.uzoreto.com	1
	TOTAL: 3	52
Huge articles
	csiph-out.feeder.erje.net	156
	csiph-out.news.xs4all.nl	74
	csiph-out.feed.uzoreto.com	44
	newsfeeds.xmission.com	24
	csiph-out.news.weretis.net	21
	news.freedyn.net	9
	feeder.eternal-september.org	6
	news-out.mixmin.net	1
	TOTAL: 8	335
Including strange strings
	newsfeed.fu-berlin.de	407
	news-out.aioe.org	72
	news-out.mixmin.net	12
	news.freedyn.net	9
	csiph-out.news.weretis.net	7
	newsfeeds.xmission.com	6
	news.swapon.de	5
	csiph-out.news.xs4all.nl	3
	feeder.eternal-september.org	2
	csiph-out.feed.uzoreto.com	1
	TOTAL: 11	525
No colon-space in header
	csiph-out.feed.uzoreto.com	1
	TOTAL: 1	1
TOTAL: 4		913

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	16279	1174	13005	3	0	7%	23:59:41
2	news.samoylyk.net	14672	428	13736	9	0	2%	23:59:54
3	news.freedyn.net	13741	410	13019	38	0	2%	23:59:56
4	fu-berlin.de	13161	409	12752	0	0	3%	23:59:56
5	news.bbs.nz	26774	354	13381	9	0	1%	23:59:56
6	tnet	15399	176	13577	0	0	1%	23:59:53
7	usenet.pasdenom.info	14272	85	13621	36	42	0%	23:59:56
8	newsfeed.xs4all.nl	13599	40	13207	6	94	0%	23:59:48
9	neva.ru	12993	37	12766	87	0	0%	23:59:56
10	aioe	10476	20	10128	1	0	0%	23:59:44
11	neodome.net	14450	17	14006	0	0	0%	23:59:55
12	news.uzoreto.com	13822	15	13581	35	0	0%	23:59:49
13	news.mixmin.net	12933	12	12498	0	0	0%	23:59:56
14	xmission	11315	11	10203	0	0	0%	23:59:56
15	erje	13310	8	13117	98	0	0%	23:59:55
16	weretis.net	13232	6	13071	0	0	0%	23:59:56
17	eternal-september	12076	6	11663	0	0	0%	23:59:51
18	news.swapon.de	1336	6	1308	1	0	0%	23:46:55
19	news.fcku.it	1340	0	1338	0	0	0%	21:58:16
TOTAL: 19		245180	3214	219977	323	136	1%	453:43:09

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	6.4 MB	12.6 KB	6.4 MB	0.1 KB/s	5.6 KB	23:59:41
2	news.freedyn.net	4.5 MB	63.2 KB	4.6 MB	0.1 KB/s	10.5 KB	23:59:56
3	fu-berlin.de	4.5 MB	0.0 KB	4.5 MB	0.1 KB/s	11.2 KB	23:59:56
4	news.samoylyk.net	4.5 MB	34.5 KB	4.5 MB	0.1 KB/s	10.6 KB	23:59:54
5	news.bbs.nz	929.8 KB	44.8 KB	974.7 KB	0.0 KB/s	2.7 KB	23:59:56
6	tnet	431.1 KB	0.0 KB	431.1 KB	0.0 KB/s	2.4 KB	23:59:53
7	usenet.pasdenom.info	297.7 KB	88.3 KB	386.0 KB	0.0 KB/s	3.2 KB	23:59:56
8	newsfeed.xs4all.nl	116.2 KB	23.3 KB	139.5 KB	0.0 KB/s	3.0 KB	23:59:48
9	neva.ru	67.4 KB	211.2 KB	278.5 KB	0.0 KB/s	2.2 KB	23:59:56
10	neodome.net	45.8 KB	0.0 KB	45.8 KB	0.0 KB/s	2.7 KB	23:59:55
11	aioe	45.0 KB	23.0 KB	68.1 KB	0.0 KB/s	3.2 KB	23:59:44
12	news.uzoreto.com	35.3 KB	159.5 KB	194.8 KB	0.0 KB/s	3.9 KB	23:59:49
13	xmission	26.7 KB	0.0 KB	26.7 KB	0.0 KB/s	2.4 KB	23:59:56
14	news.mixmin.net	24.9 KB	0.0 KB	24.9 KB	0.0 KB/s	2.1 KB	23:59:56
15	erje	15.6 KB	274.2 KB	289.8 KB	0.0 KB/s	2.7 KB	23:59:55
16	weretis.net	7.9 KB	0.0 KB	7.9 KB	0.0 KB/s	1.3 KB	23:59:56
17	eternal-september	7.9 KB	0.0 KB	7.9 KB	0.0 KB/s	1.3 KB	23:59:51
18	news.swapon.de	7.9 KB	1.6 KB	9.5 KB	0.0 KB/s	1.4 KB	23:46:55
19	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	21:58:16
TOTAL: 19		21.9 MB	936.1 KB	22.8 MB	0.0 KB/s	6.6 KB	453:43:09

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	a131033.upc-a.chello.nl	41	15	21.4 KB	4	0	0	12:17:50
2	68-114-222-137.dhcp.mdsn.wi.charter.com	29	14	20.1 KB	8	6	5	06:22:29
TOTAL: 2		70	29	41.5 KB	12	6	5	45:23:48

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.upc-a.chello.nl	41	15	21.4 KB	4	0	0	12:17:50
2	*.dhcp.mdsn.wi.charter.com	29	14	20.1 KB	8	6	5	06:22:29
3	*.nat.epc.tmcz.cz	1	0	0.0 KB	0	0	0	00:13:09
4	unresolved	72	0	0.0 KB	0	0	0	24:00:02
5	*.ph.ph.cox.net	5	0	0.0 KB	0	0	0	02:30:15
TOTAL: 5		148	29	41.5 KB	12	6	5	45:23:48

NNRP auth users [Top 20]:

User	Conn
ohlandl	5
ctomczyk	1
TOTAL: 2	6

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
91.187.33.87	4.810	1.040	0.000	24:00:02
a131033.upc-a.chello.nl	2.761	0.612	0.000	12:17:50
68-114-222-137.dhcp.mdsn.wi.charter.com	2.264	0.490	0.011	06:22:29
ip72-222-200-117.ph.ph.cox.net	0.529	0.085	0.000	02:30:15
78-80-19-82.nat.epc.tmcz.cz	0.045	0.030	0.003	00:13:09
TOTAL: 5	10.409	2.257	0.014	45:23:48

Curious NNRP server explorers [Top 20]:

System	Conn
91.187.33.87	72
ip72-222-200-117.ph.ph.cox.net	5
78-80-19-82.nat.epc.tmcz.cz	1
TOTAL: 3	78

NNRP client timeouts [Top 20]:

System	Conn	Peer
68-114-222-137.dhcp.mdsn.wi.charter.com	7	1
ip72-222-200-117.ph.ph.cox.net	5	0
TOTAL: 2	12	1

Newsgroup request counts (by category):

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

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

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

Daily Usenet report for csiph.com

Mar 7 04:15:00 -- Mar 8 04:15:00