Daily Usenet report for csiph.com: Nov 28 04:15:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	44231	45.3%	6.5 MB	57.0%
nnrpd	32350	33.1%	2.7 MB	24.0%
innd	19237	19.7%	1.9 MB	16.6%
innfeed	1834	1.9%	282.5 KB	2.4%
controlchan	5	0.0%	0.7 KB	0.0%
TOTAL: 5	97657	100.0%	11.4 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	217614	46.8%
Negative hits	203703	43.8%
Do not exist	43594	9.4%
Cache misses	112	0.0%
TOTAL: 4	465023	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.440	0.0%	206	0.000	2.136	18.667
article cleanup	00:00:00.249	0.0%	40378	0.000	0.006	0.029
article logging	00:00:00.535	0.0%	40763	0.000	0.013	0.100
article parse	00:00:06.551	0.0%	534959	0.003	0.012	0.093
article write	00:00:34.831	0.0%	22257	0.177	1.565	6.452
artlog/artcncl	00:00:00.005	0.0%	160	0.000	0.031	1.000
artlog/artparse	00:00:00.041	0.0%	3315	0.000	0.012	0.333
data move	00:00:00.493	0.0%	938574	0.000	0.001	0.002
hisgrep/artcncl	00:00:00.079	0.0%	198	0.000	0.399	10.000
hishave/artcncl	00:00:00.000	0.0%	206	0.000	0.000	0.000
hishave/artparse	00:00:00.021	0.0%	3315	0.000	0.006	0.111
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:11.958	0.0%	462508	0.001	0.026	0.505
history sync	00:00:02.078	0.0%	361	0.000	5.756	53.500
history write	00:01:01.205	0.1%	40369	0.102	1.516	11.873
hiswrite/artcncl	00:00:00.006	0.0%	8	0.000	0.750	4.000
hiswrite/artparse	00:00:02.288	0.0%	3315	0.000	0.690	50.000
idle	23:55:45.259	99.6%	908072	11.685	94.866	350.126
nntp read	00:00:02.755	0.0%	910329	0.000	0.003	0.006
overview write	00:01:22.477	0.1%	22257	0.987	3.706	68.373
perl filter	00:01:12.563	0.1%	40369	0.947	1.797	3.979
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.359	0.0%	44516	0.000	0.008	0.045
TOTAL: 24:00:56.134	24:00:24.193	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.056	0.0%	22249	0.000	0.003	0.022
article prepare	00:00:00.000	0.0%	5488	0.000	0.000	0.000
article read	00:00:00.188	0.0%	1079	0.000	0.174	15.000
backlog stats	00:00:00.073	0.0%	250453	0.000	0.000	0.001
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.097	0.0%	192193	0.000	0.006	0.013
data write	00:00:01.325	0.0%	172067	0.000	0.008	0.016
idle	23:54:08.347	100.0%	250453	189.265	343.571	998.341
status file	00:00:00.086	0.0%	176	0.000	0.489	1.000
TOTAL: 23:54:14.685	23:54:11.172	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:01.659	0.0%	19160	0.000	0.087	1.000
idle	69:59:45.261	99.8%	50594	0.000	4980.536	600163.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.663	0.0%	102065	0.000	0.006	0.167
readart	00:00:00.053	0.0%	43	0.000	1.233	10.000
TOTAL: 70:09:44.299	69:59:47.636	99.8%	-	-	-	-

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
randito@dictatorshandbook.net	0	0	2	0	0	2
TOTAL	0	0	2	0	0	2

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	feeder.eternal-september.org	5	35129	5596	27374	2159	15%	23:57:10
2	au2pb.net	1	24973	5130	18924	919	20%	24:04:40
3	news-out.mixmin.net	3	29039	3334	21616	4089	11%	24:09:45
4	xanadu-bbs.net	3	43750	2906	31339	9505	6%	25:30:37
5	newsfeeds.xmission.com	1	22066	1968	20035	63	8%	23:42:18
6	newsfeed.neva.ru	140	50406	1687	44209	4510	3%	72:10:26
7	newsfeed.fu-berlin.de	26	28348	1237	26842	269	4%	29:20:30
8	nntp.pasdenom.info	3	23073	173	22865	35	0%	24:08:37
9	news.swapon.de	2	1846	140	1702	4	7%	24:05:32
10	localhost	26	0	0	0	0	0%	00:00:00
TOTAL: 10		210	258630	22171	214906	21553	8%	271:09:35

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	feeder.eternal-september.org	15.0 MB	1.6 KB	12.2 MB	27.2 MB	55%	3.6 KB
2	au2pb.net	13.6 MB	0.0 KB	5.0 MB	18.6 MB	72%	3.2 KB
3	news-out.mixmin.net	12.5 MB	2.9 KB	7.9 MB	20.5 MB	61%	2.8 KB
4	xanadu-bbs.net	7.4 MB	14.5 KB	687.1 MB	694.6 MB	1%	57.3 KB
5	newsfeeds.xmission.com	5.5 MB	0.0 KB	623.5 KB	6.1 MB	90%	3.1 KB
6	newsfeed.neva.ru	5.2 MB	136.9 KB	24.6 MB	29.8 MB	17%	4.9 KB
7	newsfeed.fu-berlin.de	2.6 MB	2.9 KB	576.5 KB	3.2 MB	82%	2.2 KB
8	nntp.pasdenom.info	401.5 KB	0.0 KB	552.5 KB	954.0 KB	42%	4.6 KB
9	news.swapon.de	366.9 KB	0.0 KB	260.8 KB	627.7 KB	58%	4.4 KB
10	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 10		62.6 MB	158.7 KB	738.8 MB	801.5 MB	7%	18.8 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Nov 28 04:15:00 - 04:59:59	294	1.3%	0.11	946.5 KB	1.5%	0.35
Nov 28 05:00:00 - 05:59:59	387	1.7%	0.11	1.3 MB	2.1%	0.38
Nov 28 06:00:00 - 06:59:59	461	2.1%	0.13	1.4 MB	2.2%	0.39
Nov 28 07:00:00 - 07:59:59	682	3.1%	0.19	2.3 MB	3.6%	0.64
Nov 28 08:00:00 - 08:59:59	971	4.4%	0.27	2.7 MB	4.4%	0.78
Nov 28 09:00:00 - 09:59:59	982	4.4%	0.27	2.7 MB	4.3%	0.77
Nov 28 10:00:00 - 10:59:59	1038	4.7%	0.29	3.0 MB	4.8%	0.86
Nov 28 11:00:00 - 11:59:59	980	4.4%	0.27	2.5 MB	3.9%	0.70
Nov 28 12:00:00 - 12:59:59	1107	5.0%	0.31	3.0 MB	4.8%	0.85
Nov 28 13:00:00 - 13:59:59	1106	5.0%	0.31	3.0 MB	4.7%	0.84
Nov 28 14:00:00 - 14:59:59	1212	5.4%	0.34	3.4 MB	5.3%	0.95
Nov 28 15:00:00 - 15:59:59	1170	5.3%	0.33	3.1 MB	5.0%	0.89
Nov 28 16:00:00 - 16:59:59	1195	5.4%	0.33	3.1 MB	5.0%	0.89
Nov 28 17:00:00 - 17:59:59	1335	6.0%	0.37	3.6 MB	5.7%	1.01
Nov 28 18:00:00 - 18:59:59	1301	5.8%	0.36	3.9 MB	6.3%	1.12
Nov 28 19:00:00 - 19:59:59	1347	6.1%	0.37	3.5 MB	5.6%	1.00
Nov 28 20:00:00 - 20:59:59	1098	4.9%	0.30	2.8 MB	4.5%	0.80
Nov 28 21:00:00 - 21:59:59	1168	5.2%	0.32	3.3 MB	5.2%	0.93
Nov 28 22:00:00 - 22:59:59	1021	4.6%	0.28	2.8 MB	4.4%	0.79
Nov 28 23:00:00 - 23:59:59	1011	4.5%	0.28	3.2 MB	5.1%	0.91
Nov 29 00:00:00 - 00:59:59	752	3.4%	0.21	2.4 MB	3.9%	0.69
Nov 29 01:00:00 - 01:59:59	648	2.9%	0.18	1.9 MB	3.0%	0.54
Nov 29 02:00:00 - 02:59:59	463	2.1%	0.13	1.4 MB	2.2%	0.40
Nov 29 03:00:00 - 03:59:59	435	2.0%	0.12	1.3 MB	2.1%	0.38
Nov 29 04:00:00 - 04:15:00	91	0.4%	0.10	266.4 KB	0.4%	0.30
TOTAL: 24:00:00	22255	100.0%	0.26	62.8 MB	100.0%	0.74

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	xanadu-bbs.net	9456	459	2	8995
2	newsfeed.neva.ru	4458	2066	6	2386
3	news-out.mixmin.net	4080	3	0	4077
4	feeder.eternal-september.org	2202	162	1	2039
5	au2pb.net	936	836	0	100
6	newsfeed.fu-berlin.de	553	41	0	512
7	newsfeeds.xmission.com	67	54	0	13
8	nntp.pasdenom.info	34	27	0	7
9	news.swapon.de	30	0	0	30
TOTAL: 9		21816	3648	9	18159

