Dec 07 22:24:32.198 INFO testing bluenrg-0.0.3 against try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468 for pr-56514
Dec 07 22:24:32.198 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-3/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/pr-56514/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/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 +6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468-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:32.825 INFO [stdout] 58e6939d345b538d469f3278587a6a8e5181d8f652370ad70dcc0caccb941a44
Dec 07 22:24:32.828 INFO running `"docker" "start" "-a" "58e6939d345b538d469f3278587a6a8e5181d8f652370ad70dcc0caccb941a44"`
Dec 07 22:24:33.896 INFO [stderr] usermod: no changes
Dec 07 22:24:33.988 INFO [stderr]    Compiling bluetooth-hci v0.0.3
Dec 07 22:24:38.568 INFO [stderr]    Compiling bluenrg v0.0.3 (/source)
Dec 07 22:24:41.724 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:41.724 INFO [stderr]   --> src/lib.rs:42:12
Dec 07 22:24:41.724 INFO [stderr]    |
Dec 07 22:24:41.724 INFO [stderr] 42 | #![feature(extern_prelude)]
Dec 07 22:24:41.724 INFO [stderr]    |            ^^^^^^^^^^^^^^
Dec 07 22:24:41.724 INFO [stderr]    |
Dec 07 22:24:41.724 INFO [stderr]    = note: #[warn(stable_features)] on by default
Dec 07 22:24:41.724 INFO [stderr] 
Dec 07 22:24:41.760 INFO [stderr] warning: unused `core::result::Result` that must be used
Dec 07 22:24:41.760 INFO [stderr]     --> src/event/command.rs:1006:9
Dec 07 22:24:41.760 INFO [stderr]      |
Dec 07 22:24:41.760 INFO [stderr] 1006 |         write!(f, "status: {:?}; value: {{", self.status);
Dec 07 22:24:41.760 INFO [stderr]      |         ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 07 22:24:41.760 INFO [stderr]      |
Dec 07 22:24:41.760 INFO [stderr]      = note: #[warn(unused_must_use)] on by default
Dec 07 22:24:41.760 INFO [stderr]      = note: this `Result` may be an `Err` variant, which should be handled
Dec 07 22:24:41.760 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:41.760 INFO [stderr] 
Dec 07 22:24:42.697 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 8.78s
Dec 07 22:24:42.698 INFO [stderr] su: No module specific data is present
Dec 07 22:24:42.982 INFO running `"docker" "inspect" "58e6939d345b538d469f3278587a6a8e5181d8f652370ad70dcc0caccb941a44"`
Dec 07 22:24:43.058 INFO running `"docker" "rm" "-f" "58e6939d345b538d469f3278587a6a8e5181d8f652370ad70dcc0caccb941a44"`
Dec 07 22:24:43.121 INFO [stdout] 58e6939d345b538d469f3278587a6a8e5181d8f652370ad70dcc0caccb941a44
Dec 07 22:24:43.126 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-3/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/pr-56514/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/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 +6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468-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:43.339 INFO [stdout] 4b872a5056f5ea79773d80a7326105de8f4ff38cb6933bf58da99c928f09b530
Dec 07 22:24:43.341 INFO running `"docker" "start" "-a" "4b872a5056f5ea79773d80a7326105de8f4ff38cb6933bf58da99c928f09b530"`
Dec 07 22:24:43.808 INFO [stderr] usermod: no changes
Dec 07 22:24:43.872 INFO [stderr]    Compiling bluenrg v0.0.3 (/source)
Dec 07 22:24:50.840 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:50.840 INFO [stderr]   --> src/lib.rs:42:12
Dec 07 22:24:50.840 INFO [stderr]    |
Dec 07 22:24:50.840 INFO [stderr] 42 | #![feature(extern_prelude)]
Dec 07 22:24:50.840 INFO [stderr]    |            ^^^^^^^^^^^^^^
Dec 07 22:24:50.840 INFO [stderr]    |
Dec 07 22:24:50.840 INFO [stderr]    = note: #[warn(stable_features)] on by default
Dec 07 22:24:50.840 INFO [stderr] 
Dec 07 22:24:50.860 INFO [stderr] warning: unused `core::result::Result` that must be used
Dec 07 22:24:50.860 INFO [stderr]     --> src/event/command.rs:1006:9
Dec 07 22:24:50.860 INFO [stderr]      |
Dec 07 22:24:50.860 INFO [stderr] 1006 |         write!(f, "status: {:?}; value: {{", self.status);
Dec 07 22:24:50.860 INFO [stderr]      |         ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 07 22:24:50.860 INFO [stderr]      |
Dec 07 22:24:50.860 INFO [stderr]      = note: #[warn(unused_must_use)] on by default
Dec 07 22:24:50.864 INFO [stderr]      = note: this `Result` may be an `Err` variant, which should be handled
Dec 07 22:24:50.864 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:50.864 INFO [stderr] 
Dec 07 22:24:51.380 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 7.53s
Dec 07 22:24:51.380 INFO [stderr] su: No module specific data is present
Dec 07 22:24:51.934 INFO running `"docker" "inspect" "4b872a5056f5ea79773d80a7326105de8f4ff38cb6933bf58da99c928f09b530"`
Dec 07 22:24:52.256 INFO running `"docker" "rm" "-f" "4b872a5056f5ea79773d80a7326105de8f4ff38cb6933bf58da99c928f09b530"`
Dec 07 22:24:52.460 INFO [stdout] 4b872a5056f5ea79773d80a7326105de8f4ff38cb6933bf58da99c928f09b530
Dec 07 22:24:52.472 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-3/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/pr-56514/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/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 +6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468-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:52.942 INFO [stdout] 954cb1aeaaf3a3764d5981391ee705ed4fd15e57723869fd88d9976b6bce69b0
Dec 07 22:24:52.944 INFO running `"docker" "start" "-a" "954cb1aeaaf3a3764d5981391ee705ed4fd15e57723869fd88d9976b6bce69b0"`
Dec 07 22:24:53.915 INFO [stderr] usermod: no changes
Dec 07 22:24:54.030 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.08s
Dec 07 22:24:54.036 INFO [stderr]      Running /target/debug/deps/bluenrg-d330be6156694c06
Dec 07 22:24:54.036 INFO [stdout] 
Dec 07 22:24:54.036 INFO [stdout] running 6 tests
Dec 07 22:24:54.036 INFO [stdout] test cb::tests::peek ... ok
Dec 07 22:24:54.036 INFO [stdout] test cb::tests::empty_capacity_after_use ... ok
Dec 07 22:24:54.036 INFO [stdout] test cb::tests::empty_capacity ... ok
Dec 07 22:24:54.168 INFO [stdout] test cb::tests::request_peek_too_far ... ok
Dec 07 22:24:54.180 INFO [stdout] test cb::tests::request_too_many_bytes_read ... ok
Dec 07 22:24:54.180 INFO [stdout] test cb::tests::request_too_many_bytes_write ... ok
Dec 07 22:24:54.180 INFO [stdout] 
Dec 07 22:24:54.180 INFO [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 22:24:54.180 INFO [stdout] 
Dec 07 22:24:54.180 INFO [stdout] 
Dec 07 22:24:54.180 INFO [stdout] running 0 tests
Dec 07 22:24:54.180 INFO [stdout] 
Dec 07 22:24:54.180 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 22:24:54.180 INFO [stdout] 
Dec 07 22:24:54.181 INFO [stderr]      Running /target/debug/deps/cb-dd2df0291de25ede
Dec 07 22:24:54.181 INFO [stderr]      Running /target/debug/deps/command_complete-b66afdd924c2b647
Dec 07 22:24:54.196 INFO [stdout] 
Dec 07 22:24:54.196 INFO [stdout] running 69 tests
Dec 07 22:24:54.226 INFO [stdout] test gap_allow_rebond ... ok
Dec 07 22:24:54.226 INFO [stdout] test gap_authorization_response ... ok
Dec 07 22:24:54.226 INFO [stdout] test gap_delete_ad_type ... ok
Dec 07 22:24:54.226 INFO [stdout] test gap_clear_security_database ... ok
Dec 07 22:24:54.226 INFO [stdout] test gap_configure_white_list ... ok
Dec 07 22:24:54.226 INFO [stdout] test gap_get_bonded_addresses ... ok
Dec 07 22:24:54.226 INFO [stdout] test gap_get_bonded_addresses_failed ... ok
Dec 07 22:24:54.226 INFO [stdout] test gap_get_bonded_addresses_bad_addr_type ... ok
Dec 07 22:24:54.227 INFO [stdout] test gap_is_device_bonded ... ok
Dec 07 22:24:54.227 INFO [stdout] test gap_pass_key_response ... ok
Dec 07 22:24:54.227 INFO [stdout] test gap_resolve_private_address ... ok
Dec 07 22:24:54.227 INFO [stdout] test gap_resolve_private_address_failed ... ok
Dec 07 22:24:54.227 INFO [stdout] test gap_resolve_private_address_failed_mixed_signals ... ok
Dec 07 22:24:54.228 INFO [stdout] test gap_set_authentication_requirement ... ok
Dec 07 22:24:54.228 INFO [stdout] test gap_set_authorization_requirement ... ok
Dec 07 22:24:54.228 INFO [stdout] test gap_set_broadcast_mode ... ok
Dec 07 22:24:54.228 INFO [stdout] test gap_set_direct_connectable ... ok
Dec 07 22:24:54.228 INFO [stdout] test gap_set_discoverable ... ok
Dec 07 22:24:54.228 INFO [stdout] test gap_set_event_mask ... ok
Dec 07 22:24:54.228 INFO [stdout] test gap_init ... ok
Dec 07 22:24:54.228 INFO [stdout] test gap_get_security_level_bad_bool ... ok
Dec 07 22:24:54.232 INFO [stdout] test gap_get_security_level_bad_pass_key_requirement ... ok
Dec 07 22:24:54.232 INFO [stdout] test gap_get_bonded_addresses_failed_mixed_signals ... ok
Dec 07 22:24:54.232 INFO [stdout] test gap_set_io_capability ... ok
Dec 07 22:24:54.232 INFO [stdout] test gap_set_nonconnectable ... ok
Dec 07 22:24:54.232 INFO [stdout] test gap_get_security_level ... ok
Dec 07 22:24:54.232 INFO [stdout] test gap_get_bonded_addresses_partial ... ok
Dec 07 22:24:54.232 INFO [stdout] test gap_start_observation_procedure ... ok
Dec 07 22:24:54.232 INFO [stdout] test gap_terminate_procedure ... ok
Dec 07 22:24:54.232 INFO [stdout] test gap_update_advertising_data ... ok
Dec 07 22:24:54.232 INFO [stdout] test gatt_add_characteristic ... ok
Dec 07 22:24:54.232 INFO [stdout] test gatt_add_characteristic_descriptor ... ok
Dec 07 22:24:54.232 INFO [stdout] test gatt_allow_read ... ok
Dec 07 22:24:54.232 INFO [stdout] test gatt_add_service ... ok
Dec 07 22:24:54.232 INFO [stdout] test gatt_confirm_indication ... ok
Dec 07 22:24:54.232 INFO [stdout] test gatt_delete_characteristic ... ok
Dec 07 22:24:54.232 INFO [stdout] test gatt_delete_included_service ... ok
Dec 07 22:24:54.232 INFO [stdout] test gatt_init ... ok
Dec 07 22:24:54.232 INFO [stdout] test gatt_delete_service ... ok
Dec 07 22:24:54.232 INFO [stdout] test gatt_include_service ... ok
Dec 07 22:24:54.232 INFO [stdout] test gatt_read_handle_value ... ok
Dec 07 22:24:54.232 INFO [stdout] test gatt_read_handle_value_offset ... ok
Dec 07 22:24:54.232 INFO [stdout] test gatt_set_descriptor_value ... ok
Dec 07 22:24:54.232 INFO [stdout] test gatt_set_event_mask ... ok
Dec 07 22:24:54.233 INFO [stdout] test gatt_set_security_permission ... ok
Dec 07 22:24:54.233 INFO [stdout] test gatt_signed_write_without_response ... ok
Dec 07 22:24:54.233 INFO [stdout] test gatt_update_characteristic_value ... ok
Dec 07 22:24:54.233 INFO [stdout] test gatt_update_long_characteristic_value ... ok
Dec 07 22:24:54.233 INFO [stdout] test gatt_write_response ... ok
Dec 07 22:24:54.233 INFO [stdout] test gatt_write_without_response ... ok
Dec 07 22:24:54.233 INFO [stdout] test hal_device_standby ... ok
Dec 07 22:24:54.233 INFO [stdout] test hal_get_firmware_revision ... ok
Dec 07 22:24:54.233 INFO [stdout] test hal_get_anchor_period ... ok
Dec 07 22:24:54.233 INFO [stdout] test hal_get_link_status ... ok
Dec 07 22:24:54.233 INFO [stdout] test hal_get_link_status_invalid_status ... ok
Dec 07 22:24:54.233 INFO [stdout] test hal_get_tx_test_packet_count ... ok
Dec 07 22:24:54.233 INFO [stdout] test hal_read_config_byte ... ok
Dec 07 22:24:54.233 INFO [stdout] test hal_read_config_data_diversifier ... ok
Dec 07 22:24:54.233 INFO [stdout] test hal_read_config_data_key ... ok
Dec 07 22:24:54.233 INFO [stdout] test hal_read_config_data_public_addr ... ok
Dec 07 22:24:54.233 INFO [stdout] test hal_read_config_invalid ... ok
Dec 07 22:24:54.233 INFO [stdout] test hal_set_tx_power_level ... ok
Dec 07 22:24:54.233 INFO [stdout] test hal_start_tone ... ok
Dec 07 22:24:54.233 INFO [stdout] test hal_stop_tone ... ok
Dec 07 22:24:54.233 INFO [stdout] test hal_write_config_data ... ok
Dec 07 22:24:54.233 INFO [stdout] test hal_write_config_data_nonstandard_status ... ok
Dec 07 22:24:54.233 INFO [stdout] test l2cap_connection_parameter_update_response ... ok
Dec 07 22:24:54.236 INFO [stdout] test gap_set_nondiscoverable ... ok
Dec 07 22:24:54.236 INFO [stdout] test gap_set_undirected_connectable ... ok
Dec 07 22:24:54.236 INFO [stdout] 
Dec 07 22:24:54.236 INFO [stdout] test result: ok. 69 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 22:24:54.236 INFO [stdout] 
Dec 07 22:24:54.236 INFO [stderr]      Running /target/debug/deps/event-1d08bf596da26439
Dec 07 22:24:54.244 INFO [stdout] 
Dec 07 22:24:54.244 INFO [stdout] running 86 tests
Dec 07 22:24:54.244 INFO [stdout] test att_execute_write_response ... ok
Dec 07 22:24:54.244 INFO [stdout] test att_error_response_failed_bad_error_code ... ok
Dec 07 22:24:54.244 INFO [stdout] test att_error_response_failed_bad_request_opcode ... ok
Dec 07 22:24:54.244 INFO [stdout] test att_exchange_mtu_response ... ok
Dec 07 22:24:54.244 INFO [stdout] test att_error_response ... ok
Dec 07 22:24:54.244 INFO [stdout] test att_find_by_type_value_response ... ok
Dec 07 22:24:54.244 INFO [stdout] test att_prepare_write_response ... ok
Dec 07 22:24:54.244 INFO [stdout] test att_prepare_write_response_empty ... ok
Dec 07 22:24:54.244 INFO [stdout] test att_read_blob_response ... ok
Dec 07 22:24:54.244 INFO [stdout] test att_read_blob_response_empty ... ok
Dec 07 22:24:54.244 INFO [stdout] test att_read_blob_response_failed ... ok
Dec 07 22:24:54.244 INFO [stdout] test att_read_by_group_type_response ... ok
Dec 07 22:24:54.244 INFO [stdout] test att_read_by_group_type_response_failed ... ok
Dec 07 22:24:54.244 INFO [stdout] test att_read_by_type_response ... ok
Dec 07 22:24:54.244 INFO [stdout] test att_read_by_type_response_failed_partial_pair ... ok
Dec 07 22:24:54.244 INFO [stdout] test att_read_multiple_permit_request ... ok
Dec 07 22:24:54.244 INFO [stdout] test att_read_multiple_permit_request_failed ... ok
Dec 07 22:24:54.244 INFO [stdout] test att_read_multiple_response ... ok
Dec 07 22:24:54.244 INFO [stdout] test att_read_multiple_response_empty ... ok
Dec 07 22:24:54.244 INFO [stdout] test att_read_multiple_response_failed ... ok
Dec 07 22:24:54.244 INFO [stdout] test att_read_permit_request ... ok
Dec 07 22:24:54.244 INFO [stdout] test att_read_response ... ok
Dec 07 22:24:54.245 INFO [stdout] test att_read_response_empty ... ok
Dec 07 22:24:54.245 INFO [stdout] test att_read_response_failed ... ok
Dec 07 22:24:54.245 INFO [stdout] test att_write_permit_request ... ok
Dec 07 22:24:54.245 INFO [stdout] test att_write_permit_request_empty ... ok
Dec 07 22:24:54.245 INFO [stdout] test gap_addr_not_resolved ... ok
Dec 07 22:24:54.245 INFO [stdout] test gap_authorization_request ... ok
Dec 07 22:24:54.245 INFO [stdout] test gap_bond_lost ... ok
Dec 07 22:24:54.245 INFO [stdout] test gap_device_found ... ok
Dec 07 22:24:54.245 INFO [stdout] test gap_device_found_failure_bad_bdaddr_type ... ok
Dec 07 22:24:54.245 INFO [stdout] test gap_device_found_failure_bad_data_length ... ok
Dec 07 22:24:54.245 INFO [stdout] test gap_device_found_failure_bad_event ... ok
Dec 07 22:24:54.245 INFO [stdout] test gap_device_found_failure_bad_rssi ... ok
Dec 07 22:24:54.245 INFO [stdout] test gap_limited_discoverable ... ok
Dec 07 22:24:54.245 INFO [stdout] test gap_pairing_complete ... ok
Dec 07 22:24:54.245 INFO [stdout] test att_find_information_response_failed_format ... ok
Dec 07 22:24:54.245 INFO [stdout] test att_prepare_write_permit_request_empty ... ok
Dec 07 22:24:54.245 INFO [stdout] test att_prepare_write_permit_request ... ok
Dec 07 22:24:54.245 INFO [stdout] test gap_pairing_complete_failed ... ok
Dec 07 22:24:54.245 INFO [stdout] test att_find_information_response_failed_partial_uuid ... ok
Dec 07 22:24:54.252 INFO [stdout] test att_find_information_response_128bit_uuids ... ok
Dec 07 22:24:54.252 INFO [stdout] test att_find_information_response_16bit_uuids ... ok
Dec 07 22:24:54.252 INFO [stdout] test att_find_by_type_value_response_failed_partial_pair ... ok
Dec 07 22:24:54.252 INFO [stdout] test gap_pass_key_request ... ok
Dec 07 22:24:54.252 INFO [stdout] test gap_procedure_complete_failed_bad_status ... ok
Dec 07 22:24:54.252 INFO [stdout] test gap_procedure_complete_failed_general_connection_establishment_length ... ok
Dec 07 22:24:54.252 INFO [stdout] test gap_procedure_complete ... ok
Dec 07 22:24:54.252 INFO [stdout] test gap_peripheral_security_initiated ... ok
Dec 07 22:24:54.252 INFO [stdout] test gap_procedure_complete_failed_bad_procedure ... ok
Dec 07 22:24:54.252 INFO [stdout] test gatt_attribute_modified_failed_bad_data_len ... ok
Dec 07 22:24:54.252 INFO [stdout] test gap_procedure_complete_general_connection_establishment ... ok
Dec 07 22:24:54.252 INFO [stdout] test gatt_attribute_modified ... ok
Dec 07 22:24:54.252 INFO [stdout] test gap_procedure_complete_name_discovery ... ok
Dec 07 22:24:54.252 INFO [stdout] test gatt_procedure_complete_failed ... ok
Dec 07 22:24:54.252 INFO [stdout] test gatt_procedure_complete_success ... ok
Dec 07 22:24:54.252 INFO [stdout] test gatt_procedure_timeout ... ok
Dec 07 22:24:54.252 INFO [stdout] test gatt_server_confirmation ... ok
Dec 07 22:24:54.252 INFO [stdout] test gatt_tx_pool_available ... ok
Dec 07 22:24:54.252 INFO [stdout] test hal_crash_info ... ok
Dec 07 22:24:54.252 INFO [stdout] test hal_crash_info_failed_bad_crash_reason ... ok
Dec 07 22:24:54.252 INFO [stdout] test hal_crash_info_failed_bad_debug_data_len ... ok
Dec 07 22:24:54.252 INFO [stdout] test hal_events_lost ... ok
Dec 07 22:24:54.252 INFO [stdout] test hal_events_lost_failure ... ok
Dec 07 22:24:54.252 INFO [stdout] test hal_initialized ... ok
Dec 07 22:24:54.252 INFO [stdout] test hal_initialized_failure ... ok
Dec 07 22:24:54.253 INFO [stdout] test l2cap_connection_update_request ... ok
Dec 07 22:24:54.253 INFO [stdout] test l2cap_connection_update_request_failed_event_data_len ... ok
Dec 07 22:24:54.253 INFO [stdout] test l2cap_connection_update_request_failed_l2cap_len ... ok
Dec 07 22:24:54.253 INFO [stdout] test l2cap_connection_update_response_cmd_rejected ... ok
Dec 07 22:24:54.253 INFO [stdout] test l2cap_connection_update_response_failed_code ... ok
Dec 07 22:24:54.253 INFO [stdout] test l2cap_connection_update_response_failed_data_length ... ok
Dec 07 22:24:54.253 INFO [stdout] test l2cap_connection_update_response_failed_l2cap_length ... ok
Dec 07 22:24:54.253 INFO [stdout] test l2cap_connection_update_response_failed_unknown_rejection_reason ... ok
Dec 07 22:24:54.253 INFO [stdout] test l2cap_connection_update_response_failed_unknown_result ... ok
Dec 07 22:24:54.253 INFO [stdout] test l2cap_connection_update_response_updated_accepted ... ok
Dec 07 22:24:54.253 INFO [stdout] test l2cap_connection_update_response_updated_param_rejected ... ok
Dec 07 22:24:54.253 INFO [stdout] test l2cap_procedure_timeout ... ok
Dec 07 22:24:54.253 INFO [stdout] test l2cap_procedure_timeout_failed ... ok
Dec 07 22:24:54.253 INFO [stdout] test gatt_indication ... ok
Dec 07 22:24:54.253 INFO [stdout] test gatt_notification ... ok
Dec 07 22:24:54.253 INFO [stdout] test gatt_indication_empty ... ok
Dec 07 22:24:54.253 INFO [stdout] test gatt_discover_or_read_characteristic_by_uuid_response ... ok
Dec 07 22:24:54.253 INFO [stdout] test gatt_notification_empty ... ok
Dec 07 22:24:54.253 INFO [stdout] test gatt_discover_or_read_characteristic_by_uuid_response_empty ... ok
Dec 07 22:24:54.253 INFO [stdout] test gatt_procedure_complete_error_unknown_code ... ok
Dec 07 22:24:54.253 INFO [stdout] 
Dec 07 22:24:54.253 INFO [stdout] test result: ok. 86 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 22:24:54.253 INFO [stdout] 
Dec 07 22:24:54.260 INFO [stderr]      Running /target/debug/deps/extensions-891ba3d065d51b66
Dec 07 22:24:54.261 INFO [stdout] 
Dec 07 22:24:54.261 INFO [stdout] running 2 tests
Dec 07 22:24:54.262 INFO [stdout] test hardware_error ... ok
Dec 07 22:24:54.272 INFO [stdout] test hardware_error_failed ... ok
Dec 07 22:24:54.272 INFO [stdout] 
Dec 07 22:24:54.272 INFO [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 22:24:54.272 INFO [stdout] 
Dec 07 22:24:54.272 INFO [stderr]      Running /target/debug/deps/gap-de2416841e7f0c4a
Dec 07 22:24:54.277 INFO [stdout] 
Dec 07 22:24:54.277 INFO [stdout] running 60 tests
Dec 07 22:24:54.279 INFO [stdout] test configure_white_list ... ok
Dec 07 22:24:54.279 INFO [stdout] test clear_security_database ... ok
Dec 07 22:24:54.279 INFO [stdout] test delete_ad_type ... ok
Dec 07 22:24:54.279 INFO [stdout] test get_bonded_devices ... ok
Dec 07 22:24:54.279 INFO [stdout] test create_connection ... ok
Dec 07 22:24:54.279 INFO [stdout] test allow_rebond ... ok
Dec 07 22:24:54.280 INFO [stdout] test pass_key_response_bad_pin ... ok
Dec 07 22:24:54.280 INFO [stdout] test resolve_private_address ... ok
Dec 07 22:24:54.280 INFO [stdout] test authorization_response ... ok
Dec 07 22:24:54.280 INFO [stdout] test set_authentication_requirement ... ok
Dec 07 22:24:54.280 INFO [stdout] test set_authentication_requirement_2 ... ok
Dec 07 22:24:54.281 INFO [stdout] test set_authentication_requirement_bad_key_size_range ... ok
Dec 07 22:24:54.281 INFO [stdout] test set_authentication_requirement_bad_pin ... ok
Dec 07 22:24:54.281 INFO [stdout] test set_broadcast_mode ... ok
Dec 07 22:24:54.281 INFO [stdout] test set_authorization_requirement ... ok
Dec 07 22:24:54.281 INFO [stdout] test set_broadcast_mode_advertising_data_too_long ... ok
Dec 07 22:24:54.281 INFO [stdout] test set_broadcast_mode_white_list_too_long ... ok
Dec 07 22:24:54.281 INFO [stdout] test set_broadcast_mode_bad_advertising_type ... ok
Dec 07 22:24:54.281 INFO [stdout] test set_broadcast_mode_white_list_too_long_no_adv_data ... ok
Dec 07 22:24:54.281 INFO [stdout] test set_direct_connectable ... ok
Dec 07 22:24:54.281 INFO [stdout] test set_direct_connectable_bad_adv_interval ... ok
Dec 07 22:24:54.281 INFO [stdout] test set_direct_connectable_bad_adv_type ... ok
Dec 07 22:24:54.281 INFO [stdout] test set_discoverable_bad_adv_interval ... ok
Dec 07 22:24:54.281 INFO [stdout] test set_discoverable ... ok
Dec 07 22:24:54.281 INFO [stdout] test set_discoverable_bad_adv_type ... ok
Dec 07 22:24:54.282 INFO [stdout] test set_discoverable_bad_conn_interval ... ok
Dec 07 22:24:54.282 INFO [stdout] test set_io_capability ... ok
Dec 07 22:24:54.282 INFO [stdout] test set_limited_discoverable ... ok
Dec 07 22:24:54.282 INFO [stdout] test set_event_mask ... ok
Dec 07 22:24:54.282 INFO [stdout] test set_limited_discoverable_bad_adv_interval ... ok
Dec 07 22:24:54.282 INFO [stdout] test set_limited_discoverable_bad_conn_interval ... ok
Dec 07 22:24:54.282 INFO [stdout] test set_nonconnectable ... ok
Dec 07 22:24:54.282 INFO [stdout] test set_nonconnectable_bad_type ... ok
Dec 07 22:24:54.282 INFO [stdout] test set_nondiscoverable ... ok
Dec 07 22:24:54.284 INFO [stdout] test set_limited_discoverable_bad_adv_type ... ok
Dec 07 22:24:54.284 INFO [stdout] test set_undirected_connectable_bad_advertising_filter_policy ... ok
Dec 07 22:24:54.284 INFO [stdout] test set_undirected_connectable ... ok
Dec 07 22:24:54.284 INFO [stdout] test start_auto_connection_establishment ... ok
Dec 07 22:24:54.284 INFO [stdout] test start_connection_update ... ok
Dec 07 22:24:54.284 INFO [stdout] test start_general_connection_establishment ... ok
Dec 07 22:24:54.284 INFO [stdout] test start_general_discovery_procedure ... ok
Dec 07 22:24:54.284 INFO [stdout] test start_limited_discovery_procedure ... ok
Dec 07 22:24:54.284 INFO [stdout] test start_name_discovery_procedure ... ok
Dec 07 22:24:54.284 INFO [stdout] test start_observation_procedure ... ok
Dec 07 22:24:54.284 INFO [stdout] test start_selective_connection_establishment ... ok
Dec 07 22:24:54.284 INFO [stdout] test start_selective_connection_establishment_white_list_too_long ... ok
Dec 07 22:24:54.284 INFO [stdout] test terminate ... ok
Dec 07 22:24:54.284 INFO [stdout] test terminate_bad_disconnection_reason ... ok
Dec 07 22:24:54.284 INFO [stdout] test terminate_multiple_procedure ... ok
Dec 07 22:24:54.284 INFO [stdout] test terminate_no_procedure ... ok
Dec 07 22:24:54.284 INFO [stdout] test terminate_procedure ... ok
Dec 07 22:24:54.284 INFO [stdout] test update_advertising_data ... ok
Dec 07 22:24:54.284 INFO [stdout] test update_advertising_data_too_long ... ok
Dec 07 22:24:54.284 INFO [stdout] test start_auto_connection_establishment_white_list_too_long ... ok
Dec 07 22:24:54.284 INFO [stdout] test send_pairing_request ... ok
Dec 07 22:24:54.296 INFO [stdout] test peripheral_security_request ... ok
Dec 07 22:24:54.296 INFO [stdout] test pass_key_response ... ok
Dec 07 22:24:54.296 INFO [stdout] test is_device_bonded ... ok
Dec 07 22:24:54.296 INFO [stdout] test get_security_level ... ok
Dec 07 22:24:54.300 INFO [stdout] test init ... ok
Dec 07 22:24:54.300 INFO [stdout] 
Dec 07 22:24:54.300 INFO [stdout] test result: ok. 60 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 22:24:54.300 INFO [stdout] 
Dec 07 22:24:54.308 INFO [stderr]      Running /target/debug/deps/gatt-e537334105a06132
Dec 07 22:24:54.320 INFO [stdout] 
Dec 07 22:24:54.320 INFO [stdout] running 73 tests
Dec 07 22:24:54.332 INFO [stdout] test add_characteristic_128 ... ok
Dec 07 22:24:54.344 INFO [stdout] test add_characteristic_descriptor_buffer_too_long ... ok
Dec 07 22:24:54.344 INFO [stdout] test add_characteristic_descriptor_too_long ... ok
Dec 07 22:24:54.344 INFO [stdout] test add_characteristic_pre_v72_16 ... ok
Dec 07 22:24:54.344 INFO [stdout] test add_characteristic_descriptor_128 ... ok
Dec 07 22:24:54.344 INFO [stdout] test add_characteristic_16 ... ok
Dec 07 22:24:54.344 INFO [stdout] test add_characteristic_pre_v72_128 ... ok
Dec 07 22:24:54.344 INFO [stdout] test add_characteristic_descriptor_16 ... ok
Dec 07 22:24:54.344 INFO [stdout] test add_service_128 ... ok
Dec 07 22:24:54.344 INFO [stdout] test confirm_indication ... ok
Dec 07 22:24:54.348 INFO [stdout] test cancel_write_request ... ok
Dec 07 22:24:54.348 INFO [stdout] test delete_included_service ... ok
Dec 07 22:24:54.348 INFO [stdout] test add_service_16 ... ok
Dec 07 22:24:54.348 INFO [stdout] test allow_read ... ok
Dec 07 22:24:54.348 INFO [stdout] test bad_range ... ok
Dec 07 22:24:54.348 INFO [stdout] test delete_characteristic ... ok
Dec 07 22:24:54.348 INFO [stdout] test discover_all_characteristic_descriptors ... ok
Dec 07 22:24:54.348 INFO [stdout] test delete_service ... ok
Dec 07 22:24:54.348 INFO [stdout] test discover_all_characteristics_of_service ... ok
Dec 07 22:24:54.348 INFO [stdout] test discover_all_primary_services ... ok
Dec 07 22:24:54.348 INFO [stdout] test discover_characteristics_by_uuid_128 ... ok
Dec 07 22:24:54.348 INFO [stdout] test discover_characteristics_by_uuid_16 ... ok
Dec 07 22:24:54.348 INFO [stdout] test discovery_primary_services_by_uuid_128 ... ok
Dec 07 22:24:54.348 INFO [stdout] test discovery_primary_services_by_uuid_16 ... ok
Dec 07 22:24:54.348 INFO [stdout] test encryption_key_size_range ... ok
Dec 07 22:24:54.348 INFO [stdout] test exchange_configuration ... ok
Dec 07 22:24:54.349 INFO [stdout] test execute_write_request ... ok
Dec 07 22:24:54.349 INFO [stdout] test find_by_type_value_request ... ok
Dec 07 22:24:54.349 INFO [stdout] test find_by_type_value_request_value_too_long ... ok
Dec 07 22:24:54.349 INFO [stdout] test find_included_services ... ok
Dec 07 22:24:54.349 INFO [stdout] test find_information_request ... ok
Dec 07 22:24:54.349 INFO [stdout] test include_service_128 ... ok
Dec 07 22:24:54.349 INFO [stdout] test include_service_16 ... ok
Dec 07 22:24:54.349 INFO [stdout] test init ... ok
Dec 07 22:24:54.349 INFO [stdout] test prepare_write_request ... ok
Dec 07 22:24:54.349 INFO [stdout] test prepare_write_request_too_long ... ok
Dec 07 22:24:54.349 INFO [stdout] test read_by_group_type_request_128 ... ok
Dec 07 22:24:54.349 INFO [stdout] test read_by_group_type_request_16 ... ok
Dec 07 22:24:54.349 INFO [stdout] test read_by_type_request_128 ... ok
Dec 07 22:24:54.349 INFO [stdout] test read_by_type_request_16 ... ok
Dec 07 22:24:54.349 INFO [stdout] test read_characteristic_descriptor ... ok
Dec 07 22:24:54.349 INFO [stdout] test read_characteristic_using_uuid_128 ... ok
Dec 07 22:24:54.349 INFO [stdout] test read_characteristic_using_uuid_16 ... ok
Dec 07 22:24:54.349 INFO [stdout] test read_characteristic_value ... ok
Dec 07 22:24:54.349 INFO [stdout] test read_handle_value ... ok
Dec 07 22:24:54.349 INFO [stdout] test read_handle_value_offset ... ok
Dec 07 22:24:54.349 INFO [stdout] test read_long_characteristic_descriptor ... ok
Dec 07 22:24:54.349 INFO [stdout] test read_long_characteristic_value ... ok
Dec 07 22:24:54.349 INFO [stdout] test read_multiple_characteristic_values ... ok
Dec 07 22:24:54.349 INFO [stdout] test read_multiple_characteristic_values_too_many_handles ... ok
Dec 07 22:24:54.349 INFO [stdout] test set_descriptor_value ... ok
Dec 07 22:24:54.349 INFO [stdout] test set_descriptor_value_too_long ... ok
Dec 07 22:24:54.349 INFO [stdout] test set_event_mask ... ok
Dec 07 22:24:54.349 INFO [stdout] test set_security_permission ... ok
Dec 07 22:24:54.349 INFO [stdout] test signed_write_without_response ... ok
Dec 07 22:24:54.349 INFO [stdout] test signed_write_without_response_too_long ... ok
Dec 07 22:24:54.349 INFO [stdout] test update_characteristic_value ... ok
Dec 07 22:24:54.349 INFO [stdout] test update_long_characteristic_value ... ok
Dec 07 22:24:54.349 INFO [stdout] test update_long_characteristic_value_too_long ... ok
Dec 07 22:24:54.349 INFO [stdout] test write_characteristic_descriptor ... ok
Dec 07 22:24:54.349 INFO [stdout] test write_characteristic_descriptor_too_long ... ok
Dec 07 22:24:54.349 INFO [stdout] test write_characteristic_value ... ok
Dec 07 22:24:54.349 INFO [stdout] test write_characteristic_value_reliably ... ok
Dec 07 22:24:54.349 INFO [stdout] test write_characteristic_value_reliably_too_long ... ok
Dec 07 22:24:54.349 INFO [stdout] test write_characteristic_value_too_long ... ok
Dec 07 22:24:54.349 INFO [stdout] test write_long_characteristic_descriptor ... ok
Dec 07 22:24:54.349 INFO [stdout] test write_long_characteristic_descriptor_too_long ... ok
Dec 07 22:24:54.349 INFO [stdout] test write_long_characteristic_value ... ok
Dec 07 22:24:54.349 INFO [stdout] test write_long_characteristic_value_too_long ... ok
Dec 07 22:24:54.349 INFO [stdout] test write_response ... ok
Dec 07 22:24:54.349 INFO [stdout] test write_response_too_long ... ok
Dec 07 22:24:54.349 INFO [stdout] test write_without_response ... ok
Dec 07 22:24:54.349 INFO [stdout] test write_without_response_too_long ... ok
Dec 07 22:24:54.349 INFO [stdout] 
Dec 07 22:24:54.349 INFO [stdout] test result: ok. 73 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 22:24:54.349 INFO [stdout] 
Dec 07 22:24:54.349 INFO [stderr]      Running /target/debug/deps/hal-dbbdac20f2fe8dbf
Dec 07 22:24:54.380 INFO [stdout] 
Dec 07 22:24:54.380 INFO [stdout] running 12 tests
Dec 07 22:24:54.380 INFO [stdout] test config_data ... ok
Dec 07 22:24:54.380 INFO [stdout] test read_config_data ... ok
Dec 07 22:24:54.380 INFO [stdout] test get_tx_test_packet_count ... ok
Dec 07 22:24:54.380 INFO [stdout] test device_standby ... ok
Dec 07 22:24:54.380 INFO [stdout] test get_link_status ... ok
Dec 07 22:24:54.380 INFO [stdout] test start_tone ... ok
Dec 07 22:24:54.380 INFO [stdout] test start_tone_invalid ... ok
Dec 07 22:24:54.380 INFO [stdout] test stop_tone ... ok
Dec 07 22:24:54.380 INFO [stdout] test write_config_data ... ok
Dec 07 22:24:54.380 INFO [stdout] test set_tx_power_level ... ok
Dec 07 22:24:54.380 INFO [stdout] test get_anchor_period ... ok
Dec 07 22:24:54.380 INFO [stdout] test get_firmware_revision ... ok
Dec 07 22:24:54.380 INFO [stdout] 
Dec 07 22:24:54.380 INFO [stdout] test result: ok. 12 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 22:24:54.380 INFO [stdout] 
Dec 07 22:24:54.380 INFO [stdout] 
Dec 07 22:24:54.380 INFO [stdout] running 2 tests
Dec 07 22:24:54.380 INFO [stdout] test connection_parameter_update_response ... ok
Dec 07 22:24:54.380 INFO [stdout] test connection_parameter_update_request ... ok
Dec 07 22:24:54.380 INFO [stdout] 
Dec 07 22:24:54.380 INFO [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 22:24:54.380 INFO [stdout] 
Dec 07 22:24:54.381 INFO [stderr]      Running /target/debug/deps/l2cap-893aab78ac186ab2
Dec 07 22:24:54.381 INFO [stderr]    Doc-tests bluenrg
Dec 07 22:24:55.468 INFO [stdout] 
Dec 07 22:24:55.468 INFO [stdout] running 0 tests
Dec 07 22:24:55.468 INFO [stdout] 
Dec 07 22:24:55.468 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 22:24:55.468 INFO [stdout] 
Dec 07 22:24:55.475 INFO [stderr] su: No module specific data is present
Dec 07 22:24:55.918 INFO running `"docker" "inspect" "954cb1aeaaf3a3764d5981391ee705ed4fd15e57723869fd88d9976b6bce69b0"`
Dec 07 22:24:55.995 INFO running `"docker" "rm" "-f" "954cb1aeaaf3a3764d5981391ee705ed4fd15e57723869fd88d9976b6bce69b0"`
Dec 07 22:24:56.141 INFO [stdout] 954cb1aeaaf3a3764d5981391ee705ed4fd15e57723869fd88d9976b6bce69b0