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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	56142	44.7%	8.6 MB	56.6%
innd	33493	26.7%	3.3 MB	22.1%
nnrpd	33266	26.5%	2.8 MB	18.6%
innfeed	2603	2.1%	418.0 KB	2.7%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 5	125505	100.0%	15.1 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	553901	58.6%
Negative hits	335066	35.5%
Do not exist	54499	5.8%
Cache misses	1282	0.1%
TOTAL: 4	944748	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.324	0.0%	282	0.000	1.149	23.750
article cleanup	00:00:00.342	0.0%	52034	0.000	0.007	0.030
article logging	00:00:00.648	0.0%	52540	0.000	0.012	0.114
article parse	00:00:06.209	0.0%	748849	0.000	0.008	0.043
article write	00:00:16.526	0.0%	25457	0.233	0.649	9.857
artlog/artcncl	00:00:00.001	0.0%	249	0.000	0.004	0.111
artlog/artparse	00:00:00.038	0.0%	3118	0.000	0.012	1.000
data move	00:00:00.583	0.0%	1321610	0.000	0.000	0.001
hisgrep/artcncl	00:00:00.011	0.0%	277	0.000	0.040	1.000
hishave/artcncl	00:00:00.001	0.0%	282	0.000	0.004	0.056
hishave/artparse	00:00:00.007	0.0%	2477	0.000	0.003	0.038
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:02.852	0.0%	944132	0.001	0.003	0.019
history sync	00:00:00.994	0.0%	339	0.000	2.932	41.500
history write	00:00:25.197	0.0%	52014	0.083	0.484	8.046
hiswrite/artcncl	00:00:00.000	0.0%	5	0.000	0.000	0.000
hiswrite/artparse	00:00:00.616	0.0%	2476	0.000	0.249	9.750
idle	23:55:50.707	99.7%	1348112	16.661	63.905	369.367
nntp read	00:00:04.356	0.0%	1355800	0.002	0.003	0.007
overview write	00:00:52.980	0.1%	25457	0.312	2.081	17.032
perl filter	00:02:08.625	0.1%	51269	0.964	2.509	4.736
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.488	0.0%	50914	0.000	0.010	0.031
TOTAL: 24:00:47.505	23:59:51.505	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.069	0.0%	25556	0.000	0.003	0.016
article prepare	00:00:00.004	0.0%	31992	0.000	0.000	0.009
article read	00:00:00.704	0.0%	4206	0.000	0.167	2.875
backlog stats	00:00:00.163	0.0%	389100	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.485	0.0%	299472	0.001	0.005	0.011
data write	00:00:02.030	0.0%	280043	0.003	0.007	0.016
idle	23:53:43.379	100.0%	389100	120.470	221.083	631.981
status file	00:00:00.172	0.0%	266	0.000	0.647	1.000
TOTAL: 23:53:54.225	23:53:48.006	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:03.809	0.0%	233434	0.000	0.016	0.077
idle	36:29:50.277	99.9%	265537	134.548	494.810	600209.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:03.314	0.0%	532124	0.000	0.006	0.167
readart	00:00:00.011	0.0%	97	0.000	0.113	1.000
TOTAL: 36:31:45.229	36:29:57.411	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	usenet.blueworldhosting.com	288	48662	7758	27997	12907	15%	23:49:44
2	csiph-out.feeder.erje.net	1152	203000	4266	191086	7648	2%	94:58:07
3	feeder.eternal-september.org	35	47534	3715	41126	2693	7%	30:12:54
4	news-out.mixmin.net	2	28267	3694	23759	814	13%	24:08:44
5	newsfeed.neva.ru	142	90340	1721	85712	2907	1%	72:04:56
6	newsfeed.fu-berlin.de	41	27973	1353	26510	110	4%	31:25:26
7	news.fcku.it	1	8004	818	7186	0	10%	26:16:00
8	au2pb.net	1	24846	803	23957	86	3%	22:06:32
9	newsfeeds.xmission.com	1	29954	658	29234	62	2%	30:39:53
10	news.freedyn.net	93	20779	480	20139	160	2%	17:48:26
11	news.swapon.de	5	3849	175	3667	7	4%	45:40:16
12	xanadu-bbs.net	9	55978	154	53293	2531	0%	31:43:09
13	nntp.pasdenom.info	3	24249	62	24162	25	0%	24:08:36
14	localhost	26	0	0	0	0	0%	00:00:00
TOTAL: 14		1799	613435	25657	557828	29950	4%	475:02:43

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	usenet.blueworldhosting.com	21.0 MB	621.2 KB	125.9 MB	147.5 MB	14%	7.3 KB
2	csiph-out.feeder.erje.net	19.7 MB	4.2 MB	65.8 MB	89.7 MB	21%	7.7 KB
3	news-out.mixmin.net	11.0 MB	12.2 KB	1.8 MB	12.8 MB	85%	2.9 KB
4	feeder.eternal-september.org	9.9 MB	2.3 MB	32.8 MB	45.0 MB	22%	7.2 KB
5	newsfeed.neva.ru	4.6 MB	810.9 KB	22.8 MB	28.2 MB	16%	6.2 KB
6	newsfeed.fu-berlin.de	2.9 MB	3.6 KB	326.5 KB	3.2 MB	89%	2.2 KB
7	newsfeeds.xmission.com	2.2 MB	3.0 KB	1.0 MB	3.2 MB	67%	4.5 KB
8	au2pb.net	1.7 MB	0.0 KB	428.2 KB	2.1 MB	79%	2.4 KB
9	news.fcku.it	1.5 MB	0.0 KB	0.0 KB	1.5 MB	100%	1.9 KB
10	news.freedyn.net	1.1 MB	0.0 KB	1.4 MB	2.4 MB	44%	3.9 KB
11	news.swapon.de	442.5 KB	0.0 KB	34.2 KB	476.7 KB	92%	2.6 KB
12	xanadu-bbs.net	426.8 KB	78.4 KB	891.0 MB	891.5 MB	0%	340.0 KB
13	nntp.pasdenom.info	148.0 KB	0.0 KB	64.0 KB	212.0 KB	69%	2.4 KB
14	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 14		76.5 MB	8.0 MB	1.1 GB	1.2 GB	6%	22.6 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Dec 28 04:15:00 - 04:59:59	304	1.2%	0.11	1015.7 KB	1.3%	0.38
Dec 28 05:00:00 - 05:59:59	500	2.0%	0.14	1.7 MB	2.2%	0.49
Dec 28 06:00:00 - 06:59:59	593	2.3%	0.16	2.0 MB	2.6%	0.57
Dec 28 07:00:00 - 07:59:59	635	2.5%	0.18	2.3 MB	3.1%	0.67
Dec 28 08:00:00 - 08:59:59	1143	4.5%	0.32	4.6 MB	6.0%	1.31
Dec 28 09:00:00 - 09:59:59	1287	5.1%	0.36	4.0 MB	5.3%	1.14
Dec 28 10:00:00 - 10:59:59	1088	4.3%	0.30	2.6 MB	3.4%	0.74
Dec 28 11:00:00 - 11:59:59	1233	4.8%	0.34	4.0 MB	5.2%	1.13
Dec 28 12:00:00 - 12:59:59	1124	4.4%	0.31	3.1 MB	4.0%	0.87
Dec 28 13:00:00 - 13:59:59	1102	4.3%	0.31	3.0 MB	4.0%	0.86
Dec 28 14:00:00 - 14:59:59	1220	4.8%	0.34	3.3 MB	4.3%	0.93
Dec 28 15:00:00 - 15:59:59	1387	5.4%	0.39	4.0 MB	5.2%	1.13
Dec 28 16:00:00 - 16:59:59	1610	6.3%	0.45	4.6 MB	6.1%	1.32
Dec 28 17:00:00 - 17:59:59	1494	5.9%	0.41	4.2 MB	5.6%	1.21
Dec 28 18:00:00 - 18:59:59	1372	5.4%	0.38	3.5 MB	4.6%	1.00
Dec 28 19:00:00 - 19:59:59	1443	5.7%	0.40	4.4 MB	5.8%	1.25
Dec 28 20:00:00 - 20:59:59	1435	5.6%	0.40	4.0 MB	5.2%	1.14
Dec 28 21:00:00 - 21:59:59	1522	6.0%	0.42	4.2 MB	5.5%	1.19
Dec 28 22:00:00 - 22:59:59	1381	5.4%	0.38	4.0 MB	5.2%	1.13
Dec 28 23:00:00 - 23:59:59	894	3.5%	0.25	2.4 MB	3.2%	0.69
Dec 29 00:00:00 - 00:59:59	780	3.1%	0.22	2.4 MB	3.2%	0.70
Dec 29 01:00:00 - 01:59:59	713	2.8%	0.20	2.5 MB	3.3%	0.72
Dec 29 02:00:00 - 02:59:59	556	2.2%	0.15	1.9 MB	2.5%	0.54
Dec 29 03:00:00 - 03:59:59	495	1.9%	0.14	1.7 MB	2.2%	0.47
Dec 29 04:00:00 - 04:15:00	151	0.6%	0.17	576.0 KB	0.7%	0.64
TOTAL: 24:00:00	25462	100.0%	0.29	76.0 MB	100.0%	0.90

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	usenet.blueworldhosting.com	12981	966	50	11965
2	csiph-out.feeder.erje.net	7709	471	366	6872
3	newsfeed.neva.ru	2915	1028	74	1813
4	feeder.eternal-september.org	2640	119	156	2365
5	xanadu-bbs.net	2439	31	7	2401
6	news-out.mixmin.net	834	2	8	824
7	newsfeed.fu-berlin.de	535	46	1	488
8	news.freedyn.net	185	0	0	185
9	au2pb.net	90	87	0	3
10	newsfeeds.xmission.com	52	46	0	6
11	nntp.pasdenom.info	25	23	0	2
12	news.swapon.de	14	0	0	14
13	news.fcku.it	12	0	0	12
TOTAL: 13		30431	2819	662	26950

