nova-manage db sync seems like its pointing at the wrong database for some people

[Nick Robison]

In upgrading my testing cluster from juno to kilo-rc1 on Ubuntu 14.04 I noticed that some of the new columns weren't being populated in my postgres database. I believe I've traced it back to nova-manage not actually writing anything to the database. Pointing it to a new, blank database results in the database still being empty. Other services such as glance and neutron have upgraded fine, so it seems to be limited to nova. I've manually upgraded my sqlalchemy from 0.9.8 to 1.0.2, but to no avail.

Here's the output of nova-manage --debug db sync

No handlers could be found for logger "oslo_config.cfg"
2015-04-30 03:24:49.445 28869 DEBUG migrate.versioning.repository [-] Loading repository /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo... __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/repository.py:76
2015-04-30 03:24:49.447 28869 DEBUG migrate.versioning.script.base [-] Loading script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/256_placeholder.py... __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:27
2015-04-30 03:24:49.447 28869 DEBUG migrate.versioning.script.base [-] Script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/256_placeholder.py loaded successfully __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:30
2015-04-30 03:24:49.448 28869 DEBUG migrate.versioning.script.base [-] Loading script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/257_placeholder.py... __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:27
2015-04-30 03:24:49.448 28869 DEBUG migrate.versioning.script.base [-] Script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/257_placeholder.py loaded successfully __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:30
2015-04-30 03:24:49.448 28869 DEBUG migrate.versioning.script.base [-] Loading script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/258_placeholder.py... __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:27
2015-04-30 03:24:49.453 28869 DEBUG migrate.versioning.script.base [-] Script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/258_placeholder.py loaded successfully __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:30
2015-04-30 03:24:49.462 28869 DEBUG migrate.versioning.script.base [-] Loading script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/259_placeholder.py... __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:27
2015-04-30 03:24:49.462 28869 DEBUG migrate.versioning.script.base [-] Script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/259_placeholder.py loaded successfully __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:30
2015-04-30 03:24:49.463 28869 DEBUG migrate.versioning.script.base [-] Loading script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/260_placeholder.py... __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:27
2015-04-30 03:24:49.463 28869 DEBUG migrate.versioning.script.base [-] Script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/260_placeholder.py loaded successfully __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:30
2015-04-30 03:24:49.463 28869 DEBUG migrate.versioning.script.base [-] Loading script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/261_placeholder.py... __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:27
2015-04-30 03:24:49.464 28869 DEBUG migrate.versioning.script.base [-] Script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/261_placeholder.py loaded successfully __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:30
2015-04-30 03:24:49.464 28869 DEBUG migrate.versioning.script.base [-] Loading script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/262_placeholder.py... __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:27
2015-04-30 03:24:49.464 28869 DEBUG migrate.versioning.script.base [-] Script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/262_placeholder.py loaded successfully __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:30
2015-04-30 03:24:49.464 28869 DEBUG migrate.versioning.script.base [-] Loading script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/263_placeholder.py... __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:27
2015-04-30 03:24:49.465 28869 DEBUG migrate.versioning.script.base [-] Script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/263_placeholder.py loaded successfully __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:30
2015-04-30 03:24:49.465 28869 DEBUG migrate.versioning.script.base [-] Loading script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/264_placeholder.py... __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:27
2015-04-30 03:24:49.465 28869 DEBUG migrate.versioning.script.base [-] Script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/264_placeholder.py loaded successfully __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:30
2015-04-30 03:24:49.465 28869 DEBUG migrate.versioning.script.base [-] Loading script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/265_remove_duplicated_index.py... __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:27
2015-04-30 03:24:49.466 28869 DEBUG migrate.versioning.script.base [-] Script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/265_remove_duplicated_index.py loaded successfully __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:30
2015-04-30 03:24:49.466 28869 DEBUG migrate.versioning.script.base [-] Loading script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/266_add_instance_tags.py... __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:27
2015-04-30 03:24:49.466 28869 DEBUG migrate.versioning.script.base [-] Script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/266_add_instance_tags.py loaded successfully __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:30
2015-04-30 03:24:49.467 28869 DEBUG migrate.versioning.script.base [-] Loading script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/267_instance_uuid_non_nullable.py... __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:27
2015-04-30 03:24:49.467 28869 DEBUG migrate.versioning.script.base [-] Script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/267_instance_uuid_non_nullable.py loaded successfully __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:30
2015-04-30 03:24:49.467 28869 DEBUG migrate.versioning.script.base [-] Loading script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/268_add_host_in_compute_node.py... __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:27
2015-04-30 03:24:49.467 28869 DEBUG migrate.versioning.script.base [-] Script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/268_add_host_in_compute_node.py loaded successfully __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:30
2015-04-30 03:24:49.468 28869 DEBUG migrate.versioning.script.base [-] Loading script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/269_add_numa_node_column.py... __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:27
2015-04-30 03:24:49.468 28869 DEBUG migrate.versioning.script.base [-] Script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/269_add_numa_node_column.py loaded successfully __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:30
2015-04-30 03:24:49.468 28869 DEBUG migrate.versioning.script.base [-] Loading script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/270_flavor_data_in_extra.py... __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:27
2015-04-30 03:24:49.468 28869 DEBUG migrate.versioning.script.base [-] Script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/270_flavor_data_in_extra.py loaded successfully __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:30
2015-04-30 03:24:49.469 28869 DEBUG migrate.versioning.script.base [-] Loading script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/271_sqlite_postgresql_indexes.py... __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:27
2015-04-30 03:24:49.469 28869 DEBUG migrate.versioning.script.base [-] Script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/271_sqlite_postgresql_indexes.py loaded successfully __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:30
2015-04-30 03:24:49.469 28869 DEBUG migrate.versioning.script.base [-] Loading script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/272_add_keypair_type.py... __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:27
2015-04-30 03:24:49.469 28869 DEBUG migrate.versioning.script.base [-] Script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/272_add_keypair_type.py loaded successfully __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:30
2015-04-30 03:24:49.470 28869 DEBUG migrate.versioning.script.base [-] Loading script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/273_sqlite_foreign_keys.py... __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:27
2015-04-30 03:24:49.470 28869 DEBUG migrate.versioning.script.base [-] Script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/273_sqlite_foreign_keys.py loaded successfully __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:30
2015-04-30 03:24:49.470 28869 DEBUG migrate.versioning.script.base [-] Loading script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/274_update_instances_project_id_index.py... __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:27
2015-04-30 03:24:49.471 28869 DEBUG migrate.versioning.script.base [-] Script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/274_update_instances_project_id_index.py loaded successfully __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:30
2015-04-30 03:24:49.471 28869 DEBUG migrate.versioning.script.base [-] Loading script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/275_add_keypair_type.py... __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:27
2015-04-30 03:24:49.478 28869 DEBUG migrate.versioning.script.base [-] Script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/275_add_keypair_type.py loaded successfully __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:30
2015-04-30 03:24:49.478 28869 DEBUG migrate.versioning.script.base [-] Loading script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/276_vcpu_model.py... __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:27
2015-04-30 03:24:49.479 28869 DEBUG migrate.versioning.script.base [-] Script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/276_vcpu_model.py loaded successfully __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:30
2015-04-30 03:24:49.479 28869 DEBUG migrate.versioning.script.base [-] Loading script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/277_add_fixed_ip_updated_index.py... __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:27
2015-04-30 03:24:49.482 28869 DEBUG migrate.versioning.script.base [-] Script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/277_add_fixed_ip_updated_index.py loaded successfully __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:30
2015-04-30 03:24:49.482 28869 DEBUG migrate.versioning.script.base [-] Loading script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/278_remove_service_fk_in_compute_nodes.py... __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:27
2015-04-30 03:24:49.482 28869 DEBUG migrate.versioning.script.base [-] Script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/278_remove_service_fk_in_compute_nodes.py loaded successfully __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:30
2015-04-30 03:24:49.483 28869 DEBUG migrate.versioning.script.base [-] Loading script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/279_fix_unique_constraint_for_compute_node.py... __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:27
2015-04-30 03:24:49.483 28869 DEBUG migrate.versioning.script.base [-] Script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/279_fix_unique_constraint_for_compute_node.py loaded successfully __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:30
2015-04-30 03:24:49.483 28869 DEBUG migrate.versioning.script.base [-] Loading script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/280_add_nullable_false_to_keypairs_name.py... __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:27
2015-04-30 03:24:49.484 28869 DEBUG migrate.versioning.script.base [-] Script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/280_add_nullable_false_to_keypairs_name.py loaded successfully __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:30
2015-04-30 03:24:49.484 28869 DEBUG migrate.versioning.script.base [-] Loading script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/216_havana.py... __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:27
2015-04-30 03:24:49.484 28869 DEBUG migrate.versioning.script.base [-] Script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/216_havana.py loaded successfully __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:30
2015-04-30 03:24:49.484 28869 DEBUG migrate.versioning.script.base [-] Loading script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/217_placeholder.py... __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:27
2015-04-30 03:24:49.485 28869 DEBUG migrate.versioning.script.base [-] Script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/217_placeholder.py loaded successfully __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:30
2015-04-30 03:24:49.485 28869 DEBUG migrate.versioning.script.base [-] Loading script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/218_placeholder.py... __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:27
2015-04-30 03:24:49.485 28869 DEBUG migrate.versioning.script.base [-] Script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/218_placeholder.py loaded successfully __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:30
2015-04-30 03:24:49.485 28869 DEBUG migrate.versioning.script.base [-] Loading script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/219_placeholder.py... __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:27
2015-04-30 03:24:49.486 28869 DEBUG migrate.versioning.script.base [-] Script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/219_placeholder.py loaded successfully __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:30
2015-04-30 03:24:49.486 28869 DEBUG migrate.versioning.script.base [-] Loading script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/220_placeholder.py... __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:27
2015-04-30 03:24:49.486 28869 DEBUG migrate.versioning.script.base [-] Script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/220_placeholder.py loaded successfully __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:30
2015-04-30 03:24:49.486 28869 DEBUG migrate.versioning.script.base [-] Loading script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/221_placeholder.py... __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:27
2015-04-30 03:24:49.487 28869 DEBUG migrate.versioning.script.base [-] Script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/221_placeholder.py loaded successfully __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:30
2015-04-30 03:24:49.487 28869 DEBUG migrate.versioning.script.base [-] Loading script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/222_placeholder.py... __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:27
2015-04-30 03:24:49.487 28869 DEBUG migrate.versioning.script.base [-] Script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/222_placeholder.py loaded successfully __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:30
2015-04-30 03:24:49.490 28869 DEBUG migrate.versioning.script.base [-] Loading script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/223_placeholder.py... __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:27
2015-04-30 03:24:49.490 28869 DEBUG migrate.versioning.script.base [-] Script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/223_placeholder.py loaded successfully __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:30
2015-04-30 03:24:49.498 28869 DEBUG migrate.versioning.script.base [-] Loading script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/224_placeholder.py... __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:27
2015-04-30 03:24:49.498 28869 DEBUG migrate.versioning.script.base [-] Script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/224_placeholder.py loaded successfully __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:30
2015-04-30 03:24:49.498 28869 DEBUG migrate.versioning.script.base [-] Loading script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/225_placeholder.py... __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:27
2015-04-30 03:24:49.499 28869 DEBUG migrate.versioning.script.base [-] Script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/225_placeholder.py loaded successfully __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:30
2015-04-30 03:24:49.499 28869 DEBUG migrate.versioning.script.base [-] Loading script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/226_placeholder.py... __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:27
2015-04-30 03:24:49.499 28869 DEBUG migrate.versioning.script.base [-] Script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/226_placeholder.py loaded successfully __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:30
2015-04-30 03:24:49.500 28869 DEBUG migrate.versioning.script.base [-] Loading script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/227_fix_project_user_quotas_resource_length.py... __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:27
2015-04-30 03:24:49.500 28869 DEBUG migrate.versioning.script.base [-] Script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/227_fix_project_user_quotas_resource_length.py loaded successfully __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:30
2015-04-30 03:24:49.500 28869 DEBUG migrate.versioning.script.base [-] Loading script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/228_add_metrics_in_compute_nodes.py... __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:27
2015-04-30 03:24:49.500 28869 DEBUG migrate.versioning.script.base [-] Script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/228_add_metrics_in_compute_nodes.py loaded successfully __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:30
2015-04-30 03:24:49.501 28869 DEBUG migrate.versioning.script.base [-] Loading script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/229_add_extra_resources_in_compute_nodes.py... __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:27
2015-04-30 03:24:49.501 28869 DEBUG migrate.versioning.script.base [-] Script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/229_add_extra_resources_in_compute_nodes.py loaded successfully __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:30
2015-04-30 03:24:49.501 28869 DEBUG migrate.versioning.script.base [-] Loading script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/230_add_details_column_to_instance_actions_events.py... __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:27
2015-04-30 03:24:49.501 28869 DEBUG migrate.versioning.script.base [-] Script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/230_add_details_column_to_instance_actions_events.py loaded successfully __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:30
2015-04-30 03:24:49.502 28869 DEBUG migrate.versioning.script.base [-] Loading script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/231_add_ephemeral_key_uuid.py... __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:27
2015-04-30 03:24:49.502 28869 DEBUG migrate.versioning.script.base [-] Script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/231_add_ephemeral_key_uuid.py loaded successfully __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:30
2015-04-30 03:24:49.502 28869 DEBUG migrate.versioning.script.base [-] Loading script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/232_drop_dump_tables.py... __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:27
2015-04-30 03:24:49.506 28869 DEBUG migrate.versioning.script.base [-] Script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/232_drop_dump_tables.py loaded successfully __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:30
2015-04-30 03:24:49.506 28869 DEBUG migrate.versioning.script.base [-] Loading script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/233_add_stats_in_compute_nodes.py... __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:27
2015-04-30 03:24:49.507 28869 DEBUG migrate.versioning.script.base [-] Script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/233_add_stats_in_compute_nodes.py loaded successfully __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:30
2015-04-30 03:24:49.507 28869 DEBUG migrate.versioning.script.base [-] Loading script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/234_add_expire_reservations_index.py... __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:27
2015-04-30 03:24:49.507 28869 DEBUG migrate.versioning.script.base [-] Script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/234_add_expire_reservations_index.py loaded successfully __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:30
2015-04-30 03:24:49.507 28869 DEBUG migrate.versioning.script.base [-] Loading script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/235_placeholder.py... __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:27
2015-04-30 03:24:49.508 28869 DEBUG migrate.versioning.script.base [-] Script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/235_placeholder.py loaded successfully __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:30
2015-04-30 03:24:49.508 28869 DEBUG migrate.versioning.script.base [-] Loading script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/236_placeholder.py... __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:27
2015-04-30 03:24:49.508 28869 DEBUG migrate.versioning.script.base [-] Script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/236_placeholder.py loaded successfully __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:30
2015-04-30 03:24:49.508 28869 DEBUG migrate.versioning.script.base [-] Loading script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/237_placeholder.py... __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:27
2015-04-30 03:24:49.509 28869 DEBUG migrate.versioning.script.base [-] Script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/237_placeholder.py loaded successfully __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:30
2015-04-30 03:24:49.509 28869 DEBUG migrate.versioning.script.base [-] Loading script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/238_placeholder.py... __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:27
2015-04-30 03:24:49.511 28869 DEBUG migrate.versioning.script.base [-] Script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/238_placeholder.py loaded successfully __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:30
2015-04-30 03:24:49.511 28869 DEBUG migrate.versioning.script.base [-] Loading script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/239_placeholder.py... __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:27
2015-04-30 03:24:49.511 28869 DEBUG migrate.versioning.script.base [-] Script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/239_placeholder.py loaded successfully __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:30
2015-04-30 03:24:49.512 28869 DEBUG migrate.versioning.script.base [-] Loading script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/240_placeholder.py... __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:27
2015-04-30 03:24:49.512 28869 DEBUG migrate.versioning.script.base [-] Script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/240_placeholder.py loaded successfully __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:30
2015-04-30 03:24:49.512 28869 DEBUG migrate.versioning.script.base [-] Loading script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/241_placeholder.py... __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:27
2015-04-30 03:24:49.512 28869 DEBUG migrate.versioning.script.base [-] Script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/241_placeholder.py loaded successfully __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:30
2015-04-30 03:24:49.514 28869 DEBUG migrate.versioning.script.base [-] Loading script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/242_placeholder.py... __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:27
2015-04-30 03:24:49.514 28869 DEBUG migrate.versioning.script.base [-] Script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/242_placeholder.py loaded successfully __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:30
2015-04-30 03:24:49.514 28869 DEBUG migrate.versioning.script.base [-] Loading script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/243_placeholder.py... __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:27
2015-04-30 03:24:49.515 28869 DEBUG migrate.versioning.script.base [-] Script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/243_placeholder.py loaded successfully __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:30
2015-04-30 03:24:49.522 28869 DEBUG migrate.versioning.script.base [-] Loading script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/244_increase_user_id_length_volume_usage_cache.py... __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:27
2015-04-30 03:24:49.522 28869 DEBUG migrate.versioning.script.base [-] Script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/244_increase_user_id_length_volume_usage_cache.py loaded successfully __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:30
2015-04-30 03:24:49.522 28869 DEBUG migrate.versioning.script.base [-] Loading script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/245_add_mtu_and_dhcp_server.py... __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:27
2015-04-30 03:24:49.523 28869 DEBUG migrate.versioning.script.base [-] Script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/245_add_mtu_and_dhcp_server.py loaded successfully __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:30
2015-04-30 03:24:49.526 28869 DEBUG migrate.versioning.script.base [-] Loading script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/246_sqlite_upgrade.sql... __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:27
2015-04-30 03:24:49.526 28869 DEBUG migrate.versioning.script.base [-] Script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/246_sqlite_upgrade.sql loaded successfully __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:30
2015-04-30 03:24:49.526 28869 DEBUG migrate.versioning.script.base [-] Loading script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/246_sqlite_downgrade.sql... __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:27
2015-04-30 03:24:49.527 28869 DEBUG migrate.versioning.script.base [-] Script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/246_sqlite_downgrade.sql loaded successfully __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:30
2015-04-30 03:24:49.527 28869 DEBUG migrate.versioning.script.base [-] Loading script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/246_add_compute_node_id_fk.py... __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:27
2015-04-30 03:24:49.527 28869 DEBUG migrate.versioning.script.base [-] Script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/246_add_compute_node_id_fk.py loaded successfully __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:30
2015-04-30 03:24:49.528 28869 DEBUG migrate.versioning.script.base [-] Loading script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/247_nullable_mismatch.py... __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:27
2015-04-30 03:24:49.528 28869 DEBUG migrate.versioning.script.base [-] Script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/247_nullable_mismatch.py loaded successfully __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:30
2015-04-30 03:24:49.528 28869 DEBUG migrate.versioning.script.base [-] Loading script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/248_add_expire_reservations_index.py... __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:27
2015-04-30 03:24:49.528 28869 DEBUG migrate.versioning.script.base [-] Script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/248_add_expire_reservations_index.py loaded successfully __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:30
2015-04-30 03:24:49.529 28869 DEBUG migrate.versioning.script.base [-] Loading script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/249_remove_duplicate_index.py... __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:27
2015-04-30 03:24:49.529 28869 DEBUG migrate.versioning.script.base [-] Script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/249_remove_duplicate_index.py loaded successfully __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:30
2015-04-30 03:24:49.529 28869 DEBUG migrate.versioning.script.base [-] Loading script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/250_remove_instance_groups_metadata.py... __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:27
2015-04-30 03:24:49.529 28869 DEBUG migrate.versioning.script.base [-] Script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/250_remove_instance_groups_metadata.py loaded successfully __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:30
2015-04-30 03:24:49.529 28869 DEBUG migrate.versioning.script.base [-] Loading script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/251_add_numa_topology_to_comput_nodes.py... __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:27
2015-04-30 03:24:49.530 28869 DEBUG migrate.versioning.script.base [-] Script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/251_add_numa_topology_to_comput_nodes.py loaded successfully __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:30
2015-04-30 03:24:49.530 28869 DEBUG migrate.versioning.script.base [-] Loading script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/252_add_instance_extra_table.py... __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:27
2015-04-30 03:24:49.530 28869 DEBUG migrate.versioning.script.base [-] Script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/252_add_instance_extra_table.py loaded successfully __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:30
2015-04-30 03:24:49.530 28869 DEBUG migrate.versioning.script.base [-] Loading script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/253_add_pci_requests_to_instance_extra_table.py... __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:27
2015-04-30 03:24:49.531 28869 DEBUG migrate.versioning.script.base [-] Script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/253_add_pci_requests_to_instance_extra_table.py loaded successfully __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:30
2015-04-30 03:24:49.531 28869 DEBUG migrate.versioning.script.base [-] Loading script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/254_add_request_id_in_pci_devices.py... __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:27
2015-04-30 03:24:49.531 28869 DEBUG migrate.versioning.script.base [-] Script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/254_add_request_id_in_pci_devices.py loaded successfully __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:30
2015-04-30 03:24:49.531 28869 DEBUG migrate.versioning.script.base [-] Loading script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/255_placeholder.py... __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:27
2015-04-30 03:24:49.532 28869 DEBUG migrate.versioning.script.base [-] Script /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo/versions/255_placeholder.py loaded successfully __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/script/base.py:30
2015-04-30 03:24:49.534 28869 DEBUG migrate.versioning.repository [-] Repository /usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/migrate_repo loaded successfully __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/repository.py:82
2015-04-30 03:24:49.542 28869 DEBUG migrate.versioning.repository [-] Config: OrderedDict([('db_settings', OrderedDict([('__name__', 'db_settings'), ('repository_id', 'nova'), ('version_table', 'migrate_version'), ('required_dbs', '[]')]))]) __init__ /usr/lib/python2.7/dist-packages/migrate/versioning/repository.py:83

