Dec 15 16:49:53.830 INFO testing ditto-0.2.0 against try#aa49d8ef14939ddec0e34b346b60174a5673d48f for pr-56550
Dec 15 16:49:53.830 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-5/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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 15 16:49:54.163 INFO [stdout] d30442b024fada4f18ecc2f630daa1212465a5595ecff4deaaa53b7581e2deea
Dec 15 16:49:54.168 INFO running `"docker" "start" "-a" "d30442b024fada4f18ecc2f630daa1212465a5595ecff4deaaa53b7581e2deea"`
Dec 15 16:49:55.164 INFO [stderr] usermod: no changes
Dec 15 16:49:55.335 INFO [stderr]    Compiling ditto v0.2.0 (/source)
Dec 15 16:50:04.509 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 9.31s
Dec 15 16:50:04.519 INFO [stderr] su: No module specific data is present
Dec 15 16:50:05.104 INFO running `"docker" "inspect" "d30442b024fada4f18ecc2f630daa1212465a5595ecff4deaaa53b7581e2deea"`
Dec 15 16:50:05.541 INFO running `"docker" "rm" "-f" "d30442b024fada4f18ecc2f630daa1212465a5595ecff4deaaa53b7581e2deea"`
Dec 15 16:50:05.802 INFO [stdout] d30442b024fada4f18ecc2f630daa1212465a5595ecff4deaaa53b7581e2deea
Dec 15 16:50:05.805 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-5/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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 15 16:50:06.276 INFO [stdout] e8409326a9034a3d6e412f7bae0ad4b5e063c826b00b29a4ca29139ab26175f9
Dec 15 16:50:06.278 INFO running `"docker" "start" "-a" "e8409326a9034a3d6e412f7bae0ad4b5e063c826b00b29a4ca29139ab26175f9"`
Dec 15 16:50:08.042 INFO [stderr] usermod: no changes
Dec 15 16:50:08.247 INFO [stderr]    Compiling ditto v0.2.0 (/source)
Dec 15 16:50:21.455 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 13.37s
Dec 15 16:50:21.455 INFO [stderr] su: No module specific data is present
Dec 15 16:50:22.651 INFO running `"docker" "inspect" "e8409326a9034a3d6e412f7bae0ad4b5e063c826b00b29a4ca29139ab26175f9"`
Dec 15 16:50:23.012 INFO running `"docker" "rm" "-f" "e8409326a9034a3d6e412f7bae0ad4b5e063c826b00b29a4ca29139ab26175f9"`
Dec 15 16:50:23.367 INFO [stdout] e8409326a9034a3d6e412f7bae0ad4b5e063c826b00b29a4ca29139ab26175f9
Dec 15 16:50:23.369 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-5/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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 15 16:50:23.817 INFO [stdout] 3d1510095839957767e06541922bb0ce248e1e4b341f3377aee51b794a58bb95
Dec 15 16:50:23.819 INFO running `"docker" "start" "-a" "3d1510095839957767e06541922bb0ce248e1e4b341f3377aee51b794a58bb95"`
Dec 15 16:50:25.718 INFO [stderr] usermod: no changes
Dec 15 16:50:25.916 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.15s
Dec 15 16:50:25.920 INFO [stderr]      Running /target/debug/deps/ditto-854727194650c792
Dec 15 16:50:25.928 INFO [stdout] 
Dec 15 16:50:25.928 INFO [stdout] running 126 tests
Dec 15 16:50:25.951 INFO [stdout] test json::tests::test_add_site_already_has_site ... ok
Dec 15 16:50:25.951 INFO [stdout] test json::tests::test_add_site_id ... ok
Dec 15 16:50:25.951 INFO [stdout] test json::tests::test_add_site_nested ... ok
Dec 15 16:50:25.951 INFO [stdout] test json::tests::test_array_insert ... ok
Dec 15 16:50:25.955 INFO [stdout] test json::tests::test_array_remove_invalid_pointer ... ok
Dec 15 16:50:25.975 INFO [stdout] test json::tests::test_array_remove_awaiting_site ... ok
Dec 15 16:50:25.975 INFO [stdout] test json::tests::test_array_insert_awaiting_site ... ok
Dec 15 16:50:25.975 INFO [stdout] test json::tests::test_array_remove ... ok
Dec 15 16:50:26.003 INFO [stdout] test json::tests::test_execute_op_object ... ok
Dec 15 16:50:26.011 INFO [stdout] test json::tests::test_from_str ... ok
Dec 15 16:50:26.011 INFO [stdout] test json::tests::test_execute_op_dupe ... ok
Dec 15 16:50:26.027 INFO [stdout] test json::tests::test_from_str_invalid ... ok
Dec 15 16:50:26.043 INFO [stdout] test json::tests::test_array_insert_invalid_pointer ... ok
Dec 15 16:50:26.043 INFO [stdout] test json::tests::test_execute_op_array ... ok
Dec 15 16:50:26.047 INFO [stdout] test json::tests::test_object_insert_awaiting_site_id ... ok
Dec 15 16:50:26.047 INFO [stdout] test json::tests::test_object_insert_invalid_pointer ... ok
Dec 15 16:50:26.055 INFO [stdout] test json::tests::test_object_insert_replaces_value ... ok
Dec 15 16:50:26.063 INFO [stdout] test json::tests::test_execute_op_missing_pointer ... ok
Dec 15 16:50:26.063 INFO [stdout] test json::tests::test_object_insert ... ok
Dec 15 16:50:26.063 INFO [stdout] test json::tests::test_object_insert_same_value ... ok
Dec 15 16:50:26.075 INFO [stdout] test json::tests::test_merge ... ok
Dec 15 16:50:26.095 INFO [stdout] test json::tests::test_object_remove_invalid_pointer ... ok
Dec 15 16:50:26.103 INFO [stdout] test json::tests::test_object_remove_does_not_exist ... ok
Dec 15 16:50:26.104 INFO [stdout] test json::tests::test_execute_op_string ... ok
Dec 15 16:50:26.113 INFO [stdout] test json::tests::test_replace_text ... ok
Dec 15 16:50:26.123 INFO [stdout] test sequence::uid::tests::test_between_basic ... ok
Dec 15 16:50:26.123 INFO [stdout] test json::tests::test_object_remove_awaiting_site ... ok
Dec 15 16:50:26.131 INFO [stdout] test json::tests::test_replace_text_awaiting_site ... ok
Dec 15 16:50:26.132 INFO [stdout] test sequence::uid::tests::test_between_first_is_longer ... ok
Dec 15 16:50:26.143 INFO [stdout] test json::tests::test_replace_text_invalid_pointer ... ok
Dec 15 16:50:26.147 INFO [stdout] test json::tests::test_object_remove ... ok
Dec 15 16:50:26.147 INFO [stdout] test sequence::uid::tests::test_between_equals ... ok
Dec 15 16:50:26.148 INFO [stdout] test sequence::uid::tests::test_between_squeeze ... ok
Dec 15 16:50:26.148 INFO [stdout] test sequence::uid::tests::test_max ... ok
Dec 15 16:50:26.155 INFO [stdout] test sequence::uid::tests::test_min ... ok
Dec 15 16:50:26.167 INFO [stdout] test sequence::uid::tests::test_between_first_is_shorter ... ok
Dec 15 16:50:26.171 INFO [stdout] test sequence::uid::tests::test_between_multi_level ... ok
Dec 15 16:50:26.171 INFO [stdout] test sequence::uid::tests::test_ord ... ok
Dec 15 16:50:26.171 INFO [stdout] test sequence::uid::tests::test_between_trivial ... ok
Dec 15 16:50:26.171 INFO [stdout] test sequence::uid::tests::test_serialize ... ok
Dec 15 16:50:26.171 INFO [stdout] test sequence::uid::tests::test_serialize_deserialize_invalid ... ok
Dec 15 16:50:26.175 INFO [stdout] test sequence::uid::tests::test_to_from_string ... ok
Dec 15 16:50:26.175 INFO [stdout] test text::text_edit::tests::merge_no_overlap ... ok
Dec 15 16:50:26.175 INFO [stdout] test text::text_edit::tests::merge_inside_insert ... ok
Dec 15 16:50:26.179 INFO [stdout] test text::text_edit::tests::merge_postfix_delete ... ok
Dec 15 16:50:26.179 INFO [stdout] test text::text_edit::tests::merge_internal_replacement ... ok
Dec 15 16:50:26.179 INFO [stdout] test text::text_edit::tests::merge_internal_delete ... ok
Dec 15 16:50:26.187 INFO [stdout] test text::text_edit::tests::merge_postfix_replacement ... ok
Dec 15 16:50:26.187 INFO [stdout] test text::text_edit::tests::merge_prefix_delete ... ok
Dec 15 16:50:26.187 INFO [stdout] test text::text_edit::tests::merge_postoverlapping_delete ... ok
Dec 15 16:50:26.187 INFO [stdout] test text::text_edit::tests::merge_postfix_insert ... ok
Dec 15 16:50:26.187 INFO [stdout] test text::text_edit::tests::merge_postoverlapping_replacement ... ok
Dec 15 16:50:26.211 INFO [stdout] test text::text_edit::tests::merge_prefix_insert ... ok
Dec 15 16:50:26.211 INFO [stdout] test text::text_edit::tests::merge_prefix_replacement ... ok
Dec 15 16:50:26.219 INFO [stdout] test text::text_edit::tests::merge_preoverlapping_delete ... ok
Dec 15 16:50:26.219 INFO [stdout] test text::text_edit::tests::merge_preoverlapping_replacement ... ok
Dec 15 16:50:26.219 INFO [stdout] test text::text_edit::tests::merge_wrapping_delete ... ok
Dec 15 16:50:26.223 INFO [stdout] test text::text_edit::tests::overwrite_inside_insert ... ok
Dec 15 16:50:26.223 INFO [stdout] test text::text_edit::tests::overwrite_internal_delete ... ok
Dec 15 16:50:26.223 INFO [stdout] test text::text_edit::tests::merge_wrapping_replacement ... ok
Dec 15 16:50:26.223 INFO [stdout] test text::text_edit::tests::overwrite_internal_replacement ... ok
Dec 15 16:50:26.223 INFO [stdout] test text::text_edit::tests::overwrite_postfix_delete ... ok
Dec 15 16:50:26.225 INFO [stdout] test text::text_edit::tests::overwrite_no_overlap ... ok
Dec 15 16:50:26.255 INFO [stdout] test text::text_edit::tests::overwrite_newline ... ok
Dec 15 16:50:26.255 INFO [stdout] test text::text_edit::tests::overwrite_postfix_replacement ... ok
Dec 15 16:50:26.255 INFO [stdout] test text::text_edit::tests::overwrite_postfix_insert ... ok
Dec 15 16:50:26.255 INFO [stdout] test text::text_edit::tests::overwrite_postoverlapping_delete ... ok
Dec 15 16:50:26.259 INFO [stdout] test text::text_edit::tests::overwrite_prefix_insert ... ok
Dec 15 16:50:26.259 INFO [stdout] test text::text_edit::tests::overwrite_prefix_delete ... ok
Dec 15 16:50:26.265 INFO [stdout] test text::text_edit::tests::overwrite_prefix_replacement ... ok
Dec 15 16:50:26.271 INFO [stdout] test text::text_edit::tests::overwrite_preoverlapping_delete ... ok
Dec 15 16:50:26.281 INFO [stdout] test text::text_edit::tests::overwrite_postoverlapping_replacement ... ok
Dec 15 16:50:26.281 INFO [stdout] test text::text_edit::tests::overwrite_prefix_insert2 ... ok
Dec 15 16:50:26.287 INFO [stdout] test text::text_edit::tests::overwrite_preoverlapping_replacement ... ok
Dec 15 16:50:26.287 INFO [stdout] test text::text_edit::tests::overwrite_wrapping_delete ... ok
Dec 15 16:50:26.287 INFO [stdout] test text::text_edit::tests::overwrite_toolong ... ok
Dec 15 16:50:26.287 INFO [stdout] test text::text_edit::tests::overwrite_wrapping_replacement ... ok
Dec 15 16:50:26.291 INFO [stdout] test text::text_edit::tests::shift_delete_after ... ok
Dec 15 16:50:26.291 INFO [stdout] test text::text_edit::tests::shift_delete_internal ... ok
Dec 15 16:50:26.291 INFO [stdout] test text::text_edit::tests::shift_delete_before ... ok
Dec 15 16:50:26.291 INFO [stdout] test text::text_edit::tests::shift_delete_postoverlapping ... ok
Dec 15 16:50:26.291 INFO [stdout] test text::text_edit::tests::shift_delete_prefix ... ok
Dec 15 16:50:26.291 INFO [stdout] test text::text_edit::tests::shift_delete_wrapping ... ok
Dec 15 16:50:26.303 INFO [stdout] test text::text_edit::tests::shift_delete_postfix ... ok
Dec 15 16:50:26.303 INFO [stdout] test text::text_edit::tests::shift_delete_preoverlapping ... ok
Dec 15 16:50:26.303 INFO [stdout] test text::text_edit::tests::shift_insert_internal ... ok
Dec 15 16:50:26.303 INFO [stdout] test text::text_edit::tests::shift_insert_after ... ok
Dec 15 16:50:26.303 INFO [stdout] test text::text_edit::tests::shift_insert_prefix ... ok
Dec 15 16:50:26.303 INFO [stdout] test text::text_edit::tests::shift_replace_after ... ok
Dec 15 16:50:26.315 INFO [stdout] test text::text_edit::tests::shift_insert_before ... ok
Dec 15 16:50:26.315 INFO [stdout] test text::text_edit::tests::shift_insert_postfix ... ok
Dec 15 16:50:26.315 INFO [stdout] test text::text_edit::tests::shift_replace_before ... ok
Dec 15 16:50:26.331 INFO [stdout] test text::text_edit::tests::shift_replace_postoverlapping ... ok
Dec 15 16:50:26.331 INFO [stdout] test text::text_edit::tests::shift_replace_postfix ... ok
Dec 15 16:50:26.331 INFO [stdout] test text::text_edit::tests::shift_replace_internal ... ok
Dec 15 16:50:26.331 INFO [stdout] test text::text_edit::tests::shift_replace_prefix ... ok
Dec 15 16:50:26.331 INFO [stdout] test tree::test::get_elt_empty ... ok
Dec 15 16:50:26.343 INFO [stdout] test text::text_edit::tests::shift_replace_preoverlapping ... ok
Dec 15 16:50:26.343 INFO [stdout] test text::text_edit::tests::shift_replace_wrapping ... ok
Dec 15 16:50:26.343 INFO [stdout] test tree::test::get_elt_nonempty ... ok
Dec 15 16:50:26.343 INFO [stdout] test tree::test::get_elt_out_of_bounds ... ok
Dec 15 16:50:26.359 INFO [stdout] test tree::test::get_idx_does_not_exist ... ok
Dec 15 16:50:26.359 INFO [stdout] test tree::test::get_idx_element_exists ... ok
Dec 15 16:50:26.360 INFO [stdout] test tree::test::insert_and_remove_ordered ... ok
Dec 15 16:50:26.361 INFO [stdout] test tree::test::insert_and_remove_random ... ok
Dec 15 16:50:26.361 INFO [stdout] test tree::test::insert_basic ... ok
Dec 15 16:50:26.362 INFO [stdout] test tree::test::insert_duplicate ... ok
Dec 15 16:50:26.367 INFO [stdout] test tree::test::remove_basic ... ok
Dec 15 16:50:26.367 INFO [stdout] test tree::test::insert_emoji ... ok
Dec 15 16:50:26.368 INFO [stdout] test tree::test::remove_duplicate ... ok
Dec 15 16:50:26.368 INFO [stdout] test tree::test::remove_emoji ... ok
Dec 15 16:50:26.371 INFO [stdout] test vlq::tests::test_decode_multibyte_value ... ok
Dec 15 16:50:26.371 INFO [stdout] test vlq::tests::test_decode_invalid_value ... ok
Dec 15 16:50:26.371 INFO [stdout] test vlq::tests::test_decode_multiple_values ... ok
Dec 15 16:50:26.371 INFO [stdout] test tree::test::test_new ... ok
Dec 15 16:50:26.371 INFO [stdout] test vlq::tests::test_encode_and_decode ... ok
Dec 15 16:50:26.371 INFO [stdout] test vlq::tests::test_encode_multibyte_values ... ok
Dec 15 16:50:26.371 INFO [stdout] test vlq::tests::test_decode_zero ... ok
Dec 15 16:50:26.371 INFO [stdout] test vlq::tests::test_encode_zero ... ok
Dec 15 16:50:26.375 INFO [stdout] test vlq::tests::test_decode_single_byte_value ... ok
Dec 15 16:50:26.379 INFO [stdout] test vlq::tests::test_encode_single_byte_values ... ok
Dec 15 16:50:26.400 INFO [stdout] test json::tests::test_array_remove_out_of_bounds ... ok
Dec 15 16:50:26.401 INFO [stdout] test json::tests::test_replace_text_out_of_bounds ... ok
Dec 15 16:50:26.401 INFO [stdout] test json::tests::test_array_insert_out_of_bounds ... ok
Dec 15 16:50:26.407 INFO [stdout] test text::text_edit::tests::merge_invalid_replacement ... ok
Dec 15 16:50:26.407 INFO [stdout] test text::text_edit::tests::overwrite_invalid_replacement ... ok
Dec 15 16:50:26.407 INFO [stdout] 
Dec 15 16:50:26.407 INFO [stdout] test result: ok. 126 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 16:50:26.407 INFO [stdout] 
Dec 15 16:50:26.409 INFO [stderr]    Doc-tests ditto
Dec 15 16:50:30.058 INFO [stdout] 
Dec 15 16:50:30.058 INFO [stdout] running 1 test
Dec 15 16:50:36.014 INFO [stdout] test src/lib.rs -  (line 26) ... ok
Dec 15 16:50:36.014 INFO [stdout] 
Dec 15 16:50:36.014 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 16:50:36.014 INFO [stdout] 
Dec 15 16:50:36.039 INFO [stderr] su: No module specific data is present
Dec 15 16:50:36.587 INFO running `"docker" "inspect" "3d1510095839957767e06541922bb0ce248e1e4b341f3377aee51b794a58bb95"`
Dec 15 16:50:36.845 INFO running `"docker" "rm" "-f" "3d1510095839957767e06541922bb0ce248e1e4b341f3377aee51b794a58bb95"`
Dec 15 16:50:37.134 INFO [stdout] 3d1510095839957767e06541922bb0ce248e1e4b341f3377aee51b794a58bb95