Dec 15 02:19:46.449 INFO testing pandoc-ac-0.1.0 against try#aa49d8ef14939ddec0e34b346b60174a5673d48f for pr-56550 Dec 15 02:19:46.449 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-6/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/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 15 02:19:46.633 INFO [stdout] 287c5c23ac9a22328b4643aea2681adb536fa012f20b263fcb7bb5eab9ac4eba Dec 15 02:19:46.637 INFO running `"docker" "start" "-a" "287c5c23ac9a22328b4643aea2681adb536fa012f20b263fcb7bb5eab9ac4eba"` Dec 15 02:19:47.212 INFO [stderr] usermod: no changes Dec 15 02:19:47.331 INFO [stderr] Compiling pandoc_ast v0.7.2 Dec 15 02:19:55.839 INFO [stderr] Compiling pandoc-ac v0.1.0 (/source) Dec 15 02:20:05.711 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 18.47s Dec 15 02:20:05.716 INFO [stderr] su: No module specific data is present Dec 15 02:20:06.402 INFO running `"docker" "inspect" "287c5c23ac9a22328b4643aea2681adb536fa012f20b263fcb7bb5eab9ac4eba"` Dec 15 02:20:06.484 INFO running `"docker" "rm" "-f" "287c5c23ac9a22328b4643aea2681adb536fa012f20b263fcb7bb5eab9ac4eba"` Dec 15 02:20:06.614 INFO [stdout] 287c5c23ac9a22328b4643aea2681adb536fa012f20b263fcb7bb5eab9ac4eba Dec 15 02:20:06.616 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-6/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/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 15 02:20:06.939 INFO [stdout] 10dbbea0c5917f172946f1ccc3c3a280f9498f9f0b678bdefa3fd5ef8635e560 Dec 15 02:20:06.941 INFO running `"docker" "start" "-a" "10dbbea0c5917f172946f1ccc3c3a280f9498f9f0b678bdefa3fd5ef8635e560"` Dec 15 02:20:07.603 INFO [stderr] usermod: no changes Dec 15 02:20:07.735 INFO [stderr] Compiling pandoc v0.7.0 Dec 15 02:20:09.675 INFO [stderr] Compiling pandoc-ac v0.1.0 (/source) Dec 15 02:20:15.989 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 8.37s Dec 15 02:20:15.995 INFO [stderr] su: No module specific data is present Dec 15 02:20:16.300 INFO running `"docker" "inspect" "10dbbea0c5917f172946f1ccc3c3a280f9498f9f0b678bdefa3fd5ef8635e560"` Dec 15 02:20:16.401 INFO running `"docker" "rm" "-f" "10dbbea0c5917f172946f1ccc3c3a280f9498f9f0b678bdefa3fd5ef8635e560"` Dec 15 02:20:16.556 INFO [stdout] 10dbbea0c5917f172946f1ccc3c3a280f9498f9f0b678bdefa3fd5ef8635e560 Dec 15 02:20:16.558 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-6/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/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 15 02:20:16.786 INFO [stdout] 64978b904a569e0e258a524ba857c7062f94bd49b657f9ddb68540efb666f47a Dec 15 02:20:16.788 INFO running `"docker" "start" "-a" "64978b904a569e0e258a524ba857c7062f94bd49b657f9ddb68540efb666f47a"` Dec 15 02:20:17.367 INFO [stderr] usermod: no changes Dec 15 02:20:17.458 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 0.07s Dec 15 02:20:17.475 INFO [stderr] Running /target/debug/deps/pandoc_ac-ba2696ba41f5f8ee Dec 15 02:20:17.478 INFO [stdout] Dec 15 02:20:17.479 INFO [stdout] running 0 tests Dec 15 02:20:17.479 INFO [stdout] Dec 15 02:20:17.479 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 02:20:17.479 INFO [stdout] Dec 15 02:20:17.487 INFO [stderr] Running /target/debug/deps/pandoc_ac-f57002aedcc7b222 Dec 15 02:20:17.489 INFO [stdout] Dec 15 02:20:17.489 INFO [stdout] running 0 tests Dec 15 02:20:17.489 INFO [stdout] Dec 15 02:20:17.489 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 02:20:17.489 INFO [stdout] Dec 15 02:20:17.495 INFO [stdout] Dec 15 02:20:17.495 INFO [stderr] Running /target/debug/deps/test-7ec093d4169b636d Dec 15 02:20:17.495 INFO [stdout] running 1 test Dec 15 02:20:17.599 INFO [stdout] test test1 ... FAILED Dec 15 02:20:17.599 INFO [stdout] Dec 15 02:20:17.599 INFO [stdout] failures: Dec 15 02:20:17.599 INFO [stdout] Dec 15 02:20:17.599 INFO [stdout] ---- test1 stdout ---- Dec 15 02:20:17.599 INFO [stdout] thread 'test1' panicked at 'called `Result::unwrap()` on an `Err` value: Pandoc not found, did you forget to install pandoc?', src/libcore/result.rs:1009:5 Dec 15 02:20:17.599 INFO [stdout] stack backtrace: Dec 15 02:20:17.599 INFO [stdout] 0: 0x55d17ba7b313 - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h2c40bdfb30f25bdd Dec 15 02:20:17.599 INFO [stdout] at src/libstd/sys/unix/backtrace/tracing/gcc_s.rs:49 Dec 15 02:20:17.599 INFO [stdout] 1: 0x55d17ba759d8 - std::sys_common::backtrace::_print::he11ceebc70626ac9 Dec 15 02:20:17.599 INFO [stdout] at src/libstd/sys_common/backtrace.rs:71 Dec 15 02:20:17.599 INFO [stdout] 2: 0x55d17ba7a1b2 - std::panicking::default_hook::{{closure}}::h4fde3ffb19c01413 Dec 15 02:20:17.599 INFO [stdout] at src/libstd/sys_common/backtrace.rs:59 Dec 15 02:20:17.599 INFO [stdout] at src/libstd/panicking.rs:210 Dec 15 02:20:17.599 INFO [stdout] 3: 0x55d17ba79ea7 - std::panicking::default_hook::hf0c15a583008ed0d Dec 15 02:20:17.599 INFO [stdout] at src/libstd/panicking.rs:218 Dec 15 02:20:17.599 INFO [stdout] 4: 0x55d17ba7a8c0 - std::panicking::rust_panic_with_hook::hc1663f6bc7813185 Dec 15 02:20:17.599 INFO [stdout] at src/libstd/panicking.rs:487 Dec 15 02:20:17.599 INFO [stdout] 5: 0x55d17ba7a441 - std::panicking::continue_panic_fmt::h42bc2d03ddf03b3e Dec 15 02:20:17.599 INFO [stdout] at src/libstd/panicking.rs:394 Dec 15 02:20:17.599 INFO [stdout] 6: 0x55d17ba7a325 - rust_begin_unwind Dec 15 02:20:17.599 INFO [stdout] at src/libstd/panicking.rs:321 Dec 15 02:20:17.599 INFO [stdout] 7: 0x55d17ba936dc - core::panicking::panic_fmt::h44df04385fc0c5a6 Dec 15 02:20:17.599 INFO [stdout] at src/libcore/panicking.rs:95 Dec 15 02:20:17.599 INFO [stdout] 8: 0x55d17b71405b - core::result::unwrap_failed::h8371134025cddc21 Dec 15 02:20:17.599 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libcore/macros.rs:26 Dec 15 02:20:17.599 INFO [stdout] 9: 0x55d17b713326 - >::unwrap::h544b24be1008c14d Dec 15 02:20:17.599 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libcore/result.rs:808 Dec 15 02:20:17.599 INFO [stdout] 10: 0x55d17b6f8c38 - test::test1::hf85b73d289d5fb56 Dec 15 02:20:17.599 INFO [stdout] at tests/test.rs:26 Dec 15 02:20:17.599 INFO [stdout] 11: 0x55d17b6f8969 - test::test1::{{closure}}::h46c9793608ff0bc6 Dec 15 02:20:17.599 INFO [stdout] at tests/test.rs:10 Dec 15 02:20:17.599 INFO [stdout] 12: 0x55d17b6fa82d - core::ops::function::FnOnce::call_once::he4c2ee0b9a334df3 Dec 15 02:20:17.599 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libcore/ops/function.rs:238 Dec 15 02:20:17.599 INFO [stdout] 13: 0x55d17b71f14e - >::call_box::hac337ba1af72dc2b Dec 15 02:20:17.599 INFO [stdout] at src/libtest/lib.rs:1483 Dec 15 02:20:17.599 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libcore/ops/function.rs:238 Dec 15 02:20:17.599 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/liballoc/boxed.rs:673 Dec 15 02:20:17.599 INFO [stdout] 14: 0x55d17ba8e529 - __rust_maybe_catch_panic Dec 15 02:20:17.599 INFO [stdout] at src/libpanic_unwind/lib.rs:102 Dec 15 02:20:17.599 INFO [stdout] 15: 0x55d17b73c957 - test::run_test::run_test_inner::{{closure}}::hfbfe4a58c0ebb01b Dec 15 02:20:17.599 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/panicking.rs:285 Dec 15 02:20:17.599 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/panic.rs:398 Dec 15 02:20:17.599 INFO [stdout] at src/libtest/lib.rs:1438 Dec 15 02:20:17.599 INFO [stdout] 16: 0x55d17b717864 - std::sys_common::backtrace::__rust_begin_short_backtrace::hd1f0cf202092f8d7 Dec 15 02:20:17.599 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/sys_common/backtrace.rs:136 Dec 15 02:20:17.599 INFO [stdout] 17: 0x55d17b717e54 - std::panicking::try::do_call::h5e99f92fbf448cf6 Dec 15 02:20:17.600 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/thread/mod.rs:479 Dec 15 02:20:17.600 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/panic.rs:319 Dec 15 02:20:17.600 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/panicking.rs:306 Dec 15 02:20:17.600 INFO [stdout] 18: 0x55d17ba8e529 - __rust_maybe_catch_panic Dec 15 02:20:17.600 INFO [stdout] at src/libpanic_unwind/lib.rs:102 Dec 15 02:20:17.600 INFO [stdout] 19: 0x55d17b71f02c - >::call_box::h8ae063aff93ccdb6 Dec 15 02:20:17.600 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/panicking.rs:285 Dec 15 02:20:17.600 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/panic.rs:398 Dec 15 02:20:17.600 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/thread/mod.rs:478 Dec 15 02:20:17.600 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/liballoc/boxed.rs:673 Dec 15 02:20:17.600 INFO [stdout] 20: 0x55d17ba821ed - std::sys::unix::thread::Thread::new::thread_start::h42c32b292fdd228f Dec 15 02:20:17.600 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/liballoc/boxed.rs:683 Dec 15 02:20:17.600 INFO [stdout] at src/libstd/sys_common/thread.rs:24 Dec 15 02:20:17.600 INFO [stdout] at src/libstd/sys/unix/thread.rs:91 Dec 15 02:20:17.600 INFO [stdout] 21: 0x7f2b160516b9 - start_thread Dec 15 02:20:17.600 INFO [stdout] 22: 0x7f2b15b7141c - clone Dec 15 02:20:17.600 INFO [stdout] 23: 0x0 - Dec 15 02:20:17.600 INFO [stdout] Dec 15 02:20:17.600 INFO [stdout] Dec 15 02:20:17.600 INFO [stdout] failures: Dec 15 02:20:17.600 INFO [stdout] test1 Dec 15 02:20:17.600 INFO [stdout] Dec 15 02:20:17.600 INFO [stdout] test result: FAILED. 0 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 02:20:17.600 INFO [stdout] Dec 15 02:20:17.600 INFO [stderr] error: test failed, to rerun pass '--test test' Dec 15 02:20:17.601 INFO [stderr] su: No module specific data is present Dec 15 02:20:17.975 INFO running `"docker" "inspect" "64978b904a569e0e258a524ba857c7062f94bd49b657f9ddb68540efb666f47a"` Dec 15 02:20:18.064 INFO running `"docker" "rm" "-f" "64978b904a569e0e258a524ba857c7062f94bd49b657f9ddb68540efb666f47a"` Dec 15 02:20:18.202 INFO [stdout] 64978b904a569e0e258a524ba857c7062f94bd49b657f9ddb68540efb666f47a