My current nova versions (output from dpkg -l):
ii nova-api 1:2015.1~rc1-0ubuntu1~cloud0 all OpenStack Compute - API frontend
ii nova-cert 1:2015.1~rc1-0ubuntu1~cloud0 all OpenStack Compute - certificate management
ii nova-common 1:2015.1~rc1-0ubuntu1~cloud0 all OpenStack Compute - common files
ii nova-conductor 1:2015.1~rc1-0ubuntu1~cloud0 all OpenStack Compute - conductor service
ii nova-consoleauth 1:2015.1~rc1-0ubuntu1~cloud0 all OpenStack Compute - Console Authenticator
ii nova-novncproxy 1:2015.1~rc1-0ubuntu1~cloud0 all OpenStack Compute - NoVNC proxy
ii nova-scheduler 1:2015.1~rc1-0ubuntu1~cloud0 all OpenStack Compute - virtual machine scheduler
ii python-nova 1:2015.1~rc1-0ubuntu1~cloud0 all OpenStack Compute Python libraries
ii python-novaclient 1:2.22.0-0ubuntu1~cloud0 all client library for OpenStack Compute API

Happy to provide any additional debug/config details.

[Michael Still (mikal)]

I know it would be a bit of a pain, but are you able to confirm if this problem happens with mysql as well?

