Daily Usenet report for csiph.com: Dec 7 04:15:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	60696	48.6%	9.2 MB	61.1%
nnrpd	32140	25.7%	2.7 MB	18.1%
innd	30110	24.1%	2.9 MB	19.2%
innfeed	1869	1.5%	254.0 KB	1.6%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 5	124816	100.0%	15.1 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	249318	45.6%
Negative hits	218679	40.0%
Do not exist	66629	12.2%
Cache misses	12172	2.2%
TOTAL: 4	546798	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.658	0.0%	180	0.000	3.656	37.000
article cleanup	00:00:00.249	0.0%	41777	0.000	0.006	0.023
article logging	00:00:00.612	0.0%	42265	0.000	0.014	0.070
article parse	00:00:48.801	0.1%	3608205	0.003	0.014	0.064
article write	00:00:53.446	0.1%	27858	0.249	1.919	11.525
artlog/artcncl	00:00:00.003	0.0%	152	0.000	0.020	0.143
artlog/artparse	00:00:00.232	0.0%	18260	0.000	0.013	0.125
data move	00:00:03.204	0.0%	4049390	0.000	0.001	0.001
hisgrep/artcncl	00:00:00.078	0.0%	180	0.000	0.433	13.000
hishave/artcncl	00:00:00.003	0.0%	180	0.000	0.017	0.286
hishave/artparse	00:00:00.075	0.0%	18259	0.000	0.004	0.050
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:03.451	0.0%	530338	0.000	0.007	0.085
history sync	00:00:01.782	0.0%	316	0.000	5.639	56.000
history write	00:00:44.005	0.1%	41775	0.069	1.053	10.720
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
hiswrite/artparse	00:00:20.596	0.0%	18259	0.000	1.128	9.381
idle	23:54:23.251	99.6%	3975457	7.104	21.649	385.277
nntp read	00:00:12.180	0.0%	3983490	0.001	0.003	0.006
overview write	00:01:14.271	0.1%	27858	0.443	2.666	18.184
perl filter	00:01:02.352	0.1%	41775	0.959	1.493	3.495
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.469	0.0%	55716	0.000	0.008	0.044
TOTAL: 24:00:23.600	23:59:49.718	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.068	0.0%	28637	0.000	0.002	0.022
article prepare	00:00:00.001	0.0%	6920	0.000	0.000	0.042
article read	00:00:00.247	0.0%	1566	0.000	0.158	45.000
backlog stats	00:00:00.110	0.0%	313331	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.397	0.0%	236930	0.001	0.006	0.013
data write	00:00:01.643	0.0%	217549	0.001	0.008	0.017
idle	23:54:36.176	100.0%	313331	166.983	274.713	781.299
status file	00:00:00.092	0.0%	189	0.000	0.487	1.000
TOTAL: 23:54:45.668	23:54:39.734	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:00.647	0.0%	8610	0.000	0.075	0.110
idle	52:37:17.680	100.0%	40144	0.000	4718.954	600218.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.519	0.0%	81394	0.000	0.006	0.333
readart	00:00:00.028	0.0%	127	0.000	0.220	9.000
TOTAL: 52:38:27.592	52:37:18.874	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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	au2pb.net	1	30890	7388	22093	1409	23%	23:53:39
2	feeder.eternal-september.org	1	37260	6392	28546	2322	17%	23:21:20
3	newsfeeds.xmission.com	2	30083	4705	25063	315	15%	25:36:33
4	news-out.mixmin.net	2	33154	4267	25726	3161	12%	24:08:48
5	newsfeed.neva.ru	150	50340	3097	42295	4948	6%	71:40:56
6	newsfeed.fu-berlin.de	66	32070	1239	30604	227	3%	35:12:23
7	xanadu-bbs.net	7	60562	694	40062	19806	1%	93:08:38
8	nntp.pasdenom.info	3	28678	140	28475	63	0%	24:08:35
9	news.swapon.de	3	2350	101	2241	8	4%	16:26:27
10	localhost	26	0	0	0	0	0%	00:00:00
TOTAL: 10		261	305387	28023	245105	32259	9%	337:37:19

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	feeder.eternal-september.org	19.0 MB	0.0 KB	21.2 MB	40.2 MB	47%	4.7 KB
2	au2pb.net	18.7 MB	36.1 KB	10.7 MB	29.4 MB	63%	3.4 KB
3	news-out.mixmin.net	15.0 MB	0.0 KB	6.1 MB	21.1 MB	71%	2.9 KB
4	newsfeeds.xmission.com	13.1 MB	39.1 KB	1.5 MB	14.7 MB	89%	3.0 KB
5	newsfeed.neva.ru	10.8 MB	0.0 KB	34.2 MB	45.0 MB	23%	5.7 KB
6	newsfeed.fu-berlin.de	2.8 MB	0.0 KB	584.1 KB	3.3 MB	82%	2.3 KB
7	xanadu-bbs.net	2.3 MB	0.0 KB	6.0 GB	6.0 GB	0%	309.3 KB
8	nntp.pasdenom.info	313.3 KB	0.0 KB	852.4 KB	1.1 MB	26%	5.7 KB
9	news.swapon.de	258.4 KB	0.0 KB	30.8 KB	289.2 KB	89%	2.7 KB
10	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 10		82.2 MB	75.2 KB	6.1 GB	6.2 GB	1%	107.8 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Dec 7 04:15:00 - 04:59:59	378	1.4%	0.14	1.2 MB	1.5%	0.46
Dec 7 05:00:00 - 05:59:59	587	2.1%	0.16	1.9 MB	2.4%	0.55
Dec 7 06:00:00 - 06:59:59	628	2.3%	0.17	2.2 MB	2.7%	0.62
Dec 7 07:00:00 - 07:59:59	683	2.5%	0.19	1.9 MB	2.3%	0.54
Dec 7 08:00:00 - 08:59:59	1113	4.0%	0.31	3.3 MB	4.0%	0.94
Dec 7 09:00:00 - 09:59:59	1286	4.6%	0.36	3.8 MB	4.6%	1.07
Dec 7 10:00:00 - 10:59:59	1350	4.8%	0.38	3.3 MB	4.1%	0.95
Dec 7 11:00:00 - 11:59:59	1302	4.7%	0.36	3.7 MB	4.6%	1.06
Dec 7 12:00:00 - 12:59:59	1394	5.0%	0.39	3.7 MB	4.6%	1.06
Dec 7 13:00:00 - 13:59:59	1425	5.1%	0.40	3.9 MB	4.7%	1.10
Dec 7 14:00:00 - 14:59:59	1615	5.8%	0.45	4.7 MB	5.8%	1.35
Dec 7 15:00:00 - 15:59:59	1823	6.5%	0.51	5.4 MB	6.6%	1.53
Dec 7 16:00:00 - 16:59:59	1638	5.9%	0.46	4.9 MB	6.1%	1.41
Dec 7 17:00:00 - 17:59:59	1628	5.8%	0.45	4.5 MB	5.5%	1.27
Dec 7 18:00:00 - 18:59:59	1452	5.2%	0.40	4.0 MB	4.9%	1.14
Dec 7 19:00:00 - 19:59:59	1448	5.2%	0.40	3.7 MB	4.5%	1.05
Dec 7 20:00:00 - 20:59:59	1511	5.4%	0.42	4.1 MB	5.0%	1.17
Dec 7 21:00:00 - 21:59:59	1470	5.3%	0.41	4.5 MB	5.5%	1.27
Dec 7 22:00:00 - 22:59:59	1420	5.1%	0.39	4.1 MB	5.0%	1.16
Dec 7 23:00:00 - 23:59:59	1050	3.8%	0.29	3.3 MB	4.1%	0.94
Dec 8 00:00:00 - 00:59:59	759	2.7%	0.21	2.3 MB	2.8%	0.66
Dec 8 01:00:00 - 01:59:59	695	2.5%	0.19	2.6 MB	3.2%	0.75
Dec 8 02:00:00 - 02:59:59	508	1.8%	0.14	1.8 MB	2.2%	0.51
Dec 8 03:00:00 - 03:59:59	557	2.0%	0.15	2.2 MB	2.7%	0.63
Dec 8 04:00:00 - 04:15:00	151	0.5%	0.17	521.8 KB	0.6%	0.58
TOTAL: 24:00:00	27871	100.0%	0.32	81.7 MB	100.0%	0.97

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	xanadu-bbs.net	19716	70	0	19646
2	newsfeed.neva.ru	4957	1679	0	3278
3	news-out.mixmin.net	3180	12	0	3168
4	feeder.eternal-september.org	2381	279	0	2102
5	au2pb.net	1426	1311	1	114
6	newsfeed.fu-berlin.de	592	45	0	547
7	newsfeeds.xmission.com	330	306	1	23
8	nntp.pasdenom.info	63	49	0	14
9	news.swapon.de	24	0	0	24
TOTAL: 9		32669	3751	2	28916

