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

Unknown entries from news log file:

First 50 / 225 lines (22.2%)

Aug 3 04:15:02 csiph innfeed[12807]: usenet.pasdenom.info:0 connect: No route to host
Aug 3 04:15:30 csiph innfeed[12807]: usenet.pasdenom.info:0 connect: No route to host
Aug 3 14:17:54 csiph nnrpd[67088]: feeder.eternal-september.org noperm ihave without permission
Aug 3 14:17:54 csiph nnrpd[67094]: feeder.eternal-september.org noperm ihave without permission
Aug 3 14:17:55 csiph nnrpd[67097]: feeder.eternal-september.org noperm ihave without permission
Aug 3 14:17:55 csiph nnrpd[67098]: feeder.eternal-september.org noperm ihave without permission
Aug 3 14:18:29 csiph nnrpd[67148]: feeder.eternal-september.org noperm ihave without permission
Aug 3 14:18:29 csiph nnrpd[67147]: feeder.eternal-september.org noperm ihave without permission
Aug 3 14:18:29 csiph nnrpd[67152]: feeder.eternal-september.org noperm ihave without permission
Aug 3 14:18:30 csiph nnrpd[67151]: feeder.eternal-september.org noperm ihave without permission
Aug 3 14:19:00 csiph nnrpd[67228]: feeder.eternal-september.org noperm ihave without permission
Aug 3 14:19:00 csiph nnrpd[67229]: feeder.eternal-september.org noperm ihave without permission
Aug 3 14:19:00 csiph nnrpd[67230]: feeder.eternal-september.org noperm ihave without permission
Aug 3 14:19:00 csiph nnrpd[67233]: feeder.eternal-september.org noperm ihave without permission
Aug 3 14:19:31 csiph nnrpd[67268]: feeder.eternal-september.org noperm ihave without permission
Aug 3 14:19:31 csiph nnrpd[67269]: feeder.eternal-september.org noperm ihave without permission
Aug 3 14:19:31 csiph nnrpd[67270]: feeder.eternal-september.org noperm ihave without permission
Aug 3 14:19:31 csiph nnrpd[67271]: feeder.eternal-september.org noperm ihave without permission
Aug 3 14:20:01 csiph nnrpd[67345]: feeder.eternal-september.org noperm ihave without permission
Aug 3 14:20:01 csiph nnrpd[67346]: feeder.eternal-september.org noperm ihave without permission
Aug 3 14:20:01 csiph nnrpd[67347]: feeder.eternal-september.org noperm ihave without permission
Aug 3 14:20:01 csiph nnrpd[67348]: feeder.eternal-september.org noperm ihave without permission
Aug 3 14:20:32 csiph nnrpd[67380]: feeder.eternal-september.org noperm ihave without permission
Aug 3 14:20:32 csiph nnrpd[67381]: feeder.eternal-september.org noperm ihave without permission
Aug 3 14:20:32 csiph nnrpd[67382]: feeder.eternal-september.org noperm ihave without permission
Aug 3 14:20:32 csiph nnrpd[67383]: feeder.eternal-september.org noperm ihave without permission
Aug 3 14:21:02 csiph nnrpd[67473]: feeder.eternal-september.org noperm ihave without permission
Aug 3 14:21:02 csiph nnrpd[67472]: feeder.eternal-september.org noperm ihave without permission
Aug 3 14:21:02 csiph nnrpd[67474]: feeder.eternal-september.org noperm ihave without permission
Aug 3 14:21:02 csiph nnrpd[67475]: feeder.eternal-september.org noperm ihave without permission
Aug 3 14:21:32 csiph nnrpd[67506]: feeder.eternal-september.org noperm ihave without permission
Aug 3 14:21:32 csiph nnrpd[67507]: feeder.eternal-september.org noperm ihave without permission
Aug 3 14:21:32 csiph nnrpd[67508]: feeder.eternal-september.org noperm ihave without permission
Aug 3 14:21:32 csiph nnrpd[67509]: feeder.eternal-september.org noperm ihave without permission
Aug 3 14:22:02 csiph nnrpd[67728]: feeder.eternal-september.org noperm ihave without permission
Aug 3 14:22:04 csiph nnrpd[67736]: feeder.eternal-september.org noperm ihave without permission
Aug 3 14:22:04 csiph nnrpd[67737]: feeder.eternal-september.org noperm ihave without permission
Aug 3 14:22:04 csiph nnrpd[67738]: feeder.eternal-september.org noperm ihave without permission
Aug 3 14:22:32 csiph nnrpd[67783]: feeder.eternal-september.org noperm ihave without permission
Aug 3 14:22:34 csiph nnrpd[67788]: feeder.eternal-september.org noperm ihave without permission
Aug 3 14:22:34 csiph nnrpd[67789]: feeder.eternal-september.org noperm ihave without permission
Aug 3 14:22:34 csiph nnrpd[67790]: feeder.eternal-september.org noperm ihave without permission
Aug 3 14:23:02 csiph nnrpd[67859]: feeder.eternal-september.org noperm ihave without permission
Aug 3 14:23:04 csiph nnrpd[67866]: feeder.eternal-september.org noperm ihave without permission
Aug 3 14:23:04 csiph nnrpd[67867]: feeder.eternal-september.org noperm ihave without permission
Aug 3 14:23:04 csiph nnrpd[67868]: feeder.eternal-september.org noperm ihave without permission
Aug 3 14:23:33 csiph nnrpd[67942]: feeder.eternal-september.org noperm ihave without permission
Aug 3 14:23:34 csiph nnrpd[67945]: feeder.eternal-september.org noperm ihave without permission
Aug 3 14:23:34 csiph nnrpd[67946]: feeder.eternal-september.org noperm ihave without permission
Aug 3 14:23:34 csiph nnrpd[67947]: feeder.eternal-september.org noperm ihave without permission

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	47732	56.1%	5.6 MB	64.6%
nnrpd	35679	42.0%	2.9 MB	33.5%
innd	802	0.9%	86.7 KB	1.0%
innfeed	796	0.9%	81.7 KB	0.9%
controlchan	3	0.0%	0.2 KB	0.0%
TOTAL: 5	85012	100.0%	8.7 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	8410	48.4%
Negative hits	5492	31.6%
Positive hits	2215	12.7%
Cache misses	1261	7.3%
TOTAL: 4	17378	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.107	0.0%	64	0.000	1.672	22.333
article cleanup	00:00:00.062	0.0%	8431	0.000	0.007	0.026
article logging	00:00:00.115	0.0%	8545	0.000	0.013	0.036
article parse	00:00:00.606	0.0%	76825	0.002	0.008	0.015
article write	00:00:02.661	0.0%	7681	0.163	0.346	0.531
artlog/artcncl	00:00:00.000	0.0%	64	0.000	0.000	0.000
data move	00:00:00.048	0.0%	91605	0.000	0.001	0.002
hisgrep/artcncl	00:00:00.001	0.0%	47	0.000	0.021	0.143
hishave/artcncl	00:00:00.002	0.0%	64	0.000	0.031	0.500
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:00.073	0.0%	17314	0.000	0.004	0.011
history sync	00:00:00.055	0.0%	99	0.000	0.556	1.000
history write	00:00:00.931	0.0%	8393	0.061	0.111	0.143
hiswrite/artcncl	00:00:00.001	0.0%	17	0.000	0.059	0.111
idle	06:10:07.381	100.0%	84461	34.511	262.931	893.330
nntp read	00:00:00.232	0.0%	83790	0.001	0.003	0.008
overview write	00:00:01.565	0.0%	7681	0.133	0.204	0.309
perl filter	00:00:00.348	0.0%	8393	0.014	0.041	0.086
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.157	0.0%	15362	0.002	0.010	0.024
TOTAL: 06:10:17.242	06:10:14.345	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.029	0.0%	7481	0.000	0.004	0.011
article prepare	00:00:00.000	0.0%	4	0.000	0.000	0.000
article read	00:00:00.070	0.0%	1	70.000	70.000	70.000
backlog stats	00:00:00.008	0.0%	23862	0.000	0.000	0.002
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.116	0.0%	14562	0.000	0.008	0.018
data write	00:00:00.095	0.0%	7417	0.000	0.013	0.030
idle	06:01:25.735	100.0%	23862	365.294	908.798	1571.743
status file	00:00:00.015	0.0%	69	0.000	0.217	1.000
TOTAL: 06:01:26.381	06:01:26.068	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	10:53:43.413	99.9%	8613	0.000	4553.978	450244.250
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.093	0.0%	17521	0.000	0.005	0.059
readart	00:00:00.002	0.0%	26	0.000	0.077	1.000
TOTAL: 10:54:04.239	10:53:43.508	99.9%	-	-	-	-

