Dec 07 19:54:39.969 INFO testing conserve-0.5.1 against try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468 for pr-56514
Dec 07 19:54:39.969 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-4/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-56514/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/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 +6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468-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.234 INFO [stdout] 0a34c230bed3ac274627d9c5529c27a0e76aeb388632c41b1859bd679e789630
Dec 07 19:54:40.236 INFO running `"docker" "start" "-a" "0a34c230bed3ac274627d9c5529c27a0e76aeb388632c41b1859bd679e789630"`
Dec 07 19:54:40.770 INFO [stderr] usermod: no changes
Dec 07 19:54:40.948 INFO [stderr]    Compiling thousands v0.1.2
Dec 07 19:54:40.951 INFO [stderr]    Compiling chrono v0.2.25
Dec 07 19:54:43.363 INFO [stderr]    Compiling conserve v0.5.1 (/source)
Dec 07 19:54:55.719 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 14.93s
Dec 07 19:54:55.740 INFO [stderr] su: No module specific data is present
Dec 07 19:54:56.221 INFO running `"docker" "inspect" "0a34c230bed3ac274627d9c5529c27a0e76aeb388632c41b1859bd679e789630"`
Dec 07 19:54:56.287 INFO running `"docker" "rm" "-f" "0a34c230bed3ac274627d9c5529c27a0e76aeb388632c41b1859bd679e789630"`
Dec 07 19:54:56.380 INFO [stdout] 0a34c230bed3ac274627d9c5529c27a0e76aeb388632c41b1859bd679e789630
Dec 07 19:54:56.382 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-4/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-56514/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/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 +6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468-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:56.652 INFO [stdout] 6700c43f79050d1719c7bcb98f372299320c2247d8f3e987e83af7ee78ebde6d
Dec 07 19:54:56.654 INFO running `"docker" "start" "-a" "6700c43f79050d1719c7bcb98f372299320c2247d8f3e987e83af7ee78ebde6d"`
Dec 07 19:54:57.216 INFO [stderr] usermod: no changes
Dec 07 19:54:57.424 INFO [stderr]    Compiling predicates v1.0.0
Dec 07 19:54:57.424 INFO [stderr]    Compiling escargot v0.3.1
Dec 07 19:54:57.424 INFO [stderr]    Compiling globwalk v0.5.0
Dec 07 19:55:01.209 INFO [stderr]    Compiling assert_fs v0.10.0
Dec 07 19:55:01.826 INFO [stderr]    Compiling assert_cmd v0.10.2
Dec 07 19:55:04.632 INFO [stderr]    Compiling conserve v0.5.1 (/source)
Dec 07 19:55:21.035 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 23.80s
Dec 07 19:55:21.049 INFO [stderr] su: No module specific data is present
Dec 07 19:55:21.545 INFO running `"docker" "inspect" "6700c43f79050d1719c7bcb98f372299320c2247d8f3e987e83af7ee78ebde6d"`
Dec 07 19:55:21.730 INFO running `"docker" "rm" "-f" "6700c43f79050d1719c7bcb98f372299320c2247d8f3e987e83af7ee78ebde6d"`
Dec 07 19:55:21.924 INFO [stdout] 6700c43f79050d1719c7bcb98f372299320c2247d8f3e987e83af7ee78ebde6d
Dec 07 19:55:21.930 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-4/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-56514/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/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 +6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468-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:22.276 INFO [stdout] c3038ad0900491a66916019358f556287fbe32c57028f52489fb885b872273d0
Dec 07 19:55:22.278 INFO running `"docker" "start" "-a" "c3038ad0900491a66916019358f556287fbe32c57028f52489fb885b872273d0"`
Dec 07 19:55:23.452 INFO [stderr] usermod: no changes
Dec 07 19:55:23.680 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.20s
Dec 07 19:55:23.695 INFO [stderr]      Running /target/debug/deps/conserve-30a449bd80552681
Dec 07 19:55:23.697 INFO [stdout] 
Dec 07 19:55:23.697 INFO [stdout] running 52 tests
Dec 07 19:55:23.698 INFO [stdout] test apath::tests::invalid ... ok
Dec 07 19:55:23.699 INFO [stdout] test archive::tests::init_empty_dir ... ok
Dec 07 19:55:23.710 INFO [stdout] test apath::tests::valid_and_ordered ... ok
Dec 07 19:55:23.714 INFO [stdout] test backup::tests::empty_file_uses_zero_blocks ... ok
Dec 07 19:55:23.716 INFO [stdout] test backup::tests::symlink ... ok
Dec 07 19:55:23.716 INFO [stdout] test band::tests::create_existing_band ... ok
Dec 07 19:55:23.717 INFO [stdout] test archive::tests::empty_archive ... ok
Dec 07 19:55:23.720 INFO [stdout] test archive::tests::create_bands ... ok
Dec 07 19:55:23.721 INFO [stdout] test archive::tests::create_then_open_archive ... ok
Dec 07 19:55:23.724 INFO [stdout] test band::tests::create_and_reopen_band ... ok
Dec 07 19:55:23.728 INFO [stdout] test bandid::tests::format ... ok
Dec 07 19:55:23.728 INFO [stdout] test bandid::tests::to_string ... ok
Dec 07 19:55:23.728 INFO [stdout] test bandid::tests::next ... ok
Dec 07 19:55:23.732 INFO [stdout] test bandid::tests::equality ... ok
Dec 07 19:55:23.732 INFO [stdout] test bandid::tests::from_string_detects_invalid ... ok
Dec 07 19:55:23.732 INFO [stdout] test bandid::tests::zero ... ok
Dec 07 19:55:23.738 INFO [stdout] test bandid::tests::from_string_valid ... ok
Dec 07 19:55:23.738 INFO [stdout] test excludes::tests::extendend_pattern_parse ... ok
Dec 07 19:55:23.760 INFO [stdout] test excludes::tests::simple_parse ... ok
Dec 07 19:55:23.788 INFO [stdout] test excludes::tests::nothing_parse ... ok
Dec 07 19:55:23.805 INFO [stdout] test excludes::tests::path_parse ... ok
Dec 07 19:55:23.844 INFO [stdout] test index::tests::basic ... ok
Dec 07 19:55:23.848 INFO [stdout] test index::tests::excluded_entries ... ok
Dec 07 19:55:23.848 INFO [stdout] test index::tests::multiple_hunks ... ok
Dec 07 19:55:24.060 INFO [stdout] test bandid::tests::empty_id_not_allowed ... ok
Dec 07 19:55:24.072 INFO [stdout] test index::tests::no_duplicate_paths_across_hunks ... ok
Dec 07 19:55:24.072 INFO [stdout] test blockdir::tests::write_to_file ... ok
Dec 07 19:55:24.080 INFO [stdout] test index::tests::path_for_hunk ... ok
Dec 07 19:55:24.085 INFO [stdout] test index::tests::serialize_index ... ok
Dec 07 19:55:24.088 INFO [stdout] test index::tests::index_builder_checks_order ... ok
Dec 07 19:55:24.088 INFO [stdout] test index::tests::index_builder_checks_names ... ok
Dec 07 19:55:24.108 INFO [stdout] test index::tests::no_duplicate_paths ... ok
Dec 07 19:55:24.108 INFO [stdout] test live_tree::tests::symlinks ... ok
Dec 07 19:55:24.108 INFO [stdout] test live_tree::tests::open_tree ... ok
Dec 07 19:55:24.108 INFO [stdout] test live_tree::tests::simple_directory ... ok
Dec 07 19:55:24.116 INFO [stdout] test jsonio::tests::read_write_json ... ok
Dec 07 19:55:24.116 INFO [stdout] test report::tests::count ... ok
Dec 07 19:55:24.128 INFO [stdout] test report::tests::display ... ok
Dec 07 19:55:24.128 INFO [stdout] test report::tests::merge_reports ... ok
Dec 07 19:55:24.148 INFO [stdout] test live_tree::tests::exclude_entries_directory ... ok
Dec 07 19:55:24.360 INFO [stdout] test backup::tests::excludes ... ok
Dec 07 19:55:24.376 INFO [stdout] test stored_tree::test::cant_open_no_versions ... ok
Dec 07 19:55:24.820 INFO [stdout] test blockdir::tests::write_same_data_again ... ok
Dec 07 19:55:24.820 INFO [stdout] test ui::tests::by_name ... ok
Dec 07 19:55:24.826 INFO [stdout] test ui::tests::test_compression_ratio ... ok
Dec 07 19:55:24.892 INFO [stdout] test restore::tests::exclude_files ... ok
Dec 07 19:55:25.080 INFO [stdout] test restore::tests::simple_restore ... ok
Dec 07 19:55:25.301 INFO [stdout] test restore::tests::decline_to_overwrite ... ok
Dec 07 19:55:25.560 INFO [stdout] test restore::tests::forced_overwrite ... ok
Dec 07 19:55:25.855 INFO [stdout] test stored_tree::test::open_stored_tree ... ok
Dec 07 19:55:25.855 INFO [stdout] test restore::tests::restore_named_band ... ok
Dec 07 19:55:30.618 INFO [stdout] test blockdir::tests::large_file ... ok
Dec 07 19:55:30.618 INFO [stdout] 
Dec 07 19:55:30.618 INFO [stdout] test result: ok. 52 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 19:55:30.618 INFO [stdout] 
Dec 07 19:55:30.625 INFO [stderr]      Running /target/debug/deps/conserve-fa4558c749825f8c
Dec 07 19:55:30.627 INFO [stdout] 
Dec 07 19:55:30.627 INFO [stdout] running 0 tests
Dec 07 19:55:30.627 INFO [stdout] 
Dec 07 19:55:30.627 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 19:55:30.627 INFO [stdout] 
Dec 07 19:55:30.629 INFO [stderr]      Running /target/debug/deps/blackbox-cc64302142bc71a6
Dec 07 19:55:30.631 INFO [stdout] 
Dec 07 19:55:30.631 INFO [stdout] running 6 tests
Dec 07 19:55:30.863 INFO [stdout] test blackbox_help ... ok
Dec 07 19:55:30.870 INFO [stdout] test blackbox_no_args ... ok
Dec 07 19:55:30.870 INFO [stdout] test clean_error_on_non_archive ... ok
Dec 07 19:55:30.892 INFO [stdout] test incomplete_version ... ok
Dec 07 19:55:30.897 INFO [stdout] test empty_archive ... ok
Dec 07 19:55:31.072 INFO [stdout] test blackbox_backup ... ok
Dec 07 19:55:31.072 INFO [stdout] 
Dec 07 19:55:31.072 INFO [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 19:55:31.072 INFO [stdout] 
Dec 07 19:55:31.076 INFO [stderr]      Running /target/debug/deps/integration-c34f7c74440d08b3
Dec 07 19:55:31.084 INFO [stdout] 
Dec 07 19:55:31.084 INFO [stdout] running 3 tests
Dec 07 19:55:31.331 INFO [stdout] test simple_backup ... ok
Dec 07 19:55:31.384 INFO [stdout] test simple_backup_with_excludes ... ok
Dec 07 19:55:35.733 INFO [stdout] test large_file ... ok
Dec 07 19:55:35.733 INFO [stdout] 
Dec 07 19:55:35.733 INFO [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 19:55:35.733 INFO [stdout] 
Dec 07 19:55:35.742 INFO [stderr]    Doc-tests conserve
Dec 07 19:55:40.656 INFO [stdout] 
Dec 07 19:55:40.657 INFO [stdout] running 0 tests
Dec 07 19:55:40.657 INFO [stdout] 
Dec 07 19:55:40.657 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 19:55:40.657 INFO [stdout] 
Dec 07 19:55:40.672 INFO [stderr] su: No module specific data is present
Dec 07 19:55:41.624 INFO running `"docker" "inspect" "c3038ad0900491a66916019358f556287fbe32c57028f52489fb885b872273d0"`
Dec 07 19:55:41.946 INFO running `"docker" "rm" "-f" "c3038ad0900491a66916019358f556287fbe32c57028f52489fb885b872273d0"`
Dec 07 19:55:42.354 INFO [stdout] c3038ad0900491a66916019358f556287fbe32c57028f52489fb885b872273d0