The attempt to merge lp:~blamar/nova/libvirt-cleanup-branch into lp:nova failed. Below is the output from the failed tests. FloatingIpTest test_floating_ip_allocate OK 0.29 test_floating_ip_associate OK 0.10 test_floating_ip_disassociate OK 0.10 test_floating_ip_release OK 0.10 test_floating_ip_show OK 0.10 test_floating_ips_list OK 0.09 test_translate_floating_ip_view OK 0.04 FixedIpTest test_add_fixed_ip OK 0.08 test_add_fixed_ip_no_network OK 0.08 test_remove_fixed_ip OK 0.28 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.39 test_account_delete OK 0.17 test_account_update OK 0.18 test_get_account OK 0.18 AdminAPITest test_admin_disabled OK 0.14 test_admin_enabled OK 0.47 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.10 test_authorize_user OK 0.06 test_bad_project OK 0.35 test_bad_token OK 0.06 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.06 test_token_expiry OK 0.37 TestLimiter test_authorize_token OK 0.10 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.00 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_remove_version_from_href OK 0.00 test_remove_version_from_href_2 OK 0.00 test_remove_version_from_href_3 OK 0.00 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.00 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.02 test_valid_marker OK 0.00 ActionExtensionTest test_extended_action OK 0.16 test_invalid_action OK 0.11 test_invalid_action_body OK 0.16 ExtensionControllerTest test_get_by_alias OK 0.10 test_index OK 0.06 ExtensionManagerTest test_get_resources OK 0.35 test_invalid_extensions OK 0.05 RequestExtensionTest test_get_resources_with_mgr OK 0.20 test_get_resources_with_stub_mgr OK 0.20 ResourceExtensionTest test_get_resources OK 0.03 test_get_resources_with_controller OK 0.02 test_no_extension_present OK 0.07 TestFaults test_400_fault_json OK 0.00 test_400_fault_xml OK 0.00 test_413_fault_json OK 0.01 test_413_fault_xml OK 0.00 test_raise OK 0.00 FlavorsTest test_get_empty_flavor_list_v1_0 OK 0.12 test_get_empty_flavor_list_v1_1 OK 0.48 test_get_flavor_by_id_v1_0 OK 0.13 test_get_flavor_by_id_v1_1 OK 0.19 test_get_flavor_by_invalid_id OK 0.13 test_get_flavor_list_detail_v1_0 OK 0.08 test_get_flavor_list_detail_v1_1 OK 0.18 test_get_flavor_list_v1_0 OK 0.13 test_get_flavor_list_v1_1 OK 0.49 ImageMetaDataTest test_create OK 0.19 test_delete OK 0.19 test_delete_not_found OK 0.19 test_index OK 0.19 test_show OK 0.51 test_show_not_found OK 0.19 test_too_many_metadata_items_on_create OK 0.20 test_too_many_metadata_items_on_put OK 0.19 test_update_item OK 0.19 test_update_item_bad_body OK 0.19 test_update_item_body_uri_mismatch OK 0.48 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.01 test_create_with_instance_id OK 0.01 test_create_without_instance_id OK 0.01 test_delete OK 0.01 test_detail_limit OK 0.02 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.01 test_index_limit OK 0.01 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.13 test_create_backup_no_rotation OK 0.17 test_create_backup_with_rotation_and_backup_type OK 0.49 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.20 test_create_image_v1_1_actual_server_ref_port OK 0.51 test_create_image_v1_1_no_server_ref OK 0.18 test_create_image_v1_1_server_ref_bad_hostname OK 0.18 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.17 test_create_snapshot_no_name OK 0.42 test_get_image OK 0.08 test_get_image_404_json OK 0.08 test_get_image_404_v1_1_json OK 0.18 test_get_image_404_v1_1_xml OK 0.18 test_get_image_404_xml OK 0.12 test_get_image_details OK 0.37 test_get_image_details_v1_1 OK 0.20 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.08 test_get_image_v1_1 OK 0.50 test_get_image_xml OK 0.13 test_get_image_xml_no_name OK 0.08 test_image_detail_filter_not_supported 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.00 test_image_detail_no_filters OK 0.00 test_image_filter_not_supported 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_no_filters OK 0.00 ImageXMLSerializationTest test_create OK 0.01 test_detail OK 0.01 test_index OK 0.01 test_index_zero_images OK 0.00 test_show OK 0.01 test_show_image_no_metadata_key OK 0.01 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.00 test_index_absolute_instances_json OK 0.01 test_index_absolute_metadata_json OK 0.01 test_index_absolute_ram_json OK 0.01 test_index_diff_regex OK 0.01 test_index_ignores_extra_absolute_limits_json OK 0.00 test_index_json OK 0.01 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.19 test_create_empty_body OK 0.19 test_create_nonexistant_server OK 0.48 test_delete OK 0.19 test_delete_nonexistant_server OK 0.18 test_index OK 0.19 test_index_no_data OK 0.18 test_index_nonexistant_server OK 0.18 test_show OK 0.51 test_show_meta_not_found OK 0.19 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.19 test_update_item OK 0.47 test_update_item_body_uri_mismatch OK 0.18 test_update_item_empty_body OK 0.17 test_update_item_nonexistant_server OK 0.18 test_update_item_too_many_keys OK 0.18 ServersTest test_confirm_resize_server OK 0.12 test_confirm_resize_server_fails OK 0.38 test_create_backup_schedules OK 0.08 test_create_instance OK 0.17 test_create_instance_has_uuid OK 0.01 test_create_instance_no_key_pair OK 0.17 test_create_instance_no_name OK 0.08 test_create_instance_nonstring_name OK 0.08 test_create_instance_v1_1 OK 0.29 test_create_instance_v1_1_bad_href OK 0.47 test_create_instance_v1_1_local_href OK 0.27 test_create_instance_via_zones OK 0.23 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.47 test_create_instance_with_admin_pass_v1_1 OK 0.28 test_create_instance_with_empty_admin_pass_v1_1 OK 0.19 test_delete_backup_schedules OK 0.12 test_delete_server_instance OK 0.10 test_delete_server_instance_v1_1 OK 0.21 test_get_all_server_details_v1_0 OK 0.50 test_get_all_server_details_v1_1 OK 0.26 test_get_all_server_details_with_host OK 0.21 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.47 test_get_server_addresses_private_v1_0 OK 0.13 test_get_server_addresses_private_xml_v1_0 OK 0.10 test_get_server_addresses_public_v1_0 OK 0.10 test_get_server_addresses_public_xml_v1_0 OK 0.09 test_get_server_addresses_single_network_v1_1 OK 0.18 test_get_server_addresses_v1_0 OK 0.13 test_get_server_addresses_v1_1 OK 0.51 test_get_server_addresses_xml_v1_0 OK 0.14 test_get_server_backup_schedule OK 0.08 test_get_server_backup_schedules OK 0.08 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.45 test_get_server_by_id_with_addresses_v1_1 OK 0.20 test_get_server_by_id_with_addresses_xml OK 0.15 test_get_server_by_uuid OK 0.10 test_get_server_list OK 0.14 test_get_server_list_v1_1 OK 0.25 test_get_server_list_with_reservation_id OK 0.68 test_get_server_list_with_reservation_id_details OK 0.34 test_get_server_list_with_reservation_id_empty OK 0.07 test_get_servers_with_bad_limit OK 0.15 test_get_servers_with_bad_marker OK 0.24 test_get_servers_with_bad_offset OK 0.49 test_get_servers_with_limit OK 0.29 test_get_servers_with_limit_and_marker OK 0.25 test_get_servers_with_limit_and_offset OK 0.19 test_get_servers_with_marker OK 0.24 test_get_servers_with_offset OK 0.64 test_migrate_server OK 0.08 test_rescue_accepted OK 0.17 test_rescue_raises_handled OK 0.18 test_resize_bad_flavor_fails OK 0.12 test_resize_raises_fails OK 0.37 test_resize_server OK 0.08 test_resize_server_v11 OK 0.19 test_resized_server_has_correct_status OK 0.13 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.50 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.19 test_server_change_password_none_v1_1 OK 0.19 test_server_change_password_not_a_string_v1_1 OK 0.47 test_server_change_password_v1_1 OK 0.19 test_server_change_password_xml OK 0.00 test_server_diagnostics OK 0.13 test_server_inject_network_info OK 0.19 test_server_pause OK 0.18 test_server_reboot OK 0.13 test_server_rebuild_accepted OK 0.42 test_server_rebuild_accepted_minimum_v1_1 OK 0.23 test_server_rebuild_accepted_with_bad_metadata_v1_1 OK 0.18 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.18 test_server_rebuild_bad_personality_v1_1 OK 0.50 test_server_rebuild_personality_v1_1 OK 0.22 test_server_rebuild_rejected_when_building OK 0.14 test_server_rebuild_rejected_when_building_v1_1 OK 0.20 test_server_reset_network OK 0.20 test_server_resume OK 0.48 test_server_suspend OK 0.18 test_server_unpause OK 1.51 test_shutdown_status OK 0.13 test_shutoff_status OK 0.10 test_update_nonstring_name OK 0.08 test_update_null_name OK 0.36 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.11 test_update_server_no_body_v1_1 OK 0.08 test_update_server_v1_0 OK 0.08 test_update_whitespace_name OK 0.08 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.40 test_create_instance_admin_pass_xml OK 0.09 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.10 test_create_instance_with_personality OK 0.09 test_create_instance_with_personality_no_contents OK 0.07 test_create_instance_with_personality_no_path OK 0.37 test_create_instance_with_personality_not_a_list OK 0.08 test_create_instance_with_personality_with_non_b64_content OK 0.07 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.07 test_delete_shared_ip_group OK 0.08 test_deprecated_v11 OK 0.46 test_get_shared_ip_groups OK 0.12 test_update_shared_ip_group OK 0.08 UsersTest test_get_user_by_id OK 0.17 test_get_user_list OK 0.17 test_user_create OK 0.17 test_user_delete OK 0.81 test_user_update OK 0.17 VersionsTest test_generate_href OK 0.00 test_get_version_list OK 0.06 test_get_version_list_xml OK 0.39 test_view_builder 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.18 test_get_zone_list_db OK 0.18 test_get_zone_list_scheduler OK 0.17 test_zone_create OK 0.17 test_zone_delete OK 0.48 test_zone_info OK 0.18 test_zone_select OK 0.17 test_zone_update OK 0.17 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.01 ExtensionsTest test_get_foxnsocks OK 0.68 LoginTest test_bad_login_both_bad OK 0.29 test_bad_login_password OK 0.28 test_bad_login_username OK 0.28 test_login OK 0.41 ServersTest test_create_and_delete_server OK 2.15 test_create_and_rebuild_server OK 2.12 test_create_and_rebuild_server_with_metadata OK 4.84 test_create_and_rebuild_server_with_metadata_removal OK 2.47 test_create_server_with_metadata OK 2.19 test_get_servers OK 0.49 test_rename_server OK 2.09 VolumesTest test_attach_and_detach_volume OK 5.40 test_create_and_delete_volume OK 2.79 test_get_volumes OK 0.36 test_get_volumes_summary OK 0.37 XmlTests test_namespace_limits OK 0.79 test_namespace_servers OK 0.46 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.01 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.08 test_show_host_resources_works_correctly OK 0.12 SimpleDriverTestCase test_doesnt_report_disabled_hosts_as_up OK 0.19 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.24 test_live_migration_common_check_service_different_version OK 0.24 test_live_migration_common_check_service_orig_not_exists OK 0.22 test_live_migration_dest_check_not_alive OK 0.22 test_live_migration_dest_check_service_lack_memory OK 0.21 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.20 test_live_migration_src_check_instance_not_running OK 0.14 test_live_migration_src_check_volume_node_not_alive OK 0.68 test_live_migration_src_check_works_correctly OK 0.19 test_reports_enabled_hosts_as_up OK 0.15 test_scheduler_live_migration_with_volume OK 0.38 test_specific_host_gets_instance OK 1.09 test_too_many_cores OK 8.26 test_too_many_gigabytes OK 1.07 test_will_schedule_on_disabled_host_if_specified OK 0.29 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.29 test_002_allow_none OK 0.26 test_003_allow_project_manager OK 0.27 test_004_allow_sys_and_net OK 0.29 AdminApiTestCase test_block_external_ips OK 0.69 test_list_blocked_ips OK 1.14 test_remove_ip_block OK 0.70 ApiEc2TestCase test_authorize_revoke_security_group_cidr OK 0.88 test_authorize_revoke_security_group_cidr_v6 OK 1.69 test_authorize_revoke_security_group_foreign_group OK 0.74 test_create_delete_security_group OK 0.28 test_create_duplicate_key_pair OK 0.44 test_describe_instances OK 0.15 test_get_all_key_pairs OK 0.35 test_get_all_security_groups OK 0.76 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.20 test_can_add_user_to_project OK 0.13 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.09 test_can_delete_user OK 0.03 test_can_generate_x509 OK 0.51 test_can_list_project_roles OK 0.14 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.17 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.09 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.08 test_modify_project_adds_new_manager OK 0.16 test_no_extra_project_managers OK 0.09 test_no_extra_project_members OK 0.10 test_removing_user_role_hides_it_from_project OK 0.12 AuthManagerLdapTestCase test_004_signature_is_valid OK 0.10 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.42 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.02 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.03 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.03 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 2.46 test_allocate_address SKIP: Skipping this pending future merge -------------------- >> begin captured logging << -------------------- 2011-07-19 15:09:12,711 AUDIT nova [-] Starting compute node (version 2011.3-LOCALBRANCH:LOCALREVISION) 2011-07-19 15:09:12,720 DEBUG nova [-] Creating Consumer connection for Service compute from (pid=4466) start /tmp/tmp8ro60a/nova/service.py:154 2011-07-19 15:09:12,720 DEBUG nova.rpc [-] Initing the Adapter Consumer for compute from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:12,720 DEBUG nova.fakerabbit [-] Declaring queue compute from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:12,721 DEBUG nova.fakerabbit [-] Declaring exchange nova from (pid=4466) exchange_declare /tmp/tmp8ro60a/nova/fakerabbit.py:90 2011-07-19 15:09:12,721 DEBUG nova.fakerabbit [-] Binding compute to nova with key compute from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:12,721 DEBUG nova.rpc [-] Initing the Adapter Consumer for compute.66f6f494d7f6479186e5b66828cc3cb4 from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:12,721 DEBUG nova.fakerabbit [-] Declaring queue compute.66f6f494d7f6479186e5b66828cc3cb4 from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:12,722 DEBUG nova.fakerabbit [-] Binding compute.66f6f494d7f6479186e5b66828cc3cb4 to nova with key compute.66f6f494d7f6479186e5b66828cc3cb4 from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:12,722 INFO nova.rpc [-] Created "compute_fanout" fanout exchange with "compute" routing key 2011-07-19 15:09:12,722 DEBUG nova.rpc [-] Initing the Adapter Consumer for compute from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:12,722 DEBUG nova.fakerabbit [-] Declaring queue compute_fanout_d4ec4b7a73d84fe798b1020623189f1a from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:12,722 DEBUG nova.fakerabbit [-] Declaring exchange compute_fanout from (pid=4466) exchange_declare /tmp/tmp8ro60a/nova/fakerabbit.py:90 2011-07-19 15:09:12,723 DEBUG nova.fakerabbit [-] Binding compute_fanout_d4ec4b7a73d84fe798b1020623189f1a to compute_fanout with key compute from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:12,723 AUDIT nova [-] Starting scheduler node (version 2011.3-LOCALBRANCH:LOCALREVISION) 2011-07-19 15:09:12,731 DEBUG nova [-] Creating Consumer connection for Service scheduler from (pid=4466) start /tmp/tmp8ro60a/nova/service.py:154 2011-07-19 15:09:12,731 DEBUG nova.rpc [-] Initing the Adapter Consumer for scheduler from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:12,732 DEBUG nova.fakerabbit [-] Declaring queue scheduler from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:12,732 DEBUG nova.fakerabbit [-] Binding scheduler to nova with key scheduler from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:12,732 DEBUG nova.rpc [-] Initing the Adapter Consumer for scheduler.40381f8927474a78a07e95c714e2fbc9 from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:12,732 DEBUG nova.fakerabbit [-] Declaring queue scheduler.40381f8927474a78a07e95c714e2fbc9 from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:12,733 DEBUG nova.fakerabbit [-] Binding scheduler.40381f8927474a78a07e95c714e2fbc9 to nova with key scheduler.40381f8927474a78a07e95c714e2fbc9 from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:12,733 INFO nova.rpc [-] Created "scheduler_fanout" fanout exchange with "scheduler" routing key 2011-07-19 15:09:12,733 DEBUG nova.rpc [-] Initing the Adapter Consumer for scheduler from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:12,733 DEBUG nova.fakerabbit [-] Declaring queue scheduler_fanout_96e2a866d92b4ccdb6cc83ce56809195 from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:12,734 DEBUG nova.fakerabbit [-] Declaring exchange scheduler_fanout from (pid=4466) exchange_declare /tmp/tmp8ro60a/nova/fakerabbit.py:90 2011-07-19 15:09:12,734 DEBUG nova.fakerabbit [-] Binding scheduler_fanout_96e2a866d92b4ccdb6cc83ce56809195 to scheduler_fanout with key scheduler from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:12,734 AUDIT nova [-] Starting network node (version 2011.3-LOCALBRANCH:LOCALREVISION) 2011-07-19 15:09:12,735 DEBUG nova.utils [-] Attempting to grab semaphore "iptables" for method "apply"... from (pid=4466) inner /tmp/tmp8ro60a/nova/utils.py:615 2011-07-19 15:09:12,735 DEBUG nova.utils [-] Attempting to grab file lock "iptables" for method "apply"... from (pid=4466) inner /tmp/tmp8ro60a/nova/utils.py:620 2011-07-19 15:09:12,735 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-save -t filter from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:12,735 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-restore from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:12,736 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-save -t nat from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:12,736 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-restore from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:12,737 DEBUG nova.linux_net [-] FAKE NET: sudo ip6tables-save -t filter from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:12,737 DEBUG nova.linux_net [-] FAKE NET: sudo ip6tables-restore from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:12,737 DEBUG nova.linux_net [-] FAKE NET: sudo ip addr add 169.254.169.254/32 scope link dev lo from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:12,763 DEBUG nova.utils [-] Attempting to grab semaphore "iptables" for method "apply"... from (pid=4466) inner /tmp/tmp8ro60a/nova/utils.py:615 2011-07-19 15:09:12,764 DEBUG nova.utils [-] Attempting to grab file lock "iptables" for method "apply"... from (pid=4466) inner /tmp/tmp8ro60a/nova/utils.py:620 2011-07-19 15:09:12,764 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-save -t filter from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:12,764 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-restore from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:12,765 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-save -t nat from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:12,765 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-restore from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:12,765 DEBUG nova.linux_net [-] FAKE NET: sudo ip6tables-save -t filter from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:12,766 DEBUG nova.linux_net [-] FAKE NET: sudo ip6tables-restore from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:12,775 DEBUG nova [-] Creating Consumer connection for Service network from (pid=4466) start /tmp/tmp8ro60a/nova/service.py:154 2011-07-19 15:09:12,775 DEBUG nova.rpc [-] Initing the Adapter Consumer for network from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:12,776 DEBUG nova.fakerabbit [-] Declaring queue network from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:12,776 DEBUG nova.fakerabbit [-] Binding network to nova with key network from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:12,777 DEBUG nova.rpc [-] Initing the Adapter Consumer for network.e25bf9e3d5704f14a310d1107420ca3e from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:12,777 DEBUG nova.fakerabbit [-] Declaring queue network.e25bf9e3d5704f14a310d1107420ca3e from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:12,777 DEBUG nova.fakerabbit [-] Binding network.e25bf9e3d5704f14a310d1107420ca3e to nova with key network.e25bf9e3d5704f14a310d1107420ca3e from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:12,778 INFO nova.rpc [-] Created "network_fanout" fanout exchange with "network" routing key 2011-07-19 15:09:12,778 DEBUG nova.rpc [-] Initing the Adapter Consumer for network from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:12,778 DEBUG nova.fakerabbit [-] Declaring queue network_fanout_350d1465255640d3b04f8411ea4fcf3d from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:12,778 DEBUG nova.fakerabbit [-] Declaring exchange network_fanout from (pid=4466) exchange_declare /tmp/tmp8ro60a/nova/fakerabbit.py:90 2011-07-19 15:09:12,778 DEBUG nova.fakerabbit [-] Binding network_fanout_350d1465255640d3b04f8411ea4fcf3d to network_fanout with key network from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:12,779 AUDIT nova [-] Starting volume node (version 2011.3-LOCALBRANCH:LOCALREVISION) 2011-07-19 15:09:12,806 DEBUG nova.volume.manager [-] Re-exporting 0 volumes from (pid=4466) init_host /tmp/tmp8ro60a/nova/volume/manager.py:84 2011-07-19 15:09:12,816 DEBUG nova [-] Creating Consumer connection for Service volume from (pid=4466) start /tmp/tmp8ro60a/nova/service.py:154 2011-07-19 15:09:12,816 DEBUG nova.rpc [-] Initing the Adapter Consumer for volume from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:12,817 DEBUG nova.fakerabbit [-] Declaring queue volume from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:12,817 DEBUG nova.fakerabbit [-] Binding volume to nova with key volume from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:12,818 DEBUG nova.rpc [-] Initing the Adapter Consumer for volume.6c35eda02d2544bda3d187bfb348f885 from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:12,818 DEBUG nova.fakerabbit [-] Declaring queue volume.6c35eda02d2544bda3d187bfb348f885 from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:12,818 DEBUG nova.fakerabbit [-] Binding volume.6c35eda02d2544bda3d187bfb348f885 to nova with key volume.6c35eda02d2544bda3d187bfb348f885 from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:12,819 INFO nova.rpc [-] Created "volume_fanout" fanout exchange with "volume" routing key 2011-07-19 15:09:12,819 DEBUG nova.rpc [-] Initing the Adapter Consumer for volume from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:12,819 DEBUG nova.fakerabbit [-] Declaring queue volume_fanout_44c4077cd0d947d398edf270028698aa from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:12,819 DEBUG nova.fakerabbit [-] Declaring exchange volume_fanout from (pid=4466) exchange_declare /tmp/tmp8ro60a/nova/fakerabbit.py:90 2011-07-19 15:09:12,820 DEBUG nova.fakerabbit [-] Binding volume_fanout_44c4077cd0d947d398edf270028698aa to volume_fanout with key volume from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:12,821 AUDIT nova.auth.manager [-] Created user admin (admin: True) 2011-07-19 15:09:12,822 DEBUG nova.ldapdriver [-] Local cache hit for __project_to_dn by key pid_dn-proj from (pid=4466) inner /tmp/tmp8ro60a/nova/auth/ldapdriver.py:188 2011-07-19 15:09:12,823 DEBUG nova.ldapdriver [-] Local cache hit for __dn_to_uid by key dn_uid-uid=admin,ou=Users,dc=example,dc=com from (pid=4466) inner /tmp/tmp8ro60a/nova/auth/ldapdriver.py:188 2011-07-19 15:09:12,823 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-19 15:09:12,909 AUDIT nova [-] Starting compute node (version 2011.3-LOCALBRANCH:LOCALREVISION) 2011-07-19 15:09:12,918 DEBUG nova [-] Creating Consumer connection for Service compute from (pid=4466) start /tmp/tmp8ro60a/nova/service.py:154 2011-07-19 15:09:12,919 DEBUG nova.rpc [-] Initing the Adapter Consumer for compute from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:12,919 DEBUG nova.fakerabbit [-] Declaring queue compute from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:12,919 DEBUG nova.fakerabbit [-] Declaring exchange nova from (pid=4466) exchange_declare /tmp/tmp8ro60a/nova/fakerabbit.py:90 2011-07-19 15:09:12,920 DEBUG nova.fakerabbit [-] Binding compute to nova with key compute from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:12,920 DEBUG nova.rpc [-] Initing the Adapter Consumer for compute.ed6501c4ef4e47b0a5787865dce7bf10 from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:12,920 DEBUG nova.fakerabbit [-] Declaring queue compute.ed6501c4ef4e47b0a5787865dce7bf10 from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:12,921 DEBUG nova.fakerabbit [-] Binding compute.ed6501c4ef4e47b0a5787865dce7bf10 to nova with key compute.ed6501c4ef4e47b0a5787865dce7bf10 from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:12,921 INFO nova.rpc [-] Created "compute_fanout" fanout exchange with "compute" routing key 2011-07-19 15:09:12,921 DEBUG nova.rpc [-] Initing the Adapter Consumer for compute from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:12,922 DEBUG nova.fakerabbit [-] Declaring queue compute_fanout_0e24259d12c046b196d0b70aed6e43d1 from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:12,922 DEBUG nova.fakerabbit [-] Declaring exchange compute_fanout from (pid=4466) exchange_declare /tmp/tmp8ro60a/nova/fakerabbit.py:90 2011-07-19 15:09:12,922 DEBUG nova.fakerabbit [-] Binding compute_fanout_0e24259d12c046b196d0b70aed6e43d1 to compute_fanout with key compute from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:12,923 AUDIT nova [-] Starting scheduler node (version 2011.3-LOCALBRANCH:LOCALREVISION) 2011-07-19 15:09:12,931 DEBUG nova [-] Creating Consumer connection for Service scheduler from (pid=4466) start /tmp/tmp8ro60a/nova/service.py:154 2011-07-19 15:09:12,931 DEBUG nova.rpc [-] Initing the Adapter Consumer for scheduler from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:12,931 DEBUG nova.fakerabbit [-] Declaring queue scheduler from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:12,931 DEBUG nova.fakerabbit [-] Binding scheduler to nova with key scheduler from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:12,932 DEBUG nova.rpc [-] Initing the Adapter Consumer for scheduler.760deb492d094e72871adfae700f6769 from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:12,932 DEBUG nova.fakerabbit [-] Declaring queue scheduler.760deb492d094e72871adfae700f6769 from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:12,932 DEBUG nova.fakerabbit [-] Binding scheduler.760deb492d094e72871adfae700f6769 to nova with key scheduler.760deb492d094e72871adfae700f6769 from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:12,932 INFO nova.rpc [-] Created "scheduler_fanout" fanout exchange with "scheduler" routing key 2011-07-19 15:09:12,932 DEBUG nova.rpc [-] Initing the Adapter Consumer for scheduler from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:12,933 DEBUG nova.fakerabbit [-] Declaring queue scheduler_fanout_a9ffde33830d4456a8070ecbeb429970 from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:12,933 DEBUG nova.fakerabbit [-] Declaring exchange scheduler_fanout from (pid=4466) exchange_declare /tmp/tmp8ro60a/nova/fakerabbit.py:90 2011-07-19 15:09:12,933 DEBUG nova.fakerabbit [-] Binding scheduler_fanout_a9ffde33830d4456a8070ecbeb429970 to scheduler_fanout with key scheduler from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:12,934 AUDIT nova [-] Starting network node (version 2011.3-LOCALBRANCH:LOCALREVISION) 2011-07-19 15:09:12,934 DEBUG nova.utils [-] Attempting to grab semaphore "iptables" for method "apply"... from (pid=4466) inner /tmp/tmp8ro60a/nova/utils.py:615 2011-07-19 15:09:12,934 DEBUG nova.utils [-] Attempting to grab file lock "iptables" for method "apply"... from (pid=4466) inner /tmp/tmp8ro60a/nova/utils.py:620 2011-07-19 15:09:12,935 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-save -t filter from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:12,935 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-restore from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:12,935 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-save -t nat from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:12,936 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-restore from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:12,936 DEBUG nova.linux_net [-] FAKE NET: sudo ip6tables-save -t filter from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:12,936 DEBUG nova.linux_net [-] FAKE NET: sudo ip6tables-restore from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:12,936 DEBUG nova.linux_net [-] FAKE NET: sudo ip addr add 169.254.169.254/32 scope link dev lo from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:12,961 DEBUG nova.utils [-] Attempting to grab semaphore "iptables" for method "apply"... from (pid=4466) inner /tmp/tmp8ro60a/nova/utils.py:615 2011-07-19 15:09:12,961 DEBUG nova.utils [-] Attempting to grab file lock "iptables" for method "apply"... from (pid=4466) inner /tmp/tmp8ro60a/nova/utils.py:620 2011-07-19 15:09:12,961 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-save -t filter from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:12,962 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-restore from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:12,962 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-save -t nat from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:12,962 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-restore from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:12,963 DEBUG nova.linux_net [-] FAKE NET: sudo ip6tables-save -t filter from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:12,963 DEBUG nova.linux_net [-] FAKE NET: sudo ip6tables-restore from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:12,972 DEBUG nova [-] Creating Consumer connection for Service network from (pid=4466) start /tmp/tmp8ro60a/nova/service.py:154 2011-07-19 15:09:12,972 DEBUG nova.rpc [-] Initing the Adapter Consumer for network from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:12,973 DEBUG nova.fakerabbit [-] Declaring queue network from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:12,973 DEBUG nova.fakerabbit [-] Binding network to nova with key network from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:12,973 DEBUG nova.rpc [-] Initing the Adapter Consumer for network.b01653fdb3d84bdc96ce9653ec6cbf78 from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:12,973 DEBUG nova.fakerabbit [-] Declaring queue network.b01653fdb3d84bdc96ce9653ec6cbf78 from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:12,974 DEBUG nova.fakerabbit [-] Binding network.b01653fdb3d84bdc96ce9653ec6cbf78 to nova with key network.b01653fdb3d84bdc96ce9653ec6cbf78 from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:12,974 INFO nova.rpc [-] Created "network_fanout" fanout exchange with "network" routing key 2011-07-19 15:09:12,974 DEBUG nova.rpc [-] Initing the Adapter Consumer for network from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:12,974 DEBUG nova.fakerabbit [-] Declaring queue network_fanout_fadeaaee6f154411ae58e819be48ffc6 from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:12,975 DEBUG nova.fakerabbit [-] Declaring exchange network_fanout from (pid=4466) exchange_declare /tmp/tmp8ro60a/nova/fakerabbit.py:90 2011-07-19 15:09:12,975 DEBUG nova.fakerabbit [-] Binding network_fanout_fadeaaee6f154411ae58e819be48ffc6 to network_fanout with key network from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:12,976 AUDIT nova [-] Starting volume node (version 2011.3-LOCALBRANCH:LOCALREVISION) 2011-07-19 15:09:12,991 DEBUG nova.volume.manager [-] Re-exporting 0 volumes from (pid=4466) init_host /tmp/tmp8ro60a/nova/volume/manager.py:84 2011-07-19 15:09:13,000 DEBUG nova [-] Creating Consumer connection for Service volume from (pid=4466) start /tmp/tmp8ro60a/nova/service.py:154 2011-07-19 15:09:13,000 DEBUG nova.rpc [-] Initing the Adapter Consumer for volume from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:13,000 DEBUG nova.fakerabbit [-] Declaring queue volume from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:13,001 DEBUG nova.fakerabbit [-] Binding volume to nova with key volume from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:13,001 DEBUG nova.rpc [-] Initing the Adapter Consumer for volume.45d922533b00467492a08b2a4673f67d from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:13,001 DEBUG nova.fakerabbit [-] Declaring queue volume.45d922533b00467492a08b2a4673f67d from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:13,001 DEBUG nova.fakerabbit [-] Binding volume.45d922533b00467492a08b2a4673f67d to nova with key volume.45d922533b00467492a08b2a4673f67d from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:13,002 INFO nova.rpc [-] Created "volume_fanout" fanout exchange with "volume" routing key 2011-07-19 15:09:13,002 DEBUG nova.rpc [-] Initing the Adapter Consumer for volume from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:13,002 DEBUG nova.fakerabbit [-] Declaring queue volume_fanout_630309dd118541f894cd99b9ce9d2a15 from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:13,002 DEBUG nova.fakerabbit [-] Declaring exchange volume_fanout from (pid=4466) exchange_declare /tmp/tmp8ro60a/nova/fakerabbit.py:90 2011-07-19 15:09:13,003 DEBUG nova.fakerabbit [-] Binding volume_fanout_630309dd118541f894cd99b9ce9d2a15 to volume_fanout with key volume from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:13,004 AUDIT nova.auth.manager [-] Created user admin (admin: True) 2011-07-19 15:09:13,005 DEBUG nova.ldapdriver [-] Local cache hit for __project_to_dn by key pid_dn-proj from (pid=4466) inner /tmp/tmp8ro60a/nova/auth/ldapdriver.py:188 2011-07-19 15:09:13,005 DEBUG nova.ldapdriver [-] Local cache hit for __dn_to_uid by key dn_uid-uid=admin,ou=Users,dc=example,dc=com from (pid=4466) inner /tmp/tmp8ro60a/nova/auth/ldapdriver.py:188 2011-07-19 15:09:13,006 AUDIT nova.auth.manager [-] Created project proj with manager admin --------------------- >> end captured logging << --------------------- test_authorize_revoke_security_group_ingress OK 0.35 test_authorize_revoke_security_group_ingress_by_id OK 0.30 test_authorize_security_group_ingress_already_exists OK 0.78 test_authorize_security_group_ingress_missing_group_name_or_idOK 0.18 test_authorize_security_group_ingress_missing_protocol_paramsOK 0.25 test_console_output OK 1.66 test_create_delete_security_group OK 0.75 test_create_image OK 5.17 test_create_snapshot OK 0.43 test_create_volume_from_snapshot OK 0.46 test_delete_key_pair OK 0.47 test_delete_security_group_by_id OK 0.24 test_delete_security_group_no_params OK 0.19 test_delete_security_group_with_bad_group_id OK 0.80 test_delete_security_group_with_bad_name OK 0.22 test_delete_snapshot OK 0.42 test_deregister_image OK 0.20 test_deregister_image_wrong_container_type OK 0.19 test_describe_addresses OK 0.49 test_describe_availability_zones OK 0.22 test_describe_image_attribute OK 0.19 test_describe_image_attribute_block_device_mapping OK 0.19 test_describe_image_attribute_root_device_name OK 0.18 test_describe_image_mapping OK 0.17 test_describe_images OK 0.18 test_describe_instances OK 0.36 test_describe_instances_bdm OK 1.60 test_describe_key_pairs OK 0.67 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-19 15:09:31,229 AUDIT nova [-] Starting compute node (version 2011.3-LOCALBRANCH:LOCALREVISION) 2011-07-19 15:09:31,238 DEBUG nova [-] Creating Consumer connection for Service compute from (pid=4466) start /tmp/tmp8ro60a/nova/service.py:154 2011-07-19 15:09:31,239 DEBUG nova.rpc [-] Initing the Adapter Consumer for compute from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:31,239 DEBUG nova.fakerabbit [-] Declaring queue compute from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:31,239 DEBUG nova.fakerabbit [-] Declaring exchange nova from (pid=4466) exchange_declare /tmp/tmp8ro60a/nova/fakerabbit.py:90 2011-07-19 15:09:31,239 DEBUG nova.fakerabbit [-] Binding compute to nova with key compute from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:31,240 DEBUG nova.rpc [-] Initing the Adapter Consumer for compute.75ed0d4f73354d4aad941c2a9922960e from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:31,240 DEBUG nova.fakerabbit [-] Declaring queue compute.75ed0d4f73354d4aad941c2a9922960e from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:31,240 DEBUG nova.fakerabbit [-] Binding compute.75ed0d4f73354d4aad941c2a9922960e to nova with key compute.75ed0d4f73354d4aad941c2a9922960e from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:31,241 INFO nova.rpc [-] Created "compute_fanout" fanout exchange with "compute" routing key 2011-07-19 15:09:31,241 DEBUG nova.rpc [-] Initing the Adapter Consumer for compute from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:31,241 DEBUG nova.fakerabbit [-] Declaring queue compute_fanout_a08b9011a1b04f389e0ee9f03ddd148a from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:31,241 DEBUG nova.fakerabbit [-] Declaring exchange compute_fanout from (pid=4466) exchange_declare /tmp/tmp8ro60a/nova/fakerabbit.py:90 2011-07-19 15:09:31,241 DEBUG nova.fakerabbit [-] Binding compute_fanout_a08b9011a1b04f389e0ee9f03ddd148a to compute_fanout with key compute from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:31,242 AUDIT nova [-] Starting scheduler node (version 2011.3-LOCALBRANCH:LOCALREVISION) 2011-07-19 15:09:31,250 DEBUG nova [-] Creating Consumer connection for Service scheduler from (pid=4466) start /tmp/tmp8ro60a/nova/service.py:154 2011-07-19 15:09:31,251 DEBUG nova.rpc [-] Initing the Adapter Consumer for scheduler from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:31,251 DEBUG nova.fakerabbit [-] Declaring queue scheduler from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:31,251 DEBUG nova.fakerabbit [-] Binding scheduler to nova with key scheduler from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:31,251 DEBUG nova.rpc [-] Initing the Adapter Consumer for scheduler.152d7f465e1445fba3ab0738e8f9a2e4 from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:31,252 DEBUG nova.fakerabbit [-] Declaring queue scheduler.152d7f465e1445fba3ab0738e8f9a2e4 from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:31,252 DEBUG nova.fakerabbit [-] Binding scheduler.152d7f465e1445fba3ab0738e8f9a2e4 to nova with key scheduler.152d7f465e1445fba3ab0738e8f9a2e4 from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:31,252 INFO nova.rpc [-] Created "scheduler_fanout" fanout exchange with "scheduler" routing key 2011-07-19 15:09:31,252 DEBUG nova.rpc [-] Initing the Adapter Consumer for scheduler from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:31,253 DEBUG nova.fakerabbit [-] Declaring queue scheduler_fanout_e46dedf3467b4b63a1908fb429a5d7a7 from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:31,253 DEBUG nova.fakerabbit [-] Declaring exchange scheduler_fanout from (pid=4466) exchange_declare /tmp/tmp8ro60a/nova/fakerabbit.py:90 2011-07-19 15:09:31,253 DEBUG nova.fakerabbit [-] Binding scheduler_fanout_e46dedf3467b4b63a1908fb429a5d7a7 to scheduler_fanout with key scheduler from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:31,254 AUDIT nova [-] Starting network node (version 2011.3-LOCALBRANCH:LOCALREVISION) 2011-07-19 15:09:31,254 DEBUG nova.utils [-] Attempting to grab semaphore "iptables" for method "apply"... from (pid=4466) inner /tmp/tmp8ro60a/nova/utils.py:615 2011-07-19 15:09:31,254 DEBUG nova.utils [-] Attempting to grab file lock "iptables" for method "apply"... from (pid=4466) inner /tmp/tmp8ro60a/nova/utils.py:620 2011-07-19 15:09:31,255 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-save -t filter from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:31,255 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-restore from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:31,255 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-save -t nat from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:31,256 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-restore from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:31,257 DEBUG nova.linux_net [-] FAKE NET: sudo ip6tables-save -t filter from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:31,257 DEBUG nova.linux_net [-] FAKE NET: sudo ip6tables-restore from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:31,257 DEBUG nova.linux_net [-] FAKE NET: sudo ip addr add 169.254.169.254/32 scope link dev lo from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:31,283 DEBUG nova.utils [-] Attempting to grab semaphore "iptables" for method "apply"... from (pid=4466) inner /tmp/tmp8ro60a/nova/utils.py:615 2011-07-19 15:09:31,283 DEBUG nova.utils [-] Attempting to grab file lock "iptables" for method "apply"... from (pid=4466) inner /tmp/tmp8ro60a/nova/utils.py:620 2011-07-19 15:09:31,284 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-save -t filter from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:31,284 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-restore from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:31,284 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-save -t nat from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:31,285 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-restore from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:31,286 DEBUG nova.linux_net [-] FAKE NET: sudo ip6tables-save -t filter from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:31,286 DEBUG nova.linux_net [-] FAKE NET: sudo ip6tables-restore from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:31,295 DEBUG nova [-] Creating Consumer connection for Service network from (pid=4466) start /tmp/tmp8ro60a/nova/service.py:154 2011-07-19 15:09:31,295 DEBUG nova.rpc [-] Initing the Adapter Consumer for network from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:31,295 DEBUG nova.fakerabbit [-] Declaring queue network from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:31,296 DEBUG nova.fakerabbit [-] Binding network to nova with key network from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:31,296 DEBUG nova.rpc [-] Initing the Adapter Consumer for network.03f5905be2c748b79e2ba78eefac46b0 from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:31,296 DEBUG nova.fakerabbit [-] Declaring queue network.03f5905be2c748b79e2ba78eefac46b0 from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:31,296 DEBUG nova.fakerabbit [-] Binding network.03f5905be2c748b79e2ba78eefac46b0 to nova with key network.03f5905be2c748b79e2ba78eefac46b0 from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:31,297 INFO nova.rpc [-] Created "network_fanout" fanout exchange with "network" routing key 2011-07-19 15:09:31,297 DEBUG nova.rpc [-] Initing the Adapter Consumer for network from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:31,297 DEBUG nova.fakerabbit [-] Declaring queue network_fanout_286d0e63a33a4b879db5b1cdc1b2ccd7 from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:31,297 DEBUG nova.fakerabbit [-] Declaring exchange network_fanout from (pid=4466) exchange_declare /tmp/tmp8ro60a/nova/fakerabbit.py:90 2011-07-19 15:09:31,298 DEBUG nova.fakerabbit [-] Binding network_fanout_286d0e63a33a4b879db5b1cdc1b2ccd7 to network_fanout with key network from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:31,298 AUDIT nova [-] Starting volume node (version 2011.3-LOCALBRANCH:LOCALREVISION) 2011-07-19 15:09:31,315 DEBUG nova.volume.manager [-] Re-exporting 0 volumes from (pid=4466) init_host /tmp/tmp8ro60a/nova/volume/manager.py:84 2011-07-19 15:09:31,325 DEBUG nova [-] Creating Consumer connection for Service volume from (pid=4466) start /tmp/tmp8ro60a/nova/service.py:154 2011-07-19 15:09:31,325 DEBUG nova.rpc [-] Initing the Adapter Consumer for volume from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:31,325 DEBUG nova.fakerabbit [-] Declaring queue volume from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:31,326 DEBUG nova.fakerabbit [-] Binding volume to nova with key volume from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:31,326 DEBUG nova.rpc [-] Initing the Adapter Consumer for volume.42b5d5d44de64a52a44332081facf790 from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:31,326 DEBUG nova.fakerabbit [-] Declaring queue volume.42b5d5d44de64a52a44332081facf790 from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:31,326 DEBUG nova.fakerabbit [-] Binding volume.42b5d5d44de64a52a44332081facf790 to nova with key volume.42b5d5d44de64a52a44332081facf790 from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:31,327 INFO nova.rpc [-] Created "volume_fanout" fanout exchange with "volume" routing key 2011-07-19 15:09:31,327 DEBUG nova.rpc [-] Initing the Adapter Consumer for volume from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:31,327 DEBUG nova.fakerabbit [-] Declaring queue volume_fanout_313532561e1041da9a37d750fa6446f7 from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:31,327 DEBUG nova.fakerabbit [-] Declaring exchange volume_fanout from (pid=4466) exchange_declare /tmp/tmp8ro60a/nova/fakerabbit.py:90 2011-07-19 15:09:31,328 DEBUG nova.fakerabbit [-] Binding volume_fanout_313532561e1041da9a37d750fa6446f7 to volume_fanout with key volume from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:31,329 AUDIT nova.auth.manager [-] Created user admin (admin: True) 2011-07-19 15:09:31,330 DEBUG nova.ldapdriver [-] Local cache hit for __project_to_dn by key pid_dn-proj from (pid=4466) inner /tmp/tmp8ro60a/nova/auth/ldapdriver.py:188 2011-07-19 15:09:31,331 DEBUG nova.ldapdriver [-] Local cache hit for __dn_to_uid by key dn_uid-uid=admin,ou=Users,dc=example,dc=com from (pid=4466) inner /tmp/tmp8ro60a/nova/auth/ldapdriver.py:188 2011-07-19 15:09:31,331 AUDIT nova.auth.manager [-] Created project proj with manager admin --------------------- >> end captured logging << --------------------- test_describe_volumes OK 0.25 test_format_instance_bdm OK 1.02 test_import_public_key OK 0.33 test_key_generation OK 1.13 test_modify_image_attribute OK 0.23 test_revoke_security_group_ingress_missing_group_name_or_id OK 0.20 test_run_instances OK 0.52 test_run_instances_image_state_invalid OK 0.20 test_run_instances_image_state_none OK 0.18 test_run_instances_image_status_active OK 1.19 test_run_with_snapshot SKIP: skipping, test is hanging with multinic for rpc reasons -------------------- >> begin captured logging << -------------------- 2011-07-19 15:09:36,689 AUDIT nova [-] Starting compute node (version 2011.3-LOCALBRANCH:LOCALREVISION) 2011-07-19 15:09:36,699 DEBUG nova [-] Creating Consumer connection for Service compute from (pid=4466) start /tmp/tmp8ro60a/nova/service.py:154 2011-07-19 15:09:36,699 DEBUG nova.rpc [-] Initing the Adapter Consumer for compute from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:36,700 DEBUG nova.fakerabbit [-] Declaring queue compute from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:36,700 DEBUG nova.fakerabbit [-] Declaring exchange nova from (pid=4466) exchange_declare /tmp/tmp8ro60a/nova/fakerabbit.py:90 2011-07-19 15:09:36,700 DEBUG nova.fakerabbit [-] Binding compute to nova with key compute from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:36,700 DEBUG nova.rpc [-] Initing the Adapter Consumer for compute.173dd73d9ed84b8f9574d43fcf84e552 from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:36,701 DEBUG nova.fakerabbit [-] Declaring queue compute.173dd73d9ed84b8f9574d43fcf84e552 from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:36,701 DEBUG nova.fakerabbit [-] Binding compute.173dd73d9ed84b8f9574d43fcf84e552 to nova with key compute.173dd73d9ed84b8f9574d43fcf84e552 from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:36,701 INFO nova.rpc [-] Created "compute_fanout" fanout exchange with "compute" routing key 2011-07-19 15:09:36,701 DEBUG nova.rpc [-] Initing the Adapter Consumer for compute from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:36,702 DEBUG nova.fakerabbit [-] Declaring queue compute_fanout_260ed1354a0541adb6dfa2d95b695e68 from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:36,702 DEBUG nova.fakerabbit [-] Declaring exchange compute_fanout from (pid=4466) exchange_declare /tmp/tmp8ro60a/nova/fakerabbit.py:90 2011-07-19 15:09:36,702 DEBUG nova.fakerabbit [-] Binding compute_fanout_260ed1354a0541adb6dfa2d95b695e68 to compute_fanout with key compute from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:36,703 AUDIT nova [-] Starting scheduler node (version 2011.3-LOCALBRANCH:LOCALREVISION) 2011-07-19 15:09:36,711 DEBUG nova [-] Creating Consumer connection for Service scheduler from (pid=4466) start /tmp/tmp8ro60a/nova/service.py:154 2011-07-19 15:09:36,711 DEBUG nova.rpc [-] Initing the Adapter Consumer for scheduler from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:36,711 DEBUG nova.fakerabbit [-] Declaring queue scheduler from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:36,712 DEBUG nova.fakerabbit [-] Binding scheduler to nova with key scheduler from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:36,712 DEBUG nova.rpc [-] Initing the Adapter Consumer for scheduler.7a37da43fa61493f812b4f91bed3c141 from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:36,712 DEBUG nova.fakerabbit [-] Declaring queue scheduler.7a37da43fa61493f812b4f91bed3c141 from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:36,712 DEBUG nova.fakerabbit [-] Binding scheduler.7a37da43fa61493f812b4f91bed3c141 to nova with key scheduler.7a37da43fa61493f812b4f91bed3c141 from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:36,713 INFO nova.rpc [-] Created "scheduler_fanout" fanout exchange with "scheduler" routing key 2011-07-19 15:09:36,713 DEBUG nova.rpc [-] Initing the Adapter Consumer for scheduler from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:36,713 DEBUG nova.fakerabbit [-] Declaring queue scheduler_fanout_5bb82320d51a4bfd8ee22d563e7648b8 from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:36,713 DEBUG nova.fakerabbit [-] Declaring exchange scheduler_fanout from (pid=4466) exchange_declare /tmp/tmp8ro60a/nova/fakerabbit.py:90 2011-07-19 15:09:36,714 DEBUG nova.fakerabbit [-] Binding scheduler_fanout_5bb82320d51a4bfd8ee22d563e7648b8 to scheduler_fanout with key scheduler from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:36,715 AUDIT nova [-] Starting network node (version 2011.3-LOCALBRANCH:LOCALREVISION) 2011-07-19 15:09:36,715 DEBUG nova.utils [-] Attempting to grab semaphore "iptables" for method "apply"... from (pid=4466) inner /tmp/tmp8ro60a/nova/utils.py:615 2011-07-19 15:09:36,715 DEBUG nova.utils [-] Attempting to grab file lock "iptables" for method "apply"... from (pid=4466) inner /tmp/tmp8ro60a/nova/utils.py:620 2011-07-19 15:09:36,715 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-save -t filter from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:36,716 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-restore from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:36,716 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-save -t nat from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:36,717 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-restore from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:36,718 DEBUG nova.linux_net [-] FAKE NET: sudo ip6tables-save -t filter from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:36,718 DEBUG nova.linux_net [-] FAKE NET: sudo ip6tables-restore from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:36,718 DEBUG nova.linux_net [-] FAKE NET: sudo ip addr add 169.254.169.254/32 scope link dev lo from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:36,741 DEBUG nova.utils [-] Attempting to grab semaphore "iptables" for method "apply"... from (pid=4466) inner /tmp/tmp8ro60a/nova/utils.py:615 2011-07-19 15:09:36,741 DEBUG nova.utils [-] Attempting to grab file lock "iptables" for method "apply"... from (pid=4466) inner /tmp/tmp8ro60a/nova/utils.py:620 2011-07-19 15:09:36,742 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-save -t filter from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:36,742 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-restore from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:36,742 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-save -t nat from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:36,744 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-restore from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:36,744 DEBUG nova.linux_net [-] FAKE NET: sudo ip6tables-save -t filter from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:36,744 DEBUG nova.linux_net [-] FAKE NET: sudo ip6tables-restore from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:36,753 DEBUG nova [-] Creating Consumer connection for Service network from (pid=4466) start /tmp/tmp8ro60a/nova/service.py:154 2011-07-19 15:09:36,753 DEBUG nova.rpc [-] Initing the Adapter Consumer for network from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:36,754 DEBUG nova.fakerabbit [-] Declaring queue network from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:36,754 DEBUG nova.fakerabbit [-] Binding network to nova with key network from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:36,754 DEBUG nova.rpc [-] Initing the Adapter Consumer for network.52a3891df8fb416f9d560bc98f2bf054 from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:36,754 DEBUG nova.fakerabbit [-] Declaring queue network.52a3891df8fb416f9d560bc98f2bf054 from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:36,755 DEBUG nova.fakerabbit [-] Binding network.52a3891df8fb416f9d560bc98f2bf054 to nova with key network.52a3891df8fb416f9d560bc98f2bf054 from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:36,755 INFO nova.rpc [-] Created "network_fanout" fanout exchange with "network" routing key 2011-07-19 15:09:36,755 DEBUG nova.rpc [-] Initing the Adapter Consumer for network from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:36,755 DEBUG nova.fakerabbit [-] Declaring queue network_fanout_cb3f57a493214d7fa5c027ef97c48141 from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:36,755 DEBUG nova.fakerabbit [-] Declaring exchange network_fanout from (pid=4466) exchange_declare /tmp/tmp8ro60a/nova/fakerabbit.py:90 2011-07-19 15:09:36,756 DEBUG nova.fakerabbit [-] Binding network_fanout_cb3f57a493214d7fa5c027ef97c48141 to network_fanout with key network from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:36,756 AUDIT nova [-] Starting volume node (version 2011.3-LOCALBRANCH:LOCALREVISION) 2011-07-19 15:09:36,780 DEBUG nova.volume.manager [-] Re-exporting 0 volumes from (pid=4466) init_host /tmp/tmp8ro60a/nova/volume/manager.py:84 2011-07-19 15:09:36,789 DEBUG nova [-] Creating Consumer connection for Service volume from (pid=4466) start /tmp/tmp8ro60a/nova/service.py:154 2011-07-19 15:09:36,789 DEBUG nova.rpc [-] Initing the Adapter Consumer for volume from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:36,789 DEBUG nova.fakerabbit [-] Declaring queue volume from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:36,790 DEBUG nova.fakerabbit [-] Binding volume to nova with key volume from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:36,790 DEBUG nova.rpc [-] Initing the Adapter Consumer for volume.25235f17e6ac446bbac6c10635101b6c from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:36,790 DEBUG nova.fakerabbit [-] Declaring queue volume.25235f17e6ac446bbac6c10635101b6c from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:36,791 DEBUG nova.fakerabbit [-] Binding volume.25235f17e6ac446bbac6c10635101b6c to nova with key volume.25235f17e6ac446bbac6c10635101b6c from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:36,791 INFO nova.rpc [-] Created "volume_fanout" fanout exchange with "volume" routing key 2011-07-19 15:09:36,791 DEBUG nova.rpc [-] Initing the Adapter Consumer for volume from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:36,791 DEBUG nova.fakerabbit [-] Declaring queue volume_fanout_6655d9f42b144864b7f14b423aac8e62 from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:36,791 DEBUG nova.fakerabbit [-] Declaring exchange volume_fanout from (pid=4466) exchange_declare /tmp/tmp8ro60a/nova/fakerabbit.py:90 2011-07-19 15:09:36,792 DEBUG nova.fakerabbit [-] Binding volume_fanout_6655d9f42b144864b7f14b423aac8e62 to volume_fanout with key volume from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:36,793 AUDIT nova.auth.manager [-] Created user admin (admin: True) 2011-07-19 15:09:36,794 DEBUG nova.ldapdriver [-] Local cache hit for __project_to_dn by key pid_dn-proj from (pid=4466) inner /tmp/tmp8ro60a/nova/auth/ldapdriver.py:188 2011-07-19 15:09:36,795 DEBUG nova.ldapdriver [-] Local cache hit for __dn_to_uid by key dn_uid-uid=admin,ou=Users,dc=example,dc=com from (pid=4466) inner /tmp/tmp8ro60a/nova/auth/ldapdriver.py:188 2011-07-19 15:09:36,795 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-19 15:09:36,880 AUDIT nova [-] Starting compute node (version 2011.3-LOCALBRANCH:LOCALREVISION) 2011-07-19 15:09:36,888 DEBUG nova [-] Creating Consumer connection for Service compute from (pid=4466) start /tmp/tmp8ro60a/nova/service.py:154 2011-07-19 15:09:36,888 DEBUG nova.rpc [-] Initing the Adapter Consumer for compute from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:36,889 DEBUG nova.fakerabbit [-] Declaring queue compute from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:36,889 DEBUG nova.fakerabbit [-] Declaring exchange nova from (pid=4466) exchange_declare /tmp/tmp8ro60a/nova/fakerabbit.py:90 2011-07-19 15:09:36,889 DEBUG nova.fakerabbit [-] Binding compute to nova with key compute from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:36,889 DEBUG nova.rpc [-] Initing the Adapter Consumer for compute.a55d4b3dfa624ebcb9886e29aff832e4 from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:36,890 DEBUG nova.fakerabbit [-] Declaring queue compute.a55d4b3dfa624ebcb9886e29aff832e4 from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:36,890 DEBUG nova.fakerabbit [-] Binding compute.a55d4b3dfa624ebcb9886e29aff832e4 to nova with key compute.a55d4b3dfa624ebcb9886e29aff832e4 from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:36,890 INFO nova.rpc [-] Created "compute_fanout" fanout exchange with "compute" routing key 2011-07-19 15:09:36,890 DEBUG nova.rpc [-] Initing the Adapter Consumer for compute from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:36,891 DEBUG nova.fakerabbit [-] Declaring queue compute_fanout_4595954da76f45da98a03846bc8e7003 from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:36,891 DEBUG nova.fakerabbit [-] Declaring exchange compute_fanout from (pid=4466) exchange_declare /tmp/tmp8ro60a/nova/fakerabbit.py:90 2011-07-19 15:09:36,891 DEBUG nova.fakerabbit [-] Binding compute_fanout_4595954da76f45da98a03846bc8e7003 to compute_fanout with key compute from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:36,892 AUDIT nova [-] Starting scheduler node (version 2011.3-LOCALBRANCH:LOCALREVISION) 2011-07-19 15:09:36,900 DEBUG nova [-] Creating Consumer connection for Service scheduler from (pid=4466) start /tmp/tmp8ro60a/nova/service.py:154 2011-07-19 15:09:36,900 DEBUG nova.rpc [-] Initing the Adapter Consumer for scheduler from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:36,900 DEBUG nova.fakerabbit [-] Declaring queue scheduler from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:36,900 DEBUG nova.fakerabbit [-] Binding scheduler to nova with key scheduler from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:36,901 DEBUG nova.rpc [-] Initing the Adapter Consumer for scheduler.7486d9cf94bd4e3eb32627e0bea2b925 from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:36,901 DEBUG nova.fakerabbit [-] Declaring queue scheduler.7486d9cf94bd4e3eb32627e0bea2b925 from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:36,901 DEBUG nova.fakerabbit [-] Binding scheduler.7486d9cf94bd4e3eb32627e0bea2b925 to nova with key scheduler.7486d9cf94bd4e3eb32627e0bea2b925 from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:36,901 INFO nova.rpc [-] Created "scheduler_fanout" fanout exchange with "scheduler" routing key 2011-07-19 15:09:36,901 DEBUG nova.rpc [-] Initing the Adapter Consumer for scheduler from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:36,902 DEBUG nova.fakerabbit [-] Declaring queue scheduler_fanout_a5ae3eb186134f1483a09b9aed3a614a from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:36,902 DEBUG nova.fakerabbit [-] Declaring exchange scheduler_fanout from (pid=4466) exchange_declare /tmp/tmp8ro60a/nova/fakerabbit.py:90 2011-07-19 15:09:36,902 DEBUG nova.fakerabbit [-] Binding scheduler_fanout_a5ae3eb186134f1483a09b9aed3a614a to scheduler_fanout with key scheduler from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:36,903 AUDIT nova [-] Starting network node (version 2011.3-LOCALBRANCH:LOCALREVISION) 2011-07-19 15:09:36,903 DEBUG nova.utils [-] Attempting to grab semaphore "iptables" for method "apply"... from (pid=4466) inner /tmp/tmp8ro60a/nova/utils.py:615 2011-07-19 15:09:36,903 DEBUG nova.utils [-] Attempting to grab file lock "iptables" for method "apply"... from (pid=4466) inner /tmp/tmp8ro60a/nova/utils.py:620 2011-07-19 15:09:36,904 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-save -t filter from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:36,904 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-restore from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:36,904 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-save -t nat from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:36,905 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-restore from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:36,906 DEBUG nova.linux_net [-] FAKE NET: sudo ip6tables-save -t filter from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:36,906 DEBUG nova.linux_net [-] FAKE NET: sudo ip6tables-restore from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:36,906 DEBUG nova.linux_net [-] FAKE NET: sudo ip addr add 169.254.169.254/32 scope link dev lo from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:36,929 DEBUG nova.utils [-] Attempting to grab semaphore "iptables" for method "apply"... from (pid=4466) inner /tmp/tmp8ro60a/nova/utils.py:615 2011-07-19 15:09:36,929 DEBUG nova.utils [-] Attempting to grab file lock "iptables" for method "apply"... from (pid=4466) inner /tmp/tmp8ro60a/nova/utils.py:620 2011-07-19 15:09:36,929 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-save -t filter from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:36,930 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-restore from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:36,930 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-save -t nat from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:36,931 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-restore from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:36,931 DEBUG nova.linux_net [-] FAKE NET: sudo ip6tables-save -t filter from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:36,931 DEBUG nova.linux_net [-] FAKE NET: sudo ip6tables-restore from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:36,940 DEBUG nova [-] Creating Consumer connection for Service network from (pid=4466) start /tmp/tmp8ro60a/nova/service.py:154 2011-07-19 15:09:36,940 DEBUG nova.rpc [-] Initing the Adapter Consumer for network from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:36,940 DEBUG nova.fakerabbit [-] Declaring queue network from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:36,941 DEBUG nova.fakerabbit [-] Binding network to nova with key network from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:36,941 DEBUG nova.rpc [-] Initing the Adapter Consumer for network.7023391e79e147a58fff8b7df884e3c3 from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:36,941 DEBUG nova.fakerabbit [-] Declaring queue network.7023391e79e147a58fff8b7df884e3c3 from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:36,941 DEBUG nova.fakerabbit [-] Binding network.7023391e79e147a58fff8b7df884e3c3 to nova with key network.7023391e79e147a58fff8b7df884e3c3 from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:36,942 INFO nova.rpc [-] Created "network_fanout" fanout exchange with "network" routing key 2011-07-19 15:09:36,942 DEBUG nova.rpc [-] Initing the Adapter Consumer for network from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:36,942 DEBUG nova.fakerabbit [-] Declaring queue network_fanout_9ea8ba5def9c453e814793f6d767429e from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:36,942 DEBUG nova.fakerabbit [-] Declaring exchange network_fanout from (pid=4466) exchange_declare /tmp/tmp8ro60a/nova/fakerabbit.py:90 2011-07-19 15:09:36,943 DEBUG nova.fakerabbit [-] Binding network_fanout_9ea8ba5def9c453e814793f6d767429e to network_fanout with key network from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:36,943 AUDIT nova [-] Starting volume node (version 2011.3-LOCALBRANCH:LOCALREVISION) 2011-07-19 15:09:36,959 DEBUG nova.volume.manager [-] Re-exporting 0 volumes from (pid=4466) init_host /tmp/tmp8ro60a/nova/volume/manager.py:84 2011-07-19 15:09:36,968 DEBUG nova [-] Creating Consumer connection for Service volume from (pid=4466) start /tmp/tmp8ro60a/nova/service.py:154 2011-07-19 15:09:36,968 DEBUG nova.rpc [-] Initing the Adapter Consumer for volume from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:36,968 DEBUG nova.fakerabbit [-] Declaring queue volume from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:36,969 DEBUG nova.fakerabbit [-] Binding volume to nova with key volume from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:36,969 DEBUG nova.rpc [-] Initing the Adapter Consumer for volume.f82750f32ab945a890c7830e36cfc42c from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:36,969 DEBUG nova.fakerabbit [-] Declaring queue volume.f82750f32ab945a890c7830e36cfc42c from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:36,969 DEBUG nova.fakerabbit [-] Binding volume.f82750f32ab945a890c7830e36cfc42c to nova with key volume.f82750f32ab945a890c7830e36cfc42c from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:36,970 INFO nova.rpc [-] Created "volume_fanout" fanout exchange with "volume" routing key 2011-07-19 15:09:36,970 DEBUG nova.rpc [-] Initing the Adapter Consumer for volume from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:36,970 DEBUG nova.fakerabbit [-] Declaring queue volume_fanout_cb1331208dcb47bba40a093209898b49 from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:36,970 DEBUG nova.fakerabbit [-] Declaring exchange volume_fanout from (pid=4466) exchange_declare /tmp/tmp8ro60a/nova/fakerabbit.py:90 2011-07-19 15:09:36,970 DEBUG nova.fakerabbit [-] Binding volume_fanout_cb1331208dcb47bba40a093209898b49 to volume_fanout with key volume from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:36,972 AUDIT nova.auth.manager [-] Created user admin (admin: True) 2011-07-19 15:09:36,973 DEBUG nova.ldapdriver [-] Local cache hit for __project_to_dn by key pid_dn-proj from (pid=4466) inner /tmp/tmp8ro60a/nova/auth/ldapdriver.py:188 2011-07-19 15:09:36,973 DEBUG nova.ldapdriver [-] Local cache hit for __dn_to_uid by key dn_uid-uid=admin,ou=Users,dc=example,dc=com from (pid=4466) inner /tmp/tmp8ro60a/nova/auth/ldapdriver.py:188 2011-07-19 15:09:36,974 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-19 15:09:37,061 AUDIT nova [-] Starting compute node (version 2011.3-LOCALBRANCH:LOCALREVISION) 2011-07-19 15:09:37,070 DEBUG nova [-] Creating Consumer connection for Service compute from (pid=4466) start /tmp/tmp8ro60a/nova/service.py:154 2011-07-19 15:09:37,070 DEBUG nova.rpc [-] Initing the Adapter Consumer for compute from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:37,070 DEBUG nova.fakerabbit [-] Declaring queue compute from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:37,070 DEBUG nova.fakerabbit [-] Declaring exchange nova from (pid=4466) exchange_declare /tmp/tmp8ro60a/nova/fakerabbit.py:90 2011-07-19 15:09:37,071 DEBUG nova.fakerabbit [-] Binding compute to nova with key compute from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:37,071 DEBUG nova.rpc [-] Initing the Adapter Consumer for compute.c01685a9ed5a41878716e8ccd88fe3a3 from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:37,071 DEBUG nova.fakerabbit [-] Declaring queue compute.c01685a9ed5a41878716e8ccd88fe3a3 from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:37,071 DEBUG nova.fakerabbit [-] Binding compute.c01685a9ed5a41878716e8ccd88fe3a3 to nova with key compute.c01685a9ed5a41878716e8ccd88fe3a3 from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:37,072 INFO nova.rpc [-] Created "compute_fanout" fanout exchange with "compute" routing key 2011-07-19 15:09:37,072 DEBUG nova.rpc [-] Initing the Adapter Consumer for compute from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:37,072 DEBUG nova.fakerabbit [-] Declaring queue compute_fanout_c1bfcfa015aa49828bd0a06daaf5e73c from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:37,072 DEBUG nova.fakerabbit [-] Declaring exchange compute_fanout from (pid=4466) exchange_declare /tmp/tmp8ro60a/nova/fakerabbit.py:90 2011-07-19 15:09:37,073 DEBUG nova.fakerabbit [-] Binding compute_fanout_c1bfcfa015aa49828bd0a06daaf5e73c to compute_fanout with key compute from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:37,073 AUDIT nova [-] Starting scheduler node (version 2011.3-LOCALBRANCH:LOCALREVISION) 2011-07-19 15:09:37,081 DEBUG nova [-] Creating Consumer connection for Service scheduler from (pid=4466) start /tmp/tmp8ro60a/nova/service.py:154 2011-07-19 15:09:37,081 DEBUG nova.rpc [-] Initing the Adapter Consumer for scheduler from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:37,082 DEBUG nova.fakerabbit [-] Declaring queue scheduler from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:37,082 DEBUG nova.fakerabbit [-] Binding scheduler to nova with key scheduler from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:37,082 DEBUG nova.rpc [-] Initing the Adapter Consumer for scheduler.04f8cc3587544f8f97bd911bcd0fd00d from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:37,082 DEBUG nova.fakerabbit [-] Declaring queue scheduler.04f8cc3587544f8f97bd911bcd0fd00d from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:37,083 DEBUG nova.fakerabbit [-] Binding scheduler.04f8cc3587544f8f97bd911bcd0fd00d to nova with key scheduler.04f8cc3587544f8f97bd911bcd0fd00d from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:37,083 INFO nova.rpc [-] Created "scheduler_fanout" fanout exchange with "scheduler" routing key 2011-07-19 15:09:37,083 DEBUG nova.rpc [-] Initing the Adapter Consumer for scheduler from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:37,083 DEBUG nova.fakerabbit [-] Declaring queue scheduler_fanout_0a85f7d7f2854833bdf61cd3365ca6b0 from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:37,083 DEBUG nova.fakerabbit [-] Declaring exchange scheduler_fanout from (pid=4466) exchange_declare /tmp/tmp8ro60a/nova/fakerabbit.py:90 2011-07-19 15:09:37,084 DEBUG nova.fakerabbit [-] Binding scheduler_fanout_0a85f7d7f2854833bdf61cd3365ca6b0 to scheduler_fanout with key scheduler from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:37,084 AUDIT nova [-] Starting network node (version 2011.3-LOCALBRANCH:LOCALREVISION) 2011-07-19 15:09:37,084 DEBUG nova.utils [-] Attempting to grab semaphore "iptables" for method "apply"... from (pid=4466) inner /tmp/tmp8ro60a/nova/utils.py:615 2011-07-19 15:09:37,085 DEBUG nova.utils [-] Attempting to grab file lock "iptables" for method "apply"... from (pid=4466) inner /tmp/tmp8ro60a/nova/utils.py:620 2011-07-19 15:09:37,085 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-save -t filter from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:37,085 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-restore from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:37,085 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-save -t nat from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:37,087 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-restore from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:37,087 DEBUG nova.linux_net [-] FAKE NET: sudo ip6tables-save -t filter from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:37,087 DEBUG nova.linux_net [-] FAKE NET: sudo ip6tables-restore from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:37,088 DEBUG nova.linux_net [-] FAKE NET: sudo ip addr add 169.254.169.254/32 scope link dev lo from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:37,111 DEBUG nova.utils [-] Attempting to grab semaphore "iptables" for method "apply"... from (pid=4466) inner /tmp/tmp8ro60a/nova/utils.py:615 2011-07-19 15:09:37,112 DEBUG nova.utils [-] Attempting to grab file lock "iptables" for method "apply"... from (pid=4466) inner /tmp/tmp8ro60a/nova/utils.py:620 2011-07-19 15:09:37,112 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-save -t filter from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:37,112 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-restore from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:37,113 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-save -t nat from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:37,114 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-restore from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:37,114 DEBUG nova.linux_net [-] FAKE NET: sudo ip6tables-save -t filter from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:37,115 DEBUG nova.linux_net [-] FAKE NET: sudo ip6tables-restore from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:37,125 DEBUG nova [-] Creating Consumer connection for Service network from (pid=4466) start /tmp/tmp8ro60a/nova/service.py:154 2011-07-19 15:09:37,125 DEBUG nova.rpc [-] Initing the Adapter Consumer for network from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:37,125 DEBUG nova.fakerabbit [-] Declaring queue network from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:37,126 DEBUG nova.fakerabbit [-] Binding network to nova with key network from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:37,126 DEBUG nova.rpc [-] Initing the Adapter Consumer for network.3d922c480d7f4266a3940cd789090a01 from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:37,126 DEBUG nova.fakerabbit [-] Declaring queue network.3d922c480d7f4266a3940cd789090a01 from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:37,127 DEBUG nova.fakerabbit [-] Binding network.3d922c480d7f4266a3940cd789090a01 to nova with key network.3d922c480d7f4266a3940cd789090a01 from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:37,127 INFO nova.rpc [-] Created "network_fanout" fanout exchange with "network" routing key 2011-07-19 15:09:37,127 DEBUG nova.rpc [-] Initing the Adapter Consumer for network from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:37,127 DEBUG nova.fakerabbit [-] Declaring queue network_fanout_6f8798542d124a9a85b28f3d52c4409e from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:37,128 DEBUG nova.fakerabbit [-] Declaring exchange network_fanout from (pid=4466) exchange_declare /tmp/tmp8ro60a/nova/fakerabbit.py:90 2011-07-19 15:09:37,128 DEBUG nova.fakerabbit [-] Binding network_fanout_6f8798542d124a9a85b28f3d52c4409e to network_fanout with key network from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:37,128 AUDIT nova [-] Starting volume node (version 2011.3-LOCALBRANCH:LOCALREVISION) 2011-07-19 15:09:37,154 DEBUG nova.volume.manager [-] Re-exporting 0 volumes from (pid=4466) init_host /tmp/tmp8ro60a/nova/volume/manager.py:84 2011-07-19 15:09:37,164 DEBUG nova [-] Creating Consumer connection for Service volume from (pid=4466) start /tmp/tmp8ro60a/nova/service.py:154 2011-07-19 15:09:37,164 DEBUG nova.rpc [-] Initing the Adapter Consumer for volume from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:37,165 DEBUG nova.fakerabbit [-] Declaring queue volume from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:37,165 DEBUG nova.fakerabbit [-] Binding volume to nova with key volume from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:37,165 DEBUG nova.rpc [-] Initing the Adapter Consumer for volume.0cb5aa715ea74021a6101a78a2e4cdef from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:37,166 DEBUG nova.fakerabbit [-] Declaring queue volume.0cb5aa715ea74021a6101a78a2e4cdef from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:37,166 DEBUG nova.fakerabbit [-] Binding volume.0cb5aa715ea74021a6101a78a2e4cdef to nova with key volume.0cb5aa715ea74021a6101a78a2e4cdef from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:37,166 INFO nova.rpc [-] Created "volume_fanout" fanout exchange with "volume" routing key 2011-07-19 15:09:37,166 DEBUG nova.rpc [-] Initing the Adapter Consumer for volume from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:37,167 DEBUG nova.fakerabbit [-] Declaring queue volume_fanout_c7b744686f124c4e92b4c29c665e1d5e from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:37,167 DEBUG nova.fakerabbit [-] Declaring exchange volume_fanout from (pid=4466) exchange_declare /tmp/tmp8ro60a/nova/fakerabbit.py:90 2011-07-19 15:09:37,167 DEBUG nova.fakerabbit [-] Binding volume_fanout_c7b744686f124c4e92b4c29c665e1d5e to volume_fanout with key volume from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:37,168 AUDIT nova.auth.manager [-] Created user admin (admin: True) 2011-07-19 15:09:37,169 DEBUG nova.ldapdriver [-] Local cache hit for __project_to_dn by key pid_dn-proj from (pid=4466) inner /tmp/tmp8ro60a/nova/auth/ldapdriver.py:188 2011-07-19 15:09:37,170 DEBUG nova.ldapdriver [-] Local cache hit for __dn_to_uid by key dn_uid-uid=admin,ou=Users,dc=example,dc=com from (pid=4466) inner /tmp/tmp8ro60a/nova/auth/ldapdriver.py:188 2011-07-19 15:09:37,170 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-19 15:09:37,825 AUDIT nova [-] Starting compute node (version 2011.3-LOCALBRANCH:LOCALREVISION) 2011-07-19 15:09:37,834 DEBUG nova [-] Creating Consumer connection for Service compute from (pid=4466) start /tmp/tmp8ro60a/nova/service.py:154 2011-07-19 15:09:37,834 DEBUG nova.rpc [-] Initing the Adapter Consumer for compute from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:37,835 DEBUG nova.fakerabbit [-] Declaring queue compute from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:37,835 DEBUG nova.fakerabbit [-] Declaring exchange nova from (pid=4466) exchange_declare /tmp/tmp8ro60a/nova/fakerabbit.py:90 2011-07-19 15:09:37,835 DEBUG nova.fakerabbit [-] Binding compute to nova with key compute from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:37,835 DEBUG nova.rpc [-] Initing the Adapter Consumer for compute.40d6af574b9a44a7bdf832f619c1c8fb from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:37,836 DEBUG nova.fakerabbit [-] Declaring queue compute.40d6af574b9a44a7bdf832f619c1c8fb from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:37,836 DEBUG nova.fakerabbit [-] Binding compute.40d6af574b9a44a7bdf832f619c1c8fb to nova with key compute.40d6af574b9a44a7bdf832f619c1c8fb from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:37,836 INFO nova.rpc [-] Created "compute_fanout" fanout exchange with "compute" routing key 2011-07-19 15:09:37,836 DEBUG nova.rpc [-] Initing the Adapter Consumer for compute from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:37,837 DEBUG nova.fakerabbit [-] Declaring queue compute_fanout_908b6ae1e3464e4a937ceaeb420963a9 from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:37,837 DEBUG nova.fakerabbit [-] Declaring exchange compute_fanout from (pid=4466) exchange_declare /tmp/tmp8ro60a/nova/fakerabbit.py:90 2011-07-19 15:09:37,837 DEBUG nova.fakerabbit [-] Binding compute_fanout_908b6ae1e3464e4a937ceaeb420963a9 to compute_fanout with key compute from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:37,838 AUDIT nova [-] Starting scheduler node (version 2011.3-LOCALBRANCH:LOCALREVISION) 2011-07-19 15:09:37,847 DEBUG nova [-] Creating Consumer connection for Service scheduler from (pid=4466) start /tmp/tmp8ro60a/nova/service.py:154 2011-07-19 15:09:37,847 DEBUG nova.rpc [-] Initing the Adapter Consumer for scheduler from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:37,847 DEBUG nova.fakerabbit [-] Declaring queue scheduler from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:37,848 DEBUG nova.fakerabbit [-] Binding scheduler to nova with key scheduler from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:37,848 DEBUG nova.rpc [-] Initing the Adapter Consumer for scheduler.839d604d78a44f168ae4356f251b8445 from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:37,848 DEBUG nova.fakerabbit [-] Declaring queue scheduler.839d604d78a44f168ae4356f251b8445 from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:37,849 DEBUG nova.fakerabbit [-] Binding scheduler.839d604d78a44f168ae4356f251b8445 to nova with key scheduler.839d604d78a44f168ae4356f251b8445 from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:37,849 INFO nova.rpc [-] Created "scheduler_fanout" fanout exchange with "scheduler" routing key 2011-07-19 15:09:37,849 DEBUG nova.rpc [-] Initing the Adapter Consumer for scheduler from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:37,849 DEBUG nova.fakerabbit [-] Declaring queue scheduler_fanout_ef7da0099efb469ba26a1694bbfb8ab2 from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:37,850 DEBUG nova.fakerabbit [-] Declaring exchange scheduler_fanout from (pid=4466) exchange_declare /tmp/tmp8ro60a/nova/fakerabbit.py:90 2011-07-19 15:09:37,850 DEBUG nova.fakerabbit [-] Binding scheduler_fanout_ef7da0099efb469ba26a1694bbfb8ab2 to scheduler_fanout with key scheduler from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:37,850 AUDIT nova [-] Starting network node (version 2011.3-LOCALBRANCH:LOCALREVISION) 2011-07-19 15:09:37,851 DEBUG nova.utils [-] Attempting to grab semaphore "iptables" for method "apply"... from (pid=4466) inner /tmp/tmp8ro60a/nova/utils.py:615 2011-07-19 15:09:37,851 DEBUG nova.utils [-] Attempting to grab file lock "iptables" for method "apply"... from (pid=4466) inner /tmp/tmp8ro60a/nova/utils.py:620 2011-07-19 15:09:37,852 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-save -t filter from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:37,852 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-restore from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:37,853 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-save -t nat from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:37,854 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-restore from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:37,855 DEBUG nova.linux_net [-] FAKE NET: sudo ip6tables-save -t filter from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:37,855 DEBUG nova.linux_net [-] FAKE NET: sudo ip6tables-restore from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:37,855 DEBUG nova.linux_net [-] FAKE NET: sudo ip addr add 169.254.169.254/32 scope link dev lo from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:37,878 DEBUG nova.utils [-] Attempting to grab semaphore "iptables" for method "apply"... from (pid=4466) inner /tmp/tmp8ro60a/nova/utils.py:615 2011-07-19 15:09:37,879 DEBUG nova.utils [-] Attempting to grab file lock "iptables" for method "apply"... from (pid=4466) inner /tmp/tmp8ro60a/nova/utils.py:620 2011-07-19 15:09:37,879 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-save -t filter from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:37,879 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-restore from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:37,879 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-save -t nat from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:37,881 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-restore from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:37,881 DEBUG nova.linux_net [-] FAKE NET: sudo ip6tables-save -t filter from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:37,881 DEBUG nova.linux_net [-] FAKE NET: sudo ip6tables-restore from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:37,890 DEBUG nova [-] Creating Consumer connection for Service network from (pid=4466) start /tmp/tmp8ro60a/nova/service.py:154 2011-07-19 15:09:37,890 DEBUG nova.rpc [-] Initing the Adapter Consumer for network from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:37,890 DEBUG nova.fakerabbit [-] Declaring queue network from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:37,891 DEBUG nova.fakerabbit [-] Binding network to nova with key network from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:37,891 DEBUG nova.rpc [-] Initing the Adapter Consumer for network.f63d690f381845378119e8a4077411d1 from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:37,891 DEBUG nova.fakerabbit [-] Declaring queue network.f63d690f381845378119e8a4077411d1 from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:37,892 DEBUG nova.fakerabbit [-] Binding network.f63d690f381845378119e8a4077411d1 to nova with key network.f63d690f381845378119e8a4077411d1 from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:37,892 INFO nova.rpc [-] Created "network_fanout" fanout exchange with "network" routing key 2011-07-19 15:09:37,892 DEBUG nova.rpc [-] Initing the Adapter Consumer for network from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:37,892 DEBUG nova.fakerabbit [-] Declaring queue network_fanout_190f73a5972247299cd935ba175cb276 from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:37,892 DEBUG nova.fakerabbit [-] Declaring exchange network_fanout from (pid=4466) exchange_declare /tmp/tmp8ro60a/nova/fakerabbit.py:90 2011-07-19 15:09:37,893 DEBUG nova.fakerabbit [-] Binding network_fanout_190f73a5972247299cd935ba175cb276 to network_fanout with key network from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:37,893 AUDIT nova [-] Starting volume node (version 2011.3-LOCALBRANCH:LOCALREVISION) 2011-07-19 15:09:37,909 DEBUG nova.volume.manager [-] Re-exporting 0 volumes from (pid=4466) init_host /tmp/tmp8ro60a/nova/volume/manager.py:84 2011-07-19 15:09:37,918 DEBUG nova [-] Creating Consumer connection for Service volume from (pid=4466) start /tmp/tmp8ro60a/nova/service.py:154 2011-07-19 15:09:37,919 DEBUG nova.rpc [-] Initing the Adapter Consumer for volume from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:37,919 DEBUG nova.fakerabbit [-] Declaring queue volume from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:37,919 DEBUG nova.fakerabbit [-] Binding volume to nova with key volume from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:37,919 DEBUG nova.rpc [-] Initing the Adapter Consumer for volume.64cc853cd18344b49d0637c7711507ac from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:37,920 DEBUG nova.fakerabbit [-] Declaring queue volume.64cc853cd18344b49d0637c7711507ac from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:37,920 DEBUG nova.fakerabbit [-] Binding volume.64cc853cd18344b49d0637c7711507ac to nova with key volume.64cc853cd18344b49d0637c7711507ac from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:37,920 INFO nova.rpc [-] Created "volume_fanout" fanout exchange with "volume" routing key 2011-07-19 15:09:37,920 DEBUG nova.rpc [-] Initing the Adapter Consumer for volume from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:37,921 DEBUG nova.fakerabbit [-] Declaring queue volume_fanout_de8ebb03587246d398ff8cd865fc2e90 from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:37,921 DEBUG nova.fakerabbit [-] Declaring exchange volume_fanout from (pid=4466) exchange_declare /tmp/tmp8ro60a/nova/fakerabbit.py:90 2011-07-19 15:09:37,921 DEBUG nova.fakerabbit [-] Binding volume_fanout_de8ebb03587246d398ff8cd865fc2e90 to volume_fanout with key volume from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:37,922 AUDIT nova.auth.manager [-] Created user admin (admin: True) 2011-07-19 15:09:37,923 DEBUG nova.ldapdriver [-] Local cache hit for __project_to_dn by key pid_dn-proj from (pid=4466) inner /tmp/tmp8ro60a/nova/auth/ldapdriver.py:188 2011-07-19 15:09:37,924 DEBUG nova.ldapdriver [-] Local cache hit for __dn_to_uid by key dn_uid-uid=admin,ou=Users,dc=example,dc=com from (pid=4466) inner /tmp/tmp8ro60a/nova/auth/ldapdriver.py:188 2011-07-19 15:09:37,924 AUDIT nova.auth.manager [-] Created project proj with manager admin --------------------- >> end captured logging << --------------------- test_terminate_instances OK 0.60 test_update_of_instance_display_fields OK 0.32 test_update_of_instance_wont_update_private_fields SKIP: EC2 stuff needs mac_address in instance_ref -------------------- >> begin captured logging << -------------------- 2011-07-19 15:09:38,931 AUDIT nova [-] Starting compute node (version 2011.3-LOCALBRANCH:LOCALREVISION) 2011-07-19 15:09:38,939 DEBUG nova [-] Creating Consumer connection for Service compute from (pid=4466) start /tmp/tmp8ro60a/nova/service.py:154 2011-07-19 15:09:38,939 DEBUG nova.rpc [-] Initing the Adapter Consumer for compute from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:38,940 DEBUG nova.fakerabbit [-] Declaring queue compute from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:38,940 DEBUG nova.fakerabbit [-] Declaring exchange nova from (pid=4466) exchange_declare /tmp/tmp8ro60a/nova/fakerabbit.py:90 2011-07-19 15:09:38,940 DEBUG nova.fakerabbit [-] Binding compute to nova with key compute from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:38,940 DEBUG nova.rpc [-] Initing the Adapter Consumer for compute.43b6ab6fe4a5438db30308e9ea7a42cc from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:38,941 DEBUG nova.fakerabbit [-] Declaring queue compute.43b6ab6fe4a5438db30308e9ea7a42cc from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:38,941 DEBUG nova.fakerabbit [-] Binding compute.43b6ab6fe4a5438db30308e9ea7a42cc to nova with key compute.43b6ab6fe4a5438db30308e9ea7a42cc from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:38,941 INFO nova.rpc [-] Created "compute_fanout" fanout exchange with "compute" routing key 2011-07-19 15:09:38,941 DEBUG nova.rpc [-] Initing the Adapter Consumer for compute from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:38,942 DEBUG nova.fakerabbit [-] Declaring queue compute_fanout_fa3ba55abff740f9badbe7d88997081e from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:38,942 DEBUG nova.fakerabbit [-] Declaring exchange compute_fanout from (pid=4466) exchange_declare /tmp/tmp8ro60a/nova/fakerabbit.py:90 2011-07-19 15:09:38,942 DEBUG nova.fakerabbit [-] Binding compute_fanout_fa3ba55abff740f9badbe7d88997081e to compute_fanout with key compute from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:38,943 AUDIT nova [-] Starting scheduler node (version 2011.3-LOCALBRANCH:LOCALREVISION) 2011-07-19 15:09:38,950 DEBUG nova [-] Creating Consumer connection for Service scheduler from (pid=4466) start /tmp/tmp8ro60a/nova/service.py:154 2011-07-19 15:09:38,951 DEBUG nova.rpc [-] Initing the Adapter Consumer for scheduler from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:38,951 DEBUG nova.fakerabbit [-] Declaring queue scheduler from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:38,951 DEBUG nova.fakerabbit [-] Binding scheduler to nova with key scheduler from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:38,951 DEBUG nova.rpc [-] Initing the Adapter Consumer for scheduler.e03fdf8876a948589fbdfa3e52bd4ae6 from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:38,952 DEBUG nova.fakerabbit [-] Declaring queue scheduler.e03fdf8876a948589fbdfa3e52bd4ae6 from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:38,952 DEBUG nova.fakerabbit [-] Binding scheduler.e03fdf8876a948589fbdfa3e52bd4ae6 to nova with key scheduler.e03fdf8876a948589fbdfa3e52bd4ae6 from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:38,952 INFO nova.rpc [-] Created "scheduler_fanout" fanout exchange with "scheduler" routing key 2011-07-19 15:09:38,952 DEBUG nova.rpc [-] Initing the Adapter Consumer for scheduler from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:38,953 DEBUG nova.fakerabbit [-] Declaring queue scheduler_fanout_5029b430ac05496facef0a9cd28e1439 from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:38,953 DEBUG nova.fakerabbit [-] Declaring exchange scheduler_fanout from (pid=4466) exchange_declare /tmp/tmp8ro60a/nova/fakerabbit.py:90 2011-07-19 15:09:38,953 DEBUG nova.fakerabbit [-] Binding scheduler_fanout_5029b430ac05496facef0a9cd28e1439 to scheduler_fanout with key scheduler from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:38,953 AUDIT nova [-] Starting network node (version 2011.3-LOCALBRANCH:LOCALREVISION) 2011-07-19 15:09:38,954 DEBUG nova.utils [-] Attempting to grab semaphore "iptables" for method "apply"... from (pid=4466) inner /tmp/tmp8ro60a/nova/utils.py:615 2011-07-19 15:09:38,954 DEBUG nova.utils [-] Attempting to grab file lock "iptables" for method "apply"... from (pid=4466) inner /tmp/tmp8ro60a/nova/utils.py:620 2011-07-19 15:09:38,954 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-save -t filter from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:38,955 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-restore from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:38,955 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-save -t nat from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:38,956 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-restore from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:38,956 DEBUG nova.linux_net [-] FAKE NET: sudo ip6tables-save -t filter from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:38,957 DEBUG nova.linux_net [-] FAKE NET: sudo ip6tables-restore from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:38,957 DEBUG nova.linux_net [-] FAKE NET: sudo ip addr add 169.254.169.254/32 scope link dev lo from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:38,980 DEBUG nova.utils [-] Attempting to grab semaphore "iptables" for method "apply"... from (pid=4466) inner /tmp/tmp8ro60a/nova/utils.py:615 2011-07-19 15:09:38,980 DEBUG nova.utils [-] Attempting to grab file lock "iptables" for method "apply"... from (pid=4466) inner /tmp/tmp8ro60a/nova/utils.py:620 2011-07-19 15:09:38,981 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-save -t filter from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:38,981 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-restore from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:38,981 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-save -t nat from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:38,983 DEBUG nova.linux_net [-] FAKE NET: sudo iptables-restore from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:38,983 DEBUG nova.linux_net [-] FAKE NET: sudo ip6tables-save -t filter from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:38,983 DEBUG nova.linux_net [-] FAKE NET: sudo ip6tables-restore from (pid=4466) _execute /tmp/tmp8ro60a/nova/network/linux_net.py:686 2011-07-19 15:09:38,992 DEBUG nova [-] Creating Consumer connection for Service network from (pid=4466) start /tmp/tmp8ro60a/nova/service.py:154 2011-07-19 15:09:38,992 DEBUG nova.rpc [-] Initing the Adapter Consumer for network from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:38,992 DEBUG nova.fakerabbit [-] Declaring queue network from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:38,993 DEBUG nova.fakerabbit [-] Binding network to nova with key network from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:38,993 DEBUG nova.rpc [-] Initing the Adapter Consumer for network.6454feb3500545e6a0df74b60cdff1b4 from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:38,993 DEBUG nova.fakerabbit [-] Declaring queue network.6454feb3500545e6a0df74b60cdff1b4 from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:38,993 DEBUG nova.fakerabbit [-] Binding network.6454feb3500545e6a0df74b60cdff1b4 to nova with key network.6454feb3500545e6a0df74b60cdff1b4 from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:38,994 INFO nova.rpc [-] Created "network_fanout" fanout exchange with "network" routing key 2011-07-19 15:09:38,994 DEBUG nova.rpc [-] Initing the Adapter Consumer for network from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:38,994 DEBUG nova.fakerabbit [-] Declaring queue network_fanout_0461d618751045b79b0f50174224b1c9 from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:38,994 DEBUG nova.fakerabbit [-] Declaring exchange network_fanout from (pid=4466) exchange_declare /tmp/tmp8ro60a/nova/fakerabbit.py:90 2011-07-19 15:09:38,995 DEBUG nova.fakerabbit [-] Binding network_fanout_0461d618751045b79b0f50174224b1c9 to network_fanout with key network from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:38,995 AUDIT nova [-] Starting volume node (version 2011.3-LOCALBRANCH:LOCALREVISION) 2011-07-19 15:09:39,022 DEBUG nova.volume.manager [-] Re-exporting 0 volumes from (pid=4466) init_host /tmp/tmp8ro60a/nova/volume/manager.py:84 2011-07-19 15:09:39,031 DEBUG nova [-] Creating Consumer connection for Service volume from (pid=4466) start /tmp/tmp8ro60a/nova/service.py:154 2011-07-19 15:09:39,031 DEBUG nova.rpc [-] Initing the Adapter Consumer for volume from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:39,032 DEBUG nova.fakerabbit [-] Declaring queue volume from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:39,032 DEBUG nova.fakerabbit [-] Binding volume to nova with key volume from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:39,032 DEBUG nova.rpc [-] Initing the Adapter Consumer for volume.268a4a616f6148129945b52e5f54a82a from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:39,032 DEBUG nova.fakerabbit [-] Declaring queue volume.268a4a616f6148129945b52e5f54a82a from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:39,033 DEBUG nova.fakerabbit [-] Binding volume.268a4a616f6148129945b52e5f54a82a to nova with key volume.268a4a616f6148129945b52e5f54a82a from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:39,033 INFO nova.rpc [-] Created "volume_fanout" fanout exchange with "volume" routing key 2011-07-19 15:09:39,033 DEBUG nova.rpc [-] Initing the Adapter Consumer for volume from (pid=4466) __init__ /tmp/tmp8ro60a/nova/rpc.py:182 2011-07-19 15:09:39,033 DEBUG nova.fakerabbit [-] Declaring queue volume_fanout_f84e45d6202d40db91eeac7d0b60e0a5 from (pid=4466) queue_declare /tmp/tmp8ro60a/nova/fakerabbit.py:84 2011-07-19 15:09:39,034 DEBUG nova.fakerabbit [-] Declaring exchange volume_fanout from (pid=4466) exchange_declare /tmp/tmp8ro60a/nova/fakerabbit.py:90 2011-07-19 15:09:39,034 DEBUG nova.fakerabbit [-] Binding volume_fanout_f84e45d6202d40db91eeac7d0b60e0a5 to volume_fanout with key volume from (pid=4466) queue_bind /tmp/tmp8ro60a/nova/fakerabbit.py:97 2011-07-19 15:09:39,035 AUDIT nova.auth.manager [-] Created user admin (admin: True) 2011-07-19 15:09:39,036 DEBUG nova.ldapdriver [-] Local cache hit for __project_to_dn by key pid_dn-proj from (pid=4466) inner /tmp/tmp8ro60a/nova/auth/ldapdriver.py:188 2011-07-19 15:09:39,037 DEBUG nova.ldapdriver [-] Local cache hit for __dn_to_uid by key dn_uid-uid=admin,ou=Users,dc=example,dc=com from (pid=4466) inner /tmp/tmp8ro60a/nova/auth/ldapdriver.py:188 2011-07-19 15:09:39,037 AUDIT nova.auth.manager [-] Created project proj with manager admin --------------------- >> end captured logging << --------------------- test_update_of_volume_display_fields OK 0.24 test_update_of_volume_wont_update_private_fields OK 0.20 ComputeTestCase test_agent_update OK 0.94 test_ajax_console OK 1.34 test_console_output OK 0.88 test_create_instance_associates_security_groups OK 0.28 test_create_instance_defaults_display_name OK 1.01 test_default_hostname_generator OK 0.72 test_destroy_instance_disassociates_security_groups OK 0.27 test_destroy_security_group_disassociates_instances OK 0.29 test_finish_resize OK 1.13 test_get_by_flavor_id OK 0.03 test_inject_file OK 0.95 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.93 test_migrate OK 0.90 test_pause OK 1.68 test_post_live_migration_working_correctly OK 0.51 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.76 test_resize_down_fails OK 0.97 test_resize_instance OK 1.73 test_resize_instance_notification OK 1.04 test_resize_invalid_flavor_fails OK 1.35 test_resize_same_size_fails OK 0.90 test_resize_same_source_fails OK 2.50 test_run_instance_existing OK 0.95 test_run_instance_usage_notification OK 0.85 test_run_kill_vm OK 1.43 test_run_terminate OK 0.91 test_run_terminate_timestamps OK 1.55 test_set_admin_password OK 0.98 test_snapshot OK 1.54 test_start OK 2.15 test_stop OK 0.98 test_suspend OK 1.77 test_terminate_usage_notification OK 0.86 test_update_block_device_mapping OK 0.43 test_vnc_console OK 1.34 ConsoleTestCase test_add_console OK 0.20 test_add_console_does_not_duplicate OK 0.20 test_get_pool_creates_new_pool_if_needed OK 0.05 test_get_pool_does_not_create_new_pool_if_exists OK 0.03 test_get_pool_for_instance_host OK 0.04 test_remove_console OK 0.13 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.01 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.06 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.02 test_instance_type_get_all OK 0.03 test_instance_type_get_by_id_with_extra_specs OK 0.04 test_instance_type_get_by_name_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-19 15:10:19,792 AUDIT nova.auth.manager [-] Created user fake (admin: True) 2011-07-19 15:10:19,793 DEBUG nova.ldapdriver [-] Local cache hit for __project_to_dn by key pid_dn-fake from (pid=4466) inner /tmp/tmp8ro60a/nova/auth/ldapdriver.py:188 2011-07-19 15:10:19,794 DEBUG nova.ldapdriver [-] Local cache hit for __dn_to_uid by key dn_uid-uid=fake,ou=Users,dc=example,dc=com from (pid=4466) inner /tmp/tmp8ro60a/nova/auth/ldapdriver.py:188 2011-07-19 15:10:19,794 AUDIT nova.auth.manager [-] Created project fake with manager fake --------------------- >> end captured logging << --------------------- test_filters_for_instance_with_ip_v6 OK 0.01 test_filters_for_instance_without_ip_v6 OK 0.01 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-19 15:10:19,877 AUDIT nova.auth.manager [-] Created user fake (admin: True) 2011-07-19 15:10:19,878 DEBUG nova.ldapdriver [-] Local cache hit for __project_to_dn by key pid_dn-fake from (pid=4466) inner /tmp/tmp8ro60a/nova/auth/ldapdriver.py:188 2011-07-19 15:10:19,879 DEBUG nova.ldapdriver [-] Local cache hit for __dn_to_uid by key dn_uid-uid=fake,ou=Users,dc=example,dc=com from (pid=4466) inner /tmp/tmp8ro60a/nova/auth/ldapdriver.py:188 2011-07-19 15:10:19,879 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-19 15:10:19,892 AUDIT nova.auth.manager [-] Created user fake (admin: True) 2011-07-19 15:10:19,893 DEBUG nova.ldapdriver [-] Local cache hit for __project_to_dn by key pid_dn-fake from (pid=4466) inner /tmp/tmp8ro60a/nova/auth/ldapdriver.py:188 2011-07-19 15:10:19,894 DEBUG nova.ldapdriver [-] Local cache hit for __dn_to_uid by key dn_uid-uid=fake,ou=Users,dc=example,dc=com from (pid=4466) inner /tmp/tmp8ro60a/nova/auth/ldapdriver.py:188 2011-07-19 15:10:19,894 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-19 15:10:19,909 AUDIT nova.auth.manager [-] Created user fake (admin: True) 2011-07-19 15:10:19,910 DEBUG nova.ldapdriver [-] Local cache hit for __project_to_dn by key pid_dn-fake from (pid=4466) inner /tmp/tmp8ro60a/nova/auth/ldapdriver.py:188 2011-07-19 15:10:19,911 DEBUG nova.ldapdriver [-] Local cache hit for __dn_to_uid by key dn_uid-uid=fake,ou=Users,dc=example,dc=com from (pid=4466) inner /tmp/tmp8ro60a/nova/auth/ldapdriver.py:188 2011-07-19 15:10:19,911 AUDIT nova.auth.manager [-] Created project fake with manager fake --------------------- >> end captured logging << --------------------- LibvirtConnTestCase test_ensure_filtering_rules_for_instance_timeout OK 0.03 test_get_host_ip_addr OK 0.01 test_get_nic_for_xml_v4 OK 0.01 test_get_nic_for_xml_v6 OK 0.01 test_live_migration_raises_exception ERROR test_lxc_container_and_uri SKIP: skipping libvirt tests depends on get_network_info shim -------------------- >> begin captured logging << -------------------- 2011-07-19 15:10:20,012 AUDIT nova.auth.manager [-] Created user fake (admin: True) 2011-07-19 15:10:20,013 DEBUG nova.ldapdriver [-] Local cache hit for __project_to_dn by key pid_dn-fake from (pid=4466) inner /tmp/tmp8ro60a/nova/auth/ldapdriver.py:188 2011-07-19 15:10:20,014 DEBUG nova.ldapdriver [-] Local cache hit for __dn_to_uid by key dn_uid-uid=fake,ou=Users,dc=example,dc=com from (pid=4466) inner /tmp/tmp8ro60a/nova/auth/ldapdriver.py:188 2011-07-19 15:10:20,014 AUDIT nova.auth.manager [-] Created project fake with manager fake --------------------- >> end captured logging << --------------------- test_multi_nic OK 0.09 test_preparing_xml_info SKIP: Please review this test to ensure intent -------------------- >> begin captured logging << -------------------- 2011-07-19 15:10:20,120 AUDIT nova.auth.manager [-] Created user fake (admin: True) 2011-07-19 15:10:20,121 DEBUG nova.ldapdriver [-] Local cache hit for __project_to_dn by key pid_dn-fake from (pid=4466) inner /tmp/tmp8ro60a/nova/auth/ldapdriver.py:188 2011-07-19 15:10:20,122 DEBUG nova.ldapdriver [-] Local cache hit for __dn_to_uid by key dn_uid-uid=fake,ou=Users,dc=example,dc=com from (pid=4466) inner /tmp/tmp8ro60a/nova/auth/ldapdriver.py:188 2011-07-19 15:10:20,122 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-19 15:10:20,178 AUDIT nova.auth.manager [-] Created user fake (admin: True) 2011-07-19 15:10:20,179 DEBUG nova.ldapdriver [-] Local cache hit for __project_to_dn by key pid_dn-fake from (pid=4466) inner /tmp/tmp8ro60a/nova/auth/ldapdriver.py:188 2011-07-19 15:10:20,180 DEBUG nova.ldapdriver [-] Local cache hit for __dn_to_uid by key dn_uid-uid=fake,ou=Users,dc=example,dc=com from (pid=4466) inner /tmp/tmp8ro60a/nova/auth/ldapdriver.py:188 2011-07-19 15:10:20,180 AUDIT nova.auth.manager [-] Created project fake with manager fake --------------------- >> end captured logging << --------------------- test_update_available_resource_works_correctly OK 0.06 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-19 15:10:20,277 AUDIT nova.auth.manager [-] Created user fake (admin: True) 2011-07-19 15:10:20,278 DEBUG nova.ldapdriver [-] Local cache hit for __project_to_dn by key pid_dn-fake from (pid=4466) inner /tmp/tmp8ro60a/nova/auth/ldapdriver.py:188 2011-07-19 15:10:20,278 DEBUG nova.ldapdriver [-] Local cache hit for __dn_to_uid by key dn_uid-uid=fake,ou=Users,dc=example,dc=com from (pid=4466) inner /tmp/tmp8ro60a/nova/auth/ldapdriver.py:188 2011-07-19 15:10:20,279 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-19 15:10:20,290 AUDIT nova.auth.manager [-] Created user fake (admin: True) 2011-07-19 15:10:20,291 DEBUG nova.ldapdriver [-] Local cache hit for __project_to_dn by key pid_dn-fake from (pid=4466) inner /tmp/tmp8ro60a/nova/auth/ldapdriver.py:188 2011-07-19 15:10:20,292 DEBUG nova.ldapdriver [-] Local cache hit for __dn_to_uid by key dn_uid-uid=fake,ou=Users,dc=example,dc=com from (pid=4466) inner /tmp/tmp8ro60a/nova/auth/ldapdriver.py:188 2011-07-19 15:10:20,292 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-19 15:10:20,304 AUDIT nova.auth.manager [-] Created user fake (admin: True) 2011-07-19 15:10:20,305 DEBUG nova.ldapdriver [-] Local cache hit for __project_to_dn by key pid_dn-fake from (pid=4466) inner /tmp/tmp8ro60a/nova/auth/ldapdriver.py:188 2011-07-19 15:10:20,305 DEBUG nova.ldapdriver [-] Local cache hit for __dn_to_uid by key dn_uid-uid=fake,ou=Users,dc=example,dc=com from (pid=4466) inner /tmp/tmp8ro60a/nova/auth/ldapdriver.py:188 2011-07-19 15:10:20,306 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-19 15:10:20,318 AUDIT nova.auth.manager [-] Created user fake (admin: True) 2011-07-19 15:10:20,319 DEBUG nova.ldapdriver [-] Local cache hit for __project_to_dn by key pid_dn-fake from (pid=4466) inner /tmp/tmp8ro60a/nova/auth/ldapdriver.py:188 2011-07-19 15:10:20,319 DEBUG nova.ldapdriver [-] Local cache hit for __dn_to_uid by key dn_uid-uid=fake,ou=Users,dc=example,dc=com from (pid=4466) inner /tmp/tmp8ro60a/nova/auth/ldapdriver.py:188 2011-07-19 15:10:20,320 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-19 15:10:20,331 AUDIT nova.auth.manager [-] Created user fake (admin: True) 2011-07-19 15:10:20,332 DEBUG nova.ldapdriver [-] Local cache hit for __project_to_dn by key pid_dn-fake from (pid=4466) inner /tmp/tmp8ro60a/nova/auth/ldapdriver.py:188 2011-07-19 15:10:20,333 DEBUG nova.ldapdriver [-] Local cache hit for __dn_to_uid by key dn_uid-uid=fake,ou=Users,dc=example,dc=com from (pid=4466) inner /tmp/tmp8ro60a/nova/auth/ldapdriver.py:188 2011-07-19 15:10:20,333 AUDIT nova.auth.manager [-] Created project fake with manager fake --------------------- >> end captured logging << --------------------- NWFilterTestCase test_cidr_rule_nwfilter_xml OK 0.20 test_create_network_filters OK 0.02 test_creates_base_rule_first SKIP: Skipping this test -------------------- >> begin captured logging << -------------------- 2011-07-19 15:10:20,567 AUDIT nova.auth.manager [-] Created user fake (admin: True) 2011-07-19 15:10:20,568 DEBUG nova.ldapdriver [-] Local cache hit for __project_to_dn by key pid_dn-fake from (pid=4466) inner /tmp/tmp8ro60a/nova/auth/ldapdriver.py:188 2011-07-19 15:10:20,569 DEBUG nova.ldapdriver [-] Local cache hit for __dn_to_uid by key dn_uid-uid=fake,ou=Users,dc=example,dc=com from (pid=4466) inner /tmp/tmp8ro60a/nova/auth/ldapdriver.py:188 2011-07-19 15:10:20,569 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-19 15:10:20,580 AUDIT nova.auth.manager [-] Created user fake (admin: True) 2011-07-19 15:10:20,582 DEBUG nova.ldapdriver [-] Local cache hit for __project_to_dn by key pid_dn-fake from (pid=4466) inner /tmp/tmp8ro60a/nova/auth/ldapdriver.py:188 2011-07-19 15:10:20,582 DEBUG nova.ldapdriver [-] Local cache hit for __dn_to_uid by key dn_uid-uid=fake,ou=Users,dc=example,dc=com from (pid=4466) inner /tmp/tmp8ro60a/nova/auth/ldapdriver.py:188 2011-07-19 15:10:20,582 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.04 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.49 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 test_set_network_hosts OK 0.00 VlanNetworkTestCase test_allocate_fixed_ip OK 0.00 test_create_networks_too_big OK 0.00 test_create_networks_too_many OK 0.00 test_vpn_allocate_fixed_ip OK 0.00 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.05 test_unknown_bucket OK 0.57 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.08 test_max_injected_file_content_bytes OK 0.32 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.08 test_overridden_allowed_injected_files OK 0.08 test_quota_overrides OK 0.14 test_too_many_cores OK 0.11 test_too_many_gigabytes OK 0.09 test_too_many_injected_file_content_bytes OK 0.10 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.10 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.08 test_unlimited_default_allowed_injected_file_content_bytes OK 0.07 test_unlimited_default_allowed_injected_files OK 0.08 test_unlimited_floating_ips OK 0.11 test_unlimited_gigabytes OK 0.11 test_unlimited_instances OK 0.13 test_unlimited_metadata_items OK 0.09 test_unlimited_ram OK 0.65 test_unlimited_volumes OK 0.10 RpcTestCase test_call_exception OK 0.15 test_call_succeed OK 0.05 test_call_succeed_despite_multiple_returns OK 0.08 test_call_succeed_despite_multiple_returns_yield OK 0.08 test_connectionpool_double OK 0.01 test_connectionpool_limit OK 0.01 test_connectionpool_single OK 0.01 test_context_passed OK 0.06 test_multicall_succeed_once OK 0.05 test_multicall_succeed_three_times OK 0.08 test_multicall_succeed_three_times_yield OK 0.08 test_nested_calls OK 0.19 ServiceFlagsTestCase test_service_disabled_on_create_based_on_flag OK 0.05 test_service_enabled_on_create_based_on_flag OK 0.05 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.10 TestWSGIService test_service_random_port OK 0.02 IsolationTestCase test_rpc_consumer_isolation OK 0.01 test_service_isolation OK 0.07 TwistdTestCase test_basic OK 0.08 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.11 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 6.91 test_check_for_export_with_no_volume OK 0.08 test_check_for_export_with_vblade_process_missing OK 6.80 ISCSITestCase test_check_for_export_with_all_volume_exported OK 0.81 test_check_for_export_with_no_volume OK 0.08 test_check_for_export_with_some_volume_missing OK 1.42 VolumeTestCase test_concurrent_volumes_get_different_targets OK 1.23 test_create_delete_snapshot OK 0.42 test_create_delete_volume OK 0.20 test_create_snapshot_force OK 0.27 test_create_volume_from_snapshot OK 0.34 test_multi_node OK 0.02 test_run_attach_detach_volume OK 0.38 test_too_big_volume OK 0.02 test_too_many_volumes OK 1.02 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.51 test_instance_disk_raw OK 0.00 XenAPIDiffieHellmanTestCase test_encrypt_many_newlines_at_end OK 0.23 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.23 test_encrypt_simple_message OK 0.23 test_encrypt_with_leading_newlines OK 0.23 test_shared OK 0.00 XenAPIMigrateInstance test_finish_resize OK 0.23 test_migrate_disk_and_power_off OK 0.04 XenAPIVMTestCase test_get_diagnostics OK 0.28 test_instance_snapshot OK 0.24 test_instance_snapshot_fails_with_no_primary_vdi OK 0.21 test_list_instances_0 OK 0.02 test_parallel_builds OK 3.61 test_rescue OK 0.26 test_spawn_fail_cleanup_1 OK 0.04 test_spawn_fail_cleanup_2 OK 0.21 test_spawn_glance OK 0.36 test_spawn_netinject_file OK 2.02 test_spawn_netinject_xenstore OK 0.36 test_spawn_not_enough_memory OK 0.12 test_spawn_objectstore OK 0.30 test_spawn_raw_glance OK 0.22 test_spawn_raw_objectstore OK 0.27 test_spawn_vhd_glance_linux OK 0.29 test_spawn_vhd_glance_swapdisk OK 0.56 test_spawn_vhd_glance_windows OK 0.93 test_spawn_vlanmanager SKIP: Never gets an address, not sure why -------------------- >> begin captured logging << -------------------- 2011-07-19 15:11:06,860 AUDIT nova.auth.manager [-] Created user fake (admin: True) 2011-07-19 15:11:06,862 DEBUG nova.ldapdriver [-] Local cache hit for __project_to_dn by key pid_dn-fake from (pid=4466) inner /tmp/tmp8ro60a/nova/auth/ldapdriver.py:188 2011-07-19 15:11:06,863 DEBUG nova.ldapdriver [-] Local cache hit for __dn_to_uid by key dn_uid-uid=fake,ou=Users,dc=example,dc=com from (pid=4466) inner /tmp/tmp8ro60a/nova/auth/ldapdriver.py:188 2011-07-19 15:11:06,864 AUDIT nova.auth.manager [-] Created project fake with manager fake --------------------- >> end captured logging << --------------------- test_spawn_with_network_qos OK 0.26 test_unrescue OK 0.25 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.00 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.01 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.01 test_refresh_from_db_missing OK 0.00 test_refresh_from_db_new OK 0.00 test_refresh_from_db_replace_existing OK 0.00 test_service_capabilities OK 0.01 ====================================================================== ERROR: test_live_migration_raises_exception (nova.tests.test_libvirt.LibvirtConnTestCase) ---------------------------------------------------------------------- SkipTest: libvirt required for this test -------------------- >> begin captured logging << -------------------- 2011-07-19 15:10:19,996 AUDIT nova.auth.manager [-] Created user fake (admin: True) 2011-07-19 15:10:19,997 DEBUG nova.ldapdriver [-] Local cache hit for __project_to_dn by key pid_dn-fake from (pid=4466) inner /tmp/tmp8ro60a/nova/auth/ldapdriver.py:188 2011-07-19 15:10:19,998 DEBUG nova.ldapdriver [-] Local cache hit for __dn_to_uid by key dn_uid-uid=fake,ou=Users,dc=example,dc=com from (pid=4466) inner /tmp/tmp8ro60a/nova/auth/ldapdriver.py:188 2011-07-19 15:10:19,998 AUDIT nova.auth.manager [-] Created project fake with manager fake --------------------- >> end captured logging << --------------------- ---------------------------------------------------------------------- Ran 1029 tests in 228.643s FAILED (SKIP=44, errors=1) Slowest 5 tests took 32.54 secs: 8.26 test_too_many_cores (nova.tests.scheduler.test_scheduler.SimpleDriverTestCase) 6.91 test_check_for_export_with_all_vblade_processes (nova.tests.test_volume.AOETestCase) 6.80 test_check_for_export_with_vblade_process_missing (nova.tests.test_volume.AOETestCase) 5.40 test_attach_and_detach_volume (nova.tests.integrated.test_volumes.VolumesTest) 5.17 test_create_image (nova.tests.test_cloud.CloudTestCase)