[INFO] fetching crate google-datafusion1 3.0.0+20211028...
[INFO] testing google-datafusion1-3.0.0+20211028 against 1.60.0 for beta-1.61-1
[INFO] extracting crate google-datafusion1 3.0.0+20211028 into /workspace/builds/worker-5/source
[INFO] validating manifest of crates.io crate google-datafusion1 3.0.0+20211028 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 google-datafusion1 3.0.0+20211028
[INFO] finished tweaking crates.io crate google-datafusion1 3.0.0+20211028
[INFO] tweaked toml for crates.io crate google-datafusion1 3.0.0+20211028 written to /workspace/builds/worker-5/source/Cargo.toml
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.60.0" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update", kill_on_drop: false }`
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.60.0" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/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] 7d4283693ab47b50f76421ac407c6e8391fc4ceed1a39f301e47d2522cd7752d
[INFO] running `Command { std: "docker" "start" "-a" "7d4283693ab47b50f76421ac407c6e8391fc4ceed1a39f301e47d2522cd7752d", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "7d4283693ab47b50f76421ac407c6e8391fc4ceed1a39f301e47d2522cd7752d", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "7d4283693ab47b50f76421ac407c6e8391fc4ceed1a39f301e47d2522cd7752d", kill_on_drop: false }`
[INFO] [stdout] 7d4283693ab47b50f76421ac407c6e8391fc4ceed1a39f301e47d2522cd7752d
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/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] 72d4d91a8c8345a74af472819ff1ee3a749ea7cfc8bb70b9da51b9ed7c8d8820
[INFO] running `Command { std: "docker" "start" "-a" "72d4d91a8c8345a74af472819ff1ee3a749ea7cfc8bb70b9da51b9ed7c8d8820", kill_on_drop: false }`
[INFO] [stderr]    Compiling google-datafusion1 v3.0.0+20211028 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2.37s
[INFO] running `Command { std: "docker" "inspect" "72d4d91a8c8345a74af472819ff1ee3a749ea7cfc8bb70b9da51b9ed7c8d8820", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "72d4d91a8c8345a74af472819ff1ee3a749ea7cfc8bb70b9da51b9ed7c8d8820", kill_on_drop: false }`
[INFO] [stdout] 72d4d91a8c8345a74af472819ff1ee3a749ea7cfc8bb70b9da51b9ed7c8d8820
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/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] e450744236537f84430513f9ed47c9bf3039b7a25af767c1c5cb20095f660227
[INFO] running `Command { std: "docker" "start" "-a" "e450744236537f84430513f9ed47c9bf3039b7a25af767c1c5cb20095f660227", kill_on_drop: false }`
[INFO] [stderr]    Compiling google-datafusion1 v3.0.0+20211028 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 1.66s
[INFO] running `Command { std: "docker" "inspect" "e450744236537f84430513f9ed47c9bf3039b7a25af767c1c5cb20095f660227", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "e450744236537f84430513f9ed47c9bf3039b7a25af767c1c5cb20095f660227", kill_on_drop: false }`
[INFO] [stdout] e450744236537f84430513f9ed47c9bf3039b7a25af767c1c5cb20095f660227
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/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] e9555cd4a1595250878ea88455fed92a637f5c04c4f7c3dd915a60f9d9a6984a
[INFO] running `Command { std: "docker" "start" "-a" "e9555cd4a1595250878ea88455fed92a637f5c04c4f7c3dd915a60f9d9a6984a", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.05s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/google_datafusion1-7120b5f209f95fdd)
[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] [stderr]    Doc-tests google-datafusion1
[INFO] [stdout] 
[INFO] [stdout] running 20 tests
[INFO] [stdout] test src/lib.rs - (line 49) ... ignored
[INFO] [stdout] test src/api.rs - api::ProjectMethods (line 698) - compile ... ok
[INFO] [stdout] test src/api.rs - api::ProjectLocationInstanceSetIamPolicyCall (line 3014) - compile ... ok
[INFO] [stdout] test src/api.rs - api::ProjectLocationInstanceDeleteCall (line 1346) - compile ... ok
[INFO] [stdout] test src/api.rs - api::ProjectLocationInstanceGetIamPolicyCall (line 1858) - compile ... ok
[INFO] [stdout] test src/api.rs - api::ProjectLocationInstanceGetCall (line 1602) - compile ... ok
[INFO] [stdout] test src/api.rs - api::ProjectLocationOperationDeleteCall (line 3872) - compile ... ok
[INFO] [stdout] test src/api.rs - api::ProjectLocationGetCall (line 4968) - compile ... ok
[INFO] [stdout] test src/api.rs - api::ProjectLocationListCall (line 5224) - compile ... ok
[INFO] [stdout] test src/api.rs - api::ProjectLocationInstanceRestartCall (line 2728) - compile ... ok
[INFO] [stdout] test src/api.rs - api::ProjectLocationOperationGetCall (line 4128) - compile ... ok
[INFO] [stdout] test src/api.rs - api::ProjectLocationOperationListCall (line 4384) - compile ... ok
[INFO] [stdout] test src/api.rs - api::DataFusion (line 52) - compile ... ok
[INFO] [stdout] test src/api.rs - api::ProjectLocationInstancePatchCall (line 2430) - compile ... ok
[INFO] [stdout] test src/api.rs - api::ProjectLocationInstanceListCall (line 2126) - compile ... ok
[INFO] [stdout] test src/lib.rs - (line 77) - compile ... ok
[INFO] [stdout] test src/api.rs - api::ProjectLocationOperationCancelCall (line 3586) - compile ... ok
[INFO] [stdout] test src/api.rs - api::ProjectLocationInstanceTestIamPermissionCall (line 3300) - compile ... ok
[INFO] [stdout] test src/api.rs - api::ProjectLocationInstanceCreateCall (line 1048) - compile ... ok
[INFO] [stdout] test src/api.rs - api::ProjectLocationVersionListCall (line 4676) - compile ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 19 passed; 0 failed; 1 ignored; 0 measured; 0 filtered out; finished in 0.16s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "e9555cd4a1595250878ea88455fed92a637f5c04c4f7c3dd915a60f9d9a6984a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "e9555cd4a1595250878ea88455fed92a637f5c04c4f7c3dd915a60f9d9a6984a", kill_on_drop: false }`
[INFO] [stdout] e9555cd4a1595250878ea88455fed92a637f5c04c4f7c3dd915a60f9d9a6984a