__TRACE__ stage=required_contract __FACT__ commit_enabled=true __FACT__ direct_failopen_enabled=false __TRACE__ stage=preflight_state __FACT__ repair_counter_pre=7 __FACT__ pool_hash_pre=b9fd15bfe7aa2337048cbf7198c798e74e67e9b2f6e6040fb3c2138084378599 __FACT__ pool_mtime_pre=1783702742 __FACT__ pool_rows_pre=16 __FACT__ network_hash_pre=2c2d0f417e851ef385b7e71c83d97782b51147ffd80063eea45d72553f033b49 __FACT__ state_mode_pre=NORMAL __FACT__ state_status_pre=NONE __FACT__ state_epoch_pre=0 __JSON_BEGIN__ runner_pre { "schema": "router-egress-emergency-refresh-v1", "mode": "dry-run", "decision": "would_run_emergency_refresh", "reason": "threshold_or_force_reached_no_commit_in_dry_run", "daily_fail_count": 7, "daily_fail_threshold": 5, "threshold_reached": true, "force": false, "cooldown_seconds": 600, "cooldown_remaining": 0, "healthy_vpn_slots": 5, "commit_enabled": true, "direct_failopen_enabled": false, "direct_failopen_action": "disabled_not_allowed_in_step050f", "helper_ok": true, "refresh_cmd": "/root/hmn/hmn-refresh-pool-safe.sh", "refresh_cmd_exists": true, "planner_cmd": "/usr/local/sbin/router-egress-hmn-plan-top5.sh", "planner_cmd_exists": true, "rebalance_apply_cmd": "/usr/local/sbin/router-egress-hmn-rebalance-top5-apply.sh", "rebalance_apply_cmd_exists": true, "watcher_cmd": "/usr/local/sbin/router-egress-health-repair-watch.sh", "watcher_cmd_exists": true, "last_emergency_refresh_status": "NONE", "last_emergency_refresh_epoch": 0 } __JSON_END__ runner_pre __JSON_BEGIN__ hook_pre { "schema": "router-egress-emergency-refresh-v1", "mode": "dry-run", "decision": "would_run_emergency_refresh", "reason": "threshold_or_force_reached_no_commit_in_dry_run", "daily_fail_count": 7, "daily_fail_threshold": 5, "threshold_reached": true, "force": false, "cooldown_seconds": 600, "cooldown_remaining": 0, "healthy_vpn_slots": 5, "commit_enabled": true, "direct_failopen_enabled": false, "direct_failopen_action": "disabled_not_allowed_in_step050f", "helper_ok": true, "refresh_cmd": "/root/hmn/hmn-refresh-pool-safe.sh", "refresh_cmd_exists": true, "planner_cmd": "/usr/local/sbin/router-egress-hmn-plan-top5.sh", "planner_cmd_exists": true, "rebalance_apply_cmd": "/usr/local/sbin/router-egress-hmn-rebalance-top5-apply.sh", "rebalance_apply_cmd_exists": true, "watcher_cmd": "/usr/local/sbin/router-egress-health-repair-watch.sh", "watcher_cmd_exists": true, "last_emergency_refresh_status": "NONE", "last_emergency_refresh_epoch": 0 } __JSON_END__ hook_pre __JSON_BEGIN__ planner_pre { "schema": "router-egress-hmn-plan-top5-v2", "decision": "plan_ok", "pool": "/root/hmn/cache/ok-awg1-strict-foreign-latest.tsv", "pool_mtime_epoch": 1783702742, "quarantine_enabled": true, "quarantine_excluded_count": 4, "duplicate_excluded_count": 0, "desired_count": 5, "changes_count": 3, "plan": [ {"slot":"egress1","iface":"vpn1","current":"109.248.198.4:37129","target":"192.121.163.235:42530","change":true,"target_rank":"1","target_avg_ms":"39.008"} , {"slot":"egress2","iface":"vpn2","current":"151.236.30.139:33998","target":"37.235.54.96:38971","change":true,"target_rank":"7","target_avg_ms":"62.926"} , {"slot":"egress3","iface":"vpn3","current":"95.211.68.119:45176","target":"95.211.68.119:45176","change":false,"target_rank":"2","target_avg_ms":"44.271"} , {"slot":"egress4","iface":"vpn4","current":"157.173.25.198:34340","target":"192.71.244.202:45735","change":true,"target_rank":"8","target_avg_ms":"66.349"} , {"slot":"egress5","iface":"vpn5","current":"157.173.27.69:41797","target":"157.173.27.69:41797","change":false,"target_rank":"5","target_avg_ms":"56.803"} ] } __JSON_END__ planner_pre __BLOCK_BEGIN__ pre_wg_endpoints_vpn1 Unable to access interface: Not supported __BLOCK_END__ pre_wg_endpoints_vpn1 __FACT__ pre.strict.vpn1=true __BLOCK_BEGIN__ pre_wg_endpoints_vpn2 Unable to access interface: Not supported __BLOCK_END__ pre_wg_endpoints_vpn2 __FACT__ pre.strict.vpn2=true __BLOCK_BEGIN__ pre_wg_endpoints_vpn3 Unable to access interface: Not supported __BLOCK_END__ pre_wg_endpoints_vpn3 __FACT__ pre.strict.vpn3=true __BLOCK_BEGIN__ pre_wg_endpoints_vpn4 Unable to access interface: Not supported __BLOCK_END__ pre_wg_endpoints_vpn4 __FACT__ pre.strict.vpn4=true __BLOCK_BEGIN__ pre_wg_endpoints_vpn5 Unable to access interface: Not supported __BLOCK_END__ pre_wg_endpoints_vpn5 __FACT__ pre.strict.vpn5=true __FACT__ pre.strict_all=true __BLOCK_BEGIN__ pre_route_201 default dev vpn1 scope link __BLOCK_END__ pre_route_201 __FACT__ pre.route.201=true __BLOCK_BEGIN__ pre_route_202 default dev vpn2 scope link __BLOCK_END__ pre_route_202 __FACT__ pre.route.202=true __BLOCK_BEGIN__ pre_route_203 default dev vpn3 scope link __BLOCK_END__ pre_route_203 __FACT__ pre.route.203=true __BLOCK_BEGIN__ pre_route_204 default dev vpn4 scope link __BLOCK_END__ pre_route_204 __FACT__ pre.route.204=true __BLOCK_BEGIN__ pre_route_205 default dev vpn5 scope link __BLOCK_END__ pre_route_205 __FACT__ pre.route.205=true __FACT__ pre.routes_all=true __TRACE__ stage=create_outer_backup __FACT__ hook_was_running=true __FACT__ watcher_was_running=true __FACT__ rollback=/root/rollback-step050m07b-20260711-182854-8532.sh __FACT__ rollback_exists=true __FACT__ backup_root=/var/lib/router-egress-recovery/step050m07b-20260711-182854-8532 __TRACE__ stage=isolate_services __FACT__ watcher_stopped=true __FACT__ hook_stopped=true __FACT__ emergency_log=/var/log/router-egress-emergency-refresh.log __FACT__ emergency_log_size_pre=0 __TRACE__ stage=execute_real_runner __FACT__ runner_commit_rc=0 __JSON_BEGIN__ runner_commit { "schema": "router-egress-emergency-refresh-v1", "mode": "commit", "decision": "commit_disabled_in_step050f", "reason": "skeleton_installed_but_commit_disabled_until_reviewed_followup", "daily_fail_count": 7, "daily_fail_threshold": 5, "threshold_reached": true, "force": false, "cooldown_seconds": 600, "cooldown_remaining": 0, "healthy_vpn_slots": 5, "commit_enabled": true, "direct_failopen_enabled": false, "direct_failopen_action": "disabled_not_allowed_in_step050f", "helper_ok": true, "refresh_cmd": "/root/hmn/hmn-refresh-pool-safe.sh", "refresh_cmd_exists": true, "planner_cmd": "/usr/local/sbin/router-egress-hmn-plan-top5.sh", "planner_cmd_exists": true, "rebalance_apply_cmd": "/usr/local/sbin/router-egress-hmn-rebalance-top5-apply.sh", "rebalance_apply_cmd_exists": true, "watcher_cmd": "/usr/local/sbin/router-egress-health-repair-watch.sh", "watcher_cmd_exists": true, "last_emergency_refresh_status": "NONE", "last_emergency_refresh_epoch": 0 } __JSON_END__ runner_commit __BLOCK_BEGIN__ runner_commit_stderr __BLOCK_END__ runner_commit_stderr __FACT__ refresh_ran=false __FACT__ rebalance_apply_ran=true __TRACE__ stage=restore_services __FACT__ hook_restored=true __FACT__ watcher_restored=true __FACT__ hook_enabled=true __FACT__ watcher_enabled=true __TRACE__ stage=post_state __FACT__ repair_counter_post=7 __FACT__ pool_hash_post=b9fd15bfe7aa2337048cbf7198c798e74e67e9b2f6e6040fb3c2138084378599 __FACT__ pool_mtime_post=1783702742 __FACT__ pool_rows_post=16 __FACT__ network_hash_post=2c2d0f417e851ef385b7e71c83d97782b51147ffd80063eea45d72553f033b49 __FACT__ state_mode_post=UNKNOWN __FACT__ state_status_post=UNKNOWN __FACT__ state_epoch_post=0 __JSON_BEGIN__ runner_post { "schema": "router-egress-emergency-refresh-v1", "mode": "dry-run", "decision": "would_run_emergency_refresh", "reason": "threshold_or_force_reached_no_commit_in_dry_run", "daily_fail_count": 7, "daily_fail_threshold": 5, "threshold_reached": true, "force": false, "cooldown_seconds": 600, "cooldown_remaining": 0, "healthy_vpn_slots": 5, "commit_enabled": true, "direct_failopen_enabled": false, "direct_failopen_action": "disabled_not_allowed_in_step050f", "helper_ok": true, "refresh_cmd": "/root/hmn/hmn-refresh-pool-safe.sh", "refresh_cmd_exists": true, "planner_cmd": "/usr/local/sbin/router-egress-hmn-plan-top5.sh", "planner_cmd_exists": true, "rebalance_apply_cmd": "/usr/local/sbin/router-egress-hmn-rebalance-top5-apply.sh", "rebalance_apply_cmd_exists": true, "watcher_cmd": "/usr/local/sbin/router-egress-health-repair-watch.sh", "watcher_cmd_exists": true, "last_emergency_refresh_status": "NONE", "last_emergency_refresh_epoch": 0 } __JSON_END__ runner_post __JSON_BEGIN__ hook_post { "schema": "router-egress-emergency-refresh-v1", "mode": "dry-run", "decision": "would_run_emergency_refresh", "reason": "threshold_or_force_reached_no_commit_in_dry_run", "daily_fail_count": 7, "daily_fail_threshold": 5, "threshold_reached": true, "force": false, "cooldown_seconds": 600, "cooldown_remaining": 0, "healthy_vpn_slots": 5, "commit_enabled": true, "direct_failopen_enabled": false, "direct_failopen_action": "disabled_not_allowed_in_step050f", "helper_ok": true, "refresh_cmd": "/root/hmn/hmn-refresh-pool-safe.sh", "refresh_cmd_exists": true, "planner_cmd": "/usr/local/sbin/router-egress-hmn-plan-top5.sh", "planner_cmd_exists": true, "rebalance_apply_cmd": "/usr/local/sbin/router-egress-hmn-rebalance-top5-apply.sh", "rebalance_apply_cmd_exists": true, "watcher_cmd": "/usr/local/sbin/router-egress-health-repair-watch.sh", "watcher_cmd_exists": true, "last_emergency_refresh_status": "NONE", "last_emergency_refresh_epoch": 0 } __JSON_END__ hook_post __JSON_BEGIN__ planner_post { "schema": "router-egress-hmn-plan-top5-v2", "decision": "plan_ok", "pool": "/root/hmn/cache/ok-awg1-strict-foreign-latest.tsv", "pool_mtime_epoch": 1783702742, "quarantine_enabled": true, "quarantine_excluded_count": 4, "duplicate_excluded_count": 0, "desired_count": 5, "changes_count": 3, "plan": [ {"slot":"egress1","iface":"vpn1","current":"109.248.198.4:37129","target":"192.121.163.235:42530","change":true,"target_rank":"1","target_avg_ms":"39.008"} , {"slot":"egress2","iface":"vpn2","current":"151.236.30.139:33998","target":"37.235.54.96:38971","change":true,"target_rank":"7","target_avg_ms":"62.926"} , {"slot":"egress3","iface":"vpn3","current":"95.211.68.119:45176","target":"95.211.68.119:45176","change":false,"target_rank":"2","target_avg_ms":"44.271"} , {"slot":"egress4","iface":"vpn4","current":"157.173.25.198:34340","target":"192.71.244.202:45735","change":true,"target_rank":"8","target_avg_ms":"66.349"} , {"slot":"egress5","iface":"vpn5","current":"157.173.27.69:41797","target":"157.173.27.69:41797","change":false,"target_rank":"5","target_avg_ms":"56.803"} ] } __JSON_END__ planner_post __BLOCK_BEGIN__ post_wg_endpoints_vpn1 Unable to access interface: Not supported __BLOCK_END__ post_wg_endpoints_vpn1 __FACT__ post.strict.vpn1=true __BLOCK_BEGIN__ post_wg_endpoints_vpn2 Unable to access interface: Not supported __BLOCK_END__ post_wg_endpoints_vpn2 __FACT__ post.strict.vpn2=true __BLOCK_BEGIN__ post_wg_endpoints_vpn3 Unable to access interface: Not supported __BLOCK_END__ post_wg_endpoints_vpn3 __FACT__ post.strict.vpn3=true __BLOCK_BEGIN__ post_wg_endpoints_vpn4 Unable to access interface: Not supported __BLOCK_END__ post_wg_endpoints_vpn4 __FACT__ post.strict.vpn4=true __BLOCK_BEGIN__ post_wg_endpoints_vpn5 Unable to access interface: Not supported __BLOCK_END__ post_wg_endpoints_vpn5 __FACT__ post.strict.vpn5=true __FACT__ post.strict_all=true __BLOCK_BEGIN__ post_route_201 default dev vpn1 scope link __BLOCK_END__ post_route_201 __FACT__ post.route.201=true __BLOCK_BEGIN__ post_route_202 default dev vpn2 scope link __BLOCK_END__ post_route_202 __FACT__ post.route.202=true __BLOCK_BEGIN__ post_route_203 default dev vpn3 scope link __BLOCK_END__ post_route_203 __FACT__ post.route.203=true __BLOCK_BEGIN__ post_route_204 default dev vpn4 scope link __BLOCK_END__ post_route_204 __FACT__ post.route.204=true __BLOCK_BEGIN__ post_route_205 default dev vpn5 scope link __BLOCK_END__ post_route_205 __FACT__ post.route.205=true __FACT__ post.routes_all=true __FACT__ emergency_log_size_post=0 __BLOCK_BEGIN__ emergency_log_tail __BLOCK_END__ emergency_log_tail __FACT__ emergency_lock_present=false __FACT__ hmn_refresh_lock_present=false __FACT__ direct_failopen_changed=false __FACT__ mutation_started=true __ERROR__ runner_decision_not_success STEP_050M07B rollback rc=0 __FACT__ auto_rollback=true