[INFO] cloning repository https://github.com/jacob-pro/mdbook-bibfile-referencing
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/jacob-pro/mdbook-bibfile-referencing" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fjacob-pro%2Fmdbook-bibfile-referencing", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fjacob-pro%2Fmdbook-bibfile-referencing'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] bd54476ca14f50ad8ed88bbb273c4fd80e3989b5
[INFO] checking jacob-pro/mdbook-bibfile-referencing against master#33fdb797f59421c7bbecaa4588ed5d7a31a9494a for pr-87190-3
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fjacob-pro%2Fmdbook-bibfile-referencing" "/workspace/builds/worker-66/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-66/source'...
[INFO] [stderr] done.
[INFO] validating manifest of git repo https://github.com/jacob-pro/mdbook-bibfile-referencing on toolchain 33fdb797f59421c7bbecaa4588ed5d7a31a9494a
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+33fdb797f59421c7bbecaa4588ed5d7a31a9494a" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking git repo https://github.com/jacob-pro/mdbook-bibfile-referencing
[INFO] finished tweaking git repo https://github.com/jacob-pro/mdbook-bibfile-referencing
[INFO] tweaked toml for git repo https://github.com/jacob-pro/mdbook-bibfile-referencing written to /workspace/builds/worker-66/source/Cargo.toml
[INFO] crate git repo https://github.com/jacob-pro/mdbook-bibfile-referencing already has a lockfile, it will not be regenerated
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+33fdb797f59421c7bbecaa4588ed5d7a31a9494a" "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] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded quick-error v2.0.1
[INFO] [stderr]   Downloaded pulldown-cmark v0.7.2
[INFO] [stderr]   Downloaded handlebars v4.1.0
[INFO] [stderr]   Downloaded pandoc v0.8.5
[INFO] [stderr]   Downloaded open v1.7.0
[INFO] [stderr]   Downloaded mdbook v0.4.10
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-66/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-66/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" "+33fdb797f59421c7bbecaa4588ed5d7a31a9494a" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 7d59dc903f4dadc26ac49a14b23d4389b59974bd594b68d81f10a94af2ba82e2
[INFO] running `Command { std: "docker" "start" "-a" "7d59dc903f4dadc26ac49a14b23d4389b59974bd594b68d81f10a94af2ba82e2", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "7d59dc903f4dadc26ac49a14b23d4389b59974bd594b68d81f10a94af2ba82e2", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "7d59dc903f4dadc26ac49a14b23d4389b59974bd594b68d81f10a94af2ba82e2", kill_on_drop: false }`
[INFO] [stdout] 7d59dc903f4dadc26ac49a14b23d4389b59974bd594b68d81f10a94af2ba82e2
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-66/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-66/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" "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" "+33fdb797f59421c7bbecaa4588ed5d7a31a9494a" "check" "--frozen" "--all" "--all-targets" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] c28d5524ad02ec32b24cf793b7901fdf5d818ff88deff034212a3ffe31e4eacd
[INFO] running `Command { std: "docker" "start" "-a" "c28d5524ad02ec32b24cf793b7901fdf5d818ff88deff034212a3ffe31e4eacd", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling libc v0.2.98
[INFO] [stderr]    Compiling version_check v0.9.3
[INFO] [stderr]    Compiling proc-macro2 v1.0.27
[INFO] [stderr]    Compiling unicode-xid v0.2.2
[INFO] [stderr]    Compiling autocfg v1.0.1
[INFO] [stderr]    Compiling syn v1.0.73
[INFO] [stderr]     Checking cfg-if v1.0.0
[INFO] [stderr]     Checking unicode-width v0.1.8
[INFO] [stderr]    Compiling serde v1.0.126
[INFO] [stderr]    Compiling ucd-trie v0.1.3
[INFO] [stderr]    Compiling log v0.4.14
[INFO] [stderr]     Checking either v1.6.1
[INFO] [stderr]    Compiling ryu v1.0.5
[INFO] [stderr]    Compiling maplit v1.0.2
[INFO] [stderr]    Compiling unicode-segmentation v1.8.0
[INFO] [stderr]     Checking vec_map v0.8.2
[INFO] [stderr]    Compiling serde_derive v1.0.126
[INFO] [stderr]    Compiling pulldown-cmark v0.7.2
[INFO] [stderr]    Compiling anyhow v1.0.42
[INFO] [stderr]     Checking regex-syntax v0.6.25
[INFO] [stderr]     Checking ansi_term v0.11.0
[INFO] [stderr]     Checking strsim v0.8.0
[INFO] [stderr]     Checking quick-error v2.0.1
[INFO] [stderr]     Checking hashbrown v0.11.2
[INFO] [stderr]     Checking shlex v1.0.0
[INFO] [stderr]     Checking version-compare v0.0.10
[INFO] [stderr]     Checking humantime v1.3.0
[INFO] [stderr]     Checking aho-corasick v0.7.18
[INFO] [stderr]     Checking textwrap v0.11.0
[INFO] [stderr]     Checking getopts v0.2.21
[INFO] [stderr]     Checking textwrap v0.12.1
[INFO] [stderr]    Compiling pest v2.1.3
[INFO] [stderr]     Checking itertools v0.8.2
[INFO] [stderr]    Compiling proc-macro-error-attr v1.0.4
[INFO] [stderr]    Compiling proc-macro-error v1.0.4
[INFO] [stderr]    Compiling unicase v2.6.0
[INFO] [stderr]    Compiling heck v0.3.3
[INFO] [stderr]    Compiling num-traits v0.2.14
[INFO] [stderr]    Compiling num-integer v0.1.44
[INFO] [stderr]    Compiling indexmap v1.7.0
[INFO] [stderr]    Compiling pest_meta v2.1.3
[INFO] [stderr]     Checking pandoc v0.8.5
[INFO] [stderr]    Compiling quote v1.0.9
[INFO] [stderr]     Checking getrandom v0.2.3
[INFO] [stderr]     Checking atty v0.2.14
[INFO] [stderr]     Checking time v0.1.43
[INFO] [stderr]     Checking which v4.1.0
[INFO] [stderr]     Checking regex v1.5.4
[INFO] [stderr]     Checking serde_json v1.0.64
[INFO] [stderr]     Checking toml v0.5.8
[INFO] [stderr]     Checking clap v2.33.3
[INFO] [stderr]     Checking open v1.7.0
[INFO] [stderr]     Checking rand_core v0.6.3
[INFO] [stderr]     Checking rand_chacha v0.3.1
[INFO] [stderr]     Checking chrono v0.4.19
[INFO] [stderr]     Checking rand v0.8.4
[INFO] [stderr]     Checking env_logger v0.7.1
[INFO] [stderr]     Checking tempfile v3.2.0
[INFO] [stderr]    Compiling pest_generator v2.1.3
[INFO] [stderr]    Compiling pest_derive v2.1.0
[INFO] [stderr]    Compiling clap_derive v3.0.0-beta.2
[INFO] [stderr]     Checking handlebars v4.1.0
[INFO] [stderr]     Checking clap v3.0.0-beta.2
[INFO] [stderr]     Checking mdbook v0.4.10
[INFO] [stderr]     Checking mdbook-bibfile-referencing v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 42.08s
[INFO] running `Command { std: "docker" "inspect" "c28d5524ad02ec32b24cf793b7901fdf5d818ff88deff034212a3ffe31e4eacd", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "c28d5524ad02ec32b24cf793b7901fdf5d818ff88deff034212a3ffe31e4eacd", kill_on_drop: false }`
[INFO] [stdout] c28d5524ad02ec32b24cf793b7901fdf5d818ff88deff034212a3ffe31e4eacd