[INFO] fetching crate tds-protocol 0.9.0...
[INFO] testing tds-protocol-0.9.0 against master#562dee4820c458d823175268e41601d4c060588a for pr-154210-2
[INFO] extracting crate tds-protocol 0.9.0 into /workspace/builds/worker-5-tc1/source
[INFO] started tweaking crates.io crate tds-protocol 0.9.0
[INFO] finished tweaking crates.io crate tds-protocol 0.9.0
[INFO] tweaked toml for crates.io crate tds-protocol 0.9.0 written to /workspace/builds/worker-5-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate tds-protocol 0.9.0 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] crate crates.io crate tds-protocol 0.9.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" "+562dee4820c458d823175268e41601d4c060588a" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded proptest v1.11.0
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-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] 9ac7fafc73c3ebb0f9f8bdaf82abb131c2b0eedb7059a37a5a14f908d90f5976
[INFO] running `Command { std: "docker" "start" "-a" "9ac7fafc73c3ebb0f9f8bdaf82abb131c2b0eedb7059a37a5a14f908d90f5976", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "9ac7fafc73c3ebb0f9f8bdaf82abb131c2b0eedb7059a37a5a14f908d90f5976", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "9ac7fafc73c3ebb0f9f8bdaf82abb131c2b0eedb7059a37a5a14f908d90f5976", kill_on_drop: false }`
[INFO] [stdout] 9ac7fafc73c3ebb0f9f8bdaf82abb131c2b0eedb7059a37a5a14f908d90f5976
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-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] 7f9a7dadf96817e1949a2774be17a463083eabf3cdc80ea7d751286983b5e059
[INFO] running `Command { std: "docker" "start" "-a" "7f9a7dadf96817e1949a2774be17a463083eabf3cdc80ea7d751286983b5e059", kill_on_drop: false }`
[INFO] [stderr]    Compiling encoding_rs v0.8.35
[INFO] [stderr]    Compiling thiserror-impl v2.0.18
[INFO] [stderr]    Compiling thiserror v2.0.18
[INFO] [stderr]    Compiling tds-protocol v0.9.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 2.20s
[INFO] running `Command { std: "docker" "inspect" "7f9a7dadf96817e1949a2774be17a463083eabf3cdc80ea7d751286983b5e059", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "7f9a7dadf96817e1949a2774be17a463083eabf3cdc80ea7d751286983b5e059", kill_on_drop: false }`
[INFO] [stdout] 7f9a7dadf96817e1949a2774be17a463083eabf3cdc80ea7d751286983b5e059
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-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] 5c5b60a6f849be31b58e32ed7ea3f7623cd7b2f376ed598fbee103508313dc6d
[INFO] running `Command { std: "docker" "start" "-a" "5c5b60a6f849be31b58e32ed7ea3f7623cd7b2f376ed598fbee103508313dc6d", kill_on_drop: false }`
[INFO] [stderr]    Compiling zerocopy v0.8.48
[INFO] [stderr]    Compiling alloca v0.4.0
[INFO] [stderr]    Compiling anstyle v1.0.14
[INFO] [stderr]    Compiling clap_lex v1.1.0
[INFO] [stderr]    Compiling once_cell v1.21.4
[INFO] [stderr]    Compiling regex-automata v0.4.14
[INFO] [stderr]    Compiling wait-timeout v0.2.1
[INFO] [stderr]    Compiling itertools v0.13.0
[INFO] [stderr]    Compiling zerocopy-derive v0.8.48
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling thiserror-impl v2.0.18
[INFO] [stderr]    Compiling serde_json v1.0.149
[INFO] [stderr]    Compiling tokio v1.51.1
[INFO] [stderr]    Compiling rand v0.9.2
[INFO] [stderr]    Compiling rand_xorshift v0.4.0
[INFO] [stderr]    Compiling page_size v0.6.0
[INFO] [stderr]    Compiling tempfile v3.27.0
[INFO] [stderr]    Compiling clap_builder v4.6.0
[INFO] [stderr]    Compiling rusty-fork v0.3.1
[INFO] [stderr]    Compiling thiserror v2.0.18
[INFO] [stderr]    Compiling tds-protocol v0.9.0 (/opt/rustwide/workdir)
[INFO] [stderr]    Compiling criterion-plot v0.8.2
[INFO] [stderr]    Compiling regex v1.12.3
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling clap v4.6.0
[INFO] [stderr]    Compiling tinytemplate v1.2.1
[INFO] [stderr]    Compiling half v2.7.1
[INFO] [stderr]    Compiling ppv-lite86 v0.2.21
[INFO] [stderr]    Compiling ciborium-ll v0.2.2
[INFO] [stderr]    Compiling rand_chacha v0.9.0
[INFO] [stderr]    Compiling ciborium v0.2.2
[INFO] [stderr]    Compiling proptest v1.11.0
[INFO] [stderr]    Compiling criterion v0.8.2
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 15.56s
[INFO] running `Command { std: "docker" "inspect" "5c5b60a6f849be31b58e32ed7ea3f7623cd7b2f376ed598fbee103508313dc6d", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "5c5b60a6f849be31b58e32ed7ea3f7623cd7b2f376ed598fbee103508313dc6d", kill_on_drop: false }`
[INFO] [stdout] 5c5b60a6f849be31b58e32ed7ea3f7623cd7b2f376ed598fbee103508313dc6d
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-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] 09e9c8741f03e74e677585e7721c54543861c6baa7c09069e1fab177e99bc771
[INFO] running `Command { std: "docker" "start" "-a" "09e9c8741f03e74e677585e7721c54543861c6baa7c09069e1fab177e99bc771", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.14s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/tds_protocol-9ea588b01d2bcbe7)
[INFO] [stdout] 
[INFO] [stdout] running 119 tests
[INFO] [stdout] test codec::tests::test_us_varchar_roundtrip ... ok
[INFO] [stdout] test codec::tests::test_utf16_byte_len ... ok
[INFO] [stdout] test collation::tests::test_baltic_encoding ... ok
[INFO] [stdout] test collation::tests::test_arabic_encoding ... ok
[INFO] [stdout] test collation::tests::test_chinese_simplified_encoding ... ok
[INFO] [stdout] test collation::tests::test_decode_chinese_text ... ok
[INFO] [stdout] test collation::tests::test_cyrillic_encoding ... ok
[INFO] [stdout] test collation::tests::test_encoding_name ... ok
[INFO] [stdout] test collation::tests::test_greek_encoding ... ok
[INFO] [stdout] test collation::tests::test_decode_japanese_text ... ok
[INFO] [stdout] test collation::tests::test_hebrew_encoding ... ok
[INFO] [stdout] test collation::tests::test_korean_encoding ... ok
[INFO] [stdout] test collation::tests::test_japanese_encoding ... ok
[INFO] [stdout] test collation::tests::test_decode_cyrillic_text ... ok
[INFO] [stdout] test collation::tests::test_thai_encoding ... ok
[INFO] [stdout] test collation::tests::test_turkish_encoding ... ok
[INFO] [stdout] test codec::tests::test_b_varchar_roundtrip ... ok
[INFO] [stdout] test collation::tests::test_chinese_traditional_encoding ... ok
[INFO] [stdout] test collation::tests::test_unknown_lcid_fallback ... ok
[INFO] [stdout] test collation::tests::test_utf8_detection ... ok
[INFO] [stdout] test collation::tests::test_vietnamese_encoding ... ok
[INFO] [stdout] test collation::tests::test_western_european_encoding ... ok
[INFO] [stdout] test crypto::tests::test_cek_table_decode ... ok
[INFO] [stdout] test crypto::tests::test_cek_table_entry_decode ... ok
[INFO] [stdout] test crypto::tests::test_cek_value_decode ... ok
[INFO] [stdout] test crypto::tests::test_column_crypto_info ... ok
[INFO] [stdout] test crypto::tests::test_crypto_metadata_decode ... ok
[INFO] [stdout] test crypto::tests::test_encryption_type_wire_roundtrip ... ok
[INFO] [stdout] test crypto::tests::test_is_column_encrypted ... ok
[INFO] [stdout] test login7::tests::test_login7_default ... ok
[INFO] [stdout] test login7::tests::test_option_flags ... ok
[INFO] [stdout] test login7::tests::test_login7_encode ... ok
[INFO] [stdout] test login7::tests::test_password_obfuscation ... ok
[INFO] [stdout] test packet::tests::test_header_roundtrip ... ok
[INFO] [stdout] test packet::tests::test_packet_type_from_u8 ... ok
[INFO] [stdout] test packet::tests::test_payload_length ... ok
[INFO] [stdout] test prelogin::tests::test_prelogin_decode_encryption_offset ... ok
[INFO] [stdout] test prelogin::tests::test_prelogin_decode_roundtrip ... ok
[INFO] [stdout] test prelogin::tests::test_prelogin_encode ... ok
[INFO] [stdout] test rpc::tests::test_execute_request ... ok
[INFO] [stdout] test prelogin::tests::test_encryption_level ... ok
[INFO] [stdout] test rpc::tests::test_execute_sql_request ... ok
[INFO] [stdout] test rpc::tests::test_int_param ... ok
[INFO] [stdout] test rpc::tests::test_nvarchar_param ... ok
[INFO] [stdout] test rpc::tests::test_option_flags_encode ... ok
[INFO] [stdout] test rpc::tests::test_param_declarations ... ok
[INFO] [stdout] test rpc::tests::test_param_flags_encode ... ok
[INFO] [stdout] test rpc::tests::test_prepare_request ... ok
[INFO] [stdout] test rpc::tests::test_proc_id_values ... ok
[INFO] [stdout] test rpc::tests::test_rpc_encode_not_empty ... ok
[INFO] [stdout] test rpc::tests::test_unprepare_request ... ok
[INFO] [stdout] test sql_batch::tests::test_empty_batch ... ok
[INFO] [stdout] test sql_batch::tests::test_encode_sql_batch ... ok
[INFO] [stdout] test sql_batch::tests::test_sql_batch_builder ... ok
[INFO] [stdout] test token::tests::test_colmetadata_no_columns ... ok
[INFO] [stdout] test token::tests::test_colmetadata_nvarchar_column ... ok
[INFO] [stdout] test token::tests::test_colmetadata_single_int_column ... ok
[INFO] [stdout] test token::tests::test_column_data_fixed_size ... ok
[INFO] [stdout] test token::tests::test_decode_nvarchar_max_then_intn_roundtrip ... ok
[INFO] [stdout] test token::tests::test_decode_nvarchar_then_intn_roundtrip ... ok
[INFO] [stdout] test token::tests::test_done_in_proc_roundtrip ... ok
[INFO] [stdout] test token::tests::test_done_proc_roundtrip ... ok
[INFO] [stdout] test token::tests::test_done_proc_truncated ... ok
[INFO] [stdout] test token::tests::test_done_in_proc_via_parser ... ok
[INFO] [stdout] test token::tests::test_done_proc_via_parser ... ok
[INFO] [stdout] test token::tests::test_done_roundtrip ... ok
[INFO] [stdout] test token::tests::test_env_change_type_from_u8 ... ok
[INFO] [stdout] test token::tests::test_multi_token_error_in_stream ... ok
[INFO] [stdout] test token::tests::test_multi_token_proc_with_return_value ... ok
[INFO] [stdout] test token::tests::test_multi_token_stored_proc_response ... ok
[INFO] [stdout] test token::tests::test_nbcrow_null_bitmap ... ok
[INFO] [stdout] test token::tests::test_raw_row_decode_int ... ok
[INFO] [stdout] test token::tests::test_raw_row_decode_null_value ... ok
[INFO] [stdout] test token::tests::test_raw_row_decode_nullable_int ... ok
[INFO] [stdout] test token::tests::test_return_status_nonzero ... ok
[INFO] [stdout] test token::tests::test_return_status_truncated ... ok
[INFO] [stdout] test token::tests::test_return_status_via_parser ... ok
[INFO] [stdout] test token::tests::test_return_value_int_output ... ok
[INFO] [stdout] test token::tests::test_return_value_null_output ... ok
[INFO] [stdout] test token::tests::test_return_value_nvarchar_output ... ok
[INFO] [stdout] test token::tests::test_return_value_udf_status ... ok
[INFO] [stdout] test token::tests::test_return_value_via_parser ... ok
[INFO] [stdout] test token::tests::test_server_error_decode ... ok
[INFO] [stdout] test token::tests::test_server_error_severity_helpers ... ok
[INFO] [stdout] test token::tests::test_server_error_truncated ... ok
[INFO] [stdout] test token::tests::test_done_proc_with_error_flag ... ok
[INFO] [stdout] test token::tests::test_done_status_bits ... ok
[INFO] [stdout] test token::tests::test_server_error_via_parser ... ok
[INFO] [stdout] test token::tests::test_token_parser_colmetadata ... ok
[INFO] [stdout] test token::tests::test_token_parser_done ... ok
[INFO] [stdout] test token::tests::test_token_parser_peek ... ok
[INFO] [stdout] test token::tests::test_token_parser_row_with_metadata ... ok
[INFO] [stdout] test token::tests::test_token_parser_row_without_metadata_fails ... ok
[INFO] [stdout] test tvp::tests::test_tvp_column_def_encoding ... ok
[INFO] [stdout] test tvp::tests::test_tvp_int_encoding ... ok
[INFO] [stdout] test tvp::tests::test_tvp_metadata_encoding ... ok
[INFO] [stdout] test tvp::tests::test_tvp_nvarchar_encoding ... ok
[INFO] [stdout] test types::tests::test_column_flags_roundtrip ... ok
[INFO] [stdout] test types::tests::test_fixed_length_detection ... ok
[INFO] [stdout] test types::tests::test_type_id_from_u8 ... ok
[INFO] [stdout] test version::tests::test_display ... ok
[INFO] [stdout] test version::tests::test_is_legacy ... ok
[INFO] [stdout] test version::tests::test_is_tds_7_3 ... ok
[INFO] [stdout] test version::tests::test_is_tds_7_4 ... ok
[INFO] [stdout] test version::tests::test_major_minor ... ok
[INFO] [stdout] test version::tests::test_min_version ... ok
[INFO] [stdout] test version::tests::test_parse ... ok
[INFO] [stdout] test version::tests::test_prelogin_requirement ... ok
[INFO] [stdout] test version::tests::test_revision_suffix ... ok
[INFO] [stdout] test version::tests::test_sql_server_version_display ... ok
[INFO] [stdout] test version::tests::test_sql_server_version_from_prelogin_bytes ... ok
[INFO] [stdout] test version::tests::test_sql_server_version_from_raw ... ok
[INFO] [stdout] test version::tests::test_sql_server_version_max_tds ... ok
[INFO] [stdout] test version::tests::test_sql_server_version_name ... ok
[INFO] [stdout] test version::tests::test_sql_server_version_product_names ... ok
[INFO] [stdout] test version::tests::test_supports_session_recovery ... ok
[INFO] [stdout] test version::tests::test_tds_8_detection ... ok
[INFO] [stdout] test version::tests::test_version_comparison ... ok
[INFO] [stdout] test version::tests::test_supports_date_time_types ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 119 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests tds_protocol
[INFO] [stdout] 
[INFO] [stdout] running 8 tests
[INFO] [stdout] test src/lib.rs - (line 45) ... ignored
[INFO] [stdout] test src/lib.rs - (line 68) - compile ... ok
[INFO] [stdout] test src/token.rs - token::Collation (line 212) ... ignored
[INFO] [stdout] test src/token.rs - token::Collation::encoding (line 256) ... ignored
[INFO] [stdout] test src/token.rs - token::TokenParser (line 2143) ... ignored
[INFO] [stdout] test src/rpc.rs - rpc::RpcRequest::execute_sql (line 615) ... ok
[INFO] [stdout] test src/sql_batch.rs - sql_batch::encode_sql_batch_with_transaction (line 53) ... ok
[INFO] [stdout] test src/sql_batch.rs - sql_batch::encode_sql_batch (line 24) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 4 passed; 0 failed; 4 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test src/token.rs - token (line 14) ... ignored
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 1 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] all doctests ran in 0.52s; merged doctests compilation took 0.51s
[INFO] running `Command { std: "docker" "inspect" "09e9c8741f03e74e677585e7721c54543861c6baa7c09069e1fab177e99bc771", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "09e9c8741f03e74e677585e7721c54543861c6baa7c09069e1fab177e99bc771", kill_on_drop: false }`
[INFO] [stdout] 09e9c8741f03e74e677585e7721c54543861c6baa7c09069e1fab177e99bc771