[INFO] fetching crate stcbsl 0.1.1...
[INFO] testing stcbsl-0.1.1 against 1.100.0-beta.1 for beta-1.100-2
[INFO] extracting crate stcbsl 0.1.1 into /workspace/builds/worker-3-tc2/source
[INFO] started tweaking crates.io crate stcbsl 0.1.1
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate stcbsl 0.1.1
[INFO] tweaked toml for crates.io crate stcbsl 0.1.1 written to /workspace/builds/worker-3-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate stcbsl 0.1.1 on toolchain 1.100.0-beta.1
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.100.0-beta.1" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate stcbsl 0.1.1 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" "+1.100.0-beta.1" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,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" "-m" "1610612736" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:3111399a4047eeb3a02b7a90e478d715f38a8c6669b5c4b49d30a17385265909" "sleep" "infinity", kill_on_drop: false }`
[INFO] [stdout] 78212d2263d803135ff1de781f6479e0b30a7178503ae5015634ed95398f2a81
[INFO] running `Command { std: "docker" "start" "78212d2263d803135ff1de781f6479e0b30a7178503ae5015634ed95398f2a81", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "78212d2263d803135ff1de781f6479e0b30a7178503ae5015634ed95398f2a81", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-w" "/opt/rustwide/workdir" "--user" "0:0" "78212d2263d803135ff1de781f6479e0b30a7178503ae5015634ed95398f2a81" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "78212d2263d803135ff1de781f6479e0b30a7178503ae5015634ed95398f2a81", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-w" "/opt/rustwide/workdir" "--user" "0:0" "78212d2263d803135ff1de781f6479e0b30a7178503ae5015634ed95398f2a81" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling unicode-ident v1.0.24
[INFO] [stderr]    Compiling libc v0.2.189
[INFO] [stderr]    Compiling thiserror v2.0.20
[INFO] [stderr]    Compiling cfg-if v1.0.4
[INFO] [stderr]    Compiling bitflags v1.3.2
[INFO] [stderr]    Compiling bitflags v2.13.1
[INFO] [stderr]    Compiling scopeguard v1.2.0
[INFO] [stderr]    Compiling libudev-sys v0.1.4
[INFO] [stderr]    Compiling proc-macro2 v1.0.107
[INFO] [stderr]    Compiling quote v1.0.47
[INFO] [stderr]    Compiling syn v3.0.3
[INFO] [stderr]    Compiling nix v0.26.4
[INFO] [stderr]    Compiling libudev v0.3.0
[INFO] [stderr]    Compiling thiserror-impl v2.0.20
[INFO] [stderr]    Compiling unescaper v0.1.10
[INFO] [stderr]    Compiling serialport v4.9.0
[INFO] [stderr]    Compiling stcbsl v0.1.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 9.39s
[INFO] running `Command { std: "docker" "inspect" "78212d2263d803135ff1de781f6479e0b30a7178503ae5015634ed95398f2a81", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-w" "/opt/rustwide/workdir" "--user" "0:0" "78212d2263d803135ff1de781f6479e0b30a7178503ae5015634ed95398f2a81" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling stcbsl v0.1.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 1.76s
[INFO] running `Command { std: "docker" "inspect" "78212d2263d803135ff1de781f6479e0b30a7178503ae5015634ed95398f2a81", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-w" "/opt/rustwide/workdir" "--user" "0:0" "78212d2263d803135ff1de781f6479e0b30a7178503ae5015634ed95398f2a81" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "test" "--frozen", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.05s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/build/stcbsl/b0c1509194f62ffd/out/stcbsl-b0c1509194f62ffd)
[INFO] [stdout] 
[INFO] [stdout] running 15 tests
[INFO] [stdout] test frame::tests::worked_example_from_spec ... ok
[INFO] [stdout] test protocol::stc89::tests::all_ff_block_acks_0x80 ... ok
[INFO] [stdout] test protocol::stc89::tests::erase_block_counts ... ok
[INFO] [stdout] test protocol::stc89::tests::reload_table ... ok
[INFO] [stdout] test frame::tests::receiver_rehunts_after_a_bad_checksum ... ok
[INFO] [stdout] test protocol::stc89::tests::frequency_table ... ok
[INFO] [stdout] test frame::tests::roundtrip ... ok
[INFO] [stdout] test ihex::tests::gaps_fill_with_zero ... ok
[INFO] [stdout] test frame::tests::echo_checksum_differs_by_two ... ok
[INFO] [stdout] test protocol::stc89::tests::negotiation_frames_match_the_capture ... ok
[INFO] [stdout] test frame::tests::receiver_discards_noise_and_finds_the_frame ... ok
[INFO] [stdout] test frame::tests::payload_may_contain_magic_and_terminator ... ok
[INFO] [stdout] test ihex::tests::rejects_a_bad_checksum ... ok
[INFO] [stdout] test ihex::tests::rejects_high_addresses ... ok
[INFO] [stdout] test ihex::tests::simple_image ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 15 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/bin/rxprobe.rs (/opt/rustwide/target/debug/build/stcbsl/03d48c473668a5ca/out/rxprobe-03d48c473668a5ca)
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stderr]      Running unittests src/bin/stcbsl.rs (/opt/rustwide/target/debug/build/stcbsl/6f4879369095701a/out/stcbsl-6f4879369095701a)
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/replay.rs (/opt/rustwide/target/debug/build/stcbsl/9f29caeac9222f0c/out/replay-9f29caeac9222f0c)
[INFO] [stdout] 
[INFO] [stdout] running 17 tests
[INFO] [stdout] test the_autoreset_capture_contains_nothing ... ok
[INFO] [stdout] test opaque_region_varies_and_is_ignored ... ok
[INFO] [stdout] test a_stray_byte_between_frames_does_not_lose_the_ack ... ok
[INFO] [stdout] test replay_the_aborted_session_and_report_indeterminate_flash ... ok
[INFO] [stdout] test replay_erase_sessions ... ok
[INFO] [stdout] test replay_info_sessions ... ok
[INFO] [stdout] test the_two_hello_runs_measured_different_frequencies ... ok
[INFO] [stdout] test replay_flash_sessions ... ok
[INFO] [stdout] test timeout_capture_is_all_noise_and_yields_nothing ... ok
[INFO] [stdout] test resyncs_on_the_preamble_after_the_timeout_capture_noise ... ok
[INFO] [stdout] test status_packets_decode ... ok
[INFO] [stdout] test every_captured_block_ack_is_the_data_sum ... ok
[INFO] [stdout] test hex_images_match_the_captured_write_payloads ... ok
[INFO] [stdout] test the_recorded_noise_happens_to_contain_no_magic ... ok
[INFO] [stdout] test every_captured_frame_satisfies_the_grammar ... ok
[INFO] [stdout] test the_run_frame_expects_no_reply ... ok
[INFO] [stdout] test options_are_only_ever_an_echo_of_what_was_read ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 17 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.05s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests stcbsl
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "78212d2263d803135ff1de781f6479e0b30a7178503ae5015634ed95398f2a81", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "78212d2263d803135ff1de781f6479e0b30a7178503ae5015634ed95398f2a81", kill_on_drop: false }`
[INFO] [stdout] 78212d2263d803135ff1de781f6479e0b30a7178503ae5015634ed95398f2a81
