[INFO] fetching crate swimos_agent_protocol 0.1.1...
[INFO] testing swimos_agent_protocol-0.1.1 against master#caccb4d0368bd918ef6668af8e13834d07040417 for pr-146098-1
[INFO] extracting crate swimos_agent_protocol 0.1.1 into /workspace/builds/worker-4-tc1/source
[INFO] started tweaking crates.io crate swimos_agent_protocol 0.1.1
[INFO] finished tweaking crates.io crate swimos_agent_protocol 0.1.1
[INFO] tweaked toml for crates.io crate swimos_agent_protocol 0.1.1 written to /workspace/builds/worker-4-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate swimos_agent_protocol 0.1.1 on toolchain caccb4d0368bd918ef6668af8e13834d07040417
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+caccb4d0368bd918ef6668af8e13834d07040417" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+caccb4d0368bd918ef6668af8e13834d07040417" "generate-lockfile" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]      Locking 139 packages to latest compatible versions
[INFO] [stderr]       Adding thiserror v1.0.69 (available: v2.0.17)
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+caccb4d0368bd918ef6668af8e13834d07040417" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded swimos_trigger v0.1.1
[INFO] [stderr]   Downloaded swimos_format v0.1.1
[INFO] [stderr]   Downloaded swimos_byte_channel v0.1.1
[INFO] [stderr]   Downloaded swimos_num v0.1.1
[INFO] [stderr]   Downloaded swimos_utilities v0.1.1
[INFO] [stderr]   Downloaded swimos_future v0.1.1
[INFO] [stderr]   Downloaded nom_locate v4.2.0
[INFO] [stderr]   Downloaded frunk_proc_macros v0.1.4
[INFO] [stderr]   Downloaded swimos_errors v0.1.1
[INFO] [stderr]   Downloaded swimos_fs v0.1.1
[INFO] [stderr]   Downloaded swimos_recon v0.1.1
[INFO] [stderr]   Downloaded frunk v0.4.4
[INFO] [stderr]   Downloaded swimos_form_derive v0.1.1
[INFO] [stderr]   Downloaded frunk_derives v0.4.4
[INFO] [stderr]   Downloaded frunk_core v0.4.4
[INFO] [stderr]   Downloaded swimos_model v0.1.1
[INFO] [stderr]   Downloaded swimos_api v0.1.1
[INFO] [stderr]   Downloaded swimos_encoding v0.1.1
[INFO] [stderr]   Downloaded swimos_algebra v0.1.1
[INFO] [stderr]   Downloaded swimos_macro_utilities v0.1.1
[INFO] [stderr]   Downloaded frunk_proc_macro_helpers v0.1.4
[INFO] [stderr]   Downloaded swimos_route v0.1.1
[INFO] [stderr]   Downloaded swimos_form v0.1.1
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-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:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+caccb4d0368bd918ef6668af8e13834d07040417" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] cd578ebec1b50c4ecc14886cd35b419eda23535e5b8ff44e706c200c9962f987
[INFO] running `Command { std: "docker" "start" "-a" "cd578ebec1b50c4ecc14886cd35b419eda23535e5b8ff44e706c200c9962f987", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "cd578ebec1b50c4ecc14886cd35b419eda23535e5b8ff44e706c200c9962f987", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "cd578ebec1b50c4ecc14886cd35b419eda23535e5b8ff44e706c200c9962f987", kill_on_drop: false }`
[INFO] [stdout] cd578ebec1b50c4ecc14886cd35b419eda23535e5b8ff44e706c200c9962f987
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-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:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+caccb4d0368bd918ef6668af8e13834d07040417" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 94f7e0e6d570d95d1f5d4940e1711198625e1a53d93007677e4c443650054611
[INFO] running `Command { std: "docker" "start" "-a" "94f7e0e6d570d95d1f5d4940e1711198625e1a53d93007677e4c443650054611", kill_on_drop: false }`
[INFO] [stderr]    Compiling memchr v2.7.6
[INFO] [stderr]    Compiling futures-channel v0.3.31
[INFO] [stderr]    Compiling bytecount v0.6.9
[INFO] [stderr]    Compiling zerocopy v0.8.27
[INFO] [stderr]    Compiling futures-macro v0.3.31
[INFO] [stderr]    Compiling smallvec v1.15.1
[INFO] [stderr]    Compiling tokio v1.47.1
[INFO] [stderr]    Compiling getrandom v0.2.16
[INFO] [stderr]    Compiling frunk_core v0.4.4
[INFO] [stderr]    Compiling rand_core v0.6.4
[INFO] [stderr]    Compiling parking_lot_core v0.9.11
[INFO] [stderr]    Compiling pin-project-internal v1.1.10
[INFO] [stderr]    Compiling parking_lot v0.12.4
[INFO] [stderr]    Compiling swimos_num v0.1.1
[INFO] [stderr]    Compiling swimos_algebra v0.1.1
[INFO] [stderr]    Compiling nom v7.1.3
[INFO] [stderr]    Compiling futures-util v0.3.31
[INFO] [stderr]    Compiling swimos_errors v0.1.1
[INFO] [stderr]    Compiling frunk_proc_macro_helpers v0.1.4
[INFO] [stderr]    Compiling swimos_format v0.1.1
[INFO] [stderr]    Compiling pin-project v1.1.10
[INFO] [stderr]    Compiling remove_dir_all v0.5.3
[INFO] [stderr]    Compiling syn v1.0.109
[INFO] [stderr]    Compiling frunk_derives v0.4.4
[INFO] [stderr]    Compiling frunk_proc_macros v0.1.4
[INFO] [stderr]    Compiling tempdir v0.3.7
[INFO] [stderr]    Compiling unicode-segmentation v1.12.0
[INFO] [stderr]    Compiling swimos_fs v0.1.1
[INFO] [stderr]    Compiling frunk v0.4.4
[INFO] [stderr]    Compiling convert_case v0.6.0
[INFO] [stderr]    Compiling ppv-lite86 v0.2.21
[INFO] [stderr]    Compiling num-integer v0.1.46
[INFO] [stderr]    Compiling iana-time-zone v0.1.64
[INFO] [stderr]    Compiling rand_chacha v0.3.1
[INFO] [stderr]    Compiling num-bigint v0.4.6
[INFO] [stderr]    Compiling chrono v0.4.42
[INFO] [stderr]    Compiling nom_locate v4.2.0
[INFO] [stderr]    Compiling rand v0.8.5
[INFO] [stderr]    Compiling tokio-util v0.7.16
[INFO] [stderr]    Compiling swimos_route v0.1.1
[INFO] [stderr]    Compiling swimos_utilities v0.1.1
[INFO] [stderr]    Compiling uuid v1.18.1
[INFO] [stderr]    Compiling swimos_encoding v0.1.1
[INFO] [stderr]    Compiling futures-executor v0.3.31
[INFO] [stderr]    Compiling futures v0.3.31
[INFO] [stderr]    Compiling swimos_trigger v0.1.1
[INFO] [stderr]    Compiling swimos_byte_channel v0.1.1
[INFO] [stderr]    Compiling swimos_future v0.1.1
[INFO] [stderr]    Compiling swimos_model v0.1.1
[INFO] [stderr]    Compiling swimos_macro_utilities v0.1.1
[INFO] [stderr]    Compiling swimos_form_derive v0.1.1
[INFO] [stderr]    Compiling swimos_form v0.1.1
[INFO] [stderr]    Compiling swimos_recon v0.1.1
[INFO] [stderr]    Compiling swimos_api v0.1.1
[INFO] [stderr]    Compiling swimos_agent_protocol v0.1.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 43.07s
[INFO] running `Command { std: "docker" "inspect" "94f7e0e6d570d95d1f5d4940e1711198625e1a53d93007677e4c443650054611", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "94f7e0e6d570d95d1f5d4940e1711198625e1a53d93007677e4c443650054611", kill_on_drop: false }`
[INFO] [stdout] 94f7e0e6d570d95d1f5d4940e1711198625e1a53d93007677e4c443650054611
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-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:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+caccb4d0368bd918ef6668af8e13834d07040417" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] dcf765764e0e104b03062e3b8da57910b97d13778294d43945aa7e27f77df7f3
[INFO] running `Command { std: "docker" "start" "-a" "dcf765764e0e104b03062e3b8da57910b97d13778294d43945aa7e27f77df7f3", kill_on_drop: false }`
[INFO] [stderr]    Compiling swimos_agent_protocol v0.1.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 2.81s
[INFO] running `Command { std: "docker" "inspect" "dcf765764e0e104b03062e3b8da57910b97d13778294d43945aa7e27f77df7f3", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "dcf765764e0e104b03062e3b8da57910b97d13778294d43945aa7e27f77df7f3", kill_on_drop: false }`
[INFO] [stdout] dcf765764e0e104b03062e3b8da57910b97d13778294d43945aa7e27f77df7f3
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-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:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+caccb4d0368bd918ef6668af8e13834d07040417" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] a189bf1e61ce2bbcef315b3b450cb2d53fa8e6112a710909fe2b1035634b42d4
[INFO] running `Command { std: "docker" "start" "-a" "a189bf1e61ce2bbcef315b3b450cb2d53fa8e6112a710909fe2b1035634b42d4", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.27s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/swimos_agent_protocol-1b3e188b40b8b550)
[INFO] [stdout] 
[INFO] [stdout] running 79 tests
[INFO] [stdout] test command::tests::round_trip_no_host_partial_with_ow ... ok
[INFO] [stdout] test command::tests::round_trip_no_host_with_ow ... ok
[INFO] [stdout] test command::tests::round_trip_no_host_no_ow ... ok
[INFO] [stdout] test command::tests::round_trip_no_host_partial_no_ow ... ok
[INFO] [stdout] test command::tests::round_trip_register ... ok
[INFO] [stdout] test command::tests::round_trip_register_no_host ... ok
[INFO] [stdout] test command::tests::round_trip_registered_partial_no_ow ... ok
[INFO] [stdout] test command::tests::round_trip_registered_partial_with_ow ... ok
[INFO] [stdout] test command::tests::round_trip_with_host_no_ow ... ok
[INFO] [stdout] test command::tests::round_trip_registered_no_ow ... ok
[INFO] [stdout] test command::tests::round_trip_with_host_with_ow ... ok
[INFO] [stdout] test command::tests::round_trip_two_messages ... ok
[INFO] [stdout] test command::tests::round_trip_with_host_partial_no_ow ... ok
[INFO] [stdout] test downlink::tests::decode_complex_operation ... ok
[INFO] [stdout] test command::tests::round_trip_with_host_partial_with_ow ... ok
[INFO] [stdout] test downlink::tests::decode_linked_notification ... ok
[INFO] [stdout] test downlink::tests::decode_event_notification ... ok
[INFO] [stdout] test downlink::tests::decode_operation ... ok
[INFO] [stdout] test downlink::tests::encode_complex_operation ... ok
[INFO] [stdout] test downlink::tests::encode_event_notification ... ok
[INFO] [stdout] test downlink::tests::encode_linked_notification ... ok
[INFO] [stdout] test downlink::tests::encode_synced_notification ... ok
[INFO] [stdout] test downlink::tests::encode_unlinked_notification ... ok
[INFO] [stdout] test downlink::tests::decode_recon_notification ... ok
[INFO] [stdout] test lane::tests::decode_command_lane_request ... ok
[INFO] [stdout] test downlink::tests::decode_recon_notification_twice ... ok
[INFO] [stdout] test lane::tests::decode_event_map_lane_response ... ok
[INFO] [stdout] test lane::tests::decode_event_value_lane_response ... ok
[INFO] [stdout] test lane::tests::decode_sync_complete_map_lane_response ... ok
[INFO] [stdout] test lane::tests::decode_sync_event_map_lane_response ... ok
[INFO] [stdout] test lane::tests::decode_sync_lane_request ... ok
[INFO] [stdout] test command::tests::round_trip_registered_with_ow ... ok
[INFO] [stdout] test lane::tests::decode_sync_value_lane_response ... ok
[INFO] [stdout] test lane::tests::decoder_sequential_value_responses ... ok
[INFO] [stdout] test lane::tests::encode_event_map_lane_response ... ok
[INFO] [stdout] test lane::tests::encode_command_lane_request ... ok
[INFO] [stdout] test lane::tests::encode_event_value_lane_response ... ok
[INFO] [stdout] test lane::tests::encode_initialized_lane_response ... ok
[INFO] [stdout] test lane::tests::encode_sync_complete_map_lane_response ... ok
[INFO] [stdout] test downlink::tests::decode_synced_notification ... ok
[INFO] [stdout] test lane::tests::encode_sync_event_map_lane_response ... ok
[INFO] [stdout] test lane::tests::encode_synced_lane_response ... ok
[INFO] [stdout] test map::parser::tests::peel_drop_header ... ok
[INFO] [stdout] test lane::tests::encode_sync_lane_request ... ok
[INFO] [stdout] test map::parser::tests::peel_remove_header ... ok
[INFO] [stdout] test map::parser::tests::peel_clear_header ... ok
[INFO] [stdout] test lane::tests::encode_sync_value_lane_response ... ok
[INFO] [stdout] test downlink::tests::encode_operation ... ok
[INFO] [stdout] test downlink::tests::decode_unlinked_notification ... ok
[INFO] [stdout] test map::parser::tests::peel_update_header ... ok
[INFO] [stdout] test map::parser::tests::peel_take_header ... ok
[INFO] [stdout] test map::tests::decode_clear_operation ... ok
[INFO] [stdout] test map::tests::decode_drop_message ... ok
[INFO] [stdout] test map::tests::decode_op_message ... ok
[INFO] [stdout] test map::tests::decode_take_message ... ok
[INFO] [stdout] test map::tests::encode_clear_operation ... ok
[INFO] [stdout] test map::tests::decode_update_operation ... ok
[INFO] [stdout] test map::tests::encode_drop_message ... ok
[INFO] [stdout] test map::tests::decode_remove_operation ... ok
[INFO] [stdout] test map::tests::encode_take_message ... ok
[INFO] [stdout] test map::tests::encode_update_operation_raw ... ok
[INFO] [stdout] test map::tests::encode_remove_operation_raw ... ok
[INFO] [stdout] test map::tests::encode_update_operation ... ok
[INFO] [stdout] test map::tests::encode_remove_operation ... ok
[INFO] [stdout] test map::tests::encode_op_message ... ok
[INFO] [stdout] test map::tests::test_map_message_form ... ok
[INFO] [stdout] test map::tests::test_map_operation_form ... ok
[INFO] [stdout] test store::tests::decode_init_complete_store_message ... ok
[INFO] [stdout] test store::tests::decode_store_response ... ok
[INFO] [stdout] test store::tests::encode_init_store_request ... ok
[INFO] [stdout] test store::tests::decode_command_store_message ... ok
[INFO] [stdout] test store::tests::decode_store_initialized ... ok
[INFO] [stdout] test store::tests::encode_store_response ... ok
[INFO] [stdout] test store::tests::encode_store_initialized ... ok
[INFO] [stdout] test tests::encode_recon_with_length ... ok
[INFO] [stdout] test store::tests::encode_command_store_request ... ok
[INFO] [stdout] test tests::recognizer_decode_with_len ... ok
[INFO] [stdout] test tests::recognizer_decode_with_len_fails_on_overrun ... ok
[INFO] [stdout] test map::tests::encode_clear_operation_raw ... ok
[INFO] [stderr]    Doc-tests swimos_agent_protocol
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 79 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.04s
[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] running `Command { std: "docker" "inspect" "a189bf1e61ce2bbcef315b3b450cb2d53fa8e6112a710909fe2b1035634b42d4", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "a189bf1e61ce2bbcef315b3b450cb2d53fa8e6112a710909fe2b1035634b42d4", kill_on_drop: false }`
[INFO] [stdout] a189bf1e61ce2bbcef315b3b450cb2d53fa8e6112a710909fe2b1035634b42d4