[INFO] fetching crate slog-bunyan 2.5.0...
[INFO] testing slog-bunyan-2.5.0 against master#562dee4820c458d823175268e41601d4c060588a for pr-154210-1
[INFO] extracting crate slog-bunyan 2.5.0 into /workspace/builds/worker-7-tc1/source
[INFO] started tweaking crates.io crate slog-bunyan 2.5.0
[INFO] finished tweaking crates.io crate slog-bunyan 2.5.0
[INFO] tweaked toml for crates.io crate slog-bunyan 2.5.0 written to /workspace/builds/worker-7-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate slog-bunyan 2.5.0 on toolchain 562dee4820c458d823175268e41601d4c060588a
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "generate-lockfile" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]      Locking 29 packages to latest compatible versions
[INFO] [stderr]       Adding hostname v0.3.1 (available: v0.4.2)
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded slog-json v2.6.1
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 970a91343743c28eefb4d7c11e9698bdb1146ce31327b697afadd6b9e09c7a2b
[INFO] running `Command { std: "docker" "start" "-a" "970a91343743c28eefb4d7c11e9698bdb1146ce31327b697afadd6b9e09c7a2b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "970a91343743c28eefb4d7c11e9698bdb1146ce31327b697afadd6b9e09c7a2b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "970a91343743c28eefb4d7c11e9698bdb1146ce31327b697afadd6b9e09c7a2b", kill_on_drop: false }`
[INFO] [stdout] 970a91343743c28eefb4d7c11e9698bdb1146ce31327b697afadd6b9e09c7a2b
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 25a4a070676894aa6706dd31301ecd0b7d4ee8d9bf80fa1bbed1d95cf9fe412a
[INFO] running `Command { std: "docker" "start" "-a" "25a4a070676894aa6706dd31301ecd0b7d4ee8d9bf80fa1bbed1d95cf9fe412a", kill_on_drop: false }`
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling num-conv v0.2.1
[INFO] [stderr]    Compiling time-core v0.1.8
[INFO] [stderr]    Compiling slog v2.8.2
[INFO] [stderr]    Compiling deranged v0.5.8
[INFO] [stderr]    Compiling num_threads v0.1.7
[INFO] [stderr]    Compiling match_cfg v0.1.0
[INFO] [stderr]    Compiling hostname v0.3.1
[INFO] [stderr]    Compiling time-macros v0.2.27
[INFO] [stderr]    Compiling erased-serde v0.3.31
[INFO] [stderr]    Compiling time v0.3.47
[INFO] [stderr]    Compiling slog-json v2.6.1
[INFO] [stderr]    Compiling slog-bunyan v2.5.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 5.61s
[INFO] running `Command { std: "docker" "inspect" "25a4a070676894aa6706dd31301ecd0b7d4ee8d9bf80fa1bbed1d95cf9fe412a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "25a4a070676894aa6706dd31301ecd0b7d4ee8d9bf80fa1bbed1d95cf9fe412a", kill_on_drop: false }`
[INFO] [stdout] 25a4a070676894aa6706dd31301ecd0b7d4ee8d9bf80fa1bbed1d95cf9fe412a
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 590bb6852c6a80f2169996477f3227bc1a272223756079ad27de46941a6fc326
[INFO] running `Command { std: "docker" "start" "-a" "590bb6852c6a80f2169996477f3227bc1a272223756079ad27de46941a6fc326", kill_on_drop: false }`
[INFO] [stderr]    Compiling slog-bunyan v2.5.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.94s
[INFO] running `Command { std: "docker" "inspect" "590bb6852c6a80f2169996477f3227bc1a272223756079ad27de46941a6fc326", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "590bb6852c6a80f2169996477f3227bc1a272223756079ad27de46941a6fc326", kill_on_drop: false }`
[INFO] [stdout] 590bb6852c6a80f2169996477f3227bc1a272223756079ad27de46941a6fc326
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 3eeef023efa16994696605cfe4760ee7a08f72da82318f03c7474ee9205d150c
[INFO] running `Command { std: "docker" "start" "-a" "3eeef023efa16994696605cfe4760ee7a08f72da82318f03c7474ee9205d150c", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.06s
[INFO] [stderr]      Running unittests lib.rs (/opt/rustwide/target/debug/deps/slog_bunyan-57ca35fe0548cca6)
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test test::custom_name_field ... ok
[INFO] [stdout] test test::trivial ... 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]    Doc-tests slog_bunyan
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test lib.rs - (line 3) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.51s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "3eeef023efa16994696605cfe4760ee7a08f72da82318f03c7474ee9205d150c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "3eeef023efa16994696605cfe4760ee7a08f72da82318f03c7474ee9205d150c", kill_on_drop: false }`
[INFO] [stdout] 3eeef023efa16994696605cfe4760ee7a08f72da82318f03c7474ee9205d150c