Forums / Developer / 3.1-2 is VERY SLOW

3.1-2 is VERY SLOW

Author Message

Gabriel Ambuehl

Friday 13 June 2003 3:06:52 am

I've been playing around with 3.1-2 and while it works very well, it's f***** slow. On a P3800 machine not doing anything except serving as development box, it takes about 9seconds (as calculated by Debug) to load the login page and 98% of the time is spent in the template module. Now caching is active and so is template compiling and I'm using phpaccelerator already.

What can I do to get better performance?

And why don't I see any of my own siteaccess templates in var/cache/compiled?

Template compiling is a nice idea in theory but in practice, the benefits seem unnoticeable.

I think a 1Ghz machine should be able to deliver at least 5 pages/s not 1 page per 10 seconds. And I'm not doing much in the lines of template black magic, my pagelayout is 25k but there's only two dynamic parts, the menu is assembled of children of the root node and the content of the current node is fetched and links to its children are displayed, nothing more.

Visit http://triligon.org

Bård Farstad

Friday 13 June 2003 3:27:19 am

Check that you have correct permissions so that cache files are created. 3.1 is faster then 3.0 when you have enabled caching. It sounds like there is a charset conversion which takes alot of time. Do you see this on the debug output?

On my development PC ( 1GHz PIII IBM ) the login page takes about 0.29 seconds to load. The cached views takes about the same.

--bård

Documentation: http://ez.no/doc

Gabriel Ambuehl

Friday 13 June 2003 4:13:39 am

Ok, I tried again on a 2Ghz Athlon XP box.

I think the real offender for the login page (which now takes approx 3.5 s to load) is this:

String conversion 1.8185 sec 46.2855% 186 0.0098 sec
String conversion w/ codepage reverse 1.8051 sec 45.9443% 1 1.8051 sec

During setup I've chosen German as language which might have been a mistake, I'll try what happens with en_UK, too.

Maybe
Warning: ezi18n Jun 13 2003 13:21:46 No translation for file(translation.ts) in context(design/standard/layout): '%1 front page' with comment()

is the problem?

Visit http://triligon.org

Gabriel Ambuehl

Friday 13 June 2003 4:31:34 am

Yes it's definitely the translation that's causing wreck havoc here.

When I set en-UK, I get to see the login page in 0.3Xs on the 2Ghz machine!

So translation is one area where some work needs to be done (maybe have the setup insert the translation into the files statically instead of translating stuff on the fly each time?)

Visit http://triligon.org

Jo Henrik Endrerud

Friday 13 June 2003 5:39:47 am

The problem can be related to the caching of the translation files. Do you have the PHP mbstring extension installed? This should take care of this problem for you

Jo Henrik Endrerud | System Developer @ Seeds Consulting | http://www.seeds.no

Gabriel Ambuehl

Friday 13 June 2003 11:22:11 am

No but thanks for the pointer, I'll try installing mbstring then.

Visit http://triligon.org

eZ debug

Timing: Jan 18 2025 10:29:43
Script start
Timing: Jan 18 2025 10:29:43
Module start 'content'
Timing: Jan 18 2025 10:29:44
Module end 'content'
Timing: Jan 18 2025 10:29:44
Script end

Main resources:

Total runtime0.9086 sec
Peak memory usage4,096.0000 KB
Database Queries205

Timing points:

CheckpointStart (sec)Duration (sec)Memory at start (KB)Memory used (KB)
Script start 0.00000.0102 588.7266180.8438
Module start 'content' 0.01020.7625 769.5703604.9688
Module end 'content' 0.77270.1358 1,374.5391337.0703
Script end 0.9085  1,711.6094 

Time accumulators:

 Accumulator Duration (sec) Duration (%) Count Average (sec)
Ini load
Load cache0.00450.4913210.0002
Check MTime0.00160.1790210.0001
Mysql Total
Database connection0.00130.142610.0013
Mysqli_queries0.829191.25852050.0040
Looping result0.00230.25672030.0000
Template Total0.865995.320.4330
Template load0.00220.246720.0011
Template processing0.863795.060820.4318
Template load and register function0.00020.024710.0002
states
state_id_array0.00140.148710.0014
state_identifier_array0.00240.260220.0012
Override
Cache load0.00180.2035300.0001
Sytem overhead
Fetch class attribute can translate value0.00120.127840.0003
Fetch class attribute name0.00150.163770.0002
XML
Image XML parsing0.00090.102340.0002
class_abstraction
Instantiating content class attribute0.00000.001770.0000
General
dbfile0.00340.3753280.0001
String conversion0.00000.001430.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
6content/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
1content/datatype/view/ezimage.tpl<No override>extension/sevenx/design/simple/templates/content/datatype/view/ezimage.tplEdit templateOverride template
2content/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: 19
 Number of unique templates used: 6

Time used to render debug report: 0.0002 secs