[INFO] fetching crate user-mode-riscv 0.1.0...
[INFO] testing user-mode-riscv-0.1.0 against master#a77da2d454e6caa227a85b16410b95f93495e7e0 for pr-91031
[INFO] extracting crate user-mode-riscv 0.1.0 into /workspace/builds/worker-94/source
[INFO] validating manifest of crates.io crate user-mode-riscv 0.1.0 on toolchain a77da2d454e6caa227a85b16410b95f93495e7e0
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+a77da2d454e6caa227a85b16410b95f93495e7e0" "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-94/source/Cargo.toml
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+a77da2d454e6caa227a85b16410b95f93495e7e0" "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" "+a77da2d454e6caa227a85b16410b95f93495e7e0" "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-94/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-94/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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+a77da2d454e6caa227a85b16410b95f93495e7e0" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 5c14a78e1bbdc482be3867b8e758061403668652221b42700b12a1da5bce47e2
[INFO] running `Command { std: "docker" "start" "-a" "5c14a78e1bbdc482be3867b8e758061403668652221b42700b12a1da5bce47e2", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "5c14a78e1bbdc482be3867b8e758061403668652221b42700b12a1da5bce47e2", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "5c14a78e1bbdc482be3867b8e758061403668652221b42700b12a1da5bce47e2", kill_on_drop: false }`
[INFO] [stdout] 5c14a78e1bbdc482be3867b8e758061403668652221b42700b12a1da5bce47e2
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-94/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-94/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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+a77da2d454e6caa227a85b16410b95f93495e7e0" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] adf87ab009e7d21fad85c05ff318044fa6dc73067718b684d245ccff8fafe86a
[INFO] running `Command { std: "docker" "start" "-a" "adf87ab009e7d21fad85c05ff318044fa6dc73067718b684d245ccff8fafe86a", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling user-mode-riscv v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.87s
[INFO] running `Command { std: "docker" "inspect" "adf87ab009e7d21fad85c05ff318044fa6dc73067718b684d245ccff8fafe86a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "adf87ab009e7d21fad85c05ff318044fa6dc73067718b684d245ccff8fafe86a", kill_on_drop: false }`
[INFO] [stdout] adf87ab009e7d21fad85c05ff318044fa6dc73067718b684d245ccff8fafe86a
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-94/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-94/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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+a77da2d454e6caa227a85b16410b95f93495e7e0" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 8b24f4d85824c769c2ca46215c2307ac1ad50c1f9462408956d4881f20df3abc
[INFO] running `Command { std: "docker" "start" "-a" "8b24f4d85824c769c2ca46215c2307ac1ad50c1f9462408956d4881f20df3abc", kill_on_drop: false }`
[INFO] [stderr]    Compiling log v0.4.14
[INFO] [stderr]    Compiling zero v0.1.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 3.01s
[INFO] running `Command { std: "docker" "inspect" "8b24f4d85824c769c2ca46215c2307ac1ad50c1f9462408956d4881f20df3abc", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "8b24f4d85824c769c2ca46215c2307ac1ad50c1f9462408956d4881f20df3abc", kill_on_drop: false }`
[INFO] [stdout] 8b24f4d85824c769c2ca46215c2307ac1ad50c1f9462408956d4881f20df3abc
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-94/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-94/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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+a77da2d454e6caa227a85b16410b95f93495e7e0" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] d05ba92ad1d917764ed506664b5e49169bd2e8bbb38ace24a9865181eff620f9
[INFO] running `Command { std: "docker" "start" "-a" "d05ba92ad1d917764ed506664b5e49169bd2e8bbb38ace24a9865181eff620f9", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.12s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/user_mode_riscv-ede4336f287c908b)
[INFO] [stdout] 
[INFO] [stdout] running 110 tests
[INFO] [stdout] test cpu::test_cpu::babys_first_instruction ... ok
[INFO] [stdout] test cpu::test_cpu::decode_fld_compressed_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_uf_p::rv64uf_p_move ... ignored
[INFO] [stdout] test test::rv64_ua_p::rv64ua_p_amoadd_d ... ok
[INFO] [stdout] test test::rv64_ua_p::rv64ua_p_amomax_w ... ok
[INFO] [stdout] test test::rv64_ua_p::rv64ua_p_amoadd_w ... ok
[INFO] [stdout] test test::rv64_ua_p::rv64ua_p_amomax_d ... ok
[INFO] [stdout] test test::examples::mandelbrot ... ok
[INFO] [stdout] test test::rv64_ua_p::rv64ua_p_amoand_d ... ok
[INFO] [stdout] test test::rv64_ua_p::rv64ua_p_amoor_d ... ok
[INFO] [stdout] test test::rv64_ud_p::rv64ud_p_fcmp ... ok
[INFO] [stdout] test test::rv64_ua_p::rv64ua_p_amominu_d ... ok
[INFO] [stdout] test test::rv64_ua_p::rv64ua_p_amomin_w ... ok
[INFO] [stdout] test test::rv64_ua_p::rv64ua_p_amoand_w ... ok
[INFO] [stdout] test test::rv64_ua_p::rv64ua_p_amomin_d ... 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_ua_p::rv64ua_p_amoswap_d ... ok
[INFO] [stdout] test test::rv64_ua_p::rv64ua_p_amomaxu_d ... ok
[INFO] [stdout] test test::rv64_ua_p::rv64ua_p_amoxor_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_fadd ... ok
[INFO] [stdout] test test::rv64_ud_p::rv64ud_p_fcvt ... ok
[INFO] [stdout] test test::rv64_ua_p::rv64ua_p_amominu_w ... ok
[INFO] [stdout] test test::rv64_uf_p::rv64uf_p_fadd ... ok
[INFO] [stdout] test test::rv64_ua_p::rv64ua_p_amoor_w ... ok
[INFO] [stdout] test test::rv64_ua_p::rv64ua_p_lrsc ... ok
[INFO] [stdout] test test::rv64_ud_p::rv64ud_p_fmin ... ok
[INFO] [stdout] test test::rv64_ua_p::rv64ua_p_amomaxu_w ... ok
[INFO] [stdout] test test::rv64_ua_p::rv64ua_p_amoxor_w ... ok
[INFO] [stdout] test test::rv64_uf_p::rv64uf_p_fcvt ... ok
[INFO] [stdout] test test::rv64_uf_p::rv64uf_p_fdiv ... ok
[INFO] [stdout] test test::rv64_ud_p::rv64ud_p_structural ... ok
[INFO] [stdout] test test::rv64_ud_p::rv64ud_p_fmadd ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_add ... ok
[INFO] [stdout] test test::rv64_ud_p::rv64ud_p_recoding ... ok
[INFO] [stdout] test test::rv64_ud_p::rv64ud_p_ldst ... ok
[INFO] [stdout] test test::rv64_uf_p::rv64uf_p_fcvt_w ... ok
[INFO] [stdout] test test::rv64_uf_p::rv64uf_p_ldst ... ok
[INFO] [stdout] test test::rv64_uf_p::rv64uf_p_fcmp ... ok
[INFO] [stdout] test test::rv64_uf_p::rv64uf_p_recoding ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_and ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_blt ... ok
[INFO] [stdout] test test::rv64_uf_p::rv64uf_p_fmadd ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_andi ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_fence_i ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_lhu ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_bltu ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_addi ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_auipc ... ok
[INFO] [stdout] test test::rv64_uf_p::rv64uf_p_fmin ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_lh ... 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_beq ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_bne ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_ld ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_jal ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_ori ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_lb ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_addiw ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_addw ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_sb ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_lui ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_or ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_lwu ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_srai ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_sw ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_lbu ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_subw ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_sh ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_sraiw ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_sub ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_simple ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_sra ... ok
[INFO] [stdout] test test::rv64_um_p::rv64um_p_divw ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_srl ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_sd ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_slt ... ok
[INFO] [stdout] test test::rv64_um_p::rv64um_p_divu ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_sltiu ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_sltu ... ok
[INFO] [stdout] test test::rv64_um_p::rv64um_p_rem ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_sll ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_slti ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_sraw ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_srli ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_slliw ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_slli ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_sllw ... ok
[INFO] [stdout] test test::rv64_um_p::rv64um_p_mulhsu ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_xor ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_srliw ... ok
[INFO] [stdout] test test::rv64_um_p::rv64um_p_mulh ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_srlw ... ok
[INFO] [stdout] test test::rv64_um_p::rv64um_p_remuw ... ok
[INFO] [stdout] test test::rv64_um_p::rv64um_p_div ... ok
[INFO] [stdout] test test::rv64_ui_p::rv64ui_p_xori ... ok
[INFO] [stdout] test test::rv64_um_p::rv64um_p_mulhu ... 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_um_p::rv64um_p_remu ... ok
[INFO] [stdout] test test::rv64_um_p::rv64um_p_mul ... ok
[INFO] [stdout] test test::rv64_um_p::rv64um_p_remw ... ok
[INFO] [stdout] test test::examples::mandelbrot_debug ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 108 passed; 0 failed; 2 ignored; 0 measured; 0 filtered out; finished in 1.03s
[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" "d05ba92ad1d917764ed506664b5e49169bd2e8bbb38ace24a9865181eff620f9", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "d05ba92ad1d917764ed506664b5e49169bd2e8bbb38ace24a9865181eff620f9", kill_on_drop: false }`
[INFO] [stdout] d05ba92ad1d917764ed506664b5e49169bd2e8bbb38ace24a9865181eff620f9