[Nick Robison (nickrobison)]

I can check that later this evening. Right now, this is a breaking issue for me. Is it possible to manually apply the sqlalchemy operations?

[Thiago Martins (martinx)]

I'm trying to install Kilo on Ubuntu 14.04.2, I'm stucked here.

root@controller-1:/etc/nova# su -s /bin/sh -c "nova-manage db sync" nova
No handlers could be found for logger "oslo_config.cfg"

I'm following:

http://docs.openstack.org/kilo/install-guide/install/apt/content/ch_nova.html#nova-controller-install

I really appreciate any tip!

I'm using "mysql-server-5.5", not MariaDB.

Stable Kilo:

root@controller-1:/etc/nova# dpkg -l | grep nova-common
ii nova-common 1:2015.1.0-0ubuntu1~cloud0 all OpenStack Compute - common files

[Anne Gentle (annegentle)]

Thiago, the original report refers to an upgrade. Your error sounds like a dependencies problem. Those docs, especially for Ubuntu, are tested thoroughly so re-check your setup.

For the original reporter, we haven't written nor tested docs for the upgrade from Juno to Kilo yet. Are you referring to http://docs.openstack.org/openstack-ops/content/ch_ops_upgrades.html to try an upgrade?

[Nick Robison (nickrobison)]

