[INFO] cloning repository https://github.com/dsocolobsky/vvdc
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/dsocolobsky/vvdc" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fdsocolobsky%2Fvvdc", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fdsocolobsky%2Fvvdc'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 026aae1ad5feae32ae0da3675753071f2d591596
[INFO] testing dsocolobsky/vvdc against master#a77da2d454e6caa227a85b16410b95f93495e7e0 for pr-91031
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fdsocolobsky%2Fvvdc" "/workspace/builds/worker-43/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-43/source'...
[INFO] [stderr] done.
[INFO] validating manifest of git repo https://github.com/dsocolobsky/vvdc on toolchain a77da2d454e6caa227a85b16410b95f93495e7e0
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+a77da2d454e6caa227a85b16410b95f93495e7e0" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking git repo https://github.com/dsocolobsky/vvdc
[INFO] finished tweaking git repo https://github.com/dsocolobsky/vvdc
[INFO] tweaked toml for git repo https://github.com/dsocolobsky/vvdc written to /workspace/builds/worker-43/source/Cargo.toml
[INFO] crate git repo https://github.com/dsocolobsky/vvdc already has a lockfile, it will not be regenerated
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+a77da2d454e6caa227a85b16410b95f93495e7e0" "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] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-43/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-43/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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+a77da2d454e6caa227a85b16410b95f93495e7e0" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 5dea6352d70ad2fbf07dd800b84666963f07da51a0b40023eaa4f7ced8496d79
[INFO] running `Command { std: "docker" "start" "-a" "5dea6352d70ad2fbf07dd800b84666963f07da51a0b40023eaa4f7ced8496d79", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "5dea6352d70ad2fbf07dd800b84666963f07da51a0b40023eaa4f7ced8496d79", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "5dea6352d70ad2fbf07dd800b84666963f07da51a0b40023eaa4f7ced8496d79", kill_on_drop: false }`
[INFO] [stdout] 5dea6352d70ad2fbf07dd800b84666963f07da51a0b40023eaa4f7ced8496d79
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-43/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-43/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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+a77da2d454e6caa227a85b16410b95f93495e7e0" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] e34ba0e436e975f5bd46f8bb86dd063d594ec2e3431efd32844fe6fa53f51068
[INFO] running `Command { std: "docker" "start" "-a" "e34ba0e436e975f5bd46f8bb86dd063d594ec2e3431efd32844fe6fa53f51068", kill_on_drop: false }`
[INFO] [stderr]    Compiling vvdc v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1.05s
[INFO] running `Command { std: "docker" "inspect" "e34ba0e436e975f5bd46f8bb86dd063d594ec2e3431efd32844fe6fa53f51068", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "e34ba0e436e975f5bd46f8bb86dd063d594ec2e3431efd32844fe6fa53f51068", kill_on_drop: false }`
[INFO] [stdout] e34ba0e436e975f5bd46f8bb86dd063d594ec2e3431efd32844fe6fa53f51068
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-43/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-43/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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+a77da2d454e6caa227a85b16410b95f93495e7e0" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 83f583a3a28524dedd12393da99e1922d5cf985926e7ff6e59f09bb11a5f4bd7
[INFO] running `Command { std: "docker" "start" "-a" "83f583a3a28524dedd12393da99e1922d5cf985926e7ff6e59f09bb11a5f4bd7", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling vvdc v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 1.44s
[INFO] running `Command { std: "docker" "inspect" "83f583a3a28524dedd12393da99e1922d5cf985926e7ff6e59f09bb11a5f4bd7", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "83f583a3a28524dedd12393da99e1922d5cf985926e7ff6e59f09bb11a5f4bd7", kill_on_drop: false }`
[INFO] [stdout] 83f583a3a28524dedd12393da99e1922d5cf985926e7ff6e59f09bb11a5f4bd7
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-43/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-43/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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+a77da2d454e6caa227a85b16410b95f93495e7e0" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] c969a4b56eb79117fb225b32d09d1ee40e9053ba040c00ad561764aa99e3f91f
[INFO] running `Command { std: "docker" "start" "-a" "c969a4b56eb79117fb225b32d09d1ee40e9053ba040c00ad561764aa99e3f91f", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.19s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/vvdc-51a73bf023e1c2bf)
[INFO] [stdout] 
[INFO] [stdout] running 40 tests
[INFO] [stdout] test codegen_test::return_a_literal ... ok
[INFO] [stdout] test codegen_test::return_a_negated_positive_number ... ok
[INFO] [stdout] test codegen_test::return_a_negated_zero ... ok
[INFO] [stdout] test lexer_test::a_multiple_digit_number ... ok
[INFO] [stdout] test codegen_test::return_negation_of_a_negation_of_a_literal ... ok
[INFO] [stdout] test lexer_test::braces ... ok
[INFO] [stdout] test lexer_test::a_single_digit_number ... ok
[INFO] [stdout] test lexer_test::comparison_operators ... ok
[INFO] [stdout] test lexer_test::complex_expression_with_equality ... ok
[INFO] [stdout] test lexer_test::complex_expression ... ok
[INFO] [stdout] test lexer_test::complex_expression_with_numbers ... ok
[INFO] [stdout] test lexer_test::empty_string_produces_empty_list_of_tokens ... ok
[INFO] [stdout] test lexer_test::keywords ... ok
[INFO] [stdout] test lexer_test::literal ... ok
[INFO] [stdout] test lexer_test::literal_and_token ... ok
[INFO] [stdout] test lexer_test::literal_number_and_string ... ok
[INFO] [stdout] test lexer_test::newlines ... ok
[INFO] [stdout] test lexer_test::number_and_symbol ... ok
[INFO] [stdout] test lexer_test::parentheses ... ok
[INFO] [stdout] test lexer_test::several_tokens_with_spaces ... ok
[INFO] [stdout] test lexer_test::sample_program ... ok
[INFO] [stdout] test lexer_test::single_letter_literal ... ok
[INFO] [stdout] test lexer_test::several_tokens ... ok
[INFO] [stdout] test lexer_test::single_letter_as_string ... ok
[INFO] [stdout] test lexer_test::string_with_spaces ... ok
[INFO] [stdout] test lexer_test::single_string ... ok
[INFO] [stdout] test lexer_test::token_assignment ... ok
[INFO] [stdout] test lexer_test::symbol_and_number ... ok
[INFO] [stdout] test lexer_test::token_asterisk ... ok
[INFO] [stdout] test lexer_test::token_minus ... ok
[INFO] [stdout] test lexer_test::two_literals ... ok
[INFO] [stdout] test lexer_test::token_equals ... ok
[INFO] [stdout] test lexer_test::token_plus ... ok
[INFO] [stdout] test parser_test::literals ... ok
[INFO] [stdout] test parser_test::return_expression ... ok
[INFO] [stdout] test parser_test::return_negation_of_negation ... ok
[INFO] [stdout] test parser_test::return_number ... ok
[INFO] [stdout] test parser_test::unary_negation ... ok
[INFO] [stdout] test test::main_test ... ok
[INFO] [stdout] test lexer_test::invalid_token_should_raise_error - should panic ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 40 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "c969a4b56eb79117fb225b32d09d1ee40e9053ba040c00ad561764aa99e3f91f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "c969a4b56eb79117fb225b32d09d1ee40e9053ba040c00ad561764aa99e3f91f", kill_on_drop: false }`
[INFO] [stdout] c969a4b56eb79117fb225b32d09d1ee40e9053ba040c00ad561764aa99e3f91f