[INFO] fetching crate borsh 0.9.3...
[INFO] testing borsh-0.9.3 against 1.60.0 for beta-1.61-1
[INFO] extracting crate borsh 0.9.3 into /workspace/builds/worker-22/source
[INFO] validating manifest of crates.io crate borsh 0.9.3 on toolchain 1.60.0
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.60.0" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate borsh 0.9.3
[INFO] finished tweaking crates.io crate borsh 0.9.3
[INFO] tweaked toml for crates.io crate borsh 0.9.3 written to /workspace/builds/worker-22/source/Cargo.toml
[INFO] crate crates.io crate borsh 0.9.3 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.60.0" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-22/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-22/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:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+1.60.0" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 7ddb3dfd910a5546b29ef0b996aaebeae7366335ba80d747e64afe3e2588979d
[INFO] running `Command { std: "docker" "start" "-a" "7ddb3dfd910a5546b29ef0b996aaebeae7366335ba80d747e64afe3e2588979d", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "7ddb3dfd910a5546b29ef0b996aaebeae7366335ba80d747e64afe3e2588979d", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "7ddb3dfd910a5546b29ef0b996aaebeae7366335ba80d747e64afe3e2588979d", kill_on_drop: false }`
[INFO] [stdout] 7ddb3dfd910a5546b29ef0b996aaebeae7366335ba80d747e64afe3e2588979d
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-22/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-22/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=warn" "-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:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+1.60.0" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 88b55e4e9cdf5af5b31ea85434b5d78c9f70746de8b3ba620dd303bafddbbabc
[INFO] running `Command { std: "docker" "start" "-a" "88b55e4e9cdf5af5b31ea85434b5d78c9f70746de8b3ba620dd303bafddbbabc", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling proc-macro2 v1.0.36
[INFO] [stderr]    Compiling syn v1.0.86
[INFO] [stderr]    Compiling libc v0.2.117
[INFO] [stderr]    Compiling once_cell v1.9.0
[INFO] [stderr]    Compiling ahash v0.7.6
[INFO] [stderr]    Compiling toml v0.5.8
[INFO] [stderr]    Compiling proc-macro-crate v0.1.5
[INFO] [stderr]    Compiling quote v1.0.15
[INFO] [stderr]    Compiling getrandom v0.2.4
[INFO] [stderr]    Compiling hashbrown v0.11.2
[INFO] [stderr]    Compiling borsh-derive-internal v0.9.3
[INFO] [stderr]    Compiling borsh-schema-derive-internal v0.9.3
[INFO] [stderr]    Compiling borsh-derive v0.9.3
[INFO] [stderr]    Compiling borsh v0.9.3 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 29.15s
[INFO] running `Command { std: "docker" "inspect" "88b55e4e9cdf5af5b31ea85434b5d78c9f70746de8b3ba620dd303bafddbbabc", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "88b55e4e9cdf5af5b31ea85434b5d78c9f70746de8b3ba620dd303bafddbbabc", kill_on_drop: false }`
[INFO] [stdout] 88b55e4e9cdf5af5b31ea85434b5d78c9f70746de8b3ba620dd303bafddbbabc
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-22/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-22/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=warn" "-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:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+1.60.0" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 416e374b6d9493347dc41724abd2e3433cc2fdbe08e8f0b6b5f7144156b9d5df
[INFO] running `Command { std: "docker" "start" "-a" "416e374b6d9493347dc41724abd2e3433cc2fdbe08e8f0b6b5f7144156b9d5df", kill_on_drop: false }`
[INFO] [stderr]    Compiling borsh v0.9.3 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 2.18s
[INFO] running `Command { std: "docker" "inspect" "416e374b6d9493347dc41724abd2e3433cc2fdbe08e8f0b6b5f7144156b9d5df", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "416e374b6d9493347dc41724abd2e3433cc2fdbe08e8f0b6b5f7144156b9d5df", kill_on_drop: false }`
[INFO] [stdout] 416e374b6d9493347dc41724abd2e3433cc2fdbe08e8f0b6b5f7144156b9d5df
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-22/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-22/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=warn" "-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:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+1.60.0" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 9bfa3c33865528f788a704fdad47bc0f39edd792e2f8e78cfe053732e1725bfd
[INFO] running `Command { std: "docker" "start" "-a" "9bfa3c33865528f788a704fdad47bc0f39edd792e2f8e78cfe053732e1725bfd", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.03s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/borsh-df73f261c35631ca)
[INFO] [stdout] running 12 tests
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/generate_schema_schema-6fb2c1a618310f32)
[INFO] [stdout] test de::hint::tests::test_cautious_u8 ... ok
[INFO] [stderr]      Running tests/smoke.rs (/opt/rustwide/target/debug/deps/smoke-814d9d12c14aeb90)
[INFO] [stdout] test schema::tests::boxed_schema ... ok
[INFO] [stderr]      Running tests/test_arrays.rs (/opt/rustwide/target/debug/deps/test_arrays-6bdd8c0856c5e52a)
[INFO] [stdout] test schema::tests::nested_array ... ok
[INFO] [stderr]      Running tests/test_binary_heaps.rs (/opt/rustwide/target/debug/deps/test_binary_heaps-721bc169edceb7a5)
[INFO] [stdout] test schema::tests::nested_option ... ok
[INFO] [stderr]      Running tests/test_de_errors.rs (/opt/rustwide/target/debug/deps/test_de_errors-1231e4d17b5acd61)
[INFO] [stdout] test schema::tests::nested_tuple ... ok
[INFO] [stderr]      Running tests/test_generic_struct.rs (/opt/rustwide/target/debug/deps/test_generic_struct-f9a68539ef39f584)
[INFO] [stdout] test schema::tests::nested_vec ... ok
[INFO] [stderr]      Running tests/test_hash_map.rs (/opt/rustwide/target/debug/deps/test_hash_map-3e185be060ed2c82)
[INFO] [stdout] test schema::tests::simple_array ... ok
[INFO] [stderr]      Running tests/test_macro_namespace_collisions.rs (/opt/rustwide/target/debug/deps/test_macro_namespace_collisions-fe170e6cf2643045)
[INFO] [stdout] test schema::tests::simple_option ... ok
[INFO] [stderr]      Running tests/test_nonzero_integers.rs (/opt/rustwide/target/debug/deps/test_nonzero_integers-6c2f0182d0fe44b7)
[INFO] [stdout] test schema::tests::simple_map ... ok
[INFO] [stderr]      Running tests/test_rc.rs (/opt/rustwide/target/debug/deps/test_rc-ef3ffe9a9f8d49a7)
[INFO] [stdout] test schema::tests::simple_tuple ... ok
[INFO] [stderr]      Running tests/test_schema_enums.rs (/opt/rustwide/target/debug/deps/test_schema_enums-9643d5a36bf2012f)
[INFO] [stdout] test schema::tests::simple_vec ... ok
[INFO] [stderr]      Running tests/test_schema_nested.rs (/opt/rustwide/target/debug/deps/test_schema_nested-fccd1f3a68b94e1d)
[INFO] [stdout] test schema::tests::string ... ok
[INFO] [stderr]      Running tests/test_schema_structs.rs (/opt/rustwide/target/debug/deps/test_schema_structs-998c0e966a9f1065)
[INFO] [stdout] 
[INFO] [stderr]      Running tests/test_simple_structs.rs (/opt/rustwide/target/debug/deps/test_simple_structs-4f79c1f26db2e880)
[INFO] [stdout] test result: ok. 12 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stderr]      Running tests/test_strings.rs (/opt/rustwide/target/debug/deps/test_strings-1807ad590d06095c)
[INFO] [stdout] 
[INFO] [stderr]      Running tests/test_vecs.rs (/opt/rustwide/target/debug/deps/test_vecs-9d146083a885fef1)
[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] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test test_to_vec ... ok
[INFO] [stdout] test test_to_writer ... 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] [stdout] 
[INFO] [stdout] running 7 tests
[INFO] [stdout] test test_array_f32 ... ok
[INFO] [stdout] test test_array_i8 ... ok
[INFO] [stdout] test test_array_array_u8 ... ok
[INFO] [stdout] test test_array_u128 ... ok
[INFO] [stdout] test test_array_u32 ... ok
[INFO] [stdout] test test_array_u8 ... ok
[INFO] [stdout] test test_array_u64 ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 4 tests
[INFO] [stdout] test test_binary_heap_u8 ... ok
[INFO] [stdout] test test_binary_heap_i8 ... ok
[INFO] [stdout] test test_binary_heap_u32 ... ok
[INFO] [stdout] test test_binary_heap_string ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 17 tests
[INFO] [stdout] test test_evil_bytes_string_extra ... ok
[INFO] [stdout] test test_evil_bytes_vec_with_extra ... ok
[INFO] [stdout] test test_extra_bytes ... ok
[INFO] [stdout] test test_invalid_enum_variant ... ok
[INFO] [stdout] test test_invalid_bool ... ok
[INFO] [stdout] test test_invalid_length_string ... ok
[INFO] [stdout] test test_invalid_length ... ok
[INFO] [stdout] test test_missing_bytes ... ok
[INFO] [stdout] test test_non_utf_string ... ok
[INFO] [stdout] test test_nan_float ... ok
[INFO] [stdout] test test_invalid_option ... ok
[INFO] [stdout] test test_zero_on_nonzero_integer_i64 ... ok
[INFO] [stdout] test test_invalid_result ... ok
[INFO] [stdout] test test_zero_on_nonzero_integer_missing_byte ... ok
[INFO] [stdout] test test_zero_on_nonzero_integer_u32 ... ok
[INFO] [stdout] test test_zero_on_nonzero_integer_u8 ... ok
[INFO] [stdout] test test_zero_on_nonzero_integer_usize ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 17 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_generic_struct ... 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 test_default_hashmap ... ok
[INFO] [stdout] test test_generic_hash_hashmap ... 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] [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] [stdout] 
[INFO] [stdout] running 5 tests
[INFO] [stdout] test test_nonzero_integer_i16b ... ok
[INFO] [stdout] test test_nonzero_integer_i64 ... ok
[INFO] [stdout] test test_nonzero_integer_u32 ... ok
[INFO] [stdout] test test_nonzero_integer_u8 ... ok
[INFO] [stdout] test test_nonzero_integer_usize ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 5 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] [stdout] 
[INFO] [stdout] running 4 tests
[INFO] [stdout] test complex_enum_generics ... ok
[INFO] [stdout] test simple_enum ... ok
[INFO] [stdout] test single_field_enum ... ok
[INFO] [stdout] test complex_enum_with_schema ... 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 duplicated_instantiations ... 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 7 tests
[INFO] [stdout] test boxed ... ok
[INFO] [stdout] test simple_generics ... ok
[INFO] [stdout] test tuple_struct_params ... ok
[INFO] [stdout] test tuple_struct ... ok
[INFO] [stdout] test simple_struct ... ok
[INFO] [stdout] test unit_struct ... ok
[INFO] [stdout] test wrapper_struct ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 7 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_simple_struct ... 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 8 tests
[INFO] [stdout] test test_a ... ok
[INFO] [stdout] test test_hello_world ... ok
[INFO] [stdout] test test_hello_1000 ... ok
[INFO] [stdout] test test_empty_string ... ok
[INFO] [stdout] test test_non_ascii ... ok
[INFO] [stdout] test test_x_1024 ... ok
[INFO] [stdout] test test_x_4096 ... ok
[INFO] [stdout] test test_x_65535 ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 8 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 7 tests
[INFO] [stdout] test test_vec_u8 ... ok
[INFO] [stdout] test test_vec_i8 ... ok
[INFO] [stdout] test test_vec_u32 ... ok
[INFO] [stdout] test test_vec_f32 ... ok
[INFO] [stdout] test test_vec_string ... ok
[INFO] [stdout] test test_vec_vec_u8 ... ok
[INFO] [stdout] test test_vec_vec_u32 ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.08s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/test_zero_size.rs (/opt/rustwide/target/debug/deps/test_zero_size-4a6455adf8122540)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test test_deserialize_vector_to_many_zero_size_struct ... 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 borsh
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test src/ser/mod.rs - ser::BorshSerialize (line 23) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.28s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "9bfa3c33865528f788a704fdad47bc0f39edd792e2f8e78cfe053732e1725bfd", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "9bfa3c33865528f788a704fdad47bc0f39edd792e2f8e78cfe053732e1725bfd", kill_on_drop: false }`
[INFO] [stdout] 9bfa3c33865528f788a704fdad47bc0f39edd792e2f8e78cfe053732e1725bfd