[INFO] fetching crate lance-arrow 4.0.0...
[INFO] testing lance-arrow-4.0.0 against try#dec9417b8611e34e787a3e4c37686b5131f9e5c5 for pr-154210-1
[INFO] extracting crate lance-arrow 4.0.0 into /workspace/builds/worker-3-tc2/source
[INFO] started tweaking crates.io crate lance-arrow 4.0.0
[INFO] finished tweaking crates.io crate lance-arrow 4.0.0
[INFO] tweaked toml for crates.io crate lance-arrow 4.0.0 written to /workspace/builds/worker-3-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate lance-arrow 4.0.0 on toolchain dec9417b8611e34e787a3e4c37686b5131f9e5c5
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate lance-arrow 4.0.0 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" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/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" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] ce1a059d9d440eadac6b662f8997c32dc3e6c1c409a3911400931a2e0c3ee83b
[INFO] running `Command { std: "docker" "start" "-a" "ce1a059d9d440eadac6b662f8997c32dc3e6c1c409a3911400931a2e0c3ee83b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "ce1a059d9d440eadac6b662f8997c32dc3e6c1c409a3911400931a2e0c3ee83b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "ce1a059d9d440eadac6b662f8997c32dc3e6c1c409a3911400931a2e0c3ee83b", kill_on_drop: false }`
[INFO] [stdout] ce1a059d9d440eadac6b662f8997c32dc3e6c1c409a3911400931a2e0c3ee83b
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/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=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-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" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 00d38ae3be4075590178be2df9e6850e001860ddd00aa72669585c64f4a3586d
[INFO] running `Command { std: "docker" "start" "-a" "00d38ae3be4075590178be2df9e6850e001860ddd00aa72669585c64f4a3586d", kill_on_drop: false }`
[INFO] [stderr]    Compiling libm v0.2.16
[INFO] [stderr]    Compiling num-traits v0.2.19
[INFO] [stderr]    Compiling zerocopy v0.8.48
[INFO] [stderr]    Compiling zerocopy-derive v0.8.48
[INFO] [stderr]    Compiling libc v0.2.183
[INFO] [stderr]    Compiling getrandom v0.3.4
[INFO] [stderr]    Compiling lexical-util v1.0.7
[INFO] [stderr]    Compiling once_cell v1.21.4
[INFO] [stderr]    Compiling arrow-schema v57.3.0
[INFO] [stderr]    Compiling ahash v0.8.12
[INFO] [stderr]    Compiling hashbrown v0.16.1
[INFO] [stderr]    Compiling serde_json v1.0.149
[INFO] [stderr]    Compiling futures-util v0.3.32
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling nom v8.0.0
[INFO] [stderr]    Compiling fast-float2 v0.2.3
[INFO] [stderr]    Compiling jiff v0.2.23
[INFO] [stderr]    Compiling ethnum v1.5.2
[INFO] [stderr]    Compiling lexical-write-integer v1.0.6
[INFO] [stderr]    Compiling lexical-parse-integer v1.0.6
[INFO] [stderr]    Compiling lexical-parse-float v1.0.6
[INFO] [stderr]    Compiling lexical-write-float v1.0.6
[INFO] [stderr]    Compiling lexical-core v1.0.6
[INFO] [stderr]    Compiling rand_core v0.9.5
[INFO] [stderr]    Compiling num-integer v0.1.46
[INFO] [stderr]    Compiling num-complex v0.4.6
[INFO] [stderr]    Compiling chrono v0.4.44
[INFO] [stderr]    Compiling atoi v2.0.0
[INFO] [stderr]    Compiling ordered-float v5.3.0
[INFO] [stderr]    Compiling num-bigint v0.4.6
[INFO] [stderr]    Compiling futures-executor v0.3.32
[INFO] [stderr]    Compiling futures v0.3.32
[INFO] [stderr]    Compiling half v2.7.1
[INFO] [stderr]    Compiling ppv-lite86 v0.2.21
[INFO] [stderr]    Compiling arrow-buffer v57.3.0
[INFO] [stderr]    Compiling rand_chacha v0.9.0
[INFO] [stderr]    Compiling rand v0.9.2
[INFO] [stderr]    Compiling arrow-data v57.3.0
[INFO] [stderr]    Compiling jsonb v0.5.6
[INFO] [stderr]    Compiling arrow-array v57.3.0
[INFO] [stderr]    Compiling arrow-select v57.3.0
[INFO] [stderr]    Compiling arrow-ord v57.3.0
[INFO] [stderr]    Compiling arrow-cast v57.3.0
[INFO] [stderr]    Compiling lance-arrow v4.0.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 48.88s
[INFO] running `Command { std: "docker" "inspect" "00d38ae3be4075590178be2df9e6850e001860ddd00aa72669585c64f4a3586d", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "00d38ae3be4075590178be2df9e6850e001860ddd00aa72669585c64f4a3586d", kill_on_drop: false }`
[INFO] [stdout] 00d38ae3be4075590178be2df9e6850e001860ddd00aa72669585c64f4a3586d
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/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=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-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" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] f5661b06c5f334ee4cad6987501cb1fba7a1f6c0adee92ebc4cafcfbbd15ebaa
[INFO] running `Command { std: "docker" "start" "-a" "f5661b06c5f334ee4cad6987501cb1fba7a1f6c0adee92ebc4cafcfbbd15ebaa", kill_on_drop: false }`
[INFO] [stderr]    Compiling lance-arrow v4.0.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 2.46s
[INFO] running `Command { std: "docker" "inspect" "f5661b06c5f334ee4cad6987501cb1fba7a1f6c0adee92ebc4cafcfbbd15ebaa", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "f5661b06c5f334ee4cad6987501cb1fba7a1f6c0adee92ebc4cafcfbbd15ebaa", kill_on_drop: false }`
[INFO] [stdout] f5661b06c5f334ee4cad6987501cb1fba7a1f6c0adee92ebc4cafcfbbd15ebaa
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/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=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-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" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 71951ee47ba131d5ba55b1c9de497a8f3f2cd09b4ed9256670afa937db5ff067
[INFO] running `Command { std: "docker" "start" "-a" "71951ee47ba131d5ba55b1c9de497a8f3f2cd09b4ed9256670afa937db5ff067", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.09s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/lance_arrow-4a176eb4852ae579)
[INFO] [stdout] 
[INFO] [stdout] running 81 tests
[INFO] [stdout] test bfloat16::tests::test_nulls ... ok
[INFO] [stdout] test bfloat16::tests::test_basics ... ok
[INFO] [stdout] test deepcopy::tests::test_deep_copy_array_sliced ... ok
[INFO] [stdout] test deepcopy::tests::test_deep_copy_array_data_sliced ... ok
[INFO] [stdout] test deepcopy::tests::test_deep_copy_array_sliced_with_nulls ... ok
[INFO] [stdout] test deepcopy::tests::test_deep_copy_batch_sliced ... ok
[INFO] [stdout] test floats::tests::test_coerce_float_vector_bfloat16 ... ok
[INFO] [stdout] test json::tests::test_convert_json_columns_empty_batch ... ok
[INFO] [stdout] test json::tests::test_convert_json_columns ... ok
[INFO] [stdout] test json::tests::test_convert_json_columns_invalid_json_utf8 ... ok
[INFO] [stdout] test json::tests::test_arrow_json_to_lance_json_non_json_field ... ok
[INFO] [stdout] test deepcopy::tests::test_deep_copy_sliced_array_with_nulls ... ok
[INFO] [stdout] test json::tests::test_convert_json_columns_invalid_storage_type ... ok
[INFO] [stdout] test json::tests::test_convert_json_columns_invalid_json_large_utf8 ... ok
[INFO] [stdout] test json::tests::test_convert_json_columns_mixed_columns ... ok
[INFO] [stdout] test json::tests::test_convert_json_columns_large_string ... ok
[INFO] [stdout] test json::tests::test_convert_json_columns_no_json_columns ... ok
[INFO] [stdout] test json::tests::test_convert_lance_json_to_arrow ... ok
[INFO] [stdout] test json::tests::test_convert_lance_json_to_arrow_empty_batch ... ok
[INFO] [stdout] test json::tests::test_convert_lance_json_to_arrow_mixed_columns ... ok
[INFO] [stdout] test json::tests::test_convert_lance_json_to_arrow_no_json_columns ... ok
[INFO] [stdout] test json::tests::test_decode_json_on_various_inputs ... ok
[INFO] [stdout] test json::tests::test_encode_json_invalid ... ok
[INFO] [stdout] test json::tests::test_has_json_fields ... ok
[INFO] [stdout] test json::tests::test_is_arrow_json_field_large_utf8 ... ok
[INFO] [stdout] test json::tests::test_is_arrow_json_field_wrong_extension ... ok
[INFO] [stdout] test json::tests::test_is_json_field_wrong_extension ... ok
[INFO] [stdout] test json::tests::test_json_array_empty ... ok
[INFO] [stdout] test json::tests::test_json_array_from_invalid_json ... ok
[INFO] [stdout] test json::tests::test_json_array_from_string_array ... ok
[INFO] [stdout] test json::tests::test_json_array_inner ... ok
[INFO] [stdout] test json::tests::test_json_array_from_strings ... ok
[INFO] [stdout] test json::tests::test_json_array_trait_methods ... ok
[INFO] [stdout] test json::tests::test_json_array_value_bytes ... ok
[INFO] [stdout] test json::tests::test_json_array_value_null_error ... ok
[INFO] [stdout] test json::tests::test_json_field_creation ... ok
[INFO] [stdout] test json::tests::test_json_path_invalid_path ... ok
[INFO] [stdout] test json::tests::test_try_from_large_string_array ... ok
[INFO] [stdout] test json::tests::test_try_from_large_string_array_invalid_json ... ok
[INFO] [stdout] test json::tests::test_json_path_extraction ... ok
[INFO] [stdout] test json::tests::test_try_from_string_array_invalid_json ... ok
[INFO] [stdout] test json::tests::test_json_path_with_null ... ok
[INFO] [stdout] test list::tests::test_trim_values ... ok
[INFO] [stdout] test list::tests::test_filter_garbage_nulls ... ok
[INFO] [stdout] test memory::tests::test_memory_accumulator ... ok
[INFO] [stdout] test json::tests::test_to_arrow_json ... ok
[INFO] [stdout] test r#struct::tests::test_arrow_rs_slicing ... ok
[INFO] [stdout] test scalar::tests::test_decode_scalar_from_value_buffer_rejects_nested_type ... ok
[INFO] [stdout] test json::tests::test_try_from_array_ref ... ok
[INFO] [stdout] test scalar::tests::test_decode_scalar_from_value_buffer_trailing_bytes ... ok
[INFO] [stdout] test scalar::tests::test_extract_scalar_value ... ok
[INFO] [stdout] test scalar::tests::test_inline_value_boolean_round_trip ... ok
[INFO] [stdout] test scalar::tests::test_scalar_value_buffer_fixed_size_binary_round_trip ... ok
[INFO] [stdout] test scalar::tests::test_scalar_value_buffer_rejects_nested_type ... ok
[INFO] [stdout] test scalar::tests::test_scalar_value_buffer_utf8_round_trip ... ok
[INFO] [stdout] test stream::tests::test_empty_stream ... ok
[INFO] [stdout] test stream::tests::test_error_propagation ... ok
[INFO] [stdout] test stream::tests::test_flush_remainder_on_stream_end ... ok
[INFO] [stdout] test stream::tests::test_large_batch_sliced ... ok
[INFO] [stdout] test stream::tests::test_large_then_small_batches ... ok
[INFO] [stdout] test stream::tests::test_row_preservation_across_slicing ... ok
[INFO] [stdout] test stream::tests::test_single_batch_passthrough ... ok
[INFO] [stdout] test stream::tests::test_sliced_leftovers_are_not_recombined ... ok
[INFO] [stdout] test tests::test_byte_width_opt ... ok
[INFO] [stdout] test stream::tests::test_small_batches_concatenated ... ok
[INFO] [stdout] test json::tests::test_json_path_on_corrupted_jsonb ... ok
[INFO] [stdout] test r#struct::tests::test_normalize_slicing_no_offset ... ok
[INFO] [stdout] test r#struct::tests::test_arrow_cpp_slicing ... ok
[INFO] [stdout] test tests::test_merge_null_typed_column_with_parent_validity ... ok
[INFO] [stdout] test tests::test_merge_recursive ... ok
[INFO] [stdout] test tests::test_merge_struct_lists ... ok
[INFO] [stdout] test tests::test_merge_struct_with_different_validity ... ok
[INFO] [stdout] test tests::test_merge_list_struct ... ok
[INFO] [stdout] test tests::test_merge_with_schema_with_nullable_struct_list_schema_mismatch ... ok
[INFO] [stdout] test tests::test_project_by_schema_nested_list_struct ... ok
[INFO] [stdout] test tests::test_project_preserves_struct_validity ... ok
[INFO] [stdout] test tests::test_take_record_batch ... ok
[INFO] [stdout] test tests::test_project_by_schema_list_struct_reorder ... ok
[INFO] [stdout] test tests::test_schema_project_by_schema ... ok
[INFO] [stdout] test tests::test_merge_with_schema ... ok
[INFO] [stdout] test tests::test_merge_struct_large_lists ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 81 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests lance_arrow
[INFO] [stdout] 
[INFO] [stdout] running 7 tests
[INFO] [stdout] test src/lib.rs - DataTypeExt::is_binary_like (line 61) ... ok
[INFO] [stdout] test src/lib.rs - FixedSizeListArrayExt::sample (line 254) ... ok
[INFO] [stdout] test src/lib.rs - RecordBatchExt::merge (line 525) ... ok
[INFO] [stdout] test src/lib.rs - try_new_generic_list_array (line 180) ... ok
[INFO] [stdout] test src/lib.rs - FixedSizeBinaryArrayExt::try_new_from_values (line 429) ... ok
[INFO] [stdout] test src/lib.rs - FixedSizeListArrayExt::try_new_from_values (line 231) ... ok
[INFO] [stdout] test src/lib.rs - RecordBatchExt::try_with_column (line 475) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stdout] all doctests ran in 0.90s; merged doctests compilation took 0.85s
[INFO] running `Command { std: "docker" "inspect" "71951ee47ba131d5ba55b1c9de497a8f3f2cd09b4ed9256670afa937db5ff067", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "71951ee47ba131d5ba55b1c9de497a8f3f2cd09b4ed9256670afa937db5ff067", kill_on_drop: false }`
[INFO] [stdout] 71951ee47ba131d5ba55b1c9de497a8f3f2cd09b4ed9256670afa937db5ff067