Dec 07 01:26:26.858 INFO testing rstest-0.2.2 against master#906deae0790bd18681b937fe9a141a3c26cf1855 for pr-56514 Dec 07 01:26:26.858 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-6/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +906deae0790bd18681b937fe9a141a3c26cf1855-alt build --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"` Dec 07 01:26:27.183 INFO [stdout] 24c27603a961abe404db96974ef14d3ec346e93da537bd40685a2b0dcd91d339 Dec 07 01:26:27.188 INFO running `"docker" "start" "-a" "24c27603a961abe404db96974ef14d3ec346e93da537bd40685a2b0dcd91d339"` Dec 07 01:26:28.181 INFO [stderr] usermod: no changes Dec 07 01:26:28.260 INFO [stderr] Compiling rstest v0.2.2 (/source) Dec 07 01:26:32.777 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 4.57s Dec 07 01:26:32.788 INFO [stderr] su: No module specific data is present Dec 07 01:26:33.397 INFO running `"docker" "inspect" "24c27603a961abe404db96974ef14d3ec346e93da537bd40685a2b0dcd91d339"` Dec 07 01:26:33.686 INFO running `"docker" "rm" "-f" "24c27603a961abe404db96974ef14d3ec346e93da537bd40685a2b0dcd91d339"` Dec 07 01:26:33.996 INFO [stdout] 24c27603a961abe404db96974ef14d3ec346e93da537bd40685a2b0dcd91d339 Dec 07 01:26:34.004 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-6/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +906deae0790bd18681b937fe9a141a3c26cf1855-alt test --frozen --no-run" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"` Dec 07 01:26:34.458 INFO [stdout] 97dfac0c8899691c89da790b17c230a7aa7adfcb57e7f544e5ceeacd37fcade4 Dec 07 01:26:34.464 INFO running `"docker" "start" "-a" "97dfac0c8899691c89da790b17c230a7aa7adfcb57e7f544e5ceeacd37fcade4"` Dec 07 01:26:35.478 INFO [stderr] usermod: no changes Dec 07 01:26:35.601 INFO [stderr] Compiling temp_testdir v0.2.2 Dec 07 01:26:35.608 INFO [stderr] Compiling combine v3.6.3 Dec 07 01:26:55.916 INFO [stderr] Compiling toml_edit v0.1.3 Dec 07 01:27:29.276 INFO [stderr] Compiling rstest v0.2.2 (/source) Dec 07 01:27:39.616 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 1m 04s Dec 07 01:27:39.624 INFO [stderr] su: No module specific data is present Dec 07 01:27:40.592 INFO running `"docker" "inspect" "97dfac0c8899691c89da790b17c230a7aa7adfcb57e7f544e5ceeacd37fcade4"` Dec 07 01:27:40.830 INFO running `"docker" "rm" "-f" "97dfac0c8899691c89da790b17c230a7aa7adfcb57e7f544e5ceeacd37fcade4"` Dec 07 01:27:41.044 INFO [stdout] 97dfac0c8899691c89da790b17c230a7aa7adfcb57e7f544e5ceeacd37fcade4 Dec 07 01:27:41.048 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-6/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +906deae0790bd18681b937fe9a141a3c26cf1855-alt test --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"` Dec 07 01:27:41.479 INFO [stdout] 4fbfb9f8864e13039fde6fb89d26fd546af700259233092c2df03355d4be5d27 Dec 07 01:27:41.481 INFO running `"docker" "start" "-a" "4fbfb9f8864e13039fde6fb89d26fd546af700259233092c2df03355d4be5d27"` Dec 07 01:27:43.035 INFO [stderr] usermod: no changes Dec 07 01:27:43.224 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 0.16s Dec 07 01:27:43.224 INFO [stderr] Running /target/debug/deps/rstest-d0c287c0e04fa53e Dec 07 01:27:43.241 INFO [stdout] Dec 07 01:27:43.241 INFO [stdout] running 14 tests Dec 07 01:27:43.245 INFO [stdout] test test::extract_fixture_call_arg ... ok Dec 07 01:27:43.245 INFO [stdout] test test::arg_2_fixture_str_should_use_passed_fixture_if_any ... ok Dec 07 01:27:43.245 INFO [stdout] test test::parse_empty_meta ... ok Dec 07 01:27:43.245 INFO [stdout] test test::parse_complex_meta ... ok Dec 07 01:27:43.247 INFO [stdout] test test::resolver_build_from_test_case_and_args ... ok Dec 07 01:27:43.247 INFO [stdout] test test::parametrize_with_two_bool_attributes ... ok Dec 07 01:27:43.247 INFO [stdout] test test::extract_parametrize_no_names_happy_path ... ok Dec 07 01:27:43.249 INFO [stdout] test test::parametrize_no_name_vec_and_array ... ok Dec 07 01:27:43.251 INFO [stdout] test test::extract_fixture_should_not_add_mut ... ok Dec 07 01:27:43.251 INFO [stdout] test test::resolver_should_return_the_given_expression ... ok Dec 07 01:27:43.251 INFO [stdout] test test::resolver_should_return_none_for_unknown_argument ... ok Dec 07 01:27:43.251 INFO [stdout] test test::parse_simple_meta ... ok Dec 07 01:27:43.256 INFO [stdout] test test::parse_invalid_meta ... ok Dec 07 01:27:43.256 INFO [stdout] test test::parse_meta_should_accept_bool_as_literal ... ok Dec 07 01:27:43.256 INFO [stdout] Dec 07 01:27:43.256 INFO [stdout] test result: ok. 14 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 07 01:27:43.256 INFO [stdout] Dec 07 01:27:43.256 INFO [stderr] Running /target/debug/deps/fixture-2a1af0d82912668c Dec 07 01:27:43.268 INFO [stdout] Dec 07 01:27:43.268 INFO [stdout] running 4 tests Dec 07 01:27:43.434 INFO [stderr] error: no such subcommand: `add` Dec 07 01:27:43.434 INFO [stderr] Dec 07 01:27:43.434 INFO [stderr] Did you mean `doc`? Dec 07 01:27:43.434 INFO [stderr] Dec 07 01:27:43.549 INFO [stdout] test mutable_fixture ... FAILED Dec 07 01:27:43.549 INFO [stdout] test should_show_correct_errors ... FAILED Dec 07 01:27:43.550 INFO [stdout] test should_panic ... FAILED Dec 07 01:27:43.561 INFO [stdout] test happy_path_one_success_and_one_fail ... FAILED Dec 07 01:27:43.561 INFO [stdout] Dec 07 01:27:43.561 INFO [stdout] failures: Dec 07 01:27:43.561 INFO [stdout] Dec 07 01:27:43.562 INFO [stdout] ---- mutable_fixture stdout ---- Dec 07 01:27:43.563 INFO [stdout] thread 'mutable_fixture' panicked at 'Once instance has previously been poisoned', src/libstd/sync/once.rs:372:21 Dec 07 01:27:43.563 INFO [stdout] stack backtrace: Dec 07 01:27:43.563 INFO [stdout] 0: 0x55b4c5b34743 - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h3c2ada0a2db8c5e7 Dec 07 01:27:43.563 INFO [stdout] at src/libstd/sys/unix/backtrace/tracing/gcc_s.rs:49 Dec 07 01:27:43.563 INFO [stdout] 1: 0x55b4c5b2edf8 - std::sys_common::backtrace::_print::h95865c77318e98b7 Dec 07 01:27:43.563 INFO [stdout] at src/libstd/sys_common/backtrace.rs:71 Dec 07 01:27:43.563 INFO [stdout] 2: 0x55b4c5b336b2 - std::panicking::default_hook::{{closure}}::hb3d1f299fcea42e5 Dec 07 01:27:43.563 INFO [stdout] at src/libstd/sys_common/backtrace.rs:59 Dec 07 01:27:43.563 INFO [stdout] at src/libstd/panicking.rs:211 Dec 07 01:27:43.563 INFO [stdout] 3: 0x55b4c5b3339c - std::panicking::default_hook::h4eae6f26f73244c8 Dec 07 01:27:43.563 INFO [stdout] at src/libstd/panicking.rs:221 Dec 07 01:27:43.563 INFO [stdout] 4: 0x55b4c5b33dc0 - std::panicking::rust_panic_with_hook::h368d37fd53b59464 Dec 07 01:27:43.563 INFO [stdout] at src/libstd/panicking.rs:491 Dec 07 01:27:43.563 INFO [stdout] 5: 0x55b4c5b33b84 - std::panicking::begin_panic::h47b734aa718c1222 Dec 07 01:27:43.563 INFO [stdout] at src/libstd/panicking.rs:425 Dec 07 01:27:43.563 INFO [stdout] 6: 0x55b4c5b2e1da - std::sync::once::Once::call_inner::h40d3ddbcd0770ac9 Dec 07 01:27:43.563 INFO [stdout] at src/libstd/sync/once.rs:372 Dec 07 01:27:43.563 INFO [stdout] 7: 0x55b4c590ef49 - std::sync::once::Once::call_once::h8160abdec2ca02fa Dec 07 01:27:43.563 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/sync/once.rs:230 Dec 07 01:27:43.563 INFO [stdout] 8: 0x55b4c59178a1 - ::deref::hab17cca4e6b071d3 Dec 07 01:27:43.563 INFO [stdout] at /cargo-home/registry/src/github.com-1ecc6299db9ec823/lazy_static-1.2.0/src/inline_lazy.rs:27 Dec 07 01:27:43.563 INFO [stdout] at /source/<::lazy_static::__lazy_static_internal macros>:12 Dec 07 01:27:43.563 INFO [stdout] at /source/<::lazy_static::__lazy_static_internal macros>:13 Dec 07 01:27:43.563 INFO [stdout] 9: 0x55b4c5917597 - fixture::prj::hafd9af9c99515e54 Dec 07 01:27:43.563 INFO [stdout] at tests/fixture.rs:22 Dec 07 01:27:43.563 INFO [stdout] 10: 0x55b4c5917754 - fixture::run_test::h65a612c0fa5e95c3 Dec 07 01:27:43.563 INFO [stdout] at tests/fixture.rs:32 Dec 07 01:27:43.563 INFO [stdout] 11: 0x55b4c5917acd - fixture::mutable_fixture::h3e7c97bd77b973f1 Dec 07 01:27:43.563 INFO [stdout] at tests/fixture.rs:48 Dec 07 01:27:43.563 INFO [stdout] 12: 0x55b4c5917a89 - fixture::mutable_fixture::{{closure}}::h1c3677f8f7ccc93a Dec 07 01:27:43.563 INFO [stdout] at tests/fixture.rs:47 Dec 07 01:27:43.563 INFO [stdout] 13: 0x55b4c5910fdd - core::ops::function::FnOnce::call_once::h80f3b740399b6ad8 Dec 07 01:27:43.563 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libcore/ops/function.rs:238 Dec 07 01:27:43.563 INFO [stdout] 14: 0x55b4c592446e - >::call_box::h994167e0fc25f327 Dec 07 01:27:43.563 INFO [stdout] at src/libtest/lib.rs:1471 Dec 07 01:27:43.563 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libcore/ops/function.rs:238 Dec 07 01:27:43.563 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/liballoc/boxed.rs:673 Dec 07 01:27:43.563 INFO [stdout] 15: 0x55b4c5b47ff9 - __rust_maybe_catch_panic Dec 07 01:27:43.563 INFO [stdout] at src/libpanic_unwind/lib.rs:102 Dec 07 01:27:43.563 INFO [stdout] 16: 0x55b4c591c373 - std::sys_common::backtrace::__rust_begin_short_backtrace::h5d34cfb78512c8c3 Dec 07 01:27:43.563 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panicking.rs:289 Dec 07 01:27:43.563 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panic.rs:398 Dec 07 01:27:43.563 INFO [stdout] at src/libtest/lib.rs:1426 Dec 07 01:27:43.563 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/sys_common/backtrace.rs:136 Dec 07 01:27:43.563 INFO [stdout] 17: 0x55b4c591d294 - std::panicking::try::do_call::h7a86b6211ebb5e72 Dec 07 01:27:43.563 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/thread/mod.rs:477 Dec 07 01:27:43.563 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panic.rs:319 Dec 07 01:27:43.563 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panicking.rs:310 Dec 07 01:27:43.563 INFO [stdout] 18: 0x55b4c5b47ff9 - __rust_maybe_catch_panic Dec 07 01:27:43.563 INFO [stdout] at src/libpanic_unwind/lib.rs:102 Dec 07 01:27:43.563 INFO [stdout] 19: 0x55b4c592434c - >::call_box::h877dbe22cb3997f4 Dec 07 01:27:43.563 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panicking.rs:289 Dec 07 01:27:43.563 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panic.rs:398 Dec 07 01:27:43.563 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/thread/mod.rs:476 Dec 07 01:27:43.563 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/liballoc/boxed.rs:673 Dec 07 01:27:43.563 INFO [stdout] 20: 0x55b4c5b3bfbd - std::sys::unix::thread::Thread::new::thread_start::hea5f7f9c570dc4cd Dec 07 01:27:43.563 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/liballoc/boxed.rs:683 Dec 07 01:27:43.563 INFO [stdout] at src/libstd/sys_common/thread.rs:24 Dec 07 01:27:43.563 INFO [stdout] at src/libstd/sys/unix/thread.rs:90 Dec 07 01:27:43.563 INFO [stdout] 21: 0x7fe3366e26b9 - start_thread Dec 07 01:27:43.563 INFO [stdout] 22: 0x7fe33620241c - clone Dec 07 01:27:43.563 INFO [stdout] 23: 0x0 - Dec 07 01:27:43.563 INFO [stdout] Dec 07 01:27:43.563 INFO [stdout] ---- should_show_correct_errors stdout ---- Dec 07 01:27:43.563 INFO [stdout] thread 'should_show_correct_errors' panicked at 'Once instance has previously been poisoned', src/libstd/sync/once.rs:372:21 Dec 07 01:27:43.563 INFO [stdout] stack backtrace: Dec 07 01:27:43.563 INFO [stdout] 0: 0x55b4c5b34743 - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h3c2ada0a2db8c5e7 Dec 07 01:27:43.563 INFO [stdout] at src/libstd/sys/unix/backtrace/tracing/gcc_s.rs:49 Dec 07 01:27:43.563 INFO [stdout] 1: 0x55b4c5b2edf8 - std::sys_common::backtrace::_print::h95865c77318e98b7 Dec 07 01:27:43.563 INFO [stdout] at src/libstd/sys_common/backtrace.rs:71 Dec 07 01:27:43.563 INFO [stdout] 2: 0x55b4c5b336b2 - std::panicking::default_hook::{{closure}}::hb3d1f299fcea42e5 Dec 07 01:27:43.563 INFO [stdout] at src/libstd/sys_common/backtrace.rs:59 Dec 07 01:27:43.563 INFO [stdout] at src/libstd/panicking.rs:211 Dec 07 01:27:43.563 INFO [stdout] 3: 0x55b4c5b3339c - std::panicking::default_hook::h4eae6f26f73244c8 Dec 07 01:27:43.563 INFO [stdout] at src/libstd/panicking.rs:221 Dec 07 01:27:43.563 INFO [stdout] 4: 0x55b4c5b33dc0 - std::panicking::rust_panic_with_hook::h368d37fd53b59464 Dec 07 01:27:43.563 INFO [stdout] at src/libstd/panicking.rs:491 Dec 07 01:27:43.563 INFO [stdout] 5: 0x55b4c5b33b84 - std::panicking::begin_panic::h47b734aa718c1222 Dec 07 01:27:43.563 INFO [stdout] at src/libstd/panicking.rs:425 Dec 07 01:27:43.563 INFO [stdout] 6: 0x55b4c5b2e1da - std::sync::once::Once::call_inner::h40d3ddbcd0770ac9 Dec 07 01:27:43.563 INFO [stdout] at src/libstd/sync/once.rs:372 Dec 07 01:27:43.563 INFO [stdout] 7: 0x55b4c590ef49 - std::sync::once::Once::call_once::h8160abdec2ca02fa Dec 07 01:27:43.563 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/sync/once.rs:230 Dec 07 01:27:43.563 INFO [stdout] 8: 0x55b4c59178a1 - ::deref::hab17cca4e6b071d3 Dec 07 01:27:43.563 INFO [stdout] at /cargo-home/registry/src/github.com-1ecc6299db9ec823/lazy_static-1.2.0/src/inline_lazy.rs:27 Dec 07 01:27:43.563 INFO [stdout] at /source/<::lazy_static::__lazy_static_internal macros>:12 Dec 07 01:27:43.563 INFO [stdout] at /source/<::lazy_static::__lazy_static_internal macros>:13 Dec 07 01:27:43.563 INFO [stdout] 9: 0x55b4c5917597 - fixture::prj::hafd9af9c99515e54 Dec 07 01:27:43.563 INFO [stdout] at tests/fixture.rs:22 Dec 07 01:27:43.563 INFO [stdout] 10: 0x55b4c5917da2 - fixture::should_show_correct_errors::ha1fdf22e04cc3287 Dec 07 01:27:43.564 INFO [stdout] at tests/fixture.rs:68 Dec 07 01:27:43.564 INFO [stdout] 11: 0x55b4c5917d69 - fixture::should_show_correct_errors::{{closure}}::h78fc15745bdf8033 Dec 07 01:27:43.564 INFO [stdout] at tests/fixture.rs:67 Dec 07 01:27:43.564 INFO [stdout] 12: 0x55b4c5910e7d - core::ops::function::FnOnce::call_once::h2b57b7bd307895ce Dec 07 01:27:43.564 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libcore/ops/function.rs:238 Dec 07 01:27:43.564 INFO [stdout] 13: 0x55b4c592446e - >::call_box::h994167e0fc25f327 Dec 07 01:27:43.564 INFO [stdout] at src/libtest/lib.rs:1471 Dec 07 01:27:43.564 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libcore/ops/function.rs:238 Dec 07 01:27:43.564 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/liballoc/boxed.rs:673 Dec 07 01:27:43.564 INFO [stdout] 14: 0x55b4c5b47ff9 - __rust_maybe_catch_panic Dec 07 01:27:43.564 INFO [stdout] at src/libpanic_unwind/lib.rs:102 Dec 07 01:27:43.564 INFO [stdout] 15: 0x55b4c591c373 - std::sys_common::backtrace::__rust_begin_short_backtrace::h5d34cfb78512c8c3 Dec 07 01:27:43.564 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panicking.rs:289 Dec 07 01:27:43.564 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panic.rs:398 Dec 07 01:27:43.564 INFO [stdout] at src/libtest/lib.rs:1426 Dec 07 01:27:43.564 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/sys_common/backtrace.rs:136 Dec 07 01:27:43.564 INFO [stdout] 16: 0x55b4c591d294 - std::panicking::try::do_call::h7a86b6211ebb5e72 Dec 07 01:27:43.564 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/thread/mod.rs:477 Dec 07 01:27:43.564 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panic.rs:319 Dec 07 01:27:43.564 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panicking.rs:310 Dec 07 01:27:43.564 INFO [stdout] 17: 0x55b4c5b47ff9 - __rust_maybe_catch_panic Dec 07 01:27:43.564 INFO [stdout] at src/libpanic_unwind/lib.rs:102 Dec 07 01:27:43.564 INFO [stdout] 18: 0x55b4c592434c - >::call_box::h877dbe22cb3997f4 Dec 07 01:27:43.564 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panicking.rs:289 Dec 07 01:27:43.564 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panic.rs:398 Dec 07 01:27:43.564 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/thread/mod.rs:476 Dec 07 01:27:43.564 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/liballoc/boxed.rs:673 Dec 07 01:27:43.564 INFO [stdout] 19: 0x55b4c5b3bfbd - std::sys::unix::thread::Thread::new::thread_start::hea5f7f9c570dc4cd Dec 07 01:27:43.564 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/liballoc/boxed.rs:683 Dec 07 01:27:43.564 INFO [stdout] at src/libstd/sys_common/thread.rs:24 Dec 07 01:27:43.564 INFO [stdout] at src/libstd/sys/unix/thread.rs:90 Dec 07 01:27:43.564 INFO [stdout] 20: 0x7fe3366e26b9 - start_thread Dec 07 01:27:43.564 INFO [stdout] 21: 0x7fe33620241c - clone Dec 07 01:27:43.564 INFO [stdout] 22: 0x0 - Dec 07 01:27:43.564 INFO [stdout] Dec 07 01:27:43.564 INFO [stdout] ---- should_panic stdout ---- Dec 07 01:27:43.564 INFO [stdout] thread 'should_panic' panicked at 'Once instance has previously been poisoned', src/libstd/sync/once.rs:372:21 Dec 07 01:27:43.564 INFO [stdout] stack backtrace: Dec 07 01:27:43.564 INFO [stdout] 0: 0x55b4c5b34743 - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h3c2ada0a2db8c5e7 Dec 07 01:27:43.564 INFO [stdout] at src/libstd/sys/unix/backtrace/tracing/gcc_s.rs:49 Dec 07 01:27:43.564 INFO [stdout] 1: 0x55b4c5b2edf8 - std::sys_common::backtrace::_print::h95865c77318e98b7 Dec 07 01:27:43.564 INFO [stdout] at src/libstd/sys_common/backtrace.rs:71 Dec 07 01:27:43.564 INFO [stdout] 2: 0x55b4c5b336b2 - std::panicking::default_hook::{{closure}}::hb3d1f299fcea42e5 Dec 07 01:27:43.564 INFO [stdout] at src/libstd/sys_common/backtrace.rs:59 Dec 07 01:27:43.564 INFO [stdout] at src/libstd/panicking.rs:211 Dec 07 01:27:43.564 INFO [stdout] 3: 0x55b4c5b3339c - std::panicking::default_hook::h4eae6f26f73244c8 Dec 07 01:27:43.564 INFO [stdout] at src/libstd/panicking.rs:221 Dec 07 01:27:43.564 INFO [stdout] 4: 0x55b4c5b33dc0 - std::panicking::rust_panic_with_hook::h368d37fd53b59464 Dec 07 01:27:43.564 INFO [stdout] at src/libstd/panicking.rs:491 Dec 07 01:27:43.564 INFO [stdout] 5: 0x55b4c5b33b84 - std::panicking::begin_panic::h47b734aa718c1222 Dec 07 01:27:43.564 INFO [stdout] at src/libstd/panicking.rs:425 Dec 07 01:27:43.564 INFO [stdout] 6: 0x55b4c5b2e1da - std::sync::once::Once::call_inner::h40d3ddbcd0770ac9 Dec 07 01:27:43.564 INFO [stdout] at src/libstd/sync/once.rs:372 Dec 07 01:27:43.564 INFO [stdout] 7: 0x55b4c590ef49 - std::sync::once::Once::call_once::h8160abdec2ca02fa Dec 07 01:27:43.564 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/sync/once.rs:230 Dec 07 01:27:43.564 INFO [stdout] 8: 0x55b4c59178a1 - ::deref::hab17cca4e6b071d3 Dec 07 01:27:43.564 INFO [stdout] at /cargo-home/registry/src/github.com-1ecc6299db9ec823/lazy_static-1.2.0/src/inline_lazy.rs:27 Dec 07 01:27:43.564 INFO [stdout] at /source/<::lazy_static::__lazy_static_internal macros>:12 Dec 07 01:27:43.564 INFO [stdout] at /source/<::lazy_static::__lazy_static_internal macros>:13 Dec 07 01:27:43.564 INFO [stdout] 9: 0x55b4c5917597 - fixture::prj::hafd9af9c99515e54 Dec 07 01:27:43.564 INFO [stdout] at tests/fixture.rs:22 Dec 07 01:27:43.564 INFO [stdout] 10: 0x55b4c5917754 - fixture::run_test::h65a612c0fa5e95c3 Dec 07 01:27:43.564 INFO [stdout] at tests/fixture.rs:32 Dec 07 01:27:43.564 INFO [stdout] 11: 0x55b4c5917c3d - fixture::should_panic::hd6945143d803a5a8 Dec 07 01:27:43.564 INFO [stdout] at tests/fixture.rs:58 Dec 07 01:27:43.564 INFO [stdout] 12: 0x55b4c5917bf9 - fixture::should_panic::{{closure}}::h3751d41138a70a5d Dec 07 01:27:43.564 INFO [stdout] at tests/fixture.rs:57 Dec 07 01:27:43.564 INFO [stdout] 13: 0x55b4c591101d - core::ops::function::FnOnce::call_once::ha49695d4a87c403c Dec 07 01:27:43.564 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libcore/ops/function.rs:238 Dec 07 01:27:43.564 INFO [stdout] 14: 0x55b4c592446e - >::call_box::h994167e0fc25f327 Dec 07 01:27:43.564 INFO [stdout] at src/libtest/lib.rs:1471 Dec 07 01:27:43.564 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libcore/ops/function.rs:238 Dec 07 01:27:43.564 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/liballoc/boxed.rs:673 Dec 07 01:27:43.564 INFO [stdout] 15: 0x55b4c5b47ff9 - __rust_maybe_catch_panic Dec 07 01:27:43.564 INFO [stdout] at src/libpanic_unwind/lib.rs:102 Dec 07 01:27:43.564 INFO [stdout] 16: 0x55b4c591c373 - std::sys_common::backtrace::__rust_begin_short_backtrace::h5d34cfb78512c8c3 Dec 07 01:27:43.564 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panicking.rs:289 Dec 07 01:27:43.564 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panic.rs:398 Dec 07 01:27:43.564 INFO [stdout] at src/libtest/lib.rs:1426 Dec 07 01:27:43.564 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/sys_common/backtrace.rs:136 Dec 07 01:27:43.564 INFO [stdout] 17: 0x55b4c591d294 - std::panicking::try::do_call::h7a86b6211ebb5e72 Dec 07 01:27:43.564 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/thread/mod.rs:477 Dec 07 01:27:43.564 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panic.rs:319 Dec 07 01:27:43.565 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panicking.rs:310 Dec 07 01:27:43.565 INFO [stdout] 18: 0x55b4c5b47ff9 - __rust_maybe_catch_panic Dec 07 01:27:43.565 INFO [stdout] at src/libpanic_unwind/lib.rs:102 Dec 07 01:27:43.565 INFO [stdout] 19: 0x55b4c592434c - >::call_box::h877dbe22cb3997f4 Dec 07 01:27:43.565 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panicking.rs:289 Dec 07 01:27:43.565 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panic.rs:398 Dec 07 01:27:43.565 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/thread/mod.rs:476 Dec 07 01:27:43.565 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/liballoc/boxed.rs:673 Dec 07 01:27:43.565 INFO [stdout] 20: 0x55b4c5b3bfbd - std::sys::unix::thread::Thread::new::thread_start::hea5f7f9c570dc4cd Dec 07 01:27:43.565 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/liballoc/boxed.rs:683 Dec 07 01:27:43.565 INFO [stdout] at src/libstd/sys_common/thread.rs:24 Dec 07 01:27:43.565 INFO [stdout] at src/libstd/sys/unix/thread.rs:90 Dec 07 01:27:43.565 INFO [stdout] 21: 0x7fe3366e26b9 - start_thread Dec 07 01:27:43.565 INFO [stdout] 22: 0x7fe33620241c - clone Dec 07 01:27:43.565 INFO [stdout] 23: 0x0 - Dec 07 01:27:43.565 INFO [stdout] Dec 07 01:27:43.565 INFO [stdout] ---- happy_path_one_success_and_one_fail stdout ---- Dec 07 01:27:43.565 INFO [stdout] thread 'happy_path_one_success_and_one_fail' panicked at 'cargo add return an error code', tests/prj/mod.rs:108:13 Dec 07 01:27:43.565 INFO [stdout] stack backtrace: Dec 07 01:27:43.565 INFO [stdout] 0: 0x55b4c5b34743 - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h3c2ada0a2db8c5e7 Dec 07 01:27:43.565 INFO [stdout] at src/libstd/sys/unix/backtrace/tracing/gcc_s.rs:49 Dec 07 01:27:43.565 INFO [stdout] 1: 0x55b4c5b2edf8 - std::sys_common::backtrace::_print::h95865c77318e98b7 Dec 07 01:27:43.565 INFO [stdout] at src/libstd/sys_common/backtrace.rs:71 Dec 07 01:27:43.565 INFO [stdout] 2: 0x55b4c5b336b2 - std::panicking::default_hook::{{closure}}::hb3d1f299fcea42e5 Dec 07 01:27:43.565 INFO [stdout] at src/libstd/sys_common/backtrace.rs:59 Dec 07 01:27:43.565 INFO [stdout] at src/libstd/panicking.rs:211 Dec 07 01:27:43.565 INFO [stdout] 3: 0x55b4c5b3339c - std::panicking::default_hook::h4eae6f26f73244c8 Dec 07 01:27:43.565 INFO [stdout] at src/libstd/panicking.rs:221 Dec 07 01:27:43.565 INFO [stdout] 4: 0x55b4c5b33dc0 - std::panicking::rust_panic_with_hook::h368d37fd53b59464 Dec 07 01:27:43.565 INFO [stdout] at src/libstd/panicking.rs:491 Dec 07 01:27:43.565 INFO [stdout] 5: 0x55b4c5b14b97 - std::panicking::begin_panic::h94f4189a5eb9b44a Dec 07 01:27:43.565 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panicking.rs:425 Dec 07 01:27:43.565 INFO [stdout] 6: 0x55b4c591a4dd - fixture::prj::Project::add_dependency::h3a54f57898c042a0 Dec 07 01:27:43.565 INFO [stdout] at tests/prj/mod.rs:108 Dec 07 01:27:43.565 INFO [stdout] 7: 0x55b4c5919eae - fixture::prj::Project::create::hfae5972efc658bf3 Dec 07 01:27:43.565 INFO [stdout] at tests/prj/mod.rs:67 Dec 07 01:27:43.565 INFO [stdout] 8: 0x55b4c5910f34 - core::ops::function::FnOnce::call_once::h3c379e2b34218e8f Dec 07 01:27:43.565 INFO [stdout] at tests/fixture.rs:16 Dec 07 01:27:43.565 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libcore/ops/function.rs:238 Dec 07 01:27:43.565 INFO [stdout] 9: 0x55b4c591acb5 - >::get::{{closure}}::h3a41e03fe9814c24 Dec 07 01:27:43.565 INFO [stdout] at /cargo-home/registry/src/github.com-1ecc6299db9ec823/lazy_static-1.2.0/src/inline_lazy.rs:28 Dec 07 01:27:43.565 INFO [stdout] 10: 0x55b4c590f0ca - std::sync::once::Once::call_once::{{closure}}::hb3b34fcf5255f2f7 Dec 07 01:27:43.565 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/sync/once.rs:230 Dec 07 01:27:43.565 INFO [stdout] 11: 0x55b4c5b2e175 - std::sync::once::Once::call_inner::h40d3ddbcd0770ac9 Dec 07 01:27:43.565 INFO [stdout] at src/libstd/sync/once.rs:397 Dec 07 01:27:43.565 INFO [stdout] 12: 0x55b4c590ef49 - std::sync::once::Once::call_once::h8160abdec2ca02fa Dec 07 01:27:43.565 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/sync/once.rs:230 Dec 07 01:27:43.565 INFO [stdout] 13: 0x55b4c59178a1 - ::deref::hab17cca4e6b071d3 Dec 07 01:27:43.565 INFO [stdout] at /cargo-home/registry/src/github.com-1ecc6299db9ec823/lazy_static-1.2.0/src/inline_lazy.rs:27 Dec 07 01:27:43.565 INFO [stdout] at /source/<::lazy_static::__lazy_static_internal macros>:12 Dec 07 01:27:43.565 INFO [stdout] at /source/<::lazy_static::__lazy_static_internal macros>:13 Dec 07 01:27:43.565 INFO [stdout] 14: 0x55b4c5917597 - fixture::prj::hafd9af9c99515e54 Dec 07 01:27:43.565 INFO [stdout] at tests/fixture.rs:22 Dec 07 01:27:43.565 INFO [stdout] 15: 0x55b4c5917754 - fixture::run_test::h65a612c0fa5e95c3 Dec 07 01:27:43.565 INFO [stdout] at tests/fixture.rs:32 Dec 07 01:27:43.565 INFO [stdout] 16: 0x55b4c591795d - fixture::happy_path_one_success_and_one_fail::hfe0bb5d81f76045c Dec 07 01:27:43.565 INFO [stdout] at tests/fixture.rs:38 Dec 07 01:27:43.565 INFO [stdout] 17: 0x55b4c5917919 - fixture::happy_path_one_success_and_one_fail::{{closure}}::h9805638392206a2e Dec 07 01:27:43.565 INFO [stdout] at tests/fixture.rs:37 Dec 07 01:27:43.565 INFO [stdout] 18: 0x55b4c5910ebd - core::ops::function::FnOnce::call_once::h3465c99bcc808dc4 Dec 07 01:27:43.565 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libcore/ops/function.rs:238 Dec 07 01:27:43.565 INFO [stdout] 19: 0x55b4c592446e - >::call_box::h994167e0fc25f327 Dec 07 01:27:43.565 INFO [stdout] at src/libtest/lib.rs:1471 Dec 07 01:27:43.565 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libcore/ops/function.rs:238 Dec 07 01:27:43.565 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/liballoc/boxed.rs:673 Dec 07 01:27:43.565 INFO [stdout] 20: 0x55b4c5b47ff9 - __rust_maybe_catch_panic Dec 07 01:27:43.565 INFO [stdout] at src/libpanic_unwind/lib.rs:102 Dec 07 01:27:43.565 INFO [stdout] 21: 0x55b4c591c373 - std::sys_common::backtrace::__rust_begin_short_backtrace::h5d34cfb78512c8c3 Dec 07 01:27:43.565 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panicking.rs:289 Dec 07 01:27:43.565 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panic.rs:398 Dec 07 01:27:43.565 INFO [stdout] at src/libtest/lib.rs:1426 Dec 07 01:27:43.565 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/sys_common/backtrace.rs:136 Dec 07 01:27:43.565 INFO [stdout] 22: 0x55b4c591d294 - std::panicking::try::do_call::h7a86b6211ebb5e72 Dec 07 01:27:43.565 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/thread/mod.rs:477 Dec 07 01:27:43.565 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panic.rs:319 Dec 07 01:27:43.565 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panicking.rs:310 Dec 07 01:27:43.565 INFO [stdout] 23: 0x55b4c5b47ff9 - __rust_maybe_catch_panic Dec 07 01:27:43.565 INFO [stdout] at src/libpanic_unwind/lib.rs:102 Dec 07 01:27:43.565 INFO [stdout] 24: 0x55b4c592434c - >::call_box::h877dbe22cb3997f4 Dec 07 01:27:43.565 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panicking.rs:289 Dec 07 01:27:43.565 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panic.rs:398 Dec 07 01:27:43.565 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/thread/mod.rs:476 Dec 07 01:27:43.565 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/liballoc/boxed.rs:673 Dec 07 01:27:43.565 INFO [stdout] 25: 0x55b4c5b3bfbd - std::sys::unix::thread::Thread::new::thread_start::hea5f7f9c570dc4cd Dec 07 01:27:43.565 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/liballoc/boxed.rs:683 Dec 07 01:27:43.565 INFO [stdout] at src/libstd/sys_common/thread.rs:24 Dec 07 01:27:43.566 INFO [stdout] at src/libstd/sys/unix/thread.rs:90 Dec 07 01:27:43.566 INFO [stdout] 26: 0x7fe3366e26b9 - start_thread Dec 07 01:27:43.566 INFO [stdout] 27: 0x7fe33620241c - clone Dec 07 01:27:43.566 INFO [stdout] 28: 0x0 - Dec 07 01:27:43.566 INFO [stdout] Dec 07 01:27:43.566 INFO [stdout] Dec 07 01:27:43.566 INFO [stdout] failures: Dec 07 01:27:43.566 INFO [stdout] happy_path_one_success_and_one_fail Dec 07 01:27:43.566 INFO [stdout] mutable_fixture Dec 07 01:27:43.566 INFO [stdout] should_panic Dec 07 01:27:43.566 INFO [stdout] should_show_correct_errors Dec 07 01:27:43.567 INFO [stdout] Dec 07 01:27:43.567 INFO [stdout] test result: FAILED. 0 passed; 4 failed; 0 ignored; 0 measured; 0 filtered out Dec 07 01:27:43.567 INFO [stdout] Dec 07 01:27:43.570 INFO [stderr] error: test failed, to rerun pass '--test fixture' Dec 07 01:27:43.572 INFO [stderr] su: No module specific data is present Dec 07 01:27:44.905 INFO running `"docker" "inspect" "4fbfb9f8864e13039fde6fb89d26fd546af700259233092c2df03355d4be5d27"` Dec 07 01:27:45.296 INFO running `"docker" "rm" "-f" "4fbfb9f8864e13039fde6fb89d26fd546af700259233092c2df03355d4be5d27"` Dec 07 01:27:45.652 INFO [stdout] 4fbfb9f8864e13039fde6fb89d26fd546af700259233092c2df03355d4be5d27