Nov 17 18:14:29.239 INFO testing wellington-0.0.1 against try#2e026d6e5d7621634147ad4c8074f1d964dbb1be for pr-55982
Nov 17 18:14:29.239 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-0/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/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 +2e026d6e5d7621634147ad4c8074f1d964dbb1be-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"`
Nov 17 18:14:29.624 INFO [stdout] 73448c083591a4cba476fb8aeeabfea65c74b30d3b4da147e8b055fd0561bce2
Nov 17 18:14:29.631 INFO running `"docker" "start" "-a" "73448c083591a4cba476fb8aeeabfea65c74b30d3b4da147e8b055fd0561bce2"`
Nov 17 18:14:30.011 INFO [stderr] usermod: no changes
Nov 17 18:14:30.158 INFO [stderr]    Compiling syn v0.14.9
Nov 17 18:14:39.907 INFO [stderr]    Compiling pest_generator v2.0.0
Nov 17 18:14:45.395 INFO [stderr]    Compiling pest_derive v2.0.1
Nov 17 18:14:49.097 INFO [stderr]    Compiling handlebars v1.1.0
Nov 17 18:14:57.798 INFO [stderr]    Compiling wellington v0.0.1 (/source)
Nov 17 18:15:11.615 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 41.58s
Nov 17 18:15:11.628 INFO [stderr] su: No module specific data is present
Nov 17 18:15:11.900 INFO running `"docker" "inspect" "73448c083591a4cba476fb8aeeabfea65c74b30d3b4da147e8b055fd0561bce2"`
Nov 17 18:15:11.994 INFO running `"docker" "rm" "-f" "73448c083591a4cba476fb8aeeabfea65c74b30d3b4da147e8b055fd0561bce2"`
Nov 17 18:15:12.074 INFO [stdout] 73448c083591a4cba476fb8aeeabfea65c74b30d3b4da147e8b055fd0561bce2
Nov 17 18:15:12.076 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-0/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/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 +2e026d6e5d7621634147ad4c8074f1d964dbb1be-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"`
Nov 17 18:15:12.341 INFO [stdout] c314846fa25bfd136ec58c927dfc657e3f76a2e6fd3bc0e0823456a938478a33
Nov 17 18:15:12.342 INFO running `"docker" "start" "-a" "c314846fa25bfd136ec58c927dfc657e3f76a2e6fd3bc0e0823456a938478a33"`
Nov 17 18:15:12.821 INFO [stderr] usermod: no changes
Nov 17 18:15:12.931 INFO [stderr]    Compiling wellington v0.0.1 (/source)
Nov 17 18:15:20.768 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 7.92s
Nov 17 18:15:20.778 INFO [stderr] su: No module specific data is present
Nov 17 18:15:21.193 INFO running `"docker" "inspect" "c314846fa25bfd136ec58c927dfc657e3f76a2e6fd3bc0e0823456a938478a33"`
Nov 17 18:15:21.472 INFO running `"docker" "rm" "-f" "c314846fa25bfd136ec58c927dfc657e3f76a2e6fd3bc0e0823456a938478a33"`
Nov 17 18:15:21.731 INFO [stdout] c314846fa25bfd136ec58c927dfc657e3f76a2e6fd3bc0e0823456a938478a33
Nov 17 18:15:21.733 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-0/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/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 +2e026d6e5d7621634147ad4c8074f1d964dbb1be-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"`
Nov 17 18:15:22.244 INFO [stdout] 3a2621a0625e31ed9815d576025f1f31c2893142bbb1a5ebd18b96dd9d9cf09e
Nov 17 18:15:22.246 INFO running `"docker" "start" "-a" "3a2621a0625e31ed9815d576025f1f31c2893142bbb1a5ebd18b96dd9d9cf09e"`
Nov 17 18:15:23.387 INFO [stderr] usermod: no changes
Nov 17 18:15:23.584 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.17s
Nov 17 18:15:23.612 INFO [stderr]      Running /target/debug/deps/wellington-ca769c7d287f8deb
Nov 17 18:15:23.619 INFO [stdout] 
Nov 17 18:15:23.619 INFO [stdout] running 19 tests
Nov 17 18:15:23.652 INFO [stdout] test parser::tests::check_fail_nested_code_sidenote ... ok
Nov 17 18:15:23.652 INFO [stdout] test parser::tests::check_absolute_links ... ok
Nov 17 18:15:23.652 INFO [stdout] test parser::tests::can_get_title ... ok
Nov 17 18:15:23.652 INFO [stdout] test parser::tests::check_catch_sidenote_errors ... ok
Nov 17 18:15:23.656 INFO [stdout] test parser::tests::can_rewrite_links ... ok
Nov 17 18:15:23.660 INFO [stdout] test parser::tests::can_parse_image ... ok
Nov 17 18:15:23.660 INFO [stdout] test sidenotes::tests::can_parse_remaining ... ok
Nov 17 18:15:23.660 INFO [stdout] test sidenotes::tests::can_get_first_sidenote ... ok
Nov 17 18:15:23.660 INFO [stdout] test sidenotes::tests::can_use_regex ... ok
Nov 17 18:15:23.673 INFO [stdout] test toc::tests::can_compute_input_output_filename ... ok
Nov 17 18:15:23.673 INFO [stdout] test rss::test::can_set ... ok
Nov 17 18:15:23.687 INFO [stdout] test parser::tests::check_nested_sidenote_code ... ok
Nov 17 18:15:23.703 INFO [stdout] test parser::tests::check_to_markdown ... ok
Nov 17 18:15:23.715 INFO [stdout] test parser::tests::check_multi_line_sidenotes ... ok
Nov 17 18:15:23.807 INFO [stdout] test toc::tests::render_index ... ok
Nov 17 18:15:23.807 INFO [stdout] test toc::tests::write_read_index ... ok
Nov 17 18:15:23.808 INFO [stdout] test toc::tests::can_update ... ok
Nov 17 18:15:23.835 INFO [stdout] test templates::tests::make_without_error ... ok
Nov 17 18:15:23.918 INFO [stdout] test toc::tests::can_list_dirs ... FAILED
Nov 17 18:15:23.918 INFO [stdout] 
Nov 17 18:15:23.918 INFO [stdout] failures:
Nov 17 18:15:23.918 INFO [stdout] 
Nov 17 18:15:23.918 INFO [stdout] ---- toc::tests::can_list_dirs stdout ----
Nov 17 18:15:23.918 INFO [stdout] thread 'toc::tests::can_list_dirs' panicked at 'assertion failed: `(left == right)`
Nov 17 18:15:23.918 INFO [stdout]   left: `["krasnoyarsk", "yekaterinburg", "irkutsk"]`,
Nov 17 18:15:23.918 INFO [stdout]  right: `["irkutsk", "krasnoyarsk", "yekaterinburg"]`', src/toc.rs:569:9
Nov 17 18:15:23.918 INFO [stdout] stack backtrace:
Nov 17 18:15:23.918 INFO [stdout]    0:     0x561f6ef78af3 - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h26df0f6fdb27c709
Nov 17 18:15:23.918 INFO [stdout]                                at libstd/sys/unix/backtrace/tracing/gcc_s.rs:49
Nov 17 18:15:23.918 INFO [stdout]    1:     0x561f6ef73308 - std::sys_common::backtrace::_print::h84c40fecda6d638e
Nov 17 18:15:23.918 INFO [stdout]                                at libstd/sys_common/backtrace.rs:71
Nov 17 18:15:23.918 INFO [stdout]    2:     0x561f6ef77a14 - std::panicking::default_hook::{{closure}}::h77e370c0567fc0a7
Nov 17 18:15:23.918 INFO [stdout]                                at libstd/sys_common/backtrace.rs:59
Nov 17 18:15:23.918 INFO [stdout]                                at libstd/panicking.rs:211
Nov 17 18:15:23.918 INFO [stdout]    3:     0x561f6ef776fc - std::panicking::default_hook::hb9a45c11a33bbcb2
Nov 17 18:15:23.918 INFO [stdout]                                at libstd/panicking.rs:221
Nov 17 18:15:23.918 INFO [stdout]    4:     0x561f6ef78120 - std::panicking::rust_panic_with_hook::ha8d95048d940f754
Nov 17 18:15:23.918 INFO [stdout]                                at libstd/panicking.rs:476
Nov 17 18:15:23.918 INFO [stdout]    5:     0x561f6ef77ca1 - std::panicking::continue_panic_fmt::hfc82a3747387e2c6
Nov 17 18:15:23.918 INFO [stdout]                                at libstd/panicking.rs:390
Nov 17 18:15:23.918 INFO [stdout]    6:     0x561f6ef77bee - std::panicking::begin_panic_fmt::h17464725d83144d2
Nov 17 18:15:23.918 INFO [stdout]                                at libstd/panicking.rs:345
Nov 17 18:15:23.918 INFO [stdout]    7:     0x561f6ea8de59 - wellington::toc::tests::can_list_dirs::h2472c05ed2fc057a
Nov 17 18:15:23.918 INFO [stdout]                                at src/toc.rs:569
Nov 17 18:15:23.918 INFO [stdout]    8:     0x561f6ea8db79 - wellington::toc::tests::can_list_dirs::{{closure}}::had47b35b97c8c6c8
Nov 17 18:15:23.918 INFO [stdout]                                at src/toc.rs:558
Nov 17 18:15:23.918 INFO [stdout]    9:     0x561f6ea46a4d - core::ops::function::FnOnce::call_once::h0ad38afe60b8de1b
Nov 17 18:15:23.918 INFO [stdout]                                at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/libcore/ops/function.rs:238
Nov 17 18:15:23.918 INFO [stdout]   10:     0x561f6ea98eee - <F as alloc::boxed::FnBox<A>>::call_box::hae1ea457a0ccd8d5
Nov 17 18:15:23.918 INFO [stdout]                                at libtest/lib.rs:1471
Nov 17 18:15:23.918 INFO [stdout]                                at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/libcore/ops/function.rs:238
Nov 17 18:15:23.918 INFO [stdout]                                at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/liballoc/boxed.rs:673
Nov 17 18:15:23.918 INFO [stdout]   11:     0x561f6ef87a89 - __rust_maybe_catch_panic
Nov 17 18:15:23.918 INFO [stdout]                                at libpanic_unwind/lib.rs:102
Nov 17 18:15:23.918 INFO [stdout]   12:     0x561f6ea90d43 - std::sys_common::backtrace::__rust_begin_short_backtrace::hd0ded23d435d70d0
Nov 17 18:15:23.918 INFO [stdout]                                at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/libstd/panicking.rs:289
Nov 17 18:15:23.918 INFO [stdout]                                at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/libstd/panic.rs:398
Nov 17 18:15:23.918 INFO [stdout]                                at libtest/lib.rs:1426
Nov 17 18:15:23.918 INFO [stdout]                                at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/libstd/sys_common/backtrace.rs:136
Nov 17 18:15:23.918 INFO [stdout]   13:     0x561f6ea91be4 - std::panicking::try::do_call::h031514fb401b7159
Nov 17 18:15:23.918 INFO [stdout]                                at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/libstd/thread/mod.rs:477
Nov 17 18:15:23.918 INFO [stdout]                                at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/libstd/panic.rs:319
Nov 17 18:15:23.919 INFO [stdout]                                at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/libstd/panicking.rs:310
Nov 17 18:15:23.919 INFO [stdout]   14:     0x561f6ef87a89 - __rust_maybe_catch_panic
Nov 17 18:15:23.919 INFO [stdout]                                at libpanic_unwind/lib.rs:102
Nov 17 18:15:23.919 INFO [stdout]   15:     0x561f6ea98dcc - <F as alloc::boxed::FnBox<A>>::call_box::h44700b7a2ec6fd33
Nov 17 18:15:23.919 INFO [stdout]                                at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/libstd/panicking.rs:289
Nov 17 18:15:23.919 INFO [stdout]                                at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/libstd/panic.rs:398
Nov 17 18:15:23.919 INFO [stdout]                                at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/libstd/thread/mod.rs:476
Nov 17 18:15:23.919 INFO [stdout]                                at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/liballoc/boxed.rs:673
Nov 17 18:15:23.919 INFO [stdout]   16:     0x561f6ef7b5fd - std::sys::unix::thread::Thread::new::thread_start::h8526625243d2f13b
Nov 17 18:15:23.919 INFO [stdout]                                at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/liballoc/boxed.rs:683
Nov 17 18:15:23.919 INFO [stdout]                                at libstd/sys_common/thread.rs:24
Nov 17 18:15:23.919 INFO [stdout]                                at libstd/sys/unix/thread.rs:90
Nov 17 18:15:23.919 INFO [stdout]   17:     0x7f21fb4e76b9 - start_thread
Nov 17 18:15:23.919 INFO [stdout]   18:     0x7f21fb00741c - clone
Nov 17 18:15:23.919 INFO [stdout]   19:                0x0 - <unknown>
Nov 17 18:15:23.919 INFO [stdout] 
Nov 17 18:15:23.919 INFO [stdout] 
Nov 17 18:15:23.919 INFO [stdout] failures:
Nov 17 18:15:23.919 INFO [stdout]     toc::tests::can_list_dirs
Nov 17 18:15:23.919 INFO [stdout] 
Nov 17 18:15:23.919 INFO [stdout] test result: FAILED. 18 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out
Nov 17 18:15:23.919 INFO [stdout] 
Nov 17 18:15:23.921 INFO [stderr] error: test failed, to rerun pass '--lib'
Nov 17 18:15:23.927 INFO [stderr] su: No module specific data is present
Nov 17 18:15:24.465 INFO running `"docker" "inspect" "3a2621a0625e31ed9815d576025f1f31c2893142bbb1a5ebd18b96dd9d9cf09e"`
Nov 17 18:15:24.740 INFO running `"docker" "rm" "-f" "3a2621a0625e31ed9815d576025f1f31c2893142bbb1a5ebd18b96dd9d9cf09e"`
Nov 17 18:15:24.875 INFO [stdout] 3a2621a0625e31ed9815d576025f1f31c2893142bbb1a5ebd18b96dd9d9cf09e