Control commands to INND:

Command	Number
L	1
flush	4
flushlogs	2
go	2
logmode	2
mode	148
pause	2
paused	2
reload	2
reserve	2
shutdown	6
TOTAL: 11	173

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	xanadu-bbs.net	2	46978	42093	731	4154	89%	23:59:33
2	feeder.eternal-september.org	12	1156	572	484	100	49%	13:37:33
3	nntp.pasdenom.info	6	944	138	768	38	14%	19:16:43
4	localhost	52	9746	21	9725	0	0%	00:01:04
TOTAL: 4		72	58824	42824	11708	4292	72%	56:54:53

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	xanadu-bbs.net	250.4 MB	45.6 KB	37.7 MB	288.1 MB	86%	6.4 KB
2	feeder.eternal-september.org	1.1 MB	186.3 KB	186.3 KB	1.5 MB	75%	2.3 KB
3	nntp.pasdenom.info	614.3 KB	183.5 KB	183.5 KB	981.3 KB	62%	5.6 KB
4	localhost	63.1 KB	0.0 KB	0.0 KB	63.1 KB	100%	3.0 KB
TOTAL: 4		252.2 MB	415.5 KB	38.0 MB	290.6 MB	86%	6.3 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Aug 3 04:15:00 - 04:59:59	838	2.0%	0.31	10.3 MB	4.1%	3.92
Aug 3 05:00:00 - 05:59:59	1018	2.4%	0.28	7.0 MB	2.8%	1.99
Aug 3 06:00:00 - 06:59:59	1352	3.2%	0.38	7.3 MB	2.9%	2.08
Aug 3 07:00:00 - 07:59:59	1735	4.0%	0.48	7.7 MB	3.0%	2.18
Aug 3 08:00:00 - 08:59:59	1645	3.8%	0.46	7.6 MB	3.0%	2.16
Aug 3 09:00:00 - 09:59:59	1864	4.3%	0.52	12.7 MB	5.1%	3.62
Aug 3 10:00:00 - 10:59:59	1904	4.4%	0.53	8.0 MB	3.2%	2.27
Aug 3 11:00:00 - 11:59:59	1812	4.2%	0.50	8.6 MB	3.4%	2.45
Aug 3 12:00:00 - 12:59:59	2124	5.0%	0.59	7.8 MB	3.1%	2.21
Aug 3 13:00:00 - 13:59:59	2111	4.9%	0.59	10.1 MB	4.0%	2.88
Aug 3 14:00:00 - 14:59:59	2577	6.0%	0.72	11.8 MB	4.7%	3.37
Aug 3 15:00:00 - 15:59:59	2110	4.9%	0.59	9.5 MB	3.8%	2.71
Aug 3 16:00:00 - 16:59:59	2592	6.0%	0.72	10.2 MB	4.0%	2.90
Aug 3 17:00:00 - 17:59:59	2320	5.4%	0.64	9.3 MB	3.7%	2.64
Aug 3 18:00:00 - 18:59:59	2424	5.7%	0.67	12.3 MB	4.9%	3.51
Aug 3 19:00:00 - 19:59:59	2206	5.1%	0.61	12.0 MB	4.7%	3.41
Aug 3 20:00:00 - 20:59:59	2159	5.0%	0.60	8.5 MB	3.4%	2.42
Aug 3 21:00:00 - 21:59:59	2215	5.2%	0.62	13.1 MB	5.2%	3.71
Aug 3 22:00:00 - 22:59:59	1523	3.6%	0.42	6.0 MB	2.4%	1.71
Aug 3 23:00:00 - 23:59:59	1547	3.6%	0.43	28.7 MB	11.4%	8.16
Aug 4 00:00:00 - 00:59:59	1125	2.6%	0.31	7.3 MB	2.9%	2.07
Aug 4 01:00:00 - 01:59:59	1101	2.6%	0.31	5.6 MB	2.2%	1.59
Aug 4 02:00:00 - 02:59:59	1161	2.7%	0.32	7.4 MB	3.0%	2.12
Aug 4 03:00:00 - 03:59:59	1019	2.4%	0.28	14.6 MB	5.8%	4.15
Aug 4 04:00:00 - 04:15:01	369	0.9%	0.41	8.7 MB	3.5%	9.92
TOTAL: 24:00:01	42851	100.0%	0.50	252.1 MB	100.0%	2.99

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	xanadu-bbs.net	4362	4141	11	210
2	feeder.eternal-september.org	109	0	100	9
3	nntp.pasdenom.info	61	0	57	4
TOTAL: 3		4532	4141	168	223

