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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	49622	48.9%	7.3 MB	60.8%
nnrpd	31711	31.3%	2.8 MB	23.2%
innd	18195	17.9%	1.7 MB	13.8%
innfeed	1879	1.9%	262.7 KB	2.1%
controlchan	5	0.0%	0.7 KB	0.0%
TOTAL: 5	101412	100.0%	12.0 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	275627	48.6%
Negative hits	240125	42.3%
Do not exist	48771	8.6%
Cache misses	3037	0.5%
TOTAL: 4	567560	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.370	0.0%	237	0.000	1.561	22.000
article cleanup	00:00:00.248	0.0%	47997	0.000	0.005	0.017
article logging	00:00:00.541	0.0%	48568	0.000	0.011	0.040
article parse	00:00:02.309	0.0%	264187	0.003	0.009	0.018
article write	00:00:07.672	0.0%	28597	0.177	0.268	1.433
artlog/artcncl	00:00:00.003	0.0%	178	0.000	0.017	0.154
artlog/artparse	00:00:00.010	0.0%	894	0.000	0.011	0.333
data move	00:00:00.307	0.0%	739791	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.002	0.0%	236	0.000	0.008	0.083
hishave/artcncl	00:00:00.000	0.0%	237	0.000	0.000	0.000
hishave/artparse	00:00:00.004	0.0%	894	0.000	0.004	1.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:01.402	0.0%	568052	0.000	0.002	0.008
history sync	00:00:00.598	0.0%	346	0.000	1.728	3.667
history write	00:00:13.156	0.0%	47991	0.086	0.274	0.353
hiswrite/artcncl	00:00:00.000	0.0%	1	0.000	0.000	0.000
hiswrite/artparse	00:00:00.229	0.0%	894	0.000	0.256	3.000
idle	23:58:11.746	99.8%	724937	32.701	119.033	349.135
nntp read	00:00:02.484	0.0%	723568	0.001	0.003	0.006
overview write	00:00:04.537	0.0%	28597	0.105	0.159	0.435
perl filter	00:01:25.365	0.1%	47991	1.030	1.779	3.598
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.531	0.0%	57195	0.000	0.009	0.024
TOTAL: 24:00:48.752	24:00:11.514	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.068	0.0%	28665	0.000	0.002	0.016
article prepare	00:00:00.001	0.0%	7520	0.000	0.000	0.025
article read	00:00:00.237	0.0%	1360	0.000	0.174	68.000
backlog stats	00:00:00.110	0.0%	317372	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.314	0.0%	243432	0.001	0.005	0.011
data write	00:00:01.787	0.0%	217858	0.003	0.008	0.017
idle	23:54:22.408	100.0%	317372	123.819	271.172	813.718
status file	00:00:00.083	0.0%	188	0.000	0.441	3.000
TOTAL: 23:54:31.084	23:54:26.008	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:00.368	0.0%	19806	0.000	0.019	0.027
idle	80:55:40.299	100.0%	50977	1.000	5715.132	600130.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.616	0.0%	102832	0.000	0.006	0.167
readart	00:00:00.125	0.0%	64	0.000	1.953	71.000
TOTAL: 80:56:51.089	80:55:41.408	100.0%	-	-	-	-

Control commands to INND:

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

Control Channel:

