[INFO] crate divans 0.0.1 is already in cache
[INFO] extracting crate divans 0.0.1 into work/ex/pr-57967/sources/master#c1c3c4e95b69dfeaca5c5db6c622d7f90ad30a54/reg/divans/0.0.1
[INFO] extracting crate divans 0.0.1 into work/ex/pr-57967/sources/try#7fea0229842e79db1159ea58ad9a653b288efee9/reg/divans/0.0.1
[INFO] validating manifest of divans-0.0.1 on toolchain master#c1c3c4e95b69dfeaca5c5db6c622d7f90ad30a54
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+c1c3c4e95b69dfeaca5c5db6c622d7f90ad30a54-alt" "read-manifest" "--manifest-path" "Cargo.toml"`
[INFO] validating manifest of divans-0.0.1 on toolchain try#7fea0229842e79db1159ea58ad9a653b288efee9
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+7fea0229842e79db1159ea58ad9a653b288efee9-alt" "read-manifest" "--manifest-path" "Cargo.toml"`
[INFO] started frobbing divans-0.0.1
[INFO] finished frobbing divans-0.0.1
[INFO] frobbed toml for divans-0.0.1 written to work/ex/pr-57967/sources/master#c1c3c4e95b69dfeaca5c5db6c622d7f90ad30a54/reg/divans/0.0.1/Cargo.toml
[INFO] started frobbing divans-0.0.1
[INFO] finished frobbing divans-0.0.1
[INFO] frobbed toml for divans-0.0.1 written to work/ex/pr-57967/sources/try#7fea0229842e79db1159ea58ad9a653b288efee9/reg/divans/0.0.1/Cargo.toml
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+c1c3c4e95b69dfeaca5c5db6c622d7f90ad30a54-alt" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update"`
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+7fea0229842e79db1159ea58ad9a653b288efee9-alt" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update"`
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+c1c3c4e95b69dfeaca5c5db6c622d7f90ad30a54-alt" "fetch" "--locked" "--manifest-path" "Cargo.toml"`
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+7fea0229842e79db1159ea58ad9a653b288efee9-alt" "fetch" "--locked" "--manifest-path" "Cargo.toml"`
[INFO] testing divans-0.0.1 against master#c1c3c4e95b69dfeaca5c5db6c622d7f90ad30a54 for pr-57967
[INFO] running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-57967/worker-2/master#c1c3c4e95b69dfeaca5c5db6c622d7f90ad30a54:/opt/crater/target:rw,Z" "-v" "/mnt/big/crater/work/ex/pr-57967/sources/master#c1c3c4e95b69dfeaca5c5db6c622d7f90ad30a54/reg/divans/0.0.1:/opt/crater/workdir:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/opt/crater/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/opt/crater/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/opt/crater/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/crater/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/crater/cargo-home" "-e" "RUSTUP_HOME=/opt/crater/rustup-home" "-w" "/opt/crater/workdir" "-m" "1536M" "--network" "none" "rustops/crates-build-env" "/opt/crater/cargo-home/bin/cargo" "+c1c3c4e95b69dfeaca5c5db6c622d7f90ad30a54-alt" "build" "--frozen"`
[INFO] [stdout] 71b18b5a7d890944ce399f5a2947a088424ac1561192e6d3401ca3a17691a5e9
[INFO] running `"docker" "start" "-a" "71b18b5a7d890944ce399f5a2947a088424ac1561192e6d3401ca3a17691a5e9"`
[INFO] [stderr]    Compiling brotli v2.5.1
[INFO] [stderr]    Compiling divans v0.0.1 (/opt/crater/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 58.50s
[INFO] running `"docker" "inspect" "71b18b5a7d890944ce399f5a2947a088424ac1561192e6d3401ca3a17691a5e9"`
[INFO] running `"docker" "rm" "-f" "71b18b5a7d890944ce399f5a2947a088424ac1561192e6d3401ca3a17691a5e9"`
[INFO] [stdout] 71b18b5a7d890944ce399f5a2947a088424ac1561192e6d3401ca3a17691a5e9
[INFO] running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-57967/worker-2/master#c1c3c4e95b69dfeaca5c5db6c622d7f90ad30a54:/opt/crater/target:rw,Z" "-v" "/mnt/big/crater/work/ex/pr-57967/sources/master#c1c3c4e95b69dfeaca5c5db6c622d7f90ad30a54/reg/divans/0.0.1:/opt/crater/workdir:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/opt/crater/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/opt/crater/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/opt/crater/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/crater/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/crater/cargo-home" "-e" "RUSTUP_HOME=/opt/crater/rustup-home" "-w" "/opt/crater/workdir" "-m" "1536M" "--network" "none" "rustops/crates-build-env" "/opt/crater/cargo-home/bin/cargo" "+c1c3c4e95b69dfeaca5c5db6c622d7f90ad30a54-alt" "test" "--frozen" "--no-run"`
[INFO] [stdout] 528aae99531629468d3ca8708cd51bcd85f35e1f9de85b352b36f40d5de4c527
[INFO] running `"docker" "start" "-a" "528aae99531629468d3ca8708cd51bcd85f35e1f9de85b352b36f40d5de4c527"`
[INFO] [stderr]    Compiling divans v0.0.1 (/opt/crater/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 46.59s
[INFO] running `"docker" "inspect" "528aae99531629468d3ca8708cd51bcd85f35e1f9de85b352b36f40d5de4c527"`
[INFO] running `"docker" "rm" "-f" "528aae99531629468d3ca8708cd51bcd85f35e1f9de85b352b36f40d5de4c527"`
[INFO] [stdout] 528aae99531629468d3ca8708cd51bcd85f35e1f9de85b352b36f40d5de4c527
[INFO] running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-57967/worker-2/master#c1c3c4e95b69dfeaca5c5db6c622d7f90ad30a54:/opt/crater/target:rw,Z" "-v" "/mnt/big/crater/work/ex/pr-57967/sources/master#c1c3c4e95b69dfeaca5c5db6c622d7f90ad30a54/reg/divans/0.0.1:/opt/crater/workdir:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/opt/crater/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/opt/crater/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/opt/crater/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/crater/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/crater/cargo-home" "-e" "RUSTUP_HOME=/opt/crater/rustup-home" "-w" "/opt/crater/workdir" "-m" "1536M" "--network" "none" "rustops/crates-build-env" "/opt/crater/cargo-home/bin/cargo" "+c1c3c4e95b69dfeaca5c5db6c622d7f90ad30a54-alt" "test" "--frozen"`
[INFO] [stdout] 225f0706af2386637f459b8ecd05619a4aa37e3363d97e3327a6c283922f6222
[INFO] running `"docker" "start" "-a" "225f0706af2386637f459b8ecd05619a4aa37e3363d97e3327a6c283922f6222"`
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.06s
[INFO] [stderr]      Running /opt/crater/target/debug/deps/divans-ff54ea34c4f95dbb
[INFO] [stdout] 
[INFO] [stdout] running 63 tests
[INFO] [stdout] test alloc_util::test::test_non_reuse ... ok
[INFO] [stdout] test alloc_util::test::test_reuse ... ok
[INFO] [stdout] test arithmetic_coder::test::test_get_nibble ... ok
[INFO] [stdout] test arithmetic_coder::test::test_put_nibble ... ok
[INFO] [stdout] test cmd_to_raw::test::test_copy_near_overlap ... ok
[INFO] [stdout] test cmd_to_raw::test::test_copy_far ... ok
[INFO] [stdout] test cmd_to_raw::test::test_copy_big_overlap ... ok
[INFO] [stdout] test codec::crc32::test::test_crc32c_qbf ... ok
[INFO] [stdout] test codec::crc32::test::test_crc32c_qbf_half ... ok
[INFO] [stdout] test priors::test::test_billing_types ... ok
[INFO] [stdout] test codec::crc32::test::test_crc32c_numeric_half ... ok
[INFO] [stdout] test codec::crc32::test::test_crc32c_numeric ... ok
[INFO] [stdout] test codec::crc32::test::test_crc32c_empty ... ok
[INFO] [stdout] test cmd_to_raw::test::test_insert_medium ... ok
[INFO] [stdout] test cmd_to_raw::test::test_insert_huge ... ok
[INFO] [stdout] test cmd_to_raw::test::test_ring_buffer_dict ... ok
[INFO] [stdout] test priors::test::test_get ... ok
[INFO] [stdout] test priors::test::test_macro_product ... ok
[INFO] [stdout] test priors::test::test_num_dimensions ... ok
[INFO] [stdout] test priors::test::test_num_prior ... ok
[INFO] [stdout] test priors::test::test_macro_count_expr ... ok
[INFO] [stdout] test priors::test::test_macro_sum_product_cdr ... ok
[INFO] [stdout] test priors::test::test_get_tuple ... ok
[INFO] [stdout] test probability::blend_cdf::test::test_blend_lut ... ok
[INFO] [stdout] test probability::blend_cdf::test::test_sym_to_start_and_freq ... ok
[INFO] [stdout] test priors::test::test_get_bad_tuple_dimensionality ... ok
[INFO] [stdout] test priors::test::test_get_bad_tuple_index ... ok
[INFO] [stdout] test probability::interface::test::test_u8_to_speed ... ok
[INFO] [stdout] test probability::frequentist_cdf::test::test_sym_to_start_and_freq ... ok
[INFO] [stdout] test probability::numeric::test::test_divide ... ok
[INFO] [stdout] test probability::opt_frequentist_cdf::test::test_cdf_opt_eq_baseline ... ok
[INFO] [stdout] test probability::frequentist_cdf::test::test_nonzero_pdf ... ok
[INFO] [stdout] test probability::opt_frequentist_cdf::test::test_nonzero_pdf ... ok
[INFO] [stdout] test probability::opt_frequentist_cdf::test::test_sym_to_start_and_freq ... ok
[INFO] [stdout] test probability::blend_cdf::test::test_cdf_offset_to_sym_start_and_freq ... ok
[INFO] [stdout] test probability::frequentist_cdf::test::test_cdf_offset_to_sym_start_and_freq ... ok
[INFO] [stdout] test probability::opt_frequentist_cdf::test::test_cdf_offset_to_sym_start_and_freq ... ok
[INFO] [stdout] test probability::blend_cdf::test::test_nonzero_pdf ... ok
[INFO] [stderr] encoded size: 2928
[INFO] [stderr] effeciency: 1.00311013336588
[INFO] [stderr] done!
[INFO] [stdout] test test_ans::entropy16_big_trait_test ... ok
[INFO] [stderr] encoded size: 24
[INFO] [stdout] test test_ans::entropy16_lite_trait_test ... ok
[INFO] [stderr] effeciency: 2.1054007256147593
[INFO] [stderr] done!
[INFO] [stderr] encoded size: 2928
[INFO] [stderr] effeciency: 0.9933084853811626
[INFO] [stderr] done!
[INFO] [stdout] test test_ans::entropy16_trait_test ... ok
[INFO] [stdout] test probability::frequentist_cdf::test::test_stationary_probability ... ok
[INFO] [stdout] test test_mux::test_balance_mux ... ok
[INFO] [stdout] test probability::blend_cdf::test::test_stationary_probability ... ok
[INFO] [stdout] test probability::opt_frequentist_cdf::test::test_stationary_probability ... ok
[INFO] [stdout] test test_mux::test_3meg_mux ... ok
[INFO] [stdout] test test_mux::test_nano_mux ... ok
[INFO] [stdout] test test_mux::test_real_mux ... ok
[INFO] [stdout] test test_mux::test_med_mux ... ok
[INFO] [stdout] test test_mux::test_short_mux ... ok
[INFO] [stdout] test test_mux::test_tiny_mux ... ok
[INFO] [stdout] test test_mux::unit_test_decode_mux ... ok
[INFO] [stdout] test test_mux::test_sc3_mux ... ok
[INFO] [stdout] test reader::test::test_experimental_reader_compressor_on_alice_full ... ok
[INFO] [stdout] test test_mux::test_interleaved_mux ... ok
[INFO] [stdout] test test_mux::test_long_mux ... ok
[INFO] [stdout] test reader::test::test_hybrid_reader_compressor_on_unicode_full ... ok
[INFO] [stdout] test reader::test::test_hybrid_reader_compressor_on_alice_full ... ok
[INFO] [stdout] test writer::test::test_hybrid_writer_compressor_on_alice_full ... ok
[INFO] [stdout] test writer::test::test_experimental_writer_compressor_on_alice_full ... ok
[INFO] [stdout] test writer::test::test_hybrid_writer_compressor_on_unicode_full ... ok
[INFO] [stdout] test reader::test::test_hybrid_reader_compressor_on_alice_small_buffer ... ok
[INFO] [stdout] test writer::test::test_hybrid_writer_compressor_on_alice_small_buffer ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 63 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] [stderr]      Running /opt/crater/target/debug/deps/divans-22208c61f29513f4
[INFO] [stdout] 
[INFO] [stdout] running 19 tests
[INFO] [stdout] test integration_test::test_e2e_64xp ... ok
[INFO] [stdout] test integration_test::test_alice29 ... ok
[INFO] [stdout] test integration_test::test_e2e_32xx ... ok
[INFO] [stdout] test integration_test::test_asyoulik ... ok
[INFO] [stdout] test integration_test::test_e2e_empty ... ok
[INFO] [stdout] test integration_test::test_e2e_empty_br ... ok
[INFO] [stdout] test integration_test::test_e2e_empty_br_tinybuf ... ok
[INFO] [stdout] test integration_test::test_e2e_262145_at ... ok
[INFO] [stdout] test integration_test::test_e2e_empty_tinybuf ... ok
[INFO] [stdout] test integration_test::test_e2e_empty_just_flush ... ok
[INFO] [stdout] test integration_test::test_ends_with_truncated_dictionary ... ok
[INFO] [stdout] test integration_test::test_e2e_ones_tinybuf ... ok
[INFO] [stdout] test benchmark::test_raw_adaptive_literal_stream ... ok
[INFO] [stdout] test integration_test::test_random_then_unicode ... ok
[INFO] [stdout] test benchmark::test_raw_literal_stream ... ok
[INFO] [stdout] test integration_test::test_e2e_smallbuf_without_priors ... ok
[INFO] [stdout] test integration_test::test_e2e_alice ... ok
[INFO] [stdout] test benchmark::test_raw_ir_literal_stream ... ok
[INFO] [stdout] test integration_test::test_e2e_tinybuf ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 19 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests divans
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] running `"docker" "inspect" "225f0706af2386637f459b8ecd05619a4aa37e3363d97e3327a6c283922f6222"`
[INFO] running `"docker" "rm" "-f" "225f0706af2386637f459b8ecd05619a4aa37e3363d97e3327a6c283922f6222"`
[INFO] [stdout] 225f0706af2386637f459b8ecd05619a4aa37e3363d97e3327a6c283922f6222