[INFO] cloning repository https://github.com/thomas9911/baret [INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/thomas9911/baret" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fthomas9911%2Fbaret", kill_on_drop: false }` [INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fthomas9911%2Fbaret'... [INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }` [INFO] [stdout] 19e2912cf53f6b2072c5873c1f780d28cbf58372 [INFO] testing thomas9911/baret against master#9e297bf54d31eb3b30067208ff9af4416945a2ed for pr-125507 [INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fthomas9911%2Fbaret" "/workspace/builds/worker-4-tc1/source", kill_on_drop: false }` [INFO] [stderr] Cloning into '/workspace/builds/worker-4-tc1/source'... [INFO] [stderr] done. [INFO] validating manifest of git repo https://github.com/thomas9911/baret on toolchain 9e297bf54d31eb3b30067208ff9af4416945a2ed [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+9e297bf54d31eb3b30067208ff9af4416945a2ed" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] started tweaking git repo https://github.com/thomas9911/baret [INFO] finished tweaking git repo https://github.com/thomas9911/baret [INFO] tweaked toml for git repo https://github.com/thomas9911/baret written to /workspace/builds/worker-4-tc1/source/Cargo.toml [INFO] crate git repo https://github.com/thomas9911/baret 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" "+9e297bf54d31eb3b30067208ff9af4416945a2ed" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [ERROR] error running command: no output for 300 seconds [ERROR] this task or one of its parent failed! [ERROR] no output for 300 seconds [ERROR] note: run with `RUST_BACKTRACE=1` to display a backtrace. [INFO] testing thomas9911/baret against try#61a9ac64344e91d62f5496627ff363d177f9daab for pr-125507 [INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fthomas9911%2Fbaret" "/workspace/builds/worker-4-tc2/source", kill_on_drop: false }` [INFO] [stderr] Cloning into '/workspace/builds/worker-4-tc2/source'... [INFO] [stderr] done. [INFO] validating manifest of git repo https://github.com/thomas9911/baret on toolchain 61a9ac64344e91d62f5496627ff363d177f9daab [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+61a9ac64344e91d62f5496627ff363d177f9daab" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] started tweaking git repo https://github.com/thomas9911/baret [INFO] finished tweaking git repo https://github.com/thomas9911/baret [INFO] tweaked toml for git repo https://github.com/thomas9911/baret written to /workspace/builds/worker-4-tc2/source/Cargo.toml [INFO] crate git repo https://github.com/thomas9911/baret 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" "+61a9ac64344e91d62f5496627ff363d177f9daab" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Downloading crates ... [INFO] [stderr] Downloaded predicates v2.0.2 [INFO] [stderr] Downloaded assert_cmd v2.0.0 [INFO] [stderr] Downloaded evalexpr v6.5.0 [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:59a85a07ab18ca8720692f8e61effa1c651d9e2ca591e072c2b212bb91a6b8b5" "/opt/rustwide/cargo-home/bin/cargo" "+61a9ac64344e91d62f5496627ff363d177f9daab" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] fed7a3bb3d8cfbed4c651f24ecf3343289bfd3d12ee93c9cfded9d5f8d744329 [INFO] running `Command { std: "docker" "start" "-a" "fed7a3bb3d8cfbed4c651f24ecf3343289bfd3d12ee93c9cfded9d5f8d744329", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "fed7a3bb3d8cfbed4c651f24ecf3343289bfd3d12ee93c9cfded9d5f8d744329", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "fed7a3bb3d8cfbed4c651f24ecf3343289bfd3d12ee93c9cfded9d5f8d744329", kill_on_drop: false }` [INFO] [stdout] fed7a3bb3d8cfbed4c651f24ecf3343289bfd3d12ee93c9cfded9d5f8d744329 [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:59a85a07ab18ca8720692f8e61effa1c651d9e2ca591e072c2b212bb91a6b8b5" "/opt/rustwide/cargo-home/bin/cargo" "+61a9ac64344e91d62f5496627ff363d177f9daab" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] d342d9bff3fa5dc64af30e2a6b050d6fcaadca09a316fa1ae97febbcfff537b5 [INFO] running `Command { std: "docker" "start" "-a" "d342d9bff3fa5dc64af30e2a6b050d6fcaadca09a316fa1ae97febbcfff537b5", kill_on_drop: false }` [INFO] [stderr] Compiling proc-macro2 v1.0.28 [INFO] [stderr] Compiling unicode-xid v0.2.2 [INFO] [stderr] Compiling syn v1.0.74 [INFO] [stderr] Compiling autocfg v1.0.1 [INFO] [stderr] Compiling libc v0.2.99 [INFO] [stderr] Compiling memchr v2.4.0 [INFO] [stderr] Compiling version_check v0.9.3 [INFO] [stderr] Compiling futures-core v0.3.16 [INFO] [stderr] Compiling cfg-if v1.0.0 [INFO] [stderr] Compiling proc-macro-hack v0.5.19 [INFO] [stderr] Compiling fnv v1.0.7 [INFO] [stderr] Compiling futures-task v0.3.16 [INFO] [stderr] Compiling futures-channel v0.3.16 [INFO] [stderr] Compiling proc-macro-error-attr v1.0.4 [INFO] [stderr] Compiling pin-project-lite v0.2.7 [INFO] [stderr] Compiling futures-macro v0.3.16 [INFO] [stderr] Compiling proc-macro-nested v0.1.7 [INFO] [stderr] Compiling unicode-width v0.1.8 [INFO] [stderr] Compiling strsim v0.10.0 [INFO] [stderr] Compiling log v0.4.14 [INFO] [stderr] Compiling ident_case v1.0.1 [INFO] [stderr] Compiling serde_derive v1.0.127 [INFO] [stderr] Compiling futures-util v0.3.16 [INFO] [stderr] Compiling proc-macro-error v1.0.4 [INFO] [stderr] Compiling instant v0.1.10 [INFO] [stderr] Compiling scopeguard v1.1.0 [INFO] [stderr] Compiling smallvec v1.6.1 [INFO] [stderr] Compiling unicode-segmentation v1.8.0 [INFO] [stderr] Compiling serde v1.0.127 [INFO] [stderr] Compiling futures-sink v0.3.16 [INFO] [stderr] Compiling quote v1.0.9 [INFO] [stderr] Compiling parking_lot_core v0.8.3 [INFO] [stderr] Compiling lock_api v0.4.4 [INFO] [stderr] Compiling tokio v1.10.0 [INFO] [stderr] Compiling slab v0.4.4 [INFO] [stderr] Compiling rustversion v1.0.5 [INFO] [stderr] Compiling pin-utils v0.1.0 [INFO] [stderr] Compiling lazy_static v1.4.0 [INFO] [stderr] Compiling futures-io v0.3.16 [INFO] [stderr] Compiling mio v0.7.13 [INFO] [stderr] Compiling parking_lot v0.11.1 [INFO] [stderr] Compiling heck v0.3.3 [INFO] [stderr] Compiling signal-hook-registry v1.4.0 [INFO] [stderr] Compiling terminal_size v0.1.17 [INFO] [stderr] Compiling num_cpus v1.13.0 [INFO] [stderr] Compiling aho-corasick v0.7.18 [INFO] [stderr] Compiling textwrap v0.11.0 [INFO] [stderr] Compiling linked-hash-map v0.5.4 [INFO] [stderr] Compiling regex-syntax v0.6.25 [INFO] [stderr] Compiling once_cell v1.8.0 [INFO] [stderr] Compiling bytes v1.0.1 [INFO] [stderr] Compiling bitflags v1.3.2 [INFO] [stderr] Compiling yaml-rust v0.4.5 [INFO] [stderr] Compiling clap v2.33.3 [INFO] [stderr] Compiling console v0.14.1 [INFO] [stderr] Compiling dtoa v0.4.8 [INFO] [stderr] Compiling number_prefix v0.4.0 [INFO] [stderr] Compiling convert_case v0.4.0 [INFO] [stderr] Compiling glob v0.3.0 [INFO] [stderr] Compiling shlex v1.0.0 [INFO] [stderr] Compiling evalexpr v6.5.0 [INFO] [stderr] Compiling regex v1.5.4 [INFO] [stderr] Compiling darling_core v0.13.0 [INFO] [stderr] Compiling indicatif v0.16.2 [INFO] [stderr] Compiling tokio-macros v1.3.0 [INFO] [stderr] Compiling structopt-derive v0.4.15 [INFO] [stderr] Compiling derive_more v0.99.16 [INFO] [stderr] Compiling darling_macro v0.13.0 [INFO] [stderr] Compiling darling v0.13.0 [INFO] [stderr] Compiling serde_with_macros v1.5.1 [INFO] [stderr] Compiling structopt v0.3.22 [INFO] [stderr] Compiling futures-executor v0.3.16 [INFO] [stderr] Compiling futures v0.3.16 [INFO] [stderr] Compiling tokio-stream v0.1.7 [INFO] [stderr] Compiling serde_yaml v0.8.17 [INFO] [stderr] Compiling serde_with v1.11.0 [INFO] [stderr] Compiling baret v0.1.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished `dev` profile [unoptimized + debuginfo] target(s) in 15.12s [INFO] running `Command { std: "docker" "inspect" "d342d9bff3fa5dc64af30e2a6b050d6fcaadca09a316fa1ae97febbcfff537b5", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "d342d9bff3fa5dc64af30e2a6b050d6fcaadca09a316fa1ae97febbcfff537b5", kill_on_drop: false }` [INFO] [stdout] d342d9bff3fa5dc64af30e2a6b050d6fcaadca09a316fa1ae97febbcfff537b5 [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:59a85a07ab18ca8720692f8e61effa1c651d9e2ca591e072c2b212bb91a6b8b5" "/opt/rustwide/cargo-home/bin/cargo" "+61a9ac64344e91d62f5496627ff363d177f9daab" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 22bd618c9ddb32f9b7db878c58a88fb26e80013321e2e1016b88bc5b5d1df734 [INFO] running `Command { std: "docker" "start" "-a" "22bd618c9ddb32f9b7db878c58a88fb26e80013321e2e1016b88bc5b5d1df734", kill_on_drop: false }` [INFO] [stderr] Compiling num-traits v0.2.14 [INFO] [stderr] Compiling predicates-core v1.0.2 [INFO] [stderr] Compiling doc-comment v0.3.3 [INFO] [stderr] Compiling either v1.6.1 [INFO] [stderr] Compiling treeline v0.1.0 [INFO] [stderr] Compiling difflib v0.4.0 [INFO] [stderr] Compiling regex-automata v0.1.10 [INFO] [stderr] Compiling normalize-line-endings v0.3.0 [INFO] [stderr] Compiling wait-timeout v0.2.0 [INFO] [stderr] Compiling itertools v0.10.1 [INFO] [stderr] Compiling predicates-tree v1.0.3 [INFO] [stderr] Compiling bstr v0.2.16 [INFO] [stderr] Compiling float-cmp v0.9.0 [INFO] [stderr] Compiling predicates v2.0.2 [INFO] [stderr] Compiling assert_cmd v2.0.0 [INFO] [stderr] Compiling baret v0.1.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 1.71s [INFO] running `Command { std: "docker" "inspect" "22bd618c9ddb32f9b7db878c58a88fb26e80013321e2e1016b88bc5b5d1df734", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "22bd618c9ddb32f9b7db878c58a88fb26e80013321e2e1016b88bc5b5d1df734", kill_on_drop: false }` [INFO] [stdout] 22bd618c9ddb32f9b7db878c58a88fb26e80013321e2e1016b88bc5b5d1df734 [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:59a85a07ab18ca8720692f8e61effa1c651d9e2ca591e072c2b212bb91a6b8b5" "/opt/rustwide/cargo-home/bin/cargo" "+61a9ac64344e91d62f5496627ff363d177f9daab" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] c65fc912af4d07d6e64d3cb97678454c09643a6b9ef5739a4872a1dbaf788ee2 [INFO] running `Command { std: "docker" "start" "-a" "c65fc912af4d07d6e64d3cb97678454c09643a6b9ef5739a4872a1dbaf788ee2", 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/deps/baret_lib-ed5889188f559533) [INFO] [stdout] [INFO] [stdout] running 3 tests [INFO] [stdout] test expression::variable_substitution_works_not_found_variable_returns_false ... ok [INFO] [stdout] test expression::variable_substitution_works_variable_found_equal ... ok [INFO] [stdout] test expression::variable_substitution_works_variable_found_not_equal ... 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] [stderr] Running unittests src/main.rs (/opt/rustwide/target/debug/deps/baret-385804cbafcecd11) [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/cli.rs (/opt/rustwide/target/debug/deps/cli-c7da71537df4f7df) [INFO] [stdout] [INFO] [stdout] running 23 tests [INFO] [stdout] test meta_failure ... ignored [INFO] [stdout] test config_does_not_exist ... ok [INFO] [stdout] test prints_example ... ok [INFO] [stdout] test run_groups ... ok [INFO] [stdout] test run_groups_many ... ok [INFO] [stdout] test run_example ... ok [INFO] [stdout] test run_python_command ... ok [INFO] [stdout] test run_env_check ... ok [INFO] [stdout] test run_should_fail ... ok [INFO] [stdout] test run_simple ... ok [INFO] [stdout] test verify_error ... ok [INFO] [stdout] test verify_env_check ... ok [INFO] [stdout] test verify_example ... ok [INFO] [stdout] test verify_groups ... ok [INFO] [stdout] test verify_python_command ... ok [INFO] [stdout] test verify_groups_many ... ok [INFO] [stdout] test verify_meta ... ok [INFO] [stdout] test verify_should_fail ... ok [INFO] [stdout] test verify_more ... ok [INFO] [stdout] test verify_simple ... ok [INFO] [stdout] test run_error ... FAILED [INFO] [stdout] test run_more ... ok [INFO] [stdout] test run_meta ... ok [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] [INFO] [stdout] ---- run_error stdout ---- [INFO] [stdout] thread 'run_error' panicked at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/assert_cmd-2.0.0/src/assert.rs:124:9: [INFO] [stdout] Unexpected stderr, failed var.contains("Failed test: 'breaks'\nexit code: 1\nstdout:\nim now going to break :'(\n\nstderr:\n") [INFO] [stdout] └── var as str: Failed test: 'another' [INFO] [stdout] exit status: 1 [INFO] [stdout] stdout: [INFO] [stdout] im now going to again :D [INFO] [stdout] [INFO] [stdout] stderr: [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] Failed test: 'breaks' [INFO] [stdout] exit status: 1 [INFO] [stdout] stdout: [INFO] [stdout] im now going to break :'( [INFO] [stdout] [INFO] [stdout] stderr: [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] Error: 2 tests had errors out of 2 tests [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] command=`"/opt/rustwide/target/debug/baret" "-c" "tests/test_data/error.yaml"` [INFO] [stdout] code=1 [INFO] [stdout] stdout=```""``` [INFO] [stdout] stderr=```"Failed test: \'another\'\nexit status: 1\nstdout:\nim now going to again :D\n\nstderr:\n\n\nFailed test: \'breaks\'\nexit status: 1\nstdout:\nim now going to break :\'(\n\nstderr:\n\n\nError: 2 tests had errors out of 2 tests\n"``` [INFO] [stdout] [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x5647d8de13d5 - std::backtrace_rs::backtrace::libunwind::trace::h00ba42e7ea42c749 [INFO] [stdout] at /rustc/61a9ac64344e91d62f5496627ff363d177f9daab/library/std/src/../../backtrace/src/backtrace/libunwind.rs:105:5 [INFO] [stdout] 1: 0x5647d8de13d5 - std::backtrace_rs::backtrace::trace_unsynchronized::h9c418817641943a2 [INFO] [stdout] at /rustc/61a9ac64344e91d62f5496627ff363d177f9daab/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5 [INFO] [stdout] 2: 0x5647d8de13d5 - std::sys_common::backtrace::_print_fmt::h16d2f41e50524011 [INFO] [stdout] at /rustc/61a9ac64344e91d62f5496627ff363d177f9daab/library/std/src/sys_common/backtrace.rs:68:5 [INFO] [stdout] 3: 0x5647d8de13d5 - ::fmt::h024be4e490be0e9e [INFO] [stdout] at /rustc/61a9ac64344e91d62f5496627ff363d177f9daab/library/std/src/sys_common/backtrace.rs:44:22 [INFO] [stdout] 4: 0x5647d8e0b1cb - core::fmt::rt::Argument::fmt::h374c4cfff31e7096 [INFO] [stdout] at /rustc/61a9ac64344e91d62f5496627ff363d177f9daab/library/core/src/fmt/rt.rs:165:63 [INFO] [stdout] 5: 0x5647d8e0b1cb - core::fmt::write::hff043ad91cd7da0c [INFO] [stdout] at /rustc/61a9ac64344e91d62f5496627ff363d177f9daab/library/core/src/fmt/mod.rs:1172:21 [INFO] [stdout] 6: 0x5647d8dddf9f - std::io::Write::write_fmt::hcbb4cf2cdd848a5b [INFO] [stdout] at /rustc/61a9ac64344e91d62f5496627ff363d177f9daab/library/std/src/io/mod.rs:1835:15 [INFO] [stdout] 7: 0x5647d8de11ae - std::sys_common::backtrace::_print::hdfa36fb392c08b8d [INFO] [stdout] at /rustc/61a9ac64344e91d62f5496627ff363d177f9daab/library/std/src/sys_common/backtrace.rs:47:5 [INFO] [stdout] 8: 0x5647d8de11ae - std::sys_common::backtrace::print::h798da7279a9c7ae4 [INFO] [stdout] at /rustc/61a9ac64344e91d62f5496627ff363d177f9daab/library/std/src/sys_common/backtrace.rs:34:9 [INFO] [stdout] 9: 0x5647d8de2c89 - std::panicking::default_hook::{{closure}}::h9b61607b4c5732c1 [INFO] [stdout] 10: 0x5647d8de28f6 - std::panicking::default_hook::hc6544668bd872893 [INFO] [stdout] at /rustc/61a9ac64344e91d62f5496627ff363d177f9daab/library/std/src/panicking.rs:295:9 [INFO] [stdout] 11: 0x5647d8d7835a - as core::ops::function::Fn>::call::h9d3afca40a444cde [INFO] [stdout] at /rustc/61a9ac64344e91d62f5496627ff363d177f9daab/library/alloc/src/boxed.rs:2077:9 [INFO] [stdout] 12: 0x5647d8d7835a - test::test_main::{{closure}}::h3c541e298fe81c6f [INFO] [stdout] at /rustc/61a9ac64344e91d62f5496627ff363d177f9daab/library/test/src/lib.rs:137:21 [INFO] [stdout] 13: 0x5647d8de32fb - as core::ops::function::Fn>::call::h1eb54927ae01d97f [INFO] [stdout] at /rustc/61a9ac64344e91d62f5496627ff363d177f9daab/library/alloc/src/boxed.rs:2077:9 [INFO] [stdout] 14: 0x5647d8de32fb - std::panicking::rust_panic_with_hook::h468693c9efe3a031 [INFO] [stdout] at /rustc/61a9ac64344e91d62f5496627ff363d177f9daab/library/std/src/panicking.rs:799:13 [INFO] [stdout] 15: 0x5647d8de3074 - std::panicking::begin_panic_handler::{{closure}}::h98a70b5e29207c8e [INFO] [stdout] at /rustc/61a9ac64344e91d62f5496627ff363d177f9daab/library/std/src/panicking.rs:664:13 [INFO] [stdout] 16: 0x5647d8de1899 - std::sys_common::backtrace::__rust_end_short_backtrace::h611a979064209015 [INFO] [stdout] at /rustc/61a9ac64344e91d62f5496627ff363d177f9daab/library/std/src/sys_common/backtrace.rs:171:18 [INFO] [stdout] 17: 0x5647d8de2da7 - rust_begin_unwind [INFO] [stdout] at /rustc/61a9ac64344e91d62f5496627ff363d177f9daab/library/std/src/panicking.rs:652:5 [INFO] [stdout] 18: 0x5647d8e09753 - core::panicking::panic_fmt::hb6dc9aface1df13b [INFO] [stdout] at /rustc/61a9ac64344e91d62f5496627ff363d177f9daab/library/core/src/panicking.rs:72:14 [INFO] [stdout] 19: 0x5647d8d8709a - core::panicking::panic_display::h4223e04ec962e7af [INFO] [stdout] at /rustc/61a9ac64344e91d62f5496627ff363d177f9daab/library/core/src/panicking.rs:262:5 [INFO] [stdout] 20: 0x5647d8d8c4fe - assert_cmd::assert::AssertError::panic::hae3d04e0001f6f8c [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/assert_cmd-2.0.0/src/assert.rs:124:9 [INFO] [stdout] 21: 0x5647d8d894ce - core::ops::function::FnOnce::call_once::h73d115a31ad9e389 [INFO] [stdout] at /rustc/61a9ac64344e91d62f5496627ff363d177f9daab/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 22: 0x5647d8d8aeff - core::result::Result::unwrap_or_else::h4da2cba3d3cb1f25 [INFO] [stdout] at /rustc/61a9ac64344e91d62f5496627ff363d177f9daab/library/core/src/result.rs:1435:23 [INFO] [stdout] 23: 0x5647d8cf32d2 - assert_cmd::assert::Assert::stderr::h9b8f267c09d49611 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/assert_cmd-2.0.0/src/assert.rs:546:9 [INFO] [stdout] 24: 0x5647d8cfda71 - cli::run_error::ha892dddaa66b9912 [INFO] [stdout] at /opt/rustwide/workdir/tests/cli.rs:88:5 [INFO] [stdout] 25: 0x5647d8cfd817 - cli::run_error::{{closure}}::hf28834d9f6d60fa0 [INFO] [stdout] at /opt/rustwide/workdir/tests/cli.rs:82:19 [INFO] [stdout] 26: 0x5647d8cf80a6 - core::ops::function::FnOnce::call_once::h0d4c2fb5a60c1a24 [INFO] [stdout] at /rustc/61a9ac64344e91d62f5496627ff363d177f9daab/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 27: 0x5647d8d7cb8b - core::ops::function::FnOnce::call_once::h83b9e7210d04f0be [INFO] [stdout] at /rustc/61a9ac64344e91d62f5496627ff363d177f9daab/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 28: 0x5647d8d7cb8b - test::__rust_begin_short_backtrace::hc51e2566ee553989 [INFO] [stdout] at /rustc/61a9ac64344e91d62f5496627ff363d177f9daab/library/test/src/lib.rs:625:18 [INFO] [stdout] 29: 0x5647d8d7c2e1 - test::run_test_in_process::{{closure}}::h507f8c4135041c73 [INFO] [stdout] at /rustc/61a9ac64344e91d62f5496627ff363d177f9daab/library/test/src/lib.rs:648:60 [INFO] [stdout] 30: 0x5647d8d7c2e1 - as core::ops::function::FnOnce<()>>::call_once::hd632d14c2c0c86cc [INFO] [stdout] at /rustc/61a9ac64344e91d62f5496627ff363d177f9daab/library/core/src/panic/unwind_safe.rs:272:9 [INFO] [stdout] 31: 0x5647d8d7c2e1 - std::panicking::try::do_call::he7cb1a3635628c20 [INFO] [stdout] at /rustc/61a9ac64344e91d62f5496627ff363d177f9daab/library/std/src/panicking.rs:559:40 [INFO] [stdout] 32: 0x5647d8d7c2e1 - std::panicking::try::h254585cffc0ff5cb [INFO] [stdout] at /rustc/61a9ac64344e91d62f5496627ff363d177f9daab/library/std/src/panicking.rs:523:19 [INFO] [stdout] 33: 0x5647d8d7c2e1 - std::panic::catch_unwind::h30903f0fa4711873 [INFO] [stdout] at /rustc/61a9ac64344e91d62f5496627ff363d177f9daab/library/std/src/panic.rs:149:14 [INFO] [stdout] 34: 0x5647d8d7c2e1 - test::run_test_in_process::h270fbcadd28ef446 [INFO] [stdout] at /rustc/61a9ac64344e91d62f5496627ff363d177f9daab/library/test/src/lib.rs:648:27 [INFO] [stdout] 35: 0x5647d8d7c2e1 - test::run_test::{{closure}}::h18e4da806d3313a0 [INFO] [stdout] at /rustc/61a9ac64344e91d62f5496627ff363d177f9daab/library/test/src/lib.rs:569:43 [INFO] [stdout] 36: 0x5647d8d44034 - test::run_test::{{closure}}::hc076b6d6ee9c0fac [INFO] [stdout] at /rustc/61a9ac64344e91d62f5496627ff363d177f9daab/library/test/src/lib.rs:599:41 [INFO] [stdout] 37: 0x5647d8d44034 - std::sys_common::backtrace::__rust_begin_short_backtrace::h4f576a631d422da3 [INFO] [stdout] at /rustc/61a9ac64344e91d62f5496627ff363d177f9daab/library/std/src/sys_common/backtrace.rs:155:18 [INFO] [stdout] 38: 0x5647d8d489c2 - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::hefe4a7694b5d43cd [INFO] [stdout] at /rustc/61a9ac64344e91d62f5496627ff363d177f9daab/library/std/src/thread/mod.rs:542:17 [INFO] [stdout] 39: 0x5647d8d489c2 - as core::ops::function::FnOnce<()>>::call_once::hf636fa9a6585dda1 [INFO] [stdout] at /rustc/61a9ac64344e91d62f5496627ff363d177f9daab/library/core/src/panic/unwind_safe.rs:272:9 [INFO] [stdout] 40: 0x5647d8d489c2 - std::panicking::try::do_call::h96113252ae0170f4 [INFO] [stdout] at /rustc/61a9ac64344e91d62f5496627ff363d177f9daab/library/std/src/panicking.rs:559:40 [INFO] [stdout] 41: 0x5647d8d489c2 - std::panicking::try::h8973076d4927ad1d [INFO] [stdout] at /rustc/61a9ac64344e91d62f5496627ff363d177f9daab/library/std/src/panicking.rs:523:19 [INFO] [stdout] 42: 0x5647d8d489c2 - std::panic::catch_unwind::h19e5115b032f0ef3 [INFO] [stdout] at /rustc/61a9ac64344e91d62f5496627ff363d177f9daab/library/std/src/panic.rs:149:14 [INFO] [stdout] 43: 0x5647d8d489c2 - std::thread::Builder::spawn_unchecked_::{{closure}}::h94b93148b33165cc [INFO] [stdout] at /rustc/61a9ac64344e91d62f5496627ff363d177f9daab/library/std/src/thread/mod.rs:541:30 [INFO] [stdout] 44: 0x5647d8d489c2 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h6156e4ffab7355ca [INFO] [stdout] at /rustc/61a9ac64344e91d62f5496627ff363d177f9daab/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 45: 0x5647d8de800b - as core::ops::function::FnOnce>::call_once::h55fe8ae975f6a9ec [INFO] [stdout] at /rustc/61a9ac64344e91d62f5496627ff363d177f9daab/library/alloc/src/boxed.rs:2063:9 [INFO] [stdout] 46: 0x5647d8de800b - as core::ops::function::FnOnce>::call_once::hfe87b9909955678e [INFO] [stdout] at /rustc/61a9ac64344e91d62f5496627ff363d177f9daab/library/alloc/src/boxed.rs:2063:9 [INFO] [stdout] 47: 0x5647d8de800b - std::sys::pal::unix::thread::Thread::new::thread_start::h7a534a78099446c7 [INFO] [stdout] at /rustc/61a9ac64344e91d62f5496627ff363d177f9daab/library/std/src/sys/pal/unix/thread.rs:108:17 [INFO] [stdout] 48: 0x7fac92783ac3 - [INFO] [stdout] 49: 0x7fac92814a04 - __clone [INFO] [stdout] 50: 0x0 - [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] run_error [INFO] [stdout] [INFO] [stdout] test result: FAILED. 21 passed; 1 failed; 1 ignored; 0 measured; 0 filtered out; finished in 0.11s [INFO] [stdout] [INFO] [stderr] error: test failed, to rerun pass `--test cli` [INFO] running `Command { std: "docker" "inspect" "c65fc912af4d07d6e64d3cb97678454c09643a6b9ef5739a4872a1dbaf788ee2", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "c65fc912af4d07d6e64d3cb97678454c09643a6b9ef5739a4872a1dbaf788ee2", kill_on_drop: false }` [INFO] [stdout] c65fc912af4d07d6e64d3cb97678454c09643a6b9ef5739a4872a1dbaf788ee2