[INFO] cloning repository https://github.com/tuzz/k-flip-sat
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/tuzz/k-flip-sat" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Ftuzz%2Fk-flip-sat", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Ftuzz%2Fk-flip-sat'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] c94f0161308e958c5ace055d0e7fdf6f2e6ae7b3
[INFO] testing tuzz/k-flip-sat against try#8262275854dc0e5381c9d42d56257d94932c5a87 for pr-90799
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Ftuzz%2Fk-flip-sat" "/workspace/builds/worker-96/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-96/source'...
[INFO] [stderr] done.
[INFO] [stderr] Updating files:  15% (16155/107023)
Updating files:  16% (17124/107023)
Updating files:  17% (18194/107023)
Updating files:  18% (19265/107023)
Updating files:  19% (20335/107023)
Updating files:  20% (21405/107023)
Updating files:  21% (22475/107023)
Updating files:  22% (23546/107023)
Updating files:  23% (24616/107023)
Updating files:  24% (25686/107023)
Updating files:  25% (26756/107023)
Updating files:  26% (27826/107023)
Updating files:  27% (28897/107023)
Updating files:  28% (29967/107023)
Updating files:  28% (30469/107023)
Updating files:  29% (31037/107023)
Updating files:  30% (32107/107023)
Updating files:  31% (33178/107023)
Updating files:  32% (34248/107023)
Updating files:  33% (35318/107023)
Updating files:  34% (36388/107023)
Updating files:  35% (37459/107023)
Updating files:  36% (38529/107023)
Updating files:  37% (39599/107023)
Updating files:  38% (40669/107023)
Updating files:  39% (41739/107023)
Updating files:  39% (42270/107023)
Updating files:  40% (42810/107023)
Updating files:  41% (43880/107023)
Updating files:  42% (44950/107023)
Updating files:  43% (46020/107023)
Updating files:  44% (47091/107023)
Updating files:  45% (48161/107023)
Updating files:  46% (49231/107023)
Updating files:  47% (50301/107023)
Updating files:  47% (50482/107023)
Updating files:  48% (51372/107023)
Updating files:  49% (52442/107023)
Updating files:  50% (53512/107023)
Updating files:  51% (54582/107023)
Updating files:  52% (55652/107023)
Updating files:  53% (56723/107023)
Updating files:  53% (56900/107023)
Updating files:  54% (57793/107023)
Updating files:  55% (58863/107023)
Updating files:  56% (59933/107023)
Updating files:  57% (61004/107023)
Updating files:  58% (62074/107023)
Updating files:  59% (63144/107023)
Updating files:  60% (64214/107023)
Updating files:  61% (65285/107023)
Updating files:  61% (65606/107023)
Updating files:  62% (66355/107023)
Updating files:  63% (67425/107023)
Updating files:  64% (68495/107023)
Updating files:  65% (69565/107023)
Updating files:  66% (70636/107023)
Updating files:  67% (71706/107023)
Updating files:  68% (72776/107023)
Updating files:  69% (73846/107023)
Updating files:  70% (74917/107023)
Updating files:  70% (75745/107023)
Updating files:  71% (75987/107023)
Updating files:  72% (77057/107023)
Updating files:  73% (78127/107023)
Updating files:  74% (79198/107023)
Updating files:  75% (80268/107023)
Updating files:  76% (81338/107023)
Updating files:  77% (82408/107023)
Updating files:  78% (83478/107023)
Updating files:  79% (84549/107023)
Updating files:  80% (85619/107023)
Updating files:  81% (86689/107023)
Updating files:  81% (86785/107023)
Updating files:  82% (87759/107023)
Updating files:  83% (88830/107023)
Updating files:  84% (89900/107023)
Updating files:  85% (90970/107023)
Updating files:  86% (92040/107023)
Updating files:  87% (93111/107023)
Updating files:  88% (94181/107023)
Updating files:  89% (95251/107023)
Updating files:  90% (96321/107023)
Updating files:  90% (97274/107023)
Updating files:  91% (97391/107023)
Updating files:  92% (98462/107023)
Updating files:  93% (99532/107023)
Updating files:  94% (100602/107023)
Updating files:  95% (101672/107023)
Updating files:  96% (102743/107023)
Updating files:  97% (103813/107023)
Updating files:  98% (104883/107023)
Updating files:  99% (105953/107023)
Updating files: 100% (107023/107023)
Updating files: 100% (107023/107023), done.
[INFO] validating manifest of git repo https://github.com/tuzz/k-flip-sat on toolchain 8262275854dc0e5381c9d42d56257d94932c5a87
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+8262275854dc0e5381c9d42d56257d94932c5a87" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking git repo https://github.com/tuzz/k-flip-sat
[INFO] finished tweaking git repo https://github.com/tuzz/k-flip-sat
[INFO] tweaked toml for git repo https://github.com/tuzz/k-flip-sat written to /workspace/builds/worker-96/source/Cargo.toml
[INFO] crate git repo https://github.com/tuzz/k-flip-sat already has a lockfile, it will not be regenerated
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+8262275854dc0e5381c9d42d56257d94932c5a87" "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-96/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-96/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:e8397a04204aaf8b9f284182a6f9e27a3c2e67044d0943b4415b160bfc957681" "/opt/rustwide/cargo-home/bin/cargo" "+8262275854dc0e5381c9d42d56257d94932c5a87" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 88b5747fa9afb6423de71d8874bfb7dcf4cb49a104b5db648e73abc6695503e2
[INFO] running `Command { std: "docker" "start" "-a" "88b5747fa9afb6423de71d8874bfb7dcf4cb49a104b5db648e73abc6695503e2", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "88b5747fa9afb6423de71d8874bfb7dcf4cb49a104b5db648e73abc6695503e2", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "88b5747fa9afb6423de71d8874bfb7dcf4cb49a104b5db648e73abc6695503e2", kill_on_drop: false }`
[INFO] [stdout] 88b5747fa9afb6423de71d8874bfb7dcf4cb49a104b5db648e73abc6695503e2
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-96/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-96/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:e8397a04204aaf8b9f284182a6f9e27a3c2e67044d0943b4415b160bfc957681" "/opt/rustwide/cargo-home/bin/cargo" "+8262275854dc0e5381c9d42d56257d94932c5a87" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] d9f5a873813fc1572d4ec9f49743c900d9c7a4d870009d53edaab7606bced827
[INFO] running `Command { std: "docker" "start" "-a" "d9f5a873813fc1572d4ec9f49743c900d9c7a4d870009d53edaab7606bced827", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling libc v0.2.76
[INFO] [stderr]    Compiling cc v1.0.59
[INFO] [stderr]    Compiling memchr v2.3.3
[INFO] [stderr]    Compiling winapi-build v0.1.1
[INFO] [stderr]    Compiling glob v0.3.0
[INFO] [stderr]    Compiling proc-macro2 v1.0.19
[INFO] [stderr]    Compiling log v0.4.11
[INFO] [stderr]    Compiling unicode-width v0.1.8
[INFO] [stderr]    Compiling getrandom v0.1.14
[INFO] [stderr]    Compiling regex-syntax v0.6.18
[INFO] [stderr]    Compiling winapi v0.2.8
[INFO] [stderr]    Compiling bindgen v0.51.1
[INFO] [stderr]    Compiling termcolor v1.1.0
[INFO] [stderr]    Compiling vec_map v0.8.2
[INFO] [stderr]    Compiling ansi_term v0.11.0
[INFO] [stderr]    Compiling strsim v0.8.0
[INFO] [stderr]    Compiling peeking_take_while v0.1.2
[INFO] [stderr]    Compiling pkg-config v0.3.18
[INFO] [stderr]    Compiling shlex v0.1.1
[INFO] [stderr]    Compiling rustc-hash v1.1.0
[INFO] [stderr]    Compiling crc32fast v1.2.0
[INFO] [stderr]    Compiling bitflags v0.8.2
[INFO] [stderr]    Compiling nom v4.2.3
[INFO] [stderr]    Compiling thread_local v1.0.1
[INFO] [stderr]    Compiling humantime v1.3.0
[INFO] [stderr]    Compiling miniz_oxide v0.4.1
[INFO] [stderr]    Compiling dimacs v0.2.0
[INFO] [stderr]    Compiling textwrap v0.11.0
[INFO] [stderr]    Compiling kernel32-sys v0.2.2
[INFO] [stderr]    Compiling clang-sys v0.28.1
[INFO] [stderr]    Compiling libloading v0.5.2
[INFO] [stderr]    Compiling lzma-sys v0.1.16
[INFO] [stderr]    Compiling aho-corasick v0.7.13
[INFO] [stderr]    Compiling quote v1.0.7
[INFO] [stderr]    Compiling atty v0.2.14
[INFO] [stderr]    Compiling which v3.1.1
[INFO] [stderr]    Compiling flate2 v1.0.17
[INFO] [stderr]    Compiling walkdir v0.1.8
[INFO] [stderr]    Compiling clap v2.33.3
[INFO] [stderr]    Compiling xz2 v0.1.6
[INFO] [stderr]    Compiling rand_core v0.5.1
[INFO] [stderr]    Compiling cexpr v0.3.6
[INFO] [stderr]    Compiling regex v1.3.9
[INFO] [stderr]    Compiling copy_dir v0.1.2
[INFO] [stderr]    Compiling rand_chacha v0.2.2
[INFO] [stderr]    Compiling rand_pcg v0.2.1
[INFO] [stderr]    Compiling rand v0.7.3
[INFO] [stderr]    Compiling env_logger v0.6.2
[INFO] [stderr]    Compiling ipasir-sys v0.3.0
[INFO] [stderr]    Compiling k-flip-sat v0.1.0 (/opt/rustwide/workdir)
[INFO] [stdout] warning: associated function is never used: `true_literal`
[INFO] [stdout]   --> src/solver.rs:61:12
[INFO] [stdout]    |
[INFO] [stdout] 61 |     pub fn true_literal(&self) -> i32 {
[INFO] [stdout]    |            ^^^^^^^^^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(dead_code)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: 1 warning emitted
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 7m 10s
[INFO] running `Command { std: "docker" "inspect" "d9f5a873813fc1572d4ec9f49743c900d9c7a4d870009d53edaab7606bced827", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "d9f5a873813fc1572d4ec9f49743c900d9c7a4d870009d53edaab7606bced827", kill_on_drop: false }`
[INFO] [stdout] d9f5a873813fc1572d4ec9f49743c900d9c7a4d870009d53edaab7606bced827
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-96/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-96/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:e8397a04204aaf8b9f284182a6f9e27a3c2e67044d0943b4415b160bfc957681" "/opt/rustwide/cargo-home/bin/cargo" "+8262275854dc0e5381c9d42d56257d94932c5a87" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] e2a6a40434096ff9c70d5ba4305f8b9cbdc675ad26c5d5fbd12b5db3f2ef9598
[INFO] running `Command { std: "docker" "start" "-a" "e2a6a40434096ff9c70d5ba4305f8b9cbdc675ad26c5d5fbd12b5db3f2ef9598", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling k-flip-sat v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.89s
[INFO] running `Command { std: "docker" "inspect" "e2a6a40434096ff9c70d5ba4305f8b9cbdc675ad26c5d5fbd12b5db3f2ef9598", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "e2a6a40434096ff9c70d5ba4305f8b9cbdc675ad26c5d5fbd12b5db3f2ef9598", kill_on_drop: false }`
[INFO] [stdout] e2a6a40434096ff9c70d5ba4305f8b9cbdc675ad26c5d5fbd12b5db3f2ef9598
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-96/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-96/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:e8397a04204aaf8b9f284182a6f9e27a3c2e67044d0943b4415b160bfc957681" "/opt/rustwide/cargo-home/bin/cargo" "+8262275854dc0e5381c9d42d56257d94932c5a87" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 734eb3c2acd75606d1c1e8f7cf96278b69d299a4f8296be580342ddc8c00ddf7
[INFO] running `Command { std: "docker" "start" "-a" "734eb3c2acd75606d1c1e8f7cf96278b69d299a4f8296be580342ddc8c00ddf7", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 2.68s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/k_flip_sat-fdee0049186a5d3d)
[INFO] [stdout] 
[INFO] [stdout] running 9 tests
[INFO] [stderr] cadical: fatal error: invalid API usage of 'int CaDiCaL::Solver::val(int)' in '../src/solver.cpp': can only get value in satisfied state
[INFO] [stderr] error: test failed, to rerun pass '--bin k-flip-sat'
[INFO] [stderr] 
[INFO] [stderr] Caused by:
[INFO] [stderr]   process didn't exit successfully: `/opt/rustwide/target/debug/deps/k_flip_sat-fdee0049186a5d3d` (signal: 6, SIGABRT: process abort signal)
[INFO] running `Command { std: "docker" "inspect" "734eb3c2acd75606d1c1e8f7cf96278b69d299a4f8296be580342ddc8c00ddf7", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "734eb3c2acd75606d1c1e8f7cf96278b69d299a4f8296be580342ddc8c00ddf7", kill_on_drop: false }`
[INFO] [stdout] 734eb3c2acd75606d1c1e8f7cf96278b69d299a4f8296be580342ddc8c00ddf7