Dec 06 00:49:53.613 INFO testing egeromin/wellington against master#906deae0790bd18681b937fe9a141a3c26cf1855 for pr-56514
Dec 06 00:49:53.614 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-6/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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 06 00:49:53.964 INFO [stdout] 41bb4206a67d7eb1c3e2f0aeb1911bdcc1a0cc8336ea4a2f21929c5c7aef8d71
Dec 06 00:49:53.974 INFO running `"docker" "start" "-a" "41bb4206a67d7eb1c3e2f0aeb1911bdcc1a0cc8336ea4a2f21929c5c7aef8d71"`
Dec 06 00:49:55.336 INFO [stderr] usermod: no changes
Dec 06 00:49:55.651 INFO [stderr]    Compiling csv-core v0.1.4
Dec 06 00:49:55.651 INFO [stderr]    Compiling url_serde v0.2.0
Dec 06 00:49:55.700 INFO [stderr]    Compiling handlebars v1.0.4
Dec 06 00:49:57.969 INFO [stderr]    Compiling csv v1.0.1
Dec 06 00:50:04.384 INFO [stderr]    Compiling wellington v0.0.1 (/source)
Dec 06 00:50:12.781 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 17.39s
Dec 06 00:50:12.788 INFO [stderr] su: No module specific data is present
Dec 06 00:50:13.073 INFO running `"docker" "inspect" "41bb4206a67d7eb1c3e2f0aeb1911bdcc1a0cc8336ea4a2f21929c5c7aef8d71"`
Dec 06 00:50:13.167 INFO running `"docker" "rm" "-f" "41bb4206a67d7eb1c3e2f0aeb1911bdcc1a0cc8336ea4a2f21929c5c7aef8d71"`
Dec 06 00:50:13.348 INFO [stdout] 41bb4206a67d7eb1c3e2f0aeb1911bdcc1a0cc8336ea4a2f21929c5c7aef8d71
Dec 06 00:50:13.355 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-6/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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 06 00:50:13.581 INFO [stdout] fc896e6d153c862b9db432a1b2d5def16b27f5febb96363f57f3cd70dc7d1e59
Dec 06 00:50:13.583 INFO running `"docker" "start" "-a" "fc896e6d153c862b9db432a1b2d5def16b27f5febb96363f57f3cd70dc7d1e59"`
Dec 06 00:50:14.285 INFO [stderr] usermod: no changes
Dec 06 00:50:14.451 INFO [stderr]    Compiling wellington v0.0.1 (/source)
Dec 06 00:50:21.035 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 6.71s
Dec 06 00:50:21.046 INFO [stderr] su: No module specific data is present
Dec 06 00:50:21.353 INFO running `"docker" "inspect" "fc896e6d153c862b9db432a1b2d5def16b27f5febb96363f57f3cd70dc7d1e59"`
Dec 06 00:50:21.520 INFO running `"docker" "rm" "-f" "fc896e6d153c862b9db432a1b2d5def16b27f5febb96363f57f3cd70dc7d1e59"`
Dec 06 00:50:21.673 INFO [stdout] fc896e6d153c862b9db432a1b2d5def16b27f5febb96363f57f3cd70dc7d1e59
Dec 06 00:50:21.683 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-6/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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 06 00:50:21.953 INFO [stdout] 499fbd86510654a2669815f075af8b0c3497d6de02ddf92982b580ad2229fc08
Dec 06 00:50:21.960 INFO running `"docker" "start" "-a" "499fbd86510654a2669815f075af8b0c3497d6de02ddf92982b580ad2229fc08"`
Dec 06 00:50:22.460 INFO [stderr] usermod: no changes
Dec 06 00:50:22.580 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.09s
Dec 06 00:50:22.595 INFO [stderr]      Running /target/debug/deps/wellington-4fe42a3903f0edcd
Dec 06 00:50:22.598 INFO [stdout] 
Dec 06 00:50:22.598 INFO [stdout] running 19 tests
Dec 06 00:50:22.600 INFO [stdout] test parser::tests::check_absolute_links ... ok
Dec 06 00:50:22.600 INFO [stdout] test parser::tests::can_parse_image ... ok
Dec 06 00:50:22.603 INFO [stdout] test parser::tests::check_fail_nested_code_sidenote ... ok
Dec 06 00:50:22.606 INFO [stdout] test parser::tests::check_nested_sidenote_code ... ok
Dec 06 00:50:22.606 INFO [stdout] test parser::tests::can_rewrite_links ... ok
Dec 06 00:50:22.614 INFO [stdout] test rss::test::can_set ... ok
Dec 06 00:50:22.616 INFO [stdout] test parser::tests::can_get_title ... ok
Dec 06 00:50:22.617 INFO [stdout] test sidenotes::tests::can_get_first_sidenote ... ok
Dec 06 00:50:22.617 INFO [stdout] test sidenotes::tests::can_parse_remaining ... ok
Dec 06 00:50:22.619 INFO [stdout] test toc::tests::can_compute_input_output_filename ... ok
Dec 06 00:50:22.624 INFO [stdout] test parser::tests::check_catch_sidenote_errors ... ok
Dec 06 00:50:22.624 INFO [stdout] test sidenotes::tests::can_use_regex ... ok
Dec 06 00:50:22.624 INFO [stdout] test parser::tests::check_multi_line_sidenotes ... ok
Dec 06 00:50:22.625 INFO [stdout] test parser::tests::check_to_markdown ... ok
Dec 06 00:50:22.658 INFO [stdout] test toc::tests::can_update ... ok
Dec 06 00:50:22.658 INFO [stdout] test toc::tests::write_read_index ... ok
Dec 06 00:50:22.658 INFO [stdout] test toc::tests::render_index ... ok
Dec 06 00:50:22.676 INFO [stdout] test templates::tests::make_without_error ... ok
Dec 06 00:50:22.730 INFO [stdout] test toc::tests::can_list_dirs ... FAILED
Dec 06 00:50:22.730 INFO [stdout] 
Dec 06 00:50:22.730 INFO [stdout] failures:
Dec 06 00:50:22.731 INFO [stdout] 
Dec 06 00:50:22.731 INFO [stdout] ---- toc::tests::can_list_dirs stdout ----
Dec 06 00:50:22.731 INFO [stdout] thread 'toc::tests::can_list_dirs' panicked at 'assertion failed: `(left == right)`
Dec 06 00:50:22.731 INFO [stdout]   left: `["krasnoyarsk", "yekaterinburg", "irkutsk"]`,
Dec 06 00:50:22.731 INFO [stdout]  right: `["irkutsk", "krasnoyarsk", "yekaterinburg"]`', src/toc.rs:569:9
Dec 06 00:50:22.731 INFO [stdout] stack backtrace:
Dec 06 00:50:22.731 INFO [stdout]    0:     0x55834479cd03 - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h3c2ada0a2db8c5e7
Dec 06 00:50:22.731 INFO [stdout]                                at src/libstd/sys/unix/backtrace/tracing/gcc_s.rs:49
Dec 06 00:50:22.731 INFO [stdout]    1:     0x558344797358 - std::sys_common::backtrace::_print::h95865c77318e98b7
Dec 06 00:50:22.731 INFO [stdout]                                at src/libstd/sys_common/backtrace.rs:71
Dec 06 00:50:22.731 INFO [stdout]    2:     0x55834479bc12 - std::panicking::default_hook::{{closure}}::hb3d1f299fcea42e5
Dec 06 00:50:22.731 INFO [stdout]                                at src/libstd/sys_common/backtrace.rs:59
Dec 06 00:50:22.731 INFO [stdout]                                at src/libstd/panicking.rs:211
Dec 06 00:50:22.731 INFO [stdout]    3:     0x55834479b8fc - std::panicking::default_hook::h4eae6f26f73244c8
Dec 06 00:50:22.731 INFO [stdout]                                at src/libstd/panicking.rs:221
Dec 06 00:50:22.731 INFO [stdout]    4:     0x55834479c320 - std::panicking::rust_panic_with_hook::h368d37fd53b59464
Dec 06 00:50:22.731 INFO [stdout]                                at src/libstd/panicking.rs:491
Dec 06 00:50:22.731 INFO [stdout]    5:     0x55834479bea1 - std::panicking::continue_panic_fmt::h1599d634b3be4304
Dec 06 00:50:22.731 INFO [stdout]                                at src/libstd/panicking.rs:398
Dec 06 00:50:22.731 INFO [stdout]    6:     0x55834479bdee - std::panicking::begin_panic_fmt::h2c0a418aaab204b3
Dec 06 00:50:22.731 INFO [stdout]                                at src/libstd/panicking.rs:353
Dec 06 00:50:22.731 INFO [stdout]    7:     0x55834429ff97 - wellington::toc::tests::can_list_dirs::h7d1aa1a813898f4d
Dec 06 00:50:22.731 INFO [stdout]                                at src/toc.rs:569
Dec 06 00:50:22.731 INFO [stdout]    8:     0x55834429fcb9 - wellington::toc::tests::can_list_dirs::{{closure}}::hc652b4c1fc53b805
Dec 06 00:50:22.731 INFO [stdout]                                at src/toc.rs:558
Dec 06 00:50:22.731 INFO [stdout]    9:     0x55834425819d - core::ops::function::FnOnce::call_once::h8ff7a4fb380181a7
Dec 06 00:50:22.731 INFO [stdout]                                at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libcore/ops/function.rs:238
Dec 06 00:50:22.731 INFO [stdout]   10:     0x5583442aaf5e - <F as alloc::boxed::FnBox<A>>::call_box::h994167e0fc25f327
Dec 06 00:50:22.731 INFO [stdout]                                at src/libtest/lib.rs:1471
Dec 06 00:50:22.731 INFO [stdout]                                at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libcore/ops/function.rs:238
Dec 06 00:50:22.731 INFO [stdout]                                at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/liballoc/boxed.rs:673
Dec 06 00:50:22.731 INFO [stdout]   11:     0x5583447aba29 - __rust_maybe_catch_panic
Dec 06 00:50:22.731 INFO [stdout]                                at src/libpanic_unwind/lib.rs:102
Dec 06 00:50:22.731 INFO [stdout]   12:     0x5583442a2e63 - std::sys_common::backtrace::__rust_begin_short_backtrace::h5d34cfb78512c8c3
Dec 06 00:50:22.731 INFO [stdout]                                at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panicking.rs:289
Dec 06 00:50:22.731 INFO [stdout]                                at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panic.rs:398
Dec 06 00:50:22.731 INFO [stdout]                                at src/libtest/lib.rs:1426
Dec 06 00:50:22.731 INFO [stdout]                                at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/sys_common/backtrace.rs:136
Dec 06 00:50:22.731 INFO [stdout]   13:     0x5583442a3d84 - std::panicking::try::do_call::h7a86b6211ebb5e72
Dec 06 00:50:22.731 INFO [stdout]                                at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/thread/mod.rs:477
Dec 06 00:50:22.731 INFO [stdout]                                at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panic.rs:319
Dec 06 00:50:22.731 INFO [stdout]                                at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panicking.rs:310
Dec 06 00:50:22.731 INFO [stdout]   14:     0x5583447aba29 - __rust_maybe_catch_panic
Dec 06 00:50:22.731 INFO [stdout]                                at src/libpanic_unwind/lib.rs:102
Dec 06 00:50:22.731 INFO [stdout]   15:     0x5583442aae3c - <F as alloc::boxed::FnBox<A>>::call_box::h877dbe22cb3997f4
Dec 06 00:50:22.731 INFO [stdout]                                at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panicking.rs:289
Dec 06 00:50:22.731 INFO [stdout]                                at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panic.rs:398
Dec 06 00:50:22.731 INFO [stdout]                                at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/thread/mod.rs:476
Dec 06 00:50:22.731 INFO [stdout]                                at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/liballoc/boxed.rs:673
Dec 06 00:50:22.731 INFO [stdout]   16:     0x55834479f6cd - std::sys::unix::thread::Thread::new::thread_start::hea5f7f9c570dc4cd
Dec 06 00:50:22.731 INFO [stdout]                                at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/liballoc/boxed.rs:683
Dec 06 00:50:22.731 INFO [stdout]                                at src/libstd/sys_common/thread.rs:24
Dec 06 00:50:22.731 INFO [stdout]                                at src/libstd/sys/unix/thread.rs:90
Dec 06 00:50:22.731 INFO [stdout]   17:     0x7f04e20aa6b9 - start_thread
Dec 06 00:50:22.731 INFO [stdout]   18:     0x7f04e1bca41c - clone
Dec 06 00:50:22.731 INFO [stdout]   19:                0x0 - <unknown>
Dec 06 00:50:22.731 INFO [stdout] 
Dec 06 00:50:22.731 INFO [stdout] 
Dec 06 00:50:22.731 INFO [stdout] failures:
Dec 06 00:50:22.731 INFO [stdout]     toc::tests::can_list_dirs
Dec 06 00:50:22.731 INFO [stdout] 
Dec 06 00:50:22.731 INFO [stdout] test result: FAILED. 18 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out
Dec 06 00:50:22.731 INFO [stdout] 
Dec 06 00:50:22.735 INFO [stderr] error: test failed, to rerun pass '--lib'
Dec 06 00:50:22.740 INFO [stderr] su: No module specific data is present
Dec 06 00:50:23.086 INFO running `"docker" "inspect" "499fbd86510654a2669815f075af8b0c3497d6de02ddf92982b580ad2229fc08"`
Dec 06 00:50:23.223 INFO running `"docker" "rm" "-f" "499fbd86510654a2669815f075af8b0c3497d6de02ddf92982b580ad2229fc08"`
Dec 06 00:50:23.384 INFO [stdout] 499fbd86510654a2669815f075af8b0c3497d6de02ddf92982b580ad2229fc08