[INFO] fetching crate brotli 3.3.3...
[INFO] testing brotli-3.3.3 against 1.59.0 for beta-1.60-1
[INFO] extracting crate brotli 3.3.3 into /workspace/builds/worker-1/source
[INFO] validating manifest of crates.io crate brotli 3.3.3 on toolchain 1.59.0
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.59.0" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate brotli 3.3.3
[INFO] finished tweaking crates.io crate brotli 3.3.3
[INFO] tweaked toml for crates.io crate brotli 3.3.3 written to /workspace/builds/worker-1/source/Cargo.toml
[INFO] crate crates.io crate brotli 3.3.3 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.59.0" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:0cd99ca24d8e8c98e67c542213511d985b8778b5bdcbb160e038429496686047" "/opt/rustwide/cargo-home/bin/cargo" "+1.59.0" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 0cee1222d77bcd00859a81c06da5ed22fc1bade721de91af82f6a4912730e310
[INFO] running `Command { std: "docker" "start" "-a" "0cee1222d77bcd00859a81c06da5ed22fc1bade721de91af82f6a4912730e310", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "0cee1222d77bcd00859a81c06da5ed22fc1bade721de91af82f6a4912730e310", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "0cee1222d77bcd00859a81c06da5ed22fc1bade721de91af82f6a4912730e310", kill_on_drop: false }`
[INFO] [stdout] 0cee1222d77bcd00859a81c06da5ed22fc1bade721de91af82f6a4912730e310
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:0cd99ca24d8e8c98e67c542213511d985b8778b5bdcbb160e038429496686047" "/opt/rustwide/cargo-home/bin/cargo" "+1.59.0" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 7da42b6258f42697746420c50fa698689d64795edc2920bf1b5a5543182d026b
[INFO] running `Command { std: "docker" "start" "-a" "7da42b6258f42697746420c50fa698689d64795edc2920bf1b5a5543182d026b", kill_on_drop: false }`
[INFO] [stderr]    Compiling alloc-no-stdlib v2.0.3
[INFO] [stderr]    Compiling alloc-stdlib v0.2.1
[INFO] [stderr]    Compiling brotli-decompressor v2.3.2
[INFO] [stderr]    Compiling brotli v3.3.3 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 10.29s
[INFO] running `Command { std: "docker" "inspect" "7da42b6258f42697746420c50fa698689d64795edc2920bf1b5a5543182d026b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "7da42b6258f42697746420c50fa698689d64795edc2920bf1b5a5543182d026b", kill_on_drop: false }`
[INFO] [stdout] 7da42b6258f42697746420c50fa698689d64795edc2920bf1b5a5543182d026b
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:0cd99ca24d8e8c98e67c542213511d985b8778b5bdcbb160e038429496686047" "/opt/rustwide/cargo-home/bin/cargo" "+1.59.0" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 9a21eb72c7de896e3da7d21b1c0dc3475078fe493d85e32d7efd5a57261717a4
[INFO] running `Command { std: "docker" "start" "-a" "9a21eb72c7de896e3da7d21b1c0dc3475078fe493d85e32d7efd5a57261717a4", kill_on_drop: false }`
[INFO] [stderr]    Compiling brotli v3.3.3 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 11.36s
[INFO] running `Command { std: "docker" "inspect" "9a21eb72c7de896e3da7d21b1c0dc3475078fe493d85e32d7efd5a57261717a4", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "9a21eb72c7de896e3da7d21b1c0dc3475078fe493d85e32d7efd5a57261717a4", kill_on_drop: false }`
[INFO] [stdout] 9a21eb72c7de896e3da7d21b1c0dc3475078fe493d85e32d7efd5a57261717a4
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:0cd99ca24d8e8c98e67c542213511d985b8778b5bdcbb160e038429496686047" "/opt/rustwide/cargo-home/bin/cargo" "+1.59.0" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] ab8319a59846065c68ad57364be876f9676300307c10492d03774dfdf44dd34b
[INFO] running `Command { std: "docker" "start" "-a" "ab8319a59846065c68ad57364be876f9676300307c10492d03774dfdf44dd34b", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.01s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/brotli-f127308ba5191c89)
[INFO] [stdout] 
[INFO] [stdout] running 35 tests
[INFO] [stdout] test concat::test::test_cat_empty_stream ... ok
[INFO] [stdout] test concat::test::test_serialization ... ok
[INFO] [stdout] test concat::test::test_deserialization ... ok
[INFO] [stdout] test concat::test::test_deserialization_any_written ... ok
[INFO] [stdout] test enc::brotli_bit_stream::test::test_encode_base_128 ... ok
[INFO] [stdout] test enc::command::test::test_command_return_distance_index_offset ... ok
[INFO] [stdout] test enc::interface::test::test_u8_to_speed ... ok
[INFO] [stdout] test enc::test::test_roundtrip_64x ... ok
[INFO] [stdout] test enc::test::test_roundtrip_10x10y ... ok
[INFO] [stdout] test enc::test::test_roundtrip_first_2_bytes_alice ... ok
[INFO] [stdout] test enc::test::test_roundtrip_first_58_bytes_alice ... ok
[INFO] [stdout] test enc::util::test::log2floor_non_zero_works ... ok
[INFO] [stdout] test enc::util::test::fast_log2_works ... ok
[INFO] [stdout] test ffi::multicompress::test::test_compress_empty_multi_raw_one_thread ... ok
[INFO] [stdout] test enc::test::test_roundtrip_ukkonooa ... ok
[INFO] [stdout] test ffi::multicompress::test::test_compress_empty_multi_catable ... ok
[INFO] [stdout] test ffi::multicompress::test::test_compress_empty_multi_raw ... ok
[INFO] [stdout] test ffi::multicompress::test::test_compress_empty_workpool ... ok
[INFO] [stdout] test ffi::multicompress::test::test_compress_null_multi_raw ... ok
[INFO] [stdout] test enc::test::test_roundtrip_quickfox ... ok
[INFO] [stdout] test enc::test::test_roundtrip_monkey ... ok
[INFO] [stdout] test enc::test::test_roundtrip_aaabaaaa ... ok
[INFO] [stdout] test enc::test::test_roundtrip_empty ... ok
[INFO] [stdout] test enc::test::test_roundtrip_x ... ok
[INFO] [stdout] test enc::static_dict::test::test_find_match_length ... ok
[INFO] [stdout] test enc::backward_references::test::test_bulk_store_range_pow2 ... ok
[INFO] [stdout] test enc::test::test_roundtrip_backward65536 ... ok
[INFO] [stdout] test ffi::multicompress::test::test_compress_workpool ... ok
[INFO] [stdout] test enc::test::test_roundtrip_compressed ... ok
[INFO] [stdout] test enc::test::test_roundtrip_quickfox_repeated ... ok
[INFO] [stdout] test enc::test::test_roundtrip_compressed_repeated ... ok
[INFO] [stdout] test enc::test::test_roundtrip_asyoulik ... ok
[INFO] [stdout] test enc::backward_references::test::test_bulk_store_range ... ok
[INFO] [stdout] test enc::backward_references::test::test_bulk_store_range_off_spec ... ok
[INFO] [stdout] test enc::test::test_roundtrip_asyoulik9_5 ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 35 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.33s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/brotli-709bccdfc0a03d3e)
[INFO] [stdout] 
[INFO] [stderr] 1 Iterations; Time 0.000594178
[INFO] [stdout] running 93 tests
[INFO] [stderr] 1 Iterations; Time 0.000654490
[INFO] [stdout] test integration_tests::test_10x_10y_byte_by_byte ... ok
[INFO] [stdout] test integration_tests::test_10x_10y_one_out_byte ... ok
[INFO] [stdout] test integration_tests::test_10x_10y ... ok
[INFO] [stdout] test integration_tests::test_64x ... ok
[INFO] [stdout] test integration_tests::test_empty12 ... ok
[INFO] [stdout] test integration_tests::test_backward65536 ... ok
[INFO] [stdout] test integration_tests::test_empty13 ... ok
[INFO] [stdout] test integration_tests::test_empty0 ... ok
[INFO] [stderr] 1 Iterations; Time 0.000298739
[INFO] [stdout] test integration_tests::test_empty4 ... ok
[INFO] [stdout] test integration_tests::test_empty8 ... ok
[INFO] [stdout] test integration_tests::test_empty9 ... ok
[INFO] [stdout] test integration_tests::test_error_returned ... ok
[INFO] [stdout] test integration_tests::test_reader_64x ... ok
[INFO] [stdout] test integration_tests::test_empty16 ... ok
[INFO] [stdout] test integration_tests::test_empty1 ... ok
[INFO] [stdout] test integration_tests::test_empty7 ... ok
[INFO] [stdout] test integration_tests::test_empty14 ... ok
[INFO] [stdout] test integration_tests::test_empty5 ... ok
[INFO] [stdout] test integration_tests::test_roundtrip_64x ... ok
[INFO] [stdout] test integration_tests::test_empty11 ... ok
[INFO] [stdout] test integration_tests::test_empty6 ... ok
[INFO] [stdout] test test_broccoli::test_one_byte_works ... ok
[INFO] [stdout] test test_threading::multi_threaded_split_compression_test_0b5 ... ok
[INFO] [stdout] test integration_tests::test_compressed_file ... ok
[INFO] [stdout] test integration_tests::test_empty ... ok
[INFO] [stdout] test integration_tests::test_empty15 ... ok
[INFO] [stdout] test integration_tests::test_empty18 ... ok
[INFO] [stdout] test integration_tests::test_empty17 ... ok
[INFO] [stdout] test integration_tests::test_compressed_repeated ... ok
[INFO] [stdout] test integration_tests::test_empty3 ... ok
[INFO] [stdout] test integration_tests::test_empty10 ... ok
[INFO] [stdout] test integration_tests::test_empty2 ... ok
[INFO] [stdout] test test_custom_dict::test_custom_wrong_dict_fails_but_doesnt_disrupt_compression_strategy ... ok
[INFO] [stdout] test integration_tests::test_ukkonooa ... ok
[INFO] [stdout] test test_threading::multi_threaded_split_compression_test_0b1 ... ok
[INFO] [stdout] test test_threading::thread_spawn_per_job_split_compression_test_0b3 ... ok
[INFO] [stdout] test test_threading::thread_spawn_per_job_split_compression_test_0b1 ... ok
[INFO] [stdout] test test_broccoli::test_two_byte_works ... ok
[INFO] [stdout] test test_threading::multi_threaded_split_compression_test_1b1 ... ok
[INFO] [stdout] test test_threading::thread_spawn_per_job_split_compression_test_1b1 ... ok
[INFO] [stdout] test integration_tests::test_as_you_like_it ... ok
[INFO] [stdout] test tests::test_10x_10y ... ok
[INFO] [stdout] test test_threading::thread_spawn_per_job_split_compression_test_1b3 ... ok
[INFO] [stdout] test test_threading::multi_threaded_split_compression_test_1b5 ... ok
[INFO] [stdout] test integration_tests::test_alice29 ... ok
[INFO] [stdout] test integration_tests::test_writer_64x ... ok
[INFO] [stdout] test test_broccoli::test_one_byte_before_works ... ok
[INFO] [stdout] test test_broccoli::test_two_byte_before_works ... ok
[INFO] [stdout] test integration_tests::test_negative_hypothesis - should panic ... ok
[INFO] [stdout] test test_broccoli::test_append_then_empty_works ... ok
[INFO] [stderr] 1 Iterations; Time 1.103373837
[INFO] [stdout] test integration_tests::test_alice1 ... ok
[INFO] [stdout] test integration_tests::test_random_then_unicode_2 ... ok
[INFO] [stdout] test test_threading::thread_spawn_per_job_split_compression_test_1 ... ok
[INFO] [stdout] test integration_tests::test_random_then_unicode_4 ... ok
[INFO] [stdout] test integration_tests::test_random_then_unicode_5 ... ok
[INFO] [stdout] test integration_tests::test_random_then_unicode_1 ... ok
[INFO] [stdout] test integration_tests::test_random_then_unicode_3 ... ok
[INFO] [stdout] test integration_tests::test_writer_as_you_lik_into_inner ... ok
[INFO] [stdout] test test_threading::multi_threaded_split_compression_test_3 ... ok
[INFO] [stdout] test test_threading::multi_threaded_split_compression_test_1 ... ok
[INFO] [stdout] test test_threading::multi_threaded_split_compression_test_2 ... ok
[INFO] [stdout] test integration_tests::test_writer_quickfox_repeated ... ok
[INFO] [stdout] test integration_tests::test_reader_quickfox_repeated ... ok
[INFO] [stdout] test tests::test_alice ... ok
[INFO] [stdout] test test_threading::thread_spawn_per_job_split_compression_test_3 ... ok
[INFO] [stdout] test integration_tests::test_random_then_unicode_0 ... ok
[INFO] [stdout] test integration_tests::test_random_then_unicode_6 ... ok
[INFO] [stdout] test integration_tests::test_random_then_unicode_7 ... ok
[INFO] [stdout] test test_threading::multi_threaded_split_compression_test_5 ... ok
[INFO] [stdout] test test_broccoli::test_empty_then_cat_works ... ok
[INFO] [stdout] test test_broccoli::test_appendonly_twice_fails - should panic ... ok
[INFO] [stdout] test integration_tests::test_1024k ... ok
[INFO] [stdout] test test_broccoli::test_append_then_cat_works ... ok
[INFO] [stdout] test integration_tests::test_random_then_unicode_8 ... ok
[INFO] [stdout] test integration_tests::test_roundtrip_quickfox_repeated ... ok
[INFO] [stdout] test integration_tests::test_writer_as_you_lik ... ok
[INFO] [stdout] test integration_tests::test_reader_as_you_lik ... ok
[INFO] [stdout] test integration_tests::test_reader_alice ... ok
[INFO] [stdout] test integration_tests::test_random_then_unicode_9 ... ok
[INFO] [stdout] test integration_tests::test_writer_alice ... ok
[INFO] [stdout] test test_threading::multi_threaded_split_compression_test_4 ... ok
[INFO] [stdout] test integration_tests::test_reader_random_then_unicode ... ok
[INFO] [stdout] test integration_tests::test_writer_random_then_unicode ... ok
[INFO] [stdout] test test_broccoli::test_concat ... ok
[INFO] [stdout] test integration_tests::test_roundtrip_as_you_lik ... ok
[INFO] [stdout] test test_custom_dict::test_custom_dict_for_multithreading ... ok
[INFO] [stdout] test integration_tests::test_roundtrip_alice29 ... ok
[INFO] [stdout] test test_custom_dict::test_custom_dict ... ok
[INFO] [stdout] test integration_tests::test_alice29_10 ... ok
[INFO] [stdout] test test_custom_dict::test_custom_wrong_dict_fails ... ok
[INFO] [stdout] test integration_tests::test_random_then_unicode_9_5 ... ok
[INFO] [stdout] test integration_tests::test_random_then_unicode_9x5 ... ok
[INFO] [stdout] test integration_tests::test_alice29_11 ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 93 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 8.12s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/catbrotli-473fc9b4600598f4)
[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; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests brotli
[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; finished in 0.00s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "ab8319a59846065c68ad57364be876f9676300307c10492d03774dfdf44dd34b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "ab8319a59846065c68ad57364be876f9676300307c10492d03774dfdf44dd34b", kill_on_drop: false }`
[INFO] [stdout] ab8319a59846065c68ad57364be876f9676300307c10492d03774dfdf44dd34b