Upgrage from 7.11.7 to 7.11.8 Failed

šŸ“¦ Install & Upgrade Help
21

Been 2 months since anyone has responded to this forum. Just noting that this is still happening. I just downloaded the very latest SuiteCRM-Upgrade-7.11.x-to-7.11.8.zip TODAY and I get the same errors the other folks get. I am upgrading from 7.11.6 to 7.11.8. I have tested on localhost (docker) and my sandbox VM which is not docker, standard debian/nginx setup. Upgrade UI just shows a blank white page. If I have warning on I get a bunch of warnings instead of blank page like so. Though I doubt these warning have anything todo with it.


Notice: Undefined index: sqlSkippedQueries in /var/www/gsb/php/suitecrm/src/modules/UpgradeWizard/commit.php on line 90
Notice: Undefined variable: suitecrm_version in /var/www/gsb/php/suitecrm/src/cache/upgrades/temp/YF6o0F/scripts/pre_install.php on line 88
Warning: copy(): The second argument to copy() function cannot be a directory in /var/www/gsb/php/suitecrm/src/modules/UpgradeWizard/uw_utils.php on line 232
Warning: copy(): The second argument to copy() function cannot be a directory in /var/www/gsb/php/suitecrm/src/modules/UpgradeWizard/uw_utils.php on line 232
Warning: copy(): The second argument to copy() function cannot be a directory in /var/www/gsb/php/suitecrm/src/modules/UpgradeWizard/uw_utils.php on line 232
Warning: copy(): The second argument to copy() function cannot be a directory in /var/www/gsb/php/suitecrm/src/modules/UpgradeWizard/uw_utils.php on line 232
Warning: copy(): The second argument to copy() function cannot be a directory in /var/www/gsb/php/suitecrm/src/modules/UpgradeWizard/uw_utils.php on line 232
Warning: copy(): The second argument to copy() function cannot be a directory in /var/www/gsb/php/suitecrm/src/modules/UpgradeWizard/uw_utils.php on line 232
Warning: copy(): The second argument to copy() function cannot be a directory in /var/www/gsb/php/suitecrm/src/modules/UpgradeWizard/uw_utils.php on line 232
Warning: copy(): The second argument to copy() function cannot be a directory in /var/www/gsb/php/suitecrm/src/modules/UpgradeWizard/uw_utils.php on line 232
Notice: Undefined index: post_install in /var/www/gsb/php/suitecrm/src/modules/UpgradeWizard/uw_utils.php on line 3113
Notice: Undefined variable: path in /var/www/gsb/php/suitecrm/src/cache/upgrades/temp/YF6o0F/scripts/post_install.php on line 210
Notice: Undefined variable: path in /var/www/gsb/php/suitecrm/src/cache/upgrades/temp/YF6o0F/scripts/post_install.php on line 215
Warning: dir(/var/www/gsb/php/suitecrm/src/cache/upgrades/temp/YF6o0F/scripts/files_to_add_post/themes/): failed to open dir: No such file or directory in /var/www/gsb/php/suitecrm/src/include/dir_inc.php on line 57

If I review the upgradewizard.log there are no errors there and it seems to indicate success. All the version php files are reflecting the new version, my app works, there doesnā€™t seem to be any bugsā€¦but I have no idea what in the upgrade process got skipped.

Last lines of upgradewizard.log


