Daily Usenet report for csiph.com: Oct 29 04:15:00

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Oct 29 04:32:12 csiph controlchan[95729]: skipping newgroup alt.binaries.sounds.mp3.halloween y chenjieli1977@126.com (would be created): Empty description
Oct 29 04:39:10 csiph controlchan[95729]: skipping newgroup alt.binaries.sounds.radio.newtime y chenjieli1977@126.com (would not change): Empty description

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	59693	49.2%	8.3 MB	59.4%
nnrpd	32078	26.5%	2.7 MB	19.4%
innd	27600	22.8%	2.7 MB	19.4%
innfeed	1894	1.6%	266.4 KB	1.9%
controlchan	5	0.0%	0.8 KB	0.0%
TOTAL: 5	121270	100.0%	13.9 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	285613	45.8%
Negative hits	279220	44.7%
Do not exist	58578	9.4%
Cache misses	556	0.1%
TOTAL: 4	623967	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.334	0.0%	171	0.000	1.953	19.000
article cleanup	00:00:00.341	0.0%	58238	0.000	0.006	0.019
article logging	00:00:00.708	0.0%	58830	0.000	0.012	0.034
article parse	00:00:02.676	0.0%	296327	0.003	0.009	0.019
article write	00:00:12.479	0.0%	27740	0.175	0.450	0.898
artlog/artcncl	00:00:00.004	0.0%	159	0.000	0.025	1.000
artlog/artparse	00:00:00.009	0.0%	747	0.000	0.012	0.500
data move	00:00:00.292	0.0%	772790	0.000	0.000	0.001
hisgrep/artcncl	00:00:00.002	0.0%	168	0.000	0.012	0.333
hishave/artcncl	00:00:00.001	0.0%	171	0.000	0.006	0.250
hishave/artparse	00:00:00.002	0.0%	747	0.000	0.003	0.250
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:01.934	0.0%	626444	0.001	0.003	0.010
history sync	00:00:00.562	0.0%	314	0.000	1.790	3.667
history write	00:00:16.584	0.0%	58210	0.104	0.285	0.369
hiswrite/artcncl	00:00:00.000	0.0%	3	0.000	0.000	0.000
hiswrite/artparse	00:00:00.249	0.0%	739	0.000	0.337	3.000
idle	23:57:11.431	99.8%	757757	31.693	113.798	326.615
nntp read	00:00:02.346	0.0%	759798	0.001	0.003	0.006
overview write	00:00:06.572	0.0%	27740	0.084	0.237	1.202
perl filter	00:02:02.671	0.1%	58210	0.986	2.107	4.524
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.474	0.0%	55482	0.000	0.009	0.022
TOTAL: 24:00:35.617	23:59:59.671	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.078	0.0%	30703	0.000	0.003	0.024
article prepare	00:00:00.003	0.0%	8628	0.000	0.000	0.010
article read	00:00:00.237	0.0%	1582	0.000	0.150	5.111
backlog stats	00:00:00.118	0.0%	309581	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.244	0.0%	236834	0.000	0.005	0.014
data write	00:00:01.607	0.0%	213385	0.002	0.008	0.016
idle	23:53:48.917	100.0%	309581	141.471	277.888	1015.582
status file	00:00:00.082	0.0%	197	0.000	0.416	1.000
TOTAL: 23:53:56.100	23:53:52.286	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:00.319	0.0%	12990	0.012	0.025	0.034
idle	61:50:50.634	99.9%	44527	0.000	5000.351	600145.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.806	0.0%	90238	0.000	0.009	2.296
readart	00:00:01.349	0.0%	4160	0.000	0.324	46.000
TOTAL: 61:52:43.145	61:50:53.108	100.0%	-	-	-	-

Control commands to INND:

Command	Number
L	1
flush	4
flushlogs	2
go	2
logmode	2
mode	147
pause	2
paused	2
reload	2
reserve	2
TOTAL: 10	166

Control Channel:

