[SOLVED] Update 1.0.5 to 1.0.6 customers configuration files Failed

[bobiturboto]

After i try to upgrade i get this error on final step

Code:

    Rebuilding all customers configuration files
     Please wait, this may take some time:                           Failed

    FATAL: An error was occured during update process!
    Correct it and re-run this program.

In error log is shown this :

Code:

Can't use string ("") as an ARRAY ref while "strict refs" in use at /var/www/ispcp/engine/ispcp-rqst-mngr line 245.

Finally how to restore ispcp before upgrade ?

[sci2tech]

You have an orphan entry in subdomain table.
Find orphan entry with:

Quote:-- check orphan subdomains records entries (not existing domain)
select * from `subdomain` where not exists (select `domain_id` from `domain` where `domain`.`domain_id` = `subdomain`.`domain_id`)

and eliminate, then restart upgrade process. And good luck

[bobiturboto]

(09-01-2010 05:33 AM)sci2tech Wrote:  You have an orphan entry in subdomain table.
Find orphan entry with:

Quote:-- check orphan subdomains records entries (not existing domain)
select * from `subdomain` where not exists (select `domain_id` from `domain` where `domain`.`domain_id` = `subdomain`.`domain_id`)

and eliminate, then restart upgrade process. And good luck

I check my subdomains there no non existing.

[bobiturboto]

Any suggestions ? My server has be down from 24 hours . I try to make upgrade with 1.0.5 but same error. Write me how to downgrade to my last version because my users are "wants to kill me "

[sci2tech]

Please post result when running

Code:

select subdomain_id, subdomain_name, subdomain_status from subdomain where subdomain_status != 'ok' order by subdomain_id

.

[bobiturboto]

Code:

mysql> select subdomain_id, subdomain_name, subdomain_status from subdomain where subdomain_status != 'ok' order by subdomain_id;
+--------------+----------------+------------------+
| subdomain_id | subdomain_name | subdomain_status |
+--------------+----------------+------------------+
|            4 | client         | change           |
|            8 | ads            | change           |
|           11 | obiavi         | change           |
|           14 | ads            | change           |
|           18 | hriart         | change           |
|           19 | pulseofgems    | change           |
|           20 | b              | change           |
+--------------+----------------+------------------+
7 rows in set (0.00 sec)

Two subdomains "ads" are consistent.

[sci2tech]

If you say that

Code:

select * from `subdomain` where not exists (select `domain_id` from `domain` where `domain`.`domain_id` = `subdomain`.`domain_id`)

return and empty result, and as I see your table seems ok, maybe error is not located /var/www/ispcp/engine/ispcp-rqst-mngr line 245. Or maybe is not ispcp v1.0.5 but i doubt. Here are some sql query that will reveal any orphan entry in database:

Code:

-- Check orphan admins not having domain
select * from `admin` where not exists (select `domain_admin_id` from `domain` where `domain`.`domain_admin_id` = `admin`.`admin_id`) AND `admin_type` not in ('reseller', 'admin')

-- check orphan domain (not having admin)
select * from `domain` where not exists (select `admin_id` from `admin` where `domain`.`domain_admin_id` = `admin`.`admin_id`)

-- check orphan domain trafic entries (not existing domain)
select * from `domain_traffic` where not exists (select `domain_id` from `domain` where `domain`.`domain_id` = `domain_traffic`.`domain_id`)

-- check orphan ftp groups entries (not existing domain)
select * from `ftp_group` where not exists (select `domain_gid` from `domain` where `domain`.`domain_gid` = `ftp_group`.`gid`)

-- check orphan ftp users entries (not existing domain)
select * from `ftp_users` where not exists (select `domain_uid` from `domain` where `domain`.`domain_uid` = `ftp_users`.`uid`)

-- check orphan ftp users entries (not existing ftp group)
select * from `ftp_users` where not exists (select `uid` from `ftp_group` where `ftp_group`.`gid` = `ftp_users`.`gid`)

-- check orphan htaccess entries (not existing domain)
select * from `htaccess` where not exists (select `domain_id` from `domain` where `domain`.`domain_id` = `htaccess`.`dmn_id`)

-- check orphan htaccess groups entries (not existing domain)
select * from `htaccess_groups` where not exists (select `domain_id` from `domain` where `domain`.`domain_id` = `htaccess_groups`.`dmn_id`)

