[INFO] fetching crate cargo-fixture 1.2.2... [INFO] testing cargo-fixture-1.2.2 against 1.81.0 for beta-1.82-1 [INFO] extracting crate cargo-fixture 1.2.2 into /workspace/builds/worker-0-tc1/source [INFO] validating manifest of crates.io crate cargo-fixture 1.2.2 on toolchain 1.81.0 [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.81.0" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] started tweaking crates.io crate cargo-fixture 1.2.2 [INFO] removed 0 missing tests [INFO] finished tweaking crates.io crate cargo-fixture 1.2.2 [INFO] tweaked toml for crates.io crate cargo-fixture 1.2.2 written to /workspace/builds/worker-0-tc1/source/Cargo.toml [INFO] crate crates.io crate cargo-fixture 1.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" "+1.81.0" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Updating crates.io index [INFO] [stderr] Downloading crates ... [INFO] [stderr] Downloaded async-net v1.8.0 [INFO] [stderr] Downloaded cargo-fixture-lib v1.2.2 [INFO] [stderr] Downloaded smol v1.3.0 [INFO] [stderr] Downloaded cargo-fixture-macros v1.2.2 [INFO] [stderr] Downloaded tabular v0.2.0 [INFO] [stderr] Downloaded os_str_bytes v7.0.0 [INFO] [stderr] Downloaded serde v1.0.202 [INFO] [stderr] Downloaded serde_derive v1.0.202 [INFO] [stderr] Downloaded syn v2.0.65 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-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:96c0aa5895ecf336b730ef27bcdde6e21027415df19888aad3cf1448e5d65d90" "/opt/rustwide/cargo-home/bin/cargo" "+1.81.0" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] 68eea196c0b7881d815e98805855710e5b301d6aa10e664108935231c584d377 [INFO] running `Command { std: "docker" "start" "-a" "68eea196c0b7881d815e98805855710e5b301d6aa10e664108935231c584d377", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "68eea196c0b7881d815e98805855710e5b301d6aa10e664108935231c584d377", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "68eea196c0b7881d815e98805855710e5b301d6aa10e664108935231c584d377", kill_on_drop: false }` [INFO] [stdout] 68eea196c0b7881d815e98805855710e5b301d6aa10e664108935231c584d377 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-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=warn" "-e" "RUSTDOCFLAGS=--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:96c0aa5895ecf336b730ef27bcdde6e21027415df19888aad3cf1448e5d65d90" "/opt/rustwide/cargo-home/bin/cargo" "+1.81.0" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] f54aa4653d6694a0fd7b6896b83bb837ec33d08332de13bafb94acb4fb342e3e [INFO] running `Command { std: "docker" "start" "-a" "f54aa4653d6694a0fd7b6896b83bb837ec33d08332de13bafb94acb4fb342e3e", kill_on_drop: false }` [INFO] [stderr] Compiling pin-project-lite v0.2.14 [INFO] [stderr] Compiling crossbeam-utils v0.8.20 [INFO] [stderr] Compiling parking v2.2.0 [INFO] [stderr] Compiling libc v0.2.155 [INFO] [stderr] Compiling futures-core v0.3.30 [INFO] [stderr] Compiling proc-macro2 v1.0.83 [INFO] [stderr] Compiling futures-io v0.3.30 [INFO] [stderr] Compiling bitflags v2.5.0 [INFO] [stderr] Compiling io-lifetimes v1.0.11 [INFO] [stderr] Compiling memchr v2.7.2 [INFO] [stderr] Compiling event-listener v2.5.3 [INFO] [stderr] Compiling rustix v0.38.34 [INFO] [stderr] Compiling rustix v0.37.27 [INFO] [stderr] Compiling slab v0.4.9 [INFO] [stderr] Compiling polling v2.8.0 [INFO] [stderr] Compiling fastrand v1.9.0 [INFO] [stderr] Compiling fastrand v2.1.0 [INFO] [stderr] Compiling futures-lite v2.3.0 [INFO] [stderr] Compiling tracing-core v0.1.32 [INFO] [stderr] Compiling linux-raw-sys v0.4.14 [INFO] [stderr] Compiling waker-fn v1.2.0 [INFO] [stderr] Compiling async-lock v2.8.0 [INFO] [stderr] Compiling async-io v1.13.0 [INFO] [stderr] Compiling linux-raw-sys v0.3.8 [INFO] [stderr] Compiling async-task v4.7.1 [INFO] [stderr] Compiling log v0.4.21 [INFO] [stderr] Compiling atomic-waker v1.1.2 [INFO] [stderr] Compiling rustversion v1.0.17 [INFO] [stderr] Compiling tracing v0.1.40 [INFO] [stderr] Compiling async-fs v1.6.0 [INFO] [stderr] Compiling futures-lite v1.13.0 [INFO] [stderr] Compiling piper v0.2.2 [INFO] [stderr] Compiling serde v1.0.202 [INFO] [stderr] Compiling cfg_aliases v0.1.1 [INFO] [stderr] Compiling nix v0.28.0 [INFO] [stderr] Compiling hashbrown v0.14.5 [INFO] [stderr] Compiling thiserror v1.0.61 [INFO] [stderr] Compiling concurrent-queue v2.5.0 [INFO] [stderr] Compiling heck v0.4.1 [INFO] [stderr] Compiling equivalent v1.0.1 [INFO] [stderr] Compiling serde_json v1.0.117 [INFO] [stderr] Compiling anyhow v1.0.86 [INFO] [stderr] Compiling futures-task v0.3.30 [INFO] [stderr] Compiling unicode-width v0.1.12 [INFO] [stderr] Compiling quote v1.0.36 [INFO] [stderr] Compiling tabular v0.2.0 [INFO] [stderr] Compiling event-listener v4.0.3 [INFO] [stderr] Compiling event-listener v5.3.0 [INFO] [stderr] Compiling event-listener v3.1.0 [INFO] [stderr] Compiling async-executor v1.11.0 [INFO] [stderr] Compiling async-channel v1.9.0 [INFO] [stderr] Compiling os_str_bytes v7.0.0 [INFO] [stderr] Compiling syn v2.0.65 [INFO] [stderr] Compiling event-listener-strategy v0.4.0 [INFO] [stderr] Compiling event-listener-strategy v0.5.2 [INFO] [stderr] Compiling async-lock v3.3.0 [INFO] [stderr] Compiling async-channel v2.3.1 [INFO] [stderr] Compiling indexmap v2.2.6 [INFO] [stderr] Compiling blocking v1.6.0 [INFO] [stderr] Compiling socket2 v0.4.10 [INFO] [stderr] Compiling signal-hook-registry v1.4.2 [INFO] [stderr] Compiling ctrlc v3.4.4 [INFO] [stderr] Compiling async-net v1.8.0 [INFO] [stderr] Compiling serde_derive v1.0.202 [INFO] [stderr] Compiling thiserror-impl v1.0.61 [INFO] [stderr] Compiling strum_macros v0.25.3 [INFO] [stderr] Compiling cargo-fixture-macros v1.2.2 [INFO] [stderr] Compiling futures-macro v0.3.30 [INFO] [stderr] Compiling polling v3.7.0 [INFO] [stderr] Compiling async-io v2.3.2 [INFO] [stderr] Compiling async-signal v0.2.6 [INFO] [stderr] Compiling async-process v1.8.1 [INFO] [stderr] Compiling smol v1.3.0 [INFO] [stderr] Compiling futures-util v0.3.30 [INFO] [stderr] Compiling strum v0.25.0 [INFO] [stderr] Compiling cargo-fixture-lib v1.2.2 [INFO] [stderr] Compiling cargo-fixture v1.2.2 (/opt/rustwide/workdir) [INFO] [stderr] Finished `dev` profile [unoptimized + debuginfo] target(s) in 28.55s [INFO] running `Command { std: "docker" "inspect" "f54aa4653d6694a0fd7b6896b83bb837ec33d08332de13bafb94acb4fb342e3e", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "f54aa4653d6694a0fd7b6896b83bb837ec33d08332de13bafb94acb4fb342e3e", kill_on_drop: false }` [INFO] [stdout] f54aa4653d6694a0fd7b6896b83bb837ec33d08332de13bafb94acb4fb342e3e [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-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=warn" "-e" "RUSTDOCFLAGS=--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:96c0aa5895ecf336b730ef27bcdde6e21027415df19888aad3cf1448e5d65d90" "/opt/rustwide/cargo-home/bin/cargo" "+1.81.0" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 56d54764629afe83669c81b02ede5407603e2817fea85762e441b4a47993c8e8 [INFO] running `Command { std: "docker" "start" "-a" "56d54764629afe83669c81b02ede5407603e2817fea85762e441b4a47993c8e8", kill_on_drop: false }` [INFO] [stderr] Compiling nix v0.28.0 [INFO] [stderr] Compiling syn v1.0.109 [INFO] [stderr] Compiling ctrlc v3.4.4 [INFO] [stderr] Compiling cargo-fixture v1.2.2 (/opt/rustwide/workdir) [INFO] [stderr] Compiling smol-potat-macro v0.6.0 [INFO] [stderr] Compiling smol-potat v1.1.2 [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 8.22s [INFO] running `Command { std: "docker" "inspect" "56d54764629afe83669c81b02ede5407603e2817fea85762e441b4a47993c8e8", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "56d54764629afe83669c81b02ede5407603e2817fea85762e441b4a47993c8e8", kill_on_drop: false }` [INFO] [stdout] 56d54764629afe83669c81b02ede5407603e2817fea85762e441b4a47993c8e8 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-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=warn" "-e" "RUSTDOCFLAGS=--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:96c0aa5895ecf336b730ef27bcdde6e21027415df19888aad3cf1448e5d65d90" "/opt/rustwide/cargo-home/bin/cargo" "+1.81.0" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] 1a3a604d39c661f60eec5bea219fa3ba6756a4ab0845433573295a05237fa36e [INFO] running `Command { std: "docker" "start" "-a" "1a3a604d39c661f60eec5bea219fa3ba6756a4ab0845433573295a05237fa36e", kill_on_drop: false }` [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 0.11s [INFO] [stderr] Running unittests src/main.rs (/opt/rustwide/target/debug/deps/cargo_fixture-2b5c0fd2c5dbd3c8) [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/args.rs (/opt/rustwide/target/debug/deps/args-31df3c9d7a16e2d5) [INFO] [stdout] [INFO] [stdout] running 2 tests [INFO] [stderr] Blocking waiting for file lock on build directory [INFO] [stderr] Compiling cargo-fixture v1.2.2 (/opt/rustwide/workdir) [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 1.85s [INFO] [stderr] Running tests/print_args.rs (/opt/rustwide/target/debug/deps/print_args-7335a973a53fa964) [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 1.89s [INFO] [stderr] Running tests/print_args.rs (/opt/rustwide/target/debug/deps/print_args-7335a973a53fa964) [INFO] [stderr] cargo-fixture DEBUG: target dir: /opt/rustwide/target [INFO] [stderr] cargo-fixture: building fixture program... [INFO] [stderr] cargo-fixture DEBUG: running /opt/rustwide/target/debug/deps/print_args-7335a973a53fa964 test -j=1 --test fixture_args --no-run --features _fixture --message-format=json-render-diagnostics [INFO] [stderr] cargo-fixture DEBUG: target dir: /opt/rustwide/target [INFO] [stderr] cargo-fixture: building fixture program... [INFO] [stderr] cargo-fixture DEBUG: running /opt/rustwide/rustup-home/toolchains/1.81.0-x86_64-unknown-linux-gnu/bin/cargo test --test fixture_args --no-run --features _fixture --message-format=json-render-diagnostics [INFO] [stderr] Compiling cargo-fixture v1.2.2 (/opt/rustwide/workdir) [INFO] [stderr] Blocking waiting for file lock on build directory [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 9.43s [INFO] [stderr] cargo-fixture: setting up fixture... [INFO] [stderr] cargo-fixture DEBUG: running /opt/rustwide/target/debug/deps/fixture_args-05201b581d311ff7 report fixture-arg1 fixture-arg2 [INFO] [stderr] Compiling cargo-fixture v1.2.2 (/opt/rustwide/workdir) [INFO] [stderr] cargo-fixture DEBUG: storing KV data for key `fixture-args` [INFO] [stderr] cargo-fixture DEBUG: storing KV data for key `fixture-args` [INFO] [stderr] cargo-fixture: running /opt/rustwide/target/debug/deps/print_args-7335a973a53fa964 test --features _fixture -j=1 --test some_test --some-other-flag -- --nocapture [INFO] [stderr] cargo-fixture DEBUG: test command: Ok(ExitStatus(unix_wait_status(0))) [INFO] [stderr] Blocking waiting for file lock on build directory [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 11.46s [INFO] [stderr] cargo-fixture: setting up fixture... [INFO] [stderr] cargo-fixture DEBUG: running /opt/rustwide/target/debug/deps/fixture_args-05201b581d311ff7 report [INFO] [stderr] Finishedcargo-fixture DEBUG: storing KV data for key `fixture-args` [INFO] [stderr] `test` profile [unoptimized + debuginfo] target(s) in 1.99s [INFO] [stderr] cargo-fixture DEBUG: storing KV data for key `fixture-args` [INFO] [stderr] cargo-fixture: running /opt/rustwide/target/debug/deps/print_args-7335a973a53fa964 [INFO] [stderr] Running tests/print_args.rs (/opt/rustwide/target/debug/deps/print_args-7335a973a53fa964) [INFO] [stderr] cargo-fixture DEBUG: test command: Ok(ExitStatus(unix_wait_status(0))) [INFO] [stderr] cargo-fixture DEBUG: target dir: /opt/rustwide/target [INFO] [stderr] cargo-fixture: building fixture program... [INFO] [stderr] cargo-fixture DEBUG: running /opt/rustwide/target/debug/deps/print_args-7335a973a53fa964 test --test fixture_args --no-run --features _fixture --message-format=json-render-diagnostics [INFO] [stdout] test shell ... ok [INFO] [stderr] Compiling cargo-fixture v1.2.2 (/opt/rustwide/workdir) [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 2.02s [INFO] [stderr] cargo-fixture: setting up fixture... [INFO] [stderr] cargo-fixture DEBUG: running /opt/rustwide/target/debug/deps/fixture_args-05201b581d311ff7 report fixture-arg1 fixture-arg2 [INFO] [stderr] cargo-fixture DEBUG: storing KV data for key `fixture-args` [INFO] [stderr] cargo-fixture DEBUG: storing KV data for key `fixture-args` [INFO] [stderr] cargo-fixture: running /opt/rustwide/target/debug/deps/print_args-7335a973a53fa964 foo bar -- --nocapture [INFO] [stderr] cargo-fixture DEBUG: test command: Ok(ExitStatus(unix_wait_status(0))) [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 0.11s [INFO] [stderr] Running tests/print_args.rs (/opt/rustwide/target/debug/deps/print_args-7335a973a53fa964) [INFO] [stderr] cargo-fixture DEBUG: target dir: /opt/rustwide/target [INFO] [stderr] cargo-fixture: building fixture program... [INFO] [stderr] cargo-fixture DEBUG: running /opt/rustwide/target/debug/deps/print_args-7335a973a53fa964 test -j 1 --test fixture_args --no-run --features _fixture --message-format=json-render-diagnostics [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 0.12s [INFO] [stderr] cargo-fixture: setting up fixture... [INFO] [stderr] cargo-fixture DEBUG: running /opt/rustwide/target/debug/deps/fixture_args-05201b581d311ff7 set_extra_cargo_test_args extra-arg1 extra-arg2 [INFO] [stderr] cargo-fixture DEBUG: storing KV data for key `fixture-args` [INFO] [stderr] cargo-fixture DEBUG: setting extra cargo test args: ["extra-arg1", "extra-arg2"] [INFO] [stderr] cargo-fixture: running /opt/rustwide/target/debug/deps/print_args-7335a973a53fa964 test --features _fixture -j 1 --test some_test --some-other-flag extra-arg1 extra-arg2 -- --nocapture [INFO] [stderr] cargo-fixture DEBUG: test command: Ok(ExitStatus(unix_wait_status(0))) [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 0.09s [INFO] [stderr] Running tests/print_args.rs (/opt/rustwide/target/debug/deps/print_args-7335a973a53fa964) [INFO] [stderr] cargo-fixture DEBUG: target dir: /opt/rustwide/target [INFO] [stderr] cargo-fixture: building fixture program... [INFO] [stderr] cargo-fixture DEBUG: running /opt/rustwide/target/debug/deps/print_args-7335a973a53fa964 test --test fixture_args --no-run --features _fixture --message-format=json-render-diagnostics [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 0.10s [INFO] [stderr] cargo-fixture: setting up fixture... [INFO] [stderr] cargo-fixture DEBUG: running /opt/rustwide/target/debug/deps/fixture_args-05201b581d311ff7 set_extra_test_binary_args extra-arg1 extra-arg2 [INFO] [stderr] cargo-fixture DEBUG: storing KV data for key `fixture-args` [INFO] [stderr] cargo-fixture DEBUG: setting extra test binary args: ["extra-arg1", "extra-arg2"] [INFO] [stderr] cargo-fixture: running /opt/rustwide/target/debug/deps/print_args-7335a973a53fa964 test --features _fixture --test some_test --some-other-flag -- --nocapture extra-arg1 extra-arg2 [INFO] [stderr] cargo-fixture DEBUG: test command: Ok(ExitStatus(unix_wait_status(0))) [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 0.12s [INFO] [stderr] Running tests/print_args.rs (/opt/rustwide/target/debug/deps/print_args-7335a973a53fa964) [INFO] [stderr] cargo-fixture DEBUG: target dir: /opt/rustwide/target [INFO] [stderr] cargo-fixture: building fixture program... [INFO] [stderr] cargo-fixture DEBUG: running /opt/rustwide/target/debug/deps/print_args-7335a973a53fa964 test --test fixture_args --no-run --features _fixture --message-format=json-render-diagnostics [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 0.10s [INFO] [stderr] cargo-fixture: setting up fixture... [INFO] [stderr] cargo-fixture DEBUG: running /opt/rustwide/target/debug/deps/fixture_args-05201b581d311ff7 set_exec /opt/rustwide/target/debug/deps/print_args-7335a973a53fa964 exec-arg1 exec-arg2 [INFO] [stderr] cargo-fixture DEBUG: storing KV data for key `fixture-args` [INFO] [stderr] cargo-fixture DEBUG: setting test command to ["/opt/rustwide/target/debug/deps/print_args-7335a973a53fa964", "exec-arg1", "exec-arg2"] [INFO] [stderr] cargo-fixture: running /opt/rustwide/target/debug/deps/print_args-7335a973a53fa964 exec-arg1 exec-arg2 [INFO] [stderr] cargo-fixture DEBUG: test command: Ok(ExitStatus(unix_wait_status(0))) [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 0.11s [INFO] [stderr] Running tests/print_args.rs (/opt/rustwide/target/debug/deps/print_args-7335a973a53fa964) [INFO] [stderr] cargo-fixture DEBUG: target dir: /opt/rustwide/target [INFO] [stderr] cargo-fixture: building fixture program... [INFO] [stderr] cargo-fixture DEBUG: running /opt/rustwide/target/debug/deps/print_args-7335a973a53fa964 test --test fixture_args --no-run --features _fixture --message-format=json-render-diagnostics [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 0.08s [INFO] [stderr] cargo-fixture: setting up fixture... [INFO] [stderr] cargo-fixture DEBUG: running /opt/rustwide/target/debug/deps/fixture_args-05201b581d311ff7 set_exec /opt/rustwide/target/debug/deps/print_args-7335a973a53fa964 exec-arg1 exec-arg2 [INFO] [stderr] cargo-fixture DEBUG: storing KV data for key `fixture-args` [INFO] [stderr] cargo-fixture DEBUG: attempt to set test command to ["/opt/rustwide/target/debug/deps/print_args-7335a973a53fa964", "exec-arg1", "exec-arg2"] from fixture, but this is overriden by CLI flag -x [INFO] [stderr] cargo-fixture: running /opt/rustwide/target/debug/deps/print_args-7335a973a53fa964 exec-cli-arg1 exec-cli-arg2 [INFO] [stderr] cargo-fixture DEBUG: test command: Ok(ExitStatus(unix_wait_status(0))) [INFO] [stdout] test args ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 16.77s [INFO] [stdout] [INFO] [stderr] Running tests/basics.rs (/opt/rustwide/target/debug/deps/basics-72db4b993b063000) [INFO] [stdout] [INFO] [stdout] running 9 tests [INFO] [stdout] test env_var_callback ... ignored, only ran under cargo fixture [INFO] [stdout] test failing_test_callback ... ignored, only ran under cargo fixture [INFO] [stdout] test kv_callback ... ignored, only ran under cargo fixture [INFO] [stdout] test early_exit ... ok [INFO] [stdout] test env_var ... ok [INFO] [stdout] test failing_test ... ok [INFO] [stdout] test kv ... FAILED [INFO] [stdout] test hang ... ok [INFO] [stdout] test panic ... ok [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] [INFO] [stdout] ---- kv stdout ---- [INFO] [stdout] running cargo fixture: CALLBACK_CONFIRM_ID="244" "/opt/rustwide/target/debug/cargo-fixture" "-L" "debug" "--fixture" "fixture_kv" "--" "--nocapture" "--exact" "kv_callback" [INFO] [stdout] thread 'kv' panicked at tests/common/mod.rs:249:9: [INFO] [stdout] cargo fixture didn't clean up socket file [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x5d57d6a87405 - std::backtrace_rs::backtrace::libunwind::trace::h649ab3318d3445c5 [INFO] [stdout] at /rustc/eeb90cda1969383f56a2637cbd3037bdf598841c/library/std/src/../../backtrace/src/backtrace/libunwind.rs:116:5 [INFO] [stdout] 1: 0x5d57d6a87405 - std::backtrace_rs::backtrace::trace_unsynchronized::hf4bb60c3387150c3 [INFO] [stdout] at /rustc/eeb90cda1969383f56a2637cbd3037bdf598841c/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5 [INFO] [stdout] 2: 0x5d57d6a87405 - std::sys::backtrace::_print_fmt::hd9186c800e44bd00 [INFO] [stdout] at /rustc/eeb90cda1969383f56a2637cbd3037bdf598841c/library/std/src/sys/backtrace.rs:65:5 [INFO] [stdout] 3: 0x5d57d6a87405 - ::fmt::h1b9dad2a88e955ff [INFO] [stdout] at /rustc/eeb90cda1969383f56a2637cbd3037bdf598841c/library/std/src/sys/backtrace.rs:40:26 [INFO] [stdout] 4: 0x5d57d6aaf6ab - core::fmt::rt::Argument::fmt::h351a7824f737a6a0 [INFO] [stdout] at /rustc/eeb90cda1969383f56a2637cbd3037bdf598841c/library/core/src/fmt/rt.rs:173:76 [INFO] [stdout] 5: 0x5d57d6aaf6ab - core::fmt::write::h4b5a1270214bc4a7 [INFO] [stdout] at /rustc/eeb90cda1969383f56a2637cbd3037bdf598841c/library/core/src/fmt/mod.rs:1182:21 [INFO] [stdout] 6: 0x5d57d6a845cf - std::io::Write::write_fmt::h9d1e399061051a36 [INFO] [stdout] at /rustc/eeb90cda1969383f56a2637cbd3037bdf598841c/library/std/src/io/mod.rs:1827:15 [INFO] [stdout] 7: 0x5d57d6a88ca1 - std::sys::backtrace::BacktraceLock::print::h68d41b51481bce5c [INFO] [stdout] at /rustc/eeb90cda1969383f56a2637cbd3037bdf598841c/library/std/src/sys/backtrace.rs:43:9 [INFO] [stdout] 8: 0x5d57d6a88ca1 - std::panicking::default_hook::{{closure}}::h96ab15e9936be7ed [INFO] [stdout] at /rustc/eeb90cda1969383f56a2637cbd3037bdf598841c/library/std/src/panicking.rs:269:22 [INFO] [stdout] 9: 0x5d57d6a88848 - std::panicking::default_hook::h3cacb9c27561ad33 [INFO] [stdout] at /rustc/eeb90cda1969383f56a2637cbd3037bdf598841c/library/std/src/panicking.rs:293:9 [INFO] [stdout] 10: 0x5d57d6a48a9a - as core::ops::function::Fn>::call::hd212b1446b2b2077 [INFO] [stdout] at /rustc/eeb90cda1969383f56a2637cbd3037bdf598841c/library/alloc/src/boxed.rs:2084:9 [INFO] [stdout] 11: 0x5d57d6a48a9a - test::test_main::{{closure}}::hd15ff34f3f68988b [INFO] [stdout] at /rustc/eeb90cda1969383f56a2637cbd3037bdf598841c/library/test/src/lib.rs:136:21 [INFO] [stdout] 12: 0x5d57d6a8953f - as core::ops::function::Fn>::call::hce7569f4ca5d1b64 [INFO] [stdout] at /rustc/eeb90cda1969383f56a2637cbd3037bdf598841c/library/alloc/src/boxed.rs:2084:9 [INFO] [stdout] 13: 0x5d57d6a8953f - std::panicking::rust_panic_with_hook::hfe205f6954b2c97b [INFO] [stdout] at /rustc/eeb90cda1969383f56a2637cbd3037bdf598841c/library/std/src/panicking.rs:808:13 [INFO] [stdout] 14: 0x5d57d6a89133 - std::panicking::begin_panic_handler::{{closure}}::h6cb44b3a50f28c44 [INFO] [stdout] at /rustc/eeb90cda1969383f56a2637cbd3037bdf598841c/library/std/src/panicking.rs:667:13 [INFO] [stdout] 15: 0x5d57d6a878c9 - std::sys::backtrace::__rust_end_short_backtrace::hf1c1f2a92799bb0e [INFO] [stdout] at /rustc/eeb90cda1969383f56a2637cbd3037bdf598841c/library/std/src/sys/backtrace.rs:168:18 [INFO] [stdout] 16: 0x5d57d6a88df4 - rust_begin_unwind [INFO] [stdout] at /rustc/eeb90cda1969383f56a2637cbd3037bdf598841c/library/std/src/panicking.rs:665:5 [INFO] [stdout] 17: 0x5d57d694a763 - core::panicking::panic_fmt::h3d8fc78294164da7 [INFO] [stdout] at /rustc/eeb90cda1969383f56a2637cbd3037bdf598841c/library/core/src/panicking.rs:74:14 [INFO] [stdout] 18: 0x5d57d695d123 - basics::common::Child::output::h90c34f5a3805c9b8 [INFO] [stdout] at /opt/rustwide/workdir/tests/common/mod.rs:249:9 [INFO] [stdout] 19: 0x5d57d696ff7b - basics::kv::hbb2a17420768a93f [INFO] [stdout] at /opt/rustwide/workdir/tests/basics.rs:49:5 [INFO] [stdout] 20: 0x5d57d696ff17 - basics::kv::{{closure}}::h1c3577218ef8cd65 [INFO] [stdout] at /opt/rustwide/workdir/tests/basics.rs:48:8 [INFO] [stdout] 21: 0x5d57d694cc46 - core::ops::function::FnOnce::call_once::h774d9d5791f9c303 [INFO] [stdout] at /rustc/eeb90cda1969383f56a2637cbd3037bdf598841c/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 22: 0x5d57d6a4d0db - core::ops::function::FnOnce::call_once::h81f56a195fe4862e [INFO] [stdout] at /rustc/eeb90cda1969383f56a2637cbd3037bdf598841c/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 23: 0x5d57d6a4d0db - test::__rust_begin_short_backtrace::h919c79c8b896f9e2 [INFO] [stdout] at /rustc/eeb90cda1969383f56a2637cbd3037bdf598841c/library/test/src/lib.rs:624:18 [INFO] [stdout] 24: 0x5d57d6a4c985 - test::run_test_in_process::{{closure}}::h7b3d5751c5b4dd75 [INFO] [stdout] at /rustc/eeb90cda1969383f56a2637cbd3037bdf598841c/library/test/src/lib.rs:647:60 [INFO] [stdout] 25: 0x5d57d6a4c985 - as core::ops::function::FnOnce<()>>::call_once::hdabd61465e4dbd80 [INFO] [stdout] at /rustc/eeb90cda1969383f56a2637cbd3037bdf598841c/library/core/src/panic/unwind_safe.rs:272:9 [INFO] [stdout] 26: 0x5d57d6a4c985 - std::panicking::try::do_call::hc813c79fd64b0a90 [INFO] [stdout] at /rustc/eeb90cda1969383f56a2637cbd3037bdf598841c/library/std/src/panicking.rs:557:40 [INFO] [stdout] 27: 0x5d57d6a4c985 - std::panicking::try::h055c5de7e7bfc209 [INFO] [stdout] at /rustc/eeb90cda1969383f56a2637cbd3037bdf598841c/library/std/src/panicking.rs:521:19 [INFO] [stdout] 28: 0x5d57d6a4c985 - std::panic::catch_unwind::h4265d6525195c807 [INFO] [stdout] at /rustc/eeb90cda1969383f56a2637cbd3037bdf598841c/library/std/src/panic.rs:350:14 [INFO] [stdout] 29: 0x5d57d6a4c985 - test::run_test_in_process::he72c277a35f96567 [INFO] [stdout] at /rustc/eeb90cda1969383f56a2637cbd3037bdf598841c/library/test/src/lib.rs:647:27 [INFO] [stdout] 30: 0x5d57d6a4c985 - test::run_test::{{closure}}::h974e632522c0fbcf [INFO] [stdout] at /rustc/eeb90cda1969383f56a2637cbd3037bdf598841c/library/test/src/lib.rs:568:43 [INFO] [stdout] 31: 0x5d57d6a14974 - test::run_test::{{closure}}::hdc2c89ce8b601dda [INFO] [stdout] at /rustc/eeb90cda1969383f56a2637cbd3037bdf598841c/library/test/src/lib.rs:598:41 [INFO] [stdout] 32: 0x5d57d6a14974 - std::sys::backtrace::__rust_begin_short_backtrace::h342cb8e53aeb2076 [INFO] [stdout] at /rustc/eeb90cda1969383f56a2637cbd3037bdf598841c/library/std/src/sys/backtrace.rs:152:18 [INFO] [stdout] 33: 0x5d57d6a180a2 - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::h67b1b5c1709ad95b [INFO] [stdout] at /rustc/eeb90cda1969383f56a2637cbd3037bdf598841c/library/std/src/thread/mod.rs:538:17 [INFO] [stdout] 34: 0x5d57d6a180a2 - as core::ops::function::FnOnce<()>>::call_once::hd8c7a030ea8b7676 [INFO] [stdout] at /rustc/eeb90cda1969383f56a2637cbd3037bdf598841c/library/core/src/panic/unwind_safe.rs:272:9 [INFO] [stdout] 35: 0x5d57d6a180a2 - std::panicking::try::do_call::h512c2ab2c15b7d31 [INFO] [stdout] at /rustc/eeb90cda1969383f56a2637cbd3037bdf598841c/library/std/src/panicking.rs:557:40 [INFO] [stdout] 36: 0x5d57d6a180a2 - std::panicking::try::h5c2903f8937bc868 [INFO] [stdout] at /rustc/eeb90cda1969383f56a2637cbd3037bdf598841c/library/std/src/panicking.rs:521:19 [INFO] [stdout] 37: 0x5d57d6a180a2 - std::panic::catch_unwind::h242c80217c2dbece [INFO] [stdout] at /rustc/eeb90cda1969383f56a2637cbd3037bdf598841c/library/std/src/panic.rs:350:14 [INFO] [stdout] 38: 0x5d57d6a180a2 - std::thread::Builder::spawn_unchecked_::{{closure}}::h6cb4494ebdd8caf7 [INFO] [stdout] at /rustc/eeb90cda1969383f56a2637cbd3037bdf598841c/library/std/src/thread/mod.rs:537:30 [INFO] [stdout] 39: 0x5d57d6a180a2 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h42193b008049ba94 [INFO] [stdout] at /rustc/eeb90cda1969383f56a2637cbd3037bdf598841c/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 40: 0x5d57d6a8e1eb - as core::ops::function::FnOnce>::call_once::ha1963004222e7822 [INFO] [stdout] at /rustc/eeb90cda1969383f56a2637cbd3037bdf598841c/library/alloc/src/boxed.rs:2070:9 [INFO] [stdout] 41: 0x5d57d6a8e1eb - as core::ops::function::FnOnce>::call_once::h1086ced1f7c494c2 [INFO] [stdout] at /rustc/eeb90cda1969383f56a2637cbd3037bdf598841c/library/alloc/src/boxed.rs:2070:9 [INFO] [stdout] 42: 0x5d57d6a8e1eb - std::sys::pal::unix::thread::Thread::new::thread_start::ha8af9c992ef0b208 [INFO] [stdout] at /rustc/eeb90cda1969383f56a2637cbd3037bdf598841c/library/std/src/sys/pal/unix/thread.rs:108:17 [INFO] [stdout] 43: 0x71d19088dac3 - [INFO] [stdout] 44: 0x71d19091ea04 - clone [INFO] [stdout] 45: 0x0 - [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] kv [INFO] [stdout] [INFO] [stdout] test result: FAILED. 5 passed; 1 failed; 3 ignored; 0 measured; 0 filtered out; finished in 15.76s [INFO] [stdout] [INFO] [stderr] error: test failed, to rerun pass `--test basics` [INFO] running `Command { std: "docker" "inspect" "1a3a604d39c661f60eec5bea219fa3ba6756a4ab0845433573295a05237fa36e", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "1a3a604d39c661f60eec5bea219fa3ba6756a4ab0845433573295a05237fa36e", kill_on_drop: false }` [INFO] [stdout] 1a3a604d39c661f60eec5bea219fa3ba6756a4ab0845433573295a05237fa36e