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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	42449	45.8%	6.3 MB	57.8%
nnrpd	32230	34.8%	2.7 MB	24.5%
innd	16161	17.4%	1.7 MB	15.2%
innfeed	1844	2.0%	271.1 KB	2.4%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 5	92685	100.0%	11.0 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	234114	48.2%
Negative hits	206476	42.5%
Do not exist	41408	8.5%
Cache misses	4106	0.8%
TOTAL: 4	486104	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:01.326	0.0%	417	0.000	3.180	35.000
article cleanup	00:00:00.295	0.0%	41067	0.000	0.007	0.026
article logging	00:00:00.614	0.0%	41575	0.000	0.015	0.132
article parse	00:00:02.535	0.0%	203725	0.002	0.012	0.047
article write	00:00:32.018	0.0%	24473	0.167	1.308	7.727
artlog/artcncl	00:00:00.003	0.0%	337	0.000	0.009	1.000
artlog/artparse	00:00:00.035	0.0%	574	0.000	0.061	1.286
data move	00:00:00.226	0.0%	625206	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.209	0.0%	414	0.000	0.505	23.000
hishave/artcncl	00:00:00.056	0.0%	417	0.000	0.134	0.300
hishave/artparse	00:00:00.002	0.0%	574	0.000	0.003	0.019
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:07.097	0.0%	488013	0.000	0.015	0.148
history sync	00:00:01.770	0.0%	354	0.000	5.000	82.000
history write	00:00:48.206	0.1%	41065	0.080	1.174	6.312
hiswrite/artcncl	00:00:00.001	0.0%	3	0.000	0.333	1.000
hiswrite/artparse	00:00:00.762	0.0%	574	0.000	1.328	17.333
idle	23:56:29.173	99.7%	612050	36.352	140.820	442.198
nntp read	00:00:02.034	0.0%	611739	0.001	0.003	0.006
overview write	00:01:04.615	0.1%	24473	0.208	2.640	8.505
perl filter	00:01:06.622	0.1%	41065	0.820	1.622	3.386
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.433	0.0%	48946	0.000	0.009	0.020
TOTAL: 24:00:53.152	24:00:18.032	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.081	0.0%	24397	0.000	0.003	0.019
article prepare	00:00:00.001	0.0%	8852	0.000	0.000	0.036
article read	00:00:00.280	0.0%	1743	0.000	0.161	9.200
backlog stats	00:00:00.128	0.0%	275185	0.000	0.000	0.003
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.208	0.0%	210516	0.000	0.006	0.012
data write	00:00:01.573	0.0%	189753	0.003	0.008	0.017
idle	23:54:24.709	100.0%	275185	163.648	312.752	835.954
status file	00:00:00.080	0.0%	189	0.000	0.423	1.000
TOTAL: 23:54:34.034	23:54:28.060	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:00.361	0.0%	7839	0.000	0.046	2.722
idle	22:15:20.838	99.9%	39297	0.000	2038.854	600139.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.486	0.0%	79595	0.000	0.006	0.125
readart	00:00:00.030	0.0%	83	0.000	0.361	14.000
TOTAL: 22:16:58.216	22:15:21.715	99.9%	-	-	-	-

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	feeder.eternal-september.org	3	36703	7087	26622	2994	19%	23:40:31
2	au2pb.net	1	25812	5028	20225	559	19%	23:43:25
3	xanadu-bbs.net	1	42343	3801	31073	7469	8%	24:44:02
4	news-out.mixmin.net	5	31852	3055	25843	2954	9%	24:18:35
5	newsfeeds.xmission.com	1	24397	1863	22405	129	7%	23:15:27
6	newsfeed.neva.ru	151	50655	1783	46012	2860	3%	71:59:27
7	newsfeed.fu-berlin.de	53	30020	1355	28356	309	4%	34:27:10
8	news.swapon.de	5	2132	249	1875	8	11%	24:34:25
9	nntp.pasdenom.info	2	6916	88	6784	44	1%	08:47:17
10	localhost	48	12420	0	12420	0	0%	00:01:00
TOTAL: 10		270	263250	24309	221615	17326	9%	259:31:19

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	feeder.eternal-september.org	18.9 MB	1.6 KB	9.2 MB	28.0 MB	67%	2.8 KB
2	au2pb.net	12.4 MB	0.0 KB	3.2 MB	15.6 MB	79%	2.9 KB
3	xanadu-bbs.net	10.4 MB	0.0 KB	130.7 MB	141.1 MB	7%	12.8 KB
4	news-out.mixmin.net	9.2 MB	2.9 KB	5.4 MB	14.6 MB	62%	2.5 KB
5	newsfeed.neva.ru	5.5 MB	0.0 KB	11.4 MB	16.9 MB	32%	3.7 KB
6	newsfeeds.xmission.com	5.5 MB	0.0 KB	1.7 MB	7.2 MB	76%	3.7 KB
7	newsfeed.fu-berlin.de	2.9 MB	0.0 KB	842.5 KB	3.7 MB	77%	2.3 KB
8	news.swapon.de	618.1 KB	0.0 KB	1.3 MB	1.9 MB	32%	7.4 KB
9	nntp.pasdenom.info	248.3 KB	0.0 KB	837.6 KB	1.1 MB	22%	8.2 KB
10	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 10		65.6 MB	4.5 KB	164.5 MB	230.1 MB	28%	5.7 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Oct 18 04:15:00 - 04:59:59	477	2.0%	0.18	1.5 MB	2.3%	0.57
Oct 18 05:00:00 - 05:59:59	494	2.0%	0.14	1.3 MB	2.0%	0.38
Oct 18 06:00:00 - 06:59:59	638	2.6%	0.18	1.8 MB	2.8%	0.52
Oct 18 07:00:00 - 07:59:59	788	3.2%	0.22	2.2 MB	3.3%	0.62
Oct 18 08:00:00 - 08:59:59	988	4.0%	0.27	2.4 MB	3.7%	0.69
Oct 18 09:00:00 - 09:59:59	1018	4.2%	0.28	2.6 MB	4.0%	0.75
Oct 18 10:00:00 - 10:59:59	1091	4.5%	0.30	2.7 MB	4.2%	0.78
Oct 18 11:00:00 - 11:59:59	1163	4.8%	0.32	3.3 MB	5.1%	0.95
Oct 18 12:00:00 - 12:59:59	1194	4.9%	0.33	3.0 MB	4.6%	0.86
Oct 18 13:00:00 - 13:59:59	1255	5.1%	0.35	3.4 MB	5.1%	0.96
Oct 18 14:00:00 - 14:59:59	1353	5.5%	0.38	3.6 MB	5.5%	1.03
Oct 18 15:00:00 - 15:59:59	1314	5.4%	0.36	3.4 MB	5.2%	0.97
Oct 18 16:00:00 - 16:59:59	1591	6.5%	0.44	4.0 MB	6.0%	1.12
Oct 18 17:00:00 - 17:59:59	1406	5.8%	0.39	3.5 MB	5.4%	1.01
Oct 18 18:00:00 - 18:59:59	1445	5.9%	0.40	4.0 MB	6.0%	1.13
Oct 18 19:00:00 - 19:59:59	1438	5.9%	0.40	3.8 MB	5.8%	1.08
Oct 18 20:00:00 - 20:59:59	1311	5.4%	0.36	3.2 MB	4.9%	0.92
Oct 18 21:00:00 - 21:59:59	1368	5.6%	0.38	3.4 MB	5.2%	0.96
Oct 18 22:00:00 - 22:59:59	937	3.8%	0.26	2.7 MB	4.1%	0.77
Oct 18 23:00:00 - 23:59:59	691	2.8%	0.19	2.0 MB	3.0%	0.56
Oct 19 00:00:00 - 00:59:59	695	2.8%	0.19	2.2 MB	3.4%	0.63
Oct 19 01:00:00 - 01:59:59	513	2.1%	0.14	1.5 MB	2.2%	0.41
Oct 19 02:00:00 - 02:59:59	594	2.4%	0.17	2.3 MB	3.4%	0.64
Oct 19 03:00:00 - 03:59:59	473	1.9%	0.13	1.3 MB	2.0%	0.37
Oct 19 04:00:00 - 04:15:00	201	0.8%	0.22	560.6 KB	0.8%	0.62
TOTAL: 24:00:00	24436	100.0%	0.28	65.8 MB	100.0%	0.78

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	xanadu-bbs.net	7339	554	0	6785
2	feeder.eternal-september.org	3026	337	1	2688
3	news-out.mixmin.net	2968	20	1	2947
4	newsfeed.neva.ru	2830	1084	0	1746
5	newsfeed.fu-berlin.de	701	38	0	663
6	au2pb.net	577	530	0	47
7	newsfeeds.xmission.com	139	112	0	27
8	nntp.pasdenom.info	54	47	0	7
9	news.swapon.de	43	0	0	43
TOTAL: 9		17677	2722	2	14953

