reads_test: open dir="../data/social_media_data_1m" secs=3600 target_rps=100000 wal_only_recovery=false threads=32 configured_threads=32 max_threads=32 auto_safe_laptop_mode=false nodes=4 partitions=8 mix_profile=default alternating_schedule=60s_easy_then_60s_heavy_random_then_60s_heavy_random_queries warmup_mode=none warmup_secs=30 warmup_budget_mb=1024 max_ram_mb=8192 page_cache_mb=4915 index_cache_mb=2048 runtime_reserve_mb=1228 cpu_percent=100
reads_test: startup phase=db_open elapsed=9461ms process_start_to_engine_open_start_ms=0 configured_node_open_parallelism=4 configured_partition_open_parallelism=8 configured_total_open_budget=32 node_open_total_wall_ms=604 node_open_sum_ms=2398 node_open_max_ms=603 node_open_p50_ms=599 node_open_p95_ms=599 peak_parallel_node_opens=4 partition_open_total_wall_ms=2361 partition_open_sum_ms=17895 partition_open_max_ms=599 partition_open_p50_ms=561 partition_open_p95_ms=588 peak_parallel_partition_opens=8 peak_parallel_partition_opens_per_node=8 peak_parallel_partition_opens_global=32 active_partition_open_workers=0 bytes_read_during_open=685700790 files_opened_during_open=192 dbms_open_ms=8855
reads_test: startup node node_id=0 partition_id=all open_start_offset_ms=0 metadata_open_ms=4 manifest_load_ms=0 manifest_open_ms=0 manifest_decode_ms=0 lock_acquire_ms=0 checkpoint_load_ms=0 free_list_recovery_ms=0 worker_spawn_ms=0 pager_open_ms=0 page_file_open_ms=0 wal_open_ms=7 wal_scan_ms=0 wal_replay_ms=1217 table_registry_ms=0 table_discovery_ms=0 background_recovery_wait_ms=0 total_open_ms=603 partition_open_total_wall_ms=599 partition_open_sum_ms=4444 partition_open_max_ms=599 partition_open_p50_ms=559 partition_open_p95_ms=592 configured_partition_open_parallelism=8 active_partition_open_workers=0 peak_parallel_partition_opens=8 peak_parallel_partition_opens_global=32 bytes_read_during_open=171673526 files_opened_during_open=48
reads_test: startup partition node_id=0 partition_id=0 open_start_offset_ms=0 metadata_open_ms=0 manifest_load_ms=500 manifest_open_ms=0 manifest_decode_ms=0 lock_acquire_ms=0 checkpoint_load_ms=0 free_list_recovery_ms=0 worker_spawn_ms=0 pager_open_ms=0 page_file_open_ms=0 wal_open_ms=1 wal_scan_ms=0 wal_replay_ms=156 table_registry_ms=0 table_discovery_ms=0 background_recovery_wait_ms=0 total_open_ms=549 bytes_read_during_open=21371997 files_opened_during_open=6
reads_test: startup partition node_id=0 partition_id=1 open_start_offset_ms=0 metadata_open_ms=0 manifest_load_ms=542 manifest_open_ms=0 manifest_decode_ms=0 lock_acquire_ms=0 checkpoint_load_ms=0 free_list_recovery_ms=0 worker_spawn_ms=0 pager_open_ms=0 page_file_open_ms=0 wal_open_ms=1 wal_scan_ms=0 wal_replay_ms=168 table_registry_ms=0 table_discovery_ms=0 background_recovery_wait_ms=0 total_open_ms=577 bytes_read_during_open=21310099 files_opened_during_open=6
reads_test: startup partition node_id=0 partition_id=2 open_start_offset_ms=0 metadata_open_ms=0 manifest_load_ms=427 manifest_open_ms=0 manifest_decode_ms=0 lock_acquire_ms=0 checkpoint_load_ms=0 free_list_recovery_ms=0 worker_spawn_ms=0 pager_open_ms=0 page_file_open_ms=0 wal_open_ms=1 wal_scan_ms=0 wal_replay_ms=141 table_registry_ms=0 table_discovery_ms=0 background_recovery_wait_ms=0 total_open_ms=454 bytes_read_during_open=21405931 files_opened_during_open=6
reads_test: startup partition node_id=0 partition_id=3 open_start_offset_ms=0 metadata_open_ms=0 manifest_load_ms=572 manifest_open_ms=0 manifest_decode_ms=0 lock_acquire_ms=0 checkpoint_load_ms=0 free_list_recovery_ms=0 worker_spawn_ms=0 pager_open_ms=0 page_file_open_ms=0 wal_open_ms=0 wal_scan_ms=0 wal_replay_ms=145 table_registry_ms=0 table_discovery_ms=0 background_recovery_wait_ms=0 total_open_ms=592 bytes_read_during_open=21428582 files_opened_during_open=6
reads_test: startup partition node_id=0 partition_id=4 open_start_offset_ms=0 metadata_open_ms=0 manifest_load_ms=507 manifest_open_ms=0 manifest_decode_ms=0 lock_acquire_ms=0 checkpoint_load_ms=0 free_list_recovery_ms=0 worker_spawn_ms=0 pager_open_ms=0 page_file_open_ms=0 wal_open_ms=1 wal_scan_ms=0 wal_replay_ms=142 table_registry_ms=0 table_discovery_ms=0 background_recovery_wait_ms=0 total_open_ms=559 bytes_read_during_open=21479783 files_opened_during_open=6
reads_test: startup partition node_id=0 partition_id=5 open_start_offset_ms=0 metadata_open_ms=0 manifest_load_ms=488 manifest_open_ms=0 manifest_decode_ms=0 lock_acquire_ms=0 checkpoint_load_ms=0 free_list_recovery_ms=0 worker_spawn_ms=0 pager_open_ms=0 page_file_open_ms=0 wal_open_ms=1 wal_scan_ms=0 wal_replay_ms=140 table_registry_ms=0 table_discovery_ms=0 background_recovery_wait_ms=0 total_open_ms=553 bytes_read_during_open=21651896 files_opened_during_open=6
reads_test: startup partition node_id=0 partition_id=6 open_start_offset_ms=0 metadata_open_ms=0 manifest_load_ms=576 manifest_open_ms=0 manifest_decode_ms=0 lock_acquire_ms=0 checkpoint_load_ms=0 free_list_recovery_ms=0 worker_spawn_ms=0 pager_open_ms=0 page_file_open_ms=0 wal_open_ms=1 wal_scan_ms=0 wal_replay_ms=140 table_registry_ms=0 table_discovery_ms=0 background_recovery_wait_ms=0 total_open_ms=599 bytes_read_during_open=21516266 files_opened_during_open=6
reads_test: startup partition node_id=0 partition_id=7 open_start_offset_ms=0 metadata_open_ms=0 manifest_load_ms=508 manifest_open_ms=0 manifest_decode_ms=0 lock_acquire_ms=0 checkpoint_load_ms=0 free_list_recovery_ms=0 worker_spawn_ms=0 pager_open_ms=0 page_file_open_ms=0 wal_open_ms=1 wal_scan_ms=0 wal_replay_ms=185 table_registry_ms=0 table_discovery_ms=0 background_recovery_wait_ms=0 total_open_ms=561 bytes_read_during_open=21508972 files_opened_during_open=6
reads_test: startup node node_id=1 partition_id=all open_start_offset_ms=0 metadata_open_ms=10 manifest_load_ms=0 manifest_open_ms=0 manifest_decode_ms=0 lock_acquire_ms=0 checkpoint_load_ms=0 free_list_recovery_ms=0 worker_spawn_ms=0 pager_open_ms=0 page_file_open_ms=0 wal_open_ms=7 wal_scan_ms=0 wal_replay_ms=1227 table_registry_ms=0 table_discovery_ms=0 background_recovery_wait_ms=0 total_open_ms=597 partition_open_total_wall_ms=587 partition_open_sum_ms=4473 partition_open_max_ms=586 partition_open_p50_ms=551 partition_open_p95_ms=582 configured_partition_open_parallelism=8 active_partition_open_workers=0 peak_parallel_partition_opens=8 peak_parallel_partition_opens_global=32 bytes_read_during_open=171108518 files_opened_during_open=48
reads_test: startup partition node_id=1 partition_id=0 open_start_offset_ms=0 metadata_open_ms=0 manifest_load_ms=483 manifest_open_ms=0 manifest_decode_ms=0 lock_acquire_ms=0 checkpoint_load_ms=0 free_list_recovery_ms=0 worker_spawn_ms=0 pager_open_ms=0 page_file_open_ms=0 wal_open_ms=1 wal_scan_ms=0 wal_replay_ms=159 table_registry_ms=0 table_discovery_ms=0 background_recovery_wait_ms=0 total_open_ms=572 bytes_read_during_open=21428690 files_opened_during_open=6
reads_test: startup partition node_id=1 partition_id=1 open_start_offset_ms=0 metadata_open_ms=0 manifest_load_ms=553 manifest_open_ms=0 manifest_decode_ms=0 lock_acquire_ms=0 checkpoint_load_ms=0 free_list_recovery_ms=0 worker_spawn_ms=0 pager_open_ms=0 page_file_open_ms=0 wal_open_ms=0 wal_scan_ms=0 wal_replay_ms=178 table_registry_ms=0 table_discovery_ms=0 background_recovery_wait_ms=0 total_open_ms=586 bytes_read_during_open=21444365 files_opened_during_open=6
reads_test: startup partition node_id=1 partition_id=2 open_start_offset_ms=0 metadata_open_ms=0 manifest_load_ms=501 manifest_open_ms=0 manifest_decode_ms=0 lock_acquire_ms=0 checkpoint_load_ms=0 free_list_recovery_ms=0 worker_spawn_ms=0 pager_open_ms=0 page_file_open_ms=0 wal_open_ms=1 wal_scan_ms=0 wal_replay_ms=138 table_registry_ms=0 table_discovery_ms=0 background_recovery_wait_ms=0 total_open_ms=548 bytes_read_during_open=21481810 files_opened_during_open=6
reads_test: startup partition node_id=1 partition_id=3 open_start_offset_ms=0 metadata_open_ms=0 manifest_load_ms=542 manifest_open_ms=0 manifest_decode_ms=0 lock_acquire_ms=0 checkpoint_load_ms=0 free_list_recovery_ms=0 worker_spawn_ms=0 pager_open_ms=0 page_file_open_ms=0 wal_open_ms=1 wal_scan_ms=0 wal_replay_ms=158 table_registry_ms=0 table_discovery_ms=0 background_recovery_wait_ms=0 total_open_ms=582 bytes_read_during_open=21397981 files_opened_during_open=6
reads_test: startup partition node_id=1 partition_id=4 open_start_offset_ms=0 metadata_open_ms=0 manifest_load_ms=456 manifest_open_ms=0 manifest_decode_ms=0 lock_acquire_ms=0 checkpoint_load_ms=0 free_list_recovery_ms=0 worker_spawn_ms=0 pager_open_ms=0 page_file_open_ms=0 wal_open_ms=1 wal_scan_ms=0 wal_replay_ms=149 table_registry_ms=0 table_discovery_ms=0 background_recovery_wait_ms=0 total_open_ms=540 bytes_read_during_open=21192146 files_opened_during_open=6
reads_test: startup partition node_id=1 partition_id=5 open_start_offset_ms=0 metadata_open_ms=0 manifest_load_ms=529 manifest_open_ms=0 manifest_decode_ms=0 lock_acquire_ms=0 checkpoint_load_ms=0 free_list_recovery_ms=0 worker_spawn_ms=0 pager_open_ms=0 page_file_open_ms=0 wal_open_ms=1 wal_scan_ms=0 wal_replay_ms=146 table_registry_ms=0 table_discovery_ms=0 background_recovery_wait_ms=0 total_open_ms=576 bytes_read_during_open=21349099 files_opened_during_open=6
reads_test: startup partition node_id=1 partition_id=6 open_start_offset_ms=0 metadata_open_ms=0 manifest_load_ms=435 manifest_open_ms=0 manifest_decode_ms=0 lock_acquire_ms=0 checkpoint_load_ms=0 free_list_recovery_ms=0 worker_spawn_ms=0 pager_open_ms=0 page_file_open_ms=0 wal_open_ms=1 wal_scan_ms=0 wal_replay_ms=139 table_registry_ms=0 table_discovery_ms=0 background_recovery_wait_ms=0 total_open_ms=518 bytes_read_during_open=21299381 files_opened_during_open=6
reads_test: startup partition node_id=1 partition_id=7 open_start_offset_ms=0 metadata_open_ms=0 manifest_load_ms=480 manifest_open_ms=0 manifest_decode_ms=0 lock_acquire_ms=0 checkpoint_load_ms=0 free_list_recovery_ms=0 worker_spawn_ms=0 pager_open_ms=0 page_file_open_ms=0 wal_open_ms=1 wal_scan_ms=0 wal_replay_ms=160 table_registry_ms=0 table_discovery_ms=0 background_recovery_wait_ms=0 total_open_ms=551 bytes_read_during_open=21515046 files_opened_during_open=6
reads_test: startup node node_id=2 partition_id=all open_start_offset_ms=0 metadata_open_ms=10 manifest_load_ms=0 manifest_open_ms=0 manifest_decode_ms=0 lock_acquire_ms=2 checkpoint_load_ms=0 free_list_recovery_ms=0 worker_spawn_ms=0 pager_open_ms=0 page_file_open_ms=0 wal_open_ms=9 wal_scan_ms=2 wal_replay_ms=1212 table_registry_ms=0 table_discovery_ms=0 background_recovery_wait_ms=0 total_open_ms=599 partition_open_total_wall_ms=589 partition_open_sum_ms=4422 partition_open_max_ms=588 partition_open_p50_ms=557 partition_open_p95_ms=585 configured_partition_open_parallelism=8 active_partition_open_workers=0 peak_parallel_partition_opens=8 peak_parallel_partition_opens_global=32 bytes_read_during_open=170887167 files_opened_during_open=48
reads_test: startup partition node_id=2 partition_id=0 open_start_offset_ms=0 metadata_open_ms=0 manifest_load_ms=515 manifest_open_ms=0 manifest_decode_ms=0 lock_acquire_ms=0 checkpoint_load_ms=0 free_list_recovery_ms=0 worker_spawn_ms=0 pager_open_ms=0 page_file_open_ms=0 wal_open_ms=1 wal_scan_ms=0 wal_replay_ms=160 table_registry_ms=0 table_discovery_ms=0 background_recovery_wait_ms=0 total_open_ms=585 bytes_read_during_open=21343614 files_opened_during_open=6
reads_test: startup partition node_id=2 partition_id=1 open_start_offset_ms=0 metadata_open_ms=0 manifest_load_ms=558 manifest_open_ms=0 manifest_decode_ms=0 lock_acquire_ms=0 checkpoint_load_ms=0 free_list_recovery_ms=0 worker_spawn_ms=0 pager_open_ms=0 page_file_open_ms=0 wal_open_ms=1 wal_scan_ms=0 wal_replay_ms=170 table_registry_ms=0 table_discovery_ms=0 background_recovery_wait_ms=0 total_open_ms=588 bytes_read_during_open=21495490 files_opened_during_open=6
reads_test: startup partition node_id=2 partition_id=2 open_start_offset_ms=0 metadata_open_ms=0 manifest_load_ms=464 manifest_open_ms=0 manifest_decode_ms=0 lock_acquire_ms=0 checkpoint_load_ms=0 free_list_recovery_ms=0 worker_spawn_ms=0 pager_open_ms=0 page_file_open_ms=0 wal_open_ms=1 wal_scan_ms=0 wal_replay_ms=129 table_registry_ms=0 table_discovery_ms=0 background_recovery_wait_ms=0 total_open_ms=557 bytes_read_during_open=21318423 files_opened_during_open=6
reads_test: startup partition node_id=2 partition_id=3 open_start_offset_ms=0 metadata_open_ms=0 manifest_load_ms=445 manifest_open_ms=0 manifest_decode_ms=0 lock_acquire_ms=1 checkpoint_load_ms=0 free_list_recovery_ms=0 worker_spawn_ms=0 pager_open_ms=0 page_file_open_ms=0 wal_open_ms=2 wal_scan_ms=1 wal_replay_ms=133 table_registry_ms=0 table_discovery_ms=0 background_recovery_wait_ms=0 total_open_ms=540 bytes_read_during_open=21388441 files_opened_during_open=6
reads_test: startup partition node_id=2 partition_id=4 open_start_offset_ms=0 metadata_open_ms=0 manifest_load_ms=487 manifest_open_ms=0 manifest_decode_ms=0 lock_acquire_ms=0 checkpoint_load_ms=0 free_list_recovery_ms=0 worker_spawn_ms=0 pager_open_ms=0 page_file_open_ms=0 wal_open_ms=1 wal_scan_ms=0 wal_replay_ms=153 table_registry_ms=0 table_discovery_ms=0 background_recovery_wait_ms=0 total_open_ms=560 bytes_read_during_open=21263209 files_opened_during_open=6
reads_test: startup partition node_id=2 partition_id=5 open_start_offset_ms=0 metadata_open_ms=0 manifest_load_ms=508 manifest_open_ms=0 manifest_decode_ms=0 lock_acquire_ms=0 checkpoint_load_ms=0 free_list_recovery_ms=0 worker_spawn_ms=0 pager_open_ms=0 page_file_open_ms=0 wal_open_ms=1 wal_scan_ms=1 wal_replay_ms=143 table_registry_ms=0 table_discovery_ms=0 background_recovery_wait_ms=0 total_open_ms=561 bytes_read_during_open=21374600 files_opened_during_open=6
reads_test: startup partition node_id=2 partition_id=6 open_start_offset_ms=0 metadata_open_ms=0 manifest_load_ms=434 manifest_open_ms=0 manifest_decode_ms=0 lock_acquire_ms=0 checkpoint_load_ms=0 free_list_recovery_ms=0 worker_spawn_ms=0 pager_open_ms=0 page_file_open_ms=0 wal_open_ms=1 wal_scan_ms=0 wal_replay_ms=164 table_registry_ms=0 table_discovery_ms=0 background_recovery_wait_ms=0 total_open_ms=494 bytes_read_during_open=21336573 files_opened_during_open=6
reads_test: startup partition node_id=2 partition_id=7 open_start_offset_ms=0 metadata_open_ms=0 manifest_load_ms=492 manifest_open_ms=0 manifest_decode_ms=0 lock_acquire_ms=1 checkpoint_load_ms=0 free_list_recovery_ms=0 worker_spawn_ms=0 pager_open_ms=0 page_file_open_ms=0 wal_open_ms=1 wal_scan_ms=0 wal_replay_ms=160 table_registry_ms=0 table_discovery_ms=0 background_recovery_wait_ms=0 total_open_ms=537 bytes_read_during_open=21366817 files_opened_during_open=6
reads_test: startup node node_id=3 partition_id=all open_start_offset_ms=0 metadata_open_ms=13 manifest_load_ms=0 manifest_open_ms=0 manifest_decode_ms=0 lock_acquire_ms=1 checkpoint_load_ms=0 free_list_recovery_ms=0 worker_spawn_ms=0 pager_open_ms=0 page_file_open_ms=0 wal_open_ms=8 wal_scan_ms=0 wal_replay_ms=1157 table_registry_ms=0 table_discovery_ms=0 background_recovery_wait_ms=0 total_open_ms=599 partition_open_total_wall_ms=586 partition_open_sum_ms=4556 partition_open_max_ms=586 partition_open_p50_ms=574 partition_open_p95_ms=585 configured_partition_open_parallelism=8 active_partition_open_workers=0 peak_parallel_partition_opens=8 peak_parallel_partition_opens_global=32 bytes_read_during_open=172031579 files_opened_during_open=48
reads_test: startup partition node_id=3 partition_id=0 open_start_offset_ms=0 metadata_open_ms=0 manifest_load_ms=526 manifest_open_ms=0 manifest_decode_ms=0 lock_acquire_ms=0 checkpoint_load_ms=0 free_list_recovery_ms=0 worker_spawn_ms=0 pager_open_ms=0 page_file_open_ms=0 wal_open_ms=1 wal_scan_ms=0 wal_replay_ms=127 table_registry_ms=0 table_discovery_ms=0 background_recovery_wait_ms=0 total_open_ms=585 bytes_read_during_open=21423360 files_opened_during_open=6
reads_test: startup partition node_id=3 partition_id=1 open_start_offset_ms=0 metadata_open_ms=0 manifest_load_ms=522 manifest_open_ms=0 manifest_decode_ms=0 lock_acquire_ms=0 checkpoint_load_ms=0 free_list_recovery_ms=0 worker_spawn_ms=0 pager_open_ms=0 page_file_open_ms=0 wal_open_ms=1 wal_scan_ms=0 wal_replay_ms=155 table_registry_ms=0 table_discovery_ms=0 background_recovery_wait_ms=0 total_open_ms=574 bytes_read_during_open=21541818 files_opened_during_open=6
reads_test: startup partition node_id=3 partition_id=2 open_start_offset_ms=0 metadata_open_ms=0 manifest_load_ms=510 manifest_open_ms=0 manifest_decode_ms=0 lock_acquire_ms=0 checkpoint_load_ms=0 free_list_recovery_ms=0 worker_spawn_ms=0 pager_open_ms=0 page_file_open_ms=0 wal_open_ms=2 wal_scan_ms=0 wal_replay_ms=133 table_registry_ms=0 table_discovery_ms=0 background_recovery_wait_ms=0 total_open_ms=569 bytes_read_during_open=21494300 files_opened_during_open=6
reads_test: startup partition node_id=3 partition_id=3 open_start_offset_ms=0 metadata_open_ms=0 manifest_load_ms=496 manifest_open_ms=0 manifest_decode_ms=0 lock_acquire_ms=0 checkpoint_load_ms=0 free_list_recovery_ms=0 worker_spawn_ms=0 pager_open_ms=0 page_file_open_ms=0 wal_open_ms=1 wal_scan_ms=0 wal_replay_ms=129 table_registry_ms=0 table_discovery_ms=0 background_recovery_wait_ms=0 total_open_ms=575 bytes_read_during_open=21482683 files_opened_during_open=6
reads_test: startup partition node_id=3 partition_id=4 open_start_offset_ms=0 metadata_open_ms=0 manifest_load_ms=484 manifest_open_ms=0 manifest_decode_ms=0 lock_acquire_ms=0 checkpoint_load_ms=0 free_list_recovery_ms=0 worker_spawn_ms=0 pager_open_ms=0 page_file_open_ms=0 wal_open_ms=1 wal_scan_ms=0 wal_replay_ms=138 table_registry_ms=0 table_discovery_ms=0 background_recovery_wait_ms=0 total_open_ms=579 bytes_read_during_open=21420197 files_opened_during_open=6
reads_test: startup partition node_id=3 partition_id=5 open_start_offset_ms=0 metadata_open_ms=0 manifest_load_ms=461 manifest_open_ms=0 manifest_decode_ms=0 lock_acquire_ms=1 checkpoint_load_ms=0 free_list_recovery_ms=0 worker_spawn_ms=0 pager_open_ms=0 page_file_open_ms=0 wal_open_ms=0 wal_scan_ms=0 wal_replay_ms=166 table_registry_ms=0 table_discovery_ms=0 background_recovery_wait_ms=0 total_open_ms=525 bytes_read_during_open=21507275 files_opened_during_open=6
reads_test: startup partition node_id=3 partition_id=6 open_start_offset_ms=0 metadata_open_ms=0 manifest_load_ms=510 manifest_open_ms=0 manifest_decode_ms=0 lock_acquire_ms=0 checkpoint_load_ms=0 free_list_recovery_ms=0 worker_spawn_ms=0 pager_open_ms=0 page_file_open_ms=0 wal_open_ms=1 wal_scan_ms=0 wal_replay_ms=135 table_registry_ms=0 table_discovery_ms=0 background_recovery_wait_ms=0 total_open_ms=563 bytes_read_during_open=21597691 files_opened_during_open=6
reads_test: startup partition node_id=3 partition_id=7 open_start_offset_ms=0 metadata_open_ms=0 manifest_load_ms=529 manifest_open_ms=0 manifest_decode_ms=0 lock_acquire_ms=0 checkpoint_load_ms=0 free_list_recovery_ms=0 worker_spawn_ms=0 pager_open_ms=0 page_file_open_ms=0 wal_open_ms=1 wal_scan_ms=0 wal_replay_ms=174 table_registry_ms=0 table_discovery_ms=0 background_recovery_wait_ms=0 total_open_ms=586 bytes_read_during_open=21564255 files_opened_during_open=6
reads_test: startup phase=metadata_loading elapsed=1ms checkpoint_lsn=0 replayed_lsn=3921
reads_test: startup phase=catalog elapsed=1ms
reads_test: startup phase=index_recovery elapsed=8849ms
reads_test: live_read_ready=true finalized_ready=false state=READ_READY mutation_log_unsynced_bytes=0 checkpoint_durable_for_reopen=false catalog_ready=true primary_ready=true wal_replay_complete=true checkpoint_lsn=0 durable_lsn=0 replayed_lsn=3921 wal_replay_ms=156 metadata_load_ms=293 pending_index_mutations=0 secondary_pending_mutations=0 text_pending_mutations=0 mutation_apply_rate=687984 estimated_seconds_remaining=0 index_overlay_queryable=true index_segments_queryable=true secondary_ready=true text_ready=true reason=none
reads_test: checkpoint_reopen checkpoint_reopen_candidate_count=0 checkpoint_selected_lsn=0 checkpoint_rejected_reason=checkpoint_lsn_zero wal_bytes_skipped_by_checkpoint=0 index_log_bytes_skipped_by_checkpoint=636881105
reads_test: readiness_milestones primary_recovered_at_ms=3549 catalog_ready_at_ms=3549 primary_logical_view_ready_at_ms=3549 manifest_valid_at_ms=3549 wal_replay_complete_at_ms=3549 index_overlay_queryable_at_ms=3549 index_segments_queryable_at_ms=3549 secondary_ready_at_ms=3549 text_ready_at_ms=3549 read_ready_at_ms=3549 write_ready_at_ms=0
reads_test: readiness_transition state=OPENING at_ms=0 blocking_reasons=none
reads_test: readiness_transition state=READ_READY at_ms=3549 blocking_reasons=checkpoint_not_durable latest_lsn=3921 durable_lsn=0 page_durable_lsn=0 manifest_durable_lsn=0 truncate_lsn=0 doc_store_durable_lsn=0
reads_test: recovery_complete database_open_ms=8851 dbms_open_ms=8855 metadata_loading_ms=293 wal_replay_ms=156 catalog_recovery_ms=1 lsm_index_open_ms=8849 readiness_wait_ms=3 recovery_complete_ms=13012
reads_test: lsm_startup directory_scan_ms=0 manifest_read_ms=0 manifest_parse_ms=0 manifest_deserialize_ms=0 manifest_validation_ms=0 table_discovery_ms=0 table_open_wall_ms=8 table_open_sum_ms=26 index_open_parallelism=4 peak_parallel_index_opens=4 lsm_open_worker_count=4 index_open_queue_wait_ms=0 table_open_result_lock_wait_ms=0 segment_file_discovery_ms=0 segment_file_open_ms=0 segment_header_read_ms=0 segment_metadata_read_ms=18 segment_metadata_deserialize_ms=11 segment_validation_ms=0 segment_index_load_ms=0 segment_checksum_ms=0 mutation_log_open_ms=0 mutation_log_scan_ms=8227 mutation_log_decode_ms=137 mutation_log_filter_ms=0 mutation_log_replay_ms=8364 mutation_dispatch_ms=4 mutation_dispatch_backpressure_ms=0 mutation_apply_wall_ms=8689 mutation_apply_cpu_ms=93 mutation_enqueue_ms=89 checkpoint_manifest_ms=0 pending_queue_reconstruction_ms=89 pending_queue_snapshot_ms=0 final_index_registration_ms=0 lag_metric_refresh_ms=35 compaction_metric_refresh_ms=0 worker_spawn_ms=6 aggregate_index_open_ms=26 index_open_wall_ms=8 total_measured_substage_ms=8531 total_index_open_wall_ms=8848 unaccounted_open_ms=317 index_tables=4 secondary_tables=4 text_tables=0 segment_count=4 secondary_segment_count=4 text_segment_count=0 pending_queue_items=2000000 segment_metadata_bytes_read=9380806 segment_data_bytes_read=0 mutation_log_bytes=636881105 mutation_log_first_lsn=1 mutation_log_last_lsn=2000000 mutation_records=2000000 mutation_records_decoded=2000000 mutation_records_scanned=2000000 mutation_records_below_floor=0 mutation_records_replayed=2000000 replayed_mutations=2000000 skipped_durable_mutations=0 files_opened=8 filesystem_metadata_calls=8 manifest_replay_floor_lsn=0 mutation_replay_floor_lsn=0 mutation_reclaimable_through_lsn=0 mutation_reclaimed_lsn=0 mutation_reclaimed_through_lsn=0 replay_floor_rejected_reason=legacy_manifest_missing_replay_floor
reads_test: lsm_startup_index metric=index_open[table=10119546700238933226,kind=secondary].segment_count value=1
reads_test: lsm_startup_index metric=index_open[table=10119546700238933226,kind=secondary].segment_file_discovery_ms value=0
reads_test: lsm_startup_index metric=index_open[table=10119546700238933226,kind=secondary].segment_file_open_ms value=0
reads_test: lsm_startup_index metric=index_open[table=10119546700238933226,kind=secondary].segment_header_read_ms value=0
reads_test: lsm_startup_index metric=index_open[table=10119546700238933226,kind=secondary].segment_metadata_read_ms value=4
reads_test: lsm_startup_index metric=index_open[table=10119546700238933226,kind=secondary].segment_metadata_deserialize_ms value=2
reads_test: lsm_startup_index metric=index_open[table=10119546700238933226,kind=secondary].segment_validation_ms value=0
reads_test: lsm_startup_index metric=index_open[table=10119546700238933226,kind=secondary].segment_metadata_bytes_read value=2097461
reads_test: lsm_startup_index metric=index_open[table=10119546700238933226,kind=secondary].segment_data_bytes_read value=0
reads_test: lsm_startup_index metric=index_open[table=10119546700238933226,kind=secondary].files_opened value=2
reads_test: lsm_startup_index metric=index_open[table=10119546700238933226,kind=secondary].filesystem_metadata_calls value=2
reads_test: lsm_startup_index metric=index_open[table=10119546700238933226,kind=secondary].total_open_ms value=5
reads_test: lsm_startup_index metric=index_open[table=11012616926180838204,kind=secondary].segment_count value=1
reads_test: lsm_startup_index metric=index_open[table=11012616926180838204,kind=secondary].segment_file_discovery_ms value=0
reads_test: lsm_startup_index metric=index_open[table=11012616926180838204,kind=secondary].segment_file_open_ms value=0
reads_test: lsm_startup_index metric=index_open[table=11012616926180838204,kind=secondary].segment_header_read_ms value=0
reads_test: lsm_startup_index metric=index_open[table=11012616926180838204,kind=secondary].segment_metadata_read_ms value=4
reads_test: lsm_startup_index metric=index_open[table=11012616926180838204,kind=secondary].segment_metadata_deserialize_ms value=3
reads_test: lsm_startup_index metric=index_open[table=11012616926180838204,kind=secondary].segment_validation_ms value=0
reads_test: lsm_startup_index metric=index_open[table=11012616926180838204,kind=secondary].segment_metadata_bytes_read value=2097460
reads_test: lsm_startup_index metric=index_open[table=11012616926180838204,kind=secondary].segment_data_bytes_read value=0
reads_test: lsm_startup_index metric=index_open[table=11012616926180838204,kind=secondary].files_opened value=2
reads_test: lsm_startup_index metric=index_open[table=11012616926180838204,kind=secondary].filesystem_metadata_calls value=2
reads_test: lsm_startup_index metric=index_open[table=11012616926180838204,kind=secondary].total_open_ms value=5
reads_test: lsm_startup_index metric=index_open[table=16226151855454274167,kind=secondary].segment_count value=1
reads_test: lsm_startup_index metric=index_open[table=16226151855454274167,kind=secondary].segment_file_discovery_ms value=0
reads_test: lsm_startup_index metric=index_open[table=16226151855454274167,kind=secondary].segment_file_open_ms value=0
reads_test: lsm_startup_index metric=index_open[table=16226151855454274167,kind=secondary].segment_header_read_ms value=0
reads_test: lsm_startup_index metric=index_open[table=16226151855454274167,kind=secondary].segment_metadata_read_ms value=5
reads_test: lsm_startup_index metric=index_open[table=16226151855454274167,kind=secondary].segment_metadata_deserialize_ms value=3
reads_test: lsm_startup_index metric=index_open[table=16226151855454274167,kind=secondary].segment_validation_ms value=0
reads_test: lsm_startup_index metric=index_open[table=16226151855454274167,kind=secondary].segment_metadata_bytes_read value=2593184
reads_test: lsm_startup_index metric=index_open[table=16226151855454274167,kind=secondary].segment_data_bytes_read value=0
reads_test: lsm_startup_index metric=index_open[table=16226151855454274167,kind=secondary].files_opened value=2
reads_test: lsm_startup_index metric=index_open[table=16226151855454274167,kind=secondary].filesystem_metadata_calls value=2
reads_test: lsm_startup_index metric=index_open[table=16226151855454274167,kind=secondary].total_open_ms value=8
reads_test: lsm_startup_index metric=index_open[table=16686173826401613498,kind=secondary].segment_count value=1
reads_test: lsm_startup_index metric=index_open[table=16686173826401613498,kind=secondary].segment_file_discovery_ms value=0
reads_test: lsm_startup_index metric=index_open[table=16686173826401613498,kind=secondary].segment_file_open_ms value=0
reads_test: lsm_startup_index metric=index_open[table=16686173826401613498,kind=secondary].segment_header_read_ms value=0
reads_test: lsm_startup_index metric=index_open[table=16686173826401613498,kind=secondary].segment_metadata_read_ms value=5
reads_test: lsm_startup_index metric=index_open[table=16686173826401613498,kind=secondary].segment_metadata_deserialize_ms value=3
reads_test: lsm_startup_index metric=index_open[table=16686173826401613498,kind=secondary].segment_validation_ms value=0
reads_test: lsm_startup_index metric=index_open[table=16686173826401613498,kind=secondary].segment_metadata_bytes_read value=2592701
reads_test: lsm_startup_index metric=index_open[table=16686173826401613498,kind=secondary].segment_data_bytes_read value=0
reads_test: lsm_startup_index metric=index_open[table=16686173826401613498,kind=secondary].files_opened value=2
reads_test: lsm_startup_index metric=index_open[table=16686173826401613498,kind=secondary].filesystem_metadata_calls value=2
reads_test: lsm_startup_index metric=index_open[table=16686173826401613498,kind=secondary].total_open_ms value=8
reads_test: lsm_startup_index metric=index_open[table=9439953132510313430,kind=secondary].pending_queue_items value=17408
reads_test: lsm_startup_index metric=index_open[table=10119546700238933226,kind=secondary].pending_queue_items value=128832
reads_test: lsm_startup_index metric=index_open[table=10259209326019780659,kind=secondary].pending_queue_items value=37376
reads_test: lsm_startup_index metric=index_open[table=10985365512571037218,kind=text].pending_queue_items value=35584
reads_test: lsm_startup_index metric=index_open[table=11012616926180838204,kind=secondary].pending_queue_items value=159488
reads_test: lsm_startup_index metric=index_open[table=11541567270475786649,kind=text].pending_queue_items value=39424
reads_test: lsm_startup_index metric=index_open[table=11550115665377471388,kind=secondary].pending_queue_items value=18688
reads_test: lsm_startup_index metric=index_open[table=11624666970863252393,kind=text].pending_queue_items value=28416
reads_test: lsm_startup_index metric=index_open[table=12012921583409832537,kind=secondary].pending_queue_items value=92928
reads_test: lsm_startup_index metric=index_open[table=12148048740072246362,kind=secondary].pending_queue_items value=29952
reads_test: lsm_startup_index metric=index_open[table=12186598357780717984,kind=secondary].pending_queue_items value=107520
reads_test: lsm_startup_index metric=index_open[table=12264642885236927177,kind=secondary].pending_queue_items value=94720
reads_test: lsm_startup_index metric=index_open[table=12394143223024549877,kind=text].pending_queue_items value=73472
reads_test: lsm_startup_index metric=index_open[table=13385553692679020687,kind=text].pending_queue_items value=29952
reads_test: lsm_startup_index metric=index_open[table=13396455952142151395,kind=text].pending_queue_items value=94720
reads_test: lsm_startup_index metric=index_open[table=13592647167583057657,kind=text].pending_queue_items value=19200
reads_test: lsm_startup_index metric=index_open[table=14536805287048444545,kind=text].pending_queue_items value=37376
reads_test: lsm_startup_index metric=index_open[table=14723968795259990006,kind=secondary].pending_queue_items value=19200
reads_test: lsm_startup_index metric=index_open[table=14781325458063692334,kind=secondary].pending_queue_items value=73472
reads_test: lsm_startup_index metric=index_open[table=14847371417175498627,kind=text].pending_queue_items value=47360
reads_test: lsm_startup_index metric=index_open[table=15099530047237732152,kind=text].pending_queue_items value=107520
reads_test: lsm_startup_index metric=index_open[table=15136280116978783466,kind=secondary].pending_queue_items value=28416
reads_test: lsm_startup_index metric=index_open[table=15171684167501876840,kind=secondary].pending_queue_items value=35584
reads_test: lsm_startup_index metric=index_open[table=15732122262421685094,kind=text].pending_queue_items value=69632
reads_test: lsm_startup_index metric=index_open[table=16226151855454274167,kind=text].pending_queue_items value=159488
reads_test: lsm_startup_index metric=index_open[table=16686173826401613498,kind=text].pending_queue_items value=128832
reads_test: lsm_startup_index metric=index_open[table=16981693102598120030,kind=text].pending_queue_items value=92928
reads_test: lsm_startup_index metric=index_open[table=17058852451635836613,kind=secondary].pending_queue_items value=47360
reads_test: lsm_startup_index metric=index_open[table=17071434096260697490,kind=secondary].pending_queue_items value=39424
reads_test: lsm_startup_index metric=index_open[table=17433252396585107584,kind=text].pending_queue_items value=17408
reads_test: lsm_startup_index metric=index_open[table=17849424355206749180,kind=text].pending_queue_items value=18688
reads_test: lsm_startup_index metric=index_open[table=18304033360603962195,kind=secondary].pending_queue_items value=69632
reads_test: lsm_startup_index metric=index_open[table=9439953132510313430,kind=secondary].records_replayed value=17408
reads_test: lsm_startup_index metric=index_open[table=10119546700238933226,kind=secondary].records_replayed value=128832
reads_test: lsm_startup_index metric=index_open[table=10259209326019780659,kind=secondary].records_replayed value=37376
reads_test: lsm_startup_index metric=index_open[table=10985365512571037218,kind=text].records_replayed value=35584
reads_test: lsm_startup_index metric=index_open[table=11012616926180838204,kind=secondary].records_replayed value=159488
reads_test: lsm_startup_index metric=index_open[table=11541567270475786649,kind=text].records_replayed value=39424
reads_test: lsm_startup_index metric=index_open[table=11550115665377471388,kind=secondary].records_replayed value=18688
reads_test: lsm_startup_index metric=index_open[table=11624666970863252393,kind=text].records_replayed value=28416
reads_test: lsm_startup_index metric=index_open[table=12012921583409832537,kind=secondary].records_replayed value=92928
reads_test: lsm_startup_index metric=index_open[table=12148048740072246362,kind=secondary].records_replayed value=29952
reads_test: lsm_startup_index metric=index_open[table=12186598357780717984,kind=secondary].records_replayed value=107520
reads_test: lsm_startup_index metric=index_open[table=12264642885236927177,kind=secondary].records_replayed value=94720
reads_test: lsm_startup_index metric=index_open[table=12394143223024549877,kind=text].records_replayed value=73472
reads_test: lsm_startup_index metric=index_open[table=13385553692679020687,kind=text].records_replayed value=29952
reads_test: lsm_startup_index metric=index_open[table=13396455952142151395,kind=text].records_replayed value=94720
reads_test: lsm_startup_index metric=index_open[table=13592647167583057657,kind=text].records_replayed value=19200
reads_test: lsm_startup_index metric=index_open[table=14536805287048444545,kind=text].records_replayed value=37376
reads_test: lsm_startup_index metric=index_open[table=14723968795259990006,kind=secondary].records_replayed value=19200
reads_test: lsm_startup_index metric=index_open[table=14781325458063692334,kind=secondary].records_replayed value=73472
reads_test: lsm_startup_index metric=index_open[table=14847371417175498627,kind=text].records_replayed value=47360
reads_test: lsm_startup_index metric=index_open[table=15099530047237732152,kind=text].records_replayed value=107520
reads_test: lsm_startup_index metric=index_open[table=15136280116978783466,kind=secondary].records_replayed value=28416
reads_test: lsm_startup_index metric=index_open[table=15171684167501876840,kind=secondary].records_replayed value=35584
reads_test: lsm_startup_index metric=index_open[table=15732122262421685094,kind=text].records_replayed value=69632
reads_test: lsm_startup_index metric=index_open[table=16226151855454274167,kind=text].records_replayed value=159488
reads_test: lsm_startup_index metric=index_open[table=16686173826401613498,kind=text].records_replayed value=128832
reads_test: lsm_startup_index metric=index_open[table=16981693102598120030,kind=text].records_replayed value=92928
reads_test: lsm_startup_index metric=index_open[table=17058852451635836613,kind=secondary].records_replayed value=47360
reads_test: lsm_startup_index metric=index_open[table=17071434096260697490,kind=secondary].records_replayed value=39424
reads_test: lsm_startup_index metric=index_open[table=17433252396585107584,kind=text].records_replayed value=17408
reads_test: lsm_startup_index metric=index_open[table=17849424355206749180,kind=text].records_replayed value=18688
reads_test: lsm_startup_index metric=index_open[table=18304033360603962195,kind=secondary].records_replayed value=69632
reads_test: post_recovery phase=first_successful_query elapsed=0ms time_since_open=13018ms total_to_first_query_ms=13019
reads_test: post_recovery phase=startup_smoke_validation elapsed=1107ms
reads_test: post_recovery phase=full_validation elapsed=2041ms
reads_test: recovery summary process_start_to_engine_open_start_ms=0 node_open_total_wall_ms=604 node_open_sum_ms=2398 node_open_max_ms=603 partition_open_total_wall_ms=2361 partition_open_sum_ms=17895 partition_open_max_ms=599 database_open_ms=8851 dbms_open_ms=8855 lsm_index_open_ms=8849 catalog_restore_ms=1 readiness_wait_ms=3 metadata_loading_ms=293 wal_replay_ms=156 recovery_complete_ms=13012 time_to_first_successful_query_ms=13018 first_successful_query_ms=0 startup_smoke_validation_ms=1107 full_validation_ms=2041
reads_test: startup_smoke known_docs_checked=3 random_docs_checked=4 queries_executed=13 index_candidates=6 documents_hydrated=6 primary_lookup_ok=true secondary_eq_ok=true secondary_range_ok=true text_query_ok=true
reads_test: validation recovered_document_count=1000000 expected_document_count=1000000 known_docs_checked=3 random_docs_checked=4 primary_lookup_ok=true secondary_eq_ok=true secondary_range_ok=true text_query_ok=true not_found=0 corrupted=0 duplicates=0
reads_test: validation_metrics full_scans=16 documents_decoded=1000000 bytes_read=641686516 partitions_scanned=512 queries_executed=13 index_candidates=6 documents_hydrated=6 duplicate_tracking_memory=144 document_count_ms=1777 known_document_lookup_ms=0 random_document_lookup_ms=0 primary_correctness_ms=0 secondary_eq_ms=0 secondary_range_ms=0 text_query_ms=0 duplicate_detection_ms=1777 corruption_detection_ms=1777
reads_test: checkpoint_state writer_checkpoint_lsn=0 reopened_checkpoint_lsn=0 match=true
reads_test: post_recovery phase=samples elapsed=6ms
reads_test: startup_timeline process_start_to_engine_open_start_ms=0 node_open_total_wall_ms=604 node_open_sum_ms=2398 node_open_max_ms=603 partition_open_total_wall_ms=2361 partition_open_sum_ms=17895 partition_open_max_ms=599 dbms_open_ms=8855 lsm_index_open_ms=8849 catalog_restore_ms=1 readiness_wait_ms=3 first_query_ms=0 startup_smoke_validation_ms=1107 full_validation_ms=2041 samples_load_ms=6 warmup_ms=0 total_to_first_query_ms=9462 time_to_benchmark_ready_ms=16172 total_to_benchmark_start_ms=16180 read_ready_at_ms=3549 write_ready_at_ms=0
reads_test: benchmark_warmup elapsed=0ms mode=none completed=true primary_meta_bytes=0 index_meta_bytes=0 primary_ops=0 index_ops=0 est_bytes=0 stop_reason=warmup_disabled
reads_test: steady_state begin elapsed_since_open=16181ms recovery_complete_ms=13012 warmup_ms=0 warmup_mode=none
reads_test: find_many_counters queries=32586 candidates=814650 hydrated=814650 predicate_matches=814650 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=32586 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=0 empty_query_result=0
reads_test: find_many_counters queries=67845 candidates=1696125 hydrated=1696125 predicate_matches=1696125 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=67845 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=0 empty_query_result=0
reads_test: find_many_counters queries=103666 candidates=2591650 hydrated=2591650 predicate_matches=2591650 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=103666 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=0 empty_query_result=0
reads_test: find_many_counters queries=138785 candidates=3469625 hydrated=3469625 predicate_matches=3469625 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=138785 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=0 empty_query_result=0
reads_test: find_many_counters queries=173748 candidates=4343700 hydrated=4343700 predicate_matches=4343700 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=173748 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=0 empty_query_result=0
reads_test: find_many_counters queries=209050 candidates=5226250 hydrated=5226250 predicate_matches=5226250 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=209050 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=0 empty_query_result=0
reads_test: find_many_counters queries=244249 candidates=6106225 hydrated=6106225 predicate_matches=6106225 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=244249 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=0 empty_query_result=0
reads_test: find_many_counters queries=279494 candidates=6987350 hydrated=6987350 predicate_matches=6987350 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=279494 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=0 empty_query_result=0
reads_test: find_many_counters queries=314701 candidates=7867525 hydrated=7867525 predicate_matches=7867525 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=314701 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=0 empty_query_result=0
reads_test: find_many_counters queries=348770 candidates=8719250 hydrated=8719250 predicate_matches=8719250 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=348770 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=0 empty_query_result=0
reads_test: find_many_counters queries=383762 candidates=9594050 hydrated=9594050 predicate_matches=9594050 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=383762 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=0 empty_query_result=0
reads_test: find_many_counters queries=418951 candidates=10473775 hydrated=10473775 predicate_matches=10473775 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=418951 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=0 empty_query_result=0
reads_test: find_many_counters queries=466553 candidates=11663825 hydrated=11663825 predicate_matches=11663825 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=466553 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=0 empty_query_result=0
reads_test: find_many_counters queries=515083 candidates=12877075 hydrated=12877075 predicate_matches=12877075 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=515083 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=0 empty_query_result=0
reads_test: find_many_counters queries=562059 candidates=14051475 hydrated=14051475 predicate_matches=14051475 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=562059 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=0 empty_query_result=0
reads_test: find_many_counters queries=613221 candidates=15330525 hydrated=15330525 predicate_matches=15330525 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=613221 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=0 empty_query_result=0
reads_test: find_many_counters queries=661799 candidates=16544975 hydrated=16544975 predicate_matches=16544975 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=661799 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=0 empty_query_result=0
reads_test: find_many_counters queries=711435 candidates=17785875 hydrated=17785875 predicate_matches=17785875 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=711435 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=0 empty_query_result=0
reads_test: find_many_counters queries=760384 candidates=19009600 hydrated=19009600 predicate_matches=19009600 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=760384 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=0 empty_query_result=0
reads_test: find_many_counters queries=807564 candidates=20189100 hydrated=20189100 predicate_matches=20189100 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=807564 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=0 empty_query_result=0
reads_test: find_many_counters queries=857311 candidates=21432775 hydrated=21432775 predicate_matches=21432775 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=857311 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=0 empty_query_result=0
reads_test: find_many_counters queries=907780 candidates=22694500 hydrated=22694500 predicate_matches=22694500 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=907780 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=0 empty_query_result=0
reads_test: find_many_counters queries=958159 candidates=23953975 hydrated=23953975 predicate_matches=23953975 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=958159 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=0 empty_query_result=0
reads_test: find_many_counters queries=1007193 candidates=25179825 hydrated=25179825 predicate_matches=25179825 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=1007193 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=501 empty_query_result=501
reads_test: find_many_counters queries=1010952 candidates=25273800 hydrated=25273800 predicate_matches=25273800 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=1010952 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=17708 empty_query_result=17708
reads_test: find_many_counters queries=1014738 candidates=25368450 hydrated=25368450 predicate_matches=25368450 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=1014738 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=34874 empty_query_result=34874
reads_test: find_many_counters queries=1018495 candidates=25462375 hydrated=25462375 predicate_matches=25462375 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=1018495 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=51604 empty_query_result=51604
reads_test: find_many_counters queries=1022272 candidates=25556800 hydrated=25556800 predicate_matches=25556800 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=1022272 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=68488 empty_query_result=68488
reads_test: find_many_counters queries=1026040 candidates=25651000 hydrated=25651000 predicate_matches=25651000 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=1026040 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=85392 empty_query_result=85392
reads_test: find_many_counters queries=1029956 candidates=25748900 hydrated=25748900 predicate_matches=25748900 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=1029956 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=102566 empty_query_result=102566
reads_test: find_many_counters queries=1033495 candidates=25837375 hydrated=25837375 predicate_matches=25837375 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=1033495 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=118637 empty_query_result=118637
reads_test: find_many_counters queries=1037062 candidates=25926550 hydrated=25926550 predicate_matches=25926550 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=1037062 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=134567 empty_query_result=134567
reads_test: find_many_counters queries=1040663 candidates=26016575 hydrated=26016575 predicate_matches=26016575 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=1040663 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=150928 empty_query_result=150928
reads_test: find_many_counters queries=1044300 candidates=26107500 hydrated=26107500 predicate_matches=26107500 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=1044300 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=167201 empty_query_result=167201
reads_test: find_many_counters queries=1047893 candidates=26197325 hydrated=26197325 predicate_matches=26197325 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=1047893 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=183089 empty_query_result=183089
reads_test: find_many_counters queries=1052653 candidates=26316325 hydrated=26316325 predicate_matches=26316325 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=1052653 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=198517 empty_query_result=198517
reads_test: find_many_counters queries=1087935 candidates=27198375 hydrated=27198375 predicate_matches=27198375 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=1087935 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=198517 empty_query_result=198517
reads_test: find_many_counters queries=1123203 candidates=28080075 hydrated=28080075 predicate_matches=28080075 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=1123203 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=198517 empty_query_result=198517
reads_test: find_many_counters queries=1158306 candidates=28957650 hydrated=28957650 predicate_matches=28957650 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=1158306 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=198517 empty_query_result=198517
reads_test: find_many_counters queries=1193748 candidates=29843700 hydrated=29843700 predicate_matches=29843700 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=1193748 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=198517 empty_query_result=198517
reads_test: find_many_counters queries=1229050 candidates=30726250 hydrated=30726250 predicate_matches=30726250 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=1229050 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=198517 empty_query_result=198517
reads_test: find_many_counters queries=1264203 candidates=31605075 hydrated=31605075 predicate_matches=31605075 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=1264203 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=198517 empty_query_result=198517
reads_test: find_many_counters queries=1299495 candidates=32487375 hydrated=32487375 predicate_matches=32487375 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=1299495 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=198517 empty_query_result=198517
reads_test: find_many_counters queries=1334895 candidates=33372375 hydrated=33372375 predicate_matches=33372375 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=1334895 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=198517 empty_query_result=198517
reads_test: find_many_counters queries=1370563 candidates=34264075 hydrated=34264075 predicate_matches=34264075 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=1370563 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=198517 empty_query_result=198517
reads_test: find_many_counters queries=1406093 candidates=35152325 hydrated=35152325 predicate_matches=35152325 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=1406093 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=198517 empty_query_result=198517
reads_test: find_many_counters queries=1441465 candidates=36036625 hydrated=36036625 predicate_matches=36036625 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=1441465 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=198517 empty_query_result=198517
reads_test: find_many_counters queries=1477615 candidates=36940375 hydrated=36940375 predicate_matches=36940375 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=1477615 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=198517 empty_query_result=198517
reads_test: find_many_counters queries=1528058 candidates=38201450 hydrated=38201450 predicate_matches=38201450 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=1528058 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=198517 empty_query_result=198517
reads_test: find_many_counters queries=1579349 candidates=39483725 hydrated=39483725 predicate_matches=39483725 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=1579349 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=198517 empty_query_result=198517
reads_test: find_many_counters queries=1631265 candidates=40781625 hydrated=40781625 predicate_matches=40781625 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=1631265 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=198517 empty_query_result=198517
reads_test: find_many_counters queries=1682826 candidates=42070650 hydrated=42070650 predicate_matches=42070650 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=1682826 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=198517 empty_query_result=198517
reads_test: find_many_counters queries=1733674 candidates=43341850 hydrated=43341850 predicate_matches=43341850 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=1733674 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=198517 empty_query_result=198517
reads_test: find_many_counters queries=1784570 candidates=44614250 hydrated=44614250 predicate_matches=44614250 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=1784570 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=198517 empty_query_result=198517
reads_test: find_many_counters queries=1835141 candidates=45878525 hydrated=45878525 predicate_matches=45878525 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=1835141 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=198517 empty_query_result=198517
reads_test: find_many_counters queries=1885365 candidates=47134125 hydrated=47134125 predicate_matches=47134125 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=1885365 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=198517 empty_query_result=198517
reads_test: find_many_counters queries=1935911 candidates=48397775 hydrated=48397775 predicate_matches=48397775 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=1935911 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=198517 empty_query_result=198517
reads_test: find_many_counters queries=1986005 candidates=49650125 hydrated=49650125 predicate_matches=49650125 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=1986005 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=198517 empty_query_result=198517
reads_test: find_many_counters queries=2035826 candidates=50895650 hydrated=50895650 predicate_matches=50895650 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=2035826 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=198517 empty_query_result=198517
reads_test: find_many_counters queries=2083874 candidates=52096850 hydrated=52096850 predicate_matches=52096850 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=2083874 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=199646 empty_query_result=199646
reads_test: find_many_counters queries=2087547 candidates=52188675 hydrated=52188675 predicate_matches=52188675 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=2087547 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=216583 empty_query_result=216583
reads_test: find_many_counters queries=2091351 candidates=52283775 hydrated=52283775 predicate_matches=52283775 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=2091351 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=233434 empty_query_result=233434
reads_test: find_many_counters queries=2095165 candidates=52379125 hydrated=52379125 predicate_matches=52379125 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=2095165 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=250444 empty_query_result=250444
reads_test: find_many_counters queries=2098927 candidates=52473175 hydrated=52473175 predicate_matches=52473175 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=2098927 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=267350 empty_query_result=267350
reads_test: find_many_counters queries=2102667 candidates=52566675 hydrated=52566675 predicate_matches=52566675 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=2102667 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=284100 empty_query_result=284100
reads_test: find_many_counters queries=2106208 candidates=52655200 hydrated=52655200 predicate_matches=52655200 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=2106208 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=299805 empty_query_result=299805
reads_test: find_many_counters queries=2109725 candidates=52743125 hydrated=52743125 predicate_matches=52743125 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=2109725 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=315681 empty_query_result=315681
reads_test: find_many_counters queries=2112877 candidates=52821925 hydrated=52821925 predicate_matches=52821925 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=2112877 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=329481 empty_query_result=329481
reads_test: find_many_counters queries=2116182 candidates=52904550 hydrated=52904550 predicate_matches=52904550 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=2116182 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=344163 empty_query_result=344163
reads_test: find_many_counters queries=2119529 candidates=52988225 hydrated=52988225 predicate_matches=52988225 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=2119529 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=359297 empty_query_result=359297
reads_test: find_many_counters queries=2123057 candidates=53076425 hydrated=53076425 predicate_matches=53076425 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=2123057 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=375438 empty_query_result=375438
reads_test: find_many_counters queries=2129241 candidates=53231025 hydrated=53231025 predicate_matches=53231025 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=2129241 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=389831 empty_query_result=389831
reads_test: find_many_counters queries=2164652 candidates=54116300 hydrated=54116300 predicate_matches=54116300 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=2164652 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=389831 empty_query_result=389831
reads_test: find_many_counters queries=2199969 candidates=54999225 hydrated=54999225 predicate_matches=54999225 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=2199969 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=389831 empty_query_result=389831
reads_test: find_many_counters queries=2235231 candidates=55880775 hydrated=55880775 predicate_matches=55880775 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=2235231 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=389831 empty_query_result=389831
reads_test: find_many_counters queries=2270326 candidates=56758150 hydrated=56758150 predicate_matches=56758150 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=2270326 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=389831 empty_query_result=389831
reads_test: find_many_counters queries=2305723 candidates=57643075 hydrated=57643075 predicate_matches=57643075 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=2305723 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=389831 empty_query_result=389831
reads_test: find_many_counters queries=2341049 candidates=58526225 hydrated=58526225 predicate_matches=58526225 empty_results=0 expected_empty=0 unexpected_empty=0 query_value_exists=2341049 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=389831 empty_query_result=389831
reads_test: done elapsed=390s elapsed_hms=0:06:30 reads=15430935 avg_reads/s=39566 errors=0 not_found=0 primary_document_not_found=0 seed_document_missing=0 query_empty_expected=0 query_empty_unexpected=389831 empty_query_result=389831 find_many_unexpected_empty=0 log=../data/social_media_data_1m\reads_log.txt other_log=../data/social_media_data_1m\reads_other_log.txt