Daily Usenet report for csiph.com: Jan 25 04:15:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	17647	44.9%	4.6 MB	60.9%
innd	17447	44.4%	2.3 MB	30.0%
innfeed	3546	9.0%	633.4 KB	8.2%
nnrpd	674	1.7%	72.3 KB	0.9%
nocem	10	0.0%	1.2 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	39325	100.0%	7.5 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	291586	57.6%
Negative hits	197088	38.9%
Do not exist	17137	3.4%
Cache misses	617	0.1%
TOTAL: 4	506428	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.175	0.0%	18	0.000	9.722	15.333
article cleanup	00:00:00.105	0.0%	16788	0.000	0.006	0.042
article logging	00:00:00.362	0.0%	17188	0.000	0.021	1.600
article parse	00:00:00.940	0.0%	51756	0.000	0.018	0.091
article write	00:00:09.282	0.0%	14308	0.146	0.649	21.193
artlog/artcncl	00:00:00.000	0.0%	18	0.000	0.000	0.000
artlog/artparse	00:00:00.007	0.0%	446	0.000	0.016	0.143
data move	00:00:00.181	0.0%	474956	0.000	0.000	0.003
hisgrep/artcncl	00:00:00.020	0.0%	18	0.000	1.111	15.000
hishave/artcncl	00:00:00.001	0.0%	18	0.000	0.056	0.125
hishave/artparse	00:00:00.001	0.0%	444	0.000	0.002	0.050
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:08.468	0.0%	508658	0.001	0.017	0.082
history sync	00:00:00.905	0.0%	388	0.000	2.332	23.667
history write	00:00:14.840	0.0%	16780	0.191	0.884	2.602
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
hiswrite/artparse	00:00:00.470	0.0%	444	0.000	1.059	5.000
idle	23:58:58.561	99.8%	481666	98.396	179.250	565.100
nntp read	00:00:01.796	0.0%	482733	0.001	0.004	0.009
overview write	00:00:40.680	0.0%	14308	0.151	2.843	52.205
perl filter	00:00:22.326	0.0%	16778	1.071	1.331	2.721
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.227	0.0%	28626	0.000	0.008	0.030
TOTAL: 24:01:11.332	24:00:39.347	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.033	0.0%	14344	0.000	0.002	0.021
article prepare	00:00:00.002	0.0%	13972	0.000	0.000	0.005
article read	00:00:00.286	0.0%	1728	0.000	0.166	22.000
backlog stats	00:00:00.171	0.0%	316292	0.000	0.001	0.002
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.063	0.0%	245998	0.000	0.004	0.010
data write	00:00:01.400	0.0%	233251	0.001	0.006	0.012
idle	23:53:59.649	100.0%	316292	152.671	272.026	740.960
status file	00:00:00.205	0.0%	297	0.000	0.690	2.000
TOTAL: 23:54:10.249	23:54:02.809	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	23:37:56.133	100.0%	621	62.000	136998.604	600113.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.012	0.0%	1602	0.000	0.007	0.200
readart	00:00:00.460	0.0%	133	0.000	3.459	42.000
TOTAL: 23:38:17.238	23:37:56.605	100.0%	-	-	-	-

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	3	13709	3468	10230	11	25%	24:55:02
2	news-out.aioe.org	2	13777	3269	10435	73	23%	24:09:03
3	feeder.eternal-september.org	2	16231	1806	14093	332	11%	25:23:11
4	csiph-out.feeder.erje.net	1441	71172	1334	69364	474	1%	118:43:14
5	csiph-out.news.xs4all.nl	861	15671	841	14096	734	5%	71:27:48
6	newsfeed.fu-berlin.de	7	16866	837	15902	127	4%	29:27:44
7	news-out.mixmin.net	2	15099	797	13807	495	5%	23:59:43
8	csiph-out.news.weretis.net	4	29551	642	28823	86	2%	47:59:32
9	newsfeed.neva.ru	139	14713	492	14037	184	3%	71:35:17
10	news.freedyn.net	1	16346	322	15863	161	1%	23:59:55
11	news-out.neodome.net	1	15520	168	15217	135	1%	23:59:54
12	news.fcku.it	13	1591	126	1465	0	7%	22:22:35
13	csiph-out.feed.uzoreto.com	864	22418	105	22189	124	0%	71:12:08
14	csiph-out.news.tnetconsulting.net	1	14960	65	14881	14	0%	23:59:57
15	nntp.pasdenom.info	2	9377	41	9322	14	0%	23:58:36
16	news.swapon.de	12	1294	30	1262	2	2%	22:29:23
17	localhost	37	11	11	0	0	100%	00:00:03
18	news.bbs.nz	1	14666	3	14663	0	0%	23:59:54
19	news.samoylyk.net	3	13864	2	13862	0	0%	21:36:18
20	xanadu-bbs.net	75	207	0	207	0	0%	67:10:30
TOTAL: 20		3471	317043	14359	299718	2966	4%	762:29:47

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeeds.xmission.com	10.2 MB	0.0 KB	506.9 KB	10.7 MB	95%	3.1 KB
2	csiph-out.feeder.erje.net	8.4 MB	5.9 KB	10.8 MB	19.2 MB	43%	10.9 KB
3	news-out.aioe.org	8.0 MB	2.0 KB	355.8 KB	8.3 MB	95%	2.6 KB
4	feeder.eternal-september.org	4.8 MB	2.0 KB	2.5 MB	7.3 MB	65%	3.5 KB
5	csiph-out.news.xs4all.nl	2.3 MB	2.0 KB	6.7 MB	9.0 MB	25%	5.9 KB
6	news-out.mixmin.net	2.2 MB	2.0 KB	766.6 KB	2.9 MB	74%	2.3 KB
7	newsfeed.fu-berlin.de	1.9 MB	0.0 KB	421.3 KB	2.3 MB	82%	2.5 KB
8	csiph-out.news.weretis.net	1.9 MB	3.9 KB	1023.9 KB	2.9 MB	65%	4.1 KB
9	newsfeed.neva.ru	1.4 MB	0.0 KB	624.2 KB	2.0 MB	70%	3.1 KB
10	news.freedyn.net	1.0 MB	2.0 KB	912.1 KB	1.9 MB	53%	4.1 KB
11	news-out.neodome.net	388.8 KB	0.0 KB	1.1 MB	1.5 MB	25%	5.0 KB
12	csiph-out.feed.uzoreto.com	328.3 KB	0.0 KB	2.3 MB	2.6 MB	12%	11.6 KB
13	news.fcku.it	214.0 KB	0.0 KB	0.0 KB	214.0 KB	100%	1.7 KB
14	csiph-out.news.tnetconsulting.net	212.5 KB	0.0 KB	207.0 KB	419.5 KB	50%	5.3 KB
15	news.swapon.de	104.3 KB	2.0 KB	82.3 KB	188.6 KB	55%	5.9 KB
16	nntp.pasdenom.info	75.1 KB	0.0 KB	22.9 KB	98.0 KB	76%	1.8 KB
17	localhost	15.5 KB	0.0 KB	0.0 KB	15.5 KB	100%	1.4 KB
18	news.bbs.nz	8.5 KB	0.0 KB	0.0 KB	8.5 KB	100%	2.8 KB
19	news.samoylyk.net	7.1 KB	0.0 KB	0.0 KB	7.1 KB	100%	3.5 KB
20	xanadu-bbs.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 20		43.5 MB	21.8 KB	28.2 MB	71.7 MB	60%	4.2 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jan 25 04:15:00 - 04:59:59	196	1.4%	0.07	610.4 KB	1.4%	0.23
Jan 25 05:00:00 - 05:59:59	299	2.1%	0.08	932.7 KB	2.1%	0.26
Jan 25 06:00:00 - 06:59:59	299	2.1%	0.08	848.7 KB	1.9%	0.24
Jan 25 07:00:00 - 07:59:59	447	3.1%	0.12	1.7 MB	3.9%	0.48
Jan 25 08:00:00 - 08:59:59	524	3.7%	0.15	2.2 MB	5.0%	0.62
Jan 25 09:00:00 - 09:59:59	638	4.5%	0.18	1.8 MB	4.1%	0.50
Jan 25 10:00:00 - 10:59:59	700	4.9%	0.19	2.0 MB	4.6%	0.56
Jan 25 11:00:00 - 11:59:59	791	5.5%	0.22	2.4 MB	5.6%	0.69
Jan 25 12:00:00 - 12:59:59	763	5.3%	0.21	2.3 MB	5.3%	0.65
Jan 25 13:00:00 - 13:59:59	681	4.8%	0.19	1.7 MB	4.0%	0.50
Jan 25 14:00:00 - 14:59:59	680	4.8%	0.19	1.7 MB	3.9%	0.48
Jan 25 15:00:00 - 15:59:59	770	5.4%	0.21	2.2 MB	5.2%	0.64
Jan 25 16:00:00 - 16:59:59	808	5.6%	0.22	2.4 MB	5.6%	0.69
Jan 25 17:00:00 - 17:59:59	834	5.8%	0.23	1.9 MB	4.5%	0.55
Jan 25 18:00:00 - 18:59:59	862	6.0%	0.24	2.5 MB	5.8%	0.71
Jan 25 19:00:00 - 19:59:59	885	6.2%	0.25	3.2 MB	7.4%	0.92
Jan 25 20:00:00 - 20:59:59	704	4.9%	0.20	1.8 MB	4.2%	0.52
Jan 25 21:00:00 - 21:59:59	757	5.3%	0.21	2.5 MB	5.7%	0.70
Jan 25 22:00:00 - 22:59:59	621	4.3%	0.17	1.8 MB	4.1%	0.51
Jan 25 23:00:00 - 23:59:59	503	3.5%	0.14	1.8 MB	4.2%	0.52
Jan 26 00:00:00 - 00:59:59	474	3.3%	0.13	1.6 MB	3.7%	0.45
Jan 26 01:00:00 - 01:59:59	347	2.4%	0.10	1.0 MB	2.4%	0.30
Jan 26 02:00:00 - 02:59:59	328	2.3%	0.09	985.3 KB	2.2%	0.27
Jan 26 03:00:00 - 03:59:59	299	2.1%	0.08	1.2 MB	2.8%	0.35
Jan 26 04:00:00 - 04:15:00	94	0.7%	0.10	249.4 KB	0.6%	0.28
TOTAL: 24:00:00	14304	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	733	60	1	672
2	news-out.mixmin.net	498	5	1	492
3	csiph-out.feeder.erje.net	476	80	3	393
4	newsfeed.fu-berlin.de	394	31	0	363
5	feeder.eternal-september.org	329	33	1	295
6	newsfeed.neva.ru	187	49	0	138
7	news.freedyn.net	160	1	1	158
8	news-out.aioe.org	147	65	1	81
9	news-out.neodome.net	139	1	0	138
10	csiph-out.feed.uzoreto.com	124	5	0	119
11	csiph-out.news.weretis.net	87	40	1	46
12	csiph-out.news.tnetconsulting.net	15	15	0	0
13	nntp.pasdenom.info	14	0	0	14
14	newsfeeds.xmission.com	13	3	0	10
15	news.swapon.de	9	0	1	8
TOTAL: 15		3325	388	10	2927

