[INFO] cloning repository https://github.com/SylvanB/chip8-rs
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/SylvanB/chip8-rs" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FSylvanB%2Fchip8-rs", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FSylvanB%2Fchip8-rs'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 9701fc5951b94cb655fdcd49d88d606f17fa16ca
[INFO] testing SylvanB/chip8-rs against 1.54.0 for beta-1.55-1
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FSylvanB%2Fchip8-rs" "/workspace/builds/worker-52/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-52/source'...
[INFO] [stderr] done.
[INFO] validating manifest of git repo https://github.com/SylvanB/chip8-rs on toolchain 1.54.0
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.54.0" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking git repo https://github.com/SylvanB/chip8-rs
[INFO] finished tweaking git repo https://github.com/SylvanB/chip8-rs
[INFO] tweaked toml for git repo https://github.com/SylvanB/chip8-rs written to /workspace/builds/worker-52/source/Cargo.toml
[INFO] crate git repo https://github.com/SylvanB/chip8-rs already has a lockfile, it will not be regenerated
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.54.0" "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-52/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-52/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" "+1.54.0" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 904291b8dc64910f4334adde7b8fd70fe7e54a9aab52e884af28dbed0e0f9f1e
[INFO] running `Command { std: "docker" "start" "-a" "904291b8dc64910f4334adde7b8fd70fe7e54a9aab52e884af28dbed0e0f9f1e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "904291b8dc64910f4334adde7b8fd70fe7e54a9aab52e884af28dbed0e0f9f1e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "904291b8dc64910f4334adde7b8fd70fe7e54a9aab52e884af28dbed0e0f9f1e", kill_on_drop: false }`
[INFO] [stdout] 904291b8dc64910f4334adde7b8fd70fe7e54a9aab52e884af28dbed0e0f9f1e
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-52/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-52/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:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+1.54.0" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] e39dfefae17a5c0c6d7c1d13c9d1de3fb84c80803246237ac977d38068072c81
[INFO] running `Command { std: "docker" "start" "-a" "e39dfefae17a5c0c6d7c1d13c9d1de3fb84c80803246237ac977d38068072c81", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling libc v0.2.98
[INFO] [stderr]    Compiling proc-macro2 v1.0.27
[INFO] [stderr]    Compiling memchr v2.3.4
[INFO] [stderr]    Compiling glob v0.3.0
[INFO] [stderr]    Compiling xml-rs v0.8.3
[INFO] [stderr]    Compiling log v0.4.14
[INFO] [stderr]    Compiling yaml-rust v0.3.5
[INFO] [stderr]    Compiling humantime v2.1.0
[INFO] [stderr]    Compiling bindgen v0.56.0
[INFO] [stderr]    Compiling peeking_take_while v0.1.2
[INFO] [stderr]    Compiling lazycell v1.3.0
[INFO] [stderr]    Compiling rustc-hash v1.1.0
[INFO] [stderr]    Compiling shlex v0.1.1
[INFO] [stderr]    Compiling downcast-rs v1.2.0
[INFO] [stderr]    Compiling cc v1.0.69
[INFO] [stderr]    Compiling nom v5.1.2
[INFO] [stderr]    Compiling libloading v0.7.0
[INFO] [stderr]    Compiling wayland-sys v0.28.6
[INFO] [stderr]    Compiling nom v6.2.1
[INFO] [stderr]    Compiling num-traits v0.2.14
[INFO] [stderr]    Compiling x11-dl v2.18.5
[INFO] [stderr]    Compiling num-integer v0.1.44
[INFO] [stderr]    Compiling clang-sys v1.2.0
[INFO] [stderr]    Compiling minifb v0.19.3
[INFO] [stderr]    Compiling atty v0.2.14
[INFO] [stderr]    Compiling which v3.1.1
[INFO] [stderr]    Compiling nix v0.20.0
[INFO] [stderr]    Compiling getrandom v0.2.3
[INFO] [stderr]    Compiling raw-window-handle v0.3.3
[INFO] [stderr]    Compiling time v0.1.43
[INFO] [stderr]    Compiling quote v1.0.9
[INFO] [stderr]    Compiling aho-corasick v0.7.15
[INFO] [stderr]    Compiling clap v2.33.3
[INFO] [stderr]    Compiling rand_core v0.6.3
[INFO] [stderr]    Compiling chrono v0.4.19
[INFO] [stderr]    Compiling wayland-scanner v0.28.6
[INFO] [stderr]    Compiling regex v1.4.6
[INFO] [stderr]    Compiling rand_chacha v0.3.1
[INFO] [stderr]    Compiling rand v0.8.4
[INFO] [stderr]    Compiling xcursor v0.3.3
[INFO] [stderr]    Compiling cexpr v0.4.0
[INFO] [stderr]    Compiling wayland-client v0.28.6
[INFO] [stderr]    Compiling wayland-protocols v0.28.6
[INFO] [stderr]    Compiling wayland-commons v0.28.6
[INFO] [stderr]    Compiling tempfile v3.2.0
[INFO] [stderr]    Compiling env_logger v0.8.4
[INFO] [stderr]    Compiling wayland-cursor v0.28.6
[INFO] [stderr]    Compiling xkbcommon-sys v0.7.5
[INFO] [stderr]    Compiling xkb v0.2.1
[INFO] [stderr]    Compiling chip8_rs v0.1.0 (/opt/rustwide/workdir)
[INFO] [stdout] warning: unused imports: `TryFrom`, `TryInto`
[INFO] [stdout]  --> src/keyboard/mod.rs:1:20
[INFO] [stdout]   |
[INFO] [stdout] 1 | use std::convert::{TryFrom, TryInto};
[INFO] [stdout]   |                    ^^^^^^^  ^^^^^^^
[INFO] [stdout]   |
[INFO] [stdout]   = note: `#[warn(unused_imports)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused imports: `TryFrom`, `TryInto`
[INFO] [stdout]  --> src/keyboard/dummy_keyboard.rs:1:20
[INFO] [stdout]   |
[INFO] [stdout] 1 | use std::convert::{TryFrom, TryInto};
[INFO] [stdout]   |                    ^^^^^^^  ^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused imports: `TryFrom`, `TryInto`, `error::Error`
[INFO] [stdout]  --> src/keyboard/minifb_keyboard.rs:3:15
[INFO] [stdout]   |
[INFO] [stdout] 3 |     convert::{TryFrom, TryInto},
[INFO] [stdout]   |               ^^^^^^^  ^^^^^^^
[INFO] [stdout] 4 |     error::Error,
[INFO] [stdout]   |     ^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused import: `Key`
[INFO] [stdout]  --> src/keyboard/minifb_keyboard.rs:8:14
[INFO] [stdout]   |
[INFO] [stdout] 8 | use minifb::{Key, Window};
[INFO] [stdout]   |              ^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused variable: `keys`
[INFO] [stdout]   --> src/keyboard/dummy_keyboard.rs:12:32
[INFO] [stdout]    |
[INFO] [stdout] 12 |     fn update_state(&mut self, keys: &[u8]) {
[INFO] [stdout]    |                                ^^^^ help: if this is intentional, prefix it with an underscore: `_keys`
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(unused_variables)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: associated function is never used: `execute`
[INFO] [stdout]   --> src/cpu.rs:86:12
[INFO] [stdout]    |
[INFO] [stdout] 86 |     pub fn execute(&mut self) {
[INFO] [stdout]    |            ^^^^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(dead_code)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: associated function is never used: `initialise`
[INFO] [stdout]   --> src/keyboard/dummy_keyboard.rs:25:12
[INFO] [stdout]    |
[INFO] [stdout] 25 |     pub fn initialise() -> Self {
[INFO] [stdout]    |            ^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: associated function is never used: `get_current_keydowns`
[INFO] [stdout]   --> src/keyboard/dummy_keyboard.rs:31:8
[INFO] [stdout]    |
[INFO] [stdout] 31 |     fn get_current_keydowns(&self) -> &Vec<u8> {
[INFO] [stdout]    |        ^^^^^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: field is never read: `window`
[INFO] [stdout]   --> src/keyboard/minifb_keyboard.rs:13:5
[INFO] [stdout]    |
[INFO] [stdout] 13 |     window: &'keyboard Rc<RefCell<Window>>,
[INFO] [stdout]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: constant is never used: `PROGRAM_START_OFFSET`
[INFO] [stdout]  --> src/memory.rs:9:1
[INFO] [stdout]   |
[INFO] [stdout] 9 | pub(crate) const PROGRAM_START_OFFSET: usize = 0x200;
[INFO] [stdout]   | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: constant is never used: `ETI_600_PROGRAM_START_OFFSET`
[INFO] [stdout]   --> src/memory.rs:11:1
[INFO] [stdout]    |
[INFO] [stdout] 11 | pub(crate) const ETI_600_PROGRAM_START_OFFSET: usize = 0x600;
[INFO] [stdout]    | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: associated function is never used: `insert_instruction`
[INFO] [stdout]    --> src/memory.rs:164:12
[INFO] [stdout]     |
[INFO] [stdout] 164 |     pub fn insert_instruction(&mut self, index: usize, ins: u16) {
[INFO] [stdout]     |            ^^^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: associated function is never used: `id`
[INFO] [stdout]   --> src/opcode.rs:27:12
[INFO] [stdout]    |
[INFO] [stdout] 27 |     pub fn id(&self) -> u8 {
[INFO] [stdout]    |            ^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: 13 warnings emitted
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2m 19s
[INFO] running `Command { std: "docker" "inspect" "e39dfefae17a5c0c6d7c1d13c9d1de3fb84c80803246237ac977d38068072c81", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "e39dfefae17a5c0c6d7c1d13c9d1de3fb84c80803246237ac977d38068072c81", kill_on_drop: false }`
[INFO] [stdout] e39dfefae17a5c0c6d7c1d13c9d1de3fb84c80803246237ac977d38068072c81
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-52/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-52/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:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+1.54.0" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 3fd09c3a5d4696318da8c83230a5ad278d82d25956333ba9bd521f96cfb1d3ee
[INFO] running `Command { std: "docker" "start" "-a" "3fd09c3a5d4696318da8c83230a5ad278d82d25956333ba9bd521f96cfb1d3ee", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling chip8_rs v0.1.0 (/opt/rustwide/workdir)
[INFO] [stdout] warning: unused imports: `TryFrom`, `TryInto`
[INFO] [stdout]  --> src/keyboard/mod.rs:1:20
[INFO] [stdout]   |
[INFO] [stdout] 1 | use std::convert::{TryFrom, TryInto};
[INFO] [stdout]   |                    ^^^^^^^  ^^^^^^^
[INFO] [stdout]   |
[INFO] [stdout]   = note: `#[warn(unused_imports)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused imports: `TryFrom`, `TryInto`
[INFO] [stdout]  --> src/keyboard/dummy_keyboard.rs:1:20
[INFO] [stdout]   |
[INFO] [stdout] 1 | use std::convert::{TryFrom, TryInto};
[INFO] [stdout]   |                    ^^^^^^^  ^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused imports: `TryFrom`, `TryInto`, `error::Error`
[INFO] [stdout]  --> src/keyboard/minifb_keyboard.rs:3:15
[INFO] [stdout]   |
[INFO] [stdout] 3 |     convert::{TryFrom, TryInto},
[INFO] [stdout]   |               ^^^^^^^  ^^^^^^^
[INFO] [stdout] 4 |     error::Error,
[INFO] [stdout]   |     ^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused import: `Key`
[INFO] [stdout]  --> src/keyboard/minifb_keyboard.rs:8:14
[INFO] [stdout]   |
[INFO] [stdout] 8 | use minifb::{Key, Window};
[INFO] [stdout]   |              ^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused variable: `keys`
[INFO] [stdout]   --> src/keyboard/dummy_keyboard.rs:12:32
[INFO] [stdout]    |
[INFO] [stdout] 12 |     fn update_state(&mut self, keys: &[u8]) {
[INFO] [stdout]    |                                ^^^^ help: if this is intentional, prefix it with an underscore: `_keys`
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(unused_variables)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: associated function is never used: `execute`
[INFO] [stdout]   --> src/cpu.rs:86:12
[INFO] [stdout]    |
[INFO] [stdout] 86 |     pub fn execute(&mut self) {
[INFO] [stdout]    |            ^^^^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(dead_code)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: associated function is never used: `get_current_keydowns`
[INFO] [stdout]   --> src/keyboard/dummy_keyboard.rs:31:8
[INFO] [stdout]    |
[INFO] [stdout] 31 |     fn get_current_keydowns(&self) -> &Vec<u8> {
[INFO] [stdout]    |        ^^^^^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: field is never read: `window`
[INFO] [stdout]   --> src/keyboard/minifb_keyboard.rs:13:5
[INFO] [stdout]    |
[INFO] [stdout] 13 |     window: &'keyboard Rc<RefCell<Window>>,
[INFO] [stdout]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: constant is never used: `PROGRAM_START_OFFSET`
[INFO] [stdout]  --> src/memory.rs:9:1
[INFO] [stdout]   |
[INFO] [stdout] 9 | pub(crate) const PROGRAM_START_OFFSET: usize = 0x200;
[INFO] [stdout]   | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: constant is never used: `ETI_600_PROGRAM_START_OFFSET`
[INFO] [stdout]   --> src/memory.rs:11:1
[INFO] [stdout]    |
[INFO] [stdout] 11 | pub(crate) const ETI_600_PROGRAM_START_OFFSET: usize = 0x600;
[INFO] [stdout]    | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: 10 warnings emitted
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 6.77s
[INFO] running `Command { std: "docker" "inspect" "3fd09c3a5d4696318da8c83230a5ad278d82d25956333ba9bd521f96cfb1d3ee", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "3fd09c3a5d4696318da8c83230a5ad278d82d25956333ba9bd521f96cfb1d3ee", kill_on_drop: false }`
[INFO] [stdout] 3fd09c3a5d4696318da8c83230a5ad278d82d25956333ba9bd521f96cfb1d3ee
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-52/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-52/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:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+1.54.0" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 4830e90e14cb9f3a6b579f9df83549ec04e59cc73fc3b8ebd2ead4bf78c15fd0
[INFO] running `Command { std: "docker" "start" "-a" "4830e90e14cb9f3a6b579f9df83549ec04e59cc73fc3b8ebd2ead4bf78c15fd0", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr] warning: unused imports: `TryFrom`, `TryInto`
[INFO] [stderr]  --> src/keyboard/mod.rs:1:20
[INFO] [stderr]   |
[INFO] [stderr] 1 | use std::convert::{TryFrom, TryInto};
[INFO] [stderr]   |                    ^^^^^^^  ^^^^^^^
[INFO] [stderr]   |
[INFO] [stderr]   = note: `#[warn(unused_imports)]` on by default
[INFO] [stderr] 
[INFO] [stderr] warning: unused imports: `TryFrom`, `TryInto`
[INFO] [stderr]  --> src/keyboard/dummy_keyboard.rs:1:20
[INFO] [stderr]   |
[INFO] [stderr] 1 | use std::convert::{TryFrom, TryInto};
[INFO] [stderr]   |                    ^^^^^^^  ^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: unused imports: `TryFrom`, `TryInto`, `error::Error`
[INFO] [stderr]  --> src/keyboard/minifb_keyboard.rs:3:15
[INFO] [stderr]   |
[INFO] [stderr] 3 |     convert::{TryFrom, TryInto},
[INFO] [stderr]   |               ^^^^^^^  ^^^^^^^
[INFO] [stderr] 4 |     error::Error,
[INFO] [stderr]   |     ^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: unused import: `Key`
[INFO] [stderr]  --> src/keyboard/minifb_keyboard.rs:8:14
[INFO] [stderr]   |
[INFO] [stderr] 8 | use minifb::{Key, Window};
[INFO] [stderr]   |              ^^^
[INFO] [stderr] 
[INFO] [stderr] warning: unused variable: `keys`
[INFO] [stderr]   --> src/keyboard/dummy_keyboard.rs:12:32
[INFO] [stderr]    |
[INFO] [stderr] 12 |     fn update_state(&mut self, keys: &[u8]) {
[INFO] [stderr]    |                                ^^^^ help: if this is intentional, prefix it with an underscore: `_keys`
[INFO] [stderr]    |
[INFO] [stderr]    = note: `#[warn(unused_variables)]` on by default
[INFO] [stderr] 
[INFO] [stderr] warning: associated function is never used: `execute`
[INFO] [stderr]   --> src/cpu.rs:86:12
[INFO] [stderr]    |
[INFO] [stderr] 86 |     pub fn execute(&mut self) {
[INFO] [stderr]    |            ^^^^^^^
[INFO] [stderr]    |
[INFO] [stderr]    = note: `#[warn(dead_code)]` on by default
[INFO] [stderr] 
[INFO] [stderr] warning: associated function is never used: `get_current_keydowns`
[INFO] [stderr]   --> src/keyboard/dummy_keyboard.rs:31:8
[INFO] [stderr]    |
[INFO] [stderr] 31 |     fn get_current_keydowns(&self) -> &Vec<u8> {
[INFO] [stderr]    |        ^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: field is never read: `window`
[INFO] [stderr]   --> src/keyboard/minifb_keyboard.rs:13:5
[INFO] [stderr]    |
[INFO] [stderr] 13 |     window: &'keyboard Rc<RefCell<Window>>,
[INFO] [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: constant is never used: `PROGRAM_START_OFFSET`
[INFO] [stderr]  --> src/memory.rs:9:1
[INFO] [stderr]   |
[INFO] [stderr] 9 | pub(crate) const PROGRAM_START_OFFSET: usize = 0x200;
[INFO] [stderr]   | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: constant is never used: `ETI_600_PROGRAM_START_OFFSET`
[INFO] [stderr]   --> src/memory.rs:11:1
[INFO] [stderr]    |
[INFO] [stderr] 11 | pub(crate) const ETI_600_PROGRAM_START_OFFSET: usize = 0x600;
[INFO] [stderr]    | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: 10 warnings emitted
[INFO] [stderr] 
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.15s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/chip8_rs-9a1d2d60bf9f9f3a)
[INFO] [stdout] 
[INFO] [stdout] running 46 tests
[INFO] [stdout] test cpu::tests::cls ... ok
[INFO] [stdout] test cpu::tests::add_i ... ok
[INFO] [stdout] test cpu::tests::add ... ok
[INFO] [stdout] test cpu::tests::jp ... ok
[INFO] [stdout] test cpu::tests::add_xy_carry ... ok
[INFO] [stdout] test cpu::tests::ld_b ... ok
[INFO] [stdout] test cpu::tests::add_xy_no_carry ... ok
[INFO] [stdout] test cpu::tests::jp_v0 ... ok
[INFO] [stdout] test cpu::tests::ld_i ... ok
[INFO] [stdout] test cpu::tests::ld_dt ... ok
[INFO] [stdout] test cpu::tests::and_xy ... ok
[INFO] [stdout] test cpu::tests::ld_mem_vx_i ... ok
[INFO] [stdout] test cpu::tests::ld_f_vx ... ok
[INFO] [stdout] test cpu::tests::ld_vx_dt ... ok
[INFO] [stdout] test cpu::tests::ld_st ... ok
[INFO] [stdout] test cpu::tests::call ... ok
[INFO] [stdout] test cpu::tests::ld_r ... ok
[INFO] [stdout] test cpu::tests::ld_vx_k ... ok
[INFO] [stdout] test cpu::tests::ld_mem_i_vx ... ok
[INFO] [stdout] test cpu::tests::se_jumps_when_equal ... ok
[INFO] [stdout] test cpu::tests::or_xy ... ok
[INFO] [stdout] test cpu::tests::or_xy_inverse ... ok
[INFO] [stdout] test cpu::tests::se_doesnt_jump_when_not_equal ... ok
[INFO] [stdout] test cpu::tests::ld_xy ... ok
[INFO] [stdout] test cpu::tests::ret ... ok
[INFO] [stdout] test cpu::tests::sknp_vx_skip_if_not_pressed ... ok
[INFO] [stdout] test cpu::tests::sne_xy_dont_skip_when_equal ... ok
[INFO] [stdout] test cpu::tests::sne_xy_skip_when_not_equal ... ok
[INFO] [stdout] test cpu::tests::shr_vf_set_when_odd ... ok
[INFO] [stdout] test cpu::tests::se_r_jumps_when_equal ... ok
[INFO] [stdout] test cpu::tests::xor_xy ... ok
[INFO] [stdout] test cpu::tests::drw ... FAILED
[INFO] [stdout] test cpu::tests::skp_vx_skip_if_pressed ... ok
[INFO] [stdout] test cpu::tests::skp_vx_dont_skip_if_not_pressed ... ok
[INFO] [stdout] test cpu::tests::shr ... ok
[INFO] [stdout] test cpu::tests::sne_doesnt_jump_when_equal ... ok
[INFO] [stdout] test cpu::tests::sne_jumps_when_not_equal ... ok
[INFO] [stdout] test cpu::tests::sknp_vx_dont_skip_if_pressed ... ok
[INFO] [stdout] test cpu::tests::se_r_doesnt_jump_when_not_equal ... ok
[INFO] [stdout] test cpu::tests::xor_xy_inverse ... ok
[INFO] [stdout] test opcode::tests::should_generate_correct_raw_value ... ok
[INFO] [stdout] test opcode::tests::should_generate_correct_y_value ... ok
[INFO] [stdout] test opcode::tests::should_generate_correct_kk_value ... ok
[INFO] [stdout] test opcode::tests::should_generate_correct_nnn_value ... ok
[INFO] [stdout] test opcode::tests::should_generate_correct_id_value ... ok
[INFO] [stdout] test opcode::tests::should_generate_correct_x_value ... ok
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- cpu::tests::drw stdout ----
[INFO] [stdout] XXXXXXXX........................................................
[INFO] [stdout] ................................................................
[INFO] [stdout] ................................................................
[INFO] [stdout] ................................................................
[INFO] [stdout] ................................................................
[INFO] [stdout] ................................................................
[INFO] [stdout] ................................................................
[INFO] [stdout] ................................................................
[INFO] [stdout] ................................................................
[INFO] [stdout] ................................................................
[INFO] [stdout] ................................................................
[INFO] [stdout] ................................................................
[INFO] [stdout] ................................................................
[INFO] [stdout] ................................................................
[INFO] [stdout] ................................................................
[INFO] [stdout] ................................................................
[INFO] [stdout] ................................................................
[INFO] [stdout] ................................................................
[INFO] [stdout] ................................................................
[INFO] [stdout] ................................................................
[INFO] [stdout] ................................................................
[INFO] [stdout] ................................................................
[INFO] [stdout] ................................................................
[INFO] [stdout] ................................................................
[INFO] [stdout] ................................................................
[INFO] [stdout] ................................................................
[INFO] [stdout] ................................................................
[INFO] [stdout] ................................................................
[INFO] [stdout] ................................................................
[INFO] [stdout] ................................................................
[INFO] [stdout] ................................................................
[INFO] [stdout] ................................................................
[INFO] [stdout] thread 'cpu::tests::drw' panicked at 'assertion failed: `(left == right)`
[INFO] [stdout]   left: `false`,
[INFO] [stdout]  right: `true`', src/cpu.rs:920:9
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x56110e50e170 - std::backtrace_rs::backtrace::libunwind::trace::h34055254b57d8e79
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/../../backtrace/src/backtrace/libunwind.rs:90:5
[INFO] [stdout]    1:     0x56110e50e170 - std::backtrace_rs::backtrace::trace_unsynchronized::h8f1e3fbd9afff6ec
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x56110e50e170 - std::sys_common::backtrace::_print_fmt::h3a99a796b770c360
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/sys_common/backtrace.rs:67:5
[INFO] [stdout]    3:     0x56110e50e170 - <std::sys_common::backtrace::_print::DisplayBacktrace as core::fmt::Display>::fmt::h32d1f94a80615d18
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/sys_common/backtrace.rs:46:22
[INFO] [stdout]    4:     0x56110e53097c - core::fmt::write::h306731c068f7162c
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/core/src/fmt/mod.rs:1110:17
[INFO] [stdout]    5:     0x56110e50b095 - std::io::Write::write_fmt::h87f19b0a2cd190bc
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/io/mod.rs:1588:15
[INFO] [stdout]    6:     0x56110e5102db - std::sys_common::backtrace::_print::h5abaa2601a852287
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/sys_common/backtrace.rs:49:5
[INFO] [stdout]    7:     0x56110e5102db - std::sys_common::backtrace::print::h8d81445442bb638f
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/sys_common/backtrace.rs:36:9
[INFO] [stdout]    8:     0x56110e5102db - std::panicking::default_hook::{{closure}}::hcfe804496a9fa747
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/panicking.rs:208:50
[INFO] [stdout]    9:     0x56110e50fdec - std::panicking::default_hook::hbea8e3ccf2ba8901
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/panicking.rs:222:9
[INFO] [stdout]   10:     0x56110e5109a4 - std::panicking::rust_panic_with_hook::h7ee9e1a2d0f8975a
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/panicking.rs:622:17
[INFO] [stdout]   11:     0x56110e510487 - std::panicking::begin_panic_handler::{{closure}}::h8ab3b4491718b2c7
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/panicking.rs:519:13
[INFO] [stdout]   12:     0x56110e50e66c - std::sys_common::backtrace::__rust_end_short_backtrace::hd489062ffa586a9f
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/sys_common/backtrace.rs:141:18
[INFO] [stdout]   13:     0x56110e5103e9 - rust_begin_unwind
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/panicking.rs:515:5
[INFO] [stdout]   14:     0x56110e46fa41 - core::panicking::panic_fmt::hca6330e3e14086b4
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/core/src/panicking.rs:92:14
[INFO] [stdout]   15:     0x56110e52f298 - core::panicking::assert_failed_inner::h33b45280069a80ed
[INFO] [stdout]   16:     0x56110e47893a - core::panicking::assert_failed::h86e6bbdeca637742
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/core/src/panicking.rs:117:5
[INFO] [stdout]   17:     0x56110e47264d - chip8_rs::cpu::tests::drw::ha713aacf6d614b7f
[INFO] [stdout]                                at /opt/rustwide/workdir/src/cpu.rs:920:9
[INFO] [stdout]   18:     0x56110e4724ca - chip8_rs::cpu::tests::drw::{{closure}}::h11a8157118956a4f
[INFO] [stdout]                                at /opt/rustwide/workdir/src/cpu.rs:910:5
[INFO] [stdout]   19:     0x56110e47960e - core::ops::function::FnOnce::call_once::he279e2e0986908aa
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   20:     0x56110e4a4363 - core::ops::function::FnOnce::call_once::h152e7e439ff59e19
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   21:     0x56110e4a4363 - test::__rust_begin_short_backtrace::h0908f3b1fdbb72ab
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/test/src/lib.rs:577:5
[INFO] [stdout]   22:     0x56110e4a2e20 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::hf6d2a51e5587546c
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/alloc/src/boxed.rs:1575:9
[INFO] [stdout]   23:     0x56110e4a2e20 - <std::panic::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h8af660f3a89ef593
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/panic.rs:347:9
[INFO] [stdout]   24:     0x56110e4a2e20 - std::panicking::try::do_call::hd36aef60f84b6d36
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/panicking.rs:401:40
[INFO] [stdout]   25:     0x56110e4a2e20 - std::panicking::try::h9932b4480e69817c
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/panicking.rs:365:19
[INFO] [stdout]   26:     0x56110e4a2e20 - std::panic::catch_unwind::h6aa177099cfff5f8
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/panic.rs:434:14
[INFO] [stdout]   27:     0x56110e4a2e20 - test::run_test_in_process::h5884d6f2d99e20c3
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/test/src/lib.rs:600:18
[INFO] [stdout]   28:     0x56110e4a2e20 - test::run_test::run_test_inner::{{closure}}::h6fdc58c6d5f5b6e3
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/test/src/lib.rs:492:39
[INFO] [stdout]   29:     0x56110e47c4d2 - test::run_test::run_test_inner::{{closure}}::h408365d67a78ade8
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/test/src/lib.rs:519:37
[INFO] [stdout]   30:     0x56110e47c4d2 - std::sys_common::backtrace::__rust_begin_short_backtrace::hb560b77c4f701523
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/sys_common/backtrace.rs:125:18
[INFO] [stdout]   31:     0x56110e480088 - std::thread::Builder::spawn_unchecked::{{closure}}::{{closure}}::hf2e7831dad93c597
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/thread/mod.rs:481:17
[INFO] [stdout]   32:     0x56110e480088 - <std::panic::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::hd2e08783d8be4d02
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/panic.rs:347:9
[INFO] [stdout]   33:     0x56110e480088 - std::panicking::try::do_call::h062597b7acfd6b82
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/panicking.rs:401:40
[INFO] [stdout]   34:     0x56110e480088 - std::panicking::try::h0d7b79db04c14552
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/panicking.rs:365:19
[INFO] [stdout]   35:     0x56110e480088 - std::panic::catch_unwind::hb01a0b5e7c8cd43b
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/panic.rs:434:14
[INFO] [stdout]   36:     0x56110e480088 - std::thread::Builder::spawn_unchecked::{{closure}}::h5bde48cc887e0d1e
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/thread/mod.rs:480:30
[INFO] [stdout]   37:     0x56110e480088 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h745ea30807a29e55
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   38:     0x56110e515467 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h7ece6cfefaff1005
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/alloc/src/boxed.rs:1575:9
[INFO] [stdout]   39:     0x56110e515467 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::hb8b48e55c21f193e
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/alloc/src/boxed.rs:1575:9
[INFO] [stdout]   40:     0x56110e515467 - std::sys::unix::thread::Thread::new::thread_start::h8c7c4450dba62914
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/sys/unix/thread.rs:71:17
[INFO] [stdout]   41:     0x7f79cfdd2609 - start_thread
[INFO] [stdout]   42:     0x7f79cfba8293 - clone
[INFO] [stdout]   43:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     cpu::tests::drw
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 45 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.11s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass '--bin chip8_rs'
[INFO] running `Command { std: "docker" "inspect" "4830e90e14cb9f3a6b579f9df83549ec04e59cc73fc3b8ebd2ead4bf78c15fd0", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "4830e90e14cb9f3a6b579f9df83549ec04e59cc73fc3b8ebd2ead4bf78c15fd0", kill_on_drop: false }`
[INFO] [stdout] 4830e90e14cb9f3a6b579f9df83549ec04e59cc73fc3b8ebd2ead4bf78c15fd0
