[INFO] fetching crate frozen-core 0.0.18...
[INFO] testing frozen-core-0.0.18 against 1.95.0 for beta-1.96-2
[INFO] extracting crate frozen-core 0.0.18 into /workspace/builds/worker-0-tc1/source
[INFO] started tweaking crates.io crate frozen-core 0.0.18
[INFO] finished tweaking crates.io crate frozen-core 0.0.18
[INFO] tweaked toml for crates.io crate frozen-core 0.0.18 written to /workspace/builds/worker-0-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate frozen-core 0.0.18 on toolchain 1.95.0
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.95.0" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate frozen-core 0.0.18 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.95.0" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded quote v1.0.44
[INFO] [stderr]   Downloaded getrandom v0.4.1
[INFO] [stderr]   Downloaded wasm-bindgen-macro v0.2.117
[INFO] [stderr]   Downloaded wasm-bindgen-shared v0.2.117
[INFO] [stderr]   Downloaded wasm-bindgen-macro-support v0.2.117
[INFO] [stderr]   Downloaded wasm-bindgen v0.2.117
[INFO] [stderr]   Downloaded wit-bindgen v0.46.0
[INFO] [stderr]   Downloaded cc v1.2.58
[INFO] [stderr]   Downloaded js-sys v0.3.94
[INFO] [stderr]   Downloaded tempfile v3.25.0
[INFO] [stderr]   Downloaded wasip2 v1.0.1+wasi-0.2.4
[INFO] [stderr]   Downloaded rustix v1.1.3
[INFO] [stderr]   Downloaded web-sys v0.3.94
[INFO] [stderr]   Downloaded libc v0.2.180
[INFO] [stderr]   Downloaded linux-raw-sys v0.11.0
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+1.95.0" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 2915a8612fe2871c3c5751cf91b45223ec12e1cdd74a52c04da5f1ef3c489ef3
[INFO] running `Command { std: "docker" "start" "-a" "2915a8612fe2871c3c5751cf91b45223ec12e1cdd74a52c04da5f1ef3c489ef3", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "2915a8612fe2871c3c5751cf91b45223ec12e1cdd74a52c04da5f1ef3c489ef3", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "2915a8612fe2871c3c5751cf91b45223ec12e1cdd74a52c04da5f1ef3c489ef3", kill_on_drop: false }`
[INFO] [stdout] 2915a8612fe2871c3c5751cf91b45223ec12e1cdd74a52c04da5f1ef3c489ef3
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/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" "RUSTDOCFLAGS=--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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+1.95.0" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] acdee3fdb21ba7bacc1de65e17cf82af7be1f1d619de3a2dea0a13058a252c77
[INFO] running `Command { std: "docker" "start" "-a" "acdee3fdb21ba7bacc1de65e17cf82af7be1f1d619de3a2dea0a13058a252c77", kill_on_drop: false }`
[INFO] [stderr]    Compiling frozen-core v0.0.18 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 0.13s
[INFO] running `Command { std: "docker" "inspect" "acdee3fdb21ba7bacc1de65e17cf82af7be1f1d619de3a2dea0a13058a252c77", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "acdee3fdb21ba7bacc1de65e17cf82af7be1f1d619de3a2dea0a13058a252c77", kill_on_drop: false }`
[INFO] [stdout] acdee3fdb21ba7bacc1de65e17cf82af7be1f1d619de3a2dea0a13058a252c77
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/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" "RUSTDOCFLAGS=--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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+1.95.0" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] f959b10c5b2efc48a4455d497f6086734d130b30c4aa47104a5124e8660a5cd9
[INFO] running `Command { std: "docker" "start" "-a" "f959b10c5b2efc48a4455d497f6086734d130b30c4aa47104a5124e8660a5cd9", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v1.0.106
[INFO] [stderr]    Compiling unicode-ident v1.0.24
[INFO] [stderr]    Compiling quote v1.0.44
[INFO] [stderr]    Compiling crossbeam-utils v0.8.21
[INFO] [stderr]    Compiling serde_core v1.0.228
[INFO] [stderr]    Compiling zerocopy v0.8.48
[INFO] [stderr]    Compiling libc v0.2.180
[INFO] [stderr]    Compiling cfg-if v1.0.4
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling autocfg v1.5.0
[INFO] [stderr]    Compiling zmij v1.0.21
[INFO] [stderr]    Compiling find-msvc-tools v0.1.9
[INFO] [stderr]    Compiling shlex v1.3.0
[INFO] [stderr]    Compiling either v1.15.0
[INFO] [stderr]    Compiling serde_json v1.0.149
[INFO] [stderr]    Compiling rayon-core v1.13.0
[INFO] [stderr]    Compiling rustix v1.1.3
[INFO] [stderr]    Compiling memchr v2.8.0
[INFO] [stderr]    Compiling itoa v1.0.17
[INFO] [stderr]    Compiling anstyle v1.0.14
[INFO] [stderr]    Compiling clap_lex v1.1.0
[INFO] [stderr]    Compiling regex-syntax v0.8.10
[INFO] [stderr]    Compiling cc v1.2.58
[INFO] [stderr]    Compiling plotters-backend v0.3.7
[INFO] [stderr]    Compiling ciborium-io v0.2.2
[INFO] [stderr]    Compiling getrandom v0.4.1
[INFO] [stderr]    Compiling clap_builder v4.6.0
[INFO] [stderr]    Compiling plotters-svg v0.3.7
[INFO] [stderr]    Compiling itertools v0.13.0
[INFO] [stderr]    Compiling bitflags v2.11.0
[INFO] [stderr]    Compiling cast v0.3.0
[INFO] [stderr]    Compiling same-file v1.0.6
[INFO] [stderr]    Compiling linux-raw-sys v0.11.0
[INFO] [stderr]    Compiling crossbeam-epoch v0.9.18
[INFO] [stderr]    Compiling num-traits v0.2.19
[INFO] [stderr]    Compiling walkdir v2.5.0
[INFO] [stderr]    Compiling oorandom v11.1.5
[INFO] [stderr]    Compiling fastrand v2.3.0
[INFO] [stderr]    Compiling once_cell v1.21.3
[INFO] [stderr]    Compiling anes v0.1.6
[INFO] [stderr]    Compiling crossbeam-deque v0.8.6
[INFO] [stderr]    Compiling syn v2.0.117
[INFO] [stderr]    Compiling alloca v0.4.0
[INFO] [stderr]    Compiling rayon v1.11.0
[INFO] [stderr]    Compiling page_size v0.6.0
[INFO] [stderr]    Compiling criterion-plot v0.8.2
[INFO] [stderr]    Compiling plotters v0.3.7
[INFO] [stderr]    Compiling regex-automata v0.4.14
[INFO] [stderr]    Compiling tempfile v3.25.0
[INFO] [stderr]    Compiling clap v4.6.0
[INFO] [stderr]    Compiling regex v1.12.3
[INFO] [stderr]    Compiling zerocopy-derive v0.8.48
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling tinytemplate v1.2.1
[INFO] [stderr]    Compiling half v2.7.1
[INFO] [stderr]    Compiling ciborium-ll v0.2.2
[INFO] [stderr]    Compiling ciborium v0.2.2
[INFO] [stderr]    Compiling criterion v0.8.2
[INFO] [stderr]    Compiling frozen-core v0.0.18 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 43.50s
[INFO] running `Command { std: "docker" "inspect" "f959b10c5b2efc48a4455d497f6086734d130b30c4aa47104a5124e8660a5cd9", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "f959b10c5b2efc48a4455d497f6086734d130b30c4aa47104a5124e8660a5cd9", kill_on_drop: false }`
[INFO] [stdout] f959b10c5b2efc48a4455d497f6086734d130b30c4aa47104a5124e8660a5cd9
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/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" "RUSTDOCFLAGS=--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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+1.95.0" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 5291ac6c35c33176e639fff3d72bc8018c15239a57dcdd93ff057517259e9e99
[INFO] running `Command { std: "docker" "start" "-a" "5291ac6c35c33176e639fff3d72bc8018c15239a57dcdd93ff057517259e9e99", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.12s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/frozen_core-7f33d2e0e626bf02)
[INFO] [stdout] running 210 tests
[INFO] [stdout] test bpool::tests::dynamic_allocs::ok_no_duplicate_slots_in_single_dynamic_alloc ... ok
[INFO] [stdout] test bpool::tests::pre_allocs::ok_alloc_all_even_when_exhausted ... ok
[INFO] [stdout] test bpool::tests::dynamic_allocs::ok_dynamic_alloc ... ok
[INFO] [stdout] test bpool::tests::pre_allocs::ok_alloc_exact_cap_as_requested ... ok
[INFO] [stdout] test bpool::tests::pre_allocs::ok_alloc_works ... ok
[INFO] [stdout] test bpool::tests::raii_safety::ok_pre_alloc_auto_free_on_drop ... ok
[INFO] [stdout] test bpool::tests::pre_allocs::ok_alloc_all_when_requested_larger_then_cap ... ok
[INFO] [stdout] test bpool::tests::raii_safety::ok_dynamic_alloc_auto_free_on_drop ... ok
[INFO] [stdout] test crc32::tests::corruption_detection::ok_detects_torn_write_simulation ... ok
[INFO] [stdout] test crc32::tests::corruption_detection::ok_every_bit_flip_changes_crc ... ok
[INFO] [stdout] test bpool::tests::dynamic_allocs::ok_large_allocation_with_dynamic_alloc ... ok
[INFO] [stdout] test bpool::tests::utils::pack_unpack_cycle ... ok
[INFO] [stdout] test crc32::tests::hw_sw_consistency::ok_crc_buf_2x ... ok
[INFO] [stdout] test crc32::tests::hw_sw_consistency::ok_crc_buf_4x ... ok
[INFO] [stdout] test bpool::tests::concurrency::ok_concurrent_dynamic_alloc ... ok
[INFO] [stdout] test bpool::tests::shutdown_safety::ok_cross_thread_drop ... ok
[INFO] [stdout] test crc32::tests::corruption_detection::ok_multiple_bit_flips_change_crc ... ok
[INFO] [stdout] test crc32::tests::corruption_detection::ok_detects_random_corruption ... ok
[INFO] [stdout] test bpool::tests::concurrency::ok_concurrent_alloc ... ok
[INFO] [stdout] test crc32::tests::hw_sw_consistency::ok_crc_single_buf ... ok
[INFO] [stdout] test crc32::tests::public_api::ok_crc_is_deterministic ... ok
[INFO] [stdout] test error::tests::ok_compare_different_id ... ok
[INFO] [stdout] test crc32::tests::public_api::ok_different_buffers_have_different_crc ... ok
[INFO] [stdout] test crc32::tests::public_api::ok_known_crc_vectors ... ok
[INFO] [stdout] test crc32::tests::public_api::ok_zero_buffer_crc ... ok
[INFO] [stdout] test error::tests::ok_compare_same_id_different_context ... ok
[INFO] [stdout] test crc32::tests::corruption_detection::ok_single_bit_flip_changes_crc ... ok
[INFO] [stdout] test crc32::tests::public_api::ok_parallel_crc_matches_single ... ok
[INFO] [stdout] test bpool::tests::pre_allocs::ok_no_duplicate_slots_in_single_alloc ... ok
[INFO] [stdout] test error::tests::ok_empty_detail ... ok
[INFO] [stdout] test error::tests::ok_error_id_roundtrip_basic ... ok
[INFO] [stdout] test error::tests::ok_empty_message ... ok
[INFO] [stdout] test error::tests::ok_error_id_roundtrip_edges ... ok
[INFO] [stdout] test error::tests::ok_new_raw_uses_display ... ok
[INFO] [stdout] test error::tests::ok_new_and_new_raw_same_id ... ok
[INFO] [stdout] test error::tests::ok_context_formatting ... ok
[INFO] [stdout] test bpool::tests::pre_allocs::ok_large_allocation_with_pre_alloc ... ok
[INFO] [stdout] test error::tests::ok_context_exact_format ... ok
[INFO] [stdout] test ffile::posix::tests::fil_sync::ok_sync ... ok
[INFO] [stdout] test ffile::posix::tests::file_grow::ok_grow_extends_with_zero ... ok
[INFO] [stdout] test error::tests::ok_error_id_reason_only_changes_low_bits ... ok
[INFO] [stdout] test ffile::posix::tests::file_grow::ok_grow ... ok
[INFO] [stdout] test ffile::posix::tests::file_lifecycle::err_pread_after_closed ... ok
[INFO] [stdout] test ffile::posix::tests::fil_sync::ok_sync_after_sync ... ok
[INFO] [stdout] test ffile::posix::tests::file_lifecycle::err_pwrite_after_closed ... ok
[INFO] [stdout] test ffile::posix::tests::file_lifecycle::err_length_after_closed ... ok
[INFO] [stdout] test ffile::posix::tests::file_lock::err_flock_when_already_locked ... ok
[INFO] [stdout] test ffile::posix::tests::file_lifecycle::err_sync_after_closed ... ok
[INFO] [stdout] test ffile::posix::tests::file_lifecycle::err_grow_after_closed ... ok
[INFO] [stdout] test ffile::posix::tests::file_new_close::err_new_on_missing_parent_dir ... ok
[INFO] [stdout] test ffile::posix::tests::file_new_close::ok_close_on_close ... ok
[INFO] [stdout] test ffile::posix::tests::file_new_close::ok_new_close_cycle ... ok
[INFO] [stdout] test ffile::posix::tests::file_lock::ok_flock_released_after_close ... ok
[INFO] [stdout] test ffile::posix::tests::utils::ok_err_msg ... ok
[INFO] [stdout] test ffile::posix::tests::file_new_close::ok_new_close_cycle_on_existing ... ok
[INFO] [stdout] test ffile::posix::tests::file_lifecycle::err_double_unlink_after_close ... ok
[INFO] [stdout] test ffile::posix::tests::utils::ok_extract_parent_dir ... ok
[INFO] [stdout] test ffile::posix::tests::file_unlink::ok_unlink_existing ... ok
[INFO] [stdout] test ffile::posix::tests::raw_syscalls::ok_f_advice_random ... ok
[INFO] [stdout] test ffile::posix::tests::raw_syscalls::ok_write_read_at_eof_boundary ... ok
[INFO] [stdout] test ffile::posix::tests::file_unlink::err_unlink_missing ... ok
[INFO] [stdout] test ffile::posix::tests::raw_syscalls::ok_multiple_open_close_cycles ... ok
[INFO] [stdout] test ffile::posix::tests::raw_syscalls::ok_sync_range ... ok
[INFO] [stdout] test ffile::posix::tests::raw_syscalls::ok_sync_cycle ... ok
[INFO] [stdout] test ffile::posix::tests::write_read_single::ok_pwrite_when_overlapping_last_wins ... ok
[INFO] [stdout] test bpool::tests::shutdown_safety::drop_waits_for_active_pre_allocations ... ok
[INFO] [stdout] test ffile::posix::tests::utils::ok_last_errno ... ok
[INFO] [stdout] test ffile::posix::tests::write_read_vectored::ok_pwritev_preadv_cycle ... ok
[INFO] [stdout] test ffile::posix::tests::write_read_single::ok_pwrite_pread_across_sessions ... ok
[INFO] [stdout] test ffile::posix::tests::write_read_vectored::ok_pwritev_preadv_across_sessions ... ok
[INFO] [stdout] test ffile::posix::tests::utils::ok_path_to_cstring ... ok
[INFO] [stdout] test ffile::posix::tests::utils::ok_read_max_iovecs ... ok
[INFO] [stdout] test ffile::posix::tests::file_lock::ok_flock_acquires_exclusive_lock ... ok
[INFO] [stdout] test ffile::posix::tests::write_read_single::ok_pwrite_pread_cycle ... ok
[INFO] [stdout] test ffile::tests::ff_lifecycle::ok_delete_file ... ok
[INFO] [stdout] test ffile::posix::tests::write_read_vectored::ok_pwritev_handles_large_iovec_batches ... ok
[INFO] [stdout] test ffile::tests::ff_lifecycle::ok_exists_true_when_exists ... ok
[INFO] [stdout] test ffile::tests::ff_lifecycle::err_delete_after_delete ... ok
[INFO] [stdout] test ffile::posix::tests::write_read_single::ok_pwrite_concurrent_non_overlapping ... ok
[INFO] [stdout] test ffile::posix::tests::write_read_vectored_load::ok_single_thread_large_batch ... ok
[INFO] [stdout] test crc32::tests::hw_sw_consistency::ok_crc_random_bufs ... ok
[INFO] [stdout] test ffile::tests::ff_lifecycle::ok_drop_persists_without_explicit_sync ... ok
[INFO] [stdout] test ffile::posix::tests::write_read_vectored::ok_pwritev_concurrent_non_overlapping ... ok
[INFO] [stdout] test ffile::tests::ff_lock::err_new_when_already_open ... ok
[INFO] [stdout] test ffile::tests::ff_lifecycle::err_new_when_file_smaller_than_init_len ... ok
[INFO] [stdout] test ffile::tests::ff_sync::err_sync_after_delete ... ok
[INFO] [stdout] test bpool::tests::shutdown_safety::drop_waits_for_active_dynamic_allocations ... ok
[INFO] [stdout] test ffile::tests::ff_sync::ok_sync_after_sync ... ok
[INFO] [stdout] test ffile::tests::ff_lock::ok_drop_releases_exclusive_lock ... ok
[INFO] [stdout] test ffile::tests::ff_write_read::ok_concurrent_grow_and_write ... ok
[INFO] [stdout] test ffile::tests::ff_grow::ok_grow_updates_length ... ok
[INFO] [stdout] test ffile::tests::ff_write_read::err_read_hcf_for_eof ... ok
[INFO] [stdout] test ffile::tests::ff_write_read::ok_single_write_read_cycle ... ok
[INFO] [stdout] test ffile::tests::ff_lifecycle::ok_exists_false_when_missing ... ok
[INFO] [stdout] test fmmap::posix::tests::map_durability::ok_map_durability_after_unmap ... ok
[INFO] [stdout] test fmmap::posix::tests::map_sync::ok_sync ... ok
[INFO] [stdout] test ffile::tests::ff_write_read::ok_vectored_write_read_cycle ... ok
[INFO] [stdout] test fmmap::posix::tests::map_sync::ok_sync_after_sync ... ok
[INFO] [stdout] test fmmap::posix::tests::map_unmap::err_unmap_on_invalid_length ... ok
[INFO] [stdout] test fmmap::posix::tests::map_unmap::err_map_on_invalid_fd ... ok
[INFO] [stdout] test fmmap::posix::tests::map_unmap::err_map_on_invalid_length ... ok
[INFO] [stdout] test fmmap::posix::tests::map_unmap::ok_map_unmap_cycle ... ok
[INFO] [stdout] test ffile::tests::ff_grow::ok_grow_sync_cycle ... ok
[INFO] [stdout] test fmmap::posix::tests::utils::ok_err_msg ... ok
[INFO] [stdout] test fmmap::posix::tests::map_durability::ok_map_durability_after_unmap_and_close ... ok
[INFO] [stdout] test fmmap::posix::tests::utils::ok_last_errno ... ok
[INFO] [stdout] test ffile::tests::ff_write_read::ok_concurrent_sync_and_write ... ok
[INFO] [stdout] test fmmap::posix::tests::map_write_read::ok_read_zero_bytes ... ok
[INFO] [stdout] test fmmap::posix::tests::map_unmap::ok_map_zero_bytes_on_new ... ok
[INFO] [stdout] test fmmap::posix::tests::map_write_read::ok_write_read_cycle ... ok
[INFO] [stdout] test fmmap::tests::fm_concurrency::ok_parallel_reads_with_diff_index ... ok
[INFO] [stdout] test fmmap::posix::tests::map_write_read::ok_write_read_sync_cycle ... ok
[INFO] [stdout] test ffile::tests::ff_write_read::ok_write_concurrent_non_overlapping ... ok
[INFO] [stdout] test fmmap::posix::tests::map_write_read::ok_write_read_with_offset ... ok
[INFO] [stdout] test fmmap::tests::fm_lifecycle::ok_delete ... ok
[INFO] [stdout] test fmmap::tests::fm_new_grown::err_new_grown_with_preexisting_instance ... ok
[INFO] [stdout] test fmmap::tests::fm_durability::ok_wait_for_durability_with_multi_writers ... ok
[INFO] [stdout] test fmmap::tests::fm_lifecycle::ok_new_existing ... ok
[INFO] [stdout] test fmmap::tests::fm_durability::ok_wait_then_drop ... ok
[INFO] [stdout] test fmmap::tests::fm_tx::err_tx_duplicate_index ... ok
[INFO] [stdout] test fmmap::tests::fm_new_grown::ok_new_grown_updates_length ... ok
[INFO] [stdout] test fmmap::tests::fm_new_grown::ok_new_grown_cycle ... ok
[INFO] [stdout] test fmmap::tests::fm_tx::err_tx_out_of_order ... ok
[INFO] [stdout] test fmmap::tests::fm_tx::ok_tx_overwrite_last_wins ... ok
[INFO] [stdout] test fmmap::tests::fm_tx::ok_tx_basic_multi_write ... ok
[INFO] [stdout] test fmmap::tests::fm_new_grown::ok_write_reopen_grown_read ... ok
[INFO] [stdout] test fmmap::tests::fm_tx::ok_tx_concurrent_non_overlapping ... ok
[INFO] [stdout] test ffile::tests::ff_lifecycle::ok_new_with_init_len ... ok
[INFO] [stdout] test fmmap::tests::fm_validate_t::err_new_grown_when_t_implements_drop ... ok
[INFO] [stdout] test fmmap::tests::fm_lifecycle::err_delete_after_delete ... ok
[INFO] [stdout] test fmmap::tests::fm_concurrency::ok_multi_tx_drop_then_reopen_grown ... ok
[INFO] [stdout] test fmmap::tests::fm_durability::ok_epoch_monotonicity ... ok
[INFO] [stdout] test fmmap::tests::fm_validate_t::err_new_grown_when_t_is_zero_sized ... ok
[INFO] [stdout] test ffile::tests::ff_lifecycle::ok_new_existing ... ok
[INFO] [stdout] test fmmap::tests::fm_validate_t::err_new_when_t_implements_drop ... ok
[INFO] [stdout] test fmmap::tests::fm_tx::ok_tx_persists_across_reopen ... ok
[INFO] [stdout] test fmmap::tests::fm_validate_t::err_new_when_t_is_not_8_byte_aligned ... ok
[INFO] [stdout] test fmmap::tests::fm_new_grown::err_new_grown_while_previous_instance_is_alive ... ok
[INFO] [stdout] test fmmap::tests::fm_validate_t::err_validate_t_when_drop ... ok
[INFO] [stdout] test fmmap::tests::fm_validate_t::err_validate_t_when_not_8_byte_aligned ... ok
[INFO] [stdout] test fmmap::tests::fm_validate_t::err_validate_t_when_size_not_multiple_of_8 ... ok
[INFO] [stdout] test fmmap::tests::fm_validate_t::err_validate_t_when_zero_sized ... ok
[INFO] [stdout] test fmmap::tests::fm_validate_t::ok_validate_t ... ok
[INFO] [stdout] test fmmap::tests::fm_validate_t::err_new_when_t_is_zero_sized ... ok
[INFO] [stdout] test fmmap::tests::fm_new_grown::ok_write_reopen_grown_read_cycle ... ok
[INFO] [stdout] test fmmap::tests::fm_validate_t::err_new_when_t_size_is_not_multiple_of_8 ... ok
[INFO] [stdout] test fmmap::tests::fm_lifecycle::ok_new ... ok
[INFO] [stdout] test fmmap::tests::fm_write_read::ok_write_wait_read_cycle ... ok
[INFO] [stdout] test fmmap::tests::fm_lifecycle::ok_drop_persists_when_dropped_before_bg_flush ... ok
[INFO] [stdout] test fmmap::tests::fm_validate_t::err_new_grown_when_t_size_is_not_multiple_of_8 ... ok
[INFO] [stdout] test fmmap::tests::fm_validate_t::err_new_grown_when_t_is_not_8_byte_aligned ... ok
[INFO] [stdout] test fmmap::tests::fm_tx::ok_tx_single_epoch ... ok
[INFO] [stdout] test fmmap::tests::fm_write_sync_read::ok_write_sync_wait_returns_immediately ... ok
[INFO] [stdout] test fmmap::tests::fm_write_sync_read::ok_write_sync_makes_prev_batch_durable ... ok
[INFO] [stdout] test fmmap::tests::fm_write_sync_read::ok_write_sync_read ... ok
[INFO] [stdout] test fmmap::tests::fm_lifecycle::err_new_when_change_in_cfg ... ok
[INFO] [stdout] test fmmap::tests::fm_write_read::ok_write_read_without_wait ... ok
[INFO] [stdout] test fmmap::tests::fm_write_sync_read::ok_write_sync_persists_across_reopen ... ok
[INFO] [stdout] test fpipe::tests::batching::ok_multiple_writes_single_batch ... ok
[INFO] [stdout] test fpipe::tests::fp_grow::ok_grow_file ... ok
[INFO] [stdout] test fmmap::tests::fm_write_sync_read::ok_write_sync_followed_by_async_write ... ok
[INFO] [stdout] test fpipe::tests::fp_read::ok_overwrite_same_index ... ok
[INFO] [stdout] test fpipe::tests::concurrency::ok_barrier_start_parallel_writes ... ok
[INFO] [stdout] test ffile::posix::tests::write_read_vectored_load::ok_multi_thread_large_batch ... ok
[INFO] [stdout] test fpipe::tests::durability_wait::ok_force_durability_concurrent ... ok
[INFO] [stdout] test fpipe::tests::durability_wait::ok_wait_blocks_until_flush ... ok
[INFO] [stdout] test fpipe::tests::fp_read::ok_read_after_grow ... ok
[INFO] [stdout] test fpipe::tests::fp_grow::ok_write_after_grow ... ok
[INFO] [stdout] test fpipe::tests::fp_read::ok_concurrent_read_write ... ok
[INFO] [stdout] test fpipe::tests::fp_read::ok_large_read_multi ... ok
[INFO] [stdout] test fpipe::tests::fp_read::ok_read_4x ... ok
[INFO] [stdout] test fpipe::tests::fp_read::ok_read_2x ... ok
[INFO] [stdout] test fpipe::tests::fp_read::ok_read_multi_generic ... ok
[INFO] [stdout] test fpipe::tests::fp_tx::err_tx_empty_commit ... ok
[INFO] [stdout] test fpipe::tests::fp_grow::ok_grow_while_writing ... ok
[INFO] [stdout] test fpipe::tests::fp_tx::ok_tx_basic_multi_write ... ok
[INFO] [stdout] test fpipe::tests::fp_read::ok_read_single_after_write ... ok
[INFO] [stdout] test fpipe::tests::fp_tx::ok_tx_overwrite_last_wins ... ok
[INFO] [stdout] test fpipe::tests::fp_read::ok_read_multiple_indices ... ok
[INFO] [stdout] test fpipe::tests::fp_read::ok_read_concurrent ... ok
[INFO] [stdout] test fpipe::tests::fp_tx::ok_tx_concurrent_non_overlapping ... ok
[INFO] [stdout] test fpipe::tests::fp_tx::ok_tx_single_epoch ... ok
[INFO] [stdout] test fpipe::tests::fp_write::ok_write_and_wait ... ok
[INFO] [stdout] test hints::tests::sanity_checks_for_likely ... ok
[INFO] [stdout] test hints::tests::sanity_checks_for_unlikely ... ok
[INFO] [stdout] test mpscq::tests::basics::ok_drain_empty_when_queue_empty ... ok
[INFO] [stdout] test mpscq::tests::basics::ok_push_drain_single ... ok
[INFO] [stdout] test fpipe::tests::lifecycle::ok_drop ... ok
[INFO] [stdout] test fpipe::tests::fp_write::ok_write_large ... ok
[INFO] [stdout] test fpipe::tests::fp_write::ok_force_durability ... ok
[INFO] [stdout] test fpipe::tests::shutdown::ok_drop_with_pending_writes ... ok
[INFO] [stdout] test fpipe::tests::fp_write::ok_write_multiple_chunks ... ok
[INFO] [stdout] test fpipe::tests::fp_tx::ok_tx_persists_across_reopen ... ok
[INFO] [stdout] test mpscq::tests::basics::ok_push_drain_multiple ... ok
[INFO] [stdout] test fpipe::tests::fp_write::ok_write_epoch_monotonic ... ok
[INFO] [stdout] test fpipe::tests::fp_write::ok_write_is_blocked_at_pool_exhaustion_for_prealloc_backend ... ok
[INFO] [stdout] test bpool::tests::polling::ok_pre_alloc_blocks_until_buffers_freed ... FAILED
[INFO] [stdout] test fpipe::tests::lifecycle::ok_new ... ok
[INFO] [stdout] test mpscq::tests::cycles::ok_multi_push_drain_cycles ... ok
[INFO] [stdout] test mpscq::tests::empty::ok_is_empty_true_after_drain ... ok
[INFO] [stdout] test mpscq::tests::cycles::ok_single_push_drain_cycles ... ok
[INFO] [stdout] test mpscq::tests::concurrency::ok_multi_tx_push_drain ... ok
[INFO] [stdout] test mpscq::tests::empty::ok_is_empty_false_after_push ... ok
[INFO] [stdout] test fpipe::tests::shutdown::ok_drop_during_activity ... ok
[INFO] [stdout] test fpipe::tests::shutdown::ok_drop_while_writer_waiting ... ok
[INFO] [stdout] test mpscq::tests::empty::ok_is_empty_true_on_init ... ok
[INFO] [stdout] test fpipe::tests::concurrency::ok_multi_writer ... ok
[INFO] [stdout] test fpipe::tests::fp_write::ok_write_large_batch ... ok
[INFO] [stdout] test mpscq::tests::concurrency::ok_multi_tx_push ... ok
[INFO] [stdout] test mpscq::tests::concurrency::ok_multi_tx_push_high_contention ... ok
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- bpool::tests::polling::ok_pre_alloc_blocks_until_buffers_freed stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread '<unnamed>' (26) panicked at src/bpool.rs:925:17:
[INFO] [stdout] assertion failed: elapsed >= Duration::from_millis(20)
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5b882b7d11fa - std[e28293b1aa0f68bd]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x5b882b7d11fa - std[e28293b1aa0f68bd]::backtrace_rs::backtrace::trace_unsynchronized::<std[e28293b1aa0f68bd]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x5b882b7d11fa - std[e28293b1aa0f68bd]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x5b882b7d11fa - <<std[e28293b1aa0f68bd]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[c1f1a4ba060b9bfa]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x5b882b7e581a - <core[c1f1a4ba060b9bfa]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x5b882b7e581a - core[c1f1a4ba060b9bfa]::fmt::write
[INFO] [stdout]    6:     0x5b882b7d5b62 - std[e28293b1aa0f68bd]::io::default_write_fmt::<alloc[fdfd2bd8633a6659]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/io/mod.rs:639:11
[INFO] [stdout]    7:     0x5b882b7d5b62 - <alloc[fdfd2bd8633a6659]::vec::Vec<u8> as std[e28293b1aa0f68bd]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/io/mod.rs:1994:13
[INFO] [stdout]    8:     0x5b882b7ae92f - <std[e28293b1aa0f68bd]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x5b882b7ae92f - std[e28293b1aa0f68bd]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x5b882b7c9079 - std[e28293b1aa0f68bd]::panicking::default_hook
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x5b882b764b3c - <alloc[fdfd2bd8633a6659]::boxed::Box<dyn for<'a, 'b> core[c1f1a4ba060b9bfa]::ops::function::Fn<(&'a std[e28293b1aa0f68bd]::panic::PanicHookInfo<'b>,), Output = ()> + core[c1f1a4ba060b9bfa]::marker::Sync + core[c1f1a4ba060b9bfa]::marker::Send> as core[c1f1a4ba060b9bfa]::ops::function::Fn<(&std[e28293b1aa0f68bd]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/alloc/src/boxed.rs:2254:9
[INFO] [stdout]   12:     0x5b882b764b3c - test[273d7611820c9051]::test_main_with_exit_callback::<test[273d7611820c9051]::test_main::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/test/src/lib.rs:145:21
[INFO] [stdout]   13:     0x5b882b7c9232 - <alloc[fdfd2bd8633a6659]::boxed::Box<dyn for<'a, 'b> core[c1f1a4ba060b9bfa]::ops::function::Fn<(&'a std[e28293b1aa0f68bd]::panic::PanicHookInfo<'b>,), Output = ()> + core[c1f1a4ba060b9bfa]::marker::Sync + core[c1f1a4ba060b9bfa]::marker::Send> as core[c1f1a4ba060b9bfa]::ops::function::Fn<(&std[e28293b1aa0f68bd]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/alloc/src/boxed.rs:2254:9
[INFO] [stdout]   14:     0x5b882b7c9232 - std[e28293b1aa0f68bd]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x5b882b7aea1a - std[e28293b1aa0f68bd]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/panicking.rs:691:13
[INFO] [stdout]   16:     0x5b882b7a62a9 - std[e28293b1aa0f68bd]::sys::backtrace::__rust_end_short_backtrace::<std[e28293b1aa0f68bd]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x5b882b7af6fd - __rustc[b7974e8690430dd9]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x5b882b7e60cc - core[c1f1a4ba060b9bfa]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x5b882b7e6092 - core[c1f1a4ba060b9bfa]::panicking::panic
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/core/src/panicking.rs:150:5
[INFO] [stdout]   20:     0x5b882b6c3760 - frozen_core::bpool::tests::polling::ok_pre_alloc_blocks_until_buffers_freed::{{closure}}::h6f866fd63c48267a
[INFO] [stdout]                                at /opt/rustwide/workdir/src/bpool.rs:925:17
[INFO] [stdout]   21:     0x5b882b72fb7e - std::sys::backtrace::__rust_begin_short_backtrace::h1c75995dd76485db
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   22:     0x5b882b629dd7 - std::thread::lifecycle::spawn_unchecked::{{closure}}::{{closure}}::h195ae8ededfca02b
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/thread/lifecycle.rs:91:13
[INFO] [stdout]   23:     0x5b882b714e00 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::hb0869f2e50b6391c
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/core/src/panic/unwind_safe.rs:274:9
[INFO] [stdout]   24:     0x5b882b6782ba - std::panicking::catch_unwind::do_call::h8a736b99da908e2f
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/panicking.rs:581:40
[INFO] [stdout]   25:     0x5b882b62f39b - __rust_try
[INFO] [stdout]   26:     0x5b882b62690a - std::panicking::catch_unwind::h7131399381ae364b
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/panicking.rs:544:19
[INFO] [stdout]   27:     0x5b882b62690a - std::panic::catch_unwind::h6068faaca4a29982
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/panic.rs:359:14
[INFO] [stdout]   28:     0x5b882b62690a - std::thread::lifecycle::spawn_unchecked::{{closure}}::hd5e6b8594138370c
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/thread/lifecycle.rs:89:26
[INFO] [stdout]   29:     0x5b882b67a0ce - core::ops::function::FnOnce::call_once{{vtable.shim}}::h2755c4f54a5f08b3
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   30:     0x5b882b7d0b0f - <alloc[fdfd2bd8633a6659]::boxed::Box<dyn core[c1f1a4ba060b9bfa]::ops::function::FnOnce<(), Output = ()> + core[c1f1a4ba060b9bfa]::marker::Send> as core[c1f1a4ba060b9bfa]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/alloc/src/boxed.rs:2240:9
[INFO] [stdout]   31:     0x5b882b7d0b0f - <std[e28293b1aa0f68bd]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stdout]   32:     0x7f1e203e5aa4 - <unknown>
[INFO] [stdout]   33:     0x7f1e20472a64 - clone
[INFO] [stdout]   34:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] thread 'bpool::tests::polling::ok_pre_alloc_blocks_until_buffers_freed' (25) panicked at src/bpool.rs:934:13:
[INFO] [stdout] assertion failed: h1.join().is_ok()
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5b882b7d11fa - std[e28293b1aa0f68bd]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x5b882b7d11fa - std[e28293b1aa0f68bd]::backtrace_rs::backtrace::trace_unsynchronized::<std[e28293b1aa0f68bd]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x5b882b7d11fa - std[e28293b1aa0f68bd]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x5b882b7d11fa - <<std[e28293b1aa0f68bd]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[c1f1a4ba060b9bfa]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x5b882b7e581a - <core[c1f1a4ba060b9bfa]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x5b882b7e581a - core[c1f1a4ba060b9bfa]::fmt::write
[INFO] [stdout]    6:     0x5b882b7d5b62 - std[e28293b1aa0f68bd]::io::default_write_fmt::<alloc[fdfd2bd8633a6659]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/io/mod.rs:639:11
[INFO] [stdout]    7:     0x5b882b7d5b62 - <alloc[fdfd2bd8633a6659]::vec::Vec<u8> as std[e28293b1aa0f68bd]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/io/mod.rs:1994:13
[INFO] [stdout]    8:     0x5b882b7ae92f - <std[e28293b1aa0f68bd]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x5b882b7ae92f - std[e28293b1aa0f68bd]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x5b882b7c9079 - std[e28293b1aa0f68bd]::panicking::default_hook
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x5b882b764b3c - <alloc[fdfd2bd8633a6659]::boxed::Box<dyn for<'a, 'b> core[c1f1a4ba060b9bfa]::ops::function::Fn<(&'a std[e28293b1aa0f68bd]::panic::PanicHookInfo<'b>,), Output = ()> + core[c1f1a4ba060b9bfa]::marker::Sync + core[c1f1a4ba060b9bfa]::marker::Send> as core[c1f1a4ba060b9bfa]::ops::function::Fn<(&std[e28293b1aa0f68bd]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/alloc/src/boxed.rs:2254:9
[INFO] [stdout]   12:     0x5b882b764b3c - test[273d7611820c9051]::test_main_with_exit_callback::<test[273d7611820c9051]::test_main::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/test/src/lib.rs:145:21
[INFO] [stdout]   13:     0x5b882b7c9232 - <alloc[fdfd2bd8633a6659]::boxed::Box<dyn for<'a, 'b> core[c1f1a4ba060b9bfa]::ops::function::Fn<(&'a std[e28293b1aa0f68bd]::panic::PanicHookInfo<'b>,), Output = ()> + core[c1f1a4ba060b9bfa]::marker::Sync + core[c1f1a4ba060b9bfa]::marker::Send> as core[c1f1a4ba060b9bfa]::ops::function::Fn<(&std[e28293b1aa0f68bd]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/alloc/src/boxed.rs:2254:9
[INFO] [stdout]   14:     0x5b882b7c9232 - std[e28293b1aa0f68bd]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x5b882b7aea1a - std[e28293b1aa0f68bd]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/panicking.rs:691:13
[INFO] [stdout]   16:     0x5b882b7a62a9 - std[e28293b1aa0f68bd]::sys::backtrace::__rust_end_short_backtrace::<std[e28293b1aa0f68bd]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x5b882b7af6fd - __rustc[b7974e8690430dd9]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x5b882b7e60cc - core[c1f1a4ba060b9bfa]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x5b882b7e6092 - core[c1f1a4ba060b9bfa]::panicking::panic
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/core/src/panicking.rs:150:5
[INFO] [stdout]   20:     0x5b882b6c2b43 - frozen_core::bpool::tests::polling::ok_pre_alloc_blocks_until_buffers_freed::h45e0da5a3806f253
[INFO] [stdout]                                at /opt/rustwide/workdir/src/bpool.rs:934:13
[INFO] [stdout]   21:     0x5b882b6c2cb7 - frozen_core::bpool::tests::polling::ok_pre_alloc_blocks_until_buffers_freed::{{closure}}::h44c67a5aa875a9ca
[INFO] [stdout]                                at /opt/rustwide/workdir/src/bpool.rs:915:53
[INFO] [stdout]   22:     0x5b882b67b9b6 - core::ops::function::FnOnce::call_once::h56a9197db6e59dd8
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   23:     0x5b882b758c1b - <fn() -> core[c1f1a4ba060b9bfa]::result::Result<(), alloc[fdfd2bd8633a6659]::string::String> as core[c1f1a4ba060b9bfa]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   24:     0x5b882b758c1b - test[273d7611820c9051]::__rust_begin_short_backtrace::<core[c1f1a4ba060b9bfa]::result::Result<(), alloc[fdfd2bd8633a6659]::string::String>, fn() -> core[c1f1a4ba060b9bfa]::result::Result<(), alloc[fdfd2bd8633a6659]::string::String>>
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/test/src/lib.rs:663:18
[INFO] [stdout]   25:     0x5b882b76560b - test[273d7611820c9051]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/test/src/lib.rs:686:74
[INFO] [stdout]   26:     0x5b882b76560b - <core[c1f1a4ba060b9bfa]::panic::unwind_safe::AssertUnwindSafe<test[273d7611820c9051]::run_test_in_process::{closure#0}> as core[c1f1a4ba060b9bfa]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/core/src/panic/unwind_safe.rs:274:9
[INFO] [stdout]   27:     0x5b882b76560b - std[e28293b1aa0f68bd]::panicking::catch_unwind::do_call::<core[c1f1a4ba060b9bfa]::panic::unwind_safe::AssertUnwindSafe<test[273d7611820c9051]::run_test_in_process::{closure#0}>, core[c1f1a4ba060b9bfa]::result::Result<(), alloc[fdfd2bd8633a6659]::string::String>>
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/panicking.rs:581:40
[INFO] [stdout]   28:     0x5b882b76560b - std[e28293b1aa0f68bd]::panicking::catch_unwind::<core[c1f1a4ba060b9bfa]::result::Result<(), alloc[fdfd2bd8633a6659]::string::String>, core[c1f1a4ba060b9bfa]::panic::unwind_safe::AssertUnwindSafe<test[273d7611820c9051]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/panicking.rs:544:19
[INFO] [stdout]   29:     0x5b882b76560b - std[e28293b1aa0f68bd]::panic::catch_unwind::<core[c1f1a4ba060b9bfa]::panic::unwind_safe::AssertUnwindSafe<test[273d7611820c9051]::run_test_in_process::{closure#0}>, core[c1f1a4ba060b9bfa]::result::Result<(), alloc[fdfd2bd8633a6659]::string::String>>
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/panic.rs:359:14
[INFO] [stdout]   30:     0x5b882b76560b - test[273d7611820c9051]::run_test_in_process
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/test/src/lib.rs:686:27
[INFO] [stdout]   31:     0x5b882b76560b - test[273d7611820c9051]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/test/src/lib.rs:607:43
[INFO] [stdout]   32:     0x5b882b760d24 - test[273d7611820c9051]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/test/src/lib.rs:637:41
[INFO] [stdout]   33:     0x5b882b760d24 - std[e28293b1aa0f68bd]::sys::backtrace::__rust_begin_short_backtrace::<test[273d7611820c9051]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   34:     0x5b882b768212 - std[e28293b1aa0f68bd]::thread::lifecycle::spawn_unchecked::<test[273d7611820c9051]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/thread/lifecycle.rs:91:13
[INFO] [stdout]   35:     0x5b882b768212 - <core[c1f1a4ba060b9bfa]::panic::unwind_safe::AssertUnwindSafe<std[e28293b1aa0f68bd]::thread::lifecycle::spawn_unchecked<test[273d7611820c9051]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[c1f1a4ba060b9bfa]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/core/src/panic/unwind_safe.rs:274:9
[INFO] [stdout]   36:     0x5b882b768212 - std[e28293b1aa0f68bd]::panicking::catch_unwind::do_call::<core[c1f1a4ba060b9bfa]::panic::unwind_safe::AssertUnwindSafe<std[e28293b1aa0f68bd]::thread::lifecycle::spawn_unchecked<test[273d7611820c9051]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/panicking.rs:581:40
[INFO] [stdout]   37:     0x5b882b768212 - std[e28293b1aa0f68bd]::panicking::catch_unwind::<(), core[c1f1a4ba060b9bfa]::panic::unwind_safe::AssertUnwindSafe<std[e28293b1aa0f68bd]::thread::lifecycle::spawn_unchecked<test[273d7611820c9051]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/panicking.rs:544:19
[INFO] [stdout]   38:     0x5b882b768212 - std[e28293b1aa0f68bd]::panic::catch_unwind::<core[c1f1a4ba060b9bfa]::panic::unwind_safe::AssertUnwindSafe<std[e28293b1aa0f68bd]::thread::lifecycle::spawn_unchecked<test[273d7611820c9051]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/panic.rs:359:14
[INFO] [stdout]   39:     0x5b882b768212 - std[e28293b1aa0f68bd]::thread::lifecycle::spawn_unchecked::<test[273d7611820c9051]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/thread/lifecycle.rs:89:26
[INFO] [stdout]   40:     0x5b882b768212 - <std[e28293b1aa0f68bd]::thread::lifecycle::spawn_unchecked<test[273d7611820c9051]::run_test::{closure#1}, ()>::{closure#1} as core[c1f1a4ba060b9bfa]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   41:     0x5b882b7d0b0f - <alloc[fdfd2bd8633a6659]::boxed::Box<dyn core[c1f1a4ba060b9bfa]::ops::function::FnOnce<(), Output = ()> + core[c1f1a4ba060b9bfa]::marker::Send> as core[c1f1a4ba060b9bfa]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/alloc/src/boxed.rs:2240:9
[INFO] [stdout]   42:     0x5b882b7d0b0f - <std[e28293b1aa0f68bd]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stdout]   43:     0x7f1e203e5aa4 - <unknown>
[INFO] [stdout]   44:     0x7f1e20472a64 - clone
[INFO] [stdout]   45:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     bpool::tests::polling::ok_pre_alloc_blocks_until_buffers_freed
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 209 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.24s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass `--lib`
[INFO] running `Command { std: "docker" "inspect" "5291ac6c35c33176e639fff3d72bc8018c15239a57dcdd93ff057517259e9e99", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "5291ac6c35c33176e639fff3d72bc8018c15239a57dcdd93ff057517259e9e99", kill_on_drop: false }`
[INFO] [stdout] 5291ac6c35c33176e639fff3d72bc8018c15239a57dcdd93ff057517259e9e99
