[INFO] cloning repository https://github.com/elasticrash/sat_rs
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/elasticrash/sat_rs" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Felasticrash%2Fsat_rs", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Felasticrash%2Fsat_rs'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] ab32f1083c4b7d60860f19e4b7b461bc36392d79
[INFO] testing elasticrash/sat_rs against 1.59.0 for beta-1.60-1
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Felasticrash%2Fsat_rs" "/workspace/builds/worker-22/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-22/source'...
[INFO] [stderr] done.
[INFO] validating manifest of git repo https://github.com/elasticrash/sat_rs on toolchain 1.59.0
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.59.0" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking git repo https://github.com/elasticrash/sat_rs
[INFO] finished tweaking git repo https://github.com/elasticrash/sat_rs
[INFO] tweaked toml for git repo https://github.com/elasticrash/sat_rs written to /workspace/builds/worker-22/source/Cargo.toml
[INFO] crate git repo https://github.com/elasticrash/sat_rs already has a lockfile, it will not be regenerated
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.59.0" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-22/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-22/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" "+1.59.0" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 5a5c6ea1349e2423dcef23c95e13e2445e42ade55b5d37941dfcb244fd5c5ca0
[INFO] running `Command { std: "docker" "start" "-a" "5a5c6ea1349e2423dcef23c95e13e2445e42ade55b5d37941dfcb244fd5c5ca0", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "5a5c6ea1349e2423dcef23c95e13e2445e42ade55b5d37941dfcb244fd5c5ca0", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "5a5c6ea1349e2423dcef23c95e13e2445e42ade55b5d37941dfcb244fd5c5ca0", kill_on_drop: false }`
[INFO] [stdout] 5a5c6ea1349e2423dcef23c95e13e2445e42ade55b5d37941dfcb244fd5c5ca0
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-22/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-22/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" "+1.59.0" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 86e02370ef5aae849f411caab9c549bd427e46bac858ce6c830aa3cd0a473ad5
[INFO] running `Command { std: "docker" "start" "-a" "86e02370ef5aae849f411caab9c549bd427e46bac858ce6c830aa3cd0a473ad5", kill_on_drop: false }`
[INFO] [stderr]    Compiling libc v0.2.86
[INFO] [stderr]    Compiling cc v1.0.45
[INFO] [stderr]    Compiling regex-syntax v0.6.18
[INFO] [stderr]    Compiling aho-corasick v0.7.13
[INFO] [stderr]    Compiling sys-info v0.5.8
[INFO] [stderr]    Compiling time v0.1.44
[INFO] [stderr]    Compiling chrono v0.4.19
[INFO] [stderr]    Compiling regex v1.3.9
[INFO] [stderr]    Compiling simplelog v0.9.0
[INFO] [stderr]    Compiling sat_rs v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 6.41s
[INFO] running `Command { std: "docker" "inspect" "86e02370ef5aae849f411caab9c549bd427e46bac858ce6c830aa3cd0a473ad5", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "86e02370ef5aae849f411caab9c549bd427e46bac858ce6c830aa3cd0a473ad5", kill_on_drop: false }`
[INFO] [stdout] 86e02370ef5aae849f411caab9c549bd427e46bac858ce6c830aa3cd0a473ad5
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-22/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-22/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" "+1.59.0" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] cf52a0fd0eb0676b0bf812c3cf0db7c2d55747fd92b849a01158a3e23a54de2a
[INFO] running `Command { std: "docker" "start" "-a" "cf52a0fd0eb0676b0bf812c3cf0db7c2d55747fd92b849a01158a3e23a54de2a", kill_on_drop: false }`
[INFO] [stderr]    Compiling sat_rs v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 1.83s
[INFO] running `Command { std: "docker" "inspect" "cf52a0fd0eb0676b0bf812c3cf0db7c2d55747fd92b849a01158a3e23a54de2a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "cf52a0fd0eb0676b0bf812c3cf0db7c2d55747fd92b849a01158a3e23a54de2a", kill_on_drop: false }`
[INFO] [stdout] cf52a0fd0eb0676b0bf812c3cf0db7c2d55747fd92b849a01158a3e23a54de2a
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-22/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-22/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" "+1.59.0" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] bc059a56e9e2fa6e3bb4329c61b5b3b5dd90e4281116aa3168b814528b3e89da
[INFO] running `Command { std: "docker" "start" "-a" "bc059a56e9e2fa6e3bb4329c61b5b3b5dd90e4281116aa3168b814528b3e89da", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.01s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/sat_rs-74f59213a351dbda)
[INFO] [stdout] 
[INFO] [stdout] running 6 tests
[INFO] [stdout] test models::varorder::tests::new_var_order ... ok
[INFO] [stdout] test models::varorder::tests::insert_new_var ... ok
[INFO] [stdout] test control_problem ... ok
[INFO] [stdout] test quinn_problem ... ok
[INFO] [stdout] test aim_50_problem ... FAILED
[INFO] [stdout] test aim_100_problem ... FAILED
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- aim_50_problem stdout ----
[INFO] [stdout] thread 'aim_50_problem' panicked at 'assertion failed: self.enqueue(&c.data[0], Some(c.clone()))', src/functions/new_clause.rs:198:21
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5584c213d7dc - std::backtrace_rs::backtrace::libunwind::trace::h91c465e73bf6c785
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/std/src/../../backtrace/src/backtrace/libunwind.rs:93:5
[INFO] [stdout]    1:     0x5584c213d7dc - std::backtrace_rs::backtrace::trace_unsynchronized::hae9da36f5d58b5f3
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x5584c213d7dc - std::sys_common::backtrace::_print_fmt::h7f499fa126a7effb
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/std/src/sys_common/backtrace.rs:67:5
[INFO] [stdout]    3:     0x5584c213d7dc - <std::sys_common::backtrace::_print::DisplayBacktrace as core::fmt::Display>::fmt::h3e2b509ce2ce6007
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/std/src/sys_common/backtrace.rs:46:22
[INFO] [stdout]    4:     0x5584c216371c - core::fmt::write::h753c7571fa063ecb
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/core/src/fmt/mod.rs:1168:17
[INFO] [stdout]    5:     0x5584c2138a43 - std::io::Write::write_fmt::hb649ab67f71b6655
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/std/src/io/mod.rs:1660:15
[INFO] [stdout]    6:     0x5584c213feb2 - std::sys_common::backtrace::_print::h64941a6fc8b0ed9b
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/std/src/sys_common/backtrace.rs:49:5
[INFO] [stdout]    7:     0x5584c213feb2 - std::sys_common::backtrace::print::hcf25e43e1a9b0766
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/std/src/sys_common/backtrace.rs:36:9
[INFO] [stdout]    8:     0x5584c213feb2 - std::panicking::default_hook::{{closure}}::h78d3e6cf97fc623d
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/std/src/panicking.rs:211:50
[INFO] [stdout]    9:     0x5584c213fb01 - std::panicking::default_hook::hda898f8d3ad1a5ae
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/std/src/panicking.rs:225:9
[INFO] [stdout]   10:     0x5584c2140503 - std::panicking::rust_panic_with_hook::h1a5ea2d6c23051aa
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/std/src/panicking.rs:606:17
[INFO] [stdout]   11:     0x5584c21401f2 - std::panicking::begin_panic_handler::{{closure}}::h07f549390938b73f
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/std/src/panicking.rs:500:13
[INFO] [stdout]   12:     0x5584c213dc84 - std::sys_common::backtrace::__rust_end_short_backtrace::h5ec3758a92cfb00d
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/std/src/sys_common/backtrace.rs:139:18
[INFO] [stdout]   13:     0x5584c213ff59 - rust_begin_unwind
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/std/src/panicking.rs:498:5
[INFO] [stdout]   14:     0x5584c1f2c311 - core::panicking::panic_fmt::h3a79a6a99affe1d5
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/core/src/panicking.rs:116:14
[INFO] [stdout]   15:     0x5584c1f2c25d - core::panicking::panic::h97167cd315d19cd4
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/core/src/panicking.rs:48:5
[INFO] [stdout]   16:     0x5584c1f32531 - <sat_rs::models::solverstate::SolverState as sat_rs::functions::new_clause::NewClause>::new_clause_pr::hb009f43edd273a4f
[INFO] [stdout]                                at /opt/rustwide/workdir/src/functions/new_clause.rs:198:21
[INFO] [stdout]   17:     0x5584c1f311cb - <sat_rs::models::solverstate::SolverState as sat_rs::functions::new_clause::NewClause>::new_clause::h7fad30cb52fdc862
[INFO] [stdout]                                at /opt/rustwide/workdir/src/functions/new_clause.rs:99:9
[INFO] [stdout]   18:     0x5584c1f36708 - <sat_rs::models::solverstate::SolverState as sat_rs::functions::search::Search>::search::h057919c4aeae035c
[INFO] [stdout]                                at /opt/rustwide/workdir/src/functions/search.rs:72:21
[INFO] [stdout]   19:     0x5584c1f39704 - <sat_rs::models::solverstate::SolverState as sat_rs::functions::solve::Solver>::solve::h71462d98e74dc4bb
[INFO] [stdout]                                at /opt/rustwide/workdir/src/functions/solve.rs:106:22
[INFO] [stdout]   20:     0x5584c1f3a0e5 - <sat_rs::models::solverstate::SolverState as sat_rs::functions::solve::Solver>::solve_no_assumptions::hce9da44a01403b62
[INFO] [stdout]                                at /opt/rustwide/workdir/src/functions/solve.rs:124:16
[INFO] [stdout]   21:     0x5584c1f44b30 - sat_rs::process_problem::ha40d5c5d0667d4d5
[INFO] [stdout]                                at /opt/rustwide/workdir/src/main.rs:84:5
[INFO] [stdout]   22:     0x5584c1f45488 - sat_rs::aim_50_problem::hbe1b36415722a65e
[INFO] [stdout]                                at /opt/rustwide/workdir/src/main.rs:198:17
[INFO] [stdout]   23:     0x5584c1f4543a - sat_rs::aim_50_problem::{{closure}}::he82f0611a419a395
[INFO] [stdout]                                at /opt/rustwide/workdir/src/main.rs:106:1
[INFO] [stdout]   24:     0x5584c1f4d80e - core::ops::function::FnOnce::call_once::hc373530c33ea9906
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   25:     0x5584c2109d83 - core::ops::function::FnOnce::call_once::h1845a80638abc06e
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   26:     0x5584c2109d83 - test::__rust_begin_short_backtrace::h4f56ccea01b9889f
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/test/src/lib.rs:574:5
[INFO] [stdout]   27:     0x5584c2108a6f - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h5afedf14a39ffa74
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/alloc/src/boxed.rs:1854:9
[INFO] [stdout]   28:     0x5584c2108a6f - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::hd5aaa1b551e9ce71
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/core/src/panic/unwind_safe.rs:271:9
[INFO] [stdout]   29:     0x5584c2108a6f - std::panicking::try::do_call::h316eebee63f96d32
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/std/src/panicking.rs:406:40
[INFO] [stdout]   30:     0x5584c2108a6f - std::panicking::try::h662e31e84dd7ce52
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/std/src/panicking.rs:370:19
[INFO] [stdout]   31:     0x5584c2108a6f - std::panic::catch_unwind::h129c1b23f076663f
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/std/src/panic.rs:133:14
[INFO] [stdout]   32:     0x5584c2108a6f - test::run_test_in_process::h51d800d572f878ef
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/test/src/lib.rs:597:18
[INFO] [stdout]   33:     0x5584c2108a6f - test::run_test::run_test_inner::{{closure}}::h71a47db430260854
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/test/src/lib.rs:491:39
[INFO] [stdout]   34:     0x5584c2111e31 - test::run_test::run_test_inner::{{closure}}::h02edd5b3e2dab52a
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/test/src/lib.rs:518:37
[INFO] [stdout]   35:     0x5584c2111e31 - std::sys_common::backtrace::__rust_begin_short_backtrace::h0838cfc8b0e995ec
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/std/src/sys_common/backtrace.rs:123:18
[INFO] [stdout]   36:     0x5584c20de8bf - std::thread::Builder::spawn_unchecked::{{closure}}::{{closure}}::h4c2725d7078043cd
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/std/src/thread/mod.rs:477:17
[INFO] [stdout]   37:     0x5584c20de8bf - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::hdf1aa612eed87270
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/core/src/panic/unwind_safe.rs:271:9
[INFO] [stdout]   38:     0x5584c20de8bf - std::panicking::try::do_call::hc72f8de3706d18d6
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/std/src/panicking.rs:406:40
[INFO] [stdout]   39:     0x5584c20de8bf - std::panicking::try::h63f01f54dbd0fb87
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/std/src/panicking.rs:370:19
[INFO] [stdout]   40:     0x5584c20de8bf - std::panic::catch_unwind::h58bc464ae9b26453
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/std/src/panic.rs:133:14
[INFO] [stdout]   41:     0x5584c20de8bf - std::thread::Builder::spawn_unchecked::{{closure}}::h6c065e19513e33e3
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/std/src/thread/mod.rs:476:30
[INFO] [stdout]   42:     0x5584c20de8bf - core::ops::function::FnOnce::call_once{{vtable.shim}}::hd143450c74f35c32
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   43:     0x5584c2146083 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h49b6c7c5155a2296
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/alloc/src/boxed.rs:1854:9
[INFO] [stdout]   44:     0x5584c2146083 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::ha8b5234bfeb15105
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/alloc/src/boxed.rs:1854:9
[INFO] [stdout]   45:     0x5584c2146083 - std::sys::unix::thread::Thread::new::thread_start::h6f207dd842d64859
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/std/src/sys/unix/thread.rs:108:17
[INFO] [stdout]   46:     0x7f7791883609 - start_thread
[INFO] [stdout]   47:     0x7f7791655293 - clone
[INFO] [stdout]   48:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- aim_100_problem stdout ----
[INFO] [stdout] thread 'aim_100_problem' panicked at 'attempt to shift left with overflow', src/functions/analyse.rs:201:38
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5584c213d7dc - std::backtrace_rs::backtrace::libunwind::trace::h91c465e73bf6c785
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/std/src/../../backtrace/src/backtrace/libunwind.rs:93:5
[INFO] [stdout]    1:     0x5584c213d7dc - std::backtrace_rs::backtrace::trace_unsynchronized::hae9da36f5d58b5f3
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x5584c213d7dc - std::sys_common::backtrace::_print_fmt::h7f499fa126a7effb
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/std/src/sys_common/backtrace.rs:67:5
[INFO] [stdout]    3:     0x5584c213d7dc - <std::sys_common::backtrace::_print::DisplayBacktrace as core::fmt::Display>::fmt::h3e2b509ce2ce6007
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/std/src/sys_common/backtrace.rs:46:22
[INFO] [stdout]    4:     0x5584c216371c - core::fmt::write::h753c7571fa063ecb
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/core/src/fmt/mod.rs:1168:17
[INFO] [stdout]    5:     0x5584c2138a43 - std::io::Write::write_fmt::hb649ab67f71b6655
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/std/src/io/mod.rs:1660:15
[INFO] [stdout]    6:     0x5584c213feb2 - std::sys_common::backtrace::_print::h64941a6fc8b0ed9b
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/std/src/sys_common/backtrace.rs:49:5
[INFO] [stdout]    7:     0x5584c213feb2 - std::sys_common::backtrace::print::hcf25e43e1a9b0766
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/std/src/sys_common/backtrace.rs:36:9
[INFO] [stdout]    8:     0x5584c213feb2 - std::panicking::default_hook::{{closure}}::h78d3e6cf97fc623d
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/std/src/panicking.rs:211:50
[INFO] [stdout]    9:     0x5584c213fb01 - std::panicking::default_hook::hda898f8d3ad1a5ae
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/std/src/panicking.rs:225:9
[INFO] [stdout]   10:     0x5584c2140503 - std::panicking::rust_panic_with_hook::h1a5ea2d6c23051aa
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/std/src/panicking.rs:606:17
[INFO] [stdout]   11:     0x5584c21401f2 - std::panicking::begin_panic_handler::{{closure}}::h07f549390938b73f
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/std/src/panicking.rs:500:13
[INFO] [stdout]   12:     0x5584c213dc84 - std::sys_common::backtrace::__rust_end_short_backtrace::h5ec3758a92cfb00d
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/std/src/sys_common/backtrace.rs:139:18
[INFO] [stdout]   13:     0x5584c213ff59 - rust_begin_unwind
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/std/src/panicking.rs:498:5
[INFO] [stdout]   14:     0x5584c1f2c311 - core::panicking::panic_fmt::h3a79a6a99affe1d5
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/core/src/panicking.rs:116:14
[INFO] [stdout]   15:     0x5584c1f2c25d - core::panicking::panic::h97167cd315d19cd4
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/core/src/panicking.rs:48:5
[INFO] [stdout]   16:     0x5584c1f2f3e7 - <sat_rs::models::solverstate::SolverState as sat_rs::functions::analyse::Analyze>::analyze_removeable::h078b226be784e4ad
[INFO] [stdout]                                at /opt/rustwide/workdir/src/functions/analyse.rs:201:38
[INFO] [stdout]   17:     0x5584c1f2de2b - <sat_rs::models::solverstate::SolverState as sat_rs::functions::analyse::Analyze>::analyze::h0ac70b32e33cd221
[INFO] [stdout]                                at /opt/rustwide/workdir/src/functions/analyse.rs:117:33
[INFO] [stdout]   18:     0x5584c1f366a5 - <sat_rs::models::solverstate::SolverState as sat_rs::functions::search::Search>::search::h057919c4aeae035c
[INFO] [stdout]                                at /opt/rustwide/workdir/src/functions/search.rs:69:48
[INFO] [stdout]   19:     0x5584c1f39704 - <sat_rs::models::solverstate::SolverState as sat_rs::functions::solve::Solver>::solve::h71462d98e74dc4bb
[INFO] [stdout]                                at /opt/rustwide/workdir/src/functions/solve.rs:106:22
[INFO] [stdout]   20:     0x5584c1f3a0e5 - <sat_rs::models::solverstate::SolverState as sat_rs::functions::solve::Solver>::solve_no_assumptions::hce9da44a01403b62
[INFO] [stdout]                                at /opt/rustwide/workdir/src/functions/solve.rs:124:16
[INFO] [stdout]   21:     0x5584c1f44b30 - sat_rs::process_problem::ha40d5c5d0667d4d5
[INFO] [stdout]                                at /opt/rustwide/workdir/src/main.rs:84:5
[INFO] [stdout]   22:     0x5584c1f45c88 - sat_rs::aim_100_problem::h2a03b16e3e220944
[INFO] [stdout]                                at /opt/rustwide/workdir/src/main.rs:413:13
[INFO] [stdout]   23:     0x5584c1f45c3a - sat_rs::aim_100_problem::{{closure}}::h21ddc04fcc369ac8
[INFO] [stdout]                                at /opt/rustwide/workdir/src/main.rs:241:1
[INFO] [stdout]   24:     0x5584c1f4d6be - core::ops::function::FnOnce::call_once::h0a54d8e75dd37501
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   25:     0x5584c2109d83 - core::ops::function::FnOnce::call_once::h1845a80638abc06e
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   26:     0x5584c2109d83 - test::__rust_begin_short_backtrace::h4f56ccea01b9889f
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/test/src/lib.rs:574:5
[INFO] [stdout]   27:     0x5584c2108a6f - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h5afedf14a39ffa74
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/alloc/src/boxed.rs:1854:9
[INFO] [stdout]   28:     0x5584c2108a6f - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::hd5aaa1b551e9ce71
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/core/src/panic/unwind_safe.rs:271:9
[INFO] [stdout]   29:     0x5584c2108a6f - std::panicking::try::do_call::h316eebee63f96d32
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/std/src/panicking.rs:406:40
[INFO] [stdout]   30:     0x5584c2108a6f - std::panicking::try::h662e31e84dd7ce52
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/std/src/panicking.rs:370:19
[INFO] [stdout]   31:     0x5584c2108a6f - std::panic::catch_unwind::h129c1b23f076663f
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/std/src/panic.rs:133:14
[INFO] [stdout]   32:     0x5584c2108a6f - test::run_test_in_process::h51d800d572f878ef
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/test/src/lib.rs:597:18
[INFO] [stdout]   33:     0x5584c2108a6f - test::run_test::run_test_inner::{{closure}}::h71a47db430260854
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/test/src/lib.rs:491:39
[INFO] [stdout]   34:     0x5584c2111e31 - test::run_test::run_test_inner::{{closure}}::h02edd5b3e2dab52a
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/test/src/lib.rs:518:37
[INFO] [stdout]   35:     0x5584c2111e31 - std::sys_common::backtrace::__rust_begin_short_backtrace::h0838cfc8b0e995ec
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/std/src/sys_common/backtrace.rs:123:18
[INFO] [stdout]   36:     0x5584c20de8bf - std::thread::Builder::spawn_unchecked::{{closure}}::{{closure}}::h4c2725d7078043cd
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/std/src/thread/mod.rs:477:17
[INFO] [stdout]   37:     0x5584c20de8bf - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::hdf1aa612eed87270
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/core/src/panic/unwind_safe.rs:271:9
[INFO] [stdout]   38:     0x5584c20de8bf - std::panicking::try::do_call::hc72f8de3706d18d6
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/std/src/panicking.rs:406:40
[INFO] [stdout]   39:     0x5584c20de8bf - std::panicking::try::h63f01f54dbd0fb87
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/std/src/panicking.rs:370:19
[INFO] [stdout]   40:     0x5584c20de8bf - std::panic::catch_unwind::h58bc464ae9b26453
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/std/src/panic.rs:133:14
[INFO] [stdout]   41:     0x5584c20de8bf - std::thread::Builder::spawn_unchecked::{{closure}}::h6c065e19513e33e3
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/std/src/thread/mod.rs:476:30
[INFO] [stdout]   42:     0x5584c20de8bf - core::ops::function::FnOnce::call_once{{vtable.shim}}::hd143450c74f35c32
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   43:     0x5584c2146083 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h49b6c7c5155a2296
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/alloc/src/boxed.rs:1854:9
[INFO] [stdout]   44:     0x5584c2146083 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::ha8b5234bfeb15105
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/alloc/src/boxed.rs:1854:9
[INFO] [stdout]   45:     0x5584c2146083 - std::sys::unix::thread::Thread::new::thread_start::h6f207dd842d64859
[INFO] [stdout]                                at /rustc/9d1b2106e23b1abd32fce1f17267604a5102f57a/library/std/src/sys/unix/thread.rs:108:17
[INFO] [stdout]   46:     0x7f7791883609 - start_thread
[INFO] [stdout]   47:     0x7f7791655293 - clone
[INFO] [stdout]   48:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     aim_100_problem
[INFO] [stdout]     aim_50_problem
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 4 passed; 2 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.04s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass '--bin sat_rs'
[INFO] running `Command { std: "docker" "inspect" "bc059a56e9e2fa6e3bb4329c61b5b3b5dd90e4281116aa3168b814528b3e89da", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "bc059a56e9e2fa6e3bb4329c61b5b3b5dd90e4281116aa3168b814528b3e89da", kill_on_drop: false }`
[INFO] [stdout] bc059a56e9e2fa6e3bb4329c61b5b3b5dd90e4281116aa3168b814528b3e89da