Dec 07 22:24:36.550 INFO testing bluenrg-0.0.3 against master#906deae0790bd18681b937fe9a141a3c26cf1855 for pr-56514
Dec 07 22:24:36.550 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-6/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +906deae0790bd18681b937fe9a141a3c26cf1855-alt build --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 07 22:24:36.991 INFO [stdout] 2ecf239993e7f481d0f88924875f8fc25a13271d7a20c4f8fec1a665fb5fd3db
Dec 07 22:24:36.993 INFO running `"docker" "start" "-a" "2ecf239993e7f481d0f88924875f8fc25a13271d7a20c4f8fec1a665fb5fd3db"`
Dec 07 22:24:37.976 INFO [stderr] usermod: no changes
Dec 07 22:24:38.089 INFO [stderr]    Compiling bluetooth-hci v0.0.3
Dec 07 22:24:42.308 INFO [stderr]    Compiling bluenrg v0.0.3 (/source)
Dec 07 22:24:44.944 INFO [stderr] warning: the feature `extern_prelude` has been stable since 1.30.0 and no longer requires an attribute to enable
Dec 07 22:24:44.944 INFO [stderr]   --> src/lib.rs:42:12
Dec 07 22:24:44.944 INFO [stderr]    |
Dec 07 22:24:44.944 INFO [stderr] 42 | #![feature(extern_prelude)]
Dec 07 22:24:44.944 INFO [stderr]    |            ^^^^^^^^^^^^^^
Dec 07 22:24:44.944 INFO [stderr]    |
Dec 07 22:24:44.944 INFO [stderr]    = note: #[warn(stable_features)] on by default
Dec 07 22:24:44.944 INFO [stderr] 
Dec 07 22:24:44.976 INFO [stderr] warning: unused `core::result::Result` that must be used
Dec 07 22:24:44.976 INFO [stderr]     --> src/event/command.rs:1006:9
Dec 07 22:24:44.976 INFO [stderr]      |
Dec 07 22:24:44.976 INFO [stderr] 1006 |         write!(f, "status: {:?}; value: {{", self.status);
Dec 07 22:24:44.976 INFO [stderr]      |         ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 07 22:24:44.976 INFO [stderr]      |
Dec 07 22:24:44.976 INFO [stderr]      = note: #[warn(unused_must_use)] on by default
Dec 07 22:24:44.976 INFO [stderr]      = note: this `Result` may be an `Err` variant, which should be handled
Dec 07 22:24:44.976 INFO [stderr]      = note: this error originates in a macro outside of the current crate (in Nightly builds, run with -Z external-macro-backtrace for more info)
Dec 07 22:24:44.976 INFO [stderr] 
Dec 07 22:24:46.345 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 8.34s
Dec 07 22:24:46.353 INFO [stderr] su: No module specific data is present
Dec 07 22:24:46.692 INFO running `"docker" "inspect" "2ecf239993e7f481d0f88924875f8fc25a13271d7a20c4f8fec1a665fb5fd3db"`
Dec 07 22:24:47.088 INFO running `"docker" "rm" "-f" "2ecf239993e7f481d0f88924875f8fc25a13271d7a20c4f8fec1a665fb5fd3db"`
Dec 07 22:24:47.416 INFO [stdout] 2ecf239993e7f481d0f88924875f8fc25a13271d7a20c4f8fec1a665fb5fd3db
Dec 07 22:24:47.476 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-6/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +906deae0790bd18681b937fe9a141a3c26cf1855-alt test --frozen --no-run" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 07 22:24:47.990 INFO [stdout] 2d0696139aab2c222b573720f8ee308eb8ada98c3bf920cc3ef64b3f968a397d
Dec 07 22:24:47.996 INFO running `"docker" "start" "-a" "2d0696139aab2c222b573720f8ee308eb8ada98c3bf920cc3ef64b3f968a397d"`
Dec 07 22:24:49.262 INFO [stderr] usermod: no changes
Dec 07 22:24:49.325 INFO [stderr]    Compiling bluenrg v0.0.3 (/source)
Dec 07 22:24:55.012 INFO [stderr] warning: the feature `extern_prelude` has been stable since 1.30.0 and no longer requires an attribute to enable
Dec 07 22:24:55.012 INFO [stderr]   --> src/lib.rs:42:12
Dec 07 22:24:55.012 INFO [stderr]    |
Dec 07 22:24:55.012 INFO [stderr] 42 | #![feature(extern_prelude)]
Dec 07 22:24:55.012 INFO [stderr]    |            ^^^^^^^^^^^^^^
Dec 07 22:24:55.012 INFO [stderr]    |
Dec 07 22:24:55.012 INFO [stderr]    = note: #[warn(stable_features)] on by default
Dec 07 22:24:55.012 INFO [stderr] 
Dec 07 22:24:55.056 INFO [stderr] warning: unused `core::result::Result` that must be used
Dec 07 22:24:55.056 INFO [stderr]     --> src/event/command.rs:1006:9
Dec 07 22:24:55.056 INFO [stderr]      |
Dec 07 22:24:55.056 INFO [stderr] 1006 |         write!(f, "status: {:?}; value: {{", self.status);
Dec 07 22:24:55.056 INFO [stderr]      |         ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 07 22:24:55.056 INFO [stderr]      |
Dec 07 22:24:55.056 INFO [stderr]      = note: #[warn(unused_must_use)] on by default
Dec 07 22:24:55.056 INFO [stderr]      = note: this `Result` may be an `Err` variant, which should be handled
Dec 07 22:24:55.056 INFO [stderr]      = note: this error originates in a macro outside of the current crate (in Nightly builds, run with -Z external-macro-backtrace for more info)
Dec 07 22:24:55.056 INFO [stderr] 
Dec 07 22:24:55.837 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 6.55s
Dec 07 22:24:55.845 INFO [stderr] su: No module specific data is present
Dec 07 22:24:56.147 INFO running `"docker" "inspect" "2d0696139aab2c222b573720f8ee308eb8ada98c3bf920cc3ef64b3f968a397d"`
Dec 07 22:24:56.242 INFO running `"docker" "rm" "-f" "2d0696139aab2c222b573720f8ee308eb8ada98c3bf920cc3ef64b3f968a397d"`
Dec 07 22:24:56.342 INFO [stdout] 2d0696139aab2c222b573720f8ee308eb8ada98c3bf920cc3ef64b3f968a397d
Dec 07 22:24:56.344 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-6/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +906deae0790bd18681b937fe9a141a3c26cf1855-alt test --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 07 22:24:56.512 INFO [stdout] 29c2ae92d47efcbb12cf6c2fd77784c7623582f9465ef65f1ae1e7b39f23f0ae
Dec 07 22:24:56.513 INFO running `"docker" "start" "-a" "29c2ae92d47efcbb12cf6c2fd77784c7623582f9465ef65f1ae1e7b39f23f0ae"`
Dec 07 22:24:56.928 INFO [stderr] usermod: no changes
Dec 07 22:24:56.976 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.02s
Dec 07 22:24:56.985 INFO [stderr]      Running /target/debug/deps/bluenrg-c8c12a21a517a710
Dec 07 22:24:56.986 INFO [stdout] 
Dec 07 22:24:56.987 INFO [stdout] running 6 tests
Dec 07 22:24:56.988 INFO [stdout] test cb::tests::peek ... ok
Dec 07 22:24:56.988 INFO [stdout] test cb::tests::empty_capacity ... ok
Dec 07 22:24:56.992 INFO [stdout] test cb::tests::empty_capacity_after_use ... ok
Dec 07 22:24:57.031 INFO [stdout] test cb::tests::request_too_many_bytes_read ... ok
Dec 07 22:24:57.031 INFO [stdout] test cb::tests::request_too_many_bytes_write ... ok
Dec 07 22:24:57.031 INFO [stdout] test cb::tests::request_peek_too_far ... ok
Dec 07 22:24:57.031 INFO [stdout] 
Dec 07 22:24:57.031 INFO [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 22:24:57.032 INFO [stdout] 
Dec 07 22:24:57.033 INFO [stderr]      Running /target/debug/deps/cb-3418bd11f906f1e2
Dec 07 22:24:57.035 INFO [stdout] 
Dec 07 22:24:57.035 INFO [stdout] running 0 tests
Dec 07 22:24:57.035 INFO [stdout] 
Dec 07 22:24:57.035 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 22:24:57.035 INFO [stdout] 
Dec 07 22:24:57.035 INFO [stderr]      Running /target/debug/deps/command_complete-085bbb87229f1f34
Dec 07 22:24:57.037 INFO [stdout] 
Dec 07 22:24:57.037 INFO [stdout] running 69 tests
Dec 07 22:24:57.038 INFO [stdout] test gap_get_bonded_addresses_bad_addr_type ... ok
Dec 07 22:24:57.038 INFO [stdout] test gap_get_bonded_addresses ... ok
Dec 07 22:24:57.038 INFO [stdout] test gap_delete_ad_type ... ok
Dec 07 22:24:57.038 INFO [stdout] test gap_configure_white_list ... ok
Dec 07 22:24:57.038 INFO [stdout] test gap_get_security_level ... ok
Dec 07 22:24:57.038 INFO [stdout] test gap_get_security_level_bad_pass_key_requirement ... ok
Dec 07 22:24:57.039 INFO [stdout] test gap_init ... ok
Dec 07 22:24:57.039 INFO [stdout] test gap_get_bonded_addresses_partial ... ok
Dec 07 22:24:57.039 INFO [stdout] test gap_pass_key_response ... ok
Dec 07 22:24:57.039 INFO [stdout] test gap_is_device_bonded ... ok
Dec 07 22:24:57.039 INFO [stdout] test gap_get_security_level_bad_bool ... ok
Dec 07 22:24:57.039 INFO [stdout] test gap_get_bonded_addresses_failed_mixed_signals ... ok
Dec 07 22:24:57.039 INFO [stdout] test gap_resolve_private_address_failed ... ok
Dec 07 22:24:57.039 INFO [stdout] test gap_resolve_private_address_failed_mixed_signals ... ok
Dec 07 22:24:57.040 INFO [stdout] test gap_set_authorization_requirement ... ok
Dec 07 22:24:57.040 INFO [stdout] test gap_set_broadcast_mode ... ok
Dec 07 22:24:57.040 INFO [stdout] test gap_resolve_private_address ... ok
Dec 07 22:24:57.040 INFO [stdout] test gap_set_discoverable ... ok
Dec 07 22:24:57.040 INFO [stdout] test gap_allow_rebond ... ok
Dec 07 22:24:57.040 INFO [stdout] test gap_get_bonded_addresses_failed ... ok
Dec 07 22:24:57.040 INFO [stdout] test gap_set_nonconnectable ... ok
Dec 07 22:24:57.040 INFO [stdout] test gap_authorization_response ... ok
Dec 07 22:24:57.041 INFO [stdout] test gap_set_nondiscoverable ... ok
Dec 07 22:24:57.041 INFO [stdout] test gap_set_undirected_connectable ... ok
Dec 07 22:24:57.041 INFO [stdout] test gap_set_io_capability ... ok
Dec 07 22:24:57.041 INFO [stdout] test gap_set_direct_connectable ... ok
Dec 07 22:24:57.041 INFO [stdout] test gap_set_authentication_requirement ... ok
Dec 07 22:24:57.041 INFO [stdout] test gatt_add_characteristic ... ok
Dec 07 22:24:57.041 INFO [stdout] test gap_set_event_mask ... ok
Dec 07 22:24:57.041 INFO [stdout] test gap_update_advertising_data ... ok
Dec 07 22:24:57.041 INFO [stdout] test gap_terminate_procedure ... ok
Dec 07 22:24:57.042 INFO [stdout] test gatt_delete_included_service ... ok
Dec 07 22:24:57.044 INFO [stdout] test gap_start_observation_procedure ... ok
Dec 07 22:24:57.044 INFO [stdout] test gatt_delete_characteristic ... ok
Dec 07 22:24:57.045 INFO [stdout] test gatt_add_service ... ok
Dec 07 22:24:57.045 INFO [stdout] test gatt_add_characteristic_descriptor ... ok
Dec 07 22:24:57.045 INFO [stdout] test gatt_confirm_indication ... ok
Dec 07 22:24:57.045 INFO [stdout] test gatt_init ... ok
Dec 07 22:24:57.047 INFO [stdout] test gatt_allow_read ... ok
Dec 07 22:24:57.047 INFO [stdout] test gap_clear_security_database ... ok
Dec 07 22:24:57.047 INFO [stdout] test gatt_delete_service ... ok
Dec 07 22:24:57.047 INFO [stdout] test gatt_update_characteristic_value ... ok
Dec 07 22:24:57.047 INFO [stdout] test gatt_set_descriptor_value ... ok
Dec 07 22:24:57.047 INFO [stdout] test gatt_read_handle_value_offset ... ok
Dec 07 22:24:57.047 INFO [stdout] test gatt_signed_write_without_response ... ok
Dec 07 22:24:57.047 INFO [stdout] test gatt_update_long_characteristic_value ... ok
Dec 07 22:24:57.047 INFO [stdout] test gatt_set_event_mask ... ok
Dec 07 22:24:57.047 INFO [stdout] test gatt_include_service ... ok
Dec 07 22:24:57.048 INFO [stdout] test gatt_set_security_permission ... ok
Dec 07 22:24:57.048 INFO [stdout] test hal_get_link_status_invalid_status ... ok
Dec 07 22:24:57.048 INFO [stdout] test hal_device_standby ... ok
Dec 07 22:24:57.048 INFO [stdout] test gatt_write_without_response ... ok
Dec 07 22:24:57.048 INFO [stdout] test gatt_read_handle_value ... ok
Dec 07 22:24:57.048 INFO [stdout] test hal_read_config_data_key ... ok
Dec 07 22:24:57.048 INFO [stdout] test hal_read_config_data_diversifier ... ok
Dec 07 22:24:57.049 INFO [stdout] test hal_read_config_byte ... ok
Dec 07 22:24:57.049 INFO [stdout] test hal_get_link_status ... ok
Dec 07 22:24:57.049 INFO [stdout] test hal_read_config_invalid ... ok
Dec 07 22:24:57.049 INFO [stdout] test hal_set_tx_power_level ... ok
Dec 07 22:24:57.049 INFO [stdout] test hal_start_tone ... ok
Dec 07 22:24:57.049 INFO [stdout] test hal_get_tx_test_packet_count ... ok
Dec 07 22:24:57.049 INFO [stdout] test hal_stop_tone ... ok
Dec 07 22:24:57.049 INFO [stdout] test hal_write_config_data ... ok
Dec 07 22:24:57.054 INFO [stdout] test l2cap_connection_parameter_update_response ... ok
Dec 07 22:24:57.054 INFO [stdout] test hal_write_config_data_nonstandard_status ... ok
Dec 07 22:24:57.054 INFO [stdout] test hal_read_config_data_public_addr ... ok
Dec 07 22:24:57.054 INFO [stdout] test hal_get_anchor_period ... ok
Dec 07 22:24:57.054 INFO [stdout] test hal_get_firmware_revision ... ok
Dec 07 22:24:57.054 INFO [stdout] test gatt_write_response ... ok
Dec 07 22:24:57.054 INFO [stdout] 
Dec 07 22:24:57.054 INFO [stdout] test result: ok. 69 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 22:24:57.054 INFO [stdout] 
Dec 07 22:24:57.054 INFO [stderr]      Running /target/debug/deps/event-7a7198e8f20044f7
Dec 07 22:24:57.056 INFO [stdout] 
Dec 07 22:24:57.056 INFO [stdout] running 86 tests
Dec 07 22:24:57.056 INFO [stdout] test att_error_response ... ok
Dec 07 22:24:57.056 INFO [stdout] test att_error_response_failed_bad_error_code ... ok
Dec 07 22:24:57.056 INFO [stdout] test att_find_by_type_value_response ... ok
Dec 07 22:24:57.056 INFO [stdout] test att_execute_write_response ... ok
Dec 07 22:24:57.056 INFO [stdout] test att_find_information_response_16bit_uuids ... ok
Dec 07 22:24:57.057 INFO [stdout] test att_find_by_type_value_response_failed_partial_pair ... ok
Dec 07 22:24:57.057 INFO [stdout] test att_find_information_response_128bit_uuids ... ok
Dec 07 22:24:57.057 INFO [stdout] test att_prepare_write_response ... ok
Dec 07 22:24:57.057 INFO [stdout] test att_prepare_write_response_empty ... ok
Dec 07 22:24:57.057 INFO [stdout] test att_prepare_write_permit_request ... ok
Dec 07 22:24:57.057 INFO [stdout] test att_error_response_failed_bad_request_opcode ... ok
Dec 07 22:24:57.057 INFO [stdout] test att_read_blob_response_empty ... ok
Dec 07 22:24:57.057 INFO [stdout] test att_read_blob_response_failed ... ok
Dec 07 22:24:57.057 INFO [stdout] test att_read_blob_response ... ok
Dec 07 22:24:57.057 INFO [stdout] test att_read_by_type_response ... ok
Dec 07 22:24:57.057 INFO [stdout] test att_read_by_group_type_response ... ok
Dec 07 22:24:57.057 INFO [stdout] test att_read_by_type_response_failed_partial_pair ... ok
Dec 07 22:24:57.057 INFO [stdout] test att_find_information_response_failed_format ... ok
Dec 07 22:24:57.058 INFO [stdout] test att_find_information_response_failed_partial_uuid ... ok
Dec 07 22:24:57.058 INFO [stdout] test att_read_multiple_response_empty ... ok
Dec 07 22:24:57.058 INFO [stdout] test att_read_multiple_response ... ok
Dec 07 22:24:57.058 INFO [stdout] test att_read_response ... ok
Dec 07 22:24:57.058 INFO [stdout] test att_read_permit_request ... ok
Dec 07 22:24:57.058 INFO [stdout] test att_read_multiple_permit_request ... ok
Dec 07 22:24:57.058 INFO [stdout] test att_read_multiple_response_failed ... ok
Dec 07 22:24:57.058 INFO [stdout] test att_read_multiple_permit_request_failed ... ok
Dec 07 22:24:57.058 INFO [stdout] test att_write_permit_request ... ok
Dec 07 22:24:57.058 INFO [stdout] test att_write_permit_request_empty ... ok
Dec 07 22:24:57.058 INFO [stdout] test gap_addr_not_resolved ... ok
Dec 07 22:24:57.058 INFO [stdout] test gap_authorization_request ... ok
Dec 07 22:24:57.058 INFO [stdout] test gap_bond_lost ... ok
Dec 07 22:24:57.058 INFO [stdout] test gap_device_found ... ok
Dec 07 22:24:57.058 INFO [stdout] test gap_device_found_failure_bad_data_length ... ok
Dec 07 22:24:57.058 INFO [stdout] test gap_device_found_failure_bad_event ... ok
Dec 07 22:24:57.058 INFO [stdout] test gap_limited_discoverable ... ok
Dec 07 22:24:57.058 INFO [stdout] test gap_device_found_failure_bad_bdaddr_type ... ok
Dec 07 22:24:57.059 INFO [stdout] test att_read_response_empty ... ok
Dec 07 22:24:57.059 INFO [stdout] test gap_pairing_complete ... ok
Dec 07 22:24:57.059 INFO [stdout] test att_read_response_failed ... ok
Dec 07 22:24:57.059 INFO [stdout] test gap_pairing_complete_failed ... ok
Dec 07 22:24:57.059 INFO [stdout] test gap_procedure_complete ... ok
Dec 07 22:24:57.059 INFO [stdout] test gap_device_found_failure_bad_rssi ... ok
Dec 07 22:24:57.059 INFO [stdout] test gap_pass_key_request ... ok
Dec 07 22:24:57.059 INFO [stdout] test gap_peripheral_security_initiated ... ok
Dec 07 22:24:57.059 INFO [stdout] test gap_procedure_complete_failed_bad_status ... ok
Dec 07 22:24:57.059 INFO [stdout] test gap_procedure_complete_failed_bad_procedure ... ok
Dec 07 22:24:57.059 INFO [stdout] test gatt_attribute_modified ... ok
Dec 07 22:24:57.059 INFO [stdout] test gatt_attribute_modified_failed_bad_data_len ... ok
Dec 07 22:24:57.059 INFO [stdout] test gatt_discover_or_read_characteristic_by_uuid_response ... ok
Dec 07 22:24:57.059 INFO [stdout] test gatt_discover_or_read_characteristic_by_uuid_response_empty ... ok
Dec 07 22:24:57.059 INFO [stdout] test gatt_indication ... ok
Dec 07 22:24:57.059 INFO [stdout] test gap_procedure_complete_failed_general_connection_establishment_length ... ok
Dec 07 22:24:57.060 INFO [stdout] test gatt_notification ... ok
Dec 07 22:24:57.060 INFO [stdout] test gatt_procedure_complete_error_unknown_code ... ok
Dec 07 22:24:57.060 INFO [stdout] test gatt_procedure_complete_failed ... ok
Dec 07 22:24:57.060 INFO [stdout] test gatt_procedure_complete_success ... ok
Dec 07 22:24:57.060 INFO [stdout] test gatt_procedure_timeout ... ok
Dec 07 22:24:57.060 INFO [stdout] test gatt_server_confirmation ... ok
Dec 07 22:24:57.060 INFO [stdout] test gatt_tx_pool_available ... ok
Dec 07 22:24:57.062 INFO [stdout] test att_prepare_write_permit_request_empty ... ok
Dec 07 22:24:57.062 INFO [stdout] test att_exchange_mtu_response ... ok
Dec 07 22:24:57.064 INFO [stdout] test gatt_notification_empty ... ok
Dec 07 22:24:57.064 INFO [stdout] test hal_crash_info_failed_bad_crash_reason ... ok
Dec 07 22:24:57.064 INFO [stdout] test gap_procedure_complete_general_connection_establishment ... ok
Dec 07 22:24:57.064 INFO [stdout] test hal_crash_info ... ok
Dec 07 22:24:57.065 INFO [stdout] test gap_procedure_complete_name_discovery ... ok
Dec 07 22:24:57.065 INFO [stdout] test att_read_by_group_type_response_failed ... ok
Dec 07 22:24:57.065 INFO [stdout] test gatt_indication_empty ... ok
Dec 07 22:24:57.065 INFO [stdout] test hal_crash_info_failed_bad_debug_data_len ... ok
Dec 07 22:24:57.065 INFO [stdout] test l2cap_connection_update_request_failed_l2cap_len ... ok
Dec 07 22:24:57.065 INFO [stdout] test hal_events_lost_failure ... ok
Dec 07 22:24:57.065 INFO [stdout] test l2cap_connection_update_request ... ok
Dec 07 22:24:57.065 INFO [stdout] test hal_initialized ... ok
Dec 07 22:24:57.065 INFO [stdout] test l2cap_connection_update_response_cmd_rejected ... ok
Dec 07 22:24:57.065 INFO [stdout] test hal_events_lost ... ok
Dec 07 22:24:57.065 INFO [stdout] test hal_initialized_failure ... ok
Dec 07 22:24:57.065 INFO [stdout] test l2cap_connection_update_response_failed_code ... ok
Dec 07 22:24:57.065 INFO [stdout] test l2cap_connection_update_request_failed_event_data_len ... ok
Dec 07 22:24:57.065 INFO [stdout] test l2cap_connection_update_response_updated_param_rejected ... ok
Dec 07 22:24:57.065 INFO [stdout] test l2cap_procedure_timeout_failed ... ok
Dec 07 22:24:57.066 INFO [stdout] test l2cap_procedure_timeout ... ok
Dec 07 22:24:57.076 INFO [stdout] test l2cap_connection_update_response_failed_data_length ... ok
Dec 07 22:24:57.076 INFO [stdout] test l2cap_connection_update_response_failed_l2cap_length ... ok
Dec 07 22:24:57.076 INFO [stdout] test l2cap_connection_update_response_updated_accepted ... ok
Dec 07 22:24:57.076 INFO [stdout] test l2cap_connection_update_response_failed_unknown_rejection_reason ... ok
Dec 07 22:24:57.076 INFO [stdout] test l2cap_connection_update_response_failed_unknown_result ... ok
Dec 07 22:24:57.076 INFO [stdout] 
Dec 07 22:24:57.076 INFO [stdout] test result: ok. 86 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 22:24:57.076 INFO [stdout] 
Dec 07 22:24:57.077 INFO [stderr]      Running /target/debug/deps/extensions-c3b70b1a45003c89
Dec 07 22:24:57.078 INFO [stdout] 
Dec 07 22:24:57.078 INFO [stdout] running 2 tests
Dec 07 22:24:57.079 INFO [stdout] test hardware_error_failed ... ok
Dec 07 22:24:57.079 INFO [stderr]      Running /target/debug/deps/gap-0f8716af2cbf01cb
Dec 07 22:24:57.079 INFO [stdout] test hardware_error ... ok
Dec 07 22:24:57.079 INFO [stdout] 
Dec 07 22:24:57.079 INFO [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 22:24:57.079 INFO [stdout] 
Dec 07 22:24:57.080 INFO [stdout] 
Dec 07 22:24:57.080 INFO [stdout] running 60 tests
Dec 07 22:24:57.080 INFO [stdout] test get_bonded_devices ... ok
Dec 07 22:24:57.080 INFO [stdout] test get_security_level ... ok
Dec 07 22:24:57.080 INFO [stdout] test delete_ad_type ... ok
Dec 07 22:24:57.080 INFO [stdout] test create_connection ... ok
Dec 07 22:24:57.081 INFO [stdout] test configure_white_list ... ok
Dec 07 22:24:57.081 INFO [stdout] test allow_rebond ... ok
Dec 07 22:24:57.081 INFO [stdout] test clear_security_database ... ok
Dec 07 22:24:57.081 INFO [stdout] test authorization_response ... ok
Dec 07 22:24:57.081 INFO [stdout] test init ... ok
Dec 07 22:24:57.081 INFO [stdout] test is_device_bonded ... ok
Dec 07 22:24:57.081 INFO [stdout] test pass_key_response ... ok
Dec 07 22:24:57.081 INFO [stdout] test set_authentication_requirement_bad_key_size_range ... ok
Dec 07 22:24:57.082 INFO [stdout] test peripheral_security_request ... ok
Dec 07 22:24:57.082 INFO [stdout] test resolve_private_address ... ok
Dec 07 22:24:57.082 INFO [stdout] test pass_key_response_bad_pin ... ok
Dec 07 22:24:57.082 INFO [stdout] test set_authentication_requirement_2 ... ok
Dec 07 22:24:57.082 INFO [stdout] test set_broadcast_mode_white_list_too_long ... ok
Dec 07 22:24:57.082 INFO [stdout] test set_authorization_requirement ... ok
Dec 07 22:24:57.082 INFO [stdout] test set_broadcast_mode_advertising_data_too_long ... ok
Dec 07 22:24:57.082 INFO [stdout] test set_broadcast_mode ... ok
Dec 07 22:24:57.082 INFO [stdout] test set_broadcast_mode_bad_advertising_type ... ok
Dec 07 22:24:57.082 INFO [stdout] test set_broadcast_mode_white_list_too_long_no_adv_data ... ok
Dec 07 22:24:57.082 INFO [stdout] test set_direct_connectable ... ok
Dec 07 22:24:57.082 INFO [stdout] test send_pairing_request ... ok
Dec 07 22:24:57.082 INFO [stdout] test set_authentication_requirement_bad_pin ... ok
Dec 07 22:24:57.082 INFO [stdout] test set_direct_connectable_bad_adv_interval ... ok
Dec 07 22:24:57.082 INFO [stdout] test set_authentication_requirement ... ok
Dec 07 22:24:57.082 INFO [stdout] test set_direct_connectable_bad_adv_type ... ok
Dec 07 22:24:57.082 INFO [stdout] test set_discoverable_bad_adv_interval ... ok
Dec 07 22:24:57.082 INFO [stdout] test set_discoverable ... ok
Dec 07 22:24:57.083 INFO [stdout] test set_discoverable_bad_adv_type ... ok
Dec 07 22:24:57.083 INFO [stdout] test set_io_capability ... ok
Dec 07 22:24:57.083 INFO [stdout] test set_limited_discoverable ... ok
Dec 07 22:24:57.083 INFO [stdout] test set_event_mask ... ok
Dec 07 22:24:57.083 INFO [stdout] test set_limited_discoverable_bad_adv_interval ... ok
Dec 07 22:24:57.083 INFO [stdout] test set_limited_discoverable_bad_adv_type ... ok
Dec 07 22:24:57.083 INFO [stdout] test set_undirected_connectable_bad_advertising_filter_policy ... ok
Dec 07 22:24:57.083 INFO [stdout] test set_nonconnectable ... ok
Dec 07 22:24:57.083 INFO [stdout] test set_discoverable_bad_conn_interval ... ok
Dec 07 22:24:57.083 INFO [stdout] test set_limited_discoverable_bad_conn_interval ... ok
Dec 07 22:24:57.083 INFO [stdout] test set_nonconnectable_bad_type ... ok
Dec 07 22:24:57.083 INFO [stdout] test set_nondiscoverable ... ok
Dec 07 22:24:57.083 INFO [stdout] test start_auto_connection_establishment_white_list_too_long ... ok
Dec 07 22:24:57.083 INFO [stdout] test start_auto_connection_establishment ... ok
Dec 07 22:24:57.083 INFO [stdout] test set_undirected_connectable ... ok
Dec 07 22:24:57.084 INFO [stdout] test start_selective_connection_establishment ... ok
Dec 07 22:24:57.084 INFO [stdout] test start_selective_connection_establishment_white_list_too_long ... ok
Dec 07 22:24:57.084 INFO [stdout] test start_general_discovery_procedure ... ok
Dec 07 22:24:57.084 INFO [stdout] test start_connection_update ... ok
Dec 07 22:24:57.084 INFO [stdout] test start_general_connection_establishment ... ok
Dec 07 22:24:57.084 INFO [stdout] test start_observation_procedure ... ok
Dec 07 22:24:57.084 INFO [stdout] test start_limited_discovery_procedure ... ok
Dec 07 22:24:57.084 INFO [stdout] test start_name_discovery_procedure ... ok
Dec 07 22:24:57.084 INFO [stdout] test terminate ... ok
Dec 07 22:24:57.084 INFO [stdout] test terminate_multiple_procedure ... ok
Dec 07 22:24:57.084 INFO [stdout] test terminate_no_procedure ... ok
Dec 07 22:24:57.084 INFO [stdout] test terminate_procedure ... ok
Dec 07 22:24:57.084 INFO [stdout] test update_advertising_data ... ok
Dec 07 22:24:57.084 INFO [stdout] test update_advertising_data_too_long ... ok
Dec 07 22:24:57.084 INFO [stdout] test terminate_bad_disconnection_reason ... ok
Dec 07 22:24:57.084 INFO [stdout] 
Dec 07 22:24:57.084 INFO [stdout] test result: ok. 60 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 22:24:57.084 INFO [stdout] 
Dec 07 22:24:57.085 INFO [stderr]      Running /target/debug/deps/gatt-17d72d82bdd7eca1
Dec 07 22:24:57.086 INFO [stdout] 
Dec 07 22:24:57.086 INFO [stdout] running 73 tests
Dec 07 22:24:57.087 INFO [stdout] test add_characteristic_pre_v72_128 ... ok
Dec 07 22:24:57.087 INFO [stdout] test add_characteristic_pre_v72_16 ... ok
Dec 07 22:24:57.087 INFO [stdout] test add_characteristic_descriptor_too_long ... ok
Dec 07 22:24:57.087 INFO [stdout] test add_characteristic_descriptor_buffer_too_long ... ok
Dec 07 22:24:57.087 INFO [stdout] test add_characteristic_descriptor_16 ... ok
Dec 07 22:24:57.087 INFO [stdout] test add_service_16 ... ok
Dec 07 22:24:57.087 INFO [stdout] test allow_read ... ok
Dec 07 22:24:57.087 INFO [stdout] test add_service_128 ... ok
Dec 07 22:24:57.087 INFO [stdout] test confirm_indication ... ok
Dec 07 22:24:57.087 INFO [stdout] test bad_range ... ok
Dec 07 22:24:57.087 INFO [stdout] test cancel_write_request ... ok
Dec 07 22:24:57.087 INFO [stdout] test add_characteristic_descriptor_128 ... ok
Dec 07 22:24:57.087 INFO [stdout] test add_characteristic_128 ... ok
Dec 07 22:24:57.088 INFO [stdout] test add_characteristic_16 ... ok
Dec 07 22:24:57.088 INFO [stdout] test delete_service ... ok
Dec 07 22:24:57.088 INFO [stdout] test delete_included_service ... ok
Dec 07 22:24:57.088 INFO [stdout] test discover_all_characteristics_of_service ... ok
Dec 07 22:24:57.088 INFO [stdout] test discover_all_characteristic_descriptors ... ok
Dec 07 22:24:57.088 INFO [stdout] test discover_all_primary_services ... ok
Dec 07 22:24:57.088 INFO [stdout] test discover_characteristics_by_uuid_16 ... ok
Dec 07 22:24:57.088 INFO [stdout] test discover_characteristics_by_uuid_128 ... ok
Dec 07 22:24:57.088 INFO [stdout] test discovery_primary_services_by_uuid_128 ... ok
Dec 07 22:24:57.088 INFO [stdout] test discovery_primary_services_by_uuid_16 ... ok
Dec 07 22:24:57.088 INFO [stdout] test encryption_key_size_range ... ok
Dec 07 22:24:57.088 INFO [stdout] test exchange_configuration ... ok
Dec 07 22:24:57.088 INFO [stdout] test execute_write_request ... ok
Dec 07 22:24:57.088 INFO [stdout] test find_by_type_value_request ... ok
Dec 07 22:24:57.088 INFO [stdout] test find_by_type_value_request_value_too_long ... ok
Dec 07 22:24:57.088 INFO [stdout] test find_included_services ... ok
Dec 07 22:24:57.088 INFO [stdout] test find_information_request ... ok
Dec 07 22:24:57.088 INFO [stdout] test include_service_128 ... ok
Dec 07 22:24:57.088 INFO [stdout] test include_service_16 ... ok
Dec 07 22:24:57.088 INFO [stdout] test init ... ok
Dec 07 22:24:57.088 INFO [stdout] test prepare_write_request ... ok
Dec 07 22:24:57.088 INFO [stdout] test prepare_write_request_too_long ... ok
Dec 07 22:24:57.088 INFO [stdout] test read_characteristic_descriptor ... ok
Dec 07 22:24:57.089 INFO [stdout] test read_by_type_request_16 ... ok
Dec 07 22:24:57.089 INFO [stdout] test read_by_group_type_request_128 ... ok
Dec 07 22:24:57.089 INFO [stdout] test read_characteristic_value ... ok
Dec 07 22:24:57.089 INFO [stdout] test read_handle_value ... ok
Dec 07 22:24:57.089 INFO [stdout] test read_characteristic_using_uuid_128 ... ok
Dec 07 22:24:57.089 INFO [stdout] test read_by_group_type_request_16 ... ok
Dec 07 22:24:57.089 INFO [stdout] test read_by_type_request_128 ... ok
Dec 07 22:24:57.089 INFO [stdout] test read_characteristic_using_uuid_16 ... ok
Dec 07 22:24:57.089 INFO [stdout] test delete_characteristic ... ok
Dec 07 22:24:57.089 INFO [stdout] test read_multiple_characteristic_values_too_many_handles ... ok
Dec 07 22:24:57.089 INFO [stdout] test set_descriptor_value ... ok
Dec 07 22:24:57.089 INFO [stdout] test read_long_characteristic_value ... ok
Dec 07 22:24:57.089 INFO [stdout] test read_multiple_characteristic_values ... ok
Dec 07 22:24:57.090 INFO [stdout] test read_long_characteristic_descriptor ... ok
Dec 07 22:24:57.090 INFO [stdout] test set_descriptor_value_too_long ... ok
Dec 07 22:24:57.090 INFO [stdout] test set_event_mask ... ok
Dec 07 22:24:57.090 INFO [stdout] test set_security_permission ... ok
Dec 07 22:24:57.090 INFO [stdout] test signed_write_without_response ... ok
Dec 07 22:24:57.090 INFO [stdout] test read_handle_value_offset ... ok
Dec 07 22:24:57.090 INFO [stdout] test signed_write_without_response_too_long ... ok
Dec 07 22:24:57.090 INFO [stdout] test update_long_characteristic_value_too_long ... ok
Dec 07 22:24:57.090 INFO [stdout] test write_characteristic_descriptor_too_long ... ok
Dec 07 22:24:57.090 INFO [stdout] test write_characteristic_value_reliably ... ok
Dec 07 22:24:57.090 INFO [stdout] test write_characteristic_value_reliably_too_long ... ok
Dec 07 22:24:57.090 INFO [stdout] test write_long_characteristic_descriptor_too_long ... ok
Dec 07 22:24:57.090 INFO [stdout] test write_long_characteristic_value_too_long ... ok
Dec 07 22:24:57.090 INFO [stdout] test write_long_characteristic_value ... ok
Dec 07 22:24:57.090 INFO [stdout] test write_response ... ok
Dec 07 22:24:57.090 INFO [stdout] test write_response_too_long ... ok
Dec 07 22:24:57.090 INFO [stdout] test write_characteristic_value ... ok
Dec 07 22:24:57.090 INFO [stdout] test write_long_characteristic_descriptor ... ok
Dec 07 22:24:57.090 INFO [stdout] test write_characteristic_value_too_long ... ok
Dec 07 22:24:57.090 INFO [stdout] test write_without_response_too_long ... ok
Dec 07 22:24:57.090 INFO [stdout] test write_characteristic_descriptor ... ok
Dec 07 22:24:57.090 INFO [stdout] test update_characteristic_value ... ok
Dec 07 22:24:57.090 INFO [stdout] test update_long_characteristic_value ... ok
Dec 07 22:24:57.092 INFO [stdout] test write_without_response ... ok
Dec 07 22:24:57.092 INFO [stdout] 
Dec 07 22:24:57.092 INFO [stdout] test result: ok. 73 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 22:24:57.092 INFO [stdout] 
Dec 07 22:24:57.093 INFO [stderr]      Running /target/debug/deps/hal-024e8122d08dbc9c
Dec 07 22:24:57.094 INFO [stdout] 
Dec 07 22:24:57.094 INFO [stdout] running 12 tests
Dec 07 22:24:57.095 INFO [stdout] test get_firmware_revision ... ok
Dec 07 22:24:57.095 INFO [stdout] test get_anchor_period ... ok
Dec 07 22:24:57.095 INFO [stdout] test get_link_status ... ok
Dec 07 22:24:57.095 INFO [stdout] test device_standby ... ok
Dec 07 22:24:57.095 INFO [stdout] test get_tx_test_packet_count ... ok
Dec 07 22:24:57.095 INFO [stdout] test config_data ... ok
Dec 07 22:24:57.095 INFO [stdout] test set_tx_power_level ... ok
Dec 07 22:24:57.095 INFO [stdout] test read_config_data ... ok
Dec 07 22:24:57.095 INFO [stdout] test stop_tone ... ok
Dec 07 22:24:57.095 INFO [stdout] test start_tone_invalid ... ok
Dec 07 22:24:57.095 INFO [stdout] test write_config_data ... ok
Dec 07 22:24:57.096 INFO [stdout] test start_tone ... ok
Dec 07 22:24:57.096 INFO [stdout] 
Dec 07 22:24:57.096 INFO [stdout] test result: ok. 12 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 22:24:57.096 INFO [stdout] 
Dec 07 22:24:57.097 INFO [stderr]      Running /target/debug/deps/l2cap-59ba47504a0c2e53
Dec 07 22:24:57.098 INFO [stdout] 
Dec 07 22:24:57.098 INFO [stdout] running 2 tests
Dec 07 22:24:57.098 INFO [stdout] test connection_parameter_update_request ... ok
Dec 07 22:24:57.098 INFO [stdout] test connection_parameter_update_response ... ok
Dec 07 22:24:57.098 INFO [stdout] 
Dec 07 22:24:57.098 INFO [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 22:24:57.098 INFO [stdout] 
Dec 07 22:24:57.104 INFO [stderr]    Doc-tests bluenrg
Dec 07 22:24:57.828 INFO [stdout] 
Dec 07 22:24:57.828 INFO [stdout] running 0 tests
Dec 07 22:24:57.828 INFO [stdout] 
Dec 07 22:24:57.828 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 22:24:57.828 INFO [stdout] 
Dec 07 22:24:57.839 INFO [stderr] su: No module specific data is present
Dec 07 22:24:58.101 INFO running `"docker" "inspect" "29c2ae92d47efcbb12cf6c2fd77784c7623582f9465ef65f1ae1e7b39f23f0ae"`
Dec 07 22:24:58.298 INFO running `"docker" "rm" "-f" "29c2ae92d47efcbb12cf6c2fd77784c7623582f9465ef65f1ae1e7b39f23f0ae"`
Dec 07 22:24:58.436 INFO [stdout] 29c2ae92d47efcbb12cf6c2fd77784c7623582f9465ef65f1ae1e7b39f23f0ae