[INFO] fetching crate swimos_agent_protocol 0.1.1...
[INFO] testing swimos_agent_protocol-0.1.1 against master#ec6f9a5b4413f74386267ef8efc93712c2ce6db6 for pr-155739-1
[INFO] extracting crate swimos_agent_protocol 0.1.1 into /workspace/builds/worker-7-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-7-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate swimos_agent_protocol 0.1.1 on toolchain ec6f9a5b4413f74386267ef8efc93712c2ce6db6
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+ec6f9a5b4413f74386267ef8efc93712c2ce6db6" "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" "+ec6f9a5b4413f74386267ef8efc93712c2ce6db6" "generate-lockfile" "--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]      Locking 117 packages to latest compatible versions
[INFO] [stderr]       Adding thiserror v1.0.69 (available: v2.0.18)
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+ec6f9a5b4413f74386267ef8efc93712c2ce6db6" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded swimos_trigger 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 swimos_route v0.1.1
[INFO] [stderr]   Downloaded swimos_form_derive v0.1.1
[INFO] [stderr]   Downloaded frunk_proc_macro_helpers v0.1.4
[INFO] [stderr]   Downloaded swimos_algebra v0.1.1
[INFO] [stderr]   Downloaded frunk v0.4.4
[INFO] [stderr]   Downloaded frunk_derives v0.4.4
[INFO] [stderr]   Downloaded swimos_format v0.1.1
[INFO] [stderr]   Downloaded swimos_encoding v0.1.1
[INFO] [stderr]   Downloaded frunk_proc_macros v0.1.4
[INFO] [stderr]   Downloaded swimos_fs v0.1.1
[INFO] [stderr]   Downloaded swimos_byte_channel v0.1.1
[INFO] [stderr]   Downloaded swimos_errors v0.1.1
[INFO] [stderr]   Downloaded swimos_api v0.1.1
[INFO] [stderr]   Downloaded swimos_macro_utilities v0.1.1
[INFO] [stderr]   Downloaded swimos_model v0.1.1
[INFO] [stderr]   Downloaded frunk_core v0.4.4
[INFO] [stderr]   Downloaded swimos_recon 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-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" "+ec6f9a5b4413f74386267ef8efc93712c2ce6db6" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] f4dcbfbef3492ae66590ceabda4dc0bfb83b847273ed16ee1372cf32155e44d2
[INFO] running `Command { std: "docker" "start" "-a" "f4dcbfbef3492ae66590ceabda4dc0bfb83b847273ed16ee1372cf32155e44d2", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "f4dcbfbef3492ae66590ceabda4dc0bfb83b847273ed16ee1372cf32155e44d2", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "f4dcbfbef3492ae66590ceabda4dc0bfb83b847273ed16ee1372cf32155e44d2", kill_on_drop: false }`
[INFO] [stdout] f4dcbfbef3492ae66590ceabda4dc0bfb83b847273ed16ee1372cf32155e44d2
[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" "+ec6f9a5b4413f74386267ef8efc93712c2ce6db6" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 24d685d677b69b1cc4e01f1cb92c87c540a47fb44bb6c09b4046f292179f91d5
[INFO] running `Command { std: "docker" "start" "-a" "24d685d677b69b1cc4e01f1cb92c87c540a47fb44bb6c09b4046f292179f91d5", kill_on_drop: false }`
[INFO] [stderr]    Compiling memchr v2.8.0
[INFO] [stderr]    Compiling bytecount v0.6.9
[INFO] [stderr]    Compiling tokio v1.52.3
[INFO] [stderr]    Compiling frunk_core v0.4.4
[INFO] [stderr]    Compiling swimos_num v0.1.1
[INFO] [stderr]    Compiling swimos_algebra v0.1.1
[INFO] [stderr]    Compiling either v1.15.0
[INFO] [stderr]    Compiling remove_dir_all v0.5.3
[INFO] [stderr]    Compiling syn v2.0.117
[INFO] [stderr]    Compiling rand v0.4.6
[INFO] [stderr]    Compiling swimos_format v0.1.1
[INFO] [stderr]    Compiling syn v1.0.109
[INFO] [stderr]    Compiling convert_case v0.6.0
[INFO] [stderr]    Compiling chrono v0.4.44
[INFO] [stderr]    Compiling swimos_errors v0.1.1
[INFO] [stderr]    Compiling nom v7.1.3
[INFO] [stderr]    Compiling tempdir v0.3.7
[INFO] [stderr]    Compiling swimos_fs v0.1.1
[INFO] [stderr]    Compiling nom_locate v4.2.0
[INFO] [stderr]    Compiling swimos_route v0.1.1
[INFO] [stderr]    Compiling swimos_utilities v0.1.1
[INFO] [stderr]    Compiling tokio-util v0.7.18
[INFO] [stderr]    Compiling swimos_encoding v0.1.1
[INFO] [stderr]    Compiling frunk_proc_macro_helpers v0.1.4
[INFO] [stderr]    Compiling futures-macro v0.3.32
[INFO] [stderr]    Compiling pin-project-internal v1.1.13
[INFO] [stderr]    Compiling thiserror-impl v1.0.69
[INFO] [stderr]    Compiling frunk_derives v0.4.4
[INFO] [stderr]    Compiling frunk_proc_macros v0.1.4
[INFO] [stderr]    Compiling frunk v0.4.4
[INFO] [stderr]    Compiling futures-util v0.3.32
[INFO] [stderr]    Compiling thiserror v1.0.69
[INFO] [stderr]    Compiling pin-project v1.1.13
[INFO] [stderr]    Compiling swimos_macro_utilities v0.1.1
[INFO] [stderr]    Compiling swimos_form_derive v0.1.1
[INFO] [stderr]    Compiling futures-executor v0.3.32
[INFO] [stderr]    Compiling futures v0.3.32
[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_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 20.64s
[INFO] running `Command { std: "docker" "inspect" "24d685d677b69b1cc4e01f1cb92c87c540a47fb44bb6c09b4046f292179f91d5", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "24d685d677b69b1cc4e01f1cb92c87c540a47fb44bb6c09b4046f292179f91d5", kill_on_drop: false }`
[INFO] [stdout] 24d685d677b69b1cc4e01f1cb92c87c540a47fb44bb6c09b4046f292179f91d5
[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" "+ec6f9a5b4413f74386267ef8efc93712c2ce6db6" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 5da7cb4e22ce18af8ea0b5e1e821bf68df39cec62884510bcef7f342ef9cb292
[INFO] running `Command { std: "docker" "start" "-a" "5da7cb4e22ce18af8ea0b5e1e821bf68df39cec62884510bcef7f342ef9cb292", 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.36s
[INFO] running `Command { std: "docker" "inspect" "5da7cb4e22ce18af8ea0b5e1e821bf68df39cec62884510bcef7f342ef9cb292", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "5da7cb4e22ce18af8ea0b5e1e821bf68df39cec62884510bcef7f342ef9cb292", kill_on_drop: false }`
[INFO] [stdout] 5da7cb4e22ce18af8ea0b5e1e821bf68df39cec62884510bcef7f342ef9cb292
[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" "+ec6f9a5b4413f74386267ef8efc93712c2ce6db6" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 097c7060cbe6c45ab4fc236c41e2fd3b1f4db9775999738a57be511c066304f6
[INFO] running `Command { std: "docker" "start" "-a" "097c7060cbe6c45ab4fc236c41e2fd3b1f4db9775999738a57be511c066304f6", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.19s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/swimos_agent_protocol-dd1ebe61a2eefcfa)
[INFO] [stdout] 
[INFO] [stdout] running 79 tests
[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_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_register_no_host ... ok
[INFO] [stdout] test command::tests::round_trip_register ... ok
[INFO] [stdout] test command::tests::round_trip_registered_partial_with_ow ... ok
[INFO] [stdout] test command::tests::round_trip_registered_with_ow ... ok
[INFO] [stdout] test command::tests::round_trip_two_messages ... ok
[INFO] [stdout] test command::tests::round_trip_with_host_partial_with_ow ... 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 downlink::tests::decode_event_notification ... ok
[INFO] [stdout] test downlink::tests::decode_linked_notification ... ok
[INFO] [stdout] test command::tests::round_trip_with_host_no_ow ... ok
[INFO] [stdout] test downlink::tests::decode_unlinked_notification ... ok
[INFO] [stdout] test downlink::tests::encode_event_notification ... ok
[INFO] [stdout] test downlink::tests::decode_recon_notification ... ok
[INFO] [stdout] test downlink::tests::encode_linked_notification ... ok
[INFO] [stdout] test downlink::tests::encode_complex_operation ... ok
[INFO] [stdout] test downlink::tests::encode_operation ... ok
[INFO] [stdout] test downlink::tests::decode_recon_notification_twice ... ok
[INFO] [stdout] test downlink::tests::encode_unlinked_notification ... 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 command::tests::round_trip_registered_no_ow ... ok
[INFO] [stdout] test lane::tests::decode_event_map_lane_response ... ok
[INFO] [stdout] test lane::tests::decode_command_lane_request ... ok
[INFO] [stdout] test lane::tests::decode_event_value_lane_response ... ok
[INFO] [stdout] test downlink::tests::encode_synced_notification ... ok
[INFO] [stdout] test lane::tests::decode_sync_value_lane_response ... ok
[INFO] [stdout] test lane::tests::decode_sync_lane_request ... ok
[INFO] [stdout] test lane::tests::encode_command_lane_request ... ok
[INFO] [stdout] test lane::tests::decoder_sequential_value_responses ... ok
[INFO] [stdout] test lane::tests::encode_sync_lane_request ... ok
[INFO] [stdout] test lane::tests::encode_sync_event_map_lane_response ... ok
[INFO] [stdout] test lane::tests::encode_sync_value_lane_response ... ok
[INFO] [stdout] test lane::tests::encode_event_value_lane_response ... ok
[INFO] [stdout] test lane::tests::encode_synced_lane_response ... ok
[INFO] [stdout] test lane::tests::encode_sync_complete_map_lane_response ... ok
[INFO] [stdout] test map::parser::tests::peel_clear_header ... ok
[INFO] [stdout] test map::parser::tests::peel_drop_header ... ok
[INFO] [stdout] test lane::tests::encode_initialized_lane_response ... ok
[INFO] [stdout] test map::parser::tests::peel_take_header ... ok
[INFO] [stdout] test map::tests::decode_clear_operation ... ok
[INFO] [stdout] test lane::tests::encode_event_map_lane_response ... ok
[INFO] [stdout] test map::parser::tests::peel_remove_header ... ok
[INFO] [stdout] test map::parser::tests::peel_update_header ... ok
[INFO] [stdout] test downlink::tests::decode_operation ... ok
[INFO] [stdout] test downlink::tests::decode_synced_notification ... ok
[INFO] [stdout] test command::tests::round_trip_registered_partial_no_ow ... ok
[INFO] [stdout] test map::tests::decode_drop_message ... ok
[INFO] [stdout] test map::tests::decode_op_message ... ok
[INFO] [stdout] test map::tests::encode_clear_operation ... ok
[INFO] [stdout] test map::tests::decode_take_message ... ok
[INFO] [stdout] test map::tests::decode_update_operation ... ok
[INFO] [stdout] test map::tests::encode_op_message ... ok
[INFO] [stdout] test map::tests::decode_remove_operation ... ok
[INFO] [stdout] test map::tests::encode_clear_operation_raw ... ok
[INFO] [stdout] test map::tests::encode_drop_message ... 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_update_operation_raw ... ok
[INFO] [stdout] test map::tests::test_map_operation_form ... ok
[INFO] [stdout] test store::tests::decode_store_initialized ... ok
[INFO] [stdout] test store::tests::decode_store_response ... ok
[INFO] [stdout] test store::tests::decode_command_store_message ... ok
[INFO] [stdout] test map::tests::encode_remove_operation ... ok
[INFO] [stdout] test store::tests::encode_store_initialized ... ok
[INFO] [stdout] test store::tests::encode_command_store_request ... ok
[INFO] [stdout] test store::tests::encode_init_store_request ... ok
[INFO] [stdout] test store::tests::decode_init_complete_store_message ... ok
[INFO] [stdout] test map::tests::encode_take_message ... ok
[INFO] [stdout] test store::tests::encode_store_response ... ok
[INFO] [stdout] test map::tests::test_map_message_form ... ok
[INFO] [stdout] test tests::encode_recon_with_length ... 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 command::tests::round_trip_with_host_with_ow ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 79 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.07s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests swimos_agent_protocol
[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" "097c7060cbe6c45ab4fc236c41e2fd3b1f4db9775999738a57be511c066304f6", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "097c7060cbe6c45ab4fc236c41e2fd3b1f4db9775999738a57be511c066304f6", kill_on_drop: false }`
[INFO] [stdout] 097c7060cbe6c45ab4fc236c41e2fd3b1f4db9775999738a57be511c066304f6
