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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	18463	46.8%	4.8 MB	62.2%
innd	16792	42.6%	2.2 MB	28.6%
innfeed	3495	8.9%	652.0 KB	8.2%
nnrpd	676	1.7%	73.7 KB	0.9%
nocem	37	0.1%	4.4 KB	0.1%
controlchan	1	0.0%	0.2 KB	0.0%
TOTAL: 6	39464	100.0%	7.7 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	309150	58.1%
Negative hits	204817	38.5%
Do not exist	17883	3.4%
Cache misses	253	0.0%
TOTAL: 4	532103	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.191	0.0%	24	0.000	7.958	14.250
article cleanup	00:00:00.100	0.0%	17633	0.000	0.006	0.035
article logging	00:00:00.271	0.0%	18127	0.000	0.015	0.054
article parse	00:00:00.588	0.0%	52644	0.000	0.011	0.053
article write	00:00:05.732	0.0%	14859	0.129	0.386	9.226
artlog/artcncl	00:00:00.000	0.0%	24	0.000	0.000	0.000
artlog/artparse	00:00:00.002	0.0%	278	0.000	0.007	0.053
data move	00:00:00.172	0.0%	496072	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.007	0.0%	24	0.000	0.292	1.000
hishave/artcncl	00:00:00.003	0.0%	24	0.000	0.125	0.500
hishave/artparse	00:00:00.000	0.0%	273	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.113	0.0%	532546	0.001	0.006	0.013
history sync	00:00:00.737	0.0%	359	0.000	2.053	10.667
history write	00:00:07.600	0.0%	17621	0.021	0.431	1.552
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
hiswrite/artparse	00:00:00.130	0.0%	273	0.000	0.476	3.000
idle	23:49:08.607	99.9%	507416	91.952	168.991	440.779
nntp read	00:00:01.862	0.0%	507338	0.001	0.004	0.007
overview write	00:00:28.568	0.0%	14859	0.105	1.923	30.566
perl filter	00:00:24.016	0.0%	17614	1.032	1.363	1.806
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.254	0.0%	29754	0.000	0.009	0.031
TOTAL: 23:50:55.983	23:50:21.953	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.039	0.0%	14996	0.000	0.003	0.018
article prepare	00:00:00.001	0.0%	15884	0.000	0.000	0.003
article read	00:00:00.192	0.0%	1254	0.000	0.153	11.250
backlog stats	00:00:00.195	0.0%	359600	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.300	0.0%	279233	0.001	0.005	0.011
data write	00:00:01.657	0.0%	266439	0.000	0.006	0.013
idle	23:55:01.201	100.0%	359600	130.431	239.436	686.747
status file	00:00:00.174	0.0%	273	0.000	0.637	2.000
TOTAL: 23:55:13.346	23:55:04.759	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	20:14:20.854	100.0%	555	61.500	131280.818	600103.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.008	0.0%	1218	0.000	0.007	0.167
readart	00:00:00.502	0.0%	40	0.000	12.550	42.000
TOTAL: 20:14:39.269	20:14:21.364	100.0%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	csiph-out.feeder.erje.net	1440	75412	4074	70906	432	5%	118:51:28
2	news-out.aioe.org	3	14589	2687	11837	65	18%	24:09:47
3	feeder.eternal-september.org	2	17129	1999	14783	347	11%	25:51:40
4	newsfeeds.xmission.com	3	12872	1050	11797	25	8%	20:40:52
5	csiph-out.news.xs4all.nl	861	16573	859	14967	747	5%	71:26:54
6	news-out.mixmin.net	2	15582	785	14476	321	5%	23:59:45
7	newsfeed.fu-berlin.de	8	14697	770	13734	193	5%	24:36:58
8	csiph-out.news.weretis.net	3	31260	689	30477	94	2%	47:59:25
9	newsfeed.neva.ru	153	16623	583	15650	390	3%	71:26:45
10	news.freedyn.net	2	17074	499	16441	134	2%	23:59:47
11	csiph-out.feed.uzoreto.com	864	23881	282	23403	196	1%	71:11:10
12	nntp.pasdenom.info	2	9812	149	9613	50	1%	23:58:13
13	news-out.neodome.net	2	16111	107	15948	56	0%	24:05:54
14	news.fcku.it	13	1387	99	1287	1	7%	22:25:49
15	news.samoylyk.net	2	14936	72	14861	3	0%	23:59:35
16	csiph-out.news.tnetconsulting.net	2	15673	67	15596	10	0%	23:59:56
17	news.swapon.de	4	1503	32	1470	1	2%	20:06:52
18	localhost	44	18	18	0	0	100%	00:00:01
19	news.bbs.nz	1	15241	4	15237	0	0%	23:59:52
20	xanadu-bbs.net	20	465	1	464	0	0%	21:47:18
TOTAL: 20		3431	330838	14826	312947	3065	4%	708:38:01

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.feeder.erje.net	15.2 MB	9.0 KB	8.7 MB	23.9 MB	63%	5.4 KB
2	news-out.aioe.org	6.3 MB	2.2 KB	227.6 KB	6.5 MB	96%	2.4 KB
3	feeder.eternal-september.org	6.1 MB	6.3 KB	2.1 MB	8.2 MB	74%	3.6 KB
4	newsfeeds.xmission.com	4.0 MB	0.0 KB	1.3 MB	5.3 MB	75%	5.1 KB
5	csiph-out.news.xs4all.nl	2.7 MB	2.2 KB	6.2 MB	8.9 MB	29%	5.7 KB
6	news-out.mixmin.net	2.1 MB	2.2 KB	619.4 KB	2.7 MB	77%	2.5 KB
7	csiph-out.news.weretis.net	1.9 MB	2.2 KB	847.6 KB	2.7 MB	69%	3.5 KB
8	newsfeed.fu-berlin.de	1.8 MB	0.0 KB	553.2 KB	2.3 MB	76%	2.5 KB
9	newsfeed.neva.ru	1.7 MB	4.6 KB	2.1 MB	3.8 MB	45%	4.0 KB
10	news.freedyn.net	1.6 MB	2.2 KB	646.6 KB	2.2 MB	71%	3.6 KB
11	csiph-out.feed.uzoreto.com	1007.7 KB	0.0 KB	3.2 MB	4.2 MB	23%	8.9 KB
12	news-out.neodome.net	557.1 KB	5.2 KB	2.4 MB	3.0 MB	18%	18.8 KB
13	nntp.pasdenom.info	287.6 KB	3.8 KB	67.1 KB	358.5 KB	80%	1.8 KB
14	csiph-out.news.tnetconsulting.net	237.2 KB	0.0 KB	342.9 KB	580.1 KB	40%	7.5 KB
15	news.fcku.it	206.1 KB	0.0 KB	1.2 KB	207.4 KB	99%	2.1 KB
16	news.samoylyk.net	97.7 KB	0.0 KB	3.4 KB	101.0 KB	96%	1.3 KB
17	news.swapon.de	78.9 KB	0.0 KB	80.4 KB	159.2 KB	49%	4.8 KB
18	localhost	29.3 KB	0.0 KB	0.0 KB	29.3 KB	100%	1.6 KB
19	news.bbs.nz	10.5 KB	0.0 KB	0.0 KB	10.5 KB	100%	2.6 KB
20	xanadu-bbs.net	1.4 KB	0.0 KB	0.0 KB	1.4 KB	100%	1.4 KB
TOTAL: 20		45.7 MB	40.0 KB	29.3 MB	75.1 MB	60%	4.3 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jan 11 04:15:00 - 04:59:59	212	1.4%	0.08	637.2 KB	1.3%	0.24
Jan 11 05:00:00 - 05:59:59	283	1.9%	0.08	809.3 KB	1.7%	0.22
Jan 11 06:00:00 - 06:59:59	311	2.1%	0.09	1000.7 KB	2.1%	0.28
Jan 11 07:00:00 - 07:59:59	485	3.3%	0.13	1.6 MB	3.4%	0.45
Jan 11 08:00:00 - 08:59:59	570	3.8%	0.16	2.0 MB	4.4%	0.58
Jan 11 09:00:00 - 09:59:59	590	4.0%	0.16	1.6 MB	3.4%	0.44
Jan 11 10:00:00 - 10:59:59	788	5.3%	0.22	3.1 MB	6.7%	0.88
Jan 11 11:00:00 - 11:59:59	711	4.8%	0.20	2.1 MB	4.6%	0.60
Jan 11 12:00:00 - 12:59:59	809	5.4%	0.22	2.3 MB	5.0%	0.66
Jan 11 13:00:00 - 13:59:59	700	4.7%	0.19	1.9 MB	4.2%	0.55
Jan 11 14:00:00 - 14:59:59	752	5.1%	0.21	2.1 MB	4.4%	0.58
Jan 11 15:00:00 - 15:59:59	731	4.9%	0.20	2.2 MB	4.7%	0.62
Jan 11 16:00:00 - 16:59:59	841	5.6%	0.23	2.4 MB	5.2%	0.69
Jan 11 17:00:00 - 17:59:59	816	5.5%	0.23	2.3 MB	4.9%	0.64
Jan 11 18:00:00 - 18:59:59	926	6.2%	0.26	3.1 MB	6.7%	0.89
Jan 11 19:00:00 - 19:59:59	907	6.1%	0.25	3.0 MB	6.4%	0.84
Jan 11 20:00:00 - 20:59:59	867	5.8%	0.24	2.6 MB	5.5%	0.73
Jan 11 21:00:00 - 21:59:59	753	5.1%	0.21	2.3 MB	4.9%	0.65
Jan 11 22:00:00 - 22:59:59	682	4.6%	0.19	2.3 MB	4.9%	0.64
Jan 11 23:00:00 - 23:59:59	649	4.4%	0.18	2.2 MB	4.8%	0.64
Jan 12 00:00:00 - 00:59:59	473	3.2%	0.13	1.6 MB	3.5%	0.45
Jan 12 01:00:00 - 01:59:59	354	2.4%	0.10	973.0 KB	2.1%	0.27
Jan 12 02:00:00 - 02:59:59	308	2.1%	0.09	1010.5 KB	2.1%	0.28
Jan 12 03:00:00 - 03:59:59	318	2.1%	0.09	1.2 MB	2.6%	0.34
Jan 12 04:00:00 - 04:15:00	55	0.4%	0.06	173.5 KB	0.4%	0.19
TOTAL: 24:00:00	14891	100.0%	0.17	46.2 MB	100.0%	0.55

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	csiph-out.news.xs4all.nl	748	68	1	0	679
2	newsfeed.fu-berlin.de	569	87	0	0	482
3	csiph-out.feeder.erje.net	435	110	4	1	320
4	newsfeed.neva.ru	391	53	2	0	336
5	news-out.mixmin.net	332	8	1	0	323
6	feeder.eternal-september.org	327	32	3	0	292
7	csiph-out.feed.uzoreto.com	197	9	0	0	188
8	news.freedyn.net	139	12	1	0	126
9	csiph-out.news.weretis.net	134	42	1	0	91
10	news-out.aioe.org	126	53	1	0	72
11	news-out.neodome.net	53	1	2	0	50
12	nntp.pasdenom.info	50	0	1	0	49
13	newsfeeds.xmission.com	31	0	0	0	31
14	news.swapon.de	6	0	0	0	6
15	csiph-out.news.tnetconsulting.net	6	5	0	0	1
16	news.samoylyk.net	3	0	0	0	3
17	news.fcku.it	1	0	0	0	1
TOTAL: 17		3548	480	17	1	3050

