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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	55203	47.4%	7.8 MB	58.1%
nnrpd	34889	30.0%	3.0 MB	22.3%
innd	24383	21.0%	2.3 MB	17.5%
innfeed	1865	1.6%	294.3 KB	2.1%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 5	116341	100.0%	13.4 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	269955	45.9%
Negative hits	263640	44.9%
Do not exist	53796	9.2%
Cache misses	217	0.0%
TOTAL: 4	587608	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.621	0.0%	323	0.000	1.923	23.800
article cleanup	00:00:00.318	0.0%	53300	0.000	0.006	0.023
article logging	00:00:00.686	0.0%	53810	0.000	0.013	0.036
article parse	00:00:02.773	0.0%	307407	0.003	0.009	0.018
article write	00:00:12.322	0.0%	28100	0.166	0.439	0.827
artlog/artcncl	00:00:00.001	0.0%	216	0.000	0.005	0.333
artlog/artparse	00:00:00.005	0.0%	875	0.000	0.006	0.083
data move	00:00:00.295	0.0%	771154	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.002	0.0%	321	0.000	0.006	0.100
hishave/artcncl	00:00:00.000	0.0%	323	0.000	0.000	0.000
hishave/artparse	00:00:00.001	0.0%	875	0.000	0.001	0.015
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:01.851	0.0%	590049	0.001	0.003	0.006
history sync	00:00:00.626	0.0%	303	0.000	2.066	4.500
history write	00:00:16.086	0.0%	53280	0.079	0.302	0.425
hiswrite/artcncl	00:00:00.000	0.0%	2	0.000	0.000	0.000
hiswrite/artparse	00:00:00.248	0.0%	873	0.000	0.284	4.000
idle	23:56:50.794	99.7%	749294	31.466	115.056	366.089
nntp read	00:00:02.407	0.0%	750336	0.001	0.003	0.008
overview write	00:00:14.471	0.0%	28100	0.127	0.515	1.512
perl filter	00:02:01.560	0.1%	53280	1.043	2.282	5.105
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.474	0.0%	56200	0.000	0.008	0.025
TOTAL: 24:00:28.826	23:59:45.541	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.093	0.0%	28331	0.000	0.003	0.024
article prepare	00:00:00.001	0.0%	7212	0.000	0.000	0.006
article read	00:00:00.221	0.0%	1433	0.000	0.154	9.200
backlog stats	00:00:00.109	0.0%	313800	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.327	0.0%	240847	0.001	0.006	0.014
data write	00:00:01.632	0.0%	217846	0.002	0.007	0.014
idle	23:54:21.294	100.0%	313800	151.196	274.255	652.602
status file	00:00:00.089	0.0%	185	0.000	0.481	1.000
TOTAL: 23:54:28.611	23:54:24.766	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:01.677	0.0%	67384	0.000	0.025	1.000
idle	220:49:06.278	99.9%	99232	0.000	8010.987	603843.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:04.254	0.0%	200166	0.000	0.021	8.443
readart	00:00:48.533	0.0%	13669	0.000	3.551	3.561
TOTAL: 221:02:28.523	220:50:00.742	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	15	50145	7150	36023	6972	14%	27:07:18
2	au2pb.net	1	30368	5781	23677	910	19%	23:24:10
3	news-out.mixmin.net	6	34526	4270	27693	2563	12%	24:19:17
4	xanadu-bbs.net	2	53729	3493	43661	6575	6%	24:44:36
5	newsfeed.neva.ru	146	63424	2667	52327	8430	4%	71:38:35
6	newsfeeds.xmission.com	1	29571	2563	26932	76	8%	25:14:17
7	newsfeed.fu-berlin.de	59	30876	1388	29089	399	4%	30:55:29
8	nntp.pasdenom.info	5	28940	379	28348	213	1%	24:14:14
9	news.swapon.de	2	2852	325	2504	23	11%	25:21:04
10	localhost	26	0	0	0	0	0%	00:00:00
TOTAL: 10		263	324431	28016	270254	26161	8%	276:59:00

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	feeder.eternal-september.org	21.2 MB	46.6 KB	65.9 MB	87.2 MB	24%	6.3 KB
2	au2pb.net	15.9 MB	3.6 KB	5.4 MB	21.3 MB	74%	3.3 KB
3	news-out.mixmin.net	13.5 MB	1.9 KB	5.7 MB	19.2 MB	70%	2.9 KB
4	xanadu-bbs.net	11.1 MB	2.1 KB	189.8 MB	200.9 MB	5%	20.4 KB
5	newsfeed.neva.ru	8.8 MB	33.5 KB	77.4 MB	86.2 MB	10%	8.0 KB
6	newsfeeds.xmission.com	7.9 MB	0.0 KB	1.6 MB	9.5 MB	83%	3.7 KB
7	newsfeed.fu-berlin.de	3.0 MB	4.2 KB	1.3 MB	4.3 MB	69%	2.5 KB
8	nntp.pasdenom.info	887.9 KB	10.3 KB	1.5 MB	2.3 MB	37%	4.0 KB
9	news.swapon.de	840.3 KB	0.0 KB	172.4 KB	1012.7 KB	82%	2.9 KB
10	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 10		83.0 MB	102.2 KB	348.6 MB	431.8 MB	19%	8.2 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Nov 3 04:15:00 - 04:59:59	438	1.6%	0.16	1.8 MB	2.2%	0.70
Nov 3 05:00:00 - 05:59:59	650	2.3%	0.18	2.0 MB	2.4%	0.57
Nov 3 06:00:00 - 06:59:59	783	2.8%	0.22	2.8 MB	3.4%	0.80
Nov 3 07:00:00 - 07:59:59	864	3.1%	0.24	2.5 MB	3.0%	0.71
Nov 3 08:00:00 - 08:59:59	1158	4.1%	0.32	3.6 MB	4.3%	1.03
Nov 3 09:00:00 - 09:59:59	1269	4.5%	0.35	3.9 MB	4.6%	1.10
Nov 3 10:00:00 - 10:59:59	1193	4.2%	0.33	3.0 MB	3.6%	0.85
Nov 3 11:00:00 - 11:59:59	1238	4.4%	0.34	3.5 MB	4.2%	0.99
Nov 3 12:00:00 - 12:59:59	1238	4.4%	0.34	3.4 MB	4.1%	0.96
Nov 3 13:00:00 - 13:59:59	1366	4.9%	0.38	3.7 MB	4.4%	1.04
Nov 3 14:00:00 - 14:59:59	1546	5.5%	0.43	4.1 MB	4.9%	1.17
Nov 3 15:00:00 - 15:59:59	1666	5.9%	0.46	4.7 MB	5.6%	1.32
Nov 3 16:00:00 - 16:59:59	1743	6.2%	0.48	4.7 MB	5.7%	1.35
Nov 3 17:00:00 - 17:59:59	1759	6.3%	0.49	5.7 MB	6.8%	1.62
Nov 3 18:00:00 - 18:59:59	1862	6.6%	0.52	5.3 MB	6.3%	1.50
Nov 3 19:00:00 - 19:59:59	1499	5.3%	0.42	4.0 MB	4.8%	1.15
Nov 3 20:00:00 - 20:59:59	1407	5.0%	0.39	4.0 MB	4.8%	1.15
Nov 3 21:00:00 - 21:59:59	1459	5.2%	0.41	4.4 MB	5.3%	1.26
Nov 3 22:00:00 - 22:59:59	1263	4.5%	0.35	3.7 MB	4.4%	1.04
Nov 3 23:00:00 - 23:59:59	1042	3.7%	0.29	3.2 MB	3.8%	0.91
Nov 4 00:00:00 - 00:59:59	751	2.7%	0.21	2.4 MB	2.8%	0.67
Nov 4 01:00:00 - 01:59:59	646	2.3%	0.18	2.3 MB	2.8%	0.66
Nov 4 02:00:00 - 02:59:59	538	1.9%	0.15	2.0 MB	2.4%	0.57
Nov 4 03:00:00 - 03:59:59	600	2.1%	0.17	2.6 MB	3.1%	0.73
Nov 4 04:00:00 - 04:15:00	127	0.5%	0.14	335.5 KB	0.4%	0.37
TOTAL: 24:00:00	28105	100.0%	0.33	83.5 MB	100.0%	0.99

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	newsfeed.neva.ru	8494	1574	5	6915
2	feeder.eternal-september.org	7062	418	4	6640
3	xanadu-bbs.net	6638	616	1	6021
4	news-out.mixmin.net	2574	31	1	2542
5	au2pb.net	931	863	2	66
6	newsfeed.fu-berlin.de	838	51	2	785
7	nntp.pasdenom.info	215	97	5	113
8	newsfeeds.xmission.com	87	56	0	31
9	news.swapon.de	43	0	0	43
TOTAL: 9		26882	3706	20	23156

