Dec 13 22:06:31.722 INFO testing davidB/ffizer against master#bd47d6825bf4090517549d33cfef10d3300b4a75 for pr-56550 Dec 13 22:06:31.722 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-6/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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:32.234 INFO [stdout] ac6f9cfea3113f7e6a77498df13172590c04a492a71be99e1fa8cf9500a222f1 Dec 13 22:06:32.237 INFO running `"docker" "start" "-a" "ac6f9cfea3113f7e6a77498df13172590c04a492a71be99e1fa8cf9500a222f1"` Dec 13 22:06:34.671 INFO [stderr] usermod: no changes Dec 13 22:06:35.415 INFO [stderr] Compiling serde v1.0.82 Dec 13 22:06:35.415 INFO [stderr] Compiling slog v2.4.1 Dec 13 22:06:35.431 INFO [stderr] Compiling clicolors-control v0.3.1 Dec 13 22:06:35.432 INFO [stderr] Compiling directories v1.0.2 Dec 13 22:06:35.432 INFO [stderr] Compiling libz-sys v1.0.25 Dec 13 22:06:35.439 INFO [stderr] Compiling number_prefix v0.2.8 Dec 13 22:06:35.441 INFO [stderr] Compiling uuid v0.6.5 Dec 13 22:06:35.463 INFO [stderr] Compiling chrono v0.4.6 Dec 13 22:06:38.161 INFO [stderr] Compiling tempfile v2.2.0 Dec 13 22:06:42.028 INFO [stderr] Compiling serde_derive v1.0.82 Dec 13 22:06:42.040 INFO [stderr] Compiling libssh2-sys v0.2.11 Dec 13 22:06:42.041 INFO [stderr] Compiling curl-sys v0.4.15 Dec 13 22:06:42.197 INFO [stderr] Compiling os_type v2.2.0 Dec 13 22:06:42.312 INFO [stderr] Compiling Inflector v0.11.3 Dec 13 22:06:42.344 INFO [stderr] Compiling globset v0.4.2 Dec 13 22:06:45.636 INFO [stderr] Compiling console v0.7.1 Dec 13 22:06:45.752 INFO [stderr] Compiling libgit2-sys v0.7.10 Dec 13 22:06:54.467 INFO [stderr] Compiling slog-async v2.3.0 Dec 13 22:06:54.471 INFO [stderr] Compiling git2 v0.7.5 Dec 13 22:06:54.768 INFO [stderr] Compiling slog-term v2.4.0 Dec 13 22:07:03.911 INFO [stderr] Compiling dialoguer v0.3.0 Dec 13 22:07:03.911 INFO [stderr] Compiling indicatif v0.10.3 Dec 13 22:07:40.479 INFO [stderr] Compiling serde_json v1.0.33 Dec 13 22:07:40.479 INFO [stderr] Compiling toml v0.4.10 Dec 13 22:07:40.479 INFO [stderr] Compiling serde_urlencoded v0.5.4 Dec 13 22:07:40.483 INFO [stderr] Compiling serde_yaml v0.8.8 Dec 13 22:07:50.416 INFO [stderr] Compiling reqwest v0.9.5 Dec 13 22:07:50.487 INFO [stderr] Compiling handlebars v1.1.0 Dec 13 22:07:50.904 INFO [stderr] Compiling human-panic v1.0.1 Dec 13 22:08:05.838 INFO [stderr] Compiling ffizer v0.8.0 (/source) Dec 13 22:08:31.169 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 1m 56s Dec 13 22:08:31.203 INFO [stderr] su: No module specific data is present Dec 13 22:08:32.820 INFO running `"docker" "inspect" "ac6f9cfea3113f7e6a77498df13172590c04a492a71be99e1fa8cf9500a222f1"` Dec 13 22:08:33.268 INFO running `"docker" "rm" "-f" "ac6f9cfea3113f7e6a77498df13172590c04a492a71be99e1fa8cf9500a222f1"` Dec 13 22:08:33.666 INFO [stdout] ac6f9cfea3113f7e6a77498df13172590c04a492a71be99e1fa8cf9500a222f1 Dec 13 22:08:33.673 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-6/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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:34.316 INFO [stdout] 2cb9ad97a0b725790fafe1831cf2e9674f2448a0efa5ad6c16b8250c0c07f304 Dec 13 22:08:34.319 INFO running `"docker" "start" "-a" "2cb9ad97a0b725790fafe1831cf2e9674f2448a0efa5ad6c16b8250c0c07f304"` Dec 13 22:08:35.815 INFO [stderr] usermod: no changes Dec 13 22:08:36.345 INFO [stderr] Compiling predicates-core v1.0.0 Dec 13 22:08:36.451 INFO [stderr] Compiling num-bigint v0.1.44 Dec 13 22:08:36.459 INFO [stderr] Compiling escargot v0.3.1 Dec 13 22:08:37.803 INFO [stderr] Compiling predicates v1.0.0 Dec 13 22:08:37.803 INFO [stderr] Compiling predicates-tree v1.0.0 Dec 13 22:08:41.183 INFO [stderr] Compiling assert_cmd v0.10.2 Dec 13 22:08:42.738 INFO [stderr] Compiling num-rational v0.1.42 Dec 13 22:08:45.228 INFO [stderr] Compiling num v0.1.42 Dec 13 22:08:45.675 INFO [stderr] Compiling spectral v0.6.0 Dec 13 22:08:47.015 INFO [stderr] Compiling ffizer v0.8.0 (/source) Dec 13 22:09:13.556 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 37.70s Dec 13 22:09:13.585 INFO [stderr] su: No module specific data is present Dec 13 22:09:14.550 INFO running `"docker" "inspect" "2cb9ad97a0b725790fafe1831cf2e9674f2448a0efa5ad6c16b8250c0c07f304"` Dec 13 22:09:14.875 INFO running `"docker" "rm" "-f" "2cb9ad97a0b725790fafe1831cf2e9674f2448a0efa5ad6c16b8250c0c07f304"` Dec 13 22:09:15.287 INFO [stdout] 2cb9ad97a0b725790fafe1831cf2e9674f2448a0efa5ad6c16b8250c0c07f304 Dec 13 22:09:15.293 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-6/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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:09:15.713 INFO [stdout] f7ab26fc45d5f18dbd5fc95a6353b9764eae08ad8bbbdcd5db0602651767f4a9 Dec 13 22:09:15.719 INFO running `"docker" "start" "-a" "f7ab26fc45d5f18dbd5fc95a6353b9764eae08ad8bbbdcd5db0602651767f4a9"` Dec 13 22:09:17.386 INFO [stderr] usermod: no changes Dec 13 22:09:17.895 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 0.48s Dec 13 22:09:17.907 INFO [stderr] Running /target/debug/deps/ffizer-9f17e13cef08177c Dec 13 22:09:17.976 INFO [stdout] Dec 13 22:09:17.976 INFO [stdout] running 13 tests Dec 13 22:09:18.007 INFO [stdout] test tests::test_cmp_path_for_plan ... ok Dec 13 22:09:18.007 INFO [stdout] test tests::test_compute_dst_path_asis ... ok Dec 13 22:09:18.047 INFO [stdout] test tests::test_compute_dst_path_rendered_filename ... ok Dec 13 22:09:18.067 INFO [stdout] test hbs::tests::test_register_path_helpers ... ok Dec 13 22:09:18.087 INFO [stdout] test template_cfg::tests::test_deserialize_cfg_yaml ... ok Dec 13 22:09:18.087 INFO [stdout] test tests::test_is_ffizer_handlebars ... ok Dec 13 22:09:18.095 INFO [stdout] test tests::test_path_extension_extraction ... ok Dec 13 22:09:18.101 INFO [stdout] test template_cfg::tests::test_transforms_values ... ok Dec 13 22:09:18.102 INFO [stdout] test tests::test_compute_dst_path_ffizer_handlebars ... ok Dec 13 22:09:18.102 INFO [stdout] test tests::test_compute_dst_path_rendered_folder ... ok Dec 13 22:09:18.111 INFO [stdout] test source_uri::tests::test_source_uri_from_str ... ok Dec 13 22:09:18.251 INFO [stdout] test hbs::tests::test_chain_of_helpers_with_1_param ... ok Dec 13 22:09:18.472 INFO [stdout] test hbs::tests::test_register_string_helpers ... ok Dec 13 22:09:18.472 INFO [stdout] Dec 13 22:09:18.472 INFO [stdout] test result: ok. 13 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 13 22:09:18.472 INFO [stdout] Dec 13 22:09:18.475 INFO [stderr] Running /target/debug/deps/ffizer-7f66b8f97ad26da0 Dec 13 22:09:18.478 INFO [stdout] Dec 13 22:09:18.478 INFO [stdout] running 0 tests Dec 13 22:09:18.479 INFO [stdout] Dec 13 22:09:18.479 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 13 22:09:18.479 INFO [stdout] Dec 13 22:09:18.479 INFO [stderr] Running /target/debug/deps/dir_diff-3228bf9606cca18e Dec 13 22:09:18.487 INFO [stdout] Dec 13 22:09:18.487 INFO [stdout] running 0 tests Dec 13 22:09:18.487 INFO [stdout] Dec 13 22:09:18.487 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 13 22:09:18.487 INFO [stdout] Dec 13 22:09:18.487 INFO [stderr] Running /target/debug/deps/e2e-193bf9cf9e41ccca Dec 13 22:09:18.491 INFO [stdout] Dec 13 22:09:18.491 INFO [stdout] running 4 tests Dec 13 22:10:18.499 INFO [stdout] test test_1_subfolder ... test test_1_subfolder has been running for over 60 seconds Dec 13 22:10:18.499 INFO [stdout] test test_3 ... test test_3 has been running for over 60 seconds Dec 13 22:10:18.499 INFO [stdout] test empty_template ... test empty_template has been running for over 60 seconds Dec 13 22:10:18.499 INFO [stdout] test test_1 ... test test_1 has been running for over 60 seconds Dec 13 22:15:15.663 INFO [stdout] Dec 13 22:15:15.663 INFO [stdout] Dec 13 22:15:15.663 INFO [stdout] Plan to execute Dec 13 22:15:15.663 INFO [stdout] Dec 13 22:15:15.663 INFO [stdout] - mkdir "/tmp/.tmpIyDjz8/test_3/" Dec 13 22:15:15.663 INFO [stdout] - copyrender "/tmp/.tmpIyDjz8/test_3/file1.txt" Dec 13 22:15:15.674 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:15:15.674 INFO [stderr] Dec 13 22:15:16.120 INFO [stdout] Dec 13 22:15:16.120 INFO [stdout] Dec 13 22:15:16.120 INFO [stdout] Plan to execute Dec 13 22:15:16.120 INFO [stdout] Dec 13 22:15:16.120 INFO [stdout] - keep "/tmp/.tmpeCRG4d/" Dec 13 22:15:16.120 INFO [stdout] - copyraw "/tmp/.tmpeCRG4d/file_1_1.txt" Dec 13 22:15:16.120 INFO [stdout] test test_1_subfolder ... ok Dec 13 22:15:16.120 INFO [stderr] stack backtrace: Dec 13 22:15:16.120 INFO [stderr] 0: 0x5598144cd776 - backtrace::backtrace::libunwind::trace::hb2444f65ecd596dc Dec 13 22:15:16.120 INFO [stderr] at /cargo-home/registry/src/github.com-1ecc6299db9ec823/backtrace-0.3.9/src/backtrace/libunwind.rs:53 Dec 13 22:15:16.120 INFO [stderr] - backtrace::backtrace::trace::hf7f91d67d2f28d68 Dec 13 22:15:16.120 INFO [stderr] at /cargo-home/registry/src/github.com-1ecc6299db9ec823/backtrace-0.3.9/src/backtrace/mod.rs:42 Dec 13 22:15:16.120 INFO [stderr] 1: 0x5598144c7d23 - backtrace::capture::Backtrace::new_unresolved::h807df08100610675 Dec 13 22:15:16.120 INFO [stderr] at /cargo-home/registry/src/github.com-1ecc6299db9ec823/backtrace-0.3.9/src/capture.rs:88 Dec 13 22:15:16.120 INFO [stderr] 2: 0x5598144c67df - failure::backtrace::internal::InternalBacktrace::new::h9bd7e47be406297f Dec 13 22:15:16.120 INFO [stderr] at /cargo-home/registry/src/github.com-1ecc6299db9ec823/failure-0.1.3/src/backtrace/internal.rs:44 Dec 13 22:15:16.120 INFO [stderr] 3: 0x5598144c5c1c - failure::backtrace::Backtrace::new::h94e91ead04d30e01 Dec 13 22:15:16.120 INFO [stderr] at /cargo-home/registry/src/github.com-1ecc6299db9ec823/failure-0.1.3/src/backtrace/mod.rs:111 Dec 13 22:15:16.120 INFO [stderr] 4: 0x559813813cf9 - >::from::h3274b3780cf29cba Dec 13 22:15:16.120 INFO [stderr] at /cargo-home/registry/src/github.com-1ecc6299db9ec823/failure-0.1.3/src/error/error_impl.rs:19 Dec 13 22:15:16.120 INFO [stderr] 5: 0x5598137bfce5 - >::from::h45592abc5574d2d3 Dec 13 22:15:16.120 INFO [stderr] at /cargo-home/registry/src/github.com-1ecc6299db9ec823/failure-0.1.3/src/error/mod.rs:36 Dec 13 22:15:16.120 INFO [stderr] 6: 0x5598137aec4b - ffizer::execute::h29cfe2df182a4088 Dec 13 22:15:16.120 INFO [stderr] at src/lib.rs:219 Dec 13 22:15:16.120 INFO [stderr] 7: 0x5598137ac1af - ffizer::process::h769c1fdc20aeb34c Dec 13 22:15:16.120 INFO [stderr] at src/lib.rs:112 Dec 13 22:15:16.120 INFO [stderr] 8: 0x5598136ae76f - ffizer::main::h155fe5b57b44b561 Dec 13 22:15:16.120 INFO [stderr] at src/main.rs:40 Dec 13 22:15:16.120 INFO [stderr] 9: 0x5598136a45ef - std::rt::lang_start::{{closure}}::h6e983ba20a99e20a Dec 13 22:15:16.120 INFO [stderr] at /rustc/bd47d6825bf4090517549d33cfef10d3300b4a75/src/libstd/rt.rs:74 Dec 13 22:15:16.120 INFO [stderr] 10: 0x5598145083d2 - std::rt::lang_start_internal::{{closure}}::h5e542ccbf7ce49bf Dec 13 22:15:16.120 INFO [stderr] at src/libstd/rt.rs:59 Dec 13 22:15:16.120 INFO [stderr] - std::panicking::try::do_call::hd22385b9fba3aa8f Dec 13 22:15:16.120 INFO [stderr] at src/libstd/panicking.rs:306 Dec 13 22:15:16.120 INFO [stderr] 11: 0x55981451dda9 - __rust_maybe_catch_panic Dec 13 22:15:16.120 INFO [stderr] at src/libpanic_unwind/lib.rs:102 Dec 13 22:15:16.120 INFO [stderr] 12: 0x559814508e63 - std::panicking::try::h74178fa759266f9d Dec 13 22:15:16.120 INFO [stderr] at src/libstd/panicking.rs:285 Dec 13 22:15:16.120 INFO [stderr] - std::panic::catch_unwind::h4e0a1c67235b2793 Dec 13 22:15:16.120 INFO [stderr] at src/libstd/panic.rs:398 Dec 13 22:15:16.120 INFO [stderr] - std::rt::lang_start_internal::h884c76ddf53aa8b4 Dec 13 22:15:16.121 INFO [stderr] at src/libstd/rt.rs:58 Dec 13 22:15:16.121 INFO [stderr] 13: 0x5598136a45c8 - std::rt::lang_start::hc44162abd2908d55 Dec 13 22:15:16.121 INFO [stderr] at /rustc/bd47d6825bf4090517549d33cfef10d3300b4a75/src/libstd/rt.rs:74 Dec 13 22:15:16.121 INFO [stderr] 14: 0x5598136ae979 - main Dec 13 22:15:16.121 INFO [stderr] 15: 0x7f495c35f82f - __libc_start_main Dec 13 22:15:16.121 INFO [stderr] 16: 0x55981369fe08 - _start Dec 13 22:15:16.121 INFO [stderr] 17: 0x0 - Dec 13 22:15:16.227 INFO [stdout] test test_3 ... FAILED Dec 13 22:15:16.402 INFO [stdout] Dec 13 22:15:16.402 INFO [stdout] Dec 13 22:15:16.402 INFO [stdout] Plan to execute Dec 13 22:15:16.402 INFO [stdout] Dec 13 22:15:16.402 INFO [stdout] - mkdir "/tmp/.tmpFFaUIt/t0_actual/" Dec 13 22:15:16.402 INFO [stdout] test empty_template ... ok Dec 13 22:15:17.019 INFO [stderr] Well, this is embarrassing. Dec 13 22:15:17.019 INFO [stderr] Dec 13 22:15:17.019 INFO [stderr] ffizer had a problem and crashed. To help us diagnose the problem you can send us a crash report. Dec 13 22:15:17.019 INFO [stderr] Dec 13 22:15:17.019 INFO [stderr] We have generated a report file at "/tmp/report-064bbe6b-1831-4aae-a9d0-1e0377b571be.toml". Submit an issue or email with the subject of "ffizer Crash Report" and include the report as an attachment. Dec 13 22:15:17.019 INFO [stderr] Dec 13 22:15:17.019 INFO [stderr] - Homepage: https://github.com/davidB/ffizer Dec 13 22:15:17.019 INFO [stderr] - Authors: David Bernard Dec 13 22:15:17.019 INFO [stderr] Dec 13 22:15:17.019 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:15:17.019 INFO [stderr] Dec 13 22:15:17.019 INFO [stderr] Thank you kindly! Dec 13 22:15:17.031 INFO [stdout] test test_1 ... FAILED Dec 13 22:15:17.031 INFO [stdout] Dec 13 22:15:17.031 INFO [stdout] failures: Dec 13 22:15:17.031 INFO [stdout] Dec 13 22:15:17.031 INFO [stdout] ---- test_3 stdout ---- Dec 13 22:15:17.031 INFO [stdout] thread 'test_3' panicked at 'Unexpected failure. Dec 13 22:15:17.031 INFO [stdout] code-1 Dec 13 22:15:17.031 INFO [stdout] stderr=`````` Dec 13 22:15:17.031 INFO [stdout] command=`"/target/x86_64-unknown-linux-gnu/debug/ffizer" "--x-always_default_value" "--confirm" "never" "--destination" "/tmp/.tmpIyDjz8/test_3" "--source" "./tests/test_3/template"` Dec 13 22:15:17.031 INFO [stdout] code=1 Dec 13 22:15:17.031 INFO [stdout] stdout=`````` Dec 13 22:15:17.031 INFO [stdout] stderr=`````` Dec 13 22:15:17.031 INFO [stdout] ', /cargo-home/registry/src/github.com-1ecc6299db9ec823/assert_cmd-0.10.2/src/assert.rs:154:13 Dec 13 22:15:17.031 INFO [stdout] stack backtrace: Dec 13 22:15:17.031 INFO [stdout] 0: 0x563f13083913 - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::heb4d4d98bcf46d90 Dec 13 22:15:17.031 INFO [stdout] at src/libstd/sys/unix/backtrace/tracing/gcc_s.rs:49 Dec 13 22:15:17.031 INFO [stdout] 1: 0x563f1307dfe8 - std::sys_common::backtrace::_print::h919420b22c2473e3 Dec 13 22:15:17.031 INFO [stdout] at src/libstd/sys_common/backtrace.rs:71 Dec 13 22:15:17.031 INFO [stdout] 2: 0x563f130827c2 - std::panicking::default_hook::{{closure}}::h22d4ac021acb88d5 Dec 13 22:15:17.031 INFO [stdout] at src/libstd/sys_common/backtrace.rs:59 Dec 13 22:15:17.031 INFO [stdout] at src/libstd/panicking.rs:210 Dec 13 22:15:17.032 INFO [stdout] 3: 0x563f130824b7 - std::panicking::default_hook::h1134a4d34aab4428 Dec 13 22:15:17.032 INFO [stdout] at src/libstd/panicking.rs:218 Dec 13 22:15:17.032 INFO [stdout] 4: 0x563f13082ed0 - std::panicking::rust_panic_with_hook::h9c89557c251f2d42 Dec 13 22:15:17.032 INFO [stdout] at src/libstd/panicking.rs:487 Dec 13 22:15:17.032 INFO [stdout] 5: 0x563f13082a51 - std::panicking::continue_panic_fmt::h6b63497ce98499d4 Dec 13 22:15:17.032 INFO [stdout] at src/libstd/panicking.rs:394 Dec 13 22:15:17.032 INFO [stdout] 6: 0x563f1308299e - std::panicking::begin_panic_fmt::h33c12d7eb9e26fea Dec 13 22:15:17.032 INFO [stdout] at src/libstd/panicking.rs:349 Dec 13 22:15:17.032 INFO [stdout] 7: 0x563f13030d35 - assert_cmd::assert::Assert::success::hbd5f8a3d36701366 Dec 13 22:15:17.032 INFO [stdout] at /cargo-home/registry/src/github.com-1ecc6299db9ec823/assert_cmd-0.10.2/src/assert.rs:154 Dec 13 22:15:17.032 INFO [stdout] 8: 0x563f12f4e92a - e2e::test_3::h2baac44285e3351f Dec 13 22:15:17.032 INFO [stdout] at tests/e2e.rs:107 Dec 13 22:15:17.032 INFO [stdout] 9: 0x563f12f4defd - e2e::test_3::{{closure}}::h2740ce74f3686c3c Dec 13 22:15:17.032 INFO [stdout] at tests/e2e.rs:98 Dec 13 22:15:17.032 INFO [stdout] 10: 0x563f12f50bdd - core::ops::function::FnOnce::call_once::hc21cbf35d95649a9 Dec 13 22:15:17.032 INFO [stdout] at /rustc/bd47d6825bf4090517549d33cfef10d3300b4a75/src/libcore/ops/function.rs:238 Dec 13 22:15:17.032 INFO [stdout] 11: 0x563f12f5daae - >::call_box::h3cf534772c089f15 Dec 13 22:15:17.032 INFO [stdout] at src/libtest/lib.rs:1483 Dec 13 22:15:17.032 INFO [stdout] at /rustc/bd47d6825bf4090517549d33cfef10d3300b4a75/src/libcore/ops/function.rs:238 Dec 13 22:15:17.032 INFO [stdout] at /rustc/bd47d6825bf4090517549d33cfef10d3300b4a75/src/liballoc/boxed.rs:673 Dec 13 22:15:17.032 INFO [stdout] 12: 0x563f130967f9 - __rust_maybe_catch_panic Dec 13 22:15:17.032 INFO [stdout] at src/libpanic_unwind/lib.rs:102 Dec 13 22:15:17.032 INFO [stdout] 13: 0x563f12f7b457 - test::run_test::run_test_inner::{{closure}}::h5f14673685eef7c8 Dec 13 22:15:17.032 INFO [stdout] at /rustc/bd47d6825bf4090517549d33cfef10d3300b4a75/src/libstd/panicking.rs:285 Dec 13 22:15:17.032 INFO [stdout] at /rustc/bd47d6825bf4090517549d33cfef10d3300b4a75/src/libstd/panic.rs:398 Dec 13 22:15:17.032 INFO [stdout] at src/libtest/lib.rs:1438 Dec 13 22:15:17.032 INFO [stdout] 14: 0x563f12f56364 - std::sys_common::backtrace::__rust_begin_short_backtrace::h96de92a7d062bb5f Dec 13 22:15:17.032 INFO [stdout] at /rustc/bd47d6825bf4090517549d33cfef10d3300b4a75/src/libstd/sys_common/backtrace.rs:136 Dec 13 22:15:17.032 INFO [stdout] 15: 0x563f12f569d4 - std::panicking::try::do_call::h6a71e68ea4ad0d8a Dec 13 22:15:17.032 INFO [stdout] at /rustc/bd47d6825bf4090517549d33cfef10d3300b4a75/src/libstd/thread/mod.rs:479 Dec 13 22:15:17.032 INFO [stdout] at /rustc/bd47d6825bf4090517549d33cfef10d3300b4a75/src/libstd/panic.rs:319 Dec 13 22:15:17.032 INFO [stdout] at /rustc/bd47d6825bf4090517549d33cfef10d3300b4a75/src/libstd/panicking.rs:306 Dec 13 22:15:17.032 INFO [stdout] 16: 0x563f130967f9 - __rust_maybe_catch_panic Dec 13 22:15:17.032 INFO [stdout] at src/libpanic_unwind/lib.rs:102 Dec 13 22:15:17.032 INFO [stdout] 17: 0x563f12f5d98c - >::call_box::h260fd1ad8e2854a6 Dec 13 22:15:17.032 INFO [stdout] at /rustc/bd47d6825bf4090517549d33cfef10d3300b4a75/src/libstd/panicking.rs:285 Dec 13 22:15:17.032 INFO [stdout] at /rustc/bd47d6825bf4090517549d33cfef10d3300b4a75/src/libstd/panic.rs:398 Dec 13 22:15:17.032 INFO [stdout] at /rustc/bd47d6825bf4090517549d33cfef10d3300b4a75/src/libstd/thread/mod.rs:478 Dec 13 22:15:17.032 INFO [stdout] at /rustc/bd47d6825bf4090517549d33cfef10d3300b4a75/src/liballoc/boxed.rs:673 Dec 13 22:15:17.032 INFO [stdout] 18: 0x563f1308a7bd - std::sys::unix::thread::Thread::new::thread_start::h08aa646226e66c99 Dec 13 22:15:17.032 INFO [stdout] at /rustc/bd47d6825bf4090517549d33cfef10d3300b4a75/src/liballoc/boxed.rs:683 Dec 13 22:15:17.032 INFO [stdout] at src/libstd/sys_common/thread.rs:24 Dec 13 22:15:17.032 INFO [stdout] at src/libstd/sys/unix/thread.rs:91 Dec 13 22:15:17.032 INFO [stdout] 19: 0x7ffa65ad66b9 - start_thread Dec 13 22:15:17.032 INFO [stdout] 20: 0x7ffa65ff741c - clone Dec 13 22:15:17.032 INFO [stdout] 21: 0x0 - Dec 13 22:15:17.032 INFO [stdout] Dec 13 22:15:17.032 INFO [stdout] ---- test_1 stdout ---- Dec 13 22:15:17.032 INFO [stdout] thread 'test_1' panicked at 'Unexpected failure. Dec 13 22:15:17.032 INFO [stdout] code-101 Dec 13 22:15:17.032 INFO [stdout] stderr=`````` Dec 13 22:15:17.032 INFO [stdout] command=`"/target/x86_64-unknown-linux-gnu/debug/ffizer" "--x-always_default_value" "--confirm" "never" "--destination" "/tmp/.tmpf1chYw" "--source" "./tests/test_1/template"` Dec 13 22:15:17.032 INFO [stdout] code=101 Dec 13 22:15:17.032 INFO [stdout] stdout=`````` Dec 13 22:15:17.032 INFO [stdout] stderr=`````` Dec 13 22:15:17.032 INFO [stdout] ', /cargo-home/registry/src/github.com-1ecc6299db9ec823/assert_cmd-0.10.2/src/assert.rs:154:13 Dec 13 22:15:17.032 INFO [stdout] stack backtrace: Dec 13 22:15:17.032 INFO [stdout] 0: 0x563f13083913 - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::heb4d4d98bcf46d90 Dec 13 22:15:17.032 INFO [stdout] at src/libstd/sys/unix/backtrace/tracing/gcc_s.rs:49 Dec 13 22:15:17.032 INFO [stdout] 1: 0x563f1307dfe8 - std::sys_common::backtrace::_print::h919420b22c2473e3 Dec 13 22:15:17.032 INFO [stdout] at src/libstd/sys_common/backtrace.rs:71 Dec 13 22:15:17.032 INFO [stdout] 2: 0x563f130827c2 - std::panicking::default_hook::{{closure}}::h22d4ac021acb88d5 Dec 13 22:15:17.032 INFO [stdout] at src/libstd/sys_common/backtrace.rs:59 Dec 13 22:15:17.032 INFO [stdout] at src/libstd/panicking.rs:210 Dec 13 22:15:17.032 INFO [stdout] 3: 0x563f130824b7 - std::panicking::default_hook::h1134a4d34aab4428 Dec 13 22:15:17.032 INFO [stdout] at src/libstd/panicking.rs:218 Dec 13 22:15:17.032 INFO [stdout] 4: 0x563f13082ed0 - std::panicking::rust_panic_with_hook::h9c89557c251f2d42 Dec 13 22:15:17.032 INFO [stdout] at src/libstd/panicking.rs:487 Dec 13 22:15:17.032 INFO [stdout] 5: 0x563f13082a51 - std::panicking::continue_panic_fmt::h6b63497ce98499d4 Dec 13 22:15:17.032 INFO [stdout] at src/libstd/panicking.rs:394 Dec 13 22:15:17.032 INFO [stdout] 6: 0x563f1308299e - std::panicking::begin_panic_fmt::h33c12d7eb9e26fea Dec 13 22:15:17.032 INFO [stdout] at src/libstd/panicking.rs:349 Dec 13 22:15:17.032 INFO [stdout] 7: 0x563f13030d35 - assert_cmd::assert::Assert::success::hbd5f8a3d36701366 Dec 13 22:15:17.032 INFO [stdout] at /cargo-home/registry/src/github.com-1ecc6299db9ec823/assert_cmd-0.10.2/src/assert.rs:154 Dec 13 22:15:17.032 INFO [stdout] 8: 0x563f12f4dac6 - e2e::test_1::h101a45c387399d48 Dec 13 22:15:17.032 INFO [stdout] at tests/e2e.rs:52 Dec 13 22:15:17.032 INFO [stdout] 9: 0x563f12f4d10d - e2e::test_1::{{closure}}::hbdf4e208c04106a0 Dec 13 22:15:17.032 INFO [stdout] at tests/e2e.rs:43 Dec 13 22:15:17.032 INFO [stdout] 10: 0x563f12f50b9d - core::ops::function::FnOnce::call_once::h9cfd7588d573ee75 Dec 13 22:15:17.032 INFO [stdout] at /rustc/bd47d6825bf4090517549d33cfef10d3300b4a75/src/libcore/ops/function.rs:238 Dec 13 22:15:17.032 INFO [stdout] 11: 0x563f12f5daae - >::call_box::h3cf534772c089f15 Dec 13 22:15:17.032 INFO [stdout] at src/libtest/lib.rs:1483 Dec 13 22:15:17.032 INFO [stdout] at /rustc/bd47d6825bf4090517549d33cfef10d3300b4a75/src/libcore/ops/function.rs:238 Dec 13 22:15:17.032 INFO [stdout] at /rustc/bd47d6825bf4090517549d33cfef10d3300b4a75/src/liballoc/boxed.rs:673 Dec 13 22:15:17.032 INFO [stdout] 12: 0x563f130967f9 - __rust_maybe_catch_panic Dec 13 22:15:17.032 INFO [stdout] at src/libpanic_unwind/lib.rs:102 Dec 13 22:15:17.032 INFO [stdout] 13: 0x563f12f7b457 - test::run_test::run_test_inner::{{closure}}::h5f14673685eef7c8 Dec 13 22:15:17.032 INFO [stdout] at /rustc/bd47d6825bf4090517549d33cfef10d3300b4a75/src/libstd/panicking.rs:285 Dec 13 22:15:17.032 INFO [stdout] at /rustc/bd47d6825bf4090517549d33cfef10d3300b4a75/src/libstd/panic.rs:398 Dec 13 22:15:17.033 INFO [stdout] at src/libtest/lib.rs:1438 Dec 13 22:15:17.033 INFO [stdout] 14: 0x563f12f56364 - std::sys_common::backtrace::__rust_begin_short_backtrace::h96de92a7d062bb5f Dec 13 22:15:17.033 INFO [stdout] at /rustc/bd47d6825bf4090517549d33cfef10d3300b4a75/src/libstd/sys_common/backtrace.rs:136 Dec 13 22:15:17.033 INFO [stdout] 15: 0x563f12f569d4 - std::panicking::try::do_call::h6a71e68ea4ad0d8a Dec 13 22:15:17.033 INFO [stdout] at /rustc/bd47d6825bf4090517549d33cfef10d3300b4a75/src/libstd/thread/mod.rs:479 Dec 13 22:15:17.033 INFO [stdout] at /rustc/bd47d6825bf4090517549d33cfef10d3300b4a75/src/libstd/panic.rs:319 Dec 13 22:15:17.033 INFO [stdout] at /rustc/bd47d6825bf4090517549d33cfef10d3300b4a75/src/libstd/panicking.rs:306 Dec 13 22:15:17.033 INFO [stdout] 16: 0x563f130967f9 - __rust_maybe_catch_panic Dec 13 22:15:17.033 INFO [stdout] at src/libpanic_unwind/lib.rs:102 Dec 13 22:15:17.033 INFO [stdout] 17: 0x563f12f5d98c - >::call_box::h260fd1ad8e2854a6 Dec 13 22:15:17.033 INFO [stdout] at /rustc/bd47d6825bf4090517549d33cfef10d3300b4a75/src/libstd/panicking.rs:285 Dec 13 22:15:17.033 INFO [stdout] at /rustc/bd47d6825bf4090517549d33cfef10d3300b4a75/src/libstd/panic.rs:398 Dec 13 22:15:17.033 INFO [stdout] at /rustc/bd47d6825bf4090517549d33cfef10d3300b4a75/src/libstd/thread/mod.rs:478 Dec 13 22:15:17.033 INFO [stdout] at /rustc/bd47d6825bf4090517549d33cfef10d3300b4a75/src/liballoc/boxed.rs:673 Dec 13 22:15:17.033 INFO [stdout] 18: 0x563f1308a7bd - std::sys::unix::thread::Thread::new::thread_start::h08aa646226e66c99 Dec 13 22:15:17.033 INFO [stdout] at /rustc/bd47d6825bf4090517549d33cfef10d3300b4a75/src/liballoc/boxed.rs:683 Dec 13 22:15:17.033 INFO [stdout] at src/libstd/sys_common/thread.rs:24 Dec 13 22:15:17.033 INFO [stdout] at src/libstd/sys/unix/thread.rs:91 Dec 13 22:15:17.033 INFO [stdout] 19: 0x7ffa65ad66b9 - start_thread Dec 13 22:15:17.033 INFO [stdout] 20: 0x7ffa65ff741c - clone Dec 13 22:15:17.033 INFO [stdout] 21: 0x0 - Dec 13 22:15:17.033 INFO [stdout] Dec 13 22:15:17.033 INFO [stdout] Dec 13 22:15:17.033 INFO [stdout] failures: Dec 13 22:15:17.033 INFO [stdout] test_1 Dec 13 22:15:17.033 INFO [stdout] test_3 Dec 13 22:15:17.033 INFO [stdout] Dec 13 22:15:17.033 INFO [stdout] test result: FAILED. 2 passed; 2 failed; 0 ignored; 0 measured; 0 filtered out Dec 13 22:15:17.033 INFO [stdout] Dec 13 22:15:17.047 INFO [stderr] error: test failed, to rerun pass '--test e2e' Dec 13 22:15:17.055 INFO [stderr] su: No module specific data is present Dec 13 22:15:17.691 INFO running `"docker" "inspect" "f7ab26fc45d5f18dbd5fc95a6353b9764eae08ad8bbbdcd5db0602651767f4a9"` Dec 13 22:15:18.115 INFO running `"docker" "rm" "-f" "f7ab26fc45d5f18dbd5fc95a6353b9764eae08ad8bbbdcd5db0602651767f4a9"` Dec 13 22:15:18.411 INFO [stdout] f7ab26fc45d5f18dbd5fc95a6353b9764eae08ad8bbbdcd5db0602651767f4a9