Sender	newgroup	rmgroup	Other	Bad PGP	DoIt	OK
usenet@film.rlss.okayama-u.ac.jp	0	0	1	0	1	1
TOTAL	0	0	1	0	1	1

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	feeder.eternal-september.org	5	44712	7803	34570	2339	17%	24:37:41
2	au2pb.net	1	31072	7273	22638	1161	23%	23:17:00
3	xanadu-bbs.net	0	48885	3439	36616	8830	7%	25:06:05
4	news-out.mixmin.net	6	34080	3392	28536	2152	9%	24:25:40
5	newsfeed.neva.ru	152	64831	2529	57109	5193	3%	72:34:35
6	newsfeeds.xmission.com	1	29582	1758	27765	59	5%	24:04:52
7	newsfeed.fu-berlin.de	77	31105	1409	29281	415	4%	35:10:51
8	nntp.pasdenom.info	2	25311	520	24685	106	2%	18:11:22
9	news.swapon.de	3	2770	291	2464	15	10%	24:12:26
10	localhost	48	8479	0	8479	0	0%	00:00:59
TOTAL: 10		295	320827	28414	272143	20270	8%	271:41:31

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	feeder.eternal-september.org	22.6 MB	6.0 KB	13.8 MB	36.4 MB	62%	3.7 KB
2	au2pb.net	19.1 MB	0.0 KB	4.4 MB	23.6 MB	81%	2.9 KB
3	news-out.mixmin.net	11.0 MB	1.1 KB	5.9 MB	16.9 MB	64%	3.1 KB
4	xanadu-bbs.net	9.7 MB	0.0 KB	164.5 MB	174.2 MB	5%	14.5 KB
5	newsfeed.neva.ru	8.2 MB	18.4 KB	27.4 MB	35.7 MB	23%	4.7 KB
6	newsfeeds.xmission.com	5.4 MB	0.0 KB	1.3 MB	6.7 MB	80%	3.8 KB
7	newsfeed.fu-berlin.de	3.4 MB	0.0 KB	1.3 MB	4.8 MB	71%	2.7 KB
8	nntp.pasdenom.info	1.1 MB	0.0 KB	1.3 MB	2.4 MB	47%	4.0 KB
9	news.swapon.de	866.5 KB	0.0 KB	577.6 KB	1.4 MB	59%	4.7 KB
10	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 10		81.4 MB	25.6 KB	220.5 MB	301.9 MB	26%	6.4 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Sep 30 04:15:00 - 04:59:59	451	1.6%	0.17	1.3 MB	1.6%	0.51
Sep 30 05:00:00 - 05:59:59	694	2.4%	0.19	3.0 MB	3.6%	0.85
Sep 30 06:00:00 - 06:59:59	925	3.2%	0.26	2.9 MB	3.5%	0.82
Sep 30 07:00:00 - 07:59:59	1209	4.2%	0.34	3.3 MB	4.1%	0.94
Sep 30 08:00:00 - 08:59:59	1506	5.3%	0.42	3.9 MB	4.8%	1.12
Sep 30 09:00:00 - 09:59:59	1420	5.0%	0.39	4.5 MB	5.5%	1.27
Sep 30 10:00:00 - 10:59:59	1442	5.0%	0.40	3.8 MB	4.7%	1.08
Sep 30 11:00:00 - 11:59:59	1410	4.9%	0.39	3.5 MB	4.3%	1.01
Sep 30 12:00:00 - 12:59:59	1646	5.8%	0.46	4.0 MB	4.9%	1.14
Sep 30 13:00:00 - 13:59:59	1408	4.9%	0.39	3.6 MB	4.4%	1.02
Sep 30 14:00:00 - 14:59:59	1484	5.2%	0.41	4.2 MB	5.1%	1.18
Sep 30 15:00:00 - 15:59:59	1474	5.2%	0.41	3.9 MB	4.8%	1.11
Sep 30 16:00:00 - 16:59:59	1674	5.9%	0.47	4.7 MB	5.7%	1.33
Sep 30 17:00:00 - 17:59:59	1579	5.5%	0.44	4.3 MB	5.2%	1.22
Sep 30 18:00:00 - 18:59:59	1518	5.3%	0.42	4.3 MB	5.3%	1.23
Sep 30 19:00:00 - 19:59:59	1575	5.5%	0.44	4.6 MB	5.6%	1.31
Sep 30 20:00:00 - 20:59:59	1479	5.2%	0.41	4.3 MB	5.3%	1.24
Sep 30 21:00:00 - 21:59:59	1307	4.6%	0.36	3.9 MB	4.8%	1.12
Sep 30 22:00:00 - 22:59:59	1081	3.8%	0.30	3.5 MB	4.3%	1.01
Sep 30 23:00:00 - 23:59:59	777	2.7%	0.22	2.5 MB	3.0%	0.70
Oct 1 00:00:00 - 00:59:59	710	2.5%	0.20	2.4 MB	2.9%	0.68
Oct 1 01:00:00 - 01:59:59	596	2.1%	0.17	1.7 MB	2.1%	0.48
Oct 1 02:00:00 - 02:59:59	510	1.8%	0.14	1.4 MB	1.7%	0.39
Oct 1 03:00:00 - 03:59:59	578	2.0%	0.16	1.8 MB	2.2%	0.51
Oct 1 04:00:00 - 04:15:00	114	0.4%	0.13	349.6 KB	0.4%	0.39
TOTAL: 24:00:00	28567	100.0%	0.33	81.6 MB	100.0%	0.97

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	xanadu-bbs.net	8828	405	0	8423
2	newsfeed.neva.ru	5201	1849	3	3349
3	feeder.eternal-september.org	2386	365	2	2019
4	news-out.mixmin.net	2176	0	1	2175
5	au2pb.net	1184	1136	0	48
6	newsfeed.fu-berlin.de	882	60	0	822
7	nntp.pasdenom.info	116	100	0	16
8	newsfeeds.xmission.com	71	41	0	30
9	news.swapon.de	36	0	0	36
TOTAL: 9		20880	3956	6	16918