Unwanted newsgroups [Top 20]:

Newsgroup	Count
alt.computer.workshop	183
spline.eisfair	31
alt.survival	24
alt.windows7.general	22
alt.binaries.pictures.purebeauty	19
lada.talk	17
alt.music.pink-floyd.publius	14
mozilla.support.seamonkey	13
alt.bbs.synchronet	11
mozilla.support.thunderbird	11
mozilla.dev.platform	10
alt.binaries.ebooks	9
alt.paranormal.spells	7
mozilla.dev.builds	7
mozilla.general	6
it-alt.sport.calcio.juventus	6
oesterreich.tratsch	6
alt.digicash.deadbeats	5
mozilla.support.firefox	5
alt.philosophy	4
TOTAL: 65	480

Supposedly-moderated groups with unmoderated postings [Top 20]:

Groups	Count
uk.radio.amateur.moderated	1
TOTAL: 1	1

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	1541
EMP (phn path)	263
EMP (phn nph)	155
EMP (phl)	116
0	100
Binary: misplaced binary	59
Too many newsgroups	20
HTML Multipart	14
Scoring filter	5
Too many newsgroups (meow)	3
TOTAL: 10	2276

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Article posted in the future
	csiph-out.news.xs4all.nl	2
	TOTAL: 1	2
