[INFO] cloning repository https://github.com/lemonadern/assembler
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/lemonadern/assembler" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Flemonadern%2Fassembler", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Flemonadern%2Fassembler'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 87a1e2b7fa20b390ea3ee4e245200a0668dd950f
[INFO] testing lemonadern/assembler against 1.99.0-beta.1+cargoflags=--release for beta-release-1.99-2
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Flemonadern%2Fassembler" "/workspace/builds/worker-4-tc2/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-4-tc2/source'...
[INFO] [stderr] done.
[INFO] started tweaking git repo https://github.com/lemonadern/assembler
[INFO] finished tweaking git repo https://github.com/lemonadern/assembler
[INFO] tweaked toml for git repo https://github.com/lemonadern/assembler written to /workspace/builds/worker-4-tc2/source/Cargo.toml
[INFO] validating manifest of git repo https://github.com/lemonadern/assembler on toolchain 1.99.0-beta.1
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.99.0-beta.1" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate git repo https://github.com/lemonadern/assembler 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" "+1.99.0-beta.1" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/target:/opt/rustwide/target:rw,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" "-m" "1610612736" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:8683fc1fc2eb5c9ac98e0d076ab094b2ffac7f99da555d2b6a2e27f346de2ec7" "sleep" "infinity", kill_on_drop: false }`
[INFO] [stdout] dc38a8f377fddd0627467f727b13090b37d721b51eaf94af64cbd15c5c995ce9
[INFO] running `Command { std: "docker" "start" "dc38a8f377fddd0627467f727b13090b37d721b51eaf94af64cbd15c5c995ce9", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "dc38a8f377fddd0627467f727b13090b37d721b51eaf94af64cbd15c5c995ce9", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-w" "/opt/rustwide/workdir" "--user" "0:0" "dc38a8f377fddd0627467f727b13090b37d721b51eaf94af64cbd15c5c995ce9" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.1" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "dc38a8f377fddd0627467f727b13090b37d721b51eaf94af64cbd15c5c995ce9", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-w" "/opt/rustwide/workdir" "--user" "0:0" "dc38a8f377fddd0627467f727b13090b37d721b51eaf94af64cbd15c5c995ce9" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.1" "build" "--frozen" "--message-format=json" "--release", kill_on_drop: false }`
[INFO] [stderr]    Compiling libc v0.2.143
[INFO] [stderr]    Compiling io-lifetimes v1.0.10
[INFO] [stderr]    Compiling proc-macro2 v1.0.56
[INFO] [stderr]    Compiling rustix v0.37.19
[INFO] [stderr]    Compiling linux-raw-sys v0.3.7
[INFO] [stderr]    Compiling quote v1.0.26
[INFO] [stderr]    Compiling unicode-ident v1.0.8
[INFO] [stderr]    Compiling utf8parse v0.2.1
[INFO] [stderr]    Compiling colorchoice v1.0.0
[INFO] [stderr]    Compiling anstyle-query v1.0.0
[INFO] [stderr]    Compiling anstyle v1.0.0
[INFO] [stderr]    Compiling strsim v0.10.0
[INFO] [stderr]    Compiling clap_lex v0.4.1
[INFO] [stderr]    Compiling anyhow v1.0.71
[INFO] [stderr]    Compiling once_cell v1.17.1
[INFO] [stderr]    Compiling aho-corasick v1.0.1
[INFO] [stderr]    Compiling regex-syntax v0.7.1
[INFO] [stderr]    Compiling anstyle-parse v0.2.0
[INFO] [stderr]    Compiling syn v2.0.15
[INFO] [stderr]    Compiling regex v1.8.1
[INFO] [stderr]    Compiling is-terminal v0.4.7
[INFO] [stderr]    Compiling anstream v0.3.2
[INFO] [stderr]    Compiling clap_builder v4.2.7
[INFO] [stderr]    Compiling clap_derive v4.2.0
[INFO] [stderr]    Compiling clap v4.2.7
[INFO] [stderr]    Compiling assembler v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 29.71s
[INFO] running `Command { std: "docker" "inspect" "dc38a8f377fddd0627467f727b13090b37d721b51eaf94af64cbd15c5c995ce9", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-w" "/opt/rustwide/workdir" "--user" "0:0" "dc38a8f377fddd0627467f727b13090b37d721b51eaf94af64cbd15c5c995ce9" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.1" "test" "--frozen" "--no-run" "--message-format=json" "--release", kill_on_drop: false }`
[INFO] [stderr]    Compiling assembler v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 2.43s
[INFO] running `Command { std: "docker" "inspect" "dc38a8f377fddd0627467f727b13090b37d721b51eaf94af64cbd15c5c995ce9", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-w" "/opt/rustwide/workdir" "--user" "0:0" "dc38a8f377fddd0627467f727b13090b37d721b51eaf94af64cbd15c5c995ce9" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.1" "test" "--frozen" "--release", kill_on_drop: false }`
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 0.08s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/release/deps/assembler-cd714491996d5f2d)
[INFO] [stdout] 
[INFO] [stdout] running 3 tests
[INFO] [stdout] test instruction::opcode::tests::opcode_to_binary ... ok
[INFO] [stdout] test instruction::register::tests::fail_to_parse_strings_without_dollar_prefix ... ok
[INFO] [stdout] test instruction::register::tests::fail_to_parse_unsupported_register_name ... 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] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/release/deps/assembler-79ef68b6414ad2e5)
[INFO] [stdout] 
[INFO] [stdout] running 3 tests
[INFO] [stdout] test instruction::opcode::tests::opcode_to_binary ... ok
[INFO] [stdout] test instruction::register::tests::fail_to_parse_strings_without_dollar_prefix ... ok
[INFO] [stdout] test instruction::register::tests::fail_to_parse_unsupported_register_name ... 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] [stderr]      Running tests/0_add.rs (/opt/rustwide/target/release/deps/0_add-0c715408d9039254)
[INFO] [stdout] 
[INFO] [stdout] running 5 tests
[INFO] [stdout] test fail_on_invalid_register ... ok
[INFO] [stdout] test fail_on_excessive_operands ... ok
[INFO] [stdout] test fail_on_insufficient_operands ... ok
[INFO] [stdout] test fail_on_immediate_value_instead_of_register ... ok
[INFO] [stdout] test happy ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/1_addi.rs (/opt/rustwide/target/release/deps/1_addi-d42a59a84f2f598c)
[INFO] [stdout] 
[INFO] [stdout] running 6 tests
[INFO] [stdout] test fail_on_immediate_value_instead_of_register ... ok
[INFO] [stdout] test fail_on_excessive_operands ... ok
[INFO] [stdout] test fail_on_insufficient_operands ... ok
[INFO] [stdout] test happy ... ok
[INFO] [stdout] test fail_on_invalid_register ... ok
[INFO] [stdout] test fail_on_register_instead_of_immediate_value ... 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/2_lw.rs (/opt/rustwide/target/release/deps/2_lw-f51f1b33b420d450)
[INFO] [stdout] 
[INFO] [stdout] running 12 tests
[INFO] [stdout] test fail_on_excessive_operands ... ok
[INFO] [stdout] test fail_on_invalid_register ... ok
[INFO] [stdout] test fail_on_insufficient_operands ... ok
[INFO] [stdout] test fail_on_mismatched_parentheses ... ok
[INFO] [stdout] test fail_on_misplaced_parentheses ... ok
[INFO] [stdout] test fail_on_offset_out_of_range_negative ... ok
[INFO] [stdout] test fail_on_unexpected_whitespace ... ok
[INFO] [stdout] test happy ... ok
[INFO] [stdout] test fail_on_offset_out_of_range_positive ... ok
[INFO] [stdout] test fail_on_immediate_value_instead_of_register ... ok
[INFO] [stdout] test fail_on_invalid_base_register ... ok
[INFO] [stderr]      Running tests/3_sw.rs (/opt/rustwide/target/release/deps/3_sw-f5089824e1f9947f)
[INFO] [stdout] test fail_on_invalid_offset ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 12 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 9 tests
[INFO] [stdout] test fail_on_invalid_register ... ok
[INFO] [stdout] test fail_on_excessive_operands ... ok
[INFO] [stdout] test fail_on_unexpected_whitespace ... ok
[INFO] [stdout] test fail_on_offset_out_of_range_negative ... ok
[INFO] [stdout] test fail_on_mismatched_parentheses ... ok
[INFO] [stdout] test happy ... ok
[INFO] [stdout] test fail_on_insufficient_operands ... ok
[INFO] [stdout] test fail_on_offset_out_of_range_positive ... ok
[INFO] [stdout] test fail_on_misplaced_parentheses ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 9 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/4_beq.rs (/opt/rustwide/target/release/deps/4_beq-66fd0dc42cee4cfa)
[INFO] [stdout] 
[INFO] [stdout] running 7 tests
[INFO] [stdout] test fail_on_immediate_value_instead_of_addr ... ok
[INFO] [stdout] test fail_on_register_instead_of_addr ... ok
[INFO] [stdout] test fail_on_insufficient_operands ... ok
[INFO] [stdout] test fail_on_missing_label ... ok
[INFO] [stdout] test fail_on_excessive_operands ... ok
[INFO] [stdout] test negative_pc_relative_addressing ... ok
[INFO] [stdout] test positive_pc_relative_addressing ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/5_j.rs (/opt/rustwide/target/release/deps/5_j-4af2a83b27bf4daa)
[INFO] [stdout] 
[INFO] [stdout] running 8 tests
[INFO] [stdout] test addressing ... ok
[INFO] [stdout] test fail_on_immediate_value_instead_of_addr ... ok
[INFO] [stdout] test fail_on_missing_label ... ok
[INFO] [stdout] test fail_on_register_instead_of_addr ... ok
[INFO] [stdout] test jump_negative ... ok
[INFO] [stdout] test jump_positive ... ok
[INFO] [stdout] test fail_on_insufficient_operands ... ok
[INFO] [stdout] test fail_on_excessive_operands ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 8 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/6_jal.rs (/opt/rustwide/target/release/deps/6_jal-520e12ecb9a77fc4)
[INFO] [stdout] 
[INFO] [stdout] running 8 tests
[INFO] [stdout] test addressing ... ok
[INFO] [stdout] test fail_on_missing_label ... ok
[INFO] [stdout] test fail_on_register_instead_of_addr ... ok
[INFO] [stdout] test fail_on_excessive_operands ... ok
[INFO] [stdout] test fail_on_insufficient_operands ... ok
[INFO] [stdout] test jump_negative ... ok
[INFO] [stdout] test jump_positive ... ok
[INFO] [stderr]      Running tests/7_jr.rs (/opt/rustwide/target/release/deps/7_jr-30af67b9ec6bccf5)
[INFO] [stdout] test fail_on_immediate_value_instead_of_addr ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 8 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 5 tests
[INFO] [stdout] test fail_on_immediate_value_instead_of_register ... ok
[INFO] [stdout] test fail_on_invalid_register ... ok
[INFO] [stdout] test fail_on_excessive_operands ... ok
[INFO] [stdout] test happy ... ok
[INFO] [stdout] test fail_on_insufficient_operands ... ok
[INFO] [stdout] 
[INFO] [stderr]      Running tests/binary.rs (/opt/rustwide/target/release/deps/binary-6473a38126741e93)
[INFO] [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 5 tests
[INFO] [stderr]      Running tests/instruction_misc.rs (/opt/rustwide/target/release/deps/instruction_misc-bb1fab796a581b97)
[INFO] [stdout] test opcodes ... ok
[INFO] [stdout] test registers ... ok
[INFO] [stdout] test twos_complements ... ok
[INFO] [stdout] test addrs ... ok
[INFO] [stdout] test zero ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 5 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_fail_to_parse_unsupported_instruction ... 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/learning.rs (/opt/rustwide/target/release/deps/learning-130d371d855f543d)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test twos_complements ... 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/parser.rs (/opt/rustwide/target/release/deps/parser-5ee653d4ead9d836)
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test test_parse_asm ... ok
[INFO] [stdout] test test_remove_comments ... ok
[INFO] [stderr]    Doc-tests assembler
[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] [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" "dc38a8f377fddd0627467f727b13090b37d721b51eaf94af64cbd15c5c995ce9", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "dc38a8f377fddd0627467f727b13090b37d721b51eaf94af64cbd15c5c995ce9", kill_on_drop: false }`
[INFO] [stdout] dc38a8f377fddd0627467f727b13090b37d721b51eaf94af64cbd15c5c995ce9