Unwanted newsgroups [Top 20]:

Newsgroup	Count
alt.computer.workshop	143
lada.talk	27
alt.windows7.general	20
alt.binaries.pictures.purebeauty	14
alt.survival	13
mozilla.support.thunderbird	11
spline.eisfair	9
oesterreich.tratsch	9
alt.music.pink-floyd.publius	8
alt.binaries.documentaries	8
alt.politics.usa	8
mozilla.support.firefox	7
alt.english.usage	6
alt.politics	5
alt.paranormal.spells	4
lada.movies	4
lada.kitchen	4
rocksolid.shared.rocksolid	3
mozilla.support.seamonkey	3
it-alt.sport.calcio.juventus	3
TOTAL: 78	388

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	1397
EMP (phl)	203
EMP (phn path)	184
EMP (phn nph)	176
0	39
Too many newsgroups	30
HTML Multipart	23
Binary Payload	18
Scoring filter	3
Binary: misplaced binary	3
U2 violation - invalid distribution	2
HTML post	1
TOTAL: 12	2079

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	129
	csiph-out.feed.uzoreto.com	51
	feeder.eternal-september.org	25
	news-out.neodome.net	17
	csiph-out.news.weretis.net	12
	news.freedyn.net	8
	newsfeeds.xmission.com	7
	news.swapon.de	1
	news-out.mixmin.net	1
	TOTAL: 10	445
