Enable Logging

[vidtechsteve]

This is probably a rookie php question, but I am going to ask anyway.

How in the world do I enable logging with SugarCRM? I have seen many references to the logs that SugarCRM will create, but i have no idea how to enable this.

I have a very vague "error sending email" error that I can't find the resolution on and people have mentioned to look at the logs.

[matthew]

Check out the log4php.properties file in the root of the SugarCRM folder.

Then change around line nine from fatal to debug:

log4php.rootLogger=fatal, A2

to

log4php.rootLogger=debug, A2

[vidtechsteve]

That works awesome.

Now what do I need to look for to get my email to work?

I am getting a very vague error message displayed on the screen.

"Error Sending Email"

That is all I get.

[rana]

Hi vidtechsteve can you describe us your system (SO, sugar version.....)

Do you use SMTP or sendmail??

If you use SMTP what do you write in the field "SMTP Server"

Thanks

[vidtechsteve]

Hi vidtechsteve can you describe us your system (SO, sugar version.....)

Do you use SMTP or sendmail??

If you use SMTP what do you write in the field "SMTP Server"

Thanks

Thank you so much for trying to help me.

Currently we have Sugar running on a Windows 2003 machine and IIS.
I have configured our install to use smtp.
In the SMTP Server field I have tried a couple of things.
1). mail.zianet.com - which is our web host
2). mail.vidcad.com - which is our mail host at our ISP ( which is our web host also ).

I have enabled logging, but I am not sure what to be looking for to see why I am getting the error.

[rana]

Hi you can try the command "nslookup smtpservername" on dos promt
so you receive the ip and put it in smtp server field instead of the nameserver.
If you receive more then one ip (like me) you can use every ip address.

[vidtechsteve]

I am still getting the same error here is the log that was created.

12/09/05 16:25:10,028 [864] INFO SugarCRM - About to take action Status
12/09/05 16:25:10,029 [864] DEBUG SugarCRM - in Status
12/09/05 16:25:10,030 [864] INFO SugarCRM - current page is modules/Emails/Status.php
12/09/05 16:25:10,030 [864] INFO SugarCRM - current module is Emails
12/09/05 16:25:10,035 [864] DEBUG SugarCRM - Retrieve User : SELECT users.* FROM users WHERE users.id = '1'
12/09/05 16:25:10,036 [864] INFO SugarCRM - Query:SELECT users.* FROM users WHERE users.id = '1'
12/09/05 16:25:10,037 [864] INFO SugarCRM - Query Execution Time:0.000794
12/09/05 16:25:10,041 [864] 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
12/09/05 16:25:10,042 [864] INFO SugarCRM - Query Execution Time:0.000609
12/09/05 16:25:10,043 [864] DEBUG SugarCRM - additional detail query results:
12/09/05 16:25:10,044 [864] DEBUG SugarCRM - Current user is: admin
12/09/05 16:25:10,045 [864] INFO SugarCRM - Query:SELECT count(*) as the_count FROM config WHERE category='info' AND name='sugar_version' AND value = '3.5.1'
12/09/05 16:25:10,046 [864] INFO SugarCRM - Query Execution Time:0.000569
12/09/05 16:25:10,047 [864] DEBUG SugarCRM - Current theme is: Sugar
12/09/05 16:25:10,047 [864] DEBUG SugarCRM - current_language is: en_us
12/09/05 16:25:10,063 [864] INFO SugarCRM - Found custom language file: en_us.lang.php
12/09/05 16:25:10,067 [864] DEBUG SugarCRM - setting cookie ck_login_id_20 to 1
12/09/05 16:25:10,067 [864] DEBUG SugarCRM - setting cookie ck_login_theme_20 to Sugar
12/09/05 16:25:10,068 [864] DEBUG SugarCRM - setting cookie ck_login_language_20 to en_us
12/09/05 16:25:10,071 [864] 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 ='1'
AND meetings.reminder_time != -1
AND meetings_users.deleted != 1
HAVING dateTime >= '2005-12-09 23:25:10'
12/09/05 16:25:10,073 [864] INFO SugarCRM - Query Execution Time:0.000662
12/09/05 16:25:10,074 [864] 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 ='1'
AND calls.reminder_time != -1
AND calls_users.deleted != 1
HAVING dateTime >= '2005-12-09 23:25:10'
12/09/05 16:25:10,075 [864] INFO SugarCRM - Query Execution Time:0.000647
12/09/05 16:25:10,076 [864] DEBUG SugarCRM - including headers
12/09/05 16:25:10,111 [864] INFO SugarCRM - Query:SELECT category, name, value FROM config WHERE category='MySettings'
12/09/05 16:25:10,113 [864] INFO SugarCRM - Query Execution Time:0.00056
12/09/05 16:25:10,120 [864] INFO SugarCRM - Query:SELECT count(*) AS num FROM roles_users WHERE user_id='1' AND deleted=0
12/09/05 16:25:10,122 [864] INFO SugarCRM - Query Execution Time:0.000469
12/09/05 16:25:10,129 [864] INFO SugarCRM - Query:SELECT placement,name,id,url from iframes WHERE deleted=0 AND status=1 AND (placement='tab' OR placement='all') AND (type='global' OR (type='personal' AND created_by='1')) ORDER BY iframes.name
12/09/05 16:25:10,131 [864] INFO SugarCRM - Query Execution Time:0.000522
12/09/05 16:25:10,153 [864] DEBUG SugarCRM - About to retrieve list: SELECT * from tracker WHERE user_id='1' ORDER BY id DESC
12/09/05 16:25:10,153 [864] INFO SugarCRM - Query:SELECT * from tracker WHERE user_id='1' ORDER BY id DESC
12/09/05 16:25:10,155 [864] INFO SugarCRM - Query Execution Time:0.000673
12/09/05 16:25:10,169 [864] INFO SugarCRM - Query:SELECT category, name, value FROM config WHERE category='Update'
12/09/05 16:25:10,171 [864] INFO SugarCRM - Query Execution Time:0.000601
12/09/05 16:25:10,173 [864] INFO SugarCRM - Query:SELECT category, name, value FROM config WHERE category='Update'
12/09/05 16:25:10,175 [864] INFO SugarCRM - Query Execution Time:0.000575

[matthew]

What do your SMTP logs say?

[vidtechsteve]

Hi you can try the command "nslookup smtpservername" on dos promt
so you receive the ip and put it in smtp server field instead of the nameserver.
If you receive more then one ip (like me) you can use every ip address.

I have tried to use the IP address but I am still getting the same error.

What information from the sugar.log file will be helpful to see?

I just tried to send another email from sugar and this is an error that I received.

Warning: fsockopen() [function.fsockopen]: unable to connect to mail.vidcad.com:25 (A non-blocking socket operation could not be completed immediately. ) in E:\SugarCRM\include\phpmailer\class.smtp.php on line 105

Fatal error: Maximum execution time of 30 seconds exceeded in E:\SugarCRM\include\phpmailer\class.smtp.php on line 101

[matthew]

Warning: fsockopen() [function.fsockopen]: unable to connect to mail.vidcad.com:25 (A non-blocking socket operation could not be completed immediately. ) in E:\SugarCRM\include\phpmailer\class.smtp.php on line 105

Fatal error: Maximum execution time of 30 seconds exceeded in E:\SugarCRM\include\phpmailer\class.smtp.php on line 101

The WARNING may be caused by the same thing that is causing the Fatal error. Increase the size of your max_execution_time in your php.ini file. Also consider looking at all the Resource LImits.

Let us know.