Upgrade to 2.9.2 failed Error 500

[Arunas]

Hey guys,

I'm trying to upgrade to 2.9.2 but I get error 500.
This is what I found in logfile

[2015-02-06 14:49:33] Espo.ERROR: API [POST]:/:controller/action/:action, Params:Array
(
[controller] => Admin
[action] => uploadUpgradePackage
)
, InputData: data:application/x-zip-compressed;base64,UEsDBAoAAAAAAFNkPUYAAAAAAAAAAAAA AAAGABwAZmlsZXMvVVQJAAO+DMpUIxLKVHV4CwABBOgDAAAE6A MAAF
BLAwQKAAAAAABTZD1GAAAAAAAAAAAAAAAADgAcAGZpbGVzL2lu c3RhbGwvVVQJAAO+DMpUUxLKVHV4CwABBOgDAAAE6AMAAFBLAw QKAAAAAABTZD1GAAAAAAAAAAAAAAAADQAcAGZpbG
VzL2NsaWVudC9VVAkAA74MylRTEspUdXgLAAEE6AMAAAToAwAA UEsDBBQAAAAIAFRkPUY60pxjoFsCAMmlCQAYABwAZmlsZXMvY2 xpZW50L2VzcG8ubWluLmpzVVQJAAPADMpUwAzKVH
V4CwABBOgDAAAE6AMAAKx9/XfbNrLo7++vsNg8hYwgWXLa3lsqME/rpJv2pkk2Tre7V1b20BIkMaFIhYRsuab6t9+ZwQdBSk5733nds zEJ4mMwGMw3oNMnnRNRbvJZsT45G46+6Q9H/b
PvTp6c/p/OYpvNZJJnvmDbbC4WSSbmwb0pPfnoi+D+Ji5OJBeDVGRLuWIZ3 w3k3UbAp3Eh5LbITnaDpPwtyeb5LRRGnVE44hwaZPlcvIea3a6 MOsPQi4sivvPgU1ZVnhnD68B7t+sPoV
xCebZdX4sCauEY+eJEQuvzIfzTH50k2YkI9ha672vonk/ElN/va4BEPFv5YrCOJfy9DapqMmXOZLPgXk6yKe8M9wGTdZc/+sH9m+uPYiYHChtvi3wjCnnny1VSDmbQq4Bx2JDdL4UMbY
/BvRr5fr/HDrGu2G1iQAlgSz/1fonlalDg49p3pvEW4JEIEU6lGCcLPwNc2OXodpvYDKBCwb15L OO+15ODQmzSeCb8N8zrPxp5wUDmr/JbUVzEpfADWC4xAFC/l7JIrrdS+EXAvBJesm
WNZERHcXefcU8WW0FLRCu2iNPSvI5CWJs0VW/4FPaynqdee1n4eSBFKf0siH6+fPN6sIkLGD4Lwmw/ozVIgvv9q0EppJ7tXkDXJ1k9T7N2WY2ZXy1eYZ1s6b/q0lFd+g9fzUH3kg9iKL
8RL1KxFpnUQAC97Osm/42gALXnhT/2BRcTOQ0A2x0X22NL5KJuaCdxD2uBxP+joQMZBJYEl7AyUM+hu sIC3pFAS2mKZUwEuAX2Aa68rJf54X5MLycC90zd+GBZJQH4N7U yLmiLJJWi8C
XDnTCW3C0J9n9h5KUCH6uf86ECocbPRirM2o5wUq/jNfAM5sn4OhUeINopRgqvpx7JUAJARSkvVkk6hyaFF0RExno5y x/u3sdLaurJ63x+5wWT4bSqxCDebEQ2p3aw/fPbTBTP89kWGw
1mhYiloQjbMAidlV1IF73E57iPxE5E0dhHHn6E5j3v1Oupqszp aSVr7rSVwAPEzFe1LEXJSI8gJ6NpKGAnr/MbcTCC2+tc1jSLfWc1Xy74cJydF+Oi1wteqo02KabMW6b5dZy+ uIlTj3
WAw77Eafiy/S1w1m+pR6ERgEITlrOSxWzLUqSz5moRjb0crOLyObAkmDQw85y/hP03E2UJ76zkCh7J8oClPB+IG1zDILifi1RIcVJC62yeClbqT8 jKcYoJsvw0wMeMD2GK6SSZ6gmPi/
NsnMFkd6rRIJ7PYYiEYR3g7QGwmwZQMX/lALUlxiyBWHzg53HAXmkYt4CJGhVrFxX8OA0+RJoozp54QF+Dz 1tR3F3CZGcyL75P0+iwyNaeTC19uGKgqmRjyyBU0W6wFsVS+CD 9GPFaC/
ddA25p2zWlw9hLss1WEhPvdnOpOIUm0wh2zErMPok5zFs/hb7TAgCWgMIYthW9I5JJbsbbVP4jTrfAUxuvruzW8CHPU3LdTH pc0zYCEBdQdYhS7VfY2hpuEHtlmoDQGwVAFLDo/Lk0ZJ
H0+2OUkaAUSKCEXsbaA+iHoobmVZNhCdREgFVleUbSbzeYIdEw b56UIGyBaVRVBwrzTMZJVrYZDXMn+hI5b81RgFAu8jVgUMwv5V 0KRMKQvTgNPre3uNqAHBSYEvZAbHf8OD4vxyVsgA
JEVzllxaDEHnH7wStX+7xgXp7OLdygDuhqA13GZET1UfXC6XZo Yf1WLe5BWxL2rQ/dLuCuCOpB9Q5rjsveQSVLgwH8F6ox/YRTe+YD/bkAdBLoU7GNVldJlIVqQQpnQeA/IhxA0cN4kc
4YB/PwjpQeQYSMNLa8UPUVHNMQ3siGUsffawkgbeUiInVwHe98YGwg APo+THsI8sQvJmc4wGYH3MDVTXWfSA81eeQctUW/iLzrvJiD5hx6SJdAhiAzvw6922QuV7hwMhqFQySh8dfn+T
jv8bPAW8fFMsn09vfLnqX0rPdRTvIp6wxhLNhjkW97NZX79bbY AOtFxaPZyPTeOWygQVX1e95vBKNuF4QuIEf7rks7B5B/uW+D/dJRv1tLhTW5izbY3YsFECL1FJq3lyJZrkCi8ZdSyb
jdoNxuNnkhB9f57jL5HcADolLQ9KGowUhsFYBsBGIRxerwnCdV hdyA84Q4Y8JvFHAgN+Gz8xXmnAAjINJEtZVdaN6dWC0vGRe8hH pH4Hon0gS1sKpKyLSou0k4Ke4/pnmMfQFBGm0w6R
n6g01RHqM2oMsctCEg2xq57xwtKAfm81qCqLKaPvSU8V8Uv2P1 7u928ctOcvh/Ve1871myKIBvnNC/amD+ePj4hBaJnla0Gvh4eg4mEGLZg3/eg3jyLJcIr9N89umkk6wRHTHCHGiF8X
2Okkvzby3JwY5DCECxHOg5KhsXQHILDdcPbHsmB7dFggrcsw6U oTAFdXCdnj9T/6LeCVBCtVmaayPNYGGHAlSi8Qo7iLAFcpU5gv2XhmDf+W21VjT nhGOhjFSUlwHcDtO0C6FVT4DEEY
r/tvxGjZaMtbXzPdrxaE9oM1vWFoJE1gSr98ioEkFUQC9JEGJvPW/i9XwvJwO7NlMSUPhBvvS8KXB3Gg/sGTIP0RYGTqgbdLhxPaAtQ2hQ1ayqKAM7TELdoQagerTT2rp2j AM4MABjQH
Uc5wNQKCwoR9VsTAwC9sgQtr1salINT8O4bRZmAemwsCPzSdLr TceB1yNhCusRgTVfWHWGlEBGqjvHf7C7YLDNylWyQOsauGPr22 ZbruCDo7OmWb1wtrD0Y7WMW7PqySRGBwgzzhJ4bb
tJdJOUx77qT7c9QFRaVTlwk0k6jfKo4295GoRWdQ1xb4EajtZC aeeSAtPEfzojWG623ROJoW8l52jX5pnl1W5zQBgqX8kE0DTtdm Gbw8LUU59lLcsFKCb+GO8uhZQAcDlYpLF8s8G6ZV
VpKyNTpIMOoU7D8eL7CZRFIixQEQDYggCdRlixluOolWtDApCJ Rr5rsG0yI12MwLbmFGrVioWUYI2Ieo5jmBOq/jDXcbAdKHThJm4CB+rNYJ2syQgD6wDVvXfo5stK8VLEwCN970L 133
+vTFWkyyKwuyVGNTmGHdLt4r9qxxZglm3tIiXB+BrYy6c91ER4 oFUW5Ao03Hr3tjPlDOlstR0OM7sRhRRFCQTvnXg9/DAN7nOe6B5LlCMgyvY5B9IpjZzJQR3tqMl3uzUgIAEzkOcOVT
lGe9ZiVLW5ivQ0c3GrNxqhYgZaF2GjJAPBgTlIJ2Vzf095Y07l lCgn5zOzPOOcrA604tUa/JiIdF4CzMhDJkfKgZCA+rfdLpCQgvBHcsKgosrdAnSz2BkEaLr mzBkZh1UUk+PSWM4JZY
hIwGIHP+HylGBAb2k5clilFDYRPbJOGTjmNlIFTwYgJBLpQ+WA xYAp7B9VLdtFjCtqe6E3oJ0S6nWGUUmmeoj/dLCAnAJYh83smmKvgUNgJdXE4UFvERNPror8tvSmgeSlb3g9+v jUu/
bpbazvtZQgB0OPNJhCFEVeeIz+hGW0Cb3X+YlawZKIpsjXSJYw FZkjFvb7fbOfckumjMcQ9aCI1wT3onb4noAq+B42Yb6VvuMN3j mOTeBuO3SaZ/mt6/a9PMYZuP86A0VMcXaAFqaIJc
jsAlhz1N8TY/6VpMb3lD84AYJSPjmwd8EADQ6N3I9ZQ9EloxI7/JQZF1IMUD4XC8CZmINIi9Pb+K50p6X9NdsB/F0j1+bOR1RYA+OYtVa85DsQ4Ygx1HJqkycFrTMuCHe9dDDfFjF 205
fI57LTugRUUIBz1C/I+gXBMpC3QmSlwcJWG3umHLbmoAAZn1sOHQPmZbK4+y2RIOXYJ AX2AAycjc6BnrdgTfoxbs48vRG2ylTJJWAg8WADlJIAD7jHSYe CwfumDF3vEQCdb6RTBoLgvt
yIWRKnL+ISBE94v98D5lleJGASxakOKySiDKUt1HIpzJhFTWiR Z/ARZhY1TM04BJmtdMD3+B42dRpl1OwG9A3mlg4QVGKX6nHQAJSI T38QVGLxaDFPGkeBuiIAmm+cAY1aiq46GbWWKh
yOHRI5wSCJcvLBprfOPLuMmVrGkeMtPVwmBjZLiMWoHzZKKQaD sZgZUAytGI31PPNnR+cdNLfTp8zupxRkumlTb6s60rSON9DnJa AT9rmr9JlhcC3BYHNfjfOfmixAqYWlLnxLPltmaC
3OknWYss9bsRWh7oFeQBVhNLFlge4W/cm8oy2SCVOKz2bSs3y9wT0cDBZxkpoa+Gz3uy5Tbw7Det7WrVD M1gqUDkyBoQFGWkpSM0ODkjzNoNPBirLaesiVCZuDCNAf4Rl0O 5ahFwa+kZ
abM81xsIIyssGMeZnnn0rsFcSEp4JrHgBQonZh4m6oMNi2xbQG Mw8UtKB96FEBLooFJjomhQDzxHFVHvJNq14glQGJAQ/YGDuaLRqhz1fkHlhpdxyY/otduc... [] []
[2015-02-06 14:49:33] Espo.ERROR: Display Error: Your EspoCRM version doesn't match for this installation package., Code: 500 URL: /crm/api/
v1/Admin/action/uploadUpgradePackage [] []
[2015-02-06 14:51:01] Espo.ERROR: API [GET]:/Admin/clearCache, Params:Array
(
)
, InputData: - Error while clearing cache [] []
[2015-02-06 14:51:01] Espo.ERROR: Display Error: Error while clearing cache, Code: 500 URL: /crm/api/v1/Admin/clearCache [] []




