[INFO] fetching crate user-mode-riscv 0.1.0...
[INFO] testing user-mode-riscv-0.1.0 against beta-2022-02-22 for beta-1.60-1
[INFO] extracting crate user-mode-riscv 0.1.0 into /workspace/builds/worker-51/source
[INFO] validating manifest of crates.io crate user-mode-riscv 0.1.0 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 user-mode-riscv 0.1.0
[INFO] finished tweaking crates.io crate user-mode-riscv 0.1.0
[INFO] tweaked toml for crates.io crate user-mode-riscv 0.1.0 written to /workspace/builds/worker-51/source/Cargo.toml
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2022-02-22" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[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-51/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-51/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] b769d40acdafe1df4804fbdc349e7a76cc5b1a2c1b371e633bb7d262adfabba8
[INFO] running `Command { std: "docker" "start" "-a" "b769d40acdafe1df4804fbdc349e7a76cc5b1a2c1b371e633bb7d262adfabba8", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "b769d40acdafe1df4804fbdc349e7a76cc5b1a2c1b371e633bb7d262adfabba8", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "b769d40acdafe1df4804fbdc349e7a76cc5b1a2c1b371e633bb7d262adfabba8", kill_on_drop: false }`
[INFO] [stdout] b769d40acdafe1df4804fbdc349e7a76cc5b1a2c1b371e633bb7d262adfabba8
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-51/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-51/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] 96bc68c8acf7390363b190e1a34cb430c54d16c8c87cd2d6199a3b3b703ed069
[INFO] running `Command { std: "docker" "start" "-a" "96bc68c8acf7390363b190e1a34cb430c54d16c8c87cd2d6199a3b3b703ed069", kill_on_drop: false }`
[INFO] [stderr]    Compiling user-mode-riscv v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1.10s
[INFO] running `Command { std: "docker" "inspect" "96bc68c8acf7390363b190e1a34cb430c54d16c8c87cd2d6199a3b3b703ed069", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "96bc68c8acf7390363b190e1a34cb430c54d16c8c87cd2d6199a3b3b703ed069", kill_on_drop: false }`
[INFO] [stdout] 96bc68c8acf7390363b190e1a34cb430c54d16c8c87cd2d6199a3b3b703ed069
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-51/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-51/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] c65670de71106788fe68f5fe7ed1874ce5be37d6f1d6f2d3c0b7df79de8e8bde
[INFO] running `Command { std: "docker" "start" "-a" "c65670de71106788fe68f5fe7ed1874ce5be37d6f1d6f2d3c0b7df79de8e8bde", kill_on_drop: false }`
[INFO] [stderr]    Compiling log v0.4.14
[INFO] [stderr]    Compiling zero v0.1.2
[INFO] [stderr]    Compiling cfg-if v1.0.0
[INFO] [stderr]    Compiling bitflags v1.3.2
[INFO] [stderr]    Compiling xmas-elf v0.7.0
[INFO] [stderr]    Compiling elfloader v0.11.0
[INFO] [stderr]    Compiling user-mode-riscv v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 2.95s
[INFO] running `Command { std: "docker" "inspect" "c65670de71106788fe68f5fe7ed1874ce5be37d6f1d6f2d3c0b7df79de8e8bde", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "c65670de71106788fe68f5fe7ed1874ce5be37d6f1d6f2d3c0b7df79de8e8bde", kill_on_drop: false }`
[INFO] [stdout] c65670de71106788fe68f5fe7ed1874ce5be37d6f1d6f2d3c0b7df79de8e8bde
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-51/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-51/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] 319c730a9f0c231729012266ab6666a0bf8010185ab6b26246e14e3dc60e2c97
[INFO] running `Command { std: "docker" "start" "-a" "319c730a9f0c231729012266ab6666a0bf8010185ab6b26246e14e3dc60e2c97", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.02s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/user_mode_riscv-e600e4b257d25e97)
[INFO] [stdout] 
[INFO] [stdout] running 110 tests
[INFO] [stdout] test cpu::test_cpu::decode_fld_compressed_instruction ... ok
[INFO] [stdout] test cpu::test_cpu::babys_first_instruction ... ok
[INFO] [stdout] test cpu::test_cpu::decode_srai_compressed_instruction ... ok
[INFO] [stdout] test cpu::test_cpu::two_compressed_instruction ... ok
[INFO] [stdout] test test::rv64_ud_p::rv64ud_p_move ... ignored
[INFO] [stdout] test test::rv64_uf_p::decode_frcsr ... ok
[INFO] [stdout] test test::rv64_ua_p::rv64ua_p_amoand_d ... ok
[INFO] [stdout] test test::rv64_uf_p::rv64uf_p_move ... ignored
[INFO] [stdout] test test::rv64_ua_p::rv64ua_p_amoswap_d ... ok
[INFO] [stdout] test test::rv64_ua_p::rv64ua_p_amominu_d ... ok
[INFO] [stdout] test test::examples::mandelbrot ... ok
[INFO] [stdout] test test::rv64_ua_p::rv64ua_p_amomax_w ... ok
[INFO] [stdout] test test::rv64_ua_p::rv64ua_p_amoand_w ... ok
[INFO] [stdout] test test::rv64_ua_p::rv64ua_p_amomin_w ... ok
[INFO] [stdout] test test::rv64_ua_p::rv64ua_p_amomaxu_w ... ok
[INFO] [stdout] test test::rv64_ua_p::rv64ua_p_amoor_w ... ok
[INFO] [stdout] test test::rv64_ua_p::rv64ua_p_amoadd_w ... ok
[INFO] [stdout] test test::rv64_ua_p::rv64ua_p_amoadd_d ... ok
[INFO] [stdout] test test::rv64_ua_p::rv64ua_p_amomax_d ... ok
[INFO] [stdout] test test::rv64_ua_p::rv64ua_p_amoor_d ... ok
[INFO] [stdout] test test::rv64_ua_p::rv64ua_p_amoxor_d ... ok
[INFO] [stdout] test test::rv64_ua_p::rv64ua_p_amomin_d ... ok
[INFO] [stdout] test test::rv64_ud_p::rv64ud_p_fmadd ... ok
[INFO] [stdout] test test::rv64_ua_p::rv64ua_p_amominu_w ... ok
[INFO] [stdout] test test::rv64_ua_p::rv64ua_p_amomaxu_d ... ok
[INFO] [stdout] test test::rv64_ud_p::rv64ud_p_fcvt_w ... ok
[INFO] [stdout] test test::rv64_ua_p::rv64ua_p_amoswap_w ... ok
[INFO] [stdout] test test::rv64_ud_p::rv64ud_p_fcmp ... ok
[INFO] [stdout] test test::rv64_ud_p::rv64ud_p_fadd ... ok
[INFO] [stdout] test test::rv64_ua_p::rv64ua_p_amoxor_w ... ok
[INFO] [stdout] test test::rv64_ud_p::rv64ud_p_fcvt ... ok
[INFO] [stdout] test test::rv64_ud_p::rv64ud_p_structural ... ok
[INFO] [stdout] test test::examples::mandelbrot_debug ... ok
[INFO] [stdout] test test::rv64_ua_p::rv64ua_p_lrsc ... ok
[INFO] [stdout] test test::rv64_ud_p::rv64ud_p_fdiv ... ok
[INFO] [stdout] test test::rv64_uc_p::rv64uc_p_rvc ... ok
[INFO] [stdout] test test::rv64_uf_p::rv64uf_p_ldst ... ok
[INFO] [stdout] test test::rv64_ud_p::rv64ud_p_ldst ... ok
[INFO] [stdout] test test::rv64_uf_p::rv64uf_p_fadd ... ok
[INFO] [stdout] test test::rv64_uf_p::rv64uf_p_fcvt_w ... ok
[INFO] [stdout] test test::rv64_uf_p::rv64uf_p_fcmp ... ok
[INFO] [stdout] test test::rv64_uf_p::rv64uf_p_fmin ... ok
[INFO] [stdout] test test::rv64_ud_p::rv64ud_p_fmin ... ok
[INFO] [stdout] test test::rv64_ud_p::rv64ud_p_recoding ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_addiw ... ok
[INFO] [stdout] test test::rv64_uf_p::rv64uf_p_fmadd ... ok
[INFO] [stdout] test test::rv64_uf_p::rv64uf_p_fcvt ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_andi ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_blt ... ok
[INFO] [stdout] test test::rv64_uf_p::rv64uf_p_fdiv ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_or ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_add ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_addi ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_bltu ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_auipc ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_beq ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_addw ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_srai ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_bne ... ok
[INFO] [stdout] test test::rv64_uf_p::rv64uf_p_recoding ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_sll ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_lui ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_lw ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_jalr ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_jal ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_slliw ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_and ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_slli ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_lh ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_sllw ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_srl ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_ori ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_sltiu ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_sh ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_xori ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_slti ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_simple ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_lbu ... ok
[INFO] [stdout] test test::rv64_um_p::rv64um_p_remuw ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_fence_i ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_xor ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_sraw ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_subw ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_sw ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_sb ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_ld ... ok
[INFO] [stdout] test test::rv64_um_p::rv64um_p_mulw ... ok
[INFO] [stdout] test test::rv64_um_p::rv64um_p_divuw ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_sra ... ok
[INFO] [stdout] test test::rv64_um_p::rv64um_p_mulhsu ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_srli ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_lb ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_lwu ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_sltu ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_lhu ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_sd ... ok
[INFO] [stdout] test test::rv64_um_p::rv64um_p_remu ... ok
[INFO] [stdout] test test::rv64_um_p::rv64um_p_remw ... ok
[INFO] [stdout] test test::rv64_um_p::rv64um_p_divu ... ok
[INFO] [stdout] test test::rv64_um_p::rv64um_p_mulhu ... ok
[INFO] [stdout] test test::rv64_um_p::rv64um_p_div ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_slt ... ok
[INFO] [stdout] test test::rv64_um_p::rv64um_p_mul ... ok
[INFO] [stdout] test test::rv64_um_p::rv64um_p_rem ... ok
[INFO] [stdout] test test::rv64_um_p::rv64um_p_divw ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_sraiw ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_srlw ... ok
[INFO] [stdout] test test::rv64_um_p::rv64um_p_mulh ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_srliw ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_sub ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 108 passed; 0 failed; 2 ignored; 0 measured; 0 filtered out; finished in 1.58s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests user-mode-riscv
[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] running `Command { std: "docker" "inspect" "319c730a9f0c231729012266ab6666a0bf8010185ab6b26246e14e3dc60e2c97", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "319c730a9f0c231729012266ab6666a0bf8010185ab6b26246e14e3dc60e2c97", kill_on_drop: false }`
[INFO] [stdout] 319c730a9f0c231729012266ab6666a0bf8010185ab6b26246e14e3dc60e2c97