Nov 17 21:05:19.270 INFO testing tealdeer-1.0.0 against try#2e026d6e5d7621634147ad4c8074f1d964dbb1be for pr-55982
Nov 17 21:05:19.272 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-7/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/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 21:05:19.756 INFO [stdout] e23dde99aaf204893249d54b1416ad0cc42e6712c0e8e03a5f7dedeaa0eeb0f7
Nov 17 21:05:19.759 INFO running `"docker" "start" "-a" "e23dde99aaf204893249d54b1416ad0cc42e6712c0e8e03a5f7dedeaa0eeb0f7"`
Nov 17 21:05:20.630 INFO [stderr] usermod: no changes
Nov 17 21:05:20.908 INFO [stderr]    Compiling tar v0.4.20
Nov 17 21:05:23.153 INFO [stderr]    Compiling tealdeer v1.0.0 (/source)
Nov 17 21:05:29.111 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 8.45s
Nov 17 21:05:29.125 INFO [stderr] su: No module specific data is present
Nov 17 21:05:29.795 INFO running `"docker" "inspect" "e23dde99aaf204893249d54b1416ad0cc42e6712c0e8e03a5f7dedeaa0eeb0f7"`
Nov 17 21:05:30.081 INFO running `"docker" "rm" "-f" "e23dde99aaf204893249d54b1416ad0cc42e6712c0e8e03a5f7dedeaa0eeb0f7"`
Nov 17 21:05:30.295 INFO [stdout] e23dde99aaf204893249d54b1416ad0cc42e6712c0e8e03a5f7dedeaa0eeb0f7
Nov 17 21:05:30.299 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-7/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/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 21:05:30.713 INFO [stdout] cfe5f5d5acb91a90e0308de4f5818a3f80d377b9ca23d6bc857890b9dacb4571
Nov 17 21:05:30.716 INFO running `"docker" "start" "-a" "cfe5f5d5acb91a90e0308de4f5818a3f80d377b9ca23d6bc857890b9dacb4571"`
Nov 17 21:05:31.955 INFO [stderr] usermod: no changes
Nov 17 21:05:32.223 INFO [stderr]    Compiling cargo_metadata v0.5.8
Nov 17 21:05:36.297 INFO [stderr]    Compiling skeptic v0.13.3
Nov 17 21:05:41.176 INFO [stderr]    Compiling assert_cli v0.5.4
Nov 17 21:05:46.602 INFO [stderr]    Compiling tealdeer v1.0.0 (/source)
Nov 17 21:05:52.080 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 20.15s
Nov 17 21:05:52.095 INFO [stderr] su: No module specific data is present
Nov 17 21:05:52.487 INFO running `"docker" "inspect" "cfe5f5d5acb91a90e0308de4f5818a3f80d377b9ca23d6bc857890b9dacb4571"`
Nov 17 21:05:52.757 INFO running `"docker" "rm" "-f" "cfe5f5d5acb91a90e0308de4f5818a3f80d377b9ca23d6bc857890b9dacb4571"`
Nov 17 21:05:53.036 INFO [stdout] cfe5f5d5acb91a90e0308de4f5818a3f80d377b9ca23d6bc857890b9dacb4571
Nov 17 21:05:53.046 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-7/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/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 21:05:53.495 INFO [stdout] 3a809f9f2a213f3da8ef37397d239969ac63ef16fc0ec993687eab6d0a9c8292
Nov 17 21:05:53.497 INFO running `"docker" "start" "-a" "3a809f9f2a213f3da8ef37397d239969ac63ef16fc0ec993687eab6d0a9c8292"`
Nov 17 21:05:54.613 INFO [stderr] usermod: no changes
Nov 17 21:05:54.875 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.20s
Nov 17 21:05:54.875 INFO [stderr]      Running /target/debug/deps/tldr-3eb2fd0c68929cde
Nov 17 21:05:54.875 INFO [stdout] 
Nov 17 21:05:54.875 INFO [stdout] running 5 tests
Nov 17 21:05:54.931 INFO [stdout] test tokenizer::test::test_first_line_new_format ... ok
Nov 17 21:05:54.935 INFO [stdout] test types::test::test_linetype_from_str ... ok
Nov 17 21:05:54.999 INFO [stdout] test tokenizer::test::test_first_line_old_format ... ok
Nov 17 21:05:55.005 INFO [stdout] test test::test_docopt_expect_error ... ok
Nov 17 21:05:55.006 INFO [stdout] test test::test_docopt_os_case_insensitive ... ok
Nov 17 21:05:55.006 INFO [stdout] 
Nov 17 21:05:55.007 INFO [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 17 21:05:55.007 INFO [stdout] 
Nov 17 21:05:55.013 INFO [stderr]      Running /target/debug/deps/lib-44ea49e6d1cc800c
Nov 17 21:05:55.016 INFO [stdout] 
Nov 17 21:05:55.017 INFO [stdout] running 4 tests
Nov 17 21:05:55.748 INFO [stdout] test test_correct_rendering_v2 ... ok
Nov 17 21:05:55.769 INFO [stdout] test test_correct_rendering_v1 ... ok
Nov 17 21:05:55.852 INFO [stdout] test test_missing_cache ... ok
Nov 17 21:05:56.063 INFO [stderr] error: test failed, to rerun pass '--test lib'
Nov 17 21:05:56.063 INFO [stdout] test test_update_cache ... FAILED
Nov 17 21:05:56.063 INFO [stdout] 
Nov 17 21:05:56.063 INFO [stdout] failures:
Nov 17 21:05:56.063 INFO [stdout] 
Nov 17 21:05:56.063 INFO [stdout] ---- test_update_cache stdout ----
Nov 17 21:05:56.063 INFO [stdout] thread 'test_update_cache' panicked at 'CLI assertion failed: (command `cargo run -- --update` expected to succeed)
Nov 17 21:05:56.063 INFO [stdout] status=failed
Nov 17 21:05:56.063 INFO [stdout] stdout=```Could not update cache: Curl error: [6] Couldn't resolve host name
Nov 17 21:05:56.063 INFO [stdout] ```
Nov 17 21:05:56.063 INFO [stdout] stderr=```    Finished dev [unoptimized + debuginfo] target(s) in 0.24s
Nov 17 21:05:56.063 INFO [stdout]      Running `/target/debug/tldr --update`
Nov 17 21:05:56.063 INFO [stdout] ```', /cargo-home/registry/src/github.com-1ecc6299db9ec823/assert_cli-0.5.4/src/assert.rs:368:13
Nov 17 21:05:56.063 INFO [stdout] stack backtrace:
Nov 17 21:05:56.063 INFO [stdout]    0:     0x562ccf49fb33 - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h26df0f6fdb27c709
Nov 17 21:05:56.063 INFO [stdout]                                at libstd/sys/unix/backtrace/tracing/gcc_s.rs:49
Nov 17 21:05:56.063 INFO [stdout]    1:     0x562ccf49a348 - std::sys_common::backtrace::_print::h84c40fecda6d638e
Nov 17 21:05:56.063 INFO [stdout]                                at libstd/sys_common/backtrace.rs:71
Nov 17 21:05:56.063 INFO [stdout]    2:     0x562ccf49ea54 - std::panicking::default_hook::{{closure}}::h77e370c0567fc0a7
Nov 17 21:05:56.063 INFO [stdout]                                at libstd/sys_common/backtrace.rs:59
Nov 17 21:05:56.063 INFO [stdout]                                at libstd/panicking.rs:211
Nov 17 21:05:56.063 INFO [stdout]    3:     0x562ccf49e73c - std::panicking::default_hook::hb9a45c11a33bbcb2
Nov 17 21:05:56.063 INFO [stdout]                                at libstd/panicking.rs:221
Nov 17 21:05:56.063 INFO [stdout]    4:     0x562ccf49f160 - std::panicking::rust_panic_with_hook::ha8d95048d940f754
Nov 17 21:05:56.063 INFO [stdout]                                at libstd/panicking.rs:476
Nov 17 21:05:56.063 INFO [stdout]    5:     0x562ccf49ece1 - std::panicking::continue_panic_fmt::hfc82a3747387e2c6
Nov 17 21:05:56.063 INFO [stdout]                                at libstd/panicking.rs:390
Nov 17 21:05:56.063 INFO [stdout]    6:     0x562ccf49ec2e - std::panicking::begin_panic_fmt::h17464725d83144d2
Nov 17 21:05:56.063 INFO [stdout]                                at libstd/panicking.rs:345
Nov 17 21:05:56.063 INFO [stdout]    7:     0x562ccf413675 - assert_cli::assert::Assert::unwrap::hb5607999c61306d8
Nov 17 21:05:56.063 INFO [stdout]                                at /cargo-home/registry/src/github.com-1ecc6299db9ec823/assert_cli-0.5.4/src/assert.rs:368
Nov 17 21:05:56.063 INFO [stdout]    8:     0x562ccf3b7093 - lib::test_update_cache::ha4cfd23378ea9420
Nov 17 21:05:56.063 INFO [stdout]                                at tests/lib.rs:54
Nov 17 21:05:56.063 INFO [stdout]    9:     0x562ccf3b6f09 - lib::test_update_cache::{{closure}}::h3f44b1491daef82d
Nov 17 21:05:56.063 INFO [stdout]                                at tests/lib.rs:45
Nov 17 21:05:56.063 INFO [stdout]   10:     0x562ccf3b7ded - core::ops::function::FnOnce::call_once::h3402d37824d46c74
Nov 17 21:05:56.063 INFO [stdout]                                at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/libcore/ops/function.rs:238
Nov 17 21:05:56.063 INFO [stdout]   11:     0x562ccf3c323e - <F as alloc::boxed::FnBox<A>>::call_box::hae1ea457a0ccd8d5
Nov 17 21:05:56.063 INFO [stdout]                                at libtest/lib.rs:1471
Nov 17 21:05:56.063 INFO [stdout]                                at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/libcore/ops/function.rs:238
Nov 17 21:05:56.063 INFO [stdout]                                at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/liballoc/boxed.rs:673
Nov 17 21:05:56.063 INFO [stdout]   12:     0x562ccf4b2dd9 - __rust_maybe_catch_panic
Nov 17 21:05:56.063 INFO [stdout]                                at libpanic_unwind/lib.rs:102
Nov 17 21:05:56.063 INFO [stdout]   13:     0x562ccf3bb093 - std::sys_common::backtrace::__rust_begin_short_backtrace::hd0ded23d435d70d0
Nov 17 21:05:56.063 INFO [stdout]                                at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/libstd/panicking.rs:289
Nov 17 21:05:56.063 INFO [stdout]                                at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/libstd/panic.rs:398
Nov 17 21:05:56.063 INFO [stdout]                                at libtest/lib.rs:1426
Nov 17 21:05:56.063 INFO [stdout]                                at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/libstd/sys_common/backtrace.rs:136
Nov 17 21:05:56.063 INFO [stdout]   14:     0x562ccf3bbf34 - std::panicking::try::do_call::h031514fb401b7159
Nov 17 21:05:56.063 INFO [stdout]                                at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/libstd/thread/mod.rs:477
Nov 17 21:05:56.063 INFO [stdout]                                at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/libstd/panic.rs:319
Nov 17 21:05:56.063 INFO [stdout]                                at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/libstd/panicking.rs:310
Nov 17 21:05:56.063 INFO [stdout]   15:     0x562ccf4b2dd9 - __rust_maybe_catch_panic
Nov 17 21:05:56.063 INFO [stdout]                                at libpanic_unwind/lib.rs:102
Nov 17 21:05:56.063 INFO [stdout]   16:     0x562ccf3c311c - <F as alloc::boxed::FnBox<A>>::call_box::h44700b7a2ec6fd33
Nov 17 21:05:56.063 INFO [stdout]                                at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/libstd/panicking.rs:289
Nov 17 21:05:56.063 INFO [stdout]                                at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/libstd/panic.rs:398
Nov 17 21:05:56.063 INFO [stdout]                                at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/libstd/thread/mod.rs:476
Nov 17 21:05:56.063 INFO [stdout]                                at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/liballoc/boxed.rs:673
Nov 17 21:05:56.063 INFO [stdout]   17:     0x562ccf4a6c0d - std::sys::unix::thread::Thread::new::thread_start::h8526625243d2f13b
Nov 17 21:05:56.063 INFO [stdout]                                at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/liballoc/boxed.rs:683
Nov 17 21:05:56.063 INFO [stdout]                                at libstd/sys_common/thread.rs:24
Nov 17 21:05:56.063 INFO [stdout]                                at libstd/sys/unix/thread.rs:90
Nov 17 21:05:56.063 INFO [stdout]   18:     0x7fae0d5476b9 - start_thread
Nov 17 21:05:56.063 INFO [stdout]   19:     0x7fae0d06741c - clone
Nov 17 21:05:56.063 INFO [stdout]   20:                0x0 - <unknown>
Nov 17 21:05:56.063 INFO [stdout] 
Nov 17 21:05:56.064 INFO [stdout] 
Nov 17 21:05:56.064 INFO [stdout] failures:
Nov 17 21:05:56.064 INFO [stdout]     test_update_cache
Nov 17 21:05:56.064 INFO [stdout] 
Nov 17 21:05:56.064 INFO [stdout] test result: FAILED. 3 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out
Nov 17 21:05:56.064 INFO [stdout] 
Nov 17 21:05:56.077 INFO [stderr] su: No module specific data is present
Nov 17 21:05:56.758 INFO running `"docker" "inspect" "3a809f9f2a213f3da8ef37397d239969ac63ef16fc0ec993687eab6d0a9c8292"`
Nov 17 21:05:57.137 INFO running `"docker" "rm" "-f" "3a809f9f2a213f3da8ef37397d239969ac63ef16fc0ec993687eab6d0a9c8292"`
Nov 17 21:05:57.412 INFO [stdout] 3a809f9f2a213f3da8ef37397d239969ac63ef16fc0ec993687eab6d0a9c8292