[INFO] fetching crate kyu-planner 0.3.0...
[INFO] testing kyu-planner-0.3.0 against try#dec9417b8611e34e787a3e4c37686b5131f9e5c5 for pr-154210-1
[INFO] extracting crate kyu-planner 0.3.0 into /workspace/builds/worker-6-tc2/source
[INFO] started tweaking crates.io crate kyu-planner 0.3.0
[INFO] finished tweaking crates.io crate kyu-planner 0.3.0
[INFO] tweaked toml for crates.io crate kyu-planner 0.3.0 written to /workspace/builds/worker-6-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate kyu-planner 0.3.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 kyu-planner 0.3.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-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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 8a6820440b97b7284ab3dedd0ed45bcb6d2194b30ca5e8830086045ca8a0d028
[INFO] running `Command { std: "docker" "start" "-a" "8a6820440b97b7284ab3dedd0ed45bcb6d2194b30ca5e8830086045ca8a0d028", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "8a6820440b97b7284ab3dedd0ed45bcb6d2194b30ca5e8830086045ca8a0d028", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "8a6820440b97b7284ab3dedd0ed45bcb6d2194b30ca5e8830086045ca8a0d028", kill_on_drop: false }`
[INFO] [stdout] 8a6820440b97b7284ab3dedd0ed45bcb6d2194b30ca5e8830086045ca8a0d028
[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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 44c8eb50371038b3254b5b993a58f2201b316f301dfeda8a0baa135ebb2c8d06
[INFO] running `Command { std: "docker" "start" "-a" "44c8eb50371038b3254b5b993a58f2201b316f301dfeda8a0baa135ebb2c8d06", kill_on_drop: false }`
[INFO] [stderr]    Compiling quote v1.0.44
[INFO] [stderr]    Compiling libc v0.2.182
[INFO] [stderr]    Compiling object v0.37.3
[INFO] [stderr]    Compiling zerocopy v0.8.39
[INFO] [stderr]    Compiling getrandom v0.3.4
[INFO] [stderr]    Compiling cc v1.2.56
[INFO] [stderr]    Compiling ahash v0.8.12
[INFO] [stderr]    Compiling unicode-width v0.1.14
[INFO] [stderr]    Compiling yansi v1.0.1
[INFO] [stderr]    Compiling serde_json v1.0.149
[INFO] [stderr]    Compiling smol_str v0.3.5
[INFO] [stderr]    Compiling hashbrown v0.16.1
[INFO] [stderr]    Compiling simdutf8 v0.1.5
[INFO] [stderr]    Compiling float-cmp v0.10.0
[INFO] [stderr]    Compiling foldhash v0.1.5
[INFO] [stderr]    Compiling hashbrown v0.15.5
[INFO] [stderr]    Compiling ariadne v0.4.1
[INFO] [stderr]    Compiling syn v2.0.117
[INFO] [stderr]    Compiling stacker v0.1.23
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling thiserror-impl v2.0.18
[INFO] [stderr]    Compiling ref-cast-impl v1.0.25
[INFO] [stderr]    Compiling ref-cast v1.0.25
[INFO] [stderr]    Compiling thiserror v2.0.18
[INFO] [stderr]    Compiling ar_archive_writer v0.5.1
[INFO] [stderr]    Compiling psm v0.1.30
[INFO] [stderr]    Compiling hashbrown v0.14.5
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling chumsky v0.9.3
[INFO] [stderr]    Compiling kyu-common v0.3.0
[INFO] [stderr]    Compiling halfbrown v0.4.0
[INFO] [stderr]    Compiling kyu-types v0.3.0
[INFO] [stderr]    Compiling value-trait v0.12.1
[INFO] [stderr]    Compiling simd-json v0.17.0
[INFO] [stderr]    Compiling kyu-parser v0.3.0
[INFO] [stderr]    Compiling kyu-expression v0.3.0
[INFO] [stderr]    Compiling kyu-catalog v0.3.0
[INFO] [stderr]    Compiling kyu-binder v0.3.0
[INFO] [stderr]    Compiling kyu-planner v0.3.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 27.13s
[INFO] running `Command { std: "docker" "inspect" "44c8eb50371038b3254b5b993a58f2201b316f301dfeda8a0baa135ebb2c8d06", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "44c8eb50371038b3254b5b993a58f2201b316f301dfeda8a0baa135ebb2c8d06", kill_on_drop: false }`
[INFO] [stdout] 44c8eb50371038b3254b5b993a58f2201b316f301dfeda8a0baa135ebb2c8d06
[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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] c4f4547e8e8920a8202231210865bf9f02a1f5eb130bf5ef7ca482f4cfa10a5c
[INFO] running `Command { std: "docker" "start" "-a" "c4f4547e8e8920a8202231210865bf9f02a1f5eb130bf5ef7ca482f4cfa10a5c", kill_on_drop: false }`
[INFO] [stderr]    Compiling kyu-planner v0.3.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 2.41s
[INFO] running `Command { std: "docker" "inspect" "c4f4547e8e8920a8202231210865bf9f02a1f5eb130bf5ef7ca482f4cfa10a5c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "c4f4547e8e8920a8202231210865bf9f02a1f5eb130bf5ef7ca482f4cfa10a5c", kill_on_drop: false }`
[INFO] [stdout] c4f4547e8e8920a8202231210865bf9f02a1f5eb130bf5ef7ca482f4cfa10a5c
[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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] e86ad5f34b447f248d906354c45ea6466a7609b0c55749b54466756f65538d0d
[INFO] running `Command { std: "docker" "start" "-a" "e86ad5f34b447f248d906354c45ea6466a7609b0c55749b54466756f65538d0d", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.10s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/kyu_planner-58c3c00c4d39499c)
[INFO] [stdout] 
[INFO] [stdout] running 49 tests
[INFO] [stdout] test cost_model::tests::aggregate_reduces_rows ... ok
[INFO] [stdout] test cost_model::tests::cross_product_is_expensive ... ok
[INFO] [stdout] test cost_model::tests::empty_plan_cost ... ok
[INFO] [stdout] test logical_plan::tests::aggregate_output_schema ... ok
[INFO] [stdout] test logical_plan::tests::cross_product_combines_schemas ... ok
[INFO] [stdout] test logical_plan::tests::distinct_preserves_schema ... ok
[INFO] [stdout] test logical_plan::tests::filter_preserves_child_schema ... ok
[INFO] [stdout] test logical_plan::tests::hash_join_combines_schemas ... ok
[INFO] [stdout] test logical_plan::tests::limit_preserves_schema ... ok
[INFO] [stdout] test logical_plan::tests::projection_output_schema ... ok
[INFO] [stdout] test logical_plan::tests::scan_node_output_schema ... ok
[INFO] [stdout] test logical_plan::tests::unwind_extends_schema ... ok
[INFO] [stdout] test cost_model::tests::limit_reduces_cardinality ... ok
[INFO] [stdout] test cost_model::tests::order_by_adds_sort_cost ... ok
[INFO] [stdout] test cost_model::tests::scan_cost ... ok
[INFO] [stdout] test cost_model::tests::and_selectivity ... ok
[INFO] [stdout] test cost_model::tests::filter_reduces_cardinality ... ok
[INFO] [stdout] test optimizer::tests::leaf_nodes_unchanged ... ok
[INFO] [stdout] test plan_builder::tests::contains_aggregate_countstar ... ok
[INFO] [stdout] test optimizer::tests::nested_joins_reordered ... ok
[INFO] [stdout] test plan_builder::tests::contains_aggregate_function_call ... ok
[INFO] [stdout] test optimizer::tests::optimized_plan_costs_less ... ok
[INFO] [stdout] test logical_plan::tests::empty_schema ... ok
[INFO] [stdout] test optimizer::tests::filter_child_optimized ... ok
[INFO] [stdout] test optimizer::tests::hash_join_preserves_correct_order ... ok
[INFO] [stdout] test optimizer::tests::cross_product_reordered ... ok
[INFO] [stdout] test plan_builder::tests::contains_aggregate_literal_false ... ok
[INFO] [stdout] test optimizer::tests::hash_join_swaps_build_probe ... ok
[INFO] [stdout] test plan_builder::tests::plan_match_relationship ... ok
[INFO] [stdout] test plan_builder::tests::plan_create ... ok
[INFO] [stdout] test cost_model::tests::hash_join_cost ... ok
[INFO] [stdout] test plan_builder::tests::plan_distinct ... ok
[INFO] [stdout] test plan_builder::tests::plan_count_star ... ok
[INFO] [stdout] test plan_builder::tests::plan_match_where_return ... ok
[INFO] [stdout] test plan_builder::tests::plan_with_chaining ... ok
[INFO] [stdout] test plan_builder::tests::plan_return_arithmetic ... ok
[INFO] [stdout] test plan_builder::tests::plan_match_return ... ok
[INFO] [stdout] test statistics::tests::derive_node_stats ... ok
[INFO] [stdout] test statistics::tests::derive_rel_stats ... ok
[INFO] [stdout] test statistics::tests::empty_table_stats ... ok
[INFO] [stdout] test statistics::tests::row_count_known ... ok
[INFO] [stdout] test statistics::tests::row_count_unknown ... ok
[INFO] [stdout] test plan_builder::tests::plan_standalone_return ... ok
[INFO] [stdout] test plan_builder::tests::plan_standalone_return_multiple ... ok
[INFO] [stdout] test plan_builder::tests::plan_order_by_limit ... ok
[INFO] [stdout] test plan_builder::tests::plan_unwind ... ok
[INFO] [stdout] test plan_builder::tests::plan_group_by_aggregate ... ok
[INFO] [stdout] test plan_builder::tests::plan_sum_aggregate ... ok
[INFO] [stdout] test plan_builder::tests::plan_skip_limit ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 49 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.05s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests kyu_planner
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "e86ad5f34b447f248d906354c45ea6466a7609b0c55749b54466756f65538d0d", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "e86ad5f34b447f248d906354c45ea6466a7609b0c55749b54466756f65538d0d", kill_on_drop: false }`
[INFO] [stdout] e86ad5f34b447f248d906354c45ea6466a7609b0c55749b54466756f65538d0d