[INFO] fetching crate timeit 0.1.2...
[INFO] building timeit-0.1.2 against try#d5c88c22807925c189328ef9d923c5d2b11a95b8+rustflags=-Zprofile-closures for pr-87066-3
[INFO] extracting crate timeit 0.1.2 into /workspace/builds/worker-94/source
[INFO] validating manifest of crates.io crate timeit 0.1.2 on toolchain d5c88c22807925c189328ef9d923c5d2b11a95b8
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+d5c88c22807925c189328ef9d923c5d2b11a95b8" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate timeit 0.1.2
[INFO] finished tweaking crates.io crate timeit 0.1.2
[INFO] tweaked toml for crates.io crate timeit 0.1.2 written to /workspace/builds/worker-94/source/Cargo.toml
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+d5c88c22807925c189328ef9d923c5d2b11a95b8" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update", kill_on_drop: false }`
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+d5c88c22807925c189328ef9d923c5d2b11a95b8" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-94/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-94/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:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+d5c88c22807925c189328ef9d923c5d2b11a95b8" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] f331239abd6a2b2eedf1ab9f35c7c76f0b02e8bc6d5a89ff81ee1f6b47c12442
[INFO] running `Command { std: "docker" "start" "-a" "f331239abd6a2b2eedf1ab9f35c7c76f0b02e8bc6d5a89ff81ee1f6b47c12442", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "f331239abd6a2b2eedf1ab9f35c7c76f0b02e8bc6d5a89ff81ee1f6b47c12442", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "f331239abd6a2b2eedf1ab9f35c7c76f0b02e8bc6d5a89ff81ee1f6b47c12442", kill_on_drop: false }`
[INFO] [stdout] f331239abd6a2b2eedf1ab9f35c7c76f0b02e8bc6d5a89ff81ee1f6b47c12442
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-94/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-94/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 -Zprofile-closures" "-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:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+d5c88c22807925c189328ef9d923c5d2b11a95b8" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] a122037671b4abb6e061628d162402ba6ac6ea8ddc8b44741cfe6a32c5abfff5
[INFO] running `Command { std: "docker" "start" "-a" "a122037671b4abb6e061628d162402ba6ac6ea8ddc8b44741cfe6a32c5abfff5", kill_on_drop: false }`
[INFO] [stderr] SG_CR_Eslkdjf: build_script_build, (75b84863966839e5, 8a92c743b00988cf), 0, 0
[INFO] [stderr] SG_CR_Eslkdjf: time, (138085e056a270f6, 13f188afb496dab5), 8, 8
[INFO] [stderr] SG_CR_Eslkdjf: time, (ab27881b1d952734, b4608fc61bb51f02), 16, 16
[INFO] [stderr] SG_CR_Eslkdjf: time, (58279649268ddf39, fea2741e190b85b2), 8, 8
[INFO] [stderr] SG_CR_Eslkdjf: time, (dcc347125b202c60, a86e2941fdc6fc0e), 16, 16
[INFO] [stderr] SG_CR_Eslkdjf: time, (2c250627461396ef, c0d51850912ff286), 8, 8
[INFO] [stderr] SG_CR_Eslkdjf: time, (de65972c6c48e96, b06d52701aae0214), 16, 16
[INFO] [stderr] SG_CR_Eslkdjf: time, (23399ecd55d29399, 580ce22a972ce8d1), 8, 8
[INFO] [stderr] SG_CR_Eslkdjf: time, (70f138978b6de95b, 81437fb899433f03), 16, 16
[INFO] [stderr] SG_CR_Eslkdjf: time, (a8947dfdf7446d3a, b5da497bbf632415), 8, 8
[INFO] [stderr] SG_CR_Eslkdjf: time, (f7a54098d338807c, 33f324978a4b46b3), 16, 16
[INFO] [stderr] SG_CR_Eslkdjf: time, (3d7c0d999da1ba64, cd785a73321429e6), 8, 8
[INFO] [stderr] SG_CR_Eslkdjf: time, (2991ac7eee33b7d3, 6de5b1049729bba8), 16, 16
[INFO] [stderr] SG_CR_Eslkdjf: time, (96f9ccc74a649054, 4ec8ed49b6573d84), 8, 8
[INFO] [stderr] SG_CR_Eslkdjf: time, (22f962830f6d6fc, 4d429a3ce3d11dfd), 16, 16
[INFO] [stderr] SG_CR_Eslkdjf: time, (41cfa6f38dfac18a, 52f6e0bdc70a0eb0), 8, 8
[INFO] [stderr] SG_CR_Eslkdjf: time, (3aea8b67b39d444d, e421ada6eb94958d), 16, 16
[INFO] [stderr] SG_CR_Eslkdjf: time, (397b46221c694a86, 72fce51e181522e), 8, 8
[INFO] [stderr] SG_CR_Eslkdjf: time, (52b79db17c590896, 8e82b1db2dc8bf67), 16, 16
[INFO] [stderr] SG_CR_Eslkdjf: time, (1e86a29f27607a6c, cec43fd4558afc6c), 8, 8
[INFO] [stderr] SG_CR_Eslkdjf: time, (21b0e10557808477, 298224d9a7a19c8c), 16, 16
[INFO] [stderr] SG_CR_Eslkdjf: time, (9ef07066f863ad4d, 23adf36ed2413e91), 8, 8
[INFO] [stderr] SG_CR_Eslkdjf: time, (a08ac9f66eb959e5, 304a9c81e4d0f978), 16, 16
[INFO] [stderr] SG_CR_Eslkdjf: time, (facb33abd0ea176e, d45824f206e3c8fa), 8, 8
[INFO] [stderr] SG_CR_Eslkdjf: time, (833bdf8974a08040, 701a4e1dcb5b6294), 16, 16
[INFO] [stderr] SG_CR_Eslkdjf: time, (ae9fd7a17906a4cb, 397bed7408cbe9a7), 8, 8
[INFO] [stderr] SG_CR_Eslkdjf: time, (86d078c6ae428e74, 2fcc5bcc11e9162f), 16, 16
[INFO] [stderr] SG_CR_Eslkdjf: time, (479b68a6428392e8, fc44c32c1c347898), 8, 8
[INFO] [stderr] SG_CR_Eslkdjf: time, (34b4930610ab3b30, 96a5cfc1ced13d20), 16, 16
[INFO] [stderr] SG_CR_Eslkdjf: time, (884916f06251a717, 7e366846c901914), 8, 8
[INFO] [stderr] SG_CR_Eslkdjf: time, (1a66039006152580, 50a3a6d04ab3fded), 16, 16
[INFO] [stderr] SG_CR_Eslkdjf: time, (ef7be2b5e0bc14f5, 6b3595ceedd6c3b6), 8, 8
[INFO] [stderr] SG_CR_Eslkdjf: time, (cd3ffa83d5add1c0, 75441c476f60fc86), 16, 16
[INFO] [stderr] SG_CR_Eslkdjf: time, (80513e3d241d83d0, 1906fff752681e77), 0, 0
[INFO] [stderr]    Compiling timeit v0.1.2 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.20s
[INFO] running `Command { std: "docker" "inspect" "a122037671b4abb6e061628d162402ba6ac6ea8ddc8b44741cfe6a32c5abfff5", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "a122037671b4abb6e061628d162402ba6ac6ea8ddc8b44741cfe6a32c5abfff5", kill_on_drop: false }`
[INFO] [stdout] a122037671b4abb6e061628d162402ba6ac6ea8ddc8b44741cfe6a32c5abfff5
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-94/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-94/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 -Zprofile-closures" "-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:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+d5c88c22807925c189328ef9d923c5d2b11a95b8" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 4fe592cd9d9430f2f2da25433cb4ad067a8c4c210be5e38c8aade0fe7036c2bf
[INFO] running `Command { std: "docker" "start" "-a" "4fe592cd9d9430f2f2da25433cb4ad067a8c4c210be5e38c8aade0fe7036c2bf", kill_on_drop: false }`
[INFO] [stderr] SG_CR_Eslkdjf: build_script_build, (75b84863966839e5, 8a92c743b00988cf), 0, 0
[INFO] [stderr] SG_CR_Eslkdjf: time, (138085e056a270f6, 13f188afb496dab5), 8, 8
[INFO] [stderr] SG_CR_Eslkdjf: time, (ab27881b1d952734, b4608fc61bb51f02), 16, 16
[INFO] [stderr] SG_CR_Eslkdjf: time, (58279649268ddf39, fea2741e190b85b2), 8, 8
[INFO] [stderr] SG_CR_Eslkdjf: time, (dcc347125b202c60, a86e2941fdc6fc0e), 16, 16
[INFO] [stderr] SG_CR_Eslkdjf: time, (2c250627461396ef, c0d51850912ff286), 8, 8
[INFO] [stderr] SG_CR_Eslkdjf: time, (de65972c6c48e96, b06d52701aae0214), 16, 16
[INFO] [stderr] SG_CR_Eslkdjf: time, (23399ecd55d29399, 580ce22a972ce8d1), 8, 8
[INFO] [stderr] SG_CR_Eslkdjf: time, (70f138978b6de95b, 81437fb899433f03), 16, 16
[INFO] [stderr] SG_CR_Eslkdjf: time, (a8947dfdf7446d3a, b5da497bbf632415), 8, 8
[INFO] [stderr] SG_CR_Eslkdjf: time, (f7a54098d338807c, 33f324978a4b46b3), 16, 16
[INFO] [stderr] SG_CR_Eslkdjf: time, (3d7c0d999da1ba64, cd785a73321429e6), 8, 8
[INFO] [stderr] SG_CR_Eslkdjf: time, (2991ac7eee33b7d3, 6de5b1049729bba8), 16, 16
[INFO] [stderr] SG_CR_Eslkdjf: time, (96f9ccc74a649054, 4ec8ed49b6573d84), 8, 8
[INFO] [stderr] SG_CR_Eslkdjf: time, (22f962830f6d6fc, 4d429a3ce3d11dfd), 16, 16
[INFO] [stderr] SG_CR_Eslkdjf: time, (41cfa6f38dfac18a, 52f6e0bdc70a0eb0), 8, 8
[INFO] [stderr] SG_CR_Eslkdjf: time, (3aea8b67b39d444d, e421ada6eb94958d), 16, 16
[INFO] [stderr] SG_CR_Eslkdjf: time, (397b46221c694a86, 72fce51e181522e), 8, 8
[INFO] [stderr] SG_CR_Eslkdjf: time, (52b79db17c590896, 8e82b1db2dc8bf67), 16, 16
[INFO] [stderr] SG_CR_Eslkdjf: time, (1e86a29f27607a6c, cec43fd4558afc6c), 8, 8
[INFO] [stderr] SG_CR_Eslkdjf: time, (21b0e10557808477, 298224d9a7a19c8c), 16, 16
[INFO] [stderr] SG_CR_Eslkdjf: time, (9ef07066f863ad4d, 23adf36ed2413e91), 8, 8
[INFO] [stderr] SG_CR_Eslkdjf: time, (a08ac9f66eb959e5, 304a9c81e4d0f978), 16, 16
[INFO] [stderr] SG_CR_Eslkdjf: time, (facb33abd0ea176e, d45824f206e3c8fa), 8, 8
[INFO] [stderr] SG_CR_Eslkdjf: time, (833bdf8974a08040, 701a4e1dcb5b6294), 16, 16
[INFO] [stderr] SG_CR_Eslkdjf: time, (ae9fd7a17906a4cb, 397bed7408cbe9a7), 8, 8
[INFO] [stderr] SG_CR_Eslkdjf: time, (86d078c6ae428e74, 2fcc5bcc11e9162f), 16, 16
[INFO] [stderr] SG_CR_Eslkdjf: time, (479b68a6428392e8, fc44c32c1c347898), 8, 8
[INFO] [stderr] SG_CR_Eslkdjf: time, (34b4930610ab3b30, 96a5cfc1ced13d20), 16, 16
[INFO] [stderr] SG_CR_Eslkdjf: time, (884916f06251a717, 7e366846c901914), 8, 8
[INFO] [stderr] SG_CR_Eslkdjf: time, (1a66039006152580, 50a3a6d04ab3fded), 16, 16
[INFO] [stderr] SG_CR_Eslkdjf: time, (ef7be2b5e0bc14f5, 6b3595ceedd6c3b6), 8, 8
[INFO] [stderr] SG_CR_Eslkdjf: time, (cd3ffa83d5add1c0, 75441c476f60fc86), 16, 16
[INFO] [stderr] SG_CR_Eslkdjf: time, (80513e3d241d83d0, 1906fff752681e77), 0, 0
[INFO] [stderr]    Compiling timeit v0.1.2 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.53s
[INFO] running `Command { std: "docker" "inspect" "4fe592cd9d9430f2f2da25433cb4ad067a8c4c210be5e38c8aade0fe7036c2bf", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "4fe592cd9d9430f2f2da25433cb4ad067a8c4c210be5e38c8aade0fe7036c2bf", kill_on_drop: false }`
[INFO] [stdout] 4fe592cd9d9430f2f2da25433cb4ad067a8c4c210be5e38c8aade0fe7036c2bf