[INFO] fetching crate qcicada 0.2.2...
[INFO] testing qcicada-0.2.2 against master#562dee4820c458d823175268e41601d4c060588a for pr-154210-2
[INFO] extracting crate qcicada 0.2.2 into /workspace/builds/worker-6-tc1/source
[INFO] started tweaking crates.io crate qcicada 0.2.2
[INFO] removed 0 missing examples
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate qcicada 0.2.2
[INFO] tweaked toml for crates.io crate qcicada 0.2.2 written to /workspace/builds/worker-6-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate qcicada 0.2.2 on toolchain 562dee4820c458d823175268e41601d4c060588a
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate qcicada 0.2.2 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded libudev v0.3.0
[INFO] [stderr]   Downloaded libudev-sys v0.1.4
[INFO] [stderr]   Downloaded serialport v4.8.1
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 6c2b2f096f3e3d6d9e743084499630f590d4d3fb19277b5856f9dfffab63fd73
[INFO] running `Command { std: "docker" "start" "-a" "6c2b2f096f3e3d6d9e743084499630f590d4d3fb19277b5856f9dfffab63fd73", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "6c2b2f096f3e3d6d9e743084499630f590d4d3fb19277b5856f9dfffab63fd73", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "6c2b2f096f3e3d6d9e743084499630f590d4d3fb19277b5856f9dfffab63fd73", kill_on_drop: false }`
[INFO] [stdout] 6c2b2f096f3e3d6d9e743084499630f590d4d3fb19277b5856f9dfffab63fd73
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/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=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] f60ff7712cc05f3b1d034b056d6b4792d0a68184306e57547ff7dc1733390523
[INFO] running `Command { std: "docker" "start" "-a" "f60ff7712cc05f3b1d034b056d6b4792d0a68184306e57547ff7dc1733390523", kill_on_drop: false }`
[INFO] [stderr]    Compiling zeroize v1.8.2
[INFO] [stderr]    Compiling libc v0.2.183
[INFO] [stderr]    Compiling subtle v2.6.1
[INFO] [stderr]    Compiling base64ct v1.8.3
[INFO] [stderr]    Compiling generic-array v0.14.9
[INFO] [stderr]    Compiling libudev-sys v0.1.4
[INFO] [stderr]    Compiling quote v1.0.40
[INFO] [stderr]    Compiling proc-macro2 v1.0.106
[INFO] [stderr]    Compiling scopeguard v1.2.0
[INFO] [stderr]    Compiling syn v2.0.117
[INFO] [stderr]    Compiling pem-rfc7468 v0.7.0
[INFO] [stderr]    Compiling der v0.7.10
[INFO] [stderr]    Compiling crypto-common v0.1.6
[INFO] [stderr]    Compiling block-buffer v0.10.4
[INFO] [stderr]    Compiling digest v0.10.7
[INFO] [stderr]    Compiling hmac v0.12.1
[INFO] [stderr]    Compiling sha2 v0.10.9
[INFO] [stderr]    Compiling rfc6979 v0.4.0
[INFO] [stderr]    Compiling spki v0.7.3
[INFO] [stderr]    Compiling pkcs8 v0.10.2
[INFO] [stderr]    Compiling sec1 v0.7.3
[INFO] [stderr]    Compiling getrandom v0.2.17
[INFO] [stderr]    Compiling nix v0.26.4
[INFO] [stderr]    Compiling libudev v0.3.0
[INFO] [stderr]    Compiling rand_core v0.6.4
[INFO] [stderr]    Compiling ff v0.13.1
[INFO] [stderr]    Compiling crypto-bigint v0.5.5
[INFO] [stderr]    Compiling signature v2.2.0
[INFO] [stderr]    Compiling thiserror-impl v2.0.18
[INFO] [stderr]    Compiling group v0.13.0
[INFO] [stderr]    Compiling thiserror v2.0.18
[INFO] [stderr]    Compiling unescaper v0.1.8
[INFO] [stderr]    Compiling serialport v4.8.1
[INFO] [stderr]    Compiling elliptic-curve v0.13.8
[INFO] [stderr]    Compiling primeorder v0.13.6
[INFO] [stderr]    Compiling ecdsa v0.16.9
[INFO] [stderr]    Compiling p256 v0.13.2
[INFO] [stderr]    Compiling qcicada v0.2.2 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 21.06s
[INFO] running `Command { std: "docker" "inspect" "f60ff7712cc05f3b1d034b056d6b4792d0a68184306e57547ff7dc1733390523", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "f60ff7712cc05f3b1d034b056d6b4792d0a68184306e57547ff7dc1733390523", kill_on_drop: false }`
[INFO] [stdout] f60ff7712cc05f3b1d034b056d6b4792d0a68184306e57547ff7dc1733390523
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/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=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 7b5eeb1054f981392aa310c15de90bd88811d4f76546efd287310e7254f64d9f
[INFO] running `Command { std: "docker" "start" "-a" "7b5eeb1054f981392aa310c15de90bd88811d4f76546efd287310e7254f64d9f", kill_on_drop: false }`
[INFO] [stderr]    Compiling qcicada v0.2.2 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 2.32s
[INFO] running `Command { std: "docker" "inspect" "7b5eeb1054f981392aa310c15de90bd88811d4f76546efd287310e7254f64d9f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "7b5eeb1054f981392aa310c15de90bd88811d4f76546efd287310e7254f64d9f", kill_on_drop: false }`
[INFO] [stdout] 7b5eeb1054f981392aa310c15de90bd88811d4f76546efd287310e7254f64d9f
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/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=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] a49a6b06d6c29bba3e8fd81517489c5ca033c1d5389f68ffa4a2a0429a85c9d9
[INFO] running `Command { std: "docker" "start" "-a" "a49a6b06d6c29bba3e8fd81517489c5ca033c1d5389f68ffa4a2a0429a85c9d9", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.14s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/qcicada-e16bc9f3e6f52e4f)
[INFO] [stdout] 
[INFO] [stdout] running 42 tests
[INFO] [stdout] test crypto::tests::verify_certificate_bad_lengths ... ok
[INFO] [stdout] test crypto::tests::verify_signature_bad_key_length ... ok
[INFO] [stdout] test protocol::tests::build_cmd_no_payload ... ok
[INFO] [stdout] test protocol::tests::build_cmd_with_payload ... ok
[INFO] [stdout] test protocol::tests::build_signed_read_format ... ok
[INFO] [stdout] test protocol::tests::build_start_continuous_format ... ok
[INFO] [stdout] test protocol::tests::build_start_one_shot_format ... ok
[INFO] [stdout] test protocol::tests::build_start_one_shot_large ... ok
[INFO] [stdout] test protocol::tests::build_start_one_shot_max ... ok
[INFO] [stdout] test protocol::tests::checksum8_empty ... ok
[INFO] [stdout] test protocol::tests::checksum8_single ... ok
[INFO] [stdout] test protocol::tests::checksum8_sum_to_ff ... ok
[INFO] [stdout] test protocol::tests::checksum8_wrapping ... ok
[INFO] [stdout] test protocol::tests::command_codes_match_c_header ... ok
[INFO] [stdout] test protocol::tests::config_all_flags_off ... ok
[INFO] [stdout] test protocol::tests::config_all_flags_on ... ok
[INFO] [stdout] test protocol::tests::config_roundtrip ... ok
[INFO] [stdout] test protocol::tests::expected_response_mapping ... ok
[INFO] [stdout] test protocol::tests::parse_config_invalid_postprocess ... ok
[INFO] [stdout] test protocol::tests::parse_config_raw_noise ... ok
[INFO] [stdout] test protocol::tests::parse_config_sha256_defaults ... ok
[INFO] [stdout] test protocol::tests::parse_config_too_short ... ok
[INFO] [stdout] test protocol::tests::parse_info_full_length_strings ... ok
[INFO] [stdout] test protocol::tests::parse_info_normal ... ok
[INFO] [stdout] test protocol::tests::parse_info_too_short ... ok
[INFO] [stdout] test protocol::tests::parse_statistics_normal ... ok
[INFO] [stdout] test protocol::tests::parse_statistics_too_short ... ok
[INFO] [stdout] test protocol::tests::parse_status_all_clear ... ok
[INFO] [stdout] test protocol::tests::parse_status_all_flags_set ... ok
[INFO] [stdout] test protocol::tests::parse_status_too_short ... ok
[INFO] [stdout] test protocol::tests::payload_size_mapping ... ok
[INFO] [stdout] test protocol::tests::postprocess_to_u8 ... ok
[INFO] [stdout] test protocol::tests::postprocess_try_from ... ok
[INFO] [stdout] test protocol::tests::response_codes_match_c_header ... ok
[INFO] [stdout] test protocol::tests::signed_read_response_mapping ... ok
[INFO] [stdout] test crypto::tests::verify_signature_bad_sig_length ... ok
[INFO] [stdout] test protocol::tests::parse_status_individual_flags ... ok
[INFO] [stdout] test crypto::tests::verify_certificate_valid ... ok
[INFO] [stdout] test crypto::tests::verify_signature_valid ... ok
[INFO] [stdout] test crypto::tests::verify_signature_wrong_message ... ok
[INFO] [stdout] test crypto::tests::verify_certificate_wrong_serial ... ok
[INFO] [stdout] test crypto::tests::verify_signature_wrong_key ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 42 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.10s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]      Running tests/device.rs (/opt/rustwide/target/debug/deps/device-5da5ba6191c47762)
[INFO] [stdout] running 27 tests
[INFO] [stderr]    Doc-tests qcicada
[INFO] [stdout] test config_roundtrip ... ignored
[INFO] [stdout] test continuous_mode_fresh_read ... ignored
[INFO] [stdout] test continuous_mode_multiple_reads ... ignored
[INFO] [stdout] test continuous_mode_read ... ignored
[INFO] [stdout] test discover_devices_finds_device ... ignored
[INFO] [stdout] test drain_input_is_safe ... ignored
[INFO] [stdout] test fill_bytes_large ... ignored
[INFO] [stdout] test get_config ... ignored
[INFO] [stdout] test get_dev_certificate ... ignored
[INFO] [stdout] test get_dev_pub_key ... ignored
[INFO] [stdout] test get_info ... ignored
[INFO] [stdout] test get_statistics ... ignored
[INFO] [stdout] test get_status ... ignored
[INFO] [stdout] test io_read_trait ... ignored
[INFO] [stdout] test random_raw_noise ... ignored
[INFO] [stdout] test random_raw_samples ... ignored
[INFO] [stdout] test random_sha256_32_bytes ... ignored
[INFO] [stdout] test random_sha256_different_each_time ... ignored
[INFO] [stdout] test random_various_sizes ... ignored
[INFO] [stdout] test random_zero_returns_empty ... ignored
[INFO] [stdout] test set_postprocess_convenience ... ignored
[INFO] [stdout] test signed_read_32_bytes ... ignored
[INFO] [stdout] test signed_read_different_each_time ... ignored
[INFO] [stdout] test signed_read_verified_with_device_key ... ignored
[INFO] [stdout] test signed_read_verified_wrong_key_fails ... ignored
[INFO] [stdout] test stop_is_safe ... ignored
[INFO] [stdout] test probe_device_on_bogus_port ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 26 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test src/lib.rs - (line 10) - compile ... ok
[INFO] [stdout] test src/device.rs - device::QCicada (line 13) - compile ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.21s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "a49a6b06d6c29bba3e8fd81517489c5ca033c1d5389f68ffa4a2a0429a85c9d9", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "a49a6b06d6c29bba3e8fd81517489c5ca033c1d5389f68ffa4a2a0429a85c9d9", kill_on_drop: false }`
[INFO] [stdout] a49a6b06d6c29bba3e8fd81517489c5ca033c1d5389f68ffa4a2a0429a85c9d9