Unwanted newsgroups [Top 20]:

Newsgroup	Count
fa.linux.kernel	856
lada.talk	237
alt.politics.scorched-earth	222
it-alt.sport.calcio.juventus	186
mailing.freebsd.pkg-fallout	124
ut.test	114
lada.auto	92
mailing.freebsd.svn-ports-all	64
mailing.freebsd.ports-bugs	63
alt.politics	62
mailing.freebsd.svn-ports-head	57
pld.cvs.commit	54
alt.windows7.general	51
mailing.openbsd.source-changes	50
alt.survival	47
mailing.gcc.gcc-cvs	38
gmane.linux.alsa.devel	36
mailing.openbsd.ports-changes	34
mailing.openbsd.misc	33
mozilla.dev.tree-alerts	30
TOTAL: 277	3706

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	16713
EMP (phn path)	3334
EMP (phl)	973
PFM bot misc	207
EMP (phn nph)	136
HTML Multipart	132
User-issued spam cancel	120
Too many newsgroups	104
Binary Image: misplaced jpg	14
HTML Image Tags	11
EMP (fsl)	8
HTML post	8
Too many newsgroups (low_xpost)	7
Binary: misplaced par2	3
Binary: misplaced PAR2	2
Too many newsgroups (meow)	1
TOTAL: 16	21773

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Huge articles
	xanadu-bbs.net	723
	feeder.eternal-september.org	56
	au2pb.net	40
	news-out.mixmin.net	23
	newsfeeds.xmission.com	16
	nntp.pasdenom.info	11
	newsfeed.fu-berlin.de	3
	news.swapon.de	1
	TOTAL: 8	873
