[INFO] cloning repository https://github.com/emirror-de/pork
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/emirror-de/pork" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Femirror-de%2Fpork", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Femirror-de%2Fpork'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 987017ae5d9b5b038df30a2d2b4d6bcfab5a340f
[INFO] testing emirror-de/pork against 1.99.0-beta.8 for beta-1.100-2
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Femirror-de%2Fpork" "/workspace/builds/worker-3-tc1/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-3-tc1/source'...
[INFO] [stderr] done.
[INFO] started tweaking git repo https://github.com/emirror-de/pork
[INFO] finished tweaking git repo https://github.com/emirror-de/pork
[INFO] tweaked toml for git repo https://github.com/emirror-de/pork written to /workspace/builds/worker-3-tc1/source/Cargo.toml
[INFO] validating manifest of git repo https://github.com/emirror-de/pork on toolchain 1.99.0-beta.8
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.99.0-beta.8" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate git repo https://github.com/emirror-de/pork 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.99.0-beta.8" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded heapless v0.7.17
[INFO] [stderr]   Downloaded hash32 v0.2.1
[INFO] [stderr]   Downloaded postcard v1.1.3
[INFO] [stderr]   Downloaded wasm-bindgen-shared v0.2.127
[INFO] [stderr]   Downloaded atomic-polyfill v1.0.3
[INFO] [stderr]   Downloaded embedded-io v0.4.0
[INFO] [stderr]   Downloaded futures-macro v0.3.34
[INFO] [stderr]   Downloaded tokio-macros v2.7.2
[INFO] [stderr]   Downloaded windows-threading v0.1.0
[INFO] [stderr]   Downloaded windows-collections v0.2.0
[INFO] [stderr]   Downloaded rustc-hash v2.1.3
[INFO] [stderr]   Downloaded futures-task v0.3.34
[INFO] [stderr]   Downloaded cobs v0.3.0
[INFO] [stderr]   Downloaded wasm-bindgen-macro v0.2.127
[INFO] [stderr]   Downloaded windows-numerics v0.2.0
[INFO] [stderr]   Downloaded windows-future v0.2.1
[INFO] [stderr]   Downloaded futures-core v0.3.34
[INFO] [stderr]   Downloaded embedded-io v0.6.1
[INFO] [stderr]   Downloaded rustversion v1.0.23
[INFO] [stderr]   Downloaded critical-section v1.2.0
[INFO] [stderr]   Downloaded spin v0.9.9
[INFO] [stderr]   Downloaded windows-core v0.61.2
[INFO] [stderr]   Downloaded futures-channel v0.3.34
[INFO] [stderr]   Downloaded smallvec v1.15.2
[INFO] [stderr]   Downloaded crossbeam-utils v0.8.22
[INFO] [stderr]   Downloaded uuid v1.24.0
[INFO] [stderr]   Downloaded bytes v1.12.1
[INFO] [stderr]   Downloaded wasm-bindgen v0.2.127
[INFO] [stderr]   Downloaded wasm-bindgen-macro-support v0.2.127
[INFO] [stderr]   Downloaded rand v0.9.5
[INFO] [stderr]   Downloaded mio v1.2.2
[INFO] [stderr]   Downloaded crossbeam-channel v0.5.16
[INFO] [stderr]   Downloaded js-sys v0.3.104
[INFO] [stderr]   Downloaded zerocopy-derive v0.8.56
[INFO] [stderr]   Downloaded ipc-channel v0.22.0
[INFO] [stderr]   Downloaded futures-util v0.3.34
[INFO] [stderr]   Downloaded zerocopy v0.8.56
[INFO] [stderr]   Downloaded syn v3.0.3
[INFO] [stderr]   Downloaded tokio v1.53.1
[INFO] [stderr]   Downloaded windows v0.61.3
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/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] c271682eaaf80879f6f729aee3bb2194809d3fda6265df960c9565bf9512b656
[INFO] running `Command { std: "docker" "start" "c271682eaaf80879f6f729aee3bb2194809d3fda6265df960c9565bf9512b656", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "c271682eaaf80879f6f729aee3bb2194809d3fda6265df960c9565bf9512b656", 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" "c271682eaaf80879f6f729aee3bb2194809d3fda6265df960c9565bf9512b656" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "c271682eaaf80879f6f729aee3bb2194809d3fda6265df960c9565bf9512b656", 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" "c271682eaaf80879f6f729aee3bb2194809d3fda6265df960c9565bf9512b656" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v1.0.107
[INFO] [stderr]    Compiling quote v1.0.47
[INFO] [stderr]    Compiling libc v0.2.189
[INFO] [stderr]    Compiling serde_core v1.0.229
[INFO] [stderr]    Compiling semver v1.0.28
[INFO] [stderr]    Compiling serde v1.0.229
[INFO] [stderr]    Compiling thiserror v2.0.20
[INFO] [stderr]    Compiling getrandom v0.4.3
[INFO] [stderr]    Compiling byteorder v1.5.0
[INFO] [stderr]    Compiling crossbeam-utils v0.8.22
[INFO] [stderr]    Compiling zmij v1.0.23
[INFO] [stderr]    Compiling rustix v1.1.4
[INFO] [stderr]    Compiling linux-raw-sys v0.12.1
[INFO] [stderr]    Compiling bitflags v2.13.1
[INFO] [stderr]    Compiling spin v0.9.9
[INFO] [stderr]    Compiling serde_json v1.0.151
[INFO] [stderr]    Compiling smallvec v1.15.2
[INFO] [stderr]    Compiling hash32 v0.2.1
[INFO] [stderr]    Compiling futures-core v0.3.34
[INFO] [stderr]    Compiling once_cell v1.21.4
[INFO] [stderr]    Compiling fastrand v2.5.0
[INFO] [stderr]    Compiling memchr v2.8.3
[INFO] [stderr]    Compiling pin-project-lite v0.2.17
[INFO] [stderr]    Compiling itoa v1.0.18
[INFO] [stderr]    Compiling futures-channel v0.3.34
[INFO] [stderr]    Compiling slab v0.4.12
[INFO] [stderr]    Compiling futures-task v0.3.34
[INFO] [stderr]    Compiling bytes v1.12.1
[INFO] [stderr]    Compiling rustc-hash v2.1.3
[INFO] [stderr]    Compiling rustc_version v0.4.1
[INFO] [stderr]    Compiling heapless v0.7.17
[INFO] [stderr]    Compiling crossbeam-channel v0.5.16
[INFO] [stderr]    Compiling syn v3.0.3
[INFO] [stderr]    Compiling errno v0.3.14
[INFO] [stderr]    Compiling mio v1.2.2
[INFO] [stderr]    Compiling parking_lot_core v0.9.12
[INFO] [stderr]    Compiling socket2 v0.6.5
[INFO] [stderr]    Compiling signal-hook-registry v1.4.8
[INFO] [stderr]    Compiling uuid v1.24.0
[INFO] [stderr]    Compiling parking_lot v0.12.5
[INFO] [stderr]    Compiling tempfile v3.27.0
[INFO] [stderr]    Compiling thiserror-impl v2.0.20
[INFO] [stderr]    Compiling serde_derive v1.0.229
[INFO] [stderr]    Compiling tokio-macros v2.7.2
[INFO] [stderr]    Compiling futures-macro v0.3.34
[INFO] [stderr]    Compiling futures-util v0.3.34
[INFO] [stderr]    Compiling tokio v1.53.1
[INFO] [stderr]    Compiling cobs v0.3.0
[INFO] [stderr]    Compiling postcard v1.1.3
[INFO] [stderr]    Compiling ipc-channel v0.22.0
[INFO] [stderr]    Compiling pork-proto v2.0.0 (/opt/rustwide/workdir/pork-proto)
[INFO] [stderr]    Compiling pork v2.0.0 (/opt/rustwide/workdir/pork)
[INFO] [stderr]    Compiling pork-comms v2.0.0 (/opt/rustwide/workdir/examples/pork-comms)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 29.96s
[INFO] running `Command { std: "docker" "inspect" "c271682eaaf80879f6f729aee3bb2194809d3fda6265df960c9565bf9512b656", 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" "c271682eaaf80879f6f729aee3bb2194809d3fda6265df960c9565bf9512b656" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling pork-proto v2.0.0 (/opt/rustwide/workdir/pork-proto)
[INFO] [stderr]    Compiling pork v2.0.0 (/opt/rustwide/workdir/pork)
[INFO] [stderr]    Compiling pork-comms v2.0.0 (/opt/rustwide/workdir/examples/pork-comms)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 8.23s
[INFO] running `Command { std: "docker" "inspect" "c271682eaaf80879f6f729aee3bb2194809d3fda6265df960c9565bf9512b656", 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" "c271682eaaf80879f6f729aee3bb2194809d3fda6265df960c9565bf9512b656" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "test" "--frozen", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.09s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/pork-34b15d09c1efb70c)
[INFO] [stdout] 
[INFO] [stdout] running 24 tests
[INFO] [stdout] test child::bootstrap::tests::child_bootstrap_from_default_env_constructor_is_available ... ok
[INFO] [stdout] test error::tests::error_is_send_sync_static ... ok
[INFO] [stdout] test error::tests::display_output_is_stable ... ok
[INFO] [stdout] test child::bootstrap::tests::child_bootstrap_new_creates_instance ... ok
[INFO] [stdout] test error::tests::control_codec_forwards_its_source ... ok
[INFO] [stdout] test child::status_reporter::tests::current_time_ms_is_monotonic ... ok
[INFO] [stdout] test child::bootstrap::tests::control_and_data_sender_types_exist ... ok
[INFO] [stdout] test child::bootstrap::tests::child_bootstrap_channels_debug_format ... ok
[INFO] [stdout] test error::tests::ipc_forwards_its_source ... ok
[INFO] [stdout] test child::bootstrap::tests::child_bootstrap_from_env_with_missing_data_var ... ok
[INFO] [stdout] test child::status_reporter::tests::current_time_ms_returns_positive_value ... ok
[INFO] [stdout] test error::tests::io_forwards_its_source ... ok
[INFO] [stdout] test host::tests::bootstrap_env_debug_format ... ok
[INFO] [stdout] test host::tests::bootstrap_env_applies_to_command ... ok
[INFO] [stdout] test error::tests::leaf_variants_have_no_source ... ok
[INFO] [stdout] test orchestrator::tests::cleanup_reserved_name_after_failed_start_keeps_other_owner_registration ... ok
[INFO] [stdout] test types::tests::map_stream_item_distinguishes_message_close_and_ipc_error ... ok
[INFO] [stdout] test host::tests::bootstrap_env_can_be_cloned ... ok
[INFO] [stdout] test host::tests::bootstrap_env_stores_server_names ... ok
[INFO] [stdout] test child::bootstrap::tests::control_worker_surfaces_invalid_payload_and_keeps_receiving ... ok
[INFO] [stdout] test child::bootstrap::tests::control_worker_progresses_while_data_queue_is_full ... ok
[INFO] [stdout] test host::tests::host_bootstrap_new_creates_instance ... ok
[INFO] [stdout] test host::tests::host_bootstrap_channels_debug_format ... ok
[INFO] [stdout] test orchestrator::tests::cleanup_reserved_name_after_failed_start_waits_for_lock_and_removes_name ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 24 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.04s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/control_events.rs (/opt/rustwide/target/debug/deps/control_events-0bc56e88ba2eaae5)
[INFO] [stdout] 
[INFO] [stdout] running 3 tests
[INFO] [stdout] test subscribe_control_events_rejects_unknown_process ... ok
[INFO] [stdout] test control_events_test_child_entrypoint ... ok
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stderr]      Running tests/dependencies.rs (/opt/rustwide/target/debug/deps/dependencies-52cbd447a7909e50)
[INFO] [stdout] test control_events_test_child_entrypoint ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 2 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stdout] test observes_child_control_messages_including_ignored_lifecycle_messages ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.05s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 14 tests
[INFO] [stdout] test delayed_dep_test_child_entrypoint ... ok
[INFO] [stdout] test dep_test_child_entrypoint ... ok
[INFO] [stdout] test process_spec_depends_on_all_and_accessor ... ok
[INFO] [stdout] test start_process_returns_dependency_not_found_for_unknown_name ... ok
[INFO] [stdout] test heartbeat_only_dep_test_child_entrypoint ... ok
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test non_running_dep_test_child_entrypoint ... ok
[INFO] [stdout] test start_process_returns_dependency_cycle_for_self_dependency ... 
[INFO] [stdout] running 1 test
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] ok
[INFO] [stdout] test process_spec_depends_on_defaults_to_empty ... ok
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test dep_test_child_entrypoint ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 13 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stdout] test process_without_dependencies_starts_normally ... ok
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test dep_test_child_entrypoint ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 13 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stdout] test duplicate_start_keeps_original_name_registration ... ok
[INFO] [stdout] test dep_test_child_entrypoint ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 13 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stdout] test dep_test_child_entrypoint ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 13 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] [stdout] test process_starts_when_dependency_is_already_running ... ok
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test heartbeat_only_dep_test_child_entrypoint ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 13 filtered out; finished in 0.22s
[INFO] [stdout] 
[INFO] [stdout] test heartbeat_only_dependency_times_out ... ok
[INFO] [stdout] test non_running_dep_test_child_entrypoint ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 13 filtered out; finished in 0.33s
[INFO] [stdout] 
[INFO] [stdout] test start_process_returns_dependency_timeout_when_dep_not_ready_in_time ... ok
[INFO] [stdout] test dep_test_child_entrypoint ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 13 filtered out; finished in 0.21s
[INFO] [stdout] 
[INFO] [stdout] test delayed_dep_test_child_entrypoint ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 13 filtered out; finished in 0.37s
[INFO] [stdout] 
[INFO] [stdout] test dependent_waits_for_child_reported_running ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 14 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.38s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/heartbeat.rs (/opt/rustwide/target/debug/deps/heartbeat-dc984da1fd2d1e56)
[INFO] [stdout] 
[INFO] [stdout] running 4 tests
[INFO] [stdout] test heartbeat_only_test_child_entrypoint ... ok
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test heartbeat_status_test_child_entrypoint ... ok
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test heartbeat_only_test_child_entrypoint ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 3 filtered out; finished in 0.37s
[INFO] [stdout] 
[INFO] [stdout] test heartbeat_without_status_update_leaves_child_status_none ... ok
[INFO] [stdout] test heartbeat_status_test_child_entrypoint ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 3 filtered out; finished in 0.66s
[INFO] [stdout] 
[INFO] [stdout] test heartbeat_preserves_lifecycle_status_and_refreshes_timestamp ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.67s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/public_api.rs (/opt/rustwide/target/debug/deps/public_api-cffd312bf4d4e6d9)
[INFO] [stdout] 
[INFO] [stdout] running 7 tests
[INFO] [stdout] test process_spec_log_output_uses_one_append_target_for_both_streams ... ok
[INFO] [stdout] test process_spec_without_managed_name_clears_previous_value ... ok
[INFO] [stdout] test managed_child_identity_accessors_are_predictable ... ok
[INFO] [stdout] test process_spec_exposes_configured_fields_through_accessors ... ok
[INFO] [stdout] test child_status_by_name_reports_unknown_process ... ok
[INFO] [stdout] test child_status_reports_unknown_process ... ok
[INFO] [stdout] test process_spec_defaults_are_predictable_and_documented ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/restart.rs (/opt/rustwide/target/debug/deps/restart-11e7f288ca12cc1c)
[INFO] [stdout] 
[INFO] [stdout] running 15 tests
[INFO] [stdout] test bootstrap_cleanup_subprocess_entrypoint ... ok
[INFO] [stdout] test process_id_by_name_returns_not_found_shape_for_unknown_name ... ok
[INFO] [stdout] test restart_test_child_entrypoint ... ok
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test restart_test_child_entrypoint ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 14 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stdout] test restart_test_child_entrypoint ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 14 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stdout] test restart_test_child_entrypoint ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 14 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stdout] test restart_test_child_entrypoint ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 14 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stdout] test orchestrator_reports_stopping_status_after_graceful_shutdown_request ... ok
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test orchestrator_reports_running_status_for_started_child ... ok
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test restart_test_child_entrypoint ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 14 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] test restart_test_child_entrypoint ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 14 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test failed_start_process_cleans_up_name_registration ... ok
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test logfile_output_is_inspectable_while_child_is_running ... ok
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test restart_test_child_entrypoint ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 14 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stdout] test handshake_failure_releases_name_and_preserves_error_context ... ok
[INFO] [stdout] test restart_test_child_entrypoint ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 14 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stdout] test restart_test_child_entrypoint ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 14 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stdout] test orchestrator_restart_process_replaces_child_and_preserves_managed_name_via_process_id ... ok
[INFO] [stdout] test orchestrator_restart_process_after_name_lookup_restarts_named_child ... ok
[INFO] [stdout] test graceful_shutdown_timeout_force_kills_and_cleans_up_stubborn_child ... ok
[INFO] [stdout] test unexpected_child_exit_is_reconciled_on_lookup ... ok
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test restart_test_child_entrypoint ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 14 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stdout] test startup_timeout_releases_name_after_no_bootstrap_connection ... ok
[INFO] [stdout] test restart_test_child_entrypoint ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 14 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stdout] test startup_timeout_releases_name_after_partial_bootstrap ... ok
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test restart_test_child_entrypoint ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 14 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stdout] test bootstrap_cleanup_subprocess_entrypoint ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 14 filtered out; finished in 0.58s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test restart_test_child_entrypoint ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 14 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] [stdout] test bootstrap_cleanup_subprocess_entrypoint ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 14 filtered out; finished in 0.39s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test restart_test_child_entrypoint ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 14 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test restart_test_child_entrypoint ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 14 filtered out; finished in 0.04s
[INFO] [stdout] 
[INFO] [stdout] test bootstrap_cleanup_subprocess_entrypoint ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 14 filtered out; finished in 0.16s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test restart_test_child_entrypoint ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 14 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] [stdout] test bootstrap_cleanup_subprocess_entrypoint ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 14 filtered out; finished in 0.12s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test restart_test_child_entrypoint ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 14 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] [stdout] test bootstrap_cleanup_subprocess_entrypoint ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 14 filtered out; finished in 0.15s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test restart_test_child_entrypoint ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 14 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stdout] test bootstrap_cleanup_subprocess_entrypoint ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 14 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] [stdout] test bootstrap_cleanup_subprocess_scenarios_exit_before_watchdog ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 15 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.52s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/pork_comms-62fe9298ac549746)
[INFO] [stdout] 
[INFO] [stdout] running 5 tests
[INFO] [stdout] test tests::decoding_control_message_returns_none_for_custom_payload ... ok
[INFO] [stdout] test tests::host_echo_round_trip_with_json_codec ... ok
[INFO] [stdout] test tests::child_status_round_trip_with_postcard_codec ... ok
[INFO] [stderr]      Running unittests src/bin/child.rs (/opt/rustwide/target/debug/deps/child-efbdc7cbd937ebe9)
[INFO] [stdout] test tests::child_ready_round_trip_with_json_codec ... ok
[INFO] [stdout] test tests::host_status_round_trip_with_postcard_codec ... 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 unittests src/bin/host.rs (/opt/rustwide/target/debug/deps/host-baf790bdfce3d442)
[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 unittests src/lib.rs (/opt/rustwide/target/debug/deps/pork_proto-78556cad3cd7a2b5)
[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/public_api.rs (/opt/rustwide/target/debug/deps/public_api-bd604bdef85ef1df)
[INFO] [stdout] 
[INFO] [stdout] running 15 tests
[INFO] [stdout] test available_codecs_match_feature_flags ... ok
[INFO] [stdout] test json_codec_round_trips_graceful_shutdown_control_messages ... ok
[INFO] [stdout] test json_codec_rejects_custom_payloads_as_control_messages ... ok
[INFO] [stdout] test lifecycle_helpers_match_control_messages ... ok
[INFO] [stdout] test json_codec_round_trips_restart_and_status_control_messages ... ok
[INFO] [stdout] test encode_control_message_reports_unavailable_codec_features ... ok
[INFO] [stdout] test postcard_codec_round_trips_restart_and_status_control_messages ... ok
[INFO] [stdout] test pork_ipc_message_custom_helpers_expose_custom_payload ... ok
[INFO] [stdout] test decode_control_message_reports_unavailable_codec_features ... ok
[INFO] [stdout] test pork_control_codec_env_values_and_display_are_stable ... ok
[INFO] [stdout] test postcard_codec_rejects_custom_payloads_as_control_messages ... ok
[INFO] [stdout] test postcard_codec_round_trips_graceful_shutdown_control_messages ... ok
[INFO] [stdout] test pork_ipc_message_control_helpers_expose_control_payload ... ok
[INFO] [stdout] test pork_control_codec_parse_accepts_supported_values ... ok
[INFO] [stdout] test pork_control_codec_parse_rejects_unknown_values_with_original_input ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 15 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests pork
[INFO] [stdout] 
[INFO] [stdout] running 9 tests
[INFO] [stdout] test pork/src/child/status_reporter.rs - child::status_reporter::StatusReporter::set_status (line 91) - compile ... ok
[INFO] [stdout] test pork/src/child/status_reporter.rs - child::status_reporter::StatusReporter::wait_for_completion (line 179) - compile ... ok
[INFO] [stdout] test pork/src/child/status_reporter.rs - child::status_reporter::StatusReporter::new (line 61) - compile ... ok
[INFO] [stdout] test pork/src/child/status_reporter.rs - child::status_reporter::StatusReporter (line 19) - compile ... ok
[INFO] [stdout] test pork/src/lib.rs - (line 65) ... ok
[INFO] [stdout] test pork/src/orchestrator/spec.rs - orchestrator::spec::ProcessSpecBuilder::with_heartbeat (line 394) ... ok
[INFO] [stdout] test pork/src/child/status_reporter.rs - child::status_reporter::StatusReporter::start (line 120) - compile ... ok
[INFO] [stdout] test pork/src/orchestrator/spec.rs - orchestrator::spec::ProcessSpecBuilder::enable_heartbeat (line 369) ... ok
[INFO] [stdout] test pork/src/lib.rs - (line 35) ... 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] [stdout] all doctests ran in 0.67s; merged doctests compilation took 0.66s
[INFO] [stderr]    Doc-tests pork_comms
[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]    Doc-tests pork_proto
[INFO] [stdout] 
[INFO] [stdout] running 5 tests
[INFO] [stdout] test pork-proto/src/lib.rs - (line 72) ... ok
[INFO] [stdout] test pork-proto/src/lib.rs - (line 137) ... ok
[INFO] [stdout] test pork-proto/src/lib.rs - (line 49) ... ok
[INFO] [stdout] test pork-proto/src/lib.rs - (line 104) ... ok
[INFO] [stdout] test pork-proto/src/lib.rs - (line 25) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stdout] all doctests ran in 0.55s; merged doctests compilation took 0.53s
[INFO] running `Command { std: "docker" "inspect" "c271682eaaf80879f6f729aee3bb2194809d3fda6265df960c9565bf9512b656", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "c271682eaaf80879f6f729aee3bb2194809d3fda6265df960c9565bf9512b656", kill_on_drop: false }`
[INFO] [stdout] c271682eaaf80879f6f729aee3bb2194809d3fda6265df960c9565bf9512b656