Unwanted newsgroups [Top 20]:

Newsgroup	Count
fa.linux.kernel	347
alt.politics.scorched-earth	196
lada.talk	191
ut.test	137
it-alt.sport.calcio.juventus	136
mailing.freebsd.pkg-fallout	115
pld.cvs.commit	81
mailing.freebsd.svn-src-all	77
fa.freebsd.cvs-all	75
alt.politics	65
lada.auto	60
alt.survival	60
gmane.linux.alsa.devel	57
mailing.openbsd.source-changes	49
mailing.freebsd.svn-src-head	48
alt.windows7.general	43
mailing.freebsd.ports-bugs	41
fa.openbsd.source-changes	30
mailing.openbsd.ports-changes	29
alt.philosophy	27
TOTAL: 230	2722

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	9772
EMP (phn path)	2469
EMP (phl)	1162
EMP (phn nph)	165
PFM bot misc	113
Too many newsgroups	96
HTML Multipart	34
HTML post	19
Binary Image: misplaced jpg	19
Too many newsgroups (low_xpost)	10
HTML Image Tags	5
Binary Payload	3
Too many newsgroups (meow)	2
Binary Image: misplaced jpeg	1
UUencoded txt	1
Binary Image: misplaced png	1
U2 violation - invalid distribution	1
TOTAL: 17	13873

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Huge articles
	xanadu-bbs.net	491
	feeder.eternal-september.org	34
	au2pb.net	26
	newsfeeds.xmission.com	15
	news.swapon.de	3
	nntp.pasdenom.info	2
	newsfeed.fu-berlin.de	2
	TOTAL: 7	573
