Forums / Install & configuration / eZ debug - slow runtime

eZ debug - slow runtime

Author Message

Stéphane Cloutier

Friday 16 July 2004 6:52:52 am

I'm having speed issues. At first install of 3.4 and 3.4.1, a few weeks ago, my site runtime was between 0.4 to 0.6 secdonds. Now it is from 1.2 to 1.4 seconds. What could have caused this situation ? I cleared cache and recompile the templates. Still same results.

Would this have an impact :
strpos(): Empty delimiter. in /var/www/html/ez34/var/corporate/cache/template/compiled/node_list-e75210f10929c05db3aee13537a9f3de.php on line 30

eZ debug
Timing: Jul 16 2004 09:38:27

Script start

Timing: Jul 16 2004 09:38:27

Module start 'content'

Timing: Jul 16 2004 09:38:27

Module end 'content'

Warning: PHP Jul 16 2004 09:38:27

strpos(): Empty delimiter. in /var/www/html/ez34/var/corporate/cache/template/compiled/node_list-e75210f10929c05db3aee13537a9f3de.php on line 30

Timing: Jul 16 2004 09:38:27

End

Timing points:
Checkpoint Elapsed Rel. Elapsed Memory Rel. Memory
Script start 0.0000 sec 0.3130 sec 0.0000KB 0.0000KB
Module start 'content' 0.3130 sec 0.2214 sec 0.0000KB 0.0000KB
Module end 'content' 0.5344 sec 0.8059 sec 0.0000KB 0.0000KB
End 1.3402 sec 0.0000KB 0.0000KB
Total runtime: 1.3418 sec

Time accumulators:
Accumulator Elapsed Percent Count Average
ini_load
Load cache 0.2476 sec 18.0855% 7 0.0354 sec
Mysql Total
Mysql_queries 0.0143 sec 1.0411% 2 0.0071 sec
Looping result 0.0009 sec 0.0661% 2 0.0005 sec
Template Total 0.7812 sec 57.1% 1 0.7812 sec
Template load 0.1983 sec 14.4836% 1 0.1983 sec
Template processing 0.5806 sec 42.4033% 1 0.5806 sec
override
Cache load 0.1416 sec 10.3407% 1 0.1416 sec
Total script time: 1.3692 sec

Qupanuaq - Snow bunting

Björn Dieding@xrow.de

Friday 16 July 2004 9:08:42 am

/var/www/html/ez34/var/corporate/cache/template/compiled/node_list-e75210f10929c05db3aee13537a9f3de.php
fix the error in the compiled template, just for testing

Turn off debugging/logging.
You might have a slow disk.

Looking for a new job? http://www.xrow.com/xrow-GmbH/Jobs
Looking for hosting? http://hostingezpublish.com
-----------------------------------------------------------------------------
GMT +01:00 Hannover, Germany
Web: http://www.xrow.com/

Stéphane Cloutier

Sunday 18 July 2004 7:54:57 pm

