[INFO] fetching crate datafusion-expr 41.0.0...
[INFO] testing datafusion-expr-41.0.0 against try#024495a232636f1f9407d7695b2be51edc2c51bd for pr-130285
[INFO] extracting crate datafusion-expr 41.0.0 into /workspace/builds/worker-6-tc2/source
[INFO] validating manifest of crates.io crate datafusion-expr 41.0.0 on toolchain 024495a232636f1f9407d7695b2be51edc2c51bd
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+024495a232636f1f9407d7695b2be51edc2c51bd" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate datafusion-expr 41.0.0
[INFO] finished tweaking crates.io crate datafusion-expr 41.0.0
[INFO] tweaked toml for crates.io crate datafusion-expr 41.0.0 written to /workspace/builds/worker-6-tc2/source/Cargo.toml
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+024495a232636f1f9407d7695b2be51edc2c51bd" "generate-lockfile" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]      Locking 135 packages to latest compatible versions
[INFO] [stderr]       Adding arrow v52.2.0 (latest: v53.0.0)
[INFO] [stderr]       Adding arrow-arith v52.2.0 (latest: v53.0.0)
[INFO] [stderr]       Adding arrow-array v52.2.0 (latest: v53.0.0)
[INFO] [stderr]       Adding arrow-buffer v52.2.0 (latest: v53.0.0)
[INFO] [stderr]       Adding arrow-cast v52.2.0 (latest: v53.0.0)
[INFO] [stderr]       Adding arrow-csv v52.2.0 (latest: v53.0.0)
[INFO] [stderr]       Adding arrow-data v52.2.0 (latest: v53.0.0)
[INFO] [stderr]       Adding arrow-ipc v52.2.0 (latest: v53.0.0)
[INFO] [stderr]       Adding arrow-json v52.2.0 (latest: v53.0.0)
[INFO] [stderr]       Adding arrow-ord v52.2.0 (latest: v53.0.0)
[INFO] [stderr]       Adding arrow-row v52.2.0 (latest: v53.0.0)
[INFO] [stderr]       Adding arrow-schema v52.2.0 (latest: v53.0.0)
[INFO] [stderr]       Adding arrow-select v52.2.0 (latest: v53.0.0)
[INFO] [stderr]       Adding arrow-string v52.2.0 (latest: v53.0.0)
[INFO] [stderr]       Adding bitflags v1.3.2 (latest: v2.6.0)
[INFO] [stderr]       Adding chrono-tz v0.9.0 (latest: v0.10.0)
[INFO] [stderr]       Adding chrono-tz-build v0.3.0 (latest: v0.4.0)
[INFO] [stderr]       Adding datafusion-common v41.0.0 (latest: v42.0.0)
[INFO] [stderr]       Adding hermit-abi v0.3.9 (latest: v0.4.0)
[INFO] [stderr]       Adding lexical-core v0.8.5 (latest: v1.0.1)
[INFO] [stderr]       Adding lexical-parse-float v0.8.5 (latest: v1.0.1)
[INFO] [stderr]       Adding lexical-parse-integer v0.8.6 (latest: v1.0.1)
[INFO] [stderr]       Adding lexical-util v0.8.5 (latest: v1.0.2)
[INFO] [stderr]       Adding lexical-write-float v0.8.5 (latest: v1.0.1)
[INFO] [stderr]       Adding lexical-write-integer v0.8.5 (latest: v1.0.1)
[INFO] [stderr]       Adding siphasher v0.3.11 (latest: v1.0.1)
[INFO] [stderr]       Adding sqlparser v0.49.0 (latest: v0.51.0)
[INFO] [stderr]       Adding wasi v0.11.0+wasi-snapshot-preview1 (latest: v0.13.2+wasi-0.2.1)
[INFO] [stderr]       Adding windows-core v0.52.0 (latest: v0.58.0)
[INFO] [stderr]       Adding windows-sys v0.52.0 (latest: v0.59.0)
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+024495a232636f1f9407d7695b2be51edc2c51bd" "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-6-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-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:96c0aa5895ecf336b730ef27bcdde6e21027415df19888aad3cf1448e5d65d90" "/opt/rustwide/cargo-home/bin/cargo" "+024495a232636f1f9407d7695b2be51edc2c51bd" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] b90dc16dcd897be6beb376cfb44d352ce247cb78c452c39ddbffb2b4af2cbebe
[INFO] running `Command { std: "docker" "start" "-a" "b90dc16dcd897be6beb376cfb44d352ce247cb78c452c39ddbffb2b4af2cbebe", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "b90dc16dcd897be6beb376cfb44d352ce247cb78c452c39ddbffb2b4af2cbebe", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "b90dc16dcd897be6beb376cfb44d352ce247cb78c452c39ddbffb2b4af2cbebe", kill_on_drop: false }`
[INFO] [stdout] b90dc16dcd897be6beb376cfb44d352ce247cb78c452c39ddbffb2b4af2cbebe
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-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:96c0aa5895ecf336b730ef27bcdde6e21027415df19888aad3cf1448e5d65d90" "/opt/rustwide/cargo-home/bin/cargo" "+024495a232636f1f9407d7695b2be51edc2c51bd" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 37fe334978b8eeccd6053c1c53f0f6893dc9a87db60840d4c84d8713d73f902b
[INFO] running `Command { std: "docker" "start" "-a" "37fe334978b8eeccd6053c1c53f0f6893dc9a87db60840d4c84d8713d73f902b", kill_on_drop: false }`
[INFO] [stderr]    Compiling libm v0.2.8
[INFO] [stderr]    Compiling siphasher v0.3.11
[INFO] [stderr]    Compiling regex-syntax v0.8.4
[INFO] [stderr]    Compiling rand_core v0.6.4
[INFO] [stderr]    Compiling version_check v0.9.5
[INFO] [stderr]    Compiling once_cell v1.19.0
[INFO] [stderr]    Compiling proc-macro2 v1.0.86
[INFO] [stderr]    Compiling zerocopy v0.7.35
[INFO] [stderr]    Compiling iana-time-zone v0.1.61
[INFO] [stderr]    Compiling bytes v1.7.2
[INFO] [stderr]    Compiling unicode-ident v1.0.13
[INFO] [stderr]    Compiling allocator-api2 v0.2.18
[INFO] [stderr]    Compiling arrow-schema v52.2.0
[INFO] [stderr]    Compiling num-traits v0.2.19
[INFO] [stderr]    Compiling static_assertions v1.1.0
[INFO] [stderr]    Compiling getrandom v0.2.15
[INFO] [stderr]    Compiling lexical-util v0.8.5
[INFO] [stderr]    Compiling rustversion v1.0.17
[INFO] [stderr]    Compiling memchr v2.7.4
[INFO] [stderr]    Compiling phf_shared v0.11.2
[INFO] [stderr]    Compiling rand v0.8.5
[INFO] [stderr]    Compiling phf v0.11.2
[INFO] [stderr]    Compiling heck v0.5.0
[INFO] [stderr]    Compiling ahash v0.8.11
[INFO] [stderr]    Compiling semver v1.0.23
[INFO] [stderr]    Compiling lexical-write-integer v0.8.5
[INFO] [stderr]    Compiling lexical-parse-integer v0.8.6
[INFO] [stderr]    Compiling serde v1.0.210
[INFO] [stderr]    Compiling ryu v1.0.18
[INFO] [stderr]    Compiling lexical-write-float v0.8.5
[INFO] [stderr]    Compiling lexical-parse-float v0.8.5
[INFO] [stderr]    Compiling unicode-width v0.1.13
[INFO] [stderr]    Compiling quote v1.0.37
[INFO] [stderr]    Compiling aho-corasick v1.1.3
[INFO] [stderr]    Compiling itoa v1.0.11
[INFO] [stderr]    Compiling base64 v0.22.1
[INFO] [stderr]    Compiling phf_generator v0.11.2
[INFO] [stderr]    Compiling hashbrown v0.14.5
[INFO] [stderr]    Compiling syn v2.0.77
[INFO] [stderr]    Compiling lexical-core v0.8.5
[INFO] [stderr]    Compiling phf_codegen v0.11.2
[INFO] [stderr]    Compiling serde_json v1.0.128
[INFO] [stderr]    Compiling rustc_version v0.4.1
[INFO] [stderr]    Compiling csv-core v0.1.11
[INFO] [stderr]    Compiling equivalent v1.0.1
[INFO] [stderr]    Compiling log v0.4.22
[INFO] [stderr]    Compiling paste v1.0.15
[INFO] [stderr]    Compiling num_cpus v1.16.0
[INFO] [stderr]    Compiling flatbuffers v24.3.25
[INFO] [stderr]    Compiling indexmap v2.5.0
[INFO] [stderr]    Compiling regex-automata v0.4.7
[INFO] [stderr]    Compiling num-integer v0.1.46
[INFO] [stderr]    Compiling num-complex v0.4.6
[INFO] [stderr]    Compiling half v2.4.1
[INFO] [stderr]    Compiling chrono v0.4.38
[INFO] [stderr]    Compiling atoi v2.0.0
[INFO] [stderr]    Compiling num-bigint v0.4.6
[INFO] [stderr]    Compiling num-iter v0.1.45
[INFO] [stderr]    Compiling num-rational v0.4.2
[INFO] [stderr]    Compiling num v0.4.3
[INFO] [stderr]    Compiling arrow-buffer v52.2.0
[INFO] [stderr]    Compiling csv v1.3.0
[INFO] [stderr]    Compiling regex v1.10.6
[INFO] [stderr]    Compiling strum_macros v0.26.4
[INFO] [stderr]    Compiling sqlparser_derive v0.2.2
[INFO] [stderr]    Compiling arrow-data v52.2.0
[INFO] [stderr]    Compiling parse-zoneinfo v0.3.1
[INFO] [stderr]    Compiling sqlparser v0.49.0
[INFO] [stderr]    Compiling chrono-tz-build v0.3.0
[INFO] [stderr]    Compiling chrono-tz v0.9.0
[INFO] [stderr]    Compiling strum v0.26.3
[INFO] [stderr]    Compiling comfy-table v7.1.1
[INFO] [stderr]    Compiling arrow-array v52.2.0
[INFO] [stderr]    Compiling arrow-select v52.2.0
[INFO] [stderr]    Compiling arrow-row v52.2.0
[INFO] [stderr]    Compiling arrow-arith v52.2.0
[INFO] [stderr]    Compiling arrow-cast v52.2.0
[INFO] [stderr]    Compiling arrow-ord v52.2.0
[INFO] [stderr]    Compiling arrow-string v52.2.0
[INFO] [stderr]    Compiling arrow-ipc v52.2.0
[INFO] [stderr]    Compiling arrow-json v52.2.0
[INFO] [stderr]    Compiling arrow-csv v52.2.0
[INFO] [stderr]    Compiling arrow v52.2.0
[INFO] [stderr]    Compiling datafusion-common v41.0.0
[INFO] [stderr]    Compiling datafusion-expr v41.0.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 43.22s
[INFO] running `Command { std: "docker" "inspect" "37fe334978b8eeccd6053c1c53f0f6893dc9a87db60840d4c84d8713d73f902b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "37fe334978b8eeccd6053c1c53f0f6893dc9a87db60840d4c84d8713d73f902b", kill_on_drop: false }`
[INFO] [stdout] 37fe334978b8eeccd6053c1c53f0f6893dc9a87db60840d4c84d8713d73f902b
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-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:96c0aa5895ecf336b730ef27bcdde6e21027415df19888aad3cf1448e5d65d90" "/opt/rustwide/cargo-home/bin/cargo" "+024495a232636f1f9407d7695b2be51edc2c51bd" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 1b34f52e6b1c35e31d0fb290ac2f34f43c8dce5e2b5fce0026bce928582cc822
[INFO] running `Command { std: "docker" "start" "-a" "1b34f52e6b1c35e31d0fb290ac2f34f43c8dce5e2b5fce0026bce928582cc822", kill_on_drop: false }`
[INFO] [stderr]    Compiling syn v2.0.77
[INFO] [stderr]    Compiling log v0.4.22
[INFO] [stderr]    Compiling utf8parse v0.2.2
[INFO] [stderr]    Compiling anstyle v1.0.8
[INFO] [stderr]    Compiling is_terminal_polyfill v1.70.1
[INFO] [stderr]    Compiling colorchoice v1.0.2
[INFO] [stderr]    Compiling anstyle-query v1.1.1
[INFO] [stderr]    Compiling anstyle-parse v0.2.5
[INFO] [stderr]    Compiling env_filter v0.1.2
[INFO] [stderr]    Compiling anstream v0.6.15
[INFO] [stderr]    Compiling env_logger v0.11.5
[INFO] [stderr]    Compiling strum_macros v0.26.4
[INFO] [stderr]    Compiling sqlparser_derive v0.2.2
[INFO] [stderr]    Compiling ctor v0.2.8
[INFO] [stderr]    Compiling sqlparser v0.49.0
[INFO] [stderr]    Compiling strum v0.26.3
[INFO] [stderr]    Compiling comfy-table v7.1.1
[INFO] [stderr]    Compiling arrow-cast v52.2.0
[INFO] [stderr]    Compiling arrow-json v52.2.0
[INFO] [stderr]    Compiling arrow-ipc v52.2.0
[INFO] [stderr]    Compiling arrow-csv v52.2.0
[INFO] [stderr]    Compiling arrow v52.2.0
[INFO] [stderr]    Compiling datafusion-common v41.0.0
[INFO] [stderr]    Compiling datafusion-expr v41.0.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 23.21s
[INFO] running `Command { std: "docker" "inspect" "1b34f52e6b1c35e31d0fb290ac2f34f43c8dce5e2b5fce0026bce928582cc822", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "1b34f52e6b1c35e31d0fb290ac2f34f43c8dce5e2b5fce0026bce928582cc822", kill_on_drop: false }`
[INFO] [stdout] 1b34f52e6b1c35e31d0fb290ac2f34f43c8dce5e2b5fce0026bce928582cc822
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-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:96c0aa5895ecf336b730ef27bcdde6e21027415df19888aad3cf1448e5d65d90" "/opt/rustwide/cargo-home/bin/cargo" "+024495a232636f1f9407d7695b2be51edc2c51bd" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 80a3793ff422473bff018d2d9129fcca6370f40b8e6c4954045cae95a16c90a8
[INFO] running `Command { std: "docker" "start" "-a" "80a3793ff422473bff018d2d9129fcca6370f40b8e6c4954045cae95a16c90a8", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.12s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/datafusion_expr-0ef933c027f49344)
[INFO] [stdout] 
[INFO] [stdout] running 145 tests
[INFO] [stdout] test built_in_window_function::tests::test_display_and_from_str ... ok
[INFO] [stdout] test execution_props::test::debug ... ok
[INFO] [stdout] test expr::test::format_cast ... ok
[INFO] [stdout] test expr::test::test_collect_expr ... ok
[INFO] [stdout] test conditional_expressions::tests::case_when_same_literal_then_types ... ok
[INFO] [stdout] test conditional_expressions::tests::case_when_different_literal_then_types ... ok
[INFO] [stdout] test expr::test::format_case_when ... ok
[INFO] [stdout] test expr::test::test_cume_dist_return_type ... ok
[INFO] [stdout] test columnar_value::tests::values_to_arrays ... ok
[INFO] [stdout] test expr::test::test_find_df_window_function ... ok
[INFO] [stdout] test expr::test::test_first_value_return_type ... ok
[INFO] [stdout] test expr::test::test_lag_return_type ... ok
[INFO] [stdout] test expr::test::test_is_volatile_scalar_func ... ok
[INFO] [stdout] test expr::test::test_nth_value_return_type ... ok
[INFO] [stdout] test expr::test::test_logical_ops ... ok
[INFO] [stdout] test expr::test::test_ntile_return_type ... ok
[INFO] [stdout] test expr::test::test_last_value_return_type ... ok
[INFO] [stdout] test expr::test::test_percent_rank_return_type ... ok
[INFO] [stdout] test expr::test::test_partial_ord ... ok
[INFO] [stdout] test expr::test::test_window_function_case_insensitive ... ok
[INFO] [stdout] test expr_fn::test::filter_is_null_and_is_not_null ... ok
[INFO] [stdout] test expr::test::test_lead_return_type ... ok
[INFO] [stdout] test expr_schema::tests::test_between_nullability ... ok
[INFO] [stdout] test expr_rewriter::test::rewriter_visit ... ok
[INFO] [stdout] test expr_rewriter::test::unnormalize_cols ... ok
[INFO] [stdout] test expr_schema::tests::expr_schema_data_type ... ok
[INFO] [stdout] test expr_rewriter::test::rewriter_rewrite ... ok
[INFO] [stdout] test expr_rewriter::test::normalize_cols ... ok
[INFO] [stdout] test expr_schema::tests::test_inlist_nullability ... ok
[INFO] [stdout] test expr_schema::tests::test_like_nullability ... ok
[INFO] [stdout] test interval_arithmetic::tests::equal_test ... ok
[INFO] [stdout] test expr_schema::tests::test_expr_metadata ... ok
[INFO] [stdout] test expr_rewriter::test::normalize_cols_non_exist ... ok
[INFO] [stdout] test interval_arithmetic::tests::gt_lt_test ... ok
[INFO] [stdout] test expr_rewriter::order_by::test::preserve_cast ... ok
[INFO] [stdout] test expr_rewriter::test::test_rewrite_preserving_name ... ok
[INFO] [stdout] test interval_arithmetic::tests::and_test ... ok
[INFO] [stdout] test interval_arithmetic::tests::gteq_lteq_test ... ok
[INFO] [stdout] test interval_arithmetic::tests::not_test ... ok
[INFO] [stdout] test interval_arithmetic::tests::intersect_test ... ok
[INFO] [stdout] test interval_arithmetic::tests::test_cardinality_of_intervals ... ok
[INFO] [stdout] test expr_rewriter::order_by::test::rewrite_sort_cols_by_agg ... ok
[INFO] [stdout] test expr_schema::tests::expr_schema_nullability ... ok
[INFO] [stdout] test interval_arithmetic::tests::test_make_unbounded ... ok
[INFO] [stdout] test interval_arithmetic::tests::test_new_interval ... ok
[INFO] [stdout] test interval_arithmetic::tests::test_contains ... ok
[INFO] [stdout] test interval_arithmetic::tests::test_interval_display ... ok
[INFO] [stdout] test literal::test::test_lit_nonzero ... ok
[INFO] [stdout] test interval_arithmetic::tests::test_next_prev_value ... ok
[INFO] [stdout] test interval_arithmetic::tests::test_add_intervals_lower_affected_f32 ... ok
[INFO] [stdout] test logical_plan::builder::tests::plan_builder_empty_name ... ok
[INFO] [stdout] test logical_plan::builder::tests::plan_builder_intersect_different_num_columns_error ... ok
[INFO] [stdout] test interval_arithmetic::tests::test_satisfy_comparison ... ok
[INFO] [stdout] test expr_rewriter::order_by::test::rewrite_sort_cols_by_agg_alias ... ok
[INFO] [stdout] test logical_plan::builder::tests::exists_subquery ... ok
[INFO] [stdout] test logical_plan::builder::tests::plan_builder_from_logical_plan ... ok
[INFO] [stdout] test logical_plan::builder::tests::filter_in_subquery ... ok
[INFO] [stdout] test interval_arithmetic::tests::test_sub ... ok
[INFO] [stdout] test interval_arithmetic::tests::test_add ... ok
[INFO] [stdout] test interval_arithmetic::tests::test_mul ... ok
[INFO] [stdout] test literal::test::test_lit_timestamp_nano ... ok
[INFO] [stdout] test interval_arithmetic::tests::test_div ... ok
[INFO] [stdout] test logical_plan::builder::tests::plan_builder_schema ... ok
[INFO] [stdout] test logical_plan::builder::tests::plan_builder_simple ... ok
[INFO] [stdout] test logical_plan::builder::tests::plan_builder_union_different_num_columns_error ... ok
[INFO] [stdout] test logical_plan::builder::tests::plan_builder_sort ... ok
[INFO] [stdout] test logical_plan::builder::tests::plan_builder_simple_distinct ... ok
[INFO] [stdout] test logical_plan::builder::tests::plan_builder_union ... ok
[INFO] [stdout] test logical_plan::builder::tests::plan_builder_union_distinct ... ok
[INFO] [stdout] test logical_plan::display::tests::test_display_empty_schema ... ok
[INFO] [stdout] test logical_plan::builder::tests::select_scalar_subquery ... ok
[INFO] [stdout] test logical_plan::builder::tests::projection_non_unique_names ... ok
[INFO] [stdout] test logical_plan::display::tests::test_display_schema ... ok
[INFO] [stdout] test logical_plan::builder::tests::test_union_after_join ... ok
[INFO] [stdout] test logical_plan::plan::tests::early_stopping_post_visit ... ok
[INFO] [stdout] test logical_plan::builder::tests::plan_using_join_wildcard_projection ... ok
[INFO] [stdout] test logical_plan::builder::tests::stringified_plan ... ok
[INFO] [stdout] test logical_plan::builder::tests::test_change_redundant_column ... ok
[INFO] [stdout] test logical_plan::plan::tests::error_post_visit ... ok
[INFO] [stdout] test logical_plan::plan::tests::error_pre_visit ... ok
[INFO] [stdout] test logical_plan::plan::tests::early_stopping_pre_visit ... ok
[INFO] [stdout] test logical_plan::plan::tests::test_display_subquery_alias ... ok
[INFO] [stdout] test logical_plan::plan::tests::test_display_graphviz ... ok
[INFO] [stdout] test logical_plan::plan::tests::test_filter_is_scalar ... ok
[INFO] [stdout] test logical_plan::plan::tests::test_display_indent ... ok
[INFO] [stdout] test logical_plan::plan::tests::test_nullable_schema_after_grouping_set ... ok
[INFO] [stdout] test logical_plan::plan::tests::test_display_indent_schema ... ok
[INFO] [stdout] test logical_plan::plan::tests::projection_expr_schema_mismatch ... ok
[INFO] [stdout] test logical_plan::plan::tests::test_replace_invalid_placeholder ... ok
[INFO] [stdout] test signature::tests::supports_zero_argument_tests ... ok
[INFO] [stdout] test type_coercion::aggregates::tests::test_correlation_return_data_type ... ok
[INFO] [stdout] test logical_plan::builder::tests::plan_builder_unnest ... ok
[INFO] [stdout] test type_coercion::aggregates::tests::test_covariance_return_data_type ... ok
[INFO] [stdout] test logical_plan::plan::tests::test_transform_explain ... ok
[INFO] [stdout] test logical_plan::plan::tests::visit_order ... ok
[INFO] [stdout] test operator::tests::test_operators ... ok
[INFO] [stdout] test type_coercion::aggregates::tests::test_sum_return_data_type ... ok
[INFO] [stdout] test type_coercion::binary::tests::test_coercion_arithmetic_decimal ... ok
[INFO] [stdout] test type_coercion::aggregates::tests::test_variance_return_data_type ... ok
[INFO] [stdout] test logical_plan::plan::tests::test_display_pg_json ... ok
[INFO] [stdout] test type_coercion::binary::tests::test_dictionary_type_coercion ... ok
[INFO] [stdout] test type_coercion::binary::tests::test_date_timestamp_arithmetic_error ... ok
[INFO] [stdout] test type_coercion::binary::tests::test_coercion_error ... ok
[INFO] [stdout] test type_coercion::binary::tests::test_like_coercion ... ok
[INFO] [stdout] test type_coercion::binary::tests::test_type_coercion_compare ... ok
[INFO] [stdout] test type_coercion::binary::tests::test_type_coercion_logical_op ... ok
[INFO] [stdout] test type_coercion::binary::tests::test_decimal_binary_comparison_coercion ... ok
[INFO] [stdout] test type_coercion::functions::tests::test_coerced_from_dictionary ... ok
[INFO] [stdout] test type_coercion::binary::tests::test_type_coercion ... ok
[INFO] [stdout] test type_coercion::binary::tests::test_decimal_mathematics_op_type ... ok
[INFO] [stdout] test type_coercion::functions::tests::test_maybe_data_types ... ok
[INFO] [stdout] test type_coercion::functions::tests::test_fixed_list_wildcard_coerce ... ok
[INFO] [stdout] test type_coercion::functions::tests::test_nested_wildcard_fixed_size_lists ... ok
[INFO] [stdout] test type_coercion::functions::tests::test_get_valid_types_one_of ... ok
[INFO] [stdout] test type_coercion::functions::tests::test_string_conversion ... ok
[INFO] [stdout] test type_coercion::binary::tests::test_type_coercion_arithmetic ... ok
[INFO] [stdout] test utils::tests::test_collect_expr ... ok
[INFO] [stdout] test utils::tests::test_conjunction_empty ... ok
[INFO] [stdout] test utils::tests::test_conjunction ... ok
[INFO] [stdout] test utils::tests::test_disjunction ... ok
[INFO] [stdout] test utils::tests::avoid_generate_duplicate_sort_keys ... ok
[INFO] [stdout] test utils::tests::test_find_sort_exprs ... ok
[INFO] [stdout] test utils::tests::test_group_window_expr_by_sort_keys ... ok
[INFO] [stdout] test utils::tests::test_split_binary_owned ... ok
[INFO] [stdout] test utils::tests::test_split_binary_owned_two ... ok
[INFO] [stdout] test utils::tests::test_split_conjunction ... ok
[INFO] [stdout] test utils::tests::test_group_window_expr_by_sort_keys_empty_case ... ok
[INFO] [stdout] test utils::tests::test_split_conjunction_alias ... ok
[INFO] [stdout] test utils::tests::test_split_conjunction_or ... ok
[INFO] [stdout] test utils::tests::test_enumerate_grouping_sets ... ok
[INFO] [stdout] test utils::tests::test_split_conjunction_owned ... ok
[INFO] [stdout] test utils::tests::test_group_window_expr_by_sort_keys_empty_window ... ok
[INFO] [stdout] test utils::tests::test_disjunction_empty ... ok
[INFO] [stdout] test utils::tests::test_split_conjunction_owned_alias ... ok
[INFO] [stdout] test utils::tests::test_split_binary_owned_different_op ... ok
[INFO] [stdout] test utils::tests::test_split_conjunction_owned_or ... ok
[INFO] [stdout] test utils::tests::test_split_conjunction_owned_two ... ok
[INFO] [stdout] test utils::tests::test_split_conjunction_two ... ok
[INFO] [stdout] test var_provider::test::test_is_system_variables ... ok
[INFO] [stdout] test window_state::tests::test_window_frame_group_boundaries ... ok
[INFO] [stdout] test window_state::tests::test_window_frame_group_boundaries_both_following ... ok
[INFO] [stdout] test window_state::tests::test_window_frame_group_boundaries_both_preceding ... ok
[INFO] [stdout] test window_frame::tests::test_window_frame_creation ... ok
[INFO] [stdout] test columnar_value::tests::values_to_arrays_mixed_length - should panic ... ok
[INFO] [stdout] test columnar_value::tests::values_to_arrays_mixed_length_and_scalar - should panic ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 145 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.07s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests datafusion_expr
[INFO] [stdout] 
[INFO] [stdout] running 47 tests
[INFO] [stdout] test src/expr.rs - expr::Expr (line 135) ... ok
[INFO] [stdout] test src/expr.rs - expr::Expr (line 151) ... ok
[INFO] [stdout] test src/expr.rs - expr::Expr (line 120) ... ok
[INFO] [stdout] test src/expr.rs - expr::Expr (line 102) ... ok
[INFO] [stdout] test src/expr_fn.rs - expr_fn::ExprFunctionExt (line 652) - compile ... ok
[INFO] [stdout] test src/expr.rs - expr::Expr (line 178) ... ok
[INFO] [stdout] test src/expr.rs - expr::Expr::sort (line 1264) ... ok
[INFO] [stdout] test src/expr.rs - expr::Expr::try_as_col (line 1338) ... ok
[INFO] [stdout] test src/expr.rs - expr::Expr (line 204) ... ok
[INFO] [stdout] test src/expr.rs - expr::Expr::column_refs (line 1384) ... ok
[INFO] [stdout] test src/expr.rs - expr::Expr (line 90) ... ok
[INFO] [stdout] test src/expr.rs - expr::Expr::unalias_nested (line 1203) ... ok
[INFO] [stdout] test src/expr.rs - expr::WindowFunction (line 762) ... ok
[INFO] [stdout] test src/expr.rs - expr::Expr::column_refs_counts (line 1418) ... ok
[INFO] [stdout] test src/expr_fn.rs - expr_fn::col (line 52) ... ok
[INFO] [stdout] test src/interval_arithmetic.rs - interval_arithmetic::NullableInterval (line 1552) ... ok
[INFO] [stdout] test src/expr_fn.rs - expr_fn::wildcard (line 116) ... ok
[INFO] [stdout] test src/expr_schema.rs - expr_schema::Expr::get_type (line 75) ... ok
[INFO] [stdout] test src/expr.rs - expr::Expr::unalias (line 1176) ... ok
[INFO] [stdout] test src/interval_arithmetic.rs - interval_arithmetic::satisfy_greater (line 1178) ... ok
[INFO] [stdout] test src/interval_arithmetic.rs - interval_arithmetic::NullableInterval::single_value (line 1799) ... ok
[INFO] [stdout] test src/expr_fn.rs - expr_fn::placeholder (line 100) ... ok
[INFO] [stdout] test src/interval_arithmetic.rs - interval_arithmetic::NullableInterval::apply_operator (line 1675) ... ok
[INFO] [stdout] test src/expr_fn.rs - expr_fn::ident (line 77) ... ok
[INFO] [stdout] test src/logical_plan/builder.rs - logical_plan::builder::LogicalPlanBuilder (line 1149) ... ok
[INFO] [stdout] test src/logical_plan/builder.rs - logical_plan::builder::LogicalPlanBuilder::scan (line 238) ... ok
[INFO] [stdout] test src/logical_plan/builder.rs - logical_plan::builder::LogicalPlanBuilder (line 65) ... ok
[INFO] [stdout] test src/logical_plan/extension.rs - logical_plan::extension::UserDefinedLogicalNode::as_any (line 34) ... ok
[INFO] [stdout] test src/logical_plan/builder.rs - logical_plan::builder::LogicalPlanBuilder::join_on (line 638) ... ok
[INFO] [stdout] test src/logical_plan/display.rs - logical_plan::display::display_schema (line 99) ... ok
[INFO] [stdout] test src/udf.rs - udf::ScalarUDF::call (line 129) - compile ... ok
[INFO] [stdout] test src/logical_plan/plan.rs - logical_plan::plan::LogicalPlan::display_graphviz (line 1501) ... ok
[INFO] [stdout] test src/logical_plan/plan.rs - logical_plan::plan::LogicalPlan::display (line 1559) ... ok
[INFO] [stdout] test src/logical_plan/plan.rs - logical_plan::plan::LogicalPlan::with_param_values (line 1102) ... ok
[INFO] [stdout] test src/logical_plan/plan.rs - logical_plan::plan::LogicalPlan::display_indent_schema (line 1439) ... ok
[INFO] [stdout] test src/logical_plan/plan.rs - logical_plan::plan::LogicalPlan (line 141) ... ok
[INFO] [stdout] test src/logical_plan/plan.rs - logical_plan::plan::LogicalPlan::display_indent (line 1397) ... ok
[INFO] [stdout] test src/udf.rs - udf::ScalarUDFImpl (line 300) ... ok
[INFO] [stdout] test src/logical_plan/extension.rs - logical_plan::extension::UserDefinedLogicalNode::dyn_eq (line 172) ... ok
[INFO] [stdout] test src/udwf.rs - udwf::WindowUDFImpl (line 201) ... ok
[INFO] [stdout] test src/utils.rs - utils::disjunction (line 1107) ... ok
[INFO] [stdout] test src/udaf.rs - udaf::AggregateUDFImpl (line 282) ... ok
[INFO] [stdout] test src/signature.rs - signature::TypeSignature (line 76) ... ok
[INFO] [stdout] test src/logical_plan/plan.rs - logical_plan::plan::LogicalPlan (line 93) ... ok
[INFO] [stdout] test src/utils.rs - utils::conjunction (line 1081) ... ok
[INFO] [stdout] test src/utils.rs - utils::split_binary_owned (line 1009) ... ok
[INFO] [stdout] test src/utils.rs - utils::split_conjunction_owned (line 984) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 47 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test src/logical_plan/extension.rs - logical_plan::extension::UserDefinedLogicalNode::dyn_hash (line 135) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.08s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "80a3793ff422473bff018d2d9129fcca6370f40b8e6c4954045cae95a16c90a8", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "80a3793ff422473bff018d2d9129fcca6370f40b8e6c4954045cae95a16c90a8", kill_on_drop: false }`
[INFO] [stdout] 80a3793ff422473bff018d2d9129fcca6370f40b8e6c4954045cae95a16c90a8