Bad Message-ID's offered
	csiph-out.feeder.erje.net	45
	TOTAL: 1	45
Huge articles
	csiph-out.feeder.erje.net	153
	news-out.neodome.net	40
	newsfeeds.xmission.com	29
	csiph-out.news.xs4all.nl	16
	csiph-out.news.weretis.net	12
	csiph-out.feed.uzoreto.com	10
	feeder.eternal-september.org	6
	news-out.mixmin.net	3
	newsfeed.fu-berlin.de	1
	csiph-out.news.tnetconsulting.net	1
	TOTAL: 12	273
Including strange strings
	newsfeed.fu-berlin.de	379
	news-out.aioe.org	67
	csiph-out.news.weretis.net	19
	news-out.mixmin.net	10
	news.freedyn.net	7
	news.swapon.de	5
	csiph-out.feeder.erje.net	3
	csiph-out.feed.uzoreto.com	2
	csiph-out.news.xs4all.nl	2
	TOTAL: 9	494
No colon-space in header
	csiph-out.news.xs4all.nl	5
	TOTAL: 1	5
TOTAL: 5		819

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	19412	920	13971	0	0	4%	23:59:53
2	news.freedyn.net	14669	632	13717	28	0	4%	23:59:33
3	news.samoylyk.net	15398	525	14290	2	0	3%	23:59:53
4	fu-berlin.de	13996	508	13488	0	0	3%	23:59:49
5	news.bbs.nz	28129	307	14062	8	1	1%	23:59:50
6	tnet	16204	135	14247	0	0	0%	23:59:53
7	usenet.pasdenom.info	15067	134	14063	37	18	0%	23:59:53
8	aioe	11176	71	10635	0	0	0%	23:59:53
9	neva.ru	13779	64	13490	91	0	0%	23:59:53
10	newsfeed.xs4all.nl	14488	53	13842	7	95	0%	23:59:53
11	neodome.net	15308	51	14642	0	0	0%	23:59:22
12	erje	10722	49	10485	86	0	0%	23:59:50
13	news.uzoreto.com	14523	38	14120	132	0	0%	23:59:36
14	xmission	16095	28	13180	1	0	0%	23:59:51
15	news.mixmin.net	13942	21	13315	1	0	0%	23:59:49
16	eternal-september	12898	21	12310	0	0	0%	23:59:52
17	news.swapon.de	1677	18	1638	0	0	1%	23:49:30
18	weretis.net	14069	17	13582	4	0	0%	23:59:53
19	news.fcku.it	1197	0	1181	0	0	0%	22:02:32
TOTAL: 19		262749	3592	230258	397	114	1%	453:48:38

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	7.1 MB	0.0 KB	7.1 MB	0.1 KB/s	7.9 KB	23:59:53
2	news.freedyn.net	6.1 MB	50.2 KB	6.2 MB	0.1 KB/s	9.6 KB	23:59:33
3	news.samoylyk.net	5.4 MB	31.6 KB	5.5 MB	0.1 KB/s	10.6 KB	23:59:53
4	fu-berlin.de	5.4 MB	0.0 KB	5.4 MB	0.1 KB/s	10.9 KB	23:59:49
5	news.bbs.nz	753.4 KB	230.8 KB	984.2 KB	0.0 KB/s	3.1 KB	23:59:50
6	usenet.pasdenom.info	449.8 KB	359.0 KB	808.7 KB	0.0 KB/s	4.7 KB	23:59:53
7	tnet	287.6 KB	0.0 KB	287.6 KB	0.0 KB/s	2.1 KB	23:59:53
8	neodome.net	235.3 KB	0.0 KB	235.3 KB	0.0 KB/s	4.6 KB	23:59:22
9	newsfeed.xs4all.nl	224.1 KB	57.6 KB	281.7 KB	0.0 KB/s	4.7 KB	23:59:53
10	aioe	139.9 KB	0.0 KB	139.9 KB	0.0 KB/s	2.0 KB	23:59:53
11	neva.ru	111.7 KB	153.8 KB	265.5 KB	0.0 KB/s	1.7 KB	23:59:53
12	erje	79.9 KB	388.0 KB	467.9 KB	0.0 KB/s	3.5 KB	23:59:50
13	news.uzoreto.com	67.0 KB	344.0 KB	411.0 KB	0.0 KB/s	2.4 KB	23:59:36
14	xmission	46.6 KB	0.8 KB	47.5 KB	0.0 KB/s	1.6 KB	23:59:51
15	news.mixmin.net	35.8 KB	1.5 KB	37.3 KB	0.0 KB/s	1.7 KB	23:59:49
16	eternal-september	35.1 KB	0.0 KB	35.1 KB	0.0 KB/s	1.7 KB	23:59:52
17	news.swapon.de	29.3 KB	0.0 KB	29.3 KB	0.0 KB/s	1.6 KB	23:49:30
18	weretis.net	27.2 KB	23.4 KB	50.7 KB	0.0 KB/s	2.4 KB	23:59:53
19	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	22:02:32
TOTAL: 19		26.6 MB	1.6 MB	28.2 MB	0.0 KB/s	7.2 KB	453:48:38

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	71-90-73-253.dhcp.ftbg.wi.charter.com	44	22	38.5 KB	18	17	16	12:21:46
2	a131033.upc-a.chello.nl	35	18	31.1 KB	4	0	0	05:52:30
TOTAL: 2		79	40	69.6 KB	22	17	16	20:14:38

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.dhcp.ftbg.wi.charter.com	44	22	38.5 KB	18	17	16	12:21:46
2	*.upc-a.chello.nl	35	18	31.1 KB	4	0	0	05:52:30
3	*.ph.ph.cox.net	4	0	0.0 KB	0	0	0	02:00:14
4	unresolved	5	0	0.0 KB	0	0	0	00:00:05
5	*.security.ipip.net	1	0	0.0 KB	0	0	0	00:00:01
TOTAL: 5		89	40	69.6 KB	22	17	16	20:14:38

NNRP auth users [Top 20]:

User	Conn
ohlandl	16
TOTAL: 1	16

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
71-90-73-253.dhcp.ftbg.wi.charter.com	3.723	0.656	0.033	12:21:46
a131033.upc-a.chello.nl	2.735	0.446	0.000	05:52:30
ip72-222-200-117.ph.ph.cox.net	0.435	0.053	0.000	02:00:14
94.161.70.243	0.187	0.039	0.000	00:00:03
scan-141.security.ipip.net	0.068	0.009	0.000	00:00:01
94.163.183.9	0.046	0.031	0.000	00:00:01
94.163.146.52	0.069	0.008	0.000	00:00:01
TOTAL: 7	7.263	1.242	0.033	20:14:38

Curious NNRP server explorers [Top 20]:

System	Conn
ip72-222-200-117.ph.ph.cox.net	4
94.161.70.243	3
94.163.146.52	1
94.163.183.9	1
scan-141.security.ipip.net	1
TOTAL: 5	10

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	14	0
ip72-222-200-117.ph.ph.cox.net	4	0
TOTAL: 2	18	0

Newsgroup request counts (by category):

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

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

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

Daily Usenet report for csiph.com

Jan 11 04:15:00 -- Jan 12 04:15:00