[INFO] fetching crate bluetooth-hci 0.1.0... [INFO] testing bluetooth-hci-0.1.0 against 1.60.0 for beta-1.61-1 [INFO] extracting crate bluetooth-hci 0.1.0 into /workspace/builds/worker-89/source [INFO] validating manifest of crates.io crate bluetooth-hci 0.1.0 on toolchain 1.60.0 [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.60.0" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] started tweaking crates.io crate bluetooth-hci 0.1.0 [INFO] finished tweaking crates.io crate bluetooth-hci 0.1.0 [INFO] tweaked toml for crates.io crate bluetooth-hci 0.1.0 written to /workspace/builds/worker-89/source/Cargo.toml [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.60.0" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.60.0" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-89/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-89/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+1.60.0" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] 11eafb73fa1068312bf2f6b14454082e0159d48afc33f348479991d452af41cb [INFO] running `Command { std: "docker" "start" "-a" "11eafb73fa1068312bf2f6b14454082e0159d48afc33f348479991d452af41cb", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "11eafb73fa1068312bf2f6b14454082e0159d48afc33f348479991d452af41cb", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "11eafb73fa1068312bf2f6b14454082e0159d48afc33f348479991d452af41cb", kill_on_drop: false }` [INFO] [stdout] 11eafb73fa1068312bf2f6b14454082e0159d48afc33f348479991d452af41cb [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-89/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-89/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+1.60.0" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] c76118c7030d76cbc4036b64c6e8f02e13de301a05583120e4f2d425b24cb89c [INFO] running `Command { std: "docker" "start" "-a" "c76118c7030d76cbc4036b64c6e8f02e13de301a05583120e4f2d425b24cb89c", kill_on_drop: false }` [INFO] [stderr] Compiling byteorder v1.4.3 [INFO] [stderr] Compiling bluetooth-hci v0.1.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished dev [unoptimized + debuginfo] target(s) in 3.23s [INFO] running `Command { std: "docker" "inspect" "c76118c7030d76cbc4036b64c6e8f02e13de301a05583120e4f2d425b24cb89c", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "c76118c7030d76cbc4036b64c6e8f02e13de301a05583120e4f2d425b24cb89c", kill_on_drop: false }` [INFO] [stdout] c76118c7030d76cbc4036b64c6e8f02e13de301a05583120e4f2d425b24cb89c [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-89/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-89/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+1.60.0" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] a1cfaa6e8aae39a71f677465e7601ec2353557719eb6d240cda1825b53fd2a01 [INFO] running `Command { std: "docker" "start" "-a" "a1cfaa6e8aae39a71f677465e7601ec2353557719eb6d240cda1825b53fd2a01", kill_on_drop: false }` [INFO] [stderr] Compiling bluetooth-hci v0.1.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 5.56s [INFO] running `Command { std: "docker" "inspect" "a1cfaa6e8aae39a71f677465e7601ec2353557719eb6d240cda1825b53fd2a01", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "a1cfaa6e8aae39a71f677465e7601ec2353557719eb6d240cda1825b53fd2a01", kill_on_drop: false }` [INFO] [stdout] a1cfaa6e8aae39a71f677465e7601ec2353557719eb6d240cda1825b53fd2a01 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-89/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-89/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+1.60.0" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] c4e7ba8016cc08ec23541eae7281121d71a2226489214f8958018204add0490c [INFO] running `Command { std: "docker" "start" "-a" "c4e7ba8016cc08ec23541eae7281121d71a2226489214f8958018204add0490c", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stdout] [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 1.15s [INFO] [stdout] running 0 tests [INFO] [stderr] Running unittests (/opt/rustwide/target/debug/deps/bluetooth_hci-e822e5635e6391a9) [INFO] [stdout] [INFO] [stderr] Running tests/advertising_interval.rs (/opt/rustwide/target/debug/deps/advertising_interval-f3166483dfa7e8a0) [INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s [INFO] [stderr] Running tests/command_complete.rs (/opt/rustwide/target/debug/deps/command_complete-792ce72cb662a7c8) [INFO] [stdout] [INFO] [stderr] Running tests/connection_interval.rs (/opt/rustwide/target/debug/deps/connection_interval-27af56d7e70a3500) [INFO] [stdout] [INFO] [stderr] Running tests/event.rs (/opt/rustwide/target/debug/deps/event-be97441bb26873ef) [INFO] [stdout] running 8 tests [INFO] [stderr] Running tests/expected_connection_length.rs (/opt/rustwide/target/debug/deps/expected_connection_length-caf5d978d7f2a0a0) [INFO] [stdout] test connectable_directed_high_duty_cycle_with_range ... ok [INFO] [stderr] Running tests/host.rs (/opt/rustwide/target/debug/deps/host-f4437b2a762262d3) [INFO] [stdout] test connectable_directed_high_duty_cycle_without_range ... ok [INFO] [stdout] test higher_min_scannable_undirected ... ok [INFO] [stdout] test interval_too_long ... ok [INFO] [stdout] test interval_too_short ... ok [INFO] [stdout] test inverted ... ok [INFO] [stdout] test other_type_without_range ... ok [INFO] [stdout] test valid ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 8 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] running 40 tests [INFO] [stdout] test command_complete_failed ... ok [INFO] [stdout] test le_add_device_to_whitelist ... ok [INFO] [stdout] test le_clear_white_list ... ok [INFO] [stdout] test le_create_connection_cancel ... ok [INFO] [stdout] test le_long_term_key_request_reply ... ok [INFO] [stdout] test le_long_term_key_request_negative_reply ... ok [INFO] [stdout] test le_rand ... ok [INFO] [stdout] test le_encrypt ... ok [INFO] [stdout] test le_read_advertising_channel_tx_power ... ok [INFO] [stdout] test le_read_local_supported_features ... ok [INFO] [stdout] test le_read_buffer_size ... ok [INFO] [stdout] test le_read_channel_map ... ok [INFO] [stdout] test le_read_channel_map_failed_reserved ... ok [INFO] [stdout] test le_read_supported_states ... ok [INFO] [stdout] test le_read_supported_states_failed_reserved_flag ... ok [INFO] [stdout] test le_read_white_list_size ... ok [INFO] [stdout] test le_receiver_test ... ok [INFO] [stdout] test le_set_advertise_enable ... ok [INFO] [stdout] test le_set_advertising_parameters ... ok [INFO] [stdout] test le_set_host_channel_classification ... ok [INFO] [stdout] test le_set_advertising_data ... ok [INFO] [stdout] test le_set_event_mask ... ok [INFO] [stdout] test le_remove_device_from_whitelist ... ok [INFO] [stdout] test le_set_random_address ... ok [INFO] [stdout] test le_set_scan_enable ... ok [INFO] [stdout] test le_set_scan_parameters ... ok [INFO] [stdout] test le_set_scan_response_data ... ok [INFO] [stdout] test le_test_end ... ok [INFO] [stdout] test le_transmitter_test ... ok [INFO] [stdout] test read_bd_addr ... ok [INFO] [stdout] test read_local_supported_commands_failed_bad_command_flag ... ok [INFO] [stdout] test read_local_version_information ... ok [INFO] [stdout] test read_local_supported_commands ... ok [INFO] [stdout] test read_local_supported_features ... ok [INFO] [stdout] test set_event_mask ... ok [INFO] [stdout] test reset ... ok [INFO] [stdout] test read_rssi ... ok [INFO] [stdout] test read_tx_power_level ... ok [INFO] [stdout] test unsolicited_command_complete ... ok [INFO] [stdout] test vendor_command ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 40 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] running 26 tests [INFO] [stdout] test bad_conn_latency ... ok [INFO] [stdout] test fixed_from_bytes_bad_connection_latency ... ok [INFO] [stdout] test fixed_from_bytes_interval_too_long ... ok [INFO] [stdout] test fixed_from_bytes_interval_too_short ... ok [INFO] [stdout] test fixed_from_bytes_supervision_timeout_impossible ... ok [INFO] [stdout] test fixed_from_bytes_supervision_timeout_too_long ... ok [INFO] [stdout] test fixed_from_bytes_supervision_timeout_too_short_relative ... ok [INFO] [stdout] test fixed_from_bytes_valid ... ok [INFO] [stdout] test from_bytes_bad_connection_latency ... ok [INFO] [stdout] test from_bytes_interval_too_long ... ok [INFO] [stdout] test from_bytes_supervision_timeout_impossible ... ok [INFO] [stdout] test from_bytes_interval_too_short ... ok [INFO] [stdout] test from_bytes_supervision_timeout_too_long ... ok [INFO] [stdout] test from_bytes_supervision_timeout_too_short_absolute ... ok [INFO] [stdout] test fixed_from_bytes_supervision_timeout_too_short_absolute ... ok [INFO] [stdout] test from_bytes_valid ... ok [INFO] [stdout] test impossible_supervision_timeout ... ok [INFO] [stdout] test from_bytes_supervision_timeout_too_short_relative ... ok [INFO] [stdout] test incomplete ... ok [INFO] [stdout] test supervision_timeout_too_long ... ok [INFO] [stdout] test supervision_timeout_too_short_absolute ... ok [INFO] [stdout] test supervision_timeout_too_short_relative ... ok [INFO] [stdout] test valid ... ok [INFO] [stdout] test inverted ... ok [INFO] [stdout] test too_long ... ok [INFO] [stdout] test too_short ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 26 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] running 31 tests [INFO] [stdout] test command_status ... ok [INFO] [stdout] test connection_complete ... ok [INFO] [stdout] test command_status_vendor_status ... ok [INFO] [stdout] test disconnection_complete ... ok [INFO] [stdout] test connection_complete_failed_bad_link_type ... ok [INFO] [stdout] test data_buffer_overflow ... ok [INFO] [stdout] test data_buffer_overflow_failed_bad_link_type ... ok [INFO] [stdout] test connection_complete_failed_encryption_enabled ... ok [INFO] [stdout] test connection_complete_failed_bad_status ... ok [INFO] [stdout] test disconnection_complete_failed_bad_status ... ok [INFO] [stdout] test disconnection_complete_failed_bad_reason ... ok [INFO] [stdout] test encryption_change ... ok [INFO] [stdout] test encryption_change_failed_bad_status ... ok [INFO] [stdout] test hardware_error ... ok [INFO] [stdout] test encryption_change_failed_bad_encryption ... ok [INFO] [stdout] test le_advertising_report ... ok [INFO] [stdout] test encryption_key_refresh_complete ... ok [INFO] [stdout] test le_advertising_report_failed_bad_addr_type ... ok [INFO] [stdout] test le_advertising_report_failed_bad_advertisement_type ... ok [INFO] [stdout] test le_advertising_report_failed_incomplete ... ok [INFO] [stdout] test le_connection_complete_failed_bad_address_type ... ok [INFO] [stdout] test le_connection_complete ... ok [INFO] [stdout] test le_connection_complete_failed_bad_central_clock_accuracy ... ok [INFO] [stdout] test le_connection_complete_failed_bad_role ... ok [INFO] [stdout] test le_connection_update_complete ... ok [INFO] [stdout] test le_long_term_key_request ... ok [INFO] [stdout] test le_read_remote_used_features_complete ... ok [INFO] [stdout] test number_of_completed_packets ... ok [INFO] [stdout] test read_remote_version_complete_failed_bad_status ... ok [INFO] [stdout] test le_read_remote_used_features_complete_failed_bad_flag ... ok [INFO] [stdout] test read_remote_version_complete ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 31 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] running 3 tests [INFO] [stdout] test interval_too_long ... ok [INFO] [stdout] test inverted ... ok [INFO] [stdout] test valid ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] running 54 tests [INFO] [stdout] test disconnect ... ok [INFO] [stdout] test disconnect_bad_reason ... ok [INFO] [stdout] test le_connection_update ... ok [INFO] [stdout] test le_clear_white_list ... ok [INFO] [stdout] test le_add_device_to_white_list ... ok [INFO] [stdout] test le_create_connection_no_whitelist ... ok [INFO] [stdout] test le_create_connection_use_whitelist ... ok [INFO] [stdout] test le_encrypt ... ok [INFO] [stdout] test le_long_term_key_request_reply ... ok [INFO] [stdout] test le_rand ... ok [INFO] [stdout] test le_read_channel_map ... ok [INFO] [stdout] test le_read_buffer_size ... ok [INFO] [stdout] test le_read_local_supported_features ... ok [INFO] [stdout] test le_read_remote_used_features ... ok [INFO] [stdout] test le_read_supported_states ... ok [INFO] [stdout] test le_read_advertising_channel_tx_power ... ok [INFO] [stdout] test le_read_white_list_size ... ok [INFO] [stdout] test le_create_connection_cancel ... ok [INFO] [stdout] test le_long_term_key_request_negative_reply ... ok [INFO] [stdout] test le_receiver_test ... ok [INFO] [stdout] test le_receiver_test_out_of_range ... ok [INFO] [stdout] test le_remove_device_from_white_list ... ok [INFO] [stdout] test le_set_advertise_enable ... ok [INFO] [stdout] test le_set_advertising_data_empty ... ok [INFO] [stdout] test le_set_advertising_data_full ... ok [INFO] [stdout] test le_set_advertising_data_too_long ... ok [INFO] [stdout] test le_set_advertising_parameters ... ok [INFO] [stdout] test le_set_event_mask ... ok [INFO] [stdout] test le_set_advertising_parameters_bad_channel_map ... ok [INFO] [stdout] test le_set_host_channel_classification ... ok [INFO] [stdout] test le_set_advertising_data_partial ... ok [INFO] [stdout] test le_set_host_channel_classification_failed_empty ... ok [INFO] [stdout] test le_set_random_address ... ok [INFO] [stdout] test le_set_random_address_invalid_addr_type ... ok [INFO] [stdout] test le_set_scan_enable ... ok [INFO] [stdout] test le_set_scan_parameters ... ok [INFO] [stdout] test le_set_scan_response_data_empty ... ok [INFO] [stdout] test le_set_scan_response_data_full ... ok [INFO] [stdout] test le_set_scan_response_data_partial ... ok [INFO] [stdout] test le_set_scan_response_data_too_long ... ok [INFO] [stdout] test le_start_encryption ... ok [INFO] [stdout] test le_test_end ... ok [INFO] [stdout] test le_transmitter_test ... ok [INFO] [stdout] test le_transmitter_test_channel_out_of_range ... ok [INFO] [stdout] test le_transmitter_test_length_out_of_range ... ok [INFO] [stdout] test read_bd_addr ... ok [INFO] [stdout] test read_local_supported_commands ... ok [INFO] [stdout] test read_local_supported_features ... ok [INFO] [stdout] test read_local_version_information ... ok [INFO] [stdout] test read_remote_version_information ... ok [INFO] [stdout] test read_rssi ... ok [INFO] [stdout] test read_tx_power_level ... ok [INFO] [stdout] test reset ... ok [INFO] [stdout] test set_event_mask ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 54 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s [INFO] [stdout] [INFO] [stderr] Running tests/scan_window.rs (/opt/rustwide/target/debug/deps/scan_window-fe75631b22a8a2c5) [INFO] [stdout] [INFO] [stdout] running 7 tests [INFO] [stdout] test copy_into_slice ... ok [INFO] [stdout] test interval_too_long ... ok [INFO] [stdout] test inverted ... ok [INFO] [stdout] test inverted_and_window_too_long ... ok [INFO] [stdout] test valid ... ok [INFO] [stdout] test window_too_short ... ok [INFO] [stdout] test interval_too_short ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s [INFO] [stdout] [INFO] [stderr] Doc-tests bluetooth-hci [INFO] [stdout] [INFO] [stdout] running 2 tests [INFO] [stdout] test src/lib.rs - Controller::peek (line 237) ... ok [INFO] [stdout] test src/lib.rs - Controller::read_into (line 139) ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.64s [INFO] [stdout] [INFO] running `Command { std: "docker" "inspect" "c4e7ba8016cc08ec23541eae7281121d71a2226489214f8958018204add0490c", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "c4e7ba8016cc08ec23541eae7281121d71a2226489214f8958018204add0490c", kill_on_drop: false }` [INFO] [stdout] c4e7ba8016cc08ec23541eae7281121d71a2226489214f8958018204add0490c