CI run for I34d0d0dd84e66f325f81fc8223fbf261b22e8d1e, patchset 12

What is this? This page shows the logs from a database upgrade continuous integration run. Each patchset which proposes a database migration is run against a set of test databases. This page shows the results for one of those test databases. If the database is from Folsom, you will see a Grizzly migration in the bullet list below. You should then see an upgrade to the current state of trunk, and then finally the upgrade(s) contained in the patchset. For more information, please contact mikal@stillhq.com.


# 2013-07-03 08:53:33 + cd /srv/git/openstack/nova
# 2013-07-03 08:53:33 + git checkout master
# 2013-07-03 08:53:38 Already on 'master'
# 2013-07-03 08:53:38 + git pull
# 2013-07-03 08:53:40 Already up-to-date.
# 2013-07-03 08:53:40 + git checkout stable/grizzly
# 2013-07-03 08:53:42 Switched to branch 'stable/grizzly'
# 2013-07-03 08:53:42 + git pull
# 2013-07-03 08:53:43 Already up-to-date.
# 2013-07-03 08:53:43 + git checkout master
# 2013-07-03 08:53:44 Switched to branch 'master'
# 2013-07-03 08:53:44 + rm -rf ...git...
# 2013-07-03 08:53:44 + mkdir -p /srv/git-checkouts/openstack/nova
# 2013-07-03 08:53:44 + cp -Rp /srv/git/openstack/nova ...git...
# 2013-07-03 08:53:55 + cd ...git...
# 2013-07-03 08:53:55 + '[' 0 -gt 0 ']'
# 2013-07-03 08:53:55 + git checkout -b trunk
# 2013-07-03 08:53:55 Switched to a new branch 'trunk'
# 2013-07-03 08:53:56 + git fetch https://review.openstack.org/openstack/nova refs/changes/64/29364/12
# 2013-07-03 08:54:00 From https://review.openstack.org/openstack/nova
# 2013-07-03 08:54:00  * branch            refs/changes/64/29364/12 -> FETCH_HEAD
# 2013-07-03 08:54:00 + git checkout FETCH_HEAD
# 2013-07-03 08:54:00 Note: checking out 'FETCH_HEAD'.
# 2013-07-03 08:54:00 
# 2013-07-03 08:54:00 You are in 'detached HEAD' state. You can look around, make experimental
# 2013-07-03 08:54:00 changes and commit them, and you can discard any commits you make in this
# 2013-07-03 08:54:00 state without impacting any branches by performing another checkout.
# 2013-07-03 08:54:00 
# 2013-07-03 08:54:00 If you want to create a new branch to retain commits you create, you may
# 2013-07-03 08:54:00 do so (now or later) by using -b with the checkout command again. Example:
# 2013-07-03 08:54:00 
# 2013-07-03 08:54:01   git checkout -b new_branch_name
# 2013-07-03 08:54:01 
# 2013-07-03 08:54:01 HEAD is now at a9d8521... Add unique constraint to FixedIp.
# 2013-07-03 08:54:01 + git checkout -b target
# 2013-07-03 08:54:01 Switched to a new branch 'target'
# 2013-07-03 08:54:01 Git checkout created
# 2013-07-03 08:54:01 Plugin for work queue item found.
# 2013-07-03 08:54:01 To execute this script manually, run this:
# 2013-07-03 08:54:01 .../plugins/test_sqlalchemy_migrations.sh refs_changes_64_29364_12 ...git... nova nova nova_user_001
# 2013-07-03 08:54:01 + export PATH=/usr/lib/ccache:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/games
# 2013-07-03 08:54:01 + PATH=/usr/lib/ccache:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/games
# 2013-07-03 08:54:01 + export PIP_DOWNLOAD_CACHE=/srv/cache/pip
# 2013-07-03 08:54:01 + PIP_DOWNLOAD_CACHE=/srv/cache/pip
# 2013-07-03 08:54:01 + echo 'Restoring test database nova_user_001'
# 2013-07-03 08:54:02 Restoring test database nova_user_001
# 2013-07-03 08:54:02 + mysql --defaults-file=/srv/config/mysql -u root -e 'drop database nova_user_001'
# 2013-07-03 08:54:03 + mysql --defaults-file=/srv/config/mysql -u root -e 'create database nova_user_001'
# 2013-07-03 08:54:03 + mysql --defaults-file=/srv/config/mysql -u root -e 'create user '\''nova'\''@'\''localhost'\'' identified by '\''nova'\'';'
# 2013-07-03 08:54:03 ERROR 1396 (HY000) at line 1: Operation CREATE USER failed for 'nova'@'localhost'
# 2013-07-03 08:54:03 + mysql --defaults-file=/srv/config/mysql -u root -e 'grant all privileges on nova_user_001.* TO '\''nova'\''@'\''localhost'\'';'
# 2013-07-03 08:54:03 + mysql -u nova --password=nova nova_user_001
# 2013-07-03 08:54:31 [heartbeat]
# 2013-07-03 08:55:01 [heartbeat]
# 2013-07-03 08:55:31 [heartbeat]
# 2013-07-03 08:56:01 [heartbeat]
# 2013-07-03 08:56:05 + echo 'Build test environment'
# 2013-07-03 08:56:05 Build test environment
# 2013-07-03 08:56:05 + cd ...git...
# 2013-07-03 08:56:05 + set +x
# 2013-07-03 08:56:05 Setting up virtual env
# 2013-07-03 08:56:06 New python executable in refs_changes_64_29364_12/bin/python
# 2013-07-03 08:56:08 Installing distribute.............................................................................................................................................................................................done.
# 2013-07-03 08:56:08 Installing pip...............done.
# 2013-07-03 08:56:08 virtualenvwrapper.user_scripts creating ...venv.../bin/predeactivate
# 2013-07-03 08:56:08 virtualenvwrapper.user_scripts creating ...venv.../bin/postdeactivate
# 2013-07-03 08:56:08 virtualenvwrapper.user_scripts creating ...venv.../bin/preactivate
# 2013-07-03 08:56:08 virtualenvwrapper.user_scripts creating ...venv.../bin/postactivate
# 2013-07-03 08:56:08 virtualenvwrapper.user_scripts creating ...venv.../bin/get_env_details
# 2013-07-03 08:56:09 Enabled global site-packages
# 2013-07-03 08:56:09 + export PYTHONPATH=:...git...
# 2013-07-03 08:56:09 + PYTHONPATH=:...git...
# 2013-07-03 08:56:09 ++ mysql -u nova --password=nova nova_user_001 -e 'select * from migrate_version \G'
# 2013-07-03 08:56:09 ++ sed 's/.*: //'
# 2013-07-03 08:56:09 ++ grep version
# 2013-07-03 08:56:09 + version=133
# 2013-07-03 08:56:09 + echo 'Schema version is 133'
# 2013-07-03 08:56:09 Schema version is 133
# 2013-07-03 08:56:09 + '[' 133 == 133 ']'
# 2013-07-03 08:56:09 + echo 'Database is from Folsom! Upgrade via grizzly'
# 2013-07-03 08:56:09 Database is from Folsom! Upgrade via grizzly
# 2013-07-03 08:56:09 + git checkout stable/grizzly
# 2013-07-03 08:56:12 Switched to branch 'stable/grizzly'
# 2013-07-03 08:56:12 + pip_requires
# 2013-07-03 08:56:12 + requires=tools/pip-requires
# 2013-07-03 08:56:12 + '[' '!' -e tools/pip-requires ']'
# 2013-07-03 08:56:12 + echo 'Install pip requirements from tools/pip-requires'
# 2013-07-03 08:56:12 Install pip requirements from tools/pip-requires
# 2013-07-03 08:56:12 + pip install -q -r tools/pip-requires
# 2013-07-03 08:56:31 [heartbeat]
# 2013-07-03 08:57:01 [heartbeat]
# 2013-07-03 08:57:31 [heartbeat]
# 2013-07-03 08:58:01 [heartbeat]
# 2013-07-03 08:58:31 [heartbeat]
# 2013-07-03 08:59:02 [heartbeat]
# 2013-07-03 08:59:24 + echo 'Requirements installed'
# 2013-07-03 08:59:24 Requirements installed
# 2013-07-03 08:59:24 + db_sync grizzly ...git... nova nova nova_user_001
# 2013-07-03 08:59:24 + cat -
# 2013-07-03 08:59:24 + find ...git... -type f -name '*.pyc' -exec rm -f '{}' ';'
# 2013-07-03 08:59:24 + nova_manage=...git.../bin/nova-manage
# 2013-07-03 08:59:24 + '[' -e ...git.../bin/nova-manage ']'
# 2013-07-03 08:59:24 + echo '***** DB upgrade to state of grizzly starts *****'
# 2013-07-03 08:59:24 ***** DB upgrade to state of grizzly starts *****
# 2013-07-03 08:59:24 + python ...git.../bin/nova-manage --config-file ...git.../nova-grizzly.conf db sync
# 2013-07-03 08:59:26 133 -> 134...     [add_counters_to_bw_usage_cache]
# 2013-07-03 08:59:26 done              [0 seconds]
# 2013-07-03 08:59:26 134 -> 135...     [add_node_to_instances]
# 2013-07-03 08:59:32 [heartbeat]
# 2013-07-03 09:00:02 [heartbeat]
# 2013-07-03 09:00:22 [sqlslo] # Time: 130703  9:00:22
# 2013-07-03 09:00:22 [sqlslo] # User@Host: nova[nova] @ localhost []
# 2013-07-03 09:00:22 [sqlslo] # Query_time: 55.248809  Lock_time: 0.000153 Rows_sent: 0  Rows_examined: 0
# 2013-07-03 09:00:22 [sqlslo] SET timestamp=1372842022;
# 2013-07-03 09:00:22 [sqlslo] ALTER TABLE instances ADD node VARCHAR(255);
# 2013-07-03 09:00:22 done              [56 seconds]
# 2013-07-03 09:00:22 135 -> 136...     [add_index_to_instances]
# 2013-07-03 09:00:23 done              [1 seconds]
# 2013-07-03 09:00:23 136 -> 137...     [add_indexes_to_migrations]
# 2013-07-03 09:00:23 done              [0 seconds]
# 2013-07-03 09:00:23 137 -> 138...     [drop_server_name_from_instances]
# 2013-07-03 09:00:32 [heartbeat]
# 2013-07-03 09:01:02 [heartbeat]
# 2013-07-03 09:01:07 [sqlslo] # Time: 130703  9:01:07
# 2013-07-03 09:01:07 [sqlslo] # User@Host: nova[nova] @ localhost []
# 2013-07-03 09:01:07 [sqlslo] # Query_time: 43.728561  Lock_time: 0.000130 Rows_sent: 0  Rows_examined: 0
# 2013-07-03 09:01:07 [sqlslo] SET timestamp=1372842067;
# 2013-07-03 09:01:07 [sqlslo] ALTER TABLE instances DROP COLUMN server_name;
# 2013-07-03 09:01:07 done              [44 seconds]
# 2013-07-03 09:01:07 138 -> 139...     [add_indexes_to_fixed_ips]
# 2013-07-03 09:01:07 done              [0 seconds]
# 2013-07-03 09:01:07 139 -> 140...     [drop_unused_postgresql_volume_sequences]
# 2013-07-03 09:01:07 done              [0 seconds]
# 2013-07-03 09:01:07 140 -> 141...     [update_migrations_instance_uuid]
# 2013-07-03 09:01:07 done              [0 seconds]
# 2013-07-03 09:01:07 141 -> 142...     [add_migrations_instance_status_index]
# 2013-07-03 09:01:07 done              [0 seconds]
# 2013-07-03 09:01:07 142 -> 143...     [rename_instance_info_cache_sequence]
# 2013-07-03 09:01:09 done              [2 seconds]
# 2013-07-03 09:01:09 143 -> 144...     [add_node_to_migrations]
# 2013-07-03 09:01:09 done              [0 seconds]
# 2013-07-03 09:01:09 144 -> 145...     [add_volume_usage_cache]
# 2013-07-03 09:01:09 done              [0 seconds]
# 2013-07-03 09:01:09 145 -> 146...     [aggregate_zones]
# 2013-07-03 09:01:09 done              [0 seconds]
# 2013-07-03 09:01:09 146 -> 147...     [no_service_zones]
# 2013-07-03 09:01:09 done              [0 seconds]
# 2013-07-03 09:01:09 147 -> 148...     [add_instance_actions]
# 2013-07-03 09:01:09 done              [0 seconds]
# 2013-07-03 09:01:09 148 -> 149...     [inet_datatype_for_postgres]
# 2013-07-03 09:01:32 [heartbeat]
# 2013-07-03 09:01:53 [sqlslo] # Time: 130703  9:01:53
# 2013-07-03 09:01:53 [sqlslo] # User@Host: nova[nova] @ localhost []
# 2013-07-03 09:01:53 [sqlslo] # Query_time: 43.850418  Lock_time: 0.000153 Rows_sent: 0  Rows_examined: 0
# 2013-07-03 09:01:53 [sqlslo] SET timestamp=1372842113;
# 2013-07-03 09:01:53 [sqlslo] ALTER TABLE instances CHANGE COLUMN access_ip_v4 access_ip_v4 VARCHAR(43);
# 2013-07-03 09:02:02 [heartbeat]
# 2013-07-03 09:02:32 [heartbeat]
# 2013-07-03 09:02:38 [sqlslo] # Time: 130703  9:02:38
# 2013-07-03 09:02:38 [sqlslo] # User@Host: nova[nova] @ localhost []
# 2013-07-03 09:02:38 [sqlslo] # Query_time: 44.923243  Lock_time: 0.008973 Rows_sent: 0  Rows_examined: 0
# 2013-07-03 09:02:38 [sqlslo] SET timestamp=1372842158;
# 2013-07-03 09:02:38 [sqlslo] ALTER TABLE instances CHANGE COLUMN access_ip_v6 access_ip_v6 VARCHAR(43);
# 2013-07-03 09:02:39 done              [1 minutes, 30 seconds]
# 2013-07-03 09:02:40 149 -> 150...     [add_host_to_instance_faults]
# 2013-07-03 09:02:41 done              [1 seconds]
# 2013-07-03 09:02:41 150 -> 151...     [change_task_log_column_type]
# 2013-07-03 09:02:41 done              [0 seconds]
# 2013-07-03 09:02:41 151 -> 152...     [change_type_of_deleted_column]
# 2013-07-03 09:03:02 [heartbeat]
# 2013-07-03 09:03:26 [sqlslo] # Time: 130703  9:03:26
# 2013-07-03 09:03:26 [sqlslo] # User@Host: nova[nova] @ localhost []
# 2013-07-03 09:03:26 [sqlslo] # Query_time: 44.760413  Lock_time: 0.000075 Rows_sent: 0  Rows_examined: 0
# 2013-07-03 09:03:26 [sqlslo] SET timestamp=1372842206;
# 2013-07-03 09:03:26 [sqlslo] ALTER TABLE instances ADD new_deleted INTEGER(11);
# 2013-07-03 09:03:32 [heartbeat]
# 2013-07-03 09:03:37 [sqlslo] # Time: 130703  9:03:37
# 2013-07-03 09:03:37 [sqlslo] # User@Host: nova[nova] @ localhost []
# 2013-07-03 09:03:37 [sqlslo] # Query_time: 10.589318  Lock_time: 0.018591 Rows_sent: 0  Rows_examined: 45463
# 2013-07-03 09:03:37 [sqlslo] SET timestamp=1372842217;
# 2013-07-03 09:03:37 [sqlslo] UPDATE instances SET new_deleted=0;
# 2013-07-03 09:04:02 [heartbeat]
# 2013-07-03 09:04:27 [sqlslo] # Time: 130703  9:04:27
# 2013-07-03 09:04:27 [sqlslo] # User@Host: nova[nova] @ localhost []
# 2013-07-03 09:04:27 [sqlslo] # Query_time: 45.207886  Lock_time: 0.000134 Rows_sent: 0  Rows_examined: 0
# 2013-07-03 09:04:27 [sqlslo] SET timestamp=1372842267;
# 2013-07-03 09:04:27 [sqlslo] ALTER TABLE instances DROP COLUMN deleted;
# 2013-07-03 09:04:32 [heartbeat]
# 2013-07-03 09:05:02 [heartbeat]
# 2013-07-03 09:05:11 [sqlslo] # Time: 130703  9:05:11
# 2013-07-03 09:05:11 [sqlslo] # User@Host: nova[nova] @ localhost []
# 2013-07-03 09:05:11 [sqlslo] # Query_time: 44.625460  Lock_time: 0.019985 Rows_sent: 0  Rows_examined: 0
# 2013-07-03 09:05:11 [sqlslo] SET timestamp=1372842311;
# 2013-07-03 09:05:12 [sqlslo] ALTER TABLE instances CHANGE COLUMN new_deleted deleted INTEGER(11);
# 2013-07-03 09:05:32 [heartbeat]
# 2013-07-03 09:05:56 [sqlslo] # Time: 130703  9:05:56
# 2013-07-03 09:05:56 [sqlslo] # User@Host: nova[nova] @ localhost []
# 2013-07-03 09:05:56 [sqlslo] # Query_time: 11.022481  Lock_time: 0.002397 Rows_sent: 0  Rows_examined: 256929
# 2013-07-03 09:05:56 [sqlslo] SET timestamp=1372842356;
# 2013-07-03 09:05:56 [sqlslo] UPDATE reservations SET new_deleted=0;
# 2013-07-03 09:06:02 [heartbeat]
# 2013-07-03 09:06:32 [heartbeat]
# 2013-07-03 09:07:02 [heartbeat]
# 2013-07-03 09:07:20 done              [4 minutes, 39 seconds]
# 2013-07-03 09:07:20 152 -> 153...     [instance_type_in_system_metadata]
# 2013-07-03 09:07:31 done              [11 seconds]
# 2013-07-03 09:07:31 153 -> 154...     [add_shadow_tables]
# 2013-07-03 09:07:32 done              [1 seconds]
# 2013-07-03 09:07:32 154 -> 155...     [add_task_log_uc]
# 2013-07-03 09:07:32 done              [0 seconds]
# 2013-07-03 09:07:32 155 -> 156...     [cidr_column_length]
# 2013-07-03 09:07:32 done              [0 seconds]
# 2013-07-03 09:07:32 156 -> 157...     [add_security_group_default_rules]
# 2013-07-03 09:07:33 done              [1 seconds]
# 2013-07-03 09:07:33 157 -> 158...     [add_networks_uc]
# 2013-07-03 09:07:33 [heartbeat]
# 2013-07-03 09:07:33 done              [0 seconds]
# 2013-07-03 09:07:33 158 -> 159...     [revert_ip_column_length]
# 2013-07-03 09:08:03 [heartbeat]
# 2013-07-03 09:08:17 [sqlslo] # Time: 130703  9:08:17
# 2013-07-03 09:08:17 [sqlslo] # User@Host: nova[nova] @ localhost []
# 2013-07-03 09:08:17 [sqlslo] # Query_time: 44.753407  Lock_time: 0.000154 Rows_sent: 0  Rows_examined: 0
# 2013-07-03 09:08:17 [sqlslo] SET timestamp=1372842497;
# 2013-07-03 09:08:18 [sqlslo] ALTER TABLE instances CHANGE COLUMN access_ip_v4 access_ip_v4 VARCHAR(39);
# 2013-07-03 09:08:33 [heartbeat]
# 2013-07-03 09:09:03 [heartbeat]
# 2013-07-03 09:09:03 [sqlslo] # Time: 130703  9:09:03
# 2013-07-03 09:09:03 [sqlslo] # User@Host: nova[nova] @ localhost []
# 2013-07-03 09:09:03 [sqlslo] # Query_time: 45.378089  Lock_time: 0.018238 Rows_sent: 0  Rows_examined: 0
# 2013-07-03 09:09:03 [sqlslo] SET timestamp=1372842543;
# 2013-07-03 09:09:03 [sqlslo] ALTER TABLE instances CHANGE COLUMN access_ip_v6 access_ip_v6 VARCHAR(39);
# 2013-07-03 09:09:03 done              [1 minutes, 30 seconds]
# 2013-07-03 09:09:03 159 -> 160...     [fix_system_metadata_deleted]
# 2013-07-03 09:09:04 done              [1 seconds]
# 2013-07-03 09:09:04 160 -> 161...     [fix_system_metadata_none_strings]
# 2013-07-03 09:09:06 done              [2 seconds]
# 2013-07-03 09:09:07 + echo '***** DB upgrade to state of grizzly finished *****'
# 2013-07-03 09:09:07 ***** DB upgrade to state of grizzly finished *****
                                        [9 minutes, 43 seconds total]
