[INFO] fetching crate cfb 0.6.1...
[INFO] testing cfb-0.6.1 against beta-2022-04-10 for beta-1.61-1
[INFO] extracting crate cfb 0.6.1 into /workspace/builds/worker-37/source
[INFO] validating manifest of crates.io crate cfb 0.6.1 on toolchain beta-2022-04-10
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2022-04-10" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate cfb 0.6.1
[INFO] finished tweaking crates.io crate cfb 0.6.1
[INFO] tweaked toml for crates.io crate cfb 0.6.1 written to /workspace/builds/worker-37/source/Cargo.toml
[INFO] crate crates.io crate cfb 0.6.1 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2022-04-10" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-37/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-37/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:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2022-04-10" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] cfe9e150ca28306ebea8da25d239d4f46e97682dabb1ac1712fe382ebdf41844
[INFO] running `Command { std: "docker" "start" "-a" "cfe9e150ca28306ebea8da25d239d4f46e97682dabb1ac1712fe382ebdf41844", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "cfe9e150ca28306ebea8da25d239d4f46e97682dabb1ac1712fe382ebdf41844", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "cfe9e150ca28306ebea8da25d239d4f46e97682dabb1ac1712fe382ebdf41844", kill_on_drop: false }`
[INFO] [stdout] cfe9e150ca28306ebea8da25d239d4f46e97682dabb1ac1712fe382ebdf41844
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-37/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-37/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:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2022-04-10" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 90227ba8de00a92f55d39591e0c96264ce15d8a69d813891ff808bead003ea10
[INFO] running `Command { std: "docker" "start" "-a" "90227ba8de00a92f55d39591e0c96264ce15d8a69d813891ff808bead003ea10", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling byteorder v1.3.4
[INFO] [stderr]    Compiling uuid v0.8.1
[INFO] [stderr]    Compiling cfb v0.6.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 4.89s
[INFO] running `Command { std: "docker" "inspect" "90227ba8de00a92f55d39591e0c96264ce15d8a69d813891ff808bead003ea10", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "90227ba8de00a92f55d39591e0c96264ce15d8a69d813891ff808bead003ea10", kill_on_drop: false }`
[INFO] [stdout] 90227ba8de00a92f55d39591e0c96264ce15d8a69d813891ff808bead003ea10
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-37/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-37/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:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2022-04-10" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 03036bcb1107c04e6ff5c4ed2f218316f812e2cf87ce3d61ea3ef86558d7afde
[INFO] running `Command { std: "docker" "start" "-a" "03036bcb1107c04e6ff5c4ed2f218316f812e2cf87ce3d61ea3ef86558d7afde", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling autocfg v1.0.1
[INFO] [stderr]    Compiling libc v0.2.80
[INFO] [stderr]    Compiling bitflags v1.2.1
[INFO] [stderr]    Compiling unicode-width v0.1.8
[INFO] [stderr]    Compiling vec_map v0.8.2
[INFO] [stderr]    Compiling ansi_term v0.11.0
[INFO] [stderr]    Compiling strsim v0.8.0
[INFO] [stderr]    Compiling textwrap v0.11.0
[INFO] [stderr]    Compiling num-traits v0.2.14
[INFO] [stderr]    Compiling num-integer v0.1.44
[INFO] [stderr]    Compiling atty v0.2.14
[INFO] [stderr]    Compiling time v0.1.44
[INFO] [stderr]    Compiling clap v2.33.3
[INFO] [stderr]    Compiling chrono v0.4.19
[INFO] [stderr]    Compiling cfb v0.6.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 13.67s
[INFO] [stderr]   Executable unittests src/lib.rs (/opt/rustwide/target/debug/deps/cfb-0ee8ea09050b50c9)
[INFO] [stderr]   Executable tests/basic.rs (/opt/rustwide/target/debug/deps/basic-4c1cbf5795e2222e)
[INFO] [stderr]   Executable tests/set_len.rs (/opt/rustwide/target/debug/deps/set_len-1acc1635edcfb6db)
[INFO] running `Command { std: "docker" "inspect" "03036bcb1107c04e6ff5c4ed2f218316f812e2cf87ce3d61ea3ef86558d7afde", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "03036bcb1107c04e6ff5c4ed2f218316f812e2cf87ce3d61ea3ef86558d7afde", kill_on_drop: false }`
[INFO] [stdout] 03036bcb1107c04e6ff5c4ed2f218316f812e2cf87ce3d61ea3ef86558d7afde
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-37/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-37/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:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2022-04-10" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] f2859d27fa59ef8f118d726c2a0fdb093713e3df743c5fa1e53a178c0b4b0378
[INFO] running `Command { std: "docker" "start" "-a" "f2859d27fa59ef8f118d726c2a0fdb093713e3df743c5fa1e53a178c0b4b0378", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 3.23s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/cfb-0ee8ea09050b50c9)
[INFO] [stdout] 
[INFO] [stdout] running 58 tests
[INFO] [stdout] test internal::color::tests::round_trip ... ok
[INFO] [stdout] test internal::directory::tests::tolerate_red_root ... ok
[INFO] [stdout] test internal::directory::tests::tolerate_two_red_nodes_in_a_row ... ok
[INFO] [stdout] test internal::direntry::tests::parse_valid_storage_entry_with_end_of_chain_start ... ok
[INFO] [stdout] test internal::entry::tests::nonrecursive_entries_from_storage ... ok
[INFO] [stdout] test internal::entry::tests::preorder_entries_from_storage ... ok
[INFO] [stdout] test internal::entry::tests::preorder_entries_from_root ... ok
[INFO] [stdout] test internal::entry::tests::nonrecursive_entries_from_root ... ok
[INFO] [stdout] test internal::header::tests::round_trip ... ok
[INFO] [stdout] test internal::direntry::tests::parse_valid_storage_entry ... ok
[INFO] [stdout] test internal::path::tests::absolute_path_is_valid ... ok
[INFO] [stdout] test internal::path::tests::name_ordering ... ok
[INFO] [stdout] test internal::path::tests::path_with_parents_is_valid ... ok
[INFO] [stdout] test internal::path::tests::canonical_path_is_absolute ... ok
[INFO] [stdout] test internal::objtype::tests::round_trip ... ok
[INFO] [stdout] test internal::alloc::tests::double_pointee - should panic ... ok
[INFO] [stdout] test internal::alloc::tests::pointee_out_of_range - should panic ... ok
[INFO] [stdout] test internal::alloc::tests::difat_sector_not_marked_in_fat - should panic ... ok
[INFO] [stdout] test internal::alloc::tests::difat_sector_out_of_range - should panic ... ok
[INFO] [stdout] test internal::alloc::tests::fat_sector_not_marked_in_fat - should panic ... ok
[INFO] [stdout] test internal::path::tests::relative_path_is_valid ... ok
[INFO] [stdout] test internal::sector::tests::sector_seek ... ok
[INFO] [stdout] test internal::sector::tests::partial_final_sector ... ok
[INFO] [stdout] test internal::alloc::tests::fat_sector_out_of_range - should panic ... ok
[INFO] [stdout] test internal::time::tests::before_unix_epoch ... ok
[INFO] [stdout] test internal::sector::tests::sector_init ... ok
[INFO] [stdout] test internal::time::tests::unix_epoch ... ok
[INFO] [stdout] test internal::version::tests::number_round_trip ... ok
[INFO] [stdout] test internal::time::tests::extreme_duration ... ok
[INFO] [stdout] test internal::time::tests::extreme_timestamp_delta ... ok
[INFO] [stdout] test internal::sector::tests::sector_read ... ok
[INFO] [stdout] test tests::zero_padded_fat ... ok
[INFO] [stdout] test internal::sector::tests::sector_write ... ok
[INFO] [stdout] test internal::time::tests::after_unix_epoch ... ok
[INFO] [stdout] test internal::path::tests::short_name_is_valid ... ok
[INFO] [stdout] test internal::alloc::tests::fat_longer_than_file - should panic ... ok
[INFO] [stdout] test internal::time::tests::extreme_timestamps ... ok
[INFO] [stdout] test internal::directory::tests::incorrect_root_entry_name - should panic ... ok
[INFO] [stdout] test internal::alloc::tests::invalid_pointee - should panic ... ok
[INFO] [stdout] test internal::directory::tests::nonroot_has_wrong_type - should panic ... ok
[INFO] [stdout] test internal::directory::tests::storage_is_child_of_itself - should panic ... ok
[INFO] [stdout] test internal::direntry::tests::invalid_object_type - should panic ... ok
[INFO] [stdout] test internal::header::tests::invalid_difat_array - should panic ... ok
[INFO] [stdout] test internal::header::tests::invalid_mini_sector_shift - should panic ... ok
[INFO] [stdout] test internal::header::tests::invalid_sector_shift - should panic ... ok
[INFO] [stdout] test internal::directory::tests::root_has_wrong_type - should panic ... ok
[INFO] [stdout] test internal::directory::tests::invalid_mini_stream_len - should panic ... ok
[INFO] [stdout] test internal::header::tests::invalid_magic_number - should panic ... ok
[INFO] [stdout] test internal::header::tests::invalid_mini_stream_cutoff - should panic ... ok
[INFO] [stderr]      Running tests/basic.rs (/opt/rustwide/target/debug/deps/basic-4c1cbf5795e2222e)
[INFO] [stdout] test internal::direntry::tests::invalid_color - should panic ... ok
[INFO] [stdout] test internal::header::tests::invalid_version - should panic ... ok
[INFO] [stdout] test internal::minialloc::tests::double_pointee - should panic ... ok
[INFO] [stdout] test internal::path::tests::long_name_is_invalid - should panic ... ok
[INFO] [stdout] test internal::path::tests::parent_of_root_is_invalid - should panic ... ok
[INFO] [stdout] test internal::path::tests::name_with_slash_is_invalid - should panic ... ok
[INFO] [stdout] test internal::minialloc::tests::root_stream_too_short - should panic ... ok
[INFO] [stdout] test internal::header::tests::invalid_byte_order_mark - should panic ... ok
[INFO] [stdout] test internal::minialloc::tests::pointee_out_of_range - should panic ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 58 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.13s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 44 tests
[INFO] [stdout] test create_directory_tree ... ok
[INFO] [stdout] test empty_compound_file_has_no_children ... ok
[INFO] [stdout] test extend_stream ... ok
[INFO] [stdout] test create_storages_all ... ok
[INFO] [stdout] test path_exists ... ok
[INFO] [stdout] test create_empty_compound_file ... ok
[INFO] [stdout] test create_streams ... ok
[INFO] [stdout] test create_small_stream ... ok
[INFO] [stdout] test path_is_storage ... ok
[INFO] [stdout] test partial_final_sector ... ok
[INFO] [stdout] test path_is_stream ... ok
[INFO] [stdout] test create_large_stream ... ok
[INFO] [stdout] test remove_small_stream ... ok
[INFO] [stdout] test create_stream_where_stream_exists ... ok
[INFO] [stdout] test remove_storage_all_on_root ... ok
[INFO] [stdout] test remove_storage_all_on_storage ... ok
[INFO] [stdout] test remove_storages ... ok
[INFO] [stdout] test file_too_small - should panic ... ok
[INFO] [stdout] test create_storage_where_storage_exists - should panic ... ok
[INFO] [stdout] test truncate_stream ... ok
[INFO] [stdout] test create_root_storage - should panic ... ok
[INFO] [stdout] test remove_streams ... ok
[INFO] [stdout] test root_entry ... ok
[INFO] [stdout] test stream_seek ... ok
[INFO] [stdout] test storage_clsids ... ok
[INFO] [stdout] test state_bits ... ok
[INFO] [stdout] test walk_directory_tree ... ok
[INFO] [stdout] test create_stream_where_storage_exists - should panic ... ok
[INFO] [stdout] test set_nonexistent_storage_clsid - should panic ... ok
[INFO] [stdout] test remove_nonexistent_stream - should panic ... ok
[INFO] [stdout] test read_storage_on_stream - should panic ... ok
[INFO] [stdout] test remove_nonexistent_storage - should panic ... ok
[INFO] [stdout] test remove_root_storage - should panic ... ok
[INFO] [stdout] test remove_non_empty_storage - should panic ... ok
[INFO] [stdout] test create_storage_where_stream_exists - should panic ... ok
[INFO] [stdout] test create_new_stream_where_storage_exists - should panic ... ok
[INFO] [stdout] test open_stream_on_storage - should panic ... ok
[INFO] [stdout] test create_new_stream_where_stream_exists - should panic ... ok
[INFO] [stdout] test create_storage_all_with_stream_in_the_way - should panic ... ok
[INFO] [stdout] test set_nonexistent_state_bits - should panic ... ok
[INFO] [stdout] test remove_stream_on_storage - should panic ... ok
[INFO] [stdout] test set_storage_clsid_for_stream - should panic ... ok
[INFO] [stdout] test remove_storage_on_stream - should panic ... ok
[INFO] [stdout] test create_very_large_stream ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 44 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.62s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]      Running tests/set_len.rs (/opt/rustwide/target/debug/deps/set_len-1acc1635edcfb6db)
[INFO] [stdout] running 9 tests
[INFO] [stdout] test resize_large_to_huge ... ok
[INFO] [stdout] test resize_large_to_small ... ok
[INFO] [stdout] test resize_small_to_large ... ok
[INFO] [stdout] test resize_huge_to_large ... ok
[INFO] [stdout] test resize_small_to_slightly_smaller ... ok
[INFO] [stdout] test resize_large_to_zero ... ok
[INFO] [stdout] test resize_small_to_zero ... ok
[INFO] [stdout] test resize_zero_to_zero ... ok
[INFO] [stdout] test resize_small_to_slightly_bigger ... ok
[INFO] [stderr]    Doc-tests cfb
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 9 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.05s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test src/lib.rs - (line 17) - compile ... ok
[INFO] [stdout] test src/internal/version.rs - internal::version::Version::sector_len (line 42) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 5.22s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "f2859d27fa59ef8f118d726c2a0fdb093713e3df743c5fa1e53a178c0b4b0378", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "f2859d27fa59ef8f118d726c2a0fdb093713e3df743c5fa1e53a178c0b4b0378", kill_on_drop: false }`
[INFO] [stdout] f2859d27fa59ef8f118d726c2a0fdb093713e3df743c5fa1e53a178c0b4b0378