Installs ok but errors and crashing of app

[NiallH]

Hi,

The install of 4.0 went fine. But when I create a user and then try to relogin as that new user the application fails and I just get the "page cannot be displayed" error after clicking the login button.

Any ideas? How can I find the cause of the error?

[phpsam]

I have the same problem. I'm using Firefox 1.5. and server running on Fedora 4 with SugarCRM 4.0.0. it just show me a blank screen when i try to login after the first logout from the application. Installation and first time login is going well. I just can't login anymore even using admin and a new created use id.

Anyone Any Idea?

Your advice is highly appreciate.

Regards,
Sam Tan

[jmaxwell]

For anybody to help we need:

OS and version the Server is on.

php version

MySql version.

Have you reviewed the documentation?

http://www.sugarcrm.com/crm/documentation.html

[phpsam]

Thanks jmaxwell.

By the way, my OS is Fedora 4 with kernel 2.6.15, Mysql 4.1.16 and php 5.0.5

My SugarCRM 4.0.0 is fresh install.

Anyone any idea why only the first time login work perfectly and can't login again after the logout even restart the server and client.

Regards,
Sam Tan

Btw.... sugarcrm.log doesn't show any message.

[andrewb]

modify you log4php.properties file which is located in sugar root
//log4php.rootLogger=fatal, A2
//log4php.rootLogger=error, A2
//log4php.rootLogger=info, A2
log4php.rootLogger=debug, A2

so you need to uncomment the debug line. Reproduce the bug and post your sugarcrm.log file here. Do not forget to delete you password out of it.

[phpsam]

Here is the sugarcrm.log