Michael,

I tried running the nova-manage command against a new mysql install, but it's still not committing. No direct error messages are being shown, even if I enter the wrong username or password it still 'succeeds' with no errors. So it seems that nova-manage db sync isn't connecting to the database (there's nothing in the db logs).

Anne,

I've been following the 'icehouse to juno' upgrade guide that you mentioned, along with what exists of the kilo release notes. Aside from the nova stuff, I haven't really run into any major discrepancies.

[Kurt Lacy (kurt-lacy)]

I am having the exact same problem. I'm trying to install Kilo on Ubuntu 14.04.2, I'm stucked here.

root@controller-1:/etc/nova# su -s /bin/sh -c "nova-manage db_sync" nova - I assume there was a missing '_' in the command
 No handlers could be found for logger "oslo_config.cfg"

I'm following:

http://docs.openstack.org/kilo/install-guide/install/apt/content/ch_nova.html#nova-controller-install

I have tried to perform this installation twice, but each time it fails at the same point. I have checked my installation and steps carefully.

[cds (craigshannonx)]

Same problem, upgrading from Juno->Kilo on 14.04.2

root@controller:/home/cdshann# su -s /bin/sh -c "nova-manage db sync" nova
No handlers could be found for logger "oslo_config.cfg"

Been following the install docs exactly. Also using MySQL

[Walter (walterxj)]

  I met the same problem either,but when I use the testing repository(http://rdoproject.org/repos/openstack-kilo/rdo-testing-kilo.rpm) instead of the release repository(http://rdo.fedorapeople.org/openstack-kilo/rdo-release-kilo.rpm) few days ago it did not happen,but today I find that the testing repository has been removed .

[Walter (walterxj)]

  Sorry,I met same error message with cinder installation(new install) using :su -s /bin/sh -c "cinder-manage db sync" cinder.
  stderr says:/usr/lib/python2.7/site-packages/cinder/openstack/common/service.py:38: DeprecationWarning: The oslo namespace package is deprecated. Please use oslo_config instead.
  from oslo.config import cfg
No handlers could be found for logger "oslo_config.cfg"
/usr/lib/python2.7/site-packages/migrate/changeset/constraint.py:85: SAWarning: Table 'encryption' specifies columns 'volume_type_id' as primary_key=True, not matching locally specified columns 'encryption_id'; setting the current primary key columns to 'encryption_id'. This warning may become an exception in a future release
  self._set_parent(table)

  Then I check the mysql cinder db,there are many tables in it,and the cinder-api,cinder-scheduler running well.

[John Garbutt (johngarbutt)]

Can you tell us how the DB is configured in your conf file. And what the name of that file is, etc?

I wonder if nova-manage is actually just writing to some default location sqlite db that the rest of your code is not accessing.

[cds (craigshannonx)]

I was able to reproduce the results posted by OP by adding the debug flag. My nova.conf:

[DEFAULT]
dhcpbridge_flagfile=/etc/nova/nova.conf
dhcpbridge=/usr/bin/nova-dhcpbridge
logdir=/var/log/nova
state_path=/var/lib/nova
lock_path=/var/lock/nova
force_dhcp_release=True
libvirt_use_virtio_for_bridges=True
verbose=True
ec2_private_dns_show_ip=True
api_paste_config=/etc/nova/api-paste.ini
enabled_apis=ec2,osapi_compute,metadata
#cdshann
rpc_backend=rabbit
auth_strategy=keystone
my_ip=192.168.1.2
vncserver_listen=192.168.1.2
vncserver_proxyclient_address=192.168.1.2
network_api_class = nova.network.api.API
security_group_api = nova

[oslo_messaging_rabbit]
rabbit_host = controller
rabbit_userid = openstack
rabbit_password = XXX

[database]
mysql://nova:NovaDB_PWD@controller/nova

[keystone_authtoken]
auth_uri = http://controller:5000
auth_url = http://controller:35357
auth_plugin = password
project_domain_id = default
user_domain_id = default
project_name = service
username = nova
password = XXX

[glance]
host=controller

[oslo_concurrency]
lock_path = /var/lock/nova

[John Garbutt (johngarbutt)]

So adding incomplete as I am not sure we have narrowed this down enough yet.

We need to answer this question:
Is this specific to the ubuntu packaging, or a more general issues?

[Matt Riedemann (mriedem)]

What are the versions of your oslo.db, sqlalchemy-migrate and sqlalchemy packages when you hit this?

[cds (craigshannonx)]

python-sqlalchemy 0.9.8+dfsg-0.1~cloud0
python-migrate 0.9.5-0ubuntu1~cloud0

python-oslo.db was actually not installed on my controller. bug still exists after installing it however.

python-oslo.db 1.7.1-0ubuntu2~cloud0

[Matt Riedemann (mriedem)]

If 'nova-manage db version' shows 280 after you've upgrade (run nova-manage db sync), then you're at the latest kilo version for nova:

https://github.com/openstack/nova/tree/stable/kilo/nova/db/sqlalchemy/migrate_repo/versions

[Nick Robison (nickrobison)]

Ok, I've dug into this a little bit more.

In nova.conf, my connection string is: connection=mysql://[username]:[password]@controller:[port]/nova.
But instead of writing to the database, it's writing to the local sqlite file in /var/lib/nova. Interestingly, it seems to have been stopping at version 216, but when I deleted the errant sqlite file, it recreated it up to the version 280.
I still cannot get it to connect to either the mysql or postgres database. Was there a change to the db connection string in the kilo configuration file?

My python package versions:

python-oslo-db 1.7.1-0ubuntu2~cloud0
python-sqlalchemy 0.9.8+dfsg-0.1~cloud0
python-sqlalchemy-ext 0.9.8+dfsg-0.1~cloud0
python-migrate 0.9.5-0ubuntu1~cloud0

[Matt Riedemann (mriedem)]

The database connection config should be the same, the 'connection' option in the [database] group:

http://docs.openstack.org/kilo/config-reference/content/list-of-compute-config-options.html

Is your controller in the connection config a hostname or IP? Does it resolve OK, no DNS issues or anything?

[Nick Robison (nickrobison)]

The connection string is pointing to the hostname of the database server, and the dns does resolve correctly.

[Wu Hong Guang (whg)]

change the 'logdir' to 'log_dir' did fix this issue

[Wu Hong Guang (whg)]

this is ubuntu package issue

[Yaron (sh-yaron)]

@Wu Hong Guang (whg) - Thank you so much! Worked like a charm!

[Perry Merritt (perry-w-merritt)]

Changing the logdir to log_dir did not fix the problem for me. I am getting a sqlite database created rather than inserting the tables into my mysql database.

My nova.conf is as follows:
[DEFAULT]
dhcpbridge_flagfile=/etc/nova/nova.conf
dhcpbridge=/usr/bin/nova-dhcpbridge
#log_dir=/var/log/nova
state_path=/var/lib/nova
lock_path=/var/lock/nova
force_dhcp_release=True
libvirt_use_virtio_for_bridges=True
ec2_private_dns_show_ip=True
api_paste_config=/etc/nova/api-paste.ini
enabled_apis=osapi_compute,metadata
connection = mysql+pymysql://nova:PASSWORD@controller/nova
auth_strategy = keystone
rpc_backend = rabbit
my_ip = 192.168.1.1
network_api_class = nova.network.neutronv2.api.API
security_group_api = neutron
linuxnet_interface_driver = nova.network.linux_net.NeutronLinuxBridgeInterfaceDriver
firewall_driver = nova.virt.firewall.NoopFirewallDriver
enabled_apis=osapi_compute,metadata
backend=mysql
connection_trace=True
connection_debug = 100

[oslo_messaging_rabbit]
rabbit_host = controller
rabbit_userid = stack
rabbit_password = PASSWORD

[keystone_authtoken]
auth_uri = http://controller:5000
auth_url = http://controller:35357
auth_plugin = password
project_domain_id = default
user_domain_id = default
project_name = service
username = nova
password = PASSWORD

[vnc]
vncserver_listen = $my_ip
vncserver_proxyclient_address = $my_ip

[glance]
host = controller

[oslo_concurrency]
lock_path = /var/lib/nova/tmp

Any help would be greatly appreciated. Thank you.

[Perry Merritt (perry-w-merritt)]

I should add, this is Ubuntu 14.04.1 and Liberty

[Luke Hinds (lhinds)]

I am getting this same issue. What was the fix released Perry? Changing logdir/log_dir made no difference.

[Chetna (ck-khullar)]

I am getting similar issue. I am trying to initialize Neutron database using the below command:
sudo neutron-db-manage --config-file /etc/neutron/neutron.conf --config-file /etc/neutron/plugins/ml2/ml2_conf.ini upgrade head

I get the below:

No handlers could be found for logger "oslo_config.cfg"
Traceback (most recent call last):
  File "/usr/bin/neutron-db-manage", line 10, in <module>
    sys.exit(main())
  File "/opt/stack/neutron/neutron/db/migration/cli.py", line 744, in main
    return_val |= bool(CONF.command.func(config, CONF.command.name))
  File "/opt/stack/neutron/neutron/db/migration/cli.py", line 218, in do_upgrade
    run_sanity_checks(config, revision)
  File "/opt/stack/neutron/neutron/db/migration/cli.py", line 726, in run_sanity_checks
    script_dir.run_env()
  File "/usr/local/lib/python2.7/dist-packages/alembic/script/base.py", line 397, in run_env
    util.load_python_file(self.dir, 'env.py')
  File "/usr/local/lib/python2.7/dist-packages/alembic/util/pyfiles.py", line 81, in load_python_file
    module = load_module_py(module_id, path)
  File "/usr/local/lib/python2.7/dist-packages/alembic/util/compat.py", line 79, in load_module_py
    mod = imp.load_source(module_id, path, fp)
  File "/opt/stack/neutron/neutron/db/migration/alembic_migrations/env.py", line 126, in <module>
    run_migrations_online()
  File "/opt/stack/neutron/neutron/db/migration/alembic_migrations/env.py", line 112, in run_migrations_online
    with DBConnection(neutron_config.database.connection, connection) as conn:
  File "/opt/stack/neutron/neutron/db/migration/connection.py", line 32, in __enter__
    self.engine = session.create_engine(self.connection_url)
  File "/usr/local/lib/python2.7/dist-packages/oslo_db/sqlalchemy/engines.py", line 152, in create_engine
    test_conn = _test_connection(engine, max_retries, retry_interval)
  File "/usr/local/lib/python2.7/dist-packages/oslo_db/sqlalchemy/engines.py", line 326, in _test_connection
    return engine.connect()
  File "/usr/local/lib/python2.7/dist-packages/sqlalchemy/engine/base.py", line 2018, in connect
    return self._connection_cls(self, **kwargs)
  File "/usr/local/lib/python2.7/dist-packages/sqlalchemy/engine/base.py", line 72, in __init__
    if connection is not None else engine.raw_connection()
  File "/usr/local/lib/python2.7/dist-packages/sqlalchemy/engine/base.py", line 2104, in raw_connection
    self.pool.unique_connection, _connection)
  File "/usr/local/lib/python2.7/dist-packages/sqlalchemy/engine/base.py", line 2078, in _wrap_pool_connect
    e, dialect, self)
  File "/usr/local/lib/python2.7/dist-packages/sqlalchemy/engine/base.py", line 1401, in _handle_dbapi_exception_noconnection
    util.raise_from_cause(newraise, exc_info)
  File "/usr/local/lib/python2.7/dist-packages/sqlalchemy/util/compat.py", line 200, in raise_from_cause
    reraise(type(exception), exception, tb=exc_tb, cause=cause)
  File "/usr/local/lib/python2.7/dist-packages/sqlalchemy/engine/base.py", line 2074, in _wrap_pool_connect
    return fn()
  File "/usr/local/lib/python2.7/dist-packages/sqlalchemy/pool.py", line 318, in unique_connection
    return _ConnectionFairy._checkout(self)
  File "/usr/...