[INFO] fetching crate vlen 0.2.0...
[INFO] testing vlen-0.2.0 against master#caccb4d0368bd918ef6668af8e13834d07040417 for pr-146098-1
[INFO] extracting crate vlen 0.2.0 into /workspace/builds/worker-6-tc1/source
[INFO] started tweaking crates.io crate vlen 0.2.0
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate vlen 0.2.0
[INFO] tweaked toml for crates.io crate vlen 0.2.0 written to /workspace/builds/worker-6-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate vlen 0.2.0 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] crate crates.io crate vlen 0.2.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" "+caccb4d0368bd918ef6668af8e13834d07040417" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded criterion v0.6.0
[INFO] [stderr]   Downloaded arbtest v0.3.2
[INFO] [stderr]   Downloaded integer-encoding v4.0.2
[INFO] [stderr]   Downloaded clap v4.5.41
[INFO] [stderr]   Downloaded clap_builder v4.5.41
[INFO] [stderr]   Downloaded winnow v0.7.12
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-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] f800375f9d3dc148ebc8dbabcb592bd59a5028c5df3e537854ff12cb7fcb9af9
[INFO] running `Command { std: "docker" "start" "-a" "f800375f9d3dc148ebc8dbabcb592bd59a5028c5df3e537854ff12cb7fcb9af9", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "f800375f9d3dc148ebc8dbabcb592bd59a5028c5df3e537854ff12cb7fcb9af9", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "f800375f9d3dc148ebc8dbabcb592bd59a5028c5df3e537854ff12cb7fcb9af9", kill_on_drop: false }`
[INFO] [stdout] f800375f9d3dc148ebc8dbabcb592bd59a5028c5df3e537854ff12cb7fcb9af9
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-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] 416cece027ddc0d4371bf04ae378be0186190b2f4ef7fb921cdd007b295105fa
[INFO] running `Command { std: "docker" "start" "-a" "416cece027ddc0d4371bf04ae378be0186190b2f4ef7fb921cdd007b295105fa", kill_on_drop: false }`
[INFO] [stderr]    Compiling vlen v0.2.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 0.23s
[INFO] running `Command { std: "docker" "inspect" "416cece027ddc0d4371bf04ae378be0186190b2f4ef7fb921cdd007b295105fa", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "416cece027ddc0d4371bf04ae378be0186190b2f4ef7fb921cdd007b295105fa", kill_on_drop: false }`
[INFO] [stdout] 416cece027ddc0d4371bf04ae378be0186190b2f4ef7fb921cdd007b295105fa
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-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] 402146968c449efc02cd851281f148daeebbed9837ea1d3b18d40521822eed8e
[INFO] running `Command { std: "docker" "start" "-a" "402146968c449efc02cd851281f148daeebbed9837ea1d3b18d40521822eed8e", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v1.0.95
[INFO] [stderr]    Compiling memchr v2.7.5
[INFO] [stderr]    Compiling equivalent v1.0.2
[INFO] [stderr]    Compiling hashbrown v0.15.4
[INFO] [stderr]    Compiling regex-syntax v0.8.5
[INFO] [stderr]    Compiling toml_datetime v0.6.11
[INFO] [stderr]    Compiling winnow v0.7.12
[INFO] [stderr]    Compiling clap_builder v4.5.41
[INFO] [stderr]    Compiling glob v0.3.2
[INFO] [stderr]    Compiling rstest_macros v0.25.0
[INFO] [stderr]    Compiling relative-path v1.9.3
[INFO] [stderr]    Compiling plotters v0.3.7
[INFO] [stderr]    Compiling futures-timer v3.0.3
[INFO] [stderr]    Compiling arbitrary v1.4.1
[INFO] [stderr]    Compiling integer-encoding v4.0.2
[INFO] [stderr]    Compiling quote v1.0.40
[INFO] [stderr]    Compiling indexmap v2.10.0
[INFO] [stderr]    Compiling syn v2.0.104
[INFO] [stderr]    Compiling aho-corasick v1.1.3
[INFO] [stderr]    Compiling arbtest v0.3.2
[INFO] [stderr]    Compiling regex-automata v0.4.9
[INFO] [stderr]    Compiling toml_edit v0.22.27
[INFO] [stderr]    Compiling clap v4.5.41
[INFO] [stderr]    Compiling proc-macro-crate v3.3.0
[INFO] [stderr]    Compiling regex v1.11.1
[INFO] [stderr]    Compiling serde_derive v1.0.219
[INFO] [stderr]    Compiling futures-macro v0.3.31
[INFO] [stderr]    Compiling futures-util v0.3.31
[INFO] [stderr]    Compiling serde v1.0.219
[INFO] [stderr]    Compiling rstest v0.25.0
[INFO] [stderr]    Compiling serde_json v1.0.140
[INFO] [stderr]    Compiling ciborium v0.2.2
[INFO] [stderr]    Compiling tinytemplate v1.2.1
[INFO] [stderr]    Compiling criterion v0.6.0
[INFO] [stderr]    Compiling vlen v0.2.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 37.93s
[INFO] running `Command { std: "docker" "inspect" "402146968c449efc02cd851281f148daeebbed9837ea1d3b18d40521822eed8e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "402146968c449efc02cd851281f148daeebbed9837ea1d3b18d40521822eed8e", kill_on_drop: false }`
[INFO] [stdout] 402146968c449efc02cd851281f148daeebbed9837ea1d3b18d40521822eed8e
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-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] 6578b51cb8eac5cae9aef8a5fb26d583dafbb47e630b27778abb70128d8d5cc8
[INFO] running `Command { std: "docker" "start" "-a" "6578b51cb8eac5cae9aef8a5fb26d583dafbb47e630b27778abb70128d8d5cc8", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.15s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests vlen/mod.rs (/opt/rustwide/target/debug/deps/vlen-27946b2f6b64ac8e)
[INFO] [stdout] running 0 tests
[INFO] [stderr]      Running tests/property_tests.rs (/opt/rustwide/target/debug/deps/property_tests-42c6ec7fdf420e51)
[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] [stdout] 
[INFO] [stdout] running 35 tests
[INFO] [stdout] test test_bulk_encode_decode_mixed_types ... ok
[INFO] [stdout] test test_buffer_overflow_handling ... ok
[INFO] [stdout] test test_i128_round_trip ... ok
[INFO] [stdout] test test_f64_round_trip ... ok
[INFO] [stdout] test test_compression_efficiency_u32 ... ok
[INFO] [stdout] test test_edge_case_values ... ok
[INFO] [stdout] test test_bulk_encode_decode_round_trip ... ok
[INFO] [stdout] test test_floating_point_subnormal_handling ... ok
[INFO] [stdout] test test_i128_compression_efficiency ... ok
[INFO] [stdout] test test_compression_efficiency_u64 ... ok
[INFO] [stdout] test test_i128_size_bounds ... ok
[INFO] [stdout] test test_floating_point_infinity_handling ... ok
[INFO] [stdout] test test_f32_round_trip ... ok
[INFO] [stdout] test test_i32_round_trip ... ok
[INFO] [stdout] test test_i16_round_trip ... ok
[INFO] [stdout] test test_floating_point_byte_swapping ... ok
[INFO] [stdout] test test_i64_round_trip ... ok
[INFO] [stdout] test test_u128_round_trip ... ok
[INFO] [stdout] test test_signed_integer_sign_preservation ... ok
[INFO] [stdout] test test_u128_size_bounds ... ok
[INFO] [stdout] test test_truncated_data_handling ... ok
[INFO] [stdout] test test_invalid_prefix_handling ... ok
[INFO] [stdout] test test_u128_encoded_size_consistency ... ok
[INFO] [stdout] test test_u16_round_trip ... ok
[INFO] [stdout] test test_little_endian_encoding ... ok
[INFO] [stdout] test test_u16_size_bounds ... ok
[INFO] [stdout] test test_u16_encoded_size_consistency ... ok
[INFO] [stdout] test test_u32_encoded_size_consistency ... ok
[INFO] [stdout] test test_u32_round_trip ... ok
[INFO] [stdout] test test_u32_prefix_consistency ... ok
[INFO] [stdout] test test_u32_size_bounds ... ok
[INFO] [stdout] test test_signed_integer_zigzag_encoding ... ok
[INFO] [stdout] test test_u64_size_bounds ... ok
[INFO] [stdout] test test_u64_round_trip ... ok
[INFO] [stdout] test test_u64_encoded_size_consistency ... ok
[INFO] [stderr]      Running tests/serde_tests.rs (/opt/rustwide/target/debug/deps/serde_tests-0123cb138c31db5a)
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 35 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.46s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test test_serde_feature_gate ... 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] [stderr]      Running tests/tests.rs (/opt/rustwide/target/debug/deps/tests-5fb43ca6bbc88bd6)
[INFO] [stdout] 
[INFO] [stdout] running 28 tests
[INFO] [stdout] test test_buffer_size_errors ... ok
[INFO] [stdout] test test_decode_f32 ... ok
[INFO] [stdout] test test_decode_f64 ... ok
[INFO] [stdout] test test_decode_i128 ... ok
[INFO] [stdout] test test_decode_i16 ... ok
[INFO] [stdout] test test_decode_i32 ... ok
[INFO] [stdout] test test_decode_u32 ... ok
[INFO] [stdout] test test_decode_u16 ... ok
[INFO] [stdout] test test_encode_f32 ... ok
[INFO] [stdout] test test_decode_i64 ... ok
[INFO] [stdout] test test_encode_f64 ... ok
[INFO] [stdout] test test_encode_i128 ... ok
[INFO] [stdout] test test_decode_u128 ... ok
[INFO] [stdout] test test_decode_value ... ok
[INFO] [stdout] test test_decode_u64 ... ok
[INFO] [stdout] test test_encode_i32 ... ok
[INFO] [stdout] test test_encode_i64 ... ok
[INFO] [stdout] test test_encode_u128 ... ok
[INFO] [stdout] test test_encode_u16 ... ok
[INFO] [stdout] test test_encode_u64 ... ok
[INFO] [stdout] test test_generic_encode_decode ... ok
[INFO] [stdout] test test_generic_encoded_size ... ok
[INFO] [stdout] test test_encode_i16 ... ok
[INFO] [stdout] test test_overlong_encodings_u16 ... ok
[INFO] [stdout] test test_encode_u32 ... ok
[INFO] [stdout] test test_overlong_encodings ... ok
[INFO] [stdout] test test_generic_bulk_operations ... ok
[INFO] [stderr]    Doc-tests vlen
[INFO] [stdout] test test_manual_vs_bulk_encoding ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 28 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test vlen/mod.rs - (line 12) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.18s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "6578b51cb8eac5cae9aef8a5fb26d583dafbb47e630b27778abb70128d8d5cc8", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "6578b51cb8eac5cae9aef8a5fb26d583dafbb47e630b27778abb70128d8d5cc8", kill_on_drop: false }`
[INFO] [stdout] 6578b51cb8eac5cae9aef8a5fb26d583dafbb47e630b27778abb70128d8d5cc8