[INFO] cloning repository https://github.com/zipxing/BASIC-M6502.rs
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/zipxing/BASIC-M6502.rs" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fzipxing%2FBASIC-M6502.rs", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fzipxing%2FBASIC-M6502.rs'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] e1198b459bf2b7351e0fc4aff31044d130ffda06
[INFO] testing zipxing/BASIC-M6502.rs against 1.93.0 for beta-1.94-1
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fzipxing%2FBASIC-M6502.rs" "/workspace/builds/worker-5-tc1/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-5-tc1/source'...
[INFO] [stderr] done.
[INFO] started tweaking git repo https://github.com/zipxing/BASIC-M6502.rs
[INFO] finished tweaking git repo https://github.com/zipxing/BASIC-M6502.rs
[INFO] tweaked toml for git repo https://github.com/zipxing/BASIC-M6502.rs written to /workspace/builds/worker-5-tc1/source/Cargo.toml
[INFO] validating manifest of git repo https://github.com/zipxing/BASIC-M6502.rs on toolchain 1.93.0
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.93.0" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate git repo https://github.com/zipxing/BASIC-M6502.rs 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.93.0" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded windows-targets v0.52.6
[INFO] [stderr]   Downloaded errno v0.3.14
[INFO] [stderr]   Downloaded cfg_aliases v0.2.1
[INFO] [stderr]   Downloaded windows-link v0.2.1
[INFO] [stderr]   Downloaded home v0.5.12
[INFO] [stderr]   Downloaded cfg-if v1.0.4
[INFO] [stderr]   Downloaded quote v1.0.41
[INFO] [stderr]   Downloaded block2 v0.6.2
[INFO] [stderr]   Downloaded dispatch2 v0.3.0
[INFO] [stderr]   Downloaded unicode-ident v1.0.22
[INFO] [stderr]   Downloaded zerocopy-derive v0.8.27
[INFO] [stderr]   Downloaded memchr v2.7.6
[INFO] [stderr]   Downloaded unicode-segmentation v1.12.0
[INFO] [stderr]   Downloaded rustyline v14.0.0
[INFO] [stderr]   Downloaded log v0.4.28
[INFO] [stderr]   Downloaded proc-macro2 v1.0.103
[INFO] [stderr]   Downloaded getrandom v0.2.16
[INFO] [stderr]   Downloaded bitflags v2.10.0
[INFO] [stderr]   Downloaded smallvec v1.15.1
[INFO] [stderr]   Downloaded zerocopy v0.8.27
[INFO] [stderr]   Downloaded objc2 v0.6.3
[INFO] [stderr]   Downloaded syn v2.0.108
[INFO] [stderr]   Downloaded unicode-width v0.1.14
[INFO] [stderr]   Downloaded nix v0.28.0
[INFO] [stderr]   Downloaded radix_trie v0.2.1
[INFO] [stderr]   Downloaded nix v0.30.1
[INFO] [stderr]   Downloaded windows_x86_64_gnullvm v0.52.6
[INFO] [stderr]   Downloaded objc2-encode v4.1.0
[INFO] [stderr]   Downloaded rustix v1.1.2
[INFO] [stderr]   Downloaded windows_aarch64_gnullvm v0.52.6
[INFO] [stderr]   Downloaded ppv-lite86 v0.2.21
[INFO] [stderr]   Downloaded wasi v0.11.1+wasi-snapshot-preview1
[INFO] [stderr]   Downloaded windows_i686_gnullvm v0.52.6
[INFO] [stderr]   Downloaded clipboard-win v5.4.1
[INFO] [stderr]   Downloaded rand_core v0.6.4
[INFO] [stderr]   Downloaded cfg_aliases v0.1.1
[INFO] [stderr]   Downloaded endian-type v0.1.2
[INFO] [stderr]   Downloaded nibble_vec v0.1.0
[INFO] [stderr]   Downloaded utf8parse v0.2.2
[INFO] [stderr]   Downloaded ctrlc v3.5.1
[INFO] [stderr]   Downloaded error-code v3.3.2
[INFO] [stderr]   Downloaded fd-lock v4.0.4
[INFO] [stderr]   Downloaded windows_x86_64_msvc v0.52.6
[INFO] [stderr]   Downloaded libc v0.2.177
[INFO] [stderr]   Downloaded windows_i686_gnu v0.52.6
[INFO] [stderr]   Downloaded windows_aarch64_msvc v0.52.6
[INFO] [stderr]   Downloaded windows_x86_64_gnu v0.52.6
[INFO] [stderr]   Downloaded windows_i686_msvc v0.52.6
[INFO] [stderr]   Downloaded windows-sys v0.61.2
[INFO] [stderr]   Downloaded windows-sys v0.59.0
[INFO] [stderr]   Downloaded linux-raw-sys v0.11.0
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-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:98afbf2d16093dec2546ff8915fddc74e65664aa03fc460b3712b1c2c54a33e4" "/opt/rustwide/cargo-home/bin/cargo" "+1.93.0" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] fe77cd17e28cc2f719df4418b1aae823cc3376175ad16998a0b7ad635da0ab7b
[INFO] running `Command { std: "docker" "start" "-a" "fe77cd17e28cc2f719df4418b1aae823cc3376175ad16998a0b7ad635da0ab7b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "fe77cd17e28cc2f719df4418b1aae823cc3376175ad16998a0b7ad635da0ab7b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "fe77cd17e28cc2f719df4418b1aae823cc3376175ad16998a0b7ad635da0ab7b", kill_on_drop: false }`
[INFO] [stdout] fe77cd17e28cc2f719df4418b1aae823cc3376175ad16998a0b7ad635da0ab7b
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-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:98afbf2d16093dec2546ff8915fddc74e65664aa03fc460b3712b1c2c54a33e4" "/opt/rustwide/cargo-home/bin/cargo" "+1.93.0" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 80bc132d886e4fb5d991e31265d57d2af0543c62b6f598fb8c4d1dd5531c2aeb
[INFO] running `Command { std: "docker" "start" "-a" "80bc132d886e4fb5d991e31265d57d2af0543c62b6f598fb8c4d1dd5531c2aeb", kill_on_drop: false }`
[INFO] [stderr]    Compiling libc v0.2.177
[INFO] [stderr]    Compiling cfg-if v1.0.4
[INFO] [stderr]    Compiling bitflags v2.10.0
[INFO] [stderr]    Compiling zerocopy v0.8.27
[INFO] [stderr]    Compiling cfg_aliases v0.1.1
[INFO] [stderr]    Compiling cfg_aliases v0.2.1
[INFO] [stderr]    Compiling rustix v1.1.2
[INFO] [stderr]    Compiling smallvec v1.15.1
[INFO] [stderr]    Compiling linux-raw-sys v0.11.0
[INFO] [stderr]    Compiling endian-type v0.1.2
[INFO] [stderr]    Compiling unicode-width v0.1.14
[INFO] [stderr]    Compiling home v0.5.12
[INFO] [stderr]    Compiling log v0.4.28
[INFO] [stderr]    Compiling memchr v2.7.6
[INFO] [stderr]    Compiling unicode-segmentation v1.12.0
[INFO] [stderr]    Compiling utf8parse v0.2.2
[INFO] [stderr]    Compiling nix v0.30.1
[INFO] [stderr]    Compiling nix v0.28.0
[INFO] [stderr]    Compiling nibble_vec v0.1.0
[INFO] [stderr]    Compiling radix_trie v0.2.1
[INFO] [stderr]    Compiling fd-lock v4.0.4
[INFO] [stderr]    Compiling getrandom v0.2.16
[INFO] [stderr]    Compiling ppv-lite86 v0.2.21
[INFO] [stderr]    Compiling rand_core v0.6.4
[INFO] [stderr]    Compiling rand_chacha v0.3.1
[INFO] [stderr]    Compiling rand v0.8.5
[INFO] [stderr]    Compiling ctrlc v3.5.1
[INFO] [stderr]    Compiling rustyline v14.0.0
[INFO] [stderr]    Compiling basic_m6502 v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 10.04s
[INFO] running `Command { std: "docker" "inspect" "80bc132d886e4fb5d991e31265d57d2af0543c62b6f598fb8c4d1dd5531c2aeb", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "80bc132d886e4fb5d991e31265d57d2af0543c62b6f598fb8c4d1dd5531c2aeb", kill_on_drop: false }`
[INFO] [stdout] 80bc132d886e4fb5d991e31265d57d2af0543c62b6f598fb8c4d1dd5531c2aeb
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-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:98afbf2d16093dec2546ff8915fddc74e65664aa03fc460b3712b1c2c54a33e4" "/opt/rustwide/cargo-home/bin/cargo" "+1.93.0" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 3f613858e93f4caf0b1f700a552c6f8411383d11f38227e1dce7facf018f1d0a
[INFO] running `Command { std: "docker" "start" "-a" "3f613858e93f4caf0b1f700a552c6f8411383d11f38227e1dce7facf018f1d0a", kill_on_drop: false }`
[INFO] [stderr]    Compiling basic_m6502 v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 2.91s
[INFO] running `Command { std: "docker" "inspect" "3f613858e93f4caf0b1f700a552c6f8411383d11f38227e1dce7facf018f1d0a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "3f613858e93f4caf0b1f700a552c6f8411383d11f38227e1dce7facf018f1d0a", kill_on_drop: false }`
[INFO] [stdout] 3f613858e93f4caf0b1f700a552c6f8411383d11f38227e1dce7facf018f1d0a
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-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:98afbf2d16093dec2546ff8915fddc74e65664aa03fc460b3712b1c2c54a33e4" "/opt/rustwide/cargo-home/bin/cargo" "+1.93.0" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] d7ab2d54cff063ad3b3ad6c2c2248aee91e0dea024176c7e80f06a7e8d38600a
[INFO] running `Command { std: "docker" "start" "-a" "d7ab2d54cff063ad3b3ad6c2c2248aee91e0dea024176c7e80f06a7e8d38600a", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.05s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/basic_m6502-cdb5816c6ccbcd55)
[INFO] [stdout] running 195 tests
[INFO] [stdout] test ast::tests::test_expr_binary ... ok
[INFO] [stdout] test ast::tests::test_function_call ... ok
[INFO] [stdout] test ast::tests::test_expr_unary ... ok
[INFO] [stdout] test ast::tests::test_expr_number ... ok
[INFO] [stdout] test ast::tests::test_statement_print ... ok
[INFO] [stdout] test error::tests::test_error_clone ... ok
[INFO] [stdout] test ast::tests::test_statement_if_with_line_number ... ok
[INFO] [stdout] test error::tests::test_illegal_character ... ok
[INFO] [stdout] test error::tests::test_error_display ... ok
[INFO] [stdout] test error::tests::test_result_type ... ok
[INFO] [stdout] test executor::tests::test_complex_expression ... ok
[INFO] [stdout] test executor::tests::test_data_read ... ok
[INFO] [stdout] test executor::tests::test_addition ... ok
[INFO] [stdout] test executor::tests::test_data_read_mixed_types ... ok
[INFO] [stdout] test executor::tests::test_def_fn_statement ... ok
[INFO] [stdout] test executor::tests::test_dim_statement ... ok
[INFO] [stdout] test executor::tests::test_division ... ok
[INFO] [stdout] test executor::tests::test_division_by_zero ... ok
[INFO] [stdout] test executor::tests::test_equal ... ok
[INFO] [stdout] test executor::tests::test_float_division ... ok
[INFO] [stdout] test executor::tests::test_fn_call_basic ... ok
[INFO] [stdout] test ast::tests::test_expr_variable ... ok
[INFO] [stdout] test executor::tests::test_fn_call_nested ... ok
[INFO] [stdout] test executor::tests::test_fn_call_parameter_scope ... ok
[INFO] [stdout] test ast::tests::test_program_line ... ok
[INFO] [stdout] test executor::tests::test_fn_call_with_global ... ok
[INFO] [stdout] test executor::tests::test_for_next_basic ... ok
[INFO] [stdout] test executor::tests::test_for_next_negative_step ... ok
[INFO] [stdout] test executor::tests::test_get_no_input ... ok
[INFO] [stdout] test executor::tests::test_get_numeric_variable ... ok
[INFO] [stdout] test ast::tests::test_array_access ... ok
[INFO] [stdout] test executor::tests::test_get_string_variable ... ok
[INFO] [stdout] test executor::tests::test_gosub_statement ... ok
[INFO] [stdout] test executor::tests::test_for_next_step ... ok
[INFO] [stdout] test executor::tests::test_goto_statement ... ok
[INFO] [stdout] test executor::tests::test_if_then_false ... ok
[INFO] [stdout] test executor::tests::test_if_then_statement ... ok
[INFO] [stdout] test executor::tests::test_if_then_true ... ok
[INFO] [stdout] test executor::tests::test_input_basic ... ok
[INFO] [stdout] test executor::tests::test_input_multiple_variables ... ok
[INFO] [stdout] test executor::tests::test_input_string ... ok
[INFO] [stdout] test executor::tests::test_input_string_with_quotes ... ok
[INFO] [stdout] test executor::tests::test_let_statement ... ok
[INFO] [stdout] test executor::tests::test_load_nonexistent_file ... ok
[INFO] [stdout] test executor::tests::test_integration_advanced_features ... ok
[INFO] [stdout] test ast::tests::test_statement_let ... ok
[INFO] [stdout] test executor::tests::test_input_with_prompt ... ok
[INFO] [stdout] test executor::tests::test_multiple_null_statements ... ok
[INFO] [stdout] test executor::tests::test_power ... ok
[INFO] [stdout] test executor::tests::test_nested_gosub ... ok
[INFO] [stdout] test executor::tests::test_on_gosub ... ok
[INFO] [stdout] test executor::tests::test_on_goto ... ok
[INFO] [stdout] test executor::tests::test_pos_function ... ok
[INFO] [stdout] test executor::tests::test_pos_with_spc ... ok
[INFO] [stdout] test executor::tests::test_pos_with_tab ... ok
[INFO] [stdout] test executor::tests::test_multiplication ... ok
[INFO] [stdout] test executor::tests::test_not_equal ... ok
[INFO] [stdout] test executor::tests::test_out_of_data_error ... ok
[INFO] [stdout] test executor::tests::test_print_comma_alignment ... ok
[INFO] [stdout] test executor::tests::test_print_empty ... ok
[INFO] [stdout] test executor::tests::test_print_no_newline ... ok
[INFO] [stdout] test executor::tests::test_rnd_dice_simulation ... ok
[INFO] [stdout] test executor::tests::test_print_number ... ok
[INFO] [stdout] test executor::tests::test_print_semicolon ... ok
[INFO] [stdout] test executor::tests::test_print_string ... ok
[INFO] [stdout] test executor::tests::test_print_variable ... ok
[INFO] [stdout] test executor::tests::test_restore ... ok
[INFO] [stdout] test executor::tests::test_return_statement ... ok
[INFO] [stdout] test executor::tests::test_null_statement ... ok
[INFO] [stdout] test executor::tests::test_rnd_function ... ok
[INFO] [stdout] test executor::tests::test_string_concatenation ... ok
[INFO] [stdout] test executor::tests::test_subtraction ... ok
[INFO] [stdout] test executor::tests::test_tab_function ... ok
[INFO] [stdout] test executor::tests::test_variable_read ... ok
[INFO] [stdout] test parser::tests::test_parse_dim ... ok
[INFO] [stdout] test parser::tests::test_parse_goto ... ok
[INFO] [stdout] test parser::tests::test_parse_implicit_let ... ok
[INFO] [stdout] test parser::tests::test_parse_if_then_statement ... ok
[INFO] [stdout] test parser::tests::test_parse_for_with_step ... ok
[INFO] [stdout] test parser::tests::test_parse_if_then_line_number ... ok
[INFO] [stdout] test parser::tests::test_parse_input ... ok
[INFO] [stdout] test parser::tests::test_parse_input_with_prompt ... ok
[INFO] [stdout] test parser::tests::test_parse_let ... ok
[INFO] [stdout] test parser::tests::test_parse_next ... ok
[INFO] [stdout] test parser::tests::test_parse_operator_precedence ... ok
[INFO] [stdout] test executor::tests::test_run_test_bas_file ... ok
[INFO] [stdout] test executor::tests::test_spc_function ... ok
[INFO] [stdout] test parser::tests::test_parse_function_call ... ok
[INFO] [stdout] test executor::tests::test_unary_minus ... ok
[INFO] [stdout] test parser::tests::test_parse_for ... ok
[INFO] [stdout] test parser::tests::test_parse_multiple_statements ... ok
[INFO] [stdout] test parser::tests::test_parse_print_single ... ok
[INFO] [stdout] test parser::tests::test_parse_single_line_for_loop ... ok
[INFO] [stdout] test runtime::tests::test_cont_without_pause ... ok
[INFO] [stdout] test runtime::tests::test_cross_line_execution ... ok
[INFO] [stdout] test runtime::tests::test_cont_resume ... ok
[INFO] [stdout] test runtime::tests::test_delete_line ... ok
[INFO] [stdout] test runtime::tests::test_add_line ... ok
[INFO] [stdout] test runtime::tests::test_for_loop_pop ... ok
[INFO] [stdout] test runtime::tests::test_for_loop_push ... ok
[INFO] [stdout] test runtime::tests::test_get_next_statement ... ok
[INFO] [stdout] test runtime::tests::test_line_sorting ... ok
[INFO] [stdout] test runtime::tests::test_gosub_call ... ok
[INFO] [stdout] test runtime::tests::test_goto_jump ... ok
[INFO] [stdout] test runtime::tests::test_new_command ... ok
[INFO] [stdout] test runtime::tests::test_nested_for_loops ... ok
[INFO] [stdout] test runtime::tests::test_next_without_for ... ok
[INFO] [stdout] test runtime::tests::test_nested_gosub ... ok
[INFO] [stdout] test parser::tests::test_parse_parentheses ... ok
[INFO] [stdout] test executor::tests::test_on_goto_out_of_range ... ok
[INFO] [stdout] test runtime::tests::test_start_execution_from_first_line ... ok
[INFO] [stdout] test runtime::tests::test_stop_pause ... ok
[INFO] [stdout] test token::tests::test_all_statement_keywords ... ok
[INFO] [stdout] test token::tests::test_function_keywords ... ok
[INFO] [stdout] test runtime::tests::test_stack_overflow ... ok
[INFO] [stdout] test runtime::tests::test_start_execution_from_specific_line ... ok
[INFO] [stdout] test parser::tests::test_parse_print_comma ... ok
[INFO] [stdout] test executor::tests::test_save_empty_program ... ok
[INFO] [stdout] test executor::tests::test_string_functions ... ok
[INFO] [stdout] test runtime::tests::test_return ... ok
[INFO] [stdout] test runtime::tests::test_return_without_gosub ... ok
[INFO] [stdout] test runtime::tests::test_replace_line ... ok
[INFO] [stdout] test token::tests::test_logical_operators ... ok
[INFO] [stdout] test token::tests::test_non_keyword ... ok
[INFO] [stdout] test token::tests::test_token_clone ... ok
[INFO] [stdout] test token::tests::test_keyword_recognition_case_insensitive ... ok
[INFO] [stdout] test token::tests::test_token_equality ... ok
[INFO] [stdout] test tokenizer::tests::test_all_statement_keywords ... ok
[INFO] [stdout] test tokenizer::tests::test_all_function_keywords ... ok
[INFO] [stdout] test token::tests::test_is_statement_keyword ... ok
[INFO] [stdout] test tokenizer::tests::test_alphanumeric_variable ... ok
[INFO] [stdout] test tokenizer::tests::test_arithmetic_operators ... ok
[INFO] [stdout] test tokenizer::tests::test_colon_statement_separator ... ok
[INFO] [stdout] test tokenizer::tests::test_complete_basic_line ... ok
[INFO] [stdout] test tokenizer::tests::test_comma_separator ... ok
[INFO] [stdout] test tokenizer::tests::test_keyword_case_insensitive ... ok
[INFO] [stdout] test tokenizer::tests::test_line_number_range ... ok
[INFO] [stdout] test tokenizer::tests::test_invalid_number ... ok
[INFO] [stdout] test tokenizer::tests::test_logical_operators ... ok
[INFO] [stdout] test tokenizer::tests::test_complex_statement_separation ... ok
[INFO] [stdout] test tokenizer::tests::test_line_number ... ok
[INFO] [stdout] test token::tests::test_string_functions ... ok
[INFO] [stdout] test tokenizer::tests::test_multiple_whitespaces ... ok
[INFO] [stdout] test tokenizer::tests::test_parse_empty_string ... ok
[INFO] [stdout] test tokenizer::tests::test_parse_float ... ok
[INFO] [stdout] test tokenizer::tests::test_parse_negative_number ... ok
[INFO] [stdout] test tokenizer::tests::test_parse_string_with_spaces ... ok
[INFO] [stdout] test tokenizer::tests::test_recognize_keyword_print ... ok
[INFO] [stdout] test tokenizer::tests::test_recognize_number ... ok
[INFO] [stdout] test tokenizer::tests::test_semicolon_separator ... ok
[INFO] [stdout] test tokenizer::tests::test_string_variable ... ok
[INFO] [stdout] test tokenizer::tests::test_parse_integer ... ok
[INFO] [stdout] test tokenizer::tests::test_parse_scientific_notation ... ok
[INFO] [stdout] test tokenizer::tests::test_parse_string ... ok
[INFO] [stdout] test tokenizer::tests::test_recognize_identifier ... ok
[INFO] [stdout] test tokenizer::tests::test_relational_operators ... ok
[INFO] [stdout] test tokenizer::tests::test_single_letter_variable ... ok
[INFO] [stdout] test variables::tests::test_case_insensitive ... ok
[INFO] [stdout] test tokenizer::tests::test_whitespace_separation ... ok
[INFO] [stdout] test variables::tests::test_clear_and_reuse ... ok
[INFO] [stdout] test variables::tests::test_array_dimensions ... ok
[INFO] [stdout] test variables::tests::test_array_element_assignment ... ok
[INFO] [stdout] test variables::tests::test_array_negative_index ... ok
[INFO] [stdout] test variables::tests::test_array_subscript_out_of_range ... ok
[INFO] [stdout] test variables::tests::test_array_type_consistency ... ok
[INFO] [stdout] test variables::tests::test_implicit_array_creation ... ok
[INFO] [stdout] test variables::tests::test_clear_arrays ... ok
[INFO] [stdout] test variables::tests::test_list_variables ... ok
[INFO] [stdout] test variables::tests::test_implicit_array_size_limit ... ok
[INFO] [stdout] test variables::tests::test_clear_simple_variables ... ok
[INFO] [stdout] test variables::tests::test_dim_one_dimensional ... ok
[INFO] [stdout] test variables::tests::test_numeric_assignment ... ok
[INFO] [stdout] test variables::tests::test_multidimensional_array_access ... ok
[INFO] [stdout] test variables::tests::test_dim_string_array ... ok
[INFO] [stdout] test variables::tests::test_dim_three_dimensional ... ok
[INFO] [stdout] test ast::tests::test_statement_for ... ok
[INFO] [stdout] test tokenizer::tests::test_rem_comment ... ok
[INFO] [stdout] test variables::tests::test_string_assignment ... ok
[INFO] [stdout] test variables::tests::test_dim_two_dimensional ... ok
[INFO] [stdout] test variables::tests::test_type_mismatch_string_to_number ... ok
[INFO] [stdout] test variables::tests::test_type_mismatch_number_to_string ... ok
[INFO] [stdout] test variables::tests::test_uninitialized_numeric ... ok
[INFO] [stdout] test variables::tests::test_uninitialized_string ... ok
[INFO] [stdout] test variables::tests::test_value_as_number ... ok
[INFO] [stdout] test variables::tests::test_string_variable ... ok
[INFO] [stdout] test variables::tests::test_type_distinction ... ok
[INFO] [stdout] test variables::tests::test_value_as_string ... ok
[INFO] [stdout] test variables::tests::test_numeric_variable ... ok
[INFO] [stdout] test variables::tests::test_redimensioned_array_error ... ok
[INFO] [stdout] test tokenizer::tests::test_unterminated_string ... ok
[INFO] [stdout] test executor::tests::test_math_functions ... FAILED
[INFO] [stdout] test executor::tests::test_save_and_load ... FAILED
[INFO] [stdout] test executor::tests::test_save_complex_program ... FAILED
[INFO] [stdout] test parser::tests::test_parse_simple_arithmetic ... ok
[INFO] [stdout] test runtime::tests::test_goto_undefined_line ... ok
[INFO] [stderr] error: test failed, to rerun pass `--lib`
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- executor::tests::test_math_functions stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'executor::tests::test_math_functions' (73) panicked at src/executor.rs:1785:9:
[INFO] [stdout] assertion `left == right` failed
[INFO] [stdout]   left: Number(3.0)
[INFO] [stdout]  right: Number(-2.0)
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5f4701f22232 - std::backtrace_rs::backtrace::libunwind::trace::h90e89fac33585832
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x5f4701f22232 - std::backtrace_rs::backtrace::trace_unsynchronized::heebcf2380a8e7359
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x5f4701f22232 - std::sys::backtrace::_print_fmt::hdf3e2a22d2f810db
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/std/src/sys/backtrace.rs:68:9
[INFO] [stdout]    3:     0x5f4701f22232 - <std::sys::backtrace::BacktraceLock::print::DisplayBacktrace as core::fmt::Display>::fmt::hac1d885928ba8582
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/std/src/sys/backtrace.rs:38:26
[INFO] [stdout]    4:     0x5f4701f338f7 - core::fmt::rt::Argument::fmt::h6901eb7c19abebe8
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x5f4701f338f7 - core::fmt::write::h83ebb4d32483be9e
[INFO] [stdout]    6:     0x5f4701ef06c6 - std::io::default_write_fmt::h751a79cdae495f10
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/std/src/io/mod.rs:639:11
[INFO] [stdout]    7:     0x5f4701ef06c6 - std::io::Write::write_fmt::h9ef514f8700ff7b2
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/std/src/io/mod.rs:1994:13
[INFO] [stdout]    8:     0x5f4701f010b9 - std::sys::backtrace::BacktraceLock::print::hcc2e1a3ac996c911
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/std/src/sys/backtrace.rs:41:9
[INFO] [stdout]    9:     0x5f4701f010b9 - std::panicking::default_hook::{{closure}}::h8e9c4d1276f0925f
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x5f4701f00f51 - std::panicking::default_hook::h2b2078d38b534dfb
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x5f4701e8c74e - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h39d051e7dedac6a7
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/alloc/src/boxed.rs:2220:9
[INFO] [stdout]   12:     0x5f4701e8c74e - test::test_main_with_exit_callback::{{closure}}::h4b005fe75814c302
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/test/src/lib.rs:145:21
[INFO] [stdout]   13:     0x5f4701f01332 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::hd426070722c13cbf
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/alloc/src/boxed.rs:2220:9
[INFO] [stdout]   14:     0x5f4701f01332 - std::panicking::panic_with_hook::h39b739724e701bfd
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x5f4701f01178 - std::panicking::panic_handler::{{closure}}::he540c4833054e458
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x5f4701efc679 - std::sys::backtrace::__rust_end_short_backtrace::hfa179d89deec8aed
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/std/src/sys/backtrace.rs:176:18
[INFO] [stdout]   17:     0x5f4701ee493d - __rustc[d131491b17107b07]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x5f4701f3c9fc - core::panicking::panic_fmt::ha564519d657d9c46
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x5f4701f3c8b3 - core::panicking::assert_failed_inner::h6fc38e43be639d33
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/core/src/panicking.rs:439:17
[INFO] [stdout]   20:     0x5f4701e66698 - core::panicking::assert_failed::h81e279f0be4244ae
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/core/src/panicking.rs:394:5
[INFO] [stdout]   21:     0x5f4701dc9101 - basic_m6502::executor::tests::test_math_functions::h333d26f7e0527123
[INFO] [stdout]                                at /opt/rustwide/workdir/src/executor.rs:1785:9
[INFO] [stdout]   22:     0x5f4701dc9557 - basic_m6502::executor::tests::test_math_functions::{{closure}}::h02ef816671fd78c9
[INFO] [stdout]                                at /opt/rustwide/workdir/src/executor.rs:1752:29
[INFO] [stdout]   23:     0x5f4701e404d6 - core::ops::function::FnOnce::call_once::h339b637846ca6d86
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   24:     0x5f4701e8c57b - core::ops::function::FnOnce::call_once::h0217b30cfdee2e67
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x5f4701e8c57b - test::__rust_begin_short_backtrace::h6d98714a1e28f556
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/test/src/lib.rs:663:18
[INFO] [stdout]   26:     0x5f4701e9ff0a - test::run_test_in_process::{{closure}}::he2c70d2634d3a3cc
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/test/src/lib.rs:686:74
[INFO] [stdout]   27:     0x5f4701e9ff0a - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h40a0a825bcf17fdd
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/core/src/panic/unwind_safe.rs:274:9
[INFO] [stdout]   28:     0x5f4701e9ff0a - std::panicking::catch_unwind::do_call::h6c8eb5dd6e7b5975
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/std/src/panicking.rs:581:40
[INFO] [stdout]   29:     0x5f4701e9ff0a - std::panicking::catch_unwind::h55455eac2972ad1e
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/std/src/panicking.rs:544:19
[INFO] [stdout]   30:     0x5f4701e9ff0a - std::panic::catch_unwind::h0025465150a5e558
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/std/src/panic.rs:359:14
[INFO] [stdout]   31:     0x5f4701e9ff0a - test::run_test_in_process::hb61e682f9b630fbc
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/test/src/lib.rs:686:27
[INFO] [stdout]   32:     0x5f4701e9ff0a - test::run_test::{{closure}}::hc2c2a7a38ab176e2
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/test/src/lib.rs:607:43
[INFO] [stdout]   33:     0x5f4701e7a1a4 - test::run_test::{{closure}}::ha91867b85cd2a911
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/test/src/lib.rs:637:41
[INFO] [stdout]   34:     0x5f4701e7a1a4 - std::sys::backtrace::__rust_begin_short_backtrace::ha00a9fe02049c339
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/std/src/sys/backtrace.rs:160:18
[INFO] [stdout]   35:     0x5f4701e7dad2 - std::thread::lifecycle::spawn_unchecked::{{closure}}::{{closure}}::hd629fba9153dfb55
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/std/src/thread/lifecycle.rs:92:13
[INFO] [stdout]   36:     0x5f4701e7dad2 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h4189018816a5c5d9
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/core/src/panic/unwind_safe.rs:274:9
[INFO] [stdout]   37:     0x5f4701e7dad2 - std::panicking::catch_unwind::do_call::hf9fcdbca3c2e9877
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/std/src/panicking.rs:581:40
[INFO] [stdout]   38:     0x5f4701e7dad2 - std::panicking::catch_unwind::h97b92d88631c7c64
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/std/src/panicking.rs:544:19
[INFO] [stdout]   39:     0x5f4701e7dad2 - std::panic::catch_unwind::ha77cdbb68e725e5e
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/std/src/panic.rs:359:14
[INFO] [stdout]   40:     0x5f4701e7dad2 - std::thread::lifecycle::spawn_unchecked::{{closure}}::h511f05bc1a132253
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/std/src/thread/lifecycle.rs:90:26
[INFO] [stdout]   41:     0x5f4701e7dad2 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h6b68b31e9b685cb8
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   42:     0x5f4701ef7d0f - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h22a27d165e4e871d
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/alloc/src/boxed.rs:2206:9
[INFO] [stdout]   43:     0x5f4701ef7d0f - std::sys::thread::unix::Thread::new::thread_start::h45cc87bb053add0f
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stdout]   44:     0x7058ca454aa4 - <unknown>
[INFO] [stdout]   45:     0x7058ca4e1a64 - clone
[INFO] [stdout]   46:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- executor::tests::test_save_and_load stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'executor::tests::test_save_and_load' (99) panicked at src/executor.rs:2810:12:
[INFO] [stdout] called `Result::unwrap()` on an `Err` value: SyntaxError("Failed to create file: Read-only file system (os error 30)")
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5f4701f22232 - std::backtrace_rs::backtrace::libunwind::trace::h90e89fac33585832
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x5f4701f22232 - std::backtrace_rs::backtrace::trace_unsynchronized::heebcf2380a8e7359
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x5f4701f22232 - std::sys::backtrace::_print_fmt::hdf3e2a22d2f810db
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/std/src/sys/backtrace.rs:68:9
[INFO] [stdout]    3:     0x5f4701f22232 - <std::sys::backtrace::BacktraceLock::print::DisplayBacktrace as core::fmt::Display>::fmt::hac1d885928ba8582
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/std/src/sys/backtrace.rs:38:26
[INFO] [stdout]    4:     0x5f4701f338f7 - core::fmt::rt::Argument::fmt::h6901eb7c19abebe8
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x5f4701f338f7 - core::fmt::write::h83ebb4d32483be9e
[INFO] [stdout]    6:     0x5f4701ef06c6 - std::io::default_write_fmt::h751a79cdae495f10
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/std/src/io/mod.rs:639:11
[INFO] [stdout]    7:     0x5f4701ef06c6 - std::io::Write::write_fmt::h9ef514f8700ff7b2
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/std/src/io/mod.rs:1994:13
[INFO] [stdout]    8:     0x5f4701f010b9 - std::sys::backtrace::BacktraceLock::print::hcc2e1a3ac996c911
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/std/src/sys/backtrace.rs:41:9
[INFO] [stdout]    9:     0x5f4701f010b9 - std::panicking::default_hook::{{closure}}::h8e9c4d1276f0925f
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x5f4701f00f51 - std::panicking::default_hook::h2b2078d38b534dfb
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x5f4701e8c74e - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h39d051e7dedac6a7
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/alloc/src/boxed.rs:2220:9
[INFO] [stdout]   12:     0x5f4701e8c74e - test::test_main_with_exit_callback::{{closure}}::h4b005fe75814c302
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/test/src/lib.rs:145:21
[INFO] [stdout]   13:     0x5f4701f01332 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::hd426070722c13cbf
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/alloc/src/boxed.rs:2220:9
[INFO] [stdout]   14:     0x5f4701f01332 - std::panicking::panic_with_hook::h39b739724e701bfd
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x5f4701f01178 - std::panicking::panic_handler::{{closure}}::he540c4833054e458
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x5f4701efc679 - std::sys::backtrace::__rust_end_short_backtrace::hfa179d89deec8aed
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/std/src/sys/backtrace.rs:176:18
[INFO] [stdout]   17:     0x5f4701ee493d - __rustc[d131491b17107b07]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x5f4701f3c9fc - core::panicking::panic_fmt::ha564519d657d9c46
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x5f4701f3c0c2 - core::result::unwrap_failed::h23873bb39ca9a844
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/core/src/result.rs:1867:5
[INFO] [stdout]   20:     0x5f4701dc507a - core::result::Result<T,E>::unwrap::h77480d29344c943c
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/core/src/result.rs:1233:23
[INFO] [stdout]   21:     0x5f4701dc507a - basic_m6502::executor::tests::test_save_and_load::h8ceead57cebd0318
[INFO] [stdout]                                at /opt/rustwide/workdir/src/executor.rs:2810:12
[INFO] [stdout]   22:     0x5f4701dc5627 - basic_m6502::executor::tests::test_save_and_load::{{closure}}::hdcfdd04ccf9c137b
[INFO] [stdout]                                at /opt/rustwide/workdir/src/executor.rs:2780:28
[INFO] [stdout]   23:     0x5f4701e41d86 - core::ops::function::FnOnce::call_once::ha13581b0135ce947
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   24:     0x5f4701e8c57b - core::ops::function::FnOnce::call_once::h0217b30cfdee2e67
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x5f4701e8c57b - test::__rust_begin_short_backtrace::h6d98714a1e28f556
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/test/src/lib.rs:663:18
[INFO] [stdout]   26:     0x5f4701e9ff0a - test::run_test_in_process::{{closure}}::he2c70d2634d3a3cc
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/test/src/lib.rs:686:74
[INFO] [stdout]   27:     0x5f4701e9ff0a - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h40a0a825bcf17fdd
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/core/src/panic/unwind_safe.rs:274:9
[INFO] [stdout]   28:     0x5f4701e9ff0a - std::panicking::catch_unwind::do_call::h6c8eb5dd6e7b5975
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/std/src/panicking.rs:581:40
[INFO] [stdout]   29:     0x5f4701e9ff0a - std::panicking::catch_unwind::h55455eac2972ad1e
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/std/src/panicking.rs:544:19
[INFO] [stdout]   30:     0x5f4701e9ff0a - std::panic::catch_unwind::h0025465150a5e558
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/std/src/panic.rs:359:14
[INFO] [stdout]   31:     0x5f4701e9ff0a - test::run_test_in_process::hb61e682f9b630fbc
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/test/src/lib.rs:686:27
[INFO] [stdout]   32:     0x5f4701e9ff0a - test::run_test::{{closure}}::hc2c2a7a38ab176e2
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/test/src/lib.rs:607:43
[INFO] [stdout]   33:     0x5f4701e7a1a4 - test::run_test::{{closure}}::ha91867b85cd2a911
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/test/src/lib.rs:637:41
[INFO] [stdout]   34:     0x5f4701e7a1a4 - std::sys::backtrace::__rust_begin_short_backtrace::ha00a9fe02049c339
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/std/src/sys/backtrace.rs:160:18
[INFO] [stdout]   35:     0x5f4701e7dad2 - std::thread::lifecycle::spawn_unchecked::{{closure}}::{{closure}}::hd629fba9153dfb55
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/std/src/thread/lifecycle.rs:92:13
[INFO] [stdout]   36:     0x5f4701e7dad2 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h4189018816a5c5d9
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/core/src/panic/unwind_safe.rs:274:9
[INFO] [stdout]   37:     0x5f4701e7dad2 - std::panicking::catch_unwind::do_call::hf9fcdbca3c2e9877
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/std/src/panicking.rs:581:40
[INFO] [stdout]   38:     0x5f4701e7dad2 - std::panicking::catch_unwind::h97b92d88631c7c64
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/std/src/panicking.rs:544:19
[INFO] [stdout]   39:     0x5f4701e7dad2 - std::panic::catch_unwind::ha77cdbb68e725e5e
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/std/src/panic.rs:359:14
[INFO] [stdout]   40:     0x5f4701e7dad2 - std::thread::lifecycle::spawn_unchecked::{{closure}}::h511f05bc1a132253
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/std/src/thread/lifecycle.rs:90:26
[INFO] [stdout]   41:     0x5f4701e7dad2 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h6b68b31e9b685cb8
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   42:     0x5f4701ef7d0f - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h22a27d165e4e871d
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/alloc/src/boxed.rs:2206:9
[INFO] [stdout]   43:     0x5f4701ef7d0f - std::sys::thread::unix::Thread::new::thread_start::h45cc87bb053add0f
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stdout]   44:     0x7058ca454aa4 - <unknown>
[INFO] [stdout]   45:     0x7058ca4e1a64 - clone
[INFO] [stdout]   46:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- executor::tests::test_save_complex_program stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'executor::tests::test_save_complex_program' (100) panicked at src/executor.rs:2895:12:
[INFO] [stdout] called `Result::unwrap()` on an `Err` value: SyntaxError("Failed to create file: Read-only file system (os error 30)")
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5f4701f22232 - std::backtrace_rs::backtrace::libunwind::trace::h90e89fac33585832
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x5f4701f22232 - std::backtrace_rs::backtrace::trace_unsynchronized::heebcf2380a8e7359
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x5f4701f22232 - std::sys::backtrace::_print_fmt::hdf3e2a22d2f810db
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/std/src/sys/backtrace.rs:68:9
[INFO] [stdout]    3:     0x5f4701f22232 - <std::sys::backtrace::BacktraceLock::print::DisplayBacktrace as core::fmt::Display>::fmt::hac1d885928ba8582
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/std/src/sys/backtrace.rs:38:26
[INFO] [stdout]    4:     0x5f4701f338f7 - core::fmt::rt::Argument::fmt::h6901eb7c19abebe8
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x5f4701f338f7 - core::fmt::write::h83ebb4d32483be9e
[INFO] [stdout]    6:     0x5f4701ef06c6 - std::io::default_write_fmt::h751a79cdae495f10
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/std/src/io/mod.rs:639:11
[INFO] [stdout]    7:     0x5f4701ef06c6 - std::io::Write::write_fmt::h9ef514f8700ff7b2
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/std/src/io/mod.rs:1994:13
[INFO] [stdout]    8:     0x5f4701f010b9 - std::sys::backtrace::BacktraceLock::print::hcc2e1a3ac996c911
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/std/src/sys/backtrace.rs:41:9
[INFO] [stdout]    9:     0x5f4701f010b9 - std::panicking::default_hook::{{closure}}::h8e9c4d1276f0925f
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x5f4701f00f51 - std::panicking::default_hook::h2b2078d38b534dfb
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x5f4701e8c74e - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h39d051e7dedac6a7
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/alloc/src/boxed.rs:2220:9
[INFO] [stdout]   12:     0x5f4701e8c74e - test::test_main_with_exit_callback::{{closure}}::h4b005fe75814c302
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/test/src/lib.rs:145:21
[INFO] [stdout]   13:     0x5f4701f01332 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::hd426070722c13cbf
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/alloc/src/boxed.rs:2220:9
[INFO] [stdout]   14:     0x5f4701f01332 - std::panicking::panic_with_hook::h39b739724e701bfd
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x5f4701f01178 - std::panicking::panic_handler::{{closure}}::he540c4833054e458
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x5f4701efc679 - std::sys::backtrace::__rust_end_short_backtrace::hfa179d89deec8aed
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/std/src/sys/backtrace.rs:176:18
[INFO] [stdout]   17:     0x5f4701ee493d - __rustc[d131491b17107b07]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x5f4701f3c9fc - core::panicking::panic_fmt::ha564519d657d9c46
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x5f4701f3c0c2 - core::result::unwrap_failed::h23873bb39ca9a844
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/core/src/result.rs:1867:5
[INFO] [stdout]   20:     0x5f4701dd4026 - core::result::Result<T,E>::unwrap::h77480d29344c943c
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/core/src/result.rs:1233:23
[INFO] [stdout]   21:     0x5f4701dd4026 - basic_m6502::executor::tests::test_save_complex_program::hd6c0e301f686229f
[INFO] [stdout]                                at /opt/rustwide/workdir/src/executor.rs:2895:12
[INFO] [stdout]   22:     0x5f4701dd4337 - basic_m6502::executor::tests::test_save_complex_program::{{closure}}::h30cb7734c77898e3
[INFO] [stdout]                                at /opt/rustwide/workdir/src/executor.rs:2859:35
[INFO] [stdout]   23:     0x5f4701e41076 - core::ops::function::FnOnce::call_once::h6f9f7030b9c86a51
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   24:     0x5f4701e8c57b - core::ops::function::FnOnce::call_once::h0217b30cfdee2e67
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x5f4701e8c57b - test::__rust_begin_short_backtrace::h6d98714a1e28f556
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/test/src/lib.rs:663:18
[INFO] [stdout]   26:     0x5f4701e9ff0a - test::run_test_in_process::{{closure}}::he2c70d2634d3a3cc
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/test/src/lib.rs:686:74
[INFO] [stdout]   27:     0x5f4701e9ff0a - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h40a0a825bcf17fdd
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/core/src/panic/unwind_safe.rs:274:9
[INFO] [stdout]   28:     0x5f4701e9ff0a - std::panicking::catch_unwind::do_call::h6c8eb5dd6e7b5975
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/std/src/panicking.rs:581:40
[INFO] [stdout]   29:     0x5f4701e9ff0a - std::panicking::catch_unwind::h55455eac2972ad1e
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/std/src/panicking.rs:544:19
[INFO] [stdout]   30:     0x5f4701e9ff0a - std::panic::catch_unwind::h0025465150a5e558
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/std/src/panic.rs:359:14
[INFO] [stdout]   31:     0x5f4701e9ff0a - test::run_test_in_process::hb61e682f9b630fbc
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/test/src/lib.rs:686:27
[INFO] [stdout]   32:     0x5f4701e9ff0a - test::run_test::{{closure}}::hc2c2a7a38ab176e2
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/test/src/lib.rs:607:43
[INFO] [stdout]   33:     0x5f4701e7a1a4 - test::run_test::{{closure}}::ha91867b85cd2a911
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/test/src/lib.rs:637:41
[INFO] [stdout]   34:     0x5f4701e7a1a4 - std::sys::backtrace::__rust_begin_short_backtrace::ha00a9fe02049c339
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/std/src/sys/backtrace.rs:160:18
[INFO] [stdout]   35:     0x5f4701e7dad2 - std::thread::lifecycle::spawn_unchecked::{{closure}}::{{closure}}::hd629fba9153dfb55
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/std/src/thread/lifecycle.rs:92:13
[INFO] [stdout]   36:     0x5f4701e7dad2 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h4189018816a5c5d9
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/core/src/panic/unwind_safe.rs:274:9
[INFO] [stdout]   37:     0x5f4701e7dad2 - std::panicking::catch_unwind::do_call::hf9fcdbca3c2e9877
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/std/src/panicking.rs:581:40
[INFO] [stdout]   38:     0x5f4701e7dad2 - std::panicking::catch_unwind::h97b92d88631c7c64
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/std/src/panicking.rs:544:19
[INFO] [stdout]   39:     0x5f4701e7dad2 - std::panic::catch_unwind::ha77cdbb68e725e5e
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/std/src/panic.rs:359:14
[INFO] [stdout]   40:     0x5f4701e7dad2 - std::thread::lifecycle::spawn_unchecked::{{closure}}::h511f05bc1a132253
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/std/src/thread/lifecycle.rs:90:26
[INFO] [stdout]   41:     0x5f4701e7dad2 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h6b68b31e9b685cb8
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   42:     0x5f4701ef7d0f - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h22a27d165e4e871d
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/alloc/src/boxed.rs:2206:9
[INFO] [stdout]   43:     0x5f4701ef7d0f - std::sys::thread::unix::Thread::new::thread_start::h45cc87bb053add0f
[INFO] [stdout]                                at /rustc/254b59607d4417e9dffbc307138ae5c86280fe4c/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stdout]   44:     0x7058ca454aa4 - <unknown>
[INFO] [stdout]   45:     0x7058ca4e1a64 - clone
[INFO] [stdout]   46:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     executor::tests::test_math_functions
[INFO] [stdout]     executor::tests::test_save_and_load
[INFO] [stdout]     executor::tests::test_save_complex_program
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 192 passed; 3 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.13s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "d7ab2d54cff063ad3b3ad6c2c2248aee91e0dea024176c7e80f06a7e8d38600a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "d7ab2d54cff063ad3b3ad6c2c2248aee91e0dea024176c7e80f06a7e8d38600a", kill_on_drop: false }`
[INFO] [stdout] d7ab2d54cff063ad3b3ad6c2c2248aee91e0dea024176c7e80f06a7e8d38600a