Unwanted newsgroups [Top 20]:

Newsgroup	Count
fa.linux.kernel	323
lada.talk	284
ut.test	215
mailing.freebsd.svn-ports-head	107
mailing.freebsd.svn-ports-all	107
mailing.freebsd.ports-bugs	102
lada.auto	95
mailing.freebsd.pkg-fallout	84
alt.survival	54
pld.cvs.commit	52
alt.binaries.multimedia.tatu	42
fa.freebsd.cvs-all	40
mailing.freebsd.svn-src-all	40
mpc.lists.freebsd.ports.bugs	35
mailing.openbsd.ports-changes	35
fa.openbsd.source-changes	32
mailing.openbsd.source-changes	32
lada.photo	32
24hoursupport.helpdesk	31
mailing.openbsd.misc	25
TOTAL: 255	2819

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	18511
EMP (phn path)	3469
EMP (phl)	797
EMP (phn nph)	155
Binary: misplaced rar	109
Too many newsgroups	60
Rogue cancel (newsgroups)	44
HTML Multipart	24
Binary: misplaced rev	20
Binary Payload	14
PFM bot misc	6
Binary: misplaced par2	6
HTML Image Tags	5
HTML post	5
Binary Image: misplaced jpg	1
Too many newsgroups (meow)	1
TOTAL: 16	23227

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Article posted in the future
	csiph-out.feeder.erje.net	101
	usenet.blueworldhosting.com	3
	TOTAL: 2	104
