[INFO] cloning repository https://github.com/jtorreggiani/lam
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/jtorreggiani/lam" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fjtorreggiani%2Flam", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fjtorreggiani%2Flam'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] a9d735c4f5c2afd30720840e97a00e1ce74df2c3
[INFO] testing jtorreggiani/lam against master#cdb45c87e2cd43495379f7e867e3cc15dcee9f93 for pr-145838-1
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fjtorreggiani%2Flam" "/workspace/builds/worker-7-tc1/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-7-tc1/source'...
[INFO] [stderr] done.
[INFO] started tweaking git repo https://github.com/jtorreggiani/lam
[INFO] finished tweaking git repo https://github.com/jtorreggiani/lam
[INFO] tweaked toml for git repo https://github.com/jtorreggiani/lam written to /workspace/builds/worker-7-tc1/source/Cargo.toml
[INFO] validating manifest of git repo https://github.com/jtorreggiani/lam on toolchain cdb45c87e2cd43495379f7e867e3cc15dcee9f93
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate git repo https://github.com/jtorreggiani/lam 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" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded bstr v1.11.3
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 662ccb637bb02793bb402025797488e341378999865afb32549a1025b1f9e7d2
[INFO] running `Command { std: "docker" "start" "-a" "662ccb637bb02793bb402025797488e341378999865afb32549a1025b1f9e7d2", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "662ccb637bb02793bb402025797488e341378999865afb32549a1025b1f9e7d2", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "662ccb637bb02793bb402025797488e341378999865afb32549a1025b1f9e7d2", kill_on_drop: false }`
[INFO] [stdout] 662ccb637bb02793bb402025797488e341378999865afb32549a1025b1f9e7d2
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/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" "RUSTDOCFLAGS=--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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 62227f0ad7c08299ef8c96e837da9e59ecfb5be8df15cf161eeb32762d2b1cff
[INFO] running `Command { std: "docker" "start" "-a" "62227f0ad7c08299ef8c96e837da9e59ecfb5be8df15cf161eeb32762d2b1cff", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v1.0.93
[INFO] [stderr]    Compiling unicode-ident v1.0.16
[INFO] [stderr]    Compiling thiserror v2.0.11
[INFO] [stderr]    Compiling libc v0.2.169
[INFO] [stderr]    Compiling once_cell v1.20.2
[INFO] [stderr]    Compiling log v0.4.25
[INFO] [stderr]    Compiling quote v1.0.38
[INFO] [stderr]    Compiling syn v2.0.98
[INFO] [stderr]    Compiling is-terminal v0.4.15
[INFO] [stderr]    Compiling env_logger v0.10.2
[INFO] [stderr]    Compiling thiserror-impl v2.0.11
[INFO] [stderr]    Compiling thiserror-impl v1.0.69
[INFO] [stderr]    Compiling thiserror v1.0.69
[INFO] [stderr]    Compiling pest v2.7.15
[INFO] [stderr]    Compiling pest_meta v2.7.15
[INFO] [stderr]    Compiling pest_generator v2.7.15
[INFO] [stderr]    Compiling pest_derive v2.7.15
[INFO] [stderr]    Compiling lam v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 12.02s
[INFO] running `Command { std: "docker" "inspect" "62227f0ad7c08299ef8c96e837da9e59ecfb5be8df15cf161eeb32762d2b1cff", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "62227f0ad7c08299ef8c96e837da9e59ecfb5be8df15cf161eeb32762d2b1cff", kill_on_drop: false }`
[INFO] [stdout] 62227f0ad7c08299ef8c96e837da9e59ecfb5be8df15cf161eeb32762d2b1cff
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/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" "RUSTDOCFLAGS=--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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 47fb5b4490da2669afb3226bd2497dde8c00eb937edbc5d6ba5f68e0b8114f4a
[INFO] running `Command { std: "docker" "start" "-a" "47fb5b4490da2669afb3226bd2497dde8c00eb937edbc5d6ba5f68e0b8114f4a", kill_on_drop: false }`
[INFO] [stderr]    Compiling serde v1.0.217
[INFO] [stderr]    Compiling serde_json v1.0.138
[INFO] [stderr]    Compiling num-traits v0.2.19
[INFO] [stderr]    Compiling half v2.4.1
[INFO] [stderr]    Compiling rustix v0.38.44
[INFO] [stderr]    Compiling getrandom v0.3.1
[INFO] [stderr]    Compiling regex-automata v0.4.9
[INFO] [stderr]    Compiling indexmap v1.9.3
[INFO] [stderr]    Compiling ciborium-io v0.2.2
[INFO] [stderr]    Compiling plotters-backend v0.3.7
[INFO] [stderr]    Compiling getrandom v0.2.15
[INFO] [stderr]    Compiling doc-comment v0.3.3
[INFO] [stderr]    Compiling ryu v1.0.19
[INFO] [stderr]    Compiling serde_derive v1.0.217
[INFO] [stderr]    Compiling os_str_bytes v6.6.1
[INFO] [stderr]    Compiling predicates-core v1.0.9
[INFO] [stderr]    Compiling ciborium-ll v0.2.2
[INFO] [stderr]    Compiling clap_lex v0.2.4
[INFO] [stderr]    Compiling itertools v0.10.5
[INFO] [stderr]    Compiling assert_cmd v2.0.16
[INFO] [stderr]    Compiling plotters-svg v0.3.7
[INFO] [stderr]    Compiling rand_core v0.6.4
[INFO] [stderr]    Compiling linux-raw-sys v0.4.15
[INFO] [stderr]    Compiling difflib v0.4.0
[INFO] [stderr]    Compiling cast v0.3.0
[INFO] [stderr]    Compiling normalize-line-endings v0.3.0
[INFO] [stderr]    Compiling bitflags v2.8.0
[INFO] [stderr]    Compiling termtree v0.5.1
[INFO] [stderr]    Compiling textwrap v0.16.1
[INFO] [stderr]    Compiling rand v0.8.5
[INFO] [stderr]    Compiling predicates-tree v1.0.12
[INFO] [stderr]    Compiling rayon v1.10.0
[INFO] [stderr]    Compiling atty v0.2.14
[INFO] [stderr]    Compiling wait-timeout v0.2.1
[INFO] [stderr]    Compiling anes v0.1.6
[INFO] [stderr]    Compiling once_cell v1.20.2
[INFO] [stderr]    Compiling oorandom v11.1.4
[INFO] [stderr]    Compiling clap v3.2.25
[INFO] [stderr]    Compiling float-cmp v0.10.0
[INFO] [stderr]    Compiling plotters v0.3.7
[INFO] [stderr]    Compiling criterion-plot v0.5.0
[INFO] [stderr]    Compiling tempfile v3.16.0
[INFO] [stderr]    Compiling regex v1.11.1
[INFO] [stderr]    Compiling bstr v1.11.3
[INFO] [stderr]    Compiling env_logger v0.10.2
[INFO] [stderr]    Compiling predicates v3.1.3
[INFO] [stderr]    Compiling env_logger v0.8.4
[INFO] [stderr]    Compiling quickcheck v1.0.3
[INFO] [stderr]    Compiling lam v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]    Compiling ciborium v0.2.2
[INFO] [stderr]    Compiling tinytemplate v1.2.1
[INFO] [stderr]    Compiling criterion v0.4.0
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 34.50s
[INFO] running `Command { std: "docker" "inspect" "47fb5b4490da2669afb3226bd2497dde8c00eb937edbc5d6ba5f68e0b8114f4a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "47fb5b4490da2669afb3226bd2497dde8c00eb937edbc5d6ba5f68e0b8114f4a", kill_on_drop: false }`
[INFO] [stdout] 47fb5b4490da2669afb3226bd2497dde8c00eb937edbc5d6ba5f68e0b8114f4a
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/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" "RUSTDOCFLAGS=--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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 504c163800b2a5bb4d74866eed929d0fe388a85102f5911ca573d3c76d148ebc
[INFO] running `Command { std: "docker" "start" "-a" "504c163800b2a5bb4d74866eed929d0fe388a85102f5911ca573d3c76d148ebc", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.18s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/lam-0f87496abac54c8a)
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/debug/deps/lamc-46051091ef5e1476)
[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] [stderr]      Running tests/test_arithmetic.rs (/opt/rustwide/target/debug/deps/test_arithmetic-1b7a81bbc70639ca)
[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] [stdout] 
[INFO] [stdout] running 15 tests
[INFO] [stdout] test tests::test_evaluate_constant ... ok
[INFO] [stdout] test tests::test_evaluate_division ... ok
[INFO] [stdout] test tests::test_evaluate_addition ... ok
[INFO] [stdout] test tests::test_evaluate_multiplication ... ok
[INFO] [stdout] test tests::test_parse_expression_complex ... ok
[INFO] [stdout] test tests::test_evaluate_subtraction ... ok
[INFO] [stdout] test tests::test_parse_expression_error_extra_tokens ... ok
[INFO] [stdout] test tests::test_parse_expression_error_invalid_character ... ok
[INFO] [stdout] test tests::test_parse_expression_error_missing_parenthesis ... ok
[INFO] [stdout] test tests::test_parse_expression_precedence ... ok
[INFO] [stdout] test tests::test_parse_expression_unary_minus ... ok
[INFO] [stdout] test tests::test_parse_expression_with_parentheses ... ok
[INFO] [stdout] test tests::test_parse_expression_constant ... ok
[INFO] [stdout] test tests::test_evaluate_division_by_zero ... ok
[INFO] [stdout] test tests::test_parse_expression_simple_add ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 15 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.08s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/test_backtracking_constants.rs (/opt/rustwide/target/debug/deps/test_backtracking_constants-48fbe1d825d30d00)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test tests::test_backtracking_constants ... 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/test_backtracking_variables.rs (/opt/rustwide/target/debug/deps/test_backtracking_variables-83d4b80a955ed1ba)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test tests::test_backtracking_variables ... 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/test_build_compound.rs (/opt/rustwide/target/debug/deps/test_build_compound-f315703fb17748e9)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test tests::test_build_compound ... 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/test_builtins.rs (/opt/rustwide/target/debug/deps/test_builtins-1dae8878790999e1)
[INFO] [stdout] 
[INFO] [stdout] running 4 tests
[INFO] [stdout] test tests::test_builtin_nl ... ok
[INFO] [stderr]      Running tests/test_core.rs (/opt/rustwide/target/debug/deps/test_core-60a7e45c222d22e9)
[INFO] [stdout] test tests::test_builtin_write_dash_compound ... ok
[INFO] [stdout] test tests::test_builtin_write_non_dash ... ok
[INFO] [stdout] test tests::test_builtin_print ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 12 tests
[INFO] [stdout] test tests::test_builtin_nl ... ok
[INFO] [stdout] test tests::test_builtin_halt ... ok
[INFO] [stdout] test tests::test_builtin_write ... ok
[INFO] [stdout] test tests::test_new_initialization ... ok
[INFO] [stdout] test tests::test_register_indexed_clause ... ok
[INFO] [stdout] test tests::test_register_predicate ... ok
[INFO] [stdout] test tests::test_step_and_run ... ok
[INFO] [stdout] test tests::test_builtin_print_subst ... ok
[INFO] [stdout] test tests::test_unify_constants ... ok
[INFO] [stdout] test tests::test_trace ... ok
[INFO] [stdout] test tests::test_execute_move ... ok
[INFO] [stdout] test tests::test_execute_move_error ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 12 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/test_cut.rs (/opt/rustwide/target/debug/deps/test_cut-92c0b101d73dd7bb)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test tests::test_cut ... 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/test_dynamic_clause_indexing.rs (/opt/rustwide/target/debug/deps/test_dynamic_clause_indexing-399c043a4366c111)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test tests::test_dynamic_clause_indexing ... ok
[INFO] [stderr]      Running tests/test_dynamic_clause_management.rs (/opt/rustwide/target/debug/deps/test_dynamic_clause_management-c4031f5b5fa30dfd)
[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] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test tests::test_dynamic_clause_management ... ok
[INFO] [stderr]      Running tests/test_environment.rs (/opt/rustwide/target/debug/deps/test_environment-7174857bab57ee66)
[INFO] [stdout] 
[INFO] [stderr]      Running tests/test_eq_builtin.rs (/opt/rustwide/target/debug/deps/test_eq_builtin-600338adab5568a2)
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stderr]      Running tests/test_error_conditions.rs (/opt/rustwide/target/debug/deps/test_error_conditions-b92158c994be9599)
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test tests::test_environment ... 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] [stdout] 
[INFO] [stdout] running 3 tests
[INFO] [stdout] test tests::test_builtin_eq_success ... ok
[INFO] [stdout] test tests::test_builtin_eq_failure ... ok
[INFO] [stdout] test tests::test_variable_assignment_program ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 6 tests
[INFO] [stdout] test tests::test_deallocate_without_environment_error ... ok
[INFO] [stdout] test tests::test_register_out_of_bounds_error ... ok
[INFO] [stdout] test tests::test_indexed_call_uninitialized_register_error ... ok
[INFO] [stdout] test tests::test_get_structure_on_constant_error ... ok
[INFO] [stdout] test tests::test_unification_failure_error ... ok
[INFO] [stdout] test tests::test_uninitialized_register_error ... 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/test_execution.rs (/opt/rustwide/target/debug/deps/test_execution-55282adc7fa3e743)
[INFO] [stdout] 
[INFO] [stdout] running 51 tests
[INFO] [stdout] test tests::test_execute_arithmetic_is_error_out_of_bounds ... ok
[INFO] [stdout] test tests::test_execute_arithmetic_is_success ... ok
[INFO] [stdout] test tests::test_execute_build_compound_success ... ok
[INFO] [stdout] test tests::test_execute_allocate ... ok
[INFO] [stdout] test tests::test_execute_build_compound_error_arg_register_uninitialized ... ok
[INFO] [stdout] test tests::test_execute_call_builtin ... ok
[INFO] [stdout] test tests::test_execute_assert_clause ... ok
[INFO] [stdout] test tests::test_execute_deallocate_error ... ok
[INFO] [stdout] test tests::test_execute_get_const_error_uninitialized ... ok
[INFO] [stdout] test tests::test_execute_get_const_success ... ok
[INFO] [stdout] test tests::test_execute_get_local_error_no_env ... ok
[INFO] [stdout] test tests::test_execute_get_local_success ... ok
[INFO] [stdout] test tests::test_execute_get_local_error_uninitialized_local ... ok
[INFO] [stdout] test tests::test_execute_get_str_error_uninitialized ... ok
[INFO] [stdout] test tests::test_execute_get_str_unification_failure ... ok
[INFO] [stdout] test tests::test_execute_get_str_success ... ok
[INFO] [stdout] test tests::test_execute_get_structure_error_uninitialized ... ok
[INFO] [stdout] test tests::test_execute_get_var_error_out_of_bounds ... ok
[INFO] [stdout] test tests::test_execute_get_structure_error_not_compound ... ok
[INFO] [stdout] test tests::test_execute_get_structure_success ... ok
[INFO] [stdout] test tests::test_execute_get_var_uninitialized ... ok
[INFO] [stdout] test tests::test_execute_get_var_with_unification ... ok
[INFO] [stdout] test tests::test_execute_indexed_call_error_no_index_entry ... ok
[INFO] [stdout] test tests::test_execute_call_user_defined_success ... ok
[INFO] [stdout] test tests::test_execute_choice ... ok
[INFO] [stdout] test tests::test_execute_deallocate_success ... ok
[INFO] [stdout] test tests::test_execute_fail_error_no_choice_point ... ok
[INFO] [stdout] test tests::test_execute_fail_success_backtracking ... ok
[INFO] [stdout] test tests::test_execute_indexed_call_error_no_index_map ... ok
[INFO] [stdout] test tests::test_execute_multi_indexed_call_success ... ok
[INFO] [stdout] test tests::test_execute_put_const_success ... ok
[INFO] [stdout] test tests::test_execute_put_str_success ... ok
[INFO] [stdout] test tests::test_execute_indexed_call_success ... ok
[INFO] [stdout] test tests::test_execute_proceed ... ok
[INFO] [stdout] test tests::test_execute_retract_clause_error_not_found ... ok
[INFO] [stdout] test tests::test_execute_put_var_error_out_of_bounds ... ok
[INFO] [stdout] test tests::test_execute_put_str_error_out_of_bounds ... ok
[INFO] [stdout] test tests::test_execute_put_var_success ... ok
[INFO] [stdout] test tests::test_execute_put_const_error_out_of_bounds ... ok
[INFO] [stdout] test tests::test_execute_retract_clause_error_predicate_not_found ... ok
[INFO] [stdout] test tests::test_execute_retract_clause_success ... ok
[INFO] [stdout] test tests::test_execute_set_local_error_no_env ... ok
[INFO] [stdout] test tests::test_execute_set_local_error_index_out_of_bounds ... ok
[INFO] [stdout] test tests::test_execute_set_local_success ... ok
[INFO] [stdout] test tests::test_execute_tail_call_user_defined ... ok
[INFO] [stdout] test tests::test_execute_multi_indexed_call_error_out_of_bounds ... ok
[INFO] [stdout] test tests::test_execute_tail_call_error_no_env ... ok
[INFO] [stdout] test tests::test_execute_tail_call_builtin ... ok
[INFO] [stdout] test tests::test_execute_get_const_failure_unification ... ok
[INFO] [stdout] test tests::test_execute_call_error_predicate_not_found ... ok
[INFO] [stdout] test tests::test_execute_cut ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 51 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.30s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/test_get_structure.rs (/opt/rustwide/target/debug/deps/test_get_structure-7447b78cabfb91c2)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test tests::test_get_structure ... ok
[INFO] [stderr]      Running tests/test_higher_order.rs (/opt/rustwide/target/debug/deps/test_higher_order-696d5d145c703a2b)
[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] [stdout] 
[INFO] [stdout] running 3 tests
[INFO] [stdout] test tests::test_beta_reduce_complex ... ok
[INFO] [stdout] test tests::test_substitution ... ok
[INFO] [stdout] test tests::test_beta_reduce_identity ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/test_index_table.rs (/opt/rustwide/target/debug/deps/test_index_table-9ba8fc5171b82d30)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stderr]      Running tests/test_indexed_call.rs (/opt/rustwide/target/debug/deps/test_indexed_call-f0484a78fb3ee1fc)
[INFO] [stdout] test tests::test_update_index_table_on_retract ... 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] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test tests::test_indexed_call ... 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/test_instruction.rs (/opt/rustwide/target/debug/deps/test_instruction-d652dac727635ffe)
[INFO] [stdout] 
[INFO] [stdout] running 31 tests
[INFO] [stdout] test tests::test_assert_clause_instruction ... ok
[INFO] [stdout] test tests::test_allocate_instruction ... ok
[INFO] [stdout] test tests::test_cut_instruction ... ok
[INFO] [stdout] test tests::test_call_instruction_builtin ... ok
[INFO] [stdout] test tests::test_deallocate_instruction_error ... ok
[INFO] [stdout] test tests::test_choice_instruction ... ok
[INFO] [stdout] test tests::test_deallocate_instruction_success ... ok
[INFO] [stdout] test tests::test_call_instruction_user_defined ... ok
[INFO] [stdout] test tests::test_build_compound_instruction_success ... ok
[INFO] [stdout] test tests::test_fail_instruction ... ok
[INFO] [stdout] test tests::test_get_local_instruction ... ok
[INFO] [stdout] test tests::test_get_str_instruction_success ... ok
[INFO] [stdout] test tests::test_get_const_instruction_failure ... ok
[INFO] [stdout] test tests::test_get_const_instruction_success ... ok
[INFO] [stdout] test tests::test_get_structure_instruction_success ... ok
[INFO] [stdout] test tests::test_get_var_instruction_uninitialized ... ok
[INFO] [stdout] test tests::test_get_var_instruction_with_unification ... ok
[INFO] [stdout] test tests::test_halt_instruction ... ok
[INFO] [stdout] test tests::test_instruction_arithmetic_is_variant ... ok
[INFO] [stdout] test tests::test_move_instruction ... ok
[INFO] [stdout] test tests::test_indexed_call_instruction_success ... ok
[INFO] [stdout] test tests::test_multi_indexed_call_instruction_success ... ok
[INFO] [stdout] test tests::test_proceed_instruction ... ok
[INFO] [stdout] test tests::test_retract_clause_instruction_error ... ok
[INFO] [stdout] test tests::test_put_str_instruction ... ok
[INFO] [stdout] test tests::test_retract_clause_instruction_success ... ok
[INFO] [stdout] test tests::test_put_var_instruction ... ok
[INFO] [stdout] test tests::test_set_local_instruction ... ok
[INFO] [stdout] test tests::test_put_const_instruction ... ok
[INFO] [stdout] test tests::test_tail_call_instruction_user_defined ... ok
[INFO] [stdout] test tests::test_tail_call_instruction_builtin ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 31 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/test_instruction_interpreter.rs (/opt/rustwide/target/debug/deps/test_instruction_interpreter-1b2a33024bc11641)
[INFO] [stdout] 
[INFO] [stdout] running 25 tests
[INFO] [stdout] test test_allocate_and_deallocate ... ok
[INFO] [stdout] test test_assert_clause ... ok
[INFO] [stdout] test test_build_compound ... ok
[INFO] [stdout] test test_arithmetic_is ... ok
[INFO] [stdout] test test_call ... ok
[INFO] [stdout] test test_comments_and_empty_lines ... ok
[INFO] [stdout] test test_choice ... ok
[INFO] [stdout] test test_fail ... ok
[INFO] [stdout] test test_get_const ... ok
[INFO] [stdout] test test_cut ... ok
[INFO] [stdout] test test_get_local ... ok
[INFO] [stdout] test test_get_str ... ok
[INFO] [stdout] test test_halt ... ok
[INFO] [stdout] test test_tail_call ... ok
[INFO] [stdout] test test_move ... ok
[INFO] [stdout] test test_multi_indexed_call ... ok
[INFO] [stdout] test test_proceed ... ok
[INFO] [stdout] test test_put_str ... ok
[INFO] [stdout] test test_indexed_call ... ok
[INFO] [stdout] test test_put_var ... ok
[INFO] [stdout] test test_put_const ... ok
[INFO] [stdout] test test_get_var ... ok
[INFO] [stderr]      Running tests/test_instruction_parser_errors.rs (/opt/rustwide/target/debug/deps/test_instruction_parser_errors-8237ef579087af55)
[INFO] [stdout] test test_get_structure ... ok
[INFO] [stdout] test test_retract_clause ... ok
[INFO] [stdout] test test_set_local ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 25 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 16 tests
[INFO] [stdout] test test_complex_arithmetic_expression ... ok
[INFO] [stderr]      Running tests/test_instruction_parser_extra.rs (/opt/rustwide/target/debug/deps/test_instruction_parser_extra-614be997c2e47ca5)
[INFO] [stdout] test test_empty_input ... ok
[INFO] [stdout] test test_extra_parameter_proceed ... ok
[INFO] [stdout] test test_extra_whitespace_and_commas ... ok
[INFO] [stdout] test test_invalid_arithmetic_expression ... ok
[INFO] [stdout] test test_invalid_mnemonic ... ok
[INFO] [stdout] test test_invalid_integer_in_put_const ... ok
[INFO] [stdout] test test_invalid_register_token ... ok
[INFO] [stdout] test test_get_local_invalid_register ... ok
[INFO] [stdout] test test_missing_parameter_put_const ... ok
[INFO] [stdout] test test_multi_indexed_call_invalid_register ... ok
[INFO] [stdout] test test_move_invalid_register ... ok
[INFO] [stdout] test test_only_comments ... ok
[INFO] [stdout] test test_set_local_invalid_index ... ok
[INFO] [stdout] test test_trailing_comma ... ok
[INFO] [stdout] test test_whitespace_input ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 16 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 27 tests
[INFO] [stdout] test test_allocate_non_numeric ... ok
[INFO] [stdout] test test_arithmetic_is_extra_parameters ... ok
[INFO] [stdout] test test_build_compound_insufficient_parameters ... ok
[INFO] [stdout] test test_choice_extra_parameters ... ok
[INFO] [stdout] test test_assert_clause_extra_parameters ... ok
[INFO] [stdout] test test_call_extra_parameters ... ok
[INFO] [stdout] test test_fail_extra_parameters ... ok
[INFO] [stdout] test test_choice_missing_parameters ... ok
[INFO] [stdout] test test_get_local_extra_parameters ... ok
[INFO] [stdout] test test_get_str_extra_parameters ... ok
[INFO] [stdout] test test_get_local_invalid_register_format ... ok
[INFO] [stdout] test test_get_str_unquoted_string_with_space ... ok
[INFO] [stdout] test test_get_var_non_numeric_var_id ... ok
[INFO] [stdout] test test_move_extra_parameters ... ok
[INFO] [stdout] test test_multi_indexed_call_insufficient_parameters ... ok
[INFO] [stdout] test test_put_const_extra_parameters ... ok
[INFO] [stdout] test test_parse_register_too_short ... ok
[INFO] [stdout] test test_put_str_extra_parameters ... ok
[INFO] [stdout] test test_put_var_non_numeric_var_id ... ok
[INFO] [stdout] test test_tail_call_extra_parameters ... ok
[INFO] [stdout] test test_put_const_missing_parameters ... ok
[INFO] [stdout] test test_get_structure_extra_parameters ... ok
[INFO] [stdout] test test_retract_clause_extra_parameters ... ok
[INFO] [stdout] test test_indexed_call_extra_parameters ... ok
[INFO] [stdout] test test_put_var_missing_parameters ... ok
[INFO] [stdout] test test_set_local_extra_parameters ... ok
[INFO] [stderr]      Running tests/test_lambda.rs (/opt/rustwide/target/debug/deps/test_lambda-d392261e72d56515)
[INFO] [stdout] test test_set_local_unquoted_string_with_space ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 27 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.12s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 18 tests
[INFO] [stdout] test tests::test_beta_reduce_compound ... ok
[INFO] [stdout] test tests::test_beta_reduce_lambda_body ... ok
[INFO] [stdout] test tests::test_beta_reduce_nested_app ... ok
[INFO] [stdout] test tests::test_beta_reduce_simple ... ok
[INFO] [stdout] test tests::test_beta_reduce_wrapper_types ... ok
[INFO] [stdout] test tests::test_substitute_compound ... ok
[INFO] [stdout] test tests::test_substitute_lambda_no_capture ... ok
[INFO] [stdout] test tests::test_substitute_lambda_param_equal ... ok
[INFO] [stdout] test tests::test_substitute_higher_order ... ok
[INFO] [stdout] test tests::test_substitute_app ... ok
[INFO] [stdout] test tests::test_substitute_const_and_str ... ok
[INFO] [stdout] test tests::test_substitute_lambda_with_capture_avoidance ... ok
[INFO] [stdout] test tests::test_substitute_modal ... ok
[INFO] [stdout] test tests::test_substitute_prob ... ok
[INFO] [stdout] test tests::test_substitute_temporal ... ok
[INFO] [stdout] test tests::test_substitute_var_matches ... ok
[INFO] [stdout] test tests::test_substitute_var_no_match ... ok
[INFO] [stdout] test tests::test_substitute_constraint ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 18 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/test_machine.rs (/opt/rustwide/target/debug/deps/test_machine-c66701e963bdab31)
[INFO] [stdout] 
[INFO] [stdout] running 6 tests
[INFO] [stdout] test tests::test_get_const_unification_success ... ok
[INFO] [stdout] test tests::test_call_and_proceed ... ok
[INFO] [stdout] test tests::test_get_var_unification ... ok
[INFO] [stdout] test tests::test_get_const_unification_failure ... ok
[INFO] [stdout] test tests::test_put_const_instruction ... ok
[INFO] [stdout] test tests::test_put_var_instruction ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/test_main.rs (/opt/rustwide/target/debug/deps/test_main-01f751a361f377b0)
[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] [stderr]      Running tests/test_nqueens.rs (/opt/rustwide/target/debug/deps/test_nqueens-4cb44e769c2b8402)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test tests::test_nqueens_4_simulated ... ok
[INFO] [stdout] 
[INFO] [stderr]      Running tests/test_path_inference.rs (/opt/rustwide/target/debug/deps/test_path_inference-21b2f76cff2fe336)
[INFO] [stdout] test result: ok. 1 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 tests::benchmark_path_inference ... 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] [stdout] 
[INFO] [stderr]      Running tests/test_ping.rs (/opt/rustwide/target/debug/deps/test_ping-7dd21f0a73ea3669)
[INFO] [stdout] running 1 test
[INFO] [stderr]      Running tests/test_prolog_ast.rs (/opt/rustwide/target/debug/deps/test_prolog_ast-9c03b7bf7ba463b2)
[INFO] [stdout] test tests::test_ping ... 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] [stdout] 
[INFO] [stdout] running 6 tests
[INFO] [stdout] test tests::test_compound_term ... ok
[INFO] [stdout] test tests::test_fact_clause ... ok
[INFO] [stdout] test tests::test_term_equality_variables ... ok
[INFO] [stdout] test tests::test_rule_clause ... ok
[INFO] [stdout] test tests::test_query_structure ... ok
[INFO] [stdout] test tests::test_term_equality_atoms ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.06s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/test_prolog_interpreter.rs (/opt/rustwide/target/debug/deps/test_prolog_interpreter-cd066ae8120616cb)
[INFO] [stdout] 
[INFO] [stdout] running 3 tests
[INFO] [stdout] test test_main_write_hello_world ... ok
[INFO] [stdout] test test_main_with_variable_assignment ... ok
[INFO] [stdout] test test_main_parent ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.07s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/test_prolog_parser.rs (/opt/rustwide/target/debug/deps/test_prolog_parser-19ef2f28cb4eb4ae)
[INFO] [stdout] 
[INFO] [stdout] running 7 tests
[INFO] [stdout] test tests::test_missing_period ... ok
[INFO] [stdout] test tests::test_parse_atom ... ok
[INFO] [stdout] test tests::test_parse_compound ... ok
[INFO] [stdout] test tests::test_parse_variable ... ok
[INFO] [stdout] test tests::test_parse_rule ... ok
[INFO] [stdout] test tests::test_parse_number ... ok
[INFO] [stdout] test tests::test_parse_fact ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/test_properties.rs (/opt/rustwide/target/debug/deps/test_properties-a9f449506340ca4d)
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test tests::prop_unify_same_constants ... ok
[INFO] [stderr]      Running tests/test_tail_call.rs (/opt/rustwide/target/debug/deps/test_tail_call-c92f6b895055056b)
[INFO] [stdout] test tests::prop_undo_binding ... ok
[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 1 test
[INFO] [stdout] test tests::test_tail_call ... 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/test_term.rs (/opt/rustwide/target/debug/deps/test_term-0594c4916a112692)
[INFO] [stdout] 
[INFO] [stdout] running 5 tests
[INFO] [stdout] test tests::test_clone ... ok
[INFO] [stdout] test tests::test_create_var ... ok
[INFO] [stdout] test tests::test_nested_compound ... ok
[INFO] [stdout] test tests::test_create_const ... ok
[INFO] [stdout] test tests::test_create_compound ... 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/test_term_display.rs (/opt/rustwide/target/debug/deps/test_term_display-0e98df34aab257da)
[INFO] [stdout] 
[INFO] [stdout] running 7 tests
[INFO] [stdout] test tests::test_display_compound_nested ... ok
[INFO] [stdout] test tests::test_display_compound_empty_args ... ok
[INFO] [stdout] test tests::test_display_compound_with_args ... ok
[INFO] [stdout] test tests::test_display_const ... ok
[INFO] [stdout] test tests::test_display_var ... ok
[INFO] [stdout] test tests::test_display_other_variant_falls_back_to_debug ... ok
[INFO] [stderr]      Running tests/test_unification.rs (/opt/rustwide/target/debug/deps/test_unification-4907344ecc679770)
[INFO] [stdout] test tests::test_display_str ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 6 tests
[INFO] [stdout] test tests::test_bind_variable_to_variable ... ok
[INFO] [stdout] test tests::test_new_union_find ... ok
[INFO] [stdout] test tests::test_undo_trail ... ok
[INFO] [stdout] test tests::test_path_compression ... ok
[INFO] [stdout] test tests::test_bind_self_no_change ... ok
[INFO] [stdout] test tests::test_bind_constant ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/test_unification_performance.rs (/opt/rustwide/target/debug/deps/test_unification_performance-4e53b9f4ddc1799c)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stderr]      Running tests/test_union_find.rs (/opt/rustwide/target/debug/deps/test_union_find-12ffb889f77c0ffb)
[INFO] [stdout] test tests::benchmark_unify_identical_terms ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 25.95s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 4 tests
[INFO] [stdout] test tests::test_bind_and_resolve ... ok
[INFO] [stdout] test tests::test_bind_variable_to_variable ... ok
[INFO] [stdout] test tests::test_undo_trail ... ok
[INFO] [stdout] test tests::test_bind_variable_to_itself ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests lam
[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" "504c163800b2a5bb4d74866eed929d0fe388a85102f5911ca573d3c76d148ebc", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "504c163800b2a5bb4d74866eed929d0fe388a85102f5911ca573d3c76d148ebc", kill_on_drop: false }`
[INFO] [stdout] 504c163800b2a5bb4d74866eed929d0fe388a85102f5911ca573d3c76d148ebc