timings

Next topic

Author	Message
Fredy Dobler	Wednesday 15 February 2006 7:25:47 am My admin Pages are slow, what is using more than 2 seconds? Below is the Timing part of the 'Debug Ouput' of the Standard admin Page in ezPublish. The Total runtime is more than 2 seconds, but the individual parts cummulated are much lower, is there a way, to find out where the time is spent? Timing points: Checkpoint Elapsed Rel. Elapsed Memory Rel. Memory Script start 0.0000 sec 0.0177 sec 0.0000KB 0.0000KB Module start 'content' 0.0177 sec 0.1276 sec 0.0000KB 0.0000KB Module end 'content' 0.1453 sec 0.0997 sec 0.0000KB 0.0000KB End 0.2450 sec 0.0000KB 0.0000KB Total runtime: 2.6992 sec Time accumulators: Accumulator Elapsed Percent Count Average ini_load Load cache 0.0107 sec 0.3956% 18 0.0006 sec FindInputFiles 0.0053 sec 0.1964% 18 0.0003 sec Mysql Total Mysql_queries 0.0140 sec 0.5177% 45 0.0003 sec Looping result 0.0020 sec 0.0728% 39 0.0001 sec TS translator TS init 0.0104 sec 0.3846% 11 0.0009 sec TS cache load 0.0078 sec 0.2891% 11 0.0007 sec TS context load 0.0058 sec 0.2141% 11 0.0005 sec Template Total 0.2255 sec 8.4% 3 0.0752 sec Template load 0.0076 sec 0.2806% 3 0.0025 sec Template processing 0.2174 sec 8.0492% 3 0.0725 sec override Cache load 0.0046 sec 0.1686% 3 0.0015 sec class_abstraction Instantiating content class attribute 0.0049 sec 0.1799% 5 0.0010 sec Total script time: 2.7005 ses Thanks Fredy
Marko Žmak	Friday 17 February 2006 4:52:58 pm I also noticed this and I posted a similar post to the forum but got no answer. Is there anyone that can answer this? -- Nothing is impossible. Not if you can imagine it! Hubert Farnsworth

Author

Message

Wednesday 15 February 2006 7:25:47 am

My admin Pages are slow, what is using more than 2 seconds?
Below is the Timing part of the 'Debug Ouput' of the Standard admin Page in ezPublish.
The Total runtime is more than 2 seconds, but the individual parts cummulated are much lower, is there a way, to find out where the time is spent?

Timing points:
Checkpoint Elapsed Rel. Elapsed Memory Rel. Memory
Script start 0.0000 sec 0.0177 sec 0.0000KB 0.0000KB
Module start 'content' 0.0177 sec 0.1276 sec 0.0000KB 0.0000KB
Module end 'content' 0.1453 sec 0.0997 sec 0.0000KB 0.0000KB
End 0.2450 sec 0.0000KB 0.0000KB
Total runtime: 2.6992 sec

Time accumulators:
Accumulator Elapsed Percent Count Average
ini_load
Load cache 0.0107 sec 0.3956% 18 0.0006 sec
FindInputFiles 0.0053 sec 0.1964% 18 0.0003 sec
Mysql Total
Mysql_queries 0.0140 sec 0.5177% 45 0.0003 sec
Looping result 0.0020 sec 0.0728% 39 0.0001 sec
TS translator
TS init 0.0104 sec 0.3846% 11 0.0009 sec
TS cache load 0.0078 sec 0.2891% 11 0.0007 sec
TS context load 0.0058 sec 0.2141% 11 0.0005 sec
Template Total 0.2255 sec 8.4% 3 0.0752 sec
Template load 0.0076 sec 0.2806% 3 0.0025 sec
Template processing 0.2174 sec 8.0492% 3 0.0725 sec
override
Cache load 0.0046 sec 0.1686% 3 0.0015 sec
class_abstraction
Instantiating content class attribute 0.0049 sec 0.1799% 5 0.0010 sec
Total script time: 2.7005 ses

Thanks
Fredy

Marko Žmak

Friday 17 February 2006 4:52:58 pm

I also noticed this and I posted a similar post to the forum but got no answer. Is there anyone that can answer this?

--
Nothing is impossible. Not if you can imagine it!

Hubert Farnsworth

eZ debug

Timing:	Jan 19 2025 07:03:50
Script start
Timing:	Jan 19 2025 07:03:50
Module start 'layout'
Timing:	Jan 19 2025 07:03:50
Module start 'content'
Timing:	Jan 19 2025 07:03:51
Module end 'content'
Timing:	Jan 19 2025 07:03:51
Script end

Main resources:

Total runtime	1.3090 sec
Peak memory usage	4,096.0000 KB
Database Queries	54

Timing points:

Checkpoint	Start (sec)	Duration (sec)	Memory at start (KB)	Memory used (KB)
Script start	0.0000	0.0068	590.1641	152.6094
Module start 'layout'	0.0068	0.0038	742.7734	39.4141
Module start 'content'	0.0106	1.2968	782.1875	532.2500
Module end 'content'	1.3075	0.0015	1,314.4375	8.2031
Script end	1.3090		1,322.6406

Time accumulators:

Accumulator	Duration (sec)	Duration (%)	Count	Average (sec)
Ini load
Load cache	0.0034	0.2613	16	0.0002
Check MTime	0.0015	0.1162	16	0.0001
Mysql Total
Database connection	0.0013	0.0955	1	0.0013
Mysqli_queries	1.2535	95.7640	54	0.0232
Looping result	0.0006	0.0437	52	0.0000
Template Total	1.2691	96.9	2	0.6345
Template load	0.0022	0.1646	2	0.0011
Template processing	1.2669	96.7829	2	0.6334
Template load and register function	0.0003	0.0222	1	0.0003
states
state_id_array	0.0011	0.0821	1	0.0011
state_identifier_array	0.0014	0.1054	2	0.0007
Override
Cache load	0.0018	0.1397	38	0.0000
Sytem overhead
Fetch class attribute can translate value	0.0005	0.0398	2	0.0003
Fetch class attribute name	0.0018	0.1401	3	0.0006
XML
Image XML parsing	0.0007	0.0567	2	0.0004
class_abstraction
Instantiating content class attribute	0.0000	0.0006	3	0.0000
General
dbfile	0.0010	0.0775	18	0.0001
String conversion	0.0000	0.0007	4	0.0000
Note: percentages do not add up to 100% because some accumulators overlap

Templates used to render the page:

Usage	Requested template	Template	Template loaded
1	node/view/full.tpl	full/forum_topic.tpl	extension/sevenx/design/simple/override/templates/full/forum_topic.tpl
2	content/datatype/view/ezxmltext.tpl	<No override>	extension/community_design/design/suncana/templates/content/datatype/view/ezxmltext.tpl
4	content/datatype/view/ezxmltags/line.tpl	<No override>	design/standard/templates/content/datatype/view/ezxmltags/line.tpl
5	content/datatype/view/ezxmltags/paragraph.tpl	<No override>	extension/ezwebin/design/ezwebin/templates/content/datatype/view/ezxmltags/paragraph.tpl
1	content/datatype/view/ezimage.tpl	<No override>	extension/sevenx/design/simple/templates/content/datatype/view/ezimage.tpl
1	print_pagelayout.tpl	<No override>	extension/community/design/community/templates/print_pagelayout.tpl
Number of times templates used: 14 Number of unique templates used: 6

Time used to render debug report: 0.0001 secs