[INFO] fetching crate messageforge 0.1.13...
[INFO] testing messageforge-0.1.13 against master#562dee4820c458d823175268e41601d4c060588a for pr-154210-1
[INFO] extracting crate messageforge 0.1.13 into /workspace/builds/worker-2-tc1/source
[INFO] started tweaking crates.io crate messageforge 0.1.13
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate messageforge 0.1.13
[INFO] tweaked toml for crates.io crate messageforge 0.1.13 written to /workspace/builds/worker-2-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate messageforge 0.1.13 on toolchain 562dee4820c458d823175268e41601d4c060588a
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "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" "+562dee4820c458d823175268e41601d4c060588a" "generate-lockfile" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]      Locking 13 packages to latest compatible versions
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded derive_base_message v0.1.1
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-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" "+562dee4820c458d823175268e41601d4c060588a" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 0be84077a79a5a7e41a7de4996b6cc8ed253cb18c1b17ff5bf4025f8b7d21593
[INFO] running `Command { std: "docker" "start" "-a" "0be84077a79a5a7e41a7de4996b6cc8ed253cb18c1b17ff5bf4025f8b7d21593", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "0be84077a79a5a7e41a7de4996b6cc8ed253cb18c1b17ff5bf4025f8b7d21593", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "0be84077a79a5a7e41a7de4996b6cc8ed253cb18c1b17ff5bf4025f8b7d21593", kill_on_drop: false }`
[INFO] [stdout] 0be84077a79a5a7e41a7de4996b6cc8ed253cb18c1b17ff5bf4025f8b7d21593
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-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" "+562dee4820c458d823175268e41601d4c060588a" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] d70e826ba13e03c17b87a8c8837651f445e6d80bf26c2f83216b30b5526e77e5
[INFO] running `Command { std: "docker" "start" "-a" "d70e826ba13e03c17b87a8c8837651f445e6d80bf26c2f83216b30b5526e77e5", kill_on_drop: false }`
[INFO] [stderr]    Compiling serde_core v1.0.228
[INFO] [stderr]    Compiling syn v2.0.117
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling paste v1.0.15
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling derive_base_message v0.1.1
[INFO] [stderr]    Compiling serde_json v1.0.149
[INFO] [stderr]    Compiling messageforge v0.1.13 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 10.91s
[INFO] running `Command { std: "docker" "inspect" "d70e826ba13e03c17b87a8c8837651f445e6d80bf26c2f83216b30b5526e77e5", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "d70e826ba13e03c17b87a8c8837651f445e6d80bf26c2f83216b30b5526e77e5", kill_on_drop: false }`
[INFO] [stdout] d70e826ba13e03c17b87a8c8837651f445e6d80bf26c2f83216b30b5526e77e5
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-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" "+562dee4820c458d823175268e41601d4c060588a" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 06505f040ae1265134e475c3e351417d0024f53aacdcf1711dbdfa591f48d2d8
[INFO] running `Command { std: "docker" "start" "-a" "06505f040ae1265134e475c3e351417d0024f53aacdcf1711dbdfa591f48d2d8", kill_on_drop: false }`
[INFO] [stderr]    Compiling messageforge v0.1.13 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 2.14s
[INFO] running `Command { std: "docker" "inspect" "06505f040ae1265134e475c3e351417d0024f53aacdcf1711dbdfa591f48d2d8", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "06505f040ae1265134e475c3e351417d0024f53aacdcf1711dbdfa591f48d2d8", kill_on_drop: false }`
[INFO] [stdout] 06505f040ae1265134e475c3e351417d0024f53aacdcf1711dbdfa591f48d2d8
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-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" "+562dee4820c458d823175268e41601d4c060588a" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 48fe475adb2361b495f1da914f4aedbdd481a49ba29706b763e4016e75c4b88e
[INFO] running `Command { std: "docker" "start" "-a" "48fe475adb2361b495f1da914f4aedbdd481a49ba29706b763e4016e75c4b88e", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.03s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/messageforge-e03757b85564a659)
[INFO] [stdout] running 77 tests
[INFO] [stdout] test ai_message::tests::test_aimessage_creation ... ok
[INFO] [stdout] test ai_message::tests::test_aimessage_debug_format ... ok
[INFO] [stdout] test ai_message::tests::test_aimessage_example ... ok
[INFO] [stdout] test ai_message::tests::test_aimessage_serialization ... ok
[INFO] [stdout] test ai_message::tests::test_aimessage_with_additional_kwargs ... ok
[INFO] [stdout] test ai_message::tests::test_aimessage_with_all_fields ... ok
[INFO] [stdout] test ai_message::tests::test_aimessage_with_id_and_name ... ok
[INFO] [stdout] test chat_message::tests::test_chat_message_deserialization ... ok
[INFO] [stdout] test ai_message::tests::test_aimessage_with_response_metadata ... ok
[INFO] [stdout] test chat_message::tests::test_chat_message_serialization_with_partial_values ... ok
[INFO] [stdout] test human_message::tests::test_humanmessage_creation ... ok
[INFO] [stdout] test chat_message::tests::test_chat_message_serialization_with_values ... ok
[INFO] [stdout] test human_message::tests::test_humanmessage_deserialization ... ok
[INFO] [stdout] test ai_message::tests::test_aimessage_deserialization ... ok
[INFO] [stdout] test human_message::tests::test_humanmessage_example ... ok
[INFO] [stdout] test human_message::tests::test_humanmessage_debug_format ... ok
[INFO] [stdout] test human_message::tests::test_humanmessage_serialization ... ok
[INFO] [stdout] test human_message::tests::test_humanmessage_with_additional_kwargs ... ok
[INFO] [stdout] test human_message::tests::test_humanmessage_with_all_fields ... ok
[INFO] [stdout] test human_message::tests::test_humanmessage_with_id_and_name ... ok
[INFO] [stdout] test message_enum::tests::test_ai_from_invalid_type ... ok
[INFO] [stdout] test human_message::tests::test_humanmessage_with_response_metadata ... ok
[INFO] [stdout] test message_enum::tests::test_ai_from_success ... ok
[INFO] [stdout] test message_enum::tests::test_as_ai ... ok
[INFO] [stdout] test message_enum::tests::test_as_human ... ok
[INFO] [stdout] test message_enum::tests::test_as_system ... ok
[INFO] [stdout] test message_enum::tests::test_as_tool ... ok
[INFO] [stdout] test message_enum::tests::test_deserialize_vec_of_messages ... ok
[INFO] [stdout] test message_enum::tests::test_human_from_invalid_type ... ok
[INFO] [stdout] test message_enum::tests::test_human_from_success ... ok
[INFO] [stdout] test message_enum::tests::test_message_enum_debug_format ... ok
[INFO] [stdout] test message_enum::tests::test_message_enum_deserialization_ai_message ... ok
[INFO] [stdout] test message_enum::tests::test_message_enum_deserialization_human_message ... ok
[INFO] [stdout] test message_enum::tests::test_message_enum_deserialization_system_message ... ok
[INFO] [stdout] test message_enum::tests::test_message_enum_deserialization_with_defaults ... ok
[INFO] [stdout] test message_enum::tests::test_message_enum_deserialize_with_optional_fields ... ok
[INFO] [stdout] test message_enum::tests::test_message_enum_equality ... ok
[INFO] [stdout] test message_enum::tests::test_message_enum_serialization_ai_message ... ok
[INFO] [stdout] test message_enum::tests::test_message_enum_serialization_human_message ... ok
[INFO] [stdout] test message_enum::tests::test_message_enum_serialization_system_message ... ok
[INFO] [stdout] test message_enum::tests::test_message_enum_serialization_tool_message ... ok
[INFO] [stdout] test message_enum::tests::test_message_enum_serialize_with_optional_fields ... ok
[INFO] [stdout] test message_enum::tests::test_message_enum_tool_deserialization ... ok
[INFO] [stdout] test message_enum::tests::test_mixed_message_enum ... ok
[INFO] [stdout] test message_enum::tests::test_parse_invalid_message_format ... ok
[INFO] [stdout] test message_enum::tests::test_parse_empty_input ... ok
[INFO] [stdout] test message_enum::tests::test_parse_only_valid_messages ... ok
[INFO] [stdout] test message_enum::tests::test_serialize_vec_of_messages ... ok
[INFO] [stdout] test message_enum::tests::test_system_from_success ... ok
[INFO] [stdout] test message_enum::tests::test_parse_valid_multi_line ... ok
[INFO] [stdout] test message_enum::tests::test_tool_from_success ... ok
[INFO] [stdout] test message_enum::tests::test_try_from_ai_message_success ... ok
[INFO] [stdout] test message_enum::tests::test_parse_mixed_valid_and_invalid_messages ... ok
[INFO] [stdout] test message_enum::tests::test_tool_from_invalid_type ... ok
[INFO] [stdout] test message_enum::tests::test_try_from_invalid_message_format ... ok
[INFO] [stdout] test message_enum::tests::test_parse_with_empty_lines ... ok
[INFO] [stdout] test message_enum::tests::test_try_from_tool_message_invalid_format ... ok
[INFO] [stdout] test message_enum::tests::test_try_from_system_message_success ... ok
[INFO] [stdout] test message_enum::tests::test_try_from_tool_message_success ... ok
[INFO] [stdout] test system_message::tests::test_systemmessage_creation ... ok
[INFO] [stdout] test system_message::tests::test_systemmessage_debug_format ... ok
[INFO] [stdout] test system_message::tests::test_systemmessage_example ... ok
[INFO] [stdout] test system_message::tests::test_systemmessage_deserialization ... ok
[INFO] [stdout] test system_message::tests::test_systemmessage_serialization ... ok
[INFO] [stdout] test message_enum::tests::test_message_enum_serialization_with_message_type ... ok
[INFO] [stdout] test message_enum::tests::test_try_from_human_message_success ... ok
[INFO] [stdout] test message_enum::tests::test_system_from_invalid_type ... ok
[INFO] [stdout] test system_message::tests::test_systemmessage_with_additional_kwargs ... ok
[INFO] [stdout] test message_enum::tests::test_tool_from_invalid_format ... ok
[INFO] [stdout] test system_message::tests::test_systemmessage_with_all_fields ... ok
[INFO] [stdout] test tool_message::tests::test_tool_message_serialization_with_values ... ok
[INFO] [stdout] test system_message::tests::test_systemmessage_with_response_metadata ... ok
[INFO] [stdout] test system_message::tests::test_systemmessage_with_id_and_name ... ok
[INFO] [stdout] test tool_message::tests::test_tool_message_serialization_with_empty_fields ... ok
[INFO] [stdout] test tool_message::tests::test_tool_message_deserialization ... ok
[INFO] [stdout] test tool_message::tests::test_tool_message_serialization_with_partial_values ... ok
[INFO] [stdout] test chat_message::tests::test_chat_message_serialization_with_empty_fields ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 77 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.05s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/define_message_tests.rs (/opt/rustwide/target/debug/deps/define_message_tests-5253d3ac1907e335)
[INFO] [stdout] 
[INFO] [stdout] running 10 tests
[INFO] [stdout] test tests::test_ai_message_creation ... ok
[INFO] [stdout] test tests::test_default_additional_kwargs ... ok
[INFO] [stdout] test tests::test_empty_content ... ok
[INFO] [stdout] test tests::test_custom_fields ... ok
[INFO] [stdout] test tests::test_fully_qualified_human_message_getters ... ok
[INFO] [stdout] test tests::test_message_equality ... ok
[INFO] [stdout] test tests::test_multiple_message_types ... ok
[INFO] [stdout] test tests::test_human_message_creation ... ok
[INFO] [stdout] test tests::test_struct_macro_implementation ... ok
[INFO] [stdout] test tests::test_system_message_creation ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 10 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/derive_message_tests.rs (/opt/rustwide/target/debug/deps/derive_message_tests-521dc11e7149f988)
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test tests::test_human_message_base_message_trait_methods ... ok
[INFO] [stdout] test tests::test_human_message_new_method ... ok
[INFO] [stderr]      Running tests/message_serialization_tests.rs (/opt/rustwide/target/debug/deps/message_serialization_tests-d08d7b18051070f6)
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 4 tests
[INFO] [stderr]      Running tests/message_tests.rs (/opt/rustwide/target/debug/deps/message_tests-698e2a8aff51ae31)
[INFO] [stderr]    Doc-tests messageforge
[INFO] [stdout] test tests::test_empty_fields_deserialization ... ok
[INFO] [stdout] test tests::test_empty_fields_serialization ... ok
[INFO] [stdout] test tests::test_human_message_deserialization ... ok
[INFO] [stdout] test tests::test_human_message_serialization ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test test_message_integration ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 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] running `Command { std: "docker" "inspect" "48fe475adb2361b495f1da914f4aedbdd481a49ba29706b763e4016e75c4b88e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "48fe475adb2361b495f1da914f4aedbdd481a49ba29706b763e4016e75c4b88e", kill_on_drop: false }`
[INFO] [stdout] 48fe475adb2361b495f1da914f4aedbdd481a49ba29706b763e4016e75c4b88e