<--------------Start of Log File ---------------------->
Tue Jan 10 23:46:51 2006,080 [3335] INFO SugarCRM - Query Execution Time:0.002966
Tue Jan 10 23:46:51 2006,084 [3335] DEBUG SugarCRM - including headers
Tue Jan 10 23:46:51 2006,421 [3335] INFO SugarCRM - Query:SELECT category, name, value FROM config WHERE category='MySettings
'
Tue Jan 10 23:46:51 2006,425 [3335] INFO SugarCRM - Query Execution Time:0.002535
Tue Jan 10 23:46:51 2006,489 [3335] INFO SugarCRM - Query:SELECT count(*) AS num FROM roles_users WHERE user_id='' AND delete
d=0
Tue Jan 10 23:46:51 2006,494 [3335] INFO SugarCRM - Query Execution Time:0.002431
Tue Jan 10 23:46:51 2006,542 [3335] INFO SugarCRM - Query:SELECT placement,name,id,url from iframes WHERE deleted=0 AND statu
s=1 AND (placement='tab' OR placement='all') AND (type='global' OR (type='personal' AND created_by='')) ORDER BY iframes.name
Tue Jan 10 23:46:51 2006,547 [3335] INFO SugarCRM - Query Execution Time:0.0023409999999999
Tue Jan 10 23:46:51 2006,595 [3335] DEBUG SugarCRM - get_user_array query: SELECT id, first_name, last_name, user_name from u
sers WHERE is_group=0 order by user_name asc
Tue Jan 10 23:46:51 2006,597 [3335] INFO SugarCRM - Query:SELECT id, first_name, last_name, user_name from users WHERE is_gro
up=0 order by user_name asc
Tue Jan 10 23:46:51 2006,658 [3335] INFO SugarCRM - Query Execution Time:0.059568
Tue Jan 10 23:47:37 2006,316 [3335] INFO SugarCRM - Query:SELECT category, name, value FROM config WHERE category='system'
Tue Jan 10 23:47:37 2006,321 [3335] INFO SugarCRM - Connect:Resource id #154
Tue Jan 10 23:47:37 2006,350 [3335] INFO SugarCRM - Query Execution Time:0.002578
Tue Jan 10 23:47:37 2006,352 [3335] DEBUG SugarCRM - ****Starting for session rjq8m05i8at83h7qmuq1upq651
Tue Jan 10 23:47:37 2006,353 [3335] DEBUG SugarCRM - We are authenticating user now
Tue Jan 10 23:47:37 2006,354 [3335] DEBUG SugarCRM - array (
'gmto' => '-480',
'module' => 'Users',
'action' => 'Authenticate',
'return_module' => 'Users',
'return_action' => 'Login',
'login_module' => '',
'login_action' => '',
'login_record' => '',
'user_name' => 'admin',
'user_password' => '',
'Login' => ' Login ',
'login_theme' => 'Sugar',
'login_language' => 'en_us',
'ck_login_language_20' => 'en_us',
'ck_login_theme_20' => 'Sugar',
'ck_login_id_20' => '1',
'showLeftCol' => 'true',
'PHPSESSID' => 'rjq8m05i8at83h7qmuq1upq651',
)
Tue Jan 10 23:47:37 2006,356 [3335] INFO SugarCRM - About to take action Authenticate
Tue Jan 10 23:47:37 2006,357 [3335] DEBUG SugarCRM - in Authenticate
Tue Jan 10 23:47:37 2006,359 [3335] INFO SugarCRM - current page is modules/Users/Authenticate.php
Tue Jan 10 23:47:37 2006,360 [3335] INFO SugarCRM - current module is Users
Tue Jan 10 23:47:37 2006,369 [3335] INFO SugarCRM - Query:SELECT count(*) as the_count FROM config WHERE category='info' AND
name='sugar_version' AND value = '4.0.0'
Tue Jan 10 23:47:37 2006,377 [3335] INFO SugarCRM - Query Execution Time:0.002422
Tue Jan 10 23:47:37 2006,380 [3335] DEBUG SugarCRM - Current theme is: Sugar
Tue Jan 10 23:47:37 2006,383 [3335] DEBUG SugarCRM - current_language is: en_us
Tue Jan 10 23:47:37 2006,419 [3335] INFO SugarCRM - Query:
SELECT meetings.id, name,reminder_time, description,location, date_start, time_start,
CONCAT( date_start, CONCAT(' ', time_start ) ) AS dateTime
FROM meetings LEFT JOIN meetings_users ON meetings.id = meetings_users.meeting_id
WHERE meetings_users.user_id =''
AND meetings.reminder_time != -1
AND meetings_users.deleted != 1
HAVING dateTime >= '2006-01-10 15:47:37' AND dateTime <= '2006-01-10 16:47:37'
Tue Jan 10 23:47:37 2006,425 [3335] INFO SugarCRM - Query Execution Time:0.002626
Tue Jan 10 23:47:37 2006,427 [3335] INFO SugarCRM - Query:
SELECT calls.id, name, reminder_time, description, date_start, time_start,
CONCAT( date_start, CONCAT(' ', time_start) ) AS dateTime
FROM calls LEFT JOIN calls_users ON calls.id = calls_users.call_id
WHERE calls_users.user_id =''
AND calls.reminder_time != -1
AND calls_users.deleted != 1
HAVING dateTime >= '2006-01-10 15:47:37' AND dateTime <= '2006-01-10 16:47:37'
Tue Jan 10 23:47:37 2006,433 [3335] INFO SugarCRM - Query Execution Time:0.003891
Tue Jan 10 23:47:37 2006,446 [3335] INFO SugarCRM - Query:SELECT category, name, value FROM config WHERE category='license'
Tue Jan 10 23:47:37 2006,451 [3335] INFO SugarCRM - Query Execution Time:0.002495
Tue Jan 10 23:47:37 2006,454 [3335] DEBUG SugarCRM - skipping headers
Tue Jan 10 23:47:37 2006,466 [3335] INFO SugarCRM - Query:SELECT category, name, value FROM config WHERE category='MySettings
'
Tue Jan 10 23:47:37 2006,471 [3335] INFO SugarCRM - Query Execution Time:0.002456
Tue Jan 10 23:47:37 2006,484 [3335] INFO SugarCRM - Query:SELECT count(*) AS num FROM roles_users WHERE user_id='' AND delete
d=0
Tue Jan 10 23:47:37 2006,490 [3335] INFO SugarCRM - Query Execution Time:0.003337
Tue Jan 10 23:47:37 2006,507 [3335] DEBUG SugarCRM - Starting user load for admin
Tue Jan 10 23:47:37 2006,512 [3335] INFO SugarCRM - Query:SELECT * from users where user_name='admin' AND user_hash='b4702c1c
d00a6502bf4509020231cf95' AND (portal_only IS NULL OR portal_only !='1') AND (is_group IS NULL OR is_group !='1')
Tue Jan 10 23:47:37 2006,520 [3335] INFO SugarCRM - Query Execution Time:0.004587
Tue Jan 10 23:47:37 2006,524 [3335] INFO SugarCRM - Query:SELECT * from users where id='1'
Tue Jan 10 23:47:37 2006,530 [3335] INFO SugarCRM - Query Execution Time:0.003788
Tue Jan 10 23:47:37 2006,533 [3335] INFO SugarCRM - id
Tue Jan 10 23:47:37 2006,535 [3335] INFO SugarCRM - =1
Tue Jan 10 23:47:37 2006,537 [3335] INFO SugarCRM - user_name
Tue Jan 10 23:47:37 2006,538 [3335] INFO SugarCRM - =admin
Tue Jan 10 23:47:37 2006,541 [3335] INFO SugarCRM - user_password
Tue Jan 10 23:47:37 2006,543 [3335] INFO SugarCRM - =adcrUx7niSYJQ