Unwanted newsgroups [Top 20]:

Newsgroup	Count
fa.linux.kernel	1150
mailing.freebsd.ports-bugs	155
lada.talk	153
alt.politics	119
ut.test	108
mailing.freebsd.svn-src-all	82
mailing.freebsd.svn-ports-all	79
fa.freebsd.cvs-all	78
alt.windows7.general	75
mailing.freebsd.svn-ports-head	75
mailing.freebsd.svn-src-head	72
mailing.openbsd.tech	58
mailing.freebsd.questions	57
fa.openbsd.tech	56
mailing.gcc.gcc-cvs	45
mailing.openbsd.source-changes	45
pld.cvs.commit	44
gmane.linux.alsa.devel	42
it-alt.sport.calcio.juventus	37
mailing.openbsd.ports-changes	37
TOTAL: 262	3751

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	6782
EMP (phn path)	1398
EMP (phl)	881
Binary: misplaced rar	392
EMP (phn nph)	263
PFM bot misc	226
Too many newsgroups	83
HTML Multipart	52
Binary: misplaced par2	33
Binary: misplaced rev	17
HTML post	16
HTML Image Tags	15
Too many newsgroups (low_xpost)	3
Binary: misplaced nfo	2
Binary: misplaced sfv	2
Binary: misplaced srr	2
Binary Payload	2
Binary Image: misplaced jpg	1
Binary: misplaced nzb	1
TOTAL: 19	10171

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad command received
	xanadu-bbs.net	18
	TOTAL: 1	18
