Update problem vers. 7:11:12

SuiteCRM Forum - English Language Installation & Upgrade Help
1

Good evening,
I state that I tried several days to solve the problem by searching for the online solution without success.

At Fabbruary I decided to switch from my dear Vtiger to SuiteCRM and I have to tell the truth, (apart from the graphic presentation, it would not seem that SuiteCRM is worse than Vtiger.

After customizing the CRM in every possible and imaginable field, I tried to update it without succeeding. I need a hand on your part (The community has pushed me to switch from Vtiger to SuiteCRM !!!)

PHP Version: 7.3
PHP.ini extracts:

Blockquote
post_max_size = 64M
upload_max_filesize = 64M
max_input_time = -1
memory_limit = 512M
max_execution_time = 60
display_errors = Off

Log extracts:
UPGRADEWIZARD.log

Blockquote
Tue, 21 Apr 2020 18:02:05 +0200 [UpgradeWizard] - setting session variables…
Tue, 21 Apr 2020 18:02:05 +0200 [UpgradeWizard] - -----------------------------------------------------------------------------
Tue, 21 Apr 2020 18:02:05 +0200 [UpgradeWizard] - Upgrade started. At start.php
Tue, 21 Apr 2020 18:02:05 +0200 [UpgradeWizard] - at unlinkUWTempFiles()
Tue, 21 Apr 2020 18:02:05 +0200 [UpgradeWizard] - finished!
Tue, 21 Apr 2020 18:02:05 +0200 [UpgradeWizard] - resetting $_SESSION
Tue, 21 Apr 2020 18:02:08 +0200 [UpgradeWizard] - setting session variables…
Tue, 21 Apr 2020 18:02:08 +0200 [UpgradeWizard] - [At systemCheck.php]
Tue, 21 Apr 2020 18:02:08 +0200 [UpgradeWizard] - Starting file permission check…
Tue, 21 Apr 2020 18:02:35 +0200 [UpgradeWizard] - setting session variables…
Tue, 21 Apr 2020 18:02:35 +0200 [UpgradeWizard] - -----------------------------------------------------------------------------
Tue, 21 Apr 2020 18:02:35 +0200 [UpgradeWizard] - Upgrade started. At start.php
Tue, 21 Apr 2020 18:02:35 +0200 [UpgradeWizard] - at unlinkUWTempFiles()
Tue, 21 Apr 2020 18:02:35 +0200 [UpgradeWizard] - finished!
Tue, 21 Apr 2020 18:02:35 +0200 [UpgradeWizard] - resetting $_SESSION

thank you very much

2

Between each upgrade attempt, clear the cache/upgrades/temp directory completely.

Check also you PHP log, the one defined in error_log entry in your php.ini

3

Hello and thanks for the reply;
the [quote]cache / upgrades / temp [/quote] folder is always empty; at most, a few kb file is created.

I have enabled the error log php and in the file there is only this:

Blockquote
[22-Apr-2020 13:29:39 Europe/Berlin] PHP Strict Standards: strftime(): We selected ‘Europe/Berlin’ for ‘CEST/2.0/DST’ instead in /homepages/8/d821415530/htdocs/tecnic-crm/include/SugarLogger/SugarLogger.php on line 233
[22-Apr-2020 13:29:39 Europe/Berlin] PHP Strict Standards: strftime(): We selected ‘Europe/Berlin’ for ‘CEST/2.0/DST’ instead in /homepages/8/d821415530/htdocs/tecnic-crm/include/SugarLogger/SugarLogger.php on line 233
[22-Apr-2020 13:29:39 Europe/Berlin] PHP Strict Standards: strftime(): We selected ‘Europe/Berlin’ for ‘CEST/2.0/DST’ instead in /homepages/8/d821415530/htdocs/tecnic-crm/include/SugarLogger/SugarLogger.php on line 233
[22-Apr-2020 13:29:39 Europe/Berlin] PHP Strict Standards: strftime(): We selected ‘Europe/Berlin’ for ‘CEST/2.0/DST’ instead in /homepages/8/d821415530/htdocs/tecnic-crm/include/SugarLogger/SugarLogger.php on line 233
[22-Apr-2020 13:29:39 Europe/Berlin] PHP Strict Standards: strftime(): We selected ‘Europe/Berlin’ for ‘CEST/2.0/DST’ instead in /homepages/8/d821415530/htdocs/***-crm/include/SugarLogger/SugarLogger.php on line 233
[22-Apr-2020 13:29:39 Europe/Berlin] PHP Notice: Undefined index: additional_step in /homepages/8/d821415530/htdocs/tecnic-crm/modules/UpgradeWizard/index.php on line 291

4

That doesn’t tell me much…

You might want to increase max_exeuction_time to something like 360

Also, please describe in more detail what happens in the upgrade, in which step it fails, if it takes a long time between steps etc.

Is this Windows or Linux?

5

I tried to increase max_exeuction_time but it didn’t work.

The problem occurs a few seconds after pressing the Next button to start the update process.

Linux hosting

6

And are you sure the PHP log doesn’t show anything when you attempt the upgrade? Are those errors you pasted above showing at the time when you were attempting the upgrade?

7

The errors I pasted are written as soon as I click on the Next button.

I click on the button, the upgrade procedure starts and it stops.

You don’t post the whole LOG file because it’s huge. Here is the extract of the last 61 lines:

Wed Apr 22 17:01:41 2020 [80059][1][DEBUG] FACTOR AUTH: -------------------------------------------------------------
Wed Apr 22 17:01:41 2020 [80059][1][DEBUG] FACTOR AUTH: --------------------- CHECK FACTOR AUtH ---------------------
Wed Apr 22 17:01:41 2020 [80059][1][DEBUG] FACTOR AUTH: -------------------------------------------------------------
Wed Apr 22 17:01:41 2020 [80059][1][DEBUG] FACTOR AUTH: User needs factor auth, request is not Logout
Wed Apr 22 17:01:41 2020 [80059][1][DEBUG] FACTOR AUTH: User does`nt need factor auth
Wed Apr 22 17:01:41 2020 [80059][1][DEBUG] Current user is: cuomoa
Wed Apr 22 17:01:41 2020 [80059][1][DEBUG] Current user is: cuomoa
Wed Apr 22 17:01:41 2020 [80059][1][DEBUG] setting cookie ck_login_id_20 to 1
Wed Apr 22 17:01:41 2020 [80059][1][DEBUG] setting cookie ck_login_language_20 to en_us
Wed Apr 22 17:01:41 2020 [80059][1][DEBUG] current_language is: en_us
Wed Apr 22 17:01:42 2020 [80059][1][INFO] Found language file: it_it.lang.php
Wed Apr 22 17:01:42 2020 [80059][1][INFO] Found extended language file: it_it.lang.ext.php
Wed Apr 22 17:01:42 2020 [80059][1][INFO] Found custom language file: it_it.lang.php
Wed Apr 22 17:01:42 2020 [80059][1][INFO] Found language file: en_us.lang.php
Wed Apr 22 17:01:42 2020 [80059][1][INFO] Found extended language file: en_us.lang.ext.php
Wed Apr 22 17:01:42 2020 [80059][1][INFO] Found custom language file: en_us.lang.php
Wed Apr 22 17:01:42 2020 [80059][1][INFO] Found language file: it_it.lang.php
Wed Apr 22 17:01:42 2020 [80059][1][INFO] Found language file: en_us.lang.php
Wed Apr 22 17:01:42 2020 [80059][1][INFO] Found extended language file: it_it.lang.ext.php
Wed Apr 22 17:01:42 2020 [80059][1][INFO] Found custom language file: it_it.lang.php
Wed Apr 22 17:01:42 2020 [80059][1][INFO] Found extended language file: en_us.lang.ext.php
Wed Apr 22 17:01:42 2020 [80059][1][INFO] Found custom language file: en_us.lang.php
Wed Apr 22 17:01:42 2020 [80059][1][DEBUG] rebuilding cache for Alerts
Wed Apr 22 17:01:42 2020 [80059][1][INFO] Query:SELECT * FROM fields_meta_data WHERE custom_module=‘Alerts’ AND deleted = 0
Wed Apr 22 17:01:42 2020 [80059][1][INFO] Query Execution Time:0.0073299407958984
Wed Apr 22 17:01:42 2020 [80059][1][DEBUG] Performing action: action_get MODULE: Alerts
Wed Apr 22 17:01:42 2020 [80059][1][DEBUG] get_full_list: order_by = ‘alerts.date_entered’ and where = ‘alerts.assigned_user_id = ‘1’ AND is_read != ‘1’’
Wed Apr 22 17:01:42 2020 [80059][1][DEBUG] SugarBean[Alert].load_relationships, Loading relationship (modified_user_link).
Wed Apr 22 17:01:42 2020 [80059][1][DEBUG] SugarBean[Alert].load_relationships, Loading relationship (created_by_link).
Wed Apr 22 17:01:42 2020 [80059][1][DEBUG] SugarBean[Alert].load_relationships, Loading relationship (assigned_user_link).
Wed Apr 22 17:01:42 2020 [80059][1][DEBUG] process_order_by: (alerts.date_entered) does not have a vardef entry.
Wed Apr 22 17:01:42 2020 [80059][1][DEBUG] process_full_list_query: query is SELECT alerts.* , jt0.user_name modified_by_name , jt0.created_by modified_by_name_owner , ‘Users’ modified_by_name_mod , jt1.user_name created_by_name , jt1.created_by created_by_name_owner , ‘Users’ created_by_name_mod , jt2.user_name assigned_user_name , jt2.created_by assigned_user_name_owner , ‘Users’ assigned_user_name_mod FROM alerts LEFT JOIN users jt0 ON alerts.modified_user_id=jt0.id AND jt0.deleted=0

AND jt0.deleted=0 LEFT JOIN users jt1 ON alerts.created_by=jt1.id AND jt1.deleted=0

AND jt1.deleted=0 LEFT JOIN users jt2 ON alerts.assigned_user_id=jt2.id AND jt2.deleted=0

AND jt2.deleted=0 where (alerts.assigned_user_id = ‘1’ AND is_read != ‘1’) AND alerts.deleted=0
Wed Apr 22 17:01:42 2020 [80059][1][INFO] Query: SELECT alerts.* , jt0.user_name modified_by_name , jt0.created_by modified_by_name_owner , ‘Users’ modified_by_name_mod , jt1.user_name created_by_name , jt1.created_by created_by_name_owner , ‘Users’ created_by_name_mod , jt2.user_name assigned_user_name , jt2.created_by assigned_user_name_owner , ‘Users’ assigned_user_name_mod FROM alerts LEFT JOIN users jt0 ON alerts.modified_user_id=jt0.id AND jt0.deleted=0

AND jt0.deleted=0 LEFT JOIN users jt1 ON alerts.created_by=jt1.id AND jt1.deleted=0

AND jt1.deleted=0 LEFT JOIN users jt2 ON alerts.assigned_user_id=jt2.id AND jt2.deleted=0

AND jt2.deleted=0 where (alerts.assigned_user_id = ‘1’ AND is_read != ‘1’) AND alerts.deleted=0
Wed Apr 22 17:01:42 2020 [80059][1][INFO] Query Execution Time:0.0015950202941895
Wed Apr 22 17:01:42 2020 [80059][1][DEBUG] process_full_list_query: result is mysqli_result Object
(
[current_field] => 0
[field_count] => 23
[lengths] =>
[num_rows] => 0
[type] => 0
)

Wed Apr 22 17:01:42 2020 [80059][1][DEPRECATED] Array
(
)

Wed Apr 22 17:01:42 2020 [80059][1][DEBUG] Hook called: ::server_round_trip
Wed Apr 22 17:01:42 2020 [80059][1][DEBUG] Calling MySQLi::disconnect()

8

That is suitecrm.log, not the PHP errors log.

I’m sorry, it’s possible that there are no interesting messages in your logs, the problem, is that this way, it’s quite hard to help you.

Another thing you could try is to delete uploads/upgrades/patch in case there are some left-overs from a previous installation there, messing things up…

9

how can I help you? how do you think there are no relevant messages?

The folder you indicated to me uploads / upgrades / patch is empty.

10

What I mean is, unless there is something new in your php_errors.log, different from what you posted earlier, and that actually provides me with a clue, I don’t have information to help you out, like this, from a distance. The only way forward is to start debugging, locally…

11

unfortunately I don’t know how to help you. Can you give me info about local debugging?

12

Somehow it didn’t help OP, but it helped me. Thank you.