<--------------Continur on next post of Log File ---------------------->

Thanks for help

Regards,
Sam Tan

[phpsam]

<--------------------Continue previous Log File ---------------------->


Tue Jan 10 23:47:37 2006,544 [3335] INFO SugarCRM - user_hash
Tue Jan 10 23:47:37 2006,545 [3335] INFO SugarCRM - =b4702c1cd00a6502bf4509020231cf95
Tue Jan 10 23:47:37 2006,546 [3335] INFO SugarCRM - first_name
Tue Jan 10 23:47:37 2006,547 [3335] INFO SugarCRM - last_name
Tue Jan 10 23:47:37 2006,549 [3335] INFO SugarCRM - =Administrator
Tue Jan 10 23:47:37 2006,550 [3335] INFO SugarCRM - description
Tue Jan 10 23:47:37 2006,551 [3335] INFO SugarCRM - date_entered
Tue Jan 10 23:47:37 2006,552 [3335] INFO SugarCRM - =2006-01-08 18:05:31
Tue Jan 10 23:47:37 2006,553 [3335] INFO SugarCRM - date_modified
Tue Jan 10 23:47:37 2006,554 [3335] INFO SugarCRM - =2006-01-08 18:34:14
Tue Jan 10 23:47:37 2006,556 [3335] INFO SugarCRM - modified_user_id
Tue Jan 10 23:47:37 2006,557 [3335] INFO SugarCRM - =1
Tue Jan 10 23:47:37 2006,558 [3335] INFO SugarCRM - created_by
Tue Jan 10 23:47:37 2006,560 [3335] INFO SugarCRM - title
Tue Jan 10 23:47:37 2006,561 [3335] INFO SugarCRM - =Administrator
Tue Jan 10 23:47:37 2006,562 [3335] INFO SugarCRM - department
Tue Jan 10 23:47:37 2006,563 [3335] INFO SugarCRM - is_admin
Tue Jan 10 23:47:37 2006,564 [3335] INFO SugarCRM - =on
Tue Jan 10 23:47:37 2006,566 [3335] INFO SugarCRM - phone_home
Tue Jan 10 23:47:37 2006,568 [3335] INFO SugarCRM - phone_mobile
Tue Jan 10 23:47:37 2006,569 [3335] INFO SugarCRM - phone_work
Tue Jan 10 23:47:37 2006,570 [3335] INFO SugarCRM - phone_other
Tue Jan 10 23:47:37 2006,572 [3335] INFO SugarCRM - phone_fax
Tue Jan 10 23:47:37 2006,573 [3335] INFO SugarCRM - email1
Tue Jan 10 23:47:37 2006,576 [3335] INFO SugarCRM - email2
Tue Jan 10 23:47:37 2006,577 [3335] INFO SugarCRM - address_street
Tue Jan 10 23:47:37 2006,579 [3335] INFO SugarCRM - address_city
Tue Jan 10 23:47:37 2006,580 [3335] INFO SugarCRM - address_state
Tue Jan 10 23:47:37 2006,581 [3335] INFO SugarCRM - address_postalcode
Tue Jan 10 23:47:37 2006,582 [3335] INFO SugarCRM - address_country
Tue Jan 10 23:47:37 2006,584 [3335] INFO SugarCRM - reports_to_id
Tue Jan 10 23:47:37 2006,585 [3335] INFO SugarCRM - portal_only
Tue Jan 10 23:47:37 2006,586 [3335] INFO SugarCRM - =0
Tue Jan 10 23:47:37 2006,588 [3335] INFO SugarCRM - status
Tue Jan 10 23:47:37 2006,589 [3335] INFO SugarCRM - =Active
Tue Jan 10 23:47:37 2006,594 [3335] INFO SugarCRM - receive_notifications
Tue Jan 10 23:47:37 2006,596 [3335] INFO SugarCRM - =1
Tue Jan 10 23:47:37 2006,597 [3335] INFO SugarCRM - employee_status
Tue Jan 10 23:47:37 2006,598 [3335] INFO SugarCRM - messenger_id
Tue Jan 10 23:47:37 2006,599 [3335] INFO SugarCRM - messenger_type
Tue Jan 10 23:47:37 2006,600 [3335] INFO SugarCRM - is_group
Tue Jan 10 23:47:37 2006,601 [3335] INFO SugarCRM - =0
Tue Jan 10 23:47:37 2006,604 [3335] DEBUG SugarCRM - LOADING :PREFERENCES SIZE 1700
Tue Jan 10 23:47:37 2006,605 [3335] DEBUG SugarCRM - Finished Loading
Tue Jan 10 23:47:37 2006,663 [3335] INFO SugarCRM - Query:Select * from versions where name='Custom Labels'
Tue Jan 10 23:47:37 2006,791 [3335] INFO SugarCRM - Query Execution Time:0.125717
Tue Jan 10 23:47:37 2006,795 [3335] INFO SugarCRM - Query:Select * from versions where name='Chart Data Cache'
Tue Jan 10 23:47:37 2006,800 [3335] INFO SugarCRM - Query Execution Time:0.0030870000000001
Tue Jan 10 23:47:37 2006,803 [3335] INFO SugarCRM - Query:Select * from versions where name='htaccess'
Tue Jan 10 23:47:37 2006,808 [3335] INFO SugarCRM - Query Execution Time:0.003061
Tue Jan 10 23:47:37 2006,812 [3335] INFO SugarCRM - Query:Select * from versions where name='DST Fix'
Tue Jan 10 23:47:37 2006,817 [3335] INFO SugarCRM - Query Execution Time:0.002856
Tue Jan 10 23:47:37 2006,820 [3335] INFO SugarCRM - Query:Select * from versions where name='Rebuild Relationships'
Tue Jan 10 23:47:37 2006,827 [3335] INFO SugarCRM - Query Execution Time:0.005011
Tue Jan 10 23:47:37 2006,831 [3335] INFO SugarCRM - Query:Select * from versions where name='Rebuild Extensions'
Tue Jan 10 23:47:37 2006,835 [3335] INFO SugarCRM - Query Execution Time:0.002749
Tue Jan 10 23:47:37 2006,842 [3335] INFO SugarCRM - Query:SELECT u1.first_name, u1.last_name from users u1, users u2 where
u1.id = u2.reports_to_id AND u2.id = '1' and u1.deleted=0
Tue Jan 10 23:47:37 2006,848 [3335] INFO SugarCRM - Query Execution Time:0.003206
Tue Jan 10 23:47:37 2006,849 [3335] DEBUG SugarCRM - additional detail query results:
Tue Jan 10 23:47:37 2006,852 [3335] INFO SugarCRM - Query:SELECT category, name, value FROM config WHERE category='Update'
Tue Jan 10 23:47:37 2006,857 [3335] INFO SugarCRM - Query Execution Time:0.002375
Tue Jan 10 23:47:37 2006,861 [3335] INFO SugarCRM - Query:SELECT category, name, value FROM config WHERE category='Update'
Tue Jan 10 23:47:37 2006,866 [3335] INFO SugarCRM - Query Execution Time:0.002367
Tue Jan 10 23:47:37 2006,871 [3335] DEBUG SugarCRM - get_user_array query: SELECT id, first_name, last_name, user_name from u
sers WHERE status='Active' AND is_group=0 order by user_name asc
Tue Jan 10 23:47:37 2006,872 [3335] INFO SugarCRM - Query:SELECT id, first_name, last_name, user_name from users WHERE status
='Active' AND is_group=0 order by user_name asc
Tue Jan 10 23:47:37 2006,876 [3335] INFO SugarCRM - Query Execution Time:0.002413
Tue Jan 10 23:47:37 2006,879 [3335] INFO SugarCRM - Query:select count(*) count from users where status='Active' and deleted=
0 and is_admin='on'
Tue Jan 10 23:47:37 2006,884 [3335] INFO SugarCRM - Query Execution Time:0.002319
Tue Jan 10 23:47:37 2006,886 [3335] INFO SugarCRM - Query:select count(*) count from users
Tue Jan 10 23:47:37 2006,890 [3335] INFO SugarCRM - Query Execution Time:0.001598
Tue Jan 10 23:47:37 2006,892 [3335] INFO SugarCRM - Query:SELECT count( DISTINCT users.id ) count FROM tracker, users WHERE u
sers.id = tracker.user_id AND PERIOD_DIFF( NOW( ) , tracker.date_modified ) <=1
Tue Jan 10 23:47:37 2006,941 [3335] INFO SugarCRM - Query Execution Time:0.046365
Tue Jan 10 23:47:37 2006,943 [3335] INFO SugarCRM - Query:select id from tracker order by date_modified desc
Tue Jan 10 23:47:37 2006,948 [3335] INFO SugarCRM - Query Execution Time:0.003224
Tue Jan 10 23:47:37 2006,950 [3335] INFO SugarCRM - Query:SELECT version() version
Tue Jan 10 23:47:37 2006,954 [3335] INFO SugarCRM - Connect:Resource id #218
Tue Jan 10 23:47:37 2006,958 [3335] INFO SugarCRM - Query Execution Time:0.001381
Tue Jan 10 23:47:38 2006,164 [3335] INFO SugarCRM - Query:SELECT category, name, value FROM config WHERE category='proxy'
Tue Jan 10 23:47:38 2006,170 [3335] INFO SugarCRM - Query Execution Time:0.002571
Tue Jan 10 23:47:40 2006,913 [3335] INFO SugarCRM - Query:SELECT count(*) AS the_count FROM config WHERE category = 'license'
AND name = 'msg_admin'
Tue Jan 10 23:47:40 2006,920 [3335] INFO SugarCRM - Query Execution Time:0.004058
Tue Jan 10 23:47:40 2006,922 [3335] INFO SugarCRM - Query:UPDATE config SET value = '' WHERE category = 'license' AND name =
'msg_admin'
Tue Jan 10 23:47:40 2006,927 [3335] INFO SugarCRM - Query Execution Time:0.0020129999999999
Tue Jan 10 23:47:40 2006,929 [3335] INFO SugarCRM - Query:SELECT count(*) AS the_count FROM config WHERE category = 'license'
AND name = 'msg_all'
Tue Jan 10 23:47:40 2006,933 [3335] INFO SugarCRM - Query Execution Time:0.0024109999999999
Tue Jan 10 23:47:40 2006,936 [3335] INFO SugarCRM - Query:UPDATE config SET value = '' WHERE category = 'license' AND name =
'msg_all'
Tue Jan 10 23:47:40 2006,939 [3335] INFO SugarCRM - Query Execution Time:0.001939
Tue Jan 10 23:47:40 2006,941 [3335] INFO SugarCRM - Query:SELECT count(*) AS the_count FROM config WHERE category = 'license'
AND name = 'last_validation'
Tue Jan 10 23:47:40 2006,947 [3335] INFO SugarCRM - Query Execution Time:0.0023920000000001
Tue Jan 10 23:47:40 2006,949 [3335] INFO SugarCRM - Query:UPDATE config SET value = 'success' WHERE category = 'license' AND
name = 'last_validation'
Tue Jan 10 23:47:40 2006,953 [3335] INFO SugarCRM - Query Execution Time:0.0019250000000001
Tue Jan 10 23:47:40 2006,955 [3335] INFO SugarCRM - Query:SELECT count(*) AS the_count FROM config WHERE category = 'license'
AND name = 'latest_versions'
Tue Jan 10 23:47:40 2006,959 [3335] INFO SugarCRM - Query Execution Time:0.002398
Tue Jan 10 23:47:40 2006,961 [3335] INFO SugarCRM - Query:UPDATE config SET value = '' WHERE category = 'license' AND name =
'latest_versions'
Tue Jan 10 23:47:40 2006,969 [3335] INFO SugarCRM - Query Execution Time:0.002011
Tue Jan 10 23:47:40 2006,973 [3335] INFO SugarCRM - Query:SELECT category, name, value FROM config WHERE category='license'
Tue Jan 10 23:47:40 2006,979 [3335] INFO SugarCRM - Query Execution Time:0.002399
Tue Jan 10 23:47:40 2006,983 [3335] INFO SugarCRM - Query:SELECT count(*) AS the_count FROM config WHERE category = 'Update'
AND name = 'last_check_date'
Tue Jan 10 23:47:40 2006,988 [3335] INFO SugarCRM - Query Execution Time:0.002918
Tue Jan 10 23:47:40 2006,991 [3335] INFO SugarCRM - Query:UPDATE config SET value = '1136908057' WHERE category = 'Update' AN
D name = 'last_check_date'
Tue Jan 10 23:47:40 2006,995 [3335] INFO SugarCRM - Query Execution Time:0.00225

<--------------------End of Log File ---------------------->

[dbacon78]

Your not alone with this problem. Have you figured it out yet? I am having the same problem. I am also using Fedora Core 4.