[INFO] fetching crate nrbf 0.2.2...
[INFO] testing nrbf-0.2.2 against master#cdb45c87e2cd43495379f7e867e3cc15dcee9f93 for pr-145838-1
[INFO] extracting crate nrbf 0.2.2 into /workspace/builds/worker-0-tc1/source
[INFO] started tweaking crates.io crate nrbf 0.2.2
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate nrbf 0.2.2
[INFO] tweaked toml for crates.io crate nrbf 0.2.2 written to /workspace/builds/worker-0-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate nrbf 0.2.2 on toolchain cdb45c87e2cd43495379f7e867e3cc15dcee9f93
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate nrbf 0.2.2 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" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 9c44edfa6d4c2b2533a0939eac1e793f1e24f191cb66fd75cf0f2d4371b4af52
[INFO] running `Command { std: "docker" "start" "-a" "9c44edfa6d4c2b2533a0939eac1e793f1e24f191cb66fd75cf0f2d4371b4af52", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "9c44edfa6d4c2b2533a0939eac1e793f1e24f191cb66fd75cf0f2d4371b4af52", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "9c44edfa6d4c2b2533a0939eac1e793f1e24f191cb66fd75cf0f2d4371b4af52", kill_on_drop: false }`
[INFO] [stdout] 9c44edfa6d4c2b2533a0939eac1e793f1e24f191cb66fd75cf0f2d4371b4af52
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 472d4b5483595d3aa0730023a53ccd1dd7bbbf78aeb621ea2d8737943908ddb0
[INFO] running `Command { std: "docker" "start" "-a" "472d4b5483595d3aa0730023a53ccd1dd7bbbf78aeb621ea2d8737943908ddb0", kill_on_drop: false }`
[INFO] [stderr]    Compiling rust_decimal v1.36.0
[INFO] [stderr]    Compiling arrayvec v0.7.6
[INFO] [stderr]    Compiling bitflags v2.9.0
[INFO] [stderr]    Compiling nom v8.0.0
[INFO] [stderr]    Compiling nrbf v0.2.2 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 5.14s
[INFO] running `Command { std: "docker" "inspect" "472d4b5483595d3aa0730023a53ccd1dd7bbbf78aeb621ea2d8737943908ddb0", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "472d4b5483595d3aa0730023a53ccd1dd7bbbf78aeb621ea2d8737943908ddb0", kill_on_drop: false }`
[INFO] [stdout] 472d4b5483595d3aa0730023a53ccd1dd7bbbf78aeb621ea2d8737943908ddb0
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 6af12ecda124035876e7c87b87c5e49e7e5ec64694a2947b83d36b83fbb442a9
[INFO] running `Command { std: "docker" "start" "-a" "6af12ecda124035876e7c87b87c5e49e7e5ec64694a2947b83d36b83fbb442a9", kill_on_drop: false }`
[INFO] [stderr]    Compiling const-str v0.6.2
[INFO] [stderr]    Compiling nrbf v0.2.2 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 3.38s
[INFO] running `Command { std: "docker" "inspect" "6af12ecda124035876e7c87b87c5e49e7e5ec64694a2947b83d36b83fbb442a9", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "6af12ecda124035876e7c87b87c5e49e7e5ec64694a2947b83d36b83fbb442a9", kill_on_drop: false }`
[INFO] [stdout] 6af12ecda124035876e7c87b87c5e49e7e5ec64694a2947b83d36b83fbb442a9
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 16b921667780589023e732fc8d808725e79d3839728b1a824e3c50d5955a563f
[INFO] running `Command { std: "docker" "start" "-a" "16b921667780589023e732fc8d808725e79d3839728b1a824e3c50d5955a563f", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.04s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/nrbf-3db2c332ff279117)
[INFO] [stdout] 
[INFO] [stdout] running 5 tests
[INFO] [stdout] test data_type::length_prefixed_string::tests::length_2147483647 ... ignored, needs too much memory
[INFO] [stdout] test data_type::length_prefixed_string::tests::length_127 ... ok
[INFO] [stdout] test data_type::length_prefixed_string::tests::length_16383 ... ok
[INFO] [stdout] test data_type::length_prefixed_string::tests::length_2097151 ... ok
[INFO] [stderr]      Running tests/array_single_primitive.rs (/opt/rustwide/target/debug/deps/array_single_primitive-6b756003ffc959c8)
[INFO] [stdout] test data_type::length_prefixed_string::tests::length_268435455 ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 4 passed; 0 failed; 1 ignored; 0 measured; 0 filtered out; finished in 0.67s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test array_single_primitive ... 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/array_single_string.rs (/opt/rustwide/target/debug/deps/array_single_string-2639851461d38dd3)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test array_single_string ... 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/binary_array_jagged.rs (/opt/rustwide/target/debug/deps/binary_array_jagged-5d4993d3417798c6)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test binary_array_jagged ... 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/binary_array_jagged_offset.rs (/opt/rustwide/target/debug/deps/binary_array_jagged_offset-8c360a36894e9505)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test binary_array_jagged_offset ... 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/binary_array_rectangular.rs (/opt/rustwide/target/debug/deps/binary_array_rectangular-146a0a524b6541eb)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test binary_array_rectangular ... 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/binary_array_rectangular_offset.rs (/opt/rustwide/target/debug/deps/binary_array_rectangular_offset-4dcb987773dc4858)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test binary_array_rectangular_offset ... 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/binary_array_single_offset.rs (/opt/rustwide/target/debug/deps/binary_array_single_offset-fde9da0a5d572bd3)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test binary_array_single_offset ... 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/boolean.rs (/opt/rustwide/target/debug/deps/boolean-c8acfff8f6ebba48)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test boolean ... 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/byte.rs (/opt/rustwide/target/debug/deps/byte-820924cfbaae1bf8)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test byte ... 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/double.rs (/opt/rustwide/target/debug/deps/double-9f0aae160bb2b37b)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test double ... 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/int16.rs (/opt/rustwide/target/debug/deps/int16-80c89521846bf6f4)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test int16 ... 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/int32.rs (/opt/rustwide/target/debug/deps/int32-df4fb4b4510062b3)
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test int32_starts_with_binary_library_record_type ... ok
[INFO] [stdout] test int32 ... ok
[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] [stderr]      Running tests/int64.rs (/opt/rustwide/target/debug/deps/int64-e5eb2d7a74bfbd87)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test int64 ... 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/list_of_customers.rs (/opt/rustwide/target/debug/deps/list_of_customers-740f9ec83bc6c8e3)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test list_of_customers ... 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/method_call.rs (/opt/rustwide/target/debug/deps/method_call-f9a0c706edea30c8)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test method_call ... 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/method_return.rs (/opt/rustwide/target/debug/deps/method_return-b646c0a673991ad5)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test method_return ... 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/sbyte.rs (/opt/rustwide/target/debug/deps/sbyte-dc84b714860a3630)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test sbyte ... 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/single.rs (/opt/rustwide/target/debug/deps/single-012b2b90122947f5)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stderr]      Running tests/string.rs (/opt/rustwide/target/debug/deps/string-4149e8a4c76bba1b)
[INFO] [stdout] test single ... 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 2 tests
[INFO] [stdout] test string ... ok
[INFO] [stdout] test string_empty ... ok
[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] [stderr]      Running tests/uint16.rs (/opt/rustwide/target/debug/deps/uint16-e2aa15238a86633f)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stderr]      Running tests/uint32.rs (/opt/rustwide/target/debug/deps/uint32-344aaabd250afb93)
[INFO] [stdout] test uint16 ... 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 1 test
[INFO] [stdout] test uint32 ... 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/uint64.rs (/opt/rustwide/target/debug/deps/uint64-dd98c6f6a3d334dd)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test uint32 ... 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]    Doc-tests nrbf
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test src/remoting_message.rs - remoting_message::RemotingMessage (line 39) ... 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] running `Command { std: "docker" "inspect" "16b921667780589023e732fc8d808725e79d3839728b1a824e3c50d5955a563f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "16b921667780589023e732fc8d808725e79d3839728b1a824e3c50d5955a563f", kill_on_drop: false }`
[INFO] [stdout] 16b921667780589023e732fc8d808725e79d3839728b1a824e3c50d5955a563f