# 2013-07-03 09:09:07 + git checkout target
# 2013-07-03 09:09:13 Checking out files:  43% (471/1088)   
Checking out files:  44% (479/1088)   
Checking out files:  45% (490/1088)   
Checking out files:  46% (501/1088)   
Checking out files:  47% (512/1088)   
Checking out files:  48% (523/1088)   
Checking out files:  49% (534/1088)   
Checking out files:  50% (544/1088)   
Checking out files:  51% (555/1088)   
Checking out files:  52% (566/1088)   
Checking out files:  53% (577/1088)   
Checking out files:  54% (588/1088)   
Checking out files:  55% (599/1088)   
Checking out files:  56% (610/1088)   
Checking out files:  57% (621/1088)   
Checking out files:  58% (632/1088)   
Checking out files:  59% (642/1088)   
Checking out files:  60% (653/1088)   
Checking out files:  61% (664/1088)   
Checking out files:  62% (675/1088)   
Checking out files:  63% (686/1088)   
Checking out files:  64% (697/1088)   
Checking out files:  65% (708/1088)   
Checking out files:  66% (719/1088)   
Checking out files:  67% (729/1088)   
Checking out files:  68% (740/1088)   
Checking out files:  69% (751/1088)   
Checking out files:  69% (755/1088)   
Checking out files:  70% (762/1088)   
Checking out files:  71% (773/1088)   
Checking out files:  72% (784/1088)   
Checking out files:  73% (795/1088)   
Checking out files:  74% (806/1088)   
Checking out files:  75% (816/1088)   
Checking out files:  76% (827/1088)   
Checking out files:  77% (838/1088)   
Checking out files:  78% (849/1088)   
Checking out files:  79% (860/1088)   
Checking out files:  80% (871/1088)   
Checking out files:  81% (882/1088)   
Checking out files:  82% (893/1088)   
Checking out files:  83% (904/1088)   
Checking out files:  84% (914/1088)   
Checking out files:  85% (925/1088)   
Checking out files:  86% (936/1088)   
Checking out files:  87% (947/1088)   
Checking out files:  88% (958/1088)   
Checking out files:  89% (969/1088)   
Checking out files:  90% (980/1088)   
Checking out files:  91% (991/1088)   
Checking out files:  92% (1001/1088)   
Checking out files:  93% (1012/1088)   
Checking out files:  94% (1023/1088)   
Checking out files:  95% (1034/1088)   
Checking out files:  96% (1045/1088)   
Checking out files:  97% (1056/1088)   
Checking out files:  98% (1067/1088)   
Checking out files:  99% (1078/1088)   
Checking out files: 100% (1088/1088)   
Checking out files: 100% (1088/1088), done.
# 2013-07-03 09:09:13 Switched to branch 'target'
# 2013-07-03 09:09:13 ++ git show
# 2013-07-03 09:09:13 ++ grep migrate_repo/versions
# 2013-07-03 09:09:13 ++ wc -l
# 2013-07-03 09:09:13 ++ grep '^\-\-\-'
# 2013-07-03 09:09:13 + '[' 0 -gt 0 ']'
# 2013-07-03 09:09:13 + echo 'Update database to current state of trunk'
# 2013-07-03 09:09:13 Update database to current state of trunk
# 2013-07-03 09:09:13 + git checkout trunk
# 2013-07-03 09:09:13 Switched to branch 'trunk'
# 2013-07-03 09:09:13 + pip_requires
# 2013-07-03 09:09:13 + requires=tools/pip-requires
# 2013-07-03 09:09:13 + '[' '!' -e tools/pip-requires ']'
# 2013-07-03 09:09:13 + requires=requirements.txt
# 2013-07-03 09:09:13 + echo 'Install pip requirements from requirements.txt'
# 2013-07-03 09:09:13 Install pip requirements from requirements.txt
# 2013-07-03 09:09:13 + pip install -q -r requirements.txt
# 2013-07-03 09:09:20 + echo 'Requirements installed'
# 2013-07-03 09:09:20 Requirements installed
# 2013-07-03 09:09:20 + db_sync trunk ...git... nova nova nova_user_001
# 2013-07-03 09:09:20 + cat -
# 2013-07-03 09:09:20 + find ...git... -type f -name '*.pyc' -exec rm -f '{}' ';'
# 2013-07-03 09:09:21 + nova_manage=...git.../bin/nova-manage
# 2013-07-03 09:09:21 + '[' -e ...git.../bin/nova-manage ']'
# 2013-07-03 09:09:21 + python setup.py clean
# 2013-07-03 09:09:22 running clean
# 2013-07-03 09:09:22 + python setup.py develop
# 2013-07-03 09:09:23 running develop
# 2013-07-03 09:09:23 running egg_info
# 2013-07-03 09:09:23 creating nova.egg-info
# 2013-07-03 09:09:23 writing requirements to nova.egg-info/requires.txt
# 2013-07-03 09:09:23 writing nova.egg-info/PKG-INFO
# 2013-07-03 09:09:23 writing top-level names to nova.egg-info/top_level.txt
# 2013-07-03 09:09:23 writing dependency_links to nova.egg-info/dependency_links.txt
# 2013-07-03 09:09:23 writing entry points to nova.egg-info/entry_points.txt
# 2013-07-03 09:09:23 writing manifest file 'nova.egg-info/SOURCES.txt'
# 2013-07-03 09:09:24 reading manifest template 'MANIFEST.in'
# 2013-07-03 09:09:24 warning: no files found matching 'AUTHORS'
# 2013-07-03 09:09:24 warning: no files found matching 'ChangeLog'
# 2013-07-03 09:09:24 warning: no previously-included files matching '*.pyc' found anywhere in distribution
# 2013-07-03 09:09:24 writing manifest file 'nova.egg-info/SOURCES.txt'
# 2013-07-03 09:09:24 running build_ext
# 2013-07-03 09:09:24 Creating ...venv.../lib/python2.7/site-packages/nova.egg-link (link to .)
# 2013-07-03 09:09:24 Adding nova 2013.2.a1672.gaaa871c to easy-install.pth file
# 2013-07-03 09:09:24 Installing nova-dhcpbridge script to ...venv.../bin
# 2013-07-03 09:09:24 Installing nova-manage script to ...venv.../bin
# 2013-07-03 09:09:24 Installing nova-api script to ...venv.../bin
# 2013-07-03 09:09:24 Installing nova-api-os-compute script to ...venv.../bin
# 2013-07-03 09:09:24 Installing nova-objectstore script to ...venv.../bin
# 2013-07-03 09:09:24 Installing nova-novncproxy script to ...venv.../bin
# 2013-07-03 09:09:24 Installing nova-rpc-zmq-receiver script to ...venv.../bin
# 2013-07-03 09:09:25 Installing nova-consoleauth script to ...venv.../bin
# 2013-07-03 09:09:25 Installing nova-network script to ...venv.../bin
# 2013-07-03 09:09:25 Installing nova-all script to ...venv.../bin
# 2013-07-03 09:09:25 Installing nova-api-ec2 script to ...venv.../bin
# 2013-07-03 09:09:25 Installing nova-api-metadata script to ...venv.../bin
# 2013-07-03 09:09:25 Installing nova-baremetal-deploy-helper script to ...venv.../bin
# 2013-07-03 09:09:25 Installing nova-clear-rabbit-queues script to ...venv.../bin
# 2013-07-03 09:09:25 Installing nova-xvpvncproxy script to ...venv.../bin
# 2013-07-03 09:09:25 Installing nova-conductor script to ...venv.../bin
# 2013-07-03 09:09:25 Installing nova-scheduler script to ...venv.../bin
# 2013-07-03 09:09:25 Installing nova-console script to ...venv.../bin
# 2013-07-03 09:09:25 Installing nova-spicehtml5proxy script to ...venv.../bin
# 2013-07-03 09:09:25 Installing nova-cert script to ...venv.../bin
# 2013-07-03 09:09:25 Installing nova-baremetal-manage script to ...venv.../bin
# 2013-07-03 09:09:25 Installing nova-compute script to ...venv.../bin
# 2013-07-03 09:09:25 Installing nova-cells script to ...venv.../bin
# 2013-07-03 09:09:25 Installing nova-rootwrap script to ...venv.../bin
# 2013-07-03 09:09:25 
# 2013-07-03 09:09:25 Installed ...git...
# 2013-07-03 09:09:25 Processing dependencies for nova==2013.2.a1672.gaaa871c
# 2013-07-03 09:09:25 Searching for oslo.config==1.1.1
# 2013-07-03 09:09:25 Best match: oslo.config 1.1.1
# 2013-07-03 09:09:25 Adding oslo.config 1.1.1 to easy-install.pth file
# 2013-07-03 09:09:25 
# 2013-07-03 09:09:25 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:25 Searching for websockify==0.3.0
# 2013-07-03 09:09:25 Best match: websockify 0.3.0
# 2013-07-03 09:09:25 Adding websockify 0.3.0 to easy-install.pth file
# 2013-07-03 09:09:25 Installing websockify script to ...venv.../bin
# 2013-07-03 09:09:25 
# 2013-07-03 09:09:25 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:25 Searching for stevedore==0.9.1
# 2013-07-03 09:09:25 Best match: stevedore 0.9.1
# 2013-07-03 09:09:25 Adding stevedore 0.9.1 to easy-install.pth file
# 2013-07-03 09:09:25 
# 2013-07-03 09:09:25 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:25 Searching for six==1.3.0
# 2013-07-03 09:09:25 Best match: six 1.3.0
# 2013-07-03 09:09:25 Adding six 1.3.0 to easy-install.pth file
# 2013-07-03 09:09:25 
# 2013-07-03 09:09:25 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:25 Searching for python-keystoneclient==0.3.0
# 2013-07-03 09:09:25 Best match: python-keystoneclient 0.3.0
# 2013-07-03 09:09:25 Adding python-keystoneclient 0.3.0 to easy-install.pth file
# 2013-07-03 09:09:25 Installing keystone script to ...venv.../bin
# 2013-07-03 09:09:26 
# 2013-07-03 09:09:26 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:26 Searching for python-glanceclient==0.9.0
# 2013-07-03 09:09:26 Best match: python-glanceclient 0.9.0
# 2013-07-03 09:09:26 Adding python-glanceclient 0.9.0 to easy-install.pth file
# 2013-07-03 09:09:26 Installing glance script to ...venv.../bin
# 2013-07-03 09:09:26 
# 2013-07-03 09:09:26 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:26 Searching for python-quantumclient==2.2.3
# 2013-07-03 09:09:26 Best match: python-quantumclient 2.2.3
# 2013-07-03 09:09:26 Adding python-quantumclient 2.2.3 to easy-install.pth file
# 2013-07-03 09:09:26 Installing quantum script to ...venv.../bin
# 2013-07-03 09:09:26 
# 2013-07-03 09:09:26 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:26 Searching for python-cinderclient==1.0.4
# 2013-07-03 09:09:26 Best match: python-cinderclient 1.0.4
# 2013-07-03 09:09:26 Adding python-cinderclient 1.0.4 to easy-install.pth file
# 2013-07-03 09:09:26 Installing cinder script to ...venv.../bin
# 2013-07-03 09:09:26 
# 2013-07-03 09:09:26 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:26 Searching for requests==1.2.0
# 2013-07-03 09:09:26 Best match: requests 1.2.0
# 2013-07-03 09:09:26 Adding requests 1.2.0 to easy-install.pth file
# 2013-07-03 09:09:26 
# 2013-07-03 09:09:26 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:26 Searching for iso8601==0.1.4
# 2013-07-03 09:09:26 Best match: iso8601 0.1.4
# 2013-07-03 09:09:26 Adding iso8601 0.1.4 to easy-install.pth file
# 2013-07-03 09:09:26 
# 2013-07-03 09:09:26 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:26 Searching for Babel==0.9.6
# 2013-07-03 09:09:26 Best match: Babel 0.9.6
# 2013-07-03 09:09:26 Adding Babel 0.9.6 to easy-install.pth file
# 2013-07-03 09:09:26 Installing pybabel script to ...venv.../bin
# 2013-07-03 09:09:26 
# 2013-07-03 09:09:26 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:26 Searching for pyasn1==0.1.7
# 2013-07-03 09:09:26 Best match: pyasn1 0.1.7
# 2013-07-03 09:09:26 Adding pyasn1 0.1.7 to easy-install.pth file
# 2013-07-03 09:09:26 
# 2013-07-03 09:09:26 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:26 Searching for paramiko==1.10.1
# 2013-07-03 09:09:26 Best match: paramiko 1.10.1
# 2013-07-03 09:09:26 Adding paramiko 1.10.1 to easy-install.pth file
# 2013-07-03 09:09:26 
# 2013-07-03 09:09:26 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:26 Searching for suds==0.4
# 2013-07-03 09:09:27 Best match: suds 0.4
# 2013-07-03 09:09:27 Adding suds 0.4 to easy-install.pth file
# 2013-07-03 09:09:27 
# 2013-07-03 09:09:27 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:27 Searching for netaddr==0.7.10
# 2013-07-03 09:09:27 Best match: netaddr 0.7.10
# 2013-07-03 09:09:27 Adding netaddr 0.7.10 to easy-install.pth file
# 2013-07-03 09:09:27 
# 2013-07-03 09:09:27 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:27 Searching for sqlalchemy-migrate==0.7.2
# 2013-07-03 09:09:27 Best match: sqlalchemy-migrate 0.7.2
# 2013-07-03 09:09:27 Adding sqlalchemy-migrate 0.7.2 to easy-install.pth file
# 2013-07-03 09:09:27 Installing migrate script to ...venv.../bin
# 2013-07-03 09:09:27 Installing migrate-repository script to ...venv.../bin
# 2013-07-03 09:09:27 
# 2013-07-03 09:09:27 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:27 Searching for Paste==1.7.5.1
# 2013-07-03 09:09:27 Best match: Paste 1.7.5.1
# 2013-07-03 09:09:27 Adding Paste 1.7.5.1 to easy-install.pth file
# 2013-07-03 09:09:27 
# 2013-07-03 09:09:27 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:27 Searching for PasteDeploy==1.5.0
# 2013-07-03 09:09:27 Best match: PasteDeploy 1.5.0
# 2013-07-03 09:09:27 Adding PasteDeploy 1.5.0 to easy-install.pth file
# 2013-07-03 09:09:27 
# 2013-07-03 09:09:27 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:27 Searching for greenlet==0.4.1
# 2013-07-03 09:09:27 Best match: greenlet 0.4.1
# 2013-07-03 09:09:27 Adding greenlet 0.4.1 to easy-install.pth file
# 2013-07-03 09:09:27 
# 2013-07-03 09:09:27 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:27 Searching for WebOb==1.2.3
# 2013-07-03 09:09:27 Best match: WebOb 1.2.3
# 2013-07-03 09:09:27 Adding WebOb 1.2.3 to easy-install.pth file
# 2013-07-03 09:09:27 
# 2013-07-03 09:09:27 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:27 Searching for Routes==1.13
# 2013-07-03 09:09:27 Best match: Routes 1.13
# 2013-07-03 09:09:27 Adding Routes 1.13 to easy-install.pth file
# 2013-07-03 09:09:27 
# 2013-07-03 09:09:27 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:27 Searching for lxml==3.2.1
# 2013-07-03 09:09:27 Best match: lxml 3.2.1
# 2013-07-03 09:09:28 Adding lxml 3.2.1 to easy-install.pth file
# 2013-07-03 09:09:28 
# 2013-07-03 09:09:28 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:28 Searching for kombu==2.5.12
# 2013-07-03 09:09:28 Best match: kombu 2.5.12
# 2013-07-03 09:09:28 Adding kombu 2.5.12 to easy-install.pth file
# 2013-07-03 09:09:28 
# 2013-07-03 09:09:28 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:28 Searching for eventlet==0.13.0
# 2013-07-03 09:09:28 Best match: eventlet 0.13.0
# 2013-07-03 09:09:28 Adding eventlet 0.13.0 to easy-install.pth file
# 2013-07-03 09:09:28 
# 2013-07-03 09:09:28 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:28 Searching for boto==2.9.6
# 2013-07-03 09:09:28 Best match: boto 2.9.6
# 2013-07-03 09:09:28 Adding boto 2.9.6 to easy-install.pth file
# 2013-07-03 09:09:28 
# 2013-07-03 09:09:28 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:28 Searching for anyjson==0.3.3
# 2013-07-03 09:09:28 Best match: anyjson 0.3.3
# 2013-07-03 09:09:28 Adding anyjson 0.3.3 to easy-install.pth file
# 2013-07-03 09:09:28 
# 2013-07-03 09:09:28 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:28 Searching for amqplib==1.0.2
# 2013-07-03 09:09:28 Best match: amqplib 1.0.2
# 2013-07-03 09:09:28 Adding amqplib 1.0.2 to easy-install.pth file
# 2013-07-03 09:09:28 
# 2013-07-03 09:09:28 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:28 Searching for Cheetah==2.4.4
# 2013-07-03 09:09:28 Best match: Cheetah 2.4.4
# 2013-07-03 09:09:28 Adding Cheetah 2.4.4 to easy-install.pth file
# 2013-07-03 09:09:28 
# 2013-07-03 09:09:28 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:28 Searching for SQLAlchemy==0.7.10
# 2013-07-03 09:09:28 Best match: SQLAlchemy 0.7.10
# 2013-07-03 09:09:28 Adding SQLAlchemy 0.7.10 to easy-install.pth file
# 2013-07-03 09:09:28 
# 2013-07-03 09:09:28 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:28 Searching for pbr==0.5.17
# 2013-07-03 09:09:28 Best match: pbr 0.5.17
# 2013-07-03 09:09:28 Adding pbr 0.5.17 to easy-install.pth file
# 2013-07-03 09:09:28 
# 2013-07-03 09:09:28 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:28 Searching for d2to1==0.2.10
# 2013-07-03 09:09:28 Best match: d2to1 0.2.10
# 2013-07-03 09:09:29 Adding d2to1 0.2.10 to easy-install.pth file
# 2013-07-03 09:09:29 
# 2013-07-03 09:09:29 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:29 Searching for numpy==1.6.1
# 2013-07-03 09:09:29 Best match: numpy 1.6.1
# 2013-07-03 09:09:29 Adding numpy 1.6.1 to easy-install.pth file
# 2013-07-03 09:09:29 
# 2013-07-03 09:09:29 Using /usr/lib/python2.7/dist-packages
# 2013-07-03 09:09:29 Searching for simplejson==2.3.2
# 2013-07-03 09:09:29 Best match: simplejson 2.3.2
# 2013-07-03 09:09:29 simplejson 2.3.2 is already the active version in easy-install.pth
# 2013-07-03 09:09:29 
# 2013-07-03 09:09:29 Using /usr/lib/python2.7/dist-packages
# 2013-07-03 09:09:29 Searching for prettytable==0.7.2
# 2013-07-03 09:09:29 Best match: prettytable 0.7.2
# 2013-07-03 09:09:29 Adding prettytable 0.7.2 to easy-install.pth file
# 2013-07-03 09:09:29 
# 2013-07-03 09:09:29 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:29 Searching for warlock==1.0.1
# 2013-07-03 09:09:29 Best match: warlock 1.0.1
# 2013-07-03 09:09:29 Adding warlock 1.0.1 to easy-install.pth file
# 2013-07-03 09:09:29 
# 2013-07-03 09:09:29 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:29 Searching for pyOpenSSL==0.12
# 2013-07-03 09:09:29 Best match: pyOpenSSL 0.12
# 2013-07-03 09:09:29 pyOpenSSL 0.12 is already the active version in easy-install.pth
# 2013-07-03 09:09:29 
# 2013-07-03 09:09:29 Using /usr/lib/python2.7/dist-packages
# 2013-07-03 09:09:29 Searching for pyparsing==1.5.7
# 2013-07-03 09:09:29 Best match: pyparsing 1.5.7
# 2013-07-03 09:09:29 Adding pyparsing 1.5.7 to easy-install.pth file
# 2013-07-03 09:09:29 
# 2013-07-03 09:09:29 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:29 Searching for httplib2==0.7.2
# 2013-07-03 09:09:29 Best match: httplib2 0.7.2
# 2013-07-03 09:09:29 httplib2 0.7.2 is already the active version in easy-install.pth
# 2013-07-03 09:09:29 
# 2013-07-03 09:09:29 Using /usr/lib/python2.7/dist-packages
# 2013-07-03 09:09:29 Searching for cliff==1.4
# 2013-07-03 09:09:29 Best match: cliff 1.4
# 2013-07-03 09:09:30 Adding cliff 1.4 to easy-install.pth file
# 2013-07-03 09:09:30 
# 2013-07-03 09:09:30 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:30 Searching for pycrypto==2.4.1
# 2013-07-03 09:09:30 Best match: pycrypto 2.4.1
# 2013-07-03 09:09:30 pycrypto 2.4.1 is already the active version in easy-install.pth
# 2013-07-03 09:09:30 
# 2013-07-03 09:09:30 Using /usr/lib/python2.7/dist-packages
# 2013-07-03 09:09:30 Searching for distribute==0.6.24
# 2013-07-03 09:09:30 Best match: distribute 0.6.24
# 2013-07-03 09:09:30 Processing distribute-0.6.24-py2.7.egg
# 2013-07-03 09:09:30 distribute 0.6.24 is already the active version in easy-install.pth
# 2013-07-03 09:09:30 Installing easy_install script to ...venv.../bin
# 2013-07-03 09:09:30 Installing easy_install-2.7 script to ...venv.../bin
# 2013-07-03 09:09:30 
# 2013-07-03 09:09:30 Using ...venv.../lib/python2.7/site-packages/distribute-0.6.24-py2.7.egg
# 2013-07-03 09:09:30 Searching for Tempita==0.5.1
# 2013-07-03 09:09:30 Best match: Tempita 0.5.1
# 2013-07-03 09:09:30 Adding Tempita 0.5.1 to easy-install.pth file
# 2013-07-03 09:09:30 
# 2013-07-03 09:09:30 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:30 Searching for decorator==3.4.0
# 2013-07-03 09:09:30 Best match: decorator 3.4.0
# 2013-07-03 09:09:30 Adding decorator 3.4.0 to easy-install.pth file
# 2013-07-03 09:09:30 
# 2013-07-03 09:09:30 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:30 Searching for repoze.lru==0.6
# 2013-07-03 09:09:30 Best match: repoze.lru 0.6
# 2013-07-03 09:09:30 Adding repoze.lru 0.6 to easy-install.pth file
# 2013-07-03 09:09:31 
# 2013-07-03 09:09:31 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:31 Searching for amqp==1.0.12
# 2013-07-03 09:09:31 Best match: amqp 1.0.12
# 2013-07-03 09:09:31 Adding amqp 1.0.12 to easy-install.pth file
# 2013-07-03 09:09:31 
# 2013-07-03 09:09:31 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:31 Searching for Markdown==2.3.1
# 2013-07-03 09:09:31 Best match: Markdown 2.3.1
# 2013-07-03 09:09:31 Adding Markdown 2.3.1 to easy-install.pth file
# 2013-07-03 09:09:31 
# 2013-07-03 09:09:31 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:31 Searching for setuptools-git==1.0b1
# 2013-07-03 09:09:31 Best match: setuptools-git 1.0b1
# 2013-07-03 09:09:31 Adding setuptools-git 1.0b1 to easy-install.pth file
# 2013-07-03 09:09:31 
# 2013-07-03 09:09:31 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:31 Searching for jsonpatch==1.1
# 2013-07-03 09:09:31 Best match: jsonpatch 1.1
# 2013-07-03 09:09:31 Adding jsonpatch 1.1 to easy-install.pth file
# 2013-07-03 09:09:31 
# 2013-07-03 09:09:31 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:31 Searching for jsonschema==2.0.0
# 2013-07-03 09:09:31 Best match: jsonschema 2.0.0
# 2013-07-03 09:09:31 Adding jsonschema 2.0.0 to easy-install.pth file
# 2013-07-03 09:09:31 
# 2013-07-03 09:09:31 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:31 Searching for cmd2==0.6.5.1
# 2013-07-03 09:09:31 Best match: cmd2 0.6.5.1
# 2013-07-03 09:09:31 Adding cmd2 0.6.5.1 to easy-install.pth file
# 2013-07-03 09:09:31 
# 2013-07-03 09:09:31 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:31 Searching for jsonpointer==1.0
# 2013-07-03 09:09:31 Best match: jsonpointer 1.0
# 2013-07-03 09:09:31 Adding jsonpointer 1.0 to easy-install.pth file
# 2013-07-03 09:09:31 
# 2013-07-03 09:09:31 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:31 Finished processing dependencies for nova==2013.2.a1672.gaaa871c
# 2013-07-03 09:09:31 + echo '***** DB upgrade to state of trunk starts *****'
# 2013-07-03 09:09:31 ***** DB upgrade to state of trunk starts *****
# 2013-07-03 09:09:31 + nova-manage --config-file ...git.../nova-trunk.conf db sync
# 2013-07-03 09:09:31 161 -> 162...     [placeholder]
# 2013-07-03 09:09:32 done              [1 seconds]
# 2013-07-03 09:09:32 162 -> 163...     [placeholder]
# 2013-07-03 09:09:32 done              [0 seconds]
# 2013-07-03 09:09:32 163 -> 164...     [placeholder]
# 2013-07-03 09:09:32 done              [0 seconds]
# 2013-07-03 09:09:32 164 -> 165...     [placeholder]
# 2013-07-03 09:09:32 done              [0 seconds]
# 2013-07-03 09:09:32 165 -> 166...     [placeholder]
# 2013-07-03 09:09:32 done              [0 seconds]
# 2013-07-03 09:09:32 166 -> 167...     [placeholder]
# 2013-07-03 09:09:32 done              [0 seconds]
# 2013-07-03 09:09:32 167 -> 168...     [placeholder]
# 2013-07-03 09:09:32 done              [0 seconds]
# 2013-07-03 09:09:32 168 -> 169...     [placeholder]
# 2013-07-03 09:09:32 done              [0 seconds]
# 2013-07-03 09:09:32 169 -> 170...     [placeholder]
# 2013-07-03 09:09:32 done              [0 seconds]
# 2013-07-03 09:09:32 170 -> 171...     [placeholder]
# 2013-07-03 09:09:32 done              [0 seconds]
# 2013-07-03 09:09:32 171 -> 172...     [add_instance_type_uc]
# 2013-07-03 09:09:32 done              [0 seconds]
# 2013-07-03 09:09:32 172 -> 173...     [add_unique_constraint_to_key_pairs]
# 2013-07-03 09:09:32 Deleted duplicated row with id: 2086 from table: key_pairs
# 2013-07-03 09:09:32 Deleted duplicated row with id: 2086 from table: key_pairs
# 2013-07-03 09:09:32 Deleted duplicated row with id: 1161 from table: key_pairs
# 2013-07-03 09:09:32 Deleted duplicated row with id: 1161 from table: key_pairs
# 2013-07-03 09:09:32 Deleted duplicated row with id: 1107 from table: key_pairs
# 2013-07-03 09:09:32 Deleted duplicated row with id: 1107 from table: key_pairs
# 2013-07-03 09:09:32 done              [0 seconds]
# 2013-07-03 09:09:32 173 -> 174...     [add_instance_type_access_uc]
# 2013-07-03 09:09:32 done              [0 seconds]
# 2013-07-03 09:09:32 174 -> 175...     [add_project_user_id_to_volume_usage_cache]
# 2013-07-03 09:09:32 done              [0 seconds]
# 2013-07-03 09:09:32 175 -> 176...     [add_availability_zone_to_volume_usage_cache]
# 2013-07-03 09:09:32 done              [0 seconds]
# 2013-07-03 09:09:32 176 -> 177...     [add_floating_ip_uc]
# 2013-07-03 09:09:32 done              [0 seconds]
# 2013-07-03 09:09:32 177 -> 178...     [add_index_to_compute_node_stats]
# 2013-07-03 09:09:32 done              [0 seconds]
# 2013-07-03 09:09:32 178 -> 179...     [change_cells_deleted_to_int]
# 2013-07-03 09:09:32 done              [0 seconds]
# 2013-07-03 09:09:32 179 -> 180...     [fix_175_and_176_migration_sync_shadow_table]
# 2013-07-03 09:09:32 done              [0 seconds]
# 2013-07-03 09:09:32 180 -> 181...     [fix_179_migration_sync_shadow_table]
# 2013-07-03 09:09:33 done              [1 seconds]
# 2013-07-03 09:09:33 181 -> 182...     [fix_156_migration_sync_shadow_table]
# 2013-07-03 09:09:33 done              [0 seconds]
# 2013-07-03 09:09:33 182 -> 183...     [fix_157_migration_sync_shadow_table]
# 2013-07-03 09:09:33 done              [0 seconds]
# 2013-07-03 09:09:33 183 -> 184...     [fix_159_migration_sync_shadow_table]
# 2013-07-03 09:09:33 done              [0 seconds]
# 2013-07-03 09:09:33 184 -> 185...     [rename_unique_constraints]
# 2013-07-03 09:09:33 [heartbeat]
# 2013-07-03 09:09:43 done              [10 seconds]
# 2013-07-03 09:09:43 185 -> 186...     [new_bdm_format]
# 2013-07-03 09:09:43 done              [0 seconds]
# 2013-07-03 09:09:43 186 -> 187...     [add_instance_groups]
# 2013-07-03 09:09:44 done              [1 seconds]
# 2013-07-03 09:09:44 187 -> 188...     [add_reason_column_to_service]
# 2013-07-03 09:09:44 done              [0 seconds]
# 2013-07-03 09:09:44 188 -> 189...     [add_cells_uc]
# 2013-07-03 09:09:44 done              [0 seconds]
# 2013-07-03 09:09:44 189 -> 190...     [add_security_group_uc]
# 2013-07-03 09:09:44 done              [0 seconds]
# 2013-07-03 09:09:45 + echo '***** DB upgrade to state of trunk finished *****'
# 2013-07-03 09:09:45 ***** DB upgrade to state of trunk finished *****
                                        [14 seconds total]
