[INFO] fetching crate proc-macro-api-tests 0.2.1...
[INFO] testing proc-macro-api-tests-0.2.1 against master#c90bcb9571b7aab0d8beaa2ce8a998ffaf079d38 for pr-146098-8
[INFO] extracting crate proc-macro-api-tests 0.2.1 into /workspace/builds/worker-4-tc1/source
[INFO] started tweaking crates.io crate proc-macro-api-tests 0.2.1
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate proc-macro-api-tests 0.2.1
[INFO] tweaked toml for crates.io crate proc-macro-api-tests 0.2.1 written to /workspace/builds/worker-4-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate proc-macro-api-tests 0.2.1 on toolchain c90bcb9571b7aab0d8beaa2ce8a998ffaf079d38
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+c90bcb9571b7aab0d8beaa2ce8a998ffaf079d38" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate proc-macro-api-tests 0.2.1 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" "+c90bcb9571b7aab0d8beaa2ce8a998ffaf079d38" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded proc-macro-api-test-base v0.2.2
[INFO] [stderr]   Downloaded proc-macro-api v0.1.5
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-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:4848fb76d95f26979359cc7e45710b1dbc8f3acb7aeedee7c460d7702230f228" "/opt/rustwide/cargo-home/bin/cargo" "+c90bcb9571b7aab0d8beaa2ce8a998ffaf079d38" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] e352b75787afcf123c986b3d12c78eb64bcaa4a83f8b78da28362addef046936
[INFO] running `Command { std: "docker" "start" "-a" "e352b75787afcf123c986b3d12c78eb64bcaa4a83f8b78da28362addef046936", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "e352b75787afcf123c986b3d12c78eb64bcaa4a83f8b78da28362addef046936", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "e352b75787afcf123c986b3d12c78eb64bcaa4a83f8b78da28362addef046936", kill_on_drop: false }`
[INFO] [stdout] e352b75787afcf123c986b3d12c78eb64bcaa4a83f8b78da28362addef046936
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-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:4848fb76d95f26979359cc7e45710b1dbc8f3acb7aeedee7c460d7702230f228" "/opt/rustwide/cargo-home/bin/cargo" "+c90bcb9571b7aab0d8beaa2ce8a998ffaf079d38" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] a71c163d6e9a4213e828fdc541545b46031aa5a98f8d821a1ccb9f0c8621612a
[INFO] running `Command { std: "docker" "start" "-a" "a71c163d6e9a4213e828fdc541545b46031aa5a98f8d821a1ccb9f0c8621612a", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v1.0.95
[INFO] [stderr]    Compiling proc-macro-api v0.1.5
[INFO] [stderr]    Compiling quote v1.0.40
[INFO] [stderr]    Compiling proc-macro-api-test-base v0.2.2
[INFO] [stderr]    Compiling proc-macro-api-tests v0.2.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 2.32s
[INFO] running `Command { std: "docker" "inspect" "a71c163d6e9a4213e828fdc541545b46031aa5a98f8d821a1ccb9f0c8621612a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "a71c163d6e9a4213e828fdc541545b46031aa5a98f8d821a1ccb9f0c8621612a", kill_on_drop: false }`
[INFO] [stdout] a71c163d6e9a4213e828fdc541545b46031aa5a98f8d821a1ccb9f0c8621612a
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-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:4848fb76d95f26979359cc7e45710b1dbc8f3acb7aeedee7c460d7702230f228" "/opt/rustwide/cargo-home/bin/cargo" "+c90bcb9571b7aab0d8beaa2ce8a998ffaf079d38" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 72d1b7b634f501bbdb4ad8a92c336a6f76067f8d5f89141d0e1a96aaf2e9b78a
[INFO] running `Command { std: "docker" "start" "-a" "72d1b7b634f501bbdb4ad8a92c336a6f76067f8d5f89141d0e1a96aaf2e9b78a", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v1.0.95
[INFO] [stderr]    Compiling unicode-ident v1.0.18
[INFO] [stderr]    Compiling proc-macro-api v0.1.5
[INFO] [stderr]    Compiling quote v1.0.40
[INFO] [stderr]    Compiling proc-macro-api-test-base v0.2.2
[INFO] [stderr]    Compiling proc-macro-api-tests v0.2.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 1.97s
[INFO] running `Command { std: "docker" "inspect" "72d1b7b634f501bbdb4ad8a92c336a6f76067f8d5f89141d0e1a96aaf2e9b78a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "72d1b7b634f501bbdb4ad8a92c336a6f76067f8d5f89141d0e1a96aaf2e9b78a", kill_on_drop: false }`
[INFO] [stdout] 72d1b7b634f501bbdb4ad8a92c336a6f76067f8d5f89141d0e1a96aaf2e9b78a
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-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:4848fb76d95f26979359cc7e45710b1dbc8f3acb7aeedee7c460d7702230f228" "/opt/rustwide/cargo-home/bin/cargo" "+c90bcb9571b7aab0d8beaa2ce8a998ffaf079d38" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 0a412eaf02f08bfc9212ec8c4f3cd53399a0bf05dc76072624386beb08b6f49b
[INFO] running `Command { std: "docker" "start" "-a" "0a412eaf02f08bfc9212ec8c4f3cd53399a0bf05dc76072624386beb08b6f49b", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.02s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/proc_macro_api_tests-abd1903cc7e642b8)
[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]      Running tests/normal.rs (/opt/rustwide/target/debug/deps/normal-400ccde337a5ae39)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test output ... 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 proc_macro_api_tests
[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] running `Command { std: "docker" "inspect" "0a412eaf02f08bfc9212ec8c4f3cd53399a0bf05dc76072624386beb08b6f49b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "0a412eaf02f08bfc9212ec8c4f3cd53399a0bf05dc76072624386beb08b6f49b", kill_on_drop: false }`
[INFO] [stdout] 0a412eaf02f08bfc9212ec8c4f3cd53399a0bf05dc76072624386beb08b6f49b