Including strange strings
	newsfeed.fu-berlin.de	399
	news-out.mixmin.net	28
	feeder.eternal-september.org	24
	news.swapon.de	23
	xanadu-bbs.net	13
	newsfeeds.xmission.com	11
	au2pb.net	7
	newsfeed.neva.ru	4
	nntp.pasdenom.info	1
	TOTAL: 9	510
TOTAL: 2		1383

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	au2pb	23505	271	21747	175	0	1%	23:59:58
2	usenet.pasdenom.info	32237	177	26819	729	12	0%	23:59:58
3	xanadu-bbs	27782	158	24359	89	253	0%	23:59:58
4	fu-berlin.de	26259	61	26168	30	0	0%	23:59:57
5	xmission	32801	17	25366	2	0	0%	23:59:58
6	news.mixmin.net	24835	14	23703	0	0	0%	23:59:56
7	neva.ru	27200	10	25263	55	0	0%	23:59:57
8	eternal-september	21170	6	20173	3	0	0%	23:59:58
9	news.swapon.de	2348	1	2324	6	0	0%	23:57:50
TOTAL: 9		218137	715	195922	1089	265	0%	215:57:30

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	au2pb	1.2 MB	483.3 KB	1.7 MB	3.8 KB	23:59:58
2	xanadu-bbs	819.0 KB	185.8 KB	1004.8 KB	4.1 KB	23:59:58
3	usenet.pasdenom.info	732.9 KB	1.6 MB	2.3 MB	2.7 KB	23:59:58
4	fu-berlin.de	302.0 KB	39.4 KB	341.4 KB	3.8 KB	23:59:57
5	news.mixmin.net	61.2 KB	0.0 KB	61.2 KB	4.4 KB	23:59:56
6	xmission	52.8 KB	2.6 KB	55.4 KB	2.9 KB	23:59:58
7	neva.ru	46.9 KB	204.7 KB	251.5 KB	3.9 KB	23:59:57
8	eternal-september	38.0 KB	4.4 KB	42.4 KB	4.7 KB	23:59:58
9	news.swapon.de	2.8 KB	17.4 KB	20.2 KB	2.9 KB	23:57:50
TOTAL: 9		3.2 MB	2.5 MB	5.7 MB	3.3 KB	215:57:30

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	202.89.176.220	287	40	136.7 KB	39	0	0	04:36:17
TOTAL: 1		287	40	136.7 KB	39	0	0	221:02:19

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	unresolved	957	40	136.7 KB	39	193:53:57
2	*.ip-188-165-239.eu	4	0	0.0 KB	0	00:07:28
3	*.tampfl.dsl-w.verizon.net	2	0	0.0 KB	0	01:00:01
4	*.nielsenmedia.com	5	0	0.0 KB	0	02:30:19
5	*.147.22.98.dynamic.ip.windstream.net	4	0	0.0 KB	0	14:53:44
6	*.br.br.cox.net	1	0	0.0 KB	0	00:00:16
7	*.chello.nl	35	0	0.0 KB	0	08:36:30
TOTAL: 7		1008	40	136.7 KB	39	221:02:19