-- check orphan htaccess users entries (not existing domain)
select * from `htaccess_users` where not exists (select `domain_id` from `domain` where `domain`.`domain_id` = `htaccess_users`.`dmn_id`)

-- check orphan mails users entries (not existing domain)
select * from `mail_users` where not exists (select `domain_id` from `domain` where `domain`.`domain_id` = `mail_users`.`domain_id`)

-- check orphan mails users entries (not existing subdomain)
select * from `mail_users` where not exists (select `subdomain_id` from `subdomain` where `subdomain`.`subdomain_id` = `mail_users`.`sub_id`) and `sub_id` != 0

-- check orphan quotalimits entries (not existing domain)
select * from `quotalimits` where not exists (select `domain_name` from `domain` where `domain`.`domain_name` = `quotalimits`.`name`)

-- check orphan quotatallies entries (not existing domain)
select * from `quotatallies` where not exists (select `domain_name` from `domain` where `domain`.`domain_name` = `quotatallies`.`name`)

-- check orphan databses records entries (not existing domain)
select * from `sql_database` where not exists (select `domain_id` from `domain` where `sql_database`.`domain_id`=`domain`.`domain_id`)

-- check orphan sql users records entries (not existing database)
select * from `sql_user` where not exists (select `sqld_id` from `sql_database` where `sql_user`.`sqld_id`=`sql_user`.`sqld_id`)

-- check orphan subdomains records entries (not existing domain)
select * from `subdomain` where not exists (select `domain_id` from `domain` where `domain`.`domain_id` = `subdomain`.`domain_id`)

-- check orphan gui props records entries (not existing uset)
select * from `user_gui_props` where not exists (select `admin_id` from `admin` where `user_gui_props`.`user_id` = `admin`.`admin_id`)

please test carefully and double check if entry is really orphan before eliminate. if you find some eliminate. also enable debug (in /etc/ispcp/ispcp.conf DEBUG = 1), manually run /var/www/ispcp/engine/ispcp-rqst-mngr and post here output.
Better start with debug enabling to check output, only then clean database

[bobiturboto]

Code:

