[INFO] cloning repository https://github.com/Barandis/rust-c64
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/Barandis/rust-c64" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FBarandis%2Frust-c64", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FBarandis%2Frust-c64'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 329274f78de06da61ffdb70f7bbb16d2f2f78e9e
[INFO] testing Barandis/rust-c64 against beta-2022-04-10 for beta-1.61-1
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FBarandis%2Frust-c64" "/workspace/builds/worker-33/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-33/source'...
[INFO] [stderr] done.
[INFO] validating manifest of git repo https://github.com/Barandis/rust-c64 on toolchain beta-2022-04-10
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2022-04-10" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking git repo https://github.com/Barandis/rust-c64
[INFO] finished tweaking git repo https://github.com/Barandis/rust-c64
[INFO] tweaked toml for git repo https://github.com/Barandis/rust-c64 written to /workspace/builds/worker-33/source/Cargo.toml
[INFO] crate git repo https://github.com/Barandis/rust-c64 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2022-04-10" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-33/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-33/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:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2022-04-10" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 3e973afe76b05fb37a6b88c6765f5755cd9d18fba81fdbad78069d09e7a55aa7
[INFO] running `Command { std: "docker" "start" "-a" "3e973afe76b05fb37a6b88c6765f5755cd9d18fba81fdbad78069d09e7a55aa7", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "3e973afe76b05fb37a6b88c6765f5755cd9d18fba81fdbad78069d09e7a55aa7", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "3e973afe76b05fb37a6b88c6765f5755cd9d18fba81fdbad78069d09e7a55aa7", kill_on_drop: false }`
[INFO] [stdout] 3e973afe76b05fb37a6b88c6765f5755cd9d18fba81fdbad78069d09e7a55aa7
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-33/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-33/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:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2022-04-10" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 934fd1dedd25b3da22e366085f818f9bef888ca264ef2a467ff9de87f6505270
[INFO] running `Command { std: "docker" "start" "-a" "934fd1dedd25b3da22e366085f818f9bef888ca264ef2a467ff9de87f6505270", kill_on_drop: false }`
[INFO] [stderr]    Compiling c64 v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 5.49s
[INFO] running `Command { std: "docker" "inspect" "934fd1dedd25b3da22e366085f818f9bef888ca264ef2a467ff9de87f6505270", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "934fd1dedd25b3da22e366085f818f9bef888ca264ef2a467ff9de87f6505270", kill_on_drop: false }`
[INFO] [stdout] 934fd1dedd25b3da22e366085f818f9bef888ca264ef2a467ff9de87f6505270
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-33/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-33/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:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2022-04-10" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 4e7e10911af3a5668f2fd4edf06433dacf8453af97a2b4612f8b15a859d634e7
[INFO] running `Command { std: "docker" "start" "-a" "4e7e10911af3a5668f2fd4edf06433dacf8453af97a2b4612f8b15a859d634e7", kill_on_drop: false }`
[INFO] [stderr]    Compiling libc v0.2.69
[INFO] [stderr]    Compiling cfg-if v1.0.0
[INFO] [stderr]    Compiling ppv-lite86 v0.2.10
[INFO] [stderr]    Compiling getrandom v0.2.3
[INFO] [stderr]    Compiling rand_core v0.6.3
[INFO] [stderr]    Compiling rand_chacha v0.3.1
[INFO] [stderr]    Compiling rand v0.8.4
[INFO] [stderr]    Compiling c64 v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 21.43s
[INFO] [stderr]   Executable unittests src/main.rs (/opt/rustwide/target/debug/deps/c64-2c063b5486a97d7b)
[INFO] running `Command { std: "docker" "inspect" "4e7e10911af3a5668f2fd4edf06433dacf8453af97a2b4612f8b15a859d634e7", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "4e7e10911af3a5668f2fd4edf06433dacf8453af97a2b4612f8b15a859d634e7", kill_on_drop: false }`
[INFO] [stdout] 4e7e10911af3a5668f2fd4edf06433dacf8453af97a2b4612f8b15a859d634e7
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-33/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-33/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:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2022-04-10" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 25fd57b1955051acf850caccc40ee95e05a0b467436d68d543f62d8210e68308
[INFO] running `Command { std: "docker" "start" "-a" "25fd57b1955051acf850caccc40ee95e05a0b467436d68d543f62d8210e68308", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.01s
[INFO] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/debug/deps/c64-2c063b5486a97d7b)
[INFO] [stdout] 
[INFO] [stdout] running 141 tests
[INFO] [stdout] test components::pin::test::has_name ... ok
[INFO] [stdout] test components::pin::test::has_number ... ok
[INFO] [stdout] test components::pin::test::level_bidirectional ... ok
[INFO] [stdout] test components::pin::test::level_input ... ok
[INFO] [stdout] test components::pin::test::level_no_trace ... ok
[INFO] [stdout] test components::pin::test::level_output ... ok
[INFO] [stdout] test components::pin::test::level_toggle_float ... ok
[INFO] [stdout] test components::pin::test::level_toggle_high ... ok
[INFO] [stdout] test components::pin::test::level_toggle_low ... ok
[INFO] [stdout] test components::pin::test::level_unconnected ... ok
[INFO] [stdout] test components::pin::test::level_update_no_trace ... ok
[INFO] [stdout] test components::pin::test::mode_bidi_to_in ... ok
[INFO] [stdout] test components::pin::test::mode_change ... ok
[INFO] [stdout] test components::pin::test::mode_bidi_to_out ... ok
[INFO] [stdout] test components::pin::test::observer_bidirectional ... ok
[INFO] [stdout] test components::pin::test::observer_detach ... ok
[INFO] [stdout] test components::pin::test::mode_initial ... ok
[INFO] [stdout] test components::pin::test::mode_unc_to_in ... ok
[INFO] [stdout] test components::pin::test::mode_unc_to_out ... ok
[INFO] [stdout] test components::pin::test::mode_in_to_unc ... ok
[INFO] [stdout] test components::pin::test::mode_out_to_in ... ok
[INFO] [stdout] test components::pin::test::observer_direct ... ok
[INFO] [stdout] test components::pin::test::observer_input ... ok
[INFO] [stdout] test components::pin::test::observer_non_existent ... ok
[INFO] [stdout] test components::pin::test::observer_output ... ok
[INFO] [stdout] test components::pin::test::observer_unconnected ... ok
[INFO] [stdout] test components::pin::test::pull_down_after ... ok
[INFO] [stdout] test components::pin::test::pull_down_bidirectional ... ok
[INFO] [stdout] test components::pin::test::pull_down_initial ... ok
[INFO] [stdout] test components::pin::test::pull_down_input ... ok
[INFO] [stdout] test components::pin::test::pull_down_output ... ok
[INFO] [stdout] test components::pin::test::pull_down_unconnected ... ok
[INFO] [stdout] test components::pin::test::pull_off_initial ... ok
[INFO] [stdout] test components::pin::test::pull_off_pull_down ... ok
[INFO] [stdout] test components::pin::test::pull_off_pull_up ... ok
[INFO] [stdout] test components::pin::test::pull_up_after ... ok
[INFO] [stdout] test components::pin::test::pull_up_bidirectional ... ok
[INFO] [stdout] test components::pin::test::pull_up_initial ... ok
[INFO] [stdout] test components::pin::test::pull_up_input ... ok
[INFO] [stdout] test components::pin::test::pull_up_output ... ok
[INFO] [stdout] test components::pin::test::pull_up_unconnected ... ok
[INFO] [stdout] test components::trace::test::level_direct_input ... ok
[INFO] [stdout] test components::trace::test::level_direct_output_float ... ok
[INFO] [stdout] test components::trace::test::level_direct_output_high ... ok
[INFO] [stdout] test components::trace::test::level_direct_output_low ... ok
[INFO] [stdout] test components::trace::test::level_direct_unconnected ... ok
[INFO] [stdout] test components::trace::test::level_pin_bidirectional ... ok
[INFO] [stdout] test components::trace::test::level_pin_input ... ok
[INFO] [stdout] test components::trace::test::level_pin_ouput ... ok
[INFO] [stdout] test components::trace::test::level_pin_outputs_high ... ok
[INFO] [stdout] test components::trace::test::level_pin_outputs_low ... ok
[INFO] [stdout] test components::trace::test::level_pin_unconnected ... ok
[INFO] [stdout] test components::trace::test::no_add_twice ... ok
[INFO] [stdout] test components::trace::test::pull_down_initial ... ok
[INFO] [stdout] test components::trace::test::pull_down_input ... ok
[INFO] [stdout] test components::trace::test::pull_down_output_floating ... ok
[INFO] [stdout] test components::trace::test::pull_down_output_high ... ok
[INFO] [stdout] test components::trace::test::pull_down_output_low ... ok
[INFO] [stdout] test components::trace::test::pull_down_output_none ... ok
[INFO] [stdout] test components::trace::test::pull_off_input ... ok
[INFO] [stdout] test components::trace::test::pull_off_initial ... ok
[INFO] [stdout] test components::trace::test::pull_off_output_floating ... ok
[INFO] [stdout] test components::trace::test::pull_off_output_high ... ok
[INFO] [stdout] test components::trace::test::pull_off_output_low ... ok
[INFO] [stdout] test components::trace::test::pull_off_output_none ... ok
[INFO] [stdout] test components::trace::test::pull_up_initial ... ok
[INFO] [stdout] test components::trace::test::pull_up_input ... ok
[INFO] [stdout] test components::trace::test::pull_up_output_floating ... ok
[INFO] [stdout] test components::trace::test::pull_up_output_high ... ok
[INFO] [stdout] test components::trace::test::pull_up_output_low ... ok
[INFO] [stdout] test components::trace::test::pull_up_output_none ... ok
[INFO] [stdout] test devices::chips::ic4066::test::disconnect_on_high_x ... ok
[INFO] [stdout] test devices::chips::ic4066::test::last_set_a ... ok
[INFO] [stdout] test devices::chips::ic4066::test::last_set_b ... ok
[INFO] [stdout] test devices::chips::ic4066::test::no_pass_a_to_b_on_high_x ... ok
[INFO] [stdout] test devices::chips::ic4066::test::no_pass_b_to_a_on_high_x ... ok
[INFO] [stdout] test devices::chips::ic4066::test::pass_b_to_a ... ok
[INFO] [stdout] test devices::chips::ic4066::test::pass_a_to_b ... ok
[INFO] [stdout] test devices::chips::ic4164::test::read_mode_enable_q ... ok
[INFO] [stdout] test devices::chips::ic4066::test::unset_before_high_x ... ok
[INFO] [stdout] test devices::chips::ic4164::test::read_write_one_bit ... ok
[INFO] [stdout] test devices::chips::ic4164::test::rmw_mode_enable_q ... ok
[INFO] [stdout] test devices::chips::ic7406::test::input_high ... ok
[INFO] [stdout] test devices::chips::ic4164::test::rmw_one_bit ... ok
[INFO] [stdout] test devices::chips::ic7406::test::input_low ... ok
[INFO] [stdout] test devices::chips::ic7406::test::input_high_no_macro ... ok
[INFO] [stdout] test devices::chips::ic4164::test::read_write_no_rmw_q ... ok
[INFO] [stdout] test devices::chips::ic7406::test::input_low_no_macro ... ok
[INFO] [stdout] test devices::chips::ic7408::test::gate_1 ... ok
[INFO] [stdout] test devices::chips::ic4164::test::read_write_rmw_q ... ok
[INFO] [stdout] test devices::chips::ic4164::test::write_mode_disable_q ... ok
[INFO] [stdout] test devices::chips::ic7408::test::gate_3 ... ok
[INFO] [stdout] test devices::chips::ic7408::test::gate_2 ... ok
[INFO] [stdout] test devices::chips::ic74139::test::demux_1_g_high ... ok
[INFO] [stdout] test devices::chips::ic7408::test::gate_4 ... ok
[INFO] [stdout] test devices::chips::ic74139::test::demux_1_high_high ... ok
[INFO] [stdout] test devices::chips::ic74139::test::demux_1_high_low ... ok
[INFO] [stdout] test devices::chips::ic74139::test::demux_1_low_low ... ok
[INFO] [stdout] test devices::chips::ic74139::test::demux_1_low_high ... ok
[INFO] [stdout] test devices::chips::ic74139::test::demux_2_high_low ... ok
[INFO] [stdout] test devices::chips::ic74139::test::demux_2_high_high ... ok
[INFO] [stdout] test devices::chips::ic74139::test::demux_2_g_high ... ok
[INFO] [stdout] test devices::chips::ic74257::test::mux_1_oe_high ... ok
[INFO] [stdout] test devices::chips::ic74139::test::demux_2_low_low ... ok
[INFO] [stdout] test devices::chips::ic74139::test::demux_2_low_high ... ok
[INFO] [stdout] test devices::chips::ic74257::test::mux_1_select_a ... ok
[INFO] [stdout] test devices::chips::ic74257::test::mux_1_select_b ... ok
[INFO] [stdout] test devices::chips::ic74257::test::mux_2_oe_high ... ok
[INFO] [stdout] test devices::chips::ic74257::test::mux_2_select_a ... ok
[INFO] [stdout] test devices::chips::ic74257::test::mux_2_select_b ... ok
[INFO] [stdout] test devices::chips::ic74257::test::mux_3_oe_high ... ok
[INFO] [stdout] test devices::chips::ic74257::test::mux_3_select_b ... ok
[INFO] [stdout] test devices::chips::ic74257::test::mux_3_select_a ... ok
[INFO] [stdout] test devices::chips::ic4164::test::read_write_page ... ok
[INFO] [stdout] test devices::chips::ic74257::test::mux_4_oe_high ... ok
[INFO] [stdout] test devices::chips::ic74257::test::mux_4_select_a ... ok
[INFO] [stdout] test devices::chips::ic74257::test::mux_4_select_b ... ok
[INFO] [stdout] test devices::chips::ic74258::test::mux_1_select_a ... ok
[INFO] [stdout] test devices::chips::ic74258::test::mux_1_oe_high ... ok
[INFO] [stdout] test devices::chips::ic74258::test::mux_1_select_b ... ok
[INFO] [stdout] test devices::chips::ic74258::test::mux_2_oe_high ... ok
[INFO] [stdout] test devices::chips::ic74258::test::mux_2_select_a ... ok
[INFO] [stdout] test devices::chips::ic74258::test::mux_2_select_b ... ok
[INFO] [stdout] test devices::chips::ic74258::test::mux_3_oe_high ... ok
[INFO] [stdout] test devices::chips::ic74258::test::mux_3_select_a ... ok
[INFO] [stdout] test devices::chips::ic74258::test::mux_3_select_b ... ok
[INFO] [stdout] test devices::chips::ic74258::test::mux_4_oe_high ... ok
[INFO] [stdout] test devices::chips::ic74258::test::mux_4_select_a ... ok
[INFO] [stdout] test devices::chips::ic74258::test::mux_4_select_b ... ok
[INFO] [stdout] test devices::chips::ic74373::test::latch_low_le ... ok
[INFO] [stdout] test devices::chips::ic74373::test::pass_high_le ... ok
[INFO] [stdout] test devices::chips::ic74373::test::float_high_oe ... ok
[INFO] [stdout] test devices::chips::ic82s100::test::disable_out_on_high_oe ... ok
[INFO] [stdout] test devices::chips::ic74373::test::pass_return_to_high_le ... ok
[INFO] [stdout] test devices::chips::ic74373::test::recall_latch_high_oe ... ok
[INFO] [stdout] test devices::chips::ic2114::test::read_and_write ... ok
[INFO] [stdout] test devices::chips::ic2332::test::read_full ... ok
[INFO] [stdout] test devices::chips::ic2364::test::read_full_basic ... ok
[INFO] [stdout] test devices::chips::ic2364::test::read_full_kernal ... ok
[INFO] [stdout] test devices::chips::ic82s100::test::logic_combinations ... ok
[INFO] [stdout] test devices::chips::ic4164::test::read_write_full ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 141 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 5.85s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "25fd57b1955051acf850caccc40ee95e05a0b467436d68d543f62d8210e68308", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "25fd57b1955051acf850caccc40ee95e05a0b467436d68d543f62d8210e68308", kill_on_drop: false }`
[INFO] [stdout] 25fd57b1955051acf850caccc40ee95e05a0b467436d68d543f62d8210e68308