Dec 13 20:33:49.040 INFO testing egeromin/wellington against try#aa49d8ef14939ddec0e34b346b60174a5673d48f for pr-56550
Dec 13 20:33:49.040 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-1/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/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 20:33:49.374 INFO [stdout] 5a5bbf46195e7fb06ba2281dba1a46c0a49a378e7028cccdb8ca493dd0252ccf
Dec 13 20:33:49.381 INFO running `"docker" "start" "-a" "5a5bbf46195e7fb06ba2281dba1a46c0a49a378e7028cccdb8ca493dd0252ccf"`
Dec 13 20:33:50.521 INFO [stderr] usermod: no changes
Dec 13 20:33:50.723 INFO [stderr]    Compiling aho-corasick v0.6.8
Dec 13 20:33:50.723 INFO [stderr]    Compiling csv-core v0.1.4
Dec 13 20:33:50.723 INFO [stderr]    Compiling url_serde v0.2.0
Dec 13 20:33:52.783 INFO [stderr]    Compiling regex v1.0.5
Dec 13 20:33:53.903 INFO [stderr]    Compiling csv v1.0.1
Dec 13 20:34:03.886 INFO [stderr]    Compiling handlebars v1.0.4
Dec 13 20:34:14.230 INFO [stderr]    Compiling wellington v0.0.1 (/source)
Dec 13 20:34:24.040 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 33.49s
Dec 13 20:34:24.049 INFO [stderr] su: No module specific data is present
Dec 13 20:34:24.694 INFO running `"docker" "inspect" "5a5bbf46195e7fb06ba2281dba1a46c0a49a378e7028cccdb8ca493dd0252ccf"`
Dec 13 20:34:24.933 INFO running `"docker" "rm" "-f" "5a5bbf46195e7fb06ba2281dba1a46c0a49a378e7028cccdb8ca493dd0252ccf"`
Dec 13 20:34:25.115 INFO [stdout] 5a5bbf46195e7fb06ba2281dba1a46c0a49a378e7028cccdb8ca493dd0252ccf
Dec 13 20:34:25.119 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-1/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/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 20:34:25.357 INFO [stdout] bb46964df61283bb8484542f6c37e36186ac249d567aa91054b36d52ea977053
Dec 13 20:34:25.359 INFO running `"docker" "start" "-a" "bb46964df61283bb8484542f6c37e36186ac249d567aa91054b36d52ea977053"`
Dec 13 20:34:25.895 INFO [stderr] usermod: no changes
Dec 13 20:34:25.977 INFO [stderr]    Compiling wellington v0.0.1 (/source)
Dec 13 20:34:31.356 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 5.42s
Dec 13 20:34:31.356 INFO [stderr] su: No module specific data is present
Dec 13 20:34:31.761 INFO running `"docker" "inspect" "bb46964df61283bb8484542f6c37e36186ac249d567aa91054b36d52ea977053"`
Dec 13 20:34:31.836 INFO running `"docker" "rm" "-f" "bb46964df61283bb8484542f6c37e36186ac249d567aa91054b36d52ea977053"`
Dec 13 20:34:31.939 INFO [stdout] bb46964df61283bb8484542f6c37e36186ac249d567aa91054b36d52ea977053
Dec 13 20:34:31.939 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-1/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/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 20:34:32.275 INFO [stdout] bc6938d43ea5798d5446909f66ef748e3ccb19c75c81b6e22192f8ad542dc50b
Dec 13 20:34:32.280 INFO running `"docker" "start" "-a" "bc6938d43ea5798d5446909f66ef748e3ccb19c75c81b6e22192f8ad542dc50b"`
Dec 13 20:34:32.728 INFO [stderr] usermod: no changes
Dec 13 20:34:32.813 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.07s
Dec 13 20:34:32.816 INFO [stderr]      Running /target/debug/deps/wellington-e90ba629b4685357
Dec 13 20:34:32.819 INFO [stdout] 
Dec 13 20:34:32.819 INFO [stdout] running 19 tests
Dec 13 20:34:32.822 INFO [stdout] test parser::tests::can_parse_image ... ok
Dec 13 20:34:32.823 INFO [stdout] test parser::tests::check_fail_nested_code_sidenote ... ok
Dec 13 20:34:32.823 INFO [stdout] test rss::test::can_set ... ok
Dec 13 20:34:32.824 INFO [stdout] test parser::tests::can_get_title ... ok
Dec 13 20:34:32.835 INFO [stdout] test sidenotes::tests::can_get_first_sidenote ... ok
Dec 13 20:34:32.835 INFO [stdout] test parser::tests::check_nested_sidenote_code ... ok
Dec 13 20:34:32.835 INFO [stdout] test sidenotes::tests::can_parse_remaining ... ok
Dec 13 20:34:32.835 INFO [stdout] test parser::tests::check_absolute_links ... ok
Dec 13 20:34:32.835 INFO [stdout] test parser::tests::check_to_markdown ... ok
Dec 13 20:34:32.835 INFO [stdout] test parser::tests::check_catch_sidenote_errors ... ok
Dec 13 20:34:32.835 INFO [stdout] test parser::tests::check_multi_line_sidenotes ... ok
Dec 13 20:34:32.835 INFO [stdout] test sidenotes::tests::can_use_regex ... ok
Dec 13 20:34:32.835 INFO [stdout] test parser::tests::can_rewrite_links ... ok
Dec 13 20:34:32.835 INFO [stdout] test toc::tests::can_compute_input_output_filename ... ok
Dec 13 20:34:32.855 INFO [stdout] test toc::tests::can_update ... ok
Dec 13 20:34:32.859 INFO [stdout] test toc::tests::render_index ... ok
Dec 13 20:34:32.867 INFO [stdout] test templates::tests::make_without_error ... ok
Dec 13 20:34:32.870 INFO [stdout] test toc::tests::write_read_index ... ok
Dec 13 20:34:32.922 INFO [stdout] test toc::tests::can_list_dirs ... FAILED
Dec 13 20:34:32.922 INFO [stdout] 
Dec 13 20:34:32.922 INFO [stdout] failures:
Dec 13 20:34:32.922 INFO [stdout] 
Dec 13 20:34:32.922 INFO [stdout] ---- toc::tests::can_list_dirs stdout ----
Dec 13 20:34:32.922 INFO [stdout] thread 'toc::tests::can_list_dirs' panicked at 'assertion failed: `(left == right)`
Dec 13 20:34:32.922 INFO [stdout]   left: `["krasnoyarsk", "yekaterinburg", "irkutsk"]`,
Dec 13 20:34:32.922 INFO [stdout]  right: `["irkutsk", "krasnoyarsk", "yekaterinburg"]`', src/toc.rs:569:9
Dec 13 20:34:32.922 INFO [stdout] stack backtrace:
Dec 13 20:34:32.922 INFO [stdout]    0:     0x55e2d85bf333 - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h2c40bdfb30f25bdd
Dec 13 20:34:32.922 INFO [stdout]                                at src/libstd/sys/unix/backtrace/tracing/gcc_s.rs:49
Dec 13 20:34:32.922 INFO [stdout]    1:     0x55e2d85b9a68 - std::sys_common::backtrace::_print::he11ceebc70626ac9
Dec 13 20:34:32.922 INFO [stdout]                                at src/libstd/sys_common/backtrace.rs:71
Dec 13 20:34:32.922 INFO [stdout]    2:     0x55e2d85be242 - std::panicking::default_hook::{{closure}}::h4fde3ffb19c01413
Dec 13 20:34:32.922 INFO [stdout]                                at src/libstd/sys_common/backtrace.rs:59
Dec 13 20:34:32.922 INFO [stdout]                                at src/libstd/panicking.rs:210
Dec 13 20:34:32.922 INFO [stdout]    3:     0x55e2d85bdf37 - std::panicking::default_hook::hf0c15a583008ed0d
Dec 13 20:34:32.922 INFO [stdout]                                at src/libstd/panicking.rs:218
Dec 13 20:34:32.922 INFO [stdout]    4:     0x55e2d85be950 - std::panicking::rust_panic_with_hook::hc1663f6bc7813185
Dec 13 20:34:32.922 INFO [stdout]                                at src/libstd/panicking.rs:487
Dec 13 20:34:32.922 INFO [stdout]    5:     0x55e2d85be4d1 - std::panicking::continue_panic_fmt::h42bc2d03ddf03b3e
Dec 13 20:34:32.922 INFO [stdout]                                at src/libstd/panicking.rs:394
Dec 13 20:34:32.922 INFO [stdout]    6:     0x55e2d85be41e - std::panicking::begin_panic_fmt::h2207969583fb9324
Dec 13 20:34:32.922 INFO [stdout]                                at src/libstd/panicking.rs:349
Dec 13 20:34:32.922 INFO [stdout]    7:     0x55e2d80bda07 - wellington::toc::tests::can_list_dirs::h93eb9557de4ef72f
Dec 13 20:34:32.922 INFO [stdout]                                at src/toc.rs:569
Dec 13 20:34:32.922 INFO [stdout]    8:     0x55e2d80bd729 - wellington::toc::tests::can_list_dirs::{{closure}}::hd5fbe874fb1b5225
Dec 13 20:34:32.922 INFO [stdout]                                at src/toc.rs:558
Dec 13 20:34:32.922 INFO [stdout]    9:     0x55e2d807590d - core::ops::function::FnOnce::call_once::h4e37010560234074
Dec 13 20:34:32.922 INFO [stdout]                                at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libcore/ops/function.rs:238
Dec 13 20:34:32.922 INFO [stdout]   10:     0x55e2d80c809e - <F as alloc::boxed::FnBox<A>>::call_box::hac337ba1af72dc2b
Dec 13 20:34:32.922 INFO [stdout]                                at src/libtest/lib.rs:1483
Dec 13 20:34:32.922 INFO [stdout]                                at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libcore/ops/function.rs:238
Dec 13 20:34:32.922 INFO [stdout]                                at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/liballoc/boxed.rs:673
Dec 13 20:34:32.922 INFO [stdout]   11:     0x55e2d85ce059 - __rust_maybe_catch_panic
Dec 13 20:34:32.922 INFO [stdout]                                at src/libpanic_unwind/lib.rs:102
Dec 13 20:34:32.922 INFO [stdout]   12:     0x55e2d80e58a7 - test::run_test::run_test_inner::{{closure}}::hfbfe4a58c0ebb01b
Dec 13 20:34:32.922 INFO [stdout]                                at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/panicking.rs:285
Dec 13 20:34:32.922 INFO [stdout]                                at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/panic.rs:398
Dec 13 20:34:32.922 INFO [stdout]                                at src/libtest/lib.rs:1438
Dec 13 20:34:32.922 INFO [stdout]   13:     0x55e2d80c07b4 - std::sys_common::backtrace::__rust_begin_short_backtrace::hd1f0cf202092f8d7
Dec 13 20:34:32.922 INFO [stdout]                                at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/sys_common/backtrace.rs:136
Dec 13 20:34:32.922 INFO [stdout]   14:     0x55e2d80c0da4 - std::panicking::try::do_call::h5e99f92fbf448cf6
Dec 13 20:34:32.922 INFO [stdout]                                at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/thread/mod.rs:479
Dec 13 20:34:32.922 INFO [stdout]                                at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/panic.rs:319
Dec 13 20:34:32.922 INFO [stdout]                                at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/panicking.rs:306
Dec 13 20:34:32.922 INFO [stdout]   15:     0x55e2d85ce059 - __rust_maybe_catch_panic
Dec 13 20:34:32.922 INFO [stdout]                                at src/libpanic_unwind/lib.rs:102
Dec 13 20:34:32.922 INFO [stdout]   16:     0x55e2d80c7f7c - <F as alloc::boxed::FnBox<A>>::call_box::h8ae063aff93ccdb6
Dec 13 20:34:32.922 INFO [stdout]                                at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/panicking.rs:285
Dec 13 20:34:32.922 INFO [stdout]                                at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/panic.rs:398
Dec 13 20:34:32.922 INFO [stdout]                                at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/thread/mod.rs:478
Dec 13 20:34:32.922 INFO [stdout]                                at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/liballoc/boxed.rs:673
Dec 13 20:34:32.922 INFO [stdout]   17:     0x55e2d85c1cfd - std::sys::unix::thread::Thread::new::thread_start::h42c32b292fdd228f
Dec 13 20:34:32.922 INFO [stdout]                                at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/liballoc/boxed.rs:683
Dec 13 20:34:32.922 INFO [stdout]                                at src/libstd/sys_common/thread.rs:24
Dec 13 20:34:32.922 INFO [stdout]                                at src/libstd/sys/unix/thread.rs:91
Dec 13 20:34:32.922 INFO [stdout]   18:     0x7f840bbcd6b9 - start_thread
Dec 13 20:34:32.922 INFO [stdout]   19:     0x7f840b6ed41c - clone
Dec 13 20:34:32.922 INFO [stdout]   20:                0x0 - <unknown>
Dec 13 20:34:32.922 INFO [stdout] 
Dec 13 20:34:32.922 INFO [stdout] 
Dec 13 20:34:32.922 INFO [stdout] failures:
Dec 13 20:34:32.922 INFO [stdout]     toc::tests::can_list_dirs
Dec 13 20:34:32.922 INFO [stdout] 
Dec 13 20:34:32.922 INFO [stdout] test result: FAILED. 18 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out
Dec 13 20:34:32.922 INFO [stdout] 
Dec 13 20:34:32.927 INFO [stderr] error: test failed, to rerun pass '--lib'
Dec 13 20:34:32.928 INFO [stderr] su: No module specific data is present
Dec 13 20:34:33.180 INFO running `"docker" "inspect" "bc6938d43ea5798d5446909f66ef748e3ccb19c75c81b6e22192f8ad542dc50b"`
Dec 13 20:34:33.283 INFO running `"docker" "rm" "-f" "bc6938d43ea5798d5446909f66ef748e3ccb19c75c81b6e22192f8ad542dc50b"`
Dec 13 20:34:33.393 INFO [stdout] bc6938d43ea5798d5446909f66ef748e3ccb19c75c81b6e22192f8ad542dc50b