I tried fixing the template warning. I even applied the template compile compression patch, but still no improvement. I don't know what's happening. When I installed ezp 3.4, it was working very fast. I applied 3.4.1 and was still very good. Everything changed only a few days ago. I`m running apache 1.3, mysql 4.1.0, php 4.3.4.

It looks like the cache is being re-created every so often someone visits my site, although the content doesn't change that much.

Is there a tool I could run on my server so I can watch what processes ezp involves and how much CPU/memory it uses?

 

Qupanuaq - Snow bunting

eZ debug

Timing: Jan 18 2025 19:11:07
Script start
Timing: Jan 18 2025 19:11:07
Module start 'content'
Timing: Jan 18 2025 19:11:08
Module end 'content'
Timing: Jan 18 2025 19:11:08
Script end

Main resources:

Total runtime1.4410 sec
Peak memory usage4,096.0000 KB
Database Queries194

Timing points:

CheckpointStart (sec)Duration (sec)Memory at start (KB)Memory used (KB)
Script start 0.00000.0131 589.1563180.8359
Module start 'content' 0.01311.2152 769.9922557.8906
Module end 'content' 1.22830.2126 1,327.8828336.7813
Script end 1.4409  1,664.6641 

Time accumulators:

 Accumulator Duration (sec) Duration (%) Count Average (sec)
Ini load
Load cache0.00530.3694210.0003
Check MTime0.00170.1189210.0001
Mysql Total
Database connection0.00250.174110.0025
Mysqli_queries1.342993.19711940.0069
Looping result0.00270.18811920.0000
Template Total1.366194.820.6831
Template load0.00230.158620.0011
Template processing1.363894.647220.6819
Template load and register function0.00010.007010.0001
states
state_id_array0.01130.784510.0113
state_identifier_array0.00220.153820.0011
Override
Cache load0.00190.1316500.0000
Sytem overhead
Fetch class attribute can translate value0.00180.126230.0006
Fetch class attribute name0.00120.083650.0002
XML
Image XML parsing0.00130.086930.0004
class_abstraction
Instantiating content class attribute0.00000.000660.0000
General
dbfile0.00230.1613330.0001
String conversion0.00000.000530.0000
Note: percentages do not add up to 100% because some accumulators overlap

CSS/JS files loaded with "ezjscPacker" during request:

CacheTypePacklevelSourceFiles
CSS0extension/community/design/community/stylesheets/ext/jquery.autocomplete.css
extension/community_design/design/suncana/stylesheets/scrollbars.css
extension/community_design/design/suncana/stylesheets/tabs.css
extension/community_design/design/suncana/stylesheets/roadmap.css
extension/community_design/design/suncana/stylesheets/content.css
extension/community_design/design/suncana/stylesheets/star-rating.css
extension/community_design/design/suncana/stylesheets/syntax_and_custom_tags.css
extension/community_design/design/suncana/stylesheets/buttons.css
extension/community_design/design/suncana/stylesheets/tweetbox.css
extension/community_design/design/suncana/stylesheets/jquery.fancybox-1.3.4.css
extension/bcsmoothgallery/design/standard/stylesheets/magnific-popup.css
extension/sevenx/design/simple/stylesheets/star_rating.css
extension/sevenx/design/simple/stylesheets/libs/fontawesome/css/all.min.css
extension/sevenx/design/simple/stylesheets/main.v02.css
extension/sevenx/design/simple/stylesheets/main.v02.res.css
JS0extension/ezjscore/design/standard/lib/yui/3.17.2/build/yui/yui-min.js
extension/ezjscore/design/standard/javascript/jquery-3.7.0.min.js
extension/community_design/design/suncana/javascript/jquery.ui.core.min.js
extension/community_design/design/suncana/javascript/jquery.ui.widget.min.js
extension/community_design/design/suncana/javascript/jquery.easing.1.3.js
extension/community_design/design/suncana/javascript/jquery.ui.tabs.js
extension/community_design/design/suncana/javascript/jquery.hoverIntent.min.js
extension/community_design/design/suncana/javascript/jquery.popmenu.js
extension/community_design/design/suncana/javascript/jScrollPane.js
extension/community_design/design/suncana/javascript/jquery.mousewheel.js
extension/community_design/design/suncana/javascript/jquery.cycle.all.js
extension/sevenx/design/simple/javascript/jquery.scrollTo.js
extension/community_design/design/suncana/javascript/jquery.cookie.js
extension/community_design/design/suncana/javascript/ezstarrating_jquery.js
extension/community_design/design/suncana/javascript/jquery.initboxes.js
extension/community_design/design/suncana/javascript/app.js
extension/community_design/design/suncana/javascript/twitterwidget.js
extension/community_design/design/suncana/javascript/community.js
extension/community_design/design/suncana/javascript/roadmap.js
extension/community_design/design/suncana/javascript/ez.js
extension/community_design/design/suncana/javascript/ezshareevents.js
extension/sevenx/design/simple/javascript/main.js

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
3content/datatype/view/ezimage.tpl<No override>extension/sevenx/design/simple/templates/content/datatype/view/ezimage.tplEdit templateOverride template
3content/datatype/view/ezxmltext.tpl<No override>extension/community_design/design/suncana/templates/content/datatype/view/ezxmltext.tplEdit templateOverride template
8content/datatype/view/ezxmltags/paragraph.tpl<No override>extension/ezwebin/design/ezwebin/templates/content/datatype/view/ezxmltags/paragraph.tplEdit templateOverride template
6content/datatype/view/ezxmltags/line.tpl<No override>design/standard/templates/content/datatype/view/ezxmltags/line.tplEdit templateOverride template
1pagelayout.tpl<No override>extension/sevenx/design/simple/templates/pagelayout.tplEdit templateOverride template
 Number of times templates used: 22
 Number of unique templates used: 6

Time used to render debug report: 0.0002 secs