ez is too sow... simple query takes 4 sec.

Author Message

Vytautas Germanavičius

Thursday 05 October 2006 10:28:06 pm

I wrote my extension for ez. It is very simple: rubn query select top 10 form table and fetch template to display results.
i tested query on pgMyAdmin - it takes 0.08s. But when i run extension, it takes 4.4s !(according debug info)
why???

{set-block scope=root variable=cache_ttl}0{/set-block}

Xavier Dutoit

Saturday 07 October 2006 8:00:20 am

Well, on the debug info, you have more explainations on where ez spends its time.

The template might be quite heavyweight...

X+

http://www.sydesy.com

Vytautas Germanavičius

Monday 09 October 2006 4:55:19 am

As i understand, this shows, that EZ does something 1.7 sec, before it starts my written module? Or initialization of module takes 1.7s?

Checkpoint Elapsed Rel. Elapsed Memory Rel. Memory
Module start 'conferences' 0.0000 sec 1.7699 sec 12,894.0547KB 6,769.3438KB
Module end 'conferences' 1.7699 sec 0.7357 sec 19,663.3984KB 8,409.5156KB
End 2.5055 sec 28,072.9141KB 0.0078KB
Total runtime: 3.2523 sec

{set-block scope=root variable=cache_ttl}0{/set-block}

Xavier Dutoit

Monday 09 October 2006 8:13:41 am

Hi,

That's the kind of numbers you have the first time you run the script if you haven't cached/compiled the templates.

Once it's been ran one everything is cached and it should be near 0.

Check your setting otherwise.

X+

http://www.sydesy.com

Powered by eZ Publish™ CMS Open Source Web Content Management. Copyright © 1999-2014 eZ Systems AS (except where otherwise noted). All rights reserved.

eZ debug

Timing: Jan 18 2025 19:26:26
Script start
Timing: Jan 18 2025 19:26:26
Module start 'layout'
Timing: Jan 18 2025 19:26:26
Module start 'content'
Timing: Jan 18 2025 19:26:27
Module end 'content'
Timing: Jan 18 2025 19:26:27
Script end

Main resources:

Total runtime1.1534 sec
Peak memory usage4,096.0000 KB
Database Queries60

Timing points:

CheckpointStart (sec)Duration (sec)Memory at start (KB)Memory used (KB)
Script start 0.00000.0061 588.0391152.6406
Module start 'layout' 0.00610.0043 740.679739.4922
Module start 'content' 0.01041.1417 780.1719551.6484
Module end 'content' 1.15210.0013 1,331.820312.4375
Script end 1.1534  1,344.2578 

Time accumulators:

 Accumulator Duration (sec) Duration (%) Count Average (sec)
Ini load
Load cache0.00330.2825160.0002
Check MTime0.00130.1170160.0001
Mysql Total
Database connection0.00100.085210.0010
Mysqli_queries1.093794.8290600.0182
Looping result0.00060.0525580.0000
Template Total1.103895.720.5519
Template load0.00250.220520.0013
Template processing1.101295.478120.5506
Template load and register function0.00030.025110.0003
states
state_id_array0.00200.176410.0020
state_identifier_array0.00100.083820.0005
Override
Cache load0.00220.1930270.0001
Sytem overhead
Fetch class attribute can translate value0.00110.095520.0006
Fetch class attribute name0.00180.159360.0003
XML
Image XML parsing0.00110.096620.0006
class_abstraction
Instantiating content class attribute0.00000.001580.0000
General
dbfile0.00100.0879220.0000
String conversion0.00000.004240.0000
Note: percentages do not add up to 100% because some accumulators overlap

Templates used to render the page:

UsageRequested templateTemplateTemplate loadedEditOverride
1node/view/full.tplfull/forum_topic.tplextension/sevenx/design/simple/override/templates/full/forum_topic.tplEdit templateOverride template
4content/datatype/view/ezimage.tpl<No override>extension/sevenx/design/simple/templates/content/datatype/view/ezimage.tplEdit templateOverride template
4content/datatype/view/ezxmltext.tpl<No override>extension/community_design/design/suncana/templates/content/datatype/view/ezxmltext.tplEdit templateOverride template
2content/datatype/view/ezxmltags/line.tpl<No override>design/standard/templates/content/datatype/view/ezxmltags/line.tplEdit templateOverride template
5content/datatype/view/ezxmltags/paragraph.tpl<No override>extension/ezwebin/design/ezwebin/templates/content/datatype/view/ezxmltags/paragraph.tplEdit templateOverride template
1print_pagelayout.tpl<No override>extension/community/design/community/templates/print_pagelayout.tplEdit templateOverride template
 Number of times templates used: 17
 Number of unique templates used: 6

Time used to render debug report: 0.0001 secs