Sender	newgroup	rmgroup	Other	Bad PGP	DoIt	OK
chenjieli1977@126.com	2	0	0	0	2	2
TOTAL	2	0	0	0	2	2

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	feeder.eternal-september.org	7	54694	7871	39547	7276	14%	25:28:50
2	xanadu-bbs.net	1	58340	4825	44875	8640	8%	23:52:04
3	news-out.mixmin.net	6	36900	4238	29217	3445	11%	24:15:26
4	au2pb.net	1	29471	4071	24588	812	13%	23:13:49
5	newsfeeds.xmission.com	2	27961	2427	25436	98	8%	23:52:08
6	newsfeed.neva.ru	142	72437	2214	59865	10358	3%	71:46:20
7	newsfeed.fu-berlin.de	49	33038	1279	31318	441	3%	31:48:55
8	nntp.pasdenom.info	3	29534	374	29043	117	1%	24:08:38
9	news.swapon.de	1	2427	314	2089	24	12%	22:18:58
10	localhost	26	0	0	0	0	0%	00:00:00
TOTAL: 10		238	344802	27613	285978	31211	8%	270:45:08

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	feeder.eternal-september.org	22.1 MB	36.8 KB	57.9 MB	80.0 MB	27%	5.4 KB
2	xanadu-bbs.net	14.2 MB	3.1 KB	155.5 MB	169.7 MB	8%	12.9 KB
3	au2pb.net	12.8 MB	0.0 KB	4.5 MB	17.3 MB	74%	3.6 KB
4	news-out.mixmin.net	12.6 MB	0.0 KB	8.8 MB	21.3 MB	58%	2.8 KB
5	newsfeeds.xmission.com	7.7 MB	0.0 KB	1.3 MB	9.0 MB	85%	3.6 KB
6	newsfeed.neva.ru	6.6 MB	34.8 KB	87.3 MB	94.0 MB	7%	7.7 KB
7	newsfeed.fu-berlin.de	2.9 MB	0.0 KB	2.9 MB	5.8 MB	49%	3.5 KB
8	nntp.pasdenom.info	926.5 KB	8.4 KB	824.7 KB	1.7 MB	52%	3.6 KB
9	news.swapon.de	815.1 KB	0.0 KB	3.1 MB	3.9 MB	20%	11.7 KB
10	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 10		80.5 MB	83.0 KB	322.1 MB	402.7 MB	19%	7.0 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Oct 29 04:15:00 - 04:59:59	452	1.6%	0.17	1.4 MB	1.7%	0.54
Oct 29 05:00:00 - 05:59:59	678	2.4%	0.19	2.7 MB	3.3%	0.76
Oct 29 06:00:00 - 06:59:59	554	2.0%	0.15	2.1 MB	2.6%	0.59
Oct 29 07:00:00 - 07:59:59	940	3.4%	0.26	2.9 MB	3.5%	0.82
Oct 29 08:00:00 - 08:59:59	1370	4.9%	0.38	3.9 MB	4.8%	1.11
Oct 29 09:00:00 - 09:59:59	1351	4.9%	0.38	3.4 MB	4.2%	0.96
Oct 29 10:00:00 - 10:59:59	1368	4.9%	0.38	3.6 MB	4.4%	1.02
Oct 29 11:00:00 - 11:59:59	1197	4.3%	0.33	3.1 MB	3.9%	0.90
Oct 29 12:00:00 - 12:59:59	1282	4.6%	0.36	3.5 MB	4.3%	1.00
Oct 29 13:00:00 - 13:59:59	1386	5.0%	0.39	3.9 MB	4.8%	1.11
Oct 29 14:00:00 - 14:59:59	1417	5.1%	0.39	3.9 MB	4.8%	1.10
Oct 29 15:00:00 - 15:59:59	1602	5.8%	0.45	4.1 MB	5.1%	1.17
Oct 29 16:00:00 - 16:59:59	1692	6.1%	0.47	4.7 MB	5.7%	1.32
Oct 29 17:00:00 - 17:59:59	1674	6.0%	0.47	4.8 MB	5.9%	1.37
Oct 29 18:00:00 - 18:59:59	1653	6.0%	0.46	5.0 MB	6.2%	1.42
Oct 29 19:00:00 - 19:59:59	1477	5.3%	0.41	4.4 MB	5.5%	1.26
Oct 29 20:00:00 - 20:59:59	1393	5.0%	0.39	4.0 MB	4.9%	1.13
Oct 29 21:00:00 - 21:59:59	1326	4.8%	0.37	3.6 MB	4.5%	1.03
Oct 29 22:00:00 - 22:59:59	1156	4.2%	0.32	3.3 MB	4.1%	0.95
Oct 29 23:00:00 - 23:59:59	996	3.6%	0.28	3.1 MB	3.8%	0.87
Oct 30 00:00:00 - 00:59:59	774	2.8%	0.21	2.3 MB	2.8%	0.65
Oct 30 01:00:00 - 01:59:59	575	2.1%	0.16	1.8 MB	2.3%	0.52
Oct 30 02:00:00 - 02:59:59	696	2.5%	0.19	3.1 MB	3.8%	0.87
Oct 30 03:00:00 - 03:59:59	545	2.0%	0.15	1.6 MB	2.0%	0.45
Oct 30 04:00:00 - 04:15:00	182	0.7%	0.20	894.7 KB	1.1%	0.99
TOTAL: 24:00:00	27736	100.0%	0.32	81.0 MB	100.0%	0.96

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	newsfeed.neva.ru	10437	2439	12	7986
2	xanadu-bbs.net	8738	844	2	7892
3	feeder.eternal-september.org	7195	783	10	6402
4	news-out.mixmin.net	3431	23	0	3408
5	newsfeed.fu-berlin.de	858	166	0	692
6	au2pb.net	836	803	0	33
7	nntp.pasdenom.info	118	94	4	20
8	newsfeeds.xmission.com	113	82	0	31
9	news.swapon.de	72	0	0	72
TOTAL: 9		31798	5234	28	26536