Unwanted newsgroups [Top 20]:

Newsgroup	Count
fa.linux.kernel	856
lada.talk	224
ut.test	113
alt.politics	109
lada.auto	104
mailing.freebsd.svn-src-all	90
fa.freebsd.cvs-all	89
mailing.freebsd.ports-bugs	70
mpc.lists.freebsd.ports.bugs	70
alt.job	68
lada.photo	65
att.jobs	64
aus.jobs	62
mailing.freebsd.questions	61
at.jobs	58
mailing.gcc.gcc-cvs	58
mailing.freebsd.svn-src-head	58
alt.windows7.general	56
mailing.freebsd.svn-ports-all	56
mailing.freebsd.svn-ports-head	56
TOTAL: 311	4141

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	xanadu-bbs.net	210
	feeder.eternal-september.org	9
	nntp.pasdenom.info	4
	TOTAL: 3	223
TOTAL: 1		223

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	777	8	756	0	0	1%	16:40:49
2	eternal-september	22590	1	20826	2	8	0%	13:29:45
3	usenet.pasdenom.info	0	0	0	0	0	0%	00:33:01
TOTAL: 3		23367	9	21582	2	8	0%	30:43:35

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	xanadu-bbs	24.2 KB	0.0 KB	24.2 KB	3.0 KB	16:40:49
2	eternal-september	3.8 KB	161.0 KB	164.9 KB	55.0 KB	13:29:45
3	usenet.pasdenom.info	0.0 KB	0.0 KB	0.0 KB	0	00:33:01
TOTAL: 3		28.1 KB	161.0 KB	189.1 KB	17.2 KB	30:43:35

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	202.89.176.220	287	86	248.5 KB	76	0	0	04:36:42
2	tempe0.bbox.io	335	46	91.2 KB	17	2	2	50:50:06
3	challenger.nielsenmedia.com	20	6	16.4 KB	4	0	0	03:14:46
4	pool-71-98-160-84.tampfl.dsl-w.verizon.net	13	4	12.8 KB	2	0	0	01:44:26
5	dhcp-089-099-203-254.chello.nl	30	4	8.2 KB	3	0	0	13:02:37
TOTAL: 5		685	146	377.1 KB	102	2	2	111:19:03

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	unresolved	372	86	248.5 KB	76	0	0	42:24:23
2	*.bbox.io	335	46	91.2 KB	17	2	2	50:50:06
3	*.nielsenmedia.com	20	6	16.4 KB	4	0	0	03:14:46
4	*.tampfl.dsl-w.verizon.net	13	4	12.8 KB	2	0	0	01:44:26
5	*.chello.nl	30	4	8.2 KB	3	0	0	13:02:37
6	*.eternal-september.org	220	0	0.0 KB	0	0	0	00:02:31
7	*.unity-media.net	1	0	0.0 KB	0	0	0	00:00:11
TOTAL: 7		991	146	377.1 KB	102	2	2	111:19:03

