[INFO] fetching crate pp-rs 0.2.1...
[INFO] testing pp-rs-0.2.1 against 1.60.0 for beta-1.61-1
[INFO] extracting crate pp-rs 0.2.1 into /workspace/builds/worker-25/source
[INFO] validating manifest of crates.io crate pp-rs 0.2.1 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 pp-rs 0.2.1
[INFO] finished tweaking crates.io crate pp-rs 0.2.1
[INFO] tweaked toml for crates.io crate pp-rs 0.2.1 written to /workspace/builds/worker-25/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] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-25/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-25/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] 00f9f9702add4652424d5d0101815eb06e06f24c9c8b7aabddde14f36caf7c8d
[INFO] running `Command { std: "docker" "start" "-a" "00f9f9702add4652424d5d0101815eb06e06f24c9c8b7aabddde14f36caf7c8d", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "00f9f9702add4652424d5d0101815eb06e06f24c9c8b7aabddde14f36caf7c8d", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "00f9f9702add4652424d5d0101815eb06e06f24c9c8b7aabddde14f36caf7c8d", kill_on_drop: false }`
[INFO] [stdout] 00f9f9702add4652424d5d0101815eb06e06f24c9c8b7aabddde14f36caf7c8d
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-25/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-25/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] 5da0527111e4d556decc7214ec63d94aefb9766b07e906ca9f6b2fafe587e54e
[INFO] running `Command { std: "docker" "start" "-a" "5da0527111e4d556decc7214ec63d94aefb9766b07e906ca9f6b2fafe587e54e", kill_on_drop: false }`
[INFO] [stderr]    Compiling pp-rs v0.2.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1.84s
[INFO] running `Command { std: "docker" "inspect" "5da0527111e4d556decc7214ec63d94aefb9766b07e906ca9f6b2fafe587e54e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "5da0527111e4d556decc7214ec63d94aefb9766b07e906ca9f6b2fafe587e54e", kill_on_drop: false }`
[INFO] [stdout] 5da0527111e4d556decc7214ec63d94aefb9766b07e906ca9f6b2fafe587e54e
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-25/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-25/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] baa8d622bcb141657d8a83203f5825f0b15d1bd9be76b7e4d039babe4794fadb
[INFO] running `Command { std: "docker" "start" "-a" "baa8d622bcb141657d8a83203f5825f0b15d1bd9be76b7e4d039babe4794fadb", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling pp-rs v0.2.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 2.45s
[INFO] running `Command { std: "docker" "inspect" "baa8d622bcb141657d8a83203f5825f0b15d1bd9be76b7e4d039babe4794fadb", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "baa8d622bcb141657d8a83203f5825f0b15d1bd9be76b7e4d039babe4794fadb", kill_on_drop: false }`
[INFO] [stdout] baa8d622bcb141657d8a83203f5825f0b15d1bd9be76b7e4d039babe4794fadb
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-25/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-25/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] c88b5a283b544985ae04527fb146c8e9b4a040a6680fc6da95a4a92e5dfba1fa
[INFO] running `Command { std: "docker" "start" "-a" "c88b5a283b544985ae04527fb146c8e9b4a040a6680fc6da95a4a92e5dfba1fa", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.00s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/pp_rs-52610181abb8f57f)
[INFO] [stdout] 
[INFO] [stdout] running 35 tests
[INFO] [stdout] test lexer_tests::chars_and_location ... ok
[INFO] [stdout] test lexer_tests::lex_had_comments ... ok
[INFO] [stdout] test lexer_tests::lex_decimal ... ok
[INFO] [stdout] test lexer_tests::lex_float ... ok
[INFO] [stdout] test lexer_tests::lex_hash ... ok
[INFO] [stdout] test lexer_tests::lex_hexadecimal ... ok
[INFO] [stdout] test lexer_tests::lex_identifiers ... ok
[INFO] [stdout] test lexer_tests::lex_metadata ... ok
[INFO] [stdout] test lexer_tests::lex_newline ... ok
[INFO] [stdout] test lexer_tests::lex_octal ... ok
[INFO] [stdout] test lexer_tests::lex_punctuation ... ok
[INFO] [stdout] test lexer_tests::lex_whitespace ... ok
[INFO] [stdout] test lexer_tests::replace_comments ... ok
[INFO] [stdout] test lexer_tests::skip_backslash_newline ... ok
[INFO] [stdout] test pp_tests::add_define ... ok
[INFO] [stdout] test pp_tests::define_undef ... ok
[INFO] [stdout] test pp_tests::define_redefinition ... ok
[INFO] [stdout] test pp_tests::parse_define ... ok
[INFO] [stdout] test pp_tests::parse_directive ... ok
[INFO] [stdout] test pp_tests::argument_less_define ... ok
[INFO] [stdout] test pp_tests::line_define ... ok
[INFO] [stdout] test pp_tests::parse_error ... ok
[INFO] [stdout] test pp_tests::parse_elif ... ok
[INFO] [stdout] test pp_tests::parse_endif ... ok
[INFO] [stdout] test pp_tests::parse_else ... ok
[INFO] [stdout] test pp_tests::parse_extension ... ok
[INFO] [stdout] test pp_tests::parse_pragma ... ok
[INFO] [stdout] test pp_tests::parse_ifndef ... ok
[INFO] [stdout] test pp_tests::parse_ifdef ... ok
[INFO] [stdout] test pp_tests::parse_undef ... ok
[INFO] [stdout] test pp_tests::parse_version ... ok
[INFO] [stdout] test pp_tests::parse_line ... ok
[INFO] [stdout] test pp_tests::parse_if ... ok
[INFO] [stdout] test pp_tests::function_like_define ... ok
[INFO] [stdout] test pp_tests::skipping_behavior ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 35 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests pp-rs
[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" "c88b5a283b544985ae04527fb146c8e9b4a040a6680fc6da95a4a92e5dfba1fa", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "c88b5a283b544985ae04527fb146c8e9b4a040a6680fc6da95a4a92e5dfba1fa", kill_on_drop: false }`
[INFO] [stdout] c88b5a283b544985ae04527fb146c8e9b4a040a6680fc6da95a4a92e5dfba1fa