[INFO] fetching crate tianshu-observe 0.1.0...
[INFO] testing tianshu-observe-0.1.0 against 1.95.0 for beta-1.96-2
[INFO] extracting crate tianshu-observe 0.1.0 into /workspace/builds/worker-0-tc1/source
[INFO] started tweaking crates.io crate tianshu-observe 0.1.0
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate tianshu-observe 0.1.0
[INFO] tweaked toml for crates.io crate tianshu-observe 0.1.0 written to /workspace/builds/worker-0-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate tianshu-observe 0.1.0 on toolchain 1.95.0
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.95.0" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate tianshu-observe 0.1.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" "+1.95.0" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded tianshu v0.1.0
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+1.95.0" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 92473de2b388fff0a716031cb0975f5bd6c11fcd5d907295cea910bdad10bba3
[INFO] running `Command { std: "docker" "start" "-a" "92473de2b388fff0a716031cb0975f5bd6c11fcd5d907295cea910bdad10bba3", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "92473de2b388fff0a716031cb0975f5bd6c11fcd5d907295cea910bdad10bba3", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "92473de2b388fff0a716031cb0975f5bd6c11fcd5d907295cea910bdad10bba3", kill_on_drop: false }`
[INFO] [stdout] 92473de2b388fff0a716031cb0975f5bd6c11fcd5d907295cea910bdad10bba3
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+1.95.0" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 37fb54464ce43db6d3f520da4be26164c49655dc170ee26c7dac25b031d6cf32
[INFO] running `Command { std: "docker" "start" "-a" "37fb54464ce43db6d3f520da4be26164c49655dc170ee26c7dac25b031d6cf32", kill_on_drop: false }`
[INFO] [stderr]    Compiling num-traits v0.2.19
[INFO] [stderr]    Compiling syn v2.0.117
[INFO] [stderr]    Compiling getrandom v0.2.17
[INFO] [stderr]    Compiling socket2 v0.6.3
[INFO] [stderr]    Compiling serde_json v1.0.149
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling tokio-macros v2.6.1
[INFO] [stderr]    Compiling tracing-attributes v0.1.31
[INFO] [stderr]    Compiling async-trait v0.1.89
[INFO] [stderr]    Compiling tokio v1.50.0
[INFO] [stderr]    Compiling tracing v0.1.44
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling uuid v1.10.0
[INFO] [stderr]    Compiling chrono v0.4.44
[INFO] [stderr]    Compiling tianshu v0.1.0
[INFO] [stderr]    Compiling tianshu-observe v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 20.14s
[INFO] running `Command { std: "docker" "inspect" "37fb54464ce43db6d3f520da4be26164c49655dc170ee26c7dac25b031d6cf32", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "37fb54464ce43db6d3f520da4be26164c49655dc170ee26c7dac25b031d6cf32", kill_on_drop: false }`
[INFO] [stdout] 37fb54464ce43db6d3f520da4be26164c49655dc170ee26c7dac25b031d6cf32
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+1.95.0" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 7b3bad86ac1f93c2f0bfd30a4ae21b138577fb13c3f88f7bb471199e9ad42756
[INFO] running `Command { std: "docker" "start" "-a" "7b3bad86ac1f93c2f0bfd30a4ae21b138577fb13c3f88f7bb471199e9ad42756", kill_on_drop: false }`
[INFO] [stderr]    Compiling getrandom v0.3.4
[INFO] [stderr]    Compiling rustix v1.1.4
[INFO] [stderr]    Compiling tempfile v3.26.0
[INFO] [stderr]    Compiling tianshu-observe v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 4.98s
[INFO] running `Command { std: "docker" "inspect" "7b3bad86ac1f93c2f0bfd30a4ae21b138577fb13c3f88f7bb471199e9ad42756", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "7b3bad86ac1f93c2f0bfd30a4ae21b138577fb13c3f88f7bb471199e9ad42756", kill_on_drop: false }`
[INFO] [stdout] 7b3bad86ac1f93c2f0bfd30a4ae21b138577fb13c3f88f7bb471199e9ad42756
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+1.95.0" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 0cbbd01dd3a5eadbe679273bcb99f1586e3e8bff98ab766c9de3677803af613a
[INFO] running `Command { std: "docker" "start" "-a" "0cbbd01dd3a5eadbe679273bcb99f1586e3e8bff98ab766c9de3677803af613a", 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/tianshu_observe-057883403e7abc75)
[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] [stderr]      Running tests/composite_tests.rs (/opt/rustwide/target/debug/deps/composite_tests-62edcbdb0ec60f5b)
[INFO] [stdout] 
[INFO] [stdout] running 6 tests
[INFO] [stdout] test empty_composite_is_valid ... ok
[INFO] [stdout] test fans_out_llm_call ... ok
[INFO] [stdout] test flush_calls_all_children ... ok
[INFO] [stdout] test usable_as_arc_dyn_observer ... ok
[INFO] [stdout] test fans_out_step_to_all_children ... ok
[INFO] [stdout] test fans_out_workflow_complete ... 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/dataset_tests.rs (/opt/rustwide/target/debug/deps/dataset_tests-cf2b7556aced1a8f)
[INFO] [stdout] 
[INFO] [stdout] running 9 tests
[INFO] [stdout] test step_dataset_only_includes_non_cached ... ok
[INFO] [stdout] test step_dataset_skips_error_steps ... ok
[INFO] [stdout] test step_dataset_entry_has_input_output ... ok
[INFO] [stdout] test llm_dataset_skips_error_calls ... ok
[INFO] [stdout] test llm_dataset_has_request_response ... ok
[INFO] [stdout] test workflow_dataset_entry_has_input_output ... ok
[INFO] [stdout] test workflow_dataset_metadata_contains_workflow_code ... ok
[INFO] [stdout] test workflow_dataset_skips_null_input_or_output ... ok
[INFO] [stdout] test llm_dataset_metadata_contains_model ... 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/jsonl_tests.rs (/opt/rustwide/target/debug/deps/jsonl_tests-f06543a14c616b02)
[INFO] [stdout] 
[INFO] [stdout] running 6 tests
[INFO] [stdout] test writes_llm_call_as_jsonl_line ... ok
[INFO] [stdout] test multiple_events_each_on_own_line ... ok
[INFO] [stdout] test creates_file_if_not_exists ... ok
[INFO] [stdout] test usable_as_arc_dyn_observer ... ok
[INFO] [stdout] test writes_step_as_jsonl_line ... ok
[INFO] [stdout] test writes_workflow_complete_as_jsonl_line ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.04s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/memory_tests.rs (/opt/rustwide/target/debug/deps/memory_tests-c1977967e33f749f)
[INFO] [stdout] 
[INFO] [stdout] running 6 tests
[INFO] [stdout] test clear_resets_all_records ... ok
[INFO] [stdout] test collects_step_records ... ok
[INFO] [stdout] test collects_workflow_records ... ok
[INFO] [stdout] test step_records_for_case_filters_by_key ... ok
[INFO] [stdout] test collects_llm_records ... ok
[INFO] [stdout] test works_as_arc_dyn_observer ... 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]    Doc-tests tianshu_observe
[INFO] [stdout] 
[INFO] [stdout] running 4 tests
[INFO] [stdout] test src/composite.rs - composite::CompositeObserver (line 13) ... ignored
[INFO] [stdout] test src/jsonl.rs - jsonl::JsonlObserver (line 29) ... ignored
[INFO] [stdout] test src/lib.rs - (line 23) ... ignored
[INFO] [stdout] test src/memory.rs - memory::InMemoryObserver (line 16) ... ignored
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 4 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "0cbbd01dd3a5eadbe679273bcb99f1586e3e8bff98ab766c9de3677803af613a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "0cbbd01dd3a5eadbe679273bcb99f1586e3e8bff98ab766c9de3677803af613a", kill_on_drop: false }`
[INFO] [stdout] 0cbbd01dd3a5eadbe679273bcb99f1586e3e8bff98ab766c9de3677803af613a
