[INFO] fetching crate synonz 0.7.0...
[INFO] testing synonz-0.7.0 against 1.100.0-beta.1 for beta-1.100-2
[INFO] extracting crate synonz 0.7.0 into /workspace/builds/worker-3-tc2/source
[INFO] started tweaking crates.io crate synonz 0.7.0
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate synonz 0.7.0
[INFO] tweaked toml for crates.io crate synonz 0.7.0 written to /workspace/builds/worker-3-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate synonz 0.7.0 on toolchain 1.100.0-beta.1
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.100.0-beta.1" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate synonz 0.7.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.100.0-beta.1" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,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" "-m" "1610612736" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:3111399a4047eeb3a02b7a90e478d715f38a8c6669b5c4b49d30a17385265909" "sleep" "infinity", kill_on_drop: false }`
[INFO] [stdout] 7e2d94c97fcb3c0436d9a70f7d7c04db72044f79ae660ba50181cdd5037a3db8
[INFO] running `Command { std: "docker" "start" "7e2d94c97fcb3c0436d9a70f7d7c04db72044f79ae660ba50181cdd5037a3db8", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "7e2d94c97fcb3c0436d9a70f7d7c04db72044f79ae660ba50181cdd5037a3db8", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-w" "/opt/rustwide/workdir" "--user" "0:0" "7e2d94c97fcb3c0436d9a70f7d7c04db72044f79ae660ba50181cdd5037a3db8" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "7e2d94c97fcb3c0436d9a70f7d7c04db72044f79ae660ba50181cdd5037a3db8", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-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" "-w" "/opt/rustwide/workdir" "--user" "0:0" "7e2d94c97fcb3c0436d9a70f7d7c04db72044f79ae660ba50181cdd5037a3db8" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling futures-channel v0.3.34
[INFO] [stderr]    Compiling libc v0.2.189
[INFO] [stderr]    Compiling serde_json v1.0.151
[INFO] [stderr]    Compiling syn v3.0.4
[INFO] [stderr]    Compiling syn v2.0.119
[INFO] [stderr]    Compiling getrandom v0.4.3
[INFO] [stderr]    Compiling uuid v1.26.0
[INFO] [stderr]    Compiling synonz-derive v0.7.0
[INFO] [stderr]    Compiling serde_derive_internals v0.30.0
[INFO] [stderr]    Compiling futures-macro v0.3.34
[INFO] [stderr]    Compiling ref-cast-impl v1.0.27
[INFO] [stderr]    Compiling tokio-macros v2.7.2
[INFO] [stderr]    Compiling serde_derive v1.0.229
[INFO] [stderr]    Compiling thiserror-impl v2.0.20
[INFO] [stderr]    Compiling schemars_derive v1.2.2
[INFO] [stderr]    Compiling tokio v1.53.1
[INFO] [stderr]    Compiling ref-cast v1.0.27
[INFO] [stderr]    Compiling futures-util v0.3.34
[INFO] [stderr]    Compiling thiserror v2.0.20
[INFO] [stderr]    Compiling serde v1.0.229
[INFO] [stderr]    Compiling tokio-util v0.7.19
[INFO] [stderr]    Compiling schemars v1.2.2
[INFO] [stderr]    Compiling futures-executor v0.3.34
[INFO] [stderr]    Compiling futures v0.3.34
[INFO] [stderr]    Compiling synonz v0.7.0 (/opt/rustwide/workdir)
[INFO] [stderr] warning: unused dependency `uuid`
[INFO] [stderr]   --> Cargo.toml:28:15
[INFO] [stderr]    |
[INFO] [stderr] 28 | [dependencies.uuid]
[INFO] [stderr]    |               ^^^^^
[INFO] [stderr]    |
[INFO] [stderr]    = note: `cargo::unused_dependencies` is set to `warn` by default
[INFO] [stderr] help: consider removing the dependency on `uuid`
[INFO] [stderr] warning: `synonz` (manifest) generated 1 warning
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 32.57s
[INFO] running `Command { std: "docker" "inspect" "7e2d94c97fcb3c0436d9a70f7d7c04db72044f79ae660ba50181cdd5037a3db8", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-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" "-w" "/opt/rustwide/workdir" "--user" "0:0" "7e2d94c97fcb3c0436d9a70f7d7c04db72044f79ae660ba50181cdd5037a3db8" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling tokio v1.53.1
[INFO] [stderr]    Compiling tokio-util v0.7.19
[INFO] [stderr]    Compiling synonz v0.7.0 (/opt/rustwide/workdir)
[INFO] [stderr] warning: unused dependency `uuid`
[INFO] [stderr]   --> Cargo.toml:28:15
[INFO] [stderr]    |
[INFO] [stderr] 28 | [dependencies.uuid]
[INFO] [stderr]    |               ^^^^^
[INFO] [stderr]    |
[INFO] [stderr]    = note: `cargo::unused_dependencies` is set to `warn` by default
[INFO] [stderr] help: consider removing the dependency on `uuid`
[INFO] [stderr] warning: `synonz` (manifest) generated 1 warning
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 16.88s
[INFO] running `Command { std: "docker" "inspect" "7e2d94c97fcb3c0436d9a70f7d7c04db72044f79ae660ba50181cdd5037a3db8", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-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" "-w" "/opt/rustwide/workdir" "--user" "0:0" "7e2d94c97fcb3c0436d9a70f7d7c04db72044f79ae660ba50181cdd5037a3db8" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "test" "--frozen", kill_on_drop: false }`
[INFO] [stderr] warning: unused dependency `uuid`
[INFO] [stderr]   --> Cargo.toml:28:15
[INFO] [stderr]    |
[INFO] [stderr] 28 | [dependencies.uuid]
[INFO] [stderr]    |               ^^^^^
[INFO] [stderr]    |
[INFO] [stderr]    = note: `cargo::unused_dependencies` is set to `warn` by default
[INFO] [stderr] help: consider removing the dependency on `uuid`
[INFO] [stderr] warning: `synonz` (manifest) generated 1 warning
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.10s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/build/synonz/8c3c97ee6b333c48/out/synonz-8c3c97ee6b333c48)
[INFO] [stdout] 
[INFO] [stdout] running 78 tests
[INFO] [stdout] test agent::preset_tests::extend_system_prompt_composes_and_creates ... ok
[INFO] [stdout] test agent::preset_tests::extend_works_on_top_of_presets ... ok
[INFO] [stdout] test agent::preset_tests::react_is_the_bare_default ... ok
[INFO] [stdout] test agent::preset_tests::reflection_sets_prompt_without_tools ... ok
[INFO] [stdout] test agent::preset_tests::research_sets_prompt_and_round_budget ... ok
[INFO] [stdout] test agent::preset_tests::system_prompt_overrides_presets ... ok
[INFO] [stdout] test context::tests::a_failing_detector_keeps_the_previous_topic_and_reports ... ok
[INFO] [stdout] test cancel::tests::parent_token_propagates ... ok
[INFO] [stdout] test context::tests::a_non_empty_frame_is_passed_through_unchanged ... ok
[INFO] [stdout] test context::tests::empty_frame_falls_back_to_the_original_input_and_reports ... ok
[INFO] [stdout] test context::tests::a_failing_archive_is_reported_and_the_background_segment_still_runs ... ok
[INFO] [stdout] test context::tests::the_first_topic_is_an_establishment_not_a_shift ... ok
[INFO] [stdout] test context::tests::memory_failure_is_constructible_and_plain ... ok
[INFO] [stdout] test cancel::tests::drop_of_handle_cancels_signal ... ok
[INFO] [stdout] test context::tests::the_write_template_archives_and_derives_background_work ... ok
[INFO] [stdout] test context::tests::memory_scope_is_used_by_the_contracts ... ok
[INFO] [stdout] test conversation::tests::new_generates_unique_ids ... ok
[INFO] [stdout] test conversation::tests::of_fails_for_wrong_subject ... ok
[INFO] [stdout] test context::tests::a_topic_shift_is_written_back_and_visible_to_the_hooks ... ok
[INFO] [stdout] test conversation::tests::of_restores_from_store_after_save ... ok
[INFO] [stdout] test conversation::tests::registered_store_replaces_default ... ok
[INFO] [stdout] test event::tests::cancel_reason_displays ... ok
[INFO] [stdout] test conversation::tests::with_id_preserves_application_identity ... ok
[INFO] [stdout] test conversation::tests::of_fails_for_unknown_id ... ok
[INFO] [stdout] test conversation::tests::push_and_read_roundtrip ... ok
[INFO] [stdout] test conversation::tests::turn_input_serializes_by_borrow ... ok
[INFO] [stdout] test error::tests::errors_display_with_context ... ok
[INFO] [stdout] test event::tests::round_travels_on_model_events ... ok
[INFO] [stdout] test inprocess::bundled_tests::the_turn_store_keeps_the_window_bounded ... ok
[INFO] [stdout] test inprocess::tests::list_stale_ties_break_by_id_ascending ... ok
[INFO] [stdout] test event::tests::turn_event_serializes_with_kind_and_event_tags ... ok
[INFO] [stdout] test inprocess::tests::list_stale_paginates_by_cursor ... ok
[INFO] [stdout] test io::tests::text_returns_first_text_block ... ok
[INFO] [stdout] test memory::tests::list_cursor_start_has_no_position ... ok
[INFO] [stdout] test inprocess::tests::list_matches_metadata_keyword_case_insensitively ... ok
[INFO] [stdout] test inprocess::tests::list_stale_filters_and_orders ... ok
[INFO] [stdout] test memory::tests::query_builders_compose ... ok
[INFO] [stdout] test memory::tests::scope_is_an_opaque_string_value ... ok
[INFO] [stdout] test message::tests::call_id_serializes_transparently ... ok
[INFO] [stdout] test message::tests::dangling_call_id_is_rejected ... ok
[INFO] [stdout] test message::tests::parallel_calls_pair_by_call_id ... ok
[INFO] [stdout] test message::tests::valid_conversation_passes ... ok
[INFO] [stdout] test inprocess::bundled_tests::the_turn_store_is_conversation_scoped ... ok
[INFO] [stdout] test message::tests::tool_call_outside_assistant_is_rejected ... ok
[INFO] [stdout] test message::tests::tool_result_outside_tool_message_is_rejected ... ok
[INFO] [stdout] test model::tests::complete_folds_stream_until_finish ... ok
[INFO] [stdout] test model::tests::complete_fails_on_premature_stream_end ... ok
[INFO] [stdout] test model::tests::models_are_dyn_compatible ... ok
[INFO] [stdout] test io::tests::text_is_none_without_text_blocks ... ok
[INFO] [stdout] test model::tests::params_builders ... ok
[INFO] [stdout] test cancel::tests::inflight_future_is_dropped_at_cancellation ... ok
[INFO] [stdout] test runtime::tests::scheduler_snapshot_exposes_the_monitor ... ok
[INFO] [stdout] test runtime::tests::scheduler_snapshot_is_empty_without_configuration ... ok
[INFO] [stdout] test runtime::tests::executor_injection_allows_a_sync_build ... ok
[INFO] [stdout] test runtime::tests::shutdown_ends_owned_open_conversations ... ok
[INFO] [stdout] test runtime::tests::shutdown_is_idempotent ... ok
[INFO] [stdout] test runtime::tests::shutdown_flushes_observation_before_returning ... ok
[INFO] [stdout] test runtime::tests::shutdown_only_ends_conversations_the_runtime_owns ... ok
[INFO] [stdout] test runtime::tests::sweep_pages_through_many_stale_conversations ... ok
[INFO] [stdout] test runtime::tests::monitor_reconciles_previously_stored_stale_conversations ... ok
[INFO] [stdout] test cancel::tests::timeout_fires_with_timeout_outcome ... ok
[INFO] [stdout] test scheduler::tests::fires_immediately_then_periodically ... ok
[INFO] [stdout] test runtime::tests::build_panics_when_idle_timeout_has_no_execution_environment ... ok
[INFO] [stdout] test runtime::tests::finalize_drain_surfaces_task_panics ... ok
[INFO] [stdout] test runtime::tests::finalize_drain_is_bounded_and_visible ... ok
[INFO] [stdout] test subject::tests::accessors ... ok
[INFO] [stdout] test subject::tests::identity_is_type_and_id ... ok
[INFO] [stdout] test tool::tests::execute_roundtrips_arguments ... ok
[INFO] [stdout] test tool::tests::spec_collects_from_dyn_tool ... ok
[INFO] [stdout] test tool::tests::tool_error_displays ... ok
[INFO] [stdout] test tool::tests::tools_are_dyn_compatible ... ok
[INFO] [stdout] test scheduler::tests::tasks_reports_registered_tasks ... ok
[INFO] [stdout] test scheduler::tests::panicking_task_does_not_kill_the_loop ... ok
[INFO] [stdout] test scheduler::tests::concurrent_policy_allows_overlap ... ok
[INFO] [stdout] test scheduler::tests::long_task_does_not_block_other_triggers ... ok
[INFO] [stdout] test scheduler::tests::queue_policy_runs_back_to_back ... ok
[INFO] [stdout] test scheduler::tests::skip_policy_drops_triggers_while_running ... ok
[INFO] [stdout] test runtime::tests::monitor_ends_idle_conversations_automatically ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 78 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.81s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/agent.rs (/opt/rustwide/target/debug/build/synonz/601df23ddc53106f/out/agent-601df23ddc53106f)
[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/conversation.rs (/opt/rustwide/target/debug/build/synonz/d3efb17f0a313835/out/conversation-d3efb17f0a313835)
[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/derive.rs (/opt/rustwide/target/debug/build/synonz/89c6128ba1fffbcf/out/derive-89c6128ba1fffbcf)
[INFO] [stdout] 
[INFO] [stdout] running 5 tests
[INFO] [stdout] test derived_and_manual_descriptions_match ... ok
[INFO] [stdout] test derived_and_manual_execution_match ... ok
[INFO] [stdout] test derived_and_manual_names_match ... ok
[INFO] [stderr]      Running tests/handles.rs (/opt/rustwide/target/debug/build/synonz/40261f2eed4f7453/out/handles-40261f2eed4f7453)
[INFO] [stdout] test invalid_arguments_map_to_invalid_arguments_error ... ok
[INFO] [stdout] test derived_schema_matches_expected_shape ... 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] [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/memory.rs (/opt/rustwide/target/debug/build/synonz/05a0d6ac4dda46b3/out/memory-05a0d6ac4dda46b3)
[INFO] [stderr]      Running tests/observer.rs (/opt/rustwide/target/debug/build/synonz/0cfcd077c84e960d/out/observer-0cfcd077c84e960d)
[INFO] [stderr]      Running tests/serialization.rs (/opt/rustwide/target/debug/build/synonz/2af9ef7b3c6585ba/out/serialization-2af9ef7b3c6585ba)
[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] [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] [stdout] 
[INFO] [stdout] running 15 tests
[INFO] [stdout] test assistant_tool_call_block_snapshot ... ok
[INFO] [stdout] test auxiliary_model_call_carries_null_round ... ok
[INFO] [stdout] test memory_management_events_carry_scope_snapshots ... ok
[INFO] [stdout] test bus_families_roundtrip ... ok
[INFO] [stdout] test messages_roundtrip ... ok
[INFO] [stdout] test model_requested_event_snapshot ... ok
[INFO] [stdout] test tool_call_completed_event_snapshot ... ok
[INFO] [stdout] test tool_call_requested_event_snapshot ... ok
[INFO] [stdout] test started_event_snapshot ... ok
[INFO] [stdout] test stream_delta_snapshot ... ok
[INFO] [stdout] test cancelled_event_snapshot ... ok
[INFO] [stdout] test conversation_ended_event_snapshot ... ok
[INFO] [stdout] test memory_failed_event_snapshot ... ok
[INFO] [stdout] test events_roundtrip ... ok
[INFO] [stderr]    Doc-tests synonz
[INFO] [stdout] test turn_event_nests_inside_the_bus_envelope ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 15 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 3 tests
[INFO] [stdout] test src/agent.rs - agent (line 15) - compile ... ok
[INFO] [stdout] test src/event.rs - event (line 17) ... ok
[INFO] [stdout] test src/tool.rs - tool::Tool (line 59) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stdout] all doctests ran in 1.04s; merged doctests compilation took 1.00s
[INFO] running `Command { std: "docker" "inspect" "7e2d94c97fcb3c0436d9a70f7d7c04db72044f79ae660ba50181cdd5037a3db8", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "7e2d94c97fcb3c0436d9a70f7d7c04db72044f79ae660ba50181cdd5037a3db8", kill_on_drop: false }`
[INFO] [stdout] 7e2d94c97fcb3c0436d9a70f7d7c04db72044f79ae660ba50181cdd5037a3db8