Including strange strings
	newsfeed.fu-berlin.de	291
	news-out.aioe.org	75
	csiph-out.news.weretis.net	18
	news.swapon.de	7
	news-out.mixmin.net	4
	newsfeeds.xmission.com	3
	csiph-out.news.xs4all.nl	2
	csiph-out.feeder.erje.net	1
	feeder.eternal-september.org	1
	TOTAL: 9	402
No colon-space in header
	csiph-out.news.xs4all.nl	2
	TOTAL: 1	2
TOTAL: 4		894

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	12202	1037	8656	0	4611	8%	23:59:54
2	fu-berlin.de	13476	571	12905	0	0	4%	23:59:48
3	news.freedyn.net	14255	566	13378	19	0	3%	23:59:54
4	news.bbs.nz	26812	367	13357	11	0	1%	23:59:54
5	usenet.pasdenom.info	14192	94	13565	36	10	0%	23:59:54
6	aioe	10140	78	9783	0	0	0%	23:59:54
7	tnet	14720	71	13664	0	0	0%	23:59:33
8	erje	16573	70	12685	142	0	0%	23:59:54
9	newsfeed.xs4all.nl	13703	50	13238	0	64	0%	23:59:54
10	neva.ru	13222	33	12967	112	0	0%	23:59:54
11	news.uzoreto.com	13870	29	13625	117	0	0%	23:59:44
12	xmission	11631	23	10197	0	0	0%	23:58:49
13	neodome.net	14495	20	14060	0	0	0%	23:59:54
14	news.mixmin.net	13199	14	12752	0	0	0%	23:59:15
15	eternal-september	12352	11	11881	0	0	0%	23:59:52
16	weretis.net	13104	11	12956	1	0	0%	23:59:54
17	news.swapon.de	1332	11	1303	0	0	0%	23:01:09
18	news.samoylyk.net	0	0	0	0	14302	0%	23:58:40
19	news.fcku.it	1318	0	1317	0	0	0%	21:47:00
TOTAL: 19		230596	3056	202289	438	18987	1%	452:42:50

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	6.5 MB	0.0 KB	6.5 MB	0.1 KB/s	6.4 KB	23:59:54
2	fu-berlin.de	6.2 MB	0.0 KB	6.2 MB	0.1 KB/s	11.1 KB	23:59:48
3	news.freedyn.net	6.2 MB	27.8 KB	6.2 MB	0.1 KB/s	10.9 KB	23:59:54
4	news.bbs.nz	911.5 KB	63.3 KB	974.8 KB	0.0 KB/s	2.6 KB	23:59:54
5	usenet.pasdenom.info	230.6 KB	125.9 KB	356.6 KB	0.0 KB/s	2.7 KB	23:59:54
6	erje	156.7 KB	874.3 KB	1.0 MB	0.0 KB/s	4.9 KB	23:59:54
7	tnet	142.0 KB	0.0 KB	142.0 KB	0.0 KB/s	2.0 KB	23:59:33
8	aioe	138.3 KB	0.0 KB	138.3 KB	0.0 KB/s	1.8 KB	23:59:54
9	newsfeed.xs4all.nl	137.7 KB	0.0 KB	137.7 KB	0.0 KB/s	2.8 KB	23:59:54
10	neodome.net	55.6 KB	0.0 KB	55.6 KB	0.0 KB/s	2.8 KB	23:59:54
11	neva.ru	54.7 KB	229.5 KB	284.3 KB	0.0 KB/s	2.0 KB	23:59:54
12	xmission	53.8 KB	0.0 KB	53.8 KB	0.0 KB/s	2.3 KB	23:58:49
13	news.uzoreto.com	50.5 KB	355.8 KB	406.3 KB	0.0 KB/s	2.8 KB	23:59:44
14	news.mixmin.net	19.9 KB	0.0 KB	19.9 KB	0.0 KB/s	1.4 KB	23:59:15
15	eternal-september	15.6 KB	0.0 KB	15.6 KB	0.0 KB/s	1.4 KB	23:59:52
16	weretis.net	15.6 KB	1.2 KB	16.7 KB	0.0 KB/s	1.4 KB	23:59:54
17	news.swapon.de	15.6 KB	0.0 KB	15.6 KB	0.0 KB/s	1.4 KB	23:01:09
18	news.samoylyk.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:58:40
19	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	21:47:00
TOTAL: 19		20.8 MB	1.6 MB	22.5 MB	0.0 KB/s	6.6 KB	452:42:50

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	ip72-222-200-117.ph.ph.cox.net	8	74	143.1 KB	6	0	0	03:17:16
2	a131033.upc-a.chello.nl	39	32	54.3 KB	5	0	0	10:41:40
3	71-90-73-253.dhcp.ftbg.wi.charter.com	35	24	39.7 KB	19	11	11	08:54:36
4	208-71-239-109.cust.centrio.cz	2	3	7.4 KB	2	0	0	00:44:32
TOTAL: 4		84	133	244.5 KB	32	11	11	23:38:16

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.ph.ph.cox.net	8	74	143.1 KB	6	0	0	03:17:16
2	*.upc-a.chello.nl	39	32	54.3 KB	5	0	0	10:41:40
3	*.dhcp.ftbg.wi.charter.com	35	24	39.7 KB	19	11	11	08:54:36
4	*.cust.centrio.cz	2	3	7.4 KB	2	0	0	00:44:32
5	*.security.ipip.net	1	0	0.0 KB	0	0	0	00:00:01
6	unresolved	2	0	0.0 KB	0	0	0	00:00:02
7	*.20.97.83.ro.ovo.sc	1	0	0.0 KB	0	0	0	00:00:05
TOTAL: 7		88	133	244.5 KB	32	11	11	23:38:16

