[INFO] cloning repository https://github.com/fancyAqua/dag-factor-draft
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/fancyAqua/dag-factor-draft" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FfancyAqua%2Fdag-factor-draft", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FfancyAqua%2Fdag-factor-draft'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] ffbae2cd225dfe7cd5ba39c04a35cb57094fd09b
[INFO] testing fancyAqua/dag-factor-draft against 1.98.0-beta.1 for beta-1.98-1
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FfancyAqua%2Fdag-factor-draft" "/workspace/builds/worker-0-tc2/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-0-tc2/source'...
[INFO] [stderr] done.
[INFO] started tweaking git repo https://github.com/fancyAqua/dag-factor-draft
[INFO] finished tweaking git repo https://github.com/fancyAqua/dag-factor-draft
[INFO] tweaked toml for git repo https://github.com/fancyAqua/dag-factor-draft written to /workspace/builds/worker-0-tc2/source/Cargo.toml
[INFO] validating manifest of git repo https://github.com/fancyAqua/dag-factor-draft on toolchain 1.98.0-beta.1
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.98.0-beta.1" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate git repo https://github.com/fancyAqua/dag-factor-draft 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.98.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-0-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-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:3d5ced03c013a94a2f102a4510f48a6e9184255caf5fd8244f58017bde7f5210" "sleep" "infinity", kill_on_drop: false }`
[INFO] [stdout] a6b867b6f74b389beb32ab854cd6e80a7ace963679205b52525bb85e9ece1982
[INFO] running `Command { std: "docker" "start" "a6b867b6f74b389beb32ab854cd6e80a7ace963679205b52525bb85e9ece1982", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "a6b867b6f74b389beb32ab854cd6e80a7ace963679205b52525bb85e9ece1982", 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" "a6b867b6f74b389beb32ab854cd6e80a7ace963679205b52525bb85e9ece1982" "/opt/rustwide/cargo-home/bin/cargo" "+1.98.0-beta.1" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "a6b867b6f74b389beb32ab854cd6e80a7ace963679205b52525bb85e9ece1982", 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" "a6b867b6f74b389beb32ab854cd6e80a7ace963679205b52525bb85e9ece1982" "/opt/rustwide/cargo-home/bin/cargo" "+1.98.0-beta.1" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling libm v0.2.16
[INFO] [stderr]    Compiling num-traits v0.2.19
[INFO] [stderr]    Compiling zerocopy v0.8.48
[INFO] [stderr]    Compiling jobserver v0.1.34
[INFO] [stderr]    Compiling zerocopy-derive v0.8.48
[INFO] [stderr]    Compiling tokio-macros v2.7.0
[INFO] [stderr]    Compiling socket2 v0.6.3
[INFO] [stderr]    Compiling mio v1.2.0
[INFO] [stderr]    Compiling ahash v0.8.12
[INFO] [stderr]    Compiling http v1.4.0
[INFO] [stderr]    Compiling cc v1.2.62
[INFO] [stderr]    Compiling semver v1.0.28
[INFO] [stderr]    Compiling tokio v1.52.3
[INFO] [stderr]    Compiling getrandom v0.3.4
[INFO] [stderr]    Compiling rustc_version v0.4.1
[INFO] [stderr]    Compiling arrow-schema v58.3.0
[INFO] [stderr]    Compiling zstd-safe v7.2.4
[INFO] [stderr]    Compiling alloc-no-stdlib v2.0.4
[INFO] [stderr]    Compiling http-body v1.0.1
[INFO] [stderr]    Compiling flatbuffers v25.12.19
[INFO] [stderr]    Compiling alloc-stdlib v0.2.2
[INFO] [stderr]    Compiling crossbeam-epoch v0.9.18
[INFO] [stderr]    Compiling futures-channel v0.3.32
[INFO] [stderr]    Compiling bitflags v2.11.1
[INFO] [stderr]    Compiling snap v1.1.1
[INFO] [stderr]    Compiling sync_wrapper v1.0.2
[INFO] [stderr]    Compiling slab v0.4.12
[INFO] [stderr]    Compiling futures-task v0.3.32
[INFO] [stderr]    Compiling rayon-core v1.13.0
[INFO] [stderr]    Compiling futures-util v0.3.32
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling num-integer v0.1.46
[INFO] [stderr]    Compiling chrono v0.4.44
[INFO] [stderr]    Compiling zstd-sys v2.0.16+zstd.1.5.7
[INFO] [stderr]    Compiling num-bigint v0.4.6
[INFO] [stderr]    Compiling num-complex v0.4.6
[INFO] [stderr]    Compiling ordered-float v2.10.1
[INFO] [stderr]    Compiling crossbeam-deque v0.8.6
[INFO] [stderr]    Compiling brotli-decompressor v5.0.0
[INFO] [stderr]    Compiling http-body-util v0.1.3
[INFO] [stderr]    Compiling twox-hash v2.1.2
[INFO] [stderr]    Compiling winnow v1.0.3
[INFO] [stderr]    Compiling hyper v1.9.0
[INFO] [stderr]    Compiling integer-encoding v3.0.4
[INFO] [stderr]    Compiling zlib-rs v0.6.3
[INFO] [stderr]    Compiling serde_urlencoded v0.7.1
[INFO] [stderr]    Compiling thrift v0.17.0
[INFO] [stderr]    Compiling tokio-util v0.7.18
[INFO] [stderr]    Compiling clap_derive v4.6.1
[INFO] [stderr]    Compiling hyper-util v0.1.20
[INFO] [stderr]    Compiling tower v0.5.3
[INFO] [stderr]    Compiling toml_parser v1.1.2+spec-1.1.0
[INFO] [stderr]    Compiling brotli v8.0.2
[INFO] [stderr]    Compiling axum-core v0.5.6
[INFO] [stderr]    Compiling lz4_flex v0.13.1
[INFO] [stderr]    Compiling serde_spanned v1.1.1
[INFO] [stderr]    Compiling toml_datetime v0.7.5+spec-1.1.0
[INFO] [stderr]    Compiling half v2.7.1
[INFO] [stderr]    Compiling base64 v0.22.1
[INFO] [stderr]    Compiling simdutf8 v0.1.5
[INFO] [stderr]    Compiling seq-macro v0.3.6
[INFO] [stderr]    Compiling toml_writer v1.1.1+spec-1.1.0
[INFO] [stderr]    Compiling arrow-buffer v58.3.0
[INFO] [stderr]    Compiling either v1.16.0
[INFO] [stderr]    Compiling axum v0.8.9
[INFO] [stderr]    Compiling toml v0.9.12+spec-1.1.0
[INFO] [stderr]    Compiling rayon v1.12.0
[INFO] [stderr]    Compiling clap v4.6.1
[INFO] [stderr]    Compiling tokio-stream v0.1.18
[INFO] [stderr]    Compiling arrow-data v58.3.0
[INFO] [stderr]    Compiling flate2 v1.1.9
[INFO] [stderr]    Compiling arrow-array v58.3.0
[INFO] [stderr]    Compiling zstd v0.13.3
[INFO] [stderr]    Compiling arrow-select v58.3.0
[INFO] [stderr]    Compiling arrow-ipc v58.3.0
[INFO] [stderr]    Compiling parquet v58.3.0
[INFO] [stderr]    Compiling ms4_factors v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 2m 34s
[INFO] running `Command { std: "docker" "inspect" "a6b867b6f74b389beb32ab854cd6e80a7ace963679205b52525bb85e9ece1982", 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" "a6b867b6f74b389beb32ab854cd6e80a7ace963679205b52525bb85e9ece1982" "/opt/rustwide/cargo-home/bin/cargo" "+1.98.0-beta.1" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling flatbuffers v25.12.19
[INFO] [stderr]    Compiling rustix v1.1.4
[INFO] [stderr]    Compiling arrow-ipc v58.3.0
[INFO] [stderr]    Compiling tempfile v3.27.0
[INFO] [stderr]    Compiling parquet v58.3.0
[INFO] [stderr]    Compiling ms4_factors v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 1m 24s
[INFO] running `Command { std: "docker" "inspect" "a6b867b6f74b389beb32ab854cd6e80a7ace963679205b52525bb85e9ece1982", 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" "a6b867b6f74b389beb32ab854cd6e80a7ace963679205b52525bb85e9ece1982" "/opt/rustwide/cargo-home/bin/cargo" "+1.98.0-beta.1" "test" "--frozen", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.46s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/ms4_factors-f7e2c053d66e7c0e)
[INFO] [stdout] 
[INFO] [stdout] running 61 tests
[INFO] [stdout] test compute::core::memory::tests::memory_reservation_releases_on_drop ... ok
[INFO] [stdout] test api::tests::empty_status_snapshot_is_idle ... ok
[INFO] [stdout] test compute::core::parquet_io::tests::dataset_path_template_resolves_with_date ... ok
[INFO] [stdout] test compute::core::memory::tests::memory_tracker_rejects_hard_limit_before_growth ... ok
[INFO] [stdout] test compute::core::parquet_io::tests::effective_date_prefers_cli_date_then_path_date ... ok
[INFO] [stdout] test compute::operators::regression::beta::tests::rolling_beta_matches_linear_series ... ok
[INFO] [stdout] test compute::operators::stateful::extrema::tests::test_stateful_min_max_parity ... ok
[INFO] [stdout] test compute::nodes::hurst::tests::log_return_transform_filters_invalid_prices ... ok
[INFO] [stdout] test compute::operators::stateful::mean_std::tests::test_stateful_mean_parity ... ok
[INFO] [stdout] test compute::operators::stateful::mean_std::tests::test_stateful_std_parity ... ok
[INFO] [stdout] test compute::operators::path::drawdown::tests::rolling_drawdown_uses_window_peak ... ok
[INFO] [stdout] test compute::operators::stateful::sum_count::tests::test_stateful_sum_parity ... ok
[INFO] [stdout] test compute::operators::stateful::tests::stateful_operators_match_stateless_across_split_batches ... ok
[INFO] [stdout] test compute::operators::statistical::basis::tests::basis_bps_matches_expected_formula ... ok
[INFO] [stdout] test compute::operators::statistical::rolling::tests::rolling_zscore_constant_window_is_nan ... ok
[INFO] [stdout] test compute::operators::statistical::corr::tests::rolling_corr_identifies_same_and_inverse_series ... ok
[INFO] [stdout] test compute::operators::time_series::momentum::tests::endpoint_preserves_existing_window_start_behavior ... ok
[INFO] [stdout] test compute::operators::statistical::rolling::tests::rolling_stats_compute_mean_and_std ... ok
[INFO] [stdout] test compute::operators::time_series::momentum::tests::lag_uses_requested_lookback_target ... ok
[INFO] [stdout] test compute::operators::time_series::momentum::tests::ma_gap_compares_current_to_window_mean ... ok
[INFO] [stdout] test compute::operators::time_series::momentum::tests::slope_detects_trend_direction ... ok
[INFO] [stdout] test compute::operators::time_series::momentum::tests::vol_adjusted_does_not_emit_for_zero_volatility ... ok
[INFO] [stdout] test compute::operators::time_series::momentum::tests::rolling_sum_sums_return_like_series ... ok
[INFO] [stdout] test compute::operators::statistical::rolling::tests::rolling_volatility_outputs_finite_values ... ok
[INFO] [stdout] test compute::operators::time_series::resample::tests::resample_mean_ignores_non_finite_values ... ok
[INFO] [stdout] test compute::operators::time_series::resample::tests::resample_last_emits_at_bucket_tail ... ok
[INFO] [stdout] test compute::operators::time_series::rolling::tests::log_return_skips_sparse_missing_values ... ok
[INFO] [stdout] test compute::runners::chunked_parquet::tests::adaptive_commit_delta_boundary_does_not_require_modulo_alignment ... ok
[INFO] [stdout] test compute::runners::chunked_parquet::tests::adaptive_scheduler_reduces_wave_on_memory_pressure ... ok
[INFO] [stdout] test compute::operators::time_series::rolling::tests::log_return_matches_expected_values ... ok
[INFO] [stdout] test compute::runners::chunked_parquet::tests::adaptive_scheduler_raises_commit_interval_when_commit_dominates ... ok
[INFO] [stdout] test compute::runners::chunked_parquet::tests::compute_scope_progress_uses_rows_not_symbol_tasks ... ok
[INFO] [stdout] test eval::operators::tests::forward_max_drawdown_returns_worst_negative_path_drawdown ... ok
[INFO] [stdout] test eval::accumulator::tests::cross_sectional_accumulator_groups_symbols_by_timestamp ... ok
[INFO] [stdout] test eval::accumulator::tests::time_series_accumulator_aggregates_symbol_series ... ok
[INFO] [stdout] test eval::operators::tests::forward_max_return_uses_highest_future_price ... ok
[INFO] [stdout] test eval::operators::tests::invalid_prices_and_empty_windows_return_none ... ok
[INFO] [stdout] test eval::operators::tests::forward_return_matches_existing_log_return ... ok
[INFO] [stdout] test eval::progress::tests::quiet_progress_reports_to_upstream_handle ... ok
[INFO] [stdout] test eval::runner::tests::join_symbol_uses_next_price_at_or_after_horizon ... ok
[INFO] [stdout] test eval::stats::tests::percent_ranks_are_normalized ... ok
[INFO] [stdout] test eval::target_store::tests::source_dates_cover_cross_day_horizon ... ok
[INFO] [stdout] test observability::tests::broadcast_hub_tracks_latest_snapshot ... ok
[INFO] [stdout] test eval::stats::tests::pearson_and_spearman_match_monotonic_series ... ok
[INFO] [stdout] test eval::tests::eval_resource_limits_default_matches_cli_defaults ... ok
[INFO] [stdout] test observability::tests::jsonl_sink_writes_valid_event_lines ... ok
[INFO] [stdout] test observability::tests::progress_bar_finished_is_always_complete ... ok
[INFO] [stdout] test streaming::contract::tests::factor_input_batch_roundtrips_json ... ok
[INFO] [stdout] test observability::tests::progress_events_keep_last_percent_for_output_events_without_progress ... ok
[INFO] [stdout] test streaming::contract::tests::output_metadata_carries_freshness_contract ... ok
[INFO] [stdout] test observability::tests::jsonl_summary_filters_high_frequency_node_events ... ok
[INFO] [stdout] test streaming::contract::tests::factor_value_f64_keeps_numeric_semantics ... ok
[INFO] [stdout] test api::tests::global_dag_query_uses_same_planner ... ok
[INFO] [stdout] test streaming::output_cache::tests::cache_usability_respects_max_staleness ... ok
[INFO] [stdout] test streaming::engine::tests::streaming_core_can_emit_multiple_outputs_from_global_dag ... ok
[INFO] [stdout] test streaming::engine::tests::streaming_core_only_emits_new_rows_across_batches ... ok
[INFO] [stdout] test streaming::engine::tests::streaming_core_emits_return_factor ... ok
[INFO] [stdout] test streaming::engine::tests::streaming_core_rejects_dataset_mismatch ... ok
[INFO] [stdout] test compute::core::parquet_io::tests::fixed_dataset_path_ignores_date ... ok
[INFO] [stdout] test compute::nodes::hurst::tests::log_return_transform_produces_finite_dfa_hurst_for_geometric_walk ... ok
[INFO] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/debug/deps/ms4_factors-762f46a6647d21c3)
[INFO] [stdout] test compute::nodes::hurst::tests::rolling_hurst_reports_internal_row_progress ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 61 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 9.18s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/eval.rs (/opt/rustwide/target/debug/deps/eval-d7ae2beeb40292f6)
[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] [stdout] 
[INFO] [stdout] running 22 tests
[INFO] [stdout] test eval_hard_fails_under_tiny_memory_limit ... ok
[INFO] [stdout] test eval_reports_missing_target_from_eval_lib ... ok
[INFO] [stdout] test eval_reads_hot_part_factor_manifest ... ok
[INFO] [stdout] test eval_outputs_json_and_parquet_metrics_for_both_modes ... ok
[INFO] [stdout] test eval_auto_materializes_and_reuses_target_cache ... ok
[INFO] [stdout] test eval_rebuilds_target_cache_when_manifest_fingerprint_changes ... ok
[INFO] [stdout] test eval_cli_reports_missing_factor_parquet ... ok
[INFO] [stdout] test eval_parallel_dates_match_single_threaded_sample_count ... ok
[INFO] [stdout] test single_symbol_keeps_time_series_and_marks_cross_sectional_insufficient ... ok
[INFO] [stdout] test materialize_targets_cli_writes_target_cache ... ok
[INFO] [stdout] test eval_small_parquet_and_output_batches_remain_correct ... ok
[INFO] [stdout] test target_materializer_cleans_stale_tmp_and_workdir ... ok
[INFO] [stdout] test parallel_target_materializer_writes_multiple_dates_and_reuses_cache ... ok
[INFO] [stdout] test parallel_target_materializer_matches_sequential_cross_day_output ... ok
[INFO] [stdout] test validate_eval_cli_accepts_real_factor_and_eval_roots ... ok
[INFO] [stdout] test target_spec_rejects_missing_horizons ... ok
[INFO] [stdout] test eval_cli_runs_forward_max_return_target ... FAILED
[INFO] [stdout] test target_spec_rejects_unknown_kind ... ok
[INFO] [stdout] test validate_eval_cli_rejects_missing_target_column ... ok
[INFO] [stdout] test eval_runs_all_mark_price_target_kinds ... ok
[INFO] [stdout] test refresh_targets_repairs_cross_day_tail_values ... ok
[INFO] [stdout] test target_materializer_batches_symbols_under_low_memory ... ok
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- eval_cli_runs_forward_max_return_target stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'eval_cli_runs_forward_max_return_target' (1667) panicked at tests/eval.rs:1066:5:
[INFO] [stdout] stderr=Error: Read-only file system (os error 30)
[INFO] [stdout] 
[INFO] [stdout] Stack backtrace:
[INFO] [stdout]    0: <anyhow::Error as core::convert::From<core::io::error::Error>>::from
[INFO] [stdout]              at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/anyhow-1.0.102/src/backtrace.rs:10:14
[INFO] [stdout]    1: <core::result::Result<(), anyhow::Error> as core::ops::try_trait::FromResidual<core::result::Result<core::convert::Infallible, core::io::error::Error>>>::from_residual
[INFO] [stdout]              at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/core/src/result.rs:2192:27
[INFO] [stdout]    2: <ms4_factors::eval::target_store::TargetMaterializer>::materialize_date_with_progress_inner
[INFO] [stdout]              at ./src/eval/target_store.rs:348:9
[INFO] [stdout]    3: <ms4_factors::eval::target_store::TargetMaterializer>::materialize_date_with_progress_handle
[INFO] [stdout]              at ./src/eval/target_store.rs:322:14
[INFO] [stdout]    4: <ms4_factors::eval::target_store::TargetMaterializer>::materialize_date_with_progress
[INFO] [stdout]              at ./src/eval/target_store.rs:297:18
[INFO] [stdout]    5: <ms4_factors::eval::target_store::TargetMaterializer>::materialize_date
[INFO] [stdout]              at ./src/eval/target_store.rs:284:14
[INFO] [stdout]    6: <ms4_factors::eval::target_store::TargetMaterializer>::ensure_date
[INFO] [stdout]              at ./src/eval/target_store.rs:280:14
[INFO] [stdout]    7: <ms4_factors::eval::runner::ChunkedEvalRunner>::run_date
[INFO] [stdout]              at ./src/eval/runner.rs:249:30
[INFO] [stdout]    8: <ms4_factors::eval::runner::ChunkedEvalRunner>::run_dates_sequential
[INFO] [stdout]              at ./src/eval/runner.rs:194:31
[INFO] [stdout]    9: <ms4_factors::eval::runner::ChunkedEvalRunner>::run
[INFO] [stdout]              at ./src/eval/runner.rs:136:18
[INFO] [stdout]   10: ms4_factors::eval::run_eval
[INFO] [stdout]              at ./src/eval/mod.rs:121:46
[INFO] [stdout]   11: ms4_factors::cli::commands::handle_command
[INFO] [stdout]              at ./src/cli/commands.rs:521:26
[INFO] [stdout]   12: ms4_factors::main
[INFO] [stdout]              at ./src/main.rs:9:5
[INFO] [stdout]   13: <fn() -> core::result::Result<(), anyhow::Error> as core::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]              at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   14: std::sys::backtrace::__rust_begin_short_backtrace::<fn() -> core::result::Result<(), anyhow::Error>, core::result::Result<(), anyhow::Error>>
[INFO] [stdout]              at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   15: std::rt::lang_start::<core::result::Result<(), anyhow::Error>>::{closure#0}
[INFO] [stdout]              at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/rt.rs:206:18
[INFO] [stdout]   16: <&dyn core::ops::function::Fn<(), Output = i32> + core::panic::unwind_safe::RefUnwindSafe + core::marker::Sync as core::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]              at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/core/src/ops/function.rs:287:21
[INFO] [stdout]   17: std::panicking::catch_unwind::do_call::<&dyn core::ops::function::Fn<(), Output = i32> + core::panic::unwind_safe::RefUnwindSafe + core::marker::Sync, i32>
[INFO] [stdout]              at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/panicking.rs:576:43
[INFO] [stdout]   18: std::panicking::catch_unwind::<i32, &dyn core::ops::function::Fn<(), Output = i32> + core::panic::unwind_safe::RefUnwindSafe + core::marker::Sync>
[INFO] [stdout]              at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/panicking.rs:544:19
[INFO] [stdout]   19: std::panic::catch_unwind::<&dyn core::ops::function::Fn<(), Output = i32> + core::panic::unwind_safe::RefUnwindSafe + core::marker::Sync, i32>
[INFO] [stdout]              at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/panic.rs:359:14
[INFO] [stdout]   20: std::rt::lang_start_internal::{closure#0}
[INFO] [stdout]              at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/rt.rs:175:24
[INFO] [stdout]   21: std::panicking::catch_unwind::do_call::<std::rt::lang_start_internal::{closure#0}, isize>
[INFO] [stdout]              at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/panicking.rs:576:43
[INFO] [stdout]   22: std::panicking::catch_unwind::<isize, std::rt::lang_start_internal::{closure#0}>
[INFO] [stdout]              at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/panicking.rs:544:19
[INFO] [stdout]   23: std::panic::catch_unwind::<std::rt::lang_start_internal::{closure#0}, isize>
[INFO] [stdout]              at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/panic.rs:359:14
[INFO] [stdout]   24: std::rt::lang_start_internal
[INFO] [stdout]              at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/rt.rs:171:5
[INFO] [stdout]   25: std::rt::lang_start::<core::result::Result<(), anyhow::Error>>
[INFO] [stdout]              at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/rt.rs:205:5
[INFO] [stdout]   26: main
[INFO] [stdout]   27: <unknown>
[INFO] [stdout]   28: __libc_start_main
[INFO] [stdout]   29: _start
[INFO] [stdout] 
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5bfe63950441 - std[73adb7dc35730857]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x5bfe63950441 - std[73adb7dc35730857]::backtrace_rs::backtrace::trace_unsynchronized::<std[73adb7dc35730857]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x5bfe63950441 - std[73adb7dc35730857]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x5bfe63950441 - <<std[73adb7dc35730857]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[6883ba1bc0fe4ed1]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x5bfe63967eca - <core[6883ba1bc0fe4ed1]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x5bfe63967eca - core[6883ba1bc0fe4ed1]::fmt::write
[INFO] [stdout]    6:     0x5bfe6395569c - std[73adb7dc35730857]::io::default_write_fmt::<alloc[55a36b64bcbf2c0d]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/io/mod.rs:626:11
[INFO] [stdout]    7:     0x5bfe6395569c - <alloc[55a36b64bcbf2c0d]::vec::Vec<u8> as std[73adb7dc35730857]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/io/mod.rs:1730:13
[INFO] [stdout]    8:     0x5bfe6392b6e6 - <std[73adb7dc35730857]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x5bfe6392b6e6 - std[73adb7dc35730857]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x5bfe63946ff9 - std[73adb7dc35730857]::panicking::default_hook
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x5bfe625cc1f0 - <alloc[55a36b64bcbf2c0d]::boxed::Box<dyn for<'a, 'b> core[6883ba1bc0fe4ed1]::ops::function::Fn<(&'a std[73adb7dc35730857]::panic::PanicHookInfo<'b>,), Output = ()> + core[6883ba1bc0fe4ed1]::marker::Send + core[6883ba1bc0fe4ed1]::marker::Sync> as core[6883ba1bc0fe4ed1]::ops::function::Fn<(&std[73adb7dc35730857]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/alloc/src/boxed.rs:2333:9
[INFO] [stdout]   12:     0x5bfe625cc1f0 - test[980ffaebd391d06d]::test_main_inner::<test[980ffaebd391d06d]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/test/src/lib.rs:155:21
[INFO] [stdout]   13:     0x5bfe63947322 - <alloc[55a36b64bcbf2c0d]::boxed::Box<dyn for<'a, 'b> core[6883ba1bc0fe4ed1]::ops::function::Fn<(&'a std[73adb7dc35730857]::panic::PanicHookInfo<'b>,), Output = ()> + core[6883ba1bc0fe4ed1]::marker::Send + core[6883ba1bc0fe4ed1]::marker::Sync> as core[6883ba1bc0fe4ed1]::ops::function::Fn<(&std[73adb7dc35730857]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/alloc/src/boxed.rs:2333:9
[INFO] [stdout]   14:     0x5bfe63947322 - std[73adb7dc35730857]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/panicking.rs:823:13
[INFO] [stdout]   15:     0x5bfe6392b792 - std[73adb7dc35730857]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/panicking.rs:688:13
[INFO] [stdout]   16:     0x5bfe63922779 - std[73adb7dc35730857]::sys::backtrace::__rust_end_short_backtrace::<std[73adb7dc35730857]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x5bfe6392c58d - __rustc[a7b7b02e776dd976]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/panicking.rs:679:5
[INFO] [stdout]   18:     0x5bfe6396871c - core[6883ba1bc0fe4ed1]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x5bfe6259840c - eval[4481c30b87a57d36]::eval_cli_runs_forward_max_return_target
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/eval.rs:1066:5
[INFO] [stdout]   20:     0x5bfe6258fa17 - eval[4481c30b87a57d36]::eval_cli_runs_forward_max_return_target::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/eval.rs:1019:45
[INFO] [stdout]   21:     0x5bfe625afe16 - <eval[4481c30b87a57d36]::eval_cli_runs_forward_max_return_target::{closure#0} as core[6883ba1bc0fe4ed1]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   22:     0x5bfe625bf52b - <fn() -> core[6883ba1bc0fe4ed1]::result::Result<(), alloc[55a36b64bcbf2c0d]::string::String> as core[6883ba1bc0fe4ed1]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   23:     0x5bfe625bf52b - test[980ffaebd391d06d]::__rust_begin_short_backtrace::<core[6883ba1bc0fe4ed1]::result::Result<(), alloc[55a36b64bcbf2c0d]::string::String>, fn() -> core[6883ba1bc0fe4ed1]::result::Result<(), alloc[55a36b64bcbf2c0d]::string::String>>
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/test/src/lib.rs:724:18
[INFO] [stdout]   24:     0x5bfe625ccb75 - test[980ffaebd391d06d]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/test/src/lib.rs:747:74
[INFO] [stdout]   25:     0x5bfe625ccb75 - <core[6883ba1bc0fe4ed1]::panic::unwind_safe::AssertUnwindSafe<test[980ffaebd391d06d]::run_test_in_process::{closure#0}> as core[6883ba1bc0fe4ed1]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   26:     0x5bfe625ccb75 - std[73adb7dc35730857]::panicking::catch_unwind::do_call::<core[6883ba1bc0fe4ed1]::panic::unwind_safe::AssertUnwindSafe<test[980ffaebd391d06d]::run_test_in_process::{closure#0}>, core[6883ba1bc0fe4ed1]::result::Result<(), alloc[55a36b64bcbf2c0d]::string::String>>
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/panicking.rs:576:43
[INFO] [stdout]   27:     0x5bfe625ccb75 - std[73adb7dc35730857]::panicking::catch_unwind::<core[6883ba1bc0fe4ed1]::result::Result<(), alloc[55a36b64bcbf2c0d]::string::String>, core[6883ba1bc0fe4ed1]::panic::unwind_safe::AssertUnwindSafe<test[980ffaebd391d06d]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/panicking.rs:544:19
[INFO] [stdout]   28:     0x5bfe625ccb75 - std[73adb7dc35730857]::panic::catch_unwind::<core[6883ba1bc0fe4ed1]::panic::unwind_safe::AssertUnwindSafe<test[980ffaebd391d06d]::run_test_in_process::{closure#0}>, core[6883ba1bc0fe4ed1]::result::Result<(), alloc[55a36b64bcbf2c0d]::string::String>>
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/panic.rs:359:14
[INFO] [stdout]   29:     0x5bfe625ccb75 - test[980ffaebd391d06d]::run_test_in_process
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/test/src/lib.rs:747:27
[INFO] [stdout]   30:     0x5bfe625ccb75 - test[980ffaebd391d06d]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/test/src/lib.rs:668:43
[INFO] [stdout]   31:     0x5bfe625c7624 - test[980ffaebd391d06d]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/test/src/lib.rs:698:41
[INFO] [stdout]   32:     0x5bfe625c7624 - std[73adb7dc35730857]::sys::backtrace::__rust_begin_short_backtrace::<test[980ffaebd391d06d]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   33:     0x5bfe625cfcc2 - std[73adb7dc35730857]::thread::lifecycle::spawn_unchecked::<test[980ffaebd391d06d]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/thread/lifecycle.rs:70:13
[INFO] [stdout]   34:     0x5bfe625cfcc2 - <core[6883ba1bc0fe4ed1]::panic::unwind_safe::AssertUnwindSafe<std[73adb7dc35730857]::thread::lifecycle::spawn_unchecked<test[980ffaebd391d06d]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[6883ba1bc0fe4ed1]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   35:     0x5bfe625cfcc2 - std[73adb7dc35730857]::panicking::catch_unwind::do_call::<core[6883ba1bc0fe4ed1]::panic::unwind_safe::AssertUnwindSafe<std[73adb7dc35730857]::thread::lifecycle::spawn_unchecked<test[980ffaebd391d06d]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/panicking.rs:576:43
[INFO] [stdout]   36:     0x5bfe625cfcc2 - std[73adb7dc35730857]::panicking::catch_unwind::<(), core[6883ba1bc0fe4ed1]::panic::unwind_safe::AssertUnwindSafe<std[73adb7dc35730857]::thread::lifecycle::spawn_unchecked<test[980ffaebd391d06d]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/panicking.rs:544:19
[INFO] [stdout]   37:     0x5bfe625cfcc2 - std[73adb7dc35730857]::panic::catch_unwind::<core[6883ba1bc0fe4ed1]::panic::unwind_safe::AssertUnwindSafe<std[73adb7dc35730857]::thread::lifecycle::spawn_unchecked<test[980ffaebd391d06d]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/panic.rs:359:14
[INFO] [stdout]   38:     0x5bfe625cfcc2 - std[73adb7dc35730857]::thread::lifecycle::spawn_unchecked::<test[980ffaebd391d06d]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/thread/lifecycle.rs:68:26
[INFO] [stdout]   39:     0x5bfe625cfcc2 - <std[73adb7dc35730857]::thread::lifecycle::spawn_unchecked<test[980ffaebd391d06d]::run_test::{closure#1}, ()>::{closure#1} as core[6883ba1bc0fe4ed1]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   40:     0x5bfe6394f41f - <alloc[55a36b64bcbf2c0d]::boxed::Box<dyn core[6883ba1bc0fe4ed1]::ops::function::FnOnce<(), Output = ()> + core[6883ba1bc0fe4ed1]::marker::Send> as core[6883ba1bc0fe4ed1]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/alloc/src/boxed.rs:2319:9
[INFO] [stdout]   41:     0x5bfe6394f41f - <std[73adb7dc35730857]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/sys/thread/unix.rs:123:17
[INFO] [stdout]   42:     0x73d5df48aaa4 - <unknown>
[INFO] [stdout]   43:     0x73d5df517a64 - clone
[INFO] [stdout]   44:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     eval_cli_runs_forward_max_return_target
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 21 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.21s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass `--test eval`
[INFO] running `Command { std: "docker" "inspect" "a6b867b6f74b389beb32ab854cd6e80a7ace963679205b52525bb85e9ece1982", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "a6b867b6f74b389beb32ab854cd6e80a7ace963679205b52525bb85e9ece1982", kill_on_drop: false }`
[INFO] [stdout] a6b867b6f74b389beb32ab854cd6e80a7ace963679205b52525bb85e9ece1982
