INFO logs

Log path is: /opt/yuga/data/yb-data/master/logs/yb-master.INFO
Showing last 1048576 bytes of log

Log file created at: 2026/09/27 03:04:18
Current UTC time: 2026/09/27 03:04:18
Running on machine: ubuntu-caremanager-1
Application fingerprint: version 2025.2.1.0 build 141 revision be088b533e1800380f620374f8c9b513f9b9d571 build_type RELEASE built at 05 Feb 2026 01:28:11 UTC
Running duration (h:mm:ss): 0:00:00
Log line format: [IWEF]mmdd hh:mm:ss.uuuuuu threadid file:line] msg
I0927 03:04:18.533838 2384983 server_main_util.cc:276] NumCPUs determined to be: 4
I0927 03:04:18.534430 2384983 server_main_util.cc:111] Total available RAM is 7.568562 GiB
I0927 03:04:18.534446 2384983 server_main_util.cc:100] Setting flag db_block_cache_size_percentage to recommended value -3
I0927 03:04:18.534461 2384983 server_main_util.cc:102] Setting flag default_memory_limit_to_ram_ratio to recommended value 0.1
I0927 03:04:18.534482 2384983 server_main_util.cc:104] Setting flag tablet_overhead_size_percentage to recommended value 0
I0927 03:04:18.534499 2384983 mem_tracker.cc:200] Creating root MemTracker with garbage collection threshold 8126681 bytes
I0927 03:04:18.534508 2384983 mem_tracker.cc:205] Root memory limit is 812668108
I0927 03:04:18.534523 2384983 tcmalloc_util.cc:233] Setting tcmalloc max thread cache bytes to: 33554432
I0927 03:04:18.534551 2384983 tcmalloc_util.cc:266] Setting TCMalloc profiler sampling period to 1048576 bytes
I0927 03:04:18.534561 2384983 mem_tracker.cc:245] TCMalloc per cpu caches active: 0
I0927 03:04:18.534570 2384983 mem_tracker.cc:247] TCMalloc max per cpu cache size: 1572864
I0927 03:04:18.534579 2384983 mem_tracker.cc:249] TCMalloc max total thread cache bytes: 33554432
I0927 03:04:18.534700 2384983 server_base_options.cc:166] Updating master addrs to {10.0.0.2:7100},{10.0.0.3:7100},{10.0.0.4:7100}
I0927 03:04:18.534724 2384983 server_base_options.cc:166] Updating master addrs to {10.0.0.2:7100},{10.0.0.3:7100},{10.0.0.4:7100}
I0927 03:04:18.534749 2384983 thread_pool.cc:288] Starting thread pool { name: metric cleanup max_workers: 1 min_workers: 0 idle_timeout: 0.500s }
I0927 03:04:18.534781 2384983 server_base_options.cc:166] Updating master addrs to {10.0.0.2:7100},{10.0.0.3:7100},{10.0.0.4:7100}
I0927 03:04:18.535290 2384983 mem_tracker.cc:840] MemTracker: hard memory limit is 0.756856 GB
I0927 03:04:18.535311 2384983 mem_tracker.cc:842] MemTracker: soft memory limit is 0.643328 GB
I0927 03:04:18.535470 2384983 thread_pool.cc:288] Starting thread pool { name: object_lock_info_manager max_workers: 4 min_workers: 0 idle_timeout: 0.500s }
I0927 03:04:18.535492 2384983 thread_pool.cc:288] Starting thread pool { name: leader-initialization max_workers: 1 min_workers: 0 idle_timeout: 0.500s }
I0927 03:04:18.535503 2384983 thread_pool.cc:288] Starting thread pool { name: CatalogManagerBGTasks max_workers: 4 min_workers: 0 idle_timeout: 0.500s }
I0927 03:04:18.535513 2384983 thread_pool.cc:288] Starting thread pool { name: async-tasks max_workers: 18446744073709551615 min_workers: 0 idle_timeout: 0.500s }
I0927 03:04:18.535523 2384983 thread_pool.cc:288] Starting thread pool { name: inform_removed_master max_workers: 4 min_workers: 0 idle_timeout: 0.500s }
I0927 03:04:18.535533 2384983 thread_pool.cc:288] Starting thread pool { name: raft max_workers: 4 min_workers: 0 idle_timeout: 0.500s }
I0927 03:04:18.535543 2384983 thread_pool.cc:288] Starting thread pool { name: raft_notifications max_workers: 18446744073709551615 min_workers: 0 idle_timeout: 15.000s }
I0927 03:04:18.535554 2384983 thread_pool.cc:288] Starting thread pool { name: prepare max_workers: 4 min_workers: 1 idle_timeout: 0.500s }
I0927 03:04:18.535833 2384983 thread_pool.cc:288] Starting thread pool { name: append max_workers: 4 min_workers: 1 idle_timeout: 0.500s }
I0927 03:04:18.536100 2384983 thread_pool.cc:288] Starting thread pool { name: log-sync max_workers: 4 min_workers: 1 idle_timeout: 0.500s }
I0927 03:04:18.536329 2384983 thread_pool.cc:288] Starting thread pool { name: log-alloc max_workers: 4 min_workers: 1 idle_timeout: 0.500s }
I0927 03:04:18.536595 2384983 server_base_options.cc:166] Updating master addrs to {10.0.0.2:7100},{10.0.0.3:7100},{10.0.0.4:7100}
I0927 03:04:18.536623 2384983 thread_pool.cc:288] Starting thread pool { name: MaintenanceMgr max_workers: 1 min_workers: 1 idle_timeout: 0.500s }
I0927 03:04:18.536900 2384983 rpc_server.cc:84] yb::server::RpcServer created at 0x313d3ff92280
I0927 03:04:18.536944 2384983 master.cc:193] yb::master::Master created at 0x7fff0af38750
I0927 03:04:18.536953 2384983 master.cc:194] yb::master::TSManager created at 0x313d3ff93a40
I0927 03:04:18.536962 2384983 master.cc:195] yb::master::CatalogManager created at 0x313d3fc09f80
I0927 03:04:18.537019 2384983 master_main.cc:137] Initializing master server...
I0927 03:04:18.537029 2384983 thread_pool.cc:288] Starting thread pool { name: init max_workers: 1 min_workers: 0 idle_timeout: 0.500s }
I0927 03:04:18.540288 2384983 fs_manager.cc:416] Opened local filesystem: /opt/yuga/data
uuid: "55d29a1415af4e44ac228b2c8a82f866"
format_stamp: "Formatted at 2026-02-23 14:21:00 on ubuntu-caremanager-1"
initdb_done_set_after_sys_catalog_restore: true
I0927 03:04:18.540714 2384983 server_base.cc:288] Auto setting FLAGS_num_reactor_threads to 4
I0927 03:04:18.540740 2384983 secure.cc:138] SetupSecureContext: kInternal, 1
I0927 03:04:18.542977 2384983 secure.cc:192] Certs directory: /opt/yuga/certs, node name: 10.0.0.2
I0927 03:04:18.545567 2384983 thread_pool.cc:288] Starting thread pool { name: Master max_workers: 1024 min_workers: 0 idle_timeout: 15.000s }
I0927 03:04:18.547844 2384983 auto_flags_manager_base.cc:350] AutoFlags promoted: ysql_yb_upgrade_to_pg15_completed,ysql_yb_pushdown_is_not_null,ysql_yb_enable_sequence_pushdown,ysql_yb_enable_saop_pushdown,ysql_yb_enable_replication_slot_consumption,ysql_yb_enable_replica_identity,ysql_yb_enable_pg_locks,ysql_yb_enable_index_aggregate_pushdown,ysql_yb_enable_hash_batch_in,ysql_yb_enable_docdb_vector_type,ysql_yb_enable_ddl_atomicity_infra,ysql_yb_enable_alter_table_rewrite,ysql_yb_enable_advisory_locks,cdc_enable_postgres_replica_identity,ysql_yb_enable_add_column_missing_default,ysql_yb_allow_block_based_sampling_algorithm,ysql_skip_row_lock_for_update,ysql_enable_packed_row,yb_enable_cdc_consistent_snapshot_streams,xcluster_store_older_schema_versions,ysql_yb_allow_replication_slot_lsn_types,ysql_enable_auto_analyze_infra,xcluster_enable_subtxn_abort_propagation,xcluster_use_encoded_key_filter,xcluster_enable_ddl_replication,ysql_yb_enable_expression_pushdown,xcluster_automatic_mode_schema_handling_v2,cdcsdk_enable_identification_of_non_eligible_tables,ysql_auto_add_new_index_to_bidirectional_xcluster_infra,ycql_allow_cassandra_drop,store_min_start_ht_running_txns,ysql_yb_enable_ddl_savepoint_infra,store_last_wal_op_log_ht,skip_prefix_locks_for_upgrade,enable_xcluster_api_v2,ysql_yb_bypass_cond_recheck,ysql_enable_object_locking_infra,master_enable_universe_uuid_heartbeat_check,enable_export_snapshot_using_relfilenode,TEST_auto_flags_initialized,ysql_yb_update_optimization_infra,remote_bootstrap_from_leader_only,ysql_yb_enable_replication_commands,enable_tablet_split_of_xcluster_replicated_tables,replicate_transaction_promotion,ycql_suppress_group_by_error,enable_object_retention_due_to_snapshots,persist_tserver_registry,regular_tablets_data_block_key_value_encoding,ysql_yb_allow_separate_requests_for_sampling_stages,enable_tablespace_based_transaction_placement,ysql_yb_allow_dockey_bounds,enable_flush_retryable_requests,ysql_yb_pushdown_strict_inequality,ysql_yb_pg_locks_integrate_advisory_locks,cdcsdk_enable_cleanup_of_expired_table_entries,save_index_into_wal_segments,enable_automatic_tablet_splitting,remote_bootstrap_idle_timeout_ms,cdcsdk_enable_dynamic_tables_disable_option,use_parent_table_id_field,cdcsdk_enable_dynamic_table_addition_with_table_cleanup,enable_xcluster_auto_flag_validation,allow_three_shared_parts_data_block_key_value_encoding,cdc_write_post_apply_metadata,TEST_auto_flags_new_install
I0927 03:04:18.572142 2384983 shared_mem_allocator.cc:323] Preparing shared memory allocator (prefix: VdKaFBWvTkSsIossioL4Zg)
I0927 03:04:18.572234 2384983 server_base.cc:606] Using private rpc address 10.0.0.2
I0927 03:04:18.572520 2384983 fs_manager.cc:827] Found tablet 00000000000000000000000000000000 metadata at /opt/yuga/data/yb-data/master
I0927 03:04:18.572736 2384998 async_client_initializer.cc:91] Starting to init ybclient
I0927 03:04:18.572747 2384983 master_main.cc:140] Starting Master server...
I0927 03:04:18.572800 2384983 ulimit_util.cc:212] Configured soft limit for cpu time is already larger than specified min value (unlimited vs. unlimited). Skipping.
I0927 03:04:18.572805 2384983 ulimit_util.cc:212] Configured soft limit for file size is already larger than specified min value (unlimited vs. unlimited). Skipping.
I0927 03:04:18.572809 2384983 ulimit_util.cc:212] Configured soft limit for data seg size is already larger than specified min value (unlimited vs. unlimited). Skipping.
I0927 03:04:18.572813 2384983 ulimit_util.cc:212] Configured soft limit for stack size is already larger than specified min value (8388608 vs. 8388608). Skipping.
I0927 03:04:18.572818 2384983 ulimit_util.cc:212] Configured soft limit for max user processes is already larger than specified min value (30848 vs. 12000). Skipping.
I0927 03:04:18.572822 2384983 env_posix.cc:1583] Modifying limit for open files from 1024 to 1048576
I0927 03:04:18.572829 2384983 ulimit_util.cc:212] Configured soft limit for max locked memory is already larger than specified min value (1015832576 vs. 65536). Skipping.
I0927 03:04:18.572834 2384983 ulimit_util.cc:212] Configured soft limit for max memory size is already larger than specified min value (unlimited vs. unlimited). Skipping.
I0927 03:04:18.572836 2384983 master_main.cc:142] ulimit cur(max)...
ulimit: core file size 0(unlimited) blks
ulimit: data seg size unlimited(unlimited) kb
ulimit: open files 1048576(1048576)
ulimit: file size unlimited(unlimited) blks
ulimit: pending signals 30848(30848)
ulimit: file locks unlimited(unlimited)
ulimit: max locked memory 992024(992024) kb
ulimit: max memory size unlimited(unlimited) kb
ulimit: stack size 8192(unlimited) kb
ulimit: cpu time unlimited(unlimited) secs
ulimit: max user processes 30848(30848)
I0927 03:04:18.573122 2384983 service_pool.cc:146] yb.master.MasterService: yb::rpc::ServicePoolImpl created at 0x313d3ff87b80
I0927 03:04:18.573325 2384983 service_pool.cc:146] yb.master.MasterBackup: yb::rpc::ServicePoolImpl created at 0x313d3fe1f8c0
I0927 03:04:18.573470 2384983 service_pool.cc:146] yb.master.MasterService: yb::rpc::ServicePoolImpl created at 0x313d3ff874a0
I0927 03:04:18.573865 2384983 service_pool.cc:146] yb.master.MasterService: yb::rpc::ServicePoolImpl created at 0x313d3ff86b00
I0927 03:04:18.573979 2384983 service_pool.cc:146] yb.master.MasterService: yb::rpc::ServicePoolImpl created at 0x313d3ff869a0
I0927 03:04:18.574189 2384998 thread_pool.cc:288] Starting thread pool { name: cdc_state_clientcb max_workers: 1 min_workers: 1 idle_timeout: 0.500s }
I0927 03:04:18.574577 2385000 client-internal.cc:2923] Reinitialize master addresses from file: ./master.conf
I0927 03:04:18.574669 2384983 service_pool.cc:146] yb.master.MasterService: yb::rpc::ServicePoolImpl created at 0x313d3ff86420
W0927 03:04:18.574689 2385000 catalog_manager.cc:1768] Failed to get current config: Illegal state (yb/master/catalog_manager.cc:12450): Node 55d29a1415af4e44ac228b2c8a82f866 peer not initialized.
I0927 03:04:18.574759 2384983 service_pool.cc:146] yb.master.MasterService: yb::rpc::ServicePoolImpl created at 0x313d3ff86580
I0927 03:04:18.575265 2385000 client-internal.cc:2952] New master addresses: [10.0.0.2:7100,10.0.0.3:7100,10.0.0.4:7100]
I0927 03:04:18.575285 2384983 service_pool.cc:146] yb.master.MasterService: yb::rpc::ServicePoolImpl created at 0x313d3ff86840
I0927 03:04:18.576131 2384983 service_pool.cc:146] yb.master.MasterService: yb::rpc::ServicePoolImpl created at 0x313d3ffae000
I0927 03:04:18.576175 2384983 service_pool.cc:146] yb.master.MasterService: yb::rpc::ServicePoolImpl created at 0x313d3ffae160
I0927 03:04:18.577029 2384983 service_pool.cc:146] yb.tserver.TabletServerService: yb::rpc::ServicePoolImpl created at 0x313d3ffae2c0
I0927 03:04:18.577203 2384983 thread_pool.cc:288] Starting thread pool { name: Master-high-pri max_workers: 1024 min_workers: 0 idle_timeout: 15.000s }
I0927 03:04:18.577212 2384983 service_pool.cc:146] yb.consensus.ConsensusService: yb::rpc::ServicePoolImpl created at 0x313d3ffae580
I0927 03:04:18.577585 2384983 service_pool.cc:146] yb.tserver.RemoteBootstrapService: yb::rpc::ServicePoolImpl created at 0x313d3ff87e40
I0927 03:04:18.578796 2384983 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I0927 03:04:18.578827 2384983 service_pool.cc:146] yb.tserver.PgClientService: yb::rpc::ServicePoolImpl created at 0x313d3ffaf1e0
I0927 03:04:18.578888 2384983 webserver.cc:359] Starting webserver on 10.0.0.2:7000
I0927 03:04:18.578892 2384983 webserver.cc:368] Document root: /root/yugabyte/www
I0927 03:04:18.578919 2384983 webserver.cc:354] Webserver listen spec is 10.0.0.2:7000
I0927 03:04:18.579039 2384983 webserver.cc:484] Webserver started. Bound to: http://10.0.0.2:7000/
I0927 03:04:18.579198 2384983 service_pool.cc:146] yb.server.GenericService: yb::rpc::ServicePoolImpl created at 0x313d3ffe2840
I0927 03:04:18.579475 2384983 rpc_server.cc:167] RPC server started. Bound to: 10.0.0.2:7100
I0927 03:04:18.579602 2385004 async_client_initializer.cc:91] Starting to init ybclient
I0927 03:04:18.580533 2384983 db_server_base.cc:80] Node information: { hostname: 'ubuntu-caremanager-1', rpc_ip: '10.0.0.2', webserver_ip: '10.0.0.2', uuid: '55d29a1415af4e44ac228b2c8a82f866' }
I0927 03:04:18.580547 2384983 server_base.cc:606] Using private rpc address 10.0.0.2
I0927 03:04:18.580554 2384983 server_base.cc:628] Using http address 10.0.0.2
I0927 03:04:18.580662 2385005 sys_catalog.cc:289] Trying to load previous SysCatalogTable data from disk
I0927 03:04:18.581176 2385004 thread_pool.cc:288] Starting thread pool { name: server_clientcb max_workers: 1 min_workers: 1 idle_timeout: 0.500s }
I0927 03:04:18.581513 2385007 client-internal.cc:2923] Reinitialize master addresses from file: ./master.conf
W0927 03:04:18.581605 2385007 catalog_manager.cc:1768] Failed to get current config: Illegal state (yb/master/catalog_manager.cc:12450): Node 55d29a1415af4e44ac228b2c8a82f866 peer not initialized.
I0927 03:04:18.581634 2385007 client-internal.cc:2952] New master addresses: [10.0.0.2:7100,10.0.0.3:7100,10.0.0.4:7100]
I0927 03:04:18.585608 2385004 async_client_initializer.cc:95] Successfully built ybclient
I0927 03:04:18.585609 2384998 async_client_initializer.cc:95] Successfully built ybclient
I0927 03:04:18.588307 2385005 consensus_meta.cc:361] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866: Updating active role from UNKNOWN_ROLE to FOLLOWER. Consensus state: current_term: 64 leader_uuid: "" config { opid_index: -1 peers { permanent_uuid: "55d29a1415af4e44ac228b2c8a82f866" member_type: VOTER last_known_private_addr { host: "10.0.0.2" port: 7100 } cloud_info { placement_cloud: "hetzner" placement_region: "fsn" placement_zone: "care1" } } peers { permanent_uuid: "a5110a40aa5b46eaa183f0022d8d9063" member_type: VOTER last_known_private_addr { host: "10.0.0.3" port: 7100 } cloud_info { placement_cloud: "hetzner" placement_region: "fsn" placement_zone: "care2" } } peers { permanent_uuid: "64fedbe39ec148ab8f9e982b6d19f6d2" member_type: VOTER last_known_private_addr { host: "10.0.0.4" port: 7100 } cloud_info { placement_cloud: "hetzner" placement_region: "fsn" placement_zone: "care3" } } }, has_pending_config = 0
I0927 03:04:18.588454 2385005 sys_catalog.cc:333] Configuring consensus for distributed operation...
I0927 03:04:18.588459 2385005 server_base_options.cc:166] Updating master addrs to {10.0.0.2:7100},{10.0.0.3:7100},{10.0.0.4:7100}
I0927 03:04:18.588465 2385005 server_base.cc:606] Using private rpc address 10.0.0.2
I0927 03:04:18.590174 2385005 tablet_bootstrap_state_manager.cc:62] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866: Initialized TabletBootstrapStateManager, found a file ? no, wal dir=/opt/yuga/data/yb-data/master/wals/table-sys.catalog.uuid/tablet-00000000000000000000000000000000
I0927 03:04:18.590202 2385005 tablet_peer.cc:1701] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866 [state=BOOTSTRAPPING]: Changed state from NOT_STARTED to BOOTSTRAPPING
I0927 03:04:18.590303 2385005 consensus_meta.cc:361] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866: Updating active role from UNKNOWN_ROLE to FOLLOWER. Consensus state: current_term: 64 leader_uuid: "" config { opid_index: -1 peers { permanent_uuid: "55d29a1415af4e44ac228b2c8a82f866" member_type: VOTER last_known_private_addr { host: "10.0.0.2" port: 7100 } cloud_info { placement_cloud: "hetzner" placement_region: "fsn" placement_zone: "care1" } } peers { permanent_uuid: "a5110a40aa5b46eaa183f0022d8d9063" member_type: VOTER last_known_private_addr { host: "10.0.0.3" port: 7100 } cloud_info { placement_cloud: "hetzner" placement_region: "fsn" placement_zone: "care2" } } peers { permanent_uuid: "64fedbe39ec148ab8f9e982b6d19f6d2" member_type: VOTER last_known_private_addr { host: "10.0.0.4" port: 7100 } cloud_info { placement_cloud: "hetzner" placement_region: "fsn" placement_zone: "care3" } } }, has_pending_config = 0
I0927 03:04:18.590322 2385005 tablet_bootstrap_if.cc:95] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866: Bootstrap starting.
I0927 03:04:18.590587 2385005 tablet.cc:731] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866: Schema version for sys.catalog is 0
I0927 03:04:18.590754 2385005 transaction_participant.cc:264] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866: Create
I0927 03:04:18.590797 2385005 docdb_rocksdb_util.cc:383] FLAGS_rocksdb_max_background_flushes was not set, automatically configuring 1 max background flushes
I0927 03:04:18.590802 2385005 docdb_rocksdb_util.cc:418] FLAGS_rocksdb_max_background_compactions was not set, automatically configuring 1 background compactions.
I0927 03:04:18.590806 2385005 docdb_rocksdb_util.cc:431] FLAGS_rocksdb_base_background_compactions was not set, automatically configuring 1 base background compactions.
I0927 03:04:18.590811 2385005 docdb_rocksdb_util.cc:669] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866: Write buffer size: 134217728
I0927 03:04:18.590816 2385005 docdb_rocksdb_util.cc:637] FLAGS_priority_thread_pool_size was not set, automatically configuring to 2.
I0927 03:04:18.590862 2385005 tablet.cc:864] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866: Creating RocksDB database in dir /opt/yuga/data/yb-data/master/data/rocksdb/table-sys.catalog.uuid/tablet-00000000000000000000000000000000
I0927 03:04:18.591766 2385005 tablet.cc:1224] Opening RocksDB at: /opt/yuga/data/yb-data/master/data/rocksdb/table-sys.catalog.uuid/tablet-00000000000000000000000000000000
I0927 03:04:18.593793 2385005 version_set.cc:3026] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866 [R]: Recovered from manifest file:/opt/yuga/data/yb-data/master/data/rocksdb/table-sys.catalog.uuid/tablet-00000000000000000000000000000000/MANIFEST-000092 succeeded,manifest_file_number is 92, next_file_number is 94, last_sequence is 1125899907113722, log_number is 0,prev_log_number is 0,max_column_family is 0, flushed_values is 0x0000313d3facee00 -> { op_id: 14.4980 hybrid_time: { physical: 1781579124111517 } max_value_level_ttl_expiration_time: <initial> primary_schema_version: 0 cotable_schema_versions: [{ec040000-0000-0180-0030-000001000000, 0}, {300a0000-0000-0180-0030-000001400000, 0}, {620a0000-0000-0180-0030-000001400000, 0}, {6d0a0000-0000-0180-0030-000001400000, 0}, {120e0000-0000-0180-0030-000001400000, 0}, {690a0000-0000-0180-0030-000001400000, 0}, {e7040000-0000-0180-0030-000001400000, 0}, {810a0000-0000-0180-0030-000001400000, 0}, {320a0000-0000-0180-0030-000001400000, 0}, {2c0a0000-0000-0180-0030-000001400000, 0}, {8d0a0000-0000-0180-0030-000001400000, 0}, {290a0000-0000-0180-0030-000001400000, 0}, {b0080000-0000-0180-0030-000001400000, 0}, {5f0a0000-0000-0180-0030-000001400000, 0}, {130e0000-0000-0180-0030-000001400000, 0}, {2e0a0000-0000-0180-0030-000001400000, 0}, {710a0000-0000-0180-0030-000001400000, 0}, {20340000-0000-0180-0030-000001400000, 0}, {eb040000-0000-0180-0030-000001400000, 0}, {7e0a0000-0000-0180-0030-000001400000, 0}, {d50d0000-0000-0180-0030-000001400000, 0}, {2f0a0000-0000-0180-0030-000001400000, 0}, {760a0000-0000-0180-0030-000001400000, 0}, {2b0a0000-0000-0180-0030-000001400000, 0}, {180e0000-0000-0180-0030-000001400000, 0}, {650a0000-0000-0180-0030-000001400000, 0}, {130a0000-0000-0180-0030-000001400000, 0}, {b4080000-0000-0180-0030-000001400000, 0}, {380a0000-0000-0180-0030-000001400000, 0}, {d0040000-0000-0180-0030-000001000000, 0}, {280a0000-0000-0180-0030-000001400000, 0}, {310a0000-0000-0180-0030-000001400000, 0}, {390a0000-0000-0180-0030-000001400000, 0}, {df040000-0000-0180-0030-000001400000, 0}, {3a0a0000-0000-0180-0030-000001400000, 0}, {e1040000-0000-0180-0030-000001400000, 0}, {370a0000-0000-0180-0030-000001400000, 0}, {3b0a0000-0000-0180-0030-000001400000, 0}, {2a0a0000-0000-0180-0030-000001400000, 0}, {5b0a0000-0000-0180-0030-000001400000, 0}, {090c0000-0000-0180-0030-000001400000, 0}, {17340000-0000-0180-0030-000001400000, 0}, {680a0000-0000-0180-0030-000001400000, 0}, {5e0a0000-0000-0180-0030-000001400000, 0}, {830a0000-0000-0180-0030-000001400000, 0}, {be040000-0000-0180-0030-000001000000, 0}, {6a0a0000-0000-0180-0030-000001400000, 0}, {6c0a0000-0000-0180-0030-000001400000, 0}, {420d0000-0000-0180-0030-000001400000, 0}, {901f0000-0000-0180-0030-000001000000, 0}, {790a0000-0000-0180-0030-000001400000, 0}, {5c0c0000-0000-0180-0030-000001400000, 0}, {850a0000-0000-0180-0030-000001400000, 0}, {c20a0000-0000-0180-0030-000001400000, 0}, {900a0000-0000-0180-0030-000001400000, 0}, {110e0000-0000-0180-0030-000001400000, 0}, {5d0a0000-0000-0180-0030-000001400000, 0}, {100e0000-0000-0180-0030-000001400000, 0}, {800d0000-0000-0180-0030-000001400000, 0}, {d1040000-0000-0180-0030-000001000000, 0}, {7f0d0000-0000-0180-0030-000001400000, 0}, {2d0a0000-0000-0180-0030-000001400000, 0}, {140e0000-0000-0180-0030-000001400000, 0}, {7c0a0000-0000-0180-0030-000001400000, 0}, {160e0000-0000-0180-0030-000001400000, 0}, {6f0a0000-0000-0180-0030-000001000000, 0}, {340a0000-0000-0180-0030-000001400000, 0}, {5b1f0000-0000-0180-0030-000001400000, 0}, {600a0000-0000-0180-0030-000001400000, 0}, {720a0000-0000-0180-0030-000001400000, 0}, {740a0000-0000-0180-0030-000001000000, 0}, {1a340000-0000-0180-0030-000001400000, 0}, {1d340000-0000-0180-0030-000001400000, 0}, {c10a0000-0000-0180-0030-000001400000, 0}, {670a0000-0000-0180-0030-000001400000, 0}, {8b0a0000-0000-0180-0030-000001400000, 0}, {070c0000-0000-0180-0030-000001400000, 0}, {ee040000-0000-0180-0030-000001000000, 0}, {b60e0000-0000-0180-0030-000001400000, 0}, {4a1f0000-0000-0180-0030-000001000000, 0}, {3c0a0000-0000-0180-0030-000001400000, 0}, {891f0000-0000-0180-0030-000001000000, 0}, {b40e0000-0000-0180-0030-000001400000, 0}] }
I0927 03:04:18.593842 2385005 version_set.cc:3034] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866 [R]: Column family [default] (ID 0), log number is 91
I0927 03:04:18.594527 2385005 event_logger.cc:66] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866 [R]: EVENT_LOG_v1 {"time_micros": 1790478258594519, "job": 1, "event": "recovery_started", "log_files": [93]}
I0927 03:04:18.594630 2385005 db_impl.cc:1781] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866 [R]: Recovering log #93 mode 0 skip-recovery 0
I0927 03:04:18.595049 2385005 version_set.cc:2467] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866 [R]: Creating manifest 95
I0927 03:04:18.599452 2385005 event_logger.cc:66] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866 [R]: EVENT_LOG_v1 {"time_micros": 1790478258599446, "job": 1, "event": "recovery_finished"}
I0927 03:04:18.599732 2385005 db_impl.cc:1436] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866 [R]: [JOB 2] Delete /opt/yuga/data/yb-data/master/data/rocksdb/table-sys.catalog.uuid/tablet-00000000000000000000000000000000//MANIFEST-000092 type=4 #92 -- OK
I0927 03:04:18.599788 2385005 db_impl.cc:1436] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866 [R]: [JOB 2] Delete /opt/yuga/data/yb-data/master/data/rocksdb/table-sys.catalog.uuid/tablet-00000000000000000000000000000000//000093.log type=0 #93 -- OK
I0927 03:04:18.603127 2385005 tablet.cc:1250] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866: Opening intents DB at: /opt/yuga/data/yb-data/master/data/rocksdb/table-sys.catalog.uuid/tablet-00000000000000000000000000000000.intents
I0927 03:04:18.604039 2385005 version_set.cc:3026] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866 [I]: Recovered from manifest file:/opt/yuga/data/yb-data/master/data/rocksdb/table-sys.catalog.uuid/tablet-00000000000000000000000000000000.intents/MANIFEST-000079 succeeded,manifest_file_number is 79, next_file_number is 81, last_sequence is 1125899906923536, log_number is 0,prev_log_number is 0,max_column_family is 0, flushed_values is 0x0000313d3face800 -> { op_id: 7.3883 hybrid_time: { physical: 1778574321215135 logical: 3 } max_value_level_ttl_expiration_time: <initial> cotable_schema_versions: [{830a0000-0000-0180-0030-000001400000, 0}, {4a1f0000-0000-0180-0030-000001000000, 0}, {2e0a0000-0000-0180-0030-000001400000, 0}, {740a0000-0000-0180-0030-000001000000, 0}, {3c0a0000-0000-0180-0030-000001400000, 0}, {e1040000-0000-0180-0030-000001400000, 0}, {670a0000-0000-0180-0030-000001400000, 0}, {ec040000-0000-0180-0030-000001000000, 0}, {8d0a0000-0000-0180-0030-000001400000, 0}, {7c0a0000-0000-0180-0030-000001400000, 0}, {ee040000-0000-0180-0030-000001000000, 0}, {900a0000-0000-0180-0030-000001400000, 0}, {2c0a0000-0000-0180-0030-000001400000, 0}, {6f0a0000-0000-0180-0030-000001000000, 0}, {600a0000-0000-0180-0030-000001400000, 0}, {720a0000-0000-0180-0030-000001400000, 0}, {be040000-0000-0180-0030-000001000000, 0}, {130a0000-0000-0180-0030-000001400000, 0}, {690a0000-0000-0180-0030-000001400000, 0}, {e7040000-0000-0180-0030-000001400000, 0}, {710a0000-0000-0180-0030-000001400000, 0}, {d1040000-0000-0180-0030-000001000000, 0}, {300a0000-0000-0180-0030-000001400000, 0}, {6a0a0000-0000-0180-0030-000001400000, 0}, {320a0000-0000-0180-0030-000001400000, 0}, {eb040000-0000-0180-0030-000001400000, 0}, {891f0000-0000-0180-0030-000001000000, 0}, {901f0000-0000-0180-0030-000001000000, 0}, {680a0000-0000-0180-0030-000001400000, 0}, {df040000-0000-0180-0030-000001400000, 0}, {620a0000-0000-0180-0030-000001400000, 0}, {7f0d0000-0000-0180-0030-000001400000, 0}, {d0040000-0000-0180-0030-000001000000, 0}, {370a0000-0000-0180-0030-000001400000, 0}, {b0080000-0000-0180-0030-000001400000, 0}, {8b0a0000-0000-0180-0030-000001400000, 0}, {760a0000-0000-0180-0030-000001400000, 0}] }
I0927 03:04:18.604070 2385005 version_set.cc:3034] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866 [I]: Column family [default] (ID 0), log number is 78
I0927 03:04:18.604455 2385005 event_logger.cc:66] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866 [I]: EVENT_LOG_v1 {"time_micros": 1790478258604449, "job": 1, "event": "recovery_started", "log_files": [80]}
I0927 03:04:18.604487 2385005 db_impl.cc:1781] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866 [I]: Recovering log #80 mode 0 skip-recovery 0
I0927 03:04:18.604522 2385005 version_set.cc:2467] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866 [I]: Creating manifest 82
I0927 03:04:18.607851 2385005 event_logger.cc:66] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866 [I]: EVENT_LOG_v1 {"time_micros": 1790478258607846, "job": 1, "event": "recovery_finished"}
I0927 03:04:18.608064 2385005 db_impl.cc:1436] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866 [I]: [JOB 2] Delete /opt/yuga/data/yb-data/master/data/rocksdb/table-sys.catalog.uuid/tablet-00000000000000000000000000000000.intents//MANIFEST-000079 type=4 #79 -- OK
I0927 03:04:18.608109 2385005 db_impl.cc:1436] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866 [I]: [JOB 2] Delete /opt/yuga/data/yb-data/master/data/rocksdb/table-sys.catalog.uuid/tablet-00000000000000000000000000000000.intents//000080.log type=0 #80 -- OK
W0927 03:04:18.611286 2385009 catalog_manager.cc:10812] CatalogManager is not yet initialized
I0927 03:04:18.611941 2385010 transaction_loader.cc:113] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866: Load transactions start
I0927 03:04:18.612310 2385005 tablet.cc:1123] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866: Successfully opened a RocksDB database at /opt/yuga/data/yb-data/master/data/rocksdb/table-sys.catalog.uuid/tablet-00000000000000000000000000000000
I0927 03:04:18.612344 2385005 tablet_bootstrap.cc:652] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866: Time spent opening tablet: real 0.022s	user 0.005s	sys 0.003s
I0927 03:04:18.613036 2385005 tablet_bootstrap.cc:748] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866: Will attempt to recover log segment /opt/yuga/data/yb-data/master/wals/table-sys.catalog.uuid/tablet-00000000000000000000000000000000/wal-000000004
I0927 03:04:18.613065 2385005 tablet_bootstrap.cc:748] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866: Will attempt to recover log segment /opt/yuga/data/yb-data/master/wals/table-sys.catalog.uuid/tablet-00000000000000000000000000000000/wal-000000005
I0927 03:04:18.613078 2385005 tablet_bootstrap.cc:748] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866: Will attempt to recover log segment /opt/yuga/data/yb-data/master/wals/table-sys.catalog.uuid/tablet-00000000000000000000000000000000/wal-000000006
I0927 03:04:18.613125 2385005 tablet_bootstrap.cc:1251] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866: Flushed DocDB OpIds: { regular: 14.4980 intents: 7.3883 vector_indexes: [] }
I0927 03:04:18.613583 2385010 transaction_loader.cc:187] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866: LoadTransactions done: loaded 0 transactions
I0927 03:04:18.614766 2385005 tablet_bootstrap.cc:1526] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866: Max persistent index in RocksDB's SSTables before bootstrap: regular RocksDB: 14.4980; intents RocksDB: 7.3883
I0927 03:04:18.616446 2385005 log.cc:1527] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866: Setting log wal retention time to 0 seconds
W0927 03:04:18.617952 2385005 log_util.cc:245] Could not read footer for segment: /opt/yuga/data/yb-data/master/wals/table-sys.catalog.uuid/tablet-00000000000000000000000000000000/wal-000000006: Not found (yb/consensus/log_util.cc:591): Footer not found. Footer magic doesn't match
W0927 03:04:18.619068 2385005 log_reader.cc:213] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866: Log segment /opt/yuga/data/yb-data/master/wals/table-sys.catalog.uuid/tablet-00000000000000000000000000000000/wal-000000006 was likely left in-progressafter a previous crash. Will try to reuse this segment as writable active segment
I0927 03:04:18.619098 2385005 log.cc:751] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866: Opened existing logs. Last segment is /opt/yuga/data/yb-data/master/wals/table-sys.catalog.uuid/tablet-00000000000000000000000000000000/wal-000000006
I0927 03:04:18.619109 2385005 log.cc:767] durable_wal_write is turned on.
I0927 03:04:18.619122 2385005 tablet_bootstrap.cc:394] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866: Bootstrap optimizer (skip_flushed_entries): op_id_replay_lowest=7.3883 (regular_op_id=14.4980, intents_op_id=7.3883, has_intents_db=1)
I0927 03:04:18.619176 2385005 tablet_bootstrap.cc:1473] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866: Segment /opt/yuga/data/yb-data/master/wals/table-sys.catalog.uuid/tablet-00000000000000000000000000000000/wal-000000006 cannot be used as the first segment to start replay with according to our OpId and retention criteria. Continuing to earlier segments.op_id=32.46141, op_id_replay_lowest=7.3883, last_op_id_in_retryable_requests=0.0, first_op_time=13637898.974s, retryable_requests_retain_interval=600.000s, *retryable_requests_replay_from_this_or_earlier_time=13637298.974s, is_first_op_id_low_enough_for_retryable_requests=0, is_first_op_time_early_enough_for_retryable_requests=0, is_first_op_id_low_enough=0
I0927 03:04:18.619223 2385005 tablet_bootstrap.cc:1473] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866: Segment /opt/yuga/data/yb-data/master/wals/table-sys.catalog.uuid/tablet-00000000000000000000000000000000/wal-000000005 cannot be used as the first segment to start replay with according to our OpId and retention criteria. Continuing to earlier segments.op_id=22.12814, op_id_replay_lowest=7.3883, last_op_id_in_retryable_requests=0.0, first_op_time=13509002.041s, retryable_requests_retain_interval=600.000s, *retryable_requests_replay_from_this_or_earlier_time=13637298.974s, is_first_op_id_low_enough_for_retryable_requests=0, is_first_op_time_early_enough_for_retryable_requests=1, is_first_op_id_low_enough=0
I0927 03:04:18.623773 2385005 tablet_bootstrap.cc:1460] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866: Retryable requests file is too old, ignore the expired retryable requests. is_first_op_id_low_enough_for_retryable_requests=0, is_first_op_time_early_enough_for_retryable_requests=1
I0927 03:04:18.623806 2385005 tablet_bootstrap.cc:1465] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866: Bootstrap optimizer (skip_flushed_entries): found first mandatory segment op id: 2.688, op_id_replay_lowest=7.3883, last_op_id_in_retryable_requests=0.0, first_op_time=112216.640s, retryable_requests_retain_interval=600.000s, *retryable_requests_replay_from_this_or_earlier_time=13637298.974s, number of segments to be skipped: 0
W0927 03:04:18.733474 2385005 transaction_participant.cc:2087] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866: Transaction not found: 17852948-54e1-4515-87cf-064661b687d0, for: pre apply
W0927 03:04:18.733503 2385005 transaction_participant.cc:956] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866: Apply of unknown transaction: { leader_term: -1 transaction_id: 17852948-54e1-4515-87cf-064661b687d0 aborted:  op_id: 2.697 commit_ht: { physical: 1772008645295403 } log_ht: { physical: 1772008645297684 } sealed: 0 status_tablet: 9f5a9f9a170e42d182145cdd9561f7ca apply_state: <NULL> }
I0927 03:04:18.751685 2385005 tablet_bootstrap_if.cc:95] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866: Bootstrap replayed 1/3 log segments. Read operations: 12126, overwritten operations: 0. Pending: 1 replicates. Last read committed op id: 22.12812, last entry metadata: { entry_time: 13509002.025s offset: 8388555 active_segment_sequence_number: 4 }, last read entry op id: 22.12813
I0927 03:04:19.008561 2385005 tablet_bootstrap_if.cc:95] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866: Bootstrap replayed 2/3 log segments. Read operations: 45453, overwritten operations: 0. Pending: 1 replicates. Last read committed op id: 32.46140, last entry metadata: { entry_time: 13637898.053s offset: 16772329 active_segment_sequence_number: 5 }, last read entry op id: 32.46140
I0927 03:04:19.053304 2385006 encryption_manager.cc:60] Responding to GetUniverseKeyRegistry request with key ids: 
I0927 03:04:19.309211 2385005 log_util.cc:807] Scanning /opt/yuga/data/yb-data/master/wals/table-sys.catalog.uuid/tablet-00000000000000000000000000000000/wal-000000006 for valid entry headers following offset 33323174...
I0927 03:04:19.309392 2385005 log_util.cc:851] Found no log entry headers
I0927 03:04:19.309399 2385005 log_util.cc:712] Ignoring partially flushed segment in write ahead log /opt/yuga/data/yb-data/master/wals/table-sys.catalog.uuid/tablet-00000000000000000000000000000000/wal-000000006 because there are no log entries following this one. The server probably crashed in the middle of writing an entry to the write-ahead log or downloaded an active log via remote bootstrap. Error detail: Corruption (yb/consensus/log_util.cc:922): Invalid checksum in log entry head header: found=0, computed=2351477386: Failed trying to read batch #71180 at offset 33323174 for log segment /opt/yuga/data/yb-data/master/wals/table-sys.catalog.uuid/tablet-00000000000000000000000000000000/wal-000000006: Prior batch offsets: 33322754 33322783 33323145 33323174; Last log entries read: [REPLICATE (64.115624)] [REPLICATE (64.115625)] [REPLICATE (64.115626)] [REPLICATE (64.115627)]
I0927 03:04:19.382011 2385005 tablet_bootstrap.cc:938] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866: Overwriting operations starting at: 46.85465 up to: 46.85466 with operation: 47.85465
I0927 03:04:19.451625 2385005 tablet_bootstrap_if.cc:95] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866: Bootstrap replayed 3/3 log segments. Read operations: 114942, overwritten operations: 2. Pending: 1 replicates. Last read committed op id: 64.115627, last entry metadata: { entry_time: 16528099.840s offset: 33322783 active_segment_sequence_number: 6 }, last read entry op id: 64.115627
I0927 03:04:19.451700 2385005 tablet_bootstrap.cc:1668] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866: Dumping replay state to log at the end of PlaySegments
I0927 03:04:19.451709 2385005 tablet_bootstrap.cc:1225] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866: ReplayState: Previous OpId: 64.115627, Committed OpId: 64.115627, Pending Replicates: 0, Flushed Regular: 14.4980, Flushed Intents: 7.3883
I0927 03:04:19.451712 2385005 tablet_bootstrap.cc:1225] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866: Log entries applied to RocksDB: 114940
I0927 03:04:19.451716 2385005 tablet_bootstrap.cc:1680] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866: Number of orphaned replicates: 0, last id: 64.115627, committed id: 64.115627
I0927 03:04:19.454962 2385005 tablet_vector_indexes.cc:411] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866: LaunchBackfillsIfNecessary: list: <NULL>
I0927 03:04:19.454980 2385005 tablet_bootstrap_if.cc:95] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866: Bootstrap complete.
I0927 03:04:19.705102 2385005 log_util.cc:807] Scanning /opt/yuga/data/yb-data/master/wals/table-sys.catalog.uuid/tablet-00000000000000000000000000000000/wal-000000006 for valid entry headers following offset 33323174...
I0927 03:04:19.705269 2385005 log_util.cc:851] Found no log entry headers
I0927 03:04:19.705274 2385005 log_util.cc:712] Ignoring partially flushed segment in write ahead log /opt/yuga/data/yb-data/master/wals/table-sys.catalog.uuid/tablet-00000000000000000000000000000000/wal-000000006 because there are no log entries following this one. The server probably crashed in the middle of writing an entry to the write-ahead log or downloaded an active log via remote bootstrap. Error detail: Corruption (yb/consensus/log_util.cc:922): Invalid checksum in log entry head header: found=0, computed=2351477386: Failed trying to read batch #71180 at offset 33323174 for log segment /opt/yuga/data/yb-data/master/wals/table-sys.catalog.uuid/tablet-00000000000000000000000000000000/wal-000000006: Prior batch offsets: 33322754 33322783 33323145 33323174; Last log entries read: [REPLICATE (64.115624)] [REPLICATE (64.115625)] [REPLICATE (64.115626)] [REPLICATE (64.115627)]
I0927 03:04:19.711884 2385005 log.cc:1163] Successfully restored footer_builder_ and log_index_ for segment: /opt/yuga/data/yb-data/master/wals/table-sys.catalog.uuid/tablet-00000000000000000000000000000000/wal-000000006. Reopen the file for write with starting offset: 33323174
I0927 03:04:19.728999 2385005 log.cc:1527] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866: Setting log wal retention time to 0 seconds
I0927 03:04:19.729267 2385005 consensus_meta.cc:361] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866: Updating active role from UNKNOWN_ROLE to FOLLOWER. Consensus state: current_term: 64 leader_uuid: "" config { opid_index: -1 peers { permanent_uuid: "55d29a1415af4e44ac228b2c8a82f866" member_type: VOTER last_known_private_addr { host: "10.0.0.2" port: 7100 } cloud_info { placement_cloud: "hetzner" placement_region: "fsn" placement_zone: "care1" } } peers { permanent_uuid: "a5110a40aa5b46eaa183f0022d8d9063" member_type: VOTER last_known_private_addr { host: "10.0.0.3" port: 7100 } cloud_info { placement_cloud: "hetzner" placement_region: "fsn" placement_zone: "care2" } } peers { permanent_uuid: "64fedbe39ec148ab8f9e982b6d19f6d2" member_type: VOTER last_known_private_addr { host: "10.0.0.4" port: 7100 } cloud_info { placement_cloud: "hetzner" placement_region: "fsn" placement_zone: "care3" } } }, has_pending_config = 0
I0927 03:04:19.736244 2385005 consensus_meta.cc:361] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866: Updating active role from FOLLOWER to FOLLOWER. Consensus state: current_term: 64 leader_uuid: "" config { opid_index: -1 peers { permanent_uuid: "55d29a1415af4e44ac228b2c8a82f866" member_type: VOTER last_known_private_addr { host: "10.0.0.2" port: 7100 } cloud_info { placement_cloud: "hetzner" placement_region: "fsn" placement_zone: "care1" } } peers { permanent_uuid: "a5110a40aa5b46eaa183f0022d8d9063" member_type: VOTER last_known_private_addr { host: "10.0.0.3" port: 7100 } cloud_info { placement_cloud: "hetzner" placement_region: "fsn" placement_zone: "care2" } } peers { permanent_uuid: "64fedbe39ec148ab8f9e982b6d19f6d2" member_type: VOTER last_known_private_addr { host: "10.0.0.4" port: 7100 } cloud_info { placement_cloud: "hetzner" placement_region: "fsn" placement_zone: "care3" } } }, has_pending_config = 0
I0927 03:04:19.736275 2385005 raft_consensus.cc:514] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866 [term 64 FOLLOWER]: Replica starting. Triggering 0 pending operations. Active config: opid_index: -1 peers { permanent_uuid: "55d29a1415af4e44ac228b2c8a82f866" member_type: VOTER last_known_private_addr { host: "10.0.0.2" port: 7100 } cloud_info { placement_cloud: "hetzner" placement_region: "fsn" placement_zone: "care1" } } peers { permanent_uuid: "a5110a40aa5b46eaa183f0022d8d9063" member_type: VOTER last_known_private_addr { host: "10.0.0.3" port: 7100 } cloud_info { placement_cloud: "hetzner" placement_region: "fsn" placement_zone: "care2" } } peers { permanent_uuid: "64fedbe39ec148ab8f9e982b6d19f6d2" member_type: VOTER last_known_private_addr { host: "10.0.0.4" port: 7100 } cloud_info { placement_cloud: "hetzner" placement_region: "fsn" placement_zone: "care3" } }
I0927 03:04:19.736289 2385005 raft_consensus.cc:1158] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866 [term 64 FOLLOWER]: Becoming Follower/Learner. State: Replica: 55d29a1415af4e44ac228b2c8a82f866, State: 1, Role: FOLLOWER, Watermarks: {Received: 64.115627 Committed: 64.115627} Leader: 0.0, new leader: , initial_fd_wait: <uninitialized>
I0927 03:04:19.736302 2385005 consensus_meta.cc:361] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866: Updating active role from FOLLOWER to FOLLOWER. Consensus state: current_term: 64 leader_uuid: "" config { opid_index: -1 peers { permanent_uuid: "55d29a1415af4e44ac228b2c8a82f866" member_type: VOTER last_known_private_addr { host: "10.0.0.2" port: 7100 } cloud_info { placement_cloud: "hetzner" placement_region: "fsn" placement_zone: "care1" } } peers { permanent_uuid: "a5110a40aa5b46eaa183f0022d8d9063" member_type: VOTER last_known_private_addr { host: "10.0.0.3" port: 7100 } cloud_info { placement_cloud: "hetzner" placement_region: "fsn" placement_zone: "care2" } } peers { permanent_uuid: "64fedbe39ec148ab8f9e982b6d19f6d2" member_type: VOTER last_known_private_addr { host: "10.0.0.4" port: 7100 } cloud_info { placement_cloud: "hetzner" placement_region: "fsn" placement_zone: "care3" } } }, has_pending_config = 0
I0927 03:04:19.736322 2385005 consensus_queue.cc:271] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866 [NON_LEADER]: Queue going to NON_LEADER mode. State: All replicated op: 0.0, Majority replicated op: 0.0, Committed index: 0.0, Last applied: 0.0, Last appended: 64.115627, Current term: 0, Majority size: -1, State: QUEUE_OPEN, Mode: NON_LEADER
I0927 03:04:19.736337 2385005 raft_consensus.cc:3580] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866 [term 64 FOLLOWER]: Calling mark dirty synchronously for reason code CONSENSUS_STARTED
I0927 03:04:19.736346 2385005 sys_catalog.cc:447] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866 [sys.catalog]: SysCatalogTable state changed. Locked=0. Reason: RaftConsensus started. Latest consensus state: current_term: 64 leader_uuid: "" config { opid_index: -1 peers { permanent_uuid: "55d29a1415af4e44ac228b2c8a82f866" member_type: VOTER last_known_private_addr { host: "10.0.0.2" port: 7100 } cloud_info { placement_cloud: "hetzner" placement_region: "fsn" placement_zone: "care1" } } peers { permanent_uuid: "a5110a40aa5b46eaa183f0022d8d9063" member_type: VOTER last_known_private_addr { host: "10.0.0.3" port: 7100 } cloud_info { placement_cloud: "hetzner" placement_region: "fsn" placement_zone: "care2" } } peers { permanent_uuid: "64fedbe39ec148ab8f9e982b6d19f6d2" member_type: VOTER last_known_private_addr { host: "10.0.0.4" port: 7100 } cloud_info { placement_cloud: "hetzner" placement_region: "fsn" placement_zone: "care3" } } }
I0927 03:04:19.736356 2385005 sys_catalog.cc:451] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866 [sys.catalog]: This master's current role is: FOLLOWER
I0927 03:04:19.736366 2385005 tablet_peer.cc:1701] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866 [state=RUNNING]: Changed state from BOOTSTRAPPING to RUNNING
I0927 03:04:19.736370 2385005 transaction_participant.cc:378] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866: Start
I0927 03:04:19.736380 2385005 sys_catalog.cc:447] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866 [sys.catalog]: SysCatalogTable state changed. Locked=0. Reason: Started TabletPeer. Latest consensus state: current_term: 64 leader_uuid: "" config { opid_index: -1 peers { permanent_uuid: "55d29a1415af4e44ac228b2c8a82f866" member_type: VOTER last_known_private_addr { host: "10.0.0.2" port: 7100 } cloud_info { placement_cloud: "hetzner" placement_region: "fsn" placement_zone: "care1" } } peers { permanent_uuid: "a5110a40aa5b46eaa183f0022d8d9063" member_type: VOTER last_known_private_addr { host: "10.0.0.3" port: 7100 } cloud_info { placement_cloud: "hetzner" placement_region: "fsn" placement_zone: "care2" } } peers { permanent_uuid: "64fedbe39ec148ab8f9e982b6d19f6d2" member_type: VOTER last_known_private_addr { host: "10.0.0.4" port: 7100 } cloud_info { placement_cloud: "hetzner" placement_region: "fsn" placement_zone: "care3" } } }
I0927 03:04:19.736388 2385005 sys_catalog.cc:451] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866 [sys.catalog]: This master's current role is: FOLLOWER
I0927 03:04:19.736394 2385005 tablet.cc:5843] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866: Rate limiter (regular db): set bytes_per_second to 1073741824
I0927 03:04:19.736399 2385005 tablet.cc:5843] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866: Rate limiter (intents db): set bytes_per_second to 1073741824
I0927 03:04:19.736450 2385010 transaction_participant.cc:1812] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866: LoadFinished: starting transaction status resolution
I0927 03:04:19.737963 2385005 db_impl.cc:2769] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866 [R]: SetOptions() on column family [default], inputs: [{level0_stop_writes_trigger, 2147483647}, {level0_slowdown_writes_trigger, 2147483647}]
I0927 03:04:19.737975 2385005 db_impl.cc:2773] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866 [R]: [default] SetOptions succeeded
I0927 03:04:19.739696 2385005 db_impl.cc:2769] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866 [R]: SetOptions() on column family [default], inputs: [{disable_auto_compactions, false}]
I0927 03:04:19.739712 2385005 db_impl.cc:2773] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866 [R]: [default] SetOptions succeeded
I0927 03:04:19.741276 2385005 db_impl.cc:2769] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866 [I]: SetOptions() on column family [default], inputs: [{level0_stop_writes_trigger, 2147483647}, {level0_slowdown_writes_trigger, 2147483647}]
I0927 03:04:19.741285 2385005 db_impl.cc:2773] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866 [I]: [default] SetOptions succeeded
I0927 03:04:19.742606 2385005 db_impl.cc:2769] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866 [I]: SetOptions() on column family [default], inputs: [{disable_auto_compactions, false}]
I0927 03:04:19.742616 2385005 db_impl.cc:2773] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866 [I]: [default] SetOptions succeeded
I0927 03:04:19.742628 2385005 tablet_peer.cc:1564] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866 [state=RUNNING]: Registered log gc
I0927 03:04:19.742828 2385005 sys_catalog.cc:713] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866 [sys.catalog]: configured and running, proceeding with master startup.
W0927 03:04:19.743085 2385013 catalog_manager_bg_tasks.cc:396] Catalog manager background task thread going to sleep: Service unavailable (yb/master/scoped_leader_shared_lock.cc:94): Catalog manager is not initialized. State: 1
I0927 03:04:19.743301 2385005 server_base.cc:606] Using private rpc address 10.0.0.2
I0927 03:04:19.743357 2384983 master_main.cc:145] Master server successfully started.
I0927 03:04:19.743815 2385006 universe_key_client.cc:81] Received universe keys from master: 10.0.0.3:7100
I0927 03:04:19.744134 2385006 universe_key_client.cc:81] Received universe keys from master: 10.0.0.4:7100
I0927 03:04:19.744204 2385016 total_mem_watcher.cc:78] Root memtracker limit: 812668108 (775 MiB); this server will stop if memory usage exceeds 200% of that: 1625336216 bytes (1550 MiB).
I0927 03:04:19.839680 2385009 raft_consensus.cc:3695] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866 [term 64 FOLLOWER]: Advancing to term 65
I0927 03:04:19.839731 2385009 consensus_meta.cc:361] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866: Updating active role from FOLLOWER to FOLLOWER. Consensus state: current_term: 65 leader_uuid: "" config { opid_index: -1 peers { permanent_uuid: "55d29a1415af4e44ac228b2c8a82f866" member_type: VOTER last_known_private_addr { host: "10.0.0.2" port: 7100 } cloud_info { placement_cloud: "hetzner" placement_region: "fsn" placement_zone: "care1" } } peers { permanent_uuid: "a5110a40aa5b46eaa183f0022d8d9063" member_type: VOTER last_known_private_addr { host: "10.0.0.3" port: 7100 } cloud_info { placement_cloud: "hetzner" placement_region: "fsn" placement_zone: "care2" } } peers { permanent_uuid: "64fedbe39ec148ab8f9e982b6d19f6d2" member_type: VOTER last_known_private_addr { host: "10.0.0.4" port: 7100 } cloud_info { placement_cloud: "hetzner" placement_region: "fsn" placement_zone: "care3" } } }, has_pending_config = 0
I0927 03:04:19.842811 2385009 raft_consensus.cc:1780] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866 [term 65 FOLLOWER]: Refusing update from remote peer 64fedbe39ec148ab8f9e982b6d19f6d2: Log matching property violated. Preceding OpId in replica: 64.115627. Preceding OpId from leader: 65.115630. (index mismatch)
I0927 03:04:19.842829 2385009 raft_consensus.cc:1996] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866 [term 65 FOLLOWER]: Returning from UpdateConsensus because of error: error { code: PRECEDING_ENTRY_DIDNT_MATCH status { code: ILLEGAL_STATE message: "Log matching property violated. Preceding OpId in replica: 64.115627. Preceding OpId from leader: 65.115630. (index mismatch)" source_file: "../../src/yb/consensus/raft_consensus.cc" source_line: 1778 errors: "00" } }
I0927 03:04:19.848702 2385009 consensus_meta.cc:361] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866: Updating active role from FOLLOWER to FOLLOWER. Consensus state: current_term: 65 leader_uuid: "64fedbe39ec148ab8f9e982b6d19f6d2" config { opid_index: -1 peers { permanent_uuid: "55d29a1415af4e44ac228b2c8a82f866" member_type: VOTER last_known_private_addr { host: "10.0.0.2" port: 7100 } cloud_info { placement_cloud: "hetzner" placement_region: "fsn" placement_zone: "care1" } } peers { permanent_uuid: "a5110a40aa5b46eaa183f0022d8d9063" member_type: VOTER last_known_private_addr { host: "10.0.0.3" port: 7100 } cloud_info { placement_cloud: "hetzner" placement_region: "fsn" placement_zone: "care2" } } peers { permanent_uuid: "64fedbe39ec148ab8f9e982b6d19f6d2" member_type: VOTER last_known_private_addr { host: "10.0.0.4" port: 7100 } cloud_info { placement_cloud: "hetzner" placement_region: "fsn" placement_zone: "care3" } } }, has_pending_config = 0
I0927 03:04:19.848781 2385009 raft_consensus.cc:3580] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866 [term 65 FOLLOWER]: Calling mark dirty synchronously for reason code NEW_LEADER_ELECTED
I0927 03:04:19.848798 2385009 sys_catalog.cc:447] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866 [sys.catalog]: SysCatalogTable state changed. Locked=1. Reason: New leader 64fedbe39ec148ab8f9e982b6d19f6d2 elected. Latest consensus state: current_term: 65 leader_uuid: "64fedbe39ec148ab8f9e982b6d19f6d2" config { opid_index: -1 peers { permanent_uuid: "55d29a1415af4e44ac228b2c8a82f866" member_type: VOTER last_known_private_addr { host: "10.0.0.2" port: 7100 } cloud_info { placement_cloud: "hetzner" placement_region: "fsn" placement_zone: "care1" } } peers { permanent_uuid: "a5110a40aa5b46eaa183f0022d8d9063" member_type: VOTER last_known_private_addr { host: "10.0.0.3" port: 7100 } cloud_info { placement_cloud: "hetzner" placement_region: "fsn" placement_zone: "care2" } } peers { permanent_uuid: "64fedbe39ec148ab8f9e982b6d19f6d2" member_type: VOTER last_known_private_addr { host: "10.0.0.4" port: 7100 } cloud_info { placement_cloud: "hetzner" placement_region: "fsn" placement_zone: "care3" } } }
I0927 03:04:19.848821 2385009 sys_catalog.cc:451] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866 [sys.catalog]: This master's current role is: FOLLOWER
I0927 03:04:19.848850 2385009 replica_state.cc:1215] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866 [term 65 FOLLOWER]: Reset our lease: 1979863.528s
I0927 03:04:19.848879 2385007 client-internal.cc:2923] Reinitialize master addresses from file: ./master.conf
I0927 03:04:19.850307 2385009 raft_consensus.cc:3580] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866 [term 65 FOLLOWER]: Calling mark dirty synchronously for reason code FOLLOWER_NO_OP_COMPLETE
I0927 03:04:19.850344 2385009 sys_catalog.cc:447] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866 [sys.catalog]: SysCatalogTable state changed. Locked=1. Reason: Replicate of NO_OP complete on follower. Latest consensus state: current_term: 65 leader_uuid: "64fedbe39ec148ab8f9e982b6d19f6d2" config { opid_index: -1 peers { permanent_uuid: "55d29a1415af4e44ac228b2c8a82f866" member_type: VOTER last_known_private_addr { host: "10.0.0.2" port: 7100 } cloud_info { placement_cloud: "hetzner" placement_region: "fsn" placement_zone: "care1" } } peers { permanent_uuid: "a5110a40aa5b46eaa183f0022d8d9063" member_type: VOTER last_known_private_addr { host: "10.0.0.3" port: 7100 } cloud_info { placement_cloud: "hetzner" placement_region: "fsn" placement_zone: "care2" } } peers { permanent_uuid: "64fedbe39ec148ab8f9e982b6d19f6d2" member_type: VOTER last_known_private_addr { host: "10.0.0.4" port: 7100 } cloud_info { placement_cloud: "hetzner" placement_region: "fsn" placement_zone: "care3" } } }
I0927 03:04:19.850382 2385009 sys_catalog.cc:451] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866 [sys.catalog]: This master's current role is: FOLLOWER
I0927 03:04:19.850522 2385007 client-internal.cc:2952] New master addresses: [10.0.0.2:7100,10.0.0.3:7100,10.0.0.4:7100, 10.0.0.2:7100, 10.0.0.3:7100, 10.0.0.4:7100]
I0927 03:04:19.975610 2385006 encryption_manager.cc:60] Responding to GetUniverseKeyRegistry request with key ids: 
I0927 03:04:20.242566 2384996 tcp_stream.cc:329] { local: 10.0.0.2:33615 remote: 10.0.0.2:9100 }:  Recv failed: Network error (yb/util/net/socket.cc:542): recvmsg error: Connection refused (system error 111)
W0927 03:04:25.244081 2385009 tablet_rpc.cc:520] Timed out (yb/rpc/outbound_call.cc:685): Failed GetTransactionStatus: tablet_id: "9929a6de95104613a804c2af68648cdf" transaction_id: "\227\344\033\340\252\361BZ\277\377\203(\377L\245\274" propagated_hybrid_time: 7333798953952047104 raft_config_opid_index: 6452450, retrier: { task_id: -1 state: kIdle deadline: 1979868.922s (passed 5.001s of 5.000s) } to tablet 9929a6de95104613a804c2af68648cdf on tablet server { uuid: 9c82b8717cad4642ace41a42feaa6835 private: [host: "10.0.0.3" port: 9100] cloud_info: placement_cloud: "hetzner" placement_region: "fsn" placement_zone: "care2" after 2 attempt(s): GetTransactionStatus RPC (request call id 17) to 10.0.0.3:9100 timed out after 4.996s
W0927 03:04:25.244146 2385009 transaction_status_resolver.cc:239] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866: Failed to request transaction statuses: Timed out (yb/rpc/outbound_call.cc:685): GetTransactionStatus RPC (request call id 17) to 10.0.0.3:9100 timed out after 4.996s
W0927 03:04:30.249311 2385009 tablet_rpc.cc:520] Timed out (yb/rpc/outbound_call.cc:685): Failed GetTransactionStatus: tablet_id: "9929a6de95104613a804c2af68648cdf" transaction_id: "\227\344\033\340\252\361BZ\277\377\203(\377L\245\274" propagated_hybrid_time: 7333798974458351616 raft_config_opid_index: 6452450, retrier: { task_id: -1 state: kIdle deadline: 1979873.928s (passed 5.000s of 5.000s) } to tablet 9929a6de95104613a804c2af68648cdf on tablet server { uuid: 9c82b8717cad4642ace41a42feaa6835 private: [host: "10.0.0.3" port: 9100] cloud_info: placement_cloud: "hetzner" placement_region: "fsn" placement_zone: "care2" after 2 attempt(s): GetTransactionStatus RPC (request call id 20) to 10.0.0.3:9100 timed out after 4.995s
W0927 03:04:30.249396 2385009 transaction_status_resolver.cc:239] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866: Failed to request transaction statuses: Timed out (yb/rpc/outbound_call.cc:685): GetTransactionStatus RPC (request call id 20) to 10.0.0.3:9100 timed out after 4.995s
W0927 03:04:35.262635 2385009 tablet_rpc.cc:520] Timed out (yb/rpc/outbound_call.cc:685): Failed GetTransactionStatus: tablet_id: "9929a6de95104613a804c2af68648cdf" transaction_id: "\227\344\033\340\252\361BZ\277\377\203(\377L\245\274" propagated_hybrid_time: 7333798994990391296 raft_config_opid_index: 6452450, retrier: { task_id: -1 state: kIdle deadline: 1979878.941s (passed 5.000s of 5.000s) } to tablet 9929a6de95104613a804c2af68648cdf on tablet server { uuid: 9c82b8717cad4642ace41a42feaa6835 private: [host: "10.0.0.3" port: 9100] cloud_info: placement_cloud: "hetzner" placement_region: "fsn" placement_zone: "care2" after 2 attempt(s): GetTransactionStatus RPC (request call id 23) to 10.0.0.3:9100 timed out after 4.994s
W0927 03:04:35.262691 2385009 transaction_status_resolver.cc:239] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866: Failed to request transaction statuses: Timed out (yb/rpc/outbound_call.cc:685): GetTransactionStatus RPC (request call id 23) to 10.0.0.3:9100 timed out after 4.994s
W0927 03:04:40.282171 2385009 tablet_rpc.cc:520] Timed out (yb/rpc/outbound_call.cc:685): Failed GetTransactionStatus: tablet_id: "9929a6de95104613a804c2af68648cdf" transaction_id: "\227\344\033\340\252\361BZ\277\377\203(\377L\245\274" propagated_hybrid_time: 7333799015552548864 raft_config_opid_index: 6452450, retrier: { task_id: -1 state: kIdle deadline: 1979883.961s (passed 5.000s of 5.000s) } to tablet 9929a6de95104613a804c2af68648cdf on tablet server { uuid: 9c82b8717cad4642ace41a42feaa6835 private: [host: "10.0.0.3" port: 9100] cloud_info: placement_cloud: "hetzner" placement_region: "fsn" placement_zone: "care2" after 2 attempt(s): GetTransactionStatus RPC (request call id 26) to 10.0.0.3:9100 timed out after 4.994s
W0927 03:04:40.282274 2385009 transaction_status_resolver.cc:239] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866: Failed to request transaction statuses: Timed out (yb/rpc/outbound_call.cc:685): GetTransactionStatus RPC (request call id 26) to 10.0.0.3:9100 timed out after 4.994s
W0927 03:04:45.307974 2385009 tablet_rpc.cc:520] Timed out (yb/rpc/outbound_call.cc:685): Failed GetTransactionStatus: tablet_id: "9929a6de95104613a804c2af68648cdf" transaction_id: "\227\344\033\340\252\361BZ\277\377\203(\377L\245\274" propagated_hybrid_time: 7333799036135493632 raft_config_opid_index: 6452450, retrier: { task_id: -1 state: kIdle deadline: 1979888.986s (passed 5.001s of 5.000s) } to tablet 9929a6de95104613a804c2af68648cdf on tablet server { uuid: 9c82b8717cad4642ace41a42feaa6835 private: [host: "10.0.0.3" port: 9100] cloud_info: placement_cloud: "hetzner" placement_region: "fsn" placement_zone: "care2" after 2 attempt(s): GetTransactionStatus RPC (request call id 29) to 10.0.0.3:9100 timed out after 4.996s
W0927 03:04:45.308040 2385009 transaction_status_resolver.cc:239] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866: Failed to request transaction statuses: Timed out (yb/rpc/outbound_call.cc:685): GetTransactionStatus RPC (request call id 29) to 10.0.0.3:9100 timed out after 4.996s
W0927 03:04:50.238310 2385009 tablet_rpc.cc:520] Timed out (yb/rpc/outbound_call.cc:685): Failed GetTransactionStatus: tablet_id: "9929a6de95104613a804c2af68648cdf" transaction_id: "\227\344\033\340\252\361BZ\277\377\203(\377L\245\274" propagated_hybrid_time: 7333799056710520832 raft_config_opid_index: 6452450, retrier: { task_id: -1 state: kIdle deadline: 1979893.917s (passed 4.908s of 4.908s) } to tablet 9929a6de95104613a804c2af68648cdf on tablet server { uuid: 9c82b8717cad4642ace41a42feaa6835 private: [host: "10.0.0.3" port: 9100] cloud_info: placement_cloud: "hetzner" placement_region: "fsn" placement_zone: "care2" after 2 attempt(s): GetTransactionStatus RPC (request call id 32) to 10.0.0.3:9100 timed out after 4.903s
W0927 03:04:50.238399 2385009 transaction_status_resolver.cc:239] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866: Failed to request transaction statuses: Timed out (yb/rpc/outbound_call.cc:685): GetTransactionStatus RPC (request call id 32) to 10.0.0.3:9100 timed out after 4.903s
W0927 03:04:55.248334 2385009 tablet_rpc.cc:520] Timed out (yb/rpc/outbound_call.cc:685): Failed GetTransactionStatus: tablet_id: "9cff80df6428441c88e29a9b91c3c5d6" transaction_id: "\007\300\331\350]\300K7\251p^i\'0\257\373" propagated_hybrid_time: 7333799076852084736 raft_config_opid_index: 6489123, retrier: { task_id: -1 state: kIdle deadline: 1979898.927s (passed 5.000s of 5.000s) } to tablet 9cff80df6428441c88e29a9b91c3c5d6 on tablet server { uuid: 9c82b8717cad4642ace41a42feaa6835 private: [host: "10.0.0.3" port: 9100] cloud_info: placement_cloud: "hetzner" placement_region: "fsn" placement_zone: "care2" after 2 attempt(s): GetTransactionStatus RPC (request call id 35) to 10.0.0.3:9100 timed out after 4.994s
W0927 03:04:55.248380 2385009 transaction_status_resolver.cc:239] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866: Failed to request transaction statuses: Timed out (yb/rpc/outbound_call.cc:685): GetTransactionStatus RPC (request call id 35) to 10.0.0.3:9100 timed out after 4.994s
W0927 03:05:00.251098 2385009 tablet_rpc.cc:520] Timed out (yb/rpc/outbound_call.cc:685): Failed GetTransactionStatus: tablet_id: "9cff80df6428441c88e29a9b91c3c5d6" transaction_id: "\007\300\331\350]\300K7\251p^i\'0\257\373" propagated_hybrid_time: 7333799097342885888 raft_config_opid_index: 6489123, retrier: { task_id: -1 state: kIdle deadline: 1979903.929s (passed 5.001s of 5.000s) } to tablet 9cff80df6428441c88e29a9b91c3c5d6 on tablet server { uuid: 9c82b8717cad4642ace41a42feaa6835 private: [host: "10.0.0.3" port: 9100] cloud_info: placement_cloud: "hetzner" placement_region: "fsn" placement_zone: "care2" after 2 attempt(s): GetTransactionStatus RPC (request call id 38) to 10.0.0.3:9100 timed out after 4.995s
W0927 03:05:00.251188 2385009 transaction_status_resolver.cc:239] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866: Failed to request transaction statuses: Timed out (yb/rpc/outbound_call.cc:685): GetTransactionStatus RPC (request call id 38) to 10.0.0.3:9100 timed out after 4.995s
W0927 03:05:05.262687 2385009 tablet_rpc.cc:520] Timed out (yb/rpc/outbound_call.cc:685): Failed GetTransactionStatus: tablet_id: "9cff80df6428441c88e29a9b91c3c5d6" transaction_id: "\007\300\331\350]\300K7\251p^i\'0\257\373" propagated_hybrid_time: 7333799117871673344 raft_config_opid_index: 6489123, retrier: { task_id: -1 state: kIdle deadline: 1979908.941s (passed 5.000s of 5.000s) } to tablet 9cff80df6428441c88e29a9b91c3c5d6 on tablet server { uuid: 9c82b8717cad4642ace41a42feaa6835 private: [host: "10.0.0.3" port: 9100] cloud_info: placement_cloud: "hetzner" placement_region: "fsn" placement_zone: "care2" after 2 attempt(s): GetTransactionStatus RPC (request call id 41) to 10.0.0.3:9100 timed out after 4.994s
W0927 03:05:05.262739 2385009 transaction_status_resolver.cc:239] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866: Failed to request transaction statuses: Timed out (yb/rpc/outbound_call.cc:685): GetTransactionStatus RPC (request call id 41) to 10.0.0.3:9100 timed out after 4.994s
W0927 03:05:10.279349 2385009 tablet_rpc.cc:520] Timed out (yb/rpc/outbound_call.cc:685): Failed GetTransactionStatus: tablet_id: "9cff80df6428441c88e29a9b91c3c5d6" transaction_id: "\007\300\331\350]\300K7\251p^i\'0\257\373" propagated_hybrid_time: 7333799138418610176 raft_config_opid_index: 6489123, retrier: { task_id: -1 state: kIdle deadline: 1979913.958s (passed 5.000s of 5.000s) } to tablet 9cff80df6428441c88e29a9b91c3c5d6 on tablet server { uuid: 429247ef0cef4654b978a50b32d230b5 private: [host: "10.0.0.2" port: 9100] cloud_info: placement_cloud: "hetzner" placement_region: "fsn" placement_zone: "care1" after 1 attempt(s): GetTransactionStatus RPC (request call id 46) to 10.0.0.2:9100 timed out after 5.000s
W0927 03:05:10.279476 2385009 transaction_status_resolver.cc:239] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866: Failed to request transaction statuses: Timed out (yb/rpc/outbound_call.cc:685): GetTransactionStatus RPC (request call id 46) to 10.0.0.2:9100 timed out after 5.000s
W0927 03:05:15.298125 2385009 tablet_rpc.cc:520] Timed out (yb/rpc/outbound_call.cc:685): Failed GetTransactionStatus: tablet_id: "9cff80df6428441c88e29a9b91c3c5d6" transaction_id: "\007\300\331\350]\300K7\251p^i\'0\257\373" propagated_hybrid_time: 7333799158975533056 raft_config_opid_index: 6489123, retrier: { task_id: -1 state: kIdle deadline: 1979918.976s (passed 5.001s of 5.000s) } to tablet 9cff80df6428441c88e29a9b91c3c5d6 on tablet server { uuid: 429247ef0cef4654b978a50b32d230b5 private: [host: "10.0.0.2" port: 9100] cloud_info: placement_cloud: "hetzner" placement_region: "fsn" placement_zone: "care1" after 1 attempt(s): GetTransactionStatus RPC (request call id 48) to 10.0.0.2:9100 timed out after 5.000s
W0927 03:05:15.298184 2385009 transaction_status_resolver.cc:239] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866: Failed to request transaction statuses: Timed out (yb/rpc/outbound_call.cc:685): GetTransactionStatus RPC (request call id 48) to 10.0.0.2:9100 timed out after 5.000s
I0927 03:05:18.591579 2385006 encryption_manager.cc:49] After AddUniverseKeys, key ids in memory: prime
W0927 03:05:20.246588 2385009 tablet_rpc.cc:520] Timed out (yb/rpc/outbound_call.cc:685): Failed GetTransactionStatus: tablet_id: "9cff80df6428441c88e29a9b91c3c5d6" transaction_id: "\007\300\331\350]\300K7\251p^i\'0\257\373" propagated_hybrid_time: 7333799179566297088 raft_config_opid_index: 6489123, retrier: { task_id: -1 state: kIdle deadline: 1979923.925s (passed 4.922s of 4.922s) } to tablet 9cff80df6428441c88e29a9b91c3c5d6 on tablet server { uuid: 9c82b8717cad4642ace41a42feaa6835 private: [host: "10.0.0.3" port: 9100] cloud_info: placement_cloud: "hetzner" placement_region: "fsn" placement_zone: "care2" after 2 attempt(s): GetTransactionStatus RPC (request call id 51) to 10.0.0.3:9100 timed out after 0.697s
W0927 03:05:20.246619 2385009 transaction_status_resolver.cc:239] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866: Failed to request transaction statuses: Timed out (yb/rpc/outbound_call.cc:685): GetTransactionStatus RPC (request call id 51) to 10.0.0.3:9100 timed out after 0.697s
I0927 03:05:21.350939 2384994 tablet_rpc.cc:172] Unable to pick leader for 9929a6de95104613a804c2af68648cdf, replicas: [0x0000313d31a052b0 -> { uuid: 4b655113a45248e5b5cef75067b9b6a3 private: [host: "10.0.0.4" port: 9100] cloud_info: placement_cloud: "hetzner" placement_region: "fsn" placement_zone: "care3"], followers: [{0x0000313d31a052b0 -> { uuid: 4b655113a45248e5b5cef75067b9b6a3 private: [host: "10.0.0.4" port: 9100] cloud_info: placement_cloud: "hetzner" placement_region: "fsn" placement_zone: "care3", { status: Illegal state (yb/consensus/consensus.cc:154): Not the leader (tablet server error 15) time: 0.003s }}, {0x0000313d3ffa45b0 -> { uuid: 9c82b8717cad4642ace41a42feaa6835 private: [host: "10.0.0.3" port: 9100] cloud_info: placement_cloud: "hetzner" placement_region: "fsn" placement_zone: "care2", { status: Illegal state (yb/tserver/service_util.cc:295): Tablet 9929a6de95104613a804c2af68648cdf not RUNNING: NOT_STARTED (tablet server error 12) (raft group state error 5) time: 0.013s }}, {0x0000313d3f06c820 -> { uuid: 429247ef0cef4654b978a50b32d230b5 private: [host: "10.0.0.2" port: 9100] cloud_info: placement_cloud: "hetzner" placement_region: "fsn" placement_zone: "care1", { status: Illegal state (yb/tserver/service_util.cc:295): Tablet 9929a6de95104613a804c2af68648cdf not RUNNING: NOT_STARTED (tablet server error 12) (raft group state error 5) time: 1.065s }}]
I0927 03:14:19.976261 2384999 retryable_requests.cc:468] T 00000000000000000000000000000000 P 55d29a1415af4e44ac228b2c8a82f866 [sys.catalog]: Removing client 719084d6-0917-42ba-9dc5-e63e23fe779c
I0927 06:04:18.578945 2384991 pg_client_service.cc:2621] Fetching set of database oids
I0927 06:04:18.580090 2384991 pg_client_service.cc:2628] Successfully fetched 7 database oids
I0927 06:04:18.580153 2384991 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I0927 09:04:18.580251 2384993 pg_client_service.cc:2621] Fetching set of database oids
I0927 09:04:18.581280 2384993 pg_client_service.cc:2628] Successfully fetched 7 database oids
I0927 09:04:18.581300 2384993 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I0927 12:04:18.581418 2384990 pg_client_service.cc:2621] Fetching set of database oids
I0927 12:04:18.582605 2384990 pg_client_service.cc:2628] Successfully fetched 7 database oids
I0927 12:04:18.582636 2384990 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I0927 15:04:18.582732 2384992 pg_client_service.cc:2621] Fetching set of database oids
I0927 15:04:18.583971 2384992 pg_client_service.cc:2628] Successfully fetched 7 database oids
I0927 15:04:18.584008 2384992 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I0927 18:04:18.584164 2384990 pg_client_service.cc:2621] Fetching set of database oids
I0927 18:04:18.585280 2384990 pg_client_service.cc:2628] Successfully fetched 7 database oids
I0927 18:04:18.585318 2384990 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I0927 21:04:18.585438 2384991 pg_client_service.cc:2621] Fetching set of database oids
I0927 21:04:18.586475 2384991 pg_client_service.cc:2628] Successfully fetched 7 database oids
I0927 21:04:18.586501 2384991 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I0928 00:04:18.586632 2384993 pg_client_service.cc:2621] Fetching set of database oids
I0928 00:04:18.588027 2384993 pg_client_service.cc:2628] Successfully fetched 7 database oids
I0928 00:04:18.588068 2384993 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I0928 03:04:18.588202 2384991 pg_client_service.cc:2621] Fetching set of database oids
I0928 03:04:18.589274 2384991 pg_client_service.cc:2628] Successfully fetched 7 database oids
I0928 03:04:18.589294 2384991 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I0928 06:04:18.589401 2384991 pg_client_service.cc:2621] Fetching set of database oids
I0928 06:04:18.590668 2384991 pg_client_service.cc:2628] Successfully fetched 7 database oids
I0928 06:04:18.590698 2384991 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I0928 06:31:04.398476 489843 pprof-path-handlers.cc:195] Starting a heap profile: seconds=1 only_growth=0 sample_freq_bytes=10485760
I0928 06:31:04.398502 489843 tcmalloc_profile.cc:122] Sleeping for 1 seconds while profile is collected.
I0928 06:31:05.398610 489843 tcmalloc_profile.cc:145] Analyzing TCMalloc sampling profile
I0928 06:31:08.995636 489843 tcmalloc_profile.cc:145] Analyzing TCMalloc sampling profile
W0928 06:31:09.206180 489843 tcmalloc_profile.cc:194] Failed to symbolize 165 symbols
I0928 09:04:18.590823 2384992 pg_client_service.cc:2621] Fetching set of database oids
I0928 09:04:18.592036 2384992 pg_client_service.cc:2628] Successfully fetched 7 database oids
I0928 09:04:18.592067 2384992 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I0928 12:04:18.592180 2384990 pg_client_service.cc:2621] Fetching set of database oids
I0928 12:04:18.593343 2384990 pg_client_service.cc:2628] Successfully fetched 7 database oids
I0928 12:04:18.593401 2384990 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I0928 15:04:18.593509 2384992 pg_client_service.cc:2621] Fetching set of database oids
I0928 15:04:18.595131 2384992 pg_client_service.cc:2628] Successfully fetched 7 database oids
I0928 15:04:18.595167 2384992 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I0928 18:04:18.595250 2384991 pg_client_service.cc:2621] Fetching set of database oids
I0928 18:04:18.596546 2384991 pg_client_service.cc:2628] Successfully fetched 7 database oids
I0928 18:04:18.596575 2384991 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I0928 21:04:18.596661 2384993 pg_client_service.cc:2621] Fetching set of database oids
I0928 21:04:18.597860 2384993 pg_client_service.cc:2628] Successfully fetched 7 database oids
I0928 21:04:18.597872 2384993 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I0929 00:04:18.597980 2384993 pg_client_service.cc:2621] Fetching set of database oids
I0929 00:04:18.599465 2384993 pg_client_service.cc:2628] Successfully fetched 7 database oids
I0929 00:04:18.599505 2384993 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I0929 03:04:18.599618 2384992 pg_client_service.cc:2621] Fetching set of database oids
I0929 03:04:18.600776 2384992 pg_client_service.cc:2628] Successfully fetched 7 database oids
I0929 03:04:18.600816 2384992 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I0929 06:04:18.600886 2384991 pg_client_service.cc:2621] Fetching set of database oids
I0929 06:04:18.601800 2384991 pg_client_service.cc:2628] Successfully fetched 7 database oids
I0929 06:04:18.601838 2384991 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I0929 09:04:18.601989 2384991 pg_client_service.cc:2621] Fetching set of database oids
I0929 09:04:18.603047 2384991 pg_client_service.cc:2628] Successfully fetched 7 database oids
I0929 09:04:18.603084 2384991 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I0929 12:04:18.603220 2384992 pg_client_service.cc:2621] Fetching set of database oids
I0929 12:04:18.604511 2384992 pg_client_service.cc:2628] Successfully fetched 7 database oids
I0929 12:04:18.604549 2384992 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I0929 15:04:18.604662 2384992 pg_client_service.cc:2621] Fetching set of database oids
I0929 15:04:18.605834 2384992 pg_client_service.cc:2628] Successfully fetched 7 database oids
I0929 15:04:18.605861 2384992 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I0929 15:07:29.564047 3226288 tcmalloc_profile.cc:145] Analyzing TCMalloc sampling profile
W0929 15:07:29.579316 3226288 tcmalloc_profile.cc:194] Failed to symbolize 165 symbols
I0929 18:04:18.606062 2384993 pg_client_service.cc:2621] Fetching set of database oids
I0929 18:04:18.607336 2384993 pg_client_service.cc:2628] Successfully fetched 7 database oids
I0929 18:04:18.607373 2384993 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I0929 21:04:18.607504 2384991 pg_client_service.cc:2621] Fetching set of database oids
I0929 21:04:18.608747 2384991 pg_client_service.cc:2628] Successfully fetched 7 database oids
I0929 21:04:18.608781 2384991 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I0930 00:04:18.608932 2384993 pg_client_service.cc:2621] Fetching set of database oids
I0930 00:04:18.610071 2384993 pg_client_service.cc:2628] Successfully fetched 7 database oids
I0930 00:04:18.610087 2384993 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I0930 03:04:18.610191 2384991 pg_client_service.cc:2621] Fetching set of database oids
I0930 03:04:18.611182 2384991 pg_client_service.cc:2628] Successfully fetched 7 database oids
I0930 03:04:18.611227 2384991 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I0930 06:04:18.611388 2384993 pg_client_service.cc:2621] Fetching set of database oids
I0930 06:04:18.612601 2384993 pg_client_service.cc:2628] Successfully fetched 7 database oids
I0930 06:04:18.612639 2384993 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I0930 09:04:18.612779 2384992 pg_client_service.cc:2621] Fetching set of database oids
I0930 09:04:18.614130 2384992 pg_client_service.cc:2628] Successfully fetched 7 database oids
I0930 09:04:18.614166 2384992 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I0930 12:04:18.614276 2384992 pg_client_service.cc:2621] Fetching set of database oids
I0930 12:04:18.615316 2384992 pg_client_service.cc:2628] Successfully fetched 7 database oids
I0930 12:04:18.615343 2384992 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I0930 15:04:18.615568 2384990 pg_client_service.cc:2621] Fetching set of database oids
I0930 15:04:18.617129 2384990 pg_client_service.cc:2628] Successfully fetched 7 database oids
I0930 15:04:18.617167 2384990 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I0930 18:04:18.617322 2384992 pg_client_service.cc:2621] Fetching set of database oids
I0930 18:04:18.618695 2384992 pg_client_service.cc:2628] Successfully fetched 7 database oids
I0930 18:04:18.618717 2384992 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I0930 21:04:18.618808 2384992 pg_client_service.cc:2621] Fetching set of database oids
I0930 21:04:18.619823 2384992 pg_client_service.cc:2628] Successfully fetched 7 database oids
I0930 21:04:18.619836 2384992 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1001 00:04:18.619969 2384991 pg_client_service.cc:2621] Fetching set of database oids
I1001 00:04:18.621320 2384991 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1001 00:04:18.621379 2384991 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1001 03:04:18.621480 2384990 pg_client_service.cc:2621] Fetching set of database oids
I1001 03:04:18.622535 2384990 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1001 03:04:18.622628 2384990 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1001 06:04:18.622779 2384990 pg_client_service.cc:2621] Fetching set of database oids
I1001 06:04:18.624131 2384990 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1001 06:04:18.624166 2384990 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1001 09:04:18.624282 2384990 pg_client_service.cc:2621] Fetching set of database oids
I1001 09:04:18.625274 2384990 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1001 09:04:18.625305 2384990 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1001 12:04:18.625381 2384993 pg_client_service.cc:2621] Fetching set of database oids
I1001 12:04:18.626359 2384993 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1001 12:04:18.626399 2384993 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1001 15:04:18.626505 2384993 pg_client_service.cc:2621] Fetching set of database oids
I1001 15:04:18.627373 2384993 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1001 15:04:18.627410 2384993 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1001 16:17:00.559118 3140136 pprof-path-handlers.cc:195] Starting a heap profile: seconds=1 only_growth=0 sample_freq_bytes=10485760
I1001 16:17:00.559167 3140136 tcmalloc_profile.cc:122] Sleeping for 1 seconds while profile is collected.
I1001 16:17:01.559448 3140136 tcmalloc_profile.cc:145] Analyzing TCMalloc sampling profile
I1001 16:17:09.100935 3140333 tcmalloc_profile.cc:145] Analyzing TCMalloc sampling profile
W1001 16:17:09.108690 3140333 tcmalloc_profile.cc:194] Failed to symbolize 165 symbols
I1001 18:04:18.628405 2384993 pg_client_service.cc:2621] Fetching set of database oids
I1001 18:04:18.629789 2384993 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1001 18:04:18.629822 2384993 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1001 21:04:18.629866 2384993 pg_client_service.cc:2621] Fetching set of database oids
I1001 21:04:18.630785 2384993 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1001 21:04:18.630800 2384993 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1002 00:04:18.630957 2384992 pg_client_service.cc:2621] Fetching set of database oids
I1002 00:04:18.632192 2384992 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1002 00:04:18.632225 2384992 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1002 00:42:27.315092 3843627 pprof-path-handlers.cc:195] Starting a heap profile: seconds=1 only_growth=0 sample_freq_bytes=10485760
I1002 00:42:27.315155 3843627 tcmalloc_profile.cc:122] Sleeping for 1 seconds while profile is collected.
I1002 00:42:28.315297 3843627 tcmalloc_profile.cc:145] Analyzing TCMalloc sampling profile
I1002 03:04:18.632424 2384990 pg_client_service.cc:2621] Fetching set of database oids
I1002 03:04:18.633512 2384990 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1002 03:04:18.633550 2384990 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1002 06:04:18.633682 2384990 pg_client_service.cc:2621] Fetching set of database oids
I1002 06:04:18.634863 2384990 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1002 06:04:18.634877 2384990 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1002 09:04:18.634981 2384992 pg_client_service.cc:2621] Fetching set of database oids
I1002 09:04:18.636008 2384992 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1002 09:04:18.636047 2384992 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1002 12:04:18.636174 2384993 pg_client_service.cc:2621] Fetching set of database oids
I1002 12:04:18.637290 2384993 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1002 12:04:18.637328 2384993 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1002 15:04:18.637444 2384990 pg_client_service.cc:2621] Fetching set of database oids
I1002 15:04:18.638454 2384990 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1002 15:04:18.638489 2384990 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1002 18:04:18.638645 2384992 pg_client_service.cc:2621] Fetching set of database oids
I1002 18:04:18.639966 2384992 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1002 18:04:18.640014 2384992 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1002 21:04:18.640177 2384993 pg_client_service.cc:2621] Fetching set of database oids
I1002 21:04:18.641541 2384993 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1002 21:04:18.641574 2384993 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1003 00:04:18.641693 2384992 pg_client_service.cc:2621] Fetching set of database oids
I1003 00:04:18.642812 2384992 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1003 00:04:18.642840 2384992 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1003 03:04:18.643060 2384990 pg_client_service.cc:2621] Fetching set of database oids
I1003 03:04:18.644562 2384990 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1003 03:04:18.644608 2384990 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1003 06:04:18.644718 2384990 pg_client_service.cc:2621] Fetching set of database oids
I1003 06:04:18.645826 2384990 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1003 06:04:18.645866 2384990 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1003 09:04:18.646003 2384991 pg_client_service.cc:2621] Fetching set of database oids
I1003 09:04:18.647120 2384991 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1003 09:04:18.647150 2384991 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1003 12:04:18.647266 2384993 pg_client_service.cc:2621] Fetching set of database oids
I1003 12:04:18.648361 2384993 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1003 12:04:18.648406 2384993 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1003 15:04:18.648595 2384993 pg_client_service.cc:2621] Fetching set of database oids
I1003 15:04:18.650040 2384993 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1003 15:04:18.650099 2384993 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1003 16:55:05.858295 3008276 tcmalloc_profile.cc:145] Analyzing TCMalloc sampling profile
W1003 16:55:05.873071 3008276 tcmalloc_profile.cc:194] Failed to symbolize 165 symbols
I1003 16:55:25.082221 3008783 pprof-path-handlers.cc:195] Starting a heap profile: seconds=1 only_growth=0 sample_freq_bytes=10485760
I1003 16:55:25.082252 3008783 tcmalloc_profile.cc:122] Sleeping for 1 seconds while profile is collected.
I1003 16:55:26.082376 3008783 tcmalloc_profile.cc:145] Analyzing TCMalloc sampling profile
I1003 18:04:18.650195 2384991 pg_client_service.cc:2621] Fetching set of database oids
I1003 18:04:18.651134 2384991 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1003 18:04:18.651163 2384991 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1003 21:04:18.651270 2384990 pg_client_service.cc:2621] Fetching set of database oids
I1003 21:04:18.652467 2384990 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1003 21:04:18.652520 2384990 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1004 00:04:18.652658 2384992 pg_client_service.cc:2621] Fetching set of database oids
I1004 00:04:18.653677 2384992 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1004 00:04:18.653714 2384992 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1004 03:04:18.653868 2384991 pg_client_service.cc:2621] Fetching set of database oids
I1004 03:04:18.655134 2384991 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1004 03:04:18.655167 2384991 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1004 06:04:18.655325 2384993 pg_client_service.cc:2621] Fetching set of database oids
I1004 06:04:18.656349 2384993 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1004 06:04:18.656380 2384993 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1004 09:04:18.656488 2384991 pg_client_service.cc:2621] Fetching set of database oids
I1004 09:04:18.657838 2384991 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1004 09:04:18.657900 2384991 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1004 12:04:18.658001 2384992 pg_client_service.cc:2621] Fetching set of database oids
I1004 12:04:18.659075 2384992 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1004 12:04:18.659094 2384992 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1004 15:04:18.659232 2384991 pg_client_service.cc:2621] Fetching set of database oids
I1004 15:04:18.660492 2384991 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1004 15:04:18.660527 2384991 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1004 18:04:18.660684 2384993 pg_client_service.cc:2621] Fetching set of database oids
I1004 18:04:18.661661 2384993 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1004 18:04:18.661684 2384993 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1004 21:04:18.661774 2384990 pg_client_service.cc:2621] Fetching set of database oids
I1004 21:04:18.662741 2384990 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1004 21:04:18.662765 2384990 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1005 00:04:18.662904 2384990 pg_client_service.cc:2621] Fetching set of database oids
I1005 00:04:18.664047 2384990 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1005 00:04:18.664084 2384990 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1005 03:04:18.664165 2384990 pg_client_service.cc:2621] Fetching set of database oids
I1005 03:04:18.665078 2384990 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1005 03:04:18.665094 2384990 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1005 06:04:18.665215 2384990 pg_client_service.cc:2621] Fetching set of database oids
I1005 06:04:18.666301 2384990 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1005 06:04:18.666311 2384990 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1005 09:04:18.666422 2384990 pg_client_service.cc:2621] Fetching set of database oids
I1005 09:04:18.667533 2384990 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1005 09:04:18.667569 2384990 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1005 12:04:18.667713 2384991 pg_client_service.cc:2621] Fetching set of database oids
I1005 12:04:18.668840 2384991 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1005 12:04:18.668896 2384991 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1005 15:04:18.669028 2384991 pg_client_service.cc:2621] Fetching set of database oids
I1005 15:04:18.670007 2384991 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1005 15:04:18.670027 2384991 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1005 18:04:18.670121 2384991 pg_client_service.cc:2621] Fetching set of database oids
I1005 18:04:18.671196 2384991 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1005 18:04:18.671233 2384991 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1005 21:04:18.671331 2384992 pg_client_service.cc:2621] Fetching set of database oids
I1005 21:04:18.672310 2384992 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1005 21:04:18.672343 2384992 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1006 00:04:18.672417 2384992 pg_client_service.cc:2621] Fetching set of database oids
I1006 00:04:18.673395 2384992 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1006 00:04:18.673411 2384992 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1006 03:04:18.673506 2384990 pg_client_service.cc:2621] Fetching set of database oids
I1006 03:04:18.674469 2384990 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1006 03:04:18.674494 2384990 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1006 06:04:18.674665 2384992 pg_client_service.cc:2621] Fetching set of database oids
I1006 06:04:18.675648 2384992 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1006 06:04:18.675706 2384992 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1006 09:04:18.675868 2384992 pg_client_service.cc:2621] Fetching set of database oids
I1006 09:04:18.676954 2384992 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1006 09:04:18.677006 2384992 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1006 12:04:18.677109 2384993 pg_client_service.cc:2621] Fetching set of database oids
I1006 12:04:18.678128 2384993 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1006 12:04:18.678151 2384993 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1006 15:04:18.678305 2384993 pg_client_service.cc:2621] Fetching set of database oids
I1006 15:04:18.679239 2384993 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1006 15:04:18.679256 2384993 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1006 18:04:18.679333 2384992 pg_client_service.cc:2621] Fetching set of database oids
I1006 18:04:18.680387 2384992 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1006 18:04:18.680472 2384992 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1006 21:04:18.680617 2384990 pg_client_service.cc:2621] Fetching set of database oids
I1006 21:04:18.681720 2384990 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1006 21:04:18.681761 2384990 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1007 00:04:18.682044 2384993 pg_client_service.cc:2621] Fetching set of database oids
I1007 00:04:18.683339 2384993 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1007 00:04:18.683411 2384993 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1007 01:50:51.812769 1382364 tcmalloc_profile.cc:145] Analyzing TCMalloc sampling profile
W1007 01:50:51.829141 1382364 tcmalloc_profile.cc:194] Failed to symbolize 165 symbols
I1007 03:04:18.683516 2384990 pg_client_service.cc:2621] Fetching set of database oids
I1007 03:04:18.684724 2384990 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1007 03:04:18.684815 2384990 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1007 04:09:42.496596 1576325 pprof-path-handlers.cc:195] Starting a heap profile: seconds=1 only_growth=0 sample_freq_bytes=10485760
I1007 04:09:42.496738 1576325 tcmalloc_profile.cc:122] Sleeping for 1 seconds while profile is collected.
I1007 04:09:42.496799 1576326 tcmalloc_profile.cc:145] Analyzing TCMalloc sampling profile
W1007 04:09:42.519723 1576326 tcmalloc_profile.cc:194] Failed to symbolize 165 symbols
I1007 04:09:43.496865 1576325 tcmalloc_profile.cc:145] Analyzing TCMalloc sampling profile
W1007 04:09:43.578279 1576325 tcmalloc_profile.cc:194] Failed to symbolize 14 symbols
I1007 06:04:18.684939 2384991 pg_client_service.cc:2621] Fetching set of database oids
I1007 06:04:18.686113 2384991 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1007 06:04:18.686152 2384991 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1007 09:04:18.686264 2384993 pg_client_service.cc:2621] Fetching set of database oids
I1007 09:04:18.687440 2384993 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1007 09:04:18.687459 2384993 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1007 12:04:18.687562 2384991 pg_client_service.cc:2621] Fetching set of database oids
I1007 12:04:18.688797 2384991 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1007 12:04:18.688832 2384991 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1007 15:04:18.689031 2384991 pg_client_service.cc:2621] Fetching set of database oids
I1007 15:04:18.690212 2384991 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1007 15:04:18.690265 2384991 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1007 18:04:18.690395 2384993 pg_client_service.cc:2621] Fetching set of database oids
I1007 18:04:18.691501 2384993 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1007 18:04:18.691521 2384993 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1007 21:04:18.691622 2384990 pg_client_service.cc:2621] Fetching set of database oids
I1007 21:04:18.692679 2384990 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1007 21:04:18.692708 2384990 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1008 00:04:18.692821 2384992 pg_client_service.cc:2621] Fetching set of database oids
I1008 00:04:18.693861 2384992 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1008 00:04:18.693882 2384992 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1008 03:04:18.694025 2384990 pg_client_service.cc:2621] Fetching set of database oids
I1008 03:04:18.695152 2384990 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1008 03:04:18.695214 2384990 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1008 06:04:18.695335 2384992 pg_client_service.cc:2621] Fetching set of database oids
I1008 06:04:18.696437 2384992 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1008 06:04:18.696461 2384992 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1008 09:04:18.696581 2384992 pg_client_service.cc:2621] Fetching set of database oids
I1008 09:04:18.697598 2384992 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1008 09:04:18.697619 2384992 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1008 12:04:18.697736 2384992 pg_client_service.cc:2621] Fetching set of database oids
I1008 12:04:18.698941 2384992 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1008 12:04:18.699000 2384992 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1008 12:43:31.169061 112655 tcmalloc_profile.cc:145] Analyzing TCMalloc sampling profile
W1008 12:43:31.194253 112655 tcmalloc_profile.cc:194] Failed to symbolize 165 symbols
I1008 12:53:04.362002 126009 pprof-path-handlers.cc:195] Starting a heap profile: seconds=1 only_growth=0 sample_freq_bytes=10485760
I1008 12:53:04.362042 126009 tcmalloc_profile.cc:122] Sleeping for 1 seconds while profile is collected.
I1008 12:53:05.362161 126009 tcmalloc_profile.cc:145] Analyzing TCMalloc sampling profile
I1008 15:04:18.699087 2384992 pg_client_service.cc:2621] Fetching set of database oids
I1008 15:04:18.699992 2384992 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1008 15:04:18.700031 2384992 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1008 18:04:18.700165 2384992 pg_client_service.cc:2621] Fetching set of database oids
I1008 18:04:18.701447 2384992 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1008 18:04:18.701462 2384992 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1008 21:04:18.701604 2384990 pg_client_service.cc:2621] Fetching set of database oids
I1008 21:04:18.702699 2384990 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1008 21:04:18.702761 2384990 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1009 00:04:18.702896 2384990 pg_client_service.cc:2621] Fetching set of database oids
I1009 00:04:18.704067 2384990 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1009 00:04:18.704095 2384990 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1009 03:04:18.704176 2384991 pg_client_service.cc:2621] Fetching set of database oids
I1009 03:04:18.704846 2384991 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1009 03:04:18.704866 2384991 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1009 06:04:18.704991 2384993 pg_client_service.cc:2621] Fetching set of database oids
I1009 06:04:18.705976 2384993 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1009 06:04:18.705997 2384993 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1009 09:04:18.706166 2384993 pg_client_service.cc:2621] Fetching set of database oids
I1009 09:04:18.707325 2384993 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1009 09:04:18.707360 2384993 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1009 10:28:29.079058 1940090 pprof-path-handlers.cc:195] Starting a heap profile: seconds=1 only_growth=0 sample_freq_bytes=10485760
I1009 10:28:29.079114 1940090 tcmalloc_profile.cc:122] Sleeping for 1 seconds while profile is collected.
I1009 10:28:30.079212 1940090 tcmalloc_profile.cc:145] Analyzing TCMalloc sampling profile
I1009 12:04:18.707518 2384992 pg_client_service.cc:2621] Fetching set of database oids
I1009 12:04:18.708796 2384992 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1009 12:04:18.708841 2384992 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1009 15:04:18.708985 2384990 pg_client_service.cc:2621] Fetching set of database oids
I1009 15:04:18.709986 2384990 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1009 15:04:18.710055 2384990 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1009 18:04:18.710203 2384993 pg_client_service.cc:2621] Fetching set of database oids
I1009 18:04:18.711557 2384993 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1009 18:04:18.711591 2384993 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1009 21:04:18.711740 2384992 pg_client_service.cc:2621] Fetching set of database oids
I1009 21:04:18.712751 2384992 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1009 21:04:18.712776 2384992 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1010 00:04:18.712947 2384993 pg_client_service.cc:2621] Fetching set of database oids
I1010 00:04:18.713996 2384993 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1010 00:04:18.714028 2384993 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1010 03:04:18.714154 2384990 pg_client_service.cc:2621] Fetching set of database oids
I1010 03:04:18.715199 2384990 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1010 03:04:18.715225 2384990 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1010 06:04:18.715394 2384990 pg_client_service.cc:2621] Fetching set of database oids
I1010 06:04:18.716322 2384990 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1010 06:04:18.716346 2384990 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1010 09:04:18.716425 2384992 pg_client_service.cc:2621] Fetching set of database oids
I1010 09:04:18.717456 2384992 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1010 09:04:18.717481 2384992 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1010 12:04:18.717644 2384991 pg_client_service.cc:2621] Fetching set of database oids
I1010 12:04:18.718997 2384991 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1010 12:04:18.719023 2384991 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1010 15:04:18.719151 2384991 pg_client_service.cc:2621] Fetching set of database oids
I1010 15:04:18.720738 2384991 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1010 15:04:18.720774 2384991 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1010 17:50:22.896454 371442 tcmalloc_profile.cc:145] Analyzing TCMalloc sampling profile
W1010 17:50:22.911528 371442 tcmalloc_profile.cc:194] Failed to symbolize 165 symbols
I1010 17:50:23.154654 371442 pprof-path-handlers.cc:195] Starting a heap profile: seconds=1 only_growth=0 sample_freq_bytes=10485760
I1010 17:50:23.154713 371442 tcmalloc_profile.cc:122] Sleeping for 1 seconds while profile is collected.
I1010 17:50:24.154825 371442 tcmalloc_profile.cc:145] Analyzing TCMalloc sampling profile
W1010 17:50:24.155035 371442 tcmalloc_profile.cc:194] Failed to symbolize 2 symbols
I1010 18:04:18.720884 2384990 pg_client_service.cc:2621] Fetching set of database oids
I1010 18:04:18.722138 2384990 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1010 18:04:18.722177 2384990 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1010 21:04:18.722314 2384992 pg_client_service.cc:2621] Fetching set of database oids
I1010 21:04:18.723352 2384992 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1010 21:04:18.723389 2384992 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1011 00:04:18.723528 2384991 pg_client_service.cc:2621] Fetching set of database oids
I1011 00:04:18.724376 2384991 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1011 00:04:18.724404 2384991 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1011 03:04:18.724481 2384992 pg_client_service.cc:2621] Fetching set of database oids
I1011 03:04:18.725433 2384992 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1011 03:04:18.725450 2384992 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1011 06:04:18.725567 2384991 pg_client_service.cc:2621] Fetching set of database oids
I1011 06:04:18.726598 2384991 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1011 06:04:18.726652 2384991 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1011 09:04:18.726791 2384992 pg_client_service.cc:2621] Fetching set of database oids
I1011 09:04:18.727900 2384992 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1011 09:04:18.727980 2384992 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1011 12:04:18.728093 2384992 pg_client_service.cc:2621] Fetching set of database oids
I1011 12:04:18.729303 2384992 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1011 12:04:18.729326 2384992 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1011 14:57:21.830148 2138887 pprof-path-handlers.cc:195] Starting a heap profile: seconds=1 only_growth=0 sample_freq_bytes=10485760
I1011 14:57:21.830209 2138887 tcmalloc_profile.cc:122] Sleeping for 1 seconds while profile is collected.
I1011 14:57:21.837450 2138895 tcmalloc_profile.cc:145] Analyzing TCMalloc sampling profile
W1011 14:57:21.888036 2138895 tcmalloc_profile.cc:194] Failed to symbolize 169 symbols
I1011 14:57:22.830344 2138887 tcmalloc_profile.cc:145] Analyzing TCMalloc sampling profile
W1011 14:57:22.859342 2138887 tcmalloc_profile.cc:194] Failed to symbolize 20 symbols
I1011 15:04:18.729451 2384992 pg_client_service.cc:2621] Fetching set of database oids
I1011 15:04:18.730312 2384992 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1011 15:04:18.730336 2384992 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1011 18:04:18.730471 2384990 pg_client_service.cc:2621] Fetching set of database oids
I1011 18:04:18.731600 2384990 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1011 18:04:18.731639 2384990 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1011 21:04:18.731748 2384990 pg_client_service.cc:2621] Fetching set of database oids
I1011 21:04:18.732883 2384990 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1011 21:04:18.732944 2384990 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1012 00:04:18.733090 2384993 pg_client_service.cc:2621] Fetching set of database oids
I1012 00:04:18.734246 2384993 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1012 00:04:18.734282 2384993 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1012 03:04:18.734452 2384993 pg_client_service.cc:2621] Fetching set of database oids
I1012 03:04:18.735612 2384993 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1012 03:04:18.735657 2384993 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1012 06:04:18.735839 2384990 pg_client_service.cc:2621] Fetching set of database oids
I1012 06:04:18.736987 2384990 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1012 06:04:18.737022 2384990 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1012 09:04:18.737135 2384992 pg_client_service.cc:2621] Fetching set of database oids
I1012 09:04:18.738111 2384992 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1012 09:04:18.738132 2384992 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1012 12:04:18.738289 2384990 pg_client_service.cc:2621] Fetching set of database oids
I1012 12:04:18.739351 2384990 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1012 12:04:18.739387 2384990 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1012 15:04:18.739531 2384991 pg_client_service.cc:2621] Fetching set of database oids
I1012 15:04:18.741173 2384991 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1012 15:04:18.741189 2384991 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1012 18:04:18.741329 2384990 pg_client_service.cc:2621] Fetching set of database oids
I1012 18:04:18.742501 2384990 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1012 18:04:18.742528 2384990 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1012 21:04:18.742671 2384991 pg_client_service.cc:2621] Fetching set of database oids
I1012 21:04:18.743943 2384991 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1012 21:04:18.744004 2384991 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1012 23:37:21.982791 680006 tcmalloc_profile.cc:145] Analyzing TCMalloc sampling profile
W1012 23:37:22.006692 680006 tcmalloc_profile.cc:194] Failed to symbolize 165 symbols
I1013 00:04:18.744127 2384993 pg_client_service.cc:2621] Fetching set of database oids
I1013 00:04:18.745496 2384993 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1013 00:04:18.745549 2384993 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1013 03:04:18.745623 2384993 pg_client_service.cc:2621] Fetching set of database oids
I1013 03:04:18.746649 2384993 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1013 03:04:18.746681 2384993 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1013 06:04:18.746807 2384991 pg_client_service.cc:2621] Fetching set of database oids
I1013 06:04:18.747860 2384991 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1013 06:04:18.747881 2384991 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1013 09:04:18.747996 2384990 pg_client_service.cc:2621] Fetching set of database oids
I1013 09:04:18.749207 2384990 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1013 09:04:18.749248 2384990 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1013 12:04:18.749298 2384993 pg_client_service.cc:2621] Fetching set of database oids
I1013 12:04:18.750229 2384993 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1013 12:04:18.750260 2384993 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
W1013 14:32:07.401299 2384992 periodic.cc:174] PeriodicTimer callback delayed by 0.368s
I1013 15:04:18.750366 2384992 pg_client_service.cc:2621] Fetching set of database oids
I1013 15:04:18.751216 2384992 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1013 15:04:18.751238 2384992 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1013 18:04:18.751370 2384991 pg_client_service.cc:2621] Fetching set of database oids
I1013 18:04:18.752986 2384991 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1013 18:04:18.753044 2384991 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1013 21:04:18.753168 2384992 pg_client_service.cc:2621] Fetching set of database oids
I1013 21:04:18.754271 2384992 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1013 21:04:18.754303 2384992 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1014 00:04:18.754397 2384990 pg_client_service.cc:2621] Fetching set of database oids
I1014 00:04:18.755281 2384990 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1014 00:04:18.755299 2384990 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1014 03:04:18.755369 2384991 pg_client_service.cc:2621] Fetching set of database oids
I1014 03:04:18.756240 2384991 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1014 03:04:18.756260 2384991 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1014 06:04:18.756356 2384993 pg_client_service.cc:2621] Fetching set of database oids
I1014 06:04:18.757280 2384993 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1014 06:04:18.757315 2384993 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1014 09:04:18.757491 2384990 pg_client_service.cc:2621] Fetching set of database oids
I1014 09:04:18.758606 2384990 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1014 09:04:18.758644 2384990 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1014 12:04:18.758821 2384993 pg_client_service.cc:2621] Fetching set of database oids
I1014 12:04:18.760447 2384993 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1014 12:04:18.760473 2384993 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
W1014 14:33:21.790987 2384991 periodic.cc:174] PeriodicTimer callback delayed by 0.305s
I1014 15:04:18.760583 2384991 pg_client_service.cc:2621] Fetching set of database oids
I1014 15:04:18.761665 2384991 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1014 15:04:18.761761 2384991 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1014 18:04:18.761965 2384992 pg_client_service.cc:2621] Fetching set of database oids
I1014 18:04:18.763165 2384992 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1014 18:04:18.763206 2384992 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1014 21:04:18.763345 2384991 pg_client_service.cc:2621] Fetching set of database oids
I1014 21:04:18.764281 2384991 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1014 21:04:18.764313 2384991 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1015 00:04:18.764429 2384993 pg_client_service.cc:2621] Fetching set of database oids
I1015 00:04:18.765463 2384993 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1015 00:04:18.765486 2384993 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1015 03:04:18.765614 2384992 pg_client_service.cc:2621] Fetching set of database oids
I1015 03:04:18.766683 2384992 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1015 03:04:18.766721 2384992 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1015 06:04:18.766822 2384993 pg_client_service.cc:2621] Fetching set of database oids
I1015 06:04:18.768011 2384993 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1015 06:04:18.768033 2384993 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1015 09:04:18.768160 2384993 pg_client_service.cc:2621] Fetching set of database oids
I1015 09:04:18.769004 2384993 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1015 09:04:18.769023 2384993 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1015 12:04:18.769137 2384992 pg_client_service.cc:2621] Fetching set of database oids
I1015 12:04:18.770285 2384992 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1015 12:04:18.770308 2384992 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1015 15:04:18.770426 2384990 pg_client_service.cc:2621] Fetching set of database oids
I1015 15:04:18.771332 2384990 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1015 15:04:18.771358 2384990 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1015 18:04:18.771450 2384991 pg_client_service.cc:2621] Fetching set of database oids
I1015 18:04:18.772342 2384991 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1015 18:04:18.772369 2384991 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1015 21:04:18.772452 2384990 pg_client_service.cc:2621] Fetching set of database oids
I1015 21:04:18.773332 2384990 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1015 21:04:18.773375 2384990 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1016 00:04:18.773524 2384991 pg_client_service.cc:2621] Fetching set of database oids
I1016 00:04:18.774552 2384991 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1016 00:04:18.774580 2384991 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1016 03:04:18.774768 2384992 pg_client_service.cc:2621] Fetching set of database oids
I1016 03:04:18.776352 2384992 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1016 03:04:18.776389 2384992 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1016 06:04:18.776525 2384991 pg_client_service.cc:2621] Fetching set of database oids
I1016 06:04:18.777627 2384991 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1016 06:04:18.777649 2384991 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1016 09:04:18.777757 2384991 pg_client_service.cc:2621] Fetching set of database oids
I1016 09:04:18.778800 2384991 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1016 09:04:18.778821 2384991 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1016 12:04:18.778946 2384993 pg_client_service.cc:2621] Fetching set of database oids
I1016 12:04:18.779881 2384993 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1016 12:04:18.779955 2384993 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1016 15:04:18.780081 2384992 pg_client_service.cc:2621] Fetching set of database oids
I1016 15:04:18.781226 2384992 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1016 15:04:18.781260 2384992 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1016 18:04:18.781351 2384991 pg_client_service.cc:2621] Fetching set of database oids
I1016 18:04:18.782430 2384991 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1016 18:04:18.782476 2384991 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1016 21:04:18.782641 2384993 pg_client_service.cc:2621] Fetching set of database oids
I1016 21:04:18.783818 2384993 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1016 21:04:18.783859 2384993 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1017 00:04:18.783988 2384991 pg_client_service.cc:2621] Fetching set of database oids
I1017 00:04:18.785184 2384991 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1017 00:04:18.785216 2384991 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1017 03:04:18.785339 2384991 pg_client_service.cc:2621] Fetching set of database oids
I1017 03:04:18.786679 2384991 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1017 03:04:18.786712 2384991 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1017 06:04:18.786819 2384993 pg_client_service.cc:2621] Fetching set of database oids
I1017 06:04:18.788252 2384993 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1017 06:04:18.788293 2384993 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1017 09:04:18.788373 2384993 pg_client_service.cc:2621] Fetching set of database oids
I1017 09:04:18.789572 2384993 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1017 09:04:18.789620 2384993 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1017 12:04:18.789685 2384993 pg_client_service.cc:2621] Fetching set of database oids
I1017 12:04:18.790758 2384993 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1017 12:04:18.790794 2384993 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1017 15:04:18.790957 2384991 pg_client_service.cc:2621] Fetching set of database oids
I1017 15:04:18.792210 2384991 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1017 15:04:18.792253 2384991 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1017 18:04:18.792397 2384993 pg_client_service.cc:2621] Fetching set of database oids
I1017 18:04:18.793715 2384993 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1017 18:04:18.793746 2384993 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1017 21:04:18.793882 2384993 pg_client_service.cc:2621] Fetching set of database oids
I1017 21:04:18.795176 2384993 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1017 21:04:18.795199 2384993 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1018 00:04:18.795375 2384993 pg_client_service.cc:2621] Fetching set of database oids
I1018 00:04:18.796456 2384993 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1018 00:04:18.796499 2384993 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1018 03:04:18.796617 2384991 pg_client_service.cc:2621] Fetching set of database oids
I1018 03:04:18.797564 2384991 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1018 03:04:18.797605 2384991 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1018 06:04:18.797705 2384992 pg_client_service.cc:2621] Fetching set of database oids
I1018 06:04:18.798950 2384992 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1018 06:04:18.798976 2384992 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1018 08:14:18.798157 3142093 pprof-path-handlers.cc:195] Starting a heap profile: seconds=1 only_growth=0 sample_freq_bytes=10485760
I1018 08:14:18.798223 3142093 tcmalloc_profile.cc:122] Sleeping for 1 seconds while profile is collected.
I1018 08:14:19.798362 3142093 tcmalloc_profile.cc:145] Analyzing TCMalloc sampling profile
I1018 09:04:18.799028 2384993 pg_client_service.cc:2621] Fetching set of database oids
I1018 09:04:18.799755 2384993 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1018 09:04:18.799763 2384993 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1018 12:04:18.799950 2384993 pg_client_service.cc:2621] Fetching set of database oids
I1018 12:04:18.801297 2384993 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1018 12:04:18.801339 2384993 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1018 15:04:18.801486 2384992 pg_client_service.cc:2621] Fetching set of database oids
I1018 15:04:18.802764 2384992 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1018 15:04:18.802796 2384992 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1018 18:04:18.802980 2384991 pg_client_service.cc:2621] Fetching set of database oids
I1018 18:04:18.804529 2384991 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1018 18:04:18.804570 2384991 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1018 21:04:18.804702 2384991 pg_client_service.cc:2621] Fetching set of database oids
I1018 21:04:18.805804 2384991 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1018 21:04:18.805823 2384991 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1019 00:04:18.805958 2384991 pg_client_service.cc:2621] Fetching set of database oids
I1019 00:04:18.807063 2384991 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1019 00:04:18.807101 2384991 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1019 03:04:18.807250 2384992 pg_client_service.cc:2621] Fetching set of database oids
I1019 03:04:18.808478 2384992 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1019 03:04:18.808516 2384992 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1019 04:31:52.555617 651033 tcmalloc_profile.cc:145] Analyzing TCMalloc sampling profile
W1019 04:31:52.572331 651033 tcmalloc_profile.cc:194] Failed to symbolize 165 symbols
I1019 06:04:18.808734 2384993 pg_client_service.cc:2621] Fetching set of database oids
I1019 06:04:18.809938 2384993 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1019 06:04:18.809949 2384993 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1019 09:04:18.810043 2384990 pg_client_service.cc:2621] Fetching set of database oids
I1019 09:04:18.811087 2384990 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1019 09:04:18.811128 2384990 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1019 10:27:34.240624 1148409 tcmalloc_profile.cc:145] Analyzing TCMalloc sampling profile
I1019 10:27:34.243160 1148389 pprof-path-handlers.cc:195] Starting a heap profile: seconds=1 only_growth=0 sample_freq_bytes=10485760
I1019 10:27:34.243252 1148389 tcmalloc_profile.cc:122] Sleeping for 1 seconds while profile is collected.
W1019 10:27:34.262395 1148409 tcmalloc_profile.cc:194] Failed to symbolize 165 symbols
I1019 10:27:35.243356 1148389 tcmalloc_profile.cc:145] Analyzing TCMalloc sampling profile
W1019 10:27:35.300251 1148389 tcmalloc_profile.cc:194] Failed to symbolize 50 symbols
I1019 12:04:18.811271 2384990 pg_client_service.cc:2621] Fetching set of database oids
I1019 12:04:18.812354 2384990 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1019 12:04:18.812391 2384990 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1019 15:04:18.812530 2384992 pg_client_service.cc:2621] Fetching set of database oids
I1019 15:04:18.813632 2384992 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1019 15:04:18.813683 2384992 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1019 18:04:18.813774 2384993 pg_client_service.cc:2621] Fetching set of database oids
I1019 18:04:18.814750 2384993 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1019 18:04:18.814790 2384993 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1019 21:04:18.815011 2384991 pg_client_service.cc:2621] Fetching set of database oids
I1019 21:04:18.816309 2384991 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1019 21:04:18.816339 2384991 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1019 23:57:37.508047 2282302 pprof-path-handlers.cc:195] Starting a heap profile: seconds=1 only_growth=0 sample_freq_bytes=10485760
I1019 23:57:37.508104 2282302 tcmalloc_profile.cc:122] Sleeping for 1 seconds while profile is collected.
I1019 23:57:37.509200 2282303 tcmalloc_profile.cc:145] Analyzing TCMalloc sampling profile
W1019 23:57:37.564352 2282303 tcmalloc_profile.cc:194] Failed to symbolize 173 symbols
I1019 23:57:38.508252 2282302 tcmalloc_profile.cc:145] Analyzing TCMalloc sampling profile
W1019 23:57:38.542474 2282302 tcmalloc_profile.cc:194] Failed to symbolize 32 symbols
I1020 00:04:18.816457 2384992 pg_client_service.cc:2621] Fetching set of database oids
I1020 00:04:18.817606 2384992 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1020 00:04:18.817643 2384992 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1020 03:04:18.817723 2384992 pg_client_service.cc:2621] Fetching set of database oids
I1020 03:04:18.818711 2384992 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1020 03:04:18.818730 2384992 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1020 06:04:18.818818 2384992 pg_client_service.cc:2621] Fetching set of database oids
I1020 06:04:18.819810 2384992 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1020 06:04:18.819828 2384992 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1020 09:04:18.819976 2384991 pg_client_service.cc:2621] Fetching set of database oids
I1020 09:04:18.821496 2384991 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1020 09:04:18.821542 2384991 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1020 12:04:18.821642 2384992 pg_client_service.cc:2621] Fetching set of database oids
I1020 12:04:18.822676 2384992 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1020 12:04:18.822796 2384992 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1020 15:04:18.822888 2384991 pg_client_service.cc:2621] Fetching set of database oids
I1020 15:04:18.824038 2384991 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1020 15:04:18.824059 2384991 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1020 18:04:18.824167 2384993 pg_client_service.cc:2621] Fetching set of database oids
I1020 18:04:18.825397 2384993 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1020 18:04:18.825469 2384993 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1020 21:04:18.825630 2384993 pg_client_service.cc:2621] Fetching set of database oids
I1020 21:04:18.826872 2384993 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1020 21:04:18.826895 2384993 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1021 00:04:18.827072 2384993 pg_client_service.cc:2621] Fetching set of database oids
I1021 00:04:18.828378 2384993 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1021 00:04:18.828431 2384993 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1021 03:04:18.828538 2384990 pg_client_service.cc:2621] Fetching set of database oids
I1021 03:04:18.829627 2384990 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1021 03:04:18.829653 2384990 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1021 06:04:18.829777 2384991 pg_client_service.cc:2621] Fetching set of database oids
I1021 06:04:18.830965 2384991 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1021 06:04:18.831005 2384991 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1021 09:04:18.831067 2384990 pg_client_service.cc:2621] Fetching set of database oids
I1021 09:04:18.832336 2384990 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1021 09:04:18.832348 2384990 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1021 12:04:18.832461 2384993 pg_client_service.cc:2621] Fetching set of database oids
I1021 12:04:18.833484 2384993 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1021 12:04:18.833529 2384993 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1021 15:04:18.833657 2384991 pg_client_service.cc:2621] Fetching set of database oids
I1021 15:04:18.834957 2384991 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1021 15:04:18.834997 2384991 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1021 18:04:18.835135 2384990 pg_client_service.cc:2621] Fetching set of database oids
I1021 18:04:18.836222 2384990 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1021 18:04:18.836259 2384990 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1021 21:04:18.836401 2384991 pg_client_service.cc:2621] Fetching set of database oids
I1021 21:04:18.837699 2384991 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1021 21:04:18.837728 2384991 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1022 00:04:18.837867 2384991 pg_client_service.cc:2621] Fetching set of database oids
I1022 00:04:18.839210 2384991 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1022 00:04:18.839250 2384991 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators
I1022 00:37:45.394259 2182269 tcmalloc_profile.cc:145] Analyzing TCMalloc sampling profile
I1022 00:37:45.394268 2182272 pprof-path-handlers.cc:195] Starting a heap profile: seconds=1 only_growth=0 sample_freq_bytes=10485760
I1022 00:37:45.394376 2182272 tcmalloc_profile.cc:122] Sleeping for 1 seconds while profile is collected.
W1022 00:37:45.426668 2182269 tcmalloc_profile.cc:194] Failed to symbolize 165 symbols
I1022 00:37:46.394590 2182272 tcmalloc_profile.cc:145] Analyzing TCMalloc sampling profile
W1022 00:37:46.401321 2182272 tcmalloc_profile.cc:194] Failed to symbolize 14 symbols
I1022 03:04:18.839365 2384993 pg_client_service.cc:2621] Fetching set of database oids
I1022 03:04:18.841063 2384993 pg_client_service.cc:2628] Successfully fetched 7 database oids
I1022 03:04:18.841086 2384993 pg_client_service.cc:2647] ScheduleCheckObjectIdAllocators