I check version and I see it is upgraded to 2.9.2, but whenever I try to clean up cache or rebuild backend i get Error 500. Please advise.

[yuri]

It could be an issue with permission I believe. check your permissions of data/upload, data/cache dirictories.

And then you can run php rebuil.php in CLI

[Arunas]

not sure what happened, but version is not changed to 2.9.2.
However I can't upgrade to to 3.0.0. it gives Errror 404

[Arunas]

By the way, logs didn't show any error :/

[tarasm]

It seems like you are using wrong upgrade package, Please use the following packages:
1. To upgrade from 2.9.2 to 3.0.0 use this package http://sourceforge.net/projects/espo...0.zip/download
2. To upgrade from 3.0.0. to 3.0.1 - http://sourceforge.net/projects/espo...1.zip/download

[Arunas]

It seems like you are using wrong upgrade package, Please use the following packages:
1. To upgrade from 2.9.2 to 3.0.0 use this package http://sourceforge.net/projects/espo...0.zip/download
2. To upgrade from 3.0.0. to 3.0.1 - http://sourceforge.net/projects/espo...1.zip/download

I use exactly the same packages as you mentioned. However I have noticed that during upgrade process my apache install child processes crashing. So this could be server side related. might be mpm itk module not playing nicely with apache threads.

[Arunas]

