[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-2024-12-08 for beta-1.84.0-4-retry
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fdijkstracula%2Firving" "/workspace/builds/worker-1-tc2/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-1-tc2/source'...
[INFO] [stderr] done.
[INFO] validating manifest of git repo https://github.com/dijkstracula/irving on toolchain beta-2024-12-08
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+beta-2024-12-08" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[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-1-tc2/source/Cargo.toml
[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-2024-12-08" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-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:f3a9d4ad9d972b27faf3965f35b62e55ba32bbce8f20bc8fe909558a86702fde" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2024-12-08" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] f5263f6945fdd3c6eafcf68138e9e2ccc3c927f0e44db606514c91f4ad9bfde3
[INFO] running `Command { std: "docker" "start" "-a" "f5263f6945fdd3c6eafcf68138e9e2ccc3c927f0e44db606514c91f4ad9bfde3", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "f5263f6945fdd3c6eafcf68138e9e2ccc3c927f0e44db606514c91f4ad9bfde3", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "f5263f6945fdd3c6eafcf68138e9e2ccc3c927f0e44db606514c91f4ad9bfde3", kill_on_drop: false }`
[INFO] [stdout] f5263f6945fdd3c6eafcf68138e9e2ccc3c927f0e44db606514c91f4ad9bfde3
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-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:f3a9d4ad9d972b27faf3965f35b62e55ba32bbce8f20bc8fe909558a86702fde" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2024-12-08" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 05622f6ba2c6392284e4978bca97ddbebbc071623b4db98d48cdde2daea2d011
[INFO] running `Command { std: "docker" "start" "-a" "05622f6ba2c6392284e4978bca97ddbebbc071623b4db98d48cdde2daea2d011", kill_on_drop: false }`
[INFO] [stderr]    Compiling rustix v0.38.3
[INFO] [stderr]    Compiling linux-raw-sys v0.4.3
[INFO] [stderr]    Compiling bitflags v2.3.3
[INFO] [stderr]    Compiling memchr v2.5.0
[INFO] [stderr]    Compiling ucd-trie v0.1.5
[INFO] [stderr]    Compiling once_cell v1.17.1
[INFO] [stderr]    Compiling syn v1.0.109
[INFO] [stderr]    Compiling syn v2.0.15
[INFO] [stderr]    Compiling anstyle-parse v0.2.1
[INFO] [stderr]    Compiling regex-syntax v0.7.4
[INFO] [stderr]    Compiling anstyle v1.0.1
[INFO] [stderr]    Compiling anstyle-query v1.0.0
[INFO] [stderr]    Compiling strsim v0.10.0
[INFO] [stderr]    Compiling clap_lex v0.5.0
[INFO] [stderr]    Compiling heck v0.4.1
[INFO] [stderr]    Compiling anyhow v1.0.75
[INFO] [stderr]    Compiling termcolor v1.2.0
[INFO] [stderr]    Compiling aho-corasick v1.0.2
[INFO] [stderr]    Compiling log v0.4.19
[INFO] [stderr]    Compiling either v1.9.0
[INFO] [stderr]    Compiling humantime v2.1.0
[INFO] [stderr]    Compiling annotate-snippets v0.9.2
[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 clap_builder v4.3.11
[INFO] [stderr]    Compiling regex-automata v0.3.3
[INFO] [stderr]    Compiling thiserror-impl v1.0.40
[INFO] [stderr]    Compiling clap_derive v4.3.2
[INFO] [stderr]    Compiling pest_consume_macros v1.1.0
[INFO] [stderr]    Compiling regex v1.9.1
[INFO] [stderr]    Compiling thiserror v1.0.40
[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 59.85s
[INFO] running `Command { std: "docker" "inspect" "05622f6ba2c6392284e4978bca97ddbebbc071623b4db98d48cdde2daea2d011", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "05622f6ba2c6392284e4978bca97ddbebbc071623b4db98d48cdde2daea2d011", kill_on_drop: false }`
[INFO] [stdout] 05622f6ba2c6392284e4978bca97ddbebbc071623b4db98d48cdde2daea2d011
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-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:f3a9d4ad9d972b27faf3965f35b62e55ba32bbce8f20bc8fe909558a86702fde" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2024-12-08" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 66d54c6122c281f88a9c12b0b400df8a004821f1642e5c41dcab19c29b4912df
[INFO] running `Command { std: "docker" "start" "-a" "66d54c6122c281f88a9c12b0b400df8a004821f1642e5c41dcab19c29b4912df", 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]   = help: consider adding `used_linker` as a feature in `Cargo.toml`
[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 17.76s
[INFO] running `Command { std: "docker" "inspect" "66d54c6122c281f88a9c12b0b400df8a004821f1642e5c41dcab19c29b4912df", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "66d54c6122c281f88a9c12b0b400df8a004821f1642e5c41dcab19c29b4912df", kill_on_drop: false }`
[INFO] [stdout] 66d54c6122c281f88a9c12b0b400df8a004821f1642e5c41dcab19c29b4912df
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-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:f3a9d4ad9d972b27faf3965f35b62e55ba32bbce8f20bc8fe909558a86702fde" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2024-12-08" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 81b762fee910d66114877f27b3b014b5294c2c86f5c47df3a9ba2d3e1ad4cb06
[INFO] running `Command { std: "docker" "start" "-a" "81b762fee910d66114877f27b3b014b5294c2c86f5c47df3a9ba2d3e1ad4cb06", 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]   = help: consider adding `used_linker` as a feature in `Cargo.toml`
[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.17s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/irving-7a243876cb8d809a)
[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_formula_with_dots ... ok
[INFO] [stdout] test tests::extraction::ivy::tests::pprint_subclass ... ok
[INFO] [stdout] test tests::extraction::java::tests::extract_action_and_decl ... ok
[INFO] [stdout] test tests::extraction::ivy::tests::pprint_complex_expr ... ok
[INFO] [stdout] test tests::extraction::java::tests::extract_action_forward_ref ... ok
[INFO] [stdout] test tests::extraction::ivy::tests::pprint_class ... ok
[INFO] [stdout] test tests::extraction::java::tests::extract_arith ... ok
[INFO] [stdout] test tests::extraction::java::tests::extract_after_decl ... ok
[INFO] [stdout] test tests::extraction::ivy::tests::pprint_fnapp ... ok
[INFO] [stdout] test tests::extraction::java::tests::extract_assign_range_saturated_lit ... ok
[INFO] [stdout] test tests::extraction::java::tests::extract_assign_nat_lit ... ok
[INFO] [stdout] test tests::extraction::java::tests::extract_assign_range_lit ... ok
[INFO] [stdout] test tests::extraction::java::tests::extract_bool ... ok
[INFO] [stdout] test tests::extraction::java::tests::extract_call_compound_arg ... ok
[INFO] [stdout] test tests::extraction::java::tests::extract_call ... ok
[INFO] [stdout] test tests::extraction::java::tests::extract_field_access ... ok
[INFO] [stdout] test tests::extraction::ivy::tests::pprint_formula ... ok
[INFO] [stdout] test tests::extraction::java::tests::extract_after_init ... ok
[INFO] [stdout] test tests::extraction::java::tests::extract_forall ... ok
[INFO] [stdout] test tests::extraction::java::tests::extract_vardecl ... ok
[INFO] [stdout] test tests::extraction::java::tests::extract_assign_nat_nonlit ... ok
[INFO] [stdout] test tests::extraction::java::tests::extract_module_parameterized ... ok
[INFO] [stdout] test tests::extraction::java::tests::extract_assign_range_binop ... 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_assign ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_attribute ... ok
[INFO] [stdout] test tests::extraction::java::tests::extract_nested_forall ... ok
[INFO] [stdout] test tests::extraction::java::tests::extract_process_trivial ... ok
[INFO] [stdout] test tests::extraction::java::tests::extract_module_simple ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_axiom_2 ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_axiom ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_ensure_with_fmla ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_decl_sig ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_common_decl ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_class_decl ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_function_decl_incomplete ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_implementation_decl ... ok
[INFO] [stdout] test tests::extraction::vnt::tests::test_relation_init ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_function_decl_uninterp ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_function_decl_impl ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_function_decl_impl_explicit_ret ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_interpret_annotated_decl ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_interpret_uninterp_decl ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_global_decl ... ok
[INFO] [stdout] test tests::extraction::vnt::tests::test_noninf1 ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_invariant_decl ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_nullary_relation ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_instance_decl ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_object_decl ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_subclass_decl ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_process_decl ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_type_decl ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_type_decl_range ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_module_decl_1 ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_type_decl_with_super ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_type_decl_this ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_type_enum_range ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_var_decl ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_parametrized_decl_err ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_module_decl_2 ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_var_decl_with_type ... ok
[INFO] [stdout] test tests::parser::declarations::tests::vardecl_declare_and_assign ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_relation_decl ... ok
[INFO] [stdout] test tests::parser::expressions::tests::parse_complex_expr ... ok
[INFO] [stdout] test tests::parser::expressions::tests::parse_fnapp_and_index ... ok
[INFO] [stdout] test tests::parser::expressions::tests::parse_fnapp_in_conj ... ok
[INFO] [stdout] test tests::parser::expressions::tests::parse_multi_fnapp ... ok
[INFO] [stdout] test tests::parser::expressions::tests::parse_conjunction_fmla ... ok
[INFO] [stdout] test tests::parser::expressions::tests::parse_dot_expr ... ok
[INFO] [stdout] test tests::parser::declarations::tests::parse_specification_decl ... ok
[INFO] [stdout] test tests::parser::expressions::tests::parse_logicvar ... ok
[INFO] [stdout] test tests::parser::expressions::tests::parse_negation_expr ... ok
[INFO] [stdout] test tests::parser::expressions::tests::parse_negative_number_expr ... ok
[INFO] [stdout] test tests::parser::expressions::tests::parse_pred ... ok
[INFO] [stdout] test tests::parser::expressions::tests::parse_nested_fnapp ... ok
[INFO] [stdout] test tests::parser::expressions::tests::parse_number_expr ... ok
[INFO] [stdout] test tests::parser::expressions::tests::parse_progsym ... 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_pred_2 ... ok
[INFO] [stdout] test tests::parser::expressions::tests::parse_unary_fnapp_and_negation ... ok
[INFO] [stdout] test tests::parser::formulas::tests::parse_bool ... ok
[INFO] [stdout] test tests::parser::expressions::tests::parse_le ... ok
[INFO] [stdout] test tests::parser::formulas::tests::dot_on_quant ... ok
[INFO] [stdout] test tests::parser::expressions::tests::parse_unary_fnapp ... ok
[INFO] [stdout] test tests::parser::formulas::tests::parse_logicvar_in_subexpr ... ok
[INFO] [stdout] test tests::parser::formulas::tests::parse_logical_implication ... ok
[INFO] [stdout] test tests::parser::formulas::tests::parse_negation ... ok
[INFO] [stdout] test tests::parser::formulas::tests::parse_nested_implications ... ok
[INFO] [stdout] test tests::parser::formulas::tests::parse_existential_quant ... ok
[INFO] [stdout] test tests::parser::formulas::tests::parse_nested_quants ... 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_quants2 ... ok
[INFO] [stdout] test tests::parser::formulas::tests::parse_parens_negation ... ok
[INFO] [stdout] test tests::parser::formulas::tests::parse_pred_progsym ... ok
[INFO] [stdout] test tests::parser::formulas::tests::parse_progvar_in_fnapp ... ok
[INFO] [stdout] test tests::parser::formulas::tests::parse_term ... ok
[INFO] [stdout] test tests::parser::formulas::tests::parse_term_with_annotation ... ok
[INFO] [stdout] test tests::parser::formulas::tests::parse_universal_quant ... ok
[INFO] [stdout] test tests::parser::formulas::tests::parse_nested_implications_2 ... ok
[INFO] [stdout] test tests::parser::formulas::tests::parse_pred_logicsym ... ok
[INFO] [stdout] test tests::parser::formulas::tests::parse_conjunction ... ok
[INFO] [stdout] test tests::parser::formulas::tests::parse_number ... ok
[INFO] [stdout] test tests::parser::mixins::tests::parse_action_decl_no_ret_but_body ... ok
[INFO] [stdout] test tests::parser::mixins::tests::parse_action_decl_with_ret_no_body ... ok
[INFO] [stdout] test tests::parser::mixins::tests::parse_action_decl_no_ret_nor_body ... ok
[INFO] [stdout] test tests::parser::mixins::tests::parse_action_forward_ref ... 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_after_mixin_with_declret ... ok
[INFO] [stdout] test tests::parser::mixins::tests::parse_export_action ... ok
[INFO] [stdout] test tests::parser::formulas::tests::parse_universal_quant2 ... 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::mixins::tests::parse_export_forward_ref_qualified ... ok
[INFO] [stdout] test tests::parser::statements::tests::parse_assign ... ok
[INFO] [stdout] test tests::parser::mixins::tests::parse_implement ... ok
[INFO] [stdout] test tests::parser::mixins::tests::parse_export_forward_ref ... ok
[INFO] [stdout] test tests::parser::statements::tests::parse_assert_action ... ok
[INFO] [stdout] test tests::parser::statements::tests::parse_assign_to_field ... ok
[INFO] [stdout] test tests::parser::statements::tests::parse_assign_to_relation ... ok
[INFO] [stdout] test tests::parser::mixins::tests::parse_implement_with_declret ... ok
[INFO] [stdout] test tests::parser::statements::tests::parse_assign_to_relation_2 ... ok
[INFO] [stdout] test tests::parser::statements::tests::parse_ensure_action ... ok
[INFO] [stdout] test tests::parser::statements::tests::parse_assign_with_rhs_logicvar ... ok
[INFO] [stdout] test tests::parser::statements::tests::parse_ensure_action_2 ... ok
[INFO] [stdout] test tests::parser::mixins::tests::parse_nested_action ... ok
[INFO] [stdout] test tests::parser::statements::tests::parse_assign_to_field_of_this ... ok
[INFO] [stdout] test tests::parser::statements::tests::parse_declare_annot ... ok
[INFO] [stdout] test tests::parser::statements::tests::parse_assume_action ... 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_if_stmt_with_else ... 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::toplevels::tests::parse_hashlang_major_minor ... ok
[INFO] [stdout] test tests::parser::toplevels::tests::parse_hashlang_major_only ... ok
[INFO] [stdout] test tests::parser::toplevels::tests::logical_call_to_action ... ok
[INFO] [stdout] test tests::parser::statements::tests::parse_requires_action_2 ... ok
[INFO] [stdout] test tests::parser::toplevels::tests::parse_less_trivial_prog ... ok
[INFO] [stdout] test tests::parser::statements::tests::parse_while ... ok
[INFO] [stdout] test tests::parser::toplevels::tests::non_top_include ... 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::passes::constant_fold::tests::fold_zero_add ... ok
[INFO] [stdout] test tests::parser::statements::tests::parse_stmt_block ... ok
[INFO] [stdout] test tests::passes::constant_fold::tests::fold_constants ... ok
[INFO] [stdout] test tests::passes::module_instantiation::tests::test_module_instantiation ... ok
[INFO] [stdout] test tests::passes::quantifier_bounds::tests::bounds_from_binop_literals ... 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_binop_logicvar ... ok
[INFO] [stdout] test tests::parser::toplevels::tests::parse_trivial_prog ... ok
[INFO] [stdout] test tests::passes::quantifier_bounds::tests::bounds_from_forall_nats_conjunction ... ok
[INFO] [stdout] test tests::passes::quantifier_bounds::tests::op_on_logicsym ... 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::quantifier_bounds::tests::bounds_from_forall_nats_false_monotonic_gt ... ok
[INFO] [stdout] test tests::passes::quantifier_bounds::tests::bounds_from_forall_nats_monotonic_lt ... ok
[INFO] [stdout] test tests::passes::quantifier_bounds::tests::succ_binop_of_literals ... ok
[INFO] [stdout] test tests::passes::quantifier_bounds::tests::bounds_from_forall_nats_positive ... ok
[INFO] [stdout] test tests::passes::quantifier_bounds::tests::succ_literal ... ok
[INFO] [stdout] test tests::programs::accord::typecheck_abstract_protocol ... FAILED
[INFO] [stdout] test tests::programs::parser::test_append ... ok
[INFO] [stdout] test tests::programs::accord::typecheck_sorts ... FAILED
[INFO] [stdout] test tests::programs::accord::typecheck_protocol ... FAILED
[INFO] [stdout] test tests::programs::accord::typecheck_temporality ... FAILED
[INFO] [stdout] test tests::programs::parser::test_loops ... ok
[INFO] [stdout] test tests::extraction::java::tests::extract_module_instantation ... FAILED
[INFO] [stdout] test tests::programs::parser::test_state_and_actions ... ok
[INFO] [stdout] test tests::programs::accord::typecheck_messages ... FAILED
[INFO] [stdout] test tests::programs::accord::typecheck_txn ... FAILED
[INFO] [stdout] test tests::programs::parser::test_modules ... ok
[INFO] [stdout] test tests::programs::parser::test_isolates ... ok
[INFO] [stdout] test tests::typechecker::actions::tests::action_assign ... ok
[INFO] [stdout] test tests::programs::parser::test_safety_and_invariants ... ok
[INFO] [stdout] test tests::typechecker::actions::tests::action_assign_logical ... ok
[INFO] [stdout] test tests::typechecker::actions::tests::action_call_nullary_action ... ok
[INFO] [stdout] test tests::typechecker::actions::tests::action_before_after ... ok
[INFO] [stdout] test tests::typechecker::actions::tests::action_call_curry_this ... ok
[INFO] [stdout] test tests::typechecker::actions::tests::action_forward_ref ... ok
[INFO] [stdout] test tests::typechecker::actions::tests::action_call_unary ... ok
[INFO] [stdout] test tests::typechecker::actions::tests::action_read_relation ... ok
[INFO] [stdout] test tests::typechecker::actions::tests::implicit_nullary_action_call ... ok
[INFO] [stdout] test tests::typechecker::actions::tests::action_read_relation_logical ... ok
[INFO] [stdout] test tests::typechecker::actions::tests::ident_action_decl ... ok
[INFO] [stdout] test tests::typechecker::actions::tests::action_nullary_application ... 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::action_nullary_application_opaque_ret_sort ... ok
[INFO] [stdout] test tests::typechecker::actions::tests::noop_action_decl_with_local ... ok
[INFO] [stdout] test tests::typechecker::actions::tests::unknown_ident_in_action_impl ... ok
[INFO] [stdout] test tests::typechecker::declarations::tests::declblock ... ok
[INFO] [stdout] test tests::typechecker::declarations::tests::alias_bv ... ok
[INFO] [stdout] test tests::typechecker::actions::tests::local_vardecl_and_init ... ok
[INFO] [stdout] test tests::typechecker::declarations::tests::ensure_bad ... ok
[INFO] [stdout] test tests::typechecker::actions::tests::noop_action_decl ... ok
[INFO] [stdout] test tests::typechecker::declarations::tests::ensure ... ok
[INFO] [stdout] test tests::typechecker::declarations::tests::class ... ok
[INFO] [stdout] test tests::programs::parser::test_noninf1 ... 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::instance_decl_no_args ... ok
[INFO] [stdout] test tests::typechecker::declarations::tests::require_bad ... ok
[INFO] [stdout] test tests::typechecker::declarations::tests::require ... 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::relation_decl_annotated ... ok
[INFO] [stdout] test tests::typechecker::declarations::tests::ensure_quantified ... 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_annotated ... ok
[INFO] [stdout] test tests::typechecker::declarations::tests::typedecl_range ... ok
[INFO] [stdout] test tests::typechecker::declarations::tests::typedecl_enum ... ok
[INFO] [stdout] test tests::typechecker::declarations::tests::function_uninterpreted ... ok
[INFO] [stdout] test tests::typechecker::declarations::tests::typedecl_uninterp ... 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_eq_binop ... ok
[INFO] [stdout] test tests::typechecker::expressions::tests::test_field_access ... ok
[INFO] [stdout] test tests::typechecker::expressions::tests::test_call_resolved ... ok
[INFO] [stdout] test tests::typechecker::expressions::tests::test_call_unresolved ... ok
[INFO] [stdout] test tests::typechecker::expressions::tests::test_ident ... ok
[INFO] [stdout] test tests::typechecker::expressions::tests::test_field_access_call ... ok
[INFO] [stdout] test tests::stdlib::tests::typecheck ... ok
[INFO] [stdout] test tests::typechecker::declarations::tests::vardecl_inferred ... ok
[INFO] [stdout] test tests::typechecker::expressions::tests::test_invalid_numeric_binop ... ok
[INFO] [stdout] test tests::typechecker::expressions::tests::test_lt_binop ... 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::expressions::tests::test_unary_op ... ok
[INFO] [stdout] test tests::typechecker::formulas::tests::progterm_in_fmls ... ok
[INFO] [stdout] test tests::typechecker::formulas::tests::nested_quants ... ok
[INFO] [stdout] test tests::typechecker::mixins::tests::test_action_and_impl_identical_sigs ... ok
[INFO] [stdout] test tests::typechecker::formulas::tests::universal_quant ... ok
[INFO] [stdout] test tests::typechecker::expressions::tests::test_numeric_binop ... ok
[INFO] [stdout] test tests::typechecker::mixins::tests::test_action_and_impl_different_sorts ... ok
[INFO] [stdout] test tests::typechecker::declarations::tests::relation_decl_unannotated ... ok
[INFO] [stdout] test tests::typechecker::mixins::tests::test_action_and_impl_rebound_sigs ... ok
[INFO] [stdout] test tests::typechecker::modules::tests::instantiation_with_impl_spec_blocks ... FAILED
[INFO] [stdout] test tests::typechecker::mixins::tests::test_action_and_impl ... 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::module_multiple_instantiations ... ok
[INFO] [stdout] test tests::typechecker::modules::tests::instantiation_with_overloaded_numerals ... ok
[INFO] [stdout] test tests::typechecker::modules::tests::test_mod_actions ... ok
[INFO] [stdout] test tests::typechecker::modules::tests::module_extraction ... 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::instantiation_with_invalid_overloaded_numerals ... ok
[INFO] [stdout] test tests::typechecker::processes::tests::empty_process ... ok
[INFO] [stdout] test tests::typechecker::processes::tests::parameterized_object_index ... ok
[INFO] [stdout] test tests::typechecker::processes::tests::proc_with_params ... ok
[INFO] [stdout] test tests::typechecker::processes::tests::proc_with_local_var ... ok
[INFO] [stdout] test tests::typechecker::processes::tests::parameterized_obj_index ... ok
[INFO] [stdout] test tests::typechecker::processes::tests::proc_with_implicit_impl ... ok
[INFO] [stdout] test tests::typechecker::processes::tests::process_with_ghost_state_assign_lhs ... ok
[INFO] [stdout] test tests::typechecker::processes::tests::bad_parameterized_object_index ... ok
[INFO] [stdout] test tests::typechecker::processes::tests::relation_logical_assign ... ok
[INFO] [stdout] test tests::typechecker::processes::tests::relation_inference_bad_arity ... ok
[INFO] [stdout] test tests::typechecker::processes::tests::relation_bad_inference ... ok
[INFO] [stdout] test tests::typechecker::processes::tests::relation_inference_bad_assign ... ok
[INFO] [stdout] test tests::typechecker::resolver::tests::fresh_sortvars ... ok
[INFO] [stdout] test tests::typechecker::resolver::tests::generic_unification ... 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::statements::tests::logical_assign ... ok
[INFO] [stdout] test tests::typechecker::statements::tests::while_valid ... ok
[INFO] [stdout] test tests::typechecker::processes::tests::append1_host ... ok
[INFO] [stdout] test tests::typechecker::subst::tests::uninterpreted_type_resolution ... ok
[INFO] [stdout] test tests::typechecker::statements::tests::if_bad_cond ... ok
[INFO] [stdout] test tests::typechecker::statements::tests::if_valid ... ok
[INFO] [stdout] test tests::typechecker::resolver::tests::test_record_lookup ... ok
[INFO] [stdout] test tests::typechecker::resolver::tests::test_nonrecord_lookup ... ok
[INFO] [stdout] test tests::typechecker::processes::tests::relation_inference ... ok
[INFO] [stdout] test tests::programs::parser::test_append2 ... ok
[INFO] [stdout] test typechecker::programs::typechecker::typecheck_102_counter ... ok
[INFO] [stdout] test typechecker::programs::parser::typecheck_001_state_and_actions ... ok
[INFO] [stdout] test typechecker::programs::typechecker::typecheck_202_pingpong ... ok
[INFO] [stdout] test typechecker::programs::extraction::extract_202_pingpong ... ok
[INFO] [stdout] test typechecker::programs::typechecker::typecheck_101_append2 ... ok
[INFO] [stdout] test typechecker::programs::typechecker::typecheck_200_trivial_chainrep ... 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] thread 'tests::programs::accord::typecheck_abstract_protocol' 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:     0x57ee96a545ba - std::backtrace_rs::backtrace::libunwind::trace::h8810477743020387
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/../../backtrace/src/backtrace/libunwind.rs:116:5
[INFO] [stdout]    1:     0x57ee96a545ba - std::backtrace_rs::backtrace::trace_unsynchronized::h3aa55355dd6c54a6
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x57ee96a545ba - std::sys::backtrace::_print_fmt::h8588b0f62410823f
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:66:9
[INFO] [stdout]    3:     0x57ee96a545ba - <std::sys::backtrace::BacktraceLock::print::DisplayBacktrace as core::fmt::Display>::fmt::h98c26ac25ffe89bb
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:39:26
[INFO] [stdout]    4:     0x57ee96a7a713 - core::fmt::rt::Argument::fmt::hf95377f4aebd453b
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/fmt/rt.rs:177:76
[INFO] [stdout]    5:     0x57ee96a7a713 - core::fmt::write::h0dd5f6e2238c7982
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/fmt/mod.rs:1189:21
[INFO] [stdout]    6:     0x57ee96a50f23 - std::io::Write::write_fmt::h03bb0ca26e6faf8c
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/io/mod.rs:1884:15
[INFO] [stdout]    7:     0x57ee96a54402 - std::sys::backtrace::BacktraceLock::print::h5c19c1c038ee186d
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:42:9
[INFO] [stdout]    8:     0x57ee96a55a3d - std::panicking::default_hook::{{closure}}::h77172f079a1fcb13
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:268:22
[INFO] [stdout]    9:     0x57ee96a55847 - std::panicking::default_hook::he5f8e3b203ccddba
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:292:9
[INFO] [stdout]   10:     0x57ee96a00597 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h7a3c7b4a1ae77f2f
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/alloc/src/boxed.rs:1986:9
[INFO] [stdout]   11:     0x57ee96a00597 - test::test_main::{{closure}}::hf0d3b69ae9b353d1
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:134:21
[INFO] [stdout]   12:     0x57ee96a560e8 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h6332e82e7b189abd
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/alloc/src/boxed.rs:1986:9
[INFO] [stdout]   13:     0x57ee96a560e8 - std::panicking::rust_panic_with_hook::h53863d4e9018df39
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:809:13
[INFO] [stdout]   14:     0x57ee96a55eaa - std::panicking::begin_panic_handler::{{closure}}::h67280e6fa0757873
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:674:13
[INFO] [stdout]   15:     0x57ee96a54a99 - std::sys::backtrace::__rust_end_short_backtrace::h1dac3f54d6fbbeb2
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:170:18
[INFO] [stdout]   16:     0x57ee96a55b3c - rust_begin_unwind
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:665:5
[INFO] [stdout]   17:     0x57ee9642e180 - core::panicking::panic_fmt::h6792bd1b2bf01041
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/panicking.rs:76:14
[INFO] [stdout]   18:     0x57ee9642e666 - core::result::unwrap_failed::h05e0602ed34287c5
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/result.rs:1699:5
[INFO] [stdout]   19:     0x57ee965cdfe1 - core::result::Result<T,E>::unwrap::h1335374be6788d21
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/result.rs:1104:23
[INFO] [stdout]   20:     0x57ee965cdfe1 - irving::tests::helpers::typeinference_from_filename::hc1eec639dc300dab
[INFO] [stdout]                                at /opt/rustwide/workdir/src/tests/mod.rs:108:20
[INFO] [stdout]   21:     0x57ee965cff9a - irving::tests::programs::accord::typecheck_abstract_protocol::ha66712710ec9c35f
[INFO] [stdout]                                at /opt/rustwide/workdir/src/tests/programs.rs:53:13
[INFO] [stdout]   22:     0x57ee965cff67 - irving::tests::programs::accord::typecheck_abstract_protocol::{{closure}}::hdff6df22d415facf
[INFO] [stdout]                                at /opt/rustwide/workdir/src/tests/programs.rs:51:37
[INFO] [stdout]   23:     0x57ee965e5df6 - core::ops::function::FnOnce::call_once::hb7eda7c21084db06
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   24:     0x57ee96a050bb - core::ops::function::FnOnce::call_once::h871bf86719ec9aa4
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x57ee96a050bb - test::__rust_begin_short_backtrace::h2167df1e2b7d76fd
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:632:18
[INFO] [stdout]   26:     0x57ee96a04aa8 - test::run_test_in_process::{{closure}}::h15d92f75a3adfb79
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:655:60
[INFO] [stdout]   27:     0x57ee96a04aa8 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::hb6c8955835a8dbbb
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   28:     0x57ee96a04aa8 - std::panicking::try::do_call::hc79d0fc888a0bd30
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:557:40
[INFO] [stdout]   29:     0x57ee96a04aa8 - std::panicking::try::hb8a7878e3a8589d6
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:520:19
[INFO] [stdout]   30:     0x57ee96a04aa8 - std::panic::catch_unwind::hb8e4600ff0ff5cfa
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panic.rs:358:14
[INFO] [stdout]   31:     0x57ee96a04aa8 - test::run_test_in_process::hc2900b0b18688dd6
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:655:27
[INFO] [stdout]   32:     0x57ee96a04aa8 - test::run_test::{{closure}}::hac2a9cb07be3d48d
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:576:43
[INFO] [stdout]   33:     0x57ee969c854a - test::run_test::{{closure}}::h4a5b729e66a38cd8
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:606:41
[INFO] [stdout]   34:     0x57ee969c854a - std::sys::backtrace::__rust_begin_short_backtrace::h0496fb742492f573
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:154:18
[INFO] [stdout]   35:     0x57ee969cbec4 - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::hbb6d257c550a54bd
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/thread/mod.rs:561:17
[INFO] [stdout]   36:     0x57ee969cbec4 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h46696fe4a6832328
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   37:     0x57ee969cbec4 - std::panicking::try::do_call::h2625a51b667bfb64
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:557:40
[INFO] [stdout]   38:     0x57ee969cbec4 - std::panicking::try::hb956a59a1973aa4c
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:520:19
[INFO] [stdout]   39:     0x57ee969cbec4 - std::panic::catch_unwind::h64f3b9d1067ef6a0
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panic.rs:358:14
[INFO] [stdout]   40:     0x57ee969cbec4 - std::thread::Builder::spawn_unchecked_::{{closure}}::h42b2841295b6c0b2
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/thread/mod.rs:559:30
[INFO] [stdout]   41:     0x57ee969cbec4 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h6127de71b8124639
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   42:     0x57ee96a5a0bb - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h42f0ba71002a1b2c
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/alloc/src/boxed.rs:1972:9
[INFO] [stdout]   43:     0x57ee96a5a0bb - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::had9e47d7a3dcecb8
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/alloc/src/boxed.rs:1972:9
[INFO] [stdout]   44:     0x57ee96a5a0bb - std::sys::pal::unix::thread::Thread::new::thread_start::h48cf765408f6f5f2
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/pal/unix/thread.rs:105:17
[INFO] [stdout]   45:     0x7cd00b6bdac3 - <unknown>
[INFO] [stdout]   46:     0x7cd00b74ea04 - clone
[INFO] [stdout]   47:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- tests::programs::accord::typecheck_sorts stdout ----
[INFO] [stdout] thread 'tests::programs::accord::typecheck_sorts' 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:     0x57ee96a545ba - std::backtrace_rs::backtrace::libunwind::trace::h8810477743020387
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/../../backtrace/src/backtrace/libunwind.rs:116:5
[INFO] [stdout]    1:     0x57ee96a545ba - std::backtrace_rs::backtrace::trace_unsynchronized::h3aa55355dd6c54a6
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x57ee96a545ba - std::sys::backtrace::_print_fmt::h8588b0f62410823f
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:66:9
[INFO] [stdout]    3:     0x57ee96a545ba - <std::sys::backtrace::BacktraceLock::print::DisplayBacktrace as core::fmt::Display>::fmt::h98c26ac25ffe89bb
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:39:26
[INFO] [stdout]    4:     0x57ee96a7a713 - core::fmt::rt::Argument::fmt::hf95377f4aebd453b
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/fmt/rt.rs:177:76
[INFO] [stdout]    5:     0x57ee96a7a713 - core::fmt::write::h0dd5f6e2238c7982
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/fmt/mod.rs:1189:21
[INFO] [stdout]    6:     0x57ee96a50f23 - std::io::Write::write_fmt::h03bb0ca26e6faf8c
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/io/mod.rs:1884:15
[INFO] [stdout]    7:     0x57ee96a54402 - std::sys::backtrace::BacktraceLock::print::h5c19c1c038ee186d
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:42:9
[INFO] [stdout]    8:     0x57ee96a55a3d - std::panicking::default_hook::{{closure}}::h77172f079a1fcb13
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:268:22
[INFO] [stdout]    9:     0x57ee96a55847 - std::panicking::default_hook::he5f8e3b203ccddba
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:292:9
[INFO] [stdout]   10:     0x57ee96a00597 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h7a3c7b4a1ae77f2f
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/alloc/src/boxed.rs:1986:9
[INFO] [stdout]   11:     0x57ee96a00597 - test::test_main::{{closure}}::hf0d3b69ae9b353d1
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:134:21
[INFO] [stdout]   12:     0x57ee96a560e8 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h6332e82e7b189abd
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/alloc/src/boxed.rs:1986:9
[INFO] [stdout]   13:     0x57ee96a560e8 - std::panicking::rust_panic_with_hook::h53863d4e9018df39
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:809:13
[INFO] [stdout]   14:     0x57ee96a55eaa - std::panicking::begin_panic_handler::{{closure}}::h67280e6fa0757873
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:674:13
[INFO] [stdout]   15:     0x57ee96a54a99 - std::sys::backtrace::__rust_end_short_backtrace::h1dac3f54d6fbbeb2
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:170:18
[INFO] [stdout]   16:     0x57ee96a55b3c - rust_begin_unwind
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:665:5
[INFO] [stdout]   17:     0x57ee9642e180 - core::panicking::panic_fmt::h6792bd1b2bf01041
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/panicking.rs:76:14
[INFO] [stdout]   18:     0x57ee9642e666 - core::result::unwrap_failed::h05e0602ed34287c5
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/result.rs:1699:5
[INFO] [stdout]   19:     0x57ee965cdfe1 - core::result::Result<T,E>::unwrap::h1335374be6788d21
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/result.rs:1104:23
[INFO] [stdout]   20:     0x57ee965cdfe1 - irving::tests::helpers::typeinference_from_filename::hc1eec639dc300dab
[INFO] [stdout]                                at /opt/rustwide/workdir/src/tests/mod.rs:108:20
[INFO] [stdout]   21:     0x57ee965d005a - irving::tests::programs::accord::typecheck_sorts::h011772655bc60070
[INFO] [stdout]                                at /opt/rustwide/workdir/src/tests/programs.rs:63:20
[INFO] [stdout]   22:     0x57ee965d0027 - irving::tests::programs::accord::typecheck_sorts::{{closure}}::h1fc4df982ab76ef2
[INFO] [stdout]                                at /opt/rustwide/workdir/src/tests/programs.rs:62:25
[INFO] [stdout]   23:     0x57ee965e7706 - core::ops::function::FnOnce::call_once::hd7cd25fb4718d08f
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   24:     0x57ee96a050bb - core::ops::function::FnOnce::call_once::h871bf86719ec9aa4
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x57ee96a050bb - test::__rust_begin_short_backtrace::h2167df1e2b7d76fd
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:632:18
[INFO] [stdout]   26:     0x57ee96a04aa8 - test::run_test_in_process::{{closure}}::h15d92f75a3adfb79
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:655:60
[INFO] [stdout]   27:     0x57ee96a04aa8 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::hb6c8955835a8dbbb
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   28:     0x57ee96a04aa8 - std::panicking::try::do_call::hc79d0fc888a0bd30
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:557:40
[INFO] [stdout]   29:     0x57ee96a04aa8 - std::panicking::try::hb8a7878e3a8589d6
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:520:19
[INFO] [stdout]   30:     0x57ee96a04aa8 - std::panic::catch_unwind::hb8e4600ff0ff5cfa
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panic.rs:358:14
[INFO] [stdout]   31:     0x57ee96a04aa8 - test::run_test_in_process::hc2900b0b18688dd6
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:655:27
[INFO] [stdout]   32:     0x57ee96a04aa8 - test::run_test::{{closure}}::hac2a9cb07be3d48d
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:576:43
[INFO] [stdout]   33:     0x57ee969c854a - test::run_test::{{closure}}::h4a5b729e66a38cd8
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:606:41
[INFO] [stdout]   34:     0x57ee969c854a - std::sys::backtrace::__rust_begin_short_backtrace::h0496fb742492f573
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:154:18
[INFO] [stdout]   35:     0x57ee969cbec4 - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::hbb6d257c550a54bd
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/thread/mod.rs:561:17
[INFO] [stdout]   36:     0x57ee969cbec4 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h46696fe4a6832328
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   37:     0x57ee969cbec4 - std::panicking::try::do_call::h2625a51b667bfb64
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:557:40
[INFO] [stdout]   38:     0x57ee969cbec4 - std::panicking::try::hb956a59a1973aa4c
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:520:19
[INFO] [stdout]   39:     0x57ee969cbec4 - std::panic::catch_unwind::h64f3b9d1067ef6a0
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panic.rs:358:14
[INFO] [stdout]   40:     0x57ee969cbec4 - std::thread::Builder::spawn_unchecked_::{{closure}}::h42b2841295b6c0b2
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/thread/mod.rs:559:30
[INFO] [stdout]   41:     0x57ee969cbec4 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h6127de71b8124639
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   42:     0x57ee96a5a0bb - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h42f0ba71002a1b2c
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/alloc/src/boxed.rs:1972:9
[INFO] [stdout]   43:     0x57ee96a5a0bb - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::had9e47d7a3dcecb8
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/alloc/src/boxed.rs:1972:9
[INFO] [stdout]   44:     0x57ee96a5a0bb - std::sys::pal::unix::thread::Thread::new::thread_start::h48cf765408f6f5f2
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/pal/unix/thread.rs:105:17
[INFO] [stdout]   45:     0x7cd00b6bdac3 - <unknown>
[INFO] [stdout]   46:     0x7cd00b74ea04 - clone
[INFO] [stdout]   47:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- tests::programs::accord::typecheck_protocol stdout ----
[INFO] [stdout] thread 'tests::programs::accord::typecheck_protocol' 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:     0x57ee96a545ba - std::backtrace_rs::backtrace::libunwind::trace::h8810477743020387
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/../../backtrace/src/backtrace/libunwind.rs:116:5
[INFO] [stdout]    1:     0x57ee96a545ba - std::backtrace_rs::backtrace::trace_unsynchronized::h3aa55355dd6c54a6
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x57ee96a545ba - std::sys::backtrace::_print_fmt::h8588b0f62410823f
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:66:9
[INFO] [stdout]    3:     0x57ee96a545ba - <std::sys::backtrace::BacktraceLock::print::DisplayBacktrace as core::fmt::Display>::fmt::h98c26ac25ffe89bb
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:39:26
[INFO] [stdout]    4:     0x57ee96a7a713 - core::fmt::rt::Argument::fmt::hf95377f4aebd453b
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/fmt/rt.rs:177:76
[INFO] [stdout]    5:     0x57ee96a7a713 - core::fmt::write::h0dd5f6e2238c7982
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/fmt/mod.rs:1189:21
[INFO] [stdout]    6:     0x57ee96a50f23 - std::io::Write::write_fmt::h03bb0ca26e6faf8c
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/io/mod.rs:1884:15
[INFO] [stdout]    7:     0x57ee96a54402 - std::sys::backtrace::BacktraceLock::print::h5c19c1c038ee186d
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:42:9
[INFO] [stdout]    8:     0x57ee96a55a3d - std::panicking::default_hook::{{closure}}::h77172f079a1fcb13
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:268:22
[INFO] [stdout]    9:     0x57ee96a55847 - std::panicking::default_hook::he5f8e3b203ccddba
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:292:9
[INFO] [stdout]   10:     0x57ee96a00597 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h7a3c7b4a1ae77f2f
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/alloc/src/boxed.rs:1986:9
[INFO] [stdout]   11:     0x57ee96a00597 - test::test_main::{{closure}}::hf0d3b69ae9b353d1
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:134:21
[INFO] [stdout]   12:     0x57ee96a560e8 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h6332e82e7b189abd
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/alloc/src/boxed.rs:1986:9
[INFO] [stdout]   13:     0x57ee96a560e8 - std::panicking::rust_panic_with_hook::h53863d4e9018df39
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:809:13
[INFO] [stdout]   14:     0x57ee96a55eaa - std::panicking::begin_panic_handler::{{closure}}::h67280e6fa0757873
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:674:13
[INFO] [stdout]   15:     0x57ee96a54a99 - std::sys::backtrace::__rust_end_short_backtrace::h1dac3f54d6fbbeb2
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:170:18
[INFO] [stdout]   16:     0x57ee96a55b3c - rust_begin_unwind
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:665:5
[INFO] [stdout]   17:     0x57ee9642e180 - core::panicking::panic_fmt::h6792bd1b2bf01041
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/panicking.rs:76:14
[INFO] [stdout]   18:     0x57ee9642e666 - core::result::unwrap_failed::h05e0602ed34287c5
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/result.rs:1699:5
[INFO] [stdout]   19:     0x57ee965cdfe1 - core::result::Result<T,E>::unwrap::h1335374be6788d21
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/result.rs:1104:23
[INFO] [stdout]   20:     0x57ee965cdfe1 - irving::tests::helpers::typeinference_from_filename::hc1eec639dc300dab
[INFO] [stdout]                                at /opt/rustwide/workdir/src/tests/mod.rs:108:20
[INFO] [stdout]   21:     0x57ee965d017a - irving::tests::programs::accord::typecheck_protocol::h3ad5db5d71742119
[INFO] [stdout]                                at /opt/rustwide/workdir/src/tests/programs.rs:78:20
[INFO] [stdout]   22:     0x57ee965d0147 - irving::tests::programs::accord::typecheck_protocol::{{closure}}::h750dc7b6e50a9a9d
[INFO] [stdout]                                at /opt/rustwide/workdir/src/tests/programs.rs:77:28
[INFO] [stdout]   23:     0x57ee965e5936 - core::ops::function::FnOnce::call_once::ha67713d3809e8e0c
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   24:     0x57ee96a050bb - core::ops::function::FnOnce::call_once::h871bf86719ec9aa4
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x57ee96a050bb - test::__rust_begin_short_backtrace::h2167df1e2b7d76fd
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:632:18
[INFO] [stdout]   26:     0x57ee96a04aa8 - test::run_test_in_process::{{closure}}::h15d92f75a3adfb79
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:655:60
[INFO] [stdout]   27:     0x57ee96a04aa8 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::hb6c8955835a8dbbb
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   28:     0x57ee96a04aa8 - std::panicking::try::do_call::hc79d0fc888a0bd30
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:557:40
[INFO] [stdout]   29:     0x57ee96a04aa8 - std::panicking::try::hb8a7878e3a8589d6
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:520:19
[INFO] [stdout]   30:     0x57ee96a04aa8 - std::panic::catch_unwind::hb8e4600ff0ff5cfa
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panic.rs:358:14
[INFO] [stdout]   31:     0x57ee96a04aa8 - test::run_test_in_process::hc2900b0b18688dd6
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:655:27
[INFO] [stdout]   32:     0x57ee96a04aa8 - test::run_test::{{closure}}::hac2a9cb07be3d48d
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:576:43
[INFO] [stdout]   33:     0x57ee969c854a - test::run_test::{{closure}}::h4a5b729e66a38cd8
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:606:41
[INFO] [stdout]   34:     0x57ee969c854a - std::sys::backtrace::__rust_begin_short_backtrace::h0496fb742492f573
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:154:18
[INFO] [stdout]   35:     0x57ee969cbec4 - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::hbb6d257c550a54bd
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/thread/mod.rs:561:17
[INFO] [stdout]   36:     0x57ee969cbec4 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h46696fe4a6832328
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   37:     0x57ee969cbec4 - std::panicking::try::do_call::h2625a51b667bfb64
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:557:40
[INFO] [stdout]   38:     0x57ee969cbec4 - std::panicking::try::hb956a59a1973aa4c
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:520:19
[INFO] [stdout]   39:     0x57ee969cbec4 - std::panic::catch_unwind::h64f3b9d1067ef6a0
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panic.rs:358:14
[INFO] [stdout]   40:     0x57ee969cbec4 - std::thread::Builder::spawn_unchecked_::{{closure}}::h42b2841295b6c0b2
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/thread/mod.rs:559:30
[INFO] [stdout]   41:     0x57ee969cbec4 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h6127de71b8124639
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   42:     0x57ee96a5a0bb - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h42f0ba71002a1b2c
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/alloc/src/boxed.rs:1972:9
[INFO] [stdout]   43:     0x57ee96a5a0bb - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::had9e47d7a3dcecb8
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/alloc/src/boxed.rs:1972:9
[INFO] [stdout]   44:     0x57ee96a5a0bb - std::sys::pal::unix::thread::Thread::new::thread_start::h48cf765408f6f5f2
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/pal/unix/thread.rs:105:17
[INFO] [stdout]   45:     0x7cd00b6bdac3 - <unknown>
[INFO] [stdout]   46:     0x7cd00b74ea04 - clone
[INFO] [stdout]   47:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- tests::programs::accord::typecheck_temporality stdout ----
[INFO] [stdout] thread 'tests::programs::accord::typecheck_temporality' 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:     0x57ee96a545ba - std::backtrace_rs::backtrace::libunwind::trace::h8810477743020387
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/../../backtrace/src/backtrace/libunwind.rs:116:5
[INFO] [stdout]    1:     0x57ee96a545ba - std::backtrace_rs::backtrace::trace_unsynchronized::h3aa55355dd6c54a6
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x57ee96a545ba - std::sys::backtrace::_print_fmt::h8588b0f62410823f
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:66:9
[INFO] [stdout]    3:     0x57ee96a545ba - <std::sys::backtrace::BacktraceLock::print::DisplayBacktrace as core::fmt::Display>::fmt::h98c26ac25ffe89bb
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:39:26
[INFO] [stdout]    4:     0x57ee96a7a713 - core::fmt::rt::Argument::fmt::hf95377f4aebd453b
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/fmt/rt.rs:177:76
[INFO] [stdout]    5:     0x57ee96a7a713 - core::fmt::write::h0dd5f6e2238c7982
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/fmt/mod.rs:1189:21
[INFO] [stdout]    6:     0x57ee96a50f23 - std::io::Write::write_fmt::h03bb0ca26e6faf8c
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/io/mod.rs:1884:15
[INFO] [stdout]    7:     0x57ee96a54402 - std::sys::backtrace::BacktraceLock::print::h5c19c1c038ee186d
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:42:9
[INFO] [stdout]    8:     0x57ee96a55a3d - std::panicking::default_hook::{{closure}}::h77172f079a1fcb13
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:268:22
[INFO] [stdout]    9:     0x57ee96a55847 - std::panicking::default_hook::he5f8e3b203ccddba
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:292:9
[INFO] [stdout]   10:     0x57ee96a00597 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h7a3c7b4a1ae77f2f
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/alloc/src/boxed.rs:1986:9
[INFO] [stdout]   11:     0x57ee96a00597 - test::test_main::{{closure}}::hf0d3b69ae9b353d1
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:134:21
[INFO] [stdout]   12:     0x57ee96a560e8 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h6332e82e7b189abd
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/alloc/src/boxed.rs:1986:9
[INFO] [stdout]   13:     0x57ee96a560e8 - std::panicking::rust_panic_with_hook::h53863d4e9018df39
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:809:13
[INFO] [stdout]   14:     0x57ee96a55eaa - std::panicking::begin_panic_handler::{{closure}}::h67280e6fa0757873
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:674:13
[INFO] [stdout]   15:     0x57ee96a54a99 - std::sys::backtrace::__rust_end_short_backtrace::h1dac3f54d6fbbeb2
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:170:18
[INFO] [stdout]   16:     0x57ee96a55b3c - rust_begin_unwind
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:665:5
[INFO] [stdout]   17:     0x57ee9642e180 - core::panicking::panic_fmt::h6792bd1b2bf01041
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/panicking.rs:76:14
[INFO] [stdout]   18:     0x57ee9642e666 - core::result::unwrap_failed::h05e0602ed34287c5
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/result.rs:1699:5
[INFO] [stdout]   19:     0x57ee965cdfe1 - core::result::Result<T,E>::unwrap::h1335374be6788d21
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/result.rs:1104:23
[INFO] [stdout]   20:     0x57ee965cdfe1 - irving::tests::helpers::typeinference_from_filename::hc1eec639dc300dab
[INFO] [stdout]                                at /opt/rustwide/workdir/src/tests/mod.rs:108:20
[INFO] [stdout]   21:     0x57ee965d00ba - irving::tests::programs::accord::typecheck_temporality::h868e226c8392d7d8
[INFO] [stdout]                                at /opt/rustwide/workdir/src/tests/programs.rs:68:20
[INFO] [stdout]   22:     0x57ee965d0087 - irving::tests::programs::accord::typecheck_temporality::{{closure}}::h008d23c924630857
[INFO] [stdout]                                at /opt/rustwide/workdir/src/tests/programs.rs:67:31
[INFO] [stdout]   23:     0x57ee965e2fd6 - core::ops::function::FnOnce::call_once::h286a3a87a19ed6d0
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   24:     0x57ee96a050bb - core::ops::function::FnOnce::call_once::h871bf86719ec9aa4
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x57ee96a050bb - test::__rust_begin_short_backtrace::h2167df1e2b7d76fd
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:632:18
[INFO] [stdout]   26:     0x57ee96a04aa8 - test::run_test_in_process::{{closure}}::h15d92f75a3adfb79
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:655:60
[INFO] [stdout]   27:     0x57ee96a04aa8 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::hb6c8955835a8dbbb
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   28:     0x57ee96a04aa8 - std::panicking::try::do_call::hc79d0fc888a0bd30
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:557:40
[INFO] [stdout]   29:     0x57ee96a04aa8 - std::panicking::try::hb8a7878e3a8589d6
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:520:19
[INFO] [stdout]   30:     0x57ee96a04aa8 - std::panic::catch_unwind::hb8e4600ff0ff5cfa
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panic.rs:358:14
[INFO] [stdout]   31:     0x57ee96a04aa8 - test::run_test_in_process::hc2900b0b18688dd6
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:655:27
[INFO] [stdout]   32:     0x57ee96a04aa8 - test::run_test::{{closure}}::hac2a9cb07be3d48d
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:576:43
[INFO] [stdout]   33:     0x57ee969c854a - test::run_test::{{closure}}::h4a5b729e66a38cd8
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:606:41
[INFO] [stdout]   34:     0x57ee969c854a - std::sys::backtrace::__rust_begin_short_backtrace::h0496fb742492f573
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:154:18
[INFO] [stdout]   35:     0x57ee969cbec4 - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::hbb6d257c550a54bd
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/thread/mod.rs:561:17
[INFO] [stdout]   36:     0x57ee969cbec4 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h46696fe4a6832328
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   37:     0x57ee969cbec4 - std::panicking::try::do_call::h2625a51b667bfb64
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:557:40
[INFO] [stdout]   38:     0x57ee969cbec4 - std::panicking::try::hb956a59a1973aa4c
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:520:19
[INFO] [stdout]   39:     0x57ee969cbec4 - std::panic::catch_unwind::h64f3b9d1067ef6a0
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panic.rs:358:14
[INFO] [stdout]   40:     0x57ee969cbec4 - std::thread::Builder::spawn_unchecked_::{{closure}}::h42b2841295b6c0b2
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/thread/mod.rs:559:30
[INFO] [stdout]   41:     0x57ee969cbec4 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h6127de71b8124639
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   42:     0x57ee96a5a0bb - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h42f0ba71002a1b2c
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/alloc/src/boxed.rs:1972:9
[INFO] [stdout]   43:     0x57ee96a5a0bb - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::had9e47d7a3dcecb8
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/alloc/src/boxed.rs:1972:9
[INFO] [stdout]   44:     0x57ee96a5a0bb - std::sys::pal::unix::thread::Thread::new::thread_start::h48cf765408f6f5f2
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/pal/unix/thread.rs:105:17
[INFO] [stdout]   45:     0x7cd00b6bdac3 - <unknown>
[INFO] [stdout]   46:     0x7cd00b74ea04 - clone
[INFO] [stdout]   47:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- tests::extraction::java::tests::extract_module_instantation stdout ----
[INFO] [stdout] [2024-12-14T12:43:58Z TRACE visitor] Decl Source:0 ("module pair(t) = { ...)
[INFO] [stdout] [2024-12-14T12:43:58Z TRACE binding] Inserting pair:SortVar(0) into context (depth 1)
[INFO] [stdout] [2024-12-14T12:43:58Z TRACE binding] Inserting this:This into context (depth 2)
[INFO] [stdout] [2024-12-14T12:43:58Z TRACE binding] Inserting init:Action([], List([]), Unit, Instance) into context (depth 2)
[INFO] [stdout] [2024-12-14T12:43:58Z TRACE binding] Inserting t:Generic(1, "t") into context (depth 2)
[INFO] [stdout] [2024-12-14T12:43:58Z TRACE visitor] Decl Source:1 ("x: t...)
[INFO] [stdout] [2024-12-14T12:43:58Z TRACE binding] Inserting x:Generic(1, "t") into context (depth 2)
[INFO] [stdout] [2024-12-14T12:43:58Z DEBUG sort-inference] unify(Generic(1, "t"),Generic(1, "t"))
[INFO] [stdout] [2024-12-14T12:43:58Z TRACE visitor] Decl Source:2 ("y: t...)
[INFO] [stdout] [2024-12-14T12:43:58Z TRACE binding] Inserting y:Generic(1, "t") into context (depth 2)
[INFO] [stdout] [2024-12-14T12:43:58Z DEBUG sort-inference] unify(Generic(1, "t"),Generic(1, "t"))
[INFO] [stdout] [2024-12-14T12:43:58Z 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] [2024-12-14T12:43:58Z TRACE visitor] Decl Source:0 ("instance nat_pair : pair(nat)")
[INFO] [stdout] [2024-12-14T12:43:58Z TRACE binding] Inserting nat_pair:SortVar(2) into context (depth 1)
[INFO] [stdout] [2024-12-14T12:43:58Z DEBUG sort-inference] unify(Generic(3, "t"),Number)
[INFO] [stdout] [2024-12-14T12:43:58Z 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] [2024-12-14T12:43:58Z TRACE visitor] Decl Source:0 ("instance nat_pair : pair(nat)")
[INFO] [stdout] thread 'tests::extraction::java::tests::extract_module_instantation' panicked at src/extraction/pprint.rs:29:13:
[INFO] [stdout] attempt to subtract with overflow
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x57ee96a545ba - std::backtrace_rs::backtrace::libunwind::trace::h8810477743020387
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/../../backtrace/src/backtrace/libunwind.rs:116:5
[INFO] [stdout]    1:     0x57ee96a545ba - std::backtrace_rs::backtrace::trace_unsynchronized::h3aa55355dd6c54a6
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x57ee96a545ba - std::sys::backtrace::_print_fmt::h8588b0f62410823f
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:66:9
[INFO] [stdout]    3:     0x57ee96a545ba - <std::sys::backtrace::BacktraceLock::print::DisplayBacktrace as core::fmt::Display>::fmt::h98c26ac25ffe89bb
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:39:26
[INFO] [stdout]    4:     0x57ee96a7a713 - core::fmt::rt::Argument::fmt::hf95377f4aebd453b
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/fmt/rt.rs:177:76
[INFO] [stdout]    5:     0x57ee96a7a713 - core::fmt::write::h0dd5f6e2238c7982
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/fmt/mod.rs:1189:21
[INFO] [stdout]    6:     0x57ee96a50f23 - std::io::Write::write_fmt::h03bb0ca26e6faf8c
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/io/mod.rs:1884:15
[INFO] [stdout]    7:     0x57ee96a54402 - std::sys::backtrace::BacktraceLock::print::h5c19c1c038ee186d
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:42:9
[INFO] [stdout]    8:     0x57ee96a55a3d - std::panicking::default_hook::{{closure}}::h77172f079a1fcb13
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:268:22
[INFO] [stdout]    9:     0x57ee96a55847 - std::panicking::default_hook::he5f8e3b203ccddba
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:292:9
[INFO] [stdout]   10:     0x57ee96a00597 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h7a3c7b4a1ae77f2f
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/alloc/src/boxed.rs:1986:9
[INFO] [stdout]   11:     0x57ee96a00597 - test::test_main::{{closure}}::hf0d3b69ae9b353d1
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:134:21
[INFO] [stdout]   12:     0x57ee96a560e8 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h6332e82e7b189abd
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/alloc/src/boxed.rs:1986:9
[INFO] [stdout]   13:     0x57ee96a560e8 - std::panicking::rust_panic_with_hook::h53863d4e9018df39
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:809:13
[INFO] [stdout]   14:     0x57ee96a55e76 - std::panicking::begin_panic_handler::{{closure}}::h67280e6fa0757873
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:667:13
[INFO] [stdout]   15:     0x57ee96a54a99 - std::sys::backtrace::__rust_end_short_backtrace::h1dac3f54d6fbbeb2
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:170:18
[INFO] [stdout]   16:     0x57ee96a55b3c - rust_begin_unwind
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:665:5
[INFO] [stdout]   17:     0x57ee9642e180 - core::panicking::panic_fmt::h6792bd1b2bf01041
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/panicking.rs:76:14
[INFO] [stdout]   18:     0x57ee9642e897 - core::panicking::panic_const::panic_const_sub_overflow::h71f1aad2a0839d29
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/panicking.rs:182:21
[INFO] [stdout]   19:     0x57ee9661a066 - <irving::extraction::pprint::PrettyPrinter<W> as core::fmt::Write>::write_str::h680234c80343b85f
[INFO] [stdout]                                at /opt/rustwide/workdir/src/extraction/pprint.rs:29:13
[INFO] [stdout]   20:     0x57ee9658c3d9 - <irving::extraction::java::extraction::Extractor<W> as irving::visitor::ast::Visitor<(),core::fmt::Error>>::begin_instance_decl::h633d8704ad2a77cd
[INFO] [stdout]                                at /opt/rustwide/workdir/src/extraction/java/extraction.rs:378:9
[INFO] [stdout]   21:     0x57ee96761469 - <irving::ast::declarations::Decl as irving::visitor::ast::Visitable<T,E>>::visit::h53427b73303b8d4d
[INFO] [stdout]                                at /opt/rustwide/workdir/src/visitor/ast.rs:1157:18
[INFO] [stdout]   22:     0x57ee966980b8 - irving::tests::extraction::java::tests::extract_module_instantation::ha6a21933e87d09dc
[INFO] [stdout]                                at /opt/rustwide/workdir/src/tests/extraction/java.rs:304:9
[INFO] [stdout]   23:     0x57ee96697f07 - irving::tests::extraction::java::tests::extract_module_instantation::{{closure}}::ha829599c6908dcc4
[INFO] [stdout]                                at /opt/rustwide/workdir/src/tests/extraction/java.rs:291:37
[INFO] [stdout]   24:     0x57ee965e7ba6 - core::ops::function::FnOnce::call_once::he0ef7115d662bca8
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x57ee96a050bb - core::ops::function::FnOnce::call_once::h871bf86719ec9aa4
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   26:     0x57ee96a050bb - test::__rust_begin_short_backtrace::h2167df1e2b7d76fd
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:632:18
[INFO] [stdout]   27:     0x57ee96a04aa8 - test::run_test_in_process::{{closure}}::h15d92f75a3adfb79
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:655:60
[INFO] [stdout]   28:     0x57ee96a04aa8 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::hb6c8955835a8dbbb
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   29:     0x57ee96a04aa8 - std::panicking::try::do_call::hc79d0fc888a0bd30
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:557:40
[INFO] [stdout]   30:     0x57ee96a04aa8 - std::panicking::try::hb8a7878e3a8589d6
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:520:19
[INFO] [stdout]   31:     0x57ee96a04aa8 - std::panic::catch_unwind::hb8e4600ff0ff5cfa
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panic.rs:358:14
[INFO] [stdout]   32:     0x57ee96a04aa8 - test::run_test_in_process::hc2900b0b18688dd6
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:655:27
[INFO] [stdout]   33:     0x57ee96a04aa8 - test::run_test::{{closure}}::hac2a9cb07be3d48d
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:576:43
[INFO] [stdout]   34:     0x57ee969c854a - test::run_test::{{closure}}::h4a5b729e66a38cd8
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:606:41
[INFO] [stdout]   35:     0x57ee969c854a - std::sys::backtrace::__rust_begin_short_backtrace::h0496fb742492f573
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:154:18
[INFO] [stdout]   36:     0x57ee969cbec4 - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::hbb6d257c550a54bd
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/thread/mod.rs:561:17
[INFO] [stdout]   37:     0x57ee969cbec4 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h46696fe4a6832328
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   38:     0x57ee969cbec4 - std::panicking::try::do_call::h2625a51b667bfb64
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:557:40
[INFO] [stdout]   39:     0x57ee969cbec4 - std::panicking::try::hb956a59a1973aa4c
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:520:19
[INFO] [stdout]   40:     0x57ee969cbec4 - std::panic::catch_unwind::h64f3b9d1067ef6a0
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panic.rs:358:14
[INFO] [stdout]   41:     0x57ee969cbec4 - std::thread::Builder::spawn_unchecked_::{{closure}}::h42b2841295b6c0b2
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/thread/mod.rs:559:30
[INFO] [stdout]   42:     0x57ee969cbec4 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h6127de71b8124639
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   43:     0x57ee96a5a0bb - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h42f0ba71002a1b2c
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/alloc/src/boxed.rs:1972:9
[INFO] [stdout]   44:     0x57ee96a5a0bb - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::had9e47d7a3dcecb8
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/alloc/src/boxed.rs:1972:9
[INFO] [stdout]   45:     0x57ee96a5a0bb - std::sys::pal::unix::thread::Thread::new::thread_start::h48cf765408f6f5f2
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/pal/unix/thread.rs:105:17
[INFO] [stdout]   46:     0x7cd00b6bdac3 - <unknown>
[INFO] [stdout]   47:     0x7cd00b74ea04 - clone
[INFO] [stdout]   48:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- tests::programs::accord::typecheck_messages stdout ----
[INFO] [stdout] thread 'tests::programs::accord::typecheck_messages' 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:     0x57ee96a545ba - std::backtrace_rs::backtrace::libunwind::trace::h8810477743020387
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/../../backtrace/src/backtrace/libunwind.rs:116:5
[INFO] [stdout]    1:     0x57ee96a545ba - std::backtrace_rs::backtrace::trace_unsynchronized::h3aa55355dd6c54a6
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x57ee96a545ba - std::sys::backtrace::_print_fmt::h8588b0f62410823f
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:66:9
[INFO] [stdout]    3:     0x57ee96a545ba - <std::sys::backtrace::BacktraceLock::print::DisplayBacktrace as core::fmt::Display>::fmt::h98c26ac25ffe89bb
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:39:26
[INFO] [stdout]    4:     0x57ee96a7a713 - core::fmt::rt::Argument::fmt::hf95377f4aebd453b
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/fmt/rt.rs:177:76
[INFO] [stdout]    5:     0x57ee96a7a713 - core::fmt::write::h0dd5f6e2238c7982
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/fmt/mod.rs:1189:21
[INFO] [stdout]    6:     0x57ee96a50f23 - std::io::Write::write_fmt::h03bb0ca26e6faf8c
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/io/mod.rs:1884:15
[INFO] [stdout]    7:     0x57ee96a54402 - std::sys::backtrace::BacktraceLock::print::h5c19c1c038ee186d
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:42:9
[INFO] [stdout]    8:     0x57ee96a55a3d - std::panicking::default_hook::{{closure}}::h77172f079a1fcb13
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:268:22
[INFO] [stdout]    9:     0x57ee96a55847 - std::panicking::default_hook::he5f8e3b203ccddba
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:292:9
[INFO] [stdout]   10:     0x57ee96a00597 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h7a3c7b4a1ae77f2f
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/alloc/src/boxed.rs:1986:9
[INFO] [stdout]   11:     0x57ee96a00597 - test::test_main::{{closure}}::hf0d3b69ae9b353d1
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:134:21
[INFO] [stdout]   12:     0x57ee96a560e8 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h6332e82e7b189abd
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/alloc/src/boxed.rs:1986:9
[INFO] [stdout]   13:     0x57ee96a560e8 - std::panicking::rust_panic_with_hook::h53863d4e9018df39
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:809:13
[INFO] [stdout]   14:     0x57ee96a55eaa - std::panicking::begin_panic_handler::{{closure}}::h67280e6fa0757873
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:674:13
[INFO] [stdout]   15:     0x57ee96a54a99 - std::sys::backtrace::__rust_end_short_backtrace::h1dac3f54d6fbbeb2
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:170:18
[INFO] [stdout]   16:     0x57ee96a55b3c - rust_begin_unwind
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:665:5
[INFO] [stdout]   17:     0x57ee9642e180 - core::panicking::panic_fmt::h6792bd1b2bf01041
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/panicking.rs:76:14
[INFO] [stdout]   18:     0x57ee9642e666 - core::result::unwrap_failed::h05e0602ed34287c5
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/result.rs:1699:5
[INFO] [stdout]   19:     0x57ee965cdfe1 - core::result::Result<T,E>::unwrap::h1335374be6788d21
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/result.rs:1104:23
[INFO] [stdout]   20:     0x57ee965cdfe1 - irving::tests::helpers::typeinference_from_filename::hc1eec639dc300dab
[INFO] [stdout]                                at /opt/rustwide/workdir/src/tests/mod.rs:108:20
[INFO] [stdout]   21:     0x57ee965cfffa - irving::tests::programs::accord::typecheck_messages::he218283d65235b34
[INFO] [stdout]                                at /opt/rustwide/workdir/src/tests/programs.rs:58:20
[INFO] [stdout]   22:     0x57ee965cffc7 - irving::tests::programs::accord::typecheck_messages::{{closure}}::hd0afa64c734af156
[INFO] [stdout]                                at /opt/rustwide/workdir/src/tests/programs.rs:57:28
[INFO] [stdout]   23:     0x57ee965e4366 - core::ops::function::FnOnce::call_once::h68166f1090d02183
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   24:     0x57ee96a050bb - core::ops::function::FnOnce::call_once::h871bf86719ec9aa4
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x57ee96a050bb - test::__rust_begin_short_backtrace::h2167df1e2b7d76fd
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:632:18
[INFO] [stdout]   26:     0x57ee96a04aa8 - test::run_test_in_process::{{closure}}::h15d92f75a3adfb79
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:655:60
[INFO] [stdout]   27:     0x57ee96a04aa8 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::hb6c8955835a8dbbb
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   28:     0x57ee96a04aa8 - std::panicking::try::do_call::hc79d0fc888a0bd30
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:557:40
[INFO] [stdout]   29:     0x57ee96a04aa8 - std::panicking::try::hb8a7878e3a8589d6
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:520:19
[INFO] [stdout]   30:     0x57ee96a04aa8 - std::panic::catch_unwind::hb8e4600ff0ff5cfa
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panic.rs:358:14
[INFO] [stdout]   31:     0x57ee96a04aa8 - test::run_test_in_process::hc2900b0b18688dd6
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:655:27
[INFO] [stdout]   32:     0x57ee96a04aa8 - test::run_test::{{closure}}::hac2a9cb07be3d48d
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:576:43
[INFO] [stdout]   33:     0x57ee969c854a - test::run_test::{{closure}}::h4a5b729e66a38cd8
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:606:41
[INFO] [stdout]   34:     0x57ee969c854a - std::sys::backtrace::__rust_begin_short_backtrace::h0496fb742492f573
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:154:18
[INFO] [stdout]   35:     0x57ee969cbec4 - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::hbb6d257c550a54bd
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/thread/mod.rs:561:17
[INFO] [stdout]   36:     0x57ee969cbec4 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h46696fe4a6832328
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   37:     0x57ee969cbec4 - std::panicking::try::do_call::h2625a51b667bfb64
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:557:40
[INFO] [stdout]   38:     0x57ee969cbec4 - std::panicking::try::hb956a59a1973aa4c
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:520:19
[INFO] [stdout]   39:     0x57ee969cbec4 - std::panic::catch_unwind::h64f3b9d1067ef6a0
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panic.rs:358:14
[INFO] [stdout]   40:     0x57ee969cbec4 - std::thread::Builder::spawn_unchecked_::{{closure}}::h42b2841295b6c0b2
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/thread/mod.rs:559:30
[INFO] [stdout]   41:     0x57ee969cbec4 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h6127de71b8124639
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   42:     0x57ee96a5a0bb - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h42f0ba71002a1b2c
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/alloc/src/boxed.rs:1972:9
[INFO] [stdout]   43:     0x57ee96a5a0bb - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::had9e47d7a3dcecb8
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/alloc/src/boxed.rs:1972:9
[INFO] [stdout]   44:     0x57ee96a5a0bb - std::sys::pal::unix::thread::Thread::new::thread_start::h48cf765408f6f5f2
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/pal/unix/thread.rs:105:17
[INFO] [stdout]   45:     0x7cd00b6bdac3 - <unknown>
[INFO] [stdout]   46:     0x7cd00b74ea04 - clone
[INFO] [stdout]   47:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- tests::programs::accord::typecheck_txn stdout ----
[INFO] [stdout] thread 'tests::programs::accord::typecheck_txn' 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:     0x57ee96a545ba - std::backtrace_rs::backtrace::libunwind::trace::h8810477743020387
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/../../backtrace/src/backtrace/libunwind.rs:116:5
[INFO] [stdout]    1:     0x57ee96a545ba - std::backtrace_rs::backtrace::trace_unsynchronized::h3aa55355dd6c54a6
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x57ee96a545ba - std::sys::backtrace::_print_fmt::h8588b0f62410823f
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:66:9
[INFO] [stdout]    3:     0x57ee96a545ba - <std::sys::backtrace::BacktraceLock::print::DisplayBacktrace as core::fmt::Display>::fmt::h98c26ac25ffe89bb
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:39:26
[INFO] [stdout]    4:     0x57ee96a7a713 - core::fmt::rt::Argument::fmt::hf95377f4aebd453b
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/fmt/rt.rs:177:76
[INFO] [stdout]    5:     0x57ee96a7a713 - core::fmt::write::h0dd5f6e2238c7982
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/fmt/mod.rs:1189:21
[INFO] [stdout]    6:     0x57ee96a50f23 - std::io::Write::write_fmt::h03bb0ca26e6faf8c
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/io/mod.rs:1884:15
[INFO] [stdout]    7:     0x57ee96a54402 - std::sys::backtrace::BacktraceLock::print::h5c19c1c038ee186d
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:42:9
[INFO] [stdout]    8:     0x57ee96a55a3d - std::panicking::default_hook::{{closure}}::h77172f079a1fcb13
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:268:22
[INFO] [stdout]    9:     0x57ee96a55847 - std::panicking::default_hook::he5f8e3b203ccddba
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:292:9
[INFO] [stdout]   10:     0x57ee96a00597 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h7a3c7b4a1ae77f2f
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/alloc/src/boxed.rs:1986:9
[INFO] [stdout]   11:     0x57ee96a00597 - test::test_main::{{closure}}::hf0d3b69ae9b353d1
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:134:21
[INFO] [stdout]   12:     0x57ee96a560e8 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h6332e82e7b189abd
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/alloc/src/boxed.rs:1986:9
[INFO] [stdout]   13:     0x57ee96a560e8 - std::panicking::rust_panic_with_hook::h53863d4e9018df39
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:809:13
[INFO] [stdout]   14:     0x57ee96a55eaa - std::panicking::begin_panic_handler::{{closure}}::h67280e6fa0757873
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:674:13
[INFO] [stdout]   15:     0x57ee96a54a99 - std::sys::backtrace::__rust_end_short_backtrace::h1dac3f54d6fbbeb2
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:170:18
[INFO] [stdout]   16:     0x57ee96a55b3c - rust_begin_unwind
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:665:5
[INFO] [stdout]   17:     0x57ee9642e180 - core::panicking::panic_fmt::h6792bd1b2bf01041
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/panicking.rs:76:14
[INFO] [stdout]   18:     0x57ee9642e666 - core::result::unwrap_failed::h05e0602ed34287c5
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/result.rs:1699:5
[INFO] [stdout]   19:     0x57ee965cdfe1 - core::result::Result<T,E>::unwrap::h1335374be6788d21
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/result.rs:1104:23
[INFO] [stdout]   20:     0x57ee965cdfe1 - irving::tests::helpers::typeinference_from_filename::hc1eec639dc300dab
[INFO] [stdout]                                at /opt/rustwide/workdir/src/tests/mod.rs:108:20
[INFO] [stdout]   21:     0x57ee965d011a - irving::tests::programs::accord::typecheck_txn::h11a425c8b55a4e31
[INFO] [stdout]                                at /opt/rustwide/workdir/src/tests/programs.rs:73:20
[INFO] [stdout]   22:     0x57ee965d00e7 - irving::tests::programs::accord::typecheck_txn::{{closure}}::hd1d37755feb8bae2
[INFO] [stdout]                                at /opt/rustwide/workdir/src/tests/programs.rs:72:23
[INFO] [stdout]   23:     0x57ee965e4e36 - core::ops::function::FnOnce::call_once::h843f1429ef19de57
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   24:     0x57ee96a050bb - core::ops::function::FnOnce::call_once::h871bf86719ec9aa4
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x57ee96a050bb - test::__rust_begin_short_backtrace::h2167df1e2b7d76fd
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:632:18
[INFO] [stdout]   26:     0x57ee96a04aa8 - test::run_test_in_process::{{closure}}::h15d92f75a3adfb79
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:655:60
[INFO] [stdout]   27:     0x57ee96a04aa8 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::hb6c8955835a8dbbb
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   28:     0x57ee96a04aa8 - std::panicking::try::do_call::hc79d0fc888a0bd30
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:557:40
[INFO] [stdout]   29:     0x57ee96a04aa8 - std::panicking::try::hb8a7878e3a8589d6
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:520:19
[INFO] [stdout]   30:     0x57ee96a04aa8 - std::panic::catch_unwind::hb8e4600ff0ff5cfa
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panic.rs:358:14
[INFO] [stdout]   31:     0x57ee96a04aa8 - test::run_test_in_process::hc2900b0b18688dd6
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:655:27
[INFO] [stdout]   32:     0x57ee96a04aa8 - test::run_test::{{closure}}::hac2a9cb07be3d48d
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:576:43
[INFO] [stdout]   33:     0x57ee969c854a - test::run_test::{{closure}}::h4a5b729e66a38cd8
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:606:41
[INFO] [stdout]   34:     0x57ee969c854a - std::sys::backtrace::__rust_begin_short_backtrace::h0496fb742492f573
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:154:18
[INFO] [stdout]   35:     0x57ee969cbec4 - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::hbb6d257c550a54bd
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/thread/mod.rs:561:17
[INFO] [stdout]   36:     0x57ee969cbec4 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h46696fe4a6832328
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   37:     0x57ee969cbec4 - std::panicking::try::do_call::h2625a51b667bfb64
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:557:40
[INFO] [stdout]   38:     0x57ee969cbec4 - std::panicking::try::hb956a59a1973aa4c
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:520:19
[INFO] [stdout]   39:     0x57ee969cbec4 - std::panic::catch_unwind::h64f3b9d1067ef6a0
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panic.rs:358:14
[INFO] [stdout]   40:     0x57ee969cbec4 - std::thread::Builder::spawn_unchecked_::{{closure}}::h42b2841295b6c0b2
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/thread/mod.rs:559:30
[INFO] [stdout]   41:     0x57ee969cbec4 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h6127de71b8124639
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   42:     0x57ee96a5a0bb - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h42f0ba71002a1b2c
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/alloc/src/boxed.rs:1972:9
[INFO] [stdout]   43:     0x57ee96a5a0bb - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::had9e47d7a3dcecb8
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/alloc/src/boxed.rs:1972:9
[INFO] [stdout]   44:     0x57ee96a5a0bb - std::sys::pal::unix::thread::Thread::new::thread_start::h48cf765408f6f5f2
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/pal/unix/thread.rs:105:17
[INFO] [stdout]   45:     0x7cd00b6bdac3 - <unknown>
[INFO] [stdout]   46:     0x7cd00b74ea04 - clone
[INFO] [stdout]   47:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- tests::typechecker::modules::tests::instantiation_with_impl_spec_blocks stdout ----
[INFO] [stdout] [2024-12-14T12:43:58Z TRACE binding] Inserting top:SortVar(0) into context (depth 1)
[INFO] [stdout] [2024-12-14T12:43:58Z TRACE binding] Inserting init:Action([], List([]), Unit, Instance) into context (depth 2)
[INFO] [stdout] [2024-12-14T12:43:58Z TRACE visitor] Decl Source:2 ("module counter = {...)
[INFO] [stdout] [2024-12-14T12:43:58Z TRACE binding] Inserting counter:SortVar(1) into context (depth 2)
[INFO] [stdout] [2024-12-14T12:43:58Z TRACE binding] Inserting this:This into context (depth 3)
[INFO] [stdout] [2024-12-14T12:43:58Z TRACE binding] Inserting init:Action([], List([]), Unit, Instance) into context (depth 3)
[INFO] [stdout] [2024-12-14T12:43:58Z TRACE visitor] Decl Source:3 ("implementation {...)
[INFO] [stdout] [2024-12-14T12:43:58Z TRACE binding] Inserting impl:SortVar(2) into context (depth 3)
[INFO] [stdout] [2024-12-14T12:43:58Z TRACE binding] Inserting init:Action([], List([]), Unit, Instance) into context (depth 3)
[INFO] [stdout] [2024-12-14T12:43:58Z TRACE visitor] Decl Source:4 ("val : nat...)
[INFO] [stdout] [2024-12-14T12:43:58Z TRACE binding] Inserting val:Number into context (depth 3)
[INFO] [stdout] [2024-12-14T12:43:58Z DEBUG sort-inference] unify(Number,Number)
[INFO] [stdout] [2024-12-14T12:43:58Z TRACE visitor] Decl Source:5 ("after init { val := 0 }")
[INFO] [stdout] [2024-12-14T12:43:58Z TRACE visitor] Vec<Stmt> (len 1)
[INFO] [stdout] [2024-12-14T12:43:58Z TRACE visitor] Action Source:5 ("val := 0 ")
[INFO] [stdout] [2024-12-14T12:43:58Z TRACE visitor] Expr ProgramSymbol { sym: Binding { name: "val", decl: ToBeInferred, span: Source:5 ("val") } }
[INFO] [stdout] [2024-12-14T12:43:58Z TRACE visitor] Expr Number { span: Source:5 ("0"), val: 0 }
[INFO] [stdout] [2024-12-14T12:43:58Z DEBUG sort-inference] unify(Number,Number)
[INFO] [stdout] [2024-12-14T12:43:58Z DEBUG sort-inference] unify(Action([], List([]), Unit, Instance),SortVar(3))
[INFO] [stdout] [2024-12-14T12:43:58Z DEBUG sort-inference] unify(SortVar(2),Object(Object { args: [], fields: {"init": Action([], List([]), Unit, Instance), "val": Number} }))
[INFO] [stdout] [2024-12-14T12:43:58Z 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] [2024-12-14T12:43:58Z TRACE visitor] Decl Source:9 ("instance c : counter...)
[INFO] [stdout] [2024-12-14T12:43:58Z TRACE binding] Inserting c:SortVar(4) into context (depth 2)
[INFO] [stdout] [2024-12-14T12:43:58Z 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] [2024-12-14T12:43:58Z TRACE visitor] Decl Source:10 ("v : nat...)
[INFO] [stdout] [2024-12-14T12:43:58Z TRACE binding] Inserting v:Number into context (depth 2)
[INFO] [stdout] [2024-12-14T12:43:58Z DEBUG sort-inference] unify(Number,Number)
[INFO] [stdout] [2024-12-14T12:43:58Z TRACE visitor] Decl IgnoredForTesting
[INFO] [stdout] [2024-12-14T12:43:58Z TRACE visitor] Vec<Stmt> (len 1)
[INFO] [stdout] [2024-12-14T12:43:58Z 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] [2024-12-14T12:43:58Z TRACE visitor] Expr ProgramSymbol { sym: Binding { name: "v", decl: ToBeInferred, span: Source:11 ("v") } }
[INFO] [stdout] [2024-12-14T12:43:58Z 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] [2024-12-14T12:43:58Z 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] thread 'tests::typechecker::modules::tests::instantiation_with_impl_spec_blocks' 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:     0x57ee96a545ba - std::backtrace_rs::backtrace::libunwind::trace::h8810477743020387
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/../../backtrace/src/backtrace/libunwind.rs:116:5
[INFO] [stdout]    1:     0x57ee96a545ba - std::backtrace_rs::backtrace::trace_unsynchronized::h3aa55355dd6c54a6
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x57ee96a545ba - std::sys::backtrace::_print_fmt::h8588b0f62410823f
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:66:9
[INFO] [stdout]    3:     0x57ee96a545ba - <std::sys::backtrace::BacktraceLock::print::DisplayBacktrace as core::fmt::Display>::fmt::h98c26ac25ffe89bb
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:39:26
[INFO] [stdout]    4:     0x57ee96a7a713 - core::fmt::rt::Argument::fmt::hf95377f4aebd453b
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/fmt/rt.rs:177:76
[INFO] [stdout]    5:     0x57ee96a7a713 - core::fmt::write::h0dd5f6e2238c7982
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/fmt/mod.rs:1189:21
[INFO] [stdout]    6:     0x57ee96a50f23 - std::io::Write::write_fmt::h03bb0ca26e6faf8c
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/io/mod.rs:1884:15
[INFO] [stdout]    7:     0x57ee96a54402 - std::sys::backtrace::BacktraceLock::print::h5c19c1c038ee186d
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:42:9
[INFO] [stdout]    8:     0x57ee96a55a3d - std::panicking::default_hook::{{closure}}::h77172f079a1fcb13
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:268:22
[INFO] [stdout]    9:     0x57ee96a55847 - std::panicking::default_hook::he5f8e3b203ccddba
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:292:9
[INFO] [stdout]   10:     0x57ee96a00597 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h7a3c7b4a1ae77f2f
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/alloc/src/boxed.rs:1986:9
[INFO] [stdout]   11:     0x57ee96a00597 - test::test_main::{{closure}}::hf0d3b69ae9b353d1
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:134:21
[INFO] [stdout]   12:     0x57ee96a560e8 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h6332e82e7b189abd
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/alloc/src/boxed.rs:1986:9
[INFO] [stdout]   13:     0x57ee96a560e8 - std::panicking::rust_panic_with_hook::h53863d4e9018df39
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:809:13
[INFO] [stdout]   14:     0x57ee96a55eaa - std::panicking::begin_panic_handler::{{closure}}::h67280e6fa0757873
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:674:13
[INFO] [stdout]   15:     0x57ee96a54a99 - std::sys::backtrace::__rust_end_short_backtrace::h1dac3f54d6fbbeb2
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:170:18
[INFO] [stdout]   16:     0x57ee96a55b3c - rust_begin_unwind
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:665:5
[INFO] [stdout]   17:     0x57ee9642e180 - core::panicking::panic_fmt::h6792bd1b2bf01041
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/panicking.rs:76:14
[INFO] [stdout]   18:     0x57ee9642e666 - core::result::unwrap_failed::h05e0602ed34287c5
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/result.rs:1699:5
[INFO] [stdout]   19:     0x57ee965b1b84 - core::result::Result<T,E>::unwrap::h84d55e84e017dd60
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/result.rs:1104:23
[INFO] [stdout]   20:     0x57ee965b1b84 - irving::tests::typechecker::modules::tests::instantiation_with_impl_spec_blocks::hc25f0e9e2f91b545
[INFO] [stdout]                                at /opt/rustwide/workdir/src/tests/typechecker/modules.rs:191:20
[INFO] [stdout]   21:     0x57ee965b1a27 - irving::tests::typechecker::modules::tests::instantiation_with_impl_spec_blocks::{{closure}}::hdaa4e16a801c58a3
[INFO] [stdout]                                at /opt/rustwide/workdir/src/tests/typechecker/modules.rs:173:45
[INFO] [stdout]   22:     0x57ee965e8236 - core::ops::function::FnOnce::call_once::hfa9496da67b7a125
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   23:     0x57ee96a050bb - core::ops::function::FnOnce::call_once::h871bf86719ec9aa4
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   24:     0x57ee96a050bb - test::__rust_begin_short_backtrace::h2167df1e2b7d76fd
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:632:18
[INFO] [stdout]   25:     0x57ee96a04aa8 - test::run_test_in_process::{{closure}}::h15d92f75a3adfb79
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:655:60
[INFO] [stdout]   26:     0x57ee96a04aa8 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::hb6c8955835a8dbbb
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   27:     0x57ee96a04aa8 - std::panicking::try::do_call::hc79d0fc888a0bd30
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:557:40
[INFO] [stdout]   28:     0x57ee96a04aa8 - std::panicking::try::hb8a7878e3a8589d6
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:520:19
[INFO] [stdout]   29:     0x57ee96a04aa8 - std::panic::catch_unwind::hb8e4600ff0ff5cfa
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panic.rs:358:14
[INFO] [stdout]   30:     0x57ee96a04aa8 - test::run_test_in_process::hc2900b0b18688dd6
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:655:27
[INFO] [stdout]   31:     0x57ee96a04aa8 - test::run_test::{{closure}}::hac2a9cb07be3d48d
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:576:43
[INFO] [stdout]   32:     0x57ee969c854a - test::run_test::{{closure}}::h4a5b729e66a38cd8
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:606:41
[INFO] [stdout]   33:     0x57ee969c854a - std::sys::backtrace::__rust_begin_short_backtrace::h0496fb742492f573
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:154:18
[INFO] [stdout]   34:     0x57ee969cbec4 - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::hbb6d257c550a54bd
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/thread/mod.rs:561:17
[INFO] [stdout]   35:     0x57ee969cbec4 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h46696fe4a6832328
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   36:     0x57ee969cbec4 - std::panicking::try::do_call::h2625a51b667bfb64
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:557:40
[INFO] [stdout]   37:     0x57ee969cbec4 - std::panicking::try::hb956a59a1973aa4c
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:520:19
[INFO] [stdout]   38:     0x57ee969cbec4 - std::panic::catch_unwind::h64f3b9d1067ef6a0
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panic.rs:358:14
[INFO] [stdout]   39:     0x57ee969cbec4 - std::thread::Builder::spawn_unchecked_::{{closure}}::h42b2841295b6c0b2
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/thread/mod.rs:559:30
[INFO] [stdout]   40:     0x57ee969cbec4 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h6127de71b8124639
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   41:     0x57ee96a5a0bb - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h42f0ba71002a1b2c
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/alloc/src/boxed.rs:1972:9
[INFO] [stdout]   42:     0x57ee96a5a0bb - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::had9e47d7a3dcecb8
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/alloc/src/boxed.rs:1972:9
[INFO] [stdout]   43:     0x57ee96a5a0bb - std::sys::pal::unix::thread::Thread::new::thread_start::h48cf765408f6f5f2
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/pal/unix/thread.rs:105:17
[INFO] [stdout]   44:     0x7cd00b6bdac3 - <unknown>
[INFO] [stdout]   45:     0x7cd00b74ea04 - 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.81s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass `--lib`
[INFO] running `Command { std: "docker" "inspect" "81b762fee910d66114877f27b3b014b5294c2c86f5c47df3a9ba2d3e1ad4cb06", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "81b762fee910d66114877f27b3b014b5294c2c86f5c47df3a9ba2d3e1ad4cb06", kill_on_drop: false }`
[INFO] [stdout] 81b762fee910d66114877f27b3b014b5294c2c86f5c47df3a9ba2d3e1ad4cb06