NNRP auth users [Top 20]:

User	Conn
ohlandl	11
ctomczyk	2
TOTAL: 2	13

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
a131033.upc-a.chello.nl	3.108	0.531	0.000	10:41:40
71-90-73-253.dhcp.ftbg.wi.charter.com	2.949	0.533	0.030	08:54:36
ip72-222-200-117.ph.ph.cox.net	0.811	0.171	0.000	03:17:16
208-71-239-109.cust.centrio.cz	0.189	0.049	0.004	00:44:32
49.20.97.83.ro.ovo.sc	0.062	0.016	0.000	00:00:05
94.161.234.57	0.139	0.017	0.000	00:00:02
scan-141.security.ipip.net	0.062	0.016	0.000	00:00:01
TOTAL: 7	7.320	1.333	0.034	23:38:16

Curious NNRP server explorers [Top 20]:

System	Conn
94.161.234.57	2
49.20.97.83.ro.ovo.sc	1
scan-141.security.ipip.net	1
TOTAL: 3	4

NNRP unrecognized commands (by host):

System	Conn
scan-141.security.ipip.net	4
TOTAL: 1	4

NNRP unrecognized commands (by command):

Command	Count
GET / HTTP/1.1	1
Host: 69.160.37.58:119	1
Connection: close	1
User-Agent: HTTP Banner Detection (https...	1
TOTAL: 4	4

NNRP client timeouts [Top 20]:

System	Conn	Peer
71-90-73-253.dhcp.ftbg.wi.charter.com	12	1
ip72-222-200-117.ph.ph.cox.net	6	0
TOTAL: 2	18	1

Newsgroup request counts (by category):

Category		Count	Pct
1	comp	132	99.2%
2	news	1	0.8%
TOTAL: 2		133	100.0%

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

Newsgroup		Count
1	comp.sys.ibm.ps2.hardware	128
2	comp.lang.javascript	3
3	news.software.nntp	1
4	comp.unix.aix	1
TOTAL: 4		133

Daily Usenet report for csiph.com

Jan 25 04:15:00 -- Jan 26 04:15:00