Dec 07 19:54:40.166 INFO testing conserve-0.5.1 against master#906deae0790bd18681b937fe9a141a3c26cf1855 for pr-56514
Dec 07 19:54:40.166 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-7/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/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 07 19:54:40.324 INFO [stdout] 9874946d8dbe9719872fb65303de87daa2eefebd5fda72c700e3e52792521d04
Dec 07 19:54:40.326 INFO running `"docker" "start" "-a" "9874946d8dbe9719872fb65303de87daa2eefebd5fda72c700e3e52792521d04"`
Dec 07 19:54:40.798 INFO [stderr] usermod: no changes
Dec 07 19:54:41.052 INFO [stderr]    Compiling thousands v0.1.2
Dec 07 19:54:41.056 INFO [stderr]    Compiling terminal_size v0.1.8
Dec 07 19:54:41.746 INFO [stderr]    Compiling conserve v0.5.1 (/source)
Dec 07 19:54:56.516 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 15.65s
Dec 07 19:54:56.516 INFO [stderr] su: No module specific data is present
Dec 07 19:54:56.858 INFO running `"docker" "inspect" "9874946d8dbe9719872fb65303de87daa2eefebd5fda72c700e3e52792521d04"`
Dec 07 19:54:57.013 INFO running `"docker" "rm" "-f" "9874946d8dbe9719872fb65303de87daa2eefebd5fda72c700e3e52792521d04"`
Dec 07 19:54:57.152 INFO [stdout] 9874946d8dbe9719872fb65303de87daa2eefebd5fda72c700e3e52792521d04
Dec 07 19:54:57.156 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-7/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/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 07 19:54:57.375 INFO [stdout] 5525b1c2ded8a958b673875ad990af6a7d11c1a4ea6e30b17ff8e1c2a82eae55
Dec 07 19:54:57.379 INFO running `"docker" "start" "-a" "5525b1c2ded8a958b673875ad990af6a7d11c1a4ea6e30b17ff8e1c2a82eae55"`
Dec 07 19:54:58.152 INFO [stderr] usermod: no changes
Dec 07 19:54:58.400 INFO [stderr]    Compiling predicates v1.0.0
Dec 07 19:54:58.400 INFO [stderr]    Compiling serde_json v1.0.33
Dec 07 19:54:58.432 INFO [stderr]    Compiling globwalk v0.5.0
Dec 07 19:55:02.891 INFO [stderr]    Compiling assert_fs v0.10.0
Dec 07 19:55:06.990 INFO [stderr]    Compiling escargot v0.3.1
Dec 07 19:55:09.712 INFO [stderr]    Compiling assert_cmd v0.10.2
Dec 07 19:55:13.244 INFO [stderr]    Compiling conserve v0.5.1 (/source)
Dec 07 19:55:33.868 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 35.68s
Dec 07 19:55:33.874 INFO [stderr] su: No module specific data is present
Dec 07 19:55:34.533 INFO running `"docker" "inspect" "5525b1c2ded8a958b673875ad990af6a7d11c1a4ea6e30b17ff8e1c2a82eae55"`
Dec 07 19:55:34.916 INFO running `"docker" "rm" "-f" "5525b1c2ded8a958b673875ad990af6a7d11c1a4ea6e30b17ff8e1c2a82eae55"`
Dec 07 19:55:35.188 INFO [stdout] 5525b1c2ded8a958b673875ad990af6a7d11c1a4ea6e30b17ff8e1c2a82eae55
Dec 07 19:55:35.196 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-7/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/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 07 19:55:35.595 INFO [stdout] 0978fe65dc71415ecf5f2138fd98ff5ad9226220d23a0ef85c4f4c65037dc776
Dec 07 19:55:35.598 INFO running `"docker" "start" "-a" "0978fe65dc71415ecf5f2138fd98ff5ad9226220d23a0ef85c4f4c65037dc776"`
Dec 07 19:55:36.370 INFO [stderr] usermod: no changes
Dec 07 19:55:36.545 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.15s
Dec 07 19:55:36.551 INFO [stderr]      Running /target/debug/deps/conserve-5061107c1ceaf2e2
Dec 07 19:55:36.554 INFO [stdout] 
Dec 07 19:55:36.554 INFO [stdout] running 52 tests
Dec 07 19:55:36.562 INFO [stdout] test apath::tests::valid_and_ordered ... ok
Dec 07 19:55:36.562 INFO [stdout] test archive::tests::create_then_open_archive ... ok
Dec 07 19:55:36.562 INFO [stdout] test apath::tests::invalid ... ok
Dec 07 19:55:36.564 INFO [stdout] test archive::tests::create_bands ... ok
Dec 07 19:55:36.580 INFO [stdout] test archive::tests::init_empty_dir ... ok
Dec 07 19:55:36.596 INFO [stdout] test bandid::tests::equality ... ok
Dec 07 19:55:36.596 INFO [stdout] test backup::tests::empty_file_uses_zero_blocks ... ok
Dec 07 19:55:36.596 INFO [stdout] test band::tests::create_existing_band ... ok
Dec 07 19:55:36.600 INFO [stdout] test bandid::tests::format ... ok
Dec 07 19:55:36.600 INFO [stdout] test bandid::tests::from_string_detects_invalid ... ok
Dec 07 19:55:36.616 INFO [stdout] test bandid::tests::from_string_valid ... ok
Dec 07 19:55:36.616 INFO [stdout] test bandid::tests::next ... ok
Dec 07 19:55:36.616 INFO [stdout] test band::tests::create_and_reopen_band ... ok
Dec 07 19:55:36.616 INFO [stdout] test backup::tests::symlink ... ok
Dec 07 19:55:36.616 INFO [stdout] test bandid::tests::zero ... ok
Dec 07 19:55:36.626 INFO [stdout] test archive::tests::empty_archive ... ok
Dec 07 19:55:36.628 INFO [stdout] test bandid::tests::to_string ... ok
Dec 07 19:55:36.636 INFO [stdout] test excludes::tests::extendend_pattern_parse ... ok
Dec 07 19:55:36.648 INFO [stdout] test excludes::tests::nothing_parse ... ok
Dec 07 19:55:36.660 INFO [stdout] test excludes::tests::path_parse ... ok
Dec 07 19:55:36.660 INFO [stdout] test index::tests::basic ... ok
Dec 07 19:55:36.660 INFO [stdout] test excludes::tests::simple_parse ... ok
Dec 07 19:55:36.668 INFO [stdout] test index::tests::excluded_entries ... ok
Dec 07 19:55:36.700 INFO [stdout] test index::tests::multiple_hunks ... ok
Dec 07 19:55:36.736 INFO [stdout] test backup::tests::excludes ... ok
Dec 07 19:55:36.736 INFO [stdout] test blockdir::tests::write_to_file ... ok
Dec 07 19:55:36.743 INFO [stdout] test index::tests::path_for_hunk ... ok
Dec 07 19:55:36.760 INFO [stdout] test index::tests::serialize_index ... ok
Dec 07 19:55:36.764 INFO [stdout] test jsonio::tests::read_write_json ... ok
Dec 07 19:55:36.794 INFO [stdout] test live_tree::tests::exclude_entries_directory ... ok
Dec 07 19:55:36.808 INFO [stdout] test index::tests::index_builder_checks_order ... ok
Dec 07 19:55:36.811 INFO [stdout] test index::tests::no_duplicate_paths ... ok
Dec 07 19:55:36.811 INFO [stdout] test index::tests::no_duplicate_paths_across_hunks ... ok
Dec 07 19:55:36.811 INFO [stdout] test live_tree::tests::open_tree ... ok
Dec 07 19:55:36.811 INFO [stdout] test bandid::tests::empty_id_not_allowed ... ok
Dec 07 19:55:36.811 INFO [stdout] test index::tests::index_builder_checks_names ... ok
Dec 07 19:55:36.824 INFO [stdout] test live_tree::tests::simple_directory ... ok
Dec 07 19:55:36.824 INFO [stdout] test report::tests::merge_reports ... ok
Dec 07 19:55:36.825 INFO [stdout] test report::tests::display ... ok
Dec 07 19:55:36.825 INFO [stdout] test report::tests::count ... ok
Dec 07 19:55:36.844 INFO [stdout] test live_tree::tests::symlinks ... ok
Dec 07 19:55:36.852 INFO [stdout] test stored_tree::test::cant_open_no_versions ... ok
Dec 07 19:55:36.912 INFO [stdout] test blockdir::tests::write_same_data_again ... ok
Dec 07 19:55:36.932 INFO [stdout] test ui::tests::by_name ... ok
Dec 07 19:55:36.940 INFO [stdout] test ui::tests::test_compression_ratio ... ok
Dec 07 19:55:37.537 INFO [stdout] test stored_tree::test::open_stored_tree ... ok
Dec 07 19:55:37.749 INFO [stdout] test restore::tests::simple_restore ... ok
Dec 07 19:55:37.760 INFO [stdout] test restore::tests::exclude_files ... ok
Dec 07 19:55:37.860 INFO [stdout] test restore::tests::restore_named_band ... ok
Dec 07 19:55:37.904 INFO [stdout] test restore::tests::decline_to_overwrite ... ok
Dec 07 19:55:38.147 INFO [stdout] test restore::tests::forced_overwrite ... ok
Dec 07 19:55:40.967 INFO [stdout] test blockdir::tests::large_file ... ok
Dec 07 19:55:40.967 INFO [stdout] 
Dec 07 19:55:40.967 INFO [stdout] test result: ok. 52 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 19:55:40.967 INFO [stdout] 
Dec 07 19:55:40.976 INFO [stdout] 
Dec 07 19:55:40.976 INFO [stderr]      Running /target/debug/deps/conserve-1b6c5e288908888d
Dec 07 19:55:40.976 INFO [stdout] running 0 tests
Dec 07 19:55:40.976 INFO [stderr]      Running /target/debug/deps/blackbox-f9668ac1511fb67d
Dec 07 19:55:40.976 INFO [stdout] 
Dec 07 19:55:40.976 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 19:55:40.976 INFO [stdout] 
Dec 07 19:55:40.984 INFO [stdout] 
Dec 07 19:55:40.984 INFO [stdout] running 6 tests
Dec 07 19:55:41.272 INFO [stdout] test clean_error_on_non_archive ... ok
Dec 07 19:55:41.272 INFO [stdout] test blackbox_no_args ... ok
Dec 07 19:55:41.276 INFO [stdout] test blackbox_help ... ok
Dec 07 19:55:41.292 INFO [stdout] test incomplete_version ... ok
Dec 07 19:55:41.300 INFO [stdout] test empty_archive ... ok
Dec 07 19:55:41.445 INFO [stdout] test blackbox_backup ... ok
Dec 07 19:55:41.445 INFO [stdout] 
Dec 07 19:55:41.445 INFO [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 19:55:41.445 INFO [stdout] 
Dec 07 19:55:41.448 INFO [stdout] 
Dec 07 19:55:41.448 INFO [stderr]      Running /target/debug/deps/integration-413effa997376cd7
Dec 07 19:55:41.448 INFO [stdout] running 3 tests
Dec 07 19:55:41.676 INFO [stdout] test simple_backup ... ok
Dec 07 19:55:41.683 INFO [stdout] test simple_backup_with_excludes ... ok
Dec 07 19:55:46.158 INFO [stdout] test large_file ... ok
Dec 07 19:55:46.158 INFO [stdout] 
Dec 07 19:55:46.159 INFO [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 19:55:46.159 INFO [stdout] 
Dec 07 19:55:46.160 INFO [stderr]    Doc-tests conserve
Dec 07 19:55:53.164 INFO [stdout] 
Dec 07 19:55:53.164 INFO [stdout] running 0 tests
Dec 07 19:55:53.164 INFO [stdout] 
Dec 07 19:55:53.164 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 19:55:53.164 INFO [stdout] 
Dec 07 19:55:53.186 INFO [stderr] su: No module specific data is present
Dec 07 19:55:54.335 INFO running `"docker" "inspect" "0978fe65dc71415ecf5f2138fd98ff5ad9226220d23a0ef85c4f4c65037dc776"`
Dec 07 19:55:54.564 INFO running `"docker" "rm" "-f" "0978fe65dc71415ecf5f2138fd98ff5ad9226220d23a0ef85c4f4c65037dc776"`
Dec 07 19:55:54.819 INFO [stdout] 0978fe65dc71415ecf5f2138fd98ff5ad9226220d23a0ef85c4f4c65037dc776