Including strange strings
	newsfeed.fu-berlin.de	393
	news.swapon.de	35
	feeder.eternal-september.org	32
	news-out.mixmin.net	12
	au2pb.net	11
	newsfeeds.xmission.com	10
	xanadu-bbs.net	7
	newsfeed.neva.ru	6
	nntp.pasdenom.info	1
	TOTAL: 9	507
TOTAL: 2		1080

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	au2pb	20273	290	18832	255	0	1%	23:59:55
2	usenet.pasdenom.info	30006	197	23052	1081	2	0%	23:59:55
3	xanadu-bbs	22301	129	20510	57	14	0%	23:59:55
4	fu-berlin.de	22755	50	22683	22	0	0%	23:59:02
5	news.mixmin.net	21942	17	21203	26	0	0%	23:59:55
6	eternal-september	17702	15	16798	7	0	0%	23:59:55
7	xmission	28135	5	22357	1	0	0%	23:59:55
8	neva.ru	24019	3	22501	57	0	0%	23:59:29
9	news.swapon.de	1911	0	1896	2	0	0%	23:38:39
TOTAL: 9		189044	706	169832	1508	16	0%	215:36:40

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	au2pb	1.3 MB	651.3 KB	1.9 MB	3.6 KB	23:59:55
2	usenet.pasdenom.info	907.7 KB	1.8 MB	2.7 MB	2.2 KB	23:59:55
3	xanadu-bbs	826.6 KB	123.9 KB	950.5 KB	5.1 KB	23:59:55
4	fu-berlin.de	314.0 KB	29.8 KB	343.8 KB	4.8 KB	23:59:02
5	news.mixmin.net	145.8 KB	52.7 KB	198.5 KB	4.6 KB	23:59:55
6	eternal-september	62.9 KB	12.0 KB	74.9 KB	3.4 KB	23:59:55
7	neva.ru	20.1 KB	297.6 KB	317.7 KB	5.3 KB	23:59:29
8	xmission	10.6 KB	1.7 KB	12.3 KB	2.1 KB	23:59:55
9	news.swapon.de	0.0 KB	3.1 KB	3.1 KB	1.5 KB	23:38:39
TOTAL: 9		3.5 MB	3.0 MB	6.5 MB	3.0 KB	215:36:40

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Elapsed
1	202.89.176.220	288	77	239.6 KB	71	04:10:08
2	tempe0.bbox.io	7	2	2.4 KB	2	01:02:38
3	challenger.nielsenmedia.com	2	2	5.7 KB	1	00:30:14
4	pool-71-98-160-84.tampfl.dsl-w.verizon.net	9	2	5.7 KB	1	02:03:44
TOTAL: 4		306	83	253.4 KB	75	22:16:53

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	unresolved	372	77	239.6 KB	71	14:10:55
2	*.tampfl.dsl-w.verizon.net	9	2	5.7 KB	1	02:03:44
3	*.nielsenmedia.com	2	2	5.7 KB	1	00:30:14
4	*.bbox.io	7	2	2.4 KB	2	01:02:38
5	*.br.br.cox.net	1	0	0.0 KB	0	00:00:20
6	*.chello.nl	11	0	0.0 KB	0	04:10:23
7	*.ip-188-165-239.eu	29	0	0.0 KB	0	00:18:37
TOTAL: 7		431	83	253.4 KB	75	22:16:53

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.393	0.108	0.000	05:02:44
108.175.242.48	3.565	1.021	0.000	04:51:38
dhcp-089-099-203-254.chello.nl	0.858	0.155	0.000	04:10:23
202.89.176.220	27.025	6.019	0.698	04:10:08
pool-71-98-160-84.tampfl.dsl-w.verizon.net	0.787	0.127	0.000	02:03:44
tempe0.bbox.io	0.718	0.086	0.000	01:02:38
challenger.nielsenmedia.com	0.224	0.031	0.000	00:30:14
ns342002.ip-188-165-239.eu	2.307	0.664	0.000	00:18:37
71.94.21.184	0.112	0.008	0.000	00:06:21
ip70-186-184-250.br.br.cox.net	0.162	0.016	0.000	00:00:20
69.160.37.54	1.750	0.337	0.000	00:00:02
TOTAL: 11	37.901	8.572	0.698	22:16:53

