The attempt to merge lp:~rackspace-titan/nova/servers-response-formatting into lp:nova failed. Below is the output from the failed tests. FloatingIpTest test_floating_ip_allocate OK 0.31 test_floating_ip_associate OK 0.11 test_floating_ip_disassociate OK 0.11 test_floating_ip_release OK 0.11 test_floating_ip_show OK 0.13 test_floating_ips_list OK 0.10 test_translate_floating_ip_view OK 0.05 FixedIpTest test_add_fixed_ip OK 0.08 test_add_fixed_ip_no_network OK 0.09 test_remove_fixed_ip OK 0.29 test_remove_fixed_ip_no_address OK 0.07 FlavorsExtraSpecsTest test_create OK 0.05 test_create_empty_body OK 0.05 test_delete OK 0.05 test_index OK 0.05 test_index_no_data OK 0.05 test_show OK 0.05 test_show_spec_not_found OK 0.05 test_update_item OK 0.05 test_update_item_body_uri_mismatch OK 0.05 test_update_item_empty_body OK 0.05 test_update_item_too_many_keys OK 0.05 AccountsTest test_account_create OK 0.41 test_account_delete OK 0.18 test_account_update OK 0.18 test_get_account OK 0.18 AdminAPITest test_admin_disabled OK 0.13 test_admin_enabled OK 0.43 APITest test_exceptions_are_converted_to_faults OK 0.01 test_malformed_json OK 0.06 test_malformed_xml OK 0.06 Test test_authorize_project OK 0.10 test_authorize_token OK 0.11 test_authorize_user OK 0.06 test_bad_project OK 0.36 test_bad_token OK 0.07 test_bad_user_bad_key OK 0.06 test_bad_user_good_key OK 0.06 test_no_user OK 0.06 test_not_existing_project OK 0.10 test_token_expiry OK 0.06 TestFunctional test_token_doesnotexist OK 0.07 test_token_expiry OK 0.37 TestLimiter test_authorize_token OK 0.13 LimiterTest test_limiter_custom_max_limit OK 0.00 test_limiter_limit_and_offset OK 0.00 test_limiter_limit_medium OK 0.00 test_limiter_limit_over_max OK 0.00 test_limiter_limit_zero OK 0.01 test_limiter_negative_limit OK 0.00 test_limiter_negative_offset OK 0.00 test_limiter_nothing OK 0.00 test_limiter_offset_bad OK 0.00 test_limiter_offset_blank OK 0.00 test_limiter_offset_medium OK 0.00 test_limiter_offset_over_max OK 0.00 test_limiter_offset_zero OK 0.00 MiscFunctionsTest test_get_id_from_href OK 0.00 test_get_id_from_href_bad_request OK 0.00 test_get_version_from_href OK 0.01 test_get_version_from_href_2 OK 0.00 test_get_version_from_href_default OK 0.00 test_remove_version_from_href OK 0.00 test_remove_version_from_href_2 OK 0.00 test_remove_version_from_href_3 OK 0.01 test_remove_version_from_href_4 OK 0.00 test_remove_version_from_href_bad_request OK 0.00 test_remove_version_from_href_bad_request_2 OK 0.00 test_remove_version_from_href_bad_request_3 OK 0.00 PaginationParamsTest test_invalid_limit OK 0.01 test_invalid_marker OK 0.00 test_no_params OK 0.00 test_valid_limit OK 0.00 test_valid_limit_and_marker OK 0.00 test_valid_marker OK 0.00 ActionExtensionTest test_extended_action OK 0.19 test_invalid_action OK 0.11 test_invalid_action_body OK 0.16 ExtensionControllerTest test_get_extension_json OK 0.10 test_get_extension_xml OK 0.06 test_list_extensions_json OK 0.05 test_list_extensions_xml OK 0.34 ExtensionManagerTest test_get_resources OK 0.05 test_invalid_extensions OK 0.05 ExtensionsXMLSerializerTest test_serialize_extensions OK 0.00 test_serialize_extenstion OK 0.00 RequestExtensionTest test_get_resources_with_mgr OK 0.20 test_get_resources_with_stub_mgr OK 0.21 ResourceExtensionTest test_get_resources OK 0.02 test_get_resources_with_controller OK 0.02 test_no_extension_present OK 0.07 FaultsXMLSerializationTestV11 test_400_fault OK 0.00 test_404_fault OK 0.00 test_413_fault OK 0.00 TestFaults test_400_fault_json OK 0.00 test_400_fault_xml OK 0.00 test_413_fault_json OK 0.00 test_413_fault_xml OK 0.00 test_fault_has_status_int OK 0.00 test_raise OK 0.00 test_v10_xml_serializer OK 0.00 test_v11_xml_serializer OK 0.00 FlavorsTest test_get_empty_flavor_list_v1_0 OK 0.12 test_get_empty_flavor_list_v1_1 OK 0.47 test_get_flavor_by_id_v1_0 OK 0.12 test_get_flavor_by_id_v1_1 OK 0.18 test_get_flavor_by_invalid_id OK 0.12 test_get_flavor_list_detail_v1_0 OK 0.08 test_get_flavor_list_detail_v1_1 OK 0.19 test_get_flavor_list_v1_0 OK 0.40 test_get_flavor_list_v1_1 OK 0.18 FlavorsXMLSerializationTest test_detail OK 0.01 test_index OK 0.01 test_index_empty OK 0.00 test_show OK 0.00 test_show_handles_integers OK 0.00 ImageMetaDataTest test_create OK 0.20 test_delete OK 0.18 test_delete_not_found OK 0.18 test_index OK 0.44 test_show OK 0.18 test_show_not_found OK 0.19 test_too_many_metadata_items_on_create OK 0.19 test_too_many_metadata_items_on_put OK 0.18 test_update_item OK 0.19 test_update_item_bad_body OK 0.47 test_update_item_body_uri_mismatch OK 0.19 test_update_item_too_many_keys OK 0.18 ImageMetadataXMLSerializationTest test_create_xml OK 0.00 test_index_xml OK 0.00 test_index_xml_null OK 0.00 test_index_xml_unicode OK 0.00 test_show_xml OK 0.00 test_update_item_xml OK 0.00 GlanceImageServiceTest test_create OK 0.01 test_create_and_show_non_existing_image OK 0.01 test_create_and_show_non_existing_image_by_name OK 0.02 test_create_with_instance_id OK 0.01 test_create_without_instance_id OK 0.02 test_delete OK 0.02 test_detail_limit OK 0.04 test_detail_marker OK 0.02 test_detail_marker_and_limit OK 0.02 test_index OK 0.01 test_index_default_limit OK 0.02 test_index_limit OK 0.03 test_index_marker OK 0.01 test_index_marker_and_limit OK 0.01 test_update OK 0.01 ImageControllerWithGlanceServiceTest test_create_backup_no_backup_type OK 0.17 test_create_backup_no_name OK 0.14 test_create_backup_no_rotation OK 0.44 test_create_backup_with_rotation_and_backup_type OK 0.18 test_create_image OK 0.12 test_create_image_no_server_id OK 0.08 test_create_image_v1_1 OK 0.19 test_create_image_v1_1_actual_server_ref OK 0.19 test_create_image_v1_1_actual_server_ref_port OK 0.47 test_create_image_v1_1_no_server_ref OK 0.18 test_create_image_v1_1_server_ref_bad_hostname OK 0.19 test_create_image_v1_1_server_ref_missing_id OK 0.18 test_create_image_v1_1_server_ref_missing_version OK 0.18 test_create_image_with_invalid_image_type OK 0.49 test_create_snapshot_no_name OK 0.14 test_get_image OK 0.08 test_get_image_404_json OK 0.08 test_get_image_404_v1_1_json OK 0.19 test_get_image_404_v1_1_xml OK 0.18 test_get_image_404_xml OK 0.46 test_get_image_details OK 0.08 test_get_image_details_v1_1 OK 0.19 test_get_image_found OK 0.13 test_get_image_index OK 0.08 test_get_image_index_v1_1 OK 0.19 test_get_image_non_existent OK 0.13 test_get_image_not_owned OK 0.39 test_get_image_v1_1 OK 0.19 test_get_image_xml OK 0.13 test_get_image_xml_no_name OK 0.08 test_image_detail_filter_changes_since OK 0.00 test_image_detail_filter_not_supported OK 0.00 test_image_detail_filter_server OK 0.00 test_image_detail_filter_with_name OK 0.00 test_image_detail_filter_with_property OK 0.00 test_image_detail_filter_with_status OK 0.01 test_image_detail_filter_with_type OK 0.01 test_image_detail_no_filters OK 0.00 test_image_filter_changes_since OK 0.00 test_image_filter_not_supported OK 0.00 test_image_filter_server OK 0.00 test_image_filter_with_name OK 0.00 test_image_filter_with_property OK 0.00 test_image_filter_with_status OK 0.00 test_image_filter_with_type OK 0.00 test_image_no_filters OK 0.00 ImageXMLSerializationTest test_create OK 0.01 test_detail OK 0.01 test_index OK 0.00 test_index_zero_images OK 0.00 test_show OK 0.01 test_show_image_no_metadata_key OK 0.00 test_show_no_server OK 0.01 test_show_zero_metadata OK 0.01 LimitMiddlewareTest test_good_request OK 0.00 test_limit_class OK 0.00 test_limited_request_json OK 0.00 test_limited_request_xml OK 0.00 LimitTest test_GET_delay OK 0.00 test_GET_no_delay OK 0.00 LimiterTest test_delay_GET OK 0.00 test_delay_POST OK 0.00 test_delay_PUT OK 0.00 test_delay_PUT_servers OK 0.00 test_delay_PUT_wait OK 0.00 test_multiple_delays OK 0.00 test_multiple_users OK 0.00 test_no_delay_GET OK 0.00 test_no_delay_PUT OK 0.00 test_user_limit OK 0.00 LimitsControllerV10Test test_empty_index_json OK 0.01 test_empty_index_xml OK 0.01 test_index_json OK 0.01 test_index_xml OK 0.01 LimitsControllerV11Test test_empty_index_json OK 0.01 test_index_absolute_cores_json OK 0.00 test_index_absolute_injected_files OK 0.01 test_index_absolute_instances_json OK 0.00 test_index_absolute_metadata_json OK 0.00 test_index_absolute_ram_json OK 0.00 test_index_diff_regex OK 0.01 test_index_ignores_extra_absolute_limits_json OK 0.01 test_index_json OK 0.01 LimitsViewBuilderV11Test test_build_limits OK 0.00 test_build_limits_empty_limits OK 0.00 LimitsXMLSerializationTest test_index OK 0.00 test_index_no_limits OK 0.00 ParseLimitsTest test_bad_rule OK 0.00 test_bad_unit OK 0.00 test_bad_value OK 0.00 test_invalid OK 0.00 test_missing_arg OK 0.00 test_multiple_rules OK 0.00 WsgiLimiterProxyTest test_200 OK 0.00 test_403 OK 0.00 WsgiLimiterTest test_escaping OK 0.00 test_good_url OK 0.00 test_invalid_methods OK 0.00 test_response_to_delays OK 0.00 test_response_to_delays_usernames OK 0.00 ServerMetaDataTest test_create OK 0.21 test_create_empty_body OK 0.18 test_create_nonexistant_server OK 0.48 test_delete OK 0.18 test_delete_nonexistant_server OK 0.18 test_index OK 0.18 test_index_no_data OK 0.18 test_index_nonexistant_server OK 0.43 test_show OK 0.18 test_show_meta_not_found OK 0.18 test_show_nonexistant_server OK 0.18 test_to_many_metadata_items_on_update_item OK 0.18 test_too_many_metadata_items_on_create OK 0.18 test_update_item OK 0.46 test_update_item_body_uri_mismatch OK 0.18 test_update_item_empty_body OK 0.18 test_update_item_nonexistant_server OK 0.17 test_update_item_too_many_keys OK 0.18 ServersTest test_confirm_resize_server OK 0.39 test_confirm_resize_server_fails OK 0.08 test_create_backup_schedules OK 0.08 test_create_instance OK 0.19 test_create_instance_has_uuid OK 0.01 test_create_instance_no_key_pair OK 0.19 test_create_instance_no_name OK 0.08 test_create_instance_no_server_entity OK 0.08 test_create_instance_nonstring_name OK 0.08 test_create_instance_v1_1 OK 0.60 test_create_instance_v1_1_bad_flavor_href OK 0.21 test_create_instance_v1_1_bad_href OK 0.20 test_create_instance_v1_1_invalid_flavor_href OK 0.18 test_create_instance_v1_1_local_href OK 0.28 test_create_instance_via_zones OK 0.54 test_create_instance_via_zones_with_resid OK 0.23 test_create_instance_whitespace_name OK 0.13 test_create_instance_with_admin_pass_v1_0 OK 0.18 test_create_instance_with_admin_pass_v1_1 OK 0.29 test_create_instance_with_empty_admin_pass_v1_1 OK 0.48 test_delete_backup_schedules OK 0.12 test_delete_server_instance OK 0.10 test_delete_server_instance_v1_1 OK 0.22 test_get_all_server_details_v1_0 OK 0.21 test_get_all_server_details_v1_1 OK 0.55 test_get_all_server_details_with_host OK 0.22 test_get_all_server_details_xml_v1_0 OK 0.17 test_get_server_addresses_nonexistant_network_v1_1 OK 0.19 test_get_server_addresses_nonexistant_server_v1_1 OK 0.19 test_get_server_addresses_private_v1_0 OK 0.13 test_get_server_addresses_private_xml_v1_0 OK 0.40 test_get_server_addresses_public_v1_0 OK 0.09 test_get_server_addresses_public_xml_v1_0 OK 0.09 test_get_server_addresses_single_network_v1_1 OK 0.19 test_get_server_addresses_v1_0 OK 0.13 test_get_server_addresses_v1_1 OK 0.18 test_get_server_addresses_xml_v1_0 OK 0.14 test_get_server_backup_schedule OK 0.36 test_get_server_backup_schedules OK 0.09 test_get_server_by_id OK 0.09 test_get_server_by_id_v1_1 OK 0.20 test_get_server_by_id_with_addresses OK 0.14 test_get_server_by_id_with_addresses_v1_1 ERROR test_get_server_by_id_with_addresses_v1_1_ipv6_disabled OK 0.20 test_get_server_by_id_with_addresses_xml OK 0.43 test_get_server_by_uuid OK 0.10 test_get_server_list OK 0.14 test_get_server_list_v1_1 OK 0.24 test_get_server_list_with_reservation_id OK 0.36 test_get_server_list_with_reservation_id_details OK 0.33 test_get_server_list_with_reservation_id_empty OK 0.36 test_get_server_with_active_status_by_id_v1_1 OK 0.20 test_get_server_with_id_image_ref_by_id_v1_1 OK 0.20 test_get_servers_with_bad_limit OK 0.18 test_get_servers_with_bad_marker OK 0.24 test_get_servers_with_bad_offset OK 0.45 test_get_servers_with_limit OK 0.28 test_get_servers_with_limit_and_marker OK 0.24 test_get_servers_with_limit_and_offset OK 0.18 test_get_servers_with_marker OK 0.58 test_get_servers_with_offset OK 0.33 test_migrate_server OK 0.08 test_rescue_accepted OK 0.18 test_rescue_raises_handled OK 0.17 test_resize_bad_flavor_fails OK 0.42 test_resize_raises_fails OK 0.08 test_resize_server OK 0.08 test_resize_server_v11 OK 0.19 test_resized_server_has_correct_status OK 0.14 test_revert_resize_server OK 0.08 test_revert_resize_server_fails OK 0.08 test_server_actions OK 0.08 test_server_backup_schedule_deprecated_v1_1 OK 0.51 test_server_change_password OK 0.13 test_server_change_password_bad_request_v1_1 OK 0.18 test_server_change_password_empty_string_v1_1 OK 0.18 test_server_change_password_none_v1_1 OK 0.18 test_server_change_password_not_a_string_v1_1 OK 0.46 test_server_change_password_v1_1 OK 0.18 test_server_change_password_xml OK 0.00 test_server_diagnostics OK 0.13 test_server_inject_network_info OK 0.18 test_server_pause OK 0.17 test_server_reboot OK 0.12 test_server_rebuild_accepted OK 0.43 test_server_rebuild_accepted_minimum_v1_1 OK 0.22 test_server_rebuild_accepted_with_bad_metadata_v1_1 OK 0.19 test_server_rebuild_accepted_with_metadata_v1_1 OK 0.23 test_server_rebuild_bad_entity OK 0.13 test_server_rebuild_bad_entity_v1_1 OK 0.49 test_server_rebuild_bad_personality_v1_1 OK 0.18 test_server_rebuild_personality_v1_1 OK 0.23 test_server_rebuild_rejected_when_building OK 0.15 test_server_rebuild_rejected_when_building_v1_1 OK 0.19 test_server_reset_network OK 0.18 test_server_resume OK 0.48 test_server_suspend OK 0.18 test_server_unpause OK 0.17 test_shutdown_status OK 0.14 test_shutoff_status OK 0.10 test_update_nonstring_name OK 0.36 test_update_null_name OK 0.09 test_update_server_adminPass_ignored_v1_1 OK 0.19 test_update_server_name_v1_1 OK 0.19 test_update_server_no_body OK 0.12 test_update_server_no_body_v1_1 OK 0.07 test_update_server_v1_0 OK 0.08 test_update_whitespace_name OK 0.37 ServersViewBuilderV11Test test_build_server OK 0.00 test_build_server_detail OK 0.00 test_build_server_detail_active_status OK 0.00 test_build_server_detail_with_metadata OK 0.00 TestGetKernelRamdiskFromImage test_ami_kernel_ramdisk_present OK 0.00 test_ami_no_kernel OK 0.00 test_ami_no_ramdisk OK 0.00 test_not_ami OK 0.00 test_status_not_active OK 0.00 TestServerCreateRequestXMLDeserializer test_canonical_request_from_docs OK 0.00 test_minimal_request OK 0.00 test_request_second_personality_node_ignored OK 0.00 test_request_with_empty_metadata OK 0.00 test_request_with_empty_metadata_and_personality OK 0.00 test_request_with_empty_metadata_and_personality_reversed OK 0.00 test_request_with_empty_personality OK 0.00 test_request_with_metadata_duplicate_key OK 0.00 test_request_with_metadata_missing_key OK 0.00 test_request_with_metadata_missing_value OK 0.00 test_request_with_one_metadata OK 0.00 test_request_with_one_personality OK 0.00 test_request_with_one_personality_empty_contents OK 0.00 test_request_with_one_personality_empty_contents_variation OK 0.00 test_request_with_one_personality_missing_path OK 0.00 test_request_with_two_metadata OK 0.00 test_request_with_two_metadata_missing_key OK 0.00 test_request_with_two_metadata_missing_value OK 0.00 test_request_with_two_personalities OK 0.00 test_request_xmlser_with_flavor_image_href OK 0.00 TestServerInstanceCreation test_create_instance_admin_pass_json OK 0.09 test_create_instance_admin_pass_xml OK 0.10 test_create_instance_personality_empty_content OK 0.09 test_create_instance_with_no_personality OK 0.09 test_create_instance_with_no_personality_xml OK 0.09 test_create_instance_with_null_personality OK 0.09 test_create_instance_with_personality OK 0.09 test_create_instance_with_personality_no_contents OK 0.35 test_create_instance_with_personality_no_path OK 0.08 test_create_instance_with_personality_not_a_list OK 0.07 test_create_instance_with_personality_with_non_b64_content OK 0.08 test_create_instance_with_personality_xml OK 0.09 test_create_instance_with_three_personalities OK 0.09 SharedIpGroupsTest test_create_shared_ip_group OK 0.08 test_delete_shared_ip_group OK 0.07 test_deprecated_v11 OK 0.47 test_get_shared_ip_groups OK 0.12 test_update_shared_ip_group OK 0.07 UsersTest test_get_user_by_id OK 0.18 test_get_user_list OK 0.18 test_user_create OK 0.17 test_user_delete OK 0.78 test_user_update OK 0.17 VersionsTest test_atom_serializer OK 0.01 test_generate_href OK 0.00 test_get_version_list OK 0.06 test_get_version_list_atom OK 0.38 test_get_version_list_xml OK 0.06 test_view_builder OK 0.00 test_xml_serializer OK 0.00 ActionDispatcherTest test_dispatch OK 0.00 test_dispatch_action_None OK 0.00 test_dispatch_default OK 0.00 DictSerializerTest test_dispatch_default OK 0.00 JSONDeserializerTest test_json OK 0.00 JSONDictSerializerTest test_json OK 0.00 RequestDeserializerTest test_deserialize OK 0.00 test_get_action_args OK 0.00 test_get_deserializer OK 0.00 test_get_deserializer_unknown_content_type OK 0.00 test_get_expected_content_type OK 0.00 RequestHeadersDeserializerTest test_custom OK 0.00 test_default OK 0.00 RequestTest test_content_type_accept_and_query_extension OK 0.00 test_content_type_accept_default OK 0.00 test_content_type_from_accept_xml OK 0.00 test_content_type_from_query_extension OK 0.00 test_content_type_missing OK 0.00 test_content_type_unsupported OK 0.00 test_content_type_with_charset OK 0.00 ResourceTest test_dispatch OK 0.00 test_dispatch_unknown_controller_action OK 0.00 ResponseHeadersSerializerTest test_custom OK 0.00 test_default OK 0.00 ResponseSerializerTest test_get_serializer OK 0.00 test_get_serializer_unknown_content_type OK 0.00 test_serialize_response OK 0.00 test_serialize_response_dict_to_unknown_content_type OK 0.00 TextDeserializerTest test_dispatch_default OK 0.00 XMLDeserializerTest test_xml OK 0.00 test_xml_empty OK 0.00 XMLDictSerializerTest test_xml OK 0.00 ZonesTest test_get_zone_by_id OK 0.19 test_get_zone_list_db OK 0.18 test_get_zone_list_scheduler OK 0.18 test_zone_create OK 0.47 test_zone_delete OK 0.18 test_zone_info OK 0.18 test_zone_select OK 0.18 test_zone_update OK 0.18 Test test_debug OK 0.00 test_router OK 0.01 TestGetterDateTimeNoneTests test_detail_handles_blank_datetimes OK 0.00 test_detail_handles_none_datetimes OK 0.00 test_detail_makes_datetimes OK 0.00 test_get_handles_blank_datetimes OK 0.00 test_get_handles_none_datetimes OK 0.00 test_get_makes_datetimes OK 0.00 test_show_handles_blank_datetimes OK 0.00 test_show_handles_none_datetimes OK 0.00 test_show_makes_datetimes OK 0.00 TestGlanceImageServiceProperties test_detail_passes_through_to_client OK 0.00 test_show_passes_through_to_client OK 0.00 TestMutatorDateTimeTests test_create_handles_datetimes OK 0.00 test_create_handles_none_datetimes OK 0.00 test_update_handles_datetimes OK 0.00 test_update_handles_none_datetimes OK 0.00 TestS3ImageService test_s3_create OK 0.00 ExtensionsTest test_get_foxnsocks OK 0.73 LoginTest test_bad_login_both_bad OK 0.29 test_bad_login_password OK 0.31 test_bad_login_username OK 0.30 test_login OK 0.42 ServersTest test_create_and_delete_server OK 2.16 test_create_and_rebuild_server OK 4.37 test_create_and_rebuild_server_with_metadata OK 4.81 test_create_and_rebuild_server_with_metadata_removal OK 2.46 test_create_server_with_metadata OK 2.23 test_get_servers OK 0.46 test_rename_server OK 2.11 VolumesTest test_attach_and_detach_volume OK 5.82 test_create_and_delete_volume OK 1.78 test_get_volumes OK 0.37 test_get_volumes_summary OK 0.36 XmlTests test_namespace_limits OK 0.81 test_namespace_servers OK 0.47 HostFilterTestCase test_all_host_filter OK 0.00 test_choose_filter OK 0.00 test_instance_type_filter OK 0.00 test_instance_type_filter_extra_specs OK 0.00 test_json_filter OK 0.00 LeastCostSchedulerTestCase test_compute_fill_first_cost_fn OK 0.00 test_cost_fn_weights OK 0.00 test_no_hosts OK 0.00 test_noop_cost_fn OK 0.00 WeightedSumTestCase test_basic_costing OK 0.00 test_empty_domain OK 0.00 CallZoneMethodTest test_call_zone_method OK 0.00 test_call_zone_method_generates_exception OK 0.00 test_call_zone_method_not_present OK 0.00 DynamicNovaClientTest test_issue_novaclient_command_found OK 0.00 test_issue_novaclient_command_not_found OK 0.00 SchedulerTestCase test_fallback OK 0.00 test_named_method OK 0.00 test_show_host_resources_host_not_exit OK 0.01 test_show_host_resources_no_project OK 0.09 test_show_host_resources_works_correctly OK 0.12 SimpleDriverTestCase test_doesnt_report_disabled_hosts_as_up OK 0.22 test_least_busy_host_gets_instance OK 1.51 test_least_busy_host_gets_volume OK 0.36 test_live_migration_common_check_checking_cpuinfo_fail OK 0.24 test_live_migration_common_check_service_different_hypervisorOK 0.23 test_live_migration_common_check_service_different_version OK 0.24 test_live_migration_common_check_service_orig_not_exists OK 0.21 test_live_migration_dest_check_not_alive OK 0.20 test_live_migration_dest_check_service_lack_memory OK 0.20 test_live_migration_dest_check_service_same_host OK 0.19 test_live_migration_dest_check_service_works_correctly OK 0.20 test_live_migration_src_check_compute_node_not_alive OK 0.65 test_live_migration_src_check_instance_not_running OK 0.15 test_live_migration_src_check_volume_node_not_alive OK 0.25 test_live_migration_src_check_works_correctly OK 0.20 test_reports_enabled_hosts_as_up OK 0.16 test_scheduler_live_migration_with_volume OK 0.38 test_specific_host_gets_instance OK 1.09 test_too_many_cores OK 8.59 test_too_many_gigabytes OK 1.09 test_will_schedule_on_disabled_host_if_specified OK 0.28 test_wont_sechedule_if_specified_host_is_down OK 0.22 ZoneRedirectTest test_get_collection_context_and_id OK 0.00 test_routing_flags OK 0.00 test_trap_found_locally OK 0.00 test_trap_not_found_locally_id_passed OK 0.00 test_trap_not_found_locally_uuid_passed OK 0.00 test_unmarshal_single_server OK 0.00 ZoneSchedulerTestCase test_with_two_zones OK 0.01 ZoneAwareSchedulerTestCase test_adjust_child_weights OK 0.00 test_empty_zone_aware_scheduler OK 0.00 test_provision_resource_from_blob_empty OK 0.00 test_provision_resource_from_blob_with_child_blob OK 0.00 test_provision_resource_from_blob_with_immediate_child_blob OK 0.00 test_provision_resource_from_blob_with_local_blob OK 0.00 test_provision_resource_local OK 0.00 test_provision_resource_remote OK 0.00 test_schedule_do_not_schedule_with_hint OK 0.00 test_zone_aware_scheduler OK 0.00 AccessTestCase test_001_allow_all OK 0.31 test_002_allow_none OK 0.26 test_003_allow_project_manager OK 0.26 test_004_allow_sys_and_net OK 0.74 AdminApiTestCase test_block_external_ips OK 0.70 test_list_blocked_ips OK 0.70 test_remove_ip_block OK 0.71 ApiEc2TestCase test_authorize_revoke_security_group_cidr OK 0.77 test_authorize_revoke_security_group_cidr_v6 OK 0.54 test_authorize_revoke_security_group_foreign_group OK 0.70 test_create_delete_security_group OK 0.81 test_create_duplicate_key_pair OK 0.38 test_describe_instances OK 0.15 test_get_all_key_pairs OK 0.38 test_get_all_security_groups OK 0.14 test_return_valid_isoformat OK 0.01 test_terminate_invalid_instance OK 0.17 test_xmlns_version_matches_request_version OK 0.13 Ec2utilsTestCase test_bad_ec2_id OK 0.00 test_dict_from_dotted_str OK 0.00 test_ec2_id_to_id OK 0.00 test_id_to_ec2_id OK 0.00 test_mapping_prepend_dev OK 0.00 test_properties_root_defice_name OK 0.00 XmlConversionTestCase test_number_conversion OK 0.00 AuthManagerDbTestCase test_004_signature_is_valid OK 0.14 test_005_can_get_credentials OK 0.00 test_add_user_role_doesnt_infect_project_roles OK 0.10 test_adding_role_to_project_is_ignored_unless_added_to_user OK 0.11 test_can_add_and_remove_user_role OK 0.06 test_can_add_remove_user_with_role OK 0.21 test_can_add_user_to_project OK 0.14 test_can_create_and_get_project OK 0.09 test_can_create_and_get_project_with_attributes OK 0.08 test_can_create_project_with_manager OK 0.07 test_can_delete_project OK 0.10 test_can_delete_user OK 0.03 test_can_generate_x509 OK 0.48 test_can_list_project_roles OK 0.13 test_can_list_projects OK 0.14 test_can_list_user_roles OK 0.09 test_can_list_users OK 0.06 test_can_modify_project OK 0.18 test_can_modify_users OK 0.04 test_can_remove_project_role_but_keep_user_role OK 0.11 test_can_remove_user_from_project OK 0.19 test_can_remove_user_roles OK 0.10 test_can_retrieve_project_by_user OK 0.08 test_create_and_find_user OK 0.03 test_create_and_find_with_properties OK 0.03 test_create_project_assigns_manager_to_members OK 0.64 test_modify_project_adds_new_manager OK 0.17 test_no_extra_project_managers OK 0.10 test_no_extra_project_members OK 0.09 test_removing_user_role_hides_it_from_project OK 0.11 AuthManagerLdapTestCase test_004_signature_is_valid OK 0.08 test_005_can_get_credentials OK 0.00 test_add_user_role_doesnt_infect_project_roles OK 0.02 test_adding_role_to_project_is_ignored_unless_added_to_user OK 0.02 test_can_add_and_remove_user_role OK 0.02 test_can_add_remove_user_with_role OK 0.04 test_can_add_user_to_project OK 0.03 test_can_create_and_get_project OK 0.02 test_can_create_and_get_project_with_attributes OK 0.01 test_can_create_project_with_manager OK 0.01 test_can_delete_project OK 0.01 test_can_delete_user OK 0.01 test_can_generate_x509 OK 0.44 test_can_list_project_roles OK 0.03 test_can_list_projects OK 0.02 test_can_list_user_roles OK 0.02 test_can_list_users OK 0.02 test_can_modify_project OK 0.03 test_can_modify_users OK 0.01 test_can_remove_project_role_but_keep_user_role OK 0.03 test_can_remove_user_from_project OK 0.03 test_can_remove_user_roles OK 0.03 test_can_retrieve_project_by_user OK 0.02 test_create_and_find_user OK 0.01 test_create_and_find_with_properties OK 0.01 test_create_project_assigns_manager_to_members OK 0.01 test_modify_project_adds_new_manager OK 0.03 test_no_extra_project_managers OK 0.02 test_no_extra_project_members OK 0.02 test_reconnect_on_server_failure OK 0.00 test_removing_user_role_hides_it_from_project OK 0.02 BlockDeviceMappingEc2CloudTestCase test_format_block_device_mapping OK 0.00 test_format_mapping OK 0.00 test_parse_block_device_mapping OK 0.00 CloudTestCase test_ajax_console OK 1.94 test_allocate_address SKIP: Skipping this pending future merge -------------------- >> begin captured logging << -------------------- 2011-07-25 21:33:58,703 AUDIT nova [-] Starting compute node (version 2011.3-LOCALBRANCH:LOCALREVISION) 2011-07-25 21:33:58,713 DEBUG nova [-] Creating Consumer connection for Service compute from (pid=19173) start /tmp/tmpFvibRA/nova/service.py:154 2011-07-25 21:33:58,713 DEBUG nova.rpc [-] Initing the Adapter Consumer for compute from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:33:58,713 DEBUG nova.fakerabbit [-] Declaring queue compute from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:33:58,714 DEBUG nova.fakerabbit [-] Declaring exchange nova from (pid=19173) exchange_declare /tmp/tmpFvibRA/nova/fakerabbit.py:90 2011-07-25 21:33:58,714 DEBUG nova.fakerabbit [-] Binding compute to nova with key compute from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:33:58,714 DEBUG nova.rpc [-] Initing the Adapter Consumer for compute.0bb732afd28c4864915f0e8edc9a6bee from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:33:58,714 DEBUG nova.fakerabbit [-] Declaring queue compute.0bb732afd28c4864915f0e8edc9a6bee from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:33:58,715 DEBUG nova.fakerabbit [-] Binding compute.0bb732afd28c4864915f0e8edc9a6bee to nova with key compute.0bb732afd28c4864915f0e8edc9a6bee from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:33:58,715 INFO nova.rpc [-] Created "compute_fanout" fanout exchange with "compute" routing key 2011-07-25 21:33:58,715 DEBUG nova.rpc [-] Initing the Adapter Consumer for compute from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:33:58,715 DEBUG nova.fakerabbit [-] Declaring queue compute_fanout_c66e26c6bafc46beb0ee2e044693b885 from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:33:58,716 DEBUG nova.fakerabbit [-] Declaring exchange compute_fanout from (pid=19173) exchange_declare /tmp/tmpFvibRA/nova/fakerabbit.py:90 2011-07-25 21:33:58,716 DEBUG nova.fakerabbit [-] Binding compute_fanout_c66e26c6bafc46beb0ee2e044693b885 to compute_fanout with key compute from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:33:58,716 AUDIT nova [-] Starting scheduler node (version 2011.3-LOCALBRANCH:LOCALREVISION) 2011-07-25 21:33:58,726 DEBUG nova [-] Creating Consumer connection for Service scheduler from (pid=19173) start /tmp/tmpFvibRA/nova/service.py:154 2011-07-25 21:33:58,726 DEBUG nova.rpc [-] Initing the Adapter Consumer for scheduler from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:33:58,727 DEBUG nova.fakerabbit [-] Declaring queue scheduler from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:33:58,727 DEBUG nova.fakerabbit [-] Binding scheduler to nova with key scheduler from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:33:58,727 DEBUG nova.rpc [-] Initing the Adapter Consumer for scheduler.a663b5aa19264b848a731d506451eba2 from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:33:58,727 DEBUG nova.fakerabbit [-] Declaring queue scheduler.a663b5aa19264b848a731d506451eba2 from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:33:58,728 DEBUG nova.fakerabbit [-] Binding scheduler.a663b5aa19264b848a731d506451eba2 to nova with key scheduler.a663b5aa19264b848a731d506451eba2 from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:33:58,728 INFO nova.rpc [-] Created "scheduler_fanout" fanout exchange with "scheduler" routing key 2011-07-25 21:33:58,728 DEBUG nova.rpc [-] Initing the Adapter Consumer for scheduler from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:33:58,728 DEBUG nova.fakerabbit [-] Declaring queue scheduler_fanout_57a57edda700483fb5ff9f68d0775a70 from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:33:58,729 DEBUG nova.fakerabbit [-] Declaring exchange scheduler_fanout from (pid=19173) exchange_declare /tmp/tmpFvibRA/nova/fakerabbit.py:90 2011-07-25 21:33:58,729 DEBUG nova.fakerabbit [-] Binding scheduler_fanout_57a57edda700483fb5ff9f68d0775a70 to scheduler_fanout with key scheduler from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:33:58,729 AUDIT nova [-] Starting network node (version 2011.3-LOCALBRANCH:LOCALREVISION) 2011-07-25 21:33:58,730 DEBUG nova.utils [-] Attempting to grab semaphore "iptables" for method "apply"... from (pid=19173) inner /tmp/tmpFvibRA/nova/utils.py:600 2011-07-25 21:33:58,730 DEBUG nova.utils [-] Attempting to grab file lock "iptables" for method "apply"... from (pid=19173) inner /tmp/tmpFvibRA/nova/utils.py:605 2011-07-25 21:33:58,730 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-save -t filter from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:33:58,730 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-restore from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:33:58,731 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-save -t nat from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:33:58,731 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-restore from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:33:58,731 DEBUG nova.linux_net [-] FAKE NET: sudo ip6tables-save -t filter from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:33:58,732 DEBUG nova.linux_net [-] FAKE NET: sudo ip6tables-restore from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:33:58,732 DEBUG nova.linux_net [-] FAKE NET: sudo ip addr add 169.254.169.254/32 scope link dev lo from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:33:58,757 DEBUG nova.utils [-] Attempting to grab semaphore "iptables" for method "apply"... from (pid=19173) inner /tmp/tmpFvibRA/nova/utils.py:600 2011-07-25 21:33:58,757 DEBUG nova.utils [-] Attempting to grab file lock "iptables" for method "apply"... from (pid=19173) inner /tmp/tmpFvibRA/nova/utils.py:605 2011-07-25 21:33:58,757 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-save -t filter from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:33:58,758 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-restore from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:33:58,758 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-save -t nat from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:33:58,759 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-restore from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:33:58,759 DEBUG nova.linux_net [-] FAKE NET: sudo ip6tables-save -t filter from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:33:58,759 DEBUG nova.linux_net [-] FAKE NET: sudo ip6tables-restore from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:33:58,768 DEBUG nova [-] Creating Consumer connection for Service network from (pid=19173) start /tmp/tmpFvibRA/nova/service.py:154 2011-07-25 21:33:58,768 DEBUG nova.rpc [-] Initing the Adapter Consumer for network from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:33:58,769 DEBUG nova.fakerabbit [-] Declaring queue network from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:33:58,769 DEBUG nova.fakerabbit [-] Binding network to nova with key network from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:33:58,769 DEBUG nova.rpc [-] Initing the Adapter Consumer for network.ce8eaeb2a6b6483a8fc01940129db5a0 from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:33:58,770 DEBUG nova.fakerabbit [-] Declaring queue network.ce8eaeb2a6b6483a8fc01940129db5a0 from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:33:58,770 DEBUG nova.fakerabbit [-] Binding network.ce8eaeb2a6b6483a8fc01940129db5a0 to nova with key network.ce8eaeb2a6b6483a8fc01940129db5a0 from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:33:58,770 INFO nova.rpc [-] Created "network_fanout" fanout exchange with "network" routing key 2011-07-25 21:33:58,770 DEBUG nova.rpc [-] Initing the Adapter Consumer for network from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:33:58,771 DEBUG nova.fakerabbit [-] Declaring queue network_fanout_cf60e80e2b7f41a5a6c56c56d132219d from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:33:58,771 DEBUG nova.fakerabbit [-] Declaring exchange network_fanout from (pid=19173) exchange_declare /tmp/tmpFvibRA/nova/fakerabbit.py:90 2011-07-25 21:33:58,771 DEBUG nova.fakerabbit [-] Binding network_fanout_cf60e80e2b7f41a5a6c56c56d132219d to network_fanout with key network from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:33:58,772 AUDIT nova [-] Starting volume node (version 2011.3-LOCALBRANCH:LOCALREVISION) 2011-07-25 21:33:58,788 DEBUG nova.volume.manager [-] Re-exporting 0 volumes from (pid=19173) init_host /tmp/tmpFvibRA/nova/volume/manager.py:84 2011-07-25 21:33:58,796 DEBUG nova [-] Creating Consumer connection for Service volume from (pid=19173) start /tmp/tmpFvibRA/nova/service.py:154 2011-07-25 21:33:58,796 DEBUG nova.rpc [-] Initing the Adapter Consumer for volume from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:33:58,797 DEBUG nova.fakerabbit [-] Declaring queue volume from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:33:58,797 DEBUG nova.fakerabbit [-] Binding volume to nova with key volume from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:33:58,797 DEBUG nova.rpc [-] Initing the Adapter Consumer for volume.707445fa971f499481689d741384f351 from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:33:58,797 DEBUG nova.fakerabbit [-] Declaring queue volume.707445fa971f499481689d741384f351 from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:33:58,798 DEBUG nova.fakerabbit [-] Binding volume.707445fa971f499481689d741384f351 to nova with key volume.707445fa971f499481689d741384f351 from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:33:58,798 INFO nova.rpc [-] Created "volume_fanout" fanout exchange with "volume" routing key 2011-07-25 21:33:58,798 DEBUG nova.rpc [-] Initing the Adapter Consumer for volume from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:33:58,798 DEBUG nova.fakerabbit [-] Declaring queue volume_fanout_148e6134f1b147869fc91a7bdf8c163c from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:33:58,799 DEBUG nova.fakerabbit [-] Declaring exchange volume_fanout from (pid=19173) exchange_declare /tmp/tmpFvibRA/nova/fakerabbit.py:90 2011-07-25 21:33:58,799 DEBUG nova.fakerabbit [-] Binding volume_fanout_148e6134f1b147869fc91a7bdf8c163c to volume_fanout with key volume from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:33:58,800 AUDIT nova.auth.manager [-] Created user admin (admin: True) 2011-07-25 21:33:58,801 DEBUG nova.ldapdriver [-] Local cache hit for __project_to_dn by key pid_dn-proj from (pid=19173) inner /tmp/tmpFvibRA/nova/auth/ldapdriver.py:188 2011-07-25 21:33:58,802 DEBUG nova.ldapdriver [-] Local cache hit for __dn_to_uid by key dn_uid-uid=admin,ou=Users,dc=example,dc=com from (pid=19173) inner /tmp/tmpFvibRA/nova/auth/ldapdriver.py:188 2011-07-25 21:33:58,802 AUDIT nova.auth.manager [-] Created project proj with manager admin --------------------- >> end captured logging << --------------------- test_associate_disassociate_address SKIP: Skipping this pending future merge -------------------- >> begin captured logging << -------------------- 2011-07-25 21:33:58,887 AUDIT nova [-] Starting compute node (version 2011.3-LOCALBRANCH:LOCALREVISION) 2011-07-25 21:33:58,895 DEBUG nova [-] Creating Consumer connection for Service compute from (pid=19173) start /tmp/tmpFvibRA/nova/service.py:154 2011-07-25 21:33:58,896 DEBUG nova.rpc [-] Initing the Adapter Consumer for compute from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:33:58,896 DEBUG nova.fakerabbit [-] Declaring queue compute from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:33:58,896 DEBUG nova.fakerabbit [-] Declaring exchange nova from (pid=19173) exchange_declare /tmp/tmpFvibRA/nova/fakerabbit.py:90 2011-07-25 21:33:58,896 DEBUG nova.fakerabbit [-] Binding compute to nova with key compute from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:33:58,897 DEBUG nova.rpc [-] Initing the Adapter Consumer for compute.204612ceb03b4865838a7e8546c49986 from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:33:58,897 DEBUG nova.fakerabbit [-] Declaring queue compute.204612ceb03b4865838a7e8546c49986 from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:33:58,897 DEBUG nova.fakerabbit [-] Binding compute.204612ceb03b4865838a7e8546c49986 to nova with key compute.204612ceb03b4865838a7e8546c49986 from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:33:58,897 INFO nova.rpc [-] Created "compute_fanout" fanout exchange with "compute" routing key 2011-07-25 21:33:58,898 DEBUG nova.rpc [-] Initing the Adapter Consumer for compute from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:33:58,898 DEBUG nova.fakerabbit [-] Declaring queue compute_fanout_ca3e6db966ad4c939f9b6d054124ab63 from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:33:58,898 DEBUG nova.fakerabbit [-] Declaring exchange compute_fanout from (pid=19173) exchange_declare /tmp/tmpFvibRA/nova/fakerabbit.py:90 2011-07-25 21:33:58,898 DEBUG nova.fakerabbit [-] Binding compute_fanout_ca3e6db966ad4c939f9b6d054124ab63 to compute_fanout with key compute from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:33:58,900 AUDIT nova [-] Starting scheduler node (version 2011.3-LOCALBRANCH:LOCALREVISION) 2011-07-25 21:33:58,909 DEBUG nova [-] Creating Consumer connection for Service scheduler from (pid=19173) start /tmp/tmpFvibRA/nova/service.py:154 2011-07-25 21:33:58,909 DEBUG nova.rpc [-] Initing the Adapter Consumer for scheduler from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:33:58,910 DEBUG nova.fakerabbit [-] Declaring queue scheduler from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:33:58,910 DEBUG nova.fakerabbit [-] Binding scheduler to nova with key scheduler from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:33:58,910 DEBUG nova.rpc [-] Initing the Adapter Consumer for scheduler.42fa11d4aaff40d0b3f77af9ac5f3035 from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:33:58,910 DEBUG nova.fakerabbit [-] Declaring queue scheduler.42fa11d4aaff40d0b3f77af9ac5f3035 from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:33:58,911 DEBUG nova.fakerabbit [-] Binding scheduler.42fa11d4aaff40d0b3f77af9ac5f3035 to nova with key scheduler.42fa11d4aaff40d0b3f77af9ac5f3035 from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:33:58,911 INFO nova.rpc [-] Created "scheduler_fanout" fanout exchange with "scheduler" routing key 2011-07-25 21:33:58,911 DEBUG nova.rpc [-] Initing the Adapter Consumer for scheduler from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:33:58,911 DEBUG nova.fakerabbit [-] Declaring queue scheduler_fanout_b5d6e8d077574abdba446729017f8a5c from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:33:58,912 DEBUG nova.fakerabbit [-] Declaring exchange scheduler_fanout from (pid=19173) exchange_declare /tmp/tmpFvibRA/nova/fakerabbit.py:90 2011-07-25 21:33:58,912 DEBUG nova.fakerabbit [-] Binding scheduler_fanout_b5d6e8d077574abdba446729017f8a5c to scheduler_fanout with key scheduler from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:33:58,912 AUDIT nova [-] Starting network node (version 2011.3-LOCALBRANCH:LOCALREVISION) 2011-07-25 21:33:58,913 DEBUG nova.utils [-] Attempting to grab semaphore "iptables" for method "apply"... from (pid=19173) inner /tmp/tmpFvibRA/nova/utils.py:600 2011-07-25 21:33:58,913 DEBUG nova.utils [-] Attempting to grab file lock "iptables" for method "apply"... from (pid=19173) inner /tmp/tmpFvibRA/nova/utils.py:605 2011-07-25 21:33:58,913 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-save -t filter from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:33:58,913 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-restore from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:33:58,914 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-save -t nat from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:33:58,914 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-restore from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:33:58,914 DEBUG nova.linux_net [-] FAKE NET: sudo ip6tables-save -t filter from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:33:58,915 DEBUG nova.linux_net [-] FAKE NET: sudo ip6tables-restore from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:33:58,915 DEBUG nova.linux_net [-] FAKE NET: sudo ip addr add 169.254.169.254/32 scope link dev lo from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:33:58,940 DEBUG nova.utils [-] Attempting to grab semaphore "iptables" for method "apply"... from (pid=19173) inner /tmp/tmpFvibRA/nova/utils.py:600 2011-07-25 21:33:58,940 DEBUG nova.utils [-] Attempting to grab file lock "iptables" for method "apply"... from (pid=19173) inner /tmp/tmpFvibRA/nova/utils.py:605 2011-07-25 21:33:58,941 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-save -t filter from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:33:58,941 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-restore from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:33:58,941 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-save -t nat from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:33:58,942 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-restore from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:33:58,942 DEBUG nova.linux_net [-] FAKE NET: sudo ip6tables-save -t filter from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:33:58,942 DEBUG nova.linux_net [-] FAKE NET: sudo ip6tables-restore from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:33:58,951 DEBUG nova [-] Creating Consumer connection for Service network from (pid=19173) start /tmp/tmpFvibRA/nova/service.py:154 2011-07-25 21:33:58,952 DEBUG nova.rpc [-] Initing the Adapter Consumer for network from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:33:58,952 DEBUG nova.fakerabbit [-] Declaring queue network from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:33:58,952 DEBUG nova.fakerabbit [-] Binding network to nova with key network from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:33:58,953 DEBUG nova.rpc [-] Initing the Adapter Consumer for network.dbbc4d78e75b4ede812de4b287165259 from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:33:58,953 DEBUG nova.fakerabbit [-] Declaring queue network.dbbc4d78e75b4ede812de4b287165259 from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:33:58,953 DEBUG nova.fakerabbit [-] Binding network.dbbc4d78e75b4ede812de4b287165259 to nova with key network.dbbc4d78e75b4ede812de4b287165259 from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:33:58,954 INFO nova.rpc [-] Created "network_fanout" fanout exchange with "network" routing key 2011-07-25 21:33:58,954 DEBUG nova.rpc [-] Initing the Adapter Consumer for network from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:33:58,954 DEBUG nova.fakerabbit [-] Declaring queue network_fanout_a4992013f1d64a6599e61651da4d8fe3 from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:33:58,954 DEBUG nova.fakerabbit [-] Declaring exchange network_fanout from (pid=19173) exchange_declare /tmp/tmpFvibRA/nova/fakerabbit.py:90 2011-07-25 21:33:58,955 DEBUG nova.fakerabbit [-] Binding network_fanout_a4992013f1d64a6599e61651da4d8fe3 to network_fanout with key network from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:33:58,955 AUDIT nova [-] Starting volume node (version 2011.3-LOCALBRANCH:LOCALREVISION) 2011-07-25 21:33:58,971 DEBUG nova.volume.manager [-] Re-exporting 0 volumes from (pid=19173) init_host /tmp/tmpFvibRA/nova/volume/manager.py:84 2011-07-25 21:33:58,981 DEBUG nova [-] Creating Consumer connection for Service volume from (pid=19173) start /tmp/tmpFvibRA/nova/service.py:154 2011-07-25 21:33:58,981 DEBUG nova.rpc [-] Initing the Adapter Consumer for volume from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:33:58,982 DEBUG nova.fakerabbit [-] Declaring queue volume from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:33:58,982 DEBUG nova.fakerabbit [-] Binding volume to nova with key volume from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:33:58,982 DEBUG nova.rpc [-] Initing the Adapter Consumer for volume.dcf23f53ea1445e6aec28f2fd2ee1eea from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:33:58,982 DEBUG nova.fakerabbit [-] Declaring queue volume.dcf23f53ea1445e6aec28f2fd2ee1eea from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:33:58,983 DEBUG nova.fakerabbit [-] Binding volume.dcf23f53ea1445e6aec28f2fd2ee1eea to nova with key volume.dcf23f53ea1445e6aec28f2fd2ee1eea from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:33:58,983 INFO nova.rpc [-] Created "volume_fanout" fanout exchange with "volume" routing key 2011-07-25 21:33:58,983 DEBUG nova.rpc [-] Initing the Adapter Consumer for volume from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:33:58,983 DEBUG nova.fakerabbit [-] Declaring queue volume_fanout_eea8f0bdf7fe448ba65d17b181c8dd85 from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:33:58,984 DEBUG nova.fakerabbit [-] Declaring exchange volume_fanout from (pid=19173) exchange_declare /tmp/tmpFvibRA/nova/fakerabbit.py:90 2011-07-25 21:33:58,984 DEBUG nova.fakerabbit [-] Binding volume_fanout_eea8f0bdf7fe448ba65d17b181c8dd85 to volume_fanout with key volume from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:33:58,985 AUDIT nova.auth.manager [-] Created user admin (admin: True) 2011-07-25 21:33:58,986 DEBUG nova.ldapdriver [-] Local cache hit for __project_to_dn by key pid_dn-proj from (pid=19173) inner /tmp/tmpFvibRA/nova/auth/ldapdriver.py:188 2011-07-25 21:33:58,988 DEBUG nova.ldapdriver [-] Local cache hit for __dn_to_uid by key dn_uid-uid=admin,ou=Users,dc=example,dc=com from (pid=19173) inner /tmp/tmpFvibRA/nova/auth/ldapdriver.py:188 2011-07-25 21:33:58,988 AUDIT nova.auth.manager [-] Created project proj with manager admin --------------------- >> end captured logging << --------------------- test_authorize_security_group_ingress OK 0.28 test_authorize_security_group_ingress_already_exists OK 0.33 test_authorize_security_group_ingress_by_id OK 0.27 test_authorize_security_group_ingress_ip_permissions_groups OK 0.29 test_authorize_security_group_ingress_ip_permissions_ip_rangesOK 0.29 test_authorize_security_group_ingress_missing_group_name_or_idOK 0.88 test_authorize_security_group_ingress_missing_protocol_paramsOK 0.24 test_console_output OK 2.13 test_create_delete_security_group OK 0.28 test_create_image OK 5.60 test_create_snapshot OK 0.43 test_create_volume_from_snapshot OK 0.45 test_delete_key_pair OK 0.52 test_delete_security_group_by_id OK 0.22 test_delete_security_group_no_params OK 0.21 test_delete_security_group_with_bad_group_id OK 0.20 test_delete_security_group_with_bad_name OK 0.21 test_delete_snapshot OK 0.47 test_deregister_image OK 0.31 test_deregister_image_wrong_container_type OK 0.19 test_describe_addresses OK 0.51 test_describe_availability_zones OK 0.23 test_describe_image_attribute OK 0.20 test_describe_image_attribute_block_device_mapping OK 0.19 test_describe_image_attribute_root_device_name OK 0.71 test_describe_image_mapping OK 0.18 test_describe_images OK 0.18 test_describe_instances OK 0.36 test_describe_instances_bdm OK 1.10 test_describe_key_pairs OK 0.71 test_describe_regions OK 0.20 test_describe_security_groups OK 0.29 test_describe_security_groups_by_id OK 0.31 test_describe_snapshots SKIP: EC2 stuff needs fixed_ip in instance_ref -------------------- >> begin captured logging << -------------------- 2011-07-25 21:34:18,575 AUDIT nova [-] Starting compute node (version 2011.3-LOCALBRANCH:LOCALREVISION) 2011-07-25 21:34:18,584 DEBUG nova [-] Creating Consumer connection for Service compute from (pid=19173) start /tmp/tmpFvibRA/nova/service.py:154 2011-07-25 21:34:18,585 DEBUG nova.rpc [-] Initing the Adapter Consumer for compute from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:34:18,585 DEBUG nova.fakerabbit [-] Declaring queue compute from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:34:18,585 DEBUG nova.fakerabbit [-] Declaring exchange nova from (pid=19173) exchange_declare /tmp/tmpFvibRA/nova/fakerabbit.py:90 2011-07-25 21:34:18,586 DEBUG nova.fakerabbit [-] Binding compute to nova with key compute from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:34:18,586 DEBUG nova.rpc [-] Initing the Adapter Consumer for compute.2ece44a4fe2441debbd7df8232cc9728 from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:34:18,586 DEBUG nova.fakerabbit [-] Declaring queue compute.2ece44a4fe2441debbd7df8232cc9728 from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:34:18,587 DEBUG nova.fakerabbit [-] Binding compute.2ece44a4fe2441debbd7df8232cc9728 to nova with key compute.2ece44a4fe2441debbd7df8232cc9728 from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:34:18,587 INFO nova.rpc [-] Created "compute_fanout" fanout exchange with "compute" routing key 2011-07-25 21:34:18,587 DEBUG nova.rpc [-] Initing the Adapter Consumer for compute from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:34:18,587 DEBUG nova.fakerabbit [-] Declaring queue compute_fanout_053311b8f8ca4a11aa00e690a7d15a3f from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:34:18,588 DEBUG nova.fakerabbit [-] Declaring exchange compute_fanout from (pid=19173) exchange_declare /tmp/tmpFvibRA/nova/fakerabbit.py:90 2011-07-25 21:34:18,588 DEBUG nova.fakerabbit [-] Binding compute_fanout_053311b8f8ca4a11aa00e690a7d15a3f to compute_fanout with key compute from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:34:18,588 AUDIT nova [-] Starting scheduler node (version 2011.3-LOCALBRANCH:LOCALREVISION) 2011-07-25 21:34:18,598 DEBUG nova [-] Creating Consumer connection for Service scheduler from (pid=19173) start /tmp/tmpFvibRA/nova/service.py:154 2011-07-25 21:34:18,598 DEBUG nova.rpc [-] Initing the Adapter Consumer for scheduler from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:34:18,599 DEBUG nova.fakerabbit [-] Declaring queue scheduler from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:34:18,599 DEBUG nova.fakerabbit [-] Binding scheduler to nova with key scheduler from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:34:18,599 DEBUG nova.rpc [-] Initing the Adapter Consumer for scheduler.c0050dde57bb4f1aa4161c4e025dd381 from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:34:18,599 DEBUG nova.fakerabbit [-] Declaring queue scheduler.c0050dde57bb4f1aa4161c4e025dd381 from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:34:18,600 DEBUG nova.fakerabbit [-] Binding scheduler.c0050dde57bb4f1aa4161c4e025dd381 to nova with key scheduler.c0050dde57bb4f1aa4161c4e025dd381 from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:34:18,600 INFO nova.rpc [-] Created "scheduler_fanout" fanout exchange with "scheduler" routing key 2011-07-25 21:34:18,600 DEBUG nova.rpc [-] Initing the Adapter Consumer for scheduler from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:34:18,600 DEBUG nova.fakerabbit [-] Declaring queue scheduler_fanout_484f4b93e88044fe803d7cc3a529dd26 from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:34:18,601 DEBUG nova.fakerabbit [-] Declaring exchange scheduler_fanout from (pid=19173) exchange_declare /tmp/tmpFvibRA/nova/fakerabbit.py:90 2011-07-25 21:34:18,601 DEBUG nova.fakerabbit [-] Binding scheduler_fanout_484f4b93e88044fe803d7cc3a529dd26 to scheduler_fanout with key scheduler from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:34:18,601 AUDIT nova [-] Starting network node (version 2011.3-LOCALBRANCH:LOCALREVISION) 2011-07-25 21:34:18,602 DEBUG nova.utils [-] Attempting to grab semaphore "iptables" for method "apply"... from (pid=19173) inner /tmp/tmpFvibRA/nova/utils.py:600 2011-07-25 21:34:18,602 DEBUG nova.utils [-] Attempting to grab file lock "iptables" for method "apply"... from (pid=19173) inner /tmp/tmpFvibRA/nova/utils.py:605 2011-07-25 21:34:18,602 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-save -t filter from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:18,602 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-restore from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:18,603 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-save -t nat from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:18,604 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-restore from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:18,604 DEBUG nova.linux_net [-] FAKE NET: sudo ip6tables-save -t filter from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:18,604 DEBUG nova.linux_net [-] FAKE NET: sudo ip6tables-restore from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:18,604 DEBUG nova.linux_net [-] FAKE NET: sudo ip addr add 169.254.169.254/32 scope link dev lo from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:18,630 DEBUG nova.utils [-] Attempting to grab semaphore "iptables" for method "apply"... from (pid=19173) inner /tmp/tmpFvibRA/nova/utils.py:600 2011-07-25 21:34:18,630 DEBUG nova.utils [-] Attempting to grab file lock "iptables" for method "apply"... from (pid=19173) inner /tmp/tmpFvibRA/nova/utils.py:605 2011-07-25 21:34:18,631 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-save -t filter from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:18,631 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-restore from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:18,631 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-save -t nat from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:18,632 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-restore from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:18,633 DEBUG nova.linux_net [-] FAKE NET: sudo ip6tables-save -t filter from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:18,633 DEBUG nova.linux_net [-] FAKE NET: sudo ip6tables-restore from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:18,642 DEBUG nova [-] Creating Consumer connection for Service network from (pid=19173) start /tmp/tmpFvibRA/nova/service.py:154 2011-07-25 21:34:18,642 DEBUG nova.rpc [-] Initing the Adapter Consumer for network from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:34:18,643 DEBUG nova.fakerabbit [-] Declaring queue network from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:34:18,643 DEBUG nova.fakerabbit [-] Binding network to nova with key network from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:34:18,643 DEBUG nova.rpc [-] Initing the Adapter Consumer for network.2713630de52a4fc5b1c86f5079a79789 from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:34:18,643 DEBUG nova.fakerabbit [-] Declaring queue network.2713630de52a4fc5b1c86f5079a79789 from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:34:18,644 DEBUG nova.fakerabbit [-] Binding network.2713630de52a4fc5b1c86f5079a79789 to nova with key network.2713630de52a4fc5b1c86f5079a79789 from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:34:18,644 INFO nova.rpc [-] Created "network_fanout" fanout exchange with "network" routing key 2011-07-25 21:34:18,644 DEBUG nova.rpc [-] Initing the Adapter Consumer for network from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:34:18,644 DEBUG nova.fakerabbit [-] Declaring queue network_fanout_c971b29f78554ab691b5191501d46ce1 from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:34:18,644 DEBUG nova.fakerabbit [-] Declaring exchange network_fanout from (pid=19173) exchange_declare /tmp/tmpFvibRA/nova/fakerabbit.py:90 2011-07-25 21:34:18,645 DEBUG nova.fakerabbit [-] Binding network_fanout_c971b29f78554ab691b5191501d46ce1 to network_fanout with key network from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:34:18,645 AUDIT nova [-] Starting volume node (version 2011.3-LOCALBRANCH:LOCALREVISION) 2011-07-25 21:34:18,662 DEBUG nova.volume.manager [-] Re-exporting 0 volumes from (pid=19173) init_host /tmp/tmpFvibRA/nova/volume/manager.py:84 2011-07-25 21:34:18,671 DEBUG nova [-] Creating Consumer connection for Service volume from (pid=19173) start /tmp/tmpFvibRA/nova/service.py:154 2011-07-25 21:34:18,671 DEBUG nova.rpc [-] Initing the Adapter Consumer for volume from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:34:18,671 DEBUG nova.fakerabbit [-] Declaring queue volume from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:34:18,671 DEBUG nova.fakerabbit [-] Binding volume to nova with key volume from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:34:18,672 DEBUG nova.rpc [-] Initing the Adapter Consumer for volume.2a059994f89448689800df241651c3fc from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:34:18,672 DEBUG nova.fakerabbit [-] Declaring queue volume.2a059994f89448689800df241651c3fc from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:34:18,672 DEBUG nova.fakerabbit [-] Binding volume.2a059994f89448689800df241651c3fc to nova with key volume.2a059994f89448689800df241651c3fc from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:34:18,672 INFO nova.rpc [-] Created "volume_fanout" fanout exchange with "volume" routing key 2011-07-25 21:34:18,673 DEBUG nova.rpc [-] Initing the Adapter Consumer for volume from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:34:18,673 DEBUG nova.fakerabbit [-] Declaring queue volume_fanout_73d649391e64434dafa69d8fd76c489b from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:34:18,673 DEBUG nova.fakerabbit [-] Declaring exchange volume_fanout from (pid=19173) exchange_declare /tmp/tmpFvibRA/nova/fakerabbit.py:90 2011-07-25 21:34:18,673 DEBUG nova.fakerabbit [-] Binding volume_fanout_73d649391e64434dafa69d8fd76c489b to volume_fanout with key volume from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:34:18,674 AUDIT nova.auth.manager [-] Created user admin (admin: True) 2011-07-25 21:34:18,676 DEBUG nova.ldapdriver [-] Local cache hit for __project_to_dn by key pid_dn-proj from (pid=19173) inner /tmp/tmpFvibRA/nova/auth/ldapdriver.py:188 2011-07-25 21:34:18,676 DEBUG nova.ldapdriver [-] Local cache hit for __dn_to_uid by key dn_uid-uid=admin,ou=Users,dc=example,dc=com from (pid=19173) inner /tmp/tmpFvibRA/nova/auth/ldapdriver.py:188 2011-07-25 21:34:18,676 AUDIT nova.auth.manager [-] Created project proj with manager admin --------------------- >> end captured logging << --------------------- test_describe_volumes OK 0.23 test_format_instance_bdm OK 0.99 test_import_public_key OK 0.34 test_key_generation OK 0.45 test_modify_image_attribute OK 0.19 test_release_address OK 0.40 test_release_address_still_associated OK 0.20 test_rescue_unrescue_instance OK 2.69 test_revoke_security_group_ingress OK 0.34 test_revoke_security_group_ingress_by_id OK 0.33 test_revoke_security_group_ingress_missing_group_name_or_id OK 0.18 test_run_instances OK 0.95 test_run_instances_image_state_invalid OK 0.18 test_run_instances_image_state_none OK 0.18 test_run_instances_image_status_active OK 1.18 test_run_with_snapshot SKIP: skipping, test is hanging with multinic for rpc reasons -------------------- >> begin captured logging << -------------------- 2011-07-25 21:34:28,228 AUDIT nova [-] Starting compute node (version 2011.3-LOCALBRANCH:LOCALREVISION) 2011-07-25 21:34:28,237 DEBUG nova [-] Creating Consumer connection for Service compute from (pid=19173) start /tmp/tmpFvibRA/nova/service.py:154 2011-07-25 21:34:28,237 DEBUG nova.rpc [-] Initing the Adapter Consumer for compute from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:34:28,238 DEBUG nova.fakerabbit [-] Declaring queue compute from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:34:28,238 DEBUG nova.fakerabbit [-] Declaring exchange nova from (pid=19173) exchange_declare /tmp/tmpFvibRA/nova/fakerabbit.py:90 2011-07-25 21:34:28,238 DEBUG nova.fakerabbit [-] Binding compute to nova with key compute from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:34:28,239 DEBUG nova.rpc [-] Initing the Adapter Consumer for compute.69317903d5e74330a561acc42fb2e6ff from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:34:28,239 DEBUG nova.fakerabbit [-] Declaring queue compute.69317903d5e74330a561acc42fb2e6ff from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:34:28,239 DEBUG nova.fakerabbit [-] Binding compute.69317903d5e74330a561acc42fb2e6ff to nova with key compute.69317903d5e74330a561acc42fb2e6ff from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:34:28,239 INFO nova.rpc [-] Created "compute_fanout" fanout exchange with "compute" routing key 2011-07-25 21:34:28,240 DEBUG nova.rpc [-] Initing the Adapter Consumer for compute from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:34:28,240 DEBUG nova.fakerabbit [-] Declaring queue compute_fanout_3f5a5e77c9444aecbb6d9a832d3fb98f from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:34:28,240 DEBUG nova.fakerabbit [-] Declaring exchange compute_fanout from (pid=19173) exchange_declare /tmp/tmpFvibRA/nova/fakerabbit.py:90 2011-07-25 21:34:28,240 DEBUG nova.fakerabbit [-] Binding compute_fanout_3f5a5e77c9444aecbb6d9a832d3fb98f to compute_fanout with key compute from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:34:28,241 AUDIT nova [-] Starting scheduler node (version 2011.3-LOCALBRANCH:LOCALREVISION) 2011-07-25 21:34:28,250 DEBUG nova [-] Creating Consumer connection for Service scheduler from (pid=19173) start /tmp/tmpFvibRA/nova/service.py:154 2011-07-25 21:34:28,250 DEBUG nova.rpc [-] Initing the Adapter Consumer for scheduler from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:34:28,250 DEBUG nova.fakerabbit [-] Declaring queue scheduler from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:34:28,251 DEBUG nova.fakerabbit [-] Binding scheduler to nova with key scheduler from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:34:28,251 DEBUG nova.rpc [-] Initing the Adapter Consumer for scheduler.bb01a3f2f6cb41e6854e3748b0f4d398 from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:34:28,251 DEBUG nova.fakerabbit [-] Declaring queue scheduler.bb01a3f2f6cb41e6854e3748b0f4d398 from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:34:28,251 DEBUG nova.fakerabbit [-] Binding scheduler.bb01a3f2f6cb41e6854e3748b0f4d398 to nova with key scheduler.bb01a3f2f6cb41e6854e3748b0f4d398 from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:34:28,252 INFO nova.rpc [-] Created "scheduler_fanout" fanout exchange with "scheduler" routing key 2011-07-25 21:34:28,252 DEBUG nova.rpc [-] Initing the Adapter Consumer for scheduler from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:34:28,252 DEBUG nova.fakerabbit [-] Declaring queue scheduler_fanout_93ab8e7e83fe46caba2d9df67e63f46c from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:34:28,252 DEBUG nova.fakerabbit [-] Declaring exchange scheduler_fanout from (pid=19173) exchange_declare /tmp/tmpFvibRA/nova/fakerabbit.py:90 2011-07-25 21:34:28,253 DEBUG nova.fakerabbit [-] Binding scheduler_fanout_93ab8e7e83fe46caba2d9df67e63f46c to scheduler_fanout with key scheduler from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:34:28,253 AUDIT nova [-] Starting network node (version 2011.3-LOCALBRANCH:LOCALREVISION) 2011-07-25 21:34:28,253 DEBUG nova.utils [-] Attempting to grab semaphore "iptables" for method "apply"... from (pid=19173) inner /tmp/tmpFvibRA/nova/utils.py:600 2011-07-25 21:34:28,254 DEBUG nova.utils [-] Attempting to grab file lock "iptables" for method "apply"... from (pid=19173) inner /tmp/tmpFvibRA/nova/utils.py:605 2011-07-25 21:34:28,254 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-save -t filter from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:28,254 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-restore from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:28,254 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-save -t nat from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:28,256 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-restore from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:28,256 DEBUG nova.linux_net [-] FAKE NET: sudo ip6tables-save -t filter from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:28,256 DEBUG nova.linux_net [-] FAKE NET: sudo ip6tables-restore from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:28,257 DEBUG nova.linux_net [-] FAKE NET: sudo ip addr add 169.254.169.254/32 scope link dev lo from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:28,283 DEBUG nova.utils [-] Attempting to grab semaphore "iptables" for method "apply"... from (pid=19173) inner /tmp/tmpFvibRA/nova/utils.py:600 2011-07-25 21:34:28,283 DEBUG nova.utils [-] Attempting to grab file lock "iptables" for method "apply"... from (pid=19173) inner /tmp/tmpFvibRA/nova/utils.py:605 2011-07-25 21:34:28,283 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-save -t filter from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:28,283 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-restore from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:28,284 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-save -t nat from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:28,285 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-restore from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:28,285 DEBUG nova.linux_net [-] FAKE NET: sudo ip6tables-save -t filter from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:28,286 DEBUG nova.linux_net [-] FAKE NET: sudo ip6tables-restore from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:28,294 DEBUG nova [-] Creating Consumer connection for Service network from (pid=19173) start /tmp/tmpFvibRA/nova/service.py:154 2011-07-25 21:34:28,294 DEBUG nova.rpc [-] Initing the Adapter Consumer for network from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:34:28,294 DEBUG nova.fakerabbit [-] Declaring queue network from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:34:28,295 DEBUG nova.fakerabbit [-] Binding network to nova with key network from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:34:28,295 DEBUG nova.rpc [-] Initing the Adapter Consumer for network.a2964b961069466f8a1a2d290ac35685 from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:34:28,295 DEBUG nova.fakerabbit [-] Declaring queue network.a2964b961069466f8a1a2d290ac35685 from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:34:28,295 DEBUG nova.fakerabbit [-] Binding network.a2964b961069466f8a1a2d290ac35685 to nova with key network.a2964b961069466f8a1a2d290ac35685 from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:34:28,296 INFO nova.rpc [-] Created "network_fanout" fanout exchange with "network" routing key 2011-07-25 21:34:28,296 DEBUG nova.rpc [-] Initing the Adapter Consumer for network from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:34:28,296 DEBUG nova.fakerabbit [-] Declaring queue network_fanout_094eff6761a1410782da72eb05378cf8 from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:34:28,296 DEBUG nova.fakerabbit [-] Declaring exchange network_fanout from (pid=19173) exchange_declare /tmp/tmpFvibRA/nova/fakerabbit.py:90 2011-07-25 21:34:28,296 DEBUG nova.fakerabbit [-] Binding network_fanout_094eff6761a1410782da72eb05378cf8 to network_fanout with key network from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:34:28,297 AUDIT nova [-] Starting volume node (version 2011.3-LOCALBRANCH:LOCALREVISION) 2011-07-25 21:34:28,313 DEBUG nova.volume.manager [-] Re-exporting 0 volumes from (pid=19173) init_host /tmp/tmpFvibRA/nova/volume/manager.py:84 2011-07-25 21:34:28,322 DEBUG nova [-] Creating Consumer connection for Service volume from (pid=19173) start /tmp/tmpFvibRA/nova/service.py:154 2011-07-25 21:34:28,322 DEBUG nova.rpc [-] Initing the Adapter Consumer for volume from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:34:28,322 DEBUG nova.fakerabbit [-] Declaring queue volume from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:34:28,323 DEBUG nova.fakerabbit [-] Binding volume to nova with key volume from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:34:28,323 DEBUG nova.rpc [-] Initing the Adapter Consumer for volume.5814799e9c694931926fddb73e9f9e97 from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:34:28,323 DEBUG nova.fakerabbit [-] Declaring queue volume.5814799e9c694931926fddb73e9f9e97 from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:34:28,324 DEBUG nova.fakerabbit [-] Binding volume.5814799e9c694931926fddb73e9f9e97 to nova with key volume.5814799e9c694931926fddb73e9f9e97 from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:34:28,324 INFO nova.rpc [-] Created "volume_fanout" fanout exchange with "volume" routing key 2011-07-25 21:34:28,324 DEBUG nova.rpc [-] Initing the Adapter Consumer for volume from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:34:28,324 DEBUG nova.fakerabbit [-] Declaring queue volume_fanout_60e518fdb9ca4ff9b27f0f89adfb7ef4 from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:34:28,324 DEBUG nova.fakerabbit [-] Declaring exchange volume_fanout from (pid=19173) exchange_declare /tmp/tmpFvibRA/nova/fakerabbit.py:90 2011-07-25 21:34:28,325 DEBUG nova.fakerabbit [-] Binding volume_fanout_60e518fdb9ca4ff9b27f0f89adfb7ef4 to volume_fanout with key volume from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:34:28,326 AUDIT nova.auth.manager [-] Created user admin (admin: True) 2011-07-25 21:34:28,327 DEBUG nova.ldapdriver [-] Local cache hit for __project_to_dn by key pid_dn-proj from (pid=19173) inner /tmp/tmpFvibRA/nova/auth/ldapdriver.py:188 2011-07-25 21:34:28,328 DEBUG nova.ldapdriver [-] Local cache hit for __dn_to_uid by key dn_uid-uid=admin,ou=Users,dc=example,dc=com from (pid=19173) inner /tmp/tmpFvibRA/nova/auth/ldapdriver.py:188 2011-07-25 21:34:28,328 AUDIT nova.auth.manager [-] Created project proj with manager admin --------------------- >> end captured logging << --------------------- test_stop_start_instance SKIP: skipping, test is hanging with multinic for rpc reasons -------------------- >> begin captured logging << -------------------- 2011-07-25 21:34:28,414 AUDIT nova [-] Starting compute node (version 2011.3-LOCALBRANCH:LOCALREVISION) 2011-07-25 21:34:28,423 DEBUG nova [-] Creating Consumer connection for Service compute from (pid=19173) start /tmp/tmpFvibRA/nova/service.py:154 2011-07-25 21:34:28,423 DEBUG nova.rpc [-] Initing the Adapter Consumer for compute from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:34:28,423 DEBUG nova.fakerabbit [-] Declaring queue compute from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:34:28,424 DEBUG nova.fakerabbit [-] Declaring exchange nova from (pid=19173) exchange_declare /tmp/tmpFvibRA/nova/fakerabbit.py:90 2011-07-25 21:34:28,424 DEBUG nova.fakerabbit [-] Binding compute to nova with key compute from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:34:28,424 DEBUG nova.rpc [-] Initing the Adapter Consumer for compute.86b13fd674284499a739624bb1bd3f87 from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:34:28,424 DEBUG nova.fakerabbit [-] Declaring queue compute.86b13fd674284499a739624bb1bd3f87 from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:34:28,425 DEBUG nova.fakerabbit [-] Binding compute.86b13fd674284499a739624bb1bd3f87 to nova with key compute.86b13fd674284499a739624bb1bd3f87 from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:34:28,425 INFO nova.rpc [-] Created "compute_fanout" fanout exchange with "compute" routing key 2011-07-25 21:34:28,425 DEBUG nova.rpc [-] Initing the Adapter Consumer for compute from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:34:28,425 DEBUG nova.fakerabbit [-] Declaring queue compute_fanout_f87505d2b3a44f1987d5a71f33d0b70c from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:34:28,426 DEBUG nova.fakerabbit [-] Declaring exchange compute_fanout from (pid=19173) exchange_declare /tmp/tmpFvibRA/nova/fakerabbit.py:90 2011-07-25 21:34:28,426 DEBUG nova.fakerabbit [-] Binding compute_fanout_f87505d2b3a44f1987d5a71f33d0b70c to compute_fanout with key compute from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:34:28,436 AUDIT nova [-] Starting scheduler node (version 2011.3-LOCALBRANCH:LOCALREVISION) 2011-07-25 21:34:28,446 DEBUG nova [-] Creating Consumer connection for Service scheduler from (pid=19173) start /tmp/tmpFvibRA/nova/service.py:154 2011-07-25 21:34:28,446 DEBUG nova.rpc [-] Initing the Adapter Consumer for scheduler from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:34:28,446 DEBUG nova.fakerabbit [-] Declaring queue scheduler from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:34:28,447 DEBUG nova.fakerabbit [-] Binding scheduler to nova with key scheduler from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:34:28,447 DEBUG nova.rpc [-] Initing the Adapter Consumer for scheduler.e8f092d4343540a39aa498bdc69e4603 from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:34:28,447 DEBUG nova.fakerabbit [-] Declaring queue scheduler.e8f092d4343540a39aa498bdc69e4603 from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:34:28,447 DEBUG nova.fakerabbit [-] Binding scheduler.e8f092d4343540a39aa498bdc69e4603 to nova with key scheduler.e8f092d4343540a39aa498bdc69e4603 from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:34:28,448 INFO nova.rpc [-] Created "scheduler_fanout" fanout exchange with "scheduler" routing key 2011-07-25 21:34:28,448 DEBUG nova.rpc [-] Initing the Adapter Consumer for scheduler from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:34:28,448 DEBUG nova.fakerabbit [-] Declaring queue scheduler_fanout_873860c99a2e4881bc0af23f5bf23c82 from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:34:28,449 DEBUG nova.fakerabbit [-] Declaring exchange scheduler_fanout from (pid=19173) exchange_declare /tmp/tmpFvibRA/nova/fakerabbit.py:90 2011-07-25 21:34:28,449 DEBUG nova.fakerabbit [-] Binding scheduler_fanout_873860c99a2e4881bc0af23f5bf23c82 to scheduler_fanout with key scheduler from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:34:28,449 AUDIT nova [-] Starting network node (version 2011.3-LOCALBRANCH:LOCALREVISION) 2011-07-25 21:34:28,450 DEBUG nova.utils [-] Attempting to grab semaphore "iptables" for method "apply"... from (pid=19173) inner /tmp/tmpFvibRA/nova/utils.py:600 2011-07-25 21:34:28,450 DEBUG nova.utils [-] Attempting to grab file lock "iptables" for method "apply"... from (pid=19173) inner /tmp/tmpFvibRA/nova/utils.py:605 2011-07-25 21:34:28,450 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-save -t filter from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:28,451 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-restore from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:28,451 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-save -t nat from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:28,452 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-restore from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:28,452 DEBUG nova.linux_net [-] FAKE NET: sudo ip6tables-save -t filter from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:28,453 DEBUG nova.linux_net [-] FAKE NET: sudo ip6tables-restore from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:28,453 DEBUG nova.linux_net [-] FAKE NET: sudo ip addr add 169.254.169.254/32 scope link dev lo from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:28,478 DEBUG nova.utils [-] Attempting to grab semaphore "iptables" for method "apply"... from (pid=19173) inner /tmp/tmpFvibRA/nova/utils.py:600 2011-07-25 21:34:28,478 DEBUG nova.utils [-] Attempting to grab file lock "iptables" for method "apply"... from (pid=19173) inner /tmp/tmpFvibRA/nova/utils.py:605 2011-07-25 21:34:28,478 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-save -t filter from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:28,479 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-restore from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:28,479 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-save -t nat from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:28,480 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-restore from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:28,480 DEBUG nova.linux_net [-] FAKE NET: sudo ip6tables-save -t filter from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:28,481 DEBUG nova.linux_net [-] FAKE NET: sudo ip6tables-restore from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:28,490 DEBUG nova [-] Creating Consumer connection for Service network from (pid=19173) start /tmp/tmpFvibRA/nova/service.py:154 2011-07-25 21:34:28,490 DEBUG nova.rpc [-] Initing the Adapter Consumer for network from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:34:28,490 DEBUG nova.fakerabbit [-] Declaring queue network from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:34:28,491 DEBUG nova.fakerabbit [-] Binding network to nova with key network from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:34:28,491 DEBUG nova.rpc [-] Initing the Adapter Consumer for network.fec80b999b70483c9e1abc5f6e6b9724 from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:34:28,491 DEBUG nova.fakerabbit [-] Declaring queue network.fec80b999b70483c9e1abc5f6e6b9724 from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:34:28,491 DEBUG nova.fakerabbit [-] Binding network.fec80b999b70483c9e1abc5f6e6b9724 to nova with key network.fec80b999b70483c9e1abc5f6e6b9724 from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:34:28,492 INFO nova.rpc [-] Created "network_fanout" fanout exchange with "network" routing key 2011-07-25 21:34:28,492 DEBUG nova.rpc [-] Initing the Adapter Consumer for network from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:34:28,492 DEBUG nova.fakerabbit [-] Declaring queue network_fanout_1696d545be37485a9ed5a15455437da7 from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:34:28,492 DEBUG nova.fakerabbit [-] Declaring exchange network_fanout from (pid=19173) exchange_declare /tmp/tmpFvibRA/nova/fakerabbit.py:90 2011-07-25 21:34:28,492 DEBUG nova.fakerabbit [-] Binding network_fanout_1696d545be37485a9ed5a15455437da7 to network_fanout with key network from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:34:28,493 AUDIT nova [-] Starting volume node (version 2011.3-LOCALBRANCH:LOCALREVISION) 2011-07-25 21:34:28,509 DEBUG nova.volume.manager [-] Re-exporting 0 volumes from (pid=19173) init_host /tmp/tmpFvibRA/nova/volume/manager.py:84 2011-07-25 21:34:28,517 DEBUG nova [-] Creating Consumer connection for Service volume from (pid=19173) start /tmp/tmpFvibRA/nova/service.py:154 2011-07-25 21:34:28,517 DEBUG nova.rpc [-] Initing the Adapter Consumer for volume from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:34:28,518 DEBUG nova.fakerabbit [-] Declaring queue volume from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:34:28,518 DEBUG nova.fakerabbit [-] Binding volume to nova with key volume from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:34:28,518 DEBUG nova.rpc [-] Initing the Adapter Consumer for volume.424157cad6a64cdea1ba1450cf5d63fc from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:34:28,519 DEBUG nova.fakerabbit [-] Declaring queue volume.424157cad6a64cdea1ba1450cf5d63fc from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:34:28,519 DEBUG nova.fakerabbit [-] Binding volume.424157cad6a64cdea1ba1450cf5d63fc to nova with key volume.424157cad6a64cdea1ba1450cf5d63fc from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:34:28,519 INFO nova.rpc [-] Created "volume_fanout" fanout exchange with "volume" routing key 2011-07-25 21:34:28,519 DEBUG nova.rpc [-] Initing the Adapter Consumer for volume from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:34:28,520 DEBUG nova.fakerabbit [-] Declaring queue volume_fanout_6d8cde9950cc468d99752e03da963e11 from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:34:28,520 DEBUG nova.fakerabbit [-] Declaring exchange volume_fanout from (pid=19173) exchange_declare /tmp/tmpFvibRA/nova/fakerabbit.py:90 2011-07-25 21:34:28,520 DEBUG nova.fakerabbit [-] Binding volume_fanout_6d8cde9950cc468d99752e03da963e11 to volume_fanout with key volume from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:34:28,521 AUDIT nova.auth.manager [-] Created user admin (admin: True) 2011-07-25 21:34:28,522 DEBUG nova.ldapdriver [-] Local cache hit for __project_to_dn by key pid_dn-proj from (pid=19173) inner /tmp/tmpFvibRA/nova/auth/ldapdriver.py:188 2011-07-25 21:34:28,523 DEBUG nova.ldapdriver [-] Local cache hit for __dn_to_uid by key dn_uid-uid=admin,ou=Users,dc=example,dc=com from (pid=19173) inner /tmp/tmpFvibRA/nova/auth/ldapdriver.py:188 2011-07-25 21:34:28,523 AUDIT nova.auth.manager [-] Created project proj with manager admin --------------------- >> end captured logging << --------------------- test_stop_start_with_volume SKIP: skipping, test is hanging with multinic for rpc reasons -------------------- >> begin captured logging << -------------------- 2011-07-25 21:34:28,612 AUDIT nova [-] Starting compute node (version 2011.3-LOCALBRANCH:LOCALREVISION) 2011-07-25 21:34:28,620 DEBUG nova [-] Creating Consumer connection for Service compute from (pid=19173) start /tmp/tmpFvibRA/nova/service.py:154 2011-07-25 21:34:28,621 DEBUG nova.rpc [-] Initing the Adapter Consumer for compute from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:34:28,621 DEBUG nova.fakerabbit [-] Declaring queue compute from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:34:28,621 DEBUG nova.fakerabbit [-] Declaring exchange nova from (pid=19173) exchange_declare /tmp/tmpFvibRA/nova/fakerabbit.py:90 2011-07-25 21:34:28,622 DEBUG nova.fakerabbit [-] Binding compute to nova with key compute from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:34:28,622 DEBUG nova.rpc [-] Initing the Adapter Consumer for compute.ed197ab7f93d4b8ebe6001427b896a7a from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:34:28,622 DEBUG nova.fakerabbit [-] Declaring queue compute.ed197ab7f93d4b8ebe6001427b896a7a from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:34:28,622 DEBUG nova.fakerabbit [-] Binding compute.ed197ab7f93d4b8ebe6001427b896a7a to nova with key compute.ed197ab7f93d4b8ebe6001427b896a7a from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:34:28,623 INFO nova.rpc [-] Created "compute_fanout" fanout exchange with "compute" routing key 2011-07-25 21:34:28,623 DEBUG nova.rpc [-] Initing the Adapter Consumer for compute from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:34:28,623 DEBUG nova.fakerabbit [-] Declaring queue compute_fanout_b04800d213f442f4945d9e2cef4ec6c1 from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:34:28,623 DEBUG nova.fakerabbit [-] Declaring exchange compute_fanout from (pid=19173) exchange_declare /tmp/tmpFvibRA/nova/fakerabbit.py:90 2011-07-25 21:34:28,624 DEBUG nova.fakerabbit [-] Binding compute_fanout_b04800d213f442f4945d9e2cef4ec6c1 to compute_fanout with key compute from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:34:28,624 AUDIT nova [-] Starting scheduler node (version 2011.3-LOCALBRANCH:LOCALREVISION) 2011-07-25 21:34:28,633 DEBUG nova [-] Creating Consumer connection for Service scheduler from (pid=19173) start /tmp/tmpFvibRA/nova/service.py:154 2011-07-25 21:34:28,633 DEBUG nova.rpc [-] Initing the Adapter Consumer for scheduler from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:34:28,634 DEBUG nova.fakerabbit [-] Declaring queue scheduler from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:34:28,634 DEBUG nova.fakerabbit [-] Binding scheduler to nova with key scheduler from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:34:28,634 DEBUG nova.rpc [-] Initing the Adapter Consumer for scheduler.51c762713031486d90679f6cced0a75e from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:34:28,634 DEBUG nova.fakerabbit [-] Declaring queue scheduler.51c762713031486d90679f6cced0a75e from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:34:28,635 DEBUG nova.fakerabbit [-] Binding scheduler.51c762713031486d90679f6cced0a75e to nova with key scheduler.51c762713031486d90679f6cced0a75e from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:34:28,635 INFO nova.rpc [-] Created "scheduler_fanout" fanout exchange with "scheduler" routing key 2011-07-25 21:34:28,635 DEBUG nova.rpc [-] Initing the Adapter Consumer for scheduler from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:34:28,635 DEBUG nova.fakerabbit [-] Declaring queue scheduler_fanout_a10e7fa766654f2085562c8d7e2c6870 from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:34:28,636 DEBUG nova.fakerabbit [-] Declaring exchange scheduler_fanout from (pid=19173) exchange_declare /tmp/tmpFvibRA/nova/fakerabbit.py:90 2011-07-25 21:34:28,636 DEBUG nova.fakerabbit [-] Binding scheduler_fanout_a10e7fa766654f2085562c8d7e2c6870 to scheduler_fanout with key scheduler from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:34:28,636 AUDIT nova [-] Starting network node (version 2011.3-LOCALBRANCH:LOCALREVISION) 2011-07-25 21:34:28,637 DEBUG nova.utils [-] Attempting to grab semaphore "iptables" for method "apply"... from (pid=19173) inner /tmp/tmpFvibRA/nova/utils.py:600 2011-07-25 21:34:28,637 DEBUG nova.utils [-] Attempting to grab file lock "iptables" for method "apply"... from (pid=19173) inner /tmp/tmpFvibRA/nova/utils.py:605 2011-07-25 21:34:28,637 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-save -t filter from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:28,638 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-restore from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:28,638 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-save -t nat from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:28,639 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-restore from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:28,640 DEBUG nova.linux_net [-] FAKE NET: sudo ip6tables-save -t filter from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:28,640 DEBUG nova.linux_net [-] FAKE NET: sudo ip6tables-restore from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:28,640 DEBUG nova.linux_net [-] FAKE NET: sudo ip addr add 169.254.169.254/32 scope link dev lo from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:28,666 DEBUG nova.utils [-] Attempting to grab semaphore "iptables" for method "apply"... from (pid=19173) inner /tmp/tmpFvibRA/nova/utils.py:600 2011-07-25 21:34:28,666 DEBUG nova.utils [-] Attempting to grab file lock "iptables" for method "apply"... from (pid=19173) inner /tmp/tmpFvibRA/nova/utils.py:605 2011-07-25 21:34:28,666 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-save -t filter from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:28,666 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-restore from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:28,667 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-save -t nat from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:28,668 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-restore from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:28,669 DEBUG nova.linux_net [-] FAKE NET: sudo ip6tables-save -t filter from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:28,669 DEBUG nova.linux_net [-] FAKE NET: sudo ip6tables-restore from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:28,678 DEBUG nova [-] Creating Consumer connection for Service network from (pid=19173) start /tmp/tmpFvibRA/nova/service.py:154 2011-07-25 21:34:28,678 DEBUG nova.rpc [-] Initing the Adapter Consumer for network from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:34:28,678 DEBUG nova.fakerabbit [-] Declaring queue network from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:34:28,678 DEBUG nova.fakerabbit [-] Binding network to nova with key network from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:34:28,679 DEBUG nova.rpc [-] Initing the Adapter Consumer for network.c10ebc9b52614d2fa656a3823a35322b from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:34:28,679 DEBUG nova.fakerabbit [-] Declaring queue network.c10ebc9b52614d2fa656a3823a35322b from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:34:28,679 DEBUG nova.fakerabbit [-] Binding network.c10ebc9b52614d2fa656a3823a35322b to nova with key network.c10ebc9b52614d2fa656a3823a35322b from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:34:28,679 INFO nova.rpc [-] Created "network_fanout" fanout exchange with "network" routing key 2011-07-25 21:34:28,680 DEBUG nova.rpc [-] Initing the Adapter Consumer for network from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:34:28,680 DEBUG nova.fakerabbit [-] Declaring queue network_fanout_3d839eadb6084afbac03af91a1cf73f2 from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:34:28,680 DEBUG nova.fakerabbit [-] Declaring exchange network_fanout from (pid=19173) exchange_declare /tmp/tmpFvibRA/nova/fakerabbit.py:90 2011-07-25 21:34:28,680 DEBUG nova.fakerabbit [-] Binding network_fanout_3d839eadb6084afbac03af91a1cf73f2 to network_fanout with key network from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:34:28,681 AUDIT nova [-] Starting volume node (version 2011.3-LOCALBRANCH:LOCALREVISION) 2011-07-25 21:34:28,696 DEBUG nova.volume.manager [-] Re-exporting 0 volumes from (pid=19173) init_host /tmp/tmpFvibRA/nova/volume/manager.py:84 2011-07-25 21:34:28,705 DEBUG nova [-] Creating Consumer connection for Service volume from (pid=19173) start /tmp/tmpFvibRA/nova/service.py:154 2011-07-25 21:34:28,705 DEBUG nova.rpc [-] Initing the Adapter Consumer for volume from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:34:28,705 DEBUG nova.fakerabbit [-] Declaring queue volume from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:34:28,706 DEBUG nova.fakerabbit [-] Binding volume to nova with key volume from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:34:28,706 DEBUG nova.rpc [-] Initing the Adapter Consumer for volume.19e609b339ed425fb1b093bf274462ce from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:34:28,706 DEBUG nova.fakerabbit [-] Declaring queue volume.19e609b339ed425fb1b093bf274462ce from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:34:28,706 DEBUG nova.fakerabbit [-] Binding volume.19e609b339ed425fb1b093bf274462ce to nova with key volume.19e609b339ed425fb1b093bf274462ce from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:34:28,707 INFO nova.rpc [-] Created "volume_fanout" fanout exchange with "volume" routing key 2011-07-25 21:34:28,707 DEBUG nova.rpc [-] Initing the Adapter Consumer for volume from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:34:28,707 DEBUG nova.fakerabbit [-] Declaring queue volume_fanout_a04240d6646649c898e3fce2bb4b7454 from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:34:28,707 DEBUG nova.fakerabbit [-] Declaring exchange volume_fanout from (pid=19173) exchange_declare /tmp/tmpFvibRA/nova/fakerabbit.py:90 2011-07-25 21:34:28,708 DEBUG nova.fakerabbit [-] Binding volume_fanout_a04240d6646649c898e3fce2bb4b7454 to volume_fanout with key volume from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:34:28,709 AUDIT nova.auth.manager [-] Created user admin (admin: True) 2011-07-25 21:34:28,710 DEBUG nova.ldapdriver [-] Local cache hit for __project_to_dn by key pid_dn-proj from (pid=19173) inner /tmp/tmpFvibRA/nova/auth/ldapdriver.py:188 2011-07-25 21:34:28,710 DEBUG nova.ldapdriver [-] Local cache hit for __dn_to_uid by key dn_uid-uid=admin,ou=Users,dc=example,dc=com from (pid=19173) inner /tmp/tmpFvibRA/nova/auth/ldapdriver.py:188 2011-07-25 21:34:28,711 AUDIT nova.auth.manager [-] Created project proj with manager admin --------------------- >> end captured logging << --------------------- test_stop_with_attached_volume SKIP: skipping, test is hanging with multinic for rpc reasons -------------------- >> begin captured logging << -------------------- 2011-07-25 21:34:28,803 AUDIT nova [-] Starting compute node (version 2011.3-LOCALBRANCH:LOCALREVISION) 2011-07-25 21:34:28,811 DEBUG nova [-] Creating Consumer connection for Service compute from (pid=19173) start /tmp/tmpFvibRA/nova/service.py:154 2011-07-25 21:34:28,811 DEBUG nova.rpc [-] Initing the Adapter Consumer for compute from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:34:28,812 DEBUG nova.fakerabbit [-] Declaring queue compute from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:34:28,812 DEBUG nova.fakerabbit [-] Declaring exchange nova from (pid=19173) exchange_declare /tmp/tmpFvibRA/nova/fakerabbit.py:90 2011-07-25 21:34:28,812 DEBUG nova.fakerabbit [-] Binding compute to nova with key compute from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:34:28,813 DEBUG nova.rpc [-] Initing the Adapter Consumer for compute.ce67cb196e0d4262a96d4b184502cb4c from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:34:28,813 DEBUG nova.fakerabbit [-] Declaring queue compute.ce67cb196e0d4262a96d4b184502cb4c from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:34:28,813 DEBUG nova.fakerabbit [-] Binding compute.ce67cb196e0d4262a96d4b184502cb4c to nova with key compute.ce67cb196e0d4262a96d4b184502cb4c from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:34:28,813 INFO nova.rpc [-] Created "compute_fanout" fanout exchange with "compute" routing key 2011-07-25 21:34:28,813 DEBUG nova.rpc [-] Initing the Adapter Consumer for compute from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:34:28,814 DEBUG nova.fakerabbit [-] Declaring queue compute_fanout_2dc74e7967844aeb970824c433fbd2e7 from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:34:28,814 DEBUG nova.fakerabbit [-] Declaring exchange compute_fanout from (pid=19173) exchange_declare /tmp/tmpFvibRA/nova/fakerabbit.py:90 2011-07-25 21:34:28,814 DEBUG nova.fakerabbit [-] Binding compute_fanout_2dc74e7967844aeb970824c433fbd2e7 to compute_fanout with key compute from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:34:28,815 AUDIT nova [-] Starting scheduler node (version 2011.3-LOCALBRANCH:LOCALREVISION) 2011-07-25 21:34:28,823 DEBUG nova [-] Creating Consumer connection for Service scheduler from (pid=19173) start /tmp/tmpFvibRA/nova/service.py:154 2011-07-25 21:34:28,824 DEBUG nova.rpc [-] Initing the Adapter Consumer for scheduler from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:34:28,824 DEBUG nova.fakerabbit [-] Declaring queue scheduler from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:34:28,824 DEBUG nova.fakerabbit [-] Binding scheduler to nova with key scheduler from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:34:28,825 DEBUG nova.rpc [-] Initing the Adapter Consumer for scheduler.ed069864d6394e489cde4b8a371c143a from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:34:28,825 DEBUG nova.fakerabbit [-] Declaring queue scheduler.ed069864d6394e489cde4b8a371c143a from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:34:28,825 DEBUG nova.fakerabbit [-] Binding scheduler.ed069864d6394e489cde4b8a371c143a to nova with key scheduler.ed069864d6394e489cde4b8a371c143a from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:34:28,825 INFO nova.rpc [-] Created "scheduler_fanout" fanout exchange with "scheduler" routing key 2011-07-25 21:34:28,826 DEBUG nova.rpc [-] Initing the Adapter Consumer for scheduler from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:34:28,826 DEBUG nova.fakerabbit [-] Declaring queue scheduler_fanout_1ad9d78ce25a4fb2b03cfad444807458 from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:34:28,826 DEBUG nova.fakerabbit [-] Declaring exchange scheduler_fanout from (pid=19173) exchange_declare /tmp/tmpFvibRA/nova/fakerabbit.py:90 2011-07-25 21:34:28,826 DEBUG nova.fakerabbit [-] Binding scheduler_fanout_1ad9d78ce25a4fb2b03cfad444807458 to scheduler_fanout with key scheduler from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:34:28,827 AUDIT nova [-] Starting network node (version 2011.3-LOCALBRANCH:LOCALREVISION) 2011-07-25 21:34:28,827 DEBUG nova.utils [-] Attempting to grab semaphore "iptables" for method "apply"... from (pid=19173) inner /tmp/tmpFvibRA/nova/utils.py:600 2011-07-25 21:34:28,827 DEBUG nova.utils [-] Attempting to grab file lock "iptables" for method "apply"... from (pid=19173) inner /tmp/tmpFvibRA/nova/utils.py:605 2011-07-25 21:34:28,828 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-save -t filter from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:28,828 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-restore from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:28,828 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-save -t nat from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:28,830 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-restore from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:28,830 DEBUG nova.linux_net [-] FAKE NET: sudo ip6tables-save -t filter from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:28,830 DEBUG nova.linux_net [-] FAKE NET: sudo ip6tables-restore from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:28,830 DEBUG nova.linux_net [-] FAKE NET: sudo ip addr add 169.254.169.254/32 scope link dev lo from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:28,855 DEBUG nova.utils [-] Attempting to grab semaphore "iptables" for method "apply"... from (pid=19173) inner /tmp/tmpFvibRA/nova/utils.py:600 2011-07-25 21:34:28,856 DEBUG nova.utils [-] Attempting to grab file lock "iptables" for method "apply"... from (pid=19173) inner /tmp/tmpFvibRA/nova/utils.py:605 2011-07-25 21:34:28,856 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-save -t filter from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:28,856 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-restore from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:28,856 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-save -t nat from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:28,858 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-restore from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:28,858 DEBUG nova.linux_net [-] FAKE NET: sudo ip6tables-save -t filter from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:28,858 DEBUG nova.linux_net [-] FAKE NET: sudo ip6tables-restore from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:28,867 DEBUG nova [-] Creating Consumer connection for Service network from (pid=19173) start /tmp/tmpFvibRA/nova/service.py:154 2011-07-25 21:34:28,868 DEBUG nova.rpc [-] Initing the Adapter Consumer for network from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:34:28,868 DEBUG nova.fakerabbit [-] Declaring queue network from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:34:28,868 DEBUG nova.fakerabbit [-] Binding network to nova with key network from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:34:28,868 DEBUG nova.rpc [-] Initing the Adapter Consumer for network.1e127b9ecf4e4923a663f92196fe3af4 from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:34:28,869 DEBUG nova.fakerabbit [-] Declaring queue network.1e127b9ecf4e4923a663f92196fe3af4 from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:34:28,869 DEBUG nova.fakerabbit [-] Binding network.1e127b9ecf4e4923a663f92196fe3af4 to nova with key network.1e127b9ecf4e4923a663f92196fe3af4 from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:34:28,869 INFO nova.rpc [-] Created "network_fanout" fanout exchange with "network" routing key 2011-07-25 21:34:28,869 DEBUG nova.rpc [-] Initing the Adapter Consumer for network from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:34:28,870 DEBUG nova.fakerabbit [-] Declaring queue network_fanout_32122f872bdc405e81b527fed9c6e985 from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:34:28,870 DEBUG nova.fakerabbit [-] Declaring exchange network_fanout from (pid=19173) exchange_declare /tmp/tmpFvibRA/nova/fakerabbit.py:90 2011-07-25 21:34:28,870 DEBUG nova.fakerabbit [-] Binding network_fanout_32122f872bdc405e81b527fed9c6e985 to network_fanout with key network from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:34:28,871 AUDIT nova [-] Starting volume node (version 2011.3-LOCALBRANCH:LOCALREVISION) 2011-07-25 21:34:28,886 DEBUG nova.volume.manager [-] Re-exporting 0 volumes from (pid=19173) init_host /tmp/tmpFvibRA/nova/volume/manager.py:84 2011-07-25 21:34:28,894 DEBUG nova [-] Creating Consumer connection for Service volume from (pid=19173) start /tmp/tmpFvibRA/nova/service.py:154 2011-07-25 21:34:28,895 DEBUG nova.rpc [-] Initing the Adapter Consumer for volume from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:34:28,895 DEBUG nova.fakerabbit [-] Declaring queue volume from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:34:28,895 DEBUG nova.fakerabbit [-] Binding volume to nova with key volume from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:34:28,895 DEBUG nova.rpc [-] Initing the Adapter Consumer for volume.7664529872c946bd82efb31f8b5fdc4d from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:34:28,896 DEBUG nova.fakerabbit [-] Declaring queue volume.7664529872c946bd82efb31f8b5fdc4d from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:34:28,896 DEBUG nova.fakerabbit [-] Binding volume.7664529872c946bd82efb31f8b5fdc4d to nova with key volume.7664529872c946bd82efb31f8b5fdc4d from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:34:28,896 INFO nova.rpc [-] Created "volume_fanout" fanout exchange with "volume" routing key 2011-07-25 21:34:28,896 DEBUG nova.rpc [-] Initing the Adapter Consumer for volume from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:34:28,897 DEBUG nova.fakerabbit [-] Declaring queue volume_fanout_4f596ea1d94e45089cbbb76e40190522 from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:34:28,897 DEBUG nova.fakerabbit [-] Declaring exchange volume_fanout from (pid=19173) exchange_declare /tmp/tmpFvibRA/nova/fakerabbit.py:90 2011-07-25 21:34:28,897 DEBUG nova.fakerabbit [-] Binding volume_fanout_4f596ea1d94e45089cbbb76e40190522 to volume_fanout with key volume from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:34:28,898 AUDIT nova.auth.manager [-] Created user admin (admin: True) 2011-07-25 21:34:28,899 DEBUG nova.ldapdriver [-] Local cache hit for __project_to_dn by key pid_dn-proj from (pid=19173) inner /tmp/tmpFvibRA/nova/auth/ldapdriver.py:188 2011-07-25 21:34:28,900 DEBUG nova.ldapdriver [-] Local cache hit for __dn_to_uid by key dn_uid-uid=admin,ou=Users,dc=example,dc=com from (pid=19173) inner /tmp/tmpFvibRA/nova/auth/ldapdriver.py:188 2011-07-25 21:34:28,900 AUDIT nova.auth.manager [-] Created project proj with manager admin --------------------- >> end captured logging << --------------------- test_terminate_instances OK 1.10 test_update_of_instance_display_fields OK 0.33 test_update_of_instance_wont_update_private_fields SKIP: EC2 stuff needs mac_address in instance_ref -------------------- >> begin captured logging << -------------------- 2011-07-25 21:34:30,408 AUDIT nova [-] Starting compute node (version 2011.3-LOCALBRANCH:LOCALREVISION) 2011-07-25 21:34:30,417 DEBUG nova [-] Creating Consumer connection for Service compute from (pid=19173) start /tmp/tmpFvibRA/nova/service.py:154 2011-07-25 21:34:30,418 DEBUG nova.rpc [-] Initing the Adapter Consumer for compute from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:34:30,418 DEBUG nova.fakerabbit [-] Declaring queue compute from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:34:30,418 DEBUG nova.fakerabbit [-] Declaring exchange nova from (pid=19173) exchange_declare /tmp/tmpFvibRA/nova/fakerabbit.py:90 2011-07-25 21:34:30,418 DEBUG nova.fakerabbit [-] Binding compute to nova with key compute from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:34:30,419 DEBUG nova.rpc [-] Initing the Adapter Consumer for compute.f6d78fd7dc69452dab4b4dbf673e82b1 from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:34:30,419 DEBUG nova.fakerabbit [-] Declaring queue compute.f6d78fd7dc69452dab4b4dbf673e82b1 from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:34:30,419 DEBUG nova.fakerabbit [-] Binding compute.f6d78fd7dc69452dab4b4dbf673e82b1 to nova with key compute.f6d78fd7dc69452dab4b4dbf673e82b1 from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:34:30,419 INFO nova.rpc [-] Created "compute_fanout" fanout exchange with "compute" routing key 2011-07-25 21:34:30,420 DEBUG nova.rpc [-] Initing the Adapter Consumer for compute from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:34:30,420 DEBUG nova.fakerabbit [-] Declaring queue compute_fanout_fdd0d17cc5134ff1a83e735636fc859e from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:34:30,420 DEBUG nova.fakerabbit [-] Declaring exchange compute_fanout from (pid=19173) exchange_declare /tmp/tmpFvibRA/nova/fakerabbit.py:90 2011-07-25 21:34:30,420 DEBUG nova.fakerabbit [-] Binding compute_fanout_fdd0d17cc5134ff1a83e735636fc859e to compute_fanout with key compute from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:34:30,421 AUDIT nova [-] Starting scheduler node (version 2011.3-LOCALBRANCH:LOCALREVISION) 2011-07-25 21:34:30,429 DEBUG nova [-] Creating Consumer connection for Service scheduler from (pid=19173) start /tmp/tmpFvibRA/nova/service.py:154 2011-07-25 21:34:30,430 DEBUG nova.rpc [-] Initing the Adapter Consumer for scheduler from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:34:30,430 DEBUG nova.fakerabbit [-] Declaring queue scheduler from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:34:30,430 DEBUG nova.fakerabbit [-] Binding scheduler to nova with key scheduler from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:34:30,430 DEBUG nova.rpc [-] Initing the Adapter Consumer for scheduler.771245d987004865a5f9dc7b61812407 from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:34:30,431 DEBUG nova.fakerabbit [-] Declaring queue scheduler.771245d987004865a5f9dc7b61812407 from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:34:30,431 DEBUG nova.fakerabbit [-] Binding scheduler.771245d987004865a5f9dc7b61812407 to nova with key scheduler.771245d987004865a5f9dc7b61812407 from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:34:30,431 INFO nova.rpc [-] Created "scheduler_fanout" fanout exchange with "scheduler" routing key 2011-07-25 21:34:30,431 DEBUG nova.rpc [-] Initing the Adapter Consumer for scheduler from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:34:30,432 DEBUG nova.fakerabbit [-] Declaring queue scheduler_fanout_4742327d3e9f46aaac9d896ed41df0ca from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:34:30,432 DEBUG nova.fakerabbit [-] Declaring exchange scheduler_fanout from (pid=19173) exchange_declare /tmp/tmpFvibRA/nova/fakerabbit.py:90 2011-07-25 21:34:30,432 DEBUG nova.fakerabbit [-] Binding scheduler_fanout_4742327d3e9f46aaac9d896ed41df0ca to scheduler_fanout with key scheduler from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:34:30,433 AUDIT nova [-] Starting network node (version 2011.3-LOCALBRANCH:LOCALREVISION) 2011-07-25 21:34:30,433 DEBUG nova.utils [-] Attempting to grab semaphore "iptables" for method "apply"... from (pid=19173) inner /tmp/tmpFvibRA/nova/utils.py:600 2011-07-25 21:34:30,433 DEBUG nova.utils [-] Attempting to grab file lock "iptables" for method "apply"... from (pid=19173) inner /tmp/tmpFvibRA/nova/utils.py:605 2011-07-25 21:34:30,433 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-save -t filter from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:30,434 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-restore from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:30,434 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-save -t nat from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:30,435 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-restore from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:30,436 DEBUG nova.linux_net [-] FAKE NET: sudo ip6tables-save -t filter from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:30,436 DEBUG nova.linux_net [-] FAKE NET: sudo ip6tables-restore from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:30,436 DEBUG nova.linux_net [-] FAKE NET: sudo ip addr add 169.254.169.254/32 scope link dev lo from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:30,461 DEBUG nova.utils [-] Attempting to grab semaphore "iptables" for method "apply"... from (pid=19173) inner /tmp/tmpFvibRA/nova/utils.py:600 2011-07-25 21:34:30,461 DEBUG nova.utils [-] Attempting to grab file lock "iptables" for method "apply"... from (pid=19173) inner /tmp/tmpFvibRA/nova/utils.py:605 2011-07-25 21:34:30,461 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-save -t filter from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:30,462 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-restore from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:30,462 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-save -t nat from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:30,463 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-restore from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:30,463 DEBUG nova.linux_net [-] FAKE NET: sudo ip6tables-save -t filter from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:30,464 DEBUG nova.linux_net [-] FAKE NET: sudo ip6tables-restore from (pid=19173) _execute /tmp/tmpFvibRA/nova/network/linux_net.py:685 2011-07-25 21:34:30,472 DEBUG nova [-] Creating Consumer connection for Service network from (pid=19173) start /tmp/tmpFvibRA/nova/service.py:154 2011-07-25 21:34:30,472 DEBUG nova.rpc [-] Initing the Adapter Consumer for network from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:34:30,473 DEBUG nova.fakerabbit [-] Declaring queue network from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:34:30,473 DEBUG nova.fakerabbit [-] Binding network to nova with key network from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:34:30,473 DEBUG nova.rpc [-] Initing the Adapter Consumer for network.d266928185d8451aabde75240e4511fe from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:34:30,474 DEBUG nova.fakerabbit [-] Declaring queue network.d266928185d8451aabde75240e4511fe from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:34:30,474 DEBUG nova.fakerabbit [-] Binding network.d266928185d8451aabde75240e4511fe to nova with key network.d266928185d8451aabde75240e4511fe from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:34:30,474 INFO nova.rpc [-] Created "network_fanout" fanout exchange with "network" routing key 2011-07-25 21:34:30,474 DEBUG nova.rpc [-] Initing the Adapter Consumer for network from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:34:30,474 DEBUG nova.fakerabbit [-] Declaring queue network_fanout_3af827682eab4b28a1ef36846acc1cfc from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:34:30,475 DEBUG nova.fakerabbit [-] Declaring exchange network_fanout from (pid=19173) exchange_declare /tmp/tmpFvibRA/nova/fakerabbit.py:90 2011-07-25 21:34:30,475 DEBUG nova.fakerabbit [-] Binding network_fanout_3af827682eab4b28a1ef36846acc1cfc to network_fanout with key network from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:34:30,476 AUDIT nova [-] Starting volume node (version 2011.3-LOCALBRANCH:LOCALREVISION) 2011-07-25 21:34:30,492 DEBUG nova.volume.manager [-] Re-exporting 0 volumes from (pid=19173) init_host /tmp/tmpFvibRA/nova/volume/manager.py:84 2011-07-25 21:34:30,500 DEBUG nova [-] Creating Consumer connection for Service volume from (pid=19173) start /tmp/tmpFvibRA/nova/service.py:154 2011-07-25 21:34:30,501 DEBUG nova.rpc [-] Initing the Adapter Consumer for volume from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:34:30,501 DEBUG nova.fakerabbit [-] Declaring queue volume from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:34:30,501 DEBUG nova.fakerabbit [-] Binding volume to nova with key volume from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:34:30,502 DEBUG nova.rpc [-] Initing the Adapter Consumer for volume.dd921716bf174469a454ff6d57ee8af4 from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:34:30,502 DEBUG nova.fakerabbit [-] Declaring queue volume.dd921716bf174469a454ff6d57ee8af4 from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:34:30,502 DEBUG nova.fakerabbit [-] Binding volume.dd921716bf174469a454ff6d57ee8af4 to nova with key volume.dd921716bf174469a454ff6d57ee8af4 from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:34:30,502 INFO nova.rpc [-] Created "volume_fanout" fanout exchange with "volume" routing key 2011-07-25 21:34:30,503 DEBUG nova.rpc [-] Initing the Adapter Consumer for volume from (pid=19173) __init__ /tmp/tmpFvibRA/nova/rpc.py:182 2011-07-25 21:34:30,503 DEBUG nova.fakerabbit [-] Declaring queue volume_fanout_c2cda1ebd10f4b1f893de876280f8b0c from (pid=19173) queue_declare /tmp/tmpFvibRA/nova/fakerabbit.py:84 2011-07-25 21:34:30,503 DEBUG nova.fakerabbit [-] Declaring exchange volume_fanout from (pid=19173) exchange_declare /tmp/tmpFvibRA/nova/fakerabbit.py:90 2011-07-25 21:34:30,503 DEBUG nova.fakerabbit [-] Binding volume_fanout_c2cda1ebd10f4b1f893de876280f8b0c to volume_fanout with key volume from (pid=19173) queue_bind /tmp/tmpFvibRA/nova/fakerabbit.py:97 2011-07-25 21:34:30,504 AUDIT nova.auth.manager [-] Created user admin (admin: True) 2011-07-25 21:34:30,506 DEBUG nova.ldapdriver [-] Local cache hit for __project_to_dn by key pid_dn-proj from (pid=19173) inner /tmp/tmpFvibRA/nova/auth/ldapdriver.py:188 2011-07-25 21:34:30,506 DEBUG nova.ldapdriver [-] Local cache hit for __dn_to_uid by key dn_uid-uid=admin,ou=Users,dc=example,dc=com from (pid=19173) inner /tmp/tmpFvibRA/nova/auth/ldapdriver.py:188 2011-07-25 21:34:30,506 AUDIT nova.auth.manager [-] Created project proj with manager admin --------------------- >> end captured logging << --------------------- test_update_of_volume_display_fields OK 0.22 test_update_of_volume_wont_update_private_fields OK 0.21 ComputeTestCase test_agent_update OK 0.95 test_ajax_console OK 1.40 test_console_output OK 0.88 test_create_instance_associates_security_groups OK 0.28 test_create_instance_defaults_display_name OK 0.48 test_default_hostname_generator OK 1.27 test_destroy_instance_disassociates_security_groups OK 0.28 test_destroy_security_group_disassociates_instances OK 0.28 test_finish_resize OK 0.73 test_finish_revert_resize OK 2.53 test_get_by_flavor_id OK 0.03 test_inject_file OK 1.42 test_live_migration_dest_raises_exception OK 0.02 test_live_migration_dest_raises_exception_no_volume OK 0.02 test_live_migration_works_correctly_no_volume OK 0.02 test_live_migration_works_correctly_with_volume OK 0.02 test_lock OK 1.92 test_migrate OK 0.97 test_pause OK 1.69 test_post_live_migration_working_correctly OK 0.53 test_pre_live_migration_instance_has_no_fixed_ip OK 0.02 test_pre_live_migration_instance_has_no_volume OK 0.02 test_pre_live_migration_instance_has_volume OK 0.02 test_pre_live_migration_setup_compute_node_fail OK 0.02 test_reboot OK 1.79 test_resize_down_fails OK 0.98 test_resize_instance OK 1.78 test_resize_instance_notification OK 1.13 test_resize_invalid_flavor_fails OK 1.39 test_resize_same_size_fails OK 0.91 test_resize_same_source_fails OK 1.45 test_run_instance_existing OK 0.91 test_run_instance_usage_notification OK 1.29 test_run_kill_vm OK 0.86 test_run_terminate OK 0.89 test_run_terminate_timestamps OK 1.53 test_set_admin_password OK 2.14 test_snapshot OK 1.69 test_start OK 2.24 test_stop OK 1.07 test_suspend OK 1.81 test_terminate_usage_notification OK 0.92 test_update_block_device_mapping OK 0.47 test_vnc_console OK 1.46 ConsoleTestCase test_add_console OK 0.19 test_add_console_does_not_duplicate OK 0.19 test_get_pool_creates_new_pool_if_needed OK 0.06 test_get_pool_does_not_create_new_pool_if_exists OK 0.03 test_get_pool_for_instance_host OK 0.03 test_remove_console OK 0.14 RevokeCertsTest test_revoke_certs_by_project OK 0.00 test_revoke_certs_by_user OK 0.00 test_revoke_certs_by_user_and_project OK 0.00 SymmetricKeyTestCase test_encrypt_decrypt OK 0.00 DirectTestCase test_delegated_auth OK 0.01 test_invalid OK 0.01 test_json_params OK 0.01 test_post_params OK 0.01 test_proxy OK 0.01 ApiErrorTestCase test_return_valid_error OK 0.00 WrapExceptionTestCase test_wrap_exception_good_return OK 0.00 test_wrap_exception_throws_error OK 0.00 test_wrap_exception_throws_exception OK 0.00 test_wrap_exception_with_notifier OK 0.00 test_wrap_exception_with_notifier_defaults OK 0.00 FlagsTestCase test_declare OK 0.01 test_define OK 0.01 test_flag_leak_left OK 0.00 test_flag_leak_right OK 0.00 test_long_vs_short_flags OK 0.02 test_runtime_and_unknown_flags OK 0.02 HostFilterTestCase test_all_host_filter OK 0.00 test_choose_filter OK 0.00 test_instance_type_filter OK 0.00 test_json_filter OK 0.00 HostTestCase test_bad_host OK 0.00 test_bad_status_value OK 0.00 test_bad_update_key OK 0.00 test_disable_host OK 0.00 test_enable_host OK 0.00 test_list_hosts OK 0.00 InstanceTypeTestCase test_get_all_instance_types OK 0.02 test_instance_type_create_then_delete OK 0.08 test_invalid_create_args_should_fail OK 0.01 test_non_existant_inst_type_shouldnt_delete OK 0.02 test_repeated_inst_types_should_raise_api_error OK 0.03 InstanceTypeExtraSpecsTestCase test_instance_type_extra_specs_create OK 0.03 test_instance_type_extra_specs_delete OK 0.03 test_instance_type_extra_specs_update OK 0.03 test_instance_type_get_all OK 0.03 test_instance_type_get_by_name_with_extra_specs OK 0.04 test_instance_type_get_with_extra_specs OK 0.04 test_instance_type_specs_get OK 0.02 IptablesManagerTestCase test_filter_rules OK 0.00 test_filter_rules_are_wrapped OK 0.00 test_nat_rules OK 0.00 IPv6AccountIdentiferTestCase test_to_global OK 0.00 test_to_mac OK 0.00 IPv6RFC2462TestCase test_to_global OK 0.00 test_to_mac OK 0.00 CacheConcurrencyTestCase test_different_fname_concurrency OK 0.01 test_same_fname_concurrency OK 0.00 IptablesFirewallTestCase test_do_refresh_security_group_rules SKIP: skipping libvirt tests -------------------- >> begin captured logging << -------------------- 2011-07-25 21:35:14,758 AUDIT nova.auth.manager [-] Created user fake (admin: True) 2011-07-25 21:35:14,760 DEBUG nova.ldapdriver [-] Local cache hit for __project_to_dn by key pid_dn-fake from (pid=19173) inner /tmp/tmpFvibRA/nova/auth/ldapdriver.py:188 2011-07-25 21:35:14,761 DEBUG nova.ldapdriver [-] Local cache hit for __dn_to_uid by key dn_uid-uid=fake,ou=Users,dc=example,dc=com from (pid=19173) inner /tmp/tmpFvibRA/nova/auth/ldapdriver.py:188 2011-07-25 21:35:14,761 AUDIT nova.auth.manager [-] Created project fake with manager fake --------------------- >> end captured logging << --------------------- test_filters_for_instance_with_ip_v6 OK 0.02 test_filters_for_instance_without_ip_v6 OK 0.02 test_multinic_iptables OK 0.04 test_provider_firewall_rules SKIP: skip libvirt test project_get_network no longer exists -------------------- >> begin captured logging << -------------------- 2011-07-25 21:35:14,850 AUDIT nova.auth.manager [-] Created user fake (admin: True) 2011-07-25 21:35:14,851 DEBUG nova.ldapdriver [-] Local cache hit for __project_to_dn by key pid_dn-fake from (pid=19173) inner /tmp/tmpFvibRA/nova/auth/ldapdriver.py:188 2011-07-25 21:35:14,852 DEBUG nova.ldapdriver [-] Local cache hit for __dn_to_uid by key dn_uid-uid=fake,ou=Users,dc=example,dc=com from (pid=19173) inner /tmp/tmpFvibRA/nova/auth/ldapdriver.py:188 2011-07-25 21:35:14,852 AUDIT nova.auth.manager [-] Created project fake with manager fake --------------------- >> end captured logging << --------------------- test_static_filters SKIP: skipping libvirt tests depends on get_network_info shim -------------------- >> begin captured logging << -------------------- 2011-07-25 21:35:14,866 AUDIT nova.auth.manager [-] Created user fake (admin: True) 2011-07-25 21:35:14,867 DEBUG nova.ldapdriver [-] Local cache hit for __project_to_dn by key pid_dn-fake from (pid=19173) inner /tmp/tmpFvibRA/nova/auth/ldapdriver.py:188 2011-07-25 21:35:14,868 DEBUG nova.ldapdriver [-] Local cache hit for __dn_to_uid by key dn_uid-uid=fake,ou=Users,dc=example,dc=com from (pid=19173) inner /tmp/tmpFvibRA/nova/auth/ldapdriver.py:188 2011-07-25 21:35:14,868 AUDIT nova.auth.manager [-] Created project fake with manager fake --------------------- >> end captured logging << --------------------- test_unfilter_instance_undefines_nwfilter SKIP: skip libvirt test project_get_network no longer exists -------------------- >> begin captured logging << -------------------- 2011-07-25 21:35:14,882 AUDIT nova.auth.manager [-] Created user fake (admin: True) 2011-07-25 21:35:14,883 DEBUG nova.ldapdriver [-] Local cache hit for __project_to_dn by key pid_dn-fake from (pid=19173) inner /tmp/tmpFvibRA/nova/auth/ldapdriver.py:188 2011-07-25 21:35:14,883 DEBUG nova.ldapdriver [-] Local cache hit for __dn_to_uid by key dn_uid-uid=fake,ou=Users,dc=example,dc=com from (pid=19173) inner /tmp/tmpFvibRA/nova/auth/ldapdriver.py:188 2011-07-25 21:35:14,884 AUDIT nova.auth.manager [-] Created project fake with manager fake --------------------- >> end captured logging << --------------------- LibvirtConnTestCase test_ensure_filtering_rules_for_instance_timeout OK 0.06 test_get_host_ip_addr OK 0.01 test_get_nic_for_xml_v4 OK 0.02 test_get_nic_for_xml_v6 OK 0.02 test_live_migration_raises_exception OK 0.01 test_lxc_container_and_uri SKIP: skipping libvirt tests depends on get_network_info shim -------------------- >> begin captured logging << -------------------- 2011-07-25 21:35:15,017 AUDIT nova.auth.manager [-] Created user fake (admin: True) 2011-07-25 21:35:15,018 DEBUG nova.ldapdriver [-] Local cache hit for __project_to_dn by key pid_dn-fake from (pid=19173) inner /tmp/tmpFvibRA/nova/auth/ldapdriver.py:188 2011-07-25 21:35:15,019 DEBUG nova.ldapdriver [-] Local cache hit for __dn_to_uid by key dn_uid-uid=fake,ou=Users,dc=example,dc=com from (pid=19173) inner /tmp/tmpFvibRA/nova/auth/ldapdriver.py:188 2011-07-25 21:35:15,019 AUDIT nova.auth.manager [-] Created project fake with manager fake --------------------- >> end captured logging << --------------------- test_multi_nic OK 0.10 test_preparing_xml_info SKIP: Please review this test to ensure intent -------------------- >> begin captured logging << -------------------- 2011-07-25 21:35:15,137 AUDIT nova.auth.manager [-] Created user fake (admin: True) 2011-07-25 21:35:15,138 DEBUG nova.ldapdriver [-] Local cache hit for __project_to_dn by key pid_dn-fake from (pid=19173) inner /tmp/tmpFvibRA/nova/auth/ldapdriver.py:188 2011-07-25 21:35:15,139 DEBUG nova.ldapdriver [-] Local cache hit for __dn_to_uid by key dn_uid-uid=fake,ou=Users,dc=example,dc=com from (pid=19173) inner /tmp/tmpFvibRA/nova/auth/ldapdriver.py:188 2011-07-25 21:35:15,139 AUDIT nova.auth.manager [-] Created project fake with manager fake --------------------- >> end captured logging << --------------------- test_snapshot OK 0.02 test_snapshot_no_image_architecture OK 0.02 test_spawn_with_network_info SKIP: test needs rewrite: instance no longer has mac_address -------------------- >> begin captured logging << -------------------- 2011-07-25 21:35:15,186 AUDIT nova.auth.manager [-] Created user fake (admin: True) 2011-07-25 21:35:15,187 DEBUG nova.ldapdriver [-] Local cache hit for __project_to_dn by key pid_dn-fake from (pid=19173) inner /tmp/tmpFvibRA/nova/auth/ldapdriver.py:188 2011-07-25 21:35:15,188 DEBUG nova.ldapdriver [-] Local cache hit for __dn_to_uid by key dn_uid-uid=fake,ou=Users,dc=example,dc=com from (pid=19173) inner /tmp/tmpFvibRA/nova/auth/ldapdriver.py:188 2011-07-25 21:35:15,188 AUDIT nova.auth.manager [-] Created project fake with manager fake --------------------- >> end captured logging << --------------------- test_update_available_resource_works_correctly OK 0.07 test_update_resource_info_no_compute_record_found OK 0.02 test_xml_and_uri SKIP: skipping libvirt tests depends on get_network_info shim -------------------- >> begin captured logging << -------------------- 2011-07-25 21:35:15,296 AUDIT nova.auth.manager [-] Created user fake (admin: True) 2011-07-25 21:35:15,297 DEBUG nova.ldapdriver [-] Local cache hit for __project_to_dn by key pid_dn-fake from (pid=19173) inner /tmp/tmpFvibRA/nova/auth/ldapdriver.py:188 2011-07-25 21:35:15,297 DEBUG nova.ldapdriver [-] Local cache hit for __dn_to_uid by key dn_uid-uid=fake,ou=Users,dc=example,dc=com from (pid=19173) inner /tmp/tmpFvibRA/nova/auth/ldapdriver.py:188 2011-07-25 21:35:15,298 AUDIT nova.auth.manager [-] Created project fake with manager fake --------------------- >> end captured logging << --------------------- test_xml_and_uri_no_kernel SKIP: skipping libvirt tests depends on get_network_info shim -------------------- >> begin captured logging << -------------------- 2011-07-25 21:35:15,310 AUDIT nova.auth.manager [-] Created user fake (admin: True) 2011-07-25 21:35:15,311 DEBUG nova.ldapdriver [-] Local cache hit for __project_to_dn by key pid_dn-fake from (pid=19173) inner /tmp/tmpFvibRA/nova/auth/ldapdriver.py:188 2011-07-25 21:35:15,312 DEBUG nova.ldapdriver [-] Local cache hit for __dn_to_uid by key dn_uid-uid=fake,ou=Users,dc=example,dc=com from (pid=19173) inner /tmp/tmpFvibRA/nova/auth/ldapdriver.py:188 2011-07-25 21:35:15,312 AUDIT nova.auth.manager [-] Created project fake with manager fake --------------------- >> end captured logging << --------------------- test_xml_and_uri_no_ramdisk SKIP: skipping libvirt tests depends on get_network_info shim -------------------- >> begin captured logging << -------------------- 2011-07-25 21:35:15,327 AUDIT nova.auth.manager [-] Created user fake (admin: True) 2011-07-25 21:35:15,328 DEBUG nova.ldapdriver [-] Local cache hit for __project_to_dn by key pid_dn-fake from (pid=19173) inner /tmp/tmpFvibRA/nova/auth/ldapdriver.py:188 2011-07-25 21:35:15,328 DEBUG nova.ldapdriver [-] Local cache hit for __dn_to_uid by key dn_uid-uid=fake,ou=Users,dc=example,dc=com from (pid=19173) inner /tmp/tmpFvibRA/nova/auth/ldapdriver.py:188 2011-07-25 21:35:15,329 AUDIT nova.auth.manager [-] Created project fake with manager fake --------------------- >> end captured logging << --------------------- test_xml_and_uri_no_ramdisk_no_kernel SKIP: skipping libvirt tests depends on get_network_info shim -------------------- >> begin captured logging << -------------------- 2011-07-25 21:35:15,342 AUDIT nova.auth.manager [-] Created user fake (admin: True) 2011-07-25 21:35:15,344 DEBUG nova.ldapdriver [-] Local cache hit for __project_to_dn by key pid_dn-fake from (pid=19173) inner /tmp/tmpFvibRA/nova/auth/ldapdriver.py:188 2011-07-25 21:35:15,344 DEBUG nova.ldapdriver [-] Local cache hit for __dn_to_uid by key dn_uid-uid=fake,ou=Users,dc=example,dc=com from (pid=19173) inner /tmp/tmpFvibRA/nova/auth/ldapdriver.py:188 2011-07-25 21:35:15,344 AUDIT nova.auth.manager [-] Created project fake with manager fake --------------------- >> end captured logging << --------------------- test_xml_and_uri_rescue SKIP: skipping libvirt tests depends on get_network_info shim -------------------- >> begin captured logging << -------------------- 2011-07-25 21:35:15,359 AUDIT nova.auth.manager [-] Created user fake (admin: True) 2011-07-25 21:35:15,360 DEBUG nova.ldapdriver [-] Local cache hit for __project_to_dn by key pid_dn-fake from (pid=19173) inner /tmp/tmpFvibRA/nova/auth/ldapdriver.py:188 2011-07-25 21:35:15,361 DEBUG nova.ldapdriver [-] Local cache hit for __dn_to_uid by key dn_uid-uid=fake,ou=Users,dc=example,dc=com from (pid=19173) inner /tmp/tmpFvibRA/nova/auth/ldapdriver.py:188 2011-07-25 21:35:15,361 AUDIT nova.auth.manager [-] Created project fake with manager fake --------------------- >> end captured logging << --------------------- NWFilterTestCase test_cidr_rule_nwfilter_xml OK 0.24 test_create_network_filters OK 0.02 test_creates_base_rule_first SKIP: Skipping this test -------------------- >> begin captured logging << -------------------- 2011-07-25 21:35:15,642 AUDIT nova.auth.manager [-] Created user fake (admin: True) 2011-07-25 21:35:15,644 DEBUG nova.ldapdriver [-] Local cache hit for __project_to_dn by key pid_dn-fake from (pid=19173) inner /tmp/tmpFvibRA/nova/auth/ldapdriver.py:188 2011-07-25 21:35:15,644 DEBUG nova.ldapdriver [-] Local cache hit for __dn_to_uid by key dn_uid-uid=fake,ou=Users,dc=example,dc=com from (pid=19173) inner /tmp/tmpFvibRA/nova/auth/ldapdriver.py:188 2011-07-25 21:35:15,645 AUDIT nova.auth.manager [-] Created project fake with manager fake --------------------- >> end captured logging << --------------------- test_unfilter_instance_undefines_nwfilters SKIP: skip libvirt test project_get_network no longer exists -------------------- >> begin captured logging << -------------------- 2011-07-25 21:35:15,658 AUDIT nova.auth.manager [-] Created user fake (admin: True) 2011-07-25 21:35:15,660 DEBUG nova.ldapdriver [-] Local cache hit for __project_to_dn by key pid_dn-fake from (pid=19173) inner /tmp/tmpFvibRA/nova/auth/ldapdriver.py:188 2011-07-25 21:35:15,660 DEBUG nova.ldapdriver [-] Local cache hit for __dn_to_uid by key dn_uid-uid=fake,ou=Users,dc=example,dc=com from (pid=19173) inner /tmp/tmpFvibRA/nova/auth/ldapdriver.py:188 2011-07-25 21:35:15,661 AUDIT nova.auth.manager [-] Created project fake with manager fake --------------------- >> end captured logging << --------------------- LocalizationTestCase test_multiple_positional_format_placeholders OK 0.16 LogHandlerTestCase test_log_path_logdir OK 0.00 test_log_path_logfile OK 0.00 test_log_path_logfile_overrides_logdir OK 0.00 test_log_path_none OK 0.00 NovaFormatterTestCase test_contextualized_log OK 0.00 test_debugging_log OK 0.00 test_uncontextualized_log OK 0.00 NovaLoggerTestCase test_child_log_has_level_of_parent_flag OK 0.00 test_has_level_from_flags OK 0.00 RootLoggerTestCase test_handlers_have_nova_formatter OK 0.00 test_handles_context_kwarg OK 0.00 test_is_nova_instance OK 0.00 test_module_level_audit_handles_context_arg OK 0.00 test_module_level_methods_handle_context_arg OK 0.00 test_name_is_nova OK 0.00 test_will_be_verbose_if_verbose_flag_set OK 0.01 test_will_not_be_verbose_if_verbose_flag_not_set OK 0.01 MetadataTestCase test_base OK 0.05 test_security_groups OK 0.53 test_user_data OK 0.05 LockoutTestCase test_lockout OK 0.01 test_multiple_keys OK 0.01 test_timeout OK 0.01 test_window_timeout OK 0.01 ExceptionTestCase test_exceptions_raise OK 0.00 LockTestCase test_synchronized_externally OK 1.08 test_synchronized_internally OK 0.02 test_synchronized_wrapped_function_metadata OK 0.00 ProjectTestCase test_authors_up_to_date OK 4.70 CommonNetworkTestCase test_remove_fixed_ip_from_instance OK 0.00 test_remove_fixed_ip_from_instance_bad_input OK 0.00 FlatNetworkTestCase test_get_instance_nw_info OK 0.01 VlanNetworkTestCase test_allocate_fixed_ip OK 0.01 test_create_networks_too_big OK 0.00 test_create_networks_too_many OK 0.00 test_vpn_allocate_fixed_ip OK 0.01 NotifierTestCase test_error_notification OK 0.00 test_invalid_priority OK 0.00 test_rabbit_priority_queue OK 0.00 test_send_notification OK 0.00 test_send_rabbit_notification OK 0.00 test_verify_message_format OK 0.00 S3APITestCase test_000_list_buckets OK 0.03 test_001_create_and_delete_bucket OK 0.04 test_002_create_bucket_and_key_and_delete_key_again OK 0.04 test_unknown_bucket OK 0.02 QuotaTestCase test_allowed_injected_file_path_bytes OK 0.07 test_default_allowed_injected_file_content_bytes OK 0.08 test_default_allowed_injected_files OK 0.09 test_max_injected_file_content_bytes OK 0.34 test_max_injected_file_path_bytes OK 0.33 test_max_injected_files OK 0.33 test_no_injected_files OK 0.31 test_overridden_allowed_injected_file_content_bytes OK 0.09 test_overridden_allowed_injected_files OK 0.09 test_quota_overrides OK 0.13 test_too_many_cores OK 0.10 test_too_many_gigabytes OK 0.09 test_too_many_injected_file_content_bytes OK 0.62 test_too_many_injected_file_path_bytes OK 0.10 test_too_many_injected_files OK 0.10 test_too_many_instances OK 0.12 test_too_many_metadata_items OK 0.10 test_too_many_volumes OK 0.11 test_unlimited_cores OK 0.10 test_unlimited_db_allowed_injected_file_content_bytes OK 0.08 test_unlimited_db_allowed_injected_files OK 0.09 test_unlimited_default_allowed_injected_file_content_bytes OK 0.08 test_unlimited_default_allowed_injected_files OK 0.08 test_unlimited_floating_ips OK 0.10 test_unlimited_gigabytes OK 0.10 test_unlimited_instances OK 0.10 test_unlimited_metadata_items OK 0.09 test_unlimited_ram OK 0.10 test_unlimited_volumes OK 0.10 RpcTestCase test_call_exception OK 0.15 test_call_succeed OK 0.04 test_call_succeed_despite_multiple_returns OK 0.07 test_call_succeed_despite_multiple_returns_yield OK 0.07 test_connectionpool_double OK 0.00 test_connectionpool_limit OK 0.01 test_connectionpool_single OK 0.01 test_context_passed OK 0.05 test_multicall_succeed_once OK 0.04 test_multicall_succeed_three_times OK 0.07 test_multicall_succeed_three_times_yield OK 0.07 test_nested_calls OK 0.18 ServiceFlagsTestCase test_service_disabled_on_create_based_on_flag OK 0.04 test_service_enabled_on_create_based_on_flag OK 0.04 ServiceManagerTestCase test_message_gets_to_manager OK 0.02 test_override_manager_method OK 0.02 ServiceTestCase test_compute_can_update_available_resource OK 0.03 test_create OK 0.01 test_report_state_newly_connected OK 0.01 test_report_state_newly_disconnected OK 0.01 test_report_state_no_service OK 0.01 TestLauncher test_launch_app OK 0.09 TestWSGIService test_service_random_port OK 0.01 IsolationTestCase test_rpc_consumer_isolation OK 0.01 test_service_isolation OK 0.05 TwistdTestCase test_basic OK 0.07 test_help OK 0.03 test_logfile OK 0.01 ExecuteTestCase test_no_retry_on_success OK 0.11 test_retry_on_failure OK 1.15 test_unknown_kwargs_raises_error OK 0.00 GenericUtilsTestCase test_bool_from_str OK 0.00 test_parse_server_string OK 0.00 GetFromPathTestCase test_accepts_dictionaries OK 0.00 test_bad_xpath OK 0.00 test_does_select OK 0.00 test_flattens_lists OK 0.00 test_real_failure1 OK 0.00 test_tolerates_nones OK 0.00 IsUUIDLikeTestCase test_good_uuid OK 0.00 test_integer_passed OK 0.00 test_non_uuid_string_passed OK 0.00 VMWareAPIVMTestCase test_destroy SKIP: DB stubbing not removed, needs updating for multi-nic test_destroy_non_existent SKIP: DB stubbing not removed, needs updating for multi-nic test_diagnostics SKIP: DB stubbing not removed, needs updating for multi-nic test_get_ajax_console SKIP: DB stubbing not removed, needs updating for multi-nic test_get_console_output SKIP: DB stubbing not removed, needs updating for multi-nic test_get_info SKIP: DB stubbing not removed, needs updating for multi-nic test_list_instances SKIP: DB stubbing not removed, needs updating for multi-nic test_list_instances_1 SKIP: DB stubbing not removed, needs updating for multi-nic test_pause SKIP: DB stubbing not removed, needs updating for multi-nic test_reboot SKIP: DB stubbing not removed, needs updating for multi-nic test_reboot_non_existent SKIP: DB stubbing not removed, needs updating for multi-nic test_reboot_not_poweredon SKIP: DB stubbing not removed, needs updating for multi-nic test_resume SKIP: DB stubbing not removed, needs updating for multi-nic test_resume_non_existent SKIP: DB stubbing not removed, needs updating for multi-nic test_resume_not_suspended SKIP: DB stubbing not removed, needs updating for multi-nic test_snapshot SKIP: DB stubbing not removed, needs updating for multi-nic test_snapshot_non_existent SKIP: DB stubbing not removed, needs updating for multi-nic test_spawn SKIP: DB stubbing not removed, needs updating for multi-nic test_suspend SKIP: DB stubbing not removed, needs updating for multi-nic test_suspend_non_existent SKIP: DB stubbing not removed, needs updating for multi-nic test_unpause SKIP: DB stubbing not removed, needs updating for multi-nic AOETestCase test_check_for_export_with_all_vblade_processes OK 7.84 test_check_for_export_with_no_volume OK 0.07 test_check_for_export_with_vblade_process_missing OK 6.84 ISCSITestCase test_check_for_export_with_all_volume_exported OK 1.43 test_check_for_export_with_no_volume OK 0.08 test_check_for_export_with_some_volume_missing OK 0.80 VolumeTestCase test_concurrent_volumes_get_different_targets OK 0.97 test_create_delete_snapshot OK 0.19 test_create_delete_volume OK 0.18 test_create_snapshot_force OK 0.25 test_create_volume_from_snapshot OK 0.90 test_multi_node OK 0.02 test_run_attach_detach_volume OK 0.37 test_too_big_volume OK 0.02 test_too_many_volumes OK 1.01 TestLoaderNormalFilesystem test_app_found OK 0.02 test_app_not_found OK 0.00 test_config_found OK 0.00 TestLoaderNothingExists test_config_not_found OK 0.00 TestWSGIServer test_no_app OK 0.00 test_start_random_port OK 0.00 CompareVersionTestCase test_equal OK 0.00 test_greater_than OK 0.00 test_length OK 0.00 test_less_than OK 0.00 test_non_lexical OK 0.00 HostStateTestCase test_host_state OK 0.00 XenAPIDetermineDiskImageTestCase test_glance_disk_raw OK 0.00 test_glance_disk_vhd OK 0.00 test_instance_disk OK 0.00 test_instance_disk_raw OK 0.01 XenAPIDiffieHellmanTestCase test_encrypt_many_newlines_at_end OK 0.24 test_encrypt_message_with_newlines_at_end OK 0.22 test_encrypt_newlines_inside_message OK 0.23 test_encrypt_really_long_message OK 0.22 test_encrypt_simple_message OK 0.22 test_encrypt_with_leading_newlines OK 0.23 test_shared OK 0.01 XenAPIMigrateInstance test_finish_resize OK 0.83 test_migrate_disk_and_power_off OK 0.04 XenAPIVMTestCase test_get_diagnostics OK 0.28 test_instance_snapshot OK 0.27 test_instance_snapshot_fails_with_no_primary_vdi OK 0.21 test_list_instances_0 OK 0.02 test_parallel_builds OK 3.51 test_rescue OK 0.25 test_spawn_fail_cleanup_1 OK 0.04 test_spawn_fail_cleanup_2 OK 0.22 test_spawn_glance OK 0.38 test_spawn_netinject_file OK 0.37 test_spawn_netinject_xenstore OK 0.33 test_spawn_not_enough_memory OK 0.12 test_spawn_objectstore OK 0.97 test_spawn_raw_glance OK 0.23 test_spawn_raw_objectstore OK 0.28 test_spawn_vhd_glance_linux OK 0.28 test_spawn_vhd_glance_swapdisk OK 0.57 test_spawn_vhd_glance_windows OK 0.52 test_spawn_vlanmanager SKIP: Never gets an address, not sure why -------------------- >> begin captured logging << -------------------- 2011-07-25 21:36:01,604 AUDIT nova.auth.manager [-] Created user fake (admin: True) 2011-07-25 21:36:01,606 DEBUG nova.ldapdriver [-] Local cache hit for __project_to_dn by key pid_dn-fake from (pid=19173) inner /tmp/tmpFvibRA/nova/auth/ldapdriver.py:188 2011-07-25 21:36:01,607 DEBUG nova.ldapdriver [-] Local cache hit for __dn_to_uid by key dn_uid-uid=fake,ou=Users,dc=example,dc=com from (pid=19173) inner /tmp/tmpFvibRA/nova/auth/ldapdriver.py:188 2011-07-25 21:36:01,607 AUDIT nova.auth.manager [-] Created project fake with manager fake --------------------- >> end captured logging << --------------------- test_spawn_with_network_qos OK 0.25 test_unrescue OK 0.26 XenAPIVolumeTestCase test_attach_volume OK 0.04 test_attach_volume_raise_exception OK 0.03 test_create_iscsi_storage OK 0.02 test_parse_volume_info_raise_exception OK 0.02 ZoneManagerTestCase test_delete_expired_host_services_del_all_hosts OK 0.01 test_delete_expired_host_services_del_one_service OK 0.00 test_delete_expired_host_services_del_one_service_per_host OK 0.00 test_get_zone_capabilities_all_stale_host_services OK 0.01 test_get_zone_capabilities_expired_host OK 0.00 test_get_zone_capabilities_multiple_hosts OK 0.00 test_get_zone_capabilities_multiple_service_per_host OK 0.01 test_get_zone_capabilities_one_host OK 0.00 test_get_zone_capabilities_one_stale_host OK 0.00 test_get_zone_capabilities_one_stale_service_per_host OK 0.01 test_get_zone_capabilities_three_stale_host_services OK 0.01 test_host_service_caps_stale_all_stale_services OK 0.00 test_host_service_caps_stale_no_stale_service OK 0.00 test_host_service_caps_stale_one_stale_service OK 0.00 test_ping OK 0.00 test_poll_zone OK 0.00 test_poll_zone_fails OK 0.01 test_refresh_from_db_add_and_delete OK 0.00 test_refresh_from_db_missing OK 0.00 test_refresh_from_db_new OK 0.00 test_refresh_from_db_replace_existing OK 0.01 test_service_capabilities OK 0.01 ====================================================================== ERROR: test_get_server_by_id_with_addresses_v1_1 (nova.tests.api.openstack.test_servers.ServersTest) ---------------------------------------------------------------------- Traceback (most recent call last): File "/tmp/tmpFvibRA/nova/tests/api/openstack/test_servers.py", line 709, in test_get_server_by_id_with_addresses_v1_1 new_return_server = return_server_with_interfaces(interfaces) NameError: global name 'return_server_with_interfaces' is not defined ---------------------------------------------------------------------- Ran 1077 tests in 238.619s FAILED (SKIP=44, errors=1) Slowest 5 tests took 34.70 secs: 8.59 test_too_many_cores (nova.tests.scheduler.test_scheduler.SimpleDriverTestCase) 7.84 test_check_for_export_with_all_vblade_processes (nova.tests.test_volume.AOETestCase) 6.84 test_check_for_export_with_vblade_process_missing (nova.tests.test_volume.AOETestCase) 5.82 test_attach_and_detach_volume (nova.tests.integrated.test_volumes.VolumesTest) 5.60 test_create_image (nova.tests.test_cloud.CloudTestCase)