[INFO] fetching crate iz80 0.3.4...
[INFO] testing iz80-0.3.4 against beta-2022-02-22 for beta-1.60-1
[INFO] extracting crate iz80 0.3.4 into /workspace/builds/worker-103/source
[INFO] validating manifest of crates.io crate iz80 0.3.4 on toolchain beta-2022-02-22
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2022-02-22" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate iz80 0.3.4
[INFO] finished tweaking crates.io crate iz80 0.3.4
[INFO] tweaked toml for crates.io crate iz80 0.3.4 written to /workspace/builds/worker-103/source/Cargo.toml
[INFO] crate crates.io crate iz80 0.3.4 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2022-02-22" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-103/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-103/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:0cd99ca24d8e8c98e67c542213511d985b8778b5bdcbb160e038429496686047" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2022-02-22" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 6016e3b5e10311ac1271df9d7263d9f5a16fa9d09a9e3d1d706158ae68ab4a6f
[INFO] running `Command { std: "docker" "start" "-a" "6016e3b5e10311ac1271df9d7263d9f5a16fa9d09a9e3d1d706158ae68ab4a6f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "6016e3b5e10311ac1271df9d7263d9f5a16fa9d09a9e3d1d706158ae68ab4a6f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "6016e3b5e10311ac1271df9d7263d9f5a16fa9d09a9e3d1d706158ae68ab4a6f", kill_on_drop: false }`
[INFO] [stdout] 6016e3b5e10311ac1271df9d7263d9f5a16fa9d09a9e3d1d706158ae68ab4a6f
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-103/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-103/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:0cd99ca24d8e8c98e67c542213511d985b8778b5bdcbb160e038429496686047" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2022-02-22" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 1fbbeb164f5e4118b997f2c95e4ca1398075ab5f8bd462d8c9c81c3949e88948
[INFO] running `Command { std: "docker" "start" "-a" "1fbbeb164f5e4118b997f2c95e4ca1398075ab5f8bd462d8c9c81c3949e88948", kill_on_drop: false }`
[INFO] [stderr]    Compiling iz80 v0.3.4 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1.74s
[INFO] running `Command { std: "docker" "inspect" "1fbbeb164f5e4118b997f2c95e4ca1398075ab5f8bd462d8c9c81c3949e88948", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "1fbbeb164f5e4118b997f2c95e4ca1398075ab5f8bd462d8c9c81c3949e88948", kill_on_drop: false }`
[INFO] [stdout] 1fbbeb164f5e4118b997f2c95e4ca1398075ab5f8bd462d8c9c81c3949e88948
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-103/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-103/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:0cd99ca24d8e8c98e67c542213511d985b8778b5bdcbb160e038429496686047" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2022-02-22" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] d1f97aa85ae7bb0e67248a6b86f67afd950b87a34b13b87cc507b32647bb212b
[INFO] running `Command { std: "docker" "start" "-a" "d1f97aa85ae7bb0e67248a6b86f67afd950b87a34b13b87cc507b32647bb212b", kill_on_drop: false }`
[INFO] [stderr]    Compiling iz80 v0.3.4 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 1.15s
[INFO] running `Command { std: "docker" "inspect" "d1f97aa85ae7bb0e67248a6b86f67afd950b87a34b13b87cc507b32647bb212b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "d1f97aa85ae7bb0e67248a6b86f67afd950b87a34b13b87cc507b32647bb212b", kill_on_drop: false }`
[INFO] [stdout] d1f97aa85ae7bb0e67248a6b86f67afd950b87a34b13b87cc507b32647bb212b
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-103/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-103/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:0cd99ca24d8e8c98e67c542213511d985b8778b5bdcbb160e038429496686047" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2022-02-22" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 0527758bda2ef35e3fb8a0cf5df7a74ff22049cfcc0490ecc570befb7bf775e0
[INFO] running `Command { std: "docker" "start" "-a" "0527758bda2ef35e3fb8a0cf5df7a74ff22049cfcc0490ecc570befb7bf775e0", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.04s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/iz80-7d1797158f8d469b)
[INFO] [stdout] 
[INFO] [stdout] running 4 tests
[INFO] [stdout] test registers::tests::set_get_16bit_register ... ok
[INFO] [stdout] test machine::tests::set_get_byte ... ok
[INFO] [stdout] test registers::tests::set_get_8bit_register ... ok
[INFO] [stdout] test registers::tests::set_get_flag ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/cpuville-032fb1057d0304ff)
[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] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/simplest-482f683e09a30b32)
[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] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/simplest8080-485ffa1ea74cfd59)
[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] [stderr]      Running tests/cputest.rs (/opt/rustwide/target/debug/deps/cputest-7a07db1327c27939)
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test test_cpu_test_8080 ... ok
[INFO] [stderr]      Running tests/ex8080.rs (/opt/rustwide/target/debug/deps/ex8080-8c40552ad22f11a6)
[INFO] [stdout] test test_cpu_test_z80 ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 7.30s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test test_ex8080 ... ignored
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 1 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/opcodes.rs (/opt/rustwide/target/debug/deps/opcodes-9e19daf7b90edcc4)
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stderr]      Running tests/opcodes_alu.rs (/opt/rustwide/target/debug/deps/opcodes_alu-7e4279e94e7d795d)
[INFO] [stdout] test test_push_pop_rr ... ok
[INFO] [stdout] test test_two_opcodes ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stderr]      Running tests/opcodes_arith.rs (/opt/rustwide/target/debug/deps/opcodes_arith-bb3dde4d776cb8e7)
[INFO] [stdout] test test_cp_a ... ok
[INFO] [stdout] test test_cp_a_2 ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 12 tests
[INFO] [stdout] test test_dec_a ... ok
[INFO] [stdout] test test_dec_de ... ok
[INFO] [stdout] test test_dec_de_underflow ... ok
[INFO] [stdout] test test_add_hl_de ... ok
[INFO] [stdout] test test_dec_a_underflow ... ok
[INFO] [stdout] test test_dec_phl ... ok
[INFO] [stdout] test test_inc_a ... ok
[INFO] [stdout] test test_inc_e ... ok
[INFO] [stdout] test test_inc_de ... ok
[INFO] [stdout] test test_neg_a ... ok
[INFO] [stderr]      Running tests/opcodes_bits.rs (/opt/rustwide/target/debug/deps/opcodes_bits-a68aeff5d5a5e51e)
[INFO] [stdout] test test_inc_a_overflow ... ok
[INFO] [stdout] test test_inc_de_overflow ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 12 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.07s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 15 tests
[INFO] [stdout] test test_srl_d ... ok
[INFO] [stdout] test test_sra_c ... ok
[INFO] [stdout] test test_rlc_a ... ok
[INFO] [stdout] test test_rld ... ok
[INFO] [stdout] test test_rrc_a ... ok
[INFO] [stdout] test test_cpl ... ok
[INFO] [stdout] test test_rr_b ... ok
[INFO] [stdout] test test_rl_b ... ok
[INFO] [stdout] test test_sll_d ... ok
[INFO] [stdout] test test_rrd ... ok
[INFO] [stdout] test test_rrca_fast ... ok
[INFO] [stdout] test test_sla_c ... ok
[INFO] [stderr]      Running tests/opcodes_io.rs (/opt/rustwide/target/debug/deps/opcodes_io-7073683dd35739b9)
[INFO] [stdout] test test_res_c ... ok
[INFO] [stdout] test test_bit_a ... ok
[INFO] [stdout] test test_set_b ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 15 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.07s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test test_in_e ... ok
[INFO] [stdout] test test_out_e ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/opcodes_jumps.rs (/opt/rustwide/target/debug/deps/opcodes_jumps-f3160372d42a73d6)
[INFO] [stdout] 
[INFO] [stdout] running 9 tests
[INFO] [stdout] test test_call_ret ... ok
[INFO] [stdout] test test_call_z_jump ... ok
[INFO] [stdout] test test_call ... ok
[INFO] [stdout] test test_rst ... ok
[INFO] [stdout] test test_djnz_jump ... ok
[INFO] [stdout] test test_call_z_no_jump ... ok
[INFO] [stdout] test test_jr_z_jump ... ok
[INFO] [stdout] test test_djnz_no_jump ... ok
[INFO] [stdout] test test_jp ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 9 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.08s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/opcodes_ld.rs (/opt/rustwide/target/debug/deps/opcodes_ld-dbe790f83350e64e)
[INFO] [stdout] 
[INFO] [stdout] running 6 tests
[INFO] [stdout] test test_ld_a_b ... ok
[INFO] [stdout] test test_ld_pnn_bc ... ok
[INFO] [stdout] test test_ld_bc_nn ... ok
[INFO] [stdout] test test_ld_b_n ... ok
[INFO] [stdout] test test_ld_d_e ... ok
[INFO] [stdout] test test_ld_bc_pnn ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/z80test.rs (/opt/rustwide/target/debug/deps/z80test-12a817382801f761)
[INFO] [stdout] 
[INFO] [stderr]      Running tests/zexall.rs (/opt/rustwide/target/debug/deps/zexall-82b7a9029ab30788)
[INFO] [stdout] running 1 test
[INFO] [stdout] test z80test ... ignored
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 1 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test test_zexall ... ignored
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 1 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests iz80
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test src/lib.rs - (line 10) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 2.28s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "0527758bda2ef35e3fb8a0cf5df7a74ff22049cfcc0490ecc570befb7bf775e0", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "0527758bda2ef35e3fb8a0cf5df7a74ff22049cfcc0490ecc570befb7bf775e0", kill_on_drop: false }`
[INFO] [stdout] 0527758bda2ef35e3fb8a0cf5df7a74ff22049cfcc0490ecc570befb7bf775e0