[INFO] fetching crate todc-utils 0.1.1... [INFO] testing todc-utils-0.1.1 against try#b83b707f97d809763b7861afa7638871f3339a33 for pr-145838-1 [INFO] extracting crate todc-utils 0.1.1 into /workspace/builds/worker-4-tc2/source [INFO] started tweaking crates.io crate todc-utils 0.1.1 [INFO] finished tweaking crates.io crate todc-utils 0.1.1 [INFO] tweaked toml for crates.io crate todc-utils 0.1.1 written to /workspace/builds/worker-4-tc2/source/Cargo.toml [INFO] validating manifest of crates.io crate todc-utils 0.1.1 on toolchain b83b707f97d809763b7861afa7638871f3339a33 [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+b83b707f97d809763b7861afa7638871f3339a33" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+b83b707f97d809763b7861afa7638871f3339a33" "generate-lockfile" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Updating crates.io index [INFO] [stderr] Locking 77 packages to latest compatible versions [INFO] [stderr] Adding criterion v0.4.0 (available: v0.7.0) [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+b83b707f97d809763b7861afa7638871f3339a33" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+b83b707f97d809763b7861afa7638871f3339a33" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] 667ea78680f019ecc64be8d29dd96ef63afec3d56aedb51ac7e6b97bc9f30e16 [INFO] running `Command { std: "docker" "start" "-a" "667ea78680f019ecc64be8d29dd96ef63afec3d56aedb51ac7e6b97bc9f30e16", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "667ea78680f019ecc64be8d29dd96ef63afec3d56aedb51ac7e6b97bc9f30e16", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "667ea78680f019ecc64be8d29dd96ef63afec3d56aedb51ac7e6b97bc9f30e16", kill_on_drop: false }` [INFO] [stdout] 667ea78680f019ecc64be8d29dd96ef63afec3d56aedb51ac7e6b97bc9f30e16 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+b83b707f97d809763b7861afa7638871f3339a33" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] de1a5968dd15a52597c12ae2300e167b8180e9d2bcd84c6271d22eb6cd347504 [INFO] running `Command { std: "docker" "start" "-a" "de1a5968dd15a52597c12ae2300e167b8180e9d2bcd84c6271d22eb6cd347504", kill_on_drop: false }` [INFO] [stderr] Compiling todc-utils v0.1.1 (/opt/rustwide/workdir) [INFO] [stderr] Finished `dev` profile [unoptimized + debuginfo] target(s) in 0.35s [INFO] running `Command { std: "docker" "inspect" "de1a5968dd15a52597c12ae2300e167b8180e9d2bcd84c6271d22eb6cd347504", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "de1a5968dd15a52597c12ae2300e167b8180e9d2bcd84c6271d22eb6cd347504", kill_on_drop: false }` [INFO] [stdout] de1a5968dd15a52597c12ae2300e167b8180e9d2bcd84c6271d22eb6cd347504 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+b83b707f97d809763b7861afa7638871f3339a33" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 4eede467c59c8ae363805c6eda1f2941514d13e14504bc9e5c140e4f975b577e [INFO] running `Command { std: "docker" "start" "-a" "4eede467c59c8ae363805c6eda1f2941514d13e14504bc9e5c140e4f975b577e", kill_on_drop: false }` [INFO] [stderr] Compiling regex-syntax v0.8.6 [INFO] [stderr] Compiling ciborium-io v0.2.2 [INFO] [stderr] Compiling os_str_bytes v6.6.1 [INFO] [stderr] Compiling indexmap v1.9.3 [INFO] [stderr] Compiling textwrap v0.16.2 [INFO] [stderr] Compiling cast v0.3.0 [INFO] [stderr] Compiling anes v0.1.6 [INFO] [stderr] Compiling oorandom v11.1.5 [INFO] [stderr] Compiling syn v2.0.106 [INFO] [stderr] Compiling atty v0.2.14 [INFO] [stderr] Compiling plotters v0.3.7 [INFO] [stderr] Compiling ciborium-ll v0.2.2 [INFO] [stderr] Compiling criterion-plot v0.5.0 [INFO] [stderr] Compiling clap_lex v0.2.4 [INFO] [stderr] Compiling clap v3.2.25 [INFO] [stderr] Compiling regex-automata v0.4.10 [INFO] [stderr] Compiling serde_derive v1.0.219 [INFO] [stderr] Compiling regex v1.11.2 [INFO] [stderr] Compiling serde v1.0.219 [INFO] [stderr] Compiling serde_json v1.0.143 [INFO] [stderr] Compiling ciborium v0.2.2 [INFO] [stderr] Compiling tinytemplate v1.2.1 [INFO] [stderr] Compiling criterion v0.4.0 [INFO] [stderr] Compiling todc-utils v0.1.1 (/opt/rustwide/workdir) [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 19.86s [INFO] running `Command { std: "docker" "inspect" "4eede467c59c8ae363805c6eda1f2941514d13e14504bc9e5c140e4f975b577e", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "4eede467c59c8ae363805c6eda1f2941514d13e14504bc9e5c140e4f975b577e", kill_on_drop: false }` [INFO] [stdout] 4eede467c59c8ae363805c6eda1f2941514d13e14504bc9e5c140e4f975b577e [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+b83b707f97d809763b7861afa7638871f3339a33" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] 00ff527920fed2932c3c6ecb61986a46a425264d361c92fd473bc58ce499d43b [INFO] running `Command { std: "docker" "start" "-a" "00ff527920fed2932c3c6ecb61986a46a425264d361c92fd473bc58ce499d43b", kill_on_drop: false }` [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 0.11s [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/todc_utils-067e85e842bb0d83) [INFO] [stdout] [INFO] [stdout] running 28 tests [INFO] [stdout] test linearizability::history::tests::from_actions::creates_sequential_ids ... ok [INFO] [stdout] test linearizability::history::tests::from_actions::links_actions_of_multiple_processes ... ok [INFO] [stdout] test linearizability::history::tests::insert::is_inverse_of_remove ... ok [INFO] [stdout] test linearizability::history::tests::lift::removes_call_and_response_entries ... ok [INFO] [stdout] test linearizability::history::tests::from_actions::links_actions_of_single_process ... ok [INFO] [stdout] test linearizability::history::tests::unlift::is_inverse_of_lift ... ok [INFO] [stdout] test linearizability::history::tests::remove::removes_only_requested_entry ... ok [INFO] [stdout] test linearizability::test::is_linearizable::accepts_sequential_read_and_write ... ok [INFO] [stdout] test linearizability::test::is_linearizable::accepts_writes_in_reverse_order ... ok [INFO] [stdout] test linearizability::test::is_linearizable::rejects_invalid_reads ... ok [INFO] [stdout] test specifications::etcd::test::apply::cas_of_bad_value_is_invalid ... ok [INFO] [stdout] test linearizability::test::is_linearizable::rejects_sequentially_consistent_reads ... ok [INFO] [stdout] test specifications::etcd::test::apply::read_does_not_mutate_state ... ok [INFO] [stdout] test specifications::etcd::test::apply::read_of_bad_value_is_invalid ... ok [INFO] [stdout] test specifications::etcd::test::apply::read_of_state_is_valid ... ok [INFO] [stdout] test specifications::etcd::test::apply::write_sets_new_state_to_written_value ... ok [INFO] [stdout] test specifications::etcd::test::init::initializes_state_to_none ... ok [INFO] [stdout] test specifications::register::test::apply::read_does_not_affect_state ... ok [INFO] [stdout] test specifications::register::test::apply::read_is_valid_if_value_is_current_state ... ok [INFO] [stdout] test specifications::register::test::apply::read_is_not_valid_if_value_is_not_current_state ... ok [INFO] [stdout] test specifications::register::test::apply::write_sets_new_state_to_written_value ... ok [INFO] [stdout] test specifications::register::test::apply::write_is_always_valid ... ok [INFO] [stdout] test specifications::snapshot::tests::apply::scan_doesnt_affect_state ... ok [INFO] [stdout] test specifications::register::test::init::initializes_state_to_default ... ok [INFO] [stdout] test specifications::snapshot::tests::apply::update_always_valid ... ok [INFO] [stdout] test specifications::snapshot::tests::init::returns_array_of_defaults ... ok [INFO] [stdout] test specifications::snapshot::tests::apply::update_applied_to_proper_component ... ok [INFO] [stdout] test specifications::snapshot::tests::apply::scan_not_valid_if_differs_from_state ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 28 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s [INFO] [stdout] [INFO] [stderr] Running tests/linearizability/main.rs (/opt/rustwide/target/debug/deps/linearizability-caa9a27a48cb689f) [INFO] [stdout] [INFO] [stdout] running 102 tests [INFO] [stdout] test etcd::test_004 ... ok [INFO] [stdout] test etcd::test_013 ... ok [INFO] [stdout] test etcd::test_012 ... ok [INFO] [stdout] test etcd::test_009 ... ok [INFO] [stdout] test etcd::test_010 ... ok [INFO] [stdout] test etcd::test_014 ... ok [INFO] [stdout] test etcd::test_016 ... ok [INFO] [stdout] test etcd::test_005 ... ok [INFO] [stdout] test etcd::test_015 ... ok [INFO] [stdout] test etcd::test_022 ... ok [INFO] [stdout] test etcd::test_003 ... ok [INFO] [stdout] test etcd::test_000 ... ok [INFO] [stdout] test etcd::test_021 ... ok [INFO] [stdout] test etcd::test_008 ... ok [INFO] [stdout] test etcd::test_006 ... ok [INFO] [stdout] test etcd::test_011 ... ok [INFO] [stdout] test etcd::test_023 ... ok [INFO] [stdout] test etcd::test_025 ... ok [INFO] [stdout] test etcd::test_028 ... ok [INFO] [stdout] test etcd::test_017 ... ok [INFO] [stdout] test etcd::test_027 ... ok [INFO] [stdout] test etcd::test_031 ... ok [INFO] [stdout] test etcd::test_001 ... ok [INFO] [stdout] test etcd::test_019 ... ok [INFO] [stdout] test etcd::test_036 ... ok [INFO] [stdout] test etcd::test_020 ... ok [INFO] [stdout] test etcd::test_024 ... ok [INFO] [stdout] test etcd::test_041 ... ok [INFO] [stdout] test etcd::test_030 ... ok [INFO] [stdout] test etcd::test_034 ... ok [INFO] [stdout] test etcd::test_026 ... ok [INFO] [stdout] test etcd::test_032 ... ok [INFO] [stdout] test etcd::test_043 ... ok [INFO] [stdout] test etcd::test_033 ... ok [INFO] [stdout] test etcd::test_037 ... ok [INFO] [stdout] test etcd::test_045 ... ok [INFO] [stdout] test etcd::test_029 ... ok [INFO] [stdout] test etcd::test_050 ... ok [INFO] [stdout] test etcd::test_038 ... ok [INFO] [stdout] test etcd::test_039 ... ok [INFO] [stdout] test etcd::test_046 ... ok [INFO] [stdout] test etcd::test_051 ... ok [INFO] [stdout] test etcd::test_042 ... ok [INFO] [stdout] test etcd::test_048 ... ok [INFO] [stdout] test etcd::test_035 ... ok [INFO] [stdout] test etcd::test_055 ... ok [INFO] [stdout] test etcd::test_052 ... ok [INFO] [stdout] test etcd::test_049 ... ok [INFO] [stdout] test etcd::test_044 ... ok [INFO] [stdout] test etcd::test_062 ... ok [INFO] [stdout] test etcd::test_065 ... ok [INFO] [stdout] test etcd::test_059 ... ok [INFO] [stdout] test etcd::test_058 ... ok [INFO] [stdout] test etcd::test_066 ... ok [INFO] [stdout] test etcd::test_064 ... ok [INFO] [stdout] test etcd::test_047 ... ok [INFO] [stdout] test etcd::test_067 ... ok [INFO] [stdout] test etcd::test_069 ... ok [INFO] [stdout] test etcd::test_068 ... ok [INFO] [stdout] test etcd::test_054 ... ok [INFO] [stdout] test etcd::test_056 ... ok [INFO] [stdout] test etcd::test_018 ... ok [INFO] [stdout] test etcd::test_070 ... ok [INFO] [stdout] test etcd::test_078 ... ok [INFO] [stdout] test etcd::test_063 ... ok [INFO] [stdout] test etcd::test_074 ... ok [INFO] [stdout] test etcd::test_076 ... ok [INFO] [stdout] test etcd::test_077 ... ok [INFO] [stdout] test etcd::test_072 ... ok [INFO] [stdout] test etcd::test_081 ... ok [INFO] [stdout] test etcd::test_083 ... ok [INFO] [stdout] test etcd::test_079 ... ok [INFO] [stdout] test etcd::test_060 ... ok [INFO] [stdout] test etcd::test_071 ... ok [INFO] [stdout] test etcd::test_086 ... ok [INFO] [stdout] test etcd::test_084 ... ok [INFO] [stdout] test etcd::test_082 ... ok [INFO] [stdout] test etcd::test_088 ... ok [INFO] [stdout] test etcd::test_090 ... ok [INFO] [stdout] test etcd::test_092 ... ok [INFO] [stdout] test etcd::test_091 ... ok [INFO] [stdout] test etcd::test_087 ... ok [INFO] [stdout] test etcd::test_094 ... ok [INFO] [stdout] test etcd::test_093 ... ok [INFO] [stdout] test etcd::test_061 ... ok [INFO] [stdout] test etcd::test_100 ... ok [INFO] [stdout] test etcd::test_096 ... ok [INFO] [stdout] test etcd::test_101 ... ok [INFO] [stdout] test etcd::test_089 ... ok [INFO] [stdout] test etcd::test_073 ... ok [INFO] [stdout] test etcd::test_102 ... ok [INFO] [stdout] test etcd::test_098 ... ok [INFO] [stdout] test etcd::test_053 ... ok [INFO] [stdout] test etcd::test_097 ... ok [INFO] [stdout] test etcd::test_085 ... ok [INFO] [stdout] test etcd::test_080 ... ok [INFO] [stdout] test etcd::test_040 ... ok [INFO] [stdout] test etcd::test_075 ... ok [INFO] [stdout] test etcd::test_099 ... ok [INFO] [stdout] test etcd::test_057 ... ok [INFO] [stdout] test etcd::test_007 ... ok [INFO] [stdout] test etcd::test_002 ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 102 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 13.81s [INFO] [stdout] [INFO] [stderr] Doc-tests todc_utils [INFO] [stdout] [INFO] [stdout] running 8 tests [INFO] [stdout] test src/linearizability/history.rs - linearizability::history::History (line 98) ... ok [INFO] [stdout] test src/linearizability.rs - linearizability::WGLChecker (line 33) ... ok [INFO] [stdout] test src/specifications.rs - specifications::Specification (line 18) ... ok [INFO] [stdout] test src/specifications.rs - specifications::Specification (line 51) ... ok [INFO] [stdout] test src/specifications.rs - specifications::Specification (line 86) ... ok [INFO] [stdout] test src/linearizability/history.rs - linearizability::history::History (line 75) ... ok [INFO] [stdout] test src/linearizability/history.rs - linearizability::history::History::from_actions (line 144) ... ok [INFO] [stdout] test src/linearizability.rs - linearizability::WGLChecker (line 82) ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 8 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.46s [INFO] [stdout] [INFO] running `Command { std: "docker" "inspect" "00ff527920fed2932c3c6ecb61986a46a425264d361c92fd473bc58ce499d43b", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "00ff527920fed2932c3c6ecb61986a46a425264d361c92fd473bc58ce499d43b", kill_on_drop: false }` [INFO] [stdout] 00ff527920fed2932c3c6ecb61986a46a425264d361c92fd473bc58ce499d43b