Huge articles
	xanadu-bbs.net	2301
	usenet.blueworldhosting.com	112
	feeder.eternal-september.org	32
	news.freedyn.net	10
	news-out.mixmin.net	9
	newsfeeds.xmission.com	6
	newsfeed.fu-berlin.de	1
	au2pb.net	1
	TOTAL: 8	2472
Including strange strings
	newsfeed.fu-berlin.de	433
	news-out.mixmin.net	22
	feeder.eternal-september.org	17
	news.fcku.it	12
	news.swapon.de	9
	csiph-out.feeder.erje.net	8
	usenet.blueworldhosting.com	2
	au2pb.net	2
	newsfeed.neva.ru	1
	TOTAL: 9	506
No colon-space in header
	csiph-out.feeder.erje.net	549
	usenet.blueworldhosting.com	85
	TOTAL: 2	634
TOTAL: 4		3716

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.freedyn.net	25444	3244	21405	252	0	12%	23:59:56
2	xanadu-bbs	27854	1104	24076	111	133	3%	23:59:56
3	fu-berlin.de	23791	926	22859	6	0	3%	23:59:55
4	usenet.pasdenom.info	30915	183	23621	1596	0	0%	23:59:56
5	au2pb	23960	107	23400	33	0	0%	23:59:53
6	neva.ru	25759	16	22266	175	0	0%	23:59:47
7	eternal-september	23454	7	20318	5	0	0%	23:59:56
8	news.mixmin.net	24374	7	20520	0	0	0%	23:59:56
9	xmission	28931	4	23838	2	0	0%	23:59:51
10	news.fcku.it	2100	3	1869	0	0	0%	22:21:20
11	erje	18298	0	17164	235	4	0%	23:59:54
12	bwh	16893	0	16559	0	0	0%	23:59:56
13	news.swapon.de	1860	0	1786	1	0	0%	23:20:07
TOTAL: 13		273633	5601	239681	2416	137	2%	309:40:23

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	news.freedyn.net	17.8 MB	1.3 MB	19.1 MB	0.2 KB/s	5.6 KB	23:59:56
2	xanadu-bbs	9.2 MB	305.1 KB	9.5 MB	0.1 KB/s	8.0 KB	23:59:56
3	fu-berlin.de	8.5 MB	6.6 KB	8.5 MB	0.1 KB/s	9.4 KB	23:59:55
4	usenet.pasdenom.info	753.7 KB	10.3 MB	11.0 MB	0.1 KB/s	6.4 KB	23:59:56
5	au2pb	531.5 KB	104.6 KB	636.2 KB	0.0 KB/s	4.5 KB	23:59:53
6	neva.ru	178.1 KB	1.2 MB	1.4 MB	0.0 KB/s	7.6 KB	23:59:47
7	news.mixmin.net	59.4 KB	0.0 KB	59.4 KB	0.0 KB/s	8.5 KB	23:59:56
8	eternal-september	26.5 KB	7.7 KB	34.1 KB	0.0 KB/s	2.8 KB	23:59:56
9	xmission	9.2 KB	8.3 KB	17.6 KB	0.0 KB/s	2.9 KB	23:59:51
10	news.fcku.it	6.6 KB	0.0 KB	6.6 KB	0.0 KB/s	2.2 KB	22:21:20
11	erje	0.0 KB	1.4 MB	1.4 MB	0.0 KB/s	6.3 KB	23:59:54
12	bwh	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:59:56
13	news.swapon.de	0.0 KB	2.1 KB	2.1 KB	0.0 KB/s	2.1 KB	23:20:07
TOTAL: 13		37.0 MB	14.7 MB	51.7 MB	0.0 KB/s	6.6 KB	309:40:23

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	202.89.176.220	288	97	243.2 KB	84	0	0	04:45:57
TOTAL: 1		288	97	243.2 KB	84	0	0	36:31:39

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	unresolved	289	97	243.2 KB	84	04:46:08
2	*.hsd1.nj.comcast.net	4	0	0.0 KB	0	02:31:22
3	*.ip-188-165-239.eu	252	0	0.0 KB	0	09:46:22
4	*.lightspeed.rcsntx.sbcglobal.net	51	0	0.0 KB	0	07:50:22
5	*.bbox.io	4	0	0.0 KB	0	02:00:01
6	*.chello.nl	20	0	0.0 KB	0	07:54:27
TOTAL: 6		620	97	243.2 KB	84	36:31: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
ns342002.ip-188-165-239.eu	24.731	13.054	0.000	09:46:22
dhcp-089-099-203-254.chello.nl	1.589	0.359	0.000	07:54:27
99-180-119-17.lightspeed.rcsntx.sbcglobal.net	4.608	0.684	0.000	07:50:22
202.89.176.220	29.360	6.409	0.727	04:45:57
c-73-195-247-24.hsd1.nj.comcast.net	0.367	0.132	0.000	02:31:22
tempe0.bbox.io	0.402	0.081	0.000	02:00:01
h71.136.22.98.dynamic.ip.windstream.net	0.116	0.128	0.000	01:42:53
151.217.178.31	0.088	0.024	0.000	00:00:10
TOTAL: 8	61.261	20.871	0.727	36:31:39