Unwanted newsgroups [Top 20]:

Newsgroup	Count
fa.linux.kernel	1086
lada.talk	341
it-alt.sport.calcio.juventus	161
alt.politics	121
lada.auto	115
pld.cvs.commit	111
ut.test	69
gmane.linux.alsa.devel	64
mailing.freebsd.ports-bugs	62
mozilla.dev.tree-alerts	61
mailing.freebsd.svn-ports-all	53
mailing.freebsd.svn-ports-head	53
mailing.openbsd.source-changes	52
fa.openbsd.source-changes	51
tin.it.sport.calcio	45
free.it.calcio.juventus	39
alt.survival	38
mailing.gcc.gcc-cvs	38
lada.politics	36
mailing.openbsd.tech	36
TOTAL: 267	3956

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	11811
EMP (phn path)	2206
EMP (phl)	777
EMP (phn nph)	251
PFM bot misc	112
Binary: misplaced PAR2	103
Too many newsgroups	57
HTML Multipart	50
HTML post	32
Binary Image: misplaced jpg	20
Binary: misplaced par2	15
Binary: misplaced nzb	8
HTML Image Tags	5
Too many newsgroups (low_xpost)	2
Binary: misplaced c1Gi	1
Binary Image: misplaced gif	1
TOTAL: 16	15451

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Huge articles
	xanadu-bbs.net	732
	feeder.eternal-september.org	62
	news-out.mixmin.net	43
	au2pb.net	24
	newsfeeds.xmission.com	17
	nntp.pasdenom.info	13
	newsfeed.fu-berlin.de	5
	news.swapon.de	1
	TOTAL: 8	897
Including strange strings
	newsfeed.fu-berlin.de	443
	feeder.eternal-september.org	44
	news-out.mixmin.net	25
	news.swapon.de	21
	xanadu-bbs.net	13
	newsfeeds.xmission.com	11
	au2pb.net	9
	newsfeed.neva.ru	4
	TOTAL: 8	570
