[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-01-20 for beta-1.94-1
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fdijkstracula%2Firving" "/workspace/builds/worker-4-tc2/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-4-tc2/source'...
[INFO] [stderr] done.
[INFO] started tweaking git repo https://github.com/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-4-tc2/source/Cargo.toml
[INFO] validating manifest of git repo https://github.com/dijkstracula/irving on toolchain beta-2026-01-20
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+beta-2026-01-20" "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-01-20" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-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:98afbf2d16093dec2546ff8915fddc74e65664aa03fc460b3712b1c2c54a33e4" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2026-01-20" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] d623741dd7d84a85f4b802d801a49d27d68ef7200791e39810fbe17eb029b1ff
[INFO] running `Command { std: "docker" "start" "-a" "d623741dd7d84a85f4b802d801a49d27d68ef7200791e39810fbe17eb029b1ff", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "d623741dd7d84a85f4b802d801a49d27d68ef7200791e39810fbe17eb029b1ff", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "d623741dd7d84a85f4b802d801a49d27d68ef7200791e39810fbe17eb029b1ff", kill_on_drop: false }`
[INFO] [stdout] d623741dd7d84a85f4b802d801a49d27d68ef7200791e39810fbe17eb029b1ff
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-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:98afbf2d16093dec2546ff8915fddc74e65664aa03fc460b3712b1c2c54a33e4" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2026-01-20" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 73ec221d95f24fe484339ad4abd7b754d372d522130cc54d88da4bccda63d083
[INFO] running `Command { std: "docker" "start" "-a" "73ec221d95f24fe484339ad4abd7b754d372d522130cc54d88da4bccda63d083", kill_on_drop: false }`
[INFO] [stderr]    Compiling rustix v0.38.3
[INFO] [stderr]    Compiling thiserror v1.0.40
[INFO] [stderr]    Compiling linux-raw-sys v0.4.3
[INFO] [stderr]    Compiling bitflags v2.3.3
[INFO] [stderr]    Compiling regex-syntax v0.7.4
[INFO] [stderr]    Compiling anstyle v1.0.1
[INFO] [stderr]    Compiling anstyle-parse v0.2.1
[INFO] [stderr]    Compiling anyhow v1.0.75
[INFO] [stderr]    Compiling termcolor v1.2.0
[INFO] [stderr]    Compiling either v1.9.0
[INFO] [stderr]    Compiling syn v2.0.15
[INFO] [stderr]    Compiling annotate-snippets v0.9.2
[INFO] [stderr]    Compiling pest_consume_macros v1.1.0
[INFO] [stderr]    Compiling itertools v0.11.0
[INFO] [stderr]    Compiling is-terminal v0.4.9
[INFO] [stderr]    Compiling anstream v0.3.2
[INFO] [stderr]    Compiling regex-automata v0.3.3
[INFO] [stderr]    Compiling clap_builder v4.3.11
[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 v2.6.0
[INFO] [stderr]    Compiling env_logger v0.10.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 28.76s
[INFO] running `Command { std: "docker" "inspect" "73ec221d95f24fe484339ad4abd7b754d372d522130cc54d88da4bccda63d083", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "73ec221d95f24fe484339ad4abd7b754d372d522130cc54d88da4bccda63d083", kill_on_drop: false }`
[INFO] [stdout] 73ec221d95f24fe484339ad4abd7b754d372d522130cc54d88da4bccda63d083
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-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:98afbf2d16093dec2546ff8915fddc74e65664aa03fc460b3712b1c2c54a33e4" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2026-01-20" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] d6608dcb5cac59ce69d222972941af8d7c7abfbc0c812ec2f7fbdaacc6e7768d
[INFO] running `Command { std: "docker" "start" "-a" "d6608dcb5cac59ce69d222972941af8d7c7abfbc0c812ec2f7fbdaacc6e7768d", 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 12.08s
[INFO] running `Command { std: "docker" "inspect" "d6608dcb5cac59ce69d222972941af8d7c7abfbc0c812ec2f7fbdaacc6e7768d", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "d6608dcb5cac59ce69d222972941af8d7c7abfbc0c812ec2f7fbdaacc6e7768d", kill_on_drop: false }`
[INFO] [stdout] d6608dcb5cac59ce69d222972941af8d7c7abfbc0c812ec2f7fbdaacc6e7768d
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-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:98afbf2d16093dec2546ff8915fddc74e65664aa03fc460b3712b1c2c54a33e4" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2026-01-20" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] aa5a97b2c430493e4e20d5761de2b0f668bba2bff8a3f01a26b75a5552f316ea
[INFO] running `Command { std: "docker" "start" "-a" "aa5a97b2c430493e4e20d5761de2b0f668bba2bff8a3f01a26b75a5552f316ea", 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.11s
[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_arith ... 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::java::tests::extract_action_forward_ref ... ok
[INFO] [stdout] test tests::extraction::ivy::tests::pprint_formula_with_dots ... ok
[INFO] [stdout] test tests::extraction::ivy::tests::pprint_subclass ... ok
[INFO] [stdout] test tests::extraction::java::tests::extract_after_decl ... ok
[INFO] [stdout] test tests::extraction::java::tests::extract_arith ... ok
[INFO] [stdout] test tests::extraction::ivy::tests::pprint_fnapp ... ok
[INFO] [stdout] test tests::extraction::java::tests::extract_action_and_decl ... ok
[INFO] [stdout] test tests::extraction::java::tests::extract_assign_nat_lit ... ok
[INFO] [stdout] test tests::extraction::java::tests::extract_assign_range_binop ... ok
[INFO] [stdout] test tests::extraction::java::tests::extract_assign_nat_nonlit ... ok
[INFO] [stdout] test tests::extraction::java::tests::extract_assign_range_lit ... ok
[INFO] [stdout] test tests::extraction::java::tests::extract_assign_range_saturated_lit ... ok
[INFO] [stdout] test tests::extraction::java::tests::extract_field_access ... ok
[INFO] [stdout] test tests::extraction::ivy::tests::pprint_class ... ok
[INFO] [stdout] test tests::extraction::java::tests::extract_module_simple ... ok
[INFO] [stdout] test tests::extraction::java::tests::extract_nested_forall ... ok
[INFO] [stdout] test tests::extraction::java::tests::extract_forall ... ok
[INFO] [stdout] test tests::extraction::java::tests::extract_after_init ... ok
[INFO] [stdout] test tests::extraction::java::tests::extract_call_compound_arg ... ok
[INFO] [stdout] test tests::extraction::vnt::tests::test_relation_init ... 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_vardecl ... ok
[INFO] [stdout] test tests::extraction::java::tests::extract_module_parameterized ... ok
[INFO] [stdout] test tests::extraction::java::tests::extract_process_trivial ... ok
[INFO] [stdout] test tests::extraction::vnt::tests::test_param_dedup ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_alias_decl ... 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_ensure_with_fmla ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_instance_decl ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_axiom_2 ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_decl_sig ... ok
[INFO] [stdout] test tests::extraction::vnt::tests::test_noninf1 ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_interpret_annotated_decl ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_function_decl_uninterp ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_axiom ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_module_decl_1 ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_nullary_relation ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_common_decl ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_object_decl ... 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_impl ... 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_relation_decl ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_type_decl ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_process_decl ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_type_decl_range ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_specification_decl ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_parametrized_decl_err ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_var_decl ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_var_decl_with_type ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_interpret_uninterp_decl ... ok
[INFO] [stdout] test tests::parser::expressions::tests::parse_complex_expr ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_invariant_decl ... ok
[INFO] [stdout] test tests::parser::declarations::tests::vardecl_declare_and_assign ... ok
[INFO] [stdout] test tests::parser::expressions::tests::parse_conjunction_fmla ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_attribute_assign ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_type_decl_with_super ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_subclass_decl ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_type_enum_range ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_type_decl_this ... ok
[INFO] [stdout] test tests::parser::expressions::tests::parse_dot_expr ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_global_decl ... ok
[INFO] [stdout] test tests::parser::expressions::tests::parse_fnapp_in_conj ... ok
[INFO] [stdout] test tests::parser::expressions::tests::parse_le ... ok
[INFO] [stdout] test tests::parser::expressions::tests::parse_fnapp_and_index ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_implementation_decl ... ok
[INFO] [stdout] test tests::parser::expressions::tests::parse_multi_fnapp ... ok
[INFO] [stdout] test tests::parser::expressions::tests::parse_negation_expr ... ok
[INFO] [stdout] test tests::parser::expressions::tests::parse_logicvar ... ok
[INFO] [stdout] test tests::parser::expressions::tests::parse_sub ... ok
[INFO] [stdout] test tests::parser::expressions::tests::parse_symbol_with_underscore ... ok
[INFO] [stdout] test tests::parser::expressions::tests::parse_negative_number_expr ... ok
[INFO] [stdout] test tests::parser::expressions::tests::parse_unary_fnapp ... ok
[INFO] [stdout] test tests::parser::expressions::tests::parse_nested_fnapp ... ok
[INFO] [stdout] test tests::parser::expressions::tests::parse_pred ... ok
[INFO] [stdout] test tests::parser::expressions::tests::parse_unary_fnapp_and_negation ... ok
[INFO] [stdout] test tests::parser::expressions::tests::parse_progsym ... ok
[INFO] [stdout] test tests::parser::expressions::tests::parse_pred_2 ... ok
[INFO] [stdout] test tests::parser::formulas::tests::parse_conjunction ... 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_negation ... ok
[INFO] [stdout] test tests::parser::formulas::tests::parse_logical_implication ... ok
[INFO] [stdout] test tests::parser::formulas::tests::parse_existential_quant ... ok
[INFO] [stdout] test tests::parser::formulas::tests::parse_bool ... ok
[INFO] [stdout] test tests::parser::formulas::tests::parse_nested_implications ... 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_number ... ok
[INFO] [stdout] test tests::parser::formulas::tests::parse_logicvar_in_fnapp ... ok
[INFO] [stdout] test tests::parser::formulas::tests::parse_negated_quant ... ok
[INFO] [stdout] test tests::parser::formulas::tests::parse_nested_implications_2 ... ok
[INFO] [stdout] test tests::parser::formulas::tests::parse_parens_negation ... ok
[INFO] [stdout] test tests::parser::formulas::tests::parse_term ... ok
[INFO] [stdout] test tests::parser::formulas::tests::parse_term_with_annotation ... ok
[INFO] [stdout] test tests::parser::mixins::tests::parse_action_decl_no_ret_nor_body ... ok
[INFO] [stdout] test tests::parser::formulas::tests::parse_universal_quant ... ok
[INFO] [stdout] test tests::parser::formulas::tests::parse_progvar_in_fnapp ... ok
[INFO] [stdout] test tests::parser::mixins::tests::parse_action_decl_with_ret_and_body ... 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_quants ... ok
[INFO] [stdout] test tests::parser::mixins::tests::parse_action_forward_ref ... ok
[INFO] [stdout] test tests::parser::mixins::tests::parse_export_forward_ref ... ok
[INFO] [stdout] test tests::parser::mixins::tests::parse_after_mixin_with_declret ... ok
[INFO] [stdout] test tests::parser::mixins::tests::parse_after_init ... ok
[INFO] [stdout] test tests::parser::mixins::tests::parse_after_mixin ... ok
[INFO] [stdout] test tests::parser::mixins::tests::parse_export_forward_ref_qualified ... 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::mixins::tests::parse_export_action ... ok
[INFO] [stdout] test tests::parser::mixins::tests::parse_implement ... ok
[INFO] [stdout] test tests::parser::mixins::tests::parse_action_decl_with_ret_no_body ... ok
[INFO] [stdout] test tests::parser::mixins::tests::parse_implement_with_declret ... ok
[INFO] [stdout] test tests::parser::expressions::tests::parse_number_expr ... ok
[INFO] [stdout] test tests::parser::statements::tests::parse_assign_to_field_of_this ... ok
[INFO] [stdout] test tests::parser::statements::tests::parse_assign_to_relation ... ok
[INFO] [stdout] test tests::parser::mixins::tests::parse_nested_action ... ok
[INFO] [stdout] test tests::parser::statements::tests::parse_declare_annot ... ok
[INFO] [stdout] test tests::parser::statements::tests::parse_assign_with_rhs_logicvar ... ok
[INFO] [stdout] test tests::parser::statements::tests::parse_ensure_action ... ok
[INFO] [stdout] test tests::parser::statements::tests::parse_assume_action ... ok
[INFO] [stdout] test tests::parser::statements::tests::parse_multi_stmt_while ... ok
[INFO] [stdout] test tests::parser::statements::tests::parse_if_ladder ... ok
[INFO] [stdout] test tests::parser::statements::tests::parse_not_an_assign ... ok
[INFO] [stdout] test tests::parser::statements::tests::parse_assign_to_relation_2 ... ok
[INFO] [stdout] test tests::parser::statements::tests::parse_ensure_action_2 ... 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::parse_trivial_prog ... ok
[INFO] [stdout] test tests::parser::statements::tests::parse_while ... ok
[INFO] [stdout] test tests::parser::toplevels::tests::logical_call_to_action ... ok
[INFO] [stdout] test tests::parser::toplevels::tests::parse_less_trivial_prog ... ok
[INFO] [stdout] test tests::passes::constant_fold::tests::fold_constants ... 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::passes::quantifier_bounds::tests::bounds_from_binop_literals ... ok
[INFO] [stdout] test tests::passes::quantifier_bounds::tests::bounds_for_sort ... ok
[INFO] [stdout] test tests::passes::constant_fold::tests::fold_left_assoc ... ok
[INFO] [stdout] test tests::parser::statements::tests::parse_requires_action_2 ... ok
[INFO] [stdout] test tests::passes::quantifier_bounds::tests::bounds_from_binop_logicvar ... ok
[INFO] [stdout] test tests::parser::toplevels::tests::parse_hashlang_major_only ... ok
[INFO] [stdout] test tests::passes::quantifier_bounds::tests::bounds_from_forall_nats_conjunction ... ok
[INFO] [stdout] test tests::passes::quantifier_bounds::tests::bounds_from_forall_nats_false_monotonic_gt ... ok
[INFO] [stdout] test tests::passes::constant_fold::tests::fold_zero_add ... ok
[INFO] [stdout] test tests::passes::quantifier_bounds::tests::bounds_from_forall_nats_disjunction ... 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_literal ... ok
[INFO] [stdout] test tests::passes::quantifier_bounds::tests::succ_binop_of_literals ... ok
[INFO] [stdout] test tests::passes::quantifier_bounds::tests::succ_compound ... ok
[INFO] [stdout] test tests::passes::quantifier_bounds::tests::bounds_from_forall_nats_not_negative ... ok
[INFO] [stdout] test tests::passes::module_instantiation::tests::test_module_instantiation ... ok
[INFO] [stdout] test tests::programs::parser::test_loops ... ok
[INFO] [stdout] test tests::programs::parser::test_isolates ... ok
[INFO] [stdout] test tests::programs::parser::test_append ... ok
[INFO] [stdout] test tests::programs::parser::test_safety_and_invariants ... ok
[INFO] [stdout] test tests::parser::statements::tests::parse_assign_to_field ... ok
[INFO] [stdout] test tests::passes::quantifier_bounds::tests::op_on_logicsym ... ok
[INFO] [stdout] test tests::programs::parser::test_modules ... ok
[INFO] [stdout] test tests::typechecker::actions::tests::action_assign_logical ... ok
[INFO] [stdout] test tests::programs::parser::test_state_and_actions ... ok
[INFO] [stdout] test tests::typechecker::actions::tests::action_assign ... ok
[INFO] [stdout] test tests::typechecker::actions::tests::action_call_curry_this ... ok
[INFO] [stdout] test tests::typechecker::actions::tests::action_before_after ... ok
[INFO] [stdout] test tests::programs::parser::test_noninf1 ... ok
[INFO] [stdout] test tests::typechecker::actions::tests::action_call_unary ... ok
[INFO] [stdout] test tests::typechecker::actions::tests::action_forward_ref ... ok
[INFO] [stdout] test tests::typechecker::actions::tests::action_nullary_application ... ok
[INFO] [stdout] test tests::typechecker::actions::tests::action_read_relation_logical ... ok
[INFO] [stdout] test tests::typechecker::actions::tests::action_read_relation ... ok
[INFO] [stdout] test tests::typechecker::actions::tests::ident_action_decl ... ok
[INFO] [stdout] test tests::typechecker::actions::tests::action_call_nullary_action ... ok
[INFO] [stdout] test tests::typechecker::actions::tests::action_nullary_application_opaque_ret_sort ... ok
[INFO] [stdout] test tests::typechecker::actions::tests::local_vardecl ... ok
[INFO] [stdout] test tests::typechecker::actions::tests::inconsistent_mixin ... ok
[INFO] [stdout] test tests::typechecker::actions::tests::local_vardecl_and_init ... 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::actions::tests::noop_action_decl ... ok
[INFO] [stdout] test tests::typechecker::actions::tests::noop_action_decl_with_local ... 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::ensure_bad ... ok
[INFO] [stdout] test tests::typechecker::declarations::tests::ensure_quantified ... ok
[INFO] [stdout] test tests::typechecker::declarations::tests::declblock ... ok
[INFO] [stdout] test tests::typechecker::actions::tests::implicit_nullary_action_call ... ok
[INFO] [stdout] test tests::typechecker::declarations::tests::function_interpreted ... 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::relation_decl_unannotated ... ok
[INFO] [stdout] test tests::typechecker::declarations::tests::relation_decl_annotated ... 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::require_bad ... 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::var_redefinition ... ok
[INFO] [stdout] test tests::typechecker::declarations::tests::vardecl_inferred ... ok
[INFO] [stdout] test tests::typechecker::declarations::tests::vardecl_annotated ... ok
[INFO] [stdout] test tests::typechecker::declarations::tests::typedecl_range ... 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::expressions::tests::test_call_parameterized_obj_invalid_parameter ... ok
[INFO] [stdout] test tests::typechecker::expressions::tests::test_call_resolved ... ok
[INFO] [stdout] test tests::typechecker::expressions::tests::test_call_unresolved ... ok
[INFO] [stdout] test tests::typechecker::expressions::tests::test_eq_binop ... ok
[INFO] [stdout] test tests::programs::accord::typecheck_abstract_protocol ... FAILED
[INFO] [stdout] test tests::typechecker::expressions::tests::test_invalid_numeric_binop ... ok
[INFO] [stdout] test tests::programs::accord::typecheck_sorts ... FAILED
[INFO] [stdout] test tests::programs::accord::typecheck_messages ... FAILED
[INFO] [stdout] test tests::typechecker::expressions::tests::test_lt_binop ... ok
[INFO] [stdout] test tests::programs::accord::typecheck_protocol ... FAILED
[INFO] [stdout] test tests::typechecker::expressions::tests::test_numeric_binop ... ok
[INFO] [stdout] test tests::typechecker::expressions::tests::test_ident ... ok
[INFO] [stdout] test tests::typechecker::expressions::tests::test_unary_op ... ok
[INFO] [stdout] test tests::typechecker::expressions::tests::test_unbound_this ... ok
[INFO] [stdout] test tests::typechecker::formulas::tests::universal_quant_annotated ... ok
[INFO] [stdout] test tests::typechecker::formulas::tests::nested_quants ... ok
[INFO] [stdout] test tests::typechecker::formulas::tests::progterm_in_fmls ... ok
[INFO] [stdout] test tests::programs::accord::typecheck_txn ... FAILED
[INFO] [stdout] test tests::typechecker::formulas::tests::universal_quant ... ok
[INFO] [stdout] test tests::typechecker::mixins::tests::test_action_and_impl ... ok
[INFO] [stdout] test tests::typechecker::mixins::tests::test_action_and_impl_identical_sigs ... ok
[INFO] [stdout] test tests::programs::accord::typecheck_temporality ... FAILED
[INFO] [stdout] test tests::typechecker::modules::tests::instantiation_with_overloaded_numerals ... ok
[INFO] [stdout] test tests::typechecker::mixins::tests::test_action_and_impl_different_sorts ... ok
[INFO] [stdout] test tests::typechecker::expressions::tests::test_field_access_call ... ok
[INFO] [stdout] test tests::typechecker::modules::tests::module_extraction ... ok
[INFO] [stdout] test tests::typechecker::modules::tests::instantiation_with_invalid_overloaded_numerals ... ok
[INFO] [stdout] test tests::typechecker::modules::tests::test_after_init ... ok
[INFO] [stdout] test tests::typechecker::modules::tests::test_empty_module ... ok
[INFO] [stdout] test tests::typechecker::modules::tests::test_mod_bind_and_alias_this ... ok
[INFO] [stdout] test tests::typechecker::modules::tests::multimod_instantiation ... ok
[INFO] [stdout] test tests::typechecker::modules::tests::test_mod_actions ... ok
[INFO] [stdout] test tests::typechecker::mixins::tests::test_action_and_impl_rebound_sigs ... ok
[INFO] [stdout] test tests::typechecker::processes::tests::empty_process ... ok
[INFO] [stdout] test tests::typechecker::processes::tests::proc_with_implicit_impl ... ok
[INFO] [stdout] test tests::typechecker::modules::tests::module_multiple_instantiations ... ok
[INFO] [stdout] test tests::typechecker::processes::tests::parameterized_obj_index ... ok
[INFO] [stdout] test tests::parser::formulas::tests::parse_universal_quant2 ... ok
[INFO] [stdout] test tests::parser::mixins::tests::parse_action_decl_no_ret_but_body ... ok
[INFO] [stdout] test tests::parser::statements::tests::parse_if_stmt_with_else ... ok
[INFO] [stdout] test tests::typechecker::processes::tests::parameterized_object_index ... ok
[INFO] [stdout] test tests::typechecker::declarations::tests::typedecl_uninterp ... ok
[INFO] [stdout] test tests::typechecker::expressions::tests::test_field_access ... ok
[INFO] [stdout] test tests::typechecker::processes::tests::proc_with_params ... ok
[INFO] [stdout] test tests::typechecker::processes::tests::append1_host ... ok
[INFO] [stdout] test tests::typechecker::resolver::tests::fresh_sortvars ... ok
[INFO] [stdout] test tests::typechecker::resolver::tests::fresh_sortvar_consistent_mapping ... ok
[INFO] [stdout] test tests::typechecker::resolver::tests::sortvar_unification ... ok
[INFO] [stdout] test tests::typechecker::resolver::tests::test_path_lookup ... ok
[INFO] [stdout] test tests::typechecker::processes::tests::relation_bad_inference ... ok
[INFO] [stdout] test tests::typechecker::processes::tests::relation_inference_bad_arity ... ok
[INFO] [stdout] test tests::typechecker::processes::tests::relation_logical_assign ... 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::logical_assign ... ok
[INFO] [stdout] test tests::typechecker::statements::tests::while_valid ... ok
[INFO] [stdout] test tests::typechecker::resolver::tests::test_nonrecord_lookup ... ok
[INFO] [stdout] test tests::typechecker::processes::tests::proc_with_local_var ... ok
[INFO] [stdout] test tests::typechecker::processes::tests::process_with_ghost_state_assign_lhs ... ok
[INFO] [stdout] test tests::typechecker::subst::tests::uninterpreted_type_resolution ... ok
[INFO] [stdout] test tests::typechecker::processes::tests::relation_inference ... 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::typechecker::resolver::tests::generic_unification ... ok
[INFO] [stdout] test tests::typechecker::statements::tests::if_valid ... ok
[INFO] [stdout] test tests::extraction::java::tests::extract_module_instantation ... FAILED
[INFO] [stdout] test tests::typechecker::processes::tests::relation_inference_bad_assign ... ok
[INFO] [stdout] test tests::typechecker::modules::tests::instantiation_with_impl_spec_blocks ... FAILED
[INFO] [stdout] test typechecker::programs::parser::typecheck_001_state_and_actions ... ok
[INFO] [stdout] test tests::stdlib::tests::typecheck ... ok
[INFO] [stdout] test typechecker::programs::typechecker::typecheck_202_pingpong ... 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::typechecker::typecheck_200_trivial_chainrep ... ok
[INFO] [stdout] test typechecker::programs::typechecker::typecheck_101_append2 ... ok
[INFO] [stdout] test typechecker::programs::extraction::extract_200_trivial_chainrep ... ok
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- tests::programs::accord::typecheck_abstract_protocol stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'tests::programs::accord::typecheck_abstract_protocol' (190) 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:     0x5796c9ea4632 - std::backtrace_rs::backtrace::libunwind::trace::hf0bd46b30bc61685
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x5796c9ea4632 - std::backtrace_rs::backtrace::trace_unsynchronized::h1d1fbb72ad89d7b7
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x5796c9ea4632 - std::sys::backtrace::_print_fmt::he38b6f68ca847f47
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x5796c9ea4632 - <std::sys::backtrace::BacktraceLock::print::DisplayBacktrace as core::fmt::Display>::fmt::hb7e843cde1bc81a3
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x5796c9eb52fa - core::fmt::rt::Argument::fmt::hc1dd77ac64f2688c
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x5796c9eb52fa - core::fmt::write::h952c506e2dbe9cff
[INFO] [stdout]    6:     0x5796c9e729b6 - std::io::default_write_fmt::hd23bd8145c03a23a
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/io/mod.rs:639:11
[INFO] [stdout]    7:     0x5796c9e729b6 - std::io::Write::write_fmt::hdd3314a2bd8a34bd
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/io/mod.rs:1994:13
[INFO] [stdout]    8:     0x5796c9e837d9 - std::sys::backtrace::BacktraceLock::print::h1079b82381c2c252
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x5796c9e837d9 - std::panicking::default_hook::{{closure}}::h85cb76b8462c00f2
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x5796c9e83671 - std::panicking::default_hook::h0134d220cc034c02
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x5796c9e3127e - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::hb2e68dca3970e3ca
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/alloc/src/boxed.rs:2220:9
[INFO] [stdout]   12:     0x5796c9e3127e - test::test_main_with_exit_callback::{{closure}}::ha7ec2063a2565ec3
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:145:21
[INFO] [stdout]   13:     0x5796c9e83a52 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::haebee478d0f56cf4
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/alloc/src/boxed.rs:2220:9
[INFO] [stdout]   14:     0x5796c9e83a52 - std::panicking::panic_with_hook::h8119b6db1fef734f
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x5796c9e83898 - std::panicking::panic_handler::{{closure}}::h24f5360b91482c0e
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x5796c9e7e5a9 - std::sys::backtrace::__rust_end_short_backtrace::h4e60c5cbd1bd0108
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x5796c9e66ddd - __rustc[e4c6931bd8050421]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x5796c9ebd92c - core::panicking::panic_fmt::hb1614a3ff6840071
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x5796c9ebcf02 - core::result::unwrap_failed::h7d4c34940aded59c
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/result.rs:1867:5
[INFO] [stdout]   20:     0x5796c9a92fed - core::result::Result<T,E>::unwrap::h3009e3e1ee9d770c
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/result.rs:1233:23
[INFO] [stdout]   21:     0x5796c9a92fed - irving::tests::helpers::typeinference_from_filename::h8150b4c83c671f54
[INFO] [stdout]                                at /opt/rustwide/workdir/src/tests/mod.rs:108:51
[INFO] [stdout]   22:     0x5796c9b0c14a - irving::tests::programs::accord::typecheck_abstract_protocol::h0b285a1761cfe359
[INFO] [stdout]                                at /opt/rustwide/workdir/src/tests/programs.rs:53:13
[INFO] [stdout]   23:     0x5796c9b0c177 - irving::tests::programs::accord::typecheck_abstract_protocol::{{closure}}::hadcb5866b6eefac8
[INFO] [stdout]                                at /opt/rustwide/workdir/src/tests/programs.rs:51:37
[INFO] [stdout]   24:     0x5796c99c8e46 - core::ops::function::FnOnce::call_once::h34c47bebe5542c92
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x5796c9e3107b - core::ops::function::FnOnce::call_once::hefaf63600cd43d2a
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   26:     0x5796c9e3107b - test::__rust_begin_short_backtrace::he30322a73a0e9ea6
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:663:18
[INFO] [stdout]   27:     0x5796c9e44a4a - test::run_test_in_process::{{closure}}::hdea3ab8d0243ef36
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:686:74
[INFO] [stdout]   28:     0x5796c9e44a4a - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h66d192f42498ffce
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/panic/unwind_safe.rs:274:9
[INFO] [stdout]   29:     0x5796c9e44a4a - std::panicking::catch_unwind::do_call::h822e18e8d3a6bb65
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:581:40
[INFO] [stdout]   30:     0x5796c9e44a4a - std::panicking::catch_unwind::h54b1de7ceab578bf
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:544:19
[INFO] [stdout]   31:     0x5796c9e44a4a - std::panic::catch_unwind::h60c29b7a9d0246b1
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panic.rs:359:14
[INFO] [stdout]   32:     0x5796c9e44a4a - test::run_test_in_process::h6099b5f871379b13
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:686:27
[INFO] [stdout]   33:     0x5796c9e44a4a - test::run_test::{{closure}}::h926ce0a38281a4c8
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:607:43
[INFO] [stdout]   34:     0x5796c9e1eea4 - test::run_test::{{closure}}::h508de21a9afc7140
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:637:41
[INFO] [stdout]   35:     0x5796c9e1eea4 - std::sys::backtrace::__rust_begin_short_backtrace::h6e2f5c39ca00735a
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   36:     0x5796c9e22762 - std::thread::lifecycle::spawn_unchecked::{{closure}}::{{closure}}::h133e44f0e5802c14
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/thread/lifecycle.rs:91:13
[INFO] [stdout]   37:     0x5796c9e22762 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h4718c1285283955c
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/panic/unwind_safe.rs:274:9
[INFO] [stdout]   38:     0x5796c9e22762 - std::panicking::catch_unwind::do_call::h0bba3937b4892238
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:581:40
[INFO] [stdout]   39:     0x5796c9e22762 - std::panicking::catch_unwind::h5b31cab5fb8c5d7f
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:544:19
[INFO] [stdout]   40:     0x5796c9e22762 - std::panic::catch_unwind::hb2fa05d52ed0124e
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panic.rs:359:14
[INFO] [stdout]   41:     0x5796c9e22762 - std::thread::lifecycle::spawn_unchecked::{{closure}}::hf401cf5ff501bd29
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/thread/lifecycle.rs:89:26
[INFO] [stdout]   42:     0x5796c9e22762 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h160022e94ce3b0bb
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   43:     0x5796c9e7983f - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::hf234e0d1d1d272ba
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/alloc/src/boxed.rs:2206:9
[INFO] [stdout]   44:     0x5796c9e7983f - std::sys::thread::unix::Thread::new::thread_start::h106a295241840d3b
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/thread/unix.rs:127:17
[INFO] [stdout]   45:     0x7e896d617aa4 - <unknown>
[INFO] [stdout]   46:     0x7e896d6a4a64 - 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' (193) 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:     0x5796c9ea4632 - std::backtrace_rs::backtrace::libunwind::trace::hf0bd46b30bc61685
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x5796c9ea4632 - std::backtrace_rs::backtrace::trace_unsynchronized::h1d1fbb72ad89d7b7
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x5796c9ea4632 - std::sys::backtrace::_print_fmt::he38b6f68ca847f47
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x5796c9ea4632 - <std::sys::backtrace::BacktraceLock::print::DisplayBacktrace as core::fmt::Display>::fmt::hb7e843cde1bc81a3
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x5796c9eb52fa - core::fmt::rt::Argument::fmt::hc1dd77ac64f2688c
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x5796c9eb52fa - core::fmt::write::h952c506e2dbe9cff
[INFO] [stdout]    6:     0x5796c9e729b6 - std::io::default_write_fmt::hd23bd8145c03a23a
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/io/mod.rs:639:11
[INFO] [stdout]    7:     0x5796c9e729b6 - std::io::Write::write_fmt::hdd3314a2bd8a34bd
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/io/mod.rs:1994:13
[INFO] [stdout]    8:     0x5796c9e837d9 - std::sys::backtrace::BacktraceLock::print::h1079b82381c2c252
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x5796c9e837d9 - std::panicking::default_hook::{{closure}}::h85cb76b8462c00f2
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x5796c9e83671 - std::panicking::default_hook::h0134d220cc034c02
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x5796c9e3127e - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::hb2e68dca3970e3ca
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/alloc/src/boxed.rs:2220:9
[INFO] [stdout]   12:     0x5796c9e3127e - test::test_main_with_exit_callback::{{closure}}::ha7ec2063a2565ec3
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:145:21
[INFO] [stdout]   13:     0x5796c9e83a52 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::haebee478d0f56cf4
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/alloc/src/boxed.rs:2220:9
[INFO] [stdout]   14:     0x5796c9e83a52 - std::panicking::panic_with_hook::h8119b6db1fef734f
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x5796c9e83898 - std::panicking::panic_handler::{{closure}}::h24f5360b91482c0e
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x5796c9e7e5a9 - std::sys::backtrace::__rust_end_short_backtrace::h4e60c5cbd1bd0108
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x5796c9e66ddd - __rustc[e4c6931bd8050421]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x5796c9ebd92c - core::panicking::panic_fmt::hb1614a3ff6840071
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x5796c9ebcf02 - core::result::unwrap_failed::h7d4c34940aded59c
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/result.rs:1867:5
[INFO] [stdout]   20:     0x5796c9a92fed - core::result::Result<T,E>::unwrap::h3009e3e1ee9d770c
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/result.rs:1233:23
[INFO] [stdout]   21:     0x5796c9a92fed - irving::tests::helpers::typeinference_from_filename::h8150b4c83c671f54
[INFO] [stdout]                                at /opt/rustwide/workdir/src/tests/mod.rs:108:51
[INFO] [stdout]   22:     0x5796c9b0bfca - irving::tests::programs::accord::typecheck_sorts::h81f60062503ef72a
[INFO] [stdout]                                at /opt/rustwide/workdir/src/tests/programs.rs:63:20
[INFO] [stdout]   23:     0x5796c9b0bff7 - irving::tests::programs::accord::typecheck_sorts::{{closure}}::hee3ad35649036294
[INFO] [stdout]                                at /opt/rustwide/workdir/src/tests/programs.rs:62:25
[INFO] [stdout]   24:     0x5796c99cb9c6 - core::ops::function::FnOnce::call_once::haf2c2d07f457b911
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x5796c9e3107b - core::ops::function::FnOnce::call_once::hefaf63600cd43d2a
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   26:     0x5796c9e3107b - test::__rust_begin_short_backtrace::he30322a73a0e9ea6
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:663:18
[INFO] [stdout]   27:     0x5796c9e44a4a - test::run_test_in_process::{{closure}}::hdea3ab8d0243ef36
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:686:74
[INFO] [stdout]   28:     0x5796c9e44a4a - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h66d192f42498ffce
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/panic/unwind_safe.rs:274:9
[INFO] [stdout]   29:     0x5796c9e44a4a - std::panicking::catch_unwind::do_call::h822e18e8d3a6bb65
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:581:40
[INFO] [stdout]   30:     0x5796c9e44a4a - std::panicking::catch_unwind::h54b1de7ceab578bf
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:544:19
[INFO] [stdout]   31:     0x5796c9e44a4a - std::panic::catch_unwind::h60c29b7a9d0246b1
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panic.rs:359:14
[INFO] [stdout]   32:     0x5796c9e44a4a - test::run_test_in_process::h6099b5f871379b13
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:686:27
[INFO] [stdout]   33:     0x5796c9e44a4a - test::run_test::{{closure}}::h926ce0a38281a4c8
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:607:43
[INFO] [stderr] error: test failed, to rerun pass `--lib`
[INFO] [stdout]   34:     0x5796c9e1eea4 - test::run_test::{{closure}}::h508de21a9afc7140
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:637:41
[INFO] [stdout]   35:     0x5796c9e1eea4 - std::sys::backtrace::__rust_begin_short_backtrace::h6e2f5c39ca00735a
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   36:     0x5796c9e22762 - std::thread::lifecycle::spawn_unchecked::{{closure}}::{{closure}}::h133e44f0e5802c14
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/thread/lifecycle.rs:91:13
[INFO] [stdout]   37:     0x5796c9e22762 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h4718c1285283955c
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/panic/unwind_safe.rs:274:9
[INFO] [stdout]   38:     0x5796c9e22762 - std::panicking::catch_unwind::do_call::h0bba3937b4892238
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:581:40
[INFO] [stdout]   39:     0x5796c9e22762 - std::panicking::catch_unwind::h5b31cab5fb8c5d7f
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:544:19
[INFO] [stdout]   40:     0x5796c9e22762 - std::panic::catch_unwind::hb2fa05d52ed0124e
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panic.rs:359:14
[INFO] [stdout]   41:     0x5796c9e22762 - std::thread::lifecycle::spawn_unchecked::{{closure}}::hf401cf5ff501bd29
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/thread/lifecycle.rs:89:26
[INFO] [stdout]   42:     0x5796c9e22762 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h160022e94ce3b0bb
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   43:     0x5796c9e7983f - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::hf234e0d1d1d272ba
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/alloc/src/boxed.rs:2206:9
[INFO] [stdout]   44:     0x5796c9e7983f - std::sys::thread::unix::Thread::new::thread_start::h106a295241840d3b
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/thread/unix.rs:127:17
[INFO] [stdout]   45:     0x7e896d617aa4 - <unknown>
[INFO] [stdout]   46:     0x7e896d6a4a64 - 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' (191) 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:     0x5796c9ea4632 - std::backtrace_rs::backtrace::libunwind::trace::hf0bd46b30bc61685
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x5796c9ea4632 - std::backtrace_rs::backtrace::trace_unsynchronized::h1d1fbb72ad89d7b7
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x5796c9ea4632 - std::sys::backtrace::_print_fmt::he38b6f68ca847f47
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x5796c9ea4632 - <std::sys::backtrace::BacktraceLock::print::DisplayBacktrace as core::fmt::Display>::fmt::hb7e843cde1bc81a3
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x5796c9eb52fa - core::fmt::rt::Argument::fmt::hc1dd77ac64f2688c
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x5796c9eb52fa - core::fmt::write::h952c506e2dbe9cff
[INFO] [stdout]    6:     0x5796c9e729b6 - std::io::default_write_fmt::hd23bd8145c03a23a
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/io/mod.rs:639:11
[INFO] [stdout]    7:     0x5796c9e729b6 - std::io::Write::write_fmt::hdd3314a2bd8a34bd
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/io/mod.rs:1994:13
[INFO] [stdout]    8:     0x5796c9e837d9 - std::sys::backtrace::BacktraceLock::print::h1079b82381c2c252
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x5796c9e837d9 - std::panicking::default_hook::{{closure}}::h85cb76b8462c00f2
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x5796c9e83671 - std::panicking::default_hook::h0134d220cc034c02
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x5796c9e3127e - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::hb2e68dca3970e3ca
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/alloc/src/boxed.rs:2220:9
[INFO] [stdout]   12:     0x5796c9e3127e - test::test_main_with_exit_callback::{{closure}}::ha7ec2063a2565ec3
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:145:21
[INFO] [stdout]   13:     0x5796c9e83a52 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::haebee478d0f56cf4
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/alloc/src/boxed.rs:2220:9
[INFO] [stdout]   14:     0x5796c9e83a52 - std::panicking::panic_with_hook::h8119b6db1fef734f
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x5796c9e83898 - std::panicking::panic_handler::{{closure}}::h24f5360b91482c0e
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x5796c9e7e5a9 - std::sys::backtrace::__rust_end_short_backtrace::h4e60c5cbd1bd0108
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x5796c9e66ddd - __rustc[e4c6931bd8050421]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x5796c9ebd92c - core::panicking::panic_fmt::hb1614a3ff6840071
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x5796c9ebcf02 - core::result::unwrap_failed::h7d4c34940aded59c
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/result.rs:1867:5
[INFO] [stdout]   20:     0x5796c9a92fed - core::result::Result<T,E>::unwrap::h3009e3e1ee9d770c
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/result.rs:1233:23
[INFO] [stdout]   21:     0x5796c9a92fed - irving::tests::helpers::typeinference_from_filename::h8150b4c83c671f54
[INFO] [stdout]                                at /opt/rustwide/workdir/src/tests/mod.rs:108:51
[INFO] [stdout]   22:     0x5796c9b0c02a - irving::tests::programs::accord::typecheck_messages::h301b90bab9fae14c
[INFO] [stdout]                                at /opt/rustwide/workdir/src/tests/programs.rs:58:20
[INFO] [stdout]   23:     0x5796c9b0c057 - irving::tests::programs::accord::typecheck_messages::{{closure}}::h7a77d66e21cbc1fe
[INFO] [stdout]                                at /opt/rustwide/workdir/src/tests/programs.rs:57:28
[INFO] [stdout]   24:     0x5796c99c9cc6 - core::ops::function::FnOnce::call_once::h5d95a09b141ee182
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x5796c9e3107b - core::ops::function::FnOnce::call_once::hefaf63600cd43d2a
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   26:     0x5796c9e3107b - test::__rust_begin_short_backtrace::he30322a73a0e9ea6
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:663:18
[INFO] [stdout]   27:     0x5796c9e44a4a - test::run_test_in_process::{{closure}}::hdea3ab8d0243ef36
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:686:74
[INFO] [stdout]   28:     0x5796c9e44a4a - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h66d192f42498ffce
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/panic/unwind_safe.rs:274:9
[INFO] [stdout]   29:     0x5796c9e44a4a - std::panicking::catch_unwind::do_call::h822e18e8d3a6bb65
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:581:40
[INFO] [stdout]   30:     0x5796c9e44a4a - std::panicking::catch_unwind::h54b1de7ceab578bf
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:544:19
[INFO] [stdout]   31:     0x5796c9e44a4a - std::panic::catch_unwind::h60c29b7a9d0246b1
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panic.rs:359:14
[INFO] [stdout]   32:     0x5796c9e44a4a - test::run_test_in_process::h6099b5f871379b13
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:686:27
[INFO] [stdout]   33:     0x5796c9e44a4a - test::run_test::{{closure}}::h926ce0a38281a4c8
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:607:43
[INFO] [stdout]   34:     0x5796c9e1eea4 - test::run_test::{{closure}}::h508de21a9afc7140
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:637:41
[INFO] [stdout]   35:     0x5796c9e1eea4 - std::sys::backtrace::__rust_begin_short_backtrace::h6e2f5c39ca00735a
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   36:     0x5796c9e22762 - std::thread::lifecycle::spawn_unchecked::{{closure}}::{{closure}}::h133e44f0e5802c14
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/thread/lifecycle.rs:91:13
[INFO] [stdout]   37:     0x5796c9e22762 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h4718c1285283955c
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/panic/unwind_safe.rs:274:9
[INFO] [stdout]   38:     0x5796c9e22762 - std::panicking::catch_unwind::do_call::h0bba3937b4892238
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:581:40
[INFO] [stdout]   39:     0x5796c9e22762 - std::panicking::catch_unwind::h5b31cab5fb8c5d7f
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:544:19
[INFO] [stdout]   40:     0x5796c9e22762 - std::panic::catch_unwind::hb2fa05d52ed0124e
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panic.rs:359:14
[INFO] [stdout]   41:     0x5796c9e22762 - std::thread::lifecycle::spawn_unchecked::{{closure}}::hf401cf5ff501bd29
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/thread/lifecycle.rs:89:26
[INFO] [stdout]   42:     0x5796c9e22762 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h160022e94ce3b0bb
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   43:     0x5796c9e7983f - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::hf234e0d1d1d272ba
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/alloc/src/boxed.rs:2206:9
[INFO] [stdout]   44:     0x5796c9e7983f - std::sys::thread::unix::Thread::new::thread_start::h106a295241840d3b
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/thread/unix.rs:127:17
[INFO] [stdout]   45:     0x7e896d617aa4 - <unknown>
[INFO] [stdout]   46:     0x7e896d6a4a64 - 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' (192) 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:     0x5796c9ea4632 - std::backtrace_rs::backtrace::libunwind::trace::hf0bd46b30bc61685
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x5796c9ea4632 - std::backtrace_rs::backtrace::trace_unsynchronized::h1d1fbb72ad89d7b7
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x5796c9ea4632 - std::sys::backtrace::_print_fmt::he38b6f68ca847f47
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x5796c9ea4632 - <std::sys::backtrace::BacktraceLock::print::DisplayBacktrace as core::fmt::Display>::fmt::hb7e843cde1bc81a3
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x5796c9eb52fa - core::fmt::rt::Argument::fmt::hc1dd77ac64f2688c
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x5796c9eb52fa - core::fmt::write::h952c506e2dbe9cff
[INFO] [stdout]    6:     0x5796c9e729b6 - std::io::default_write_fmt::hd23bd8145c03a23a
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/io/mod.rs:639:11
[INFO] [stdout]    7:     0x5796c9e729b6 - std::io::Write::write_fmt::hdd3314a2bd8a34bd
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/io/mod.rs:1994:13
[INFO] [stdout]    8:     0x5796c9e837d9 - std::sys::backtrace::BacktraceLock::print::h1079b82381c2c252
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x5796c9e837d9 - std::panicking::default_hook::{{closure}}::h85cb76b8462c00f2
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x5796c9e83671 - std::panicking::default_hook::h0134d220cc034c02
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x5796c9e3127e - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::hb2e68dca3970e3ca
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/alloc/src/boxed.rs:2220:9
[INFO] [stdout]   12:     0x5796c9e3127e - test::test_main_with_exit_callback::{{closure}}::ha7ec2063a2565ec3
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:145:21
[INFO] [stdout]   13:     0x5796c9e83a52 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::haebee478d0f56cf4
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/alloc/src/boxed.rs:2220:9
[INFO] [stdout]   14:     0x5796c9e83a52 - std::panicking::panic_with_hook::h8119b6db1fef734f
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x5796c9e83898 - std::panicking::panic_handler::{{closure}}::h24f5360b91482c0e
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x5796c9e7e5a9 - std::sys::backtrace::__rust_end_short_backtrace::h4e60c5cbd1bd0108
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x5796c9e66ddd - __rustc[e4c6931bd8050421]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x5796c9ebd92c - core::panicking::panic_fmt::hb1614a3ff6840071
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x5796c9ebcf02 - core::result::unwrap_failed::h7d4c34940aded59c
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/result.rs:1867:5
[INFO] [stdout]   20:     0x5796c9a92fed - core::result::Result<T,E>::unwrap::h3009e3e1ee9d770c
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/result.rs:1233:23
[INFO] [stdout]   21:     0x5796c9a92fed - irving::tests::helpers::typeinference_from_filename::h8150b4c83c671f54
[INFO] [stdout]                                at /opt/rustwide/workdir/src/tests/mod.rs:108:51
[INFO] [stdout]   22:     0x5796c9b0c08a - irving::tests::programs::accord::typecheck_protocol::h6094b16314373a9d
[INFO] [stdout]                                at /opt/rustwide/workdir/src/tests/programs.rs:78:20
[INFO] [stdout]   23:     0x5796c9b0c0b7 - irving::tests::programs::accord::typecheck_protocol::{{closure}}::hf45c06cdb6e9c71e
[INFO] [stdout]                                at /opt/rustwide/workdir/src/tests/programs.rs:77:28
[INFO] [stdout]   24:     0x5796c99cadd6 - core::ops::function::FnOnce::call_once::h8c3c280bdcf78fbf
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x5796c9e3107b - core::ops::function::FnOnce::call_once::hefaf63600cd43d2a
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   26:     0x5796c9e3107b - test::__rust_begin_short_backtrace::he30322a73a0e9ea6
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:663:18
[INFO] [stdout]   27:     0x5796c9e44a4a - test::run_test_in_process::{{closure}}::hdea3ab8d0243ef36
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:686:74
[INFO] [stdout]   28:     0x5796c9e44a4a - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h66d192f42498ffce
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/panic/unwind_safe.rs:274:9
[INFO] [stdout]   29:     0x5796c9e44a4a - std::panicking::catch_unwind::do_call::h822e18e8d3a6bb65
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:581:40
[INFO] [stdout]   30:     0x5796c9e44a4a - std::panicking::catch_unwind::h54b1de7ceab578bf
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:544:19
[INFO] [stdout]   31:     0x5796c9e44a4a - std::panic::catch_unwind::h60c29b7a9d0246b1
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panic.rs:359:14
[INFO] [stdout]   32:     0x5796c9e44a4a - test::run_test_in_process::h6099b5f871379b13
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:686:27
[INFO] [stdout]   33:     0x5796c9e44a4a - test::run_test::{{closure}}::h926ce0a38281a4c8
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:607:43
[INFO] [stdout]   34:     0x5796c9e1eea4 - test::run_test::{{closure}}::h508de21a9afc7140
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:637:41
[INFO] [stdout]   35:     0x5796c9e1eea4 - std::sys::backtrace::__rust_begin_short_backtrace::h6e2f5c39ca00735a
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   36:     0x5796c9e22762 - std::thread::lifecycle::spawn_unchecked::{{closure}}::{{closure}}::h133e44f0e5802c14
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/thread/lifecycle.rs:91:13
[INFO] [stdout]   37:     0x5796c9e22762 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h4718c1285283955c
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/panic/unwind_safe.rs:274:9
[INFO] [stdout]   38:     0x5796c9e22762 - std::panicking::catch_unwind::do_call::h0bba3937b4892238
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:581:40
[INFO] [stdout]   39:     0x5796c9e22762 - std::panicking::catch_unwind::h5b31cab5fb8c5d7f
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:544:19
[INFO] [stdout]   40:     0x5796c9e22762 - std::panic::catch_unwind::hb2fa05d52ed0124e
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panic.rs:359:14
[INFO] [stdout]   41:     0x5796c9e22762 - std::thread::lifecycle::spawn_unchecked::{{closure}}::hf401cf5ff501bd29
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/thread/lifecycle.rs:89:26
[INFO] [stdout]   42:     0x5796c9e22762 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h160022e94ce3b0bb
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   43:     0x5796c9e7983f - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::hf234e0d1d1d272ba
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/alloc/src/boxed.rs:2206:9
[INFO] [stdout]   44:     0x5796c9e7983f - std::sys::thread::unix::Thread::new::thread_start::h106a295241840d3b
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/thread/unix.rs:127:17
[INFO] [stdout]   45:     0x7e896d617aa4 - <unknown>
[INFO] [stdout]   46:     0x7e896d6a4a64 - 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' (195) 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:     0x5796c9ea4632 - std::backtrace_rs::backtrace::libunwind::trace::hf0bd46b30bc61685
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x5796c9ea4632 - std::backtrace_rs::backtrace::trace_unsynchronized::h1d1fbb72ad89d7b7
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x5796c9ea4632 - std::sys::backtrace::_print_fmt::he38b6f68ca847f47
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x5796c9ea4632 - <std::sys::backtrace::BacktraceLock::print::DisplayBacktrace as core::fmt::Display>::fmt::hb7e843cde1bc81a3
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x5796c9eb52fa - core::fmt::rt::Argument::fmt::hc1dd77ac64f2688c
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x5796c9eb52fa - core::fmt::write::h952c506e2dbe9cff
[INFO] [stdout]    6:     0x5796c9e729b6 - std::io::default_write_fmt::hd23bd8145c03a23a
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/io/mod.rs:639:11
[INFO] [stdout]    7:     0x5796c9e729b6 - std::io::Write::write_fmt::hdd3314a2bd8a34bd
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/io/mod.rs:1994:13
[INFO] [stdout]    8:     0x5796c9e837d9 - std::sys::backtrace::BacktraceLock::print::h1079b82381c2c252
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x5796c9e837d9 - std::panicking::default_hook::{{closure}}::h85cb76b8462c00f2
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x5796c9e83671 - std::panicking::default_hook::h0134d220cc034c02
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x5796c9e3127e - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::hb2e68dca3970e3ca
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/alloc/src/boxed.rs:2220:9
[INFO] [stdout]   12:     0x5796c9e3127e - test::test_main_with_exit_callback::{{closure}}::ha7ec2063a2565ec3
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:145:21
[INFO] [stdout]   13:     0x5796c9e83a52 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::haebee478d0f56cf4
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/alloc/src/boxed.rs:2220:9
[INFO] [stdout]   14:     0x5796c9e83a52 - std::panicking::panic_with_hook::h8119b6db1fef734f
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x5796c9e83898 - std::panicking::panic_handler::{{closure}}::h24f5360b91482c0e
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x5796c9e7e5a9 - std::sys::backtrace::__rust_end_short_backtrace::h4e60c5cbd1bd0108
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x5796c9e66ddd - __rustc[e4c6931bd8050421]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x5796c9ebd92c - core::panicking::panic_fmt::hb1614a3ff6840071
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x5796c9ebcf02 - core::result::unwrap_failed::h7d4c34940aded59c
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/result.rs:1867:5
[INFO] [stdout]   20:     0x5796c9a92fed - core::result::Result<T,E>::unwrap::h3009e3e1ee9d770c
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/result.rs:1233:23
[INFO] [stdout]   21:     0x5796c9a92fed - irving::tests::helpers::typeinference_from_filename::h8150b4c83c671f54
[INFO] [stdout]                                at /opt/rustwide/workdir/src/tests/mod.rs:108:51
[INFO] [stdout]   22:     0x5796c9b0bf6a - irving::tests::programs::accord::typecheck_txn::hcbc7f4d3704211eb
[INFO] [stdout]                                at /opt/rustwide/workdir/src/tests/programs.rs:73:20
[INFO] [stdout]   23:     0x5796c9b0bf97 - irving::tests::programs::accord::typecheck_txn::{{closure}}::h5420723db08292cb
[INFO] [stdout]                                at /opt/rustwide/workdir/src/tests/programs.rs:72:23
[INFO] [stdout]   24:     0x5796c99cb2d6 - core::ops::function::FnOnce::call_once::h9db079fb9fe4138c
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x5796c9e3107b - core::ops::function::FnOnce::call_once::hefaf63600cd43d2a
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   26:     0x5796c9e3107b - test::__rust_begin_short_backtrace::he30322a73a0e9ea6
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:663:18
[INFO] [stdout]   27:     0x5796c9e44a4a - test::run_test_in_process::{{closure}}::hdea3ab8d0243ef36
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:686:74
[INFO] [stdout]   28:     0x5796c9e44a4a - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h66d192f42498ffce
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/panic/unwind_safe.rs:274:9
[INFO] [stdout]   29:     0x5796c9e44a4a - std::panicking::catch_unwind::do_call::h822e18e8d3a6bb65
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:581:40
[INFO] [stdout]   30:     0x5796c9e44a4a - std::panicking::catch_unwind::h54b1de7ceab578bf
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:544:19
[INFO] [stdout]   31:     0x5796c9e44a4a - std::panic::catch_unwind::h60c29b7a9d0246b1
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panic.rs:359:14
[INFO] [stdout]   32:     0x5796c9e44a4a - test::run_test_in_process::h6099b5f871379b13
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:686:27
[INFO] [stdout]   33:     0x5796c9e44a4a - test::run_test::{{closure}}::h926ce0a38281a4c8
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:607:43
[INFO] [stdout]   34:     0x5796c9e1eea4 - test::run_test::{{closure}}::h508de21a9afc7140
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:637:41
[INFO] [stdout]   35:     0x5796c9e1eea4 - std::sys::backtrace::__rust_begin_short_backtrace::h6e2f5c39ca00735a
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   36:     0x5796c9e22762 - std::thread::lifecycle::spawn_unchecked::{{closure}}::{{closure}}::h133e44f0e5802c14
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/thread/lifecycle.rs:91:13
[INFO] [stdout]   37:     0x5796c9e22762 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h4718c1285283955c
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/panic/unwind_safe.rs:274:9
[INFO] [stdout]   38:     0x5796c9e22762 - std::panicking::catch_unwind::do_call::h0bba3937b4892238
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:581:40
[INFO] [stdout]   39:     0x5796c9e22762 - std::panicking::catch_unwind::h5b31cab5fb8c5d7f
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:544:19
[INFO] [stdout]   40:     0x5796c9e22762 - std::panic::catch_unwind::hb2fa05d52ed0124e
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panic.rs:359:14
[INFO] [stdout]   41:     0x5796c9e22762 - std::thread::lifecycle::spawn_unchecked::{{closure}}::hf401cf5ff501bd29
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/thread/lifecycle.rs:89:26
[INFO] [stdout]   42:     0x5796c9e22762 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h160022e94ce3b0bb
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   43:     0x5796c9e7983f - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::hf234e0d1d1d272ba
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/alloc/src/boxed.rs:2206:9
[INFO] [stdout]   44:     0x5796c9e7983f - std::sys::thread::unix::Thread::new::thread_start::h106a295241840d3b
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/thread/unix.rs:127:17
[INFO] [stdout]   45:     0x7e896d617aa4 - <unknown>
[INFO] [stdout]   46:     0x7e896d6a4a64 - 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' (194) 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:     0x5796c9ea4632 - std::backtrace_rs::backtrace::libunwind::trace::hf0bd46b30bc61685
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x5796c9ea4632 - std::backtrace_rs::backtrace::trace_unsynchronized::h1d1fbb72ad89d7b7
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x5796c9ea4632 - std::sys::backtrace::_print_fmt::he38b6f68ca847f47
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x5796c9ea4632 - <std::sys::backtrace::BacktraceLock::print::DisplayBacktrace as core::fmt::Display>::fmt::hb7e843cde1bc81a3
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x5796c9eb52fa - core::fmt::rt::Argument::fmt::hc1dd77ac64f2688c
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x5796c9eb52fa - core::fmt::write::h952c506e2dbe9cff
[INFO] [stdout]    6:     0x5796c9e729b6 - std::io::default_write_fmt::hd23bd8145c03a23a
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/io/mod.rs:639:11
[INFO] [stdout]    7:     0x5796c9e729b6 - std::io::Write::write_fmt::hdd3314a2bd8a34bd
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/io/mod.rs:1994:13
[INFO] [stdout]    8:     0x5796c9e837d9 - std::sys::backtrace::BacktraceLock::print::h1079b82381c2c252
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x5796c9e837d9 - std::panicking::default_hook::{{closure}}::h85cb76b8462c00f2
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x5796c9e83671 - std::panicking::default_hook::h0134d220cc034c02
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x5796c9e3127e - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::hb2e68dca3970e3ca
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/alloc/src/boxed.rs:2220:9
[INFO] [stdout]   12:     0x5796c9e3127e - test::test_main_with_exit_callback::{{closure}}::ha7ec2063a2565ec3
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:145:21
[INFO] [stdout]   13:     0x5796c9e83a52 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::haebee478d0f56cf4
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/alloc/src/boxed.rs:2220:9
[INFO] [stdout]   14:     0x5796c9e83a52 - std::panicking::panic_with_hook::h8119b6db1fef734f
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x5796c9e83898 - std::panicking::panic_handler::{{closure}}::h24f5360b91482c0e
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x5796c9e7e5a9 - std::sys::backtrace::__rust_end_short_backtrace::h4e60c5cbd1bd0108
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x5796c9e66ddd - __rustc[e4c6931bd8050421]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x5796c9ebd92c - core::panicking::panic_fmt::hb1614a3ff6840071
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x5796c9ebcf02 - core::result::unwrap_failed::h7d4c34940aded59c
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/result.rs:1867:5
[INFO] [stdout]   20:     0x5796c9a92fed - core::result::Result<T,E>::unwrap::h3009e3e1ee9d770c
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/result.rs:1233:23
[INFO] [stdout]   21:     0x5796c9a92fed - irving::tests::helpers::typeinference_from_filename::h8150b4c83c671f54
[INFO] [stdout]                                at /opt/rustwide/workdir/src/tests/mod.rs:108:51
[INFO] [stdout]   22:     0x5796c9b0c0ea - irving::tests::programs::accord::typecheck_temporality::h58f9656d3568ed63
[INFO] [stdout]                                at /opt/rustwide/workdir/src/tests/programs.rs:68:20
[INFO] [stdout]   23:     0x5796c9b0c117 - irving::tests::programs::accord::typecheck_temporality::{{closure}}::h112aaed8c8a2ce84
[INFO] [stdout]                                at /opt/rustwide/workdir/src/tests/programs.rs:67:31
[INFO] [stdout]   24:     0x5796c99c94f6 - core::ops::function::FnOnce::call_once::h47bdf5fa97964a67
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x5796c9e3107b - core::ops::function::FnOnce::call_once::hefaf63600cd43d2a
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   26:     0x5796c9e3107b - test::__rust_begin_short_backtrace::he30322a73a0e9ea6
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:663:18
[INFO] [stdout]   27:     0x5796c9e44a4a - test::run_test_in_process::{{closure}}::hdea3ab8d0243ef36
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:686:74
[INFO] [stdout]   28:     0x5796c9e44a4a - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h66d192f42498ffce
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/panic/unwind_safe.rs:274:9
[INFO] [stdout]   29:     0x5796c9e44a4a - std::panicking::catch_unwind::do_call::h822e18e8d3a6bb65
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:581:40
[INFO] [stdout]   30:     0x5796c9e44a4a - std::panicking::catch_unwind::h54b1de7ceab578bf
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:544:19
[INFO] [stdout]   31:     0x5796c9e44a4a - std::panic::catch_unwind::h60c29b7a9d0246b1
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panic.rs:359:14
[INFO] [stdout]   32:     0x5796c9e44a4a - test::run_test_in_process::h6099b5f871379b13
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:686:27
[INFO] [stdout]   33:     0x5796c9e44a4a - test::run_test::{{closure}}::h926ce0a38281a4c8
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:607:43
[INFO] [stdout]   34:     0x5796c9e1eea4 - test::run_test::{{closure}}::h508de21a9afc7140
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:637:41
[INFO] [stdout]   35:     0x5796c9e1eea4 - std::sys::backtrace::__rust_begin_short_backtrace::h6e2f5c39ca00735a
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   36:     0x5796c9e22762 - std::thread::lifecycle::spawn_unchecked::{{closure}}::{{closure}}::h133e44f0e5802c14
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/thread/lifecycle.rs:91:13
[INFO] [stdout]   37:     0x5796c9e22762 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h4718c1285283955c
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/panic/unwind_safe.rs:274:9
[INFO] [stdout]   38:     0x5796c9e22762 - std::panicking::catch_unwind::do_call::h0bba3937b4892238
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:581:40
[INFO] [stdout]   39:     0x5796c9e22762 - std::panicking::catch_unwind::h5b31cab5fb8c5d7f
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:544:19
[INFO] [stdout]   40:     0x5796c9e22762 - std::panic::catch_unwind::hb2fa05d52ed0124e
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panic.rs:359:14
[INFO] [stdout]   41:     0x5796c9e22762 - std::thread::lifecycle::spawn_unchecked::{{closure}}::hf401cf5ff501bd29
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/thread/lifecycle.rs:89:26
[INFO] [stdout]   42:     0x5796c9e22762 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h160022e94ce3b0bb
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   43:     0x5796c9e7983f - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::hf234e0d1d1d272ba
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/alloc/src/boxed.rs:2206:9
[INFO] [stdout]   44:     0x5796c9e7983f - std::sys::thread::unix::Thread::new::thread_start::h106a295241840d3b
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/thread/unix.rs:127:17
[INFO] [stdout]   45:     0x7e896d617aa4 - <unknown>
[INFO] [stdout]   46:     0x7e896d6a4a64 - clone
[INFO] [stdout]   47:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- tests::extraction::java::tests::extract_module_instantation stdout ----
[INFO] [stdout] [2026-01-27T08:49:17Z TRACE visitor] Decl Source:0 ("module pair(t) = { ...)
[INFO] [stdout] [2026-01-27T08:49:17Z TRACE binding] Inserting pair:SortVar(0) into context (depth 1)
[INFO] [stdout] [2026-01-27T08:49:17Z TRACE binding] Inserting this:This into context (depth 2)
[INFO] [stdout] [2026-01-27T08:49:17Z TRACE binding] Inserting init:Action([], List([]), Unit, Instance) into context (depth 2)
[INFO] [stdout] [2026-01-27T08:49:17Z TRACE binding] Inserting t:Generic(1, "t") into context (depth 2)
[INFO] [stdout] [2026-01-27T08:49:17Z TRACE visitor] Decl Source:1 ("x: t...)
[INFO] [stdout] [2026-01-27T08:49:17Z TRACE binding] Inserting x:Generic(1, "t") into context (depth 2)
[INFO] [stdout] [2026-01-27T08:49:17Z DEBUG sort-inference] unify(Generic(1, "t"),Generic(1, "t"))
[INFO] [stdout] [2026-01-27T08:49:17Z TRACE visitor] Decl Source:2 ("y: t...)
[INFO] [stdout] [2026-01-27T08:49:17Z TRACE binding] Inserting y:Generic(1, "t") into context (depth 2)
[INFO] [stdout] [2026-01-27T08:49:17Z DEBUG sort-inference] unify(Generic(1, "t"),Generic(1, "t"))
[INFO] [stdout] [2026-01-27T08:49:17Z 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-01-27T08:49:17Z TRACE visitor] Decl Source:0 ("instance nat_pair : pair(nat)")
[INFO] [stdout] [2026-01-27T08:49:17Z TRACE binding] Inserting nat_pair:SortVar(2) into context (depth 1)
[INFO] [stdout] [2026-01-27T08:49:17Z DEBUG sort-inference] unify(Generic(3, "t"),Number)
[INFO] [stdout] [2026-01-27T08:49:17Z 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-01-27T08:49:17Z TRACE visitor] Decl Source:0 ("instance nat_pair : pair(nat)")
[INFO] [stdout] 
[INFO] [stdout] thread 'tests::extraction::java::tests::extract_module_instantation' (46) panicked at src/extraction/pprint.rs:29:13:
[INFO] [stdout] attempt to subtract with overflow
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5796c9ea4632 - std::backtrace_rs::backtrace::libunwind::trace::hf0bd46b30bc61685
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x5796c9ea4632 - std::backtrace_rs::backtrace::trace_unsynchronized::h1d1fbb72ad89d7b7
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x5796c9ea4632 - std::sys::backtrace::_print_fmt::he38b6f68ca847f47
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x5796c9ea4632 - <std::sys::backtrace::BacktraceLock::print::DisplayBacktrace as core::fmt::Display>::fmt::hb7e843cde1bc81a3
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x5796c9eb52fa - core::fmt::rt::Argument::fmt::hc1dd77ac64f2688c
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x5796c9eb52fa - core::fmt::write::h952c506e2dbe9cff
[INFO] [stdout]    6:     0x5796c9e729b6 - std::io::default_write_fmt::hd23bd8145c03a23a
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/io/mod.rs:639:11
[INFO] [stdout]    7:     0x5796c9e729b6 - std::io::Write::write_fmt::hdd3314a2bd8a34bd
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/io/mod.rs:1994:13
[INFO] [stdout]    8:     0x5796c9e837d9 - std::sys::backtrace::BacktraceLock::print::h1079b82381c2c252
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x5796c9e837d9 - std::panicking::default_hook::{{closure}}::h85cb76b8462c00f2
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x5796c9e83671 - std::panicking::default_hook::h0134d220cc034c02
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x5796c9e3127e - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::hb2e68dca3970e3ca
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/alloc/src/boxed.rs:2220:9
[INFO] [stdout]   12:     0x5796c9e3127e - test::test_main_with_exit_callback::{{closure}}::ha7ec2063a2565ec3
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:145:21
[INFO] [stdout]   13:     0x5796c9e83a52 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::haebee478d0f56cf4
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/alloc/src/boxed.rs:2220:9
[INFO] [stdout]   14:     0x5796c9e83a52 - std::panicking::panic_with_hook::h8119b6db1fef734f
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x5796c9e838ca - std::panicking::panic_handler::{{closure}}::h24f5360b91482c0e
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:691:13
[INFO] [stdout]   16:     0x5796c9e7e5a9 - std::sys::backtrace::__rust_end_short_backtrace::h4e60c5cbd1bd0108
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x5796c9e66ddd - __rustc[e4c6931bd8050421]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x5796c9ebd92c - core::panicking::panic_fmt::hb1614a3ff6840071
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x5796c9ebd5d9 - core::panicking::panic_const::panic_const_sub_overflow::h65ab8bb9d5c6a2db
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/panicking.rs:175:17
[INFO] [stdout]   20:     0x5796c9aeda36 - <irving::extraction::pprint::PrettyPrinter<W> as core::fmt::Write>::write_str::h4ae769120a1caeac
[INFO] [stdout]                                at /opt/rustwide/workdir/src/extraction/pprint.rs:29:13
[INFO] [stdout]   21:     0x5796c99fa337 - <irving::extraction::java::extraction::Extractor<W> as irving::visitor::ast::Visitor<(),core::fmt::Error>>::begin_instance_decl::hb2695ec086567e56
[INFO] [stdout]                                at /opt/rustwide/workdir/src/extraction/java/extraction.rs:378:17
[INFO] [stdout]   22:     0x5796c9a6b279 - <irving::ast::declarations::Decl as irving::visitor::ast::Visitable<T,E>>::visit::h32cddf022246ee66
[INFO] [stdout]                                at /opt/rustwide/workdir/src/visitor/ast.rs:1158:18
[INFO] [stdout]   23:     0x5796c9a7bcb8 - irving::tests::extraction::java::tests::extract_module_instantation::hf4eff22f3f3049ae
[INFO] [stdout]                                at /opt/rustwide/workdir/src/tests/extraction/java.rs:304:23
[INFO] [stdout]   24:     0x5796c9a7bdf7 - irving::tests::extraction::java::tests::extract_module_instantation::{{closure}}::heecbc80f95ff244a
[INFO] [stdout]                                at /opt/rustwide/workdir/src/tests/extraction/java.rs:291:37
[INFO] [stdout]   25:     0x5796c99c9046 - core::ops::function::FnOnce::call_once::h39a74b080dbf5b14
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   26:     0x5796c9e3107b - core::ops::function::FnOnce::call_once::hefaf63600cd43d2a
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   27:     0x5796c9e3107b - test::__rust_begin_short_backtrace::he30322a73a0e9ea6
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:663:18
[INFO] [stdout]   28:     0x5796c9e44a4a - test::run_test_in_process::{{closure}}::hdea3ab8d0243ef36
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:686:74
[INFO] [stdout]   29:     0x5796c9e44a4a - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h66d192f42498ffce
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/panic/unwind_safe.rs:274:9
[INFO] [stdout]   30:     0x5796c9e44a4a - std::panicking::catch_unwind::do_call::h822e18e8d3a6bb65
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:581:40
[INFO] [stdout]   31:     0x5796c9e44a4a - std::panicking::catch_unwind::h54b1de7ceab578bf
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:544:19
[INFO] [stdout]   32:     0x5796c9e44a4a - std::panic::catch_unwind::h60c29b7a9d0246b1
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panic.rs:359:14
[INFO] [stdout]   33:     0x5796c9e44a4a - test::run_test_in_process::h6099b5f871379b13
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:686:27
[INFO] [stdout]   34:     0x5796c9e44a4a - test::run_test::{{closure}}::h926ce0a38281a4c8
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:607:43
[INFO] [stdout]   35:     0x5796c9e1eea4 - test::run_test::{{closure}}::h508de21a9afc7140
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:637:41
[INFO] [stdout]   36:     0x5796c9e1eea4 - std::sys::backtrace::__rust_begin_short_backtrace::h6e2f5c39ca00735a
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   37:     0x5796c9e22762 - std::thread::lifecycle::spawn_unchecked::{{closure}}::{{closure}}::h133e44f0e5802c14
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/thread/lifecycle.rs:91:13
[INFO] [stdout]   38:     0x5796c9e22762 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h4718c1285283955c
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/panic/unwind_safe.rs:274:9
[INFO] [stdout]   39:     0x5796c9e22762 - std::panicking::catch_unwind::do_call::h0bba3937b4892238
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:581:40
[INFO] [stdout]   40:     0x5796c9e22762 - std::panicking::catch_unwind::h5b31cab5fb8c5d7f
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:544:19
[INFO] [stdout]   41:     0x5796c9e22762 - std::panic::catch_unwind::hb2fa05d52ed0124e
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panic.rs:359:14
[INFO] [stdout]   42:     0x5796c9e22762 - std::thread::lifecycle::spawn_unchecked::{{closure}}::hf401cf5ff501bd29
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/thread/lifecycle.rs:89:26
[INFO] [stdout]   43:     0x5796c9e22762 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h160022e94ce3b0bb
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   44:     0x5796c9e7983f - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::hf234e0d1d1d272ba
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/alloc/src/boxed.rs:2206:9
[INFO] [stdout]   45:     0x5796c9e7983f - std::sys::thread::unix::Thread::new::thread_start::h106a295241840d3b
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/thread/unix.rs:127:17
[INFO] [stdout]   46:     0x7e896d617aa4 - <unknown>
[INFO] [stdout]   47:     0x7e896d6a4a64 - clone
[INFO] [stdout]   48:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- tests::typechecker::modules::tests::instantiation_with_impl_spec_blocks stdout ----
[INFO] [stdout] [2026-01-27T08:49:17Z TRACE binding] Inserting top:SortVar(0) into context (depth 1)
[INFO] [stdout] [2026-01-27T08:49:17Z TRACE binding] Inserting init:Action([], List([]), Unit, Instance) into context (depth 2)
[INFO] [stdout] [2026-01-27T08:49:17Z TRACE visitor] Decl Source:2 ("module counter = {...)
[INFO] [stdout] [2026-01-27T08:49:17Z TRACE binding] Inserting counter:SortVar(1) into context (depth 2)
[INFO] [stdout] [2026-01-27T08:49:17Z TRACE binding] Inserting this:This into context (depth 3)
[INFO] [stdout] [2026-01-27T08:49:17Z TRACE binding] Inserting init:Action([], List([]), Unit, Instance) into context (depth 3)
[INFO] [stdout] [2026-01-27T08:49:17Z TRACE visitor] Decl Source:3 ("implementation {...)
[INFO] [stdout] [2026-01-27T08:49:17Z TRACE binding] Inserting impl:SortVar(2) into context (depth 3)
[INFO] [stdout] [2026-01-27T08:49:17Z TRACE binding] Inserting init:Action([], List([]), Unit, Instance) into context (depth 3)
[INFO] [stdout] [2026-01-27T08:49:17Z TRACE visitor] Decl Source:4 ("val : nat...)
[INFO] [stdout] [2026-01-27T08:49:17Z TRACE binding] Inserting val:Number into context (depth 3)
[INFO] [stdout] [2026-01-27T08:49:17Z DEBUG sort-inference] unify(Number,Number)
[INFO] [stdout] [2026-01-27T08:49:17Z TRACE visitor] Decl Source:5 ("after init { val := 0 }")
[INFO] [stdout] [2026-01-27T08:49:17Z TRACE visitor] Vec<Stmt> (len 1)
[INFO] [stdout] [2026-01-27T08:49:17Z TRACE visitor] Action Source:5 ("val := 0 ")
[INFO] [stdout] [2026-01-27T08:49:17Z TRACE visitor] Expr ProgramSymbol { sym: Binding { name: "val", decl: ToBeInferred, span: Source:5 ("val") } }
[INFO] [stdout] [2026-01-27T08:49:17Z TRACE visitor] Expr Number { span: Source:5 ("0"), val: 0 }
[INFO] [stdout] [2026-01-27T08:49:17Z DEBUG sort-inference] unify(Number,Number)
[INFO] [stdout] [2026-01-27T08:49:17Z DEBUG sort-inference] unify(Action([], List([]), Unit, Instance),SortVar(3))
[INFO] [stdout] [2026-01-27T08:49:17Z DEBUG sort-inference] unify(SortVar(2),Object(Object { args: [], fields: {"init": Action([], List([]), Unit, Instance), "val": Number} }))
[INFO] [stdout] [2026-01-27T08:49:17Z 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-01-27T08:49:17Z TRACE visitor] Decl Source:9 ("instance c : counter...)
[INFO] [stdout] [2026-01-27T08:49:17Z TRACE binding] Inserting c:SortVar(4) into context (depth 2)
[INFO] [stdout] [2026-01-27T08:49:17Z 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-01-27T08:49:17Z TRACE visitor] Decl Source:10 ("v : nat...)
[INFO] [stdout] [2026-01-27T08:49:17Z TRACE binding] Inserting v:Number into context (depth 2)
[INFO] [stdout] [2026-01-27T08:49:17Z DEBUG sort-inference] unify(Number,Number)
[INFO] [stdout] [2026-01-27T08:49:17Z TRACE visitor] Decl IgnoredForTesting
[INFO] [stdout] [2026-01-27T08:49:17Z TRACE visitor] Vec<Stmt> (len 1)
[INFO] [stdout] [2026-01-27T08:49:17Z 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-01-27T08:49:17Z TRACE visitor] Expr ProgramSymbol { sym: Binding { name: "v", decl: ToBeInferred, span: Source:11 ("v") } }
[INFO] [stdout] [2026-01-27T08:49:17Z 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-01-27T08:49:17Z 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' (270) 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:     0x5796c9ea4632 - std::backtrace_rs::backtrace::libunwind::trace::hf0bd46b30bc61685
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x5796c9ea4632 - std::backtrace_rs::backtrace::trace_unsynchronized::h1d1fbb72ad89d7b7
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x5796c9ea4632 - std::sys::backtrace::_print_fmt::he38b6f68ca847f47
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x5796c9ea4632 - <std::sys::backtrace::BacktraceLock::print::DisplayBacktrace as core::fmt::Display>::fmt::hb7e843cde1bc81a3
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x5796c9eb52fa - core::fmt::rt::Argument::fmt::hc1dd77ac64f2688c
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x5796c9eb52fa - core::fmt::write::h952c506e2dbe9cff
[INFO] [stdout]    6:     0x5796c9e729b6 - std::io::default_write_fmt::hd23bd8145c03a23a
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/io/mod.rs:639:11
[INFO] [stdout]    7:     0x5796c9e729b6 - std::io::Write::write_fmt::hdd3314a2bd8a34bd
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/io/mod.rs:1994:13
[INFO] [stdout]    8:     0x5796c9e837d9 - std::sys::backtrace::BacktraceLock::print::h1079b82381c2c252
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x5796c9e837d9 - std::panicking::default_hook::{{closure}}::h85cb76b8462c00f2
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x5796c9e83671 - std::panicking::default_hook::h0134d220cc034c02
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x5796c9e3127e - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::hb2e68dca3970e3ca
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/alloc/src/boxed.rs:2220:9
[INFO] [stdout]   12:     0x5796c9e3127e - test::test_main_with_exit_callback::{{closure}}::ha7ec2063a2565ec3
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:145:21
[INFO] [stdout]   13:     0x5796c9e83a52 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::haebee478d0f56cf4
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/alloc/src/boxed.rs:2220:9
[INFO] [stdout]   14:     0x5796c9e83a52 - std::panicking::panic_with_hook::h8119b6db1fef734f
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x5796c9e83898 - std::panicking::panic_handler::{{closure}}::h24f5360b91482c0e
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x5796c9e7e5a9 - std::sys::backtrace::__rust_end_short_backtrace::h4e60c5cbd1bd0108
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x5796c9e66ddd - __rustc[e4c6931bd8050421]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x5796c9ebd92c - core::panicking::panic_fmt::hb1614a3ff6840071
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x5796c9ebcf02 - core::result::unwrap_failed::h7d4c34940aded59c
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/result.rs:1867:5
[INFO] [stdout]   20:     0x5796c9bd9946 - core::result::Result<T,E>::unwrap::hebb3db774ce0e05c
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/result.rs:1233:23
[INFO] [stdout]   21:     0x5796c9bd9946 - irving::tests::typechecker::modules::tests::instantiation_with_impl_spec_blocks::h335f0c5bca23bdbb
[INFO] [stdout]                                at /opt/rustwide/workdir/src/tests/typechecker/modules.rs:191:40
[INFO] [stdout]   22:     0x5796c9bd9a27 - irving::tests::typechecker::modules::tests::instantiation_with_impl_spec_blocks::{{closure}}::hfac2e2c852d2ca57
[INFO] [stdout]                                at /opt/rustwide/workdir/src/tests/typechecker/modules.rs:173:45
[INFO] [stdout]   23:     0x5796c99cd816 - core::ops::function::FnOnce::call_once::hef0a01345c26f431
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   24:     0x5796c9e3107b - core::ops::function::FnOnce::call_once::hefaf63600cd43d2a
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x5796c9e3107b - test::__rust_begin_short_backtrace::he30322a73a0e9ea6
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:663:18
[INFO] [stdout]   26:     0x5796c9e44a4a - test::run_test_in_process::{{closure}}::hdea3ab8d0243ef36
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:686:74
[INFO] [stdout]   27:     0x5796c9e44a4a - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h66d192f42498ffce
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/panic/unwind_safe.rs:274:9
[INFO] [stdout]   28:     0x5796c9e44a4a - std::panicking::catch_unwind::do_call::h822e18e8d3a6bb65
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:581:40
[INFO] [stdout]   29:     0x5796c9e44a4a - std::panicking::catch_unwind::h54b1de7ceab578bf
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:544:19
[INFO] [stdout]   30:     0x5796c9e44a4a - std::panic::catch_unwind::h60c29b7a9d0246b1
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panic.rs:359:14
[INFO] [stdout]   31:     0x5796c9e44a4a - test::run_test_in_process::h6099b5f871379b13
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:686:27
[INFO] [stdout]   32:     0x5796c9e44a4a - test::run_test::{{closure}}::h926ce0a38281a4c8
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:607:43
[INFO] [stdout]   33:     0x5796c9e1eea4 - test::run_test::{{closure}}::h508de21a9afc7140
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:637:41
[INFO] [stdout]   34:     0x5796c9e1eea4 - std::sys::backtrace::__rust_begin_short_backtrace::h6e2f5c39ca00735a
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   35:     0x5796c9e22762 - std::thread::lifecycle::spawn_unchecked::{{closure}}::{{closure}}::h133e44f0e5802c14
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/thread/lifecycle.rs:91:13
[INFO] [stdout]   36:     0x5796c9e22762 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h4718c1285283955c
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/panic/unwind_safe.rs:274:9
[INFO] [stdout]   37:     0x5796c9e22762 - std::panicking::catch_unwind::do_call::h0bba3937b4892238
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:581:40
[INFO] [stdout]   38:     0x5796c9e22762 - std::panicking::catch_unwind::h5b31cab5fb8c5d7f
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:544:19
[INFO] [stdout]   39:     0x5796c9e22762 - std::panic::catch_unwind::hb2fa05d52ed0124e
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panic.rs:359:14
[INFO] [stdout]   40:     0x5796c9e22762 - std::thread::lifecycle::spawn_unchecked::{{closure}}::hf401cf5ff501bd29
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/thread/lifecycle.rs:89:26
[INFO] [stdout]   41:     0x5796c9e22762 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h160022e94ce3b0bb
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   42:     0x5796c9e7983f - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::hf234e0d1d1d272ba
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/alloc/src/boxed.rs:2206:9
[INFO] [stdout]   43:     0x5796c9e7983f - std::sys::thread::unix::Thread::new::thread_start::h106a295241840d3b
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/thread/unix.rs:127:17
[INFO] [stdout]   44:     0x7e896d617aa4 - <unknown>
[INFO] [stdout]   45:     0x7e896d6a4a64 - 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.35s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "aa5a97b2c430493e4e20d5761de2b0f668bba2bff8a3f01a26b75a5552f316ea", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "aa5a97b2c430493e4e20d5761de2b0f668bba2bff8a3f01a26b75a5552f316ea", kill_on_drop: false }`
[INFO] [stdout] aa5a97b2c430493e4e20d5761de2b0f668bba2bff8a3f01a26b75a5552f316ea