Unwanted newsgroups [Top 20]:

Newsgroup	Count
pld.cvs.commit	1627
mailing.freebsd.pkg-fallout	245
fa.linux.kernel	167
ut.test	120
alt.politics	119
alt.survival	92
mailing.freebsd.ports-bugs	79
lada.talk	64
mailing.freebsd.svn-ports-head	60
mailing.freebsd.svn-ports-all	60
lada.auto	47
it-alt.sport.calcio.juventus	44
mozilla.support.seamonkey	42
fa.netbsd.bugs	38
alt.politics.scorched-earth	36
alt.windows7.general	36
mailing.openbsd.misc	34
mailing.openbsd.source-changes	26
fa.openbsd.source-changes	22
mailing.freebsd.python	22
TOTAL: 185	3648

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	10267
EMP (phn path)	2763
EMP (phl)	926
PFM bot misc	179
EMP (phn nph)	121
Too many newsgroups	76
HTML Multipart	57
HTML post	38
Binary Image: misplaced jpg	16
User-issued spam cancel	5
Binary Payload	2
Too many newsgroups (low_xpost)	2
Poison newsgroup	1
Binary: misplaced zip	1
Binary: misplaced mp4	1
Binary: misplaced pdf	1
Binary Image: misplaced png	1
TOTAL: 17	14457

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Huge articles
	xanadu-bbs.net	3200
	feeder.eternal-september.org	60
	au2pb.net	39
	news-out.mixmin.net	6
	newsfeeds.xmission.com	6
	nntp.pasdenom.info	2
	news.swapon.de	1
	TOTAL: 7	3314
