[INFO] cloning repository https://github.com/rustyforks/rustation-ng
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/rustyforks/rustation-ng" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Frustyforks%2Frustation-ng", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Frustyforks%2Frustation-ng'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 69583239cfc53152d6fb89583956bb3d13e88af3
[INFO] testing rustyforks/rustation-ng against master#b70888601af92f6cdc0364abab3446e418b91d36 for pr-86479
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Frustyforks%2Frustation-ng" "/workspace/builds/worker-8/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-8/source'...
[INFO] [stderr] done.
[INFO] validating manifest of git repo https://github.com/rustyforks/rustation-ng on toolchain b70888601af92f6cdc0364abab3446e418b91d36
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+b70888601af92f6cdc0364abab3446e418b91d36" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking git repo https://github.com/rustyforks/rustation-ng
[INFO] finished tweaking git repo https://github.com/rustyforks/rustation-ng
[INFO] tweaked toml for git repo https://github.com/rustyforks/rustation-ng written to /workspace/builds/worker-8/source/Cargo.toml
[INFO] crate git repo https://github.com/rustyforks/rustation-ng already has a lockfile, it will not be regenerated
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+b70888601af92f6cdc0364abab3446e418b91d36" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-8/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-8/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" "+b70888601af92f6cdc0364abab3446e418b91d36" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 505a3f3b18738cedd345c64afd2b815a05bf7b48596ede81c967b72c3d462ac9
[INFO] running `Command { std: "docker" "start" "-a" "505a3f3b18738cedd345c64afd2b815a05bf7b48596ede81c967b72c3d462ac9", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "505a3f3b18738cedd345c64afd2b815a05bf7b48596ede81c967b72c3d462ac9", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "505a3f3b18738cedd345c64afd2b815a05bf7b48596ede81c967b72c3d462ac9", kill_on_drop: false }`
[INFO] [stdout] 505a3f3b18738cedd345c64afd2b815a05bf7b48596ede81c967b72c3d462ac9
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-8/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-8/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" "+b70888601af92f6cdc0364abab3446e418b91d36" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] b469e6ddb0a7d738a58bea21c84ffbcb69c2a89643f1533b51337ada485fef28
[INFO] running `Command { std: "docker" "start" "-a" "b469e6ddb0a7d738a58bea21c84ffbcb69c2a89643f1533b51337ada485fef28", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling cfg-if v0.1.10
[INFO] [stderr]    Compiling getrandom v0.1.14
[INFO] [stderr]    Compiling ppv-lite86 v0.2.6
[INFO] [stderr]    Compiling log v0.4.8
[INFO] [stderr]    Compiling rustc-serialize v0.3.24
[INFO] [stderr]    Compiling rustation-retro v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]    Compiling arrayref v0.3.6
[INFO] [stderr]    Compiling fnv v1.0.6
[INFO] [stderr]    Compiling libc v0.2.68
[INFO] [stderr]    Compiling bitflags v1.2.1
[INFO] [stderr]    Compiling cdimage v0.1.0 (https://github.com/simias/cdimage?branch=master#db9cdd42)
[INFO] [stderr]    Compiling rand_core v0.5.1
[INFO] [stderr]    Compiling rand_chacha v0.2.2
[INFO] [stderr]    Compiling rand v0.7.3
[INFO] [stderr]    Compiling shaman v0.1.0
[INFO] [stderr]     Finished dev [optimized + debuginfo] target(s) in 34.39s
[INFO] running `Command { std: "docker" "inspect" "b469e6ddb0a7d738a58bea21c84ffbcb69c2a89643f1533b51337ada485fef28", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "b469e6ddb0a7d738a58bea21c84ffbcb69c2a89643f1533b51337ada485fef28", kill_on_drop: false }`
[INFO] [stdout] b469e6ddb0a7d738a58bea21c84ffbcb69c2a89643f1533b51337ada485fef28
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-8/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-8/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" "+b70888601af92f6cdc0364abab3446e418b91d36" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] e52340629871ee5c96526f22bd5b65a5322272d31fbef0acb4891f96d94500bc
[INFO] running `Command { std: "docker" "start" "-a" "e52340629871ee5c96526f22bd5b65a5322272d31fbef0acb4891f96d94500bc", kill_on_drop: false }`
[INFO] [stderr]    Compiling rustation-retro v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [optimized + debuginfo] target(s) in 7.55s
[INFO] running `Command { std: "docker" "inspect" "e52340629871ee5c96526f22bd5b65a5322272d31fbef0acb4891f96d94500bc", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "e52340629871ee5c96526f22bd5b65a5322272d31fbef0acb4891f96d94500bc", kill_on_drop: false }`
[INFO] [stdout] e52340629871ee5c96526f22bd5b65a5322272d31fbef0acb4891f96d94500bc
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-8/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-8/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" "+b70888601af92f6cdc0364abab3446e418b91d36" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 2d0ccb4234dd0d1dcd6e69b4c194ab23bb51218529309eda8aaa90ef031b5770
[INFO] running `Command { std: "docker" "start" "-a" "2d0ccb4234dd0d1dcd6e69b4c194ab23bb51218529309eda8aaa90ef031b5770", kill_on_drop: false }`
[INFO] [stdout] 
[INFO] [stderr]     Finished test [optimized + debuginfo] target(s) in 0.02s
[INFO] [stdout] running 38 tests
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/rustation_ng_retro-646ccfd978fb9e77)
[INFO] [stdout] test assembler::opcodes ... ok
[INFO] [stdout] test psx::cpu::validate_mult_timings ... ok
[INFO] [stdout] test psx::gpu::fifo::test_fifo_pointer_overflow ... ok
[INFO] [stdout] test psx::gpu::fifo::test_command_fifo ... ok
[INFO] [stdout] test psx::gte::divider::test_divider ... ok
[INFO] [stdout] test psx::gpu::rasterizer::draw::fixed_point::test_add ... ok
[INFO] [stdout] test psx::gte::divider::validate_unr_table ... ok
[INFO] [stdout] test psx::gte::tests::gte_lzcr ... ok
[INFO] [stdout] test psx::gte::tests::gte_ops ... ok
[INFO] [stdout] test psx::mdec::fifo::test_command_fifo ... ok
[INFO] [stdout] test psx::mdec::fifo::test_fifo_pointer_overflow ... ok
[INFO] [stdout] test psx::mdec::test_idct ... ok
[INFO] [stdout] test psx::gpu::rasterizer::draw::tests::triangle_solid_opaque_slant_top_right ... ok
[INFO] [stdout] test psx::gpu::rasterizer::draw::fixed_point::test_sub ... ok
[INFO] [stdout] test psx::gpu::rasterizer::draw::fixed_point::test_mul_i32 ... ok
[INFO] [stdout] test psx::mdec::test_quantize_dc ... ok
[INFO] [stdout] test psx::mdec::test_quantize_ac ... ok
[INFO] [stdout] test psx::pad_memcard::devices::memory_card::test_format ... ok
[INFO] [stdout] test psx::gpu::rasterizer::draw::tests::triangle_solid_opaque_flat_up ... ok
[INFO] [stdout] test psx::gpu::rasterizer::draw::tests::triangle_solid_opaque_false_friends ... ok
[INFO] [stdout] test psx::gpu::rasterizer::draw::tests::triangle_solid_opaque_mid_left ... ok
[INFO] [stdout] test psx::gpu::rasterizer::draw::tests::triangle_solid_opaque_flat_left ... ok
[INFO] [stdout] test psx::gpu::rasterizer::draw::tests::triangle_solid_opaque_flat_down ... ok
[INFO] [stdout] test psx::gpu::rasterizer::draw::tests::test_overflow ... ok
[INFO] [stdout] test psx::gpu::rasterizer::draw::tests::triangle_solid_opaque_pyramid_down ... ok
[INFO] [stdout] test psx::gpu::rasterizer::draw::tests::triangle_solid_opaque_mid_right ... ok
[INFO] [stdout] test psx::gpu::rasterizer::draw::tests::triangle_solid_opaque_pyramid_up ... ok
[INFO] [stdout] test psx::gpu::rasterizer::draw::tests::triangle_solid_opaque_slant_bot_left ... ok
[INFO] [stdout] test psx::gpu::rasterizer::draw::tests::gouraud_rgb_right ... ok
[INFO] [stdout] test psx::gpu::rasterizer::draw::tests::triangle_solid_opaque_big1 ... ok
[INFO] [stdout] test psx::gpu::rasterizer::draw::tests::triangle_solid_opaque_slant_top_left ... ok
[INFO] [stdout] test psx::gpu::rasterizer::draw::tests::test_bad_draw_psx_logo ... ok
[INFO] [stdout] test psx::gpu::rasterizer::draw::tests::triangle_solid_opaque_big2 ... ok
[INFO] [stdout] test psx::gpu::rasterizer::draw::tests::triangle_solid_opaque_slant_bot_right ... ok
[INFO] [stdout] test psx::gpu::rasterizer::draw::tests::quad_rect_solid_opaque ... ok
[INFO] [stdout] test psx::gpu::rasterizer::draw::tests::triangle_solid_opaque_flat_right ... ok
[INFO] [stdout] test psx::gpu::rasterizer::draw::tests::triangle_solid_opaque_draw_limits ... ok
[INFO] [stdout] test psx::gpu::commands::check_poly_callbacks ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 38 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.60s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "2d0ccb4234dd0d1dcd6e69b4c194ab23bb51218529309eda8aaa90ef031b5770", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "2d0ccb4234dd0d1dcd6e69b4c194ab23bb51218529309eda8aaa90ef031b5770", kill_on_drop: false }`
[INFO] [stdout] 2d0ccb4234dd0d1dcd6e69b4c194ab23bb51218529309eda8aaa90ef031b5770