[INFO] fetching crate iz80 0.4.4...
[INFO] testing iz80-0.4.4 against try#8de4c7234dd9b97c9d76b58671343fdbbc9a433e+target=x86_64-unknown-linux-musl for musl_upgrade_1_2_5_with_libc_patch_0
[INFO] extracting crate iz80 0.4.4 into /workspace/builds/worker-1-tc1/source
[INFO] started tweaking crates.io crate iz80 0.4.4
[INFO] removed 0 missing examples
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate iz80 0.4.4
[INFO] tweaked toml for crates.io crate iz80 0.4.4 written to /workspace/builds/worker-1-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate iz80 0.4.4 on toolchain 8de4c7234dd9b97c9d76b58671343fdbbc9a433e
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+8de4c7234dd9b97c9d76b58671343fdbbc9a433e" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate iz80 0.4.4 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+8de4c7234dd9b97c9d76b58671343fdbbc9a433e" "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-1-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/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:90999bfc7ae267e83380e433d8e61a7c072ca6729e92edbae886d3423b3a6f4c" "/opt/rustwide/cargo-home/bin/cargo" "+8de4c7234dd9b97c9d76b58671343fdbbc9a433e" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] ed292b0b5e6ed14c3d836400190630548ee818c4717f5b5a1043c47b54bcbc45
[INFO] running `Command { std: "docker" "start" "-a" "ed292b0b5e6ed14c3d836400190630548ee818c4717f5b5a1043c47b54bcbc45", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "ed292b0b5e6ed14c3d836400190630548ee818c4717f5b5a1043c47b54bcbc45", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "ed292b0b5e6ed14c3d836400190630548ee818c4717f5b5a1043c47b54bcbc45", kill_on_drop: false }`
[INFO] [stdout] ed292b0b5e6ed14c3d836400190630548ee818c4717f5b5a1043c47b54bcbc45
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/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" "RUSTDOCFLAGS=--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:90999bfc7ae267e83380e433d8e61a7c072ca6729e92edbae886d3423b3a6f4c" "/opt/rustwide/cargo-home/bin/cargo" "+8de4c7234dd9b97c9d76b58671343fdbbc9a433e" "build" "--frozen" "--message-format=json" "--target" "x86_64-unknown-linux-musl", kill_on_drop: false }`
[INFO] [stdout] 6343b0b36f1c8c11313aff42680a39b524a3decc3e2f153bdd9550778915a23a
[INFO] running `Command { std: "docker" "start" "-a" "6343b0b36f1c8c11313aff42680a39b524a3decc3e2f153bdd9550778915a23a", kill_on_drop: false }`
[INFO] [stderr]    Compiling iz80 v0.4.4 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 0.48s
[INFO] running `Command { std: "docker" "inspect" "6343b0b36f1c8c11313aff42680a39b524a3decc3e2f153bdd9550778915a23a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "6343b0b36f1c8c11313aff42680a39b524a3decc3e2f153bdd9550778915a23a", kill_on_drop: false }`
[INFO] [stdout] 6343b0b36f1c8c11313aff42680a39b524a3decc3e2f153bdd9550778915a23a
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/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" "RUSTDOCFLAGS=--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:90999bfc7ae267e83380e433d8e61a7c072ca6729e92edbae886d3423b3a6f4c" "/opt/rustwide/cargo-home/bin/cargo" "+8de4c7234dd9b97c9d76b58671343fdbbc9a433e" "test" "--frozen" "--no-run" "--message-format=json" "--target" "x86_64-unknown-linux-musl", kill_on_drop: false }`
[INFO] [stdout] 839908778aa4e7df7866ea3b225f5d83341e45bc183ea5aef80821ae51c6f715
[INFO] running `Command { std: "docker" "start" "-a" "839908778aa4e7df7866ea3b225f5d83341e45bc183ea5aef80821ae51c6f715", kill_on_drop: false }`
[INFO] [stderr]    Compiling iz80 v0.4.4 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 1.86s
[INFO] running `Command { std: "docker" "inspect" "839908778aa4e7df7866ea3b225f5d83341e45bc183ea5aef80821ae51c6f715", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "839908778aa4e7df7866ea3b225f5d83341e45bc183ea5aef80821ae51c6f715", kill_on_drop: false }`
[INFO] [stdout] 839908778aa4e7df7866ea3b225f5d83341e45bc183ea5aef80821ae51c6f715
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/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" "RUSTDOCFLAGS=--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:90999bfc7ae267e83380e433d8e61a7c072ca6729e92edbae886d3423b3a6f4c" "/opt/rustwide/cargo-home/bin/cargo" "+8de4c7234dd9b97c9d76b58671343fdbbc9a433e" "test" "--frozen" "--target" "x86_64-unknown-linux-musl", kill_on_drop: false }`
[INFO] [stdout] cc880f4aab2fc2445f42ff2e486c572bd7809962586c0738252d351667a8f4ca
[INFO] running `Command { std: "docker" "start" "-a" "cc880f4aab2fc2445f42ff2e486c572bd7809962586c0738252d351667a8f4ca", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.04s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/x86_64-unknown-linux-musl/debug/deps/iz80-854c7970f64b50d1)
[INFO] [stdout] 
[INFO] [stdout] running 4 tests
[INFO] [stdout] test registers::tests::set_get_16bit_register ... ok
[INFO] [stdout] test registers::tests::set_get_8bit_register ... ok
[INFO] [stdout] test registers::tests::set_get_flag ... ok
[INFO] [stdout] test machine::tests::set_get_byte ... 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 tests/cputest.rs (/opt/rustwide/target/x86_64-unknown-linux-musl/debug/deps/cputest-85f1f1be1853a79e)
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test test_cpu_test_8080 ... ok
[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 5.04s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]      Running tests/disasm_z80.rs (/opt/rustwide/target/x86_64-unknown-linux-musl/debug/deps/disasm_z80-c078a43fa1109e63)
[INFO] [stdout] running 3 tests
[INFO] [stdout] test test_disasm_nop ... ok
[INFO] [stdout] test test_disasm_ld_hl_n ... ok
[INFO] [stderr]      Running tests/ex8080.rs (/opt/rustwide/target/x86_64-unknown-linux-musl/debug/deps/ex8080-5f6101c22a65a9a5)
[INFO] [stdout] test test_disasm_ld_ix_d_n ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[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/interrupts.rs (/opt/rustwide/target/x86_64-unknown-linux-musl/debug/deps/interrupts-a2ce6c98559df6df)
[INFO] [stdout] 
[INFO] [stdout] running 4 tests
[INFO] [stdout] test test_ei_on_handler ... ok
[INFO] [stdout] test test_ei_on_handler_int_not_lowered ... ok
[INFO] [stdout] test test_ei ... ok
[INFO] [stdout] test test_di ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/opcodes.rs (/opt/rustwide/target/x86_64-unknown-linux-musl/debug/deps/opcodes-e9f5ddd58522ff7f)
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[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.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/opcodes_alu.rs (/opt/rustwide/target/x86_64-unknown-linux-musl/debug/deps/opcodes_alu-5ef1d9c761cead04)
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[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.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/opcodes_arith.rs (/opt/rustwide/target/x86_64-unknown-linux-musl/debug/deps/opcodes_arith-43b99607338f1c16)
[INFO] [stdout] 
[INFO] [stdout] running 12 tests
[INFO] [stdout] test test_inc_de ... ok
[INFO] [stdout] test test_dec_a_underflow ... ok
[INFO] [stdout] test test_inc_e ... ok
[INFO] [stdout] test test_dec_de ... ok
[INFO] [stdout] test test_inc_de_overflow ... ok
[INFO] [stdout] test test_dec_phl ... ok
[INFO] [stdout] test test_neg_a ... ok
[INFO] [stdout] test test_add_hl_de ... ok
[INFO] [stdout] test test_inc_a_overflow ... ok
[INFO] [stdout] test test_dec_de_underflow ... ok
[INFO] [stdout] test test_dec_a ... ok
[INFO] [stdout] test test_inc_a ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 12 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/opcodes_bits.rs (/opt/rustwide/target/x86_64-unknown-linux-musl/debug/deps/opcodes_bits-0f2c0b9e0518d54f)
[INFO] [stdout] 
[INFO] [stdout] running 15 tests
[INFO] [stdout] test test_rld ... ok
[INFO] [stdout] test test_res_c ... ok
[INFO] [stdout] test test_cpl ... ok
[INFO] [stdout] test test_rl_b ... ok
[INFO] [stdout] test test_set_b ... ok
[INFO] [stdout] test test_rrca_fast ... ok
[INFO] [stdout] test test_sll_d ... ok
[INFO] [stdout] test test_bit_a ... ok
[INFO] [stdout] test test_srl_d ... ok
[INFO] [stdout] test test_sra_c ... ok
[INFO] [stdout] test test_rrc_a ... ok
[INFO] [stdout] test test_rr_b ... ok
[INFO] [stdout] test test_rlc_a ... ok
[INFO] [stdout] test test_sla_c ... ok
[INFO] [stdout] test test_rrd ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 15 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/opcodes_io.rs (/opt/rustwide/target/x86_64-unknown-linux-musl/debug/deps/opcodes_io-53bd726b41d92c39)
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test test_out_e ... ok
[INFO] [stdout] test test_in_e ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/opcodes_jumps.rs (/opt/rustwide/target/x86_64-unknown-linux-musl/debug/deps/opcodes_jumps-fb28064ce791b3c1)
[INFO] [stdout] 
[INFO] [stdout] running 9 tests
[INFO] [stdout] test test_call_z_jump ... ok
[INFO] [stdout] test test_jp ... ok
[INFO] [stdout] test test_call_z_no_jump ... ok
[INFO] [stdout] test test_jr_z_jump ... ok
[INFO] [stdout] test test_call_ret ... ok
[INFO] [stdout] test test_call ... ok
[INFO] [stdout] test test_rst ... ok
[INFO] [stdout] test test_djnz_no_jump ... ok
[INFO] [stdout] test test_djnz_jump ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 9 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/opcodes_ld.rs (/opt/rustwide/target/x86_64-unknown-linux-musl/debug/deps/opcodes_ld-bdbba0cc1024550d)
[INFO] [stdout] 
[INFO] [stdout] running 6 tests
[INFO] [stdout] test test_ld_bc_nn ... ok
[INFO] [stdout] test test_ld_a_b ... ok
[INFO] [stdout] test test_ld_bc_pnn ... ok
[INFO] [stdout] test test_ld_pnn_bc ... ok
[INFO] [stdout] test test_ld_b_n ... ok
[INFO] [stdout] test test_ld_d_e ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/serialization.rs (/opt/rustwide/target/x86_64-unknown-linux-musl/debug/deps/serialization-e8ae057c754c053b)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test test_serialization_deserialization ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/z80test.rs (/opt/rustwide/target/x86_64-unknown-linux-musl/debug/deps/z80test-7ac925600b2e3b84)
[INFO] [stdout] 
[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] [stderr]      Running tests/zexall.rs (/opt/rustwide/target/x86_64-unknown-linux-musl/debug/deps/zexall-0ab55a8ac4737498)
[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] running `Command { std: "docker" "inspect" "cc880f4aab2fc2445f42ff2e486c572bd7809962586c0738252d351667a8f4ca", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "cc880f4aab2fc2445f42ff2e486c572bd7809962586c0738252d351667a8f4ca", kill_on_drop: false }`
[INFO] [stdout] cc880f4aab2fc2445f42ff2e486c572bd7809962586c0738252d351667a8f4ca