NNRP auth users [Top 20]:

User	Conn
moussa	287
TOTAL: 1	287

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
63.142.120.8	45.364	11.726	0.000	163:40:03
162.212.88.214	0.570	0.397	0.000	25:36:36
h168.147.22.98.dynamic.ip.windstream.net	0.811	0.683	0.000	14:53:44
dhcp-089-099-203-254.chello.nl	3.060	0.577	0.000	08:36:30
202.89.176.220	27.346	5.646	0.721	04:36:17
challenger.nielsenmedia.com	0.462	0.072	0.000	02:30:19
pool-71-98-160-84.tampfl.dsl-w.verizon.net	0.182	0.031	0.000	01:00:01
ns342002.ip-188-165-239.eu	0.369	0.176	0.000	00:07:28
216.240.144.80	0.448	1.193	0.000	00:00:57
ip68-11-166-106.br.br.cox.net	0.082	0.025	0.000	00:00:16
69.160.37.54	2.035	0.338	0.000	00:00:02
TOTAL: 11	80.729	20.864	0.721	221:02:19

Curious NNRP server explorers [Top 20]:

System	Conn
63.142.120.8	640
dhcp-089-099-203-254.chello.nl	35
69.160.37.54	25
challenger.nielsenmedia.com	5
h168.147.22.98.dynamic.ip.windstream.net	4
ns342002.ip-188-165-239.eu	4
162.212.88.214	4
pool-71-98-160-84.tampfl.dsl-w.verizon.net	2
216.240.144.80	1
ip68-11-166-106.br.br.cox.net	1
TOTAL: 10	721

NNRP client timeouts [Top 20]:

System	Conn	Peer
dhcp-089-099-203-254.chello.nl	9	0
challenger.nielsenmedia.com	5	0
h168.147.22.98.dynamic.ip.windstream.net	4	1
pool-71-98-160-84.tampfl.dsl-w.verizon.net	2	0
TOTAL: 4	20	1

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.pc.games.war-historical	25
2	comp.os.vms	4
3	comp.sys.ibm.pc.games.action	2
4	comp.os.linux.networking	2
5	comp.ai.neural-nets	1
6	comp.sys.ibm.pc.hardware.chips	1
7	comp.ai.philosophy	1
8	comp.answers	1
9	comp.os.os2.announce	1
10	comp.arch.embedded	1
11	comp.arch.storage	1
TOTAL: 11		40

Daily Usenet report for csiph.com

Nov 3 04:15:00 -- Nov 4 04:15:00