More information about cache in debug output

Author Message

Eirik Alfstad Johansen

Wednesday 05 January 2011 5:42:26 am

Hi,

We have a site where the cache files of specific pages seem to expire without there being any logical reason for them to do so. However, debugging this issue is not an easy one as it requires me to know, for any given URI I visit:

* If there exists template cache files that will be used and, is so, for which templates

Is there any way to get more detailed information about the cache engine (specifically the template cache) and how it behaves within a given view? The info in eZ debug is pretty scarce, and I haven't managed to locate any INI settings which will allow me to get more details.

Thanks in advance !

Sincerely,

Eirik Alfstad Johansen
http://www.netmaking.no/

Nicolas Pastorino

Wednesday 05 January 2011 6:17:03 am

Hi Eirik !

Happy new year ;)

Have you tried enabling conditional debug output :

[DebugSettings]
ConditionDebug=enabled

[GeneralCondition]
kernel-content-view-cache=enabled
eztemplate-tree-cache=enabled

Let us know how things go,
Cheers,

--
Nicolas Pastorino
Director Community - eZ
Member of the Community Project Board

eZ Publish Community on twitter: http://twitter.com/ezcommunity

t : http://twitter.com/jeanvoye
G+ : http://plus.tl/jeanvoye

Eirik Alfstad Johansen

Wednesday 05 January 2011 7:06:52 am

Hi Nicolas, and a happy new year to you as well!

I tried this, but I'm not sure what to look for. How will this setting affect the debug output?

I took a look at the docs, but they weren't all that helpful in this regard.

Sincerely,

Eirik Alfstad Johansen
http://www.netmaking.no/

Nicolas Pastorino

Wednesday 05 January 2011 9:14:51 am

Hei igjen,

Through an example : with

kernel-content-view-cache=enabled

and the main Conditional Debug switch enabled, all lines like :

eZDebugSetting::writeDebug( 'kernel-content-view-cache', 'cache expired #1' );

will output something in the main DebugOutput ('cache expired #1' in this case), in a block having a title containing 'kernel-content-view-cache', easily searchable in a browser.

Scanning the default debug.ini, i only found the two debug-conditions pasted earlier potentially matching your needs. However, i do not know for sure that conditional debug statements are located in relevant places for your issue.

Cheers !

--
Nicolas Pastorino
Director Community - eZ
Member of the Community Project Board

eZ Publish Community on twitter: http://twitter.com/ezcommunity

t : http://twitter.com/jeanvoye
G+ : http://plus.tl/jeanvoye

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 30 2025 21:41:04
Script start
Timing: Jan 30 2025 21:41:04
Module start 'layout'
Timing: Jan 30 2025 21:41:04
Module start 'content'
Timing: Jan 30 2025 21:41:05
Module end 'content'
Timing: Jan 30 2025 21:41:05
Script end

Main resources:

Total runtime1.1231 sec
Peak memory usage8,192.0000 KB
Database Queries61

Timing points:

CheckpointStart (sec)Duration (sec)Memory at start (KB)Memory used (KB)
Script start 0.00000.0058 588.2656151.2266
Module start 'layout' 0.00580.0035 739.4922220.7266
Module start 'content' 0.00931.1130 960.21884,469.1094
Module end 'content' 1.12230.0007 5,429.328115.8125
Script end 1.1230  5,445.1406 

Time accumulators:

 Accumulator Duration (sec) Duration (%) Count Average (sec)
Ini load
Load cache0.00340.3055160.0002
Check MTime0.00120.1099160.0001
Mysql Total
Database connection0.00090.076410.0009
Mysqli_queries1.027691.5018610.0168
Looping result0.00070.0650590.0000
Template Total1.067995.120.5340
Template load0.00210.184920.0010
Template processing1.065894.902520.5329
Template load and register function0.00130.119910.0013
states
state_id_array0.00110.101610.0011
state_identifier_array0.00110.097620.0005
Override
Cache load0.00180.1591330.0001
Sytem overhead
Fetch class attribute can translate value0.00270.239420.0013
Fetch class attribute name0.00230.204960.0004
XML
Image XML parsing0.00110.098320.0006
class_abstraction
Instantiating content class attribute0.00000.001880.0000
General
dbfile0.00170.1482220.0001
String conversion0.00000.000740.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
8content/datatype/view/ezxmltags/paragraph.tpl<No override>extension/ezwebin/design/ezwebin/templates/content/datatype/view/ezxmltags/paragraph.tplEdit templateOverride template
3content/datatype/view/ezxmltags/literal.tpl<No override>extension/community/design/standard/templates/content/datatype/view/ezxmltags/literal.tplEdit templateOverride template
1content/datatype/view/ezxmltags/line.tpl<No override>design/standard/templates/content/datatype/view/ezxmltags/line.tplEdit templateOverride template
1content/datatype/view/ezxmltags/link.tpl<No override>design/standard/templates/content/datatype/view/ezxmltags/link.tplEdit templateOverride template
1print_pagelayout.tpl<No override>extension/community/design/community/templates/print_pagelayout.tplEdit templateOverride template
 Number of times templates used: 23
 Number of unique templates used: 8

Time used to render debug report: 0.0001 secs