Mon, 28 Oct 2019 13:33:49 -0500 [UpgradeWizard] - Upgrading the database from 6.5.25 to version 6.5.25
Mon, 28 Oct 2019 13:33:49 -0500 [UpgradeWizard] - Running SQL file /var/www/suitecrm/sandbox/shared/cache/upgrades/temp/HJmseO/scripts/65x_to_65x_mysql.sql
Mon, 28 Oct 2019 13:33:49 -0500 [UpgradeWizard] - *** Skipping schema upgrade for point release.
Mon, 28 Oct 2019 13:33:49 -0500 [UpgradeWizard] - Rebuilding JS Langauages
Mon, 28 Oct 2019 13:33:49 -0500 [UpgradeWizard] - Rebuilding Dashlets
Mon, 28 Oct 2019 13:33:49 -0500 [UpgradeWizard] - At updateVersions()... updating config table and sugar_version.php.
Mon, 28 Oct 2019 13:33:49 -0500 [UpgradeWizard] - sugar_version.php successfully updated!
Mon, 28 Oct 2019 13:33:49 -0500 [UpgradeWizard] - Deleting old DB version info from config table.
Mon, 28 Oct 2019 13:33:49 -0500 [UpgradeWizard] - Inserting updated version info into config table.
Mon, 28 Oct 2019 13:33:49 -0500 [UpgradeWizard] - updateVersions() complete.
Mon, 28 Oct 2019 13:33:49 -0500 [UpgradeWizard] - rebuild grouping js files..
Mon, 28 Oct 2019 13:33:49 -0500 [UpgradeWizard] - unlink: cache/include/javascript/sugar_grp1.js
Mon, 28 Oct 2019 13:33:49 -0500 [UpgradeWizard] - cwd: /var/www/suitecrm/sandbox/releases/20190906145159
Mon, 28 Oct 2019 13:33:51 -0500 [UpgradeWizard] - updating UpgradeWizard code post install from: cache/include/javascript/sugar_grp1.js
Mon, 28 Oct 2019 13:33:51 -0500 [UpgradeWizard] - updating UpgradeWizard code post install: cache/include/javascript/sugar_grp1.js
Mon, 28 Oct 2019 13:33:51 -0500 [UpgradeWizard] - updating UpgradeWizard code post install from: /var/www/suitecrm/sandbox/shared/cache/upgrades/temp/HJmseO/scripts/files_to_add_post/include/
Mon, 28 Oct 2019 13:33:51 -0500 [UpgradeWizard] - updating UpgradeWizard code post install: include/
Mon, 28 Oct 2019 13:33:51 -0500 [UpgradeWizard] - updating UpgradeWizard code post install from: /var/www/suitecrm/sandbox/shared/cache/upgrades/temp/HJmseO/scripts/files_to_add_post/modules/
Mon, 28 Oct 2019 13:33:51 -0500 [UpgradeWizard] - updating UpgradeWizard code post install: modules/
Mon, 28 Oct 2019 13:33:51 -0500 [UpgradeWizard] - updating UpgradeWizard code post install from: /var/www/suitecrm/sandbox/shared/cache/upgrades/temp/HJmseO/scripts/files_to_add_post/themes/
Mon, 28 Oct 2019 13:33:51 -0500 [UpgradeWizard] - updating UpgradeWizard code post install: themes/
Mon, 28 Oct 2019 13:33:51 -0500 [UpgradeWizard] - Performing UWrebuild()...
Mon, 28 Oct 2019 13:33:51 -0500 [UpgradeWizard] - UWrebuild() done.
Mon, 28 Oct 2019 13:33:51 -0500 [UpgradeWizard] - post_install() done.
Mon, 28 Oct 2019 13:33:51 -0500 [UpgradeWizard] - check if current_db_version in $_SESSION equals target_db_version in $_SESSION
Mon, 28 Oct 2019 13:33:51 -0500 [UpgradeWizard] - finished check to see if current_db_version in $_SESSION equals target_db_version in $_SESSION
Mon, 28 Oct 2019 13:33:51 -0500 [UpgradeWizard] - running deleteChance() function
Mon, 28 Oct 2019 13:33:51 -0500 [UpgradeWizard] - running deleteCache() function
Mon, 28 Oct 2019 13:33:51 -0500 [UpgradeWizard] - call addNewSystemTabsFromUpgrade(upload://upgrades/patch/SuiteCRM-Upgrade-7.11.x-to-7.11.8-restore)
Mon, 28 Oct 2019 13:33:51 -0500 [UpgradeWizard] - check to see if new modules exist
Mon, 28 Oct 2019 13:33:51 -0500 [UpgradeWizard] - new modules to add are array (
)
Mon, 28 Oct 2019 13:33:51 -0500 [UpgradeWizard] - module tabs updated
Mon, 28 Oct 2019 13:33:51 -0500 [UpgradeWizard] - finished addNewSystemTabsFromUpgrade
Mon, 28 Oct 2019 13:33:51 -0500 [UpgradeWizard] - Registering upgrade with UpgradeHistory
Mon, 28 Oct 2019 13:33:51 -0500 [UpgradeWizard] - Rebuilding style js file: cache/themes/SuiteP/js/style-min.js
Mon, 28 Oct 2019 13:33:51 -0500 [UpgradeWizard] - Rebuilding language cache

My error log shows the same smarty errors as the other folks


Mon Oct 28 13:33:51 2019 [6702][1a8c3e85-280d-2632-ebc7-5d28f646db4b][FATAL] Exception handling in /var/www/suitecrm/sandbox/releases/20190906145159/include/MVC/Controller/SugarController.php:400
Mon Oct 28 13:33:51 2019 [6702][1a8c3e85-280d-2632-ebc7-5d28f646db4b][FATAL] Exception in Controller: Some garbage state left in stack (did you pop everything?)
Needs to restore:
        [error_reporting.sugar_smarty_errors] => 'sugar_smarty_errors'

Mon Oct 28 13:33:51 2019 [6702][1a8c3e85-280d-2632-ebc7-5d28f646db4b][FATAL] backtrace:
#0 /var/www/suitecrm/sandbox/releases/20190906145159/include/Sugar_Smarty.php(167): SuiteCRM\StateSaver->__destruct()
#1 /var/www/suitecrm/sandbox/releases/20190906145159/include/Smarty/Smarty.class.php(1113): Sugar_Smarty->fetch('modules/Upgrade...', NULL, NULL, true)
#2 /var/www/suitecrm/sandbox/releases/20190906145159/modules/UpgradeWizard/index.php(539): Smarty->display('modules/Upgrade...')
#3 /var/www/suitecrm/sandbox/releases/20190906145159/include/MVC/View/SugarView.php(834): include_once('/var/www/suitec...')
#4 /var/www/suitecrm/sandbox/releases/20190906145159/include/MVC/View/views/view.classic.php(72): SugarView->includeClassicFile('/var/www/suitec...')
#5 /var/www/suitecrm/sandbox/releases/20190906145159/include/MVC/View/SugarView.php(226): ViewClassic->display()
#6 /var/www/suitecrm/sandbox/releases/20190906145159/include/MVC/Controller/SugarController.php(435): SugarView->process()
#7 /var/www/suitecrm/sandbox/releases/20190906145159/include/MVC/Controller/SugarController.php(375): SugarController->processView()
#8 /var/www/suitecrm/sandbox/releases/20190906145159/include/MVC/SugarApplication.php(113): SugarController->execute()
#9 /var/www/suitecrm/sandbox/releases/20190906145159/index.php(52): SugarApplication->execute()
#10 {main}
Mon Oct 28 13:33:51 2019 [6702][1a8c3e85-280d-2632-ebc7-5d28f646db4b][FATAL] Previous:
22

Upgrading from 7.11.6 to 7.11.8 just today, and this smarty type error is still happening. The UI fails to a white screen. The upgradeWizard.log seem to indicate no errors, but suitecrm.log shows same smarty errors. And I just downloaded SuiteCRM-Upgrade-7.11.x-to-7.11.8.zip as of Oct 23rd. I cannot upgrade my localhost, sandbox or production because of this issue. I will note however that the upgrade seemed to work in all other respects. All version files and UI state 7.11.8 properly, using git I can see hundreds of files modified. There was no SQL to run on this small point release. My site seems to be working perfectlyā€¦but I have no idea what part of the upgrade was skipped.

suitecrm.log


Mon Oct 28 13:33:51 2019 [6702][1a8c3e85-280d-2632-ebc7-5d28f646db4b][FATAL] Exception handling in /var/www/suitecrm/sandbox/releases/20190906145159/include/MVC/Controller/SugarController.php:400
Mon Oct 28 13:33:51 2019 [6702][1a8c3e85-280d-2632-ebc7-5d28f646db4b][FATAL] Exception in Controller: Some garbage state left in stack (did you pop everything?)
Needs to restore:
        [error_reporting.sugar_smarty_errors] => 'sugar_smarty_errors'

Mon Oct 28 13:33:51 2019 [6702][1a8c3e85-280d-2632-ebc7-5d28f646db4b][FATAL] backtrace:
#0 /var/www/suitecrm/sandbox/releases/20190906145159/include/Sugar_Smarty.php(167): SuiteCRM\StateSaver->__destruct()
#1 /var/www/suitecrm/sandbox/releases/20190906145159/include/Smarty/Smarty.class.php(1113): Sugar_Smarty->fetch('modules/Upgrade...', NULL, NULL, true)
#2 /var/www/suitecrm/sandbox/releases/20190906145159/modules/UpgradeWizard/index.php(539): Smarty->display('modules/Upgrade...')
#3 /var/www/suitecrm/sandbox/releases/20190906145159/include/MVC/View/SugarView.php(834): include_once('/var/www/suitec...')
#4 /var/www/suitecrm/sandbox/releases/20190906145159/include/MVC/View/views/view.classic.php(72): SugarView->includeClassicFile('/var/www/suitec...')
#5 /var/www/suitecrm/sandbox/releases/20190906145159/include/MVC/View/SugarView.php(226): ViewClassic->display()
#6 /var/www/suitecrm/sandbox/releases/20190906145159/include/MVC/Controller/SugarController.php(435): SugarView->process()
#7 /var/www/suitecrm/sandbox/releases/20190906145159/include/MVC/Controller/SugarController.php(375): SugarController->processView()
#8 /var/www/suitecrm/sandbox/releases/20190906145159/include/MVC/SugarApplication.php(113): SugarController->execute()
#9 /var/www/suitecrm/sandbox/releases/20190906145159/index.php(52): SugarApplication->execute()
#10 {main}
Mon Oct 28 13:33:51 2019 [6702][1a8c3e85-280d-2632-ebc7-5d28f646db4b][FATAL] Previous:

And the upgradeWizard.log last few lines showing you no real errors here


Mon, 28 Oct 2019 13:33:49 -0500 [UpgradeWizard] - Upgrading the database from 6.5.25 to version 6.5.25
Mon, 28 Oct 2019 13:33:49 -0500 [UpgradeWizard] - Running SQL file /var/www/suitecrm/sandbox/shared/cache/upgrades/temp/HJmseO/scripts/65x_to_65x_mysql.sql
Mon, 28 Oct 2019 13:33:49 -0500 [UpgradeWizard] - *** Skipping schema upgrade for point release.
Mon, 28 Oct 2019 13:33:49 -0500 [UpgradeWizard] - Rebuilding JS Langauages
Mon, 28 Oct 2019 13:33:49 -0500 [UpgradeWizard] - Rebuilding Dashlets
Mon, 28 Oct 2019 13:33:49 -0500 [UpgradeWizard] - At updateVersions()... updating config table and sugar_version.php.
Mon, 28 Oct 2019 13:33:49 -0500 [UpgradeWizard] - sugar_version.php successfully updated!
Mon, 28 Oct 2019 13:33:49 -0500 [UpgradeWizard] - Deleting old DB version info from config table.
Mon, 28 Oct 2019 13:33:49 -0500 [UpgradeWizard] - Inserting updated version info into config table.
Mon, 28 Oct 2019 13:33:49 -0500 [UpgradeWizard] - updateVersions() complete.
Mon, 28 Oct 2019 13:33:49 -0500 [UpgradeWizard] - rebuild grouping js files..
Mon, 28 Oct 2019 13:33:49 -0500 [UpgradeWizard] - unlink: cache/include/javascript/sugar_grp1.js
Mon, 28 Oct 2019 13:33:49 -0500 [UpgradeWizard] - cwd: /var/www/suitecrm/sandbox/releases/20190906145159
Mon, 28 Oct 2019 13:33:51 -0500 [UpgradeWizard] - updating UpgradeWizard code post install from: cache/include/javascript/sugar_grp1.js
Mon, 28 Oct 2019 13:33:51 -0500 [UpgradeWizard] - updating UpgradeWizard code post install: cache/include/javascript/sugar_grp1.js
Mon, 28 Oct 2019 13:33:51 -0500 [UpgradeWizard] - updating UpgradeWizard code post install from: /var/www/suitecrm/sandbox/shared/cache/upgrades/temp/HJmseO/scripts/files_to_add_post/include/
Mon, 28 Oct 2019 13:33:51 -0500 [UpgradeWizard] - updating UpgradeWizard code post install: include/
Mon, 28 Oct 2019 13:33:51 -0500 [UpgradeWizard] - updating UpgradeWizard code post install from: /var/www/suitecrm/sandbox/shared/cache/upgrades/temp/HJmseO/scripts/files_to_add_post/modules/
Mon, 28 Oct 2019 13:33:51 -0500 [UpgradeWizard] - updating UpgradeWizard code post install: modules/
Mon, 28 Oct 2019 13:33:51 -0500 [UpgradeWizard] - updating UpgradeWizard code post install from: /var/www/suitecrm/sandbox/shared/cache/upgrades/temp/HJmseO/scripts/files_to_add_post/themes/
Mon, 28 Oct 2019 13:33:51 -0500 [UpgradeWizard] - updating UpgradeWizard code post install: themes/
Mon, 28 Oct 2019 13:33:51 -0500 [UpgradeWizard] - Performing UWrebuild()...
Mon, 28 Oct 2019 13:33:51 -0500 [UpgradeWizard] - UWrebuild() done.
Mon, 28 Oct 2019 13:33:51 -0500 [UpgradeWizard] - post_install() done.
Mon, 28 Oct 2019 13:33:51 -0500 [UpgradeWizard] - check if current_db_version in $_SESSION equals target_db_version in $_SESSION
Mon, 28 Oct 2019 13:33:51 -0500 [UpgradeWizard] - finished check to see if current_db_version in $_SESSION equals target_db_version in $_SESSION
Mon, 28 Oct 2019 13:33:51 -0500 [UpgradeWizard] - running deleteChance() function
Mon, 28 Oct 2019 13:33:51 -0500 [UpgradeWizard] - running deleteCache() function
Mon, 28 Oct 2019 13:33:51 -0500 [UpgradeWizard] - call addNewSystemTabsFromUpgrade(upload://upgrades/patch/SuiteCRM-Upgrade-7.11.x-to-7.11.8-restore)
Mon, 28 Oct 2019 13:33:51 -0500 [UpgradeWizard] - check to see if new modules exist
Mon, 28 Oct 2019 13:33:51 -0500 [UpgradeWizard] - new modules to add are array (
)
Mon, 28 Oct 2019 13:33:51 -0500 [UpgradeWizard] - module tabs updated
Mon, 28 Oct 2019 13:33:51 -0500 [UpgradeWizard] - finished addNewSystemTabsFromUpgrade
Mon, 28 Oct 2019 13:33:51 -0500 [UpgradeWizard] - Registering upgrade with UpgradeHistory
Mon, 28 Oct 2019 13:33:51 -0500 [UpgradeWizard] - Rebuilding style js file: cache/themes/SuiteP/js/style-min.js
Mon, 28 Oct 2019 13:33:51 -0500 [UpgradeWizard] - Rebuilding language cache
23

If the upgrade fails at the very end, and your ā€œAboutā€ shows the new version, then I wouldnā€™t worry unless you experience other problems. Iā€™ve had this happen to me and I didnā€™t see any problems later.

The upgrader needs to be fixed, of course, it has received a few fixes already for the upcoming version, letā€™s hope this doesnā€™t keep happening.

24

There are 5 steps in the upgrade process according to the UI

1: System Check
2: Upload Upgrade Package
3: Preflight Check
4: Commit Upgrade
5: Confirm Layouts

The big one is step 4, thatā€™s the one that works for awhile and copies all the files and looks like it did 99% of the work, then shows the blank white page (or if you have PHP warning on, a bunch of warnings). It never hits step 5. In fact if I go back to the upgrade UI now, it defaults to highlighting step 4 with only a next button. If I click next it shows the popup stating ā€˜Update Scripts in Progressā€™, seems like its re-running step 4 again.

So although step 4 probably did complete properly the wizard is in a hung broken state and step 5 never ran. Not even sure what step 5 is or if its important to the actual upgrade process. If you think step 5 isnā€™t important, and I can ā€œun hang/resetā€ the upgrade wizard, then I might just keep this 7.11.8 upgrade and call it safe?

25

In my last post I stated the upgrade UI was kind of hung on step 4 with only a Next button showing. I went ahead and click next and it shows the popup stating ā€œUpdate Scripts in Progressā€ for a few minutes, then it finished! It said


Click Done to exit the Upgrade Wizard.
The upgrade is complete. If you plan to apply another upgrade package using the Upgrade Wizard, log out and log back in prior to doing so.

When I click done button it takes be to the About page which shows the correct version. Going back to the upgrade UI it now looks reset back to step 1 which seems great. Using git I can see this second round modified only a single file, the .htaccess file.

I am hoping this upgrade is 100% successful. Now I have to do this 2 step attempt in production as well, hopefully it is repeatable.

26

You might be interested in knowing that 7.11.9 is coming out today.

It includes fixes to the upgrader, as well as many others.

1 Like
27

Hi,

anybody solved the problem?

I canā€™t update since 7.11.7, alway the same problem. sugar error and white page after step 4. Tested today with 7.11.10. Donā€™t now what to do :frowning:

Frank

28

Hi Frawi any update on this issue. Did you resolve it as I am also getting the same error

29

Hi pdoshi,
sorry for the late answer due to a big project an vacation.
No solution for the problem but i will start working on it again in the next days starting with a test server.
Regards, Frank

30

Solved: it seems to work an update to 7.11.15 directly from 7.11.7. There was an patch released with 7.11.14: https://docs.suitecrm.com/admin/releases/7.11.x/#_7_11_14 but I didnā€™t need this.
Regards
Frank

1 Like