[INFO] fetching crate motosan-agent-workflow 0.6.2...
[INFO] testing motosan-agent-workflow-0.6.2 against master#562dee4820c458d823175268e41601d4c060588a for pr-154210-2
[INFO] extracting crate motosan-agent-workflow 0.6.2 into /workspace/builds/worker-7-tc1/source
[INFO] started tweaking crates.io crate motosan-agent-workflow 0.6.2
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate motosan-agent-workflow 0.6.2
[INFO] tweaked toml for crates.io crate motosan-agent-workflow 0.6.2 written to /workspace/builds/worker-7-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate motosan-agent-workflow 0.6.2 on toolchain 562dee4820c458d823175268e41601d4c060588a
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate motosan-agent-workflow 0.6.2 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" "+562dee4820c458d823175268e41601d4c060588a" "fetch" "--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]  Downloading crates ...
[INFO] [stderr]   Downloaded wasm-bindgen-shared v0.2.114
[INFO] [stderr]   Downloaded wasm-bindgen-macro v0.2.114
[INFO] [stderr]   Downloaded js-sys v0.3.91
[INFO] [stderr]   Downloaded futures-macro v0.3.32
[INFO] [stderr]   Downloaded ag-ui-core v0.1.0
[INFO] [stderr]   Downloaded uuid v1.22.0
[INFO] [stderr]   Downloaded futures-executor v0.3.32
[INFO] [stderr]   Downloaded futures v0.3.32
[INFO] [stderr]   Downloaded wasm-bindgen-macro-support v0.2.114
[INFO] [stderr]   Downloaded wasm-bindgen v0.2.114
[INFO] [stderr]   Downloaded tokio-macros v2.6.1
[INFO] [stderr]   Downloaded bitflags v2.11.0
[INFO] [stderr]   Downloaded libc v0.2.183
[INFO] [stderr]   Downloaded tokio v1.50.0
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-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" "+562dee4820c458d823175268e41601d4c060588a" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 8543a4e1445c35fa3a3fd83969962eff9407de4615933ac6ba9ef5831f286425
[INFO] running `Command { std: "docker" "start" "-a" "8543a4e1445c35fa3a3fd83969962eff9407de4615933ac6ba9ef5831f286425", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "8543a4e1445c35fa3a3fd83969962eff9407de4615933ac6ba9ef5831f286425", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "8543a4e1445c35fa3a3fd83969962eff9407de4615933ac6ba9ef5831f286425", kill_on_drop: false }`
[INFO] [stdout] 8543a4e1445c35fa3a3fd83969962eff9407de4615933ac6ba9ef5831f286425
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-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=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" "+562dee4820c458d823175268e41601d4c060588a" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] c7fa71417b62c2879127fc4fa3b20af554bc76a6bab3086f1feddf16bff2b4b6
[INFO] running `Command { std: "docker" "start" "-a" "c7fa71417b62c2879127fc4fa3b20af554bc76a6bab3086f1feddf16bff2b4b6", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v1.0.106
[INFO] [stderr]    Compiling quote v1.0.45
[INFO] [stderr]    Compiling unicode-ident v1.0.24
[INFO] [stderr]    Compiling libc v0.2.183
[INFO] [stderr]    Compiling serde_core v1.0.228
[INFO] [stderr]    Compiling pin-project-lite v0.2.17
[INFO] [stderr]    Compiling futures-sink v0.3.32
[INFO] [stderr]    Compiling memchr v2.8.0
[INFO] [stderr]    Compiling futures-core v0.3.32
[INFO] [stderr]    Compiling slab v0.4.12
[INFO] [stderr]    Compiling futures-task v0.3.32
[INFO] [stderr]    Compiling futures-io v0.3.32
[INFO] [stderr]    Compiling zmij v1.0.21
[INFO] [stderr]    Compiling getrandom v0.4.2
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling equivalent v1.0.2
[INFO] [stderr]    Compiling serde_json v1.0.149
[INFO] [stderr]    Compiling itoa v1.0.17
[INFO] [stderr]    Compiling hashbrown v0.16.1
[INFO] [stderr]    Compiling thiserror v2.0.18
[INFO] [stderr]    Compiling cfg-if v1.0.4
[INFO] [stderr]    Compiling ryu v1.0.23
[INFO] [stderr]    Compiling unsafe-libyaml v0.2.11
[INFO] [stderr]    Compiling bytes v1.11.1
[INFO] [stderr]    Compiling futures-channel v0.3.32
[INFO] [stderr]    Compiling indexmap v2.13.0
[INFO] [stderr]    Compiling syn v2.0.117
[INFO] [stderr]    Compiling errno v0.3.14
[INFO] [stderr]    Compiling mio v1.1.1
[INFO] [stderr]    Compiling signal-hook-registry v1.4.8
[INFO] [stderr]    Compiling uuid v1.22.0
[INFO] [stderr]    Compiling futures-macro v0.3.32
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling tokio-macros v2.6.1
[INFO] [stderr]    Compiling thiserror-impl v2.0.18
[INFO] [stderr]    Compiling async-trait v0.1.89
[INFO] [stderr]    Compiling futures-util v0.3.32
[INFO] [stderr]    Compiling tokio v1.50.0
[INFO] [stderr]    Compiling futures-executor v0.3.32
[INFO] [stderr]    Compiling serde_yaml v0.9.34+deprecated
[INFO] [stderr]    Compiling futures v0.3.32
[INFO] [stderr]    Compiling motosan-agent-workflow v0.6.2 (/opt/rustwide/workdir)
[INFO] [stdout] warning: unused import: `TransformConfig`
[INFO] [stdout]   --> src/runtime.rs:17:136
[INFO] [stdout]    |
[INFO] [stdout] 17 | ...e, HumanConfig, LoopConfig, NodeKind, SubWorkflowConfig, TransformConfig};
[INFO] [stdout]    |                                                             ^^^^^^^^^^^^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(unused_imports)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: method `execute_node` is never used
[INFO] [stdout]    --> src/runtime.rs:658:14
[INFO] [stdout]     |
[INFO] [stdout] 195 | impl Runtime {
[INFO] [stdout]     | ------------ method in this implementation
[INFO] [stdout] ...
[INFO] [stdout] 658 |     async fn execute_node(
[INFO] [stdout]     |              ^^^^^^^^^^^^
[INFO] [stdout]     |
[INFO] [stdout]     = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 25.18s
[INFO] running `Command { std: "docker" "inspect" "c7fa71417b62c2879127fc4fa3b20af554bc76a6bab3086f1feddf16bff2b4b6", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "c7fa71417b62c2879127fc4fa3b20af554bc76a6bab3086f1feddf16bff2b4b6", kill_on_drop: false }`
[INFO] [stdout] c7fa71417b62c2879127fc4fa3b20af554bc76a6bab3086f1feddf16bff2b4b6
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-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=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" "+562dee4820c458d823175268e41601d4c060588a" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] b0d4043f0b4f21fb1fd5fd452c0fddb880debd069be5d8f1efd5249813ed5914
[INFO] running `Command { std: "docker" "start" "-a" "b0d4043f0b4f21fb1fd5fd452c0fddb880debd069be5d8f1efd5249813ed5914", kill_on_drop: false }`
[INFO] [stderr]    Compiling parking_lot_core v0.9.12
[INFO] [stderr]    Compiling lock_api v0.4.14
[INFO] [stderr]    Compiling rustix v1.1.4
[INFO] [stderr]    Compiling socket2 v0.6.3
[INFO] [stderr]    Compiling bitflags v2.11.0
[INFO] [stderr]    Compiling linux-raw-sys v0.12.1
[INFO] [stderr]    Compiling fastrand v2.3.0
[INFO] [stderr]    Compiling once_cell v1.21.4
[INFO] [stderr]    Compiling parking_lot v0.12.5
[INFO] [stderr]    Compiling tokio v1.50.0
[INFO] [stderr]    Compiling tempfile v3.27.0
[INFO] [stderr]    Compiling motosan-agent-workflow v0.6.2 (/opt/rustwide/workdir)
[INFO] [stdout] warning: unused import: `TransformConfig`
[INFO] [stdout]   --> src/runtime.rs:17:136
[INFO] [stdout]    |
[INFO] [stdout] 17 | ...e, HumanConfig, LoopConfig, NodeKind, SubWorkflowConfig, TransformConfig};
[INFO] [stdout]    |                                                             ^^^^^^^^^^^^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(unused_imports)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused import: `TransformConfig`
[INFO] [stdout]   --> src/runtime.rs:17:136
[INFO] [stdout]    |
[INFO] [stdout] 17 | ...e, HumanConfig, LoopConfig, NodeKind, SubWorkflowConfig, TransformConfig};
[INFO] [stdout]    |                                                             ^^^^^^^^^^^^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(unused_imports)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: method `execute_node` is never used
[INFO] [stdout]    --> src/runtime.rs:658:14
[INFO] [stdout]     |
[INFO] [stdout] 195 | impl Runtime {
[INFO] [stdout]     | ------------ method in this implementation
[INFO] [stdout] ...
[INFO] [stdout] 658 |     async fn execute_node(
[INFO] [stdout]     |              ^^^^^^^^^^^^
[INFO] [stdout]     |
[INFO] [stdout]     = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: method `execute_node` is never used
[INFO] [stdout]    --> src/runtime.rs:658:14
[INFO] [stdout]     |
[INFO] [stdout] 195 | impl Runtime {
[INFO] [stdout]     | ------------ method in this implementation
[INFO] [stdout] ...
[INFO] [stdout] 658 |     async fn execute_node(
[INFO] [stdout]     |              ^^^^^^^^^^^^
[INFO] [stdout]     |
[INFO] [stdout]     = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 19.44s
[INFO] running `Command { std: "docker" "inspect" "b0d4043f0b4f21fb1fd5fd452c0fddb880debd069be5d8f1efd5249813ed5914", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "b0d4043f0b4f21fb1fd5fd452c0fddb880debd069be5d8f1efd5249813ed5914", kill_on_drop: false }`
[INFO] [stdout] b0d4043f0b4f21fb1fd5fd452c0fddb880debd069be5d8f1efd5249813ed5914
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-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=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" "+562dee4820c458d823175268e41601d4c060588a" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] ec8f253e41d59edf27b64f3a47f37c8ebf99f3d20880eba2d663e5debacf331f
[INFO] running `Command { std: "docker" "start" "-a" "ec8f253e41d59edf27b64f3a47f37c8ebf99f3d20880eba2d663e5debacf331f", kill_on_drop: false }`
[INFO] [stderr] warning: unused import: `TransformConfig`
[INFO] [stderr]   --> src/runtime.rs:17:136
[INFO] [stderr]    |
[INFO] [stderr] 17 | ...e, HumanConfig, LoopConfig, NodeKind, SubWorkflowConfig, TransformConfig};
[INFO] [stderr]    |                                                             ^^^^^^^^^^^^^^^
[INFO] [stderr]    |
[INFO] [stderr]    = note: `#[warn(unused_imports)]` (part of `#[warn(unused)]`) on by default
[INFO] [stderr] 
[INFO] [stderr] warning: method `execute_node` is never used
[INFO] [stderr]    --> src/runtime.rs:658:14
[INFO] [stderr]     |
[INFO] [stderr] 195 | impl Runtime {
[INFO] [stderr]     | ------------ method in this implementation
[INFO] [stderr] ...
[INFO] [stderr] 658 |     async fn execute_node(
[INFO] [stderr]     |              ^^^^^^^^^^^^
[INFO] [stderr]     |
[INFO] [stderr]     = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stderr] 
[INFO] [stderr] warning: `motosan-agent-workflow` (lib) generated 2 warnings (run `cargo fix --lib -p motosan-agent-workflow` to apply 1 suggestion)
[INFO] [stderr] warning: `motosan-agent-workflow` (lib test) generated 2 warnings (2 duplicates)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.21s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/motosan_agent_workflow-2ac4e63858456554)
[INFO] [stdout] 
[INFO] [stdout] running 14 tests
[INFO] [stdout] test schema::tests::test_integer_rejects_fractional_float ... ok
[INFO] [stdout] test schema::tests::test_array_items_validation ... ok
[INFO] [stdout] test schema::tests::test_integer_accepts_whole_float ... ok
[INFO] [stdout] test schema::tests::test_invalid_type ... ok
[INFO] [stdout] test schema::tests::test_no_schema_means_valid ... ok
[INFO] [stdout] test schema::tests::test_nested_object_validation ... ok
[INFO] [stdout] test schema::tests::test_valid_simple_type ... ok
[INFO] [stdout] test schema::tests::test_missing_required_field ... ok
[INFO] [stdout] test schema::tests::test_wrong_property_type ... ok
[INFO] [stdout] test state::tests::test_find_changed_fields_added_and_removed ... ok
[INFO] [stdout] test state::tests::test_find_changed_fields_value_changed ... ok
[INFO] [stdout] test state::tests::test_find_changed_fields_no_change ... ok
[INFO] [stdout] test state::tests::test_sanitize_key ... ok
[INFO] [stdout] test schema::tests::test_valid_object_with_required ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 14 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/test_condition.rs (/opt/rustwide/target/debug/deps/test_condition-b58046b5b158aa32)
[INFO] [stdout] 
[INFO] [stdout] running 6 tests
[INFO] [stdout] test test_condition_no_match_errors ... ok
[INFO] [stdout] test test_condition_eq_operator ... ok
[INFO] [stdout] test test_condition_routes_to_first_matching_branch ... ok
[INFO] [stdout] test test_condition_routes_to_second_branch ... ok
[INFO] [stdout] test test_condition_default_goto ... ok
[INFO] [stdout] test test_condition_emits_events ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/test_context.rs (/opt/rustwide/target/debug/deps/test_context-cd0d22c7f43e1fdd)
[INFO] [stdout] 
[INFO] [stdout] running 7 tests
[INFO] [stdout] test test_context_assemble_input_missing_upstream ... ok
[INFO] [stdout] test test_context_all_outputs ... ok
[INFO] [stdout] test test_context_input ... ok
[INFO] [stdout] test test_context_node_outputs ... ok
[INFO] [stdout] test test_context_assemble_input_with_upstream ... ok
[INFO] [stdout] test test_context_assemble_input_no_upstream ... ok
[INFO] [stderr]      Running tests/test_cost.rs (/opt/rustwide/target/debug/deps/test_cost-34e2019bccf955d5)
[INFO] [stdout] test test_context_shared_state ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 13 tests
[INFO] [stdout] test test_budget_event_emitted ... ok
[INFO] [stdout] test test_estimate_cost_simple_workflow ... ok
[INFO] [stdout] test test_input_output_split_in_workflow_result ... ok
[INFO] [stdout] test test_no_budget_set_workflow_runs_without_limit ... ok
[INFO] [stdout] test test_llm_call_records_tracked_per_node ... ok
[INFO] [stdout] test test_estimate_cost_non_llm_nodes_are_zero ... ok
[INFO] [stdout] test test_node_completed_event_has_input_output_tokens ... ok
[INFO] [stdout] test test_no_pricing_cost_is_zero ... ok
[INFO] [stdout] test test_token_budget_exceeded_aborts ... ok
[INFO] [stdout] test test_token_budget_not_exceeded_workflow_completes ... ok
[INFO] [stdout] test test_per_node_token_tracking_in_result ... ok
[INFO] [stdout] test test_with_model_pricing_calculates_cost ... ok
[INFO] [stdout] test test_node_llm_call_event_emitted ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 13 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/test_dag.rs (/opt/rustwide/target/debug/deps/test_dag-5374b907d751b1d3)
[INFO] [stdout] 
[INFO] [stdout] running 9 tests
[INFO] [stdout] test test_cycle_detection ... ok
[INFO] [stdout] test test_parallel_layers_linear ... ok
[INFO] [stdout] test test_single_node_workflow ... ok
[INFO] [stdout] test test_duplicate_node_rejected ... ok
[INFO] [stdout] test test_empty_workflow_rejected ... ok
[INFO] [stdout] test test_parallel_layers_diamond ... ok
[INFO] [stdout] test test_topological_sort_diamond ... ok
[INFO] [stdout] test test_topological_sort_linear ... ok
[INFO] [stdout] test test_unknown_edge_node_rejected ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 9 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.05s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 9 tests
[INFO] [stdout] test test_enriched_event_sequence ... ok
[INFO] [stdout] test test_node_completed_includes_duration_and_tokens ... ok
[INFO] [stdout] test test_node_input_resolved_emitted_for_agent ... ok
[INFO] [stdout] test test_node_input_resolved_contains_upstream_output ... ok
[INFO] [stdout] test test_node_failed_includes_will_retry ... ok
[INFO] [stdout] test test_node_started_includes_layer ... ok
[INFO] [stdout] test test_workflow_completed_includes_duration_and_total_tokens ... ok
[INFO] [stdout] test test_workflow_started_includes_node_count ... ok
[INFO] [stdout] test test_workflow_failed_event_emitted ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 9 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/test_events.rs (/opt/rustwide/target/debug/deps/test_events-9a5161686fd8e5cb)
[INFO] [stderr]      Running tests/test_execution.rs (/opt/rustwide/target/debug/deps/test_execution-785adbc4d4397c74)
[INFO] [stdout] 
[INFO] [stdout] running 9 tests
[INFO] [stdout] test execution_filter_default_values ... ok
[INFO] [stdout] test enum_serialization_uses_snake_case ... ok
[INFO] [stdout] test execution_filter_json_roundtrip ... ok
[INFO] [stdout] test execution_record_failed_roundtrip ... ok
[INFO] [stdout] test execution_stats_json_roundtrip ... ok
[INFO] [stdout] test execution_record_json_roundtrip ... ok
[INFO] [stdout] test node_record_json_roundtrip ... ok
[INFO] [stdout] test tool_call_record_json_roundtrip ... ok
[INFO] [stdout] test node_record_skipped_no_output ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 9 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/test_execution_store.rs (/opt/rustwide/target/debug/deps/test_execution_store-d69477cfd2900d19)
[INFO] [stdout] 
[INFO] [stdout] running 9 tests
[INFO] [stdout] test get_non_existent_returns_none ... ok
[INFO] [stdout] test list_with_workflow_id_filter ... ok
[INFO] [stdout] test stats_empty_store ... ok
[INFO] [stdout] test save_and_get_round_trip ... ok
[INFO] [stdout] test list_with_status_filter ... ok
[INFO] [stdout] test list_no_filter ... ok
[INFO] [stdout] test prune_old_records ... ok
[INFO] [stdout] test list_with_limit_and_offset ... ok
[INFO] [stdout] test stats_computation ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 9 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/test_loader.rs (/opt/rustwide/target/debug/deps/test_loader-099278413476c9dc)
[INFO] [stdout] 
[INFO] [stdout] running 28 tests
[INFO] [stdout] test test_builder_single_skill ... ok
[INFO] [stdout] test test_builder_skill_called_twice_pushes ... ok
[INFO] [stdout] test test_all_condition_ops ... ok
[INFO] [stdout] test test_builder_skills_sets_vec ... ok
[INFO] [stdout] test test_condition_node_yaml ... ok
[INFO] [stdout] test test_empty_workflow_error ... ok
[INFO] [stdout] test test_cycle_in_yaml_detected ... ok
[INFO] [stdout] test test_human_node_yaml ... ok
[INFO] [stdout] test test_load_from_json_file ... ok
[INFO] [stdout] test test_load_json_basic ... ok
[INFO] [stdout] test test_load_unsupported_extension ... ok
[INFO] [stdout] test test_load_yaml_basic ... ok
[INFO] [stdout] test test_load_from_yaml_file ... ok
[INFO] [stdout] test test_load_from_yml_extension ... ok
[INFO] [stdout] test test_loop_node_yaml ... ok
[INFO] [stdout] test test_malformed_json_gives_clear_error ... ok
[INFO] [stdout] test test_malformed_yaml_gives_clear_error ... ok
[INFO] [stdout] test test_node_missing_type ... ok
[INFO] [stdout] test test_retry_policy_abort_default ... ok
[INFO] [stdout] test test_unknown_edge_node ... ok
[INFO] [stdout] test test_retry_policy_yaml ... ok
[INFO] [stdout] test test_yaml_no_skill_defaults_to_empty ... ok
[INFO] [stdout] test test_yaml_skill_singular_backward_compat ... ok
[INFO] [stdout] test test_yaml_skills_plural ... ok
[INFO] [stdout] test test_retry_policy_fallback ... ok
[INFO] [stdout] test test_unknown_condition_op ... ok
[INFO] [stdout] test test_yaml_skill_and_skills_merged ... ok
[INFO] [stdout] test test_yaml_skill_and_skills_no_duplicate ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 28 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/test_loop.rs (/opt/rustwide/target/debug/deps/test_loop-b3741ec8dd704c35)
[INFO] [stdout] 
[INFO] [stdout] running 11 tests
[INFO] [stdout] test test_loop_context_not_leaked_to_downstream ... ok
[INFO] [stdout] test test_loop_body_receives_loop_context ... ok
[INFO] [stdout] test test_loop_context_with_multiple_body_nodes ... ok
[INFO] [stdout] test test_loop_emits_events ... ok
[INFO] [stdout] test test_loop_max_iterations_error ... ok
[INFO] [stdout] test test_loop_runs_until_condition_met ... ok
[INFO] [stdout] test test_loop_no_until_runs_max_iterations ... ok
[INFO] [stdout] test test_loop_followed_by_downstream_node ... ok
[INFO] [stdout] test test_loop_output_includes_history ... ok
[INFO] [stdout] test test_loop_single_iteration_condition_met ... ok
[INFO] [stdout] test test_loop_with_multiple_body_nodes ... ok
[INFO] [stderr]      Running tests/test_node_ref.rs (/opt/rustwide/target/debug/deps/test_node_ref-41839da8f0ebc147)
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 11 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 10 tests
[INFO] [stdout] test test_ref_in_from_str_errors ... ok
[INFO] [stdout] test test_mixed_inline_and_ref_nodes ... ok
[INFO] [stdout] test test_ref_missing_file_error ... ok
[INFO] [stdout] test test_ref_loads_external_node_file ... ok
[INFO] [stdout] test test_ref_human_node ... ok
[INFO] [stdout] test test_ref_path_resolution_with_custom_base_dir ... ok
[INFO] [stdout] test test_ref_id_comes_from_workflow ... ok
[INFO] [stdout] test test_ref_preserves_retry_policy ... ok
[INFO] [stdout] test test_ref_with_system_prompt_append ... ok
[INFO] [stdout] test test_ref_with_skills_override ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 10 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/test_observer.rs (/opt/rustwide/target/debug/deps/test_observer-ebdf3546a83a4d71)
[INFO] [stdout] 
[INFO] [stdout] running 6 tests
[INFO] [stdout] test test_observer_multi_node_token_aggregation ... ok
[INFO] [stdout] test test_observer_basic_workflow ... ok
[INFO] [stdout] test test_observer_retry_tracking ... ok
[INFO] [stdout] test test_observer_node_llm_call_tracking ... ok
[INFO] [stdout] test test_observer_node_input_captured ... ok
[INFO] [stdout] test test_observer_failed_workflow ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/test_prompt_assembly.rs (/opt/rustwide/target/debug/deps/test_prompt_assembly-7e46c9d7ef8c07b2)
[INFO] [stdout] 
[INFO] [stdout] running 6 tests
[INFO] [stdout] test test_no_resolver_prompt_unchanged ... ok
[INFO] [stderr]      Running tests/test_resume.rs (/opt/rustwide/target/debug/deps/test_resume-b7370e63f80977c9)
[INFO] [stdout] test test_all_three_types_correct_ordering ... ok
[INFO] [stdout] test test_skills_with_no_resolver_backward_compat ... ok
[INFO] [stdout] test test_output_format_schema_overrides_node_schema ... ok
[INFO] [stdout] test test_unknown_skill_name_propagates_error ... ok
[INFO] [stdout] test test_knowledge_skill_injected_after_prompt ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 10 tests
[INFO] [stdout] test test_resume_token_decode_invalid_base64 ... ok
[INFO] [stdout] test test_resume_token_decode_invalid_json ... ok
[INFO] [stdout] test test_resume_token_expired ... ok
[INFO] [stdout] test test_resume_token_not_expired_no_ttl ... ok
[INFO] [stdout] test test_resume_token_encode_decode ... ok
[INFO] [stdout] test test_resume_token_not_expired_future ... ok
[INFO] [stdout] test test_resume_with_expired_token_fails ... ok
[INFO] [stdout] test test_workflow_with_provider_completes_normally ... ok
[INFO] [stdout] test test_workflow_pauses_at_human_node ... ok
[INFO] [stdout] test test_resume_workflow_continues ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 10 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/test_retry.rs (/opt/rustwide/target/debug/deps/test_retry-5c3eeaf6adc4531f)
[INFO] [stdout] 
[INFO] [stdout] running 11 tests
[INFO] [stdout] test test_no_retry_policy_preserves_original_behavior ... ok
[INFO] [stdout] test test_retry_policy_default_values ... ok
[INFO] [stdout] test test_node_succeeds_first_try_no_retry_needed ... ok
[INFO] [stdout] test test_failure_mode_abort_stops_workflow ... ok
[INFO] [stdout] test test_failure_mode_skip_continues_workflow ... ok
[INFO] [stdout] test test_failure_mode_fallback_uses_fallback_content ... ok
[INFO] [stdout] test test_transform_node_retry_exhausted_aborts ... ok
[INFO] [stdout] test test_transform_node_retries_on_failure ... ok
[INFO] [stdout] test test_node_fails_then_succeeds_on_retry ... ok
[INFO] [stdout] test test_max_retries_exhausted_emits_events ... ok
[INFO] [stdout] test test_exponential_backoff_timing ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 11 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.16s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/test_runtime.rs (/opt/rustwide/target/debug/deps/test_runtime-24b5fe269557c65c)
[INFO] [stdout] 
[INFO] [stdout] running 16 tests
[INFO] [stdout] test test_human_node_no_provider_pauses ... ok
[INFO] [stdout] test test_human_node_reject ... ok
[INFO] [stdout] test test_human_node_emits_waiting_event ... ok
[INFO] [stdout] test test_human_node_approve ... ok
[INFO] [stdout] test test_human_node_with_edit_response ... ok
[INFO] [stdout] test test_linear_workflow_execution ... ok
[INFO] [stdout] test test_mixed_agent_and_human_workflow ... ok
[INFO] [stdout] test test_input_from_single_string ... ok
[INFO] [stdout] test test_llm_failure_propagates ... ok
[INFO] [stdout] test test_single_node_workflow ... ok
[INFO] [stdout] test test_input_from_array_and_single_string_coexist ... ok
[INFO] [stdout] test test_workflow_events ... ok
[INFO] [stdout] test test_parallel_workflow_execution ... ok
[INFO] [stdout] test test_human_node_timeout_auto_reject ... ok
[INFO] [stdout] test test_human_node_default_timeout_action_is_approve ... ok
[INFO] [stdout] test test_human_node_timeout_auto_approve ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 16 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/test_schema.rs (/opt/rustwide/target/debug/deps/test_schema-dba56d1a26d63043)
[INFO] [stdout] 
[INFO] [stdout] running 11 tests
[INFO] [stdout] test test_validate_array_of_objects ... ok
[INFO] [stdout] test test_schema_validation_emits_events ... ok
[INFO] [stdout] test test_no_schema_skips_validation ... ok
[INFO] [stdout] test test_invalid_output_fails_after_retries ... ok
[INFO] [stdout] test test_self_correction_on_first_retry ... ok
[INFO] [stdout] test test_self_correction_on_second_retry ... ok
[INFO] [stdout] test test_schema_validation_in_multi_node_workflow ... ok
[INFO] [stdout] test test_valid_output_passes_schema ... ok
[INFO] [stdout] test test_validate_boolean_type ... ok
[INFO] [stdout] test test_validate_number_type ... ok
[INFO] [stdout] test test_validate_null_type ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 11 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/test_skill.rs (/opt/rustwide/target/debug/deps/test_skill-e489318496b7f3cc)
[INFO] [stdout] 
[INFO] [stdout] running 9 tests
[INFO] [stdout] test error_on_missing_name ... ok
[INFO] [stdout] test error_on_invalid_frontmatter ... ok
[INFO] [stdout] test error_on_missing_type ... ok
[INFO] [stdout] test error_on_unclosed_frontmatter ... ok
[INFO] [stdout] test error_on_no_frontmatter ... ok
[INFO] [stdout] test parse_minimal_skill ... ok
[INFO] [stdout] test parse_without_optional_fields ... ok
[INFO] [stdout] test parse_with_extends_and_compose ... ok
[INFO] [stdout] test parse_with_schema ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 9 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/test_skill_resolver.rs (/opt/rustwide/target/debug/deps/test_skill_resolver-872a91d94c642a3e)
[INFO] [stdout] 
[INFO] [stdout] running 13 tests
[INFO] [stdout] test detect_circular_dependency ... ok
[INFO] [stdout] test error_with_no_providers ... ok
[INFO] [stdout] test filesystem_provider_not_found ... ok
[INFO] [stdout] test filesystem_provider_flat_file ... ok
[INFO] [stdout] test resolve_all_fails_on_missing ... ok
[INFO] [stdout] test filesystem_provider_directory_layout ... ok
[INFO] [stdout] test resolve_simple_skill ... ok
[INFO] [stdout] test resolve_all_skills ... ok
[INFO] [stdout] test resolve_with_compose_full_content ... ok
[INFO] [stdout] test filesystem_resolve_with_extends ... ok
[INFO] [stdout] test resolve_with_compose_pick ... ok
[INFO] [stdout] test provider_fallback_order ... ok
[INFO] [stdout] test resolve_with_extends ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 13 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/test_state.rs (/opt/rustwide/target/debug/deps/test_state-2fc1c9a637bdf198)
[INFO] [stdout] 
[INFO] [stdout] running 8 tests
[INFO] [stdout] test test_context_diff_state_no_store_errors ... ok
[INFO] [stdout] test test_context_diff_state_with_store ... ok
[INFO] [stdout] test test_diff_and_store_persists ... ok
[INFO] [stdout] test test_diff_first_run ... ok
[INFO] [stdout] test test_file_state_store_sanitizes_keys ... ok
[INFO] [stdout] test test_diff_field_changes ... ok
[INFO] [stdout] test test_diff_no_change ... ok
[INFO] [stdout] test test_file_state_store_read_write ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 8 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/test_sub_workflow.rs (/opt/rustwide/target/debug/deps/test_sub_workflow-f994ebb06ce6a0c0)
[INFO] [stdout] 
[INFO] [stdout] running 5 tests
[INFO] [stdout] test test_sub_workflow_emits_events ... ok
[INFO] [stdout] test test_sub_workflow_nested_two_levels ... ok
[INFO] [stdout] test test_sub_workflow_passes_parent_input ... ok
[INFO] [stdout] test test_sub_workflow_basic ... ok
[INFO] [stdout] test test_sub_workflow_in_parallel ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/test_templates.rs (/opt/rustwide/target/debug/deps/test_templates-42788d510c68dc97)
[INFO] [stdout] 
[INFO] [stdout] running 13 tests
[INFO] [stdout] test builtin_workflow_nonexistent_returns_none ... ok
[INFO] [stdout] test code_review_template_has_expected_agents ... ok
[INFO] [stdout] test architecture_review_has_parallel_reviewers ... ok
[INFO] [stdout] test research_template_has_expected_agents ... ok
[INFO] [stdout] test playlist_template_has_parallel_layer ... ok
[INFO] [stdout] test sprint_planning_has_parallel_reviewers ... ok
[INFO] [stdout] test builtin_workflow_by_name_returns_correct_one ... ok
[INFO] [stdout] test each_template_has_edges ... ok
[INFO] [stdout] test each_template_has_unique_name ... ok
[INFO] [stdout] test each_template_passes_dag_validation ... ok
[INFO] [stdout] test builtin_workflows_returns_all_eight ... ok
[INFO] [stdout] test each_template_has_at_least_two_nodes ... ok
[INFO] [stdout] test each_template_has_description ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 13 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/test_transform.rs (/opt/rustwide/target/debug/deps/test_transform-f4cac9219ded92a8)
[INFO] [stdout] 
[INFO] [stdout] running 8 tests
[INFO] [stdout] test test_transform_node_error_propagates ... ok
[INFO] [stdout] test test_transform_node_basic ... ok
[INFO] [stdout] test test_transform_node_filter_pattern ... ok
[INFO] [stdout] test test_transform_node_emits_events ... ok
[INFO] [stdout] test test_transform_node_output_used_by_downstream ... ok
[INFO] [stdout] test test_transform_node_in_parallel_layer ... ok
[INFO] [stdout] test test_transform_node_multiple_inputs ... ok
[INFO] [stdout] test test_transform_node_receives_upstream_outputs ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 8 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests motosan_agent_workflow
[INFO] [stdout] 
[INFO] [stdout] running 3 tests
[INFO] [stdout] test src/node.rs - node::IntoInputIds (line 11) ... ignored
[INFO] [stdout] test src/node.rs - node::NodeBuilder::async_transform_fn (line 673) ... ignored
[INFO] [stdout] test src/lib.rs - (line 7) - compile ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 2 ignored; 0 measured; 0 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "ec8f253e41d59edf27b64f3a47f37c8ebf99f3d20880eba2d663e5debacf331f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "ec8f253e41d59edf27b64f3a47f37c8ebf99f3d20880eba2d663e5debacf331f", kill_on_drop: false }`
[INFO] [stdout] ec8f253e41d59edf27b64f3a47f37c8ebf99f3d20880eba2d663e5debacf331f