[INFO] cloning repository https://github.com/dijkstracula/irving
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/dijkstracula/irving" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fdijkstracula%2Firving", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fdijkstracula%2Firving'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] e254c3417ec9b9545151107cc419d63411ce8999
[INFO] testing dijkstracula/irving against beta-2026-03-05 for beta-1.95-1
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fdijkstracula%2Firving" "/workspace/builds/worker-0-tc2/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-0-tc2/source'...
[INFO] [stderr] done.
[INFO] started tweaking git repo https://github.com/dijkstracula/irving
[INFO] finished tweaking git repo https://github.com/dijkstracula/irving
[INFO] tweaked toml for git repo https://github.com/dijkstracula/irving written to /workspace/builds/worker-0-tc2/source/Cargo.toml
[INFO] validating manifest of git repo https://github.com/dijkstracula/irving on toolchain beta-2026-03-05
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+beta-2026-03-05" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate git repo https://github.com/dijkstracula/irving 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" "+beta-2026-03-05" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2026-03-05" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 074df97edf5eb18824c0bf69e784398cc0e3aaa9d4ba8a9977b4b5d2508d43ce
[INFO] running `Command { std: "docker" "start" "-a" "074df97edf5eb18824c0bf69e784398cc0e3aaa9d4ba8a9977b4b5d2508d43ce", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "074df97edf5eb18824c0bf69e784398cc0e3aaa9d4ba8a9977b4b5d2508d43ce", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "074df97edf5eb18824c0bf69e784398cc0e3aaa9d4ba8a9977b4b5d2508d43ce", kill_on_drop: false }`
[INFO] [stdout] 074df97edf5eb18824c0bf69e784398cc0e3aaa9d4ba8a9977b4b5d2508d43ce
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/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" "RUSTDOCFLAGS=--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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2026-03-05" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 5586e1a0ea741eaa8526ad3b47c06a33d7957fb37fe392cc945ce1415d7e96b8
[INFO] running `Command { std: "docker" "start" "-a" "5586e1a0ea741eaa8526ad3b47c06a33d7957fb37fe392cc945ce1415d7e96b8", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v1.0.56
[INFO] [stderr]    Compiling quote v1.0.26
[INFO] [stderr]    Compiling unicode-ident v1.0.8
[INFO] [stderr]    Compiling thiserror v1.0.40
[INFO] [stderr]    Compiling rustix v0.38.3
[INFO] [stderr]    Compiling memchr v2.5.0
[INFO] [stderr]    Compiling linux-raw-sys v0.4.3
[INFO] [stderr]    Compiling bitflags v2.3.3
[INFO] [stderr]    Compiling once_cell v1.17.1
[INFO] [stderr]    Compiling ucd-trie v0.1.5
[INFO] [stderr]    Compiling utf8parse v0.2.1
[INFO] [stderr]    Compiling syn v1.0.109
[INFO] [stderr]    Compiling anstyle-parse v0.2.1
[INFO] [stderr]    Compiling anstyle v1.0.1
[INFO] [stderr]    Compiling regex-syntax v0.7.4
[INFO] [stderr]    Compiling anstyle-query v1.0.0
[INFO] [stderr]    Compiling colorchoice v1.0.0
[INFO] [stderr]    Compiling strsim v0.10.0
[INFO] [stderr]    Compiling heck v0.4.1
[INFO] [stderr]    Compiling anyhow v1.0.75
[INFO] [stderr]    Compiling clap_lex v0.5.0
[INFO] [stderr]    Compiling either v1.9.0
[INFO] [stderr]    Compiling aho-corasick v1.0.2
[INFO] [stderr]    Compiling humantime v2.1.0
[INFO] [stderr]    Compiling unicode-width v0.1.10
[INFO] [stderr]    Compiling termcolor v1.2.0
[INFO] [stderr]    Compiling log v0.4.19
[INFO] [stderr]    Compiling annotate-snippets v0.9.2
[INFO] [stderr]    Compiling itertools v0.11.0
[INFO] [stderr]    Compiling syn v2.0.15
[INFO] [stderr]    Compiling is-terminal v0.4.9
[INFO] [stderr]    Compiling anstream v0.3.2
[INFO] [stderr]    Compiling lazy_static v1.4.0
[INFO] [stderr]    Compiling clap_builder v4.3.11
[INFO] [stderr]    Compiling regex-automata v0.3.3
[INFO] [stderr]    Compiling thiserror-impl v1.0.40
[INFO] [stderr]    Compiling clap_derive v4.3.2
[INFO] [stderr]    Compiling regex v1.9.1
[INFO] [stderr]    Compiling pest_consume_macros v1.1.0
[INFO] [stderr]    Compiling env_logger v0.10.0
[INFO] [stderr]    Compiling pest v2.6.0
[INFO] [stderr]    Compiling clap v4.3.11
[INFO] [stderr]    Compiling pest_meta v2.6.0
[INFO] [stderr]    Compiling pest_generator v2.6.0
[INFO] [stderr]    Compiling pest_derive v2.6.0
[INFO] [stderr]    Compiling pest_consume v1.1.3
[INFO] [stderr]    Compiling irving v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 52.00s
[INFO] running `Command { std: "docker" "inspect" "5586e1a0ea741eaa8526ad3b47c06a33d7957fb37fe392cc945ce1415d7e96b8", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "5586e1a0ea741eaa8526ad3b47c06a33d7957fb37fe392cc945ce1415d7e96b8", kill_on_drop: false }`
[INFO] [stdout] 5586e1a0ea741eaa8526ad3b47c06a33d7957fb37fe392cc945ce1415d7e96b8
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/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" "RUSTDOCFLAGS=--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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2026-03-05" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] e8eac243d20a60445da549cae650af03177ae253329f5539583ec87490b7a843
[INFO] running `Command { std: "docker" "start" "-a" "e8eac243d20a60445da549cae650af03177ae253329f5539583ec87490b7a843", kill_on_drop: false }`
[INFO] [stderr]    Compiling ctor v0.2.4
[INFO] [stderr]    Compiling irving v0.1.0 (/opt/rustwide/workdir)
[INFO] [stdout] warning: unexpected `cfg` condition value: `used_linker`
[INFO] [stdout]  --> src/tests/mod.rs:9:1
[INFO] [stdout]   |
[INFO] [stdout] 9 | #[ctor::ctor]
[INFO] [stdout]   | ^^^^^^^^^^^^^
[INFO] [stdout]   |
[INFO] [stdout]   = note: no expected values for `feature`
[INFO] [stdout]   = note: using a cfg inside a attribute macro will use the cfgs from the destination crate and not the ones from the defining crate
[INFO] [stdout]   = help: try referring to `ctor::ctor` crate for guidance on how handle this unexpected cfg
[INFO] [stdout]   = help: the attribute macro `ctor::ctor` may come from an old version of the `ctor` crate, try updating your dependency with `cargo update -p ctor`
[INFO] [stdout]   = note: see <https://doc.rust-lang.org/nightly/rustc/check-cfg/cargo-specifics.html> for more information about checking conditional configuration
[INFO] [stdout]   = note: `#[warn(unexpected_cfgs)]` on by default
[INFO] [stdout]   = note: this warning originates in the attribute macro `ctor::ctor` (in Nightly builds, run with -Z macro-backtrace for more info)
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 14.26s
[INFO] running `Command { std: "docker" "inspect" "e8eac243d20a60445da549cae650af03177ae253329f5539583ec87490b7a843", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "e8eac243d20a60445da549cae650af03177ae253329f5539583ec87490b7a843", kill_on_drop: false }`
[INFO] [stdout] e8eac243d20a60445da549cae650af03177ae253329f5539583ec87490b7a843
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/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" "RUSTDOCFLAGS=--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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2026-03-05" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] f6b125f90cfc97a13ad182083558acbe8fbc90e7867851370765014581980d44
[INFO] running `Command { std: "docker" "start" "-a" "f6b125f90cfc97a13ad182083558acbe8fbc90e7867851370765014581980d44", kill_on_drop: false }`
[INFO] [stderr] warning: unexpected `cfg` condition value: `used_linker`
[INFO] [stderr]  --> src/tests/mod.rs:9:1
[INFO] [stderr]   |
[INFO] [stderr] 9 | #[ctor::ctor]
[INFO] [stderr]   | ^^^^^^^^^^^^^
[INFO] [stderr]   |
[INFO] [stderr]   = note: no expected values for `feature`
[INFO] [stderr]   = note: using a cfg inside a attribute macro will use the cfgs from the destination crate and not the ones from the defining crate
[INFO] [stderr]   = help: try referring to `ctor::ctor` crate for guidance on how handle this unexpected cfg
[INFO] [stderr]   = help: the attribute macro `ctor::ctor` may come from an old version of the `ctor` crate, try updating your dependency with `cargo update -p ctor`
[INFO] [stderr]   = note: see <https://doc.rust-lang.org/nightly/rustc/check-cfg/cargo-specifics.html> for more information about checking conditional configuration
[INFO] [stderr]   = note: `#[warn(unexpected_cfgs)]` on by default
[INFO] [stderr]   = note: this warning originates in the attribute macro `ctor::ctor` (in Nightly builds, run with -Z macro-backtrace for more info)
[INFO] [stderr] 
[INFO] [stderr] warning: `irving` (lib test) generated 1 warning
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.13s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/irving-b716b933b8eef1f4)
[INFO] [stdout] 
[INFO] [stdout] running 289 tests
[INFO] [stdout] test tests::extraction::ivy::tests::pprint_class ... ok
[INFO] [stdout] test tests::extraction::ivy::tests::pprint_subclass ... ok
[INFO] [stdout] test tests::extraction::java::tests::extract_action_forward_ref ... ok
[INFO] [stdout] test tests::extraction::java::tests::extract_action_and_decl ... ok
[INFO] [stdout] test tests::extraction::java::tests::extract_arith ... ok
[INFO] [stdout] test tests::extraction::java::tests::extract_assign_nat_lit ... ok
[INFO] [stdout] test tests::extraction::ivy::tests::pprint_formula_with_dots ... ok
[INFO] [stdout] test tests::extraction::java::tests::extract_after_decl ... ok
[INFO] [stdout] test tests::extraction::ivy::tests::pprint_arith ... ok
[INFO] [stdout] test tests::extraction::java::tests::extract_after_init ... ok
[INFO] [stdout] test tests::extraction::java::tests::extract_assign_nat_nonlit ... ok
[INFO] [stdout] test tests::extraction::java::tests::extract_assign_range_binop ... ok
[INFO] [stdout] test tests::extraction::java::tests::extract_call ... ok
[INFO] [stdout] test tests::extraction::java::tests::extract_bool ... ok
[INFO] [stdout] test tests::extraction::java::tests::extract_field_access ... ok
[INFO] [stdout] test tests::extraction::java::tests::extract_forall ... ok
[INFO] [stdout] test tests::extraction::java::tests::extract_call_compound_arg ... ok
[INFO] [stdout] test tests::extraction::java::tests::extract_module_parameterized ... ok
[INFO] [stdout] test tests::extraction::java::tests::extract_assign_range_lit ... ok
[INFO] [stdout] test tests::extraction::ivy::tests::pprint_fnapp ... ok
[INFO] [stdout] test tests::extraction::java::tests::extract_assign_range_saturated_lit ... ok
[INFO] [stdout] test tests::extraction::java::tests::extract_module_simple ... ok
[INFO] [stdout] test tests::extraction::java::tests::extract_process_trivial ... ok
[INFO] [stdout] test tests::extraction::java::tests::extract_vardecl ... ok
[INFO] [stdout] test tests::extraction::java::tests::extract_nested_forall ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_alias_decl ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_attribute_assign ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_axiom ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_axiom_2 ... ok
[INFO] [stdout] test tests::extraction::vnt::tests::test_param_dedup ... ok
[INFO] [stdout] test tests::extraction::ivy::tests::pprint_complex_expr ... ok
[INFO] [stdout] test tests::extraction::ivy::tests::pprint_formula ... ok
[INFO] [stdout] test tests::extraction::vnt::tests::test_relation_init ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_attribute ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_class_decl ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_function_decl_impl ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_ensure_with_fmla ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_function_decl_impl_explicit_ret ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_function_decl_uninterp ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_global_decl ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_implementation_decl ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_interpret_annotated_decl ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_instance_decl ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_interpret_uninterp_decl ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_module_decl_1 ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_invariant_decl ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_common_decl ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_decl_sig ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_module_decl_2 ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_function_decl_incomplete ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_nullary_relation ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_parametrized_decl_err ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_object_decl ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_process_decl ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_relation_decl ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_subclass_decl ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_type_decl_with_super ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_specification_decl ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_var_decl_with_type ... ok
[INFO] [stdout] test tests::parser::declarations::tests::vardecl_declare_and_assign ... ok
[INFO] [stdout] test tests::parser::expressions::tests::parse_complex_expr ... ok
[INFO] [stdout] test tests::parser::expressions::tests::parse_conjunction_fmla ... ok
[INFO] [stdout] test tests::parser::expressions::tests::parse_dot_expr ... ok
[INFO] [stdout] test tests::parser::expressions::tests::parse_fnapp_and_index ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_type_decl ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_type_decl_this ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_var_decl ... ok
[INFO] [stdout] test tests::parser::expressions::tests::parse_fnapp_in_conj ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_type_decl_range ... ok
[INFO] [stdout] test tests::parser::expressions::tests::parse_negation_expr ... ok
[INFO] [stdout] test tests::parser::expressions::tests::parse_le ... ok
[INFO] [stdout] test tests::parser::expressions::tests::parse_logicvar ... ok
[INFO] [stdout] test tests::parser::expressions::tests::parse_negative_number_expr ... ok
[INFO] [stdout] test tests::parser::expressions::tests::parse_number_expr ... ok
[INFO] [stdout] test tests::parser::expressions::tests::parse_pred_2 ... ok
[INFO] [stdout] test tests::parser::expressions::tests::parse_nested_fnapp ... ok
[INFO] [stdout] test tests::parser::expressions::tests::parse_sub ... ok
[INFO] [stdout] test tests::parser::expressions::tests::parse_pred ... ok
[INFO] [stdout] test tests::parser::expressions::tests::parse_progsym ... ok
[INFO] [stdout] test tests::parser::expressions::tests::parse_symbol_with_underscore ... ok
[INFO] [stdout] test tests::parser::formulas::tests::parse_bool ... ok
[INFO] [stdout] test tests::parser::formulas::tests::parse_conjunction ... ok
[INFO] [stdout] test tests::parser::expressions::tests::parse_unary_fnapp ... ok
[INFO] [stdout] test tests::parser::expressions::tests::parse_unary_fnapp_and_negation ... ok
[INFO] [stdout] test tests::parser::formulas::tests::parse_existential_quant ... ok
[INFO] [stdout] test tests::parser::formulas::tests::parse_logical_implication ... ok
[INFO] [stdout] test tests::parser::formulas::tests::dot_on_quant ... ok
[INFO] [stdout] test tests::parser::formulas::tests::parse_logicvar_in_subexpr ... ok
[INFO] [stdout] test tests::parser::formulas::tests::parse_logicvar_in_fnapp ... ok
[INFO] [stdout] test tests::parser::formulas::tests::parse_negation ... ok
[INFO] [stdout] test tests::parser::formulas::tests::parse_nested_quants ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_type_enum_range ... ok
[INFO] [stdout] test tests::parser::formulas::tests::parse_number ... ok
[INFO] [stdout] test tests::parser::expressions::tests::parse_multi_fnapp ... ok
[INFO] [stdout] test tests::parser::formulas::tests::parse_parens_negation ... ok
[INFO] [stdout] test tests::parser::formulas::tests::parse_pred_logicsym ... ok
[INFO] [stdout] test tests::parser::formulas::tests::parse_pred_progsym ... ok
[INFO] [stdout] test tests::parser::formulas::tests::parse_progvar_in_fnapp ... ok
[INFO] [stdout] test tests::parser::formulas::tests::parse_term ... ok
[INFO] [stdout] test tests::parser::formulas::tests::parse_universal_quant ... ok
[INFO] [stdout] test tests::parser::formulas::tests::parse_universal_quant2 ... ok
[INFO] [stdout] test tests::parser::formulas::tests::parse_universal_quant3 ... ok
[INFO] [stdout] test tests::parser::formulas::tests::parse_nested_quants2 ... ok
[INFO] [stdout] test tests::parser::formulas::tests::parse_nested_implications ... ok
[INFO] [stdout] test tests::parser::mixins::tests::parse_action_decl_with_ret_and_body ... ok
[INFO] [stdout] test tests::extraction::vnt::tests::test_noninf1 ... ok
[INFO] [stdout] test tests::parser::mixins::tests::parse_action_forward_ref ... ok
[INFO] [stdout] test tests::parser::formulas::tests::parse_negated_quant ... ok
[INFO] [stdout] test tests::parser::mixins::tests::parse_action_decl_with_ret_no_body ... ok
[INFO] [stdout] test tests::parser::mixins::tests::parse_after_init ... ok
[INFO] [stdout] test tests::parser::formulas::tests::parse_nested_implications_2 ... ok
[INFO] [stdout] test tests::parser::mixins::tests::parse_action_decl_no_ret_but_body ... ok
[INFO] [stdout] test tests::parser::mixins::tests::parse_action_decl_no_ret_nor_body ... ok
[INFO] [stdout] test tests::parser::formulas::tests::parse_term_with_annotation ... ok
[INFO] [stdout] test tests::parser::mixins::tests::parse_implement_with_declret ... ok
[INFO] [stdout] test tests::parser::mixins::tests::parse_after_mixin ... ok
[INFO] [stdout] test tests::parser::mixins::tests::parse_nested_action ... ok
[INFO] [stdout] test tests::parser::mixins::tests::parse_after_mixin_with_declret ... ok
[INFO] [stdout] test tests::parser::mixins::tests::parse_export_action ... ok
[INFO] [stdout] test tests::parser::mixins::tests::parse_export_forward_ref ... ok
[INFO] [stdout] test tests::parser::mixins::tests::parse_export_forward_ref_qualified ... ok
[INFO] [stdout] test tests::parser::mixins::tests::parse_implement ... ok
[INFO] [stdout] test tests::parser::statements::tests::parse_assert_action ... ok
[INFO] [stdout] test tests::parser::statements::tests::parse_assign ... ok
[INFO] [stdout] test tests::parser::statements::tests::parse_assign_to_relation_2 ... ok
[INFO] [stdout] test tests::parser::statements::tests::parse_assign_to_field ... ok
[INFO] [stdout] test tests::parser::statements::tests::parse_assign_to_field_of_this ... ok
[INFO] [stdout] test tests::parser::statements::tests::parse_assign_with_rhs_logicvar ... ok
[INFO] [stdout] test tests::parser::statements::tests::parse_assign_to_relation ... ok
[INFO] [stdout] test tests::parser::statements::tests::parse_assume_action ... ok
[INFO] [stdout] test tests::parser::statements::tests::parse_declare_annot ... ok
[INFO] [stdout] test tests::parser::statements::tests::parse_ensure_action ... ok
[INFO] [stdout] test tests::parser::statements::tests::parse_not_an_assign ... ok
[INFO] [stdout] test tests::parser::statements::tests::parse_multi_stmt_while ... ok
[INFO] [stdout] test tests::parser::statements::tests::parse_requires_action ... ok
[INFO] [stdout] test tests::parser::statements::tests::parse_if_stmt ... ok
[INFO] [stdout] test tests::parser::statements::tests::parse_stmt_block ... ok
[INFO] [stdout] test tests::parser::toplevels::tests::non_top_include ... ok
[INFO] [stdout] test tests::parser::toplevels::tests::parse_hashlang_major_minor ... ok
[INFO] [stdout] test tests::parser::toplevels::tests::parse_hashlang_major_only ... ok
[INFO] [stdout] test tests::parser::toplevels::tests::parse_less_trivial_prog ... ok
[INFO] [stdout] test tests::parser::toplevels::tests::parse_trivial_prog ... ok
[INFO] [stdout] test tests::parser::statements::tests::parse_ensure_action_2 ... ok
[INFO] [stdout] test tests::parser::statements::tests::parse_requires_action_2 ... ok
[INFO] [stdout] test tests::passes::constant_fold::tests::fold_constants ... ok
[INFO] [stdout] test tests::passes::constant_fold::tests::fold_left_assoc ... ok
[INFO] [stdout] test tests::passes::constant_fold::tests::fold_zero_add ... ok
[INFO] [stdout] test tests::parser::statements::tests::parse_while ... ok
[INFO] [stdout] test tests::passes::quantifier_bounds::tests::bounds_from_binop_literals ... ok
[INFO] [stdout] test tests::passes::quantifier_bounds::tests::bounds_from_binop_logicvar ... ok
[INFO] [stdout] test tests::passes::quantifier_bounds::tests::bounds_from_forall_nats_conjunction ... ok
[INFO] [stdout] test tests::passes::module_instantiation::tests::test_module_instantiation ... ok
[INFO] [stdout] test tests::passes::quantifier_bounds::tests::bounds_for_sort ... ok
[INFO] [stdout] test tests::passes::quantifier_bounds::tests::bounds_from_forall_nats_disjunction ... ok
[INFO] [stdout] test tests::parser::toplevels::tests::logical_call_to_action ... ok
[INFO] [stdout] test tests::passes::quantifier_bounds::tests::op_on_logicsym ... ok
[INFO] [stdout] test tests::passes::quantifier_bounds::tests::bounds_from_forall_nats_false_monotonic_gt ... ok
[INFO] [stdout] test tests::passes::quantifier_bounds::tests::succ_binop_of_literals ... ok
[INFO] [stdout] test tests::passes::quantifier_bounds::tests::bounds_from_forall_nats_not_negative ... ok
[INFO] [stdout] test tests::passes::quantifier_bounds::tests::bounds_from_forall_nats_monotonic_lt ... ok
[INFO] [stdout] test tests::passes::quantifier_bounds::tests::bounds_from_forall_nats_positive ... ok
[INFO] [stdout] test tests::passes::quantifier_bounds::tests::succ_compound ... ok
[INFO] [stdout] test tests::passes::quantifier_bounds::tests::succ_literal ... ok
[INFO] [stdout] test tests::parser::statements::tests::parse_if_ladder ... ok
[INFO] [stdout] test tests::parser::statements::tests::parse_if_stmt_with_else ... ok
[INFO] [stdout] test tests::extraction::java::tests::extract_module_instantation ... FAILED
[INFO] [stdout] test tests::programs::accord::typecheck_abstract_protocol ... FAILED
[INFO] [stdout] test tests::programs::accord::typecheck_sorts ... FAILED
[INFO] [stdout] test tests::programs::accord::typecheck_protocol ... FAILED
[INFO] [stdout] test tests::programs::accord::typecheck_messages ... FAILED
[INFO] [stdout] test tests::programs::accord::typecheck_temporality ... FAILED
[INFO] [stdout] test tests::programs::accord::typecheck_txn ... FAILED
[INFO] [stdout] test tests::programs::parser::test_append ... ok
[INFO] [stdout] test tests::programs::parser::test_loops ... ok
[INFO] [stdout] test tests::typechecker::actions::tests::action_assign ... ok
[INFO] [stdout] test tests::programs::parser::test_state_and_actions ... ok
[INFO] [stdout] test tests::typechecker::actions::tests::action_assign_logical ... ok
[INFO] [stdout] test tests::typechecker::actions::tests::action_call_curry_this ... ok
[INFO] [stdout] test tests::programs::parser::test_modules ... ok
[INFO] [stdout] test tests::typechecker::actions::tests::action_before_after ... ok
[INFO] [stdout] test tests::typechecker::actions::tests::action_call_nullary_action ... ok
[INFO] [stdout] test tests::typechecker::actions::tests::action_forward_ref ... ok
[INFO] [stdout] test tests::programs::parser::test_isolates ... ok
[INFO] [stdout] test tests::typechecker::actions::tests::action_call_unary ... ok
[INFO] [stdout] test tests::programs::parser::test_safety_and_invariants ... ok
[INFO] [stdout] test tests::typechecker::actions::tests::action_read_relation_logical ... ok
[INFO] [stdout] test tests::typechecker::actions::tests::action_nullary_application ... ok
[INFO] [stdout] test tests::typechecker::actions::tests::ident_action_decl ... ok
[INFO] [stdout] test tests::typechecker::actions::tests::action_read_relation ... ok
[INFO] [stdout] test tests::typechecker::actions::tests::implicit_nullary_action_call ... ok
[INFO] [stdout] test tests::typechecker::actions::tests::inconsistent_mixin ... ok
[INFO] [stdout] test tests::typechecker::actions::tests::local_vardecl ... ok
[INFO] [stdout] test tests::typechecker::actions::tests::action_nullary_application_opaque_ret_sort ... ok
[INFO] [stdout] test tests::typechecker::actions::tests::noop_action_decl ... ok
[INFO] [stdout] test tests::typechecker::actions::tests::local_vardecl_and_init ... ok
[INFO] [stdout] test tests::typechecker::actions::tests::noop_action_decl_with_local ... ok
[INFO] [stdout] test tests::typechecker::actions::tests::unknown_ident_in_action_impl ... ok
[INFO] [stdout] test tests::typechecker::declarations::tests::alias_bv ... ok
[INFO] [stdout] test tests::typechecker::declarations::tests::ensure ... ok
[INFO] [stdout] test tests::typechecker::declarations::tests::class ... ok
[INFO] [stdout] test tests::typechecker::declarations::tests::declblock ... ok
[INFO] [stdout] test tests::typechecker::declarations::tests::ensure_bad ... ok
[INFO] [stdout] test tests::typechecker::declarations::tests::ensure_quantified ... ok
[INFO] [stdout] test tests::typechecker::declarations::tests::function_interpreted_ret_mismatch ... ok
[INFO] [stdout] test tests::typechecker::declarations::tests::function_uninterpreted ... ok
[INFO] [stdout] test tests::typechecker::declarations::tests::instance_decl_no_args ... ok
[INFO] [stdout] test tests::typechecker::declarations::tests::require ... ok
[INFO] [stdout] test tests::typechecker::declarations::tests::relation_decl_unannotated ... ok
[INFO] [stdout] test tests::typechecker::declarations::tests::relation_decl_annotated ... ok
[INFO] [stdout] test tests::typechecker::declarations::tests::function_interpreted ... ok
[INFO] [stdout] test tests::typechecker::declarations::tests::subclass_invalid_inheritance ... ok
[INFO] [stdout] test tests::typechecker::declarations::tests::typedecl_bv ... ok
[INFO] [stdout] test tests::typechecker::declarations::tests::subclass ... ok
[INFO] [stdout] test tests::typechecker::declarations::tests::typedecl_enum ... ok
[INFO] [stdout] test tests::typechecker::declarations::tests::typedecl_this ... ok
[INFO] [stdout] test tests::typechecker::declarations::tests::typedecl_range ... ok
[INFO] [stdout] test tests::typechecker::declarations::tests::vardecl_annotated ... ok
[INFO] [stdout] test tests::typechecker::declarations::tests::vardecl_inferred ... ok
[INFO] [stdout] test tests::typechecker::expressions::tests::test_call_invalid ... ok
[INFO] [stdout] test tests::typechecker::expressions::tests::test_call_parameterized_obj ... ok
[INFO] [stdout] test tests::typechecker::declarations::tests::typedecl_uninterp ... ok
[INFO] [stdout] test tests::typechecker::expressions::tests::test_call_unresolved ... ok
[INFO] [stdout] test tests::typechecker::declarations::tests::var_redefinition ... ok
[INFO] [stdout] test tests::typechecker::expressions::tests::test_field_access ... ok
[INFO] [stdout] test tests::typechecker::expressions::tests::test_call_resolved ... ok
[INFO] [stdout] test tests::typechecker::expressions::tests::test_call_parameterized_obj_invalid_parameter ... ok
[INFO] [stdout] test tests::typechecker::declarations::tests::require_bad ... ok
[INFO] [stdout] test tests::typechecker::expressions::tests::test_field_access_call ... ok
[INFO] [stdout] test tests::typechecker::expressions::tests::test_ident ... ok
[INFO] [stdout] test tests::typechecker::expressions::tests::test_eq_binop ... ok
[INFO] [stdout] test tests::programs::parser::test_noninf1 ... ok
[INFO] [stdout] test tests::typechecker::expressions::tests::test_unbound_this ... ok
[INFO] [stdout] test tests::typechecker::expressions::tests::test_unary_op ... ok
[INFO] [stdout] test tests::typechecker::expressions::tests::test_invalid_numeric_binop ... ok
[INFO] [stdout] test tests::typechecker::expressions::tests::test_numeric_binop ... ok
[INFO] [stdout] test tests::typechecker::formulas::tests::nested_quants ... ok
[INFO] [stdout] test tests::typechecker::formulas::tests::universal_quant_annotated ... ok
[INFO] [stdout] test tests::typechecker::mixins::tests::test_action_and_impl ... ok
[INFO] [stdout] test tests::typechecker::expressions::tests::test_lt_binop ... ok
[INFO] [stdout] test tests::typechecker::formulas::tests::universal_quant ... ok
[INFO] [stdout] test tests::typechecker::mixins::tests::test_action_and_impl_different_sorts ... ok
[INFO] [stdout] test tests::typechecker::formulas::tests::progterm_in_fmls ... ok
[INFO] [stdout] test tests::typechecker::mixins::tests::test_action_and_impl_rebound_sigs ... ok
[INFO] [stdout] test tests::typechecker::modules::tests::instantiation_with_overloaded_numerals ... ok
[INFO] [stdout] test tests::typechecker::modules::tests::instantiation_with_invalid_overloaded_numerals ... ok
[INFO] [stdout] test tests::typechecker::mixins::tests::test_action_and_impl_identical_sigs ... ok
[INFO] [stdout] test tests::typechecker::modules::tests::module_extraction ... ok
[INFO] [stdout] test tests::typechecker::modules::tests::module_multiple_instantiations ... ok
[INFO] [stdout] test tests::typechecker::modules::tests::instantiation_with_impl_spec_blocks ... FAILED
[INFO] [stdout] test tests::typechecker::modules::tests::test_mod_bind_and_alias_this ... ok
[INFO] [stdout] test tests::typechecker::modules::tests::test_mod_actions ... ok
[INFO] [stdout] test tests::typechecker::modules::tests::test_empty_module ... ok
[INFO] [stdout] test tests::typechecker::modules::tests::multimod_instantiation ... ok
[INFO] [stdout] test tests::typechecker::modules::tests::test_after_init ... ok
[INFO] [stdout] test tests::typechecker::processes::tests::empty_process ... ok
[INFO] [stdout] test tests::typechecker::processes::tests::bad_parameterized_object_index ... ok
[INFO] [stdout] test tests::programs::parser::test_append2 ... ok
[INFO] [stdout] test tests::stdlib::tests::typecheck ... ok
[INFO] [stdout] test tests::typechecker::processes::tests::parameterized_obj_index ... ok
[INFO] [stdout] test tests::typechecker::processes::tests::append1_host ... ok
[INFO] [stdout] test tests::typechecker::processes::tests::parameterized_object_index ... ok
[INFO] [stdout] test tests::typechecker::processes::tests::proc_with_implicit_impl ... ok
[INFO] [stdout] test tests::typechecker::processes::tests::process_with_ghost_state_assign_lhs ... ok
[INFO] [stdout] test tests::typechecker::processes::tests::proc_with_params ... ok
[INFO] [stdout] test tests::typechecker::resolver::tests::fresh_sortvar_consistent_mapping ... ok
[INFO] [stdout] test tests::typechecker::processes::tests::relation_inference_bad_arity ... ok
[INFO] [stdout] test tests::typechecker::resolver::tests::generic_unification ... ok
[INFO] [stdout] test tests::typechecker::resolver::tests::sortvar_unification ... ok
[INFO] [stdout] test tests::typechecker::processes::tests::relation_inference_bad_assign ... ok
[INFO] [stdout] test tests::typechecker::resolver::tests::test_path_lookup ... ok
[INFO] [stdout] test tests::typechecker::resolver::tests::test_nonrecord_lookup ... ok
[INFO] [stdout] test tests::typechecker::resolver::tests::test_record_lookup ... ok
[INFO] [stdout] test tests::typechecker::statements::tests::if_bad_cond ... ok
[INFO] [stdout] test tests::typechecker::statements::tests::if_valid ... ok
[INFO] [stdout] test tests::typechecker::statements::tests::logical_assign ... ok
[INFO] [stdout] test tests::typechecker::statements::tests::while_valid ... ok
[INFO] [stdout] test tests::typechecker::processes::tests::proc_with_local_var ... ok
[INFO] [stdout] test tests::typechecker::processes::tests::relation_inference ... ok
[INFO] [stdout] test tests::typechecker::processes::tests::relation_bad_inference ... ok
[INFO] [stdout] test tests::typechecker::resolver::tests::fresh_sortvars ... ok
[INFO] [stdout] test tests::typechecker::processes::tests::relation_logical_assign ... ok
[INFO] [stdout] test tests::typechecker::subst::tests::uninterpreted_type_resolution ... ok
[INFO] [stdout] test typechecker::programs::typechecker::typecheck_102_counter ... ok
[INFO] [stdout] test typechecker::programs::extraction::extract_202_pingpong ... ok
[INFO] [stdout] test typechecker::programs::parser::typecheck_001_state_and_actions ... ok
[INFO] [stdout] test typechecker::programs::typechecker::typecheck_101_append2 ... ok
[INFO] [stdout] test typechecker::programs::typechecker::typecheck_202_pingpong ... ok
[INFO] [stdout] test typechecker::programs::extraction::extract_200_trivial_chainrep ... ok
[INFO] [stdout] test typechecker::programs::typechecker::typecheck_200_trivial_chainrep ... ok
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- tests::extraction::java::tests::extract_module_instantation stdout ----
[INFO] [stdout] [2026-03-10T02:36:45Z TRACE visitor] Decl Source:0 ("module pair(t) = { ...)
[INFO] [stdout] [2026-03-10T02:36:45Z TRACE binding] Inserting pair:SortVar(0) into context (depth 1)
[INFO] [stdout] [2026-03-10T02:36:45Z TRACE binding] Inserting this:This into context (depth 2)
[INFO] [stdout] [2026-03-10T02:36:45Z TRACE binding] Inserting init:Action([], List([]), Unit, Instance) into context (depth 2)
[INFO] [stdout] [2026-03-10T02:36:45Z TRACE binding] Inserting t:Generic(1, "t") into context (depth 2)
[INFO] [stdout] [2026-03-10T02:36:45Z TRACE visitor] Decl Source:1 ("x: t...)
[INFO] [stdout] [2026-03-10T02:36:45Z TRACE binding] Inserting x:Generic(1, "t") into context (depth 2)
[INFO] [stdout] [2026-03-10T02:36:45Z DEBUG sort-inference] unify(Generic(1, "t"),Generic(1, "t"))
[INFO] [stdout] [2026-03-10T02:36:45Z TRACE visitor] Decl Source:2 ("y: t...)
[INFO] [stdout] [2026-03-10T02:36:45Z TRACE binding] Inserting y:Generic(1, "t") into context (depth 2)
[INFO] [stdout] [2026-03-10T02:36:45Z DEBUG sort-inference] unify(Generic(1, "t"),Generic(1, "t"))
[INFO] [stdout] [2026-03-10T02:36:45Z DEBUG sort-inference] unify(SortVar(0),Module(Module { name: "pair", args: [Binding { name: "t", decl: Generic(1, "t"), span: Source:0 ("pair(t)") }], fields: {"init": Action([], List([]), Unit, Instance), "x": Generic(1, "t"), "y": Generic(1, "t")} }))
[INFO] [stdout] [2026-03-10T02:36:45Z TRACE visitor] Decl Source:0 ("instance nat_pair : pair(nat)")
[INFO] [stdout] [2026-03-10T02:36:45Z TRACE binding] Inserting nat_pair:SortVar(2) into context (depth 1)
[INFO] [stdout] [2026-03-10T02:36:45Z DEBUG sort-inference] unify(Generic(3, "t"),Number)
[INFO] [stdout] [2026-03-10T02:36:45Z DEBUG sort-inference] unify(SortVar(2),Module(Module { name: "pair", args: [], fields: {"init": Action([], List([]), Unit, Instance), "x": Number, "y": Number} }))
[INFO] [stdout] NBT: [Binding { name: "t", decl: Resolved(Number), span: Source:0 ("pair(t)") }]
[INFO] [stdout] [2026-03-10T02:36:45Z TRACE visitor] Decl Source:0 ("instance nat_pair : pair(nat)")
[INFO] [stdout] 
[INFO] [stdout] thread 'tests::extraction::java::tests::extract_module_instantation' (38) panicked at src/extraction/pprint.rs:29:13:
[INFO] [stdout] attempt to subtract with overflow
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5e25d6e0b0aa - std[b80a194dd3c418bb]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x5e25d6e0b0aa - std[b80a194dd3c418bb]::backtrace_rs::backtrace::trace_unsynchronized::<std[b80a194dd3c418bb]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x5e25d6e0b0aa - std[b80a194dd3c418bb]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x5e25d6e0b0aa - <<std[b80a194dd3c418bb]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[10b6fa85044e1869]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x5e25d6e209da - <core[10b6fa85044e1869]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x5e25d6e209da - core[10b6fa85044e1869]::fmt::write
[INFO] [stdout]    6:     0x5e25d6e0fce2 - std[b80a194dd3c418bb]::io::default_write_fmt::<alloc[dd269455e567d8e9]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/io/mod.rs:639:11
[INFO] [stdout]    7:     0x5e25d6e0fce2 - <alloc[dd269455e567d8e9]::vec::Vec<u8> as std[b80a194dd3c418bb]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/io/mod.rs:1994:13
[INFO] [stdout]    8:     0x5e25d6de96df - <std[b80a194dd3c418bb]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x5e25d6de96df - std[b80a194dd3c418bb]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x5e25d6e032b9 - std[b80a194dd3c418bb]::panicking::default_hook
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x5e25d6d8475c - <alloc[dd269455e567d8e9]::boxed::Box<dyn for<'a, 'b> core[10b6fa85044e1869]::ops::function::Fn<(&'a std[b80a194dd3c418bb]::panic::PanicHookInfo<'b>,), Output = ()> + core[10b6fa85044e1869]::marker::Sync + core[10b6fa85044e1869]::marker::Send> as core[10b6fa85044e1869]::ops::function::Fn<(&std[b80a194dd3c418bb]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/alloc/src/boxed.rs:2254:9
[INFO] [stdout]   12:     0x5e25d6d8475c - test[826cbc6ef54ab466]::test_main_with_exit_callback::<test[826cbc6ef54ab466]::test_main::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/test/src/lib.rs:145:21
[INFO] [stdout]   13:     0x5e25d6e03472 - <alloc[dd269455e567d8e9]::boxed::Box<dyn for<'a, 'b> core[10b6fa85044e1869]::ops::function::Fn<(&'a std[b80a194dd3c418bb]::panic::PanicHookInfo<'b>,), Output = ()> + core[10b6fa85044e1869]::marker::Sync + core[10b6fa85044e1869]::marker::Send> as core[10b6fa85044e1869]::ops::function::Fn<(&std[b80a194dd3c418bb]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/alloc/src/boxed.rs:2254:9
[INFO] [stdout]   14:     0x5e25d6e03472 - std[b80a194dd3c418bb]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x5e25d6de97ca - std[b80a194dd3c418bb]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panicking.rs:691:13
[INFO] [stdout]   16:     0x5e25d6de0fb9 - std[b80a194dd3c418bb]::sys::backtrace::__rust_end_short_backtrace::<std[b80a194dd3c418bb]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x5e25d6dea4ad - __rustc[9698a3e60dd14283]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x5e25d6e2136c - core[10b6fa85044e1869]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x5e25d6e22419 - core[10b6fa85044e1869]::panicking::panic_const::panic_const_sub_overflow
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/core/src/panicking.rs:175:17
[INFO] [stdout]   20:     0x5e25d6aab476 - <irving::extraction::pprint::PrettyPrinter<W> as core::fmt::Write>::write_str::hef25fc28264497f9
[INFO] [stdout]                                at /opt/rustwide/workdir/src/extraction/pprint.rs:29:13
[INFO] [stdout]   21:     0x5e25d6b0f707 - <irving::extraction::java::extraction::Extractor<W> as irving::visitor::ast::Visitor<(),core::fmt::Error>>::begin_instance_decl::hc4e0c8d7add2f731
[INFO] [stdout]                                at /opt/rustwide/workdir/src/extraction/java/extraction.rs:378:17
[INFO] [stdout]   22:     0x5e25d6a746c2 - <irving::ast::declarations::Decl as irving::visitor::ast::Visitable<T,E>>::visit::h1ddc119b5a2f350a
[INFO] [stdout]                                at /opt/rustwide/workdir/src/visitor/ast.rs:1158:18
[INFO] [stdout]   23:     0x5e25d6b1f1e8 - irving::tests::extraction::java::tests::extract_module_instantation::he8fb5f5f52733b6c
[INFO] [stdout]                                at /opt/rustwide/workdir/src/tests/extraction/java.rs:304:23
[INFO] [stdout]   24:     0x5e25d6b1f327 - irving::tests::extraction::java::tests::extract_module_instantation::{{closure}}::hb377d36c6769fc9b
[INFO] [stdout]                                at /opt/rustwide/workdir/src/tests/extraction/java.rs:291:37
[INFO] [stdout]   25:     0x5e25d6ad2dc6 - core::ops::function::FnOnce::call_once::h3a17df7ea4b7aed1
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   26:     0x5e25d6d7883b - <fn() -> core[10b6fa85044e1869]::result::Result<(), alloc[dd269455e567d8e9]::string::String> as core[10b6fa85044e1869]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   27:     0x5e25d6d7883b - test[826cbc6ef54ab466]::__rust_begin_short_backtrace::<core[10b6fa85044e1869]::result::Result<(), alloc[dd269455e567d8e9]::string::String>, fn() -> core[10b6fa85044e1869]::result::Result<(), alloc[dd269455e567d8e9]::string::String>>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/test/src/lib.rs:663:18
[INFO] [stdout]   28:     0x5e25d6d8522b - test[826cbc6ef54ab466]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/test/src/lib.rs:686:74
[INFO] [stdout]   29:     0x5e25d6d8522b - <core[10b6fa85044e1869]::panic::unwind_safe::AssertUnwindSafe<test[826cbc6ef54ab466]::run_test_in_process::{closure#0}> as core[10b6fa85044e1869]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/core/src/panic/unwind_safe.rs:274:9
[INFO] [stdout]   30:     0x5e25d6d8522b - std[b80a194dd3c418bb]::panicking::catch_unwind::do_call::<core[10b6fa85044e1869]::panic::unwind_safe::AssertUnwindSafe<test[826cbc6ef54ab466]::run_test_in_process::{closure#0}>, core[10b6fa85044e1869]::result::Result<(), alloc[dd269455e567d8e9]::string::String>>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panicking.rs:581:40
[INFO] [stdout]   31:     0x5e25d6d8522b - std[b80a194dd3c418bb]::panicking::catch_unwind::<core[10b6fa85044e1869]::result::Result<(), alloc[dd269455e567d8e9]::string::String>, core[10b6fa85044e1869]::panic::unwind_safe::AssertUnwindSafe<test[826cbc6ef54ab466]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panicking.rs:544:19
[INFO] [stdout]   32:     0x5e25d6d8522b - std[b80a194dd3c418bb]::panic::catch_unwind::<core[10b6fa85044e1869]::panic::unwind_safe::AssertUnwindSafe<test[826cbc6ef54ab466]::run_test_in_process::{closure#0}>, core[10b6fa85044e1869]::result::Result<(), alloc[dd269455e567d8e9]::string::String>>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panic.rs:359:14
[INFO] [stdout]   33:     0x5e25d6d8522b - test[826cbc6ef54ab466]::run_test_in_process
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/test/src/lib.rs:686:27
[INFO] [stdout]   34:     0x5e25d6d8522b - test[826cbc6ef54ab466]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/test/src/lib.rs:607:43
[INFO] [stdout]   35:     0x5e25d6d80944 - test[826cbc6ef54ab466]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/test/src/lib.rs:637:41
[INFO] [stdout]   36:     0x5e25d6d80944 - std[b80a194dd3c418bb]::sys::backtrace::__rust_begin_short_backtrace::<test[826cbc6ef54ab466]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   37:     0x5e25d6d87e32 - std[b80a194dd3c418bb]::thread::lifecycle::spawn_unchecked::<test[826cbc6ef54ab466]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/thread/lifecycle.rs:91:13
[INFO] [stdout]   38:     0x5e25d6d87e32 - <core[10b6fa85044e1869]::panic::unwind_safe::AssertUnwindSafe<std[b80a194dd3c418bb]::thread::lifecycle::spawn_unchecked<test[826cbc6ef54ab466]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[10b6fa85044e1869]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/core/src/panic/unwind_safe.rs:274:9
[INFO] [stdout]   39:     0x5e25d6d87e32 - std[b80a194dd3c418bb]::panicking::catch_unwind::do_call::<core[10b6fa85044e1869]::panic::unwind_safe::AssertUnwindSafe<std[b80a194dd3c418bb]::thread::lifecycle::spawn_unchecked<test[826cbc6ef54ab466]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panicking.rs:581:40
[INFO] [stdout]   40:     0x5e25d6d87e32 - std[b80a194dd3c418bb]::panicking::catch_unwind::<(), core[10b6fa85044e1869]::panic::unwind_safe::AssertUnwindSafe<std[b80a194dd3c418bb]::thread::lifecycle::spawn_unchecked<test[826cbc6ef54ab466]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panicking.rs:544:19
[INFO] [stdout]   41:     0x5e25d6d87e32 - std[b80a194dd3c418bb]::panic::catch_unwind::<core[10b6fa85044e1869]::panic::unwind_safe::AssertUnwindSafe<std[b80a194dd3c418bb]::thread::lifecycle::spawn_unchecked<test[826cbc6ef54ab466]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panic.rs:359:14
[INFO] [stdout]   42:     0x5e25d6d87e32 - std[b80a194dd3c418bb]::thread::lifecycle::spawn_unchecked::<test[826cbc6ef54ab466]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/thread/lifecycle.rs:89:26
[INFO] [stdout]   43:     0x5e25d6d87e32 - <std[b80a194dd3c418bb]::thread::lifecycle::spawn_unchecked<test[826cbc6ef54ab466]::run_test::{closure#1}, ()>::{closure#1} as core[10b6fa85044e1869]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   44:     0x5e25d6e0a65f - <alloc[dd269455e567d8e9]::boxed::Box<dyn core[10b6fa85044e1869]::ops::function::FnOnce<(), Output = ()> + core[10b6fa85044e1869]::marker::Send> as core[10b6fa85044e1869]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/alloc/src/boxed.rs:2240:9
[INFO] [stdout]   45:     0x5e25d6e0a65f - <std[b80a194dd3c418bb]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stdout]   46:     0x7873ad29caa4 - <unknown>
[INFO] [stdout]   47:     0x7873ad329a64 - clone
[INFO] [stdout]   48:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- tests::programs::accord::typecheck_abstract_protocol stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'tests::programs::accord::typecheck_abstract_protocol' (182) panicked at src/tests/mod.rs:108:51:
[INFO] [stdout] called `Result::unwrap()` on an `Err` value: Os { code: 2, kind: NotFound, message: "No such file or directory" }
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5e25d6e0b0aa - std[b80a194dd3c418bb]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x5e25d6e0b0aa - std[b80a194dd3c418bb]::backtrace_rs::backtrace::trace_unsynchronized::<std[b80a194dd3c418bb]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x5e25d6e0b0aa - std[b80a194dd3c418bb]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x5e25d6e0b0aa - <<std[b80a194dd3c418bb]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[10b6fa85044e1869]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x5e25d6e209da - <core[10b6fa85044e1869]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x5e25d6e209da - core[10b6fa85044e1869]::fmt::write
[INFO] [stdout]    6:     0x5e25d6e0fce2 - std[b80a194dd3c418bb]::io::default_write_fmt::<alloc[dd269455e567d8e9]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/io/mod.rs:639:11
[INFO] [stdout]    7:     0x5e25d6e0fce2 - <alloc[dd269455e567d8e9]::vec::Vec<u8> as std[b80a194dd3c418bb]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/io/mod.rs:1994:13
[INFO] [stdout]    8:     0x5e25d6de96df - <std[b80a194dd3c418bb]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x5e25d6de96df - std[b80a194dd3c418bb]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x5e25d6e032b9 - std[b80a194dd3c418bb]::panicking::default_hook
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x5e25d6d8475c - <alloc[dd269455e567d8e9]::boxed::Box<dyn for<'a, 'b> core[10b6fa85044e1869]::ops::function::Fn<(&'a std[b80a194dd3c418bb]::panic::PanicHookInfo<'b>,), Output = ()> + core[10b6fa85044e1869]::marker::Sync + core[10b6fa85044e1869]::marker::Send> as core[10b6fa85044e1869]::ops::function::Fn<(&std[b80a194dd3c418bb]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/alloc/src/boxed.rs:2254:9
[INFO] [stdout]   12:     0x5e25d6d8475c - test[826cbc6ef54ab466]::test_main_with_exit_callback::<test[826cbc6ef54ab466]::test_main::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/test/src/lib.rs:145:21
[INFO] [stdout]   13:     0x5e25d6e03472 - <alloc[dd269455e567d8e9]::boxed::Box<dyn for<'a, 'b> core[10b6fa85044e1869]::ops::function::Fn<(&'a std[b80a194dd3c418bb]::panic::PanicHookInfo<'b>,), Output = ()> + core[10b6fa85044e1869]::marker::Sync + core[10b6fa85044e1869]::marker::Send> as core[10b6fa85044e1869]::ops::function::Fn<(&std[b80a194dd3c418bb]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/alloc/src/boxed.rs:2254:9
[INFO] [stdout]   14:     0x5e25d6e03472 - std[b80a194dd3c418bb]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x5e25d6de9798 - std[b80a194dd3c418bb]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x5e25d6de0fb9 - std[b80a194dd3c418bb]::sys::backtrace::__rust_end_short_backtrace::<std[b80a194dd3c418bb]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x5e25d6dea4ad - __rustc[9698a3e60dd14283]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x5e25d6e2136c - core[10b6fa85044e1869]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x5e25d6e210b2 - core[10b6fa85044e1869]::result::unwrap_failed
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/core/src/result.rs:1867:5
[INFO] [stdout]   20:     0x5e25d69f045d - core::result::Result<T,E>::unwrap::hd0e832927281f933
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/core/src/result.rs:1233:23
[INFO] [stdout]   21:     0x5e25d69f045d - irving::tests::helpers::typeinference_from_filename::h74a228827b588e45
[INFO] [stdout]                                at /opt/rustwide/workdir/src/tests/mod.rs:108:51
[INFO] [stdout]   22:     0x5e25d6b4bb7a - irving::tests::programs::accord::typecheck_abstract_protocol::h46fb68ee1211e1a0
[INFO] [stdout]                                at /opt/rustwide/workdir/src/tests/programs.rs:53:13
[INFO] [stdout]   23:     0x5e25d6b4bba7 - irving::tests::programs::accord::typecheck_abstract_protocol::{{closure}}::h36fda0e2d2064c1e
[INFO] [stdout]                                at /opt/rustwide/workdir/src/tests/programs.rs:51:37
[INFO] [stdout]   24:     0x5e25d6ad33e6 - core::ops::function::FnOnce::call_once::h5285a4a7c283b277
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x5e25d6d7883b - <fn() -> core[10b6fa85044e1869]::result::Result<(), alloc[dd269455e567d8e9]::string::String> as core[10b6fa85044e1869]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   26:     0x5e25d6d7883b - test[826cbc6ef54ab466]::__rust_begin_short_backtrace::<core[10b6fa85044e1869]::result::Result<(), alloc[dd269455e567d8e9]::string::String>, fn() -> core[10b6fa85044e1869]::result::Result<(), alloc[dd269455e567d8e9]::string::String>>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/test/src/lib.rs:663:18
[INFO] [stdout]   27:     0x5e25d6d8522b - test[826cbc6ef54ab466]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/test/src/lib.rs:686:74
[INFO] [stdout]   28:     0x5e25d6d8522b - <core[10b6fa85044e1869]::panic::unwind_safe::AssertUnwindSafe<test[826cbc6ef54ab466]::run_test_in_process::{closure#0}> as core[10b6fa85044e1869]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/core/src/panic/unwind_safe.rs:274:9
[INFO] [stdout]   29:     0x5e25d6d8522b - std[b80a194dd3c418bb]::panicking::catch_unwind::do_call::<core[10b6fa85044e1869]::panic::unwind_safe::AssertUnwindSafe<test[826cbc6ef54ab466]::run_test_in_process::{closure#0}>, core[10b6fa85044e1869]::result::Result<(), alloc[dd269455e567d8e9]::string::String>>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panicking.rs:581:40
[INFO] [stdout]   30:     0x5e25d6d8522b - std[b80a194dd3c418bb]::panicking::catch_unwind::<core[10b6fa85044e1869]::result::Result<(), alloc[dd269455e567d8e9]::string::String>, core[10b6fa85044e1869]::panic::unwind_safe::AssertUnwindSafe<test[826cbc6ef54ab466]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panicking.rs:544:19
[INFO] [stdout]   31:     0x5e25d6d8522b - std[b80a194dd3c418bb]::panic::catch_unwind::<core[10b6fa85044e1869]::panic::unwind_safe::AssertUnwindSafe<test[826cbc6ef54ab466]::run_test_in_process::{closure#0}>, core[10b6fa85044e1869]::result::Result<(), alloc[dd269455e567d8e9]::string::String>>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panic.rs:359:14
[INFO] [stdout]   32:     0x5e25d6d8522b - test[826cbc6ef54ab466]::run_test_in_process
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/test/src/lib.rs:686:27
[INFO] [stdout]   33:     0x5e25d6d8522b - test[826cbc6ef54ab466]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/test/src/lib.rs:607:43
[INFO] [stdout]   34:     0x5e25d6d80944 - test[826cbc6ef54ab466]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/test/src/lib.rs:637:41
[INFO] [stdout]   35:     0x5e25d6d80944 - std[b80a194dd3c418bb]::sys::backtrace::__rust_begin_short_backtrace::<test[826cbc6ef54ab466]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   36:     0x5e25d6d87e32 - std[b80a194dd3c418bb]::thread::lifecycle::spawn_unchecked::<test[826cbc6ef54ab466]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/thread/lifecycle.rs:91:13
[INFO] [stdout]   37:     0x5e25d6d87e32 - <core[10b6fa85044e1869]::panic::unwind_safe::AssertUnwindSafe<std[b80a194dd3c418bb]::thread::lifecycle::spawn_unchecked<test[826cbc6ef54ab466]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[10b6fa85044e1869]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/core/src/panic/unwind_safe.rs:274:9
[INFO] [stdout]   38:     0x5e25d6d87e32 - std[b80a194dd3c418bb]::panicking::catch_unwind::do_call::<core[10b6fa85044e1869]::panic::unwind_safe::AssertUnwindSafe<std[b80a194dd3c418bb]::thread::lifecycle::spawn_unchecked<test[826cbc6ef54ab466]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panicking.rs:581:40
[INFO] [stdout]   39:     0x5e25d6d87e32 - std[b80a194dd3c418bb]::panicking::catch_unwind::<(), core[10b6fa85044e1869]::panic::unwind_safe::AssertUnwindSafe<std[b80a194dd3c418bb]::thread::lifecycle::spawn_unchecked<test[826cbc6ef54ab466]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panicking.rs:544:19
[INFO] [stdout]   40:     0x5e25d6d87e32 - std[b80a194dd3c418bb]::panic::catch_unwind::<core[10b6fa85044e1869]::panic::unwind_safe::AssertUnwindSafe<std[b80a194dd3c418bb]::thread::lifecycle::spawn_unchecked<test[826cbc6ef54ab466]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panic.rs:359:14
[INFO] [stdout]   41:     0x5e25d6d87e32 - std[b80a194dd3c418bb]::thread::lifecycle::spawn_unchecked::<test[826cbc6ef54ab466]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/thread/lifecycle.rs:89:26
[INFO] [stdout]   42:     0x5e25d6d87e32 - <std[b80a194dd3c418bb]::thread::lifecycle::spawn_unchecked<test[826cbc6ef54ab466]::run_test::{closure#1}, ()>::{closure#1} as core[10b6fa85044e1869]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   43:     0x5e25d6e0a65f - <alloc[dd269455e567d8e9]::boxed::Box<dyn core[10b6fa85044e1869]::ops::function::FnOnce<(), Output = ()> + core[10b6fa85044e1869]::marker::Send> as core[10b6fa85044e1869]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/alloc/src/boxed.rs:2240:9
[INFO] [stdout]   44:     0x5e25d6e0a65f - <std[b80a194dd3c418bb]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stdout]   45:     0x7873ad29caa4 - <unknown>
[INFO] [stdout]   46:     0x7873ad329a64 - clone
[INFO] [stdout]   47:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- tests::programs::accord::typecheck_sorts stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'tests::programs::accord::typecheck_sorts' (185) panicked at src/tests/mod.rs:108:51:
[INFO] [stdout] called `Result::unwrap()` on an `Err` value: Os { code: 2, kind: NotFound, message: "No such file or directory" }
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5e25d6e0b0aa - std[b80a194dd3c418bb]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x5e25d6e0b0aa - std[b80a194dd3c418bb]::backtrace_rs::backtrace::trace_unsynchronized::<std[b80a194dd3c418bb]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x5e25d6e0b0aa - std[b80a194dd3c418bb]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x5e25d6e0b0aa - <<std[b80a194dd3c418bb]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[10b6fa85044e1869]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x5e25d6e209da - <core[10b6fa85044e1869]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x5e25d6e209da - core[10b6fa85044e1869]::fmt::write
[INFO] [stdout]    6:     0x5e25d6e0fce2 - std[b80a194dd3c418bb]::io::default_write_fmt::<alloc[dd269455e567d8e9]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/io/mod.rs:639:11
[INFO] [stdout]    7:     0x5e25d6e0fce2 - <alloc[dd269455e567d8e9]::vec::Vec<u8> as std[b80a194dd3c418bb]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/io/mod.rs:1994:13
[INFO] [stdout]    8:     0x5e25d6de96df - <std[b80a194dd3c418bb]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x5e25d6de96df - std[b80a194dd3c418bb]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x5e25d6e032b9 - std[b80a194dd3c418bb]::panicking::default_hook
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x5e25d6d8475c - <alloc[dd269455e567d8e9]::boxed::Box<dyn for<'a, 'b> core[10b6fa85044e1869]::ops::function::Fn<(&'a std[b80a194dd3c418bb]::panic::PanicHookInfo<'b>,), Output = ()> + core[10b6fa85044e1869]::marker::Sync + core[10b6fa85044e1869]::marker::Send> as core[10b6fa85044e1869]::ops::function::Fn<(&std[b80a194dd3c418bb]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/alloc/src/boxed.rs:2254:9
[INFO] [stdout]   12:     0x5e25d6d8475c - test[826cbc6ef54ab466]::test_main_with_exit_callback::<test[826cbc6ef54ab466]::test_main::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/test/src/lib.rs:145:21
[INFO] [stdout]   13:     0x5e25d6e03472 - <alloc[dd269455e567d8e9]::boxed::Box<dyn for<'a, 'b> core[10b6fa85044e1869]::ops::function::Fn<(&'a std[b80a194dd3c418bb]::panic::PanicHookInfo<'b>,), Output = ()> + core[10b6fa85044e1869]::marker::Sync + core[10b6fa85044e1869]::marker::Send> as core[10b6fa85044e1869]::ops::function::Fn<(&std[b80a194dd3c418bb]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/alloc/src/boxed.rs:2254:9
[INFO] [stdout]   14:     0x5e25d6e03472 - std[b80a194dd3c418bb]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x5e25d6de9798 - std[b80a194dd3c418bb]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x5e25d6de0fb9 - std[b80a194dd3c418bb]::sys::backtrace::__rust_end_short_backtrace::<std[b80a194dd3c418bb]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x5e25d6dea4ad - __rustc[9698a3e60dd14283]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x5e25d6e2136c - core[10b6fa85044e1869]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x5e25d6e210b2 - core[10b6fa85044e1869]::result::unwrap_failed
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/core/src/result.rs:1867:5
[INFO] [stdout]   20:     0x5e25d69f045d - core::result::Result<T,E>::unwrap::hd0e832927281f933
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/core/src/result.rs:1233:23
[INFO] [stdout]   21:     0x5e25d69f045d - irving::tests::helpers::typeinference_from_filename::h74a228827b588e45
[INFO] [stdout]                                at /opt/rustwide/workdir/src/tests/mod.rs:108:51
[INFO] [stdout]   22:     0x5e25d6b4b9fa - irving::tests::programs::accord::typecheck_sorts::h28bf60ee37d28d52
[INFO] [stdout]                                at /opt/rustwide/workdir/src/tests/programs.rs:63:20
[INFO] [stdout]   23:     0x5e25d6b4ba27 - irving::tests::programs::accord::typecheck_sorts::{{closure}}::hd14dfde92709ae31
[INFO] [stdout]                                at /opt/rustwide/workdir/src/tests/programs.rs:62:25
[INFO] [stdout]   24:     0x5e25d6ad2226 - core::ops::function::FnOnce::call_once::h17f933d0177586d2
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x5e25d6d7883b - <fn() -> core[10b6fa85044e1869]::result::Result<(), alloc[dd269455e567d8e9]::string::String> as core[10b6fa85044e1869]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   26:     0x5e25d6d7883b - test[826cbc6ef54ab466]::__rust_begin_short_backtrace::<core[10b6fa85044e1869]::result::Result<(), alloc[dd269455e567d8e9]::string::String>, fn() -> core[10b6fa85044e1869]::result::Result<(), alloc[dd269455e567d8e9]::string::String>>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/test/src/lib.rs:663:18
[INFO] [stdout]   27:     0x5e25d6d8522b - test[826cbc6ef54ab466]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/test/src/lib.rs:686:74
[INFO] [stdout]   28:     0x5e25d6d8522b - <core[10b6fa85044e1869]::panic::unwind_safe::AssertUnwindSafe<test[826cbc6ef54ab466]::run_test_in_process::{closure#0}> as core[10b6fa85044e1869]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/core/src/panic/unwind_safe.rs:274:9
[INFO] [stdout]   29:     0x5e25d6d8522b - std[b80a194dd3c418bb]::panicking::catch_unwind::do_call::<core[10b6fa85044e1869]::panic::unwind_safe::AssertUnwindSafe<test[826cbc6ef54ab466]::run_test_in_process::{closure#0}>, core[10b6fa85044e1869]::result::Result<(), alloc[dd269455e567d8e9]::string::String>>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panicking.rs:581:40
[INFO] [stdout]   30:     0x5e25d6d8522b - std[b80a194dd3c418bb]::panicking::catch_unwind::<core[10b6fa85044e1869]::result::Result<(), alloc[dd269455e567d8e9]::string::String>, core[10b6fa85044e1869]::panic::unwind_safe::AssertUnwindSafe<test[826cbc6ef54ab466]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panicking.rs:544:19
[INFO] [stdout]   31:     0x5e25d6d8522b - std[b80a194dd3c418bb]::panic::catch_unwind::<core[10b6fa85044e1869]::panic::unwind_safe::AssertUnwindSafe<test[826cbc6ef54ab466]::run_test_in_process::{closure#0}>, core[10b6fa85044e1869]::result::Result<(), alloc[dd269455e567d8e9]::string::String>>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panic.rs:359:14
[INFO] [stdout]   32:     0x5e25d6d8522b - test[826cbc6ef54ab466]::run_test_in_process
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/test/src/lib.rs:686:27
[INFO] [stdout]   33:     0x5e25d6d8522b - test[826cbc6ef54ab466]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/test/src/lib.rs:607:43
[INFO] [stdout]   34:     0x5e25d6d80944 - test[826cbc6ef54ab466]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/test/src/lib.rs:637:41
[INFO] [stdout]   35:     0x5e25d6d80944 - std[b80a194dd3c418bb]::sys::backtrace::__rust_begin_short_backtrace::<test[826cbc6ef54ab466]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   36:     0x5e25d6d87e32 - std[b80a194dd3c418bb]::thread::lifecycle::spawn_unchecked::<test[826cbc6ef54ab466]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/thread/lifecycle.rs:91:13
[INFO] [stdout]   37:     0x5e25d6d87e32 - <core[10b6fa85044e1869]::panic::unwind_safe::AssertUnwindSafe<std[b80a194dd3c418bb]::thread::lifecycle::spawn_unchecked<test[826cbc6ef54ab466]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[10b6fa85044e1869]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/core/src/panic/unwind_safe.rs:274:9
[INFO] [stdout]   38:     0x5e25d6d87e32 - std[b80a194dd3c418bb]::panicking::catch_unwind::do_call::<core[10b6fa85044e1869]::panic::unwind_safe::AssertUnwindSafe<std[b80a194dd3c418bb]::thread::lifecycle::spawn_unchecked<test[826cbc6ef54ab466]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panicking.rs:581:40
[INFO] [stdout]   39:     0x5e25d6d87e32 - std[b80a194dd3c418bb]::panicking::catch_unwind::<(), core[10b6fa85044e1869]::panic::unwind_safe::AssertUnwindSafe<std[b80a194dd3c418bb]::thread::lifecycle::spawn_unchecked<test[826cbc6ef54ab466]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panicking.rs:544:19
[INFO] [stdout]   40:     0x5e25d6d87e32 - std[b80a194dd3c418bb]::panic::catch_unwind::<core[10b6fa85044e1869]::panic::unwind_safe::AssertUnwindSafe<std[b80a194dd3c418bb]::thread::lifecycle::spawn_unchecked<test[826cbc6ef54ab466]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panic.rs:359:14
[INFO] [stdout]   41:     0x5e25d6d87e32 - std[b80a194dd3c418bb]::thread::lifecycle::spawn_unchecked::<test[826cbc6ef54ab466]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/thread/lifecycle.rs:89:26
[INFO] [stdout]   42:     0x5e25d6d87e32 - <std[b80a194dd3c418bb]::thread::lifecycle::spawn_unchecked<test[826cbc6ef54ab466]::run_test::{closure#1}, ()>::{closure#1} as core[10b6fa85044e1869]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   43:     0x5e25d6e0a65f - <alloc[dd269455e567d8e9]::boxed::Box<dyn core[10b6fa85044e1869]::ops::function::FnOnce<(), Output = ()> + core[10b6fa85044e1869]::marker::Send> as core[10b6fa85044e1869]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/alloc/src/boxed.rs:2240:9
[INFO] [stdout]   44:     0x5e25d6e0a65f - <std[b80a194dd3c418bb]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stdout]   45:     0x7873ad29caa4 - <unknown>
[INFO] [stdout]   46:     0x7873ad329a64 - clone
[INFO] [stdout]   47:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- tests::programs::accord::typecheck_protocol stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'tests::programs::accord::typecheck_protocol' (184) panicked at src/tests/mod.rs:108:51:
[INFO] [stdout] called `Result::unwrap()` on an `Err` value: Os { code: 2, kind: NotFound, message: "No such file or directory" }
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5e25d6e0b0aa - std[b80a194dd3c418bb]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x5e25d6e0b0aa - std[b80a194dd3c418bb]::backtrace_rs::backtrace::trace_unsynchronized::<std[b80a194dd3c418bb]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x5e25d6e0b0aa - std[b80a194dd3c418bb]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x5e25d6e0b0aa - <<std[b80a194dd3c418bb]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[10b6fa85044e1869]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x5e25d6e209da - <core[10b6fa85044e1869]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x5e25d6e209da - core[10b6fa85044e1869]::fmt::write
[INFO] [stdout]    6:     0x5e25d6e0fce2 - std[b80a194dd3c418bb]::io::default_write_fmt::<alloc[dd269455e567d8e9]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/io/mod.rs:639:11
[INFO] [stdout]    7:     0x5e25d6e0fce2 - <alloc[dd269455e567d8e9]::vec::Vec<u8> as std[b80a194dd3c418bb]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/io/mod.rs:1994:13
[INFO] [stdout]    8:     0x5e25d6de96df - <std[b80a194dd3c418bb]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x5e25d6de96df - std[b80a194dd3c418bb]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x5e25d6e032b9 - std[b80a194dd3c418bb]::panicking::default_hook
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x5e25d6d8475c - <alloc[dd269455e567d8e9]::boxed::Box<dyn for<'a, 'b> core[10b6fa85044e1869]::ops::function::Fn<(&'a std[b80a194dd3c418bb]::panic::PanicHookInfo<'b>,), Output = ()> + core[10b6fa85044e1869]::marker::Sync + core[10b6fa85044e1869]::marker::Send> as core[10b6fa85044e1869]::ops::function::Fn<(&std[b80a194dd3c418bb]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/alloc/src/boxed.rs:2254:9
[INFO] [stdout]   12:     0x5e25d6d8475c - test[826cbc6ef54ab466]::test_main_with_exit_callback::<test[826cbc6ef54ab466]::test_main::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/test/src/lib.rs:145:21
[INFO] [stdout]   13:     0x5e25d6e03472 - <alloc[dd269455e567d8e9]::boxed::Box<dyn for<'a, 'b> core[10b6fa85044e1869]::ops::function::Fn<(&'a std[b80a194dd3c418bb]::panic::PanicHookInfo<'b>,), Output = ()> + core[10b6fa85044e1869]::marker::Sync + core[10b6fa85044e1869]::marker::Send> as core[10b6fa85044e1869]::ops::function::Fn<(&std[b80a194dd3c418bb]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/alloc/src/boxed.rs:2254:9
[INFO] [stdout]   14:     0x5e25d6e03472 - std[b80a194dd3c418bb]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x5e25d6de9798 - std[b80a194dd3c418bb]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x5e25d6de0fb9 - std[b80a194dd3c418bb]::sys::backtrace::__rust_end_short_backtrace::<std[b80a194dd3c418bb]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x5e25d6dea4ad - __rustc[9698a3e60dd14283]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x5e25d6e2136c - core[10b6fa85044e1869]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x5e25d6e210b2 - core[10b6fa85044e1869]::result::unwrap_failed
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/core/src/result.rs:1867:5
[INFO] [stdout]   20:     0x5e25d69f045d - core::result::Result<T,E>::unwrap::hd0e832927281f933
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/core/src/result.rs:1233:23
[INFO] [stdout]   21:     0x5e25d69f045d - irving::tests::helpers::typeinference_from_filename::h74a228827b588e45
[INFO] [stdout]                                at /opt/rustwide/workdir/src/tests/mod.rs:108:51
[INFO] [stdout]   22:     0x5e25d6b4baba - irving::tests::programs::accord::typecheck_protocol::h1543ff5b5798b0ad
[INFO] [stdout]                                at /opt/rustwide/workdir/src/tests/programs.rs:78:20
[INFO] [stdout]   23:     0x5e25d6b4bae7 - irving::tests::programs::accord::typecheck_protocol::{{closure}}::h9e8e41c9ebb79387
[INFO] [stdout]                                at /opt/rustwide/workdir/src/tests/programs.rs:77:28
[INFO] [stdout]   24:     0x5e25d6ad24e6 - core::ops::function::FnOnce::call_once::h23482329b5366897
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x5e25d6d7883b - <fn() -> core[10b6fa85044e1869]::result::Result<(), alloc[dd269455e567d8e9]::string::String> as core[10b6fa85044e1869]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   26:     0x5e25d6d7883b - test[826cbc6ef54ab466]::__rust_begin_short_backtrace::<core[10b6fa85044e1869]::result::Result<(), alloc[dd269455e567d8e9]::string::String>, fn() -> core[10b6fa85044e1869]::result::Result<(), alloc[dd269455e567d8e9]::string::String>>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/test/src/lib.rs:663:18
[INFO] [stdout]   27:     0x5e25d6d8522b - test[826cbc6ef54ab466]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/test/src/lib.rs:686:74
[INFO] [stdout]   28:     0x5e25d6d8522b - <core[10b6fa85044e1869]::panic::unwind_safe::AssertUnwindSafe<test[826cbc6ef54ab466]::run_test_in_process::{closure#0}> as core[10b6fa85044e1869]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/core/src/panic/unwind_safe.rs:274:9
[INFO] [stdout]   29:     0x5e25d6d8522b - std[b80a194dd3c418bb]::panicking::catch_unwind::do_call::<core[10b6fa85044e1869]::panic::unwind_safe::AssertUnwindSafe<test[826cbc6ef54ab466]::run_test_in_process::{closure#0}>, core[10b6fa85044e1869]::result::Result<(), alloc[dd269455e567d8e9]::string::String>>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panicking.rs:581:40
[INFO] [stdout]   30:     0x5e25d6d8522b - std[b80a194dd3c418bb]::panicking::catch_unwind::<core[10b6fa85044e1869]::result::Result<(), alloc[dd269455e567d8e9]::string::String>, core[10b6fa85044e1869]::panic::unwind_safe::AssertUnwindSafe<test[826cbc6ef54ab466]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panicking.rs:544:19
[INFO] [stdout]   31:     0x5e25d6d8522b - std[b80a194dd3c418bb]::panic::catch_unwind::<core[10b6fa85044e1869]::panic::unwind_safe::AssertUnwindSafe<test[826cbc6ef54ab466]::run_test_in_process::{closure#0}>, core[10b6fa85044e1869]::result::Result<(), alloc[dd269455e567d8e9]::string::String>>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panic.rs:359:14
[INFO] [stdout]   32:     0x5e25d6d8522b - test[826cbc6ef54ab466]::run_test_in_process
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/test/src/lib.rs:686:27
[INFO] [stdout]   33:     0x5e25d6d8522b - test[826cbc6ef54ab466]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/test/src/lib.rs:607:43
[INFO] [stdout]   34:     0x5e25d6d80944 - test[826cbc6ef54ab466]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/test/src/lib.rs:637:41
[INFO] [stdout]   35:     0x5e25d6d80944 - std[b80a194dd3c418bb]::sys::backtrace::__rust_begin_short_backtrace::<test[826cbc6ef54ab466]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   36:     0x5e25d6d87e32 - std[b80a194dd3c418bb]::thread::lifecycle::spawn_unchecked::<test[826cbc6ef54ab466]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/thread/lifecycle.rs:91:13
[INFO] [stdout]   37:     0x5e25d6d87e32 - <core[10b6fa85044e1869]::panic::unwind_safe::AssertUnwindSafe<std[b80a194dd3c418bb]::thread::lifecycle::spawn_unchecked<test[826cbc6ef54ab466]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[10b6fa85044e1869]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/core/src/panic/unwind_safe.rs:274:9
[INFO] [stdout]   38:     0x5e25d6d87e32 - std[b80a194dd3c418bb]::panicking::catch_unwind::do_call::<core[10b6fa85044e1869]::panic::unwind_safe::AssertUnwindSafe<std[b80a194dd3c418bb]::thread::lifecycle::spawn_unchecked<test[826cbc6ef54ab466]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panicking.rs:581:40
[INFO] [stdout]   39:     0x5e25d6d87e32 - std[b80a194dd3c418bb]::panicking::catch_unwind::<(), core[10b6fa85044e1869]::panic::unwind_safe::AssertUnwindSafe<std[b80a194dd3c418bb]::thread::lifecycle::spawn_unchecked<test[826cbc6ef54ab466]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panicking.rs:544:19
[INFO] [stdout]   40:     0x5e25d6d87e32 - std[b80a194dd3c418bb]::panic::catch_unwind::<core[10b6fa85044e1869]::panic::unwind_safe::AssertUnwindSafe<std[b80a194dd3c418bb]::thread::lifecycle::spawn_unchecked<test[826cbc6ef54ab466]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panic.rs:359:14
[INFO] [stdout]   41:     0x5e25d6d87e32 - std[b80a194dd3c418bb]::thread::lifecycle::spawn_unchecked::<test[826cbc6ef54ab466]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/thread/lifecycle.rs:89:26
[INFO] [stdout]   42:     0x5e25d6d87e32 - <std[b80a194dd3c418bb]::thread::lifecycle::spawn_unchecked<test[826cbc6ef54ab466]::run_test::{closure#1}, ()>::{closure#1} as core[10b6fa85044e1869]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   43:     0x5e25d6e0a65f - <alloc[dd269455e567d8e9]::boxed::Box<dyn core[10b6fa85044e1869]::ops::function::FnOnce<(), Output = ()> + core[10b6fa85044e1869]::marker::Send> as core[10b6fa85044e1869]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/alloc/src/boxed.rs:2240:9
[INFO] [stdout]   44:     0x5e25d6e0a65f - <std[b80a194dd3c418bb]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stdout]   45:     0x7873ad29caa4 - <unknown>
[INFO] [stdout]   46:     0x7873ad329a64 - clone
[INFO] [stdout]   47:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- tests::programs::accord::typecheck_messages stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'tests::programs::accord::typecheck_messages' (183) panicked at src/tests/mod.rs:108:51:
[INFO] [stdout] called `Result::unwrap()` on an `Err` value: Os { code: 2, kind: NotFound, message: "No such file or directory" }
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5e25d6e0b0aa - std[b80a194dd3c418bb]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x5e25d6e0b0aa - std[b80a194dd3c418bb]::backtrace_rs::backtrace::trace_unsynchronized::<std[b80a194dd3c418bb]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x5e25d6e0b0aa - std[b80a194dd3c418bb]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x5e25d6e0b0aa - <<std[b80a194dd3c418bb]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[10b6fa85044e1869]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x5e25d6e209da - <core[10b6fa85044e1869]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x5e25d6e209da - core[10b6fa85044e1869]::fmt::write
[INFO] [stdout]    6:     0x5e25d6e0fce2 - std[b80a194dd3c418bb]::io::default_write_fmt::<alloc[dd269455e567d8e9]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/io/mod.rs:639:11
[INFO] [stdout]    7:     0x5e25d6e0fce2 - <alloc[dd269455e567d8e9]::vec::Vec<u8> as std[b80a194dd3c418bb]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/io/mod.rs:1994:13
[INFO] [stdout]    8:     0x5e25d6de96df - <std[b80a194dd3c418bb]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x5e25d6de96df - std[b80a194dd3c418bb]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x5e25d6e032b9 - std[b80a194dd3c418bb]::panicking::default_hook
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x5e25d6d8475c - <alloc[dd269455e567d8e9]::boxed::Box<dyn for<'a, 'b> core[10b6fa85044e1869]::ops::function::Fn<(&'a std[b80a194dd3c418bb]::panic::PanicHookInfo<'b>,), Output = ()> + core[10b6fa85044e1869]::marker::Sync + core[10b6fa85044e1869]::marker::Send> as core[10b6fa85044e1869]::ops::function::Fn<(&std[b80a194dd3c418bb]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/alloc/src/boxed.rs:2254:9
[INFO] [stdout]   12:     0x5e25d6d8475c - test[826cbc6ef54ab466]::test_main_with_exit_callback::<test[826cbc6ef54ab466]::test_main::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/test/src/lib.rs:145:21
[INFO] [stdout]   13:     0x5e25d6e03472 - <alloc[dd269455e567d8e9]::boxed::Box<dyn for<'a, 'b> core[10b6fa85044e1869]::ops::function::Fn<(&'a std[b80a194dd3c418bb]::panic::PanicHookInfo<'b>,), Output = ()> + core[10b6fa85044e1869]::marker::Sync + core[10b6fa85044e1869]::marker::Send> as core[10b6fa85044e1869]::ops::function::Fn<(&std[b80a194dd3c418bb]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/alloc/src/boxed.rs:2254:9
[INFO] [stdout]   14:     0x5e25d6e03472 - std[b80a194dd3c418bb]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x5e25d6de9798 - std[b80a194dd3c418bb]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x5e25d6de0fb9 - std[b80a194dd3c418bb]::sys::backtrace::__rust_end_short_backtrace::<std[b80a194dd3c418bb]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x5e25d6dea4ad - __rustc[9698a3e60dd14283]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x5e25d6e2136c - core[10b6fa85044e1869]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x5e25d6e210b2 - core[10b6fa85044e1869]::result::unwrap_failed
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/core/src/result.rs:1867:5
[INFO] [stdout]   20:     0x5e25d69f045d - core::result::Result<T,E>::unwrap::hd0e832927281f933
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/core/src/result.rs:1233:23
[INFO] [stdout]   21:     0x5e25d69f045d - irving::tests::helpers::typeinference_from_filename::h74a228827b588e45
[INFO] [stdout]                                at /opt/rustwide/workdir/src/tests/mod.rs:108:51
[INFO] [stdout]   22:     0x5e25d6b4ba5a - irving::tests::programs::accord::typecheck_messages::hf9d891600ac9fe3b
[INFO] [stdout]                                at /opt/rustwide/workdir/src/tests/programs.rs:58:20
[INFO] [stdout]   23:     0x5e25d6b4ba87 - irving::tests::programs::accord::typecheck_messages::{{closure}}::h5b1059d5e587af32
[INFO] [stdout]                                at /opt/rustwide/workdir/src/tests/programs.rs:57:28
[INFO] [stdout]   24:     0x5e25d6ad20f6 - core::ops::function::FnOnce::call_once::h13d14612c01c9b0d
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x5e25d6d7883b - <fn() -> core[10b6fa85044e1869]::result::Result<(), alloc[dd269455e567d8e9]::string::String> as core[10b6fa85044e1869]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   26:     0x5e25d6d7883b - test[826cbc6ef54ab466]::__rust_begin_short_backtrace::<core[10b6fa85044e1869]::result::Result<(), alloc[dd269455e567d8e9]::string::String>, fn() -> core[10b6fa85044e1869]::result::Result<(), alloc[dd269455e567d8e9]::string::String>>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/test/src/lib.rs:663:18
[INFO] [stdout]   27:     0x5e25d6d8522b - test[826cbc6ef54ab466]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/test/src/lib.rs:686:74
[INFO] [stdout]   28:     0x5e25d6d8522b - <core[10b6fa85044e1869]::panic::unwind_safe::AssertUnwindSafe<test[826cbc6ef54ab466]::run_test_in_process::{closure#0}> as core[10b6fa85044e1869]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/core/src/panic/unwind_safe.rs:274:9
[INFO] [stdout]   29:     0x5e25d6d8522b - std[b80a194dd3c418bb]::panicking::catch_unwind::do_call::<core[10b6fa85044e1869]::panic::unwind_safe::AssertUnwindSafe<test[826cbc6ef54ab466]::run_test_in_process::{closure#0}>, core[10b6fa85044e1869]::result::Result<(), alloc[dd269455e567d8e9]::string::String>>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panicking.rs:581:40
[INFO] [stdout]   30:     0x5e25d6d8522b - std[b80a194dd3c418bb]::panicking::catch_unwind::<core[10b6fa85044e1869]::result::Result<(), alloc[dd269455e567d8e9]::string::String>, core[10b6fa85044e1869]::panic::unwind_safe::AssertUnwindSafe<test[826cbc6ef54ab466]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panicking.rs:544:19
[INFO] [stdout]   31:     0x5e25d6d8522b - std[b80a194dd3c418bb]::panic::catch_unwind::<core[10b6fa85044e1869]::panic::unwind_safe::AssertUnwindSafe<test[826cbc6ef54ab466]::run_test_in_process::{closure#0}>, core[10b6fa85044e1869]::result::Result<(), alloc[dd269455e567d8e9]::string::String>>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panic.rs:359:14
[INFO] [stdout]   32:     0x5e25d6d8522b - test[826cbc6ef54ab466]::run_test_in_process
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/test/src/lib.rs:686:27
[INFO] [stdout]   33:     0x5e25d6d8522b - test[826cbc6ef54ab466]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/test/src/lib.rs:607:43
[INFO] [stdout]   34:     0x5e25d6d80944 - test[826cbc6ef54ab466]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/test/src/lib.rs:637:41
[INFO] [stdout]   35:     0x5e25d6d80944 - std[b80a194dd3c418bb]::sys::backtrace::__rust_begin_short_backtrace::<test[826cbc6ef54ab466]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   36:     0x5e25d6d87e32 - std[b80a194dd3c418bb]::thread::lifecycle::spawn_unchecked::<test[826cbc6ef54ab466]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/thread/lifecycle.rs:91:13
[INFO] [stdout]   37:     0x5e25d6d87e32 - <core[10b6fa85044e1869]::panic::unwind_safe::AssertUnwindSafe<std[b80a194dd3c418bb]::thread::lifecycle::spawn_unchecked<test[826cbc6ef54ab466]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[10b6fa85044e1869]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/core/src/panic/unwind_safe.rs:274:9
[INFO] [stdout]   38:     0x5e25d6d87e32 - std[b80a194dd3c418bb]::panicking::catch_unwind::do_call::<core[10b6fa85044e1869]::panic::unwind_safe::AssertUnwindSafe<std[b80a194dd3c418bb]::thread::lifecycle::spawn_unchecked<test[826cbc6ef54ab466]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panicking.rs:581:40
[INFO] [stdout]   39:     0x5e25d6d87e32 - std[b80a194dd3c418bb]::panicking::catch_unwind::<(), core[10b6fa85044e1869]::panic::unwind_safe::AssertUnwindSafe<std[b80a194dd3c418bb]::thread::lifecycle::spawn_unchecked<test[826cbc6ef54ab466]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panicking.rs:544:19
[INFO] [stdout]   40:     0x5e25d6d87e32 - std[b80a194dd3c418bb]::panic::catch_unwind::<core[10b6fa85044e1869]::panic::unwind_safe::AssertUnwindSafe<std[b80a194dd3c418bb]::thread::lifecycle::spawn_unchecked<test[826cbc6ef54ab466]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panic.rs:359:14
[INFO] [stdout]   41:     0x5e25d6d87e32 - std[b80a194dd3c418bb]::thread::lifecycle::spawn_unchecked::<test[826cbc6ef54ab466]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/thread/lifecycle.rs:89:26
[INFO] [stdout]   42:     0x5e25d6d87e32 - <std[b80a194dd3c418bb]::thread::lifecycle::spawn_unchecked<test[826cbc6ef54ab466]::run_test::{closure#1}, ()>::{closure#1} as core[10b6fa85044e1869]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   43:     0x5e25d6e0a65f - <alloc[dd269455e567d8e9]::boxed::Box<dyn core[10b6fa85044e1869]::ops::function::FnOnce<(), Output = ()> + core[10b6fa85044e1869]::marker::Send> as core[10b6fa85044e1869]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/alloc/src/boxed.rs:2240:9
[INFO] [stdout]   44:     0x5e25d6e0a65f - <std[b80a194dd3c418bb]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stdout]   45:     0x7873ad29caa4 - <unknown>
[INFO] [stdout]   46:     0x7873ad329a64 - clone
[INFO] [stdout]   47:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- tests::programs::accord::typecheck_temporality stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'tests::programs::accord::typecheck_temporality' (186) panicked at src/tests/mod.rs:108:51:
[INFO] [stdout] called `Result::unwrap()` on an `Err` value: Os { code: 2, kind: NotFound, message: "No such file or directory" }
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5e25d6e0b0aa - std[b80a194dd3c418bb]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x5e25d6e0b0aa - std[b80a194dd3c418bb]::backtrace_rs::backtrace::trace_unsynchronized::<std[b80a194dd3c418bb]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x5e25d6e0b0aa - std[b80a194dd3c418bb]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x5e25d6e0b0aa - <<std[b80a194dd3c418bb]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[10b6fa85044e1869]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x5e25d6e209da - <core[10b6fa85044e1869]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x5e25d6e209da - core[10b6fa85044e1869]::fmt::write
[INFO] [stdout]    6:     0x5e25d6e0fce2 - std[b80a194dd3c418bb]::io::default_write_fmt::<alloc[dd269455e567d8e9]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/io/mod.rs:639:11
[INFO] [stdout]    7:     0x5e25d6e0fce2 - <alloc[dd269455e567d8e9]::vec::Vec<u8> as std[b80a194dd3c418bb]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/io/mod.rs:1994:13
[INFO] [stdout]    8:     0x5e25d6de96df - <std[b80a194dd3c418bb]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x5e25d6de96df - std[b80a194dd3c418bb]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x5e25d6e032b9 - std[b80a194dd3c418bb]::panicking::default_hook
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x5e25d6d8475c - <alloc[dd269455e567d8e9]::boxed::Box<dyn for<'a, 'b> core[10b6fa85044e1869]::ops::function::Fn<(&'a std[b80a194dd3c418bb]::panic::PanicHookInfo<'b>,), Output = ()> + core[10b6fa85044e1869]::marker::Sync + core[10b6fa85044e1869]::marker::Send> as core[10b6fa85044e1869]::ops::function::Fn<(&std[b80a194dd3c418bb]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/alloc/src/boxed.rs:2254:9
[INFO] [stdout]   12:     0x5e25d6d8475c - test[826cbc6ef54ab466]::test_main_with_exit_callback::<test[826cbc6ef54ab466]::test_main::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/test/src/lib.rs:145:21
[INFO] [stdout]   13:     0x5e25d6e03472 - <alloc[dd269455e567d8e9]::boxed::Box<dyn for<'a, 'b> core[10b6fa85044e1869]::ops::function::Fn<(&'a std[b80a194dd3c418bb]::panic::PanicHookInfo<'b>,), Output = ()> + core[10b6fa85044e1869]::marker::Sync + core[10b6fa85044e1869]::marker::Send> as core[10b6fa85044e1869]::ops::function::Fn<(&std[b80a194dd3c418bb]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/alloc/src/boxed.rs:2254:9
[INFO] [stdout]   14:     0x5e25d6e03472 - std[b80a194dd3c418bb]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x5e25d6de9798 - std[b80a194dd3c418bb]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x5e25d6de0fb9 - std[b80a194dd3c418bb]::sys::backtrace::__rust_end_short_backtrace::<std[b80a194dd3c418bb]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x5e25d6dea4ad - __rustc[9698a3e60dd14283]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x5e25d6e2136c - core[10b6fa85044e1869]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x5e25d6e210b2 - core[10b6fa85044e1869]::result::unwrap_failed
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/core/src/result.rs:1867:5
[INFO] [stdout]   20:     0x5e25d69f045d - core::result::Result<T,E>::unwrap::hd0e832927281f933
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/core/src/result.rs:1233:23
[INFO] [stdout]   21:     0x5e25d69f045d - irving::tests::helpers::typeinference_from_filename::h74a228827b588e45
[INFO] [stdout]                                at /opt/rustwide/workdir/src/tests/mod.rs:108:51
[INFO] [stdout]   22:     0x5e25d6b4bb1a - irving::tests::programs::accord::typecheck_temporality::h68b5324f7a6c8c87
[INFO] [stdout]                                at /opt/rustwide/workdir/src/tests/programs.rs:68:20
[INFO] [stdout]   23:     0x5e25d6b4bb47 - irving::tests::programs::accord::typecheck_temporality::{{closure}}::hbd2b913957c49187
[INFO] [stdout]                                at /opt/rustwide/workdir/src/tests/programs.rs:67:31
[INFO] [stdout]   24:     0x5e25d6ad6f66 - core::ops::function::FnOnce::call_once::he333eef9e4bcbc3e
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x5e25d6d7883b - <fn() -> core[10b6fa85044e1869]::result::Result<(), alloc[dd269455e567d8e9]::string::String> as core[10b6fa85044e1869]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   26:     0x5e25d6d7883b - test[826cbc6ef54ab466]::__rust_begin_short_backtrace::<core[10b6fa85044e1869]::result::Result<(), alloc[dd269455e567d8e9]::string::String>, fn() -> core[10b6fa85044e1869]::result::Result<(), alloc[dd269455e567d8e9]::string::String>>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/test/src/lib.rs:663:18
[INFO] [stdout]   27:     0x5e25d6d8522b - test[826cbc6ef54ab466]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/test/src/lib.rs:686:74
[INFO] [stdout]   28:     0x5e25d6d8522b - <core[10b6fa85044e1869]::panic::unwind_safe::AssertUnwindSafe<test[826cbc6ef54ab466]::run_test_in_process::{closure#0}> as core[10b6fa85044e1869]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/core/src/panic/unwind_safe.rs:274:9
[INFO] [stdout]   29:     0x5e25d6d8522b - std[b80a194dd3c418bb]::panicking::catch_unwind::do_call::<core[10b6fa85044e1869]::panic::unwind_safe::AssertUnwindSafe<test[826cbc6ef54ab466]::run_test_in_process::{closure#0}>, core[10b6fa85044e1869]::result::Result<(), alloc[dd269455e567d8e9]::string::String>>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panicking.rs:581:40
[INFO] [stdout]   30:     0x5e25d6d8522b - std[b80a194dd3c418bb]::panicking::catch_unwind::<core[10b6fa85044e1869]::result::Result<(), alloc[dd269455e567d8e9]::string::String>, core[10b6fa85044e1869]::panic::unwind_safe::AssertUnwindSafe<test[826cbc6ef54ab466]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panicking.rs:544:19
[INFO] [stdout]   31:     0x5e25d6d8522b - std[b80a194dd3c418bb]::panic::catch_unwind::<core[10b6fa85044e1869]::panic::unwind_safe::AssertUnwindSafe<test[826cbc6ef54ab466]::run_test_in_process::{closure#0}>, core[10b6fa85044e1869]::result::Result<(), alloc[dd269455e567d8e9]::string::String>>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panic.rs:359:14
[INFO] [stdout]   32:     0x5e25d6d8522b - test[826cbc6ef54ab466]::run_test_in_process
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/test/src/lib.rs:686:27
[INFO] [stdout]   33:     0x5e25d6d8522b - test[826cbc6ef54ab466]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/test/src/lib.rs:607:43
[INFO] [stdout]   34:     0x5e25d6d80944 - test[826cbc6ef54ab466]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/test/src/lib.rs:637:41
[INFO] [stdout]   35:     0x5e25d6d80944 - std[b80a194dd3c418bb]::sys::backtrace::__rust_begin_short_backtrace::<test[826cbc6ef54ab466]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   36:     0x5e25d6d87e32 - std[b80a194dd3c418bb]::thread::lifecycle::spawn_unchecked::<test[826cbc6ef54ab466]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/thread/lifecycle.rs:91:13
[INFO] [stdout]   37:     0x5e25d6d87e32 - <core[10b6fa85044e1869]::panic::unwind_safe::AssertUnwindSafe<std[b80a194dd3c418bb]::thread::lifecycle::spawn_unchecked<test[826cbc6ef54ab466]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[10b6fa85044e1869]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/core/src/panic/unwind_safe.rs:274:9
[INFO] [stdout]   38:     0x5e25d6d87e32 - std[b80a194dd3c418bb]::panicking::catch_unwind::do_call::<core[10b6fa85044e1869]::panic::unwind_safe::AssertUnwindSafe<std[b80a194dd3c418bb]::thread::lifecycle::spawn_unchecked<test[826cbc6ef54ab466]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panicking.rs:581:40
[INFO] [stdout]   39:     0x5e25d6d87e32 - std[b80a194dd3c418bb]::panicking::catch_unwind::<(), core[10b6fa85044e1869]::panic::unwind_safe::AssertUnwindSafe<std[b80a194dd3c418bb]::thread::lifecycle::spawn_unchecked<test[826cbc6ef54ab466]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panicking.rs:544:19
[INFO] [stdout]   40:     0x5e25d6d87e32 - std[b80a194dd3c418bb]::panic::catch_unwind::<core[10b6fa85044e1869]::panic::unwind_safe::AssertUnwindSafe<std[b80a194dd3c418bb]::thread::lifecycle::spawn_unchecked<test[826cbc6ef54ab466]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panic.rs:359:14
[INFO] [stdout]   41:     0x5e25d6d87e32 - std[b80a194dd3c418bb]::thread::lifecycle::spawn_unchecked::<test[826cbc6ef54ab466]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/thread/lifecycle.rs:89:26
[INFO] [stdout]   42:     0x5e25d6d87e32 - <std[b80a194dd3c418bb]::thread::lifecycle::spawn_unchecked<test[826cbc6ef54ab466]::run_test::{closure#1}, ()>::{closure#1} as core[10b6fa85044e1869]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   43:     0x5e25d6e0a65f - <alloc[dd269455e567d8e9]::boxed::Box<dyn core[10b6fa85044e1869]::ops::function::FnOnce<(), Output = ()> + core[10b6fa85044e1869]::marker::Send> as core[10b6fa85044e1869]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/alloc/src/boxed.rs:2240:9
[INFO] [stdout]   44:     0x5e25d6e0a65f - <std[b80a194dd3c418bb]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stdout]   45:     0x7873ad29caa4 - <unknown>
[INFO] [stdout]   46:     0x7873ad329a64 - clone
[INFO] [stdout]   47:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- tests::programs::accord::typecheck_txn stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'tests::programs::accord::typecheck_txn' (187) panicked at src/tests/mod.rs:108:51:
[INFO] [stdout] called `Result::unwrap()` on an `Err` value: Os { code: 2, kind: NotFound, message: "No such file or directory" }
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5e25d6e0b0aa - std[b80a194dd3c418bb]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x5e25d6e0b0aa - std[b80a194dd3c418bb]::backtrace_rs::backtrace::trace_unsynchronized::<std[b80a194dd3c418bb]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x5e25d6e0b0aa - std[b80a194dd3c418bb]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x5e25d6e0b0aa - <<std[b80a194dd3c418bb]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[10b6fa85044e1869]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x5e25d6e209da - <core[10b6fa85044e1869]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x5e25d6e209da - core[10b6fa85044e1869]::fmt::write
[INFO] [stdout]    6:     0x5e25d6e0fce2 - std[b80a194dd3c418bb]::io::default_write_fmt::<alloc[dd269455e567d8e9]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/io/mod.rs:639:11
[INFO] [stdout]    7:     0x5e25d6e0fce2 - <alloc[dd269455e567d8e9]::vec::Vec<u8> as std[b80a194dd3c418bb]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/io/mod.rs:1994:13
[INFO] [stdout]    8:     0x5e25d6de96df - <std[b80a194dd3c418bb]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x5e25d6de96df - std[b80a194dd3c418bb]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x5e25d6e032b9 - std[b80a194dd3c418bb]::panicking::default_hook
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x5e25d6d8475c - <alloc[dd269455e567d8e9]::boxed::Box<dyn for<'a, 'b> core[10b6fa85044e1869]::ops::function::Fn<(&'a std[b80a194dd3c418bb]::panic::PanicHookInfo<'b>,), Output = ()> + core[10b6fa85044e1869]::marker::Sync + core[10b6fa85044e1869]::marker::Send> as core[10b6fa85044e1869]::ops::function::Fn<(&std[b80a194dd3c418bb]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/alloc/src/boxed.rs:2254:9
[INFO] [stdout]   12:     0x5e25d6d8475c - test[826cbc6ef54ab466]::test_main_with_exit_callback::<test[826cbc6ef54ab466]::test_main::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/test/src/lib.rs:145:21
[INFO] [stdout]   13:     0x5e25d6e03472 - <alloc[dd269455e567d8e9]::boxed::Box<dyn for<'a, 'b> core[10b6fa85044e1869]::ops::function::Fn<(&'a std[b80a194dd3c418bb]::panic::PanicHookInfo<'b>,), Output = ()> + core[10b6fa85044e1869]::marker::Sync + core[10b6fa85044e1869]::marker::Send> as core[10b6fa85044e1869]::ops::function::Fn<(&std[b80a194dd3c418bb]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/alloc/src/boxed.rs:2254:9
[INFO] [stdout]   14:     0x5e25d6e03472 - std[b80a194dd3c418bb]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x5e25d6de9798 - std[b80a194dd3c418bb]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x5e25d6de0fb9 - std[b80a194dd3c418bb]::sys::backtrace::__rust_end_short_backtrace::<std[b80a194dd3c418bb]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x5e25d6dea4ad - __rustc[9698a3e60dd14283]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x5e25d6e2136c - core[10b6fa85044e1869]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x5e25d6e210b2 - core[10b6fa85044e1869]::result::unwrap_failed
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/core/src/result.rs:1867:5
[INFO] [stdout]   20:     0x5e25d69f045d - core::result::Result<T,E>::unwrap::hd0e832927281f933
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/core/src/result.rs:1233:23
[INFO] [stdout]   21:     0x5e25d69f045d - irving::tests::helpers::typeinference_from_filename::h74a228827b588e45
[INFO] [stdout]                                at /opt/rustwide/workdir/src/tests/mod.rs:108:51
[INFO] [stdout]   22:     0x5e25d6b4b99a - irving::tests::programs::accord::typecheck_txn::hc48c96eb78ae0d1f
[INFO] [stdout]                                at /opt/rustwide/workdir/src/tests/programs.rs:73:20
[INFO] [stdout]   23:     0x5e25d6b4b9c7 - irving::tests::programs::accord::typecheck_txn::{{closure}}::h02a7a110ab050fb3
[INFO] [stdout]                                at /opt/rustwide/workdir/src/tests/programs.rs:72:23
[INFO] [stdout]   24:     0x5e25d6ad7616 - core::ops::function::FnOnce::call_once::hf9cc1964ed1fd0ea
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x5e25d6d7883b - <fn() -> core[10b6fa85044e1869]::result::Result<(), alloc[dd269455e567d8e9]::string::String> as core[10b6fa85044e1869]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   26:     0x5e25d6d7883b - test[826cbc6ef54ab466]::__rust_begin_short_backtrace::<core[10b6fa85044e1869]::result::Result<(), alloc[dd269455e567d8e9]::string::String>, fn() -> core[10b6fa85044e1869]::result::Result<(), alloc[dd269455e567d8e9]::string::String>>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/test/src/lib.rs:663:18
[INFO] [stdout]   27:     0x5e25d6d8522b - test[826cbc6ef54ab466]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/test/src/lib.rs:686:74
[INFO] [stdout]   28:     0x5e25d6d8522b - <core[10b6fa85044e1869]::panic::unwind_safe::AssertUnwindSafe<test[826cbc6ef54ab466]::run_test_in_process::{closure#0}> as core[10b6fa85044e1869]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/core/src/panic/unwind_safe.rs:274:9
[INFO] [stdout]   29:     0x5e25d6d8522b - std[b80a194dd3c418bb]::panicking::catch_unwind::do_call::<core[10b6fa85044e1869]::panic::unwind_safe::AssertUnwindSafe<test[826cbc6ef54ab466]::run_test_in_process::{closure#0}>, core[10b6fa85044e1869]::result::Result<(), alloc[dd269455e567d8e9]::string::String>>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panicking.rs:581:40
[INFO] [stdout]   30:     0x5e25d6d8522b - std[b80a194dd3c418bb]::panicking::catch_unwind::<core[10b6fa85044e1869]::result::Result<(), alloc[dd269455e567d8e9]::string::String>, core[10b6fa85044e1869]::panic::unwind_safe::AssertUnwindSafe<test[826cbc6ef54ab466]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panicking.rs:544:19
[INFO] [stdout]   31:     0x5e25d6d8522b - std[b80a194dd3c418bb]::panic::catch_unwind::<core[10b6fa85044e1869]::panic::unwind_safe::AssertUnwindSafe<test[826cbc6ef54ab466]::run_test_in_process::{closure#0}>, core[10b6fa85044e1869]::result::Result<(), alloc[dd269455e567d8e9]::string::String>>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panic.rs:359:14
[INFO] [stdout]   32:     0x5e25d6d8522b - test[826cbc6ef54ab466]::run_test_in_process
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/test/src/lib.rs:686:27
[INFO] [stdout]   33:     0x5e25d6d8522b - test[826cbc6ef54ab466]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/test/src/lib.rs:607:43
[INFO] [stdout]   34:     0x5e25d6d80944 - test[826cbc6ef54ab466]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/test/src/lib.rs:637:41
[INFO] [stdout]   35:     0x5e25d6d80944 - std[b80a194dd3c418bb]::sys::backtrace::__rust_begin_short_backtrace::<test[826cbc6ef54ab466]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   36:     0x5e25d6d87e32 - std[b80a194dd3c418bb]::thread::lifecycle::spawn_unchecked::<test[826cbc6ef54ab466]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/thread/lifecycle.rs:91:13
[INFO] [stdout]   37:     0x5e25d6d87e32 - <core[10b6fa85044e1869]::panic::unwind_safe::AssertUnwindSafe<std[b80a194dd3c418bb]::thread::lifecycle::spawn_unchecked<test[826cbc6ef54ab466]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[10b6fa85044e1869]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/core/src/panic/unwind_safe.rs:274:9
[INFO] [stdout]   38:     0x5e25d6d87e32 - std[b80a194dd3c418bb]::panicking::catch_unwind::do_call::<core[10b6fa85044e1869]::panic::unwind_safe::AssertUnwindSafe<std[b80a194dd3c418bb]::thread::lifecycle::spawn_unchecked<test[826cbc6ef54ab466]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panicking.rs:581:40
[INFO] [stdout]   39:     0x5e25d6d87e32 - std[b80a194dd3c418bb]::panicking::catch_unwind::<(), core[10b6fa85044e1869]::panic::unwind_safe::AssertUnwindSafe<std[b80a194dd3c418bb]::thread::lifecycle::spawn_unchecked<test[826cbc6ef54ab466]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panicking.rs:544:19
[INFO] [stdout]   40:     0x5e25d6d87e32 - std[b80a194dd3c418bb]::panic::catch_unwind::<core[10b6fa85044e1869]::panic::unwind_safe::AssertUnwindSafe<std[b80a194dd3c418bb]::thread::lifecycle::spawn_unchecked<test[826cbc6ef54ab466]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panic.rs:359:14
[INFO] [stdout]   41:     0x5e25d6d87e32 - std[b80a194dd3c418bb]::thread::lifecycle::spawn_unchecked::<test[826cbc6ef54ab466]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/thread/lifecycle.rs:89:26
[INFO] [stdout]   42:     0x5e25d6d87e32 - <std[b80a194dd3c418bb]::thread::lifecycle::spawn_unchecked<test[826cbc6ef54ab466]::run_test::{closure#1}, ()>::{closure#1} as core[10b6fa85044e1869]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   43:     0x5e25d6e0a65f - <alloc[dd269455e567d8e9]::boxed::Box<dyn core[10b6fa85044e1869]::ops::function::FnOnce<(), Output = ()> + core[10b6fa85044e1869]::marker::Send> as core[10b6fa85044e1869]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/alloc/src/boxed.rs:2240:9
[INFO] [stdout]   44:     0x5e25d6e0a65f - <std[b80a194dd3c418bb]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stdout]   45:     0x7873ad29caa4 - <unknown>
[INFO] [stdout]   46:     0x7873ad329a64 - clone
[INFO] [stdout]   47:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- tests::typechecker::modules::tests::instantiation_with_impl_spec_blocks stdout ----
[INFO] [stdout] [2026-03-10T02:36:45Z TRACE binding] Inserting top:SortVar(0) into context (depth 1)
[INFO] [stdout] [2026-03-10T02:36:45Z TRACE binding] Inserting init:Action([], List([]), Unit, Instance) into context (depth 2)
[INFO] [stdout] [2026-03-10T02:36:45Z TRACE visitor] Decl Source:2 ("module counter = {...)
[INFO] [stdout] [2026-03-10T02:36:45Z TRACE binding] Inserting counter:SortVar(1) into context (depth 2)
[INFO] [stdout] [2026-03-10T02:36:45Z TRACE binding] Inserting this:This into context (depth 3)
[INFO] [stdout] [2026-03-10T02:36:45Z TRACE binding] Inserting init:Action([], List([]), Unit, Instance) into context (depth 3)
[INFO] [stdout] [2026-03-10T02:36:45Z TRACE visitor] Decl Source:3 ("implementation {...)
[INFO] [stdout] [2026-03-10T02:36:45Z TRACE binding] Inserting impl:SortVar(2) into context (depth 3)
[INFO] [stdout] [2026-03-10T02:36:45Z TRACE binding] Inserting init:Action([], List([]), Unit, Instance) into context (depth 3)
[INFO] [stdout] [2026-03-10T02:36:45Z TRACE visitor] Decl Source:4 ("val : nat...)
[INFO] [stdout] [2026-03-10T02:36:45Z TRACE binding] Inserting val:Number into context (depth 3)
[INFO] [stdout] [2026-03-10T02:36:45Z DEBUG sort-inference] unify(Number,Number)
[INFO] [stdout] [2026-03-10T02:36:45Z TRACE visitor] Decl Source:5 ("after init { val := 0 }")
[INFO] [stdout] [2026-03-10T02:36:45Z TRACE visitor] Vec<Stmt> (len 1)
[INFO] [stdout] [2026-03-10T02:36:45Z TRACE visitor] Action Source:5 ("val := 0 ")
[INFO] [stdout] [2026-03-10T02:36:45Z TRACE visitor] Expr ProgramSymbol { sym: Binding { name: "val", decl: ToBeInferred, span: Source:5 ("val") } }
[INFO] [stdout] [2026-03-10T02:36:45Z TRACE visitor] Expr Number { span: Source:5 ("0"), val: 0 }
[INFO] [stdout] [2026-03-10T02:36:45Z DEBUG sort-inference] unify(Number,Number)
[INFO] [stdout] [2026-03-10T02:36:45Z DEBUG sort-inference] unify(Action([], List([]), Unit, Instance),SortVar(3))
[INFO] [stdout] [2026-03-10T02:36:45Z DEBUG sort-inference] unify(SortVar(2),Object(Object { args: [], fields: {"init": Action([], List([]), Unit, Instance), "val": Number} }))
[INFO] [stdout] [2026-03-10T02:36:45Z DEBUG sort-inference] unify(SortVar(1),Module(Module { name: "counter", args: [], fields: {"impl": Object(Object { args: [], fields: {"init": Action([], List([]), Unit, Instance), "val": Number} }), "init": Action([], List([]), Unit, Instance)} }))
[INFO] [stdout] [2026-03-10T02:36:45Z TRACE visitor] Decl Source:9 ("instance c : counter...)
[INFO] [stdout] [2026-03-10T02:36:45Z TRACE binding] Inserting c:SortVar(4) into context (depth 2)
[INFO] [stdout] [2026-03-10T02:36:45Z DEBUG sort-inference] unify(SortVar(4),Module(Module { name: "c", args: [], fields: {"impl": Object(Object { args: [], fields: {"init": Action([], List([]), Unit, Instance), "val": Number} }), "init": Action([], List([]), Unit, Instance)} }))
[INFO] [stdout] [2026-03-10T02:36:45Z TRACE visitor] Decl Source:10 ("v : nat...)
[INFO] [stdout] [2026-03-10T02:36:45Z TRACE binding] Inserting v:Number into context (depth 2)
[INFO] [stdout] [2026-03-10T02:36:45Z DEBUG sort-inference] unify(Number,Number)
[INFO] [stdout] [2026-03-10T02:36:45Z TRACE visitor] Decl IgnoredForTesting
[INFO] [stdout] [2026-03-10T02:36:45Z TRACE visitor] Vec<Stmt> (len 1)
[INFO] [stdout] [2026-03-10T02:36:45Z TRACE visitor] Action Source:11 ("v := c.val # Even though it's wrapped in an implementation block, val should be at counter's scope....)
[INFO] [stdout] [2026-03-10T02:36:45Z TRACE visitor] Expr ProgramSymbol { sym: Binding { name: "v", decl: ToBeInferred, span: Source:11 ("v") } }
[INFO] [stdout] [2026-03-10T02:36:45Z TRACE visitor] Expr FieldAccess { span: Source:11 (".val"), expr: FieldAccess { record: ProgramSymbol { sym: Binding { name: "c", decl: ToBeInferred, span: Source:11 ("c") } }, field: Binding { name: "val", decl: ToBeInferred, span: Source:11 ("val") } } }
[INFO] [stdout] [2026-03-10T02:36:45Z TRACE visitor] Expr ProgramSymbol { sym: Binding { name: "c", decl: ToBeInferred, span: Source:11 ("c") } }
[INFO] [stdout] NBT: Module(Module { name: "c", args: [], fields: {"impl": Object(Object { args: [], fields: {"init": Action([], List([]), Unit, Instance), "val": Number} }), "init": Action([], List([]), Unit, Instance)} })
[INFO] [stdout] 
[INFO] [stdout] thread 'tests::typechecker::modules::tests::instantiation_with_impl_spec_blocks' (262) panicked at src/tests/typechecker/modules.rs:191:40:
[INFO] [stdout] called `Result::unwrap()` on an `Err` value: Spanned { span: Source:11 (".val"), inner: MissingRecordField("val") }
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5e25d6e0b0aa - std[b80a194dd3c418bb]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x5e25d6e0b0aa - std[b80a194dd3c418bb]::backtrace_rs::backtrace::trace_unsynchronized::<std[b80a194dd3c418bb]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x5e25d6e0b0aa - std[b80a194dd3c418bb]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x5e25d6e0b0aa - <<std[b80a194dd3c418bb]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[10b6fa85044e1869]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x5e25d6e209da - <core[10b6fa85044e1869]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x5e25d6e209da - core[10b6fa85044e1869]::fmt::write
[INFO] [stdout]    6:     0x5e25d6e0fce2 - std[b80a194dd3c418bb]::io::default_write_fmt::<alloc[dd269455e567d8e9]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/io/mod.rs:639:11
[INFO] [stdout]    7:     0x5e25d6e0fce2 - <alloc[dd269455e567d8e9]::vec::Vec<u8> as std[b80a194dd3c418bb]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/io/mod.rs:1994:13
[INFO] [stdout]    8:     0x5e25d6de96df - <std[b80a194dd3c418bb]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x5e25d6de96df - std[b80a194dd3c418bb]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x5e25d6e032b9 - std[b80a194dd3c418bb]::panicking::default_hook
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x5e25d6d8475c - <alloc[dd269455e567d8e9]::boxed::Box<dyn for<'a, 'b> core[10b6fa85044e1869]::ops::function::Fn<(&'a std[b80a194dd3c418bb]::panic::PanicHookInfo<'b>,), Output = ()> + core[10b6fa85044e1869]::marker::Sync + core[10b6fa85044e1869]::marker::Send> as core[10b6fa85044e1869]::ops::function::Fn<(&std[b80a194dd3c418bb]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/alloc/src/boxed.rs:2254:9
[INFO] [stdout]   12:     0x5e25d6d8475c - test[826cbc6ef54ab466]::test_main_with_exit_callback::<test[826cbc6ef54ab466]::test_main::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/test/src/lib.rs:145:21
[INFO] [stdout]   13:     0x5e25d6e03472 - <alloc[dd269455e567d8e9]::boxed::Box<dyn for<'a, 'b> core[10b6fa85044e1869]::ops::function::Fn<(&'a std[b80a194dd3c418bb]::panic::PanicHookInfo<'b>,), Output = ()> + core[10b6fa85044e1869]::marker::Sync + core[10b6fa85044e1869]::marker::Send> as core[10b6fa85044e1869]::ops::function::Fn<(&std[b80a194dd3c418bb]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/alloc/src/boxed.rs:2254:9
[INFO] [stdout]   14:     0x5e25d6e03472 - std[b80a194dd3c418bb]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x5e25d6de9798 - std[b80a194dd3c418bb]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x5e25d6de0fb9 - std[b80a194dd3c418bb]::sys::backtrace::__rust_end_short_backtrace::<std[b80a194dd3c418bb]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x5e25d6dea4ad - __rustc[9698a3e60dd14283]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x5e25d6e2136c - core[10b6fa85044e1869]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x5e25d6e210b2 - core[10b6fa85044e1869]::result::unwrap_failed
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/core/src/result.rs:1867:5
[INFO] [stdout]   20:     0x5e25d6b3a036 - core::result::Result<T,E>::unwrap::heb6544729be3d266
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/core/src/result.rs:1233:23
[INFO] [stdout]   21:     0x5e25d6b3a036 - irving::tests::typechecker::modules::tests::instantiation_with_impl_spec_blocks::h8d7f522a52bf02a0
[INFO] [stdout]                                at /opt/rustwide/workdir/src/tests/typechecker/modules.rs:191:40
[INFO] [stdout]   22:     0x5e25d6b3a117 - irving::tests::typechecker::modules::tests::instantiation_with_impl_spec_blocks::{{closure}}::hba3a8c0c71d6fde5
[INFO] [stdout]                                at /opt/rustwide/workdir/src/tests/typechecker/modules.rs:173:45
[INFO] [stdout]   23:     0x5e25d6ad7716 - core::ops::function::FnOnce::call_once::hfc742ca22e2b426a
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   24:     0x5e25d6d7883b - <fn() -> core[10b6fa85044e1869]::result::Result<(), alloc[dd269455e567d8e9]::string::String> as core[10b6fa85044e1869]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x5e25d6d7883b - test[826cbc6ef54ab466]::__rust_begin_short_backtrace::<core[10b6fa85044e1869]::result::Result<(), alloc[dd269455e567d8e9]::string::String>, fn() -> core[10b6fa85044e1869]::result::Result<(), alloc[dd269455e567d8e9]::string::String>>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/test/src/lib.rs:663:18
[INFO] [stdout]   26:     0x5e25d6d8522b - test[826cbc6ef54ab466]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/test/src/lib.rs:686:74
[INFO] [stdout]   27:     0x5e25d6d8522b - <core[10b6fa85044e1869]::panic::unwind_safe::AssertUnwindSafe<test[826cbc6ef54ab466]::run_test_in_process::{closure#0}> as core[10b6fa85044e1869]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/core/src/panic/unwind_safe.rs:274:9
[INFO] [stdout]   28:     0x5e25d6d8522b - std[b80a194dd3c418bb]::panicking::catch_unwind::do_call::<core[10b6fa85044e1869]::panic::unwind_safe::AssertUnwindSafe<test[826cbc6ef54ab466]::run_test_in_process::{closure#0}>, core[10b6fa85044e1869]::result::Result<(), alloc[dd269455e567d8e9]::string::String>>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panicking.rs:581:40
[INFO] [stdout]   29:     0x5e25d6d8522b - std[b80a194dd3c418bb]::panicking::catch_unwind::<core[10b6fa85044e1869]::result::Result<(), alloc[dd269455e567d8e9]::string::String>, core[10b6fa85044e1869]::panic::unwind_safe::AssertUnwindSafe<test[826cbc6ef54ab466]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panicking.rs:544:19
[INFO] [stdout]   30:     0x5e25d6d8522b - std[b80a194dd3c418bb]::panic::catch_unwind::<core[10b6fa85044e1869]::panic::unwind_safe::AssertUnwindSafe<test[826cbc6ef54ab466]::run_test_in_process::{closure#0}>, core[10b6fa85044e1869]::result::Result<(), alloc[dd269455e567d8e9]::string::String>>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panic.rs:359:14
[INFO] [stdout]   31:     0x5e25d6d8522b - test[826cbc6ef54ab466]::run_test_in_process
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/test/src/lib.rs:686:27
[INFO] [stdout]   32:     0x5e25d6d8522b - test[826cbc6ef54ab466]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/test/src/lib.rs:607:43
[INFO] [stdout]   33:     0x5e25d6d80944 - test[826cbc6ef54ab466]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/test/src/lib.rs:637:41
[INFO] [stdout]   34:     0x5e25d6d80944 - std[b80a194dd3c418bb]::sys::backtrace::__rust_begin_short_backtrace::<test[826cbc6ef54ab466]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   35:     0x5e25d6d87e32 - std[b80a194dd3c418bb]::thread::lifecycle::spawn_unchecked::<test[826cbc6ef54ab466]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/thread/lifecycle.rs:91:13
[INFO] [stdout]   36:     0x5e25d6d87e32 - <core[10b6fa85044e1869]::panic::unwind_safe::AssertUnwindSafe<std[b80a194dd3c418bb]::thread::lifecycle::spawn_unchecked<test[826cbc6ef54ab466]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[10b6fa85044e1869]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/core/src/panic/unwind_safe.rs:274:9
[INFO] [stdout]   37:     0x5e25d6d87e32 - std[b80a194dd3c418bb]::panicking::catch_unwind::do_call::<core[10b6fa85044e1869]::panic::unwind_safe::AssertUnwindSafe<std[b80a194dd3c418bb]::thread::lifecycle::spawn_unchecked<test[826cbc6ef54ab466]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panicking.rs:581:40
[INFO] [stdout]   38:     0x5e25d6d87e32 - std[b80a194dd3c418bb]::panicking::catch_unwind::<(), core[10b6fa85044e1869]::panic::unwind_safe::AssertUnwindSafe<std[b80a194dd3c418bb]::thread::lifecycle::spawn_unchecked<test[826cbc6ef54ab466]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panicking.rs:544:19
[INFO] [stdout]   39:     0x5e25d6d87e32 - std[b80a194dd3c418bb]::panic::catch_unwind::<core[10b6fa85044e1869]::panic::unwind_safe::AssertUnwindSafe<std[b80a194dd3c418bb]::thread::lifecycle::spawn_unchecked<test[826cbc6ef54ab466]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/panic.rs:359:14
[INFO] [stdout]   40:     0x5e25d6d87e32 - std[b80a194dd3c418bb]::thread::lifecycle::spawn_unchecked::<test[826cbc6ef54ab466]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/thread/lifecycle.rs:89:26
[INFO] [stdout]   41:     0x5e25d6d87e32 - <std[b80a194dd3c418bb]::thread::lifecycle::spawn_unchecked<test[826cbc6ef54ab466]::run_test::{closure#1}, ()>::{closure#1} as core[10b6fa85044e1869]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   42:     0x5e25d6e0a65f - <alloc[dd269455e567d8e9]::boxed::Box<dyn core[10b6fa85044e1869]::ops::function::FnOnce<(), Output = ()> + core[10b6fa85044e1869]::marker::Send> as core[10b6fa85044e1869]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/alloc/src/boxed.rs:2240:9
[INFO] [stdout]   43:     0x5e25d6e0a65f - <std[b80a194dd3c418bb]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/ad726b5063362ec9897ef3d67452fc5606ee70fa/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stdout]   44:     0x7873ad29caa4 - <unknown>
[INFO] [stdout]   45:     0x7873ad329a64 - clone
[INFO] [stdout]   46:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     tests::extraction::java::tests::extract_module_instantation
[INFO] [stdout]     tests::programs::accord::typecheck_abstract_protocol
[INFO] [stdout]     tests::programs::accord::typecheck_messages
[INFO] [stdout]     tests::programs::accord::typecheck_protocol
[INFO] [stdout]     tests::programs::accord::typecheck_sorts
[INFO] [stdout]     tests::programs::accord::typecheck_temporality
[INFO] [stdout]     tests::programs::accord::typecheck_txn
[INFO] [stdout]     tests::typechecker::modules::tests::instantiation_with_impl_spec_blocks
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 281 passed; 8 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.45s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass `--lib`
[INFO] running `Command { std: "docker" "inspect" "f6b125f90cfc97a13ad182083558acbe8fbc90e7867851370765014581980d44", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "f6b125f90cfc97a13ad182083558acbe8fbc90e7867851370765014581980d44", kill_on_drop: false }`
[INFO] [stdout] f6b125f90cfc97a13ad182083558acbe8fbc90e7867851370765014581980d44