Unwanted newsgroups [Top 20]:

Newsgroup	Count
lada.talk	1597
fa.linux.kernel	618
alt.politics.scorched-earth	164
mailing.freebsd.pkg-fallout	156
it-alt.sport.calcio.juventus	135
ut.test	133
lada.auto	132
alt.politics	105
mailing.freebsd.ports-bugs	92
gmane.linux.alsa.devel	74
mailing.freebsd.svn-src-all	67
fa.freebsd.cvs-all	64
tin.it.sport.calcio	56
mailing.freebsd.svn-src-head	55
mailing.freebsd.svn-ports-all	55
mailing.freebsd.svn-ports-head	54
mailing.gcc.gcc-cvs	53
mailing.database.pgsql-general	52
alt.survival	50
alt.windows7.general	49
TOTAL: 294	5234

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	20426
EMP (phn path)	3390
EMP (phl)	796
PFM bot misc	184
EMP (phn nph)	182
HTML Multipart	65
HTML post	50
Too many newsgroups	38
Binary Image: misplaced jpg	25
User-issued spam cancel	20
HTML Image Tags	12
Too many newsgroups (low_xpost)	5
Binary: non-binary distribution	4
Binary: misplaced PAR2	1
Binary: misplaced par2	1
TOTAL: 15	25199

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Huge articles
	xanadu-bbs.net	586
	feeder.eternal-september.org	85
	au2pb.net	20
	news-out.mixmin.net	20
	newsfeeds.xmission.com	13
	newsfeed.fu-berlin.de	9
	nntp.pasdenom.info	7
	news.swapon.de	5
	TOTAL: 8	745
Including strange strings
	newsfeed.fu-berlin.de	383
	xanadu-bbs.net	74
	news.swapon.de	45
	feeder.eternal-september.org	37
	news-out.mixmin.net	33
	newsfeeds.xmission.com	14
	newsfeed.neva.ru	3
	au2pb.net	2
	nntp.pasdenom.info	1
	TOTAL: 9	592
