[INFO] fetching crate lush 0.17.0...
[INFO] testing lush-0.17.0 against try#33835004928d3bf65db4d4712e1330766263b0bd for pr-155739
[INFO] extracting crate lush 0.17.0 into /workspace/builds/worker-1-tc2/source
[INFO] started tweaking crates.io crate lush 0.17.0
[INFO] finished tweaking crates.io crate lush 0.17.0
[INFO] tweaked toml for crates.io crate lush 0.17.0 written to /workspace/builds/worker-1-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate lush 0.17.0 on toolchain 33835004928d3bf65db4d4712e1330766263b0bd
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+33835004928d3bf65db4d4712e1330766263b0bd" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate lush 0.17.0 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" "+33835004928d3bf65db4d4712e1330766263b0bd" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+33835004928d3bf65db4d4712e1330766263b0bd" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] bbdefc38ae91223b504b39387d1631c71ca08a8ea78a5f4e2fdb130a5e907219
[INFO] running `Command { std: "docker" "start" "-a" "bbdefc38ae91223b504b39387d1631c71ca08a8ea78a5f4e2fdb130a5e907219", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "bbdefc38ae91223b504b39387d1631c71ca08a8ea78a5f4e2fdb130a5e907219", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "bbdefc38ae91223b504b39387d1631c71ca08a8ea78a5f4e2fdb130a5e907219", kill_on_drop: false }`
[INFO] [stdout] bbdefc38ae91223b504b39387d1631c71ca08a8ea78a5f4e2fdb130a5e907219
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+33835004928d3bf65db4d4712e1330766263b0bd" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 73d884600c3a8f7d649c7e7516119abb2b1b7838a47d3a114041f4c88de98729
[INFO] running `Command { std: "docker" "start" "-a" "73d884600c3a8f7d649c7e7516119abb2b1b7838a47d3a114041f4c88de98729", kill_on_drop: false }`
[INFO] [stderr]    Compiling libc v0.2.172
[INFO] [stderr]    Compiling autocfg v1.4.0
[INFO] [stderr]    Compiling bitflags v2.9.0
[INFO] [stderr]    Compiling memchr v2.7.4
[INFO] [stderr]    Compiling smallvec v1.15.0
[INFO] [stderr]    Compiling serde v1.0.219
[INFO] [stderr]    Compiling hashbrown v0.15.3
[INFO] [stderr]    Compiling syn v2.0.101
[INFO] [stderr]    Compiling rustix v1.0.7
[INFO] [stderr]    Compiling tracing-core v0.1.33
[INFO] [stderr]    Compiling openssl v0.10.73
[INFO] [stderr]    Compiling foreign-types-shared v0.1.1
[INFO] [stderr]    Compiling env_home v0.1.0
[INFO] [stderr]    Compiling atomic-waker v1.1.2
[INFO] [stderr]    Compiling native-tls v0.2.14
[INFO] [stderr]    Compiling foreign-types v0.3.2
[INFO] [stderr]    Compiling digest v0.10.7
[INFO] [stderr]    Compiling cfg_aliases v0.2.1
[INFO] [stderr]    Compiling getrandom v0.3.3
[INFO] [stderr]    Compiling parking_lot_core v0.9.10
[INFO] [stderr]    Compiling zstd-safe v7.2.4
[INFO] [stderr]    Compiling nix v0.30.1
[INFO] [stderr]    Compiling slab v0.4.9
[INFO] [stderr]    Compiling num-traits v0.2.19
[INFO] [stderr]    Compiling lock_api v0.4.12
[INFO] [stderr]    Compiling anstyle-parse v0.2.6
[INFO] [stderr]    Compiling inout v0.1.4
[INFO] [stderr]    Compiling crc32fast v1.4.2
[INFO] [stderr]    Compiling anstyle-query v1.1.2
[INFO] [stderr]    Compiling zlib-rs v0.5.0
[INFO] [stderr]    Compiling portable-atomic v1.11.0
[INFO] [stderr]    Compiling rustversion v1.0.20
[INFO] [stderr]    Compiling colorchoice v1.0.3
[INFO] [stderr]    Compiling unicode-width v0.2.0
[INFO] [stderr]    Compiling anstyle v1.0.10
[INFO] [stderr]    Compiling indexmap v2.9.0
[INFO] [stderr]    Compiling futures-util v0.3.31
[INFO] [stderr]    Compiling tracing v0.1.41
[INFO] [stderr]    Compiling powerfmt v0.2.0
[INFO] [stderr]    Compiling anstream v0.6.18
[INFO] [stderr]    Compiling aho-corasick v1.1.3
[INFO] [stderr]    Compiling deranged v0.4.0
[INFO] [stderr]    Compiling cipher v0.4.4
[INFO] [stderr]    Compiling hmac v0.12.1
[INFO] [stderr]    Compiling nibble_vec v0.1.0
[INFO] [stderr]    Compiling clap_lex v0.7.4
[INFO] [stderr]    Compiling bumpalo v3.17.0
[INFO] [stderr]    Compiling endian-type v0.1.2
[INFO] [stderr]    Compiling time-core v0.1.4
[INFO] [stderr]    Compiling iana-time-zone v0.1.63
[INFO] [stderr]    Compiling winnow v0.7.10
[INFO] [stderr]    Compiling jobserver v0.1.33
[INFO] [stderr]    Compiling num-conv v0.1.0
[INFO] [stderr]    Compiling toml_write v0.1.2
[INFO] [stderr]    Compiling simd-adler32 v0.3.7
[INFO] [stderr]    Compiling clap_builder v4.5.38
[INFO] [stderr]    Compiling radix_trie v0.2.1
[INFO] [stderr]    Compiling aes v0.8.4
[INFO] [stderr]    Compiling zopfli v0.8.2
[INFO] [stderr]    Compiling cc v1.2.22
[INFO] [stderr]    Compiling ordered-float v2.10.1
[INFO] [stderr]    Compiling chrono v0.4.41
[INFO] [stderr]    Compiling pbkdf2 v0.12.2
[INFO] [stderr]    Compiling time v0.3.41
[INFO] [stderr]    Compiling which v7.0.3
[INFO] [stderr]    Compiling socket2 v0.5.10
[INFO] [stderr]    Compiling mio v1.0.4
[INFO] [stderr]    Compiling parking_lot v0.12.3
[INFO] [stderr]    Compiling xattr v1.5.0
[INFO] [stderr]    Compiling fd-lock v4.0.4
[INFO] [stderr]    Compiling regex-automata v0.4.9
[INFO] [stderr]    Compiling openssl-src v300.5.1+3.5.1
[INFO] [stderr]    Compiling tokio v1.45.1
[INFO] [stderr]    Compiling lua-src v548.1.1
[INFO] [stderr]    Compiling luajit-src v210.6.0+eec7a80
[INFO] [stderr]    Compiling console v0.16.0
[INFO] [stderr]    Compiling filetime v0.2.25
[INFO] [stderr]    Compiling sha1 v0.10.6
[INFO] [stderr]    Compiling encoding_rs v0.8.35
[INFO] [stderr]    Compiling rustc-hash v2.1.1
[INFO] [stderr]    Compiling deflate64 v0.1.9
[INFO] [stderr]    Compiling home v0.5.11
[INFO] [stderr]    Compiling unicode-segmentation v1.12.0
[INFO] [stderr]    Compiling constant_time_eq v0.3.1
[INFO] [stderr]    Compiling toml_datetime v0.6.11
[INFO] [stderr]    Compiling serde_spanned v0.6.9
[INFO] [stderr]    Compiling serde-value v0.7.0
[INFO] [stderr]    Compiling serde_urlencoded v0.7.1
[INFO] [stderr]    Compiling openssl-sys v0.9.109
[INFO] [stderr]    Compiling zstd-sys v2.0.15+zstd.1.5.7
[INFO] [stderr]    Compiling liblzma-sys v0.4.4
[INFO] [stderr]    Compiling bzip2-sys v0.1.13+1.0.8
[INFO] [stderr]    Compiling mlua-sys v0.8.0
[INFO] [stderr]    Compiling libz-rs-sys v0.5.0
[INFO] [stderr]    Compiling flate2 v1.1.1
[INFO] [stderr]    Compiling toml_edit v0.22.27
[INFO] [stderr]    Compiling erased-serde v0.4.6
[INFO] [stderr]    Compiling synstructure v0.13.2
[INFO] [stderr]    Compiling bstr v1.12.0
[INFO] [stderr]    Compiling indicatif v0.18.0
[INFO] [stderr]    Compiling bzip2 v0.5.2
[INFO] [stderr]    Compiling serde_json v1.0.140
[INFO] [stderr]    Compiling tempfile v3.20.0
[INFO] [stderr]    Compiling tar v0.4.44
[INFO] [stderr]    Compiling regex v1.11.1
[INFO] [stderr]    Compiling sysinfo v0.35.1
[INFO] [stderr]    Compiling rustyline v16.0.0
[INFO] [stderr]    Compiling os_pipe v1.2.1
[INFO] [stderr]    Compiling whoami v1.6.0
[INFO] [stderr]    Compiling colored v3.0.0
[INFO] [stderr]    Compiling zerofrom-derive v0.1.6
[INFO] [stderr]    Compiling yoke-derive v0.8.0
[INFO] [stderr]    Compiling zerovec-derive v0.11.1
[INFO] [stderr]    Compiling displaydoc v0.2.5
[INFO] [stderr]    Compiling openssl-macros v0.1.1
[INFO] [stderr]    Compiling zeroize_derive v1.4.2
[INFO] [stderr]    Compiling clap_derive v4.5.32
[INFO] [stderr]    Compiling toml v0.8.23
[INFO] [stderr]    Compiling tokio-util v0.7.15
[INFO] [stderr]    Compiling zeroize v1.8.1
[INFO] [stderr]    Compiling tower v0.5.2
[INFO] [stderr]    Compiling h2 v0.4.10
[INFO] [stderr]    Compiling rustls-pki-types v1.12.0
[INFO] [stderr]    Compiling tower-http v0.6.4
[INFO] [stderr]    Compiling zerofrom v0.1.6
[INFO] [stderr]    Compiling yoke v0.8.0
[INFO] [stderr]    Compiling zerovec v0.11.2
[INFO] [stderr]    Compiling zerotrie v0.2.2
[INFO] [stderr]    Compiling clap v4.5.38
[INFO] [stderr]    Compiling mlua v0.11.0-beta.3
[INFO] [stderr]    Compiling liblzma v0.4.2
[INFO] [stderr]    Compiling hyper v1.6.0
[INFO] [stderr]    Compiling tinystr v0.8.1
[INFO] [stderr]    Compiling potential_utf v0.1.2
[INFO] [stderr]    Compiling icu_collections v2.0.0
[INFO] [stderr]    Compiling icu_locale_core v2.0.0
[INFO] [stderr]    Compiling hyper-util v0.1.13
[INFO] [stderr]    Compiling icu_provider v2.0.0
[INFO] [stderr]    Compiling icu_normalizer v2.0.0
[INFO] [stderr]    Compiling icu_properties v2.0.1
[INFO] [stderr]    Compiling zstd v0.13.3
[INFO] [stderr]    Compiling zip v4.1.0
[INFO] [stderr]    Compiling idna_adapter v1.2.1
[INFO] [stderr]    Compiling idna v1.0.3
[INFO] [stderr]    Compiling url v2.5.4
[INFO] [stderr]    Compiling tokio-native-tls v0.3.1
[INFO] [stderr]    Compiling hyper-tls v0.6.0
[INFO] [stderr]    Compiling reqwest v0.12.18
[INFO] [stderr]    Compiling lush v0.17.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 3m 53s
[INFO] running `Command { std: "docker" "inspect" "73d884600c3a8f7d649c7e7516119abb2b1b7838a47d3a114041f4c88de98729", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "73d884600c3a8f7d649c7e7516119abb2b1b7838a47d3a114041f4c88de98729", kill_on_drop: false }`
[INFO] [stdout] 73d884600c3a8f7d649c7e7516119abb2b1b7838a47d3a114041f4c88de98729
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+33835004928d3bf65db4d4712e1330766263b0bd" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 2422f1746b9403f23ecddde65361635c8c4b78ce4c622a68f3698eaed8ff6d0c
[INFO] running `Command { std: "docker" "start" "-a" "2422f1746b9403f23ecddde65361635c8c4b78ce4c622a68f3698eaed8ff6d0c", kill_on_drop: false }`
[INFO] [stderr]    Compiling lush v0.17.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 5.22s
[INFO] running `Command { std: "docker" "inspect" "2422f1746b9403f23ecddde65361635c8c4b78ce4c622a68f3698eaed8ff6d0c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "2422f1746b9403f23ecddde65361635c8c4b78ce4c622a68f3698eaed8ff6d0c", kill_on_drop: false }`
[INFO] [stdout] 2422f1746b9403f23ecddde65361635c8c4b78ce4c622a68f3698eaed8ff6d0c
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+33835004928d3bf65db4d4712e1330766263b0bd" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] a877cc45d967f04f5eb7dffa307a483397fb6ac260703ab70643d023e28d47f1
[INFO] running `Command { std: "docker" "start" "-a" "a877cc45d967f04f5eb7dffa307a483397fb6ac260703ab70643d023e28d47f1", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.33s
[INFO] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/debug/deps/lush-3394367a1bf07d04)
[INFO] [stdout] 
[INFO] [stdout] running 99 tests
[INFO] [stdout] test modules::environment::tests::test_is_array_with_non_sequential_keys ... ok
[INFO] [stdout] test modules::environment::tests::test_is_array_with_empty_table ... ok
[INFO] [stdout] test modules::environment::tests::interpolate_test ... ok
[INFO] [stdout] test modules::environment::tests::test_is_array_with_string_key ... ok
[INFO] [stdout] test modules::environment::tests::test_is_array_with_wrong_argument_type ... ok
[INFO] [stdout] test modules::path::tests::handles_empty_input ... ok
[INFO] [stdout] test modules::path::tests::joins_multiple_paths ... ok
[INFO] [stdout] test modules::path::tests::result_is_utf8 ... ok
[INFO] [stdout] test modules::environment::tests::test_is_array_with_wrong_argument_count ... ok
[INFO] [stdout] test modules::environment::tests::test_is_array_with_proper_array ... ok
[INFO] [stdout] test modules::path::tests::handles_absolute_paths ... ok
[INFO] [stdout] test modules::path::tests::handles_trailing_separators ... ok
[INFO] [stdout] test compress::tar_zst::tests::test_create_and_extract_tar_zst ... ok
[INFO] [stdout] test modules::string::tests::test_split_keep_empty_default ... ok
[INFO] [stdout] test modules::string::tests::test_endswith ... ok
[INFO] [stdout] test modules::pipeline_exec::tests::test_error_empty_pipeline ... ok
[INFO] [stdout] test modules::string::tests::test_startswith ... ok
[INFO] [stdout] test modules::string::tests::test_split_keep_empty_true ... ok
[INFO] [stdout] test modules::environment::tests::happy_case_3 ... ok
[INFO] [stdout] test modules::string::tests::test_split_keep_empty_false ... ok
[INFO] [stdout] test preprocessor::tests::replace_shell_exec_inside_single_quotes ... ok
[INFO] [stdout] asd
[INFO] [stdout] test modules::environment::tests::happy_case_2 ... ok
[INFO] [stdout] test modules::pipeline_exec::tests::test_complex_pipeline ... ok
[INFO] [stdout] test preprocessor::tests::replace_shell_exec_no_match ... ok
[INFO] [stdout] test modules::pipeline_exec::tests::test_echo_with_exec_variadic ... ok
[INFO] [stdout] test preprocessor::tests::replace_shell_exec_single_command ... ok
[INFO] [stdout] test preprocessor::tests::replace_shell_exec_with_quoted_args_and_lua_func ... ok
[INFO] [stdout] test preprocessor::tests::replace_shell_exec_with_quoted_args ... ok
[INFO] [stdout] test preprocessor::tests::replace_shell_exec_test ... ok
[INFO] [stdout] test preprocessor::tests::interpolate_strings_start_end ... ok
[INFO] [stdout] test preprocessor::tests::replace_sub_shell_escaped_single_quotes ... ok
[INFO] [stdout] test preprocessor::tests::replace_sub_shell_inside_single_quotes_and_spaces ... ok
[INFO] [stdout] test preprocessor::tests::replace_sub_shell_inside_single_quotes ... ok
[INFO] [stdout] test preprocessor::tests::replace_shell_exec_with_quoted_args_no_space ... ok
[INFO] [stdout] test preprocessor::tests::replace_sub_shell_no_match ... ok
[INFO] [stdout] test preprocessor::tests::replace_sub_shell_single_command_with_spaces ... ok
[INFO] [stdout] test preprocessor::tests::replace_sub_shell_single_command ... ok
[INFO] [stdout] test preprocessor::tests::replace_sub_shell_multiple_in_line ... ok
[INFO] [stdout] test modules::pipeline_exec::tests::test_simple_echo_variadic ... ok
[INFO] [stdout] test modules::pipeline_exec::tests::test_echo_pipe_grep_tables ... ok
[INFO] [stdout] test modules::pipeline_exec::tests::test_numeric_args ... ok
[INFO] [stdout] test modules::pipeline_exec::tests::test_multiple_echo_args ... ok
[INFO] [stdout] test repl::tests::test_is_balanced_brackets ... ok
[INFO] [stdout] test repl::tests::test_is_balanced_mixed ... ok
[INFO] [stdout] test modules::pipeline_exec::tests::test_single_table_command ... ok
[INFO] [stdout] test preprocessor::tests::replace_sub_shell_mixed_quotes ... ok
[INFO] [stdout] test repl::tests::test_has_incomplete_control_structure ... ok
[INFO] [stdout] test repl::tests::test_is_balanced_braces ... ok
[INFO] [stdout] test repl::tests::test_integration_multiline_scenarios ... ok
[INFO] [stdout] test preprocessor::tests::replace_sub_shell_with_args ... ok
[INFO] [stdout] test repl::tests::test_is_complete_statement_multiline ... ok
[INFO] [stdout] test preprocessor::tests::replace_sub_shell_with_quoted_args_fixed ... ok
[INFO] [stdout] test preprocessor::tests::replace_sub_shell_with_quoted_args_and_lua_func ... ok
[INFO] [stdout] test repl::tests::test_clean_lua_error ... ok
[INFO] [stdout] test repl::tests::test_is_balanced_parentheses ... ok
[INFO] [stdout] test repl::tests::test_is_incomplete_syntax_error ... ok
[INFO] [stdout] test repl::tests::test_remove_strings_and_comments ... ok
[INFO] [stdout] test repl::tests::test_is_complete_statement_with_strings_and_comments ... ok
[INFO] [stdout] test repl::tests::test_is_complete_statement_edge_cases ... ok
[INFO] [stdout] test preprocessor::tests::replace_sub_shell_test ... ok
[INFO] [stdout] test preprocessor::tests::interpolate_strings_test ... ok
[INFO] [stdout] test repl::tests::test_is_complete_statement_control_structures ... ok
[INFO] [stdout] test repl::tests::test_lua_specific_constructs ... ok
[INFO] [stdout] test setup::tests::invalid_function ... ok
[INFO] [stdout] test repl::tests::test_is_complete_statement_simple ... ok
[INFO] [stdout] test setup::tests::test_json_load_and_save_file ... ok
[INFO] [stdout] using thing
[INFO] [stdout] thing closed
[INFO] [stdout] pwd: /opt/rustwide/workdir
[INFO] [stdout] test setup::tests::test_toml_array_handling ... ok
[INFO] [stdout] test setup::tests::test_json_array_handling ... ok
[INFO] [stdout] test modules::environment::tests::print_array ... ok
[INFO] [stdout] test setup::tests::test_json_nested_objects ... ok
[INFO] [stdout] test string_utils::tests::test_remove_shebang_with_blank_lines_no_shebang ... ok
[INFO] [stdout] test string_utils::tests::test_remove_shebang_with_shebang ... ok
[INFO] [stdout] test utils::dyn_format::tests::test_escaped_braces ... ok
[INFO] [stdout] test utils::dyn_format::tests::test_hyphenated_names ... ok
[INFO] [stdout] test utils::dyn_format::tests::test_macro_mixed ... ok
[INFO] [stdout] test string_utils::tests::test_remove_shebang_with_no_shebang ... ok
[INFO] [stdout] test setup::tests::test_json_from_string ... ok
[INFO] [stdout] test setup::tests::test_json_from_string_invalid ... ok
[INFO] [stdout] test setup::tests::test_toml_load_file_nonexistent ... ok
[INFO] [stdout] test string_utils::tests::test_remove_shebang_with_shebang_and_blank_lines ... ok
[INFO] [stdout] test utils::dyn_format::tests::test_macro_named_only ... ok
[INFO] [stdout] test setup::tests::test_toml_from_string ... ok
[INFO] [stdout] test setup::tests::test_json_load_file_nonexistent ... ok
[INFO] [stdout] test setup::tests::test_toml_load_and_save_file ... ok
[INFO] [stdout] test utils::dyn_format::tests::test_missing_positional ... ok
[INFO] [stdout] test utils::dyn_format::tests::test_mixed ... ok
[INFO] [stdout] test utils::dyn_format::tests::test_named ... ok
[INFO] [stdout] test utils::dyn_format::tests::test_positional_auto ... ok
[INFO] [stdout] test utils::dyn_format::tests::test_positional_explicit ... ok
[INFO] [stdout] test utils::dyn_format::tests::test_positional_explicit_with_macro ... ok
[INFO] [stdout] test setup::tests::test_toml_from_string_invalid ... ok
[INFO] [stdout] Cargo.lock
[INFO] [stdout] Cargo.toml
[INFO] [stdout] Cargo.toml.orig
[INFO] [stdout] Changelog
[INFO] [stdout] README.md
[INFO] [stdout] doc
[INFO] [stdout] scripts
[INFO] [stdout] src
[INFO] [stdout] name: linux
[INFO] [stdout] test utils::dyn_format::tests::test_macro_positional_only ... ok
[INFO] [stdout] test utils::dyn_format::tests::test_missing_named ... ok
[INFO] [stdout] test setup::tests::run_builtin_os ... ok
[INFO] [stdout] test setup::tests::test_roundtrip_data_integrity ... ok
[INFO] [stderr] tail: cannot open '/tmp/my-file.log' for reading: No such file or directory
[INFO] [stdout] res: hello world1
[INFO] [stdout] 
[INFO] [stdout] res: hello world2
[INFO] [stdout] 
[INFO] [stderr] cat: /tmp/my-file.log: No such file or directory
[INFO] [stdout] content:
[INFO] [stdout] res: [hello world3]
[INFO] [stdout] 
[INFO] [stdout] res: [HELLO WORLD4]
[INFO] [stdout] 
[INFO] [stdout] dir_name: /tmp/.tmpEUs3pk
[INFO] [stdout] lush files: ./scripts/mod1.lush
[INFO] [stdout] ./scripts/test2.lush
[INFO] [stdout] 
[INFO] [stdout] test content
[INFO] [stdout] nil
[INFO] [stdout] test tests::test_run_pipeline ... ok
[INFO] [stdout] test tests::test_run_2 ... ok
[INFO] [stdout] ./new_post.zip
[INFO] [stdout] ENV: Thiago
[INFO] [stdout] ENV: nil
[INFO] [stdout] os name: linux
[INFO] [stdout] test setup::tests::run_test_script ... ok
[INFO] [stdout] test tests::run_test_file ... FAILED
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- tests::run_test_file stdout ----
[INFO] [stdout] pwd: /opt/rustwide/workdir
[INFO] [stdout] Zipping files
[INFO] [stdout] 
[INFO] [stdout] thread 'tests::run_test_file' (114) panicked at src/compress/zip.rs:54:37:
[INFO] [stdout] called `Result::unwrap()` on an `Err` value: Os { code: 2, kind: NotFound, message: "No such file or directory" }
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x594d6e48b3da - std[ec419fa8110287d5]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x594d6e48b3da - std[ec419fa8110287d5]::backtrace_rs::backtrace::trace_unsynchronized::<std[ec419fa8110287d5]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x594d6e48b3da - std[ec419fa8110287d5]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x594d6e48b3da - <<std[ec419fa8110287d5]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[35159d6ffb30e017]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x594d6e4a492a - <core[35159d6ffb30e017]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x594d6e4a492a - core[35159d6ffb30e017]::fmt::write
[INFO] [stdout]    6:     0x594d6e491a62 - std[ec419fa8110287d5]::io::default_write_fmt::<alloc[a8a7aba520129d98]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/io/mod.rs:621:11
[INFO] [stdout]    7:     0x594d6e491a62 - <alloc[a8a7aba520129d98]::vec::Vec<u8> as std[ec419fa8110287d5]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/io/mod.rs:1976:13
[INFO] [stdout]    8:     0x594d6e4650ff - <std[ec419fa8110287d5]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x594d6e4650ff - std[ec419fa8110287d5]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x594d6e480ba9 - std[ec419fa8110287d5]::panicking::default_hook
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x594d6d6fb7dc - <alloc[a8a7aba520129d98]::boxed::Box<dyn for<'a, 'b> core[35159d6ffb30e017]::ops::function::Fn<(&'a std[ec419fa8110287d5]::panic::PanicHookInfo<'b>,), Output = ()> + core[35159d6ffb30e017]::marker::Sync + core[35159d6ffb30e017]::marker::Send> as core[35159d6ffb30e017]::ops::function::Fn<(&std[ec419fa8110287d5]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/alloc/src/boxed.rs:2285:9
[INFO] [stdout]   12:     0x594d6d6fb7dc - test[a8007afcd3effadc]::test_main_inner::<test[a8007afcd3effadc]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/test/src/lib.rs:155:21
[INFO] [stdout]   13:     0x594d6e480e22 - <alloc[a8a7aba520129d98]::boxed::Box<dyn for<'a, 'b> core[35159d6ffb30e017]::ops::function::Fn<(&'a std[ec419fa8110287d5]::panic::PanicHookInfo<'b>,), Output = ()> + core[35159d6ffb30e017]::marker::Sync + core[35159d6ffb30e017]::marker::Send> as core[35159d6ffb30e017]::ops::function::Fn<(&std[ec419fa8110287d5]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/alloc/src/boxed.rs:2285:9
[INFO] [stdout]   14:     0x594d6e480e22 - std[ec419fa8110287d5]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x594d6e4651b8 - std[ec419fa8110287d5]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x594d6e45c3b9 - std[ec419fa8110287d5]::sys::backtrace::__rust_end_short_backtrace::<std[ec419fa8110287d5]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x594d6e4665ad - __rustc[cfb3622dd870db93]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x594d6e4a519c - core[35159d6ffb30e017]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x594d6e4a4ee2 - core[35159d6ffb30e017]::result::unwrap_failed
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/result.rs:1867:5
[INFO] [stdout]   20:     0x594d6d54c994 - <core[35159d6ffb30e017]::result::Result<std[ec419fa8110287d5]::fs::Metadata, std[ec419fa8110287d5]::io::error::Error>>::unwrap
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/result.rs:1233:23
[INFO] [stdout]   21:     0x594d6d54c994 - lush[a76724007e6b7dd6]::compress::zip::zip_list
[INFO] [stdout]                                at /opt/rustwide/workdir/src/compress/zip.rs:54:37
[INFO] [stdout]   22:     0x594d6d54b879 - lush[a76724007e6b7dd6]::compress::zip::create_zip_int
[INFO] [stdout]                                at /opt/rustwide/workdir/src/compress/zip.rs:32:5
[INFO] [stdout]   23:     0x594d6d583159 - lush[a76724007e6b7dd6]::modules::files::compress
[INFO] [stdout]                                at /opt/rustwide/workdir/src/modules/files.rs:39:9
[INFO] [stdout]   24:     0x594d6d53810a - <lush[a76724007e6b7dd6]::modules::files::compress as core[35159d6ffb30e017]::ops::function::Fn<(&mlua[5896b452052a3344]::state::Lua, (alloc[a8a7aba520129d98]::string::String, mlua[5896b452052a3344]::multi::Variadic<mlua[5896b452052a3344]::value::Value>))>>::call
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/ops/function.rs:79:5
[INFO] [stdout]   25:     0x594d6d48f83b - <mlua[5896b452052a3344]::state::Lua>::create_function::<lush[a76724007e6b7dd6]::modules::files::compress, (alloc[a8a7aba520129d98]::string::String, mlua[5896b452052a3344]::multi::Variadic<mlua[5896b452052a3344]::value::Value>), ()>::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/mlua-0.11.0-beta.3/src/state.rs:1265:13
[INFO] [stdout]   26:     0x594d6e37ed83 - <alloc[a8a7aba520129d98]::boxed::Box<dyn for<'a> core[35159d6ffb30e017]::ops::function::Fn<(&'a mlua[5896b452052a3344]::state::raw::RawLua, i32), Output = core[35159d6ffb30e017]::result::Result<i32, mlua[5896b452052a3344]::error::Error>> + core[35159d6ffb30e017]::marker::Send> as core[35159d6ffb30e017]::ops::function::Fn<(&mlua[5896b452052a3344]::state::raw::RawLua, i32)>>::call
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/alloc/src/boxed.rs:2285:9
[INFO] [stdout]   27:     0x594d6e36c38e - <mlua[5896b452052a3344]::state::raw::RawLua>::create_callback::call_callback::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/mlua-0.11.0-beta.3/src/state/raw.rs:1191:39
[INFO] [stdout]   28:     0x594d6e3ace33 - mlua[5896b452052a3344]::state::util::callback_error_ext::<<mlua[5896b452052a3344]::state::raw::RawLua>::create_callback::call_callback::{closure#0}, i32>::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/mlua-0.11.0-beta.3/src/state/util.rs:108:9
[INFO] [stdout]   29:     0x594d6e391dd9 - <core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<mlua[5896b452052a3344]::state::util::callback_error_ext<<mlua[5896b452052a3344]::state::raw::RawLua>::create_callback::call_callback::{closure#0}, i32>::{closure#0}> as core[35159d6ffb30e017]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   30:     0x594d6e3a3f2f - std[ec419fa8110287d5]::panicking::catch_unwind::do_call::<core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<mlua[5896b452052a3344]::state::util::callback_error_ext<<mlua[5896b452052a3344]::state::raw::RawLua>::create_callback::call_callback::{closure#0}, i32>::{closure#0}>, core[35159d6ffb30e017]::result::Result<i32, mlua[5896b452052a3344]::error::Error>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:581:40
[INFO] [stdout]   31:     0x594d6e3787ab - __rust_try
[INFO] [stdout]   32:     0x594d6e377470 - std[ec419fa8110287d5]::panicking::catch_unwind::<core[35159d6ffb30e017]::result::Result<i32, mlua[5896b452052a3344]::error::Error>, core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<mlua[5896b452052a3344]::state::util::callback_error_ext<<mlua[5896b452052a3344]::state::raw::RawLua>::create_callback::call_callback::{closure#0}, i32>::{closure#0}>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:544:19
[INFO] [stdout]   33:     0x594d6e377470 - std[ec419fa8110287d5]::panic::catch_unwind::<core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<mlua[5896b452052a3344]::state::util::callback_error_ext<<mlua[5896b452052a3344]::state::raw::RawLua>::create_callback::call_callback::{closure#0}, i32>::{closure#0}>, core[35159d6ffb30e017]::result::Result<i32, mlua[5896b452052a3344]::error::Error>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panic.rs:359:14
[INFO] [stdout]   34:     0x594d6e3abdbe - mlua[5896b452052a3344]::state::util::callback_error_ext::<<mlua[5896b452052a3344]::state::raw::RawLua>::create_callback::call_callback::{closure#0}, i32>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/mlua-0.11.0-beta.3/src/state/util.rs:105:11
[INFO] [stdout]   35:     0x594d6e3703f8 - <mlua[5896b452052a3344]::state::raw::RawLua>::create_callback::call_callback
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/mlua-0.11.0-beta.3/src/state/raw.rs:1186:13
[INFO] [stdout]   36:     0x594d6e3d8497 - precallC
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/lua-src-548.1.1/lua-5.4.8/ldo.c:536:8
[INFO] [stdout]   37:     0x594d6e3d87ee - luaD_precall
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/lua-src-548.1.1/lua-5.4.8/ldo.c:599:7
[INFO] [stdout]   38:     0x594d6e3e7da6 - luaV_execute
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/lua-src-548.1.1/lua-5.4.8/lvm.c:1685:22
[INFO] [stdout]   39:     0x594d6e3d8a76 - ccall
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/lua-src-548.1.1/lua-5.4.8/ldo.c:644:5
[INFO] [stdout]   40:     0x594d6e3d8af3 - luaD_callnoyield
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/lua-src-548.1.1/lua-5.4.8/ldo.c:662:3
[INFO] [stdout]   41:     0x594d6e405a2b - f_call
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/lua-src-548.1.1/lua-5.4.8/lapi.c:1038:3
[INFO] [stdout]   42:     0x594d6e3d7341 - luaD_rawrunprotected
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/lua-src-548.1.1/lua-5.4.8/ldo.c:141:3
[INFO] [stdout]   43:     0x594d6e3d9601 - luaD_pcall
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/lua-src-548.1.1/lua-5.4.8/ldo.c:964:12
[INFO] [stdout]   44:     0x594d6e405c6a - lua_pcallk
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/lua-src-548.1.1/lua-5.4.8/lapi.c:1064:14
[INFO] [stdout]   45:     0x594d6e3840f3 - mlua_sys[7ea0eea488f450c4]::lua54::lua::lua_pcall
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/mlua-sys-0.8.0/src/lua54/lua.rs:278:5
[INFO] [stdout]   46:     0x594d6e3840f3 - <mlua[5896b452052a3344]::function::Function>::call::<(), ()>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/mlua-0.11.0-beta.3/src/function.rs:121:23
[INFO] [stdout]   47:     0x594d6e387113 - <mlua[5896b452052a3344]::chunk::Chunk>::call::<(), ()>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/mlua-0.11.0-beta.3/src/chunk.rs:574:31
[INFO] [stdout]   48:     0x594d6e38b27e - <mlua[5896b452052a3344]::chunk::Chunk>::exec
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/mlua-0.11.0-beta.3/src/chunk.rs:517:14
[INFO] [stdout]   49:     0x594d6d53c95b - lush[a76724007e6b7dd6]::setup::run_script
[INFO] [stdout]                                at /opt/rustwide/workdir/src/setup.rs:127:49
[INFO] [stdout]   50:     0x594d6d53b541 - lush[a76724007e6b7dd6]::run_file
[INFO] [stdout]                                at /opt/rustwide/workdir/src/main.rs:52:15
[INFO] [stdout]   51:     0x594d6d595c9a - lush[a76724007e6b7dd6]::tests::run_test_file
[INFO] [stdout]                                at /opt/rustwide/workdir/src/main.rs:72:19
[INFO] [stdout]   52:     0x594d6d594b37 - lush[a76724007e6b7dd6]::tests::run_test_file::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/src/main.rs:71:23
[INFO] [stdout]   53:     0x594d6d5358d6 - <lush[a76724007e6b7dd6]::tests::run_test_file::{closure#0} as core[35159d6ffb30e017]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   54:     0x594d6d6eeabb - <fn() -> core[35159d6ffb30e017]::result::Result<(), alloc[a8a7aba520129d98]::string::String> as core[35159d6ffb30e017]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   55:     0x594d6d6eeabb - test[a8007afcd3effadc]::__rust_begin_short_backtrace::<core[35159d6ffb30e017]::result::Result<(), alloc[a8a7aba520129d98]::string::String>, fn() -> core[35159d6ffb30e017]::result::Result<(), alloc[a8a7aba520129d98]::string::String>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/test/src/lib.rs:724:18
[INFO] [stdout]   56:     0x594d6d6fc2ab - test[a8007afcd3effadc]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/test/src/lib.rs:747:74
[INFO] [stdout]   57:     0x594d6d6fc2ab - <core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<test[a8007afcd3effadc]::run_test_in_process::{closure#0}> as core[35159d6ffb30e017]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   58:     0x594d6d6fc2ab - std[ec419fa8110287d5]::panicking::catch_unwind::do_call::<core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<test[a8007afcd3effadc]::run_test_in_process::{closure#0}>, core[35159d6ffb30e017]::result::Result<(), alloc[a8a7aba520129d98]::string::String>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:581:40
[INFO] [stdout]   59:     0x594d6d6fc2ab - std[ec419fa8110287d5]::panicking::catch_unwind::<core[35159d6ffb30e017]::result::Result<(), alloc[a8a7aba520129d98]::string::String>, core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<test[a8007afcd3effadc]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:544:19
[INFO] [stdout]   60:     0x594d6d6fc2ab - std[ec419fa8110287d5]::panic::catch_unwind::<core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<test[a8007afcd3effadc]::run_test_in_process::{closure#0}>, core[35159d6ffb30e017]::result::Result<(), alloc[a8a7aba520129d98]::string::String>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panic.rs:359:14
[INFO] [stdout]   61:     0x594d6d6fc2ab - test[a8007afcd3effadc]::run_test_in_process
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/test/src/lib.rs:747:27
[INFO] [stdout]   62:     0x594d6d6fc2ab - test[a8007afcd3effadc]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/test/src/lib.rs:668:43
[INFO] [stdout]   63:     0x594d6d6f6c84 - test[a8007afcd3effadc]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/test/src/lib.rs:698:41
[INFO] [stdout]   64:     0x594d6d6f6c84 - std[ec419fa8110287d5]::sys::backtrace::__rust_begin_short_backtrace::<test[a8007afcd3effadc]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   65:     0x594d6d6feeb2 - std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked::<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/thread/lifecycle.rs:70:13
[INFO] [stdout]   66:     0x594d6d6feeb2 - <core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[35159d6ffb30e017]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   67:     0x594d6d6feeb2 - std[ec419fa8110287d5]::panicking::catch_unwind::do_call::<core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:581:40
[INFO] [stdout]   68:     0x594d6d6feeb2 - std[ec419fa8110287d5]::panicking::catch_unwind::<(), core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:544:19
[INFO] [stdout]   69:     0x594d6d6feeb2 - std[ec419fa8110287d5]::panic::catch_unwind::<core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panic.rs:359:14
[INFO] [stdout]   70:     0x594d6d6feeb2 - std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked::<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/thread/lifecycle.rs:68:26
[INFO] [stdout]   71:     0x594d6d6feeb2 - <std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1} as core[35159d6ffb30e017]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   72:     0x594d6e48a21f - <alloc[a8a7aba520129d98]::boxed::Box<dyn core[35159d6ffb30e017]::ops::function::FnOnce<(), Output = ()> + core[35159d6ffb30e017]::marker::Send> as core[35159d6ffb30e017]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/alloc/src/boxed.rs:2271:9
[INFO] [stdout]   73:     0x594d6e48a21f - <std[ec419fa8110287d5]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stdout]   74:     0x79bc38bb9aa4 - <unknown>
[INFO] [stdout]   75:     0x79bc38c46a64 - clone
[INFO] [stdout]   76:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     tests::run_test_file
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 98 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.29s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass `--bin lush`
[INFO] running `Command { std: "docker" "inspect" "a877cc45d967f04f5eb7dffa307a483397fb6ac260703ab70643d023e28d47f1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "a877cc45d967f04f5eb7dffa307a483397fb6ac260703ab70643d023e28d47f1", kill_on_drop: false }`
[INFO] [stdout] a877cc45d967f04f5eb7dffa307a483397fb6ac260703ab70643d023e28d47f1