OK, afetr rebuilding apache with ZTS thread safty turned off it finally worked. However during the upgrade clear cache failure accures and here is what i found in logfile

[2015-02-23 20:26:13] Espo.ERROR: API [POST]:/:controller/action/:action, Params:Array
(
[controller] => Admin
[action] => runUpgrade
)
, InputData: {"id":"54eb8cdc5a5d5"} - Error while clearing cache [] []
[2015-02-23 20:26:13] Espo.ERROR: Display Error: Error while clearing cache, Code: 500 URL: /crm/api/v1/Admin/action/runUpgrade [] []
[2015-02-23 20:26:17] Espo.ERROR: Uncaught exception {"exception":"[object] (PDOException: SQLSTATE[42S22]: Column not found: 1054 Unknown column 'user.is_active' in 'field list' at /usr/local/www/tools/crm/application/Espo/ORM/DB/Mapper.php:132)"} []
[2015-02-23 20:26:19] Espo.ERROR: Uncaught exception {"exception":"[object] (PDOException: SQLSTATE[42S22]: Column not found: 1054 Unknown column 'user.is_active' in 'field list' at /usr/local/www/tools/crm/application/Espo/ORM/DB/Mapper.php:132)"} []
[2015-02-23 20:26:28] Espo.ERROR: Uncaught exception {"exception":"[object] (PDOException: SQLSTATE[42S22]: Column not found: 1054 Unknown column 'user.is_active' in 'field list' at /usr/local/www/tools/crm/application/Espo/ORM/DB/Mapper.php:132)"} []
[2015-02-23 20:26:32] Espo.ERROR: Uncaught exception {"exception":"[object] (PDOException: SQLSTATE[42S22]: Column not found: 1054 Unknown column 'user.is_active' in 'field list' at /usr/local/www/tools/crm/application/Espo/ORM/DB/Mapper.php:132)"} []
[2015-02-23 20:26:38] Espo.ERROR: Uncaught exception {"exception":"[object] (PDOException: SQLSTATE[42S22]: Column not found: 1054 Unknown column 'user.is_active' in 'field list' at /usr/local/www/tools/crm/application/Espo/ORM/DB/Mapper.php:132)"} []
[2015-02-23 20:26:47] Espo.ERROR: Uncaught exception {"exception":"[object] (PDOException: SQLSTATE[42S22]: Column not found: 1054 Unknown column 'user.is_active' in 'field list' at /usr/local/www/tools/crm/application/Espo/ORM/DB/Mapper.php:132)"} []
[2015-02-23 20:26:48] Espo.ERROR: Uncaught exception {"exception":"[object] (PDOException: SQLSTATE[42S22]: Column not found: 1054 Unknown column 'user.is_active' in 'field list' at /usr/local/www/tools/crm/application/Espo/ORM/DB/Mapper.php:132)"} []

[Arunas]

I no longer able to login, blank screen with error "Bad servers response"

log:
Espo.ERROR: Uncaught exception {"exception":"[object] (PDOException: SQLSTATE[42S22]: Column not found: 1054 Unknown column 'user.is_active' in 'field list' at /usr/local/www/tools/crm/application/Espo/ORM/DB/Mapper.php:132)"} []

[tarasm]

Please log via SSH and run this command:

php rebuild.php

[Arunas]

Please log via SSH and run this command:

php rebuild.php

Thank you it worked. it still produced lot of same errors in log, but I was able to login. I have upgraded to version 3.0.1
this time it through me error re not able to clear cache. but everything works fine so far.

[tarasm]

Please remove the cache manually, the path is /data/cache. When you run "php rebuild.php" the owner of new files is the current user (user who is logged via SSH). That's why web server doesn't have writable permission to the cache.

[Arunas]

OK that worked Looks like there is issue with mpm-itk apache module not sure why cache is created with root, when i access CRM via web. I changed ownership to www, then I was able to clear caceh via GUI in admin section.