TOTAL: 2		1337

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	au2pb	25202	516	22821	283	0	2%	23:59:58
2	usenet.pasdenom.info	33357	259	26488	617	1	0%	23:59:58
3	xanadu-bbs	24790	229	22613	31	17	0%	23:59:58
4	fu-berlin.de	26088	61	26008	18	0	0%	23:59:56
5	news.mixmin.net	24991	28	23368	0	0	0%	23:59:43
6	neva.ru	26781	16	25181	76	3033	0%	23:59:57
7	xmission	31048	12	25078	0	0	0%	23:59:54
8	eternal-september	20843	10	19374	2	0	0%	23:59:58
9	news.swapon.de	2297	0	2262	5	0	0%	23:58:32
TOTAL: 9		215397	1131	193193	1032	3051	0%	215:57:54

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	au2pb	2.1 MB	1.1 MB	3.1 MB	4.0 KB	23:59:58
2	xanadu-bbs	1.3 MB	88.9 KB	1.4 MB	5.5 KB	23:59:58
3	usenet.pasdenom.info	1.3 MB	1.9 MB	3.2 MB	3.7 KB	23:59:58
4	fu-berlin.de	517.5 KB	24.3 KB	541.8 KB	6.9 KB	23:59:56
5	news.mixmin.net	121.4 KB	0.0 KB	121.4 KB	4.3 KB	23:59:43
6	neva.ru	93.5 KB	468.7 KB	562.2 KB	6.1 KB	23:59:57
7	eternal-september	43.4 KB	2.8 KB	46.2 KB	3.8 KB	23:59:58
8	xmission	18.2 KB	0.0 KB	18.2 KB	1.5 KB	23:59:54
9	news.swapon.de	0.0 KB	7.3 KB	7.3 KB	1.5 KB	23:58:32
TOTAL: 9		5.5 MB	3.6 MB	9.0 MB	4.3 KB	215:57:54

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Elapsed
1	202.89.176.220	288	110	342.2 KB	96	04:36:00
2	tempe0.bbox.io	16	5	7.9 KB	3	01:19:34
3	challenger.nielsenmedia.com	12	2	4.7 KB	2	02:32:24
4	dhcp-089-099-203-254.chello.nl	19	1	2.0 KB	1	08:12:02
TOTAL: 4		335	118	356.8 KB	102	61:52:39

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	unresolved	322	110	342.2 KB	96	47:54:21
2	*.bbox.io	16	5	7.9 KB	3	01:19:34
3	*.nielsenmedia.com	12	2	4.7 KB	2	02:32:24
4	*.chello.nl	19	1	2.0 KB	1	08:12:02
5	*.tampfl.dsl-w.verizon.net	15	0	0.0 KB	0	01:54:15
TOTAL: 5		384	118	356.8 KB	102	61:52:39

NNRP auth users [Top 20]:

User	Conn
moussa	288
TOTAL: 1	288

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
162.212.88.214	0.974	0.621	0.000	43:18:13
dhcp-089-099-203-254.chello.nl	1.628	0.264	0.000	08:12:02
202.89.176.220	30.176	5.759	0.717	04:36:00
challenger.nielsenmedia.com	1.145	0.258	0.000	02:32:24
pool-71-98-160-84.tampfl.dsl-w.verizon.net	1.091	0.244	0.000	01:54:15
tempe0.bbox.io	1.410	0.276	0.000	01:19:34
216.240.144.68	0.217	0.305	0.000	00:00:04
69.160.37.54	2.007	0.357	0.000	00:00:02
TOTAL: 8	38.648	8.084	0.717	61:52:39

Curious NNRP server explorers [Top 20]:

System	Conn
69.160.37.54	25
pool-71-98-160-84.tampfl.dsl-w.verizon.net	15
162.212.88.214	8
216.240.144.68	1
TOTAL: 4	49

NNRP client timeouts [Top 20]:

System	Conn	Peer
dhcp-089-099-203-254.chello.nl	11	0
challenger.nielsenmedia.com	4	0
pool-71-98-160-84.tampfl.dsl-w.verizon.net	3	0
tempe0.bbox.io	2	0
TOTAL: 4	20	0

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	comp.os.vms	36
2	comp.arch	27
3	comp.arch.fpga	16
4	comp.sys.ibm.pc.games.war-historical	16
5	comp.sys.ibm.pc.games.action	10
6	comp.arch.embedded	2
7	comp.unix.bsd.netbsd.misc	2
8	comp.lang.awk	2
9	comp.unix.bsd.freebsd.misc	2
10	comp.sys.ibm.ps2.hardware	2
11	comp.windows.x.kde	1
12	comp.sys.ibm.pc.games.rpg	1
13	comp.ai.philosophy	1
TOTAL: 13		118

Daily Usenet report for csiph.com

Oct 29 04:15:00 -- Oct 30 04:15:00