3.3-1 slowdown: looks like caching does not work

Author Message

Yaroslav Markin

Friday 02 January 2004 9:00:10 am

When i used to run 3.2-branch, all was ok.

Page generation time is about 8sec now, debug says:

Mysql_queries 0.0035 sec 0.0426% 6 0.0006 sec
Template Total 7.6155 sec 93.3% 1 7.6155 sec
Template load 0.0276 sec 0.3388% 1 0.0276 sec
Template processing 7.5875 sec 93.0025% 1 7.5875 sec
Template load and register function 0.0084 sec 0.1033% 5 0.0017 sec
String conversion in template resource 0.0192 sec 0.2359% 5 0.0038 sec
Template parser: create text elements 0.0541 sec 0.6629% 5 0.0108 sec
Template parser: remove whitespace 0.0020 sec 0.0245% 5 0.0004 sec
Template parser: construct tree 0.0443 sec 0.5426% 5 0.0089 sec
override
Cache load 0.0301 sec 0.3694% 7 0.0043 sec
TS translator
TS init 7.2947 sec 89.4137% 1 7.2947 sec
TS load 6.6530 sec 81.5478% 1 6.6530 sec
TS store cache 0.5642 sec 6.9161% 1 0.5642 sec
Total script time: 8.1584 sec

Why template processing time is so high?

PS I am running WinXP, Apache 1.3.28+mod_php

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 19 2025 04:16:24
Script start
Timing: Jan 19 2025 04:16:24
Module start 'layout'
Timing: Jan 19 2025 04:16:24
Module start 'content'
Timing: Jan 19 2025 04:16:24
Module end 'content'
Timing: Jan 19 2025 04:16:24
Script end

Main resources:

Total runtime0.0133 sec
Peak memory usage2,048.0000 KB
Database Queries3

Timing points:

CheckpointStart (sec)Duration (sec)Memory at start (KB)Memory used (KB)
Script start 0.00000.0050 589.4063152.6563
Module start 'layout' 0.00500.0029 742.062539.5078
Module start 'content' 0.00790.0035 781.570385.2891
Module end 'content' 0.01130.0019 866.859430.3047
Script end 0.0132  897.1641 

Time accumulators:

 Accumulator Duration (sec) Duration (%) Count Average (sec)
Ini load
Load cache0.002317.1945140.0002
Check MTime0.00118.0174140.0001
Mysql Total
Database connection0.00085.812910.0008
Mysqli_queries0.002619.951930.0009
Looping result0.00000.075410.0000
Template Total0.001511.310.0015
Template load0.00085.933110.0008
Template processing0.00075.308410.0007
Override
Cache load0.00053.696310.0005
General
dbfile0.00021.438080.0000
String conversion0.00000.044940.0000
Note: percentages do not add up to 100% because some accumulators overlap

Templates used to render the page:

UsageRequested templateTemplateTemplate loadedEditOverride
1print_pagelayout.tpl<No override>extension/community/design/community/templates/print_pagelayout.tplEdit templateOverride template
 Number of times templates used: 1
 Number of unique templates used: 1

Time used to render debug report: 0.0001 secs