═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ MAIN ═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ ════════════════════════════════════════════════════ CAMPAIGN_13_1 ════════════════════════════════════════════════════ 2026-11-09 11:36:39.024 | INFO | CAMPAIGN_13_1 2026-11-09 11:36:39.027 | INFO | Campaign run: event="campaign_main", name=campaign_13_1 2026-11-09 11:36:39.029 | INFO | Count: 0 2026-11-09 11:36:39.046 | INFO | <<< UI ENSURE >>> 2026-11-09 11:36:39.051 | INFO | UI get current page 2026-11-09 11:36:39.096 | INFO | [UI] page_os 2026-11-09 11:36:39.100 | INFO | Goto page_campaign 2026-11-09 11:36:39.106 | INFO | <<< UI GOTO PAGE_CAMPAIGN >>> 2026-11-09 11:36:39.132 | INFO | Page switch: page_os -> page_main 2026-11-09 11:36:39.135 | INFO | Click (1240, 32) @ GOTO_MAIN 2026-11-09 11:36:39.923 | INFO | Page switch: page_main_white -> page_campaign_menu 2026-11-09 11:36:39.928 | INFO | Click (1178, 512) @ MAIN_GOTO_CAMPAIGN_WHITE 2026-11-09 11:36:40.519 | INFO | Page switch: page_campaign_menu -> page_campaign 2026-11-09 11:36:40.523 | INFO | Click ( 379, 248) @ CAMPAIGN_MENU_GOTO_CAMPAIGN 2026-11-09 11:36:40.809 | INFO | Page arrive: page_campaign 2026-11-09 11:36:40.835 | INFO | Mode_switch_1 set to hard 2026-11-09 11:36:40.860 | INFO | [Mode_switch_1] hard 2026-11-09 11:36:40.864 | INFO | <<< UI ENSURE INDEX >>> 2026-11-09 11:36:40.935 | INFO | No stage found. 2026-11-09 11:36:41.173 | INFO | No stage found. 2026-11-09 11:36:41.486 | INFO | No stage found. 2026-11-09 11:36:41.824 | INFO | [campaign 0.047s] ['13--1', '13--3', '13--2', '13--4'] 2026-11-09 11:36:41.828 | INFO | [Chapter] 13 2026-11-09 11:36:41.832 | INFO | [Stage] 13-1, 13-3, 13-2, 13-4 2026-11-09 11:36:41.836 | INFO | [Index] 13 2026-11-09 11:36:41.903 | INFO | [OCR_OIL 0.040s] 24631 ──────────────────────────────────────────────────────── 13-1 ───────────────────────────────────────────────────────── 2026-11-09 11:36:41.908 | INFO | 13-1 2026-11-09 11:36:41.911 | INFO | Expect emotion reduce: (12, 2) 2026-11-09 11:36:41.924 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-11-09 11:36:41.928 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=55, Main.Emotion.Fleet1Record=datetime.datetime(2026, 11, 9, 11, 36, 41), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 11, 9, 11, 36, 41) 2026-11-09 11:36:41.945 | INFO | [Emotion fleet_1] 55 2026-11-09 11:36:41.948 | INFO | [Emotion fleet_2] 119 2026-11-09 11:36:41.952 | INFO | <<< ENTER MAP >>> 2026-11-09 11:36:42.006 | INFO | Click ( 183, 288) @ 13-1 2026-11-09 11:36:42.432 | INFO | [Map_clear_percentage] 5% 2026-11-09 11:36:42.711 | INFO | [Map_clear_percentage] 67% 2026-11-09 11:36:43.005 | INFO | [Map_clear_percentage] 99% 2026-11-09 11:36:43.031 | INFO | [MAP_CLEAR_ALL_THIS_TIME] False 2026-11-09 11:36:43.034 | INFO | [Map_info] 99%, star_1, star_2, star_3, 100_percent_clear, 3_stars, threat_safe, clear_mode 2026-11-09 11:36:43.039 | INFO | [StopCondition_MapAchievement] non_stop 2026-11-09 11:36:43.042 | INFO | Clear_Mode set to on 2026-11-09 11:36:43.045 | INFO | [Clear_Mode] on 2026-11-09 11:36:43.060 | INFO | Auto_Search set to on 2026-11-09 11:36:43.065 | INFO | [Auto_Search] on 2026-11-09 11:36:43.070 | INFO | Click (1058, 513) @ MAP_PREPARATION 2026-11-09 11:36:43.312 | INFO | Handling 2x book setting, mode=prep. 2026-11-09 11:36:43.609 | INFO | Using fleet: [4, 3, 1] 2026-11-09 11:36:43.682 | INFO | Hard satisfied: Fleet_1: None, Fleet_2: None, Submarine: None 2026-11-09 11:36:43.693 | INFO | [map_allow_submarine] True 2026-11-09 11:36:43.698 | INFO | Click (1143, 331) @ FLEET_2_CLEAR 2026-11-09 11:36:43.751 | INFO | Fleet SUBMARINE set to 1 2026-11-09 11:36:43.755 | INFO | Click (1046, 467) @ SUBMARINE_CHOOSE 2026-11-09 11:36:43.905 | INFO | FleetOption: [1] 2 2026-11-09 11:36:43.908 | INFO | Fleet option 1 is already selected 2026-11-09 11:36:43.911 | INFO | Click (1054, 486) @ SUBMARINE_CHOOSE 2026-11-09 11:36:44.202 | INFO | FleetOption: 2026-11-09 11:36:44.209 | INFO | Fleet FLEET_1 set to 4 2026-11-09 11:36:44.212 | INFO | Click (1038, 215) @ FLEET_1_CHOOSE 2026-11-09 11:36:44.508 | INFO | FleetOption: 1 2 3 [4] 5 6 2026-11-09 11:36:44.512 | INFO | Fleet option 4 is already selected 2026-11-09 11:36:44.514 | INFO | Click (1054, 212) @ FLEET_1_CHOOSE 2026-11-09 11:36:44.803 | INFO | FleetOption: 2026-11-09 11:36:44.806 | INFO | Fleet FLEET_2 set to 3 2026-11-09 11:36:44.809 | INFO | Click (1051, 333) @ FLEET_2_CHOOSE 2026-11-09 11:36:45.112 | INFO | FleetOption: 1 2 3 [4] 5 6 2026-11-09 11:36:45.116 | INFO | Click (1043, 486) @ FleetOption_3 2026-11-09 11:36:45.403 | INFO | FleetOption: 2026-11-09 11:36:45.408 | INFO | Auto search setting 2026-11-09 11:36:45.423 | INFO | [_fleet_sidebar_offset] 0 2026-11-09 11:36:45.429 | INFO | [_fleet_sidebar_offset] 0 2026-11-09 11:36:45.433 | INFO | [Fleet_sidebar] 1/3 2026-11-09 11:36:45.436 | INFO | Click (1210, 450) @ FLEET_SIDEBAR_0_2 2026-11-09 11:36:45.704 | INFO | [_fleet_sidebar_offset] 0 2026-11-09 11:36:45.709 | INFO | [Fleet_sidebar] 3/3 2026-11-09 11:36:45.711 | INFO | [Auto_Search_Setting] fleet1_all_fleet2_standby, sub_standby 2026-11-09 11:36:45.714 | INFO | Click ( 508, 219) @ AUTO_SEARCH_SET_MOB 2026-11-09 11:36:46.203 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_standby 2026-11-09 11:36:46.208 | INFO | Selected to the correct auto search setting 2026-11-09 11:36:46.211 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_standby 2026-11-09 11:36:46.213 | INFO | Selected to the correct auto search setting 2026-11-09 11:36:46.220 | INFO | Click (1084, 576) @ FLEET_PREPARATION 2026-11-09 11:36:47.426 | INFO | is_auto_search_running appeared ────────────────────────────────────────────────────── BATTLE_0 ─────────────────────────────────────────────────────── 2026-11-09 11:36:47.432 | INFO | BATTLE_0 2026-11-09 11:36:47.435 | INFO | Auto search moving 2026-11-09 11:36:47.451 | INFO | Fleet: 1, fleet_current_index: 1 2026-11-09 11:36:47.514 | INFO | [OCR_OIL 0.058s] 24621 2026-11-09 11:36:47.588 | INFO | [OCR_COIN 0.067s] 73440 2026-11-09 11:36:52.128 | INFO | [Loading] 8% 2026-11-09 11:36:52.134 | INFO | Auto search combat loading 2026-11-09 11:36:52.137 | INFO | Screenshot interval set to 1.0s 2026-11-09 11:36:58.136 | INFO | [BattleUI] PAUSE 2026-11-09 11:36:58.140 | INFO | Auto Search combat execute 2026-11-09 11:36:58.143 | INFO | <<< EMOTION REDUCE >>> 2026-11-09 11:36:58.283 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-11-09 11:36:58.287 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=53, Main.Emotion.Fleet1Record=datetime.datetime(2026, 11, 9, 11, 36, 58), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 11, 9, 11, 36, 58) 2026-11-09 11:36:58.297 | INFO | [Emotion fleet_1] 53 2026-11-09 11:36:58.303 | INFO | [Emotion fleet_2] 119 2026-11-09 11:37:04.123 | INFO | Combat auto check timer reached 2026-11-09 11:37:37.171 | INFO | Screenshot interval set to 0.3s 2026-11-09 11:37:37.174 | INFO | Auto Search combat status 2026-11-09 11:37:41.955 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_1 ─────────────────────────────────────────────────────── 2026-11-09 11:37:41.960 | INFO | BATTLE_1 2026-11-09 11:37:41.965 | INFO | Auto search moving 2026-11-09 11:37:41.969 | INFO | Fleet: 1, fleet_current_index: 1 2026-11-09 11:37:42.022 | INFO | [OCR_OIL 0.049s] 24602 2026-11-09 11:37:42.077 | INFO | [OCR_COIN 0.051s] 73461 2026-11-09 11:37:46.468 | INFO | [Loading] 12% 2026-11-09 11:37:46.472 | INFO | Auto search combat loading 2026-11-09 11:37:46.476 | INFO | Screenshot interval set to 1.0s 2026-11-09 11:37:52.518 | INFO | [BattleUI] PAUSE 2026-11-09 11:37:52.524 | INFO | Auto Search combat execute 2026-11-09 11:37:52.531 | INFO | <<< EMOTION REDUCE >>> 2026-11-09 11:37:52.567 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-11-09 11:37:52.573 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=51, Main.Emotion.Fleet1Record=datetime.datetime(2026, 11, 9, 11, 37, 52), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 11, 9, 11, 37, 52) 2026-11-09 11:37:52.669 | INFO | [Emotion fleet_1] 51 2026-11-09 11:37:52.675 | INFO | [Emotion fleet_2] 119 2026-11-09 11:37:58.478 | INFO | Combat auto check timer reached 2026-11-09 11:38:16.506 | INFO | Screenshot interval set to 0.3s 2026-11-09 11:38:16.509 | INFO | Auto Search combat status 2026-11-09 11:38:21.892 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_2 ─────────────────────────────────────────────────────── 2026-11-09 11:38:21.897 | INFO | BATTLE_2 2026-11-09 11:38:21.900 | INFO | Auto search moving 2026-11-09 11:38:21.906 | INFO | Fleet: 1, fleet_current_index: 1 2026-11-09 11:38:22.008 | INFO | [OCR_OIL 0.095s] 24583 2026-11-09 11:38:22.111 | INFO | [OCR_COIN 0.099s] 73482 2026-11-09 11:38:27.305 | INFO | [Loading] 9% 2026-11-09 11:38:27.309 | INFO | Auto search combat loading 2026-11-09 11:38:27.312 | INFO | Screenshot interval set to 1.0s 2026-11-09 11:38:33.313 | INFO | [BattleUI] PAUSE 2026-11-09 11:38:33.318 | INFO | Auto Search combat execute 2026-11-09 11:38:33.324 | INFO | <<< EMOTION REDUCE >>> 2026-11-09 11:38:33.337 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-11-09 11:38:33.343 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=49, Main.Emotion.Fleet1Record=datetime.datetime(2026, 11, 9, 11, 38, 33), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 11, 9, 11, 38, 33) 2026-11-09 11:38:33.360 | INFO | [Emotion fleet_1] 49 2026-11-09 11:38:33.364 | INFO | [Emotion fleet_2] 119 2026-11-09 11:38:39.305 | INFO | Combat auto check timer reached 2026-11-09 11:39:18.366 | INFO | Screenshot interval set to 0.3s 2026-11-09 11:39:18.371 | INFO | Auto Search combat status 2026-11-09 11:39:19.843 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_3 ─────────────────────────────────────────────────────── 2026-11-09 11:39:19.849 | INFO | BATTLE_3 2026-11-09 11:39:19.851 | INFO | Auto search moving 2026-11-09 11:39:19.855 | INFO | Fleet: 1, fleet_current_index: 1 2026-11-09 11:39:19.944 | INFO | [OCR_OIL 0.082s] 24564 2026-11-09 11:39:20.020 | INFO | [OCR_COIN 0.071s] 73501 2026-11-09 11:39:24.062 | INFO | [Loading] 8% 2026-11-09 11:39:24.068 | INFO | Auto search combat loading 2026-11-09 11:39:24.072 | INFO | Screenshot interval set to 1.0s 2026-11-09 11:39:30.082 | INFO | [BattleUI] PAUSE 2026-11-09 11:39:30.086 | INFO | Auto Search combat execute 2026-11-09 11:39:30.089 | INFO | <<< EMOTION REDUCE >>> 2026-11-09 11:39:30.100 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-11-09 11:39:30.104 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=47, Main.Emotion.Fleet1Record=datetime.datetime(2026, 11, 9, 11, 39, 30), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 11, 9, 11, 39, 30) 2026-11-09 11:39:30.124 | INFO | [Emotion fleet_1] 47 2026-11-09 11:39:30.127 | INFO | [Emotion fleet_2] 119 2026-11-09 11:39:36.075 | INFO | Combat auto check timer reached 2026-11-09 11:40:15.126 | INFO | Screenshot interval set to 0.3s 2026-11-09 11:40:15.131 | INFO | Auto Search combat status 2026-11-09 11:40:16.595 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_4 ─────────────────────────────────────────────────────── 2026-11-09 11:40:16.599 | INFO | BATTLE_4 2026-11-09 11:40:16.602 | INFO | Auto search moving 2026-11-09 11:40:16.606 | INFO | Fleet: 1, fleet_current_index: 1 2026-11-09 11:40:16.683 | INFO | [OCR_OIL 0.073s] 24545 2026-11-09 11:40:16.776 | INFO | [OCR_COIN 0.088s] 73523 2026-11-09 11:40:22.643 | INFO | [Loading] 6% 2026-11-09 11:40:22.650 | INFO | Auto search combat loading 2026-11-09 11:40:22.660 | INFO | Screenshot interval set to 1.0s 2026-11-09 11:40:28.616 | INFO | [BattleUI] PAUSE 2026-11-09 11:40:28.619 | INFO | Auto Search combat execute 2026-11-09 11:40:28.623 | INFO | <<< EMOTION REDUCE >>> 2026-11-09 11:40:28.642 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-11-09 11:40:28.648 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=45, Main.Emotion.Fleet1Record=datetime.datetime(2026, 11, 9, 11, 40, 28), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 11, 9, 11, 40, 28) 2026-11-09 11:40:28.661 | INFO | [Emotion fleet_1] 45 2026-11-09 11:40:28.664 | INFO | [Emotion fleet_2] 119 2026-11-09 11:40:34.609 | INFO | Combat auto check timer reached 2026-11-09 11:41:28.682 | INFO | Screenshot interval set to 0.3s 2026-11-09 11:41:28.686 | INFO | Auto Search combat status 2026-11-09 11:41:33.763 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_5 ─────────────────────────────────────────────────────── 2026-11-09 11:41:33.770 | INFO | BATTLE_5 2026-11-09 11:41:33.773 | INFO | Auto search moving 2026-11-09 11:41:33.778 | INFO | Fleet: 1, fleet_current_index: 1 2026-11-09 11:41:33.874 | INFO | [OCR_OIL 0.091s] 24526 2026-11-09 11:41:33.968 | INFO | [OCR_COIN 0.091s] 73552 2026-11-09 11:41:35.573 | INFO | [Loading] 7% 2026-11-09 11:41:35.576 | INFO | Auto search combat loading 2026-11-09 11:41:35.580 | INFO | Screenshot interval set to 1.0s 2026-11-09 11:41:41.579 | INFO | [BattleUI] PAUSE 2026-11-09 11:41:41.583 | INFO | Auto Search combat execute 2026-11-09 11:41:41.585 | INFO | <<< EMOTION REDUCE >>> 2026-11-09 11:41:41.599 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-11-09 11:41:41.604 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=43, Main.Emotion.Fleet1Record=datetime.datetime(2026, 11, 9, 11, 41, 41), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 11, 9, 11, 41, 41) 2026-11-09 11:41:41.621 | INFO | [Emotion fleet_1] 43 2026-11-09 11:41:41.625 | INFO | [Emotion fleet_2] 119 2026-11-09 11:41:46.585 | INFO | Combat auto check timer reached 2026-11-09 11:44:41.766 | INFO | Function calls: gui.py L94 process.py L112 start() context.py L223 _Popen() context.py L277 _Popen() popen_fork.py L20 __init__() popen_fork.py L74 _launch() process.py L297 _bootstrap() process.py L99 run() gui.py L85 func() main.py L463 run() server.py L60 run() runners.py L43 run() on.py L84 main() proxy_headers.py L75 __call__() applications.py L112 __call__() errors.py L146 __call__() base.py L21 __call__() exceptions.py L58 __call__() routing.py L569 __call__() routing.py L540 lifespan() routing.py L481 default_lifespan() routing.py L518 startup() app.py L1550 process_manager.py L227 restart_processes() process_manager.py L51 start() process.py L112 start() context.py L223 _Popen() context.py L277 _Popen() popen_fork.py L20 __init__() popen_fork.py L74 _launch() process.py L297 _bootstrap() process.py L99 run() process_manager.py L166 run_process() alas.py L591 loop() alas.py L69 run() alas.py L356 main() run.py L445 run() campaign_base.py L143 run() campaign_base.py L178 auto_search_execute_a_battle() auto_search_combat.py L357 auto_search_combat() auto_search_combat.py L252 auto_search_combat_execute() base.py L169 loop() device.py L194 screenshot() device.py L256 stuck_record_check() device.py L43 show_function_call() 2026-11-09 11:44:41.793 | WARNING | Wait too long 2026-11-09 11:44:41.798 | WARNING | Waiting for {'EXP_INFO_B', 'BATTLE_STATUS_B', 'EXP_INFO_A', 'EXP_INFO_S', 'GET_MISSION', 'GET_SHIP', 'COMBAT_AUTO', 'POPUP_CONFIRM_WHITE', 'COMBAT_AUTO_133', 'SP_CHECK', 'POPUP_CANCEL', 'AUTO_SEARCH_MAP_OPTION_ON', 'BATTLE_STATUS_A', 'MISSION_POPUP_GO', 'EVENT_CHECK', 'GUILD_POPUP_CONFIRM', 'BATTLE_STATUS_S', 'COMBAT_AUTO_150', 'CAMPAIGN_CHECK', 'PAUSE'} 2026-11-09 11:44:41.859 | INFO | [Package_name] com.bilibili.azurlane 2026-11-09 11:44:41.862 | ERROR | GameStuckError: Wait too long 2026-11-09 11:44:41.864 | WARNING | Saving error: ./log/error/1794195881864