[INFO] fetching crate nes_rust 0.1.2...
[INFO] testing nes_rust-0.1.2 against try#d2e9fff28e244f1ea4927194f1f9b77f93e2ffe2 for pr-86479
[INFO] extracting crate nes_rust 0.1.2 into /workspace/builds/worker-8/source
[INFO] validating manifest of crates.io crate nes_rust 0.1.2 on toolchain d2e9fff28e244f1ea4927194f1f9b77f93e2ffe2
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+d2e9fff28e244f1ea4927194f1f9b77f93e2ffe2" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate nes_rust 0.1.2
[INFO] finished tweaking crates.io crate nes_rust 0.1.2
[INFO] tweaked toml for crates.io crate nes_rust 0.1.2 written to /workspace/builds/worker-8/source/Cargo.toml
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+d2e9fff28e244f1ea4927194f1f9b77f93e2ffe2" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update", kill_on_drop: false }`
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+d2e9fff28e244f1ea4927194f1f9b77f93e2ffe2" "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" "+d2e9fff28e244f1ea4927194f1f9b77f93e2ffe2" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 44c16738f28de23c2078f6dcc2fc8b1ea0dd0315800aa11db324de5c15887eb2
[INFO] running `Command { std: "docker" "start" "-a" "44c16738f28de23c2078f6dcc2fc8b1ea0dd0315800aa11db324de5c15887eb2", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "44c16738f28de23c2078f6dcc2fc8b1ea0dd0315800aa11db324de5c15887eb2", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "44c16738f28de23c2078f6dcc2fc8b1ea0dd0315800aa11db324de5c15887eb2", kill_on_drop: false }`
[INFO] [stdout] 44c16738f28de23c2078f6dcc2fc8b1ea0dd0315800aa11db324de5c15887eb2
[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" "+d2e9fff28e244f1ea4927194f1f9b77f93e2ffe2" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 0daf7d7407c518cdad1fb2e0667de315bae56e16ed08de8decbdfb01412c2019
[INFO] running `Command { std: "docker" "start" "-a" "0daf7d7407c518cdad1fb2e0667de315bae56e16ed08de8decbdfb01412c2019", kill_on_drop: false }`
[INFO] [stderr]    Compiling nes_rust v0.1.2 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1.02s
[INFO] running `Command { std: "docker" "inspect" "0daf7d7407c518cdad1fb2e0667de315bae56e16ed08de8decbdfb01412c2019", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "0daf7d7407c518cdad1fb2e0667de315bae56e16ed08de8decbdfb01412c2019", kill_on_drop: false }`
[INFO] [stdout] 0daf7d7407c518cdad1fb2e0667de315bae56e16ed08de8decbdfb01412c2019
[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" "+d2e9fff28e244f1ea4927194f1f9b77f93e2ffe2" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] a5df8dda864b14a719fc9195dfd9aad7e9374a91ab8c781d7f89e1767c7633f4
[INFO] running `Command { std: "docker" "start" "-a" "a5df8dda864b14a719fc9195dfd9aad7e9374a91ab8c781d7f89e1767c7633f4", kill_on_drop: false }`
[INFO] [stderr]    Compiling nes_rust v0.1.2 (/opt/rustwide/workdir)
[INFO] [stdout] warning: unused variable: `r`
[INFO] [stdout]    --> src/rom.rs:200:7
[INFO] [stdout]     |
[INFO] [stdout] 200 |         let r = Rom::new(vec![0; 17]);
[INFO] [stdout]     |             ^ help: if this is intentional, prefix it with an underscore: `_r`
[INFO] [stdout]     |
[INFO] [stdout]     = note: `#[warn(unused_variables)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: 1 warning emitted
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 1.22s
[INFO] running `Command { std: "docker" "inspect" "a5df8dda864b14a719fc9195dfd9aad7e9374a91ab8c781d7f89e1767c7633f4", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "a5df8dda864b14a719fc9195dfd9aad7e9374a91ab8c781d7f89e1767c7633f4", kill_on_drop: false }`
[INFO] [stdout] a5df8dda864b14a719fc9195dfd9aad7e9374a91ab8c781d7f89e1767c7633f4
[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" "+d2e9fff28e244f1ea4927194f1f9b77f93e2ffe2" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 61889f7a1ddd74e076f76ed7de263ddb771dcb90677d64155e4fb1779aa62635
[INFO] running `Command { std: "docker" "start" "-a" "61889f7a1ddd74e076f76ed7de263ddb771dcb90677d64155e4fb1779aa62635", kill_on_drop: false }`
[INFO] [stdout] 
[INFO] [stderr] warning: unused variable: `r`
[INFO] [stdout] running 52 tests
[INFO] [stderr]    --> src/rom.rs:200:7
[INFO] [stdout] test mapper::tests_nrom_mapper::map_with_program_bank_num_1 ... ok
[INFO] [stderr]     |
[INFO] [stdout] test memory::tests_memory::capacity ... ok
[INFO] [stderr] 200 |         let r = Rom::new(vec![0; 17]);
[INFO] [stdout] test memory::tests_memory::clear ... ok
[INFO] [stderr]     |             ^ help: if this is intentional, prefix it with an underscore: `_r`
[INFO] [stdout] test register::tests_register_u16::add ... ok
[INFO] [stderr]     |
[INFO] [stdout] test register::tests_register_u16::clear_bit ... ok
[INFO] [stderr]     = note: `#[warn(unused_variables)]` on by default
[INFO] [stdout] test memory::tests_memory::initialize ... ok
[INFO] [stderr] 
[INFO] [stdout] test register::tests_register_u16::clear ... ok
[INFO] [stderr] warning: `nes_rust` (lib test) generated 1 warning
[INFO] [stdout] test register::tests_register_u16::decrement_by_2 ... ok
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.01s
[INFO] [stdout] test register::tests_register_u16::is_bit_set ... ok
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/nes_rust-4aba9444c0868e00)
[INFO] [stdout] test register::tests_register_u16::load_bit ... ok
[INFO] [stdout] test register::tests_register_u16::set_bit ... ok
[INFO] [stdout] test register::tests_register_u16::shift ... ok
[INFO] [stdout] test register::tests_register_u16::initial_value ... ok
[INFO] [stdout] test register::tests_register_u16::sub ... ok
[INFO] [stdout] test register::tests_register_u16::store_bits ... ok
[INFO] [stdout] test register::tests_register_u16::load_bits ... ok
[INFO] [stdout] test register::tests_register_u16::load ... ok
[INFO] [stdout] test register::tests_register_u8::increment_by_2 ... ok
[INFO] [stdout] test register::tests_register_u8::clear_bit ... ok
[INFO] [stdout] test register::tests_register_u8::clear ... ok
[INFO] [stdout] test register::tests_register_u8::decrement ... ok
[INFO] [stdout] test register::tests_register_u8::shift ... ok
[INFO] [stdout] test register::tests_register_u8::store ... ok
[INFO] [stdout] test register::tests_register_u8::store_bit ... ok
[INFO] [stdout] test rom::tests_rom::initialize ... ok
[INFO] [stdout] test rom::tests_rom::load ... ok
[INFO] [stdout] test rom::tests_rom::valid ... ok
[INFO] [stdout] test register::tests_register_u16::get_width ... ok
[INFO] [stdout] test register::tests_register_u16::increment ... ok
[INFO] [stdout] test register::tests_register_u8::increment ... ok
[INFO] [stdout] test register::tests_register_u16::increment_by_2 ... ok
[INFO] [stdout] test register::tests_register_u8::load ... ok
[INFO] [stdout] test rom::tests_rom::store ... ok
[INFO] [stdout] test register::tests_register_u16::store ... ok
[INFO] [stdout] test register::tests_register_u8::set_bit ... ok
[INFO] [stdout] test register::tests_register_u8::add ... ok
[INFO] [stdout] test register::tests_register_u8::load_bit ... ok
[INFO] [stdout] test register::tests_register_u16::decrement ... ok
[INFO] [stdout] test memory::tests_memory::store_and_load ... ok
[INFO] [stdout] test mapper::tests_nrom_mapper::map_for_chr_rom ... ok
[INFO] [stdout] test register::tests_register_u8::store_bits ... ok
[INFO] [stderr]    Doc-tests nes_rust
[INFO] [stdout] test register::tests_register_u8::is_bit_set ... ok
[INFO] [stdout] test mapper::tests_nrom_mapper::map_with_program_bank_num_2 ... ok
[INFO] [stdout] test register::tests_register_u8::decrement_by_2 ... ok
[INFO] [stdout] test mapper::tests_nrom_mapper::initialize ... ok
[INFO] [stdout] test register::tests_register_u8::get_width ... ok
[INFO] [stdout] test register::tests_register_u8::initial_value ... ok
[INFO] [stdout] test register::tests_register_u8::load_bits ... ok
[INFO] [stdout] test register::tests_register_u16::dump ... ok
[INFO] [stdout] test register::tests_register_u8::sub ... ok
[INFO] [stdout] test register::tests_register_u8::dump ... ok
[INFO] [stdout] test register::tests_register_u16::store_bit ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 52 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.04s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test src/lib.rs - Nes (line 26) ... ignored
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 1 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "61889f7a1ddd74e076f76ed7de263ddb771dcb90677d64155e4fb1779aa62635", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "61889f7a1ddd74e076f76ed7de263ddb771dcb90677d64155e4fb1779aa62635", kill_on_drop: false }`
[INFO] [stdout] 61889f7a1ddd74e076f76ed7de263ddb771dcb90677d64155e4fb1779aa62635