Forums / Developer / I read all about ez performance, but admin part is slow...

I read all about ez performance, but admin part is slow...

Author Message

Stan Cheredov

Tuesday 05 December 2006 5:58:54 am

I have refresh time a page in admin interface about 3-10 sec. Is normal? I think is slow :( ... All pages is cached.

Timing points:
Checkpoint	Elapsed	Rel. Elapsed	Memory	Rel. Memory
Module start 'content'	0.0000 sec	2.4954 sec	0.0000KB	0.0000KB
Module end 'content'	2.4954 sec	2.8317 sec	0.0000KB	0.0000KB
End	5.3271 sec	 	0.0000KB	0.0000KB
Total runtime:	5.6019 sec	
Time accumulators:
 Accumulator	 Elapsed	 Percent	 Count	 Average
ini_load				
Load cache	0.0486 sec	0.8438%	15	0.0032 sec
FindInputFiles	0.0355 sec	0.6165%	15	0.0024 sec
Mysql Total				
Mysql_queries	0.2719 sec	4.7241%	116	0.0023 sec
Looping result	0.0291 sec	0.5057%	110	0.0003 sec
TS translator				
TS init	0.0400 sec	0.6950%	8	0.0050 sec
TS cache load	0.0151 sec	0.2622%	8	0.0019 sec
TS context load	0.0120 sec	0.2085%	8	0.0015 sec
Template Total	5.3367 sec	92.7%	3	1.7789 sec
Template load	0.0478 sec	0.8306%	3	0.0159 sec
Template processing	5.2881 sec	91.8765%	3	1.7627 sec
Template load and register function	0.0005 sec	0.0082%	1	0.0005 sec
override				
Cache load	0.0338 sec	0.5865%	4	0.0084 sec
class_abstraction				
Instantiating content class attribute	0.0133 sec	0.2314%	7	0.0019 sec
General				
dbfile	0.0571 sec	0.9926%	239	0.0002 sec
Total script time:	5.7556 sec	

My info is:
windows 2000
ez: 3.8.6 (3.8.6)
Apache/1.3.33 (Win32) PHP/4.4.4
eAccelerator 0.9.4
Athlon 2500+, 1Gb memory
mysql 4.1.16

plain_site_admin:
site.ini.append.php

....
[ContentSettings]
ViewCaching=enable
PreViewCache=enabled

[TemplateSettings]
Debug=enabled
NodeTreeCaching=enabled
TemplateCache=enable
TemplateCompile=enabled
TemplateOptimization=enabled
ShowXHTMLCode=enabled
ShowUsedTemplates=enabled

[OverrideSettings]
Cache=enabled

[SearchSettings]
DelayedIndexing=enabled
.....

php.ini:

max_execution_time = 100
memory_limit = 128M
max_input_time = 60

extension="eaccelerator.dll"
eaccelerator.shm_size="256"
eaccelerator.cache_dir="/tmp/eaccelerator"
eaccelerator.enable="1"
eaccelerator.optimizer="1"
eaccelerator.check_mtime="1"
eaccelerator.debug="0"
eaccelerator.filter=""
eaccelerator.shm_max="0"
eaccelerator.shm_ttl="0"
eaccelerator.shm_prune_period="0"
eaccelerator.shm_only="0"
eaccelerator.compress="1"
eaccelerator.compress_level="9"  

Thank you!

Łukasz Serwatka

Wednesday 06 December 2006 2:40:39 am

Hi,

Your template processing takes a lot of time ( 5.2881 sec ). I'm suspecting that you content tree it too big. You can reduce amount of item in content tree via INI file settings/contentstructuremenu.ini . Place overrided file in your admin siteaccess. Make also sure that permission to var folder are correct.

Personal website -> http://serwatka.net
Blog (about eZ Publish) -> http://serwatka.net/blog

Stan Cheredov

Wednesday 06 December 2006 3:12:47 am

Lukasz, thank you for you reply!

I found some part of a poblem: several week ago i installed "[eZjaxx] Ajax Admin" extension. It description say: "A Ajax / speed up extension for eZ Publish 3.8 / 3.9, more:" But it is slower! I uninstall it and now the refresh time page is 2-3 sec. Browse other page 4-5 sec. I have about 100-150 objects in the content tree. It is normal refresh time ?
I think if i enable all caches, refresh time must be less 1 sec. Why admin interface make more 146 SQL queries and a template processing time 2-5 sec if i enabled all caches ?

Łukasz Serwatka

Wednesday 06 December 2006 3:24:04 am

content/view/full/2 in admin usually takes around 12 SQL queries on cached site. How many queries do you have when content structure menu is collapsed?

You have also typo in

ViewCaching=enable
TemplateCache=enable

It should be ViewCaching=enabled and TemplateCache=enabled

Personal website -> http://serwatka.net
Blog (about eZ Publish) -> http://serwatka.net/blog

André R.

Wednesday 06 December 2006 3:41:54 am

Hi,

what version of eZjaxx did you use ?
And how big site is this ?

eZ Online Editor 5: http://projects.ez.no/ezoe || eZJSCore (Ajax): http://projects.ez.no/ezjscore || eZ Publish EE http://ez.no/eZPublish/eZ-Publish-Enterprise-Subscription
@: http://twitter.com/andrerom

Stan Cheredov

Wednesday 06 December 2006 3:53:56 am

<i>Lukasz Serwatka:</i>
How i wrote above, i have 146 SQL queries for a page refresh. And admin site access have:

 ViewCaching  	   siteaccess  	"enable"
 TemplateCache   siteaccess   "enable"

I copy this from "setting view" of plain_site_admin site access

When i collapse the content tree, number of SQL query is 35, and refresh time less 1 sec. Why content tree doesn't cached ?

I don't undestand parameter CachedViewPreferences, may be it is wrong ?

  	
 CachedViewPreferences  	 siteaccess
	
[full] admin_navigation_content=0; admin_navigation_details=0; admin_navigation_languages=0; admin_navigation_locations=0; admin_navigation_relations=0; admin_navigation_roles=0; admin_navigation_policies=0; admin_navigation_content=0; admin_navigation_translations=0; admin_children_viewmode=list; admin_list_limit=1; admin_edit_show_locations=0; admin_leftmenu_width=10; admin_url_list_limit=10; admin_url_view_limit=10; admin_section_list_limit=1; admin_orderlist_sortfield=user_name; admin_orderlist_sortorder=desc; admin_search_stats_limit=1; admin_treemenu=1; admin_bookmarkmenu=1; admin_left_menu_width=13

<i>André R.</i>
eZjaxx version is
"eZjaxx extension 0.3"
site have about 100-150 objects

André R.

Wednesday 06 December 2006 4:02:08 am

ok, yes 0.3 where quite experimental.
Somewhere around version 0.7 and 0.8 I did a lot of changes to that menu because of poor performance on some systems.

So if you could take a couple of minutes testing a newer version, that will probably help a lot!
And could you also post back with feedback about this?

eZ Online Editor 5: http://projects.ez.no/ezoe || eZJSCore (Ajax): http://projects.ez.no/ezjscore || eZ Publish EE http://ez.no/eZPublish/eZ-Publish-Enterprise-Subscription
@: http://twitter.com/andrerom

Stan Cheredov

Wednesday 06 December 2006 4:33:19 am

I download "eZjaxx extension 0.9" and inslall it.
With out it i have page refresh time about 4.7 sec, with it - 3.8 sec. But in std. content menu when i expand node - it is instanly, but with eZjaxx it proceed about 1-2 sec (node have only 2-3 objects! )

André R.

Wednesday 06 December 2006 5:32:58 am

Thats because ezjaxx is a ajax menu, elements not shown when you load the page is dynamicly loaded with ajax / xmlhttprequest in the background when you click expand (+).
Without it, every single node of the node tree is loaded on each page load, a really bad idea on large sites(really huge (x)html tree, and quite heavy on the database side to).

I / Paul or others willing to contribute will look into speeding up the expand function in the future. (by doing the sql calls directly with eZDB and avoid using the template system)

eZ Online Editor 5: http://projects.ez.no/ezoe || eZJSCore (Ajax): http://projects.ez.no/ezjscore || eZ Publish EE http://ez.no/eZPublish/eZ-Publish-Enterprise-Subscription
@: http://twitter.com/andrerom

André R.

Wednesday 06 December 2006 5:47:08 am

oh, and one other thing.
On production system this is more recommended settings:

[TemplateSettings]
Debug=disabled
TemplateCache=enabled
TemplateCompile=enabled
TemplateOptimization=enabled
ShowUsedTemplates=disabled
ShowXHTMLCode=disabled
DevelopmentMode=disabled
NodeTreeCaching=disabled

If I remember correctly NodeTreeCaching is unnecessary when you have template cache/compile on.

eZ Online Editor 5: http://projects.ez.no/ezoe || eZJSCore (Ajax): http://projects.ez.no/ezjscore || eZ Publish EE http://ez.no/eZPublish/eZ-Publish-Enterprise-Subscription
@: http://twitter.com/andrerom

Stan Cheredov

Wednesday 06 December 2006 6:42:07 am

Thank you, André R!

I try set

NodeTreeCaching=disabled

but a refresh speed not impoved.

But i transfered 60 nodes from main node to speshial folder, and now main node have only 10 nodes and i see a good speed up! Refresh page is 1-3 sec, and number sql queries decrease from 156 to 60. But i don't undestand why the content menu don't cached although i setup a full caching.

André R.

Wednesday 06 December 2006 8:05:00 am

The menu is cached by a cache block, so the next time you visit that node the menu will be loaded from cache.

Btw: CachedViewPreferences is not caching part of the layout if that is what your trying to do, I think it is for setting how preferences changes affects view cache.

Edit: have you remembered to change the settings Lukasz mentioned you had typos on ?

eZ Online Editor 5: http://projects.ez.no/ezoe || eZJSCore (Ajax): http://projects.ez.no/ezjscore || eZ Publish EE http://ez.no/eZPublish/eZ-Publish-Enterprise-Subscription
@: http://twitter.com/andrerom

eZ debug

Timing: Jan 18 2025 14:58:56
Script start
Timing: Jan 18 2025 14:58:56
Module start 'content'
Timing: Jan 18 2025 14:58:57
Module end 'content'
Timing: Jan 18 2025 14:58:57
Script end

Main resources:

Total runtime1.4849 sec
Peak memory usage4,096.0000 KB
Database Queries223

Timing points:

CheckpointStart (sec)Duration (sec)Memory at start (KB)Memory used (KB)
Script start 0.00000.0062 589.0547180.8125
Module start 'content' 0.00621.3370 769.8672719.0391
Module end 'content' 1.34310.1416 1,488.9063352.4141
Script end 1.4848  1,841.3203 

Time accumulators:

 Accumulator Duration (sec) Duration (%) Count Average (sec)
Ini load
Load cache0.00380.2540210.0002
Check MTime0.00140.0942210.0001
Mysql Total
Database connection0.00070.046710.0007
Mysqli_queries1.391993.74042230.0062
Looping result0.00210.13812210.0000
Template Total1.455198.020.7276
Template load0.00190.128220.0010
Template processing1.453297.870220.7266
Template load and register function0.00020.013910.0002
states
state_id_array0.00090.060310.0009
state_identifier_array0.00230.152120.0011
Override
Cache load0.00170.1169810.0000
Sytem overhead
Fetch class attribute can translate value0.00140.095940.0004
Fetch class attribute name0.00120.0835140.0001
XML
Image XML parsing0.00150.098440.0004
class_abstraction
Instantiating content class attribute0.00000.0022190.0000
General
dbfile0.00600.4072360.0002
String conversion0.00000.000330.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
12content/datatype/view/ezxmltext.tpl<No override>extension/community_design/design/suncana/templates/content/datatype/view/ezxmltext.tplEdit templateOverride template
24content/datatype/view/ezxmltags/paragraph.tpl<No override>extension/ezwebin/design/ezwebin/templates/content/datatype/view/ezxmltags/paragraph.tplEdit templateOverride template
7content/datatype/view/ezxmltags/literal.tpl<No override>extension/community/design/standard/templates/content/datatype/view/ezxmltags/literal.tplEdit templateOverride template
12content/datatype/view/ezxmltags/line.tpl<No override>design/standard/templates/content/datatype/view/ezxmltags/line.tplEdit templateOverride template
7content/datatype/view/ezimage.tpl<No override>extension/sevenx/design/simple/templates/content/datatype/view/ezimage.tplEdit templateOverride template
1pagelayout.tpl<No override>extension/sevenx/design/simple/templates/pagelayout.tplEdit templateOverride template
 Number of times templates used: 64
 Number of unique templates used: 7

Time used to render debug report: 0.0002 secs