# 2013-07-03 09:09:45 + git checkout target
# 2013-07-03 09:09:45 Switched to branch 'target'
# 2013-07-03 09:09:45 + echo 'Now test the patchset'
# 2013-07-03 09:09:45 Now test the patchset
# 2013-07-03 09:09:45 + pip_requires
# 2013-07-03 09:09:45 + requires=tools/pip-requires
# 2013-07-03 09:09:45 + '[' '!' -e tools/pip-requires ']'
# 2013-07-03 09:09:45 + requires=requirements.txt
# 2013-07-03 09:09:45 + echo 'Install pip requirements from requirements.txt'
# 2013-07-03 09:09:45 Install pip requirements from requirements.txt
# 2013-07-03 09:09:45 + pip install -q -r requirements.txt
# 2013-07-03 09:09:49 + echo 'Requirements installed'
# 2013-07-03 09:09:49 Requirements installed
# 2013-07-03 09:09:49 + db_sync patchset ...git... nova nova nova_user_001
# 2013-07-03 09:09:49 + cat -
# 2013-07-03 09:09:49 + find ...git... -type f -name '*.pyc' -exec rm -f '{}' ';'
# 2013-07-03 09:09:49 + nova_manage=...git.../bin/nova-manage
# 2013-07-03 09:09:49 + '[' -e ...git.../bin/nova-manage ']'
# 2013-07-03 09:09:49 + python setup.py clean
# 2013-07-03 09:09:50 running clean
# 2013-07-03 09:09:50 + python setup.py develop
# 2013-07-03 09:09:50 running develop
# 2013-07-03 09:09:50 running egg_info
# 2013-07-03 09:09:50 writing requirements to nova.egg-info/requires.txt
# 2013-07-03 09:09:50 writing nova.egg-info/PKG-INFO
# 2013-07-03 09:09:50 writing top-level names to nova.egg-info/top_level.txt
# 2013-07-03 09:09:51 writing dependency_links to nova.egg-info/dependency_links.txt
# 2013-07-03 09:09:51 writing entry points to nova.egg-info/entry_points.txt
# 2013-07-03 09:09:51 reading manifest template 'MANIFEST.in'
# 2013-07-03 09:09:51 warning: no files found matching 'AUTHORS'
# 2013-07-03 09:09:51 warning: no files found matching 'ChangeLog'
# 2013-07-03 09:09:51 warning: no previously-included files matching '*.pyc' found anywhere in distribution
# 2013-07-03 09:09:51 writing manifest file 'nova.egg-info/SOURCES.txt'
# 2013-07-03 09:09:51 running build_ext
# 2013-07-03 09:09:51 Creating ...venv.../lib/python2.7/site-packages/nova.egg-link (link to .)
# 2013-07-03 09:09:51 Adding nova 2013.2.a1673.ga9d8521 to easy-install.pth file
# 2013-07-03 09:09:51 Installing nova-dhcpbridge script to ...venv.../bin
# 2013-07-03 09:09:51 Installing nova-manage script to ...venv.../bin
# 2013-07-03 09:09:51 Installing nova-api script to ...venv.../bin
# 2013-07-03 09:09:51 Installing nova-api-os-compute script to ...venv.../bin
# 2013-07-03 09:09:51 Installing nova-objectstore script to ...venv.../bin
# 2013-07-03 09:09:51 Installing nova-novncproxy script to ...venv.../bin
# 2013-07-03 09:09:51 Installing nova-rpc-zmq-receiver script to ...venv.../bin
# 2013-07-03 09:09:51 Installing nova-consoleauth script to ...venv.../bin
# 2013-07-03 09:09:51 Installing nova-network script to ...venv.../bin
# 2013-07-03 09:09:51 Installing nova-all script to ...venv.../bin
# 2013-07-03 09:09:51 Installing nova-api-ec2 script to ...venv.../bin
# 2013-07-03 09:09:51 Installing nova-api-metadata script to ...venv.../bin
# 2013-07-03 09:09:51 Installing nova-baremetal-deploy-helper script to ...venv.../bin
# 2013-07-03 09:09:51 Installing nova-clear-rabbit-queues script to ...venv.../bin
# 2013-07-03 09:09:52 Installing nova-xvpvncproxy script to ...venv.../bin
# 2013-07-03 09:09:52 Installing nova-conductor script to ...venv.../bin
# 2013-07-03 09:09:52 Installing nova-scheduler script to ...venv.../bin
# 2013-07-03 09:09:52 Installing nova-console script to ...venv.../bin
# 2013-07-03 09:09:52 Installing nova-spicehtml5proxy script to ...venv.../bin
# 2013-07-03 09:09:52 Installing nova-cert script to ...venv.../bin
# 2013-07-03 09:09:52 Installing nova-baremetal-manage script to ...venv.../bin
# 2013-07-03 09:09:52 Installing nova-compute script to ...venv.../bin
# 2013-07-03 09:09:52 Installing nova-cells script to ...venv.../bin
# 2013-07-03 09:09:52 Installing nova-rootwrap script to ...venv.../bin
# 2013-07-03 09:09:52 
# 2013-07-03 09:09:52 Installed ...git...
# 2013-07-03 09:09:52 Processing dependencies for nova==2013.2.a1673.ga9d8521
# 2013-07-03 09:09:52 Searching for oslo.config==1.1.1
# 2013-07-03 09:09:52 Best match: oslo.config 1.1.1
# 2013-07-03 09:09:52 Adding oslo.config 1.1.1 to easy-install.pth file
# 2013-07-03 09:09:52 
# 2013-07-03 09:09:52 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:52 Searching for websockify==0.3.0
# 2013-07-03 09:09:52 Best match: websockify 0.3.0
# 2013-07-03 09:09:52 Adding websockify 0.3.0 to easy-install.pth file
# 2013-07-03 09:09:52 Installing websockify script to ...venv.../bin
# 2013-07-03 09:09:52 
# 2013-07-03 09:09:52 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:52 Searching for stevedore==0.9.1
# 2013-07-03 09:09:52 Best match: stevedore 0.9.1
# 2013-07-03 09:09:52 Adding stevedore 0.9.1 to easy-install.pth file
# 2013-07-03 09:09:52 
# 2013-07-03 09:09:52 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:52 Searching for six==1.3.0
# 2013-07-03 09:09:52 Best match: six 1.3.0
# 2013-07-03 09:09:52 Adding six 1.3.0 to easy-install.pth file
# 2013-07-03 09:09:52 
# 2013-07-03 09:09:52 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:52 Searching for python-keystoneclient==0.3.0
# 2013-07-03 09:09:52 Best match: python-keystoneclient 0.3.0
# 2013-07-03 09:09:52 Adding python-keystoneclient 0.3.0 to easy-install.pth file
# 2013-07-03 09:09:52 Installing keystone script to ...venv.../bin
# 2013-07-03 09:09:52 
# 2013-07-03 09:09:52 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:52 Searching for python-glanceclient==0.9.0
# 2013-07-03 09:09:53 Best match: python-glanceclient 0.9.0
# 2013-07-03 09:09:53 Adding python-glanceclient 0.9.0 to easy-install.pth file
# 2013-07-03 09:09:53 Installing glance script to ...venv.../bin
# 2013-07-03 09:09:53 
# 2013-07-03 09:09:53 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:53 Searching for python-quantumclient==2.2.3
# 2013-07-03 09:09:53 Best match: python-quantumclient 2.2.3
# 2013-07-03 09:09:53 Adding python-quantumclient 2.2.3 to easy-install.pth file
# 2013-07-03 09:09:53 Installing quantum script to ...venv.../bin
# 2013-07-03 09:09:53 
# 2013-07-03 09:09:53 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:53 Searching for python-cinderclient==1.0.4
# 2013-07-03 09:09:53 Best match: python-cinderclient 1.0.4
# 2013-07-03 09:09:53 Adding python-cinderclient 1.0.4 to easy-install.pth file
# 2013-07-03 09:09:53 Installing cinder script to ...venv.../bin
# 2013-07-03 09:09:53 
# 2013-07-03 09:09:53 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:53 Searching for requests==1.2.0
# 2013-07-03 09:09:53 Best match: requests 1.2.0
# 2013-07-03 09:09:53 Adding requests 1.2.0 to easy-install.pth file
# 2013-07-03 09:09:53 
# 2013-07-03 09:09:53 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:53 Searching for iso8601==0.1.4
# 2013-07-03 09:09:53 Best match: iso8601 0.1.4
# 2013-07-03 09:09:53 Adding iso8601 0.1.4 to easy-install.pth file
# 2013-07-03 09:09:53 
# 2013-07-03 09:09:53 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:53 Searching for Babel==0.9.6
# 2013-07-03 09:09:53 Best match: Babel 0.9.6
# 2013-07-03 09:09:53 Adding Babel 0.9.6 to easy-install.pth file
# 2013-07-03 09:09:53 Installing pybabel script to ...venv.../bin
# 2013-07-03 09:09:53 
# 2013-07-03 09:09:53 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:53 Searching for pyasn1==0.1.7
# 2013-07-03 09:09:53 Best match: pyasn1 0.1.7
# 2013-07-03 09:09:53 Adding pyasn1 0.1.7 to easy-install.pth file
# 2013-07-03 09:09:53 
# 2013-07-03 09:09:53 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:53 Searching for paramiko==1.10.1
# 2013-07-03 09:09:53 Best match: paramiko 1.10.1
# 2013-07-03 09:09:54 Adding paramiko 1.10.1 to easy-install.pth file
# 2013-07-03 09:09:54 
# 2013-07-03 09:09:54 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:54 Searching for suds==0.4
# 2013-07-03 09:09:54 Best match: suds 0.4
# 2013-07-03 09:09:54 Adding suds 0.4 to easy-install.pth file
# 2013-07-03 09:09:54 
# 2013-07-03 09:09:54 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:54 Searching for netaddr==0.7.10
# 2013-07-03 09:09:54 Best match: netaddr 0.7.10
# 2013-07-03 09:09:54 Removing netaddr 0.7.5 from easy-install.pth file
# 2013-07-03 09:09:54 Adding netaddr 0.7.10 to easy-install.pth file
# 2013-07-03 09:09:54 
# 2013-07-03 09:09:54 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:54 Searching for sqlalchemy-migrate==0.7.2
# 2013-07-03 09:09:54 Best match: sqlalchemy-migrate 0.7.2
# 2013-07-03 09:09:54 Adding sqlalchemy-migrate 0.7.2 to easy-install.pth file
# 2013-07-03 09:09:54 Installing migrate script to ...venv.../bin
# 2013-07-03 09:09:54 Installing migrate-repository script to ...venv.../bin
# 2013-07-03 09:09:54 
# 2013-07-03 09:09:54 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:54 Searching for Paste==1.7.5.1
# 2013-07-03 09:09:54 Best match: Paste 1.7.5.1
# 2013-07-03 09:09:54 Adding Paste 1.7.5.1 to easy-install.pth file
# 2013-07-03 09:09:54 
# 2013-07-03 09:09:54 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:54 Searching for PasteDeploy==1.5.0
# 2013-07-03 09:09:54 Best match: PasteDeploy 1.5.0
# 2013-07-03 09:09:54 Adding PasteDeploy 1.5.0 to easy-install.pth file
# 2013-07-03 09:09:54 
# 2013-07-03 09:09:54 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:54 Searching for greenlet==0.4.1
# 2013-07-03 09:09:54 Best match: greenlet 0.4.1
# 2013-07-03 09:09:54 Adding greenlet 0.4.1 to easy-install.pth file
# 2013-07-03 09:09:54 
# 2013-07-03 09:09:54 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:54 Searching for WebOb==1.2.3
# 2013-07-03 09:09:54 Best match: WebOb 1.2.3
# 2013-07-03 09:09:54 Adding WebOb 1.2.3 to easy-install.pth file
# 2013-07-03 09:09:54 
# 2013-07-03 09:09:54 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:54 Searching for Routes==1.13
# 2013-07-03 09:09:54 Best match: Routes 1.13
# 2013-07-03 09:09:55 Adding Routes 1.13 to easy-install.pth file
# 2013-07-03 09:09:55 
# 2013-07-03 09:09:55 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:55 Searching for lxml==3.2.1
# 2013-07-03 09:09:55 Best match: lxml 3.2.1
# 2013-07-03 09:09:55 Adding lxml 3.2.1 to easy-install.pth file
# 2013-07-03 09:09:55 
# 2013-07-03 09:09:55 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:55 Searching for kombu==2.5.12
# 2013-07-03 09:09:55 Best match: kombu 2.5.12
# 2013-07-03 09:09:55 Adding kombu 2.5.12 to easy-install.pth file
# 2013-07-03 09:09:55 
# 2013-07-03 09:09:55 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:55 Searching for eventlet==0.13.0
# 2013-07-03 09:09:55 Best match: eventlet 0.13.0
# 2013-07-03 09:09:55 Adding eventlet 0.13.0 to easy-install.pth file
# 2013-07-03 09:09:55 
# 2013-07-03 09:09:55 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:55 Searching for boto==2.9.6
# 2013-07-03 09:09:55 Best match: boto 2.9.6
# 2013-07-03 09:09:55 Adding boto 2.9.6 to easy-install.pth file
# 2013-07-03 09:09:55 
# 2013-07-03 09:09:55 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:55 Searching for anyjson==0.3.3
# 2013-07-03 09:09:55 Best match: anyjson 0.3.3
# 2013-07-03 09:09:55 Adding anyjson 0.3.3 to easy-install.pth file
# 2013-07-03 09:09:55 
# 2013-07-03 09:09:55 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:55 Searching for amqplib==1.0.2
# 2013-07-03 09:09:55 Best match: amqplib 1.0.2
# 2013-07-03 09:09:55 Adding amqplib 1.0.2 to easy-install.pth file
# 2013-07-03 09:09:55 
# 2013-07-03 09:09:55 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:55 Searching for Cheetah==2.4.4
# 2013-07-03 09:09:55 Best match: Cheetah 2.4.4
# 2013-07-03 09:09:55 Adding Cheetah 2.4.4 to easy-install.pth file
# 2013-07-03 09:09:55 
# 2013-07-03 09:09:55 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:55 Searching for SQLAlchemy==0.7.10
# 2013-07-03 09:09:55 Best match: SQLAlchemy 0.7.10
# 2013-07-03 09:09:55 Adding SQLAlchemy 0.7.10 to easy-install.pth file
# 2013-07-03 09:09:55 
# 2013-07-03 09:09:55 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:55 Searching for pbr==0.5.17
# 2013-07-03 09:09:56 Best match: pbr 0.5.17
# 2013-07-03 09:09:56 Adding pbr 0.5.17 to easy-install.pth file
# 2013-07-03 09:09:56 
# 2013-07-03 09:09:56 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:56 Searching for d2to1==0.2.10
# 2013-07-03 09:09:56 Best match: d2to1 0.2.10
# 2013-07-03 09:09:56 Adding d2to1 0.2.10 to easy-install.pth file
# 2013-07-03 09:09:56 
# 2013-07-03 09:09:56 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:56 Searching for numpy==1.6.1
# 2013-07-03 09:09:56 Best match: numpy 1.6.1
# 2013-07-03 09:09:56 Adding numpy 1.6.1 to easy-install.pth file
# 2013-07-03 09:09:56 
# 2013-07-03 09:09:56 Using /usr/lib/python2.7/dist-packages
# 2013-07-03 09:09:56 Searching for simplejson==2.3.2
# 2013-07-03 09:09:56 Best match: simplejson 2.3.2
# 2013-07-03 09:09:56 simplejson 2.3.2 is already the active version in easy-install.pth
# 2013-07-03 09:09:56 
# 2013-07-03 09:09:56 Using /usr/lib/python2.7/dist-packages
# 2013-07-03 09:09:56 Searching for prettytable==0.7.2
# 2013-07-03 09:09:56 Best match: prettytable 0.7.2
# 2013-07-03 09:09:56 Adding prettytable 0.7.2 to easy-install.pth file
# 2013-07-03 09:09:56 
# 2013-07-03 09:09:56 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:56 Searching for warlock==1.0.1
# 2013-07-03 09:09:56 Best match: warlock 1.0.1
# 2013-07-03 09:09:56 Adding warlock 1.0.1 to easy-install.pth file
# 2013-07-03 09:09:56 
# 2013-07-03 09:09:56 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:56 Searching for pyOpenSSL==0.12
# 2013-07-03 09:09:56 Best match: pyOpenSSL 0.12
# 2013-07-03 09:09:56 pyOpenSSL 0.12 is already the active version in easy-install.pth
# 2013-07-03 09:09:56 
# 2013-07-03 09:09:56 Using /usr/lib/python2.7/dist-packages
# 2013-07-03 09:09:56 Searching for pyparsing==1.5.7
# 2013-07-03 09:09:56 Best match: pyparsing 1.5.7
# 2013-07-03 09:09:56 Adding pyparsing 1.5.7 to easy-install.pth file
# 2013-07-03 09:09:56 
# 2013-07-03 09:09:56 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:56 Searching for httplib2==0.7.2
# 2013-07-03 09:09:56 Best match: httplib2 0.7.2
# 2013-07-03 09:09:57 httplib2 0.7.2 is already the active version in easy-install.pth
# 2013-07-03 09:09:57 
# 2013-07-03 09:09:57 Using /usr/lib/python2.7/dist-packages
# 2013-07-03 09:09:57 Searching for cliff==1.4
# 2013-07-03 09:09:57 Best match: cliff 1.4
# 2013-07-03 09:09:57 Adding cliff 1.4 to easy-install.pth file
# 2013-07-03 09:09:57 
# 2013-07-03 09:09:57 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:57 Searching for pycrypto==2.4.1
# 2013-07-03 09:09:57 Best match: pycrypto 2.4.1
# 2013-07-03 09:09:57 pycrypto 2.4.1 is already the active version in easy-install.pth
# 2013-07-03 09:09:57 
# 2013-07-03 09:09:57 Using /usr/lib/python2.7/dist-packages
# 2013-07-03 09:09:57 Searching for distribute==0.6.24
# 2013-07-03 09:09:57 Best match: distribute 0.6.24
# 2013-07-03 09:09:57 Processing distribute-0.6.24-py2.7.egg
# 2013-07-03 09:09:57 Removing distribute 0.6.24dev-r0 from easy-install.pth file
# 2013-07-03 09:09:57 distribute 0.6.24 is already the active version in easy-install.pth
# 2013-07-03 09:09:57 Installing easy_install script to ...venv.../bin
# 2013-07-03 09:09:57 Installing easy_install-2.7 script to ...venv.../bin
# 2013-07-03 09:09:57 
# 2013-07-03 09:09:57 Using ...venv.../lib/python2.7/site-packages/distribute-0.6.24-py2.7.egg
# 2013-07-03 09:09:57 Searching for Tempita==0.5.1
# 2013-07-03 09:09:57 Best match: Tempita 0.5.1
# 2013-07-03 09:09:57 Adding Tempita 0.5.1 to easy-install.pth file
# 2013-07-03 09:09:57 
# 2013-07-03 09:09:57 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:57 Searching for decorator==3.4.0
# 2013-07-03 09:09:57 Best match: decorator 3.4.0
# 2013-07-03 09:09:57 Adding decorator 3.4.0 to easy-install.pth file
# 2013-07-03 09:09:57 
# 2013-07-03 09:09:57 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:57 Searching for repoze.lru==0.6
# 2013-07-03 09:09:57 Best match: repoze.lru 0.6
# 2013-07-03 09:09:57 Adding repoze.lru 0.6 to easy-install.pth file
# 2013-07-03 09:09:57 
# 2013-07-03 09:09:57 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:57 Searching for amqp==1.0.12
# 2013-07-03 09:09:57 Best match: amqp 1.0.12
# 2013-07-03 09:09:57 Adding amqp 1.0.12 to easy-install.pth file
# 2013-07-03 09:09:58 
# 2013-07-03 09:09:58 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:58 Searching for Markdown==2.3.1
# 2013-07-03 09:09:58 Best match: Markdown 2.3.1
# 2013-07-03 09:09:58 Adding Markdown 2.3.1 to easy-install.pth file
# 2013-07-03 09:09:58 
# 2013-07-03 09:09:58 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:58 Searching for setuptools-git==1.0b1
# 2013-07-03 09:09:58 Best match: setuptools-git 1.0b1
# 2013-07-03 09:09:58 Adding setuptools-git 1.0b1 to easy-install.pth file
# 2013-07-03 09:09:58 
# 2013-07-03 09:09:58 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:58 Searching for jsonpatch==1.1
# 2013-07-03 09:09:58 Best match: jsonpatch 1.1
# 2013-07-03 09:09:58 Adding jsonpatch 1.1 to easy-install.pth file
# 2013-07-03 09:09:58 
# 2013-07-03 09:09:58 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:58 Searching for jsonschema==2.0.0
# 2013-07-03 09:09:58 Best match: jsonschema 2.0.0
# 2013-07-03 09:09:58 Adding jsonschema 2.0.0 to easy-install.pth file
# 2013-07-03 09:09:58 
# 2013-07-03 09:09:58 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:58 Searching for cmd2==0.6.5.1
# 2013-07-03 09:09:58 Best match: cmd2 0.6.5.1
# 2013-07-03 09:09:58 Adding cmd2 0.6.5.1 to easy-install.pth file
# 2013-07-03 09:09:58 
# 2013-07-03 09:09:58 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:58 Searching for jsonpointer==1.0
# 2013-07-03 09:09:58 Best match: jsonpointer 1.0
# 2013-07-03 09:09:58 Adding jsonpointer 1.0 to easy-install.pth file
# 2013-07-03 09:09:58 
# 2013-07-03 09:09:58 Using ...venv.../lib/python2.7/site-packages
# 2013-07-03 09:09:58 Finished processing dependencies for nova==2013.2.a1673.ga9d8521
# 2013-07-03 09:09:58 + echo '***** DB upgrade to state of patchset starts *****'
# 2013-07-03 09:09:58 ***** DB upgrade to state of patchset starts *****
# 2013-07-03 09:09:58 + nova-manage --config-file ...git.../nova-patchset.conf db sync
# 2013-07-03 09:09:58 190 -> 191...     [add_fixed_ip_uc]
# 2013-07-03 09:09:58 done              [0 seconds]
# 2013-07-03 09:09:59 + echo '***** DB upgrade to state of patchset finished *****'
# 2013-07-03 09:09:59 ***** DB upgrade to state of patchset finished *****
                                        [1 seconds total]
# 2013-07-03 09:09:59 ++ sed 's/.*: //'
# 2013-07-03 09:09:59 ++ mysql -u nova --password=nova nova_user_001 -e 'select * from migrate_version \G'
# 2013-07-03 09:09:59 ++ grep version
# 2013-07-03 09:09:59 + version=191
# 2013-07-03 09:09:59 + echo 'Final schema version is 191'
# 2013-07-03 09:09:59 Final schema version is 191
# 2013-07-03 09:09:59 + set +x
# 2013-07-03 09:09:59 Cleaning up virtual env
# 2013-07-03 09:09:59 [script exit code = 0]