NNRP auth users [Top 20]:

User	Conn
moussa	287
kev009	2
TOTAL: 2	289

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
tempe0.bbox.io	24.627	3.368	0.004	50:50:06
162.212.88.198	0.900	0.569	0.000	35:26:39
dhcp-089-099-203-254.chello.nl	2.417	0.367	0.000	13:02:37
202.89.176.220	26.058	4.489	0.638	04:36:42
challenger.nielsenmedia.com	1.626	0.149	0.000	03:14:46
108.175.241.207	3.835	0.464	0.000	02:20:58
pool-71-98-160-84.tampfl.dsl-w.verizon.net	1.134	0.124	0.000	01:44:26
feeder.eternal-september.org	13.245	2.146	0.000	00:02:31
aftr-95-222-31-142.unity-media.net	0.061	0.008	0.000	00:00:11
69.160.37.54	1.713	0.281	0.000	00:00:01
TOTAL: 10	75.616	11.965	0.642	111:19:03

Curious NNRP server explorers [Top 20]:

System	Conn
feeder.eternal-september.org	220
108.175.241.207	50
69.160.37.54	25
162.212.88.198	10
aftr-95-222-31-142.unity-media.net	1
TOTAL: 5	306

NNRP client timeouts [Top 20]:

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

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	comp.arch	50
2	comp.unix.tru64	16
3	comp.os.vms	12
4	comp.sys.ibm.ps2.hardware	11
5	comp.lang.awk	10
6	comp.os.os2.advocacy	9
7	comp.sys.ibm.pc.games.action	8
8	comp.unix.solaris	5
9	comp.unix.unixware.misc	4
10	comp.unix.sco.misc	4
11	comp.unix.aix	4
12	comp.os.linux.networking	3
13	comp.unix.misc	2
14	comp.answers	1
15	comp.arch.fpga	1
16	comp.unix.programmer	1
17	comp.unix.sco.programmer	1
18	comp.sys.ibm.pc.games.rpg	1
19	comp.unix.sys5.r4	1
20	comp.unix.bsd.misc	1
21	comp.sys.hp.hpux	1
TOTAL: 21		146

Daily Usenet report for csiph.com

Aug 3 04:15:00 -- Aug 4 04:15:01