perl ispcp-rqst-mngr
DEBUG: push_el() sub_name: mngr_start_up(), msg: Starting...
DEBUG: push_el() sub_name: lock_system(), msg: Starting...
DEBUG: push_el() sub_name: lock_system(), msg: Ending...
DEBUG: push_el() sub_name: get_conf(), msg: Starting...
DEBUG: push_el() sub_name: get_file(), msg: Starting...
DEBUG: push_el() sub_name: get_file(), msg: Ending...
DEBUG: push_el() sub_name: setup_main_vars(), msg: Starting...
DEBUG: push_el() sub_name: decrypt_db_password(), msg: Starting...
DEBUG: push_el() sub_name: decrypt_db_password(), msg: Ending...
DEBUG: push_el() sub_name: setup_main_vars(), msg: Ending...
DEBUG: push_el() sub_name: get_conf(), msg: Ending...
DEBUG: push_el() sub_name: doSQL(), msg: Starting...
DEBUG: push_el() sub_name: doSQL(), msg: Ending...
DEBUG: push_el() sub_name: mngr_start_up(), msg: Ending...
DEBUG: push_el() sub_name: mngr_engine(), msg: Starting...
DEBUG: push_el() sub_name: doSQL(), msg: Starting...
DEBUG: push_el() sub_name: doSQL(), msg: Ending...
DEBUG: push_el() sub_name: doSQL(), msg: Starting...
DEBUG: push_el() sub_name: doSQL(), msg: Ending...
DEBUG: push_el() sub_name: doSQL(), msg: Starting...
DEBUG: push_el() sub_name: doSQL(), msg: Ending...
DEBUG: push_el() sub_name: mngr_engine(), msg: processing 4, client, change.
DEBUG: push_el() sub_name: sys_command(), msg: Starting...
DEBUG: push_el() sub_name: sys_command('/var/www/ispcp/engine/ispcp-sub-mngr 4 1>/var/log/ispcp/ispcp-sub-mngr.stdout 2>/var/log/ispcp/ispcp-sub-mngr.stderr'), msg: Ending...
DEBUG: push_el() sub_name: mngr_engine(), msg: processing 8, ads, change.
DEBUG: push_el() sub_name: sys_command(), msg: Starting...
DEBUG: push_el() sub_name: sys_command('/var/www/ispcp/engine/ispcp-sub-mngr 8 1>/var/log/ispcp/ispcp-sub-mngr.stdout 2>/var/log/ispcp/ispcp-sub-mngr.stderr'), msg: Ending...
DEBUG: push_el() sub_name: mngr_engine(), msg: processing 11, obiavi, change.
DEBUG: push_el() sub_name: sys_command(), msg: Starting...
DEBUG: push_el() sub_name: sys_command('/var/www/ispcp/engine/ispcp-sub-mngr 11 1>/var/log/ispcp/ispcp-sub-mngr.stdout 2>/var/log/ispcp/ispcp-sub-mngr.stderr'), msg: Ending...
DEBUG: push_el() sub_name: mngr_engine(), msg: processing 14, ads, change.
DEBUG: push_el() sub_name: sys_command(), msg: Starting...
DEBUG: push_el() sub_name: sys_command('/var/www/ispcp/engine/ispcp-sub-mngr 14 1>/var/log/ispcp/ispcp-sub-mngr.stdout 2>/var/log/ispcp/ispcp-sub-mngr.stderr'), msg: Ending...
DEBUG: push_el() sub_name: mngr_engine(), msg: processing 18, hriart, change.
DEBUG: push_el() sub_name: sys_command(), msg: Starting...
DEBUG: push_el() sub_name: sys_command('/var/www/ispcp/engine/ispcp-sub-mngr 18 1>/var/log/ispcp/ispcp-sub-mngr.stdout 2>/var/log/ispcp/ispcp-sub-mngr.stderr'), msg: Ending...
DEBUG: push_el() sub_name: mngr_engine(), msg: processing 19, pulseofgems, change.
DEBUG: push_el() sub_name: sys_command(), msg: Starting...
DEBUG: push_el() sub_name: sys_command('/var/www/ispcp/engine/ispcp-sub-mngr 19 1>/var/log/ispcp/ispcp-sub-mngr.stdout 2>/var/log/ispcp/ispcp-sub-mngr.stderr'), msg: Ending...
DEBUG: push_el() sub_name: mngr_engine(), msg: processing 20, b, change.
DEBUG: push_el() sub_name: sys_command(), msg: Starting...
DEBUG: push_el() sub_name: sys_command('/var/www/ispcp/engine/ispcp-sub-mngr 20 1>/var/log/ispcp/ispcp-sub-mngr.stdout 2>/var/log/ispcp/ispcp-sub-mngr.stderr'), msg: Ending...
DEBUG: push_el() sub_name: doSQL(), msg: Starting...
DEBUG: push_el() sub_name: doSQL(), msg: Ending...
DEBUG: push_el() sub_name: mngr_engine(), msg: processing 6, turbogamer.org, change.
DEBUG: push_el() sub_name: sys_command(), msg: Starting...
DEBUG: push_el() sub_name: sys_command('/var/www/ispcp/engine/ispcp-als-mngr 6 1>/var/log/ispcp/ispcp-als-mngr.stdout 2>/var/log/ispcp/ispcp-als-mngr.stderr'), msg: Ending...
DEBUG: push_el() sub_name: doSQL(), msg: Starting...
DEBUG: push_el() sub_name: doSQL(), msg: Ending...
DEBUG: push_el() sub_name: doSQL(), msg: Starting...
DEBUG: push_el() sub_name: doSQL(), msg: Ending...
DEBUG: push_el() sub_name: sys_command(), msg: Starting...
DEBUG: push_el() sub_name: sys_command('/var/www/ispcp/engine/ispcp-serv-mngr 0 7 1 0 0 1>/var/log/ispcp/ispcp-serv-mngr.stdout 2>/var/log/ispcp/ispcp-serv-mngr.stderr'), msg: Ending...
DEBUG: push_el() sub_name: doSQL(), msg: Starting...
DEBUG: push_el() sub_name: doSQL(), msg: Ending...
DEBUG: push_el() sub_name: mngr_engine(), msg: processing 1, change.
DEBUG: push_el() sub_name: sys_command(), msg: Starting...
DEBUG: push_el() sub_name: sys_command('/var/www/ispcp/engine/ispcp-htusers-mngr 1 1>/var/log/ispcp/ispcp-htusers-mngr.stdout 2>/var/log/ispcp/ispcp-htusers-mngr.stderr'), msg: Ending...
DEBUG: push_el() sub_name: mngr_engine(), msg: processing 2, change.
DEBUG: push_el() sub_name: sys_command(), msg: Starting...
DEBUG: push_el() sub_name: sys_command('/var/www/ispcp/engine/ispcp-htusers-mngr 2 1>/var/log/ispcp/ispcp-htusers-mngr.stdout 2>/var/log/ispcp/ispcp-htusers-mngr.stderr'), msg: Ending...
DEBUG: push_el() sub_name: mngr_engine(), msg: processing 5, change.
DEBUG: push_el() sub_name: sys_command(), msg: Starting...
DEBUG: push_el() sub_name: sys_command('/var/www/ispcp/engine/ispcp-htusers-mngr 5 1>/var/log/ispcp/ispcp-htusers-mngr.stdout 2>/var/log/ispcp/ispcp-htusers-mngr.stderr'), msg: Ending...
DEBUG: push_el() sub_name: mngr_engine(), msg: processing 6, change.
DEBUG: push_el() sub_name: sys_command(), msg: Starting...
DEBUG: push_el() sub_name: sys_command('/var/www/ispcp/engine/ispcp-htusers-mngr 6 1>/var/log/ispcp/ispcp-htusers-mngr.stdout 2>/var/log/ispcp/ispcp-htusers-mngr.stderr'), msg: Ending...
DEBUG: push_el() sub_name: mngr_engine(), msg: processing 7, change.
DEBUG: push_el() sub_name: sys_command(), msg: Starting...
DEBUG: push_el() sub_name: sys_command('/var/www/ispcp/engine/ispcp-htusers-mngr 7 1>/var/log/ispcp/ispcp-htusers-mngr.stdout 2>/var/log/ispcp/ispcp-htusers-mngr.stderr'), msg: Ending...
DEBUG: push_el() sub_name: mngr_engine(), msg: processing 11, change.
DEBUG: push_el() sub_name: sys_command(), msg: Starting...
DEBUG: push_el() sub_name: sys_command('/var/www/ispcp/engine/ispcp-htusers-mngr 11 1>/var/log/ispcp/ispcp-htusers-mngr.stdout 2>/var/log/ispcp/ispcp-htusers-mngr.stderr'), msg: Ending...
DEBUG: push_el() sub_name: mngr_engine(), msg: processing 14, change.
DEBUG: push_el() sub_name: sys_command(), msg: Starting...
DEBUG: push_el() sub_name: sys_command('/var/www/ispcp/engine/ispcp-htusers-mngr 14 1>/var/log/ispcp/ispcp-htusers-mngr.stdout 2>/var/log/ispcp/ispcp-htusers-mngr.stderr'), msg: Ending...
DEBUG: push_el() sub_name: mngr_engine(), msg: processing 19, change.
DEBUG: push_el() sub_name: sys_command(), msg: Starting...
DEBUG: push_el() sub_name: sys_command('/var/www/ispcp/engine/ispcp-htusers-mngr 19 1>/var/log/ispcp/ispcp-htusers-mngr.stdout 2>/var/log/ispcp/ispcp-htusers-mngr.stderr'), msg: Ending...
DEBUG: push_el() sub_name: mngr_engine(), msg: processing 21, change.
DEBUG: push_el() sub_name: sys_command(), msg: Starting...
DEBUG: push_el() sub_name: sys_command('/var/www/ispcp/engine/ispcp-htusers-mngr 21 1>/var/log/ispcp/ispcp-htusers-mngr.stdout 2>/var/log/ispcp/ispcp-htusers-mngr.stderr'), msg: Ending...
DEBUG: push_el() sub_name: doSQL(), msg: Starting...
DEBUG: push_el() sub_name: doSQL(), msg: Ending...
DEBUG: push_el() sub_name: mngr_engine(), msg: processing 4 -> 1, change.
DEBUG: push_el() sub_name: sys_command(), msg: Starting...
DEBUG: push_el() sub_name: sys_command('/var/www/ispcp/engine/ispcp-htgroups-mngr 4 1>/var/log/ispcp/ispcp-htgroups-mngr.stdout 2>/var/log/ispcp/ispcp-htgroups-mngr.stderr'), msg: Ending...
DEBUG: push_el() sub_name: mngr_engine(), msg: processing 5 -> 2, change.
DEBUG: push_el() sub_name: sys_command(), msg: Starting...
DEBUG: push_el() sub_name: sys_command('/var/www/ispcp/engine/ispcp-htgroups-mngr 5 1>/var/log/ispcp/ispcp-htgroups-mngr.stdout 2>/var/log/ispcp/ispcp-htgroups-mngr.stderr'), msg: Ending...
DEBUG: push_el() sub_name: mngr_engine(), msg: processing 17 -> 7, change.
DEBUG: push_el() sub_name: sys_command(), msg: Starting...
DEBUG: push_el() sub_name: sys_command('/var/www/ispcp/engine/ispcp-htgroups-mngr 17 1>/var/log/ispcp/ispcp-htgroups-mngr.stdout 2>/var/log/ispcp/ispcp-htgroups-mngr.stderr'), msg: Ending...
DEBUG: push_el() sub_name: mngr_engine(), msg: processing 18 -> 8, change.
DEBUG: push_el() sub_name: sys_command(), msg: Starting...
DEBUG: push_el() sub_name: sys_command('/var/www/ispcp/engine/ispcp-htgroups-mngr 18 1>/var/log/ispcp/ispcp-htgroups-mngr.stdout 2>/var/log/ispcp/ispcp-htgroups-mngr.stderr'), msg: Ending...
DEBUG: push_el() sub_name: mngr_engine(), msg: processing 19 -> 9, change.
DEBUG: push_el() sub_name: sys_command(), msg: Starting...
DEBUG: push_el() sub_name: sys_command('/var/www/ispcp/engine/ispcp-htgroups-mngr 19 1>/var/log/ispcp/ispcp-htgroups-mngr.stdout 2>/var/log/ispcp/ispcp-htgroups-mngr.stderr'), msg: Ending...
DEBUG: push_el() sub_name: mngr_engine(), msg: processing 21 -> 10, change.
DEBUG: push_el() sub_name: sys_command(), msg: Starting...
DEBUG: push_el() sub_name: sys_command('/var/www/ispcp/engine/ispcp-htgroups-mngr 21 1>/var/log/ispcp/ispcp-htgroups-mngr.stdout 2>/var/log/ispcp/ispcp-htgroups-mngr.stderr'), msg: Ending...
DEBUG: push_el() sub_name: mngr_engine(), msg: processing 22 -> 11, change.
DEBUG: push_el() sub_name: sys_command(), msg: Starting...
DEBUG: push_el() sub_name: sys_command('/var/www/ispcp/engine/ispcp-htgroups-mngr 22 1>/var/log/ispcp/ispcp-htgroups-mngr.stdout 2>/var/log/ispcp/ispcp-htgroups-mngr.stderr'), msg: Ending...
DEBUG: push_el() sub_name: mngr_engine(), msg: processing 26 -> 15, change.
DEBUG: push_el() sub_name: sys_command(), msg: Starting...
DEBUG: push_el() sub_name: sys_command('/var/www/ispcp/engine/ispcp-htgroups-mngr 26 1>/var/log/ispcp/ispcp-htgroups-mngr.stdout 2>/var/log/ispcp/ispcp-htgroups-mngr.stderr'), msg: Ending...
DEBUG: push_el() sub_name: mngr_engine(), msg: processing 27 -> 16, change.
DEBUG: push_el() sub_name: sys_command(), msg: Starting...
DEBUG: push_el() sub_name: sys_command('/var/www/ispcp/engine/ispcp-htgroups-mngr 27 1>/var/log/ispcp/ispcp-htgroups-mngr.stdout 2>/var/log/ispcp/ispcp-htgroups-mngr.stderr'), msg: Ending...
DEBUG: push_el() sub_name: mngr_engine(), msg: processing 28 -> 17, change.
DEBUG: push_el() sub_name: sys_command(), msg: Starting...
DEBUG: push_el() sub_name: sys_command('/var/www/ispcp/engine/ispcp-htgroups-mngr 28 1>/var/log/ispcp/ispcp-htgroups-mngr.stdout 2>/var/log/ispcp/ispcp-htgroups-mngr.stderr'), msg: Ending...
DEBUG: push_el() sub_name: mngr_engine(), msg: processing 31 -> 20, change.
DEBUG: push_el() sub_name: sys_command(), msg: Starting...
DEBUG: push_el() sub_name: sys_command('/var/www/ispcp/engine/ispcp-htgroups-mngr 31 1>/var/log/ispcp/ispcp-htgroups-mngr.stdout 2>/var/log/ispcp/ispcp-htgroups-mngr.stderr'), msg: Ending...
DEBUG: push_el() sub_name: mngr_engine(), msg: processing 34 -> 23, change.
DEBUG: push_el() sub_name: sys_command(), msg: Starting...
DEBUG: push_el() sub_name: sys_command('/var/www/ispcp/engine/ispcp-htgroups-mngr 34 1>/var/log/ispcp/ispcp-htgroups-mngr.stdout 2>/var/log/ispcp/ispcp-htgroups-mngr.stderr'), msg: Ending...
DEBUG: push_el() sub_name: mngr_engine(), msg: processing 39 -> 28, change.
DEBUG: push_el() sub_name: sys_command(), msg: Starting...
DEBUG: push_el() sub_name: sys_command('/var/www/ispcp/engine/ispcp-htgroups-mngr 39 1>/var/log/ispcp/ispcp-htgroups-mngr.stdout 2>/var/log/ispcp/ispcp-htgroups-mngr.stderr'), msg: Ending...
DEBUG: push_el() sub_name: mngr_engine(), msg: processing 41 -> 30, change.
DEBUG: push_el() sub_name: sys_command(), msg: Starting...
DEBUG: push_el() sub_name: sys_command('/var/www/ispcp/engine/ispcp-htgroups-mngr 41 1>/var/log/ispcp/ispcp-htgroups-mngr.stdout 2>/var/log/ispcp/ispcp-htgroups-mngr.stderr'), msg: Ending...
DEBUG: push_el() sub_name: doSQL(), msg: Starting...
DEBUG: push_el() sub_name: doSQL(), msg: Ending...
DEBUG: push_el() sub_name: doSQL(), msg: Starting...
DEBUG: push_el() sub_name: doSQL(), msg: Ending...
DEBUG: push_el() sub_name: doSQL(), msg: Starting...
DEBUG: push_el() sub_name: doSQL(), msg: Ending...
DEBUG: push_el() sub_name: doSQL(), msg: Starting...
DEBUG: push_el() sub_name: doSQL(), msg: Ending...
DEBUG: push_el() sub_name: mngr_engine(), msg: Ending...
DEBUG: push_el() sub_name: mngr_shut_down(), msg: Starting..