Huge articles
	xanadu-bbs.net	18075
	feeder.eternal-september.org	87
	au2pb.net	63
	news-out.mixmin.net	15
	newsfeeds.xmission.com	8
	nntp.pasdenom.info	8
	newsfeed.fu-berlin.de	1
	TOTAL: 7	18257
Including strange strings
	newsfeed.fu-berlin.de	372
	feeder.eternal-september.org	43
	news-out.mixmin.net	20
	au2pb.net	18
	news.swapon.de	16
	newsfeeds.xmission.com	12
	newsfeed.neva.ru	6
	xanadu-bbs.net	1
	TOTAL: 8	488
TOTAL: 3		18763

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	usenet.pasdenom.info	32216	177	26922	632	1	162	0%	23:59:55
2	xanadu-bbs	37579	161	26598	517	5	16	0%	23:59:56
3	au2pb	21160	65	20390	58	0	0	0%	23:59:55
4	news.mixmin.net	24380	21	23529	0	0	0	0%	23:59:55
5	fu-berlin.de	26260	19	26228	13	0	0	0%	23:59:53
6	xmission	28423	19	23042	0	0	0	0%	23:59:56
7	neva.ru	26146	6	24553	25	0	0	0%	23:59:55
8	eternal-september	21841	4	20661	3	0	0	0%	23:59:55
9	news.swapon.de	2320	1	2288	6	0	655	0%	23:57:10
TOTAL: 9		220325	473	194211	1254	6	833	0%	215:56:30

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	xanadu-bbs	880.3 KB	1.3 MB	2.1 MB	3.2 KB	23:59:56
2	usenet.pasdenom.info	666.9 KB	1.3 MB	2.0 MB	2.5 KB	23:59:55
3	au2pb	298.9 KB	197.3 KB	496.1 KB	4.0 KB	23:59:55
4	fu-berlin.de	104.0 KB	19.6 KB	123.6 KB	3.9 KB	23:59:53
5	news.mixmin.net	81.7 KB	0.0 KB	81.7 KB	3.9 KB	23:59:55
6	xmission	62.0 KB	0.0 KB	62.0 KB	3.3 KB	23:59:56
7	neva.ru	35.9 KB	123.7 KB	159.6 KB	5.1 KB	23:59:55
8	eternal-september	13.2 KB	4.4 KB	17.5 KB	2.5 KB	23:59:55
9	news.swapon.de	1.0 KB	12.8 KB	13.8 KB	2.0 KB	23:57:10
TOTAL: 9		2.1 MB	2.9 MB	5.0 MB	3.0 KB	215:56:30

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	202.89.176.220	288	127	358.7 KB	114	0	0	04:22:48
TOTAL: 1		288	127	358.7 KB	114	0	0	52:38:23

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	unresolved	363	127	358.7 KB	114	34:27:14
2	*.ip-188-165-239.eu	1	0	0.0 KB	0	00:00:06
3	*.bbox.io	8	0	0.0 KB	0	03:35:18
4	*.tampfl.dsl-w.verizon.net	3	0	0.0 KB	0	01:03:21
5	*.248.91.75.dynamic.ip.windstream.net	1	0	0.0 KB	0	00:30:17
6	*.chello.nl	30	0	0.0 KB	0	13:02:05
TOTAL: 6		406	127	358.7 KB	114	52:38:23

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
216.246.166.29	0.545	0.458	0.000	30:04:24
dhcp-089-099-203-254.chello.nl	2.433	0.536	0.000	13:02:05
202.89.176.220	30.891	6.720	0.750	04:22:48
tempe0.bbox.io	0.773	0.148	0.000	03:35:18
pool-71-98-160-84.tampfl.dsl-w.verizon.net	0.258	0.033	0.000	01:03:21
h130.248.91.75.dynamic.ip.windstream.net	0.100	0.017	0.000	00:30:17
ns342002.ip-188-165-239.eu	0.095	0.016	0.000	00:00:06
69.160.37.54	1.788	0.419	0.000	00:00:02
TOTAL: 8	36.883	8.347	0.750	52:38:23

Curious NNRP server explorers [Top 20]:

System	Conn
63.142.120.8	50
dhcp-089-099-203-254.chello.nl	30
69.160.37.54	25
tempe0.bbox.io	8
pool-71-98-160-84.tampfl.dsl-w.verizon.net	3
h130.248.91.75.dynamic.ip.windstream.net	1
ns342002.ip-188-165-239.eu	1
TOTAL: 7	118

NNRP client timeouts [Top 20]:

System	Conn	Peer
dhcp-089-099-203-254.chello.nl	25	0
tempe0.bbox.io	6	0
pool-71-98-160-84.tampfl.dsl-w.verizon.net	2	0
h130.248.91.75.dynamic.ip.windstream.net	1	0
TOTAL: 4	34	0

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	comp.arch	61
2	comp.os.vms	30
3	comp.sys.ibm.pc.games.action	13
4	comp.sys.ibm.pc.games.war-historical	8
5	comp.os.os2.misc	6
6	comp.arch.embedded	4
7	comp.ai.neural-nets	2
8	comp.ai.philosophy	2
9	comp.sys.ibm.pc.games.rpg	1
TOTAL: 9		127

Daily Usenet report for csiph.com

Dec 7 04:15:00 -- Dec 8 04:15:00