2026-05-21T11:06:30.905Z|00001|vlog|INFO|opened log file /var/log/ovn/ovn-northd.log 2026-05-21T11:06:30.906Z|00002|ovn_northd|INFO|OVN internal version is : [24.03.6-20.33.0-76.8] 2026-05-21T11:06:30.907Z|00003|reconnect|INFO|unix:/var/run/ovn/ovnnb_db.sock: connecting... 2026-05-21T11:06:30.907Z|00004|reconnect|INFO|unix:/var/run/ovn/ovnnb_db.sock: connected 2026-05-21T11:06:30.907Z|00005|ovn_northd|INFO|OVN NB IDL reconnected, force recompute. 2026-05-21T11:06:30.907Z|00006|reconnect|INFO|unix:/var/run/ovn/ovnsb_db.sock: connecting... 2026-05-21T11:06:30.907Z|00007|reconnect|INFO|unix:/var/run/ovn/ovnsb_db.sock: connected 2026-05-21T11:06:30.907Z|00008|ovn_northd|INFO|OVN SB IDL reconnected, force recompute. 2026-05-21T11:06:30.907Z|00009|ovn_northd|INFO|ovn-northd lock acquired. This ovn-northd instance is now active. 2026-05-21T11:06:30.911Z|00010|memory_trim|INFO|Detected inactivity (last active 0 ms ago): trimming memory 2026-05-21T11:07:00.944Z|00011|memory|INFO|7308 kB peak resident set size after 30.0 seconds 2026-05-21T11:07:00.945Z|00012|memory|INFO|idl-cells-OVN_Northbound:12 idl-cells-OVN_Southbound:185 2026-05-21T11:07:00.946Z|00013|memory_trim|INFO|Detected inactivity (last active 30033 ms ago): trimming memory 2026-05-21T11:10:37.951Z|00014|ovn_parallel_hmap|INFO|Setting thread count to 0 2026-05-21T11:10:38.342Z|00001|vlog|INFO|opened log file /var/log/ovn/ovn-northd.log 2026-05-21T11:10:38.343Z|00002|ovn_northd|INFO|OVN internal version is : [24.03.6-20.33.0-76.8] 2026-05-21T11:10:38.344Z|00003|reconnect|INFO|unix:/var/run/ovn/ovnnb_db.sock: connecting... 2026-05-21T11:10:38.344Z|00004|reconnect|INFO|unix:/var/run/ovn/ovnnb_db.sock: connection attempt failed (No such file or directory) 2026-05-21T11:10:38.344Z|00005|ovn_northd|INFO|OVN NB IDL reconnected, force recompute. 2026-05-21T11:10:38.344Z|00006|reconnect|INFO|unix:/var/run/ovn/ovnsb_db.sock: connecting... 2026-05-21T11:10:38.344Z|00007|reconnect|INFO|unix:/var/run/ovn/ovnsb_db.sock: connection attempt failed (No such file or directory) 2026-05-21T11:10:38.344Z|00008|ovn_northd|INFO|OVN SB IDL reconnected, force recompute. 2026-05-21T11:10:39.345Z|00009|reconnect|INFO|unix:/var/run/ovn/ovnnb_db.sock: connecting... 2026-05-21T11:10:39.345Z|00010|reconnect|INFO|unix:/var/run/ovn/ovnnb_db.sock: connected 2026-05-21T11:10:39.345Z|00011|reconnect|INFO|unix:/var/run/ovn/ovnsb_db.sock: connecting... 2026-05-21T11:10:39.345Z|00012|reconnect|INFO|unix:/var/run/ovn/ovnsb_db.sock: connected 2026-05-21T11:10:39.346Z|00013|ovn_northd|INFO|ovn-northd lock acquired. This ovn-northd instance is now active. 2026-05-21T11:10:48.972Z|00014|memory|INFO|7332 kB peak resident set size after 10.6 seconds 2026-05-21T11:10:48.972Z|00015|memory|INFO|idl-cells-OVN_Northbound:26 idl-cells-OVN_Southbound:218 2026-05-21T11:11:43.733Z|00016|memory_trim|INFO|Detected inactivity (last active 30028 ms ago): trimming memory 2026-05-21T11:12:39.701Z|00017|memory_trim|INFO|Detected inactivity (last active 30025 ms ago): trimming memory 2026-05-21T11:13:18.474Z|00018|memory_trim|INFO|Detected inactivity (last active 30029 ms ago): trimming memory 2026-05-21T11:14:04.073Z|00019|memory|INFO|peak resident set size grew 63% in last 195.1 seconds, from 7332 kB to 11940 kB 2026-05-21T11:14:04.073Z|00020|memory|INFO|idl-cells-OVN_Northbound:2704 idl-cells-OVN_Southbound:15798 2026-05-21T11:26:26.453Z|00021|ovn_northd|INFO|OVN_Northbound IDL run: 2 iterations in 3172 ms 2026-05-21T11:26:30.367Z|00001|timeval(stopwatch0)|WARN|Unreasonably long 5601ms poll interval (0ms user, 2116ms system) 2026-05-21T11:26:44.950Z|00002|timeval(stopwatch0)|WARN|faults: 17 minor, 141 major 2026-05-21T11:26:46.861Z|00022|ovn_northd|INFO|OVN_Southbound IDL run: 2 iterations in 5792 ms 2026-05-21T11:26:53.687Z|00003|timeval(stopwatch0)|WARN|disk: 36440 reads, 0 writes 2026-05-21T11:27:05.269Z|00004|timeval(stopwatch0)|WARN|context switches: 145 voluntary, 2701 involuntary 2026-05-21T11:27:48.200Z|00005|coverage(stopwatch0)|INFO|Event coverage, avg rate over last: 5 seconds, last minute, last hour, hash=6caead25: 2026-05-21T11:27:48.635Z|00006|coverage(stopwatch0)|INFO|util_xalloc 677.4/sec 21683.033/sec 10394.8244/sec total: 37421368 2026-05-21T11:27:48.755Z|00007|coverage(stopwatch0)|INFO|stream_open 0.0/sec 0.000/sec 0.0011/sec total: 4 2026-05-21T11:27:49.055Z|00023|memory_trim|INFO|Detected inactivity (last active 119592 ms ago): trimming memory 2026-05-21T11:27:49.104Z|00008|coverage(stopwatch0)|INFO|pstream_open 0.0/sec 0.000/sec 0.0003/sec total: 1 2026-05-21T11:27:49.190Z|00024|timeval|WARN|Unreasonably long 89193ms poll interval (174ms user, 24386ms system) 2026-05-21T11:27:49.190Z|00009|coverage(stopwatch0)|INFO|seq_change 3.4/sec 25.867/sec 11.5261/sec total: 41494 2026-05-21T11:27:49.190Z|00010|coverage(stopwatch0)|INFO|poll_create_node 6.8/sec 57.667/sec 26.1039/sec total: 93974 2026-05-21T11:27:49.190Z|00025|timeval|WARN|faults: 173 minor, 2156 major 2026-05-21T11:27:49.190Z|00026|timeval|WARN|disk: 538392 reads, 24 writes 2026-05-21T11:27:49.190Z|00027|timeval|WARN|context switches: 2217 voluntary, 27758 involuntary 2026-05-21T11:27:49.190Z|00011|coverage(stopwatch0)|INFO|txn_success 0.8/sec 1.633/sec 0.7664/sec total: 2759 2026-05-21T11:27:49.190Z|00012|coverage(stopwatch0)|INFO|txn_incomplete 1.0/sec 1.883/sec 0.8831/sec total: 3179 2026-05-21T11:27:49.190Z|00013|coverage(stopwatch0)|INFO|txn_unchanged 1.4/sec 4.050/sec 2.1678/sec total: 7804 2026-05-21T11:27:49.190Z|00014|coverage(stopwatch0)|INFO|hmap_reserve 0.4/sec 44.483/sec 22.1183/sec total: 79626 2026-05-21T11:27:49.190Z|00015|coverage(stopwatch0)|INFO|hmap_expand 14.4/sec 427.283/sec 201.7106/sec total: 726158 2026-05-21T11:27:49.190Z|00016|coverage(stopwatch0)|INFO|hmap_pathological 0.8/sec 7.783/sec 3.1544/sec total: 11356 2026-05-21T11:27:49.190Z|00017|coverage(stopwatch0)|INFO|northd_run 0.0/sec 0.700/sec 0.3819/sec total: 1375 2026-05-21T11:27:49.190Z|00018|coverage(stopwatch0)|INFO|103 events never hit 2026-05-21T11:27:49.241Z|00028|coverage|INFO|Skipping details of duplicate event coverage for hash=6caead25 2026-05-21T11:35:15.655Z|00029|memory_trim|INFO|Detected inactivity (last active 30030 ms ago): trimming memory 2026-05-21T11:39:21.262Z|00030|memory_trim|INFO|Detected inactivity (last active 30030 ms ago): trimming memory