Dec 01 20:38:03.532 INFO testing cyplo/rustback against 1.30.1 for beta-1.31-5
Dec 01 20:38:03.532 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-5/worker-3/1.30.1:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/beta-1.31-5/1.30.1:/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 +1.30.1 build --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 01 20:38:03.802 INFO [stdout] 639b50ae181cdd6f5b1c631eabf2ec58d97abfc82b50ca1b64a71ba95e5b0039
Dec 01 20:38:03.805 INFO running `"docker" "start" "-a" "639b50ae181cdd6f5b1c631eabf2ec58d97abfc82b50ca1b64a71ba95e5b0039"`
Dec 01 20:38:04.269 INFO [stderr] usermod: no changes
Dec 01 20:38:04.366 INFO [stderr]    Compiling bakare v0.1.0 (/source)
Dec 01 20:38:05.199 INFO [stderr] warning: unused variable: `path`
Dec 01 20:38:05.199 INFO [stderr]   --> src/backup.rs:32:32
Dec 01 20:38:05.199 INFO [stderr]    |
Dec 01 20:38:05.199 INFO [stderr] 32 |     pub fn file_version(&self, path: &Path) -> Version {
Dec 01 20:38:05.199 INFO [stderr]    |                                ^^^^ help: consider using `_path` instead
Dec 01 20:38:05.199 INFO [stderr]    |
Dec 01 20:38:05.199 INFO [stderr]    = note: #[warn(unused_variables)] on by default
Dec 01 20:38:05.199 INFO [stderr] 
Dec 01 20:38:05.199 INFO [stderr] warning: unused variable: `what`
Dec 01 20:38:05.199 INFO [stderr]   --> src/restore.rs:34:41
Dec 01 20:38:05.199 INFO [stderr]    |
Dec 01 20:38:05.199 INFO [stderr] 34 |     pub fn restore_as_of_version(&self, what: WhatToRestore, version: Version) -> Result<(), io::Error> {
Dec 01 20:38:05.199 INFO [stderr]    |                                         ^^^^ help: consider using `_what` instead
Dec 01 20:38:05.199 INFO [stderr] 
Dec 01 20:38:05.199 INFO [stderr] warning: unused variable: `version`
Dec 01 20:38:05.199 INFO [stderr]   --> src/restore.rs:34:62
Dec 01 20:38:05.199 INFO [stderr]    |
Dec 01 20:38:05.199 INFO [stderr] 34 |     pub fn restore_as_of_version(&self, what: WhatToRestore, version: Version) -> Result<(), io::Error> {
Dec 01 20:38:05.199 INFO [stderr]    |                                                              ^^^^^^^ help: consider using `_version` instead
Dec 01 20:38:05.199 INFO [stderr] 
Dec 01 20:38:05.217 INFO [stderr] warning: method is never used: `next`
Dec 01 20:38:05.217 INFO [stderr]  --> src/storage.rs:8:5
Dec 01 20:38:05.217 INFO [stderr]   |
Dec 01 20:38:05.217 INFO [stderr] 8 |     fn next(self) -> Self {
Dec 01 20:38:05.217 INFO [stderr]   |     ^^^^^^^^^^^^^^^^^^^^^
Dec 01 20:38:05.217 INFO [stderr]   |
Dec 01 20:38:05.217 INFO [stderr]   = note: #[warn(dead_code)] on by default
Dec 01 20:38:05.217 INFO [stderr] 
Dec 01 20:38:05.217 INFO [stderr] warning: struct is never constructed: `Index`
Dec 01 20:38:05.217 INFO [stderr]   --> src/storage.rs:29:1
Dec 01 20:38:05.218 INFO [stderr]    |
Dec 01 20:38:05.218 INFO [stderr] 29 | struct Index<'a> {
Dec 01 20:38:05.218 INFO [stderr]    | ^^^^^^^^^^^^^^^^
Dec 01 20:38:05.218 INFO [stderr] 
Dec 01 20:38:05.218 INFO [stderr] warning: method is never used: `new`
Dec 01 20:38:05.218 INFO [stderr]   --> src/storage.rs:35:5
Dec 01 20:38:05.218 INFO [stderr]    |
Dec 01 20:38:05.218 INFO [stderr] 35 |     fn new() -> Self {
Dec 01 20:38:05.218 INFO [stderr]    |     ^^^^^^^^^^^^^^^^
Dec 01 20:38:05.218 INFO [stderr] 
Dec 01 20:38:05.218 INFO [stderr] warning: method is never used: `store`
Dec 01 20:38:05.218 INFO [stderr]   --> src/storage.rs:42:5
Dec 01 20:38:05.218 INFO [stderr]    |
Dec 01 20:38:05.218 INFO [stderr] 42 |     fn store(&mut self, source_path: &'a str, hash: Hash) -> (Version, String) {
Dec 01 20:38:05.218 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 01 20:38:05.218 INFO [stderr] 
Dec 01 20:38:05.218 INFO [stderr] warning: method is never used: `latest_version_for_path`
Dec 01 20:38:05.218 INFO [stderr]   --> src/storage.rs:91:5
Dec 01 20:38:05.218 INFO [stderr]    |
Dec 01 20:38:05.218 INFO [stderr] 91 |     fn latest_version_for_path(&self, path: &str) -> Option<Version> {
Dec 01 20:38:05.218 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 01 20:38:05.218 INFO [stderr] 
Dec 01 20:38:06.308 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2.01s
Dec 01 20:38:06.313 INFO [stderr] su: No module specific data is present
Dec 01 20:38:06.896 INFO running `"docker" "inspect" "639b50ae181cdd6f5b1c631eabf2ec58d97abfc82b50ca1b64a71ba95e5b0039"`
Dec 01 20:38:07.009 INFO running `"docker" "rm" "-f" "639b50ae181cdd6f5b1c631eabf2ec58d97abfc82b50ca1b64a71ba95e5b0039"`
Dec 01 20:38:07.109 INFO [stdout] 639b50ae181cdd6f5b1c631eabf2ec58d97abfc82b50ca1b64a71ba95e5b0039
Dec 01 20:38:07.112 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-5/worker-3/1.30.1:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/beta-1.31-5/1.30.1:/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 +1.30.1 test --frozen --no-run" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 01 20:38:07.381 INFO [stdout] 09b4a144b794397f9ff66f45019fe308c7c7cd273001c67f7cc5776ac78778ac
Dec 01 20:38:07.385 INFO running `"docker" "start" "-a" "09b4a144b794397f9ff66f45019fe308c7c7cd273001c67f7cc5776ac78778ac"`
Dec 01 20:38:07.742 INFO [stderr] usermod: no changes
Dec 01 20:38:07.795 INFO [stderr]    Compiling dir-diff v0.3.1
Dec 01 20:38:08.266 INFO [stderr]    Compiling bakare v0.1.0 (/source)
Dec 01 20:38:09.317 INFO [stderr] warning: unused variable: `path`
Dec 01 20:38:09.317 INFO [stderr]   --> src/backup.rs:32:32
Dec 01 20:38:09.317 INFO [stderr]    |
Dec 01 20:38:09.317 INFO [stderr] 32 |     pub fn file_version(&self, path: &Path) -> Version {
Dec 01 20:38:09.317 INFO [stderr]    |                                ^^^^ help: consider using `_path` instead
Dec 01 20:38:09.317 INFO [stderr]    |
Dec 01 20:38:09.317 INFO [stderr]    = note: #[warn(unused_variables)] on by default
Dec 01 20:38:09.317 INFO [stderr] 
Dec 01 20:38:09.317 INFO [stderr] warning: unused variable: `what`
Dec 01 20:38:09.317 INFO [stderr]   --> src/restore.rs:34:41
Dec 01 20:38:09.317 INFO [stderr]    |
Dec 01 20:38:09.317 INFO [stderr] 34 |     pub fn restore_as_of_version(&self, what: WhatToRestore, version: Version) -> Result<(), io::Error> {
Dec 01 20:38:09.317 INFO [stderr]    |                                         ^^^^ help: consider using `_what` instead
Dec 01 20:38:09.317 INFO [stderr] 
Dec 01 20:38:09.317 INFO [stderr] warning: unused variable: `version`
Dec 01 20:38:09.317 INFO [stderr]   --> src/restore.rs:34:62
Dec 01 20:38:09.317 INFO [stderr]    |
Dec 01 20:38:09.317 INFO [stderr] 34 |     pub fn restore_as_of_version(&self, what: WhatToRestore, version: Version) -> Result<(), io::Error> {
Dec 01 20:38:09.317 INFO [stderr]    |                                                              ^^^^^^^ help: consider using `_version` instead
Dec 01 20:38:09.317 INFO [stderr] 
Dec 01 20:38:10.446 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2.69s
Dec 01 20:38:10.451 INFO [stderr] su: No module specific data is present
Dec 01 20:38:11.094 INFO running `"docker" "inspect" "09b4a144b794397f9ff66f45019fe308c7c7cd273001c67f7cc5776ac78778ac"`
Dec 01 20:38:11.200 INFO running `"docker" "rm" "-f" "09b4a144b794397f9ff66f45019fe308c7c7cd273001c67f7cc5776ac78778ac"`
Dec 01 20:38:11.368 INFO [stdout] 09b4a144b794397f9ff66f45019fe308c7c7cd273001c67f7cc5776ac78778ac
Dec 01 20:38:11.372 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-5/worker-3/1.30.1:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/beta-1.31-5/1.30.1:/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 +1.30.1 test --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 01 20:38:11.636 INFO [stdout] 339963a8304f19ea6e835791945b297cb072fa1eb5a43e2cf9b91914c2d8aa8f
Dec 01 20:38:11.638 INFO running `"docker" "start" "-a" "339963a8304f19ea6e835791945b297cb072fa1eb5a43e2cf9b91914c2d8aa8f"`
Dec 01 20:38:12.165 INFO [stderr] usermod: no changes
Dec 01 20:38:12.226 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.04s
Dec 01 20:38:12.239 INFO [stderr]      Running /target/debug/deps/bakare-d58a2b8cf58ee5f1
Dec 01 20:38:12.240 INFO [stdout] 
Dec 01 20:38:12.240 INFO [stdout] running 3 tests
Dec 01 20:38:12.250 INFO [stdout] test storage::should::support_deduplication ... ok
Dec 01 20:38:12.251 INFO [stdout] test storage::should::support_file_versions ... ok
Dec 01 20:38:12.268 INFO [stdout] test backup::should::store_file_where_index_tells_it ... FAILED
Dec 01 20:38:12.269 INFO [stdout] 
Dec 01 20:38:12.269 INFO [stdout] failures:
Dec 01 20:38:12.269 INFO [stdout] 
Dec 01 20:38:12.269 INFO [stdout] ---- backup::should::store_file_where_index_tells_it stdout ----
Dec 01 20:38:12.269 INFO [stdout] thread 'backup::should::store_file_where_index_tells_it' panicked at 'assertion failed: false', src/backup.rs:59:9
Dec 01 20:38:12.269 INFO [stdout] stack backtrace:
Dec 01 20:38:12.269 INFO [stdout]    0:     0x56400401421e - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h15749a98198ba25f
Dec 01 20:38:12.269 INFO [stdout]                                at libstd/sys/unix/backtrace/tracing/gcc_s.rs:49
Dec 01 20:38:12.269 INFO [stdout]    1:     0x5640040075a6 - std::sys_common::backtrace::print::h0ba65c811294dbf0
Dec 01 20:38:12.269 INFO [stdout]                                at libstd/sys_common/backtrace.rs:71
Dec 01 20:38:12.269 INFO [stdout]                                at libstd/sys_common/backtrace.rs:59
Dec 01 20:38:12.269 INFO [stdout]    2:     0x5640040059cd - std::panicking::default_hook::{{closure}}::h42bb31757f0fee64
Dec 01 20:38:12.269 INFO [stdout]                                at libstd/panicking.rs:211
Dec 01 20:38:12.269 INFO [stdout]    3:     0x5640040056db - std::panicking::default_hook::hebc8848d7aa7dbd9
Dec 01 20:38:12.269 INFO [stdout]                                at libstd/panicking.rs:221
Dec 01 20:38:12.269 INFO [stdout]    4:     0x56400400607c - std::panicking::rust_panic_with_hook::h86e619a638415243
Dec 01 20:38:12.269 INFO [stdout]                                at libstd/panicking.rs:477
Dec 01 20:38:12.269 INFO [stdout]    5:     0x5640040023df - std::panicking::begin_panic::h40a16b41322bffb5
Dec 01 20:38:12.269 INFO [stdout]                                at libstd/panicking.rs:411
Dec 01 20:38:12.269 INFO [stdout]    6:     0x564003fb9730 - bakare::backup::should::store_file_where_index_tells_it::hc363cefc4b24f35d
Dec 01 20:38:12.269 INFO [stdout]                                at src/backup.rs:59
Dec 01 20:38:12.269 INFO [stdout]    7:     0x564003fb96f9 - bakare::backup::should::store_file_where_index_tells_it::{{closure}}::ha2d74b236f73f9b3
Dec 01 20:38:12.269 INFO [stdout]                                at src/backup.rs:55
Dec 01 20:38:12.269 INFO [stdout]    8:     0x564003fb8ebd - core::ops::function::FnOnce::call_once::h9dd9502661bde76d
Dec 01 20:38:12.269 INFO [stdout]                                at libcore/ops/function.rs:238
Dec 01 20:38:12.269 INFO [stdout]    9:     0x564003fc379e - <F as alloc::boxed::FnBox<A>>::call_box::hbea525814fa423cc
Dec 01 20:38:12.269 INFO [stdout]                                at libtest/lib.rs:1461
Dec 01 20:38:12.269 INFO [stdout]                                at libcore/ops/function.rs:238
Dec 01 20:38:12.269 INFO [stdout]                                at liballoc/boxed.rs:646
Dec 01 20:38:12.269 INFO [stdout]   10:     0x564004023089 - __rust_maybe_catch_panic
Dec 01 20:38:12.269 INFO [stdout]                                at libpanic_unwind/lib.rs:103
Dec 01 20:38:12.269 INFO [stdout]   11:     0x564003fcf0fd - std::sys_common::backtrace::__rust_begin_short_backtrace::h0ff507d7422944d3
Dec 01 20:38:12.269 INFO [stdout]                                at libstd/panicking.rs:289
Dec 01 20:38:12.269 INFO [stdout]                                at libstd/panic.rs:392
Dec 01 20:38:12.269 INFO [stdout]                                at libtest/lib.rs:1416
Dec 01 20:38:12.269 INFO [stdout]                                at libstd/sys_common/backtrace.rs:136
Dec 01 20:38:12.269 INFO [stdout]   12:     0x564003fe7734 - std::panicking::try::do_call::hba0bdcc3670471cc
Dec 01 20:38:12.269 INFO [stdout]                                at libstd/thread/mod.rs:409
Dec 01 20:38:12.269 INFO [stdout]                                at libstd/panic.rs:313
Dec 01 20:38:12.269 INFO [stdout]                                at libstd/panicking.rs:310
Dec 01 20:38:12.269 INFO [stdout]   13:     0x564004023089 - __rust_maybe_catch_panic
Dec 01 20:38:12.269 INFO [stdout]                                at libpanic_unwind/lib.rs:103
Dec 01 20:38:12.269 INFO [stdout]   14:     0x564003fd8006 - <F as alloc::boxed::FnBox<A>>::call_box::hdac52587b00591af
Dec 01 20:38:12.269 INFO [stdout]                                at libstd/panicking.rs:289
Dec 01 20:38:12.269 INFO [stdout]                                at libstd/panic.rs:392
Dec 01 20:38:12.269 INFO [stdout]                                at libstd/thread/mod.rs:408
Dec 01 20:38:12.269 INFO [stdout]                                at liballoc/boxed.rs:646
Dec 01 20:38:12.269 INFO [stdout]   15:     0x564004015b2a - std::sys_common::thread::start_thread::h75d887c7d2cc4479
Dec 01 20:38:12.269 INFO [stdout]                                at liballoc/boxed.rs:656
Dec 01 20:38:12.269 INFO [stdout]                                at libstd/sys_common/thread.rs:24
Dec 01 20:38:12.269 INFO [stdout]   16:     0x5640040067e5 - std::sys::unix::thread::Thread::new::thread_start::h8414caee632bf9ed
Dec 01 20:38:12.269 INFO [stdout]                                at libstd/sys/unix/thread.rs:90
Dec 01 20:38:12.269 INFO [stdout]   17:     0x7fa37b2156b9 - start_thread
Dec 01 20:38:12.269 INFO [stdout]   18:     0x7fa37ad3541c - clone
Dec 01 20:38:12.269 INFO [stdout]   19:                0x0 - <unknown>
Dec 01 20:38:12.269 INFO [stdout] 
Dec 01 20:38:12.269 INFO [stdout] 
Dec 01 20:38:12.269 INFO [stdout] failures:
Dec 01 20:38:12.269 INFO [stdout]     backup::should::store_file_where_index_tells_it
Dec 01 20:38:12.269 INFO [stdout] 
Dec 01 20:38:12.269 INFO [stdout] test result: FAILED. 2 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out
Dec 01 20:38:12.269 INFO [stdout] 
Dec 01 20:38:12.271 INFO [stderr] error: test failed, to rerun pass '--lib'
Dec 01 20:38:12.272 INFO [stderr] su: No module specific data is present
Dec 01 20:38:12.548 INFO running `"docker" "inspect" "339963a8304f19ea6e835791945b297cb072fa1eb5a43e2cf9b91914c2d8aa8f"`
Dec 01 20:38:12.721 INFO running `"docker" "rm" "-f" "339963a8304f19ea6e835791945b297cb072fa1eb5a43e2cf9b91914c2d8aa8f"`
Dec 01 20:38:13.071 INFO [stdout] 339963a8304f19ea6e835791945b297cb072fa1eb5a43e2cf9b91914c2d8aa8f
