[INFO] fetching crate vpxtool 0.38.0...
[INFO] testing vpxtool-0.38.0 against 1.100.0-beta.1+cargoflags=--release for beta-release-1.100-2
[INFO] extracting crate vpxtool 0.38.0 into /workspace/builds/worker-3-tc2/source
[INFO] removed /workspace/builds/worker-3-tc2/source/.cargo/config.toml
[INFO] started tweaking crates.io crate vpxtool 0.38.0
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate vpxtool 0.38.0
[INFO] tweaked toml for crates.io crate vpxtool 0.38.0 written to /workspace/builds/worker-3-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate vpxtool 0.38.0 on toolchain 1.100.0-beta.1
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.100.0-beta.1" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate vpxtool 0.38.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" "+1.100.0-beta.1" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,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" "-m" "1610612736" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:77db811e55d90add9212f6832c23229e3de5f1c1f9905e8cb07319ea15df73ac" "sleep" "infinity", kill_on_drop: false }`
[INFO] [stdout] 1b5e301237efc43b2251ac9df200c0fd5a2622b25016e27ceb5d9afed63b1e47
[INFO] running `Command { std: "docker" "start" "1b5e301237efc43b2251ac9df200c0fd5a2622b25016e27ceb5d9afed63b1e47", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "1b5e301237efc43b2251ac9df200c0fd5a2622b25016e27ceb5d9afed63b1e47", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-w" "/opt/rustwide/workdir" "--user" "0:0" "1b5e301237efc43b2251ac9df200c0fd5a2622b25016e27ceb5d9afed63b1e47" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "1b5e301237efc43b2251ac9df200c0fd5a2622b25016e27ceb5d9afed63b1e47", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-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" "-w" "/opt/rustwide/workdir" "--user" "0:0" "1b5e301237efc43b2251ac9df200c0fd5a2622b25016e27ceb5d9afed63b1e47" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "build" "--frozen" "--message-format=json" "--release", kill_on_drop: false }`
[INFO] [stderr]    Compiling typenum v1.20.1
[INFO] [stderr]    Compiling simd-adler32 v0.3.10
[INFO] [stderr]    Compiling crossbeam-utils v0.8.23
[INFO] [stderr]    Compiling syn v2.0.119
[INFO] [stderr]    Compiling syn v3.0.6
[INFO] [stderr]    Compiling num-traits v0.2.19
[INFO] [stderr]    Compiling indexmap v2.14.2
[INFO] [stderr]    Compiling aho-corasick v1.1.5
[INFO] [stderr]    Compiling crossbeam-deque v0.8.8
[INFO] [stderr]    Compiling crc32fast v1.5.2
[INFO] [stderr]    Compiling rustversion v1.0.23
[INFO] [stderr]    Compiling libc v0.2.190
[INFO] [stderr]    Compiling crossbeam-epoch v0.9.21
[INFO] [stderr]    Compiling hybrid-array v0.4.15
[INFO] [stderr]    Compiling generic-array v0.14.7
[INFO] [stderr]    Compiling alloc-no-stdlib v3.0.0
[INFO] [stderr]    Compiling zerocopy v0.8.59
[INFO] [stderr]    Compiling regex-automata v0.4.18
[INFO] [stderr]    Compiling bytemuck v1.25.2
[INFO] [stderr]    Compiling serde_core v1.0.229
[INFO] [stderr]    Compiling getrandom v0.2.17
[INFO] [stderr]    Compiling alloc-stdlib v0.3.0
[INFO] [stderr]    Compiling miniz_oxide v0.9.1
[INFO] [stderr]    Compiling zmij v1.0.23
[INFO] [stderr]    Compiling pulp v0.22.3
[INFO] [stderr]    Compiling proc-macro2-diagnostics v0.10.1
[INFO] [stderr]    Compiling rustix v1.1.5
[INFO] [stderr]    Compiling serde_json v1.0.153
[INFO] [stderr]    Compiling getrandom v0.4.3
[INFO] [stderr]    Compiling zlib-rs v0.6.8
[INFO] [stderr]    Compiling once_cell v1.21.4
[INFO] [stderr]    Compiling either v1.18.0
[INFO] [stderr]    Compiling const-random-macro v0.1.16
[INFO] [stderr]    Compiling anstyle-parse v1.0.0
[INFO] [stderr]    Compiling brotli-decompressor v6.0.1
[INFO] [stderr]    Compiling serde_derive v1.0.229
[INFO] [stderr]    Compiling num-complex v0.4.6
[INFO] [stderr]    Compiling rayon-core v1.13.0
[INFO] [stderr]    Compiling logos-codegen v0.16.1
[INFO] [stderr]    Compiling zerocopy-derive v0.8.59
[INFO] [stderr]    Compiling regex v1.13.1
[INFO] [stderr]    Compiling flate2 v1.1.10
[INFO] [stderr]    Compiling block-buffer v0.10.4
[INFO] [stderr]    Compiling crypto-common v0.1.7
[INFO] [stderr]    Compiling encoding_rs v0.8.42
[INFO] [stderr]    Compiling crypto-common v0.2.2
[INFO] [stderr]    Compiling block-buffer v0.12.1
[INFO] [stderr]    Compiling miniz_oxide v0.8.9
[INFO] [stderr]    Compiling serde v1.0.229
[INFO] [stderr]    Compiling pulp-wasm-simd-flag v0.1.1
[INFO] [stderr]    Compiling rustix v0.38.44
[INFO] [stderr]    Compiling byteorder v1.5.0
[INFO] [stderr]    Compiling option-ext v0.2.0
[INFO] [stderr]    Compiling colorchoice v1.0.5
[INFO] [stderr]    Compiling built v0.7.7
[INFO] [stderr]    Compiling reborrow v0.5.5
[INFO] [stderr]    Compiling const-oid v0.10.2
[INFO] [stderr]    Compiling heapless v0.8.0
[INFO] [stderr]    Compiling yansi v1.0.1
[INFO] [stderr]    Compiling anstream v1.0.0
[INFO] [stderr]    Compiling flacenc v0.5.1
[INFO] [stderr]    Compiling digest v0.11.3
[INFO] [stderr]    Compiling serde_spanned v0.6.9
[INFO] [stderr]    Compiling toml_datetime v0.6.11
[INFO] [stderr]    Compiling hash32 v0.3.1
[INFO] [stderr]    Compiling dirs-sys v0.5.0
[INFO] [stderr]    Compiling digest v0.10.7
[INFO] [stderr]    Compiling logos-derive v0.16.1
[INFO] [stderr]    Compiling brotli v9.0.0
[INFO] [stderr]    Compiling const-random v0.1.18
[INFO] [stderr]    Compiling fdeflate v0.3.7
[INFO] [stderr]    Compiling zune-inflate v0.2.54
[INFO] [stderr]    Compiling uncased v0.9.10
[INFO] [stderr]    Compiling crc-catalog v2.5.0
[INFO] [stderr]    Compiling weezl v0.1.12
[INFO] [stderr]    Compiling pxfm v0.1.30
[INFO] [stderr]    Compiling byteorder-lite v0.1.0
[INFO] [stderr]    Compiling winnow v0.7.15
[INFO] [stderr]    Compiling simdutf8 v0.1.5
[INFO] [stderr]    Compiling fastrand v2.5.0
[INFO] [stderr]    Compiling portable-atomic v1.15.0
[INFO] [stderr]    Compiling color_quant v1.1.0
[INFO] [stderr]    Compiling quick-error v2.0.1
[INFO] [stderr]    Compiling half v2.7.1
[INFO] [stderr]    Compiling bumpalo v3.20.3
[INFO] [stderr]    Compiling lebe v0.5.3
[INFO] [stderr]    Compiling toml_write v0.1.2
[INFO] [stderr]    Compiling core_detect v1.0.0
[INFO] [stderr]    Compiling bit_field v0.10.3
[INFO] [stderr]    Compiling winnow v1.0.4
[INFO] [stderr]    Compiling linux-raw-sys v0.4.15
[INFO] [stderr]    Compiling multiversion_no_op v1.0.0
[INFO] [stderr]    Compiling zune-core v0.5.3
[INFO] [stderr]    Compiling toml_edit v0.22.27
[INFO] [stderr]    Compiling zune-jpeg v0.5.15
[INFO] [stderr]    Compiling pinmame-nvram v0.4.18
[INFO] [stderr]    Compiling moxcms v0.8.1
[INFO] [stderr]    Compiling toml_parser v1.1.3+spec-1.1.0
[INFO] [stderr]    Compiling exr v1.74.2
[INFO] [stderr]    Compiling zopfli v0.8.3
[INFO] [stderr]    Compiling image-webp v0.2.4
[INFO] [stderr]    Compiling gif v0.14.2
[INFO] [stderr]    Compiling console v0.16.6
[INFO] [stderr]    Compiling tempfile v3.27.0
[INFO] [stderr]    Compiling crc v3.4.0
[INFO] [stderr]    Compiling png v0.18.1
[INFO] [stderr]    Compiling dlv-list v0.5.2
[INFO] [stderr]    Compiling logos v0.16.1
[INFO] [stderr]    Compiling md-5 v0.10.6
[INFO] [stderr]    Compiling pear_codegen v0.2.9
[INFO] [stderr]    Compiling tracing-attributes v0.1.31
[INFO] [stderr]    Compiling rayon v1.12.0
[INFO] [stderr]    Compiling qoi v0.4.1
[INFO] [stderr]    Compiling toml_datetime v1.1.1+spec-1.1.0
[INFO] [stderr]    Compiling include_dir_macros v0.7.4
[INFO] [stderr]    Compiling figment v0.10.19
[INFO] [stderr]    Compiling thread_local v1.1.10
[INFO] [stderr]    Compiling bstr v1.13.1
[INFO] [stderr]    Compiling toml_writer v1.1.2+spec-1.1.0
[INFO] [stderr]    Compiling typed-path v0.12.3
[INFO] [stderr]    Compiling inlinable_string v0.1.15
[INFO] [stderr]    Compiling uuid v1.27.0
[INFO] [stderr]    Compiling web-time v1.1.0
[INFO] [stderr]    Compiling seq-macro v0.3.6
[INFO] [stderr]    Compiling home v0.5.12
[INFO] [stderr]    Compiling jiff-core v0.1.1
[INFO] [stderr]    Compiling which v4.4.2
[INFO] [stderr]    Compiling pear v0.2.9
[INFO] [stderr]    Compiling zip v9.0.1
[INFO] [stderr]    Compiling cfb v0.15.0
[INFO] [stderr]    Compiling jiff v0.2.37
[INFO] [stderr]    Compiling clap_builder v4.6.7
[INFO] [stderr]    Compiling ordered-multimap v0.7.3
[INFO] [stderr]    Compiling clap_derive v4.6.7
[INFO] [stderr]    Compiling unicode-normalization v0.1.25
[INFO] [stderr]    Compiling image v0.25.10
[INFO] [stderr]    Compiling tracing v0.1.44
[INFO] [stderr]    Compiling globset v0.4.20
[INFO] [stderr]    Compiling fuzzy-matcher v0.3.7
[INFO] [stderr]    Compiling include_dir v0.7.4
[INFO] [stderr]    Compiling vbscript v0.5.1
[INFO] [stderr]    Compiling toml v0.8.23
[INFO] [stderr]    Compiling dirs v6.0.0
[INFO] [stderr]    Compiling md2 v0.11.0
[INFO] [stderr]    Compiling quick-xml v0.41.0
[INFO] [stderr]    Compiling sanitize-filename v0.6.0
[INFO] [stderr]    Compiling env_filter v2.0.0
[INFO] [stderr]    Compiling git-version-macro v0.3.9
[INFO] [stderr]    Compiling serde_repr v0.1.21
[INFO] [stderr]    Compiling wavefront-obj-io v0.3.1
[INFO] [stderr]    Compiling shell-words v1.1.1
[INFO] [stderr]    Compiling unit-prefix v0.5.2
[INFO] [stderr]    Compiling iana-time-zone v0.1.65
[INFO] [stderr]    Compiling claxon v0.4.3
[INFO] [stderr]    Compiling arrayvec v0.7.8
[INFO] [stderr]    Compiling weezl v0.2.1
[INFO] [stderr]    Compiling dialoguer v0.12.0
[INFO] [stderr]    Compiling num-format v0.4.4
[INFO] [stderr]    Compiling directb2s v0.1.2
[INFO] [stderr]    Compiling chrono v0.4.45
[INFO] [stderr]    Compiling indicatif v0.18.6
[INFO] [stderr]    Compiling sha2 v0.11.0
[INFO] [stderr]    Compiling toml v1.1.6+spec-1.1.0
[INFO] [stderr]    Compiling git-version v0.3.9
[INFO] [stderr]    Compiling env_logger v0.11.11
[INFO] [stderr]    Compiling clap v4.6.7
[INFO] [stderr]    Compiling ignore v0.4.33
[INFO] [stderr]    Compiling rust-ini v0.21.3
[INFO] [stderr]    Compiling edit v0.1.5
[INFO] [stderr]    Compiling toml_edit v0.25.15+spec-1.1.0
[INFO] [stderr]    Compiling dirs v7.0.0
[INFO] [stderr]    Compiling jojodiff v0.1.2
[INFO] [stderr]    Compiling wild v2.2.1
[INFO] [stderr]    Compiling base64 v0.23.1
[INFO] [stderr]    Compiling is_executable v1.0.6
[INFO] [stderr]    Compiling vpin v0.39.1
[INFO] [stderr]    Compiling vpxtool v0.38.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 10m 05s
[INFO] running `Command { std: "docker" "inspect" "1b5e301237efc43b2251ac9df200c0fd5a2622b25016e27ceb5d9afed63b1e47", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-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" "-w" "/opt/rustwide/workdir" "--user" "0:0" "1b5e301237efc43b2251ac9df200c0fd5a2622b25016e27ceb5d9afed63b1e47" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "test" "--frozen" "--no-run" "--message-format=json" "--release", kill_on_drop: false }`
[INFO] [stderr]    Compiling serde_core v1.0.229
[INFO] [stderr]    Compiling serde_json v1.0.153
[INFO] [stderr]    Compiling getrandom v0.4.3
[INFO] [stderr]    Compiling camino v1.2.6
[INFO] [stderr]    Compiling thiserror-impl v2.0.21
[INFO] [stderr]    Compiling object v0.37.3
[INFO] [stderr]    Compiling chacha20 v0.10.2
[INFO] [stderr]    Compiling sysinfo v0.38.4
[INFO] [stderr]    Compiling tempfile v3.27.0
[INFO] [stderr]    Compiling whoami v2.1.3
[INFO] [stderr]    Compiling fslock v0.2.1
[INFO] [stderr]    Compiling dialoguer v0.12.0
[INFO] [stderr]    Compiling edit v0.1.5
[INFO] [stderr]    Compiling diff v0.1.13
[INFO] [stderr]    Compiling rand v0.10.3
[INFO] [stderr]    Compiling thiserror v2.0.21
[INFO] [stderr]    Compiling pretty_assertions v1.4.1
[INFO] [stderr]    Compiling serde v1.0.229
[INFO] [stderr]    Compiling toml_datetime v1.1.1+spec-1.1.0
[INFO] [stderr]    Compiling serde_spanned v1.1.1
[INFO] [stderr]    Compiling semver v1.0.28
[INFO] [stderr]    Compiling cargo-platform v0.3.3
[INFO] [stderr]    Compiling toml_edit v0.25.15+spec-1.1.0
[INFO] [stderr]    Compiling toml v1.1.6+spec-1.1.0
[INFO] [stderr]    Compiling serde_spanned v0.6.9
[INFO] [stderr]    Compiling toml_datetime v0.6.11
[INFO] [stderr]    Compiling quick-xml v0.41.0
[INFO] [stderr]    Compiling toml_edit v0.22.27
[INFO] [stderr]    Compiling backtrace v0.3.76
[INFO] [stderr]    Compiling pinmame-nvram v0.4.18
[INFO] [stderr]    Compiling cargo_metadata v0.23.1
[INFO] [stderr]    Compiling toml v0.8.23
[INFO] [stderr]    Compiling vpin v0.39.1
[INFO] [stderr]    Compiling directb2s v0.1.2
[INFO] [stderr]    Compiling figment v0.10.19
[INFO] [stderr]    Compiling testdir v0.10.0
[INFO] [stderr]    Compiling vpxtool v0.38.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 5m 51s
[INFO] running `Command { std: "docker" "inspect" "1b5e301237efc43b2251ac9df200c0fd5a2622b25016e27ceb5d9afed63b1e47", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-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" "-w" "/opt/rustwide/workdir" "--user" "0:0" "1b5e301237efc43b2251ac9df200c0fd5a2622b25016e27ceb5d9afed63b1e47" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "test" "--frozen" "--release", kill_on_drop: false }`
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 0.59s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/release/build/vpxtool/1191071603369a24/out/vpxtool-1191071603369a24)
[INFO] [stdout] 
[INFO] [stdout] running 178 tests
[INFO] [stdout] test backglass::tests::test_dmd_hole_1_x_1 ... ok
[INFO] [stdout] test backglass::tests::test_dmd_hole_scale_1_x_1_to_parent ... ok
[INFO] [stdout] test backglass::tests::test_dmd_hole_scale_to_parent ... ok
[INFO] [stdout] test capture::tests::test_capture_format_from_str ... ok
[INFO] [stdout] test backglass::tests::test_find_hole_from_with_inward_corners ... ok
[INFO] [stdout] test backglass::tests::test_find_hole_from ... ok
[INFO] [stdout] test backglass::tests::test_find_hole ... ok
[INFO] [stdout] test backglass::tests::test_find_hole_no_hole ... ok
[INFO] [stdout] test backglass::tests::test_find_whole_image_with_deviation_max ... ok
[INFO] [stdout] test config::tests::test_parse_major_minor ... ok
[INFO] [stdout] test capture::tests::test_capture_image_path ... ok
[INFO] [stdout] test capture::tests::test_is_playfield_frame ... ok
[INFO] [stdout] test capture::tests::test_capture_image_path_no_parent ... ok
[INFO] [stdout] test config::tests::test_newest_versioned_vpinball_ini_returns_none_when_empty ... ok
[INFO] [stdout] test config::tests::test_read_config_with_tables_scan_max_depth ... ok
[INFO] [stdout] test config::tests::test_rewrite_vpx_config_preserves_comments_and_layout ... ok
[INFO] [stdout] Config file contents: vpx_executable = "/home/me/vpinball"
[INFO] [stdout] vpx_config = "/root/.vpinball/VPinballX.ini"
[INFO] [stdout] tables_folder = "/home/me/tables"
[INFO] [stdout] 
[INFO] [stdout] [[launch_templates]]
[INFO] [stdout] name = "Launch"
[INFO] [stdout] executable = "/home/me/vpinball"
[INFO] [stdout] 
[INFO] [stdout] [launch_templates.env]
[INFO] [stdout] SDL_RENDER_DRIVER = ""
[INFO] [stdout] SDL_VIDEODRIVER = ""
[INFO] [stdout] 
[INFO] [stdout] test hash::tests::backup_skips_and_leaves_an_existing_backup_untouched ... ok
[INFO] [stdout] test config::tests::test_configured_pinmame_folder_tolerates_broken_ini ... ok
[INFO] [stdout] test config::tests::test_newest_versioned_vpinball_ini_picks_highest ... ok
[INFO] [stdout] test config::tests::test_configured_pinmame_folder_skips_empty_key ... ok
[INFO] [stdout] test config::tests::test_write_default_config_linux ... ok
[INFO] [stdout] test config::tests::test_read_incomplete_config_linux ... ok
[INFO] [stdout] test config::tests::test_read_launch_template_with_vpinball_config ... ok
[INFO] [stdout] test hash::tests::sha256_file_matches_a_known_vector ... ok
[INFO] [stdout] test indexer::tests::extract_vpreg_keys_ignores_unresolved_identifiers ... ok
[INFO] [stdout] test indexer::tests::extract_vpreg_keys_ignores_commented_out_examples ... ok
[INFO] [stdout] test indexer::tests::extract_vpreg_keys_const_wins_over_plain_assignment ... ok
[INFO] [stdout] test indexer::tests::extract_vpreg_keys_picks_up_legacy_em_score_keys ... ok
[INFO] [stdout] test hash::tests::backup_copies_the_original_and_names_it_by_hash ... ok
[INFO] [stdout] test indexer::tests::extract_vpreg_keys_picks_up_dim_plus_assignment ... ok
[INFO] [stdout] test indexer::tests::extract_vpreg_keys_picks_up_quoted_literal_section ... ok
[INFO] [stdout] test indexer::tests::extract_vpreg_keys_picks_up_tablename_const ... ok
[INFO] [stdout] test indexer::tests::extract_vpreg_keys_returns_distinct_first_seen_order ... ok
[INFO] [stdout] test indexer::tests::extract_vpreg_keys_picks_up_cgamename_const ... ok
[INFO] [stdout] test indexer::tests::extract_vpreg_keys_treats_identifier_case_insensitively ... ok
[INFO] [stdout] test indexer::tests::extract_vpreg_keys_ignores_non_highscore_loadvalue_calls ... ok
[INFO] [stdout] test indexer::tests::extract_vpreg_keys_resolves_arbitrary_const_names ... ok
[INFO] [stdout] test indexer::tests::test_extract_game_name_dot_gamename_inline ... ok
[INFO] [stdout] test indexer::tests::test_extract_game_name_uppercase_name ... ok
[INFO] [stdout] test indexer::tests::test_extract_game_name_multidef_end ... ok
[INFO] [stdout] test indexer::tests::test_extract_game_name_spaced ... ok
[INFO] [stdout] test indexer::tests::test_extract_game_name_in_controller ... ok
[INFO] [stdout] test indexer::tests::test_extract_game_name_with_underscore ... ok
[INFO] [stdout] test indexer::tests::test_find_altcolor_path_case_insensitive_folder_and_extension ... ok
[INFO] [stdout] test indexer::tests::test_find_altcolor_path_requires_serum_file ... ok
[INFO] [stdout] test indexer::tests::test_extract_game_name_commented ... ok
[INFO] [stdout] test indexer::tests::test_find_altcolor_path_legacy_altcolor_subfolder ... ok
[INFO] [stdout] test indexer::tests::test_extract_game_name_casing ... ok
[INFO] [stdout] test indexer::tests::test_extract_game_name ... ok
[INFO] [stdout] test indexer::tests::test_extract_game_name_2_line_dim ... ok
[INFO] [stdout] test indexer::tests::test_find_altcolor_path_vni_pin2dmd_fallback ... ok
[INFO] [stdout] test indexer::tests::test_find_altsound_path_case_insensitive ... ok
[INFO] [stdout] test indexer::tests::test_find_altsound_path_none_when_dir_missing ... ok
[INFO] [stdout] test indexer::tests::test_find_altsound_path_per_table_priority ... ok
[INFO] [stdout] test indexer::tests::test_find_local_rom_path_alias_wins_over_direct ... ok
[INFO] [stdout] test indexer::tests::test_find_local_rom_path_relative_linux ... ok
[INFO] [stdout] test indexer::tests::test_find_altsound_path_falls_back_to_pinmame_subfolder ... ok
[INFO] [stdout] test indexer::tests::test_find_local_rom_path_follows_alias ... ok
[INFO] [stdout] test indexer::tests::test_find_local_rom_path_relative_not_found_linux ... ok
[INFO] [stdout] test indexer::tests::test_find_nvram_falls_back_to_global_pinmame_folder ... ok
[INFO] [stdout] test indexer::tests::test_find_nvram_falls_back_to_local_pinmame_folder ... ok
[INFO] [stdout] test indexer::tests::test_find_nvram_prefers_configured_pinmame_folder ... ok
[INFO] [stdout] test indexer::tests::test_find_nvram_lowercases_rom_name ... ok
[INFO] [stdout] test indexer::tests::test_find_nvram_resolves_relative_configured_folder ... ok
[INFO] [stdout] test indexer::tests::test_find_nvram_returns_none_when_missing ... ok
[INFO] [stdout] test indexer::tests::test_find_pup_pack_path ... ok
[INFO] [stdout] test indexer::tests::test_find_wheel_path_loose_matches_pick_the_shortest_name ... ok
[INFO] [stdout] test indexer::tests::test_find_wheel_path_none_without_candidates ... ok
[INFO] [stdout] test indexer::tests::test_find_wheel_path_stem_with_version_suffix ... ok
[INFO] [stdout] test indexer::tests::test_find_wheel_path_wheels_dir_and_plain_wheel ... ok
[INFO] [stdout] test indexer::tests::test_find_wheel_path_exact_names_win ... ok
[INFO] [stdout] test indexer::tests::test_find_wheel_path_looks_into_media_dirs_only ... ok
[INFO] [stdout] test indexer::tests::test_index_packs ... ok
[INFO] [stdout] test indexer::tests::test_parse_table_name_variants ... ok
[INFO] [stdout] test indexer::tests::test_properties_serialized_in_alphabetical_order ... ok
[INFO] [stdout] test indexer::tests::test_read_index_missing ... ok
[INFO] [stdout] test indexer::tests::test_requires_pinmame ... ok
[INFO] [stdout] test indexer::tests::test_requires_pinmame_comment ... ok
[INFO] [stdout] test indexer::tests::test_requires_pinmame_comment_and_used ... ok
[INFO] [stdout] test indexer::tests::test_requires_pinmame_cr_only_lines_and_commented_sub_loadvpm ... ok
[INFO] [stdout] test indexer::tests::test_requires_pinmame_not ... ok
[INFO] [stdout] test indexer::tests::test_find_vpx_files_descends_hidden_dirs_and_ignores_gitignore ... ok
[INFO] [stdout] test indexer::tests::test_requires_pinmame_other_casing ... ok
[INFO] [stdout] test indexer::tests::test_requires_pinmame_with_same_sub ... ok
[INFO] [stdout] test indexer::tests::test_resolve_rom_alias_absent_file ... ok
[INFO] [stdout] test indexer::tests::test_sort_tables_by_full_path_not_just_filename ... ok
[INFO] [stdout] test indexer::tests::test_sort_tables_by_path_case_insensitive ... ok
[INFO] [stdout] test indexer::tests::test_table_name_parts_precedence ... ok
[INFO] [stdout] test indexer::tests::test_find_vpx_files_skips_dotfiles ... ok
[INFO] [stdout] test indexer::tests::test_write_read_empty_array ... ok
[INFO] [stdout] test indexer::tests::test_write_read_empty_index ... ok
[INFO] [stdout] Failed to parse index file, ignoring existing index. (invalid type: string "garbage", expected struct TablesIndexJson at line 1 column 9)
[INFO] [stdout] test indexer::tests::test_write_read_invalid_file ... ok
[INFO] [stdout] test indexer::tests::test_find_vpx_files_max_depth ... ok
[INFO] [stdout] test optimize::tests::a_backglass_marker_stereo_sound_is_renamed_downmixed_then_flac ... ok
[INFO] [stdout] test optimize::tests::a_created_backup_is_reported_and_none_is_not ... ok
[INFO] [stdout] test optimize::tests::a_table_with_nothing_to_do_says_so ... ok
[INFO] [stdout] test indexer::tests::test_write_read_single_item_index ... ok
[INFO] [stdout] test optimize::tests::bytes_read_like_a_file_manager ... ok
[INFO] [stdout] test indexer::tests::test_resolve_rom_alias_tokenizes_like_pinmame ... ok
[INFO] [stdout] test optimize::tests::pngs_are_converted_and_flexdmd_images_reported ... ok
[INFO] [stdout] test optimize::tests::images_over_the_size_are_shrunk_before_the_webp_conversion ... ok
[INFO] [stdout] test indexer::tests::test_write_read_index_paths_are_relative_and_normalized ... ok
[INFO] [stdout] test patcher::tests::test_unify_line_endings ... ok
[INFO] [stdout] test patcher::tests::test_unify_line_endings_vbs_file_latin1_keeps_encoding ... ok
[INFO] [stdout] test playlog::tests::duration_formatting ... ok
[INFO] [stdout] test playlog::tests::fold_counts_plays_above_the_threshold ... ok
[INFO] [stdout] test playlog::tests::read_skips_bad_lines_and_missing_log ... ok
[INFO] [stdout] test scores::emhs::tests::drops_zero_scored_slots ... ok
[INFO] [stdout] test scores::emhs::tests::read_sections_treats_non_utf8_readme_as_pattern_not_found ... ok
[INFO] [stdout] test playlog::tests::append_and_read_round_trip ... ok
[INFO] [stdout] test scores::emhs::tests::rejects_window_where_names_look_too_long ... ok
[INFO] [stdout] test scores::emhs::tests::finds_first_matching_window_when_multiple_could_overlap ... ok
[INFO] [stdout] test scores::emhs::tests::rejects_window_where_names_are_all_digits ... ok
[INFO] [stdout] test optimize::tests::flac_is_opt_in_and_reported ... ok
[INFO] [stdout] test scores::emhs::tests::returns_pattern_not_found_when_no_block ... ok
[INFO] [stdout] test scores::emhs::tests::single_hisc_rejects_all_zero_files ... ok
[INFO] [stdout] test scores::emhs::tests::single_hisc_rejects_files_with_any_string_line ... ok
[INFO] [stdout] test scores::emhs::tests::returns_pattern_not_found_when_all_zero_scored ... ok
[INFO] [stdout] test scores::glf::tests::groups_multiple_categories_into_separate_section_blocks ... ok
[INFO] [stdout] test scores::glf::tests::ignores_unrecognized_keys_in_section ... ok
[INFO] [stdout] test scores::emhs::tests::single_hisc_rejects_short_files ... ok
[INFO] [stdout] test scores::glf::tests::category_with_underscores_in_name_round_trips ... ok
[INFO] [stdout] test scores::glf::tests::drops_entries_missing_value ... ok
[INFO] [stdout] test scores::glf::tests::orders_positions_numerically_not_lexically ... ok
[INFO] [stdout] test scores::glf::tests::returns_no_high_scores_section_when_absent ... ok
[INFO] [stdout] test scores::glf::tests::returns_empty_when_section_has_no_valued_entries ... ok
[INFO] [stdout] test scores::tests::appends_mode_champions_after_high_scores ... ok
[INFO] [stdout] test scores::tests::extract_sections_emits_one_section_per_mode_champion ... ok
[INFO] [stdout] test scores::tests::extract_sections_keeps_ranked_list_for_hash_labels ... ok
[INFO] [stdout] test scores::tests::drops_entries_with_zero_numeric_value ... ok
[INFO] [stdout] test scores::tests::extract_sections_keeps_ranked_list_together_when_no_distinct_top ... ok
[INFO] [stdout] test scores::tests::extract_sections_splits_grand_champion_from_ranked_rest ... ok
[INFO] [stdout] test scores::tests::extract_sections_single_high_score_uses_its_label_as_header ... ok
[INFO] [stdout] test scores::tests::accepts_string_score_values ... ok
[INFO] [stdout] test scores::tests::extracts_high_scores_in_array_order_with_raw_numeric_scores ... ok
[INFO] [stdout] test scores::tests::falls_back_through_score_then_counter_then_nth_time ... ok
[INFO] [stdout] test scores::tests::extracts_units_when_map_provides_them ... ok
[INFO] [stdout] test indexer::tests::test_index_folder_skips_write_when_unchanged ... ok
[INFO] [stdout] test scores::tests::pretty_score_column_groups_integer_score_thousands ... ok
[INFO] [stdout] test indexer::tests::test_index_to_json_is_sorted ... ok
[INFO] [stdout] test scores::tests::pretty_score_column_leaves_string_scores_alone ... ok
[INFO] [stdout] test scores::tests::pretty_score_column_renders_long_seconds_as_h_mm_ss ... ok
[INFO] [stdout] test indexer::tests::test_find_vpx_files_finds_packs ... ok
[INFO] [stdout] test scores::tests::render_pinemhi_emits_section_headers_and_ranked_bodies ... ok
[INFO] [stdout] test scores::tests::render_pinemhi_omits_initials_line_when_no_initials ... ok
[INFO] [stdout] test scores::tests::render_pinemhi_drops_trailing_whitespace_when_score_is_empty ... ok
[INFO] [stdout] test scores::tests::render_pinemhi_pads_rank_for_two_digit_ranks ... ok
[INFO] [stdout] test scores::tests::pretty_score_column_renders_seconds_as_time ... ok
[INFO] [stdout] test scores::tests::pretty_score_column_uses_passed_locale_for_grouping_separator ... ok
[INFO] [stdout] test scores::tests::render_pinemhi_aligns_score_column_when_initials_widths_differ ... ok
[INFO] [stdout] test indexer::tests::test_index_vpx_files ... ok
[INFO] [stdout] test scores::tests::returns_empty_when_resolved_has_no_score_arrays ... ok
[INFO] [stdout] test scores::vpreg::tests::ignores_unrelated_keys_in_the_section ... ok
[INFO] [stdout] test scores::vpreg::tests::legacy_em_decodes_extended_alphabet_chars ... ok
[INFO] [stdout] test scores::vpreg::tests::legacy_em_drops_out_of_range_hsa_index ... ok
[INFO] [stdout] test scores::vpreg::tests::legacy_em_missing_hsa_yields_empty_initials ... ok
[INFO] [stdout] test scores::vpreg::tests::legacy_em_zero_hiscore_falls_through ... ok
[INFO] [stdout] test scores::vpreg::tests::returns_no_scores_when_section_has_only_settings ... ok
[INFO] [stdout] test tests::test_os_independent_file_name_no_extension ... ok
[INFO] [stdout] test tests::test_os_independent_file_name_no_path ... ok
[INFO] [stdout] test tests::test_os_independent_file_name_windows ... ok
[INFO] [stdout] test tests::test_os_independent_file_unix ... ok
[INFO] [stdout] test scores::vpreg::tests::orders_by_rank_number_not_ini_order ... ok
[INFO] [stdout] test tests::test_describe_exit_reports_signal ... ok
[INFO] [stdout] test tests::test_os_independent_file_name_empty ... ok
[INFO] [stdout] test vpinball_config::tests::test_read_vpinball_config ... ok
[INFO] [stdout] test vpinball_config::tests::test_read_vpinball_config_empty_key ... ok
[INFO] [stdout] test vpxz::tests::bundles_lone_vpx ... ok
[INFO] [stdout] test vpinball_config::tests::test_write_vpinball_config ... ok
[INFO] [stdout] test vpxz::tests::always_excludes_prior_vpxz_archives ... ok
[INFO] [stdout] test vpxz::tests::default_output_path_uses_grandparent_and_stem ... ok
[INFO] [stdout] test vpxz::tests::injects_rom_when_not_already_in_tree ... ok
[INFO] [stdout] test vpxz::tests::applies_user_exclude_patterns ... ok
[INFO] [stdout] test vpxz::tests::keeps_directb2s_matching_chosen_stem ... ok
[INFO] [stdout] test vpxz::tests::excludes_other_vpx_and_their_sidecars ... ok
[INFO] [stdout] test scores::vpreg::tests::returns_section_not_found_when_game_name_missing ... ok
[INFO] [stdout] test tests::test_os_independent_file_name_no_path_no_extension ... ok
[INFO] [stdout] test vpxz::tests::does_not_double_inject_rom_already_present ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 178 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.58s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/release/build/vpxtool/805fd8aba390e6fc/out/vpxtool-805fd8aba390e6fc)
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/abort_exit_code.rs (/opt/rustwide/target/release/build/vpxtool/5051f4fa9095aee0/out/abort_exit_code-5051f4fa9095aee0)
[INFO] [stdout] 
[INFO] [stdout] running 6 tests
[INFO] [stdout] test info_extract_abort_answer_no_exits_nonzero ... ok
[INFO] [stdout] test assemble_abort_answer_no_exits_nonzero ... ok
[INFO] [stdout] test extract_abort_answer_no_exits_nonzero ... ok
[INFO] [stdout] test export_vpxz_abort_answer_no_exits_nonzero ... ok
[INFO] [stdout] test assemble_abort_closed_stdin_exits_nonzero ... ok
[INFO] [stdout] test info_extract_answer_yes_exits_zero ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.40s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/convert.rs (/opt/rustwide/target/release/build/vpxtool/8b2b205b2dd45b61/out/convert-8b2b205b2dd45b61)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stderr]      Running tests/extract_filter.rs (/opt/rustwide/target/release/build/vpxtool/de476f57a1bc7854/out/extract_filter-de476f57a1bc7854)
[INFO] [stdout] test convert_between_vpx_and_packs ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.40s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 4 tests
[INFO] [stdout] test bad_glob_fails_before_writing ... ok
[INFO] [stdout] test only_glob_does_not_cross_directories ... ok
[INFO] [stdout] test only_keeps_the_named_file ... ok
[INFO] [stdout] test no_media_skips_the_image_files_but_keeps_the_index ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.39s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/pack_audit_info.rs (/opt/rustwide/target/release/build/vpxtool/12c1138d18183965/out/pack_audit_info-12c1138d18183965)
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test info_show_reads_a_pack ... ok
[INFO] [stderr]      Running tests/scores_fixtures.rs (/opt/rustwide/target/release/build/vpxtool/f01889f700326f03/out/scores_fixtures-f01889f700326f03)
[INFO] [stdout] test audit_reads_a_pack ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.36s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 13 tests
[INFO] [stdout] test emhs_5plus5_roller_coaster_with_trailing_bytes ... ok
[INFO] [stdout] test emhs_5plus5_8ball_with_six_header_bytes ... ok
[INFO] [stdout] test glf_dark_chaos_grand_champion_split ... ok
[INFO] [stdout] test vpreg_modern_lochness_single_entry_unranked ... ok
[INFO] [stdout] test emhs_5plus5_carnaval ... ok
[INFO] [stdout] test emhs_single_2in1 ... ok
[INFO] [stdout] test emhs_5plus5_with_long_character_names_cuphead ... ok
[INFO] [stdout] test emhs_single_4queens ... ok
[INFO] [stdout] test vpreg_legacy_a_go_go_uppercase ... ok
[INFO] [stdout] test vpreg_legacy_abracadabra_lowercase ... ok
[INFO] [stdout] test vpreg_modern_matrix_four_entries ... ok
[INFO] [stderr]      Running tests/script_diff_line_endings.rs (/opt/rustwide/target/release/build/vpxtool/7ee7dd10daa91e8b/out/script_diff_line_endings-7ee7dd10daa91e8b)
[INFO] [stdout] test vpreg_modern_name_before_n_van_halen ... ok
[INFO] [stdout] test vpreg_modern_volkan_score_only_no_names ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 13 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 3 tests
[INFO] [stderr]      Running tests/table_diff.rs (/opt/rustwide/target/release/build/vpxtool/57ae36625b2e9fbb/out/table_diff-57ae36625b2e9fbb)
[INFO] [stdout] test script_diff_ignores_mixed_line_ending_differences ... ok
[INFO] [stdout] test script_diff_reports_real_changes_despite_mixed_endings ... ok
[INFO] [stdout] test script_diff_handles_latin1_sidecar ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.36s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test diff_reports_no_differences_for_identical_tables ... ok
[INFO] [stdout] test diff_reports_script_change_and_exits_non_zero ... ok
[INFO] [stderr]      Running tests/vpx_audit.rs (/opt/rustwide/target/release/build/vpxtool/2a0c9dae0d50b83a/out/vpx_audit-2a0c9dae0d50b83a)
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.47s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test audit_reports_findings_for_new_table ... ok
[INFO] [stderr]      Running tests/vpx_optimize.rs (/opt/rustwide/target/release/build/vpxtool/9c36db7371378af8/out/vpx_optimize-9c36db7371378af8)
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.33s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 10 tests
[INFO] [stdout] test a_missing_table_fails ... ok
[INFO] [stdout] test a_new_table_has_nothing_to_optimize_and_is_left_untouched ... ok
[INFO] [stdout] test backup_and_dry_run_are_rejected_by_clap ... ok
[INFO] [stdout] test the_british_spelling_is_accepted_but_not_advertised ... ok
[INFO] [stdout] test backup_with_nothing_to_optimize_writes_no_backup ... ok
[INFO] [stdout] test a_table_with_something_to_fix_is_rewritten_in_place ... ok
[INFO] [stdout] test backup_keeps_the_pristine_original_named_with_its_sha256 ... ok
[INFO] [stdout] test the_bare_flag_means_the_mobile_default ... ok
[INFO] [stdout] test backup_skips_the_copy_when_the_backup_already_exists ... ok
[INFO] [stdout] test images_over_the_max_image_size_are_scaled_down ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 10 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.52s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/vpx_verify.rs (/opt/rustwide/target/release/build/vpxtool/69a8ca85f30314f2/out/vpx_verify-69a8ca85f30314f2)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test verify_json_reports_the_mac_of_each_file ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.35s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests vpxtool
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "1b5e301237efc43b2251ac9df200c0fd5a2622b25016e27ceb5d9afed63b1e47", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "1b5e301237efc43b2251ac9df200c0fd5a2622b25016e27ceb5d9afed63b1e47", kill_on_drop: false }`
[INFO] [stdout] 1b5e301237efc43b2251ac9df200c0fd5a2622b25016e27ceb5d9afed63b1e47