This is the output before i clean database. Debug is 1 in ispcp.conf

[sci2tech]

There is no error here. Enable debug in ispcp.conf and ispcp.old.conf then run update. Lets see what are messages when update is running. And please check is database keys are in places (ispcp-db-keys.pl, ispcp-db-keys.php and in ispcp.conf). Did you find any orphan entry?

[bobiturboto]

Code:

    Rebuilding all customers configuration files
     Please wait, this may take some time:DEBUG: push_el() sub_name: update_old_disabled_dmn_layout(), msg: Starting...
DEBUG: push_el() sub_name: update_old_disabled_dmn_layout(), msg: Ending...
DEBUG: push_el() sub_name: rebuild_customers_cfg(), msg: Starting...
DEBUG: push_el() sub_name: doSQL(), msg: Starting...
DEBUG: push_el() sub_name: doSQL(), msg: Ending...
DEBUG: push_el() sub_name: doSQL(), msg: Starting...
DEBUG: push_el() sub_name: doSQL(), msg: Ending...
DEBUG: push_el() sub_name: doSQL(), msg: Starting...
DEBUG: push_el() sub_name: doSQL(), msg: Ending...
DEBUG: push_el() sub_name: doSQL(), msg: Starting...
DEBUG: push_el() sub_name: doSQL(), msg: Ending...
DEBUG: push_el() sub_name: doSQL(), msg: Starting...
DEBUG: push_el() sub_name: doSQL(), msg: Ending...
DEBUG: push_el() sub_name: doSQL(), msg: Starting...
DEBUG: push_el() sub_name: doSQL(), msg: Ending...
DEBUG: push_el() sub_name: doSQL(), msg: Starting...
DEBUG: push_el() sub_name: doSQL(), msg: Ending...
DEBUG: push_el() sub_name: doSQL(), msg: Starting...
DEBUG: push_el() sub_name: doSQL(), msg: Ending...
DEBUG: push_el() sub_name: sys_command_rs(), msg: Starting...
DEBUG: push_el() sub_name: sys_command_rs(), msg: Ending...
                           Failed
DEBUG: push_el() sub_name: exit_msg(), msg: Starting...

    FATAL: An error was occured during update process!
    Correct it and re-run this program.

Yes i clean database from orphan fields after that run update .