[INFO] cloning repository https://github.com/joefreeman/quiver
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/joefreeman/quiver" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fjoefreeman%2Fquiver", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fjoefreeman%2Fquiver'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 099599e9f9e9702876dbe4f877e6afa5432cde17
[INFO] testing joefreeman/quiver against 1.94.0 for beta-1.95-1
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fjoefreeman%2Fquiver" "/workspace/builds/worker-3-tc1/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-3-tc1/source'...
[INFO] [stderr] done.
[INFO] started tweaking git repo https://github.com/joefreeman/quiver
[INFO] finished tweaking git repo https://github.com/joefreeman/quiver
[INFO] tweaked toml for git repo https://github.com/joefreeman/quiver written to /workspace/builds/worker-3-tc1/source/Cargo.toml
[INFO] validating manifest of git repo https://github.com/joefreeman/quiver on toolchain 1.94.0
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.94.0" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate git repo https://github.com/joefreeman/quiver 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" "+1.94.0" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded clap v4.5.49
[INFO] [stderr]   Downloaded gloo-utils v0.1.7
[INFO] [stderr]   Downloaded include_dir_macros v0.7.4
[INFO] [stderr]   Downloaded serde_derive_internals v0.28.0
[INFO] [stderr]   Downloaded ariadne v0.4.1
[INFO] [stderr]   Downloaded include_dir v0.7.4
[INFO] [stderr]   Downloaded nom_locate v4.2.0
[INFO] [stderr]   Downloaded tsify-macros v0.4.5
[INFO] [stderr]   Downloaded rustyline v14.0.0
[INFO] [stderr]   Downloaded tsify v0.4.5
[INFO] [stderr]   Downloaded clap_builder v4.5.49
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+1.94.0" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] b85e9684696353daa109edd0eb24977459d34f3995bc16f315479e2e7a5646f8
[INFO] running `Command { std: "docker" "start" "-a" "b85e9684696353daa109edd0eb24977459d34f3995bc16f315479e2e7a5646f8", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "b85e9684696353daa109edd0eb24977459d34f3995bc16f315479e2e7a5646f8", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "b85e9684696353daa109edd0eb24977459d34f3995bc16f315479e2e7a5646f8", kill_on_drop: false }`
[INFO] [stdout] b85e9684696353daa109edd0eb24977459d34f3995bc16f315479e2e7a5646f8
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+1.94.0" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 4d77ebe13340df54267b5b31a48a165a4c14a45bad2f44896457fe32e90c8116
[INFO] running `Command { std: "docker" "start" "-a" "4d77ebe13340df54267b5b31a48a165a4c14a45bad2f44896457fe32e90c8116", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v1.0.101
[INFO] [stderr]    Compiling log v0.4.28
[INFO] [stderr]    Compiling wasm-bindgen-shared v0.2.104
[INFO] [stderr]    Compiling bumpalo v3.19.0
[INFO] [stderr]    Compiling memchr v2.7.5
[INFO] [stderr]    Compiling libc v0.2.177
[INFO] [stderr]    Compiling serde_json v1.0.143
[INFO] [stderr]    Compiling once_cell v1.21.3
[INFO] [stderr]    Compiling bytecount v0.6.9
[INFO] [stderr]    Compiling bitflags v2.9.4
[INFO] [stderr]    Compiling rustix v1.1.2
[INFO] [stderr]    Compiling nix v0.28.0
[INFO] [stderr]    Compiling anstyle-query v1.1.4
[INFO] [stderr]    Compiling wasm-bindgen v0.2.104
[INFO] [stderr]    Compiling io-uring v0.6.4
[INFO] [stderr]    Compiling nibble_vec v0.1.0
[INFO] [stderr]    Compiling anstream v0.6.21
[INFO] [stderr]    Compiling clap_lex v0.7.6
[INFO] [stderr]    Compiling unicode-width v0.1.14
[INFO] [stderr]    Compiling radix_trie v0.2.1
[INFO] [stderr]    Compiling yansi v1.0.1
[INFO] [stderr]    Compiling home v0.5.11
[INFO] [stderr]    Compiling unicode-segmentation v1.12.0
[INFO] [stderr]    Compiling colored v2.2.0
[INFO] [stderr]    Compiling clap_builder v4.5.49
[INFO] [stderr]    Compiling ariadne v0.4.1
[INFO] [stderr]    Compiling nom v7.1.3
[INFO] [stderr]    Compiling quote v1.0.40
[INFO] [stderr]    Compiling syn v2.0.106
[INFO] [stderr]    Compiling include_dir_macros v0.7.4
[INFO] [stderr]    Compiling include_dir v0.7.4
[INFO] [stderr]    Compiling socket2 v0.5.10
[INFO] [stderr]    Compiling nom_locate v4.2.0
[INFO] [stderr]    Compiling fd-lock v4.0.4
[INFO] [stderr]    Compiling rustyline v14.0.0
[INFO] [stderr]    Compiling wasm-bindgen-backend v0.2.104
[INFO] [stderr]    Compiling serde_derive_internals v0.28.0
[INFO] [stderr]    Compiling serde_derive v1.0.219
[INFO] [stderr]    Compiling clap_derive v4.5.49
[INFO] [stderr]    Compiling tsify-macros v0.4.5
[INFO] [stderr]    Compiling wasm-bindgen-macro-support v0.2.104
[INFO] [stderr]    Compiling wasm-bindgen-macro v0.2.104
[INFO] [stderr]    Compiling clap v4.5.49
[INFO] [stderr]    Compiling js-sys v0.3.81
[INFO] [stderr]    Compiling console_error_panic_hook v0.1.7
[INFO] [stderr]    Compiling serde v1.0.219
[INFO] [stderr]    Compiling quiver-core v0.3.0 (/opt/rustwide/workdir/quiver-core)
[INFO] [stderr]    Compiling web-sys v0.3.81
[INFO] [stderr]    Compiling serde-wasm-bindgen v0.6.5
[INFO] [stderr]    Compiling quiver-compiler v0.3.0 (/opt/rustwide/workdir/quiver-compiler)
[INFO] [stderr]    Compiling quiver-io v0.3.0 (/opt/rustwide/workdir/quiver-io)
[INFO] [stderr]    Compiling quiver-environment v0.3.0 (/opt/rustwide/workdir/quiver-environment)
[INFO] [stderr]    Compiling quiver-cli v0.3.0 (/opt/rustwide/workdir/quiver-cli)
[INFO] [stderr]    Compiling gloo-utils v0.1.7
[INFO] [stderr]    Compiling tsify v0.4.5
[INFO] [stderr]    Compiling quiver-web v0.3.0 (/opt/rustwide/workdir/quiver-web)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 45.40s
[INFO] running `Command { std: "docker" "inspect" "4d77ebe13340df54267b5b31a48a165a4c14a45bad2f44896457fe32e90c8116", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "4d77ebe13340df54267b5b31a48a165a4c14a45bad2f44896457fe32e90c8116", kill_on_drop: false }`
[INFO] [stdout] 4d77ebe13340df54267b5b31a48a165a4c14a45bad2f44896457fe32e90c8116
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+1.94.0" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 67f5ef48d0dd2032b7495dadefcf00ca52f53453212dc90748b850ad08b855da
[INFO] running `Command { std: "docker" "start" "-a" "67f5ef48d0dd2032b7495dadefcf00ca52f53453212dc90748b850ad08b855da", kill_on_drop: false }`
[INFO] [stderr]    Compiling quiver-io v0.3.0 (/opt/rustwide/workdir/quiver-io)
[INFO] [stderr]    Compiling quiver-environment v0.3.0 (/opt/rustwide/workdir/quiver-environment)
[INFO] [stderr]    Compiling quiver-compiler v0.3.0 (/opt/rustwide/workdir/quiver-compiler)
[INFO] [stderr]    Compiling quiver-cli v0.3.0 (/opt/rustwide/workdir/quiver-cli)
[INFO] [stderr]    Compiling quiver-core v0.3.0 (/opt/rustwide/workdir/quiver-core)
[INFO] [stderr]    Compiling quiver-tests v0.3.0 (/opt/rustwide/workdir/quiver-tests)
[INFO] [stderr]    Compiling quiver-web v0.3.0 (/opt/rustwide/workdir/quiver-web)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 37.17s
[INFO] running `Command { std: "docker" "inspect" "67f5ef48d0dd2032b7495dadefcf00ca52f53453212dc90748b850ad08b855da", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "67f5ef48d0dd2032b7495dadefcf00ca52f53453212dc90748b850ad08b855da", kill_on_drop: false }`
[INFO] [stdout] 67f5ef48d0dd2032b7495dadefcf00ca52f53453212dc90748b850ad08b855da
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+1.94.0" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] e2e69f65880aac11f8b5eb75fd4c5a601ad7e2ea0f7375cb5dccecab1b576d23
[INFO] running `Command { std: "docker" "start" "-a" "e2e69f65880aac11f8b5eb75fd4c5a601ad7e2ea0f7375cb5dccecab1b576d23", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.16s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/quiver_cli-9b7b75c5c466f328)
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/debug/deps/quiv-cffb604c0740fdc4)
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/quiver_compiler-4e8562174ee511f6)
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 14 tests
[INFO] [stdout] test parser::tests::test_span_malformed_hex ... ok
[INFO] [stdout] test parser::tests::test_context_detection_unterminated_string ... ok
[INFO] [stdout] test parser::tests::test_valid_program_parses ... ok
[INFO] [stdout] test parser::tests::test_span_invalid_escape_sequence ... ok
[INFO] [stdout] test parser::tests::test_span_error_at_end ... ok
[INFO] [stdout] test parser::tests::test_error_has_span ... ok
[INFO] [stdout] test parser::tests::test_context_detection_unclosed_tuple ... ok
[INFO] [stdout] test parser::tests::test_span_error_at_start ... ok
[INFO] [stdout] test parser::tests::test_span_process_ref_malformed ... ok
[INFO] [stdout] test parser::tests::test_context_detection_function_body ... ok
[INFO] [stdout] test parser::tests::test_context_detection_unclosed_block ... ok
[INFO] [stdout] test parser::tests::test_span_multiline_error ... ok
[INFO] [stdout] test parser::tests::test_span_with_unicode ... ok
[INFO] [stdout] test parser::tests::test_span_malformed_integer ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 14 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/quiver_core-df1541697d8cf4bd)
[INFO] [stdout] 
[INFO] [stdout] running 8 tests
[INFO] [stdout] test binary::tests::test_concat ... ok
[INFO] [stdout] test binary::tests::test_nested_operations ... ok
[INFO] [stdout] test binary::tests::test_iterator ... ok
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/quiver_environment-7c4ea71039aeaee1)
[INFO] [stdout] test binary::tests::test_slice ... ok
[INFO] [stdout] test binary::tests::test_slice_bounds ... ok
[INFO] [stdout] test binary::tests::test_zeroed ... ok
[INFO] [stdout] test binary::tests::test_owned ... ok
[INFO] [stdout] test binary::tests::test_depth ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 8 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/quiver_io-c462787bb67cef89)
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/access.rs (/opt/rustwide/target/debug/deps/access-433bc472c624d085)
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test test_nested_member_access_as_value ... ok
[INFO] [stdout] test test_nested_member_access_as_operation ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/arithmetic.rs (/opt/rustwide/target/debug/deps/arithmetic-1f673783966562d0)
[INFO] [stdout] 
[INFO] [stdout] running 8 tests
[INFO] [stdout] test test_modulo ... ok
[INFO] [stdout] test test_division_by_zero ... ok
[INFO] [stdout] test test_multiplication ... ok
[INFO] [stdout] test test_modulo_by_zero ... ok
[INFO] [stdout] test test_division ... ok
[INFO] [stdout] test test_builtin_sqrt_negative_errors ... ok
[INFO] [stdout] test test_subtraction ... ok
[INFO] [stdout] test test_addition ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 8 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/assignment.rs (/opt/rustwide/target/debug/deps/assignment-2416464bd7e486f2)
[INFO] [stdout] 
[INFO] [stdout] running 34 tests
[INFO] [stdout] test test_failed_assignment_with_unrecognised_partial_field ... ok
[INFO] [stdout] test test_failed_assignment_on_mismatched_literal_in_tuple ... ok
[INFO] [stdout] test test_multiple_placeholders ... ok
[INFO] [stdout] test test_match_union_in_nested_tuple ... ok
[INFO] [stdout] test test_failed_assignment_length ... ok
[INFO] [stdout] test test_failed_assignment_type ... ok
[INFO] [stdout] test test_complex_union_pattern_matching ... ok
[INFO] [stdout] test test_failed_assignment_on_mismatched_literal ... ok
[INFO] [stdout] test test_named_partial_pattern_in_block ... ok
[INFO] [stdout] test test_deeply_nested_tuple_pattern ... ok
[INFO] [stdout] test test_named_partial_pattern ... ok
[INFO] [stdout] test test_ignore_placeholder ... ok
[INFO] [stdout] test test_partial_pattern_order_for_union ... ok
[INFO] [stdout] test test_mixed_pattern_literal_and_binding ... ok
[INFO] [stdout] test test_named_partial_pattern_with_union ... ok
[INFO] [stdout] test test_nested_field_assignment ... ok
[INFO] [stdout] test test_star_pattern_order_for_union ... ok
[INFO] [stdout] test test_simple_partial_pattern ... ok
[INFO] [stdout] test test_union_match_with_literals ... ok
[INFO] [stdout] test test_comparison_with_literal ... ok
[INFO] [stdout] test test_repeated_identifier_bind ... ok
[INFO] [stdout] test test_repeated_identifier_nested ... ok
[INFO] [stdout] test test_tuple_destructuring ... ok
[INFO] [stdout] test test_union_match_with_tuples ... ok
[INFO] [stdout] test test_repeated_identifier_multiple_times ... ok
[INFO] [stdout] test test_partial_tuple_assignment ... ok
[INFO] [stdout] test test_empty_tuple_pattern ... ok
[INFO] [stdout] test test_string_literal_pattern ... ok
[INFO] [stdout] test test_wildcard ... ok
[INFO] [stdout] test test_star_assignment ... ok
[INFO] [stdout] test test_recursive_destructuring ... ok
[INFO] [stdout] test test_union_type_partial_destructuring ... ok
[INFO] [stdout] test test_simple_assignment ... ok
[INFO] [stdout] test test_named_field_assignment ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 34 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.44s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/binary.rs (/opt/rustwide/target/debug/deps/binary-96d8738134ad85e8)
[INFO] [stdout] 
[INFO] [stdout] running 16 tests
[INFO] [stdout] test test_and ... ok
[INFO] [stdout] test test_or ... ok
[INFO] [stdout] test test_set_byte ... ok
[INFO] [stdout] test test_chained_operations ... ok
[INFO] [stdout] test test_get_byte ... ok
[INFO] [stdout] test test_append ... ok
[INFO] [stdout] test test_bit_manipulation_pattern ... ok
[INFO] [stdout] test test_length ... ok
[INFO] [stdout] test test_concat ... ok
[INFO] [stdout] test test_shift ... ok
[INFO] [stdout] test test_xor ... ok
[INFO] [stdout] test test_new ... ok
[INFO] [stdout] test test_slice ... ok
[INFO] [stdout] test test_set_bit ... ok
[INFO] [stdout] test test_get_bit ... ok
[INFO] [stdout] test test_not ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 16 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.15s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/bitwise.rs (/opt/rustwide/target/debug/deps/bitwise-05bdbc1a2757c655)
[INFO] [stdout] 
[INFO] [stdout] running 15 tests
[INFO] [stdout] test test_binary_popcount_hamt_pattern ... ok
[INFO] [stdout] test test_bitwise_chaining ... ok
[INFO] [stdout] test test_error_conditions ... ok
[INFO] [stdout] test test_hamt_simulation ... ok
[INFO] [stdout] test test_shift_operations_boundary ... ok
[INFO] [stdout] test test_binary_and ... ok
[INFO] [stdout] test test_binary_shift_right ... ok
[INFO] [stdout] test test_binary_xor ... ok
[INFO] [stdout] test test_binary_shift_left ... ok
[INFO] [stdout] test test_binary_or ... ok
[INFO] [stdout] test test_bit_unaligned_access ... ok
[INFO] [stdout] test test_binary_not ... ok
[INFO] [stdout] test test_binary_get_bit_pos ... ok
[INFO] [stdout] test test_binary_set_bit ... ok
[INFO] [stdout] test test_binary_popcount_critical ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 15 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.08s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/blocks.rs (/opt/rustwide/target/debug/deps/blocks-fb06cb191171a4fb)
[INFO] [stdout] 
[INFO] [stdout] running 6 tests
[INFO] [stdout] test test_block_with_positional_parameter ... ok
[INFO] [stdout] test test_block_with_closure ... ok
[INFO] [stdout] test test_block_evaluation ... ok
[INFO] [stdout] test test_block_scope ... ok
[INFO] [stdout] test test_block_with_parameter ... ok
[INFO] [stdout] test test_block_with_repeated_parameter ... ok
[INFO] [stderr]      Running tests/branches.rs (/opt/rustwide/target/debug/deps/branches-0dfc35b866adc18f)
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.08s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 11 tests
[INFO] [stdout] test test_branch_first_fails_first_term ... ok
[INFO] [stdout] test test_branch_first_fails_second_term ... ok
[INFO] [stdout] test test_consequence_ripple_fallback_branch ... ok
[INFO] [stdout] test test_consequence_ripple_is_block_parameter_not_condition_result ... ok
[INFO] [stdout] test test_branch_with_failing_consequence ... ok
[INFO] [stdout] test test_use_continuation_in_consequence ... ok
[INFO] [stdout] test test_string_match ... ok
[INFO] [stdout] test test_branch_with_consequence ... ok
[INFO] [stdout] test test_branch_first_succeeds ... ok
[INFO] [stdout] test test_consequence_ripple_in_tuple ... ok
[INFO] [stdout] test test_branch_pattern_matching ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 11 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.11s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/builtins.rs (/opt/rustwide/target/debug/deps/builtins-5b410812d837412d)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test test_builtin ... ok
[INFO] [stderr]      Running tests/chaining.rs (/opt/rustwide/target/debug/deps/chaining-eddbc45c1c82ed0a)
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 8 tests
[INFO] [stdout] test test_member_access_chaining ... ok
[INFO] [stdout] test test_nested_tupple_construction ... ok
[INFO] [stdout] test test_standalone_ripple_with_nested_chain ... ok
[INFO] [stdout] test test_nested_ripple_contexts ... ok
[INFO] [stdout] test test_operation_chaining ... ok
[INFO] [stdout] test test_nested_chain_outer_value_used ... ok
[INFO] [stdout] test test_nested_chain_value_dropped ... ok
[INFO] [stdout] test test_standalone_ripple ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 8 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.05s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/comments.rs (/opt/rustwide/target/debug/deps/comments-0d5e75cb4be96773)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test test_comments ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.05s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/common.rs (/opt/rustwide/target/debug/deps/common-f7510680e43f995c)
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stderr]      Running tests/comparison.rs (/opt/rustwide/target/debug/deps/comparison-387e628d55f950bc)
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 3 tests
[INFO] [stdout] test test_greater_than ... ok
[INFO] [stderr]      Running tests/equality.rs (/opt/rustwide/target/debug/deps/equality-add3847ecee485b7)
[INFO] [stdout] test test_less_than ... ok
[INFO] [stdout] test test_equal ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 5 tests
[INFO] [stdout] test test_unequal_integers ... ok
[INFO] [stdout] test test_equal_strings ... ok
[INFO] [stdout] test test_binary_inequality_content ... ok
[INFO] [stdout] test test_binary_equality_content ... ok
[INFO] [stdout] test test_equal_integers ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/files.rs (/opt/rustwide/target/debug/deps/files-3ba5cab412484de8)
[INFO] [stdout] 
[INFO] [stdout] running 7 tests
[INFO] [stdout] test test_file_type_checking ... ok
[INFO] [stdout] test test_file_flush ... FAILED
[INFO] [stdout] test test_file_append ... FAILED
[INFO] [stdout] test test_multiple_writes ... FAILED
[INFO] [stdout] test test_file_write_and_read ... FAILED
[INFO] [stdout] test test_file_resource_type ... FAILED
[INFO] [stdout] test test_read_from_closed_file ... FAILED
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- test_file_flush stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'test_file_flush' (565) panicked at quiver-tests/tests/common.rs:225:17:
[INFO] [stdout] Expected value 'Ok', got error: Environment(Timeout(5s)) for source: 
[INFO] [stdout]             file = __file_open__["/tmp/quiver_test_flush_563.txt" ~> .0, 577, 420],
[INFO] [stdout]             __file_write__[file, 0, "Flushed data" ~> .0],
[INFO] [stdout]             __file_flush__[file],
[INFO] [stdout]             __file_close__[file],
[INFO] [stdout]             Ok
[INFO] [stdout]         
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x61cb9a17fde2 - std::backtrace_rs::backtrace::libunwind::trace::hff358a60abf734fc
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x61cb9a17fde2 - std::backtrace_rs::backtrace::trace_unsynchronized::h3b121f916dd95ec6
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x61cb9a17fde2 - std::sys::backtrace::_print_fmt::hde0a62ded68798e9
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x61cb9a17fde2 - <std::sys::backtrace::BacktraceLock::print::DisplayBacktrace as core::fmt::Display>::fmt::h93773fc827e3113d
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x61cb9a190d5a - core::fmt::rt::Argument::fmt::h01eff69902dad97f
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x61cb9a190d5a - core::fmt::write::hed7b5c73d82ecb7c
[INFO] [stdout]    6:     0x61cb9a14dca6 - std::io::default_write_fmt::h2f696ff5b8bbaa4b
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/io/mod.rs:639:11
[INFO] [stdout]    7:     0x61cb9a14dca6 - std::io::Write::write_fmt::h5e66814db8a9cfce
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/io/mod.rs:1994:13
[INFO] [stdout]    8:     0x61cb9a15efe9 - std::sys::backtrace::BacktraceLock::print::h8b1d6fcc5a56d1a3
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x61cb9a15efe9 - std::panicking::default_hook::{{closure}}::h2be84df4f189ae36
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x61cb9a15ee81 - std::panicking::default_hook::hf0ea8939246f43a9
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x61cb99f8792e - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h02d35e3888986252
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/alloc/src/boxed.rs:2220:9
[INFO] [stdout]   12:     0x61cb99f8792e - test::test_main_with_exit_callback::{{closure}}::h939640a27d647173
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/test/src/lib.rs:145:21
[INFO] [stdout]   13:     0x61cb9a15f262 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::hc9df09ff391af3e7
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/alloc/src/boxed.rs:2220:9
[INFO] [stdout]   14:     0x61cb9a15f262 - std::panicking::panic_with_hook::hb4bd9ac1123582a0
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x61cb9a15f0a8 - std::panicking::panic_handler::{{closure}}::hde00dd15f5637fe2
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x61cb9a15a379 - std::sys::backtrace::__rust_end_short_backtrace::hb72197fa777c1785
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x61cb9a1421cd - __rustc[4425a7e20b4c8619]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x61cb9a19920c - core::panicking::panic_fmt::ha59b517dd231f4da
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x61cb99f5e4a3 - files::common::TestResult::expect::h7756e5a53915e208
[INFO] [stdout]                                at /opt/rustwide/workdir/quiver-tests/tests/common.rs:225:17
[INFO] [stdout]   20:     0x61cb99f48ca7 - files::test_file_flush::h901eb48b1836f535
[INFO] [stdout]                                at /opt/rustwide/workdir/quiver-tests/tests/files.rs:121:10
[INFO] [stdout]   21:     0x61cb99f48e67 - files::test_file_flush::{{closure}}::h6b26d1d751f3501f
[INFO] [stdout]                                at /opt/rustwide/workdir/quiver-tests/tests/files.rs:103:21
[INFO] [stdout]   22:     0x61cb99f4ffb6 - core::ops::function::FnOnce::call_once::h3a0fb9fb08ae8e00
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   23:     0x61cb99f876eb - core::ops::function::FnOnce::call_once::hddb3cd395c36bfbb
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   24:     0x61cb99f876eb - test::__rust_begin_short_backtrace::h0b6a7601d9750bfa
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/test/src/lib.rs:663:18
[INFO] [stdout]   25:     0x61cb99f9b0fa - test::run_test_in_process::{{closure}}::h444209903f00b347
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/test/src/lib.rs:686:74
[INFO] [stdout]   26:     0x61cb99f9b0fa - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::hfb3ba8f46e537649
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/core/src/panic/unwind_safe.rs:274:9
[INFO] [stdout]   27:     0x61cb99f9b0fa - std::panicking::catch_unwind::do_call::h1672a45911fcf9dc
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/panicking.rs:581:40
[INFO] [stdout]   28:     0x61cb99f9b0fa - std::panicking::catch_unwind::h0fadaee22787a6dd
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/panicking.rs:544:19
[INFO] [stdout]   29:     0x61cb99f9b0fa - std::panic::catch_unwind::hc47ad190f2c8e188
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/panic.rs:359:14
[INFO] [stdout]   30:     0x61cb99f9b0fa - test::run_test_in_process::hcd7faaf934f29999
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/test/src/lib.rs:686:27
[INFO] [stdout]   31:     0x61cb99f9b0fa - test::run_test::{{closure}}::hddc4550da4871867
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/test/src/lib.rs:607:43
[INFO] [stdout]   32:     0x61cb99f75554 - test::run_test::{{closure}}::h98ae26689f13ed94
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/test/src/lib.rs:637:41
[INFO] [stdout]   33:     0x61cb99f75554 - std::sys::backtrace::__rust_begin_short_backtrace::h3ec4d1f21ad44588
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   34:     0x61cb99f78ef2 - std::thread::lifecycle::spawn_unchecked::{{closure}}::{{closure}}::hd8bf2c73d479939f
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/thread/lifecycle.rs:91:13
[INFO] [stdout]   35:     0x61cb99f78ef2 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h3b4248f358af2491
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/core/src/panic/unwind_safe.rs:274:9
[INFO] [stdout]   36:     0x61cb99f78ef2 - std::panicking::catch_unwind::do_call::hda10a64f4b8daebe
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/panicking.rs:581:40
[INFO] [stdout]   37:     0x61cb99f78ef2 - std::panicking::catch_unwind::h659e5ee8336ec8c7
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/panicking.rs:544:19
[INFO] [stdout]   38:     0x61cb99f78ef2 - std::panic::catch_unwind::h9d4d66a538912c18
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/panic.rs:359:14
[INFO] [stdout]   39:     0x61cb99f78ef2 - std::thread::lifecycle::spawn_unchecked::{{closure}}::h7557906bb51d79f1
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/thread/lifecycle.rs:89:26
[INFO] [stdout]   40:     0x61cb99f78ef2 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h9e460d1d7fc83d35
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   41:     0x61cb9a1554af - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h61282da819d64ea9
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/alloc/src/boxed.rs:2206:9
[INFO] [stdout]   42:     0x61cb9a1554af - std::sys::thread::unix::Thread::new::thread_start::h982f9ea829d1b5fb
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/sys/thread/unix.rs:127:17
[INFO] [stdout]   43:     0x7ea3b7ab2aa4 - <unknown>
[INFO] [stdout]   44:     0x7ea3b7b3fa64 - clone
[INFO] [stdout]   45:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- test_file_append stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'test_file_append' (564) panicked at quiver-tests/tests/common.rs:225:17:
[INFO] [stdout] Expected value '"First line\nSecond line\n"', got error: Environment(Timeout(5s)) for source: 
[INFO] [stdout]             // O_WRONLY | O_CREAT | O_TRUNC = 577
[INFO] [stdout]             write_file = __file_open__["/tmp/quiver_test_append_563.txt" ~> .0, 577, 420],
[INFO] [stdout]             __file_write__[write_file, 0, "First line\n" ~> .0],
[INFO] [stdout]             __file_close__[write_file],
[INFO] [stdout] 
[INFO] [stdout]             // Write at offset 11 (length of "First line\n")
[INFO] [stdout]             append_file = __file_open__["/tmp/quiver_test_append_563.txt" ~> .0, 1, 420],
[INFO] [stdout]             __file_write__[append_file, 11, "Second line\n" ~> .0],
[INFO] [stdout]             __file_close__[append_file],
[INFO] [stdout] 
[INFO] [stdout]             // Read everything
[INFO] [stdout]             read_file = __file_open__["/tmp/quiver_test_append_563.txt" ~> .0, 0, 0],
[INFO] [stdout]             data = __file_read__[read_file, 0, 4096],
[INFO] [stdout]             __file_close__[read_file],
[INFO] [stdout] 
[INFO] [stdout]             Str[data]
[INFO] [stdout]         
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x61cb9a17fde2 - std::backtrace_rs::backtrace::libunwind::trace::hff358a60abf734fc
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x61cb9a17fde2 - std::backtrace_rs::backtrace::trace_unsynchronized::h3b121f916dd95ec6
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x61cb9a17fde2 - std::sys::backtrace::_print_fmt::hde0a62ded68798e9
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x61cb9a17fde2 - <std::sys::backtrace::BacktraceLock::print::DisplayBacktrace as core::fmt::Display>::fmt::h93773fc827e3113d
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x61cb9a190d5a - core::fmt::rt::Argument::fmt::h01eff69902dad97f
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x61cb9a190d5a - core::fmt::write::hed7b5c73d82ecb7c
[INFO] [stdout]    6:     0x61cb9a14dca6 - std::io::default_write_fmt::h2f696ff5b8bbaa4b
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/io/mod.rs:639:11
[INFO] [stdout]    7:     0x61cb9a14dca6 - std::io::Write::write_fmt::h5e66814db8a9cfce
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/io/mod.rs:1994:13
[INFO] [stdout]    8:     0x61cb9a15efe9 - std::sys::backtrace::BacktraceLock::print::h8b1d6fcc5a56d1a3
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x61cb9a15efe9 - std::panicking::default_hook::{{closure}}::h2be84df4f189ae36
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x61cb9a15ee81 - std::panicking::default_hook::hf0ea8939246f43a9
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x61cb99f8792e - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h02d35e3888986252
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/alloc/src/boxed.rs:2220:9
[INFO] [stdout]   12:     0x61cb99f8792e - test::test_main_with_exit_callback::{{closure}}::h939640a27d647173
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/test/src/lib.rs:145:21
[INFO] [stdout]   13:     0x61cb9a15f262 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::hc9df09ff391af3e7
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/alloc/src/boxed.rs:2220:9
[INFO] [stdout]   14:     0x61cb9a15f262 - std::panicking::panic_with_hook::hb4bd9ac1123582a0
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x61cb9a15f0a8 - std::panicking::panic_handler::{{closure}}::hde00dd15f5637fe2
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x61cb9a15a379 - std::sys::backtrace::__rust_end_short_backtrace::hb72197fa777c1785
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x61cb9a1421cd - __rustc[4425a7e20b4c8619]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x61cb9a19920c - core::panicking::panic_fmt::ha59b517dd231f4da
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x61cb99f5e4a3 - files::common::TestResult::expect::h7756e5a53915e208
[INFO] [stdout]                                at /opt/rustwide/workdir/quiver-tests/tests/common.rs:225:17
[INFO] [stdout]   20:     0x61cb99f492d9 - files::test_file_append::h63af541a45b9b3b6
[INFO] [stdout]                                at /opt/rustwide/workdir/quiver-tests/tests/files.rs:67:10
[INFO] [stdout]   21:     0x61cb99f493b7 - files::test_file_append::{{closure}}::h141268af4e08339e
[INFO] [stdout]                                at /opt/rustwide/workdir/quiver-tests/tests/files.rs:38:22
[INFO] [stdout]   22:     0x61cb99f50666 - core::ops::function::FnOnce::call_once::h83a26467f89b780f
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   23:     0x61cb99f876eb - core::ops::function::FnOnce::call_once::hddb3cd395c36bfbb
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   24:     0x61cb99f876eb - test::__rust_begin_short_backtrace::h0b6a7601d9750bfa
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/test/src/lib.rs:663:18
[INFO] [stdout]   25:     0x61cb99f9b0fa - test::run_test_in_process::{{closure}}::h444209903f00b347
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/test/src/lib.rs:686:74
[INFO] [stdout]   26:     0x61cb99f9b0fa - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::hfb3ba8f46e537649
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/core/src/panic/unwind_safe.rs:274:9
[INFO] [stdout]   27:     0x61cb99f9b0fa - std::panicking::catch_unwind::do_call::h1672a45911fcf9dc
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/panicking.rs:581:40
[INFO] [stdout]   28:     0x61cb99f9b0fa - std::panicking::catch_unwind::h0fadaee22787a6dd
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/panicking.rs:544:19
[INFO] [stdout]   29:     0x61cb99f9b0fa - std::panic::catch_unwind::hc47ad190f2c8e188
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/panic.rs:359:14
[INFO] [stdout]   30:     0x61cb99f9b0fa - test::run_test_in_process::hcd7faaf934f29999
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/test/src/lib.rs:686:27
[INFO] [stdout]   31:     0x61cb99f9b0fa - test::run_test::{{closure}}::hddc4550da4871867
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/test/src/lib.rs:607:43
[INFO] [stdout]   32:     0x61cb99f75554 - test::run_test::{{closure}}::h98ae26689f13ed94
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/test/src/lib.rs:637:41
[INFO] [stdout]   33:     0x61cb99f75554 - std::sys::backtrace::__rust_begin_short_backtrace::h3ec4d1f21ad44588
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   34:     0x61cb99f78ef2 - std::thread::lifecycle::spawn_unchecked::{{closure}}::{{closure}}::hd8bf2c73d479939f
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/thread/lifecycle.rs:91:13
[INFO] [stdout]   35:     0x61cb99f78ef2 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h3b4248f358af2491
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/core/src/panic/unwind_safe.rs:274:9
[INFO] [stdout]   36:     0x61cb99f78ef2 - std::panicking::catch_unwind::do_call::hda10a64f4b8daebe
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/panicking.rs:581:40
[INFO] [stdout]   37:     0x61cb99f78ef2 - std::panicking::catch_unwind::h659e5ee8336ec8c7
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/panicking.rs:544:19
[INFO] [stdout]   38:     0x61cb99f78ef2 - std::panic::catch_unwind::h9d4d66a538912c18
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/panic.rs:359:14
[INFO] [stdout]   39:     0x61cb99f78ef2 - std::thread::lifecycle::spawn_unchecked::{{closure}}::h7557906bb51d79f1
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/thread/lifecycle.rs:89:26
[INFO] [stdout]   40:     0x61cb99f78ef2 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h9e460d1d7fc83d35
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   41:     0x61cb9a1554af - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h61282da819d64ea9
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/alloc/src/boxed.rs:2206:9
[INFO] [stdout]   42:     0x61cb9a1554af - std::sys::thread::unix::Thread::new::thread_start::h982f9ea829d1b5fb
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/sys/thread/unix.rs:127:17
[INFO] [stdout]   43:     0x7ea3b7ab2aa4 - <unknown>
[INFO] [stdout]   44:     0x7ea3b7b3fa64 - clone
[INFO] [stdout]   45:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- test_multiple_writes stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'test_multiple_writes' (569) panicked at quiver-tests/tests/common.rs:225:17:
[INFO] [stdout] Expected value '"Line 1\nLine 2\nLine 3\n"', got error: Environment(Timeout(5s)) for source: 
[INFO] [stdout]             file = __file_open__["/tmp/quiver_test_multi_563.txt" ~> .0, 577, 420],
[INFO] [stdout]             __file_write__[file, 0, "Line 1\n" ~> .0],
[INFO] [stdout]             __file_write__[file, 7, "Line 2\n" ~> .0],
[INFO] [stdout]             __file_write__[file, 14, "Line 3\n" ~> .0],
[INFO] [stdout]             __file_close__[file],
[INFO] [stdout] 
[INFO] [stdout]             read_file = __file_open__["/tmp/quiver_test_multi_563.txt" ~> .0, 0, 0],
[INFO] [stdout]             data = __file_read__[read_file, 0, 4096],
[INFO] [stdout]             __file_close__[read_file],
[INFO] [stdout] 
[INFO] [stdout]             Str[data]
[INFO] [stdout]         
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x61cb9a17fde2 - std::backtrace_rs::backtrace::libunwind::trace::hff358a60abf734fc
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x61cb9a17fde2 - std::backtrace_rs::backtrace::trace_unsynchronized::h3b121f916dd95ec6
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x61cb9a17fde2 - std::sys::backtrace::_print_fmt::hde0a62ded68798e9
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x61cb9a17fde2 - <std::sys::backtrace::BacktraceLock::print::DisplayBacktrace as core::fmt::Display>::fmt::h93773fc827e3113d
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x61cb9a190d5a - core::fmt::rt::Argument::fmt::h01eff69902dad97f
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x61cb9a190d5a - core::fmt::write::hed7b5c73d82ecb7c
[INFO] [stdout]    6:     0x61cb9a14dca6 - std::io::default_write_fmt::h2f696ff5b8bbaa4b
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/io/mod.rs:639:11
[INFO] [stdout]    7:     0x61cb9a14dca6 - std::io::Write::write_fmt::h5e66814db8a9cfce
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/io/mod.rs:1994:13
[INFO] [stdout]    8:     0x61cb9a15efe9 - std::sys::backtrace::BacktraceLock::print::h8b1d6fcc5a56d1a3
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x61cb9a15efe9 - std::panicking::default_hook::{{closure}}::h2be84df4f189ae36
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x61cb9a15ee81 - std::panicking::default_hook::hf0ea8939246f43a9
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x61cb99f8792e - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h02d35e3888986252
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/alloc/src/boxed.rs:2220:9
[INFO] [stdout]   12:     0x61cb99f8792e - test::test_main_with_exit_callback::{{closure}}::h939640a27d647173
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/test/src/lib.rs:145:21
[INFO] [stdout]   13:     0x61cb9a15f262 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::hc9df09ff391af3e7
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/alloc/src/boxed.rs:2220:9
[INFO] [stdout]   14:     0x61cb9a15f262 - std::panicking::panic_with_hook::hb4bd9ac1123582a0
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x61cb9a15f0a8 - std::panicking::panic_handler::{{closure}}::hde00dd15f5637fe2
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x61cb9a15a379 - std::sys::backtrace::__rust_end_short_backtrace::hb72197fa777c1785
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x61cb9a1421cd - __rustc[4425a7e20b4c8619]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x61cb9a19920c - core::panicking::panic_fmt::ha59b517dd231f4da
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x61cb99f5e4a3 - files::common::TestResult::expect::h7756e5a53915e208
[INFO] [stdout]                                at /opt/rustwide/workdir/quiver-tests/tests/common.rs:225:17
[INFO] [stdout]   20:     0x61cb99f497ee - files::test_multiple_writes::hbe17f3879836d8c5
[INFO] [stdout]                                at /opt/rustwide/workdir/quiver-tests/tests/files.rs:156:10
[INFO] [stdout]   21:     0x61cb99f498c7 - files::test_multiple_writes::{{closure}}::h2a52a8d84a5c2605
[INFO] [stdout]                                at /opt/rustwide/workdir/quiver-tests/tests/files.rs:132:26
[INFO] [stdout]   22:     0x61cb99f50d06 - core::ops::function::FnOnce::call_once::hcd8007bc6b3b6ecc
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   23:     0x61cb99f876eb - core::ops::function::FnOnce::call_once::hddb3cd395c36bfbb
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   24:     0x61cb99f876eb - test::__rust_begin_short_backtrace::h0b6a7601d9750bfa
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/test/src/lib.rs:663:18
[INFO] [stdout]   25:     0x61cb99f9b0fa - test::run_test_in_process::{{closure}}::h444209903f00b347
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/test/src/lib.rs:686:74
[INFO] [stdout]   26:     0x61cb99f9b0fa - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::hfb3ba8f46e537649
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/core/src/panic/unwind_safe.rs:274:9
[INFO] [stdout]   27:     0x61cb99f9b0fa - std::panicking::catch_unwind::do_call::h1672a45911fcf9dc
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/panicking.rs:581:40
[INFO] [stdout]   28:     0x61cb99f9b0fa - std::panicking::catch_unwind::h0fadaee22787a6dd
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/panicking.rs:544:19
[INFO] [stdout]   29:     0x61cb99f9b0fa - std::panic::catch_unwind::hc47ad190f2c8e188
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/panic.rs:359:14
[INFO] [stdout]   30:     0x61cb99f9b0fa - test::run_test_in_process::hcd7faaf934f29999
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/test/src/lib.rs:686:27
[INFO] [stdout]   31:     0x61cb99f9b0fa - test::run_test::{{closure}}::hddc4550da4871867
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/test/src/lib.rs:607:43
[INFO] [stdout]   32:     0x61cb99f75554 - test::run_test::{{closure}}::h98ae26689f13ed94
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/test/src/lib.rs:637:41
[INFO] [stdout]   33:     0x61cb99f75554 - std::sys::backtrace::__rust_begin_short_backtrace::h3ec4d1f21ad44588
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   34:     0x61cb99f78ef2 - std::thread::lifecycle::spawn_unchecked::{{closure}}::{{closure}}::hd8bf2c73d479939f
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/thread/lifecycle.rs:91:13
[INFO] [stdout]   35:     0x61cb99f78ef2 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h3b4248f358af2491
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/core/src/panic/unwind_safe.rs:274:9
[INFO] [stdout]   36:     0x61cb99f78ef2 - std::panicking::catch_unwind::do_call::hda10a64f4b8daebe
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/panicking.rs:581:40
[INFO] [stdout]   37:     0x61cb99f78ef2 - std::panicking::catch_unwind::h659e5ee8336ec8c7
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/panicking.rs:544:19
[INFO] [stdout]   38:     0x61cb99f78ef2 - std::panic::catch_unwind::h9d4d66a538912c18
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/panic.rs:359:14
[INFO] [stdout]   39:     0x61cb99f78ef2 - std::thread::lifecycle::spawn_unchecked::{{closure}}::h7557906bb51d79f1
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/thread/lifecycle.rs:89:26
[INFO] [stdout]   40:     0x61cb99f78ef2 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h9e460d1d7fc83d35
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   41:     0x61cb9a1554af - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h61282da819d64ea9
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/alloc/src/boxed.rs:2206:9
[INFO] [stdout]   42:     0x61cb9a1554af - std::sys::thread::unix::Thread::new::thread_start::h982f9ea829d1b5fb
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/sys/thread/unix.rs:127:17
[INFO] [stdout]   43:     0x7ea3b7ab2aa4 - <unknown>
[INFO] [stdout]   44:     0x7ea3b7b3fa64 - clone
[INFO] [stdout]   45:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- test_file_write_and_read stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'test_file_write_and_read' (568) panicked at quiver-tests/tests/common.rs:225:17:
[INFO] [stdout] Expected value '"Hello, World!"', got error: Environment(Timeout(5s)) for source: 
[INFO] [stdout]             // O_WRONLY | O_CREAT | O_TRUNC = 1 | 64 | 512 = 577
[INFO] [stdout]             // O_RDONLY = 0
[INFO] [stdout]             // Mode 0o644 = 420
[INFO] [stdout] 
[INFO] [stdout]             write_file = __file_open__["/tmp/quiver_test_563.txt" ~> .0, 577, 420],
[INFO] [stdout]             __file_write__[write_file, 0, "Hello, World!" ~> .0],
[INFO] [stdout]             __file_close__[write_file],
[INFO] [stdout] 
[INFO] [stdout]             read_file = __file_open__["/tmp/quiver_test_563.txt" ~> .0, 0, 0],
[INFO] [stdout]             data = __file_read__[read_file, 0, 4096],
[INFO] [stdout]             __file_close__[read_file],
[INFO] [stdout] 
[INFO] [stdout]             Str[data]
[INFO] [stdout]         
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x61cb9a17fde2 - std::backtrace_rs::backtrace::libunwind::trace::hff358a60abf734fc
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x61cb9a17fde2 - std::backtrace_rs::backtrace::trace_unsynchronized::h3b121f916dd95ec6
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x61cb9a17fde2 - std::sys::backtrace::_print_fmt::hde0a62ded68798e9
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x61cb9a17fde2 - <std::sys::backtrace::BacktraceLock::print::DisplayBacktrace as core::fmt::Display>::fmt::h93773fc827e3113d
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x61cb9a190d5a - core::fmt::rt::Argument::fmt::h01eff69902dad97f
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x61cb9a190d5a - core::fmt::write::hed7b5c73d82ecb7c
[INFO] [stdout]    6:     0x61cb9a14dca6 - std::io::default_write_fmt::h2f696ff5b8bbaa4b
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/io/mod.rs:639:11
[INFO] [stdout]    7:     0x61cb9a14dca6 - std::io::Write::write_fmt::h5e66814db8a9cfce
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/io/mod.rs:1994:13
[INFO] [stdout]    8:     0x61cb9a15efe9 - std::sys::backtrace::BacktraceLock::print::h8b1d6fcc5a56d1a3
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x61cb9a15efe9 - std::panicking::default_hook::{{closure}}::h2be84df4f189ae36
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x61cb9a15ee81 - std::panicking::default_hook::hf0ea8939246f43a9
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x61cb99f8792e - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h02d35e3888986252
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/alloc/src/boxed.rs:2220:9
[INFO] [stdout]   12:     0x61cb99f8792e - test::test_main_with_exit_callback::{{closure}}::h939640a27d647173
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/test/src/lib.rs:145:21
[INFO] [stdout]   13:     0x61cb9a15f262 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::hc9df09ff391af3e7
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/alloc/src/boxed.rs:2220:9
[INFO] [stdout]   14:     0x61cb9a15f262 - std::panicking::panic_with_hook::hb4bd9ac1123582a0
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x61cb9a15f0a8 - std::panicking::panic_handler::{{closure}}::hde00dd15f5637fe2
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x61cb9a15a379 - std::sys::backtrace::__rust_end_short_backtrace::hb72197fa777c1785
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x61cb9a1421cd - __rustc[4425a7e20b4c8619]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x61cb9a19920c - core::panicking::panic_fmt::ha59b517dd231f4da
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x61cb99f5e4a3 - files::common::TestResult::expect::h7756e5a53915e208
[INFO] [stdout]                                at /opt/rustwide/workdir/quiver-tests/tests/common.rs:225:17
[INFO] [stdout]   20:     0x61cb99f49e5a - files::test_file_write_and_read::h73fce666f75494c3
[INFO] [stdout]                                at /opt/rustwide/workdir/quiver-tests/tests/files.rs:31:10
[INFO] [stdout]   21:     0x61cb99f49f37 - files::test_file_write_and_read::{{closure}}::hb49f6b4ecfcf7370
[INFO] [stdout]                                at /opt/rustwide/workdir/quiver-tests/tests/files.rs:5:30
[INFO] [stdout]   22:     0x61cb99f50cc6 - core::ops::function::FnOnce::call_once::hc782deb58778c13e
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   23:     0x61cb99f876eb - core::ops::function::FnOnce::call_once::hddb3cd395c36bfbb
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   24:     0x61cb99f876eb - test::__rust_begin_short_backtrace::h0b6a7601d9750bfa
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/test/src/lib.rs:663:18
[INFO] [stdout]   25:     0x61cb99f9b0fa - test::run_test_in_process::{{closure}}::h444209903f00b347
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/test/src/lib.rs:686:74
[INFO] [stdout]   26:     0x61cb99f9b0fa - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::hfb3ba8f46e537649
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/core/src/panic/unwind_safe.rs:274:9
[INFO] [stdout]   27:     0x61cb99f9b0fa - std::panicking::catch_unwind::do_call::h1672a45911fcf9dc
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/panicking.rs:581:40
[INFO] [stdout]   28:     0x61cb99f9b0fa - std::panicking::catch_unwind::h0fadaee22787a6dd
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/panicking.rs:544:19
[INFO] [stdout]   29:     0x61cb99f9b0fa - std::panic::catch_unwind::hc47ad190f2c8e188
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/panic.rs:359:14
[INFO] [stdout]   30:     0x61cb99f9b0fa - test::run_test_in_process::hcd7faaf934f29999
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/test/src/lib.rs:686:27
[INFO] [stdout]   31:     0x61cb99f9b0fa - test::run_test::{{closure}}::hddc4550da4871867
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/test/src/lib.rs:607:43
[INFO] [stdout]   32:     0x61cb99f75554 - test::run_test::{{closure}}::h98ae26689f13ed94
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/test/src/lib.rs:637:41
[INFO] [stdout]   33:     0x61cb99f75554 - std::sys::backtrace::__rust_begin_short_backtrace::h3ec4d1f21ad44588
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   34:     0x61cb99f78ef2 - std::thread::lifecycle::spawn_unchecked::{{closure}}::{{closure}}::hd8bf2c73d479939f
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/thread/lifecycle.rs:91:13
[INFO] [stdout]   35:     0x61cb99f78ef2 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h3b4248f358af2491
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/core/src/panic/unwind_safe.rs:274:9
[INFO] [stdout]   36:     0x61cb99f78ef2 - std::panicking::catch_unwind::do_call::hda10a64f4b8daebe
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/panicking.rs:581:40
[INFO] [stdout]   37:     0x61cb99f78ef2 - std::panicking::catch_unwind::h659e5ee8336ec8c7
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/panicking.rs:544:19
[INFO] [stdout]   38:     0x61cb99f78ef2 - std::panic::catch_unwind::h9d4d66a538912c18
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/panic.rs:359:14
[INFO] [stdout]   39:     0x61cb99f78ef2 - std::thread::lifecycle::spawn_unchecked::{{closure}}::h7557906bb51d79f1
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/thread/lifecycle.rs:89:26
[INFO] [stdout]   40:     0x61cb99f78ef2 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h9e460d1d7fc83d35
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   41:     0x61cb9a1554af - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h61282da819d64ea9
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/alloc/src/boxed.rs:2206:9
[INFO] [stdout]   42:     0x61cb9a1554af - std::sys::thread::unix::Thread::new::thread_start::h982f9ea829d1b5fb
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/sys/thread/unix.rs:127:17
[INFO] [stdout]   43:     0x7ea3b7ab2aa4 - <unknown>
[INFO] [stdout]   44:     0x7ea3b7b3fa64 - clone
[INFO] [stdout]   45:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- test_file_resource_type stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'test_file_resource_type' (566) panicked at quiver-tests/tests/common.rs:389:17:
[INFO] [stdout] Expected result type '\File', got error: Environment(Timeout(5s)) for source: __file_open__["/tmp/foo" ~> .0, 577, 420]
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x61cb9a17fde2 - std::backtrace_rs::backtrace::libunwind::trace::hff358a60abf734fc
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x61cb9a17fde2 - std::backtrace_rs::backtrace::trace_unsynchronized::h3b121f916dd95ec6
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x61cb9a17fde2 - std::sys::backtrace::_print_fmt::hde0a62ded68798e9
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x61cb9a17fde2 - <std::sys::backtrace::BacktraceLock::print::DisplayBacktrace as core::fmt::Display>::fmt::h93773fc827e3113d
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x61cb9a190d5a - core::fmt::rt::Argument::fmt::h01eff69902dad97f
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x61cb9a190d5a - core::fmt::write::hed7b5c73d82ecb7c
[INFO] [stdout]    6:     0x61cb9a14dca6 - std::io::default_write_fmt::h2f696ff5b8bbaa4b
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/io/mod.rs:639:11
[INFO] [stdout]    7:     0x61cb9a14dca6 - std::io::Write::write_fmt::h5e66814db8a9cfce
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/io/mod.rs:1994:13
[INFO] [stdout]    8:     0x61cb9a15efe9 - std::sys::backtrace::BacktraceLock::print::h8b1d6fcc5a56d1a3
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x61cb9a15efe9 - std::panicking::default_hook::{{closure}}::h2be84df4f189ae36
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x61cb9a15ee81 - std::panicking::default_hook::hf0ea8939246f43a9
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x61cb99f8792e - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h02d35e3888986252
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/alloc/src/boxed.rs:2220:9
[INFO] [stdout]   12:     0x61cb99f8792e - test::test_main_with_exit_callback::{{closure}}::h939640a27d647173
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/test/src/lib.rs:145:21
[INFO] [stdout]   13:     0x61cb9a15f262 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::hc9df09ff391af3e7
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/alloc/src/boxed.rs:2220:9
[INFO] [stdout]   14:     0x61cb9a15f262 - std::panicking::panic_with_hook::hb4bd9ac1123582a0
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x61cb9a15f0a8 - std::panicking::panic_handler::{{closure}}::hde00dd15f5637fe2
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x61cb9a15a379 - std::sys::backtrace::__rust_end_short_backtrace::hb72197fa777c1785
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x61cb9a1421cd - __rustc[4425a7e20b4c8619]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x61cb9a19920c - core::panicking::panic_fmt::ha59b517dd231f4da
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x61cb99f5d734 - files::common::TestResult::expect_type::h9b27d76e0a68769a
[INFO] [stdout]                                at /opt/rustwide/workdir/quiver-tests/tests/common.rs:389:17
[INFO] [stdout]   20:     0x61cb99f49948 - files::test_file_resource_type::h58505ebb8d9287d3
[INFO] [stdout]                                at /opt/rustwide/workdir/quiver-tests/tests/files.rs:99:10
[INFO] [stdout]   21:     0x61cb99f49977 - files::test_file_resource_type::{{closure}}::hda9f598ddd153f89
[INFO] [stdout]                                at /opt/rustwide/workdir/quiver-tests/tests/files.rs:95:29
[INFO] [stdout]   22:     0x61cb99f504f6 - core::ops::function::FnOnce::call_once::h77be11389cc3e0a0
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   23:     0x61cb99f876eb - core::ops::function::FnOnce::call_once::hddb3cd395c36bfbb
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   24:     0x61cb99f876eb - test::__rust_begin_short_backtrace::h0b6a7601d9750bfa
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/test/src/lib.rs:663:18
[INFO] [stdout]   25:     0x61cb99f9b0fa - test::run_test_in_process::{{closure}}::h444209903f00b347
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/test/src/lib.rs:686:74
[INFO] [stdout]   26:     0x61cb99f9b0fa - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::hfb3ba8f46e537649
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/core/src/panic/unwind_safe.rs:274:9
[INFO] [stdout]   27:     0x61cb99f9b0fa - std::panicking::catch_unwind::do_call::h1672a45911fcf9dc
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/panicking.rs:581:40
[INFO] [stdout]   28:     0x61cb99f9b0fa - std::panicking::catch_unwind::h0fadaee22787a6dd
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/panicking.rs:544:19
[INFO] [stdout]   29:     0x61cb99f9b0fa - std::panic::catch_unwind::hc47ad190f2c8e188
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/panic.rs:359:14
[INFO] [stdout]   30:     0x61cb99f9b0fa - test::run_test_in_process::hcd7faaf934f29999
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/test/src/lib.rs:686:27
[INFO] [stdout]   31:     0x61cb99f9b0fa - test::run_test::{{closure}}::hddc4550da4871867
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/test/src/lib.rs:607:43
[INFO] [stdout]   32:     0x61cb99f75554 - test::run_test::{{closure}}::h98ae26689f13ed94
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/test/src/lib.rs:637:41
[INFO] [stdout]   33:     0x61cb99f75554 - std::sys::backtrace::__rust_begin_short_backtrace::h3ec4d1f21ad44588
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   34:     0x61cb99f78ef2 - std::thread::lifecycle::spawn_unchecked::{{closure}}::{{closure}}::hd8bf2c73d479939f
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/thread/lifecycle.rs:91:13
[INFO] [stdout]   35:     0x61cb99f78ef2 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h3b4248f358af2491
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/core/src/panic/unwind_safe.rs:274:9
[INFO] [stdout]   36:     0x61cb99f78ef2 - std::panicking::catch_unwind::do_call::hda10a64f4b8daebe
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/panicking.rs:581:40
[INFO] [stdout]   37:     0x61cb99f78ef2 - std::panicking::catch_unwind::h659e5ee8336ec8c7
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/panicking.rs:544:19
[INFO] [stdout]   38:     0x61cb99f78ef2 - std::panic::catch_unwind::h9d4d66a538912c18
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/panic.rs:359:14
[INFO] [stdout]   39:     0x61cb99f78ef2 - std::thread::lifecycle::spawn_unchecked::{{closure}}::h7557906bb51d79f1
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/thread/lifecycle.rs:89:26
[INFO] [stdout]   40:     0x61cb99f78ef2 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h9e460d1d7fc83d35
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   41:     0x61cb9a1554af - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h61282da819d64ea9
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/alloc/src/boxed.rs:2206:9
[INFO] [stdout]   42:     0x61cb9a1554af - std::sys::thread::unix::Thread::new::thread_start::h982f9ea829d1b5fb
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/sys/thread/unix.rs:127:17
[INFO] [stdout]   43:     0x7ea3b7ab2aa4 - <unknown>
[INFO] [stdout]   44:     0x7ea3b7b3fa64 - clone
[INFO] [stdout]   45:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- test_read_from_closed_file stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'test_read_from_closed_file' (570) panicked at quiver-tests/tests/common.rs:250:17:
[INFO] [stdout] Expected runtime error InvalidArgument("Effect operation failed: InvalidArgument(\"Resource 1 not found\")"), but got Environment(Timeout(5s)) for source: 
[INFO] [stdout]             file = __file_open__["/tmp/quiver_test_closed_563.txt" ~> .0, 0, 0],
[INFO] [stdout]             __file_close__[file],
[INFO] [stdout]             __file_read__[file, 0, 1024]
[INFO] [stdout]         
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x61cb9a17fde2 - std::backtrace_rs::backtrace::libunwind::trace::hff358a60abf734fc
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x61cb9a17fde2 - std::backtrace_rs::backtrace::trace_unsynchronized::h3b121f916dd95ec6
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x61cb9a17fde2 - std::sys::backtrace::_print_fmt::hde0a62ded68798e9
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x61cb9a17fde2 - <std::sys::backtrace::BacktraceLock::print::DisplayBacktrace as core::fmt::Display>::fmt::h93773fc827e3113d
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x61cb9a190d5a - core::fmt::rt::Argument::fmt::h01eff69902dad97f
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x61cb9a190d5a - core::fmt::write::hed7b5c73d82ecb7c
[INFO] [stdout]    6:     0x61cb9a14dca6 - std::io::default_write_fmt::h2f696ff5b8bbaa4b
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/io/mod.rs:639:11
[INFO] [stdout]    7:     0x61cb9a14dca6 - std::io::Write::write_fmt::h5e66814db8a9cfce
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/io/mod.rs:1994:13
[INFO] [stdout]    8:     0x61cb9a15efe9 - std::sys::backtrace::BacktraceLock::print::h8b1d6fcc5a56d1a3
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x61cb9a15efe9 - std::panicking::default_hook::{{closure}}::h2be84df4f189ae36
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x61cb9a15ee81 - std::panicking::default_hook::hf0ea8939246f43a9
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x61cb99f8792e - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h02d35e3888986252
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/alloc/src/boxed.rs:2220:9
[INFO] [stdout]   12:     0x61cb99f8792e - test::test_main_with_exit_callback::{{closure}}::h939640a27d647173
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/test/src/lib.rs:145:21
[INFO] [stdout]   13:     0x61cb9a15f262 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::hc9df09ff391af3e7
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/alloc/src/boxed.rs:2220:9
[INFO] [stdout]   14:     0x61cb9a15f262 - std::panicking::panic_with_hook::hb4bd9ac1123582a0
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x61cb9a15f0a8 - std::panicking::panic_handler::{{closure}}::hde00dd15f5637fe2
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x61cb9a15a379 - std::sys::backtrace::__rust_end_short_backtrace::hb72197fa777c1785
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x61cb9a1421cd - __rustc[4425a7e20b4c8619]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x61cb9a19920c - core::panicking::panic_fmt::ha59b517dd231f4da
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x61cb99f5debb - files::common::TestResult::expect_runtime_error::hb84902ac1c9e02dc
[INFO] [stdout]                                at /opt/rustwide/workdir/quiver-tests/tests/common.rs:250:17
[INFO] [stdout]   20:     0x61cb99f4a409 - files::test_read_from_closed_file::hb231223348fd2a00
[INFO] [stdout]                                at /opt/rustwide/workdir/quiver-tests/tests/files.rs:182:10
[INFO] [stdout]   21:     0x61cb99f4a4d7 - files::test_read_from_closed_file::{{closure}}::hdea11c2c5d632001
[INFO] [stdout]                                at /opt/rustwide/workdir/quiver-tests/tests/files.rs:163:32
[INFO] [stdout]   22:     0x61cb99f4fc96 - core::ops::function::FnOnce::call_once::h191b93bff703d663
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   23:     0x61cb99f876eb - core::ops::function::FnOnce::call_once::hddb3cd395c36bfbb
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   24:     0x61cb99f876eb - test::__rust_begin_short_backtrace::h0b6a7601d9750bfa
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/test/src/lib.rs:663:18
[INFO] [stdout]   25:     0x61cb99f9b0fa - test::run_test_in_process::{{closure}}::h444209903f00b347
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/test/src/lib.rs:686:74
[INFO] [stdout]   26:     0x61cb99f9b0fa - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::hfb3ba8f46e537649
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/core/src/panic/unwind_safe.rs:274:9
[INFO] [stdout]   27:     0x61cb99f9b0fa - std::panicking::catch_unwind::do_call::h1672a45911fcf9dc
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/panicking.rs:581:40
[INFO] [stdout]   28:     0x61cb99f9b0fa - std::panicking::catch_unwind::h0fadaee22787a6dd
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/panicking.rs:544:19
[INFO] [stdout]   29:     0x61cb99f9b0fa - std::panic::catch_unwind::hc47ad190f2c8e188
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/panic.rs:359:14
[INFO] [stdout]   30:     0x61cb99f9b0fa - test::run_test_in_process::hcd7faaf934f29999
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/test/src/lib.rs:686:27
[INFO] [stdout]   31:     0x61cb99f9b0fa - test::run_test::{{closure}}::hddc4550da4871867
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/test/src/lib.rs:607:43
[INFO] [stdout]   32:     0x61cb99f75554 - test::run_test::{{closure}}::h98ae26689f13ed94
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/test/src/lib.rs:637:41
[INFO] [stdout]   33:     0x61cb99f75554 - std::sys::backtrace::__rust_begin_short_backtrace::h3ec4d1f21ad44588
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   34:     0x61cb99f78ef2 - std::thread::lifecycle::spawn_unchecked::{{closure}}::{{closure}}::hd8bf2c73d479939f
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/thread/lifecycle.rs:91:13
[INFO] [stdout]   35:     0x61cb99f78ef2 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h3b4248f358af2491
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/core/src/panic/unwind_safe.rs:274:9
[INFO] [stdout]   36:     0x61cb99f78ef2 - std::panicking::catch_unwind::do_call::hda10a64f4b8daebe
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/panicking.rs:581:40
[INFO] [stdout]   37:     0x61cb99f78ef2 - std::panicking::catch_unwind::h659e5ee8336ec8c7
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/panicking.rs:544:19
[INFO] [stdout]   38:     0x61cb99f78ef2 - std::panic::catch_unwind::h9d4d66a538912c18
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/panic.rs:359:14
[INFO] [stdout]   39:     0x61cb99f78ef2 - std::thread::lifecycle::spawn_unchecked::{{closure}}::h7557906bb51d79f1
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/thread/lifecycle.rs:89:26
[INFO] [stdout]   40:     0x61cb99f78ef2 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h9e460d1d7fc83d35
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   41:     0x61cb9a1554af - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h61282da819d64ea9
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/alloc/src/boxed.rs:2206:9
[INFO] [stdout]   42:     0x61cb9a1554af - std::sys::thread::unix::Thread::new::thread_start::h982f9ea829d1b5fb
[INFO] [stdout]                                at /rustc/4a4ef493e3a1488c6e321570238084b38948f6db/library/std/src/sys/thread/unix.rs:127:17
[INFO] [stdout]   43:     0x7ea3b7ab2aa4 - <unknown>
[INFO] [stdout]   44:     0x7ea3b7b3fa64 - clone
[INFO] [stdout]   45:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     test_file_append
[INFO] [stdout]     test_file_flush
[INFO] [stdout]     test_file_resource_type
[INFO] [stdout]     test_file_write_and_read
[INFO] [stdout]     test_multiple_writes
[INFO] [stdout]     test_read_from_closed_file
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 1 passed; 6 failed; 0 ignored; 0 measured; 0 filtered out; finished in 5.12s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass `-p quiver-tests --test files`
[INFO] running `Command { std: "docker" "inspect" "e2e69f65880aac11f8b5eb75fd4c5a601ad7e2ea0f7375cb5dccecab1b576d23", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "e2e69f65880aac11f8b5eb75fd4c5a601ad7e2ea0f7375cb5dccecab1b576d23", kill_on_drop: false }`
[INFO] [stdout] e2e69f65880aac11f8b5eb75fd4c5a601ad7e2ea0f7375cb5dccecab1b576d23
