Attachment 673301 Details for Bug 890324 – update_log

update_log

ovirt-engine-upgrade_2013_01_03_03_44_27.log (text/x-log), 33.62 KB, created by Kiril Nesenko on 2013-01-06 08:43:52 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Kiril Nesenko

Created: 2013-01-06 08:43:52 UTC

Size: 33.62 KB

patch

obsolete

>2013-01-03 03:44:27::DEBUG::common_utils::766::root:: found existing pgpass file /etc/ovirt-engine/.pgpass, fetching DB host value
>2013-01-03 03:44:27::DEBUG::common_utils::766::root:: found existing pgpass file /etc/ovirt-engine/.pgpass, fetching DB port value
>2013-01-03 03:44:27::DEBUG::common_utils::766::root:: found existing pgpass file /etc/ovirt-engine/.pgpass, fetching DB user value
>2013-01-03 03:44:27::DEBUG::common_utils::324::root:: YUM: VERB: Loaded plugins: product-id, versionlock
>2013-01-03 03:44:27::INFO::rhevm-upgrade::939::root:: Info: /etc/ovirt-engine/.pgpass file found. Continue.
>2013-01-03 03:44:27::DEBUG::common_utils::474::root:: running sql query 'SELECT compatibility_version FROM storage_pool;' on db server: 'localhost'.
>2013-01-03 03:44:27::DEBUG::common_utils::427::root:: Executing command --> '/usr/bin/psql -h localhost -p 5432 -U engine -d engine -c SELECT compatibility_version FROM storage_pool;'
>2013-01-03 03:44:28::DEBUG::common_utils::465::root:: output =  compatibility_version 
>-----------------------
> 3.1
>(1 row)
>
>
>2013-01-03 03:44:28::DEBUG::common_utils::466::root:: stderr = 
>2013-01-03 03:44:28::DEBUG::common_utils::467::root:: retcode = 0
>2013-01-03 03:44:28::DEBUG::common_utils::474::root:: running sql query 'SELECT compatibility_version FROM vds_groups;' on db server: 'localhost'.
>2013-01-03 03:44:28::DEBUG::common_utils::427::root:: Executing command --> '/usr/bin/psql -h localhost -p 5432 -U engine -d engine -c SELECT compatibility_version FROM vds_groups;'
>2013-01-03 03:44:28::DEBUG::common_utils::465::root:: output =  compatibility_version 
>-----------------------
> 3.1
>(1 row)
>
>
>2013-01-03 03:44:28::DEBUG::common_utils::466::root:: stderr = 
>2013-01-03 03:44:28::DEBUG::common_utils::467::root:: retcode = 0
>2013-01-03 03:44:28::DEBUG::rhevm-upgrade::277::root:: Yum unlock started
>2013-01-03 03:44:28::DEBUG::rhevm-upgrade::289::root:: Yum unlock completed successfully
>2013-01-03 03:44:28::DEBUG::common_utils::324::root:: YUM: VERB: Downloading: repomdKnPsCEtmp.xml (0%)
>2013-01-03 03:44:28::DEBUG::common_utils::324::root:: YUM: VERB: Downloading: repomdKnPsCEtmp.xml 1.9 k(100%)
>2013-01-03 03:44:29::DEBUG::common_utils::324::root:: YUM: VERB: Downloading: epel/metalink (0%)
>2013-01-03 03:44:29::DEBUG::common_utils::324::root:: YUM: VERB: Downloading: epel/metalink 11 k(100%)
>2013-01-03 03:44:30::DEBUG::common_utils::324::root:: YUM: VERB: Downloading: repomdg02osDtmp.xml (0%)
>2013-01-03 03:44:30::DEBUG::common_utils::324::root:: YUM: VERB: Downloading: repomdg02osDtmp.xml 1.9 k(100%)
>2013-01-03 03:44:30::DEBUG::common_utils::324::root:: YUM: VERB: Downloading: repomdUXsj63tmp.xml (0%)
>2013-01-03 03:44:30::DEBUG::common_utils::324::root:: YUM: VERB: Downloading: repomdUXsj63tmp.xml 1.3 k(100%)
>2013-01-03 03:44:30::DEBUG::common_utils::324::root:: YUM: VERB: Downloading: repomdCPPztrtmp.xml (0%)
>2013-01-03 03:44:30::DEBUG::common_utils::324::root:: YUM: VERB: Downloading: repomdCPPztrtmp.xml 1.3 k(100%)
>2013-01-03 03:44:30::DEBUG::common_utils::324::root:: YUM: VERB: Downloading: repomdJuEcgytmp.xml (0%)
>2013-01-03 03:44:30::DEBUG::common_utils::324::root:: YUM: VERB: Downloading: repomdJuEcgytmp.xml 2.2 k(100%)
>2013-01-03 03:44:30::DEBUG::common_utils::324::root:: YUM: VERB: Downloading: repomdEXyW3mtmp.xml (0%)
>2013-01-03 03:44:30::DEBUG::common_utils::324::root:: YUM: VERB: Downloading: repomdEXyW3mtmp.xml 3.8 k(100%)
>2013-01-03 03:44:30::DEBUG::common_utils::324::root:: YUM: VERB: Downloading: repomdCO2DS4tmp.xml (0%)
>2013-01-03 03:44:30::DEBUG::common_utils::324::root:: YUM: VERB: Downloading: repomdCO2DS4tmp.xml 1.3 k(100%)
>2013-01-03 03:44:30::DEBUG::common_utils::324::root:: YUM: VERB: Downloading: epel/group_gz (0%)
>2013-01-03 03:44:31::DEBUG::common_utils::324::root:: YUM: VERB: Downloading: epel/group_gz 32 k(13%)
>2013-01-03 03:44:31::DEBUG::common_utils::324::root:: YUM: VERB: Downloading: epel/group_gz 110 k(47%)
>2013-01-03 03:44:32::DEBUG::common_utils::324::root:: YUM: VERB: Downloading: epel/group_gz 201 k(87%)
>2013-01-03 03:44:32::DEBUG::common_utils::324::root:: YUM: VERB: Downloading: epel/group_gz 229 k(100%)
>2013-01-03 03:44:32::DEBUG::common_utils::324::root:: YUM: VERB: Downloading: jboss/group_gz (0%)
>2013-01-03 03:44:32::DEBUG::common_utils::324::root:: YUM: VERB: Downloading: jboss/group_gz 1.2 k(100%)
>2013-01-03 03:44:32::DEBUG::common_utils::324::root:: YUM: VERB: Downloading: rhel-optional/group_gz (0%)
>2013-01-03 03:44:32::DEBUG::common_utils::324::root:: YUM: VERB: Downloading: rhel-optional/group_gz 5.9 k(100%)
>2013-01-03 03:44:32::DEBUG::common_utils::324::root:: YUM: VERB: queue package rhevm for update
>2013-01-03 03:44:33::DEBUG::common_utils::324::root:: YUM: VERB: package rhevm queued
>2013-01-03 03:44:33::DEBUG::common_utils::324::root:: YUM: VERB: Building transaction
>2013-01-03 03:44:34::DEBUG::common_utils::324::root:: YUM: VERB: Transaction built
>2013-01-03 03:44:34::DEBUG::rhevm-upgrade::311::root:: Transaction Summary:
>2013-01-03 03:44:34::DEBUG::rhevm-upgrade::315::root::     update - rhevm-3.2.0-4.el6ev.noarch
>2013-01-03 03:44:34::DEBUG::rhevm-upgrade::315::root::     install - otopi-0.0.0-0.7.master.el6ev.noarch
>2013-01-03 03:44:34::DEBUG::rhevm-upgrade::315::root::     install - otopi-java-0.0.0-0.7.master.el6ev.noarch
>2013-01-03 03:44:34::DEBUG::rhevm-upgrade::315::root::     install - ovirt-host-deploy-0.0.0-0.4.master.el6ev.noarch
>2013-01-03 03:44:34::DEBUG::rhevm-upgrade::315::root::     install - ovirt-host-deploy-java-0.0.0-0.4.master.el6ev.noarch
>2013-01-03 03:44:34::DEBUG::rhevm-upgrade::315::root::     update - rhevm-backend-3.2.0-4.el6ev.noarch
>2013-01-03 03:44:34::DEBUG::rhevm-upgrade::315::root::     update - rhevm-config-3.2.0-4.el6ev.noarch
>2013-01-03 03:44:34::DEBUG::rhevm-upgrade::315::root::     update - rhevm-dbscripts-3.2.0-4.el6ev.noarch
>2013-01-03 03:44:34::DEBUG::rhevm-upgrade::315::root::     update - rhevm-genericapi-3.2.0-4.el6ev.noarch
>2013-01-03 03:44:34::DEBUG::rhevm-upgrade::315::root::     update - rhevm-notification-service-3.2.0-4.el6ev.noarch
>2013-01-03 03:44:34::DEBUG::rhevm-upgrade::315::root::     update - rhevm-restapi-3.2.0-4.el6ev.noarch
>2013-01-03 03:44:34::DEBUG::rhevm-upgrade::315::root::     update - rhevm-tools-common-3.2.0-4.el6ev.noarch
>2013-01-03 03:44:34::DEBUG::rhevm-upgrade::315::root::     update - rhevm-userportal-3.2.0-4.el6ev.noarch
>2013-01-03 03:44:34::DEBUG::rhevm-upgrade::315::root::     update - rhevm-webadmin-portal-3.2.0-4.el6ev.noarch
>2013-01-03 03:44:34::DEBUG::rhevm-upgrade::326::root:: Yum rollback-avail started
>2013-01-03 03:44:34::DEBUG::rhevm-upgrade::332::root:: Checking package rhevm-3.1.0-39.el6ev.noarch
>2013-01-03 03:44:34::DEBUG::rhevm-upgrade::332::root:: Checking package rhevm-backend-3.1.0-39.el6ev.noarch
>2013-01-03 03:44:35::DEBUG::rhevm-upgrade::332::root:: Checking package rhevm-config-3.1.0-39.el6ev.noarch
>2013-01-03 03:44:35::DEBUG::rhevm-upgrade::332::root:: Checking package rhevm-dbscripts-3.1.0-39.el6ev.noarch
>2013-01-03 03:44:35::DEBUG::rhevm-upgrade::332::root:: Checking package rhevm-genericapi-3.1.0-39.el6ev.noarch
>2013-01-03 03:44:35::DEBUG::rhevm-upgrade::332::root:: Checking package rhevm-notification-service-3.1.0-39.el6ev.noarch
>2013-01-03 03:44:35::DEBUG::rhevm-upgrade::332::root:: Checking package rhevm-restapi-3.1.0-39.el6ev.noarch
>2013-01-03 03:44:35::DEBUG::rhevm-upgrade::332::root:: Checking package rhevm-tools-common-3.1.0-39.el6ev.noarch
>2013-01-03 03:44:35::DEBUG::rhevm-upgrade::332::root:: Checking package rhevm-userportal-3.1.0-39.el6ev.noarch
>2013-01-03 03:44:35::DEBUG::rhevm-upgrade::332::root:: Checking package rhevm-webadmin-portal-3.1.0-39.el6ev.noarch
>2013-01-03 03:44:36::DEBUG::rhevm-upgrade::337::root:: Yum rollback-avail completed successfully
>2013-01-03 03:44:36::DEBUG::rhevm-upgrade::996::root:: related to database package rhevm-backend
>2013-01-03 03:44:36::DEBUG::rhevm-upgrade::996::root:: related to database package rhevm-dbscripts
>2013-01-03 03:44:36::DEBUG::rhevm-upgrade::197::root:: checking the status of ovirt-engine service
>2013-01-03 03:44:36::DEBUG::common_utils::427::root:: Executing command --> '/sbin/service ovirt-engine status'
>2013-01-03 03:44:36::DEBUG::common_utils::465::root:: output = The engine process 4715 is running.
>
>2013-01-03 03:44:36::DEBUG::common_utils::466::root:: stderr = 
>2013-01-03 03:44:36::DEBUG::common_utils::467::root:: retcode = 0
>2013-01-03 03:44:36::DEBUG::rhevm-upgrade::204::root:: ovirt-engine service is up and running
>2013-01-03 03:44:36::DEBUG::common_utils::956::root:: asking user: Would you like to proceed? (yes|no): 
>2013-01-03 03:44:37::DEBUG::common_utils::960::root:: user answered: yes
>2013-01-03 03:44:37::DEBUG::rhevm-upgrade::565::root:: stopping ovirt-engine service.
>2013-01-03 03:44:37::DEBUG::common_utils::427::root:: Executing command --> '/sbin/service ovirt-engine stop'
>2013-01-03 03:44:38::DEBUG::common_utils::465::root:: output = Stopping engine-service:[60G [  [0;32mOK[0;39m  ]
>
>2013-01-03 03:44:38::DEBUG::common_utils::466::root:: stderr = 
>2013-01-03 03:44:38::DEBUG::common_utils::467::root:: retcode = 0
>2013-01-03 03:44:38::DEBUG::common_utils::1228::root:: getting status for engine-notifierd
>2013-01-03 03:44:38::DEBUG::common_utils::1237::root:: executing action engine-notifierd on service status
>2013-01-03 03:44:38::DEBUG::common_utils::427::root:: Executing command --> '/sbin/service engine-notifierd status'
>2013-01-03 03:44:38::DEBUG::common_utils::465::root:: output = /etc/init.d/engine-notifierd is stopped
>
>2013-01-03 03:44:38::DEBUG::common_utils::466::root:: stderr = 
>2013-01-03 03:44:38::DEBUG::common_utils::467::root:: retcode = 1
>2013-01-03 03:44:38::DEBUG::rhevm-upgrade::810::root:: Checking active system tasks
>2013-01-03 03:44:38::DEBUG::common_utils::427::root:: Executing command --> '/usr/bin/psql -U engine -f /usr/share/ovirt-engine/scripts/add_fn_db_get_async_tasks_function.sql -d engine'
>2013-01-03 03:44:39::DEBUG::common_utils::465::root:: output = DROP TYPE
>CREATE TYPE
>CREATE FUNCTION
>
>2013-01-03 03:44:39::DEBUG::common_utils::466::root:: stderr = 
>2013-01-03 03:44:39::DEBUG::common_utils::467::root:: retcode = 0
>2013-01-03 03:44:39::DEBUG::common_utils::474::root:: running sql query 'select * from fn_db_get_async_tasks();' on db server: 'localhost'.
>2013-01-03 03:44:39::DEBUG::common_utils::427::root:: Executing command --> '/usr/bin/psql -h localhost -p 5432 -U engine -d engine -c select * from fn_db_get_async_tasks();'
>2013-01-03 03:44:39::DEBUG::common_utils::465::root:: output =  dc_id | dc_name | spm_host_id | spm_host_name | task_count 
>-------+---------+-------------+---------------+------------
>(0 rows)
>
>
>2013-01-03 03:44:39::DEBUG::common_utils::466::root:: stderr = 
>2013-01-03 03:44:39::DEBUG::common_utils::467::root:: retcode = 0
>2013-01-03 03:44:39::DEBUG::common_utils::474::root:: running sql query 'select command_type, entity_type from business_entity_snapshot;' on db server: 'localhost'.
>2013-01-03 03:44:39::DEBUG::common_utils::427::root:: Executing command --> '/usr/bin/psql -h localhost -p 5432 -U engine -d engine -c select command_type, entity_type from business_entity_snapshot;'
>2013-01-03 03:44:39::DEBUG::common_utils::465::root:: output =  command_type | entity_type 
>--------------+-------------
>(0 rows)
>
>
>2013-01-03 03:44:39::DEBUG::common_utils::466::root:: stderr = 
>2013-01-03 03:44:39::DEBUG::common_utils::467::root:: retcode = 0
>2013-01-03 03:44:39::DEBUG::common_utils::474::root:: running sql query 'copy (select vds_id, vds_name, host_name, vds_unique_id, status from vds) to stdout with csv header;' on db server: 'localhost'.
>2013-01-03 03:44:39::DEBUG::common_utils::427::root:: Executing command --> '/usr/bin/psql -h localhost -p 5432 -U engine -d engine -c copy (select vds_id, vds_name, host_name, vds_unique_id, status from vds) to stdout with csv header;'
>2013-01-03 03:44:39::DEBUG::common_utils::465::root:: output = vds_id,vds_name,host_name,vds_unique_id,status
>
>2013-01-03 03:44:39::DEBUG::common_utils::466::root:: stderr = 
>2013-01-03 03:44:39::DEBUG::common_utils::467::root:: retcode = 0
>2013-01-03 03:44:39::DEBUG::rhevm-upgrade::355::root:: DB Backup started
>2013-01-03 03:44:39::DEBUG::common_utils::427::root:: Executing command --> '/usr/bin/pg_dump -C -E UTF8 --disable-dollar-quoting --disable-triggers -U engine -h localhost -p 5432 --format=p -f /var/lib/ovirt-engine/backups/ovirt-engine_db_backup_2013_01_03_03_44_27.sql engine'
>2013-01-03 03:44:39::DEBUG::common_utils::465::root:: output = 
>2013-01-03 03:44:39::DEBUG::common_utils::466::root:: stderr = 
>2013-01-03 03:44:39::DEBUG::common_utils::467::root:: retcode = 0
>2013-01-03 03:44:39::DEBUG::rhevm-upgrade::371::root:: DB Backup completed successfully
>2013-01-03 03:44:39::DEBUG::common_utils::474::root:: running sql query 'ALTER DATABASE engine RENAME TO engine_2013_01_03_03_44_27' on db server: 'localhost'.
>2013-01-03 03:44:39::DEBUG::common_utils::427::root:: Executing command --> '/usr/bin/psql -h localhost -p 5432 -U engine -d template1 -c ALTER DATABASE engine RENAME TO engine_2013_01_03_03_44_27'
>2013-01-03 03:44:39::DEBUG::common_utils::465::root:: output = ALTER DATABASE
>
>2013-01-03 03:44:39::DEBUG::common_utils::466::root:: stderr = 
>2013-01-03 03:44:39::DEBUG::common_utils::467::root:: retcode = 0
>2013-01-03 03:44:39::DEBUG::common_utils::324::root:: YUM: VERB: Processing transaction
>2013-01-03 03:44:39::INFO::common_utils::327::root:: YUM: OK:   Status: Downloading Packages
>2013-01-03 03:44:39::DEBUG::common_utils::324::root:: YUM: VERB: Status: Download packages packages: rhevm-restapi-3.2.0-4.el6ev.noarch rhevm-webadmin-portal-3.2.0-4.el6ev.noarch rhevm-3.2.0-4.el6ev.noarch rhevm-tools-common-3.2.0-4.el6ev.noarch rhevm-notification-service-3.2.0-4.el6ev.noarch rhevm-config-3.2.0-4.el6ev.noarch otopi-0.0.0-0.7.master.el6ev.noarch rhevm-userportal-3.2.0-4.el6ev.noarch rhevm-dbscripts-3.2.0-4.el6ev.noarch rhevm-backend-3.2.0-4.el6ev.noarch ovirt-host-deploy-0.0.0-0.4.master.el6ev.noarch otopi-java-0.0.0-0.7.master.el6ev.noarch ovirt-host-deploy-java-0.0.0-0.4.master.el6ev.noarch rhevm-genericapi-3.2.0-4.el6ev.noarch
>2013-01-03 03:44:39::DEBUG::common_utils::324::root:: YUM: VERB: Downloading: (1/14): otopi-0.0.0-0.7.master.el6ev.noarch.rpm (0%)
>2013-01-03 03:44:39::INFO::common_utils::327::root:: YUM: OK:   Download/Verify: otopi-0.0.0-0.7.master.el6ev.noarch
>2013-01-03 03:44:39::DEBUG::common_utils::324::root:: YUM: VERB: Downloading: (1/14): otopi-0.0.0-0.7.master.el6ev.noarch.rpm 110 k(100%)
>2013-01-03 03:44:39::DEBUG::common_utils::324::root:: YUM: VERB: Downloading: (2/14): otopi-java-0.0.0-0.7.master.el6ev.noarch.rpm (0%)
>2013-01-03 03:44:39::INFO::common_utils::327::root:: YUM: OK:   Download/Verify: otopi-java-0.0.0-0.7.master.el6ev.noarch
>2013-01-03 03:44:39::DEBUG::common_utils::324::root:: YUM: VERB: Downloading: (2/14): otopi-java-0.0.0-0.7.master.el6ev.noarch.rpm 22 k(100%)
>2013-01-03 03:44:39::DEBUG::common_utils::324::root:: YUM: VERB: Downloading: (3/14): ovirt-host-deploy-0.0.0-0.4.master.el6ev.noarch.rpm (0%)
>2013-01-03 03:44:39::INFO::common_utils::327::root:: YUM: OK:   Download/Verify: ovirt-host-deploy-0.0.0-0.4.master.el6ev.noarch
>2013-01-03 03:44:39::DEBUG::common_utils::324::root:: YUM: VERB: Downloading: (3/14): ovirt-host-deploy-0.0.0-0.4.master.el6ev.noarch.rpm 58 k(100%)
>2013-01-03 03:44:39::DEBUG::common_utils::324::root:: YUM: VERB: Downloading: (4/14): ovirt-host-deploy-java-0.0.0-0.4.master.el6ev.noarch.rpm (0%)
>2013-01-03 03:44:39::INFO::common_utils::327::root:: YUM: OK:   Download/Verify: ovirt-host-deploy-java-0.0.0-0.4.master.el6ev.noarch
>2013-01-03 03:44:39::DEBUG::common_utils::324::root:: YUM: VERB: Downloading: (4/14): ovirt-host-deploy-java-0.0.0-0.4.master.el6ev.noarch.rpm 5.4 k(100%)
>2013-01-03 03:44:39::DEBUG::common_utils::324::root:: YUM: VERB: Downloading: (5/14): rhevm-3.2.0-4.el6ev.noarch.rpm (0%)
>2013-01-03 03:44:40::INFO::common_utils::327::root:: YUM: OK:   Download/Verify: rhevm-3.2.0-4.el6ev.noarch
>2013-01-03 03:44:40::DEBUG::common_utils::324::root:: YUM: VERB: Downloading: (5/14): rhevm-3.2.0-4.el6ev.noarch.rpm 1.1 M(100%)
>2013-01-03 03:44:40::DEBUG::common_utils::324::root:: YUM: VERB: Downloading: (6/14): rhevm-backend-3.2.0-4.el6ev.noarch.rpm (0%)
>2013-01-03 03:44:40::INFO::common_utils::327::root:: YUM: OK:   Download/Verify: rhevm-backend-3.2.0-4.el6ev.noarch
>2013-01-03 03:44:40::DEBUG::common_utils::324::root:: YUM: VERB: Downloading: (6/14): rhevm-backend-3.2.0-4.el6ev.noarch.rpm 12 M(100%)
>2013-01-03 03:44:40::DEBUG::common_utils::324::root:: YUM: VERB: Downloading: (7/14): rhevm-config-3.2.0-4.el6ev.noarch.rpm (0%)
>2013-01-03 03:44:40::INFO::common_utils::327::root:: YUM: OK:   Download/Verify: rhevm-config-3.2.0-4.el6ev.noarch
>2013-01-03 03:44:40::DEBUG::common_utils::324::root:: YUM: VERB: Downloading: (7/14): rhevm-config-3.2.0-4.el6ev.noarch.rpm 13 k(100%)
>2013-01-03 03:44:40::DEBUG::common_utils::324::root:: YUM: VERB: Downloading: (8/14): rhevm-dbscripts-3.2.0-4.el6ev.noarch.rpm (0%)
>2013-01-03 03:44:40::INFO::common_utils::327::root:: YUM: OK:   Download/Verify: rhevm-dbscripts-3.2.0-4.el6ev.noarch
>2013-01-03 03:44:40::DEBUG::common_utils::324::root:: YUM: VERB: Downloading: (8/14): rhevm-dbscripts-3.2.0-4.el6ev.noarch.rpm 158 k(100%)
>2013-01-03 03:44:40::DEBUG::common_utils::324::root:: YUM: VERB: Downloading: (9/14): rhevm-genericapi-3.2.0-4.el6ev.noarch.rpm (0%)
>2013-01-03 03:44:40::INFO::common_utils::327::root:: YUM: OK:   Download/Verify: rhevm-genericapi-3.2.0-4.el6ev.noarch
>2013-01-03 03:44:40::DEBUG::common_utils::324::root:: YUM: VERB: Downloading: (9/14): rhevm-genericapi-3.2.0-4.el6ev.noarch.rpm 18 k(100%)
>2013-01-03 03:44:40::DEBUG::common_utils::324::root:: YUM: VERB: Downloading: (10/14): rhevm-notification-service-3.2.0-4.el6ev.noarch.rpm (0%)
>2013-01-03 03:44:40::INFO::common_utils::327::root:: YUM: OK:   Download/Verify: rhevm-notification-service-3.2.0-4.el6ev.noarch
>2013-01-03 03:44:40::DEBUG::common_utils::324::root:: YUM: VERB: Downloading: (10/14): rhevm-notification-service-3.2.0-4.el6ev.noarch.rpm 48 k(100%)
>2013-01-03 03:44:40::DEBUG::common_utils::324::root:: YUM: VERB: Downloading: (11/14): rhevm-restapi-3.2.0-4.el6ev.noarch.rpm (0%)
>2013-01-03 03:44:40::INFO::common_utils::327::root:: YUM: OK:   Download/Verify: rhevm-restapi-3.2.0-4.el6ev.noarch
>2013-01-03 03:44:40::DEBUG::common_utils::324::root:: YUM: VERB: Downloading: (11/14): rhevm-restapi-3.2.0-4.el6ev.noarch.rpm 1.1 M(100%)
>2013-01-03 03:44:40::DEBUG::common_utils::324::root:: YUM: VERB: Downloading: (12/14): rhevm-tools-common-3.2.0-4.el6ev.noarch.rpm (0%)
>2013-01-03 03:44:40::INFO::common_utils::327::root:: YUM: OK:   Download/Verify: rhevm-tools-common-3.2.0-4.el6ev.noarch
>2013-01-03 03:44:40::DEBUG::common_utils::324::root:: YUM: VERB: Downloading: (12/14): rhevm-tools-common-3.2.0-4.el6ev.noarch.rpm 9.2 k(100%)
>2013-01-03 03:44:40::DEBUG::common_utils::324::root:: YUM: VERB: Downloading: (13/14): rhevm-userportal-3.2.0-4.el6ev.noarch.rpm (0%)
>2013-01-03 03:44:40::DEBUG::common_utils::324::root:: YUM: VERB: Downloading: (13/14): rhevm-userportal-3.2.0-4.el6ev.noarch.rpm 33 M(57%)
>2013-01-03 03:44:40::INFO::common_utils::327::root:: YUM: OK:   Download/Verify: rhevm-userportal-3.2.0-4.el6ev.noarch
>2013-01-03 03:44:41::DEBUG::common_utils::324::root:: YUM: VERB: Downloading: (13/14): rhevm-userportal-3.2.0-4.el6ev.noarch.rpm 59 M(100%)
>2013-01-03 03:44:41::DEBUG::common_utils::324::root:: YUM: VERB: Downloading: (14/14): rhevm-webadmin-portal-3.2.0-4.el6ev.noarch.rpm (0%)
>2013-01-03 03:44:41::DEBUG::common_utils::324::root:: YUM: VERB: Downloading: (14/14): rhevm-webadmin-portal-3.2.0-4.el6ev.noarch.rpm 33 M(42%)
>2013-01-03 03:44:41::DEBUG::common_utils::324::root:: YUM: VERB: Downloading: (14/14): rhevm-webadmin-portal-3.2.0-4.el6ev.noarch.rpm 67 M(86%)
>2013-01-03 03:44:42::INFO::common_utils::327::root:: YUM: OK:   Download/Verify: rhevm-webadmin-portal-3.2.0-4.el6ev.noarch
>2013-01-03 03:44:42::DEBUG::common_utils::324::root:: YUM: VERB: Downloading: (14/14): rhevm-webadmin-portal-3.2.0-4.el6ev.noarch.rpm 78 M(100%)
>2013-01-03 03:44:42::INFO::common_utils::327::root:: YUM: OK:   Status: Check Package Signatures
>2013-01-03 03:44:42::INFO::common_utils::327::root:: YUM: OK:   Status: Running Test Transaction
>2013-01-03 03:44:42::DEBUG::common_utils::324::root:: YUM: VERB: Running rpm_check_debug
>2013-01-03 03:44:43::INFO::common_utils::327::root:: YUM: OK:   Status: Running Transaction
>2013-01-03 03:44:43::INFO::common_utils::327::root:: YUM: OK:   Installing: 1/24: otopi-0.0.0-0.7.master.el6ev.noarch
>2013-01-03 03:44:44::DEBUG::common_utils::324::root:: YUM: VERB: Installed: otopi-0.0.0-0.7.master.el6ev.noarch
>2013-01-03 03:44:44::DEBUG::common_utils::324::root:: YUM: VERB: Done: otopi-0.0.0-0.7.master.el6ev.noarch
>2013-01-03 03:44:44::INFO::common_utils::327::root:: YUM: OK:   Installing: 2/24: ovirt-host-deploy-0.0.0-0.4.master.el6ev.noarch
>2013-01-03 03:44:44::DEBUG::common_utils::324::root:: YUM: VERB: Installed: ovirt-host-deploy-0.0.0-0.4.master.el6ev.noarch
>2013-01-03 03:44:44::DEBUG::common_utils::324::root:: YUM: VERB: Done: ovirt-host-deploy-0.0.0-0.4.master.el6ev.noarch
>2013-01-03 03:44:44::INFO::common_utils::327::root:: YUM: OK:   Installing: 3/24: otopi-java-0.0.0-0.7.master.el6ev.noarch
>2013-01-03 03:44:44::DEBUG::common_utils::324::root:: YUM: VERB: Installed: otopi-java-0.0.0-0.7.master.el6ev.noarch
>2013-01-03 03:44:44::DEBUG::common_utils::324::root:: YUM: VERB: Done: otopi-java-0.0.0-0.7.master.el6ev.noarch
>2013-01-03 03:44:44::INFO::common_utils::327::root:: YUM: OK:   Installing: 4/24: ovirt-host-deploy-java-0.0.0-0.4.master.el6ev.noarch
>2013-01-03 03:44:44::DEBUG::common_utils::324::root:: YUM: VERB: Installed: ovirt-host-deploy-java-0.0.0-0.4.master.el6ev.noarch
>2013-01-03 03:44:44::DEBUG::common_utils::324::root:: YUM: VERB: Done: ovirt-host-deploy-java-0.0.0-0.4.master.el6ev.noarch
>2013-01-03 03:44:44::INFO::common_utils::327::root:: YUM: OK:   Updating: 5/24: rhevm-webadmin-portal-3.2.0-4.el6ev.noarch
>2013-01-03 03:44:55::DEBUG::common_utils::324::root:: YUM: VERB: Updated: rhevm-webadmin-portal-3.2.0-4.el6ev.noarch
>2013-01-03 03:44:55::DEBUG::common_utils::324::root:: YUM: VERB: Done: rhevm-webadmin-portal-3.2.0-4.el6ev.noarch
>2013-01-03 03:44:55::INFO::common_utils::327::root:: YUM: OK:   Updating: 6/24: rhevm-config-3.2.0-4.el6ev.noarch
>2013-01-03 03:44:55::DEBUG::common_utils::324::root:: YUM: VERB: Updated: rhevm-config-3.2.0-4.el6ev.noarch
>2013-01-03 03:44:55::DEBUG::common_utils::324::root:: YUM: VERB: Done: rhevm-config-3.2.0-4.el6ev.noarch
>2013-01-03 03:44:55::INFO::common_utils::327::root:: YUM: OK:   Updating: 7/24: rhevm-tools-common-3.2.0-4.el6ev.noarch
>2013-01-03 03:44:55::DEBUG::common_utils::324::root:: YUM: VERB: Updated: rhevm-tools-common-3.2.0-4.el6ev.noarch
>2013-01-03 03:44:55::DEBUG::common_utils::324::root:: YUM: VERB: Done: rhevm-tools-common-3.2.0-4.el6ev.noarch
>2013-01-03 03:44:55::INFO::common_utils::327::root:: YUM: OK:   Updating: 8/24: rhevm-notification-service-3.2.0-4.el6ev.noarch
>2013-01-03 03:44:55::DEBUG::common_utils::324::root:: YUM: VERB: Updated: rhevm-notification-service-3.2.0-4.el6ev.noarch
>2013-01-03 03:44:55::DEBUG::common_utils::324::root:: YUM: VERB: Done: rhevm-notification-service-3.2.0-4.el6ev.noarch
>2013-01-03 03:44:55::INFO::common_utils::327::root:: YUM: OK:   Updating: 9/24: rhevm-userportal-3.2.0-4.el6ev.noarch
>2013-01-03 03:45:02::DEBUG::common_utils::324::root:: YUM: VERB: Updated: rhevm-userportal-3.2.0-4.el6ev.noarch
>2013-01-03 03:45:02::DEBUG::common_utils::324::root:: YUM: VERB: Done: rhevm-userportal-3.2.0-4.el6ev.noarch
>2013-01-03 03:45:02::INFO::common_utils::327::root:: YUM: OK:   Updating: 10/24: rhevm-dbscripts-3.2.0-4.el6ev.noarch
>2013-01-03 03:45:03::DEBUG::common_utils::324::root:: YUM: VERB: Updated: rhevm-dbscripts-3.2.0-4.el6ev.noarch
>2013-01-03 03:45:03::DEBUG::common_utils::324::root:: YUM: VERB: Done: rhevm-dbscripts-3.2.0-4.el6ev.noarch
>2013-01-03 03:45:03::INFO::common_utils::327::root:: YUM: OK:   Updating: 11/24: rhevm-backend-3.2.0-4.el6ev.noarch
>2013-01-03 03:45:04::DEBUG::common_utils::324::root:: YUM: VERB: Updated: rhevm-backend-3.2.0-4.el6ev.noarch
>2013-01-03 03:45:04::DEBUG::common_utils::324::root:: YUM: VERB: Done: rhevm-backend-3.2.0-4.el6ev.noarch
>2013-01-03 03:45:04::INFO::common_utils::327::root:: YUM: OK:   Updating: 12/24: rhevm-genericapi-3.2.0-4.el6ev.noarch
>2013-01-03 03:45:04::DEBUG::common_utils::324::root:: YUM: VERB: Updated: rhevm-genericapi-3.2.0-4.el6ev.noarch
>2013-01-03 03:45:04::DEBUG::common_utils::324::root:: YUM: VERB: Done: rhevm-genericapi-3.2.0-4.el6ev.noarch
>2013-01-03 03:45:04::INFO::common_utils::327::root:: YUM: OK:   Updating: 13/24: rhevm-3.2.0-4.el6ev.noarch
>2013-01-03 03:45:04::DEBUG::common_utils::324::root:: YUM: VERB: Updated: rhevm-3.2.0-4.el6ev.noarch
>2013-01-03 03:45:04::DEBUG::common_utils::324::root:: YUM: VERB: Script sink: warning: /etc/sysconfig/ovirt-engine created as /etc/sysconfig/ovirt-engine.rpmnew
>
>2013-01-03 03:45:04::DEBUG::common_utils::324::root:: YUM: VERB: Done: rhevm-3.2.0-4.el6ev.noarch
>2013-01-03 03:45:04::INFO::common_utils::327::root:: YUM: OK:   Updating: 14/24: rhevm-restapi-3.2.0-4.el6ev.noarch
>2013-01-03 03:45:05::DEBUG::common_utils::324::root:: YUM: VERB: Updated: rhevm-restapi-3.2.0-4.el6ev.noarch
>2013-01-03 03:45:05::DEBUG::common_utils::324::root:: YUM: VERB: Done: rhevm-restapi-3.2.0-4.el6ev.noarch
>2013-01-03 03:45:05::INFO::common_utils::327::root:: YUM: OK:   Cleanup: 15/24: rhevm-backend
>2013-01-03 03:45:05::DEBUG::common_utils::324::root:: YUM: VERB: Done: rhevm-backend
>2013-01-03 03:45:05::INFO::common_utils::327::root:: YUM: OK:   Cleanup: 16/24: rhevm-config
>2013-01-03 03:45:05::DEBUG::common_utils::324::root:: YUM: VERB: Done: rhevm-config
>2013-01-03 03:45:05::INFO::common_utils::327::root:: YUM: OK:   Cleanup: 17/24: rhevm-dbscripts
>2013-01-03 03:45:05::DEBUG::common_utils::324::root:: YUM: VERB: Done: rhevm-dbscripts
>2013-01-03 03:45:05::INFO::common_utils::327::root:: YUM: OK:   Cleanup: 18/24: rhevm-genericapi
>2013-01-03 03:45:05::DEBUG::common_utils::324::root:: YUM: VERB: Done: rhevm-genericapi
>2013-01-03 03:45:05::INFO::common_utils::327::root:: YUM: OK:   Cleanup: 19/24: rhevm-tools-common
>2013-01-03 03:45:05::DEBUG::common_utils::324::root:: YUM: VERB: Done: rhevm-tools-common
>2013-01-03 03:45:05::INFO::common_utils::327::root:: YUM: OK:   Cleanup: 20/24: rhevm-notification-service
>2013-01-03 03:45:05::DEBUG::common_utils::324::root:: YUM: VERB: Done: rhevm-notification-service
>2013-01-03 03:45:05::INFO::common_utils::327::root:: YUM: OK:   Cleanup: 21/24: rhevm-userportal
>2013-01-03 03:45:05::DEBUG::common_utils::324::root:: YUM: VERB: Done: rhevm-userportal
>2013-01-03 03:45:05::INFO::common_utils::327::root:: YUM: OK:   Cleanup: 22/24: rhevm-webadmin-portal
>2013-01-03 03:45:05::DEBUG::common_utils::324::root:: YUM: VERB: Done: rhevm-webadmin-portal
>2013-01-03 03:45:05::INFO::common_utils::327::root:: YUM: OK:   Cleanup: 23/24: rhevm
>2013-01-03 03:45:05::DEBUG::common_utils::324::root:: YUM: VERB: Done: rhevm
>2013-01-03 03:45:05::INFO::common_utils::327::root:: YUM: OK:   Cleanup: 24/24: rhevm-restapi
>2013-01-03 03:45:05::DEBUG::common_utils::324::root:: YUM: VERB: Done: rhevm-restapi
>2013-01-03 03:45:05::DEBUG::common_utils::324::root:: YUM: VERB: Error loading productid metadata for brewkoji.
>2013-01-03 03:45:05::DEBUG::common_utils::324::root:: YUM: VERB: requested datatype productid not available
>2013-01-03 03:45:05::DEBUG::common_utils::324::root:: YUM: VERB: Error loading productid metadata for epel.
>2013-01-03 03:45:05::DEBUG::common_utils::324::root:: YUM: VERB: requested datatype productid not available
>2013-01-03 03:45:05::DEBUG::common_utils::324::root:: YUM: VERB: Error loading productid metadata for jboss.
>2013-01-03 03:45:05::DEBUG::common_utils::324::root:: YUM: VERB: requested datatype productid not available
>2013-01-03 03:45:05::DEBUG::common_utils::324::root:: YUM: VERB: Error loading productid metadata for qa-latest.
>2013-01-03 03:45:05::DEBUG::common_utils::324::root:: YUM: VERB: requested datatype productid not available
>2013-01-03 03:45:05::DEBUG::common_utils::324::root:: YUM: VERB: Error loading productid metadata for qa-latest-sf.
>2013-01-03 03:45:05::DEBUG::common_utils::324::root:: YUM: VERB: requested datatype productid not available
>2013-01-03 03:45:05::DEBUG::common_utils::324::root:: YUM: VERB: Error loading productid metadata for rhel-latest.
>2013-01-03 03:45:05::DEBUG::common_utils::324::root:: YUM: VERB: requested datatype productid not available
>2013-01-03 03:45:05::DEBUG::common_utils::324::root:: YUM: VERB: Error loading productid metadata for rhel-optional.
>2013-01-03 03:45:05::DEBUG::common_utils::324::root:: YUM: VERB: requested datatype productid not available
>2013-01-03 03:45:05::DEBUG::common_utils::324::root:: YUM: VERB: Error loading productid metadata for rhevm_deps_acceptance_repo.
>2013-01-03 03:45:05::DEBUG::common_utils::324::root:: YUM: VERB: requested datatype productid not available
>2013-01-03 03:45:07::DEBUG::common_utils::324::root:: YUM: VERB: Installed products updated.
>2013-01-03 03:45:07::INFO::common_utils::327::root:: YUM: OK:   Verify: 1/24: rhevm-restapi.noarch 0:3.2.0-4.el6ev - u
>2013-01-03 03:45:07::INFO::common_utils::327::root:: YUM: OK:   Verify: 2/24: rhevm-webadmin-portal.noarch 0:3.2.0-4.el6ev - u
>2013-01-03 03:45:07::INFO::common_utils::327::root:: YUM: OK:   Verify: 3/24: rhevm.noarch 0:3.2.0-4.el6ev - u
>2013-01-03 03:45:07::INFO::common_utils::327::root:: YUM: OK:   Verify: 4/24: rhevm-tools-common.noarch 0:3.2.0-4.el6ev - u
>2013-01-03 03:45:07::INFO::common_utils::327::root:: YUM: OK:   Verify: 5/24: rhevm-notification-service.noarch 0:3.2.0-4.el6ev - u
>2013-01-03 03:45:07::INFO::common_utils::327::root:: YUM: OK:   Verify: 6/24: rhevm-config.noarch 0:3.2.0-4.el6ev - u
>2013-01-03 03:45:07::INFO::common_utils::327::root:: YUM: OK:   Verify: 7/24: otopi.noarch 0:0.0.0-0.7.master.el6ev - u
>2013-01-03 03:45:07::INFO::common_utils::327::root:: YUM: OK:   Verify: 8/24: rhevm-userportal.noarch 0:3.2.0-4.el6ev - u
>2013-01-03 03:45:07::INFO::common_utils::327::root:: YUM: OK:   Verify: 9/24: rhevm-dbscripts.noarch 0:3.2.0-4.el6ev - u
>2013-01-03 03:45:08::INFO::common_utils::327::root:: YUM: OK:   Verify: 10/24: rhevm-backend.noarch 0:3.2.0-4.el6ev - u
>2013-01-03 03:45:08::INFO::common_utils::327::root:: YUM: OK:   Verify: 11/24: ovirt-host-deploy.noarch 0:0.0.0-0.4.master.el6ev - u
>2013-01-03 03:45:08::INFO::common_utils::327::root:: YUM: OK:   Verify: 12/24: otopi-java.noarch 0:0.0.0-0.7.master.el6ev - u
>2013-01-03 03:45:08::INFO::common_utils::327::root:: YUM: OK:   Verify: 13/24: ovirt-host-deploy-java.noarch 0:0.0.0-0.4.master.el6ev - u
>2013-01-03 03:45:08::INFO::common_utils::327::root:: YUM: OK:   Verify: 14/24: rhevm-genericapi.noarch 0:3.2.0-4.el6ev - u
>2013-01-03 03:45:08::INFO::common_utils::327::root:: YUM: OK:   Verify: 15/24: rhevm-notification-service.noarch 0:3.1.0-39.el6ev - ud
>2013-01-03 03:45:08::INFO::common_utils::327::root:: YUM: OK:   Verify: 16/24: rhevm-restapi.noarch 0:3.1.0-39.el6ev - ud
>2013-01-03 03:45:08::INFO::common_utils::327::root:: YUM: OK:   Verify: 17/24: rhevm-userportal.noarch 0:3.1.0-39.el6ev - ud
>2013-01-03 03:45:08::INFO::common_utils::327::root:: YUM: OK:   Verify: 18/24: rhevm-dbscripts.noarch 0:3.1.0-39.el6ev - ud
>2013-01-03 03:45:08::INFO::common_utils::327::root:: YUM: OK:   Verify: 19/24: rhevm.noarch 0:3.1.0-39.el6ev - ud
>2013-01-03 03:45:08::INFO::common_utils::327::root:: YUM: OK:   Verify: 20/24: rhevm-config.noarch 0:3.1.0-39.el6ev - ud
>2013-01-03 03:45:08::INFO::common_utils::327::root:: YUM: OK:   Verify: 21/24: rhevm-tools-common.noarch 0:3.1.0-39.el6ev - ud
>2013-01-03 03:45:08::INFO::common_utils::327::root:: YUM: OK:   Verify: 22/24: rhevm-genericapi.noarch 0:3.1.0-39.el6ev - ud
>2013-01-03 03:45:08::INFO::common_utils::327::root:: YUM: OK:   Verify: 23/24: rhevm-webadmin-portal.noarch 0:3.1.0-39.el6ev - ud
>2013-01-03 03:45:08::INFO::common_utils::327::root:: YUM: OK:   Verify: 24/24: rhevm-backend.noarch 0:3.1.0-39.el6ev - ud
>2013-01-03 03:45:08::DEBUG::common_utils::324::root:: YUM: VERB: Transaction processed
>2013-01-03 03:45:08::DEBUG::rhevm-upgrade::411::root:: DB Update started
>2013-01-03 03:45:08::DEBUG::common_utils::427::root:: Executing command --> '/usr/share/ovirt-engine/dbscripts/upgrade.sh -s localhost -p 5432 -u engine -d engine_2013_01_03_03_44_27'
>2013-01-03 03:45:09::DEBUG::common_utils::465::root:: output = upgrade script detected a change in Config, View or Stored Procedure...
>
>2013-01-03 03:45:09::DEBUG::common_utils::466::root:: stderr = psql:create_functions.sql:671: ERROR:  must be owner of function uuid_generate_v1
>
>2013-01-03 03:45:09::DEBUG::common_utils::467::root:: retcode = 3
>2013-01-03 03:45:09::ERROR::rhevm-upgrade::1058::root:: Traceback (most recent call last):
>  File "/usr/bin/rhevm-upgrade", line 1045, in main
>    runFunc([db.update], MSG_INFO_DB_UPDATE)
>  File "/usr/bin/rhevm-upgrade", line 593, in runFunc
>    func()
>  File "/usr/bin/rhevm-upgrade", line 428, in update
>    output, rc = utils.execCmd(cmdList=cmd, failOnError=True, msg=MSG_ERROR_UPDATE_DB)
>  File "/usr/share/ovirt-engine/scripts/common_utils.py", line 470, in execCmd
>    raise Exception(msg)
>Exception: Error: Database update failed
>
>2013-01-03 03:45:09::ERROR::rhevm-upgrade::1059::root:: Rolling back update
>2013-01-03 03:45:09::ERROR::rhevm-upgrade::562::root:: PKI: cannot remove '/etc/httpd/conf.d/ssl.conf.tmp'
>2013-01-03 03:45:09::ERROR::rhevm-upgrade::562::root:: PKI: cannot remove '/etc/pki/ovirt-engine/keys/engine.p12'
>2013-01-03 03:45:09::ERROR::rhevm-upgrade::562::root:: PKI: cannot remove '/etc/pki/ovirt-engine/keys/apache.p12'
>2013-01-03 03:45:09::ERROR::rhevm-upgrade::562::root:: PKI: cannot remove '/etc/pki/ovirt-engine/apache-ca.pem'
>2013-01-03 03:45:09::ERROR::rhevm-upgrade::562::root:: PKI: cannot remove '/etc/pki/ovirt-engine/certs/apache.cer'
>2013-01-03 03:45:09::ERROR::rhevm-upgrade::562::root:: PKI: cannot remove '/etc/pki/ovirt-engine/keys/apache.key.nopass'
>2013-01-03 03:45:09::DEBUG::rhevm-upgrade::378::root:: DB Restore started
>2013-01-03 03:45:09::DEBUG::common_utils::427::root:: Executing command --> '/usr/bin/dropdb -U engine -h localhost -p 5432 engine_2013_01_03_03_44_27'

Actions: View

Attachments on bug 890324: 669203 | 673301