Curious NNRP server explorers [Top 20]:

System	Conn
ns342002.ip-188-165-239.eu	252
99-180-119-17.lightspeed.rcsntx.sbcglobal.net	51
dhcp-089-099-203-254.chello.nl	20
c-73-195-247-24.hsd1.nj.comcast.net	4
tempe0.bbox.io	4
151.217.178.31	1
TOTAL: 6	332

NNRP client timeouts [Top 20]:

System	Conn	Peer
dhcp-089-099-203-254.chello.nl	14	0
c-73-195-247-24.hsd1.nj.comcast.net	5	0
tempe0.bbox.io	4	0
h71.136.22.98.dynamic.ip.windstream.net	1	0
TOTAL: 4	24	0

Newsgroup request counts (by category):

Category		Count	Pct
1	comp	96	99.0%
2	news	1	1.0%
TOTAL: 2		97	100.0%

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

Newsgroup		Count
1	comp.os.vms	46
2	comp.arch	34
3	comp.sys.ibm.pc.games.action	6
4	comp.arch.embedded	4
5	comp.sys.ibm.pc.hardware.storage	2
6	comp.ai.neural-nets	1
7	comp.sys.ibm.pc.games.rpg	1
8	news.admin.peering	1
9	comp.unix.aix	1
10	comp.ai.philosophy	1
TOTAL: 10		97

Daily Usenet report for csiph.com

Dec 28 04:15:00 -- Dec 29 04:15:00