Pages load slowely

[mogge]

Hi all,

I´ve installed CMS Made Simple on a restaurants website to make it easy for the owners to update their menus. The problem is that the CMS-pages loads extremely slow while the other pages loads fast and easy. Any ideas why? And how to solve this?

[Wishbone]

It's likely that your hosting company's database (or network to the database) has performance issues. Put your CMSms install into debug mode, look at the output, and you can see what the hangup is.

What hosting company do you use? If the answer is GoDaddy, then that's your answer.

[mogge]

The site is located at a swedish hosting companys server.
I´ve put it into debug mode right now... But where can I see the result? Is there a log or something like that?

[Wishbone]

It should place the debug info underneath the site.. Scroll down. It will show you each step of what it's doing, which database calls, and the time index (in seconds) of each operation.

[mogge]

I think I´ve found it...

Is it this:

Debug: (2.9000000000001E-5) - (677560)
loading smarty
Debug: (0.00612) - (999720)
loading adodb
Debug: (0.008907) - (1100488)
loading page functions
Debug: (0.013686) - (1314976)
loading content functions
Debug: (0.017629) - (1550352)
loading pageinfo functions
Debug: (0.019005) - (1588736)
loading translation functions
Debug: (0.019953) - (1609192)
loading events functions
Debug: (0.022133) - (1710064)
loading php4 entity decode functions
Debug: (0.025671) - (1960392)
done loading files
Debug: (4.547205) - (2749936)

(mysql): SET NAMES 'utf8'
Error (0):
Debug: (4.549906) - (2769984)

(mysql): SELECT sitepref_name, sitepref_value from cms_siteprefs
Error (0):
Debug: (4.558203) - (2865264)

(mysql): SELECT * FROM cms_userplugins
Error (0):
Debug: (4.609363) - (3583896)

(mysql): SELECT * FROM cms_modules WHERE active = 1 ORDER by module_name
Error (0):
Debug display of 'End of include':(4.641203) - (5415768)
Debug: (4.641347) - (5358944)
Session found.  Moving on...
Debug: (4.650198) - (5881160)
Session found.  Moving on...
Debug: (4.651729) - (5887640)

(mysql): SELECT preference, value FROM cms_userprefs WHERE user_id = '1'
Error (0):
Debug: (4.651938) - (5885152)
Session found.  Moving on...
Debug: (4.660756) - (6106128)

(mysql): SELECT ug.user_id FROM cms_user_groups ug
                    WHERE ug.user_id = '1' AND ug.group_id = 1
Error (0):
Debug: (4.662402) - (6108584)

(mysql): SELECT DISTINCT permission_name FROM cms_user_groups ug INNER JOIN cms_group_perms gp ON gp.group_id = ug.group_id INNER JOIN cms_permissions p ON p.permission_id = gp.permission_id INNER JOIN cms_groups gr ON gr.group_id = ug.group_id WHERE ug.user_id = '1' AND gr.active = 1
Error (0):
Debug: (4.710116) - (6424872)

(mysql): SELECT htmlblob_id FROM cms_additional_htmlblob_users WHERE user_id = '1'
Error (0):
Debug: (4.711193) - (6426032)

(mysql): SELECT group_id FROM cms_user_groups WHERE user_id = '1'
Error (0):
Debug: (4.71175) - (6426176)

(mysql): SELECT htmlblob_id FROM cms_additional_htmlblob_users WHERE user_id IN (-1)
Error (0):
Debug: (4.712321) - (6426240)

(mysql): SELECT content_id FROM cms_content WHERE owner_id = '1'
Error (0):
Debug: (4.712836) - (6426352)

(mysql): SELECT user_id,content_id FROM cms_additional_users
Error (0):
Debug: (4.718658) - (6503384)

(mysql): SELECT count(news_id) FROM cms_module_news n
                  WHERE status != 'published'
                    AND (( IFNULL(end_time, '1970-01-01 01:00:01')  = '1970-01-01 01:00:01') OR (end_time > '2010-01-14 23:15:33'))
Error (0):
Debug: (4.719818) - (6502840)

(mysql): SELECT version from cms_version
Error (0):
Debug: (4.722578) - (6541144)

(mysql): SELECT bookmark_id, user_id, title, url FROM cms_admin_bookmarks WHERE user_id = '1' ORDER BY title
Error (0):
Debug: (4.723269) - (6487528)

(mysql): SELECT bookmark_id, user_id, title, url FROM cms_admin_bookmarks WHERE user_id = '1' ORDER BY title
Error (0):

[Wishbone]

My issues with slowness was due to mysql latency.. This doesn't seem to be your issue.. It took 4.5 seconds to be "done loading files".. The rest of the time (with all the database calls) only took 0.2 seconds, which is good.

I'm not sure what "loading files" is.. Maybe PHP includes? If so, it might be a overworked server, a slow file system, low memory, etc. Once everything was loaded, it executed rather fast.