Including strange strings
	newsfeed.fu-berlin.de	287
	feeder.eternal-september.org	37
	news.swapon.de	26
	au2pb.net	20
	news-out.mixmin.net	8
	newsfeed.neva.ru	4
	xanadu-bbs.net	3
	newsfeeds.xmission.com	3
	TOTAL: 8	388
TOTAL: 2		3702

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	usenet.pasdenom.info	25751	183	21278	621	23	0%	23:59:57
2	au2pb	17954	177	16823	113	0	0%	23:59:58
3	xanadu-bbs	21793	109	19222	47	0	0%	23:59:58
4	fu-berlin.de	20705	36	20652	17	0	0%	23:59:55
5	news.mixmin.net	19642	13	18813	0	0	0%	23:59:49
6	xmission	25596	6	19994	1	0	0%	23:59:58
7	eternal-september	17092	6	16159	1	0	0%	23:59:56
8	news.swapon.de	1782	5	1760	3	0	0%	23:57:08
9	neva.ru	21461	5	20325	30	0	0%	23:59:49
TOTAL: 9		171776	540	155026	833	23	0%	215:56:28

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	usenet.pasdenom.info	665.3 KB	1.4 MB	2.1 MB	2.7 KB	23:59:57
2	au2pb	630.9 KB	273.6 KB	904.5 KB	3.1 KB	23:59:58
3	xanadu-bbs	423.5 KB	96.6 KB	520.2 KB	3.3 KB	23:59:58
4	fu-berlin.de	153.3 KB	24.0 KB	177.3 KB	3.3 KB	23:59:55
5	news.mixmin.net	59.7 KB	0.0 KB	59.7 KB	4.6 KB	23:59:49
6	neva.ru	33.7 KB	111.8 KB	145.4 KB	4.2 KB	23:59:49
7	eternal-september	31.0 KB	1.1 KB	32.1 KB	4.6 KB	23:59:56
8	news.swapon.de	13.2 KB	6.2 KB	19.4 KB	2.4 KB	23:57:08
9	xmission	10.8 KB	6.3 KB	17.1 KB	2.4 KB	23:59:58
TOTAL: 9		2.0 MB	1.9 MB	3.9 MB	2.9 KB	215:56:28

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Elapsed
1	202.89.176.220	288	38	90.5 KB	35	04:18:35
2	ip70-186-188-205.br.br.cox.net	2	5	17.6 KB	1	00:24:32
TOTAL: 2		290	43	108.1 KB	36	70:09:39

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	unresolved	421	38	90.5 KB	35	58:23:19
2	*.br.br.cox.net	2	5	17.6 KB	1	00:24:32
3	*.dynamic.upc.nl	3	0	0.0 KB	0	00:00:32
4	*.tampfl.dsl-w.verizon.net	2	0	0.0 KB	0	00:42:27
5	*.149.22.98.dynamic.ip.windstream.net	3	0	0.0 KB	0	03:14:54
6	*.bbox.io	20	0	0.0 KB	0	03:49:19
7	*.chello.nl	8	0	0.0 KB	0	03:34:33
TOTAL: 7		459	43	108.1 KB	36	70:09: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
63.142.120.8	10.076	2.923	0.000	44:30:26
162.212.88.214	0.721	0.207	0.000	09:34:15
202.89.176.220	27.471	6.154	0.735	04:18:35
tempe0.bbox.io	1.429	0.321	0.000	03:49:19
dhcp-089-099-203-254.chello.nl	0.711	0.108	0.000	03:34:33
h188.149.22.98.dynamic.ip.windstream.net	0.331	0.136	0.000	03:14:54
pool-71-98-160-84.tampfl.dsl-w.verizon.net	0.160	0.031	0.000	00:42:27
ip70-186-188-205.br.br.cox.net	0.251	0.030	0.000	00:24:32
92-108-162-83.dynamic.upc.nl	0.235	0.071	0.000	00:00:32
69.160.37.54	1.864	0.358	0.000	00:00:02
TOTAL: 10	43.249	10.339	0.735	70:09:39

