Dec 13 22:06:19.366 INFO testing davidB/ffizer against try#aa49d8ef14939ddec0e34b346b60174a5673d48f for pr-56550 Dec 13 22:06:19.366 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-7/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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 13 22:06:19.904 INFO [stdout] 3a9f10601fffd2fc0f31a583393b0677024e859734d14e73015dab5835821d22 Dec 13 22:06:19.906 INFO running `"docker" "start" "-a" "3a9f10601fffd2fc0f31a583393b0677024e859734d14e73015dab5835821d22"` Dec 13 22:06:22.031 INFO [stderr] usermod: no changes Dec 13 22:06:22.655 INFO [stderr] Compiling serde v1.0.82 Dec 13 22:06:22.655 INFO [stderr] Compiling slog v2.4.1 Dec 13 22:06:22.733 INFO [stderr] Compiling directories v1.0.2 Dec 13 22:06:22.735 INFO [stderr] Compiling uuid v0.6.5 Dec 13 22:06:22.736 INFO [stderr] Compiling chrono v0.4.6 Dec 13 22:06:22.737 INFO [stderr] Compiling tempfile v2.2.0 Dec 13 22:06:22.737 INFO [stderr] Compiling serde_derive v1.0.82 Dec 13 22:06:22.751 INFO [stderr] Compiling structopt-derive v0.2.14 Dec 13 22:06:29.583 INFO [stderr] Compiling os_type v2.2.0 Dec 13 22:06:29.607 INFO [stderr] Compiling Inflector v0.11.3 Dec 13 22:06:29.695 INFO [stderr] Compiling globset v0.4.2 Dec 13 22:06:29.919 INFO [stderr] Compiling dialoguer v0.3.0 Dec 13 22:06:45.940 INFO [stderr] Compiling slog-async v2.3.0 Dec 13 22:06:47.556 INFO [stderr] Compiling slog-term v2.4.0 Dec 13 22:06:47.791 INFO [stderr] Compiling structopt v0.2.14 Dec 13 22:07:16.737 INFO [stderr] Compiling toml v0.4.10 Dec 13 22:07:16.738 INFO [stderr] Compiling serde_json v1.0.33 Dec 13 22:07:16.748 INFO [stderr] Compiling serde_urlencoded v0.5.4 Dec 13 22:07:16.749 INFO [stderr] Compiling serde_yaml v0.8.8 Dec 13 22:07:29.728 INFO [stderr] Compiling handlebars v1.1.0 Dec 13 22:07:29.787 INFO [stderr] Compiling reqwest v0.9.5 Dec 13 22:07:30.058 INFO [stderr] Compiling human-panic v1.0.1 Dec 13 22:07:50.447 INFO [stderr] Compiling ffizer v0.8.0 (/source) Dec 13 22:08:16.523 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 1m 54s Dec 13 22:08:16.542 INFO [stderr] su: No module specific data is present Dec 13 22:08:16.952 INFO running `"docker" "inspect" "3a9f10601fffd2fc0f31a583393b0677024e859734d14e73015dab5835821d22"` Dec 13 22:08:17.241 INFO running `"docker" "rm" "-f" "3a9f10601fffd2fc0f31a583393b0677024e859734d14e73015dab5835821d22"` Dec 13 22:08:17.420 INFO [stdout] 3a9f10601fffd2fc0f31a583393b0677024e859734d14e73015dab5835821d22 Dec 13 22:08:17.425 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-7/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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 13 22:08:17.674 INFO [stdout] 70e47e4e44275ad6094d732799fd8b24158a56c4feb80638ffcc26e6c4580574 Dec 13 22:08:17.678 INFO running `"docker" "start" "-a" "70e47e4e44275ad6094d732799fd8b24158a56c4feb80638ffcc26e6c4580574"` Dec 13 22:08:18.272 INFO [stderr] usermod: no changes Dec 13 22:08:18.652 INFO [stderr] Compiling escargot v0.3.1 Dec 13 22:08:18.652 INFO [stderr] Compiling predicates-core v1.0.0 Dec 13 22:08:18.660 INFO [stderr] Compiling treeline v0.1.0 Dec 13 22:08:18.727 INFO [stderr] Compiling tempfile v3.0.5 Dec 13 22:08:18.727 INFO [stderr] Compiling spectral v0.6.0 Dec 13 22:08:19.531 INFO [stderr] Compiling predicates v1.0.0 Dec 13 22:08:19.531 INFO [stderr] Compiling predicates-tree v1.0.0 Dec 13 22:08:22.663 INFO [stderr] Compiling assert_cmd v0.10.2 Dec 13 22:08:25.378 INFO [stderr] Compiling ffizer v0.8.0 (/source) Dec 13 22:08:54.902 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 36.61s Dec 13 22:08:54.927 INFO [stderr] su: No module specific data is present Dec 13 22:08:55.549 INFO running `"docker" "inspect" "70e47e4e44275ad6094d732799fd8b24158a56c4feb80638ffcc26e6c4580574"` Dec 13 22:08:55.866 INFO running `"docker" "rm" "-f" "70e47e4e44275ad6094d732799fd8b24158a56c4feb80638ffcc26e6c4580574"` Dec 13 22:08:56.232 INFO [stdout] 70e47e4e44275ad6094d732799fd8b24158a56c4feb80638ffcc26e6c4580574 Dec 13 22:08:56.303 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-7/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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 13 22:08:56.722 INFO [stdout] d8366fa8b3120eedd8bdc72e3e2ba24f4be316bf769acbc4568907de7a6b7d38 Dec 13 22:08:56.724 INFO running `"docker" "start" "-a" "d8366fa8b3120eedd8bdc72e3e2ba24f4be316bf769acbc4568907de7a6b7d38"` Dec 13 22:08:57.591 INFO [stderr] usermod: no changes Dec 13 22:08:57.975 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 0.35s Dec 13 22:08:57.995 INFO [stderr] Running /target/debug/deps/ffizer-420aea91cdb6bdc7 Dec 13 22:08:58.015 INFO [stdout] Dec 13 22:08:58.015 INFO [stdout] running 13 tests Dec 13 22:08:58.051 INFO [stdout] test hbs::tests::test_register_path_helpers ... ok Dec 13 22:08:58.055 INFO [stdout] test tests::test_compute_dst_path_asis ... ok Dec 13 22:08:58.055 INFO [stdout] test tests::test_compute_dst_path_ffizer_handlebars ... ok Dec 13 22:08:58.055 INFO [stdout] test template_cfg::tests::test_deserialize_cfg_yaml ... ok Dec 13 22:08:58.055 INFO [stdout] test tests::test_compute_dst_path_rendered_filename ... ok Dec 13 22:08:58.071 INFO [stdout] test tests::test_is_ffizer_handlebars ... ok Dec 13 22:08:58.071 INFO [stdout] test tests::test_path_extension_extraction ... ok Dec 13 22:08:58.075 INFO [stdout] test tests::test_cmp_path_for_plan ... ok Dec 13 22:08:58.087 INFO [stdout] test tests::test_compute_dst_path_rendered_folder ... ok Dec 13 22:08:58.097 INFO [stdout] test template_cfg::tests::test_transforms_values ... ok Dec 13 22:08:58.097 INFO [stdout] test source_uri::tests::test_source_uri_from_str ... ok Dec 13 22:08:58.191 INFO [stdout] test hbs::tests::test_chain_of_helpers_with_1_param ... ok Dec 13 22:08:58.404 INFO [stdout] test hbs::tests::test_register_string_helpers ... ok Dec 13 22:08:58.404 INFO [stdout] Dec 13 22:08:58.404 INFO [stdout] test result: ok. 13 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 13 22:08:58.404 INFO [stdout] Dec 13 22:08:58.411 INFO [stdout] Dec 13 22:08:58.411 INFO [stdout] running 0 tests Dec 13 22:08:58.411 INFO [stdout] Dec 13 22:08:58.411 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 13 22:08:58.411 INFO [stdout] Dec 13 22:08:58.411 INFO [stderr] Running /target/debug/deps/ffizer-915da0985d7aa94e Dec 13 22:08:58.411 INFO [stderr] Running /target/debug/deps/dir_diff-9315bd3bd71bce77 Dec 13 22:08:58.415 INFO [stdout] Dec 13 22:08:58.415 INFO [stdout] running 0 tests Dec 13 22:08:58.415 INFO [stdout] Dec 13 22:08:58.415 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 13 22:08:58.415 INFO [stdout] Dec 13 22:08:58.415 INFO [stderr] Running /target/debug/deps/e2e-bc66faa1d630211c Dec 13 22:08:58.427 INFO [stdout] Dec 13 22:08:58.427 INFO [stdout] running 4 tests Dec 13 22:09:58.427 INFO [stdout] test test_1_subfolder ... test test_1_subfolder has been running for over 60 seconds Dec 13 22:09:58.427 INFO [stdout] test empty_template ... test empty_template has been running for over 60 seconds Dec 13 22:09:58.427 INFO [stdout] test test_1 ... test test_1 has been running for over 60 seconds Dec 13 22:09:58.427 INFO [stdout] test test_3 ... test test_3 has been running for over 60 seconds Dec 13 22:14:56.325 INFO [stdout] Dec 13 22:14:56.325 INFO [stdout] Dec 13 22:14:56.325 INFO [stdout] Plan to execute Dec 13 22:14:56.325 INFO [stdout] Dec 13 22:14:56.325 INFO [stdout] - keep "/tmp/.tmpJPASMH/" Dec 13 22:14:56.325 INFO [stdout] - copyraw "/tmp/.tmpJPASMH/file_1_1.txt" Dec 13 22:14:56.325 INFO [stdout] test test_1_subfolder ... ok Dec 13 22:14:56.420 INFO [stdout] Dec 13 22:14:56.420 INFO [stdout] Dec 13 22:14:56.420 INFO [stdout] Plan to execute Dec 13 22:14:56.420 INFO [stdout] Dec 13 22:14:56.420 INFO [stdout] - mkdir "/tmp/.tmp7H0tiD/test_3/" Dec 13 22:14:56.420 INFO [stdout] - copyrender "/tmp/.tmp7H0tiD/test_3/file1.txt" Dec 13 22:14:56.423 INFO [stderr] Error: RenderError(RenderError { desc: "Variable \"project_name\" not found in strict mode.", template_name: None, line_no: Some(1), column_no: Some(21), cause: None }) Dec 13 22:14:56.423 INFO [stderr] Dec 13 22:14:56.586 INFO [stdout] Dec 13 22:14:56.586 INFO [stdout] Dec 13 22:14:56.586 INFO [stdout] Plan to execute Dec 13 22:14:56.586 INFO [stdout] Dec 13 22:14:56.586 INFO [stdout] - mkdir "/tmp/.tmpeiZW9d/t0_actual/" Dec 13 22:14:56.586 INFO [stdout] test empty_template ... ok Dec 13 22:14:56.819 INFO [stderr] stack backtrace: Dec 13 22:14:56.819 INFO [stderr] 0: 0x564cf062b6a6 - backtrace::backtrace::libunwind::trace::h16320d45cd1f61fb Dec 13 22:14:56.819 INFO [stderr] at /cargo-home/registry/src/github.com-1ecc6299db9ec823/backtrace-0.3.9/src/backtrace/libunwind.rs:53 Dec 13 22:14:56.819 INFO [stderr] - backtrace::backtrace::trace::h2385e8ce2ad45667 Dec 13 22:14:56.819 INFO [stderr] at /cargo-home/registry/src/github.com-1ecc6299db9ec823/backtrace-0.3.9/src/backtrace/mod.rs:42 Dec 13 22:14:56.819 INFO [stderr] 1: 0x564cf0625c53 - backtrace::capture::Backtrace::new_unresolved::hd2f7a612811ec10d Dec 13 22:14:56.819 INFO [stderr] at /cargo-home/registry/src/github.com-1ecc6299db9ec823/backtrace-0.3.9/src/capture.rs:88 Dec 13 22:14:56.819 INFO [stderr] 2: 0x564cf062470f - failure::backtrace::internal::InternalBacktrace::new::h7dee82f4c68f12f3 Dec 13 22:14:56.819 INFO [stderr] at /cargo-home/registry/src/github.com-1ecc6299db9ec823/failure-0.1.3/src/backtrace/internal.rs:44 Dec 13 22:14:56.819 INFO [stderr] 3: 0x564cf0623b4c - failure::backtrace::Backtrace::new::h5a0277eb6f21ed61 Dec 13 22:14:56.819 INFO [stderr] at /cargo-home/registry/src/github.com-1ecc6299db9ec823/failure-0.1.3/src/backtrace/mod.rs:111 Dec 13 22:14:56.819 INFO [stderr] 4: 0x564cef977df9 - >::from::h47f003f075eb7f67 Dec 13 22:14:56.819 INFO [stderr] at /cargo-home/registry/src/github.com-1ecc6299db9ec823/failure-0.1.3/src/error/error_impl.rs:19 Dec 13 22:14:56.819 INFO [stderr] 5: 0x564cef923fc5 - >::from::hefad472400b21d36 Dec 13 22:14:56.819 INFO [stderr] at /cargo-home/registry/src/github.com-1ecc6299db9ec823/failure-0.1.3/src/error/mod.rs:36 Dec 13 22:14:56.819 INFO [stderr] 6: 0x564cef912eab - ffizer::execute::h825bd0157559ab72 Dec 13 22:14:56.819 INFO [stderr] at src/lib.rs:219 Dec 13 22:14:56.819 INFO [stderr] 7: 0x564cef91040f - ffizer::process::hd7063edeabd395ed Dec 13 22:14:56.819 INFO [stderr] at src/lib.rs:112 Dec 13 22:14:56.819 INFO [stderr] 8: 0x564cef813cff - ffizer::main::hc41d76e9a2c7ce1b Dec 13 22:14:56.819 INFO [stderr] at src/main.rs:40 Dec 13 22:14:56.819 INFO [stderr] 9: 0x564cef809b7f - std::rt::lang_start::{{closure}}::h74c9a1f7de668142 Dec 13 22:14:56.819 INFO [stderr] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/rt.rs:74 Dec 13 22:14:56.819 INFO [stderr] 10: 0x564cf0666302 - std::rt::lang_start_internal::{{closure}}::h470fb0d884ea2960 Dec 13 22:14:56.819 INFO [stderr] at src/libstd/rt.rs:59 Dec 13 22:14:56.819 INFO [stderr] - std::panicking::try::do_call::h7a0b92633a1e33d9 Dec 13 22:14:56.819 INFO [stderr] at src/libstd/panicking.rs:306 Dec 13 22:14:56.819 INFO [stderr] 11: 0x564cf067bcd9 - __rust_maybe_catch_panic Dec 13 22:14:56.819 INFO [stderr] at src/libpanic_unwind/lib.rs:102 Dec 13 22:14:56.819 INFO [stderr] 12: 0x564cf0666d93 - std::panicking::try::h18ac08534c65836b Dec 13 22:14:56.819 INFO [stderr] at src/libstd/panicking.rs:285 Dec 13 22:14:56.819 INFO [stderr] - std::panic::catch_unwind::hf3521d2648a83bca Dec 13 22:14:56.819 INFO [stderr] at src/libstd/panic.rs:398 Dec 13 22:14:56.819 INFO [stderr] - std::rt::lang_start_internal::h3628368e60eab2bb Dec 13 22:14:56.819 INFO [stderr] at src/libstd/rt.rs:58 Dec 13 22:14:56.819 INFO [stderr] 13: 0x564cef809b58 - std::rt::lang_start::h7d080f9fc5d4cfc4 Dec 13 22:14:56.819 INFO [stderr] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/rt.rs:74 Dec 13 22:14:56.819 INFO [stderr] 14: 0x564cef813f09 - main Dec 13 22:14:56.819 INFO [stderr] 15: 0x7feebecc682f - __libc_start_main Dec 13 22:14:56.819 INFO [stderr] 16: 0x564cef805398 - _start Dec 13 22:14:56.819 INFO [stderr] 17: 0x0 - Dec 13 22:14:56.831 INFO [stderr] Well, this is embarrassing. Dec 13 22:14:56.831 INFO [stderr] Dec 13 22:14:56.831 INFO [stderr] ffizer had a problem and crashed. To help us diagnose the problem you can send us a crash report. Dec 13 22:14:56.831 INFO [stderr] Dec 13 22:14:56.831 INFO [stderr] We have generated a report file at "/tmp/report-083085d4-2707-4c58-b965-21576e7f7ae7.toml". Submit an issue or email with the subject of "ffizer Crash Report" and include the report as an attachment. Dec 13 22:14:56.831 INFO [stderr] Dec 13 22:14:56.831 INFO [stderr] - Homepage: https://github.com/davidB/ffizer Dec 13 22:14:56.831 INFO [stderr] - Authors: David Bernard Dec 13 22:14:56.831 INFO [stderr] Dec 13 22:14:56.831 INFO [stderr] We take privacy seriously, and do not perform any automated error collection. In order to improve the software, we rely on people to submit reports. Dec 13 22:14:56.831 INFO [stderr] Dec 13 22:14:56.831 INFO [stderr] Thank you kindly! Dec 13 22:14:56.948 INFO [stdout] test test_3 ... FAILED Dec 13 22:14:56.948 INFO [stdout] test test_1 ... FAILED Dec 13 22:14:56.948 INFO [stdout] Dec 13 22:14:56.948 INFO [stdout] failures: Dec 13 22:14:56.948 INFO [stdout] Dec 13 22:14:56.948 INFO [stdout] ---- test_3 stdout ---- Dec 13 22:14:56.948 INFO [stdout] thread 'test_3' panicked at 'Unexpected failure. Dec 13 22:14:56.948 INFO [stdout] code-1 Dec 13 22:14:56.948 INFO [stdout] stderr=`````` Dec 13 22:14:56.948 INFO [stdout] command=`"/target/x86_64-unknown-linux-gnu/debug/ffizer" "--x-always_default_value" "--confirm" "never" "--destination" "/tmp/.tmp7H0tiD/test_3" "--source" "./tests/test_3/template"` Dec 13 22:14:56.948 INFO [stdout] code=1 Dec 13 22:14:56.948 INFO [stdout] stdout=`````` Dec 13 22:14:56.948 INFO [stdout] stderr=`````` Dec 13 22:14:56.948 INFO [stdout] ', /cargo-home/registry/src/github.com-1ecc6299db9ec823/assert_cmd-0.10.2/src/assert.rs:154:13 Dec 13 22:14:56.948 INFO [stdout] stack backtrace: Dec 13 22:14:56.948 INFO [stdout] 0: 0x55754ed18893 - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h2c40bdfb30f25bdd Dec 13 22:14:56.948 INFO [stdout] at src/libstd/sys/unix/backtrace/tracing/gcc_s.rs:49 Dec 13 22:14:56.948 INFO [stdout] 1: 0x55754ed12f68 - std::sys_common::backtrace::_print::he11ceebc70626ac9 Dec 13 22:14:56.948 INFO [stdout] at src/libstd/sys_common/backtrace.rs:71 Dec 13 22:14:56.948 INFO [stdout] 2: 0x55754ed17742 - std::panicking::default_hook::{{closure}}::h4fde3ffb19c01413 Dec 13 22:14:56.948 INFO [stdout] at src/libstd/sys_common/backtrace.rs:59 Dec 13 22:14:56.948 INFO [stdout] at src/libstd/panicking.rs:210 Dec 13 22:14:56.948 INFO [stdout] 3: 0x55754ed17437 - std::panicking::default_hook::hf0c15a583008ed0d Dec 13 22:14:56.948 INFO [stdout] at src/libstd/panicking.rs:218 Dec 13 22:14:56.948 INFO [stdout] 4: 0x55754ed17e50 - std::panicking::rust_panic_with_hook::hc1663f6bc7813185 Dec 13 22:14:56.948 INFO [stdout] at src/libstd/panicking.rs:487 Dec 13 22:14:56.948 INFO [stdout] 5: 0x55754ed179d1 - std::panicking::continue_panic_fmt::h42bc2d03ddf03b3e Dec 13 22:14:56.948 INFO [stdout] at src/libstd/panicking.rs:394 Dec 13 22:14:56.948 INFO [stdout] 6: 0x55754ed1791e - std::panicking::begin_panic_fmt::h2207969583fb9324 Dec 13 22:14:56.948 INFO [stdout] at src/libstd/panicking.rs:349 Dec 13 22:14:56.949 INFO [stdout] 7: 0x55754ecc5c75 - assert_cmd::assert::Assert::success::hd320e306bc440fcf Dec 13 22:14:56.949 INFO [stdout] at /cargo-home/registry/src/github.com-1ecc6299db9ec823/assert_cmd-0.10.2/src/assert.rs:154 Dec 13 22:14:56.949 INFO [stdout] 8: 0x55754ebe778a - e2e::test_3::h0f8fa5516c911db3 Dec 13 22:14:56.949 INFO [stdout] at tests/e2e.rs:107 Dec 13 22:14:56.949 INFO [stdout] 9: 0x55754ebe6d5d - e2e::test_3::{{closure}}::h6596e588ff2c20f3 Dec 13 22:14:56.949 INFO [stdout] at tests/e2e.rs:98 Dec 13 22:14:56.949 INFO [stdout] 10: 0x55754ebe99ad - core::ops::function::FnOnce::call_once::h9c415f98132e85e4 Dec 13 22:14:56.949 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libcore/ops/function.rs:238 Dec 13 22:14:56.949 INFO [stdout] 11: 0x55754ebf6aae - >::call_box::hac337ba1af72dc2b Dec 13 22:14:56.949 INFO [stdout] at src/libtest/lib.rs:1483 Dec 13 22:14:56.949 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libcore/ops/function.rs:238 Dec 13 22:14:56.949 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/liballoc/boxed.rs:673 Dec 13 22:14:56.949 INFO [stdout] 12: 0x55754ed2b779 - __rust_maybe_catch_panic Dec 13 22:14:56.949 INFO [stdout] at src/libpanic_unwind/lib.rs:102 Dec 13 22:14:56.949 INFO [stdout] 13: 0x55754ec142b7 - test::run_test::run_test_inner::{{closure}}::hfbfe4a58c0ebb01b Dec 13 22:14:56.949 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/panicking.rs:285 Dec 13 22:14:56.949 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/panic.rs:398 Dec 13 22:14:56.949 INFO [stdout] at src/libtest/lib.rs:1438 Dec 13 22:14:56.949 INFO [stdout] 14: 0x55754ebef1c4 - std::sys_common::backtrace::__rust_begin_short_backtrace::hd1f0cf202092f8d7 Dec 13 22:14:56.949 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/sys_common/backtrace.rs:136 Dec 13 22:14:56.949 INFO [stdout] 15: 0x55754ebef7b4 - std::panicking::try::do_call::h5e99f92fbf448cf6 Dec 13 22:14:56.949 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/thread/mod.rs:479 Dec 13 22:14:56.949 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/panic.rs:319 Dec 13 22:14:56.949 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/panicking.rs:306 Dec 13 22:14:56.949 INFO [stdout] 16: 0x55754ed2b779 - __rust_maybe_catch_panic Dec 13 22:14:56.949 INFO [stdout] at src/libpanic_unwind/lib.rs:102 Dec 13 22:14:56.949 INFO [stdout] 17: 0x55754ebf698c - >::call_box::h8ae063aff93ccdb6 Dec 13 22:14:56.949 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/panicking.rs:285 Dec 13 22:14:56.949 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/panic.rs:398 Dec 13 22:14:56.949 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/thread/mod.rs:478 Dec 13 22:14:56.949 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/liballoc/boxed.rs:673 Dec 13 22:14:56.949 INFO [stdout] 18: 0x55754ed1f73d - std::sys::unix::thread::Thread::new::thread_start::h42c32b292fdd228f Dec 13 22:14:56.949 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/liballoc/boxed.rs:683 Dec 13 22:14:56.949 INFO [stdout] at src/libstd/sys_common/thread.rs:24 Dec 13 22:14:56.949 INFO [stdout] at src/libstd/sys/unix/thread.rs:91 Dec 13 22:14:56.949 INFO [stdout] 19: 0x7f7d7cbd06b9 - start_thread Dec 13 22:14:56.949 INFO [stdout] 20: 0x7f7d7d0f141c - clone Dec 13 22:14:56.949 INFO [stdout] 21: 0x0 - Dec 13 22:14:56.949 INFO [stdout] Dec 13 22:14:56.949 INFO [stdout] ---- test_1 stdout ---- Dec 13 22:14:56.949 INFO [stdout] thread 'test_1' panicked at 'Unexpected failure. Dec 13 22:14:56.949 INFO [stdout] code-101 Dec 13 22:14:56.949 INFO [stdout] stderr=`````` Dec 13 22:14:56.949 INFO [stdout] command=`"/target/x86_64-unknown-linux-gnu/debug/ffizer" "--x-always_default_value" "--confirm" "never" "--destination" "/tmp/.tmpZv0Y1d" "--source" "./tests/test_1/template"` Dec 13 22:14:56.949 INFO [stdout] code=101 Dec 13 22:14:56.949 INFO [stdout] stdout=`````` Dec 13 22:14:56.949 INFO [stdout] stderr=`````` Dec 13 22:14:56.949 INFO [stdout] ', /cargo-home/registry/src/github.com-1ecc6299db9ec823/assert_cmd-0.10.2/src/assert.rs:154:13 Dec 13 22:14:56.949 INFO [stdout] stack backtrace: Dec 13 22:14:56.949 INFO [stdout] 0: 0x55754ed18893 - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h2c40bdfb30f25bdd Dec 13 22:14:56.949 INFO [stdout] at src/libstd/sys/unix/backtrace/tracing/gcc_s.rs:49 Dec 13 22:14:56.949 INFO [stdout] 1: 0x55754ed12f68 - std::sys_common::backtrace::_print::he11ceebc70626ac9 Dec 13 22:14:56.949 INFO [stdout] at src/libstd/sys_common/backtrace.rs:71 Dec 13 22:14:56.949 INFO [stdout] 2: 0x55754ed17742 - std::panicking::default_hook::{{closure}}::h4fde3ffb19c01413 Dec 13 22:14:56.949 INFO [stdout] at src/libstd/sys_common/backtrace.rs:59 Dec 13 22:14:56.949 INFO [stdout] at src/libstd/panicking.rs:210 Dec 13 22:14:56.949 INFO [stdout] 3: 0x55754ed17437 - std::panicking::default_hook::hf0c15a583008ed0d Dec 13 22:14:56.949 INFO [stdout] at src/libstd/panicking.rs:218 Dec 13 22:14:56.949 INFO [stdout] 4: 0x55754ed17e50 - std::panicking::rust_panic_with_hook::hc1663f6bc7813185 Dec 13 22:14:56.949 INFO [stdout] at src/libstd/panicking.rs:487 Dec 13 22:14:56.949 INFO [stdout] 5: 0x55754ed179d1 - std::panicking::continue_panic_fmt::h42bc2d03ddf03b3e Dec 13 22:14:56.949 INFO [stdout] at src/libstd/panicking.rs:394 Dec 13 22:14:56.949 INFO [stdout] 6: 0x55754ed1791e - std::panicking::begin_panic_fmt::h2207969583fb9324 Dec 13 22:14:56.949 INFO [stdout] at src/libstd/panicking.rs:349 Dec 13 22:14:56.949 INFO [stdout] 7: 0x55754ecc5c75 - assert_cmd::assert::Assert::success::hd320e306bc440fcf Dec 13 22:14:56.949 INFO [stdout] at /cargo-home/registry/src/github.com-1ecc6299db9ec823/assert_cmd-0.10.2/src/assert.rs:154 Dec 13 22:14:56.949 INFO [stdout] 8: 0x55754ebe6926 - e2e::test_1::h7fb8b433dd0dfee2 Dec 13 22:14:56.949 INFO [stdout] at tests/e2e.rs:52 Dec 13 22:14:56.949 INFO [stdout] 9: 0x55754ebe5f6d - e2e::test_1::{{closure}}::h4c3e8a94446e07c3 Dec 13 22:14:56.949 INFO [stdout] at tests/e2e.rs:43 Dec 13 22:14:56.949 INFO [stdout] 10: 0x55754ebe99ed - core::ops::function::FnOnce::call_once::hc4cd8d41deebc743 Dec 13 22:14:56.949 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libcore/ops/function.rs:238 Dec 13 22:14:56.949 INFO [stdout] 11: 0x55754ebf6aae - >::call_box::hac337ba1af72dc2b Dec 13 22:14:56.949 INFO [stdout] at src/libtest/lib.rs:1483 Dec 13 22:14:56.949 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libcore/ops/function.rs:238 Dec 13 22:14:56.949 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/liballoc/boxed.rs:673 Dec 13 22:14:56.949 INFO [stdout] 12: 0x55754ed2b779 - __rust_maybe_catch_panic Dec 13 22:14:56.949 INFO [stdout] at src/libpanic_unwind/lib.rs:102 Dec 13 22:14:56.949 INFO [stdout] 13: 0x55754ec142b7 - test::run_test::run_test_inner::{{closure}}::hfbfe4a58c0ebb01b Dec 13 22:14:56.949 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/panicking.rs:285 Dec 13 22:14:56.949 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/panic.rs:398 Dec 13 22:14:56.949 INFO [stdout] at src/libtest/lib.rs:1438 Dec 13 22:14:56.949 INFO [stdout] 14: 0x55754ebef1c4 - std::sys_common::backtrace::__rust_begin_short_backtrace::hd1f0cf202092f8d7 Dec 13 22:14:56.949 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/sys_common/backtrace.rs:136 Dec 13 22:14:56.950 INFO [stdout] 15: 0x55754ebef7b4 - std::panicking::try::do_call::h5e99f92fbf448cf6 Dec 13 22:14:56.950 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/thread/mod.rs:479 Dec 13 22:14:56.950 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/panic.rs:319 Dec 13 22:14:56.950 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/panicking.rs:306 Dec 13 22:14:56.950 INFO [stdout] 16: 0x55754ed2b779 - __rust_maybe_catch_panic Dec 13 22:14:56.950 INFO [stdout] at src/libpanic_unwind/lib.rs:102 Dec 13 22:14:56.950 INFO [stdout] 17: 0x55754ebf698c - >::call_box::h8ae063aff93ccdb6 Dec 13 22:14:56.950 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/panicking.rs:285 Dec 13 22:14:56.950 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/panic.rs:398 Dec 13 22:14:56.950 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/thread/mod.rs:478 Dec 13 22:14:56.950 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/liballoc/boxed.rs:673 Dec 13 22:14:56.950 INFO [stdout] 18: 0x55754ed1f73d - std::sys::unix::thread::Thread::new::thread_start::h42c32b292fdd228f Dec 13 22:14:56.950 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/liballoc/boxed.rs:683 Dec 13 22:14:56.950 INFO [stdout] at src/libstd/sys_common/thread.rs:24 Dec 13 22:14:56.950 INFO [stdout] at src/libstd/sys/unix/thread.rs:91 Dec 13 22:14:56.950 INFO [stdout] 19: 0x7f7d7cbd06b9 - start_thread Dec 13 22:14:56.950 INFO [stdout] 20: 0x7f7d7d0f141c - clone Dec 13 22:14:56.950 INFO [stdout] 21: 0x0 - Dec 13 22:14:56.950 INFO [stdout] Dec 13 22:14:56.950 INFO [stdout] Dec 13 22:14:56.950 INFO [stdout] failures: Dec 13 22:14:56.950 INFO [stdout] test_1 Dec 13 22:14:56.950 INFO [stdout] test_3 Dec 13 22:14:56.950 INFO [stdout] Dec 13 22:14:56.950 INFO [stdout] test result: FAILED. 2 passed; 2 failed; 0 ignored; 0 measured; 0 filtered out Dec 13 22:14:56.950 INFO [stdout] Dec 13 22:14:56.998 INFO [stderr] error: test failed, to rerun pass '--test e2e' Dec 13 22:14:57.003 INFO [stderr] su: No module specific data is present Dec 13 22:14:57.544 INFO running `"docker" "inspect" "d8366fa8b3120eedd8bdc72e3e2ba24f4be316bf769acbc4568907de7a6b7d38"` Dec 13 22:14:57.810 INFO running `"docker" "rm" "-f" "d8366fa8b3120eedd8bdc72e3e2ba24f4be316bf769acbc4568907de7a6b7d38"` Dec 13 22:14:58.117 INFO [stdout] d8366fa8b3120eedd8bdc72e3e2ba24f4be316bf769acbc4568907de7a6b7d38