Curious NNRP server explorers [Top 20]:

System	Conn
108.175.242.48	50
ns342002.ip-188-165-239.eu	29
69.160.37.54	25
dhcp-089-099-203-254.chello.nl	11
162.212.88.214	8
ip70-186-184-250.br.br.cox.net	1
71.94.21.184	1
TOTAL: 7	125

NNRP unrecognized commands (by host):

System	Conn
71.94.21.184	1
TOTAL: 1	1

NNRP unrecognized commands (by command):

Command	Count
XFEATURE COMPRESS GZIP	1
TOTAL: 1	1

NNRP client timeouts [Top 20]:

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

Newsgroup request counts (by category):

Category		Count	Pct
1	comp	82	98.8%
2	news	1	1.2%
TOTAL: 2		83	100.0%

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

Newsgroup		Count
1	comp.os.linux.networking	17
2	comp.os.vms	15
3	comp.sys.ibm.pc.games.action	13
4	comp.arch.embedded	11
5	comp.arch	10
6	comp.sys.ibm.pc.hardware.storage	5
7	comp.lang.awk	4
8	comp.os.os2.apps	3
9	comp.sys.ibm.pc.games.war-historical	2
10	news.software.nntp	1
11	comp.unix.bsd.freebsd.misc	1
12	comp.os.qnx	1
TOTAL: 12		83

Daily Usenet report for csiph.com

Oct 18 04:15:00 -- Oct 19 04:15:00