TOTAL: 2		1467

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	au2pb	22049	287	20676	213	0	1%	23:59:44
2	usenet.pasdenom.info	32027	194	27210	566	3	0%	23:59:57
3	xanadu-bbs	27523	190	24856	129	38	0%	23:59:57
4	xmission	34603	68	26618	2	0	0%	23:59:57
5	fu-berlin.de	26736	45	26671	20	0	0%	23:59:51
6	neva.ru	27096	17	25483	116	103	0%	23:59:56
7	news.mixmin.net	25707	14	24946	10	0	0%	23:59:57
8	eternal-september	21461	10	20237	3	0	0%	23:59:57
9	news.swapon.de	2504	1	2491	1	0	0%	23:58:01
TOTAL: 9		219706	826	199188	1060	144	0%	215:57:17

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	au2pb	1.2 MB	654.7 KB	1.9 MB	3.8 KB	23:59:44
2	xanadu-bbs	971.2 KB	249.1 KB	1.2 MB	3.8 KB	23:59:57
3	usenet.pasdenom.info	805.7 KB	1.3 MB	2.1 MB	2.8 KB	23:59:57
4	fu-berlin.de	254.4 KB	26.4 KB	280.9 KB	4.3 KB	23:59:51
5	xmission	160.5 KB	3.8 KB	164.3 KB	2.3 KB	23:59:57
6	neva.ru	106.2 KB	566.0 KB	672.2 KB	5.1 KB	23:59:56
7	news.mixmin.net	65.7 KB	15.3 KB	81.0 KB	3.4 KB	23:59:57
8	eternal-september	41.4 KB	4.6 KB	46.0 KB	3.5 KB	23:59:57
9	news.swapon.de	2.2 KB	2.5 KB	4.7 KB	2.4 KB	23:58:01
TOTAL: 9		3.6 MB	2.8 MB	6.4 MB	3.4 KB	215:57:17

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Elapsed
1	202.89.176.220	280	62	173.4 KB	59	19:41:45
2	challenger.nielsenmedia.com	16	2	4.4 KB	2	02:53:53
TOTAL: 2		296	64	177.8 KB	61	80:56:47

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	unresolved	320	62	173.4 KB	59	74:31:44
2	*.nielsenmedia.com	16	2	4.4 KB	2	02:53:53
3	*.ip-188-165-239.eu	2	0	0.0 KB	0	00:08:13
4	*.tu.ok.cox.net	1	0	0.0 KB	0	00:00:00
5	*.tampfl.dsl-w.verizon.net	16	0	0.0 KB	0	01:59:57
6	*.chello.nl	4	0	0.0 KB	0	01:20:27
7	*.br.br.cox.net	1	0	0.0 KB	0	00:02:30
TOTAL: 7		360	64	177.8 KB	61	80:56:47

NNRP auth users [Top 20]:

User	Conn
moussa	280
TOTAL: 1	280

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
162.212.88.198	1.095	0.859	0.000	54:49:16
202.89.176.220	25.999	6.055	0.676	19:41:45
challenger.nielsenmedia.com	1.302	0.243	0.000	02:53:53
pool-71-98-160-84.tampfl.dsl-w.verizon.net	1.236	0.303	0.000	01:59:57
dhcp-089-099-203-254.chello.nl	0.300	0.078	0.000	01:20:27
ns342002.ip-188-165-239.eu	0.254	0.124	0.000	00:08:13
ip70-186-183-22.br.br.cox.net	0.121	0.008	0.000	00:02:30
108.175.241.207	0.259	0.086	0.000	00:00:40
69.160.37.54	2.076	0.337	0.000	00:00:02
TOTAL: 9	32.642	8.093	0.676	80:56:47

Curious NNRP server explorers [Top 20]:

System	Conn
69.160.37.54	25
pool-71-98-160-84.tampfl.dsl-w.verizon.net	16
162.212.88.198	11
dhcp-089-099-203-254.chello.nl	4
108.175.241.207	4
ns342002.ip-188-165-239.eu	2
ip72-222-107-224.tu.ok.cox.net	1
ip70-186-183-22.br.br.cox.net	1
TOTAL: 8	64

NNRP client timeouts [Top 20]:

System	Conn	Peer
challenger.nielsenmedia.com	5	0
162.212.88.198	4	4
dhcp-089-099-203-254.chello.nl	2	0
pool-71-98-160-84.tampfl.dsl-w.verizon.net	2	0
TOTAL: 4	13	4

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	comp.arch	30
2	comp.os.vms	12
3	comp.arch.fpga	10
4	comp.sys.ibm.pc.hardware.storage	7
5	comp.lang.awk	2
6	comp.arch.embedded	1
7	comp.ai.edu	1
8	comp.ai.nat-lang	1
TOTAL: 8		64

Daily Usenet report for csiph.com

Sep 30 04:15:00 -- Oct 1 04:15:00