[INFO] fetching crate rustledger-loader 0.12.0... [INFO] testing rustledger-loader-0.12.0 against try#dec9417b8611e34e787a3e4c37686b5131f9e5c5 for pr-154210-2 [INFO] extracting crate rustledger-loader 0.12.0 into /workspace/builds/worker-6-tc2/source [INFO] started tweaking crates.io crate rustledger-loader 0.12.0 [INFO] removed 0 missing tests [INFO] finished tweaking crates.io crate rustledger-loader 0.12.0 [INFO] tweaked toml for crates.io crate rustledger-loader 0.12.0 written to /workspace/builds/worker-6-tc2/source/Cargo.toml [INFO] validating manifest of crates.io crate rustledger-loader 0.12.0 on toolchain dec9417b8611e34e787a3e4c37686b5131f9e5c5 [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] crate crates.io crate rustledger-loader 0.12.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" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] 0e92403b226cd4118fe875833b29ada0ca5d1390ca6f9c256fd83a3fd5d70dbd [INFO] running `Command { std: "docker" "start" "-a" "0e92403b226cd4118fe875833b29ada0ca5d1390ca6f9c256fd83a3fd5d70dbd", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "0e92403b226cd4118fe875833b29ada0ca5d1390ca6f9c256fd83a3fd5d70dbd", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "0e92403b226cd4118fe875833b29ada0ca5d1390ca6f9c256fd83a3fd5d70dbd", kill_on_drop: false }` [INFO] [stdout] 0e92403b226cd4118fe875833b29ada0ca5d1390ca6f9c256fd83a3fd5d70dbd [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 11adea35cd1caf853ca30ba71153ce24065f83304335509eca8667c0ea3fbb68 [INFO] running `Command { std: "docker" "start" "-a" "11adea35cd1caf853ca30ba71153ce24065f83304335509eca8667c0ea3fbb68", kill_on_drop: false }` [INFO] [stderr] Compiling unicode-ident v1.0.24 [INFO] [stderr] Compiling object v0.37.3 [INFO] [stderr] Compiling semver v1.0.27 [INFO] [stderr] Compiling cc v1.2.57 [INFO] [stderr] Compiling rust_decimal v1.41.0 [INFO] [stderr] Compiling typenum v1.19.0 [INFO] [stderr] Compiling arrayvec v0.7.6 [INFO] [stderr] Compiling libc v0.2.183 [INFO] [stderr] Compiling beef v0.5.2 [INFO] [stderr] Compiling serde_json v1.0.149 [INFO] [stderr] Compiling regex-automata v0.4.14 [INFO] [stderr] Compiling bigdecimal v0.4.10 [INFO] [stderr] Compiling chumsky v1.0.0-alpha.8 [INFO] [stderr] Compiling logosky v0.2.0 [INFO] [stderr] Compiling ascii v1.1.0 [INFO] [stderr] Compiling rmp v0.8.15 [INFO] [stderr] Compiling proc-macro2 v1.0.106 [INFO] [stderr] Compiling chumsky v0.11.2 [INFO] [stderr] Compiling rustc_version v0.4.1 [INFO] [stderr] Compiling winnow v1.0.1 [INFO] [stderr] Compiling const-oid v0.10.2 [INFO] [stderr] Compiling logos-codegen v0.15.1 [INFO] [stderr] Compiling quote v1.0.45 [INFO] [stderr] Compiling syn v2.0.117 [INFO] [stderr] Compiling stacker v0.1.23 [INFO] [stderr] Compiling hybrid-array v0.4.9 [INFO] [stderr] Compiling crypto-common v0.2.1 [INFO] [stderr] Compiling block-buffer v0.12.0 [INFO] [stderr] Compiling digest v0.11.2 [INFO] [stderr] Compiling sha2 v0.11.0 [INFO] [stderr] Compiling ar_archive_writer v0.5.1 [INFO] [stderr] Compiling psm v0.1.30 [INFO] [stderr] Compiling logos-codegen v0.16.1 [INFO] [stderr] Compiling serde_derive v1.0.228 [INFO] [stderr] Compiling ptr_meta_derive v0.3.1 [INFO] [stderr] Compiling bytecheck_derive v0.8.2 [INFO] [stderr] Compiling munge_macro v0.4.7 [INFO] [stderr] Compiling thiserror-impl v2.0.18 [INFO] [stderr] Compiling rkyv_derive v0.8.15 [INFO] [stderr] Compiling rust_decimal_macros v1.40.0 [INFO] [stderr] Compiling derive_more-impl v2.1.1 [INFO] [stderr] Compiling ptr_meta v0.3.1 [INFO] [stderr] Compiling rancor v0.1.1 [INFO] [stderr] Compiling logos-derive v0.15.1 [INFO] [stderr] Compiling munge v0.4.7 [INFO] [stderr] Compiling bytecheck v0.8.2 [INFO] [stderr] Compiling logos-derive v0.16.1 [INFO] [stderr] Compiling rend v0.5.3 [INFO] [stderr] Compiling logos v0.15.1 [INFO] [stderr] Compiling thiserror v2.0.18 [INFO] [stderr] Compiling logos v0.16.1 [INFO] [stderr] Compiling serde v1.0.228 [INFO] [stderr] Compiling derive_more v2.1.1 [INFO] [stderr] Compiling chrono v0.4.44 [INFO] [stderr] Compiling rustledger-plugin-types v0.12.0 [INFO] [stderr] Compiling rmp-serde v1.3.1 [INFO] [stderr] Compiling rkyv v0.8.15 [INFO] [stderr] Compiling rustledger-core v0.12.0 [INFO] [stderr] Compiling rustledger-parser v0.12.0 [INFO] [stderr] Compiling rustledger-booking v0.12.0 [INFO] [stderr] Compiling rustledger-plugin v0.12.0 [INFO] [stderr] Compiling rustledger-validate v0.12.0 [INFO] [stderr] Compiling rustledger-loader v0.12.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished `dev` profile [unoptimized + debuginfo] target(s) in 47.28s [INFO] running `Command { std: "docker" "inspect" "11adea35cd1caf853ca30ba71153ce24065f83304335509eca8667c0ea3fbb68", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "11adea35cd1caf853ca30ba71153ce24065f83304335509eca8667c0ea3fbb68", kill_on_drop: false }` [INFO] [stdout] 11adea35cd1caf853ca30ba71153ce24065f83304335509eca8667c0ea3fbb68 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 0c66d045e611e86b93a88930ef949e5bf52f9cf42d03e468ee86d4256e14842f [INFO] running `Command { std: "docker" "start" "-a" "0c66d045e611e86b93a88930ef949e5bf52f9cf42d03e468ee86d4256e14842f", kill_on_drop: false }` [INFO] [stderr] Compiling getrandom v0.4.2 [INFO] [stderr] Compiling tempfile v3.27.0 [INFO] [stderr] Compiling rustledger-loader v0.12.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 4.96s [INFO] running `Command { std: "docker" "inspect" "0c66d045e611e86b93a88930ef949e5bf52f9cf42d03e468ee86d4256e14842f", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "0c66d045e611e86b93a88930ef949e5bf52f9cf42d03e468ee86d4256e14842f", kill_on_drop: false }` [INFO] [stdout] 0c66d045e611e86b93a88930ef949e5bf52f9cf42d03e468ee86d4256e14842f [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] c82eb30b44e3a1b338afcbbff60d5b9f8a8053b4ddd0e39b139ca5cc9a5c8578 [INFO] running `Command { std: "docker" "start" "-a" "c82eb30b44e3a1b338afcbbff60d5b9f8a8053b4ddd0e39b139ca5cc9a5c8578", kill_on_drop: false }` [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 0.27s [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/rustledger_loader-c5c6d7d5d447f0c6) [INFO] [stdout] [INFO] [stdout] running 58 tests [INFO] [stdout] test cache::tests::bench_cache_performance ... ignored, manual benchmark - run with: cargo test -p rustledger-loader --release -- --ignored --nocapture [INFO] [stdout] test cache::tests::test_cache_header_roundtrip ... ok [INFO] [stdout] test cache::tests::test_cache_path ... ok [INFO] [stdout] test cache::tests::test_cache_entry_file_paths ... ok [INFO] [stdout] test cache::tests::test_reintern_balance_directive ... ok [INFO] [stdout] test cache::tests::test_reintern_directives_deduplication ... ok [INFO] [stdout] test cache::tests::test_cached_options_roundtrip ... ok [INFO] [stdout] test cache::tests::test_serialize_deserialize_roundtrip ... ok [INFO] [stdout] test options::tests::test_account_validation_options ... ok [INFO] [stdout] test options::tests::test_custom_options ... ok [INFO] [stdout] test options::tests::test_default_options ... ok [INFO] [stdout] test cache::tests::test_load_cache_missing_file ... ok [INFO] [stdout] test options::tests::test_deprecated_plugin_option ... ok [INFO] [stdout] test cache::tests::test_invalidate_cache ... ok [INFO] [stdout] test options::tests::test_duplicate_option_warning ... ok [INFO] [stdout] test cache::tests::test_load_cache_invalid_magic ... ok [INFO] [stdout] test options::tests::test_inferred_tolerance_default ... ok [INFO] [stdout] test options::tests::test_inferred_tolerance_multiplier_deprecated ... ok [INFO] [stdout] test options::tests::test_invalid_account_name_validation ... ok [INFO] [stdout] test options::tests::test_invalid_booking_method ... ok [INFO] [stdout] test options::tests::test_invalid_boolean_value ... ok [INFO] [stdout] test cache::tests::test_save_load_cache_entry_roundtrip ... ok [INFO] [stdout] test options::tests::test_invalid_tolerance_value ... ok [INFO] [stdout] test options::tests::test_is_valid_account ... ok [INFO] [stdout] test options::tests::test_plugin_processing_mode_validation ... ok [INFO] [stdout] test options::tests::test_readonly_option_warning ... ok [INFO] [stdout] test options::tests::test_render_commas_with_numeric_values ... ok [INFO] [stdout] test options::tests::test_repeatable_option_no_warning ... ok [INFO] [stdout] test options::tests::test_set_options ... ok [INFO] [stdout] test options::tests::test_tolerance_multiplier_new_name ... ok [INFO] [stdout] test options::tests::test_valid_account_name ... ok [INFO] [stdout] test options::tests::test_unknown_option_warning ... ok [INFO] [stdout] test options::tests::test_valid_booking_methods ... ok [INFO] [stdout] test source_map::tests::test_get_line ... ok [INFO] [stdout] test source_map::tests::test_line_col ... ok [INFO] [stdout] test source_map::tests::test_line_start ... ok [INFO] [stdout] test options::tests::test_deprecated_allow_pipe_separator ... ok [INFO] [stdout] test source_map::tests::test_source_map ... ok [INFO] [stdout] test tests::test_is_encrypted_file_asc_with_pgp_header ... ok [INFO] [stdout] test tests::test_is_encrypted_file_asc_without_pgp_header ... ok [INFO] [stdout] test tests::test_is_encrypted_file_gpg_extension ... ok [INFO] [stdout] test tests::test_plugin_force_python_prefix ... ok [INFO] [stdout] test tests::test_is_encrypted_file_plain_beancount ... ok [INFO] [stdout] test tests::test_plugin_force_python_with_config ... ok [INFO] [stdout] test tests::test_virtual_filesystem_glob_dot_slash_prefix ... ok [INFO] [stdout] test vfs::tests::test_virtual_filesystem_from_files ... ok [INFO] [stdout] test tests::test_virtual_filesystem_glob_no_match ... ok [INFO] [stdout] test tests::test_virtual_filesystem_missing_include ... ok [INFO] [stdout] test vfs::tests::test_virtual_filesystem_path_normalization ... ok [INFO] [stdout] test tests::test_virtual_filesystem_glob_include ... ok [INFO] [stdout] test tests::test_virtual_filesystem_include_resolution ... ok [INFO] [stdout] test tests::test_virtual_filesystem_nested_includes ... ok [INFO] [stdout] test vfs::tests::test_virtual_filesystem_not_encrypted ... ok [INFO] [stdout] test vfs::tests::test_normalize_vfs_path ... ok [INFO] [stdout] test vfs::tests::test_virtual_filesystem_basic ... ok [INFO] [stdout] test cache::tests::test_compute_hash_deterministic ... ok [INFO] [stdout] test tests::test_decrypt_gpg_file_missing_gpg ... ok [INFO] [stdout] test cache::tests::test_reintern_open_close_directives ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 57 passed; 0 failed; 1 ignored; 0 measured; 0 filtered out; finished in 0.13s [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] running 37 tests [INFO] [stderr] Running tests/loader_test.rs (/opt/rustwide/target/debug/deps/loader_test-456eb191a7c5d57d) [INFO] [stdout] test test_file_level_booking_method_applied ... ok [INFO] [stdout] test test_glob_include_deterministic_order ... ok [INFO] [stdout] test test_duplicate_include_ignored ... ok [INFO] [stdout] test test_document_discovery_no_duplicates ... ok [INFO] [stdout] test test_ledger_error_creation ... ok [INFO] [stdout] test test_load_include_cycle_detection ... ok [INFO] [stdout] test test_api_booking_method_used_when_file_does_not_set_option ... ok [INFO] [stdout] test test_load_missing_include ... ok [INFO] [stdout] test test_document_discovery_no_option ... ok [INFO] [stdout] test test_glob_include_no_match ... ok [INFO] [stdout] test test_glob_include_pattern ... ok [INFO] [stdout] test test_include_cycle_display_contains_duplicate_filename_issue_765 ... ok [INFO] [stdout] test test_load_nonexistent_file ... ok [INFO] [stdout] test test_document_discovery_from_option ... ok [INFO] [stdout] test test_load_options_default ... ok [INFO] [stdout] test test_load_with_plugins ... ok [INFO] [stdout] test test_loader_reuse ... ok [INFO] [stdout] test test_process_pipeline_with_validation ... ok [INFO] [stdout] test test_plugin_output_directives_visible_in_ledger ... ok [INFO] [stdout] test test_plugin_and_booking_interaction ... ok [INFO] [stdout] test test_load_options_raw ... ok [INFO] [stdout] test test_process_pipeline_without_validation ... ok [INFO] [stdout] test test_load_simple_file ... ok [INFO] [stdout] test test_process_from_load_result ... ok [INFO] [stdout] test test_process_preserves_display_context ... ok [INFO] [stdout] test test_process_with_auto_accounts ... ok [INFO] [stdout] test test_unknown_plugin_skipped_gracefully ... ok [INFO] [stdout] test test_load_with_parse_errors ... ok [INFO] [stdout] test test_path_traversal_allowed_without_security ... ok [INFO] [stdout] test test_path_traversal_blocked_with_security_enabled ... ok [INFO] [stdout] test test_load_with_include ... ok [INFO] [stdout] test test_process_raw_mode ... ok [INFO] [stdout] test test_with_custom_root_dir ... ok [INFO] [stdout] test test_plugin_execution_auto_accounts ... ok [INFO] [stdout] test test_process_directives_sorted_by_date ... ok [INFO] [stdout] test test_process_with_extra_plugins ... ok [INFO] [stdout] test test_source_map_line_lookup ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 37 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.18s [INFO] [stdout] [INFO] [stderr] Doc-tests rustledger_loader [INFO] [stdout] [INFO] [stdout] running 5 tests [INFO] [stdout] test src/lib.rs - (line 18) ... ignored [INFO] [stdout] test src/lib.rs - Loader::with_path_security (line 290) ... ignored [INFO] [stdout] test src/process.rs - process::load (line 563) ... ignored [INFO] [stdout] test src/vfs.rs - vfs::VirtualFileSystem (line 150) ... ok [INFO] [stdout] test src/lib.rs - Loader::with_filesystem (line 319) ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 2 passed; 0 failed; 3 ignored; 0 measured; 0 filtered out; finished in 0.01s [INFO] [stdout] [INFO] [stdout] all doctests ran in 0.99s; merged doctests compilation took 0.96s [INFO] running `Command { std: "docker" "inspect" "c82eb30b44e3a1b338afcbbff60d5b9f8a8053b4ddd0e39b139ca5cc9a5c8578", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "c82eb30b44e3a1b338afcbbff60d5b9f8a8053b4ddd0e39b139ca5cc9a5c8578", kill_on_drop: false }` [INFO] [stdout] c82eb30b44e3a1b338afcbbff60d5b9f8a8053b4ddd0e39b139ca5cc9a5c8578