═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ MAIN ═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ ════════════════════════════════════════════════════ CAMPAIGN_13_1 ════════════════════════════════════════════════════ 2026-09-27 19:14:31.146 | INFO | CAMPAIGN_13_1 2026-09-27 19:14:31.150 | INFO | Count: 0 2026-09-27 19:14:31.170 | INFO | <<< UI ENSURE >>> 2026-09-27 19:14:31.174 | INFO | UI get current page 2026-09-27 19:14:31.843 | INFO | Unknown ui page 2026-09-27 19:14:32.332 | INFO | UI additional: IDLE -> REWARD_GOTO_MAIN 2026-09-27 19:14:32.335 | INFO | Click ( 818, 618) @ REWARD_GOTO_MAIN 2026-09-27 19:14:32.521 | INFO | Unknown ui page 2026-09-27 19:14:32.658 | INFO | [Package_name] com.bilibili.azurlane 2026-09-27 19:14:32.679 | INFO | [Device Orientation] 0 (Normal) 2026-09-27 19:14:32.836 | INFO | Unknown ui page 2026-09-27 19:14:33.036 | INFO | [UI] page_main 2026-09-27 19:14:33.039 | INFO | Goto page_campaign 2026-09-27 19:14:33.044 | INFO | <<< UI GOTO PAGE_CAMPAIGN >>> 2026-09-27 19:14:33.060 | INFO | Page switch: page_main_white -> page_campaign_menu 2026-09-27 19:14:33.065 | INFO | Click (1198, 540) @ MAIN_GOTO_CAMPAIGN_WHITE 2026-09-27 19:14:33.634 | INFO | Page switch: page_campaign_menu -> page_campaign 2026-09-27 19:14:33.637 | INFO | Click ( 352, 427) @ CAMPAIGN_MENU_GOTO_CAMPAIGN 2026-09-27 19:14:33.929 | INFO | Page arrive: page_campaign 2026-09-27 19:14:33.954 | INFO | Mode_switch_1 set to hard 2026-09-27 19:14:33.981 | INFO | [Mode_switch_1] hard 2026-09-27 19:14:33.985 | INFO | <<< UI ENSURE INDEX >>> 2026-09-27 19:14:34.056 | INFO | No stage found. 2026-09-27 19:14:34.293 | INFO | No stage found. 2026-09-27 19:14:34.614 | INFO | Loading OCR model: ./bin/cnocr_models/azur_lane 2026-09-27 19:14:34.721 | INFO | [campaign 0.126s] ['I3--1', 'I3--3', 'I3--2', 'I3--4'] 2026-09-27 19:14:34.725 | INFO | [Chapter] 13 2026-09-27 19:14:34.728 | INFO | [Stage] 13-1, 13-3, 13-2, 13-4 2026-09-27 19:14:34.730 | INFO | [Index] 13 2026-09-27 19:14:34.800 | INFO | [OCR_OIL 0.043s] 2195 ──────────────────────────────────────────────────────── 13-1 ───────────────────────────────────────────────────────── 2026-09-27 19:14:34.804 | INFO | 13-1 2026-09-27 19:14:34.807 | INFO | Expect emotion reduce: (12, 2) 2026-09-27 19:14:34.819 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-09-27 19:14:34.822 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=119, Main.Emotion.Fleet1Record=datetime.datetime(2026, 9, 27, 19, 14, 34), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 9, 27, 19, 14, 34) 2026-09-27 19:14:34.839 | INFO | [Emotion fleet_1] 119 2026-09-27 19:14:34.843 | INFO | [Emotion fleet_2] 119 2026-09-27 19:14:34.846 | INFO | <<< ENTER MAP >>> 2026-09-27 19:14:34.921 | INFO | Click ( 200, 267) @ 13-1 2026-09-27 19:14:35.321 | INFO | [Map_clear_percentage] 5% 2026-09-27 19:14:35.628 | INFO | [Map_clear_percentage] 66% 2026-09-27 19:14:35.926 | INFO | [Map_clear_percentage] 99% 2026-09-27 19:14:35.951 | INFO | [MAP_CLEAR_ALL_THIS_TIME] False 2026-09-27 19:14:35.954 | INFO | [Map_info] 99%, star_1, star_2, star_3, 100_percent_clear, 3_stars, threat_safe, clear_mode 2026-09-27 19:14:35.960 | INFO | [StopCondition_MapAchievement] non_stop 2026-09-27 19:14:35.964 | INFO | Clear_Mode set to on 2026-09-27 19:14:35.968 | INFO | [Clear_Mode] on 2026-09-27 19:14:35.982 | INFO | Auto_Search set to on 2026-09-27 19:14:35.987 | INFO | [Auto_Search] on 2026-09-27 19:14:35.992 | INFO | Click (1037, 517) @ MAP_PREPARATION 2026-09-27 19:14:36.522 | INFO | Handling 2x book setting, mode=prep. 2026-09-27 19:14:36.543 | INFO | Using fleet: [4, 3, 1] 2026-09-27 19:14:36.615 | INFO | Hard satisfied: Fleet_1: None, Fleet_2: None, Submarine: None 2026-09-27 19:14:36.625 | INFO | [map_allow_submarine] True 2026-09-27 19:14:36.630 | INFO | Click (1134, 331) @ FLEET_2_CLEAR 2026-09-27 19:14:36.684 | INFO | Fleet SUBMARINE set to 1 2026-09-27 19:14:36.688 | INFO | Click (1035, 479) @ SUBMARINE_CHOOSE 2026-09-27 19:14:36.822 | INFO | FleetOption: [1] 2 2026-09-27 19:14:36.825 | INFO | Fleet option 1 is already selected 2026-09-27 19:14:36.828 | INFO | Click (1042, 465) @ SUBMARINE_CHOOSE 2026-09-27 19:14:37.129 | INFO | FleetOption: 2026-09-27 19:14:37.136 | INFO | Fleet FLEET_1 set to 4 2026-09-27 19:14:37.139 | INFO | Click (1044, 225) @ FLEET_1_CHOOSE 2026-09-27 19:14:37.425 | INFO | FleetOption: 1 2 [3] 4 5 6 2026-09-27 19:14:37.429 | INFO | Click (1084, 414) @ FleetOption_4 2026-09-27 19:14:37.725 | INFO | FleetOption: 2026-09-27 19:14:37.731 | INFO | Fleet FLEET_2 set to 3 2026-09-27 19:14:37.734 | INFO | Click (1055, 340) @ FLEET_2_CHOOSE 2026-09-27 19:14:38.024 | INFO | FleetOption: 1 2 3 [4] 5 6 2026-09-27 19:14:38.028 | INFO | Click (1061, 490) @ FleetOption_3 2026-09-27 19:14:38.319 | INFO | FleetOption: 2026-09-27 19:14:38.322 | INFO | Auto search setting 2026-09-27 19:14:38.337 | INFO | [_fleet_sidebar_offset] 0 2026-09-27 19:14:38.342 | INFO | [_fleet_sidebar_offset] 0 2026-09-27 19:14:38.346 | INFO | [Fleet_sidebar] 1/3 2026-09-27 19:14:38.352 | INFO | Click (1218, 449) @ FLEET_SIDEBAR_0_2 2026-09-27 19:14:38.618 | INFO | [_fleet_sidebar_offset] 0 2026-09-27 19:14:38.622 | INFO | [Fleet_sidebar] 3/3 2026-09-27 19:14:38.625 | INFO | [Auto_Search_Setting] fleet1_all_fleet2_standby, sub_standby 2026-09-27 19:14:38.628 | INFO | Click ( 507, 219) @ AUTO_SEARCH_SET_MOB 2026-09-27 19:14:39.116 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_standby 2026-09-27 19:14:39.119 | INFO | Selected to the correct auto search setting 2026-09-27 19:14:39.123 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_standby 2026-09-27 19:14:39.125 | INFO | Selected to the correct auto search setting 2026-09-27 19:14:39.127 | INFO | Click (1016, 532) @ FLEET_PREPARATION 2026-09-27 19:14:44.231 | INFO | Handling 2x book setting, mode=prep. 2026-09-27 19:14:44.243 | INFO | Using fleet: [4, 3, 1] 2026-09-27 19:14:44.247 | INFO | Auto search setting 2026-09-27 19:14:44.252 | INFO | [_fleet_sidebar_offset] 0 2026-09-27 19:14:44.257 | INFO | [_fleet_sidebar_offset] 0 2026-09-27 19:14:44.262 | INFO | [Fleet_sidebar] 3/3 2026-09-27 19:14:44.266 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_standby 2026-09-27 19:14:44.268 | INFO | Selected to the correct auto search setting 2026-09-27 19:14:44.271 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_standby 2026-09-27 19:14:44.276 | INFO | Selected to the correct auto search setting 2026-09-27 19:14:44.280 | INFO | Click (1055, 573) @ FLEET_PREPARATION 2026-09-27 19:14:45.144 | INFO | is_auto_search_running appeared ────────────────────────────────────────────────────── BATTLE_0 ─────────────────────────────────────────────────────── 2026-09-27 19:14:45.149 | INFO | BATTLE_0 2026-09-27 19:14:45.152 | INFO | Auto search moving 2026-09-27 19:14:45.165 | INFO | Fleet: 1, fleet_current_index: 1 2026-09-27 19:14:45.206 | INFO | [OCR_OIL 0.038s] 2185 2026-09-27 19:14:45.274 | INFO | [OCR_COIN 0.065s] 12236 2026-09-27 19:14:49.803 | INFO | [Loading] 18% 2026-09-27 19:14:49.806 | INFO | Auto search combat loading 2026-09-27 19:14:49.808 | INFO | Screenshot interval set to 1.0s 2026-09-27 19:14:55.828 | INFO | [BattleUI] PAUSE 2026-09-27 19:14:55.832 | INFO | Auto Search combat execute 2026-09-27 19:14:55.837 | INFO | <<< EMOTION REDUCE >>> 2026-09-27 19:14:55.849 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-09-27 19:14:55.853 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=117, Main.Emotion.Fleet1Record=datetime.datetime(2026, 9, 27, 19, 14, 55), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 9, 27, 19, 14, 55) 2026-09-27 19:14:55.870 | INFO | [Emotion fleet_1] 117 2026-09-27 19:14:55.873 | INFO | [Emotion fleet_2] 119 2026-09-27 19:15:01.805 | INFO | Combat auto check timer reached 2026-09-27 19:15:20.837 | INFO | Screenshot interval set to 0.3s 2026-09-27 19:15:20.840 | INFO | Auto Search combat status 2026-09-27 19:15:25.626 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_1 ─────────────────────────────────────────────────────── 2026-09-27 19:15:25.632 | INFO | BATTLE_1 2026-09-27 19:15:25.635 | INFO | Auto search moving 2026-09-27 19:15:25.639 | INFO | Fleet: 1, fleet_current_index: 1 2026-09-27 19:15:25.745 | INFO | [OCR_OIL 0.102s] 2166 2026-09-27 19:15:25.828 | INFO | [OCR_COIN 0.075s] 12256 2026-09-27 19:15:31.336 | INFO | [Loading] 12% 2026-09-27 19:15:31.341 | INFO | Auto search combat loading 2026-09-27 19:15:31.344 | INFO | Screenshot interval set to 1.0s 2026-09-27 19:15:37.346 | INFO | [BattleUI] PAUSE 2026-09-27 19:15:37.350 | INFO | Auto Search combat execute 2026-09-27 19:15:37.353 | INFO | <<< EMOTION REDUCE >>> 2026-09-27 19:15:37.365 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-09-27 19:15:37.370 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=115, Main.Emotion.Fleet1Record=datetime.datetime(2026, 9, 27, 19, 15, 37), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 9, 27, 19, 15, 37) 2026-09-27 19:15:37.389 | INFO | [Emotion fleet_1] 115 2026-09-27 19:15:37.392 | INFO | [Emotion fleet_2] 119 2026-09-27 19:15:42.353 | INFO | Combat auto check timer reached 2026-09-27 19:16:01.374 | INFO | Screenshot interval set to 0.3s 2026-09-27 19:16:01.377 | INFO | Auto Search combat status 2026-09-27 19:16:02.266 | INFO | Click (1006, 661) @ GET_SHIP 2026-09-27 19:16:03.472 | INFO | Click (1030, 666) @ GET_SHIP 2026-09-27 19:16:07.661 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_2 ─────────────────────────────────────────────────────── 2026-09-27 19:16:07.666 | INFO | BATTLE_2 2026-09-27 19:16:07.668 | INFO | Auto search moving 2026-09-27 19:16:07.671 | INFO | Fleet: 1, fleet_current_index: 1 2026-09-27 19:16:07.730 | INFO | [OCR_OIL 0.055s] 2147 2026-09-27 19:16:07.824 | INFO | [OCR_COIN 0.090s] 12272 2026-09-27 19:16:12.174 | INFO | [Loading] 10% 2026-09-27 19:16:12.177 | INFO | Auto search combat loading 2026-09-27 19:16:12.181 | INFO | Screenshot interval set to 1.0s 2026-09-27 19:16:18.184 | INFO | [BattleUI] PAUSE 2026-09-27 19:16:18.188 | INFO | Auto Search combat execute 2026-09-27 19:16:18.193 | INFO | <<< EMOTION REDUCE >>> 2026-09-27 19:16:18.209 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-09-27 19:16:18.214 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=113, Main.Emotion.Fleet1Record=datetime.datetime(2026, 9, 27, 19, 16, 18), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 9, 27, 19, 16, 18) 2026-09-27 19:16:18.234 | INFO | [Emotion fleet_1] 113 2026-09-27 19:16:18.238 | INFO | [Emotion fleet_2] 119 2026-09-27 19:16:24.180 | INFO | Combat auto check timer reached 2026-09-27 19:17:04.229 | INFO | Screenshot interval set to 0.3s 2026-09-27 19:17:04.232 | INFO | Auto Search combat status 2026-09-27 19:17:06.313 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_3 ─────────────────────────────────────────────────────── 2026-09-27 19:17:06.318 | INFO | BATTLE_3 2026-09-27 19:17:06.321 | INFO | Auto search moving 2026-09-27 19:17:06.324 | INFO | Fleet: 1, fleet_current_index: 1 2026-09-27 19:17:06.390 | INFO | [OCR_OIL 0.063s] 2128 2026-09-27 19:17:06.476 | INFO | [OCR_COIN 0.082s] 12289 2026-09-27 19:17:12.330 | INFO | [Loading] 7% 2026-09-27 19:17:12.334 | INFO | Auto search combat loading 2026-09-27 19:17:12.337 | INFO | Screenshot interval set to 1.0s 2026-09-27 19:17:18.353 | INFO | [BattleUI] PAUSE 2026-09-27 19:17:18.359 | INFO | Auto Search combat execute 2026-09-27 19:17:18.363 | INFO | <<< EMOTION REDUCE >>> 2026-09-27 19:17:18.380 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-09-27 19:17:18.386 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=111, Main.Emotion.Fleet1Record=datetime.datetime(2026, 9, 27, 19, 17, 18), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 9, 27, 19, 17, 18) 2026-09-27 19:17:18.404 | INFO | [Emotion fleet_1] 111 2026-09-27 19:17:18.409 | INFO | [Emotion fleet_2] 119 2026-09-27 19:17:24.323 | INFO | Combat auto check timer reached 2026-09-27 19:18:04.388 | INFO | Screenshot interval set to 0.3s 2026-09-27 19:18:04.392 | INFO | Auto Search combat status 2026-09-27 19:18:05.862 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_4 ─────────────────────────────────────────────────────── 2026-09-27 19:18:05.867 | INFO | BATTLE_4 2026-09-27 19:18:05.870 | INFO | Auto search moving 2026-09-27 19:18:05.873 | INFO | Fleet: 1, fleet_current_index: 1 2026-09-27 19:18:05.942 | INFO | [OCR_OIL 0.067s] 2109 2026-09-27 19:18:06.011 | INFO | [OCR_COIN 0.066s] 12318 2026-09-27 19:18:10.971 | INFO | [Loading] 19% 2026-09-27 19:18:10.976 | INFO | Auto search combat loading 2026-09-27 19:18:10.979 | INFO | Screenshot interval set to 1.0s 2026-09-27 19:18:16.988 | INFO | [BattleUI] PAUSE 2026-09-27 19:18:16.992 | INFO | Auto Search combat execute 2026-09-27 19:18:16.995 | INFO | <<< EMOTION REDUCE >>> 2026-09-27 19:18:17.008 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-09-27 19:18:17.014 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=111, Main.Emotion.Fleet1Record=datetime.datetime(2026, 9, 27, 19, 18, 16), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 9, 27, 19, 18, 16) 2026-09-27 19:18:17.029 | INFO | [Emotion fleet_1] 111 2026-09-27 19:18:17.032 | INFO | [Emotion fleet_2] 119 2026-09-27 19:18:22.976 | INFO | Combat auto check timer reached 2026-09-27 19:19:16.040 | INFO | Screenshot interval set to 0.3s 2026-09-27 19:19:16.044 | INFO | Auto Search combat status 2026-09-27 19:19:20.823 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_5 ─────────────────────────────────────────────────────── 2026-09-27 19:19:20.829 | INFO | BATTLE_5 2026-09-27 19:19:20.831 | INFO | Auto search moving 2026-09-27 19:19:20.835 | INFO | Fleet: 1, fleet_current_index: 1 2026-09-27 19:19:20.896 | INFO | [OCR_OIL 0.059s] 2090 2026-09-27 19:19:20.985 | INFO | [OCR_COIN 0.085s] 12335 2026-09-27 19:19:22.937 | INFO | [Loading] 18% 2026-09-27 19:19:22.940 | INFO | Auto search combat loading 2026-09-27 19:19:22.942 | INFO | Screenshot interval set to 1.0s 2026-09-27 19:19:28.940 | INFO | [BattleUI] PAUSE 2026-09-27 19:19:28.943 | INFO | Auto Search combat execute 2026-09-27 19:19:28.946 | INFO | <<< EMOTION REDUCE >>> 2026-09-27 19:19:28.959 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-09-27 19:19:28.963 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=109, Main.Emotion.Fleet1Record=datetime.datetime(2026, 9, 27, 19, 19, 28), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 9, 27, 19, 19, 28) 2026-09-27 19:19:28.981 | INFO | [Emotion fleet_1] 109 2026-09-27 19:19:28.984 | INFO | [Emotion fleet_2] 119 2026-09-27 19:19:33.973 | INFO | Combat auto check timer reached 2026-09-27 19:22:29.099 | 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 L587 loop() alas.py L69 run() alas.py L356 main() run.py L438 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-09-27 19:22:29.128 | WARNING | Wait too long 2026-09-27 19:22:29.134 | 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-09-27 19:22:29.205 | INFO | [Package_name] com.bilibili.azurlane 2026-09-27 19:22:29.208 | ERROR | GameStuckError: Wait too long 2026-09-27 19:22:29.210 | WARNING | Saving error: ./log/error/1790508149210