Curious NNRP server explorers [Top 20]:

System	Conn
63.142.120.8	100
69.160.37.54	25
tempe0.bbox.io	20
dhcp-089-099-203-254.chello.nl	8
162.212.88.214	8
92-108-162-83.dynamic.upc.nl	3
h188.149.22.98.dynamic.ip.windstream.net	3
pool-71-98-160-84.tampfl.dsl-w.verizon.net	2
TOTAL: 8	169

NNRP client timeouts [Top 20]:

System	Conn	Peer
dhcp-089-099-203-254.chello.nl	7	0
tempe0.bbox.io	6	0
h188.149.22.98.dynamic.ip.windstream.net	3	0
pool-71-98-160-84.tampfl.dsl-w.verizon.net	1	0
ip70-186-188-205.br.br.cox.net	1	1
TOTAL: 5	18	1

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	comp.arch	13
2	comp.os.vms	11
3	comp.sys.ibm.pc.games.war-historical	8
4	comp.sys.apple2	5
5	comp.sys.ibm.pc.games.action	3
6	comp.arch.embedded	1
7	comp.sys.ibm.pc.games.rpg	1
8	comp.os.linux.networking	1
TOTAL: 8		43

Daily Usenet report for csiph.com

Nov 28 04:15:00 -- Nov 29 04:15:00