ExpressionEngine CMS
Open, Free, Amazing

Thread

This is an archived forum and the content is probably no longer relevant, but is provided here for posterity.

The active forums are here.

Site slowness, debug results...any indication of why?

November 02, 2010 4:01pm

Subscribe [3]
  • #1 / Nov 02, 2010 4:01pm

    Doug E

    98 posts

    The page can load in a third of the time, but there are still a few spots that take a good % of the time. Namely the parsing PHP on Output.

    Anything else here that looks odd?

    TEMPLATE DEBUGGING
    (0.000015) - Begin Template Processing -
    (0.000219) URI: /fmf-admin/ministry-accounts/pay-request/
    (0.000231) Path.php Template: ma/payrequest
    (0.000248) Retrieving Template
    (0.000268) Retrieving Template from Database: ma/payrequest
    (0.001585) Template Found
    (0.001598) Determining Template Access Privileges
    (0.005545) Retrieving Template from File
    (0.020526) Template Type: webpage
    (0.021431) Parsing Site Variables
    (0.021471) Global Path.php Variables (Keys): current_page|secure_site_url|site_id|site_label|site_short_name
    (0.021484) Global Path.php Variables (Values): /fmf-admin/ministry-accounts/pay-request/|https://www.frontiermissionfellowship.org/|1|FMF|default_site
    (0.022556) Parse Date Format String Constants
    (0.022704) Parse Current Time Variables
    (0.023011) Parsing Segment, Embed, and Global Vars Conditionals
    (0.024250) Processing Assigned Variables: structure_path|error_path|enter_es_amts|audit_es_amts
    (0.025611) - Beginning Tag Processing -
    (0.025631) Parsing Tags in Template
    (0.025657) Tag: {exp:lockdown}
    (0.025782) No Closing Tag
    (0.026015) Tag: {exp:member:custom_profile_data}
    (0.026089) Closing Tag Found
    (0.026330) Tag: {exp:member:custom_profile_data}
    (0.026377) Closing Tag Found
    (0.026610) Tag: {exp:structure:nav_sub start_from="/fmf-admin/ministry-accounts" limit_depth="1" include_ul="yes" css_class="sec-nav"}
    (0.026739) No Closing Tag
    (0.026881) Processing Tags
    (0.026909) Plugin Tag: Lockdown/lockdown
    (0.026924) Module Tag: Member/custom_profile_data
    (0.026937) Module Tag: Member/custom_profile_data
    (0.026951) Module Tag: Structure/nav_sub
    (0.026966) Including Files for Tag and Modules
    (0.044234) Beginning Final Tag Data Processing
    (0.044269) Calling Class/Method: Lockdown/lockdown
    (0.044375) -> Class Called: Lockdown
    (0.044399) -> Method Called: lockdown
    (0.044412) -> Data Returned
    (0.044580) Calling Class/Method: Member/custom_profile_data
    (0.044689) -> Class Called: Member
    (0.046556) -> Method Called: custom_profile_data
    (0.057988) -> Data Returned
    (0.058217) Calling Class/Method: Member/custom_profile_data
    (0.058319) -> Class Called: Member
    (0.058444) -> Method Called: custom_profile_data
    (0.063961) -> Data Returned
    (0.064131) Calling Class/Method: Structure/nav_sub
    (0.064207) -> Class Called: Structure
    (0.064249) -> Method Called: nav_sub
    (0.092567) -> Data Returned
    (0.092856) - End Tag Processing -
    (0.093121) Parsing PHP on Output
    (0.338040) Processing Advanced Conditionals
    (0.338750) - Processing Sub Templates (Depth: 1) -
    (0.338795)    List of Embeds: embeds/.html-header my_title=Ministry Accounts,embeds/.page-header,embeds/.structure_breadcrumb,embeds/.page-footer,embeds/google_analytics
    (0.338914)    Processing Sub Template: embeds/.html-header
    (0.338945)    Retrieving Template
    (0.338972)    Retrieving Template from Database: embeds/.html-header
    (0.345878)    Template Found
    (0.345958)    Retrieving Template from File
    (0.346324)    Template Type: webpage
    (0.346442)    Embed Variables (Keys): my_title
    (0.346456)    Embed Variables (Values): Ministry Accounts
    (0.346502)    Parsing Site Variables
    (0.346539)    Global Path.php Variables (Keys): current_page|secure_site_url|site_id|site_label|site_short_name
    (0.346553)    Global Path.php Variables (Values): /fmf-admin/ministry-accounts/pay-request/|https://www.frontiermissionfellowship.org/|1|FMF|default_site
    (0.346622)    Parse Date Format String Constants
    (0.346645)    Parse Current Time Variables
    (0.346679)    Parsing Segment, Embed, and Global Vars Conditionals
    (0.347170)    - Beginning Tag Processing -
    (0.347188)    - End Tag Processing -
    (0.347225)    Processing Advanced Conditionals
    (0.347917)    Processing Sub Template: embeds/.page-header
    (0.347942)    Retrieving Template
    (0.347960)    Retrieving Template from Database: embeds/.page-header
    (0.349226)    Template Found
    (0.349303)    Retrieving Template from File
    (0.350707)    Template Type: webpage
    (0.350915)    Parsing Site Variables
    (0.350955)    Global Path.php Variables (Keys): current_page|secure_site_url|site_id|site_label|site_short_name
    (0.350971)    Global Path.php Variables (Values): /fmf-admin/ministry-accounts/pay-request/|https://www.frontiermissionfellowship.org/|1|FMF|default_site
    (0.351114)    Parse Date Format String Constants
    (0.351148)    Parse Current Time Variables
    (0.351222)    Parsing Segment, Embed, and Global Vars Conditionals
    (0.352073)    - Beginning Tag Processing -
    (0.352127)    Parsing Tags in Template
    (0.352155)    Tag: {exp:member:custom_profile_data}
    (0.352222)    Closing Tag Found
    (0.352306)    Tag: {exp:structure:nav_full css_class="main_nav" status="Open"}
    (0.352393)    No Closing Tag
    (0.352449)    Tag: {exp:structure:nav_full css_class="main_nav" status="Open|MA_Only"}
    (0.352528)    No Closing Tag
    (0.352587)    Tag: {exp:member:login_form action="https://www.frontiermissionfellowship.org/" return="/fmf-admin/ministry-accounts/pay-request/"}
    (0.352695)    Closing Tag Found
    (0.352755)    Processing Tags
    (0.352791)    Module Tag: Member/custom_profile_data
    (0.352812)    Module Tag: Structure/nav_full
    (0.352828)    Module Tag: Structure/nav_full
    (0.352843)    Module Tag: Member/login_form
    (0.352860)    Including Files for Tag and Modules
    (0.352879)    Beginning Final Tag Data Processing
    (0.352894)    Calling Class/Method: Member/custom_profile_data
    (0.353016)    -> Class Called: Member
    (0.353181)    -> Method Called: custom_profile_data
    (0.359308)    -> Data Returned
    (0.359376)    Calling Class/Method: Structure/nav_full
    (0.359476)    -> Class Called: Structure
    (0.359530)    -> Method Called: nav_full
    (0.458575)    -> Data Returned
    —continued next post—

  • #2 / Nov 02, 2010 4:12pm

    Doug E

    98 posts

    (0.458575)    -> Data Returned
    (0.458650)    Calling Class/Method: Structure/nav_full
    (0.458765)    -> Class Called: Structure
    (0.458816)    -> Method Called: nav_full
    (0.538108)    -> Data Returned
    (0.538235)    Calling Class/Method: Member/login_form
    (0.538404)    -> Class Called: Member
    (0.538576)    -> Method Called: login_form
    (0.538775)    -> Data Returned
    (0.538878)    - End Tag Processing -
    (0.538935)    Parsing PHP on Output
    (0.540039)    Processing Advanced Conditionals
    (0.542956)    - Processing Sub Templates (Depth: 2) -
    (0.542980)        List of Embeds: search/.search-basic
    (0.543044)        Processing Sub Template: search/.search-basic
    (0.543069)        Retrieving Template
    (0.543092)        Retrieving Template from Database: search/.search-basic
    (0.548193)        Template Found
    (0.548287)        Retrieving Template from File
    (0.548494)        Template Type: webpage
    (0.548611)        Parsing Site Variables
    (0.548653)        Global Path.php Variables (Keys): current_page|secure_site_url|site_id|site_label|site_short_name
    (0.548687)        Global Path.php Variables (Values): /fmf-admin/ministry-accounts/pay-request/|https://www.frontiermissionfellowship.org/|1|FMF|default_site
    (0.548739)        Parse Date Format String Constants
    (0.548762)        Parse Current Time Variables
    (0.548805)        Parsing Segment, Embed, and Global Vars Conditionals
    (0.548861)        - Beginning Tag Processing -
    (0.548910)        Parsing Tags in Template
    (0.548941)        Tag: {exp:search:simple_form result_page="search/results" search_in="entries" weblog="not member_directory"}
    (0.549070)        Closing Tag Found
    (0.549142)        Processing Tags
    (0.549182)        Module Tag: Search/simple_form
    (0.549198)        Including Files for Tag and Modules
    (0.553882)        Beginning Final Tag Data Processing
    (0.553909)        Calling Class/Method: Search/simple_form
    (0.554053)        -> Class Called: Search
    (0.554079)        -> Method Called: simple_form
    (0.554259)        -> Data Returned
    (0.554294)        - End Tag Processing -
    (0.554451)    Processing Sub Template: embeds/.structure_breadcrumb
    (0.554474)    Retrieving Template
    (0.554495)    Retrieving Template from Database: embeds/.structure_breadcrumb
    (0.557612)    Template Found
    (0.557684)    Retrieving Template from File
    (0.557860)    Template Type: webpage
    (0.557966)    Parsing Site Variables
    (0.558008)    Global Path.php Variables (Keys): current_page|secure_site_url|site_id|site_label|site_short_name
    (0.558026)    Global Path.php Variables (Values): /fmf-admin/ministry-accounts/pay-request/|https://www.frontiermissionfellowship.org/|1|FMF|default_site
    (0.558075)    Parse Date Format String Constants
    (0.558096)    Parse Current Time Variables
    (0.558122)    Parsing Segment, Embed, and Global Vars Conditionals
    (0.558171)    - Beginning Tag Processing -
    (0.558194)    Parsing Tags in Template
    (0.558224)    Tag: {exp:structure:breadcrumb here_as_title="yes"}
    (0.558316)    No Closing Tag
    (0.558369)    Processing Tags
    (0.558401)    Module Tag: Structure/breadcrumb
    (0.558418)    Including Files for Tag and Modules
    (0.558436)    Beginning Final Tag Data Processing
    (0.558452)    Calling Class/Method: Structure/breadcrumb
    (0.558537)    -> Class Called: Structure
    (0.558593)    -> Method Called: breadcrumb
    (0.560596)    -> Data Returned
    (0.560638)    - End Tag Processing -
    (0.560765)    Processing Sub Template: embeds/.page-footer
    (0.560794)    Retrieving Template
    (0.560813)    Retrieving Template from Database: embeds/.page-footer
    (0.570597)    Template Found
    (0.570674)    Retrieving Template from File
    (0.571045)    Template Type: webpage
    (0.571160)    Parsing Site Variables
    (0.571198)    Global Path.php Variables (Keys): current_page|secure_site_url|site_id|site_label|site_short_name
    (0.571213)    Global Path.php Variables (Values): /fmf-admin/ministry-accounts/pay-request/|https://www.frontiermissionfellowship.org/|1|FMF|default_site
    (0.571278)    Parse Date Format String Constants
    (0.571299)    Parse Current Time Variables
    (0.571335)    Parsing Segment, Embed, and Global Vars Conditionals
    (0.571536)    - Beginning Tag Processing -
    (0.571558)    Parsing Tags in Template
    (0.571582)    Tag: {exp:tag:cloud step="3" limit="25"}
    (0.571663)    Closing Tag Found
    (0.571727)    Tag: {exp:weblog:entries weblog="blog-leadership|blog-general|prayer|ministry-updates" limit="15" dynamic="off"}
    (0.571827)    Closing Tag Found
    (0.571874)    Processing Tags
    (0.571898)    Module Tag: Tag/cloud
    (0.571916)    Module Tag: Weblog/entries
    (0.571931)    Including Files for Tag and Modules
    (0.646695)    Beginning Final Tag Data Processing
    (0.646732)    Calling Class/Method: Tag/cloud
    (0.646940)    -> Class Called: Tag
    (0.699517)    -> Method Called: cloud
    (0.725835)    -> Data Returned
    (0.725897)    Calling Class/Method: Weblog/entries
    (0.726125)    -> Class Called: Weblog
    (0.726186)    -> Method Called: entries
    (0.757485)    Calling Extension Class/Method: Fieldframe/weblog_entries_tagdata
    (0.783002)    Calling Extension Class/Method: Mh_file_ext/modify_template
    (0.808377)    Calling Extension Class/Method: Fieldframe/weblog_entries_tagdata
    (0.809216)    Calling Extension Class/Method: Mh_file_ext/modify_template
    (0.817591)    Calling Extension Class/Method: Fieldframe/weblog_entries_tagdata
    (0.818262)    Calling Extension Class/Method: Mh_file_ext/modify_template
    (0.826516)    Calling Extension Class/Method: Fieldframe/weblog_entries_tagdata
    (0.827167)    Calling Extension Class/Method: Mh_file_ext/modify_template
    (1.002542)    Calling Extension Class/Method: Fieldframe/weblog_entries_tagdata
    (1.003275)    Calling Extension Class/Method: Mh_file_ext/modify_template
    —continued….again—-

  • #3 / Nov 02, 2010 4:13pm

    Doug E

    98 posts

    (1.003275)    Calling Extension Class/Method: Mh_file_ext/modify_template
    (1.216698)    Calling Extension Class/Method: Fieldframe/weblog_entries_tagdata
    (1.217454)    Calling Extension Class/Method: Mh_file_ext/modify_template
    (1.344219)    Calling Extension Class/Method: Fieldframe/weblog_entries_tagdata
    (1.393846)    Calling Extension Class/Method: Mh_file_ext/modify_template
    (1.438810)    Calling Extension Class/Method: Fieldframe/weblog_entries_tagdata
    (1.439601)    Calling Extension Class/Method: Mh_file_ext/modify_template
    (1.562743)    Calling Extension Class/Method: Fieldframe/weblog_entries_tagdata
    (1.563541)    Calling Extension Class/Method: Mh_file_ext/modify_template
    (1.646320)    Calling Extension Class/Method: Fieldframe/weblog_entries_tagdata
    (1.647114)    Calling Extension Class/Method: Mh_file_ext/modify_template
    (1.654961)    Calling Extension Class/Method: Fieldframe/weblog_entries_tagdata
    (1.655651)    Calling Extension Class/Method: Mh_file_ext/modify_template
    (1.751638)    Calling Extension Class/Method: Fieldframe/weblog_entries_tagdata
    (1.752505)    Calling Extension Class/Method: Mh_file_ext/modify_template
    (1.761819)    Calling Extension Class/Method: Fieldframe/weblog_entries_tagdata
    (1.762516)    Calling Extension Class/Method: Mh_file_ext/modify_template
    (1.773916)    Calling Extension Class/Method: Fieldframe/weblog_entries_tagdata
    (1.774617)    Calling Extension Class/Method: Mh_file_ext/modify_template
    (1.782344)    Calling Extension Class/Method: Fieldframe/weblog_entries_tagdata
    (1.783159)    Calling Extension Class/Method: Mh_file_ext/modify_template
    (1.790059)    -> Data Returned
    (1.791835)    - End Tag Processing -
    (1.791940)    Processing Advanced Conditionals
    (1.793357)    Processing Sub Template: embeds/google_analytics
    (1.793388)    Retrieving Template
    (1.793413)    Retrieving Template from Database: embeds/google_analytics
    (1.796453)    Template Found
    (1.796614)    Template Type: webpage
    (1.796715)    Parsing Site Variables
    (1.796754)    Global Path.php Variables (Keys): current_page|secure_site_url|site_id|site_label|site_short_name
    (1.796774)    Global Path.php Variables (Values): /fmf-admin/ministry-accounts/pay-request/|https://www.frontiermissionfellowship.org/|1|FMF|default_site
    (1.796822)    Parse Date Format String Constants
    (1.796842)    Parse Current Time Variables
    (1.796865)    Parsing Segment, Embed, and Global Vars Conditionals
    (1.796915)    - Beginning Tag Processing -
    (1.796927)    - End Tag Processing -
    (1.839143) - End Template Processing -
    (1.839189) Parse Global Variables
    (1.848326) Template Parsing Finished
    Memory Usage: 18,605,600 bytes

  • #4 / Nov 03, 2010 10:18am

    Sue Crocker

    26054 posts

    Hi, Doug.

    See:

    {exp:weblog:entries weblog=“blog-leadership|blog-general|prayer|ministry-updates” limit=“15” dynamic=“off”}

    You should be using disable parameters to help, if nothing else disabling trackbacks.

    How about putting your Google Analytics in a global variable instead of using an embed?

    You also appear to be using File and Structure. File I know can be memory hungry.. how much memory do you have allocated to PHP?


    Have you seen: EEWiki:// HowTo Determine Memory Limits

    -and-

    EEWiki:// HowTo Override Memory Limitations

  • #5 / Nov 03, 2010 3:26pm

    Doug E

    98 posts

    Thanks for the help. I had an embed that I had not optimized (ie disable parameters). I also didn’t realize FIle was being called, I don’t use it. Disabled it and that seems to have helped. I then added my GA as a global variable. I like that better, faster too it seems.

    I’ve got 128M for PHP.

    After all those changes I was able to drop the debug output from ~1200 lines to ~300. Processing time dropped in half as well. Thanks!

  • #6 / Nov 03, 2010 3:44pm

    Ingmar

    29245 posts

    Sounds good. Please post again if you require further assistance.

.(JavaScript must be enabled to view this email address)

ExpressionEngine News!

#eecms, #events, #releases