═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ MAIN ═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ ════════════════════════════════════════════════════ CAMPAIGN_13_1 ════════════════════════════════════════════════════ 2026-07-29 21:12:04.436 | INFO | CAMPAIGN_13_1 2026-07-29 21:12:04.439 | INFO | Count: 0 2026-07-29 21:12:04.459 | INFO | <<< UI ENSURE >>> 2026-07-29 21:12:04.462 | INFO | UI get current page 2026-07-29 21:12:04.479 | INFO | [UI] page_main 2026-07-29 21:12:04.484 | INFO | Goto page_campaign 2026-07-29 21:12:04.489 | INFO | <<< UI GOTO PAGE_CAMPAIGN >>> 2026-07-29 21:12:04.548 | INFO | Page switch: page_main_white -> page_campaign_menu 2026-07-29 21:12:04.553 | INFO | Click (1147, 483) @ MAIN_GOTO_CAMPAIGN_WHITE 2026-07-29 21:12:05.657 | INFO | Page switch: page_campaign_menu -> page_campaign 2026-07-29 21:12:05.661 | INFO | Click ( 252, 290) @ CAMPAIGN_MENU_GOTO_CAMPAIGN 2026-07-29 21:12:05.953 | INFO | Page arrive: page_campaign 2026-07-29 21:12:05.979 | INFO | Mode_switch_1 set to hard 2026-07-29 21:12:06.004 | INFO | [Mode_switch_1] hard 2026-07-29 21:12:06.007 | INFO | <<< UI ENSURE INDEX >>> 2026-07-29 21:12:06.078 | INFO | No stage found. 2026-07-29 21:12:06.316 | INFO | No stage found. 2026-07-29 21:12:06.625 | INFO | No stage found. 2026-07-29 21:12:06.940 | INFO | Loading OCR model: ./bin/cnocr_models/azur_lane 2026-07-29 21:12:07.043 | INFO | [campaign 0.121s] ['2--2', '2--3', '2--1', '2--4'] 2026-07-29 21:12:07.047 | INFO | [Chapter] 2 2026-07-29 21:12:07.049 | INFO | [Stage] 2-2, 2-3, 2-1, 2-4 2026-07-29 21:12:07.052 | INFO | [Index] 2 2026-07-29 21:12:07.298 | INFO | Click (1219, 380) @ CHAPTER_NEXT 2026-07-29 21:12:07.544 | INFO | Click (1224, 381) @ CHAPTER_NEXT 2026-07-29 21:12:07.799 | INFO | Click (1228, 369) @ CHAPTER_NEXT 2026-07-29 21:12:08.080 | INFO | Click (1226, 383) @ CHAPTER_NEXT 2026-07-29 21:12:08.306 | INFO | Click (1223, 386) @ CHAPTER_NEXT 2026-07-29 21:12:08.557 | INFO | Click (1225, 381) @ CHAPTER_NEXT 2026-07-29 21:12:08.796 | INFO | Click (1221, 369) @ CHAPTER_NEXT 2026-07-29 21:12:09.049 | INFO | Click (1223, 382) @ CHAPTER_NEXT 2026-07-29 21:12:09.311 | INFO | Click (1225, 375) @ CHAPTER_NEXT 2026-07-29 21:12:09.560 | INFO | Click (1221, 366) @ CHAPTER_NEXT 2026-07-29 21:12:09.814 | INFO | Click (1225, 364) @ CHAPTER_NEXT 2026-07-29 21:12:09.995 | INFO | No stage found. 2026-07-29 21:12:10.273 | INFO | No stage found. 2026-07-29 21:12:10.615 | INFO | [campaign 0.035s] ['', '', '', ''] 2026-07-29 21:12:10.928 | INFO | [campaign 0.049s] ['13--1', '13--3', '13--2', '13--4'] 2026-07-29 21:12:10.931 | INFO | [Chapter] 13 2026-07-29 21:12:10.936 | INFO | [Stage] 13-1, 13-3, 13-2, 13-4 2026-07-29 21:12:10.940 | INFO | [Index] 13 2026-07-29 21:12:11.003 | INFO | [OCR_OIL 0.037s] 17697 ──────────────────────────────────────────────────────── 13-1 ───────────────────────────────────────────────────────── 2026-07-29 21:12:11.009 | INFO | 13-1 2026-07-29 21:12:11.011 | INFO | Expect emotion reduce: (12, 2) 2026-07-29 21:12:11.021 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-07-29 21:12:11.025 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=53, Main.Emotion.Fleet1Record=datetime.datetime(2026, 7, 29, 21, 12, 11), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 7, 29, 21, 12, 11) 2026-07-29 21:12:11.039 | INFO | [Emotion fleet_1] 53 2026-07-29 21:12:11.043 | INFO | [Emotion fleet_2] 119 2026-07-29 21:12:11.045 | INFO | <<< ENTER MAP >>> 2026-07-29 21:12:11.117 | INFO | Click ( 187, 287) @ 13-1 2026-07-29 21:12:11.524 | INFO | [Map_clear_percentage] 5% 2026-07-29 21:12:11.820 | INFO | [Map_clear_percentage] 66% 2026-07-29 21:12:12.122 | INFO | [Map_clear_percentage] 99% 2026-07-29 21:12:12.148 | INFO | [MAP_CLEAR_ALL_THIS_TIME] False 2026-07-29 21:12:12.151 | INFO | [Map_info] 99%, star_1, star_2, star_3, 100_percent_clear, 3_stars, threat_safe, clear_mode 2026-07-29 21:12:12.154 | INFO | [StopCondition_MapAchievement] non_stop 2026-07-29 21:12:12.158 | INFO | Fast_Forward set to on 2026-07-29 21:12:12.161 | INFO | [Fast_Forward] on 2026-07-29 21:12:12.174 | INFO | Auto_Search set to on 2026-07-29 21:12:12.179 | INFO | [Auto_Search] on 2026-07-29 21:12:12.182 | INFO | Click ( 896, 513) @ MAP_PREPARATION 2026-07-29 21:12:12.426 | INFO | Handling 2x book setting, mode=prep. 2026-07-29 21:12:12.725 | INFO | Using fleet: [4, 3, 1] 2026-07-29 21:12:12.798 | INFO | Hard satisfied: Fleet_1: None, Fleet_2: None, Submarine: None 2026-07-29 21:12:12.808 | INFO | [map_allow_submarine] True 2026-07-29 21:12:12.813 | INFO | Click (1134, 330) @ FLEET_2_CLEAR 2026-07-29 21:12:12.868 | INFO | Click (1063, 454) @ SUBMARINE_CHOOSE 2026-07-29 21:12:13.021 | INFO | Current selected: [1] 2026-07-29 21:12:13.026 | INFO | Click (1056, 458) @ SUBMARINE_CHOOSE 2026-07-29 21:12:13.321 | INFO | Click (1037, 218) @ FLEET_1_CHOOSE 2026-07-29 21:12:13.619 | INFO | Current selected: [5] 2026-07-29 21:12:13.623 | INFO | Click (1117, 416) @ FLEET_1_BAR_INDEX_4 2026-07-29 21:12:13.920 | INFO | Click (1075, 328) @ FLEET_2_CHOOSE 2026-07-29 21:12:14.221 | INFO | Current selected: [4] 2026-07-29 21:12:14.224 | INFO | Click (1068, 482) @ FLEET_2_BAR_INDEX_3 2026-07-29 21:12:14.518 | INFO | Auto search setting 2026-07-29 21:12:14.533 | INFO | [_fleet_sidebar_offset] 0 2026-07-29 21:12:14.539 | INFO | [_fleet_sidebar_offset] 0 2026-07-29 21:12:14.545 | INFO | [Fleet_sidebar] 1/3 2026-07-29 21:12:14.549 | INFO | Click (1217, 415) @ FLEET_SIDEBAR_0_2 2026-07-29 21:12:14.821 | INFO | [_fleet_sidebar_offset] 0 2026-07-29 21:12:14.825 | INFO | [Fleet_sidebar] 3/3 2026-07-29 21:12:14.828 | INFO | [Auto_Search_Setting] fleet1_all_fleet2_standby, sub_standby 2026-07-29 21:12:14.831 | INFO | Click ( 506, 212) @ AUTO_SEARCH_SET_MOB 2026-07-29 21:12:15.343 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_standby 2026-07-29 21:12:15.350 | INFO | Selected to the correct auto search setting 2026-07-29 21:12:15.355 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_standby 2026-07-29 21:12:15.361 | INFO | Selected to the correct auto search setting 2026-07-29 21:12:15.365 | INFO | Click (1029, 589) @ FLEET_PREPARATION 2026-07-29 21:12:16.252 | INFO | is_auto_search_running appeared ────────────────────────────────────────────────────── BATTLE_0 ─────────────────────────────────────────────────────── 2026-07-29 21:12:16.257 | INFO | BATTLE_0 2026-07-29 21:12:16.259 | INFO | Auto search moving 2026-07-29 21:12:16.272 | INFO | Fleet: 1, fleet_current_index: 1 2026-07-29 21:12:16.318 | INFO | [OCR_OIL 0.041s] 17687 2026-07-29 21:12:16.377 | INFO | [OCR_COIN 0.055s] 109382 2026-07-29 21:12:21.192 | INFO | [Loading] 11% 2026-07-29 21:12:21.197 | INFO | Auto search combat loading 2026-07-29 21:12:21.200 | INFO | Screenshot interval set to 1.0s 2026-07-29 21:12:27.202 | INFO | [BattleUI] PAUSE 2026-07-29 21:12:27.206 | INFO | Auto Search combat execute 2026-07-29 21:12:27.210 | INFO | <<< EMOTION REDUCE >>> 2026-07-29 21:12:27.222 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-07-29 21:12:27.225 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=51, Main.Emotion.Fleet1Record=datetime.datetime(2026, 7, 29, 21, 12, 27), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 7, 29, 21, 12, 27) 2026-07-29 21:12:27.241 | INFO | [Emotion fleet_1] 51 2026-07-29 21:12:27.245 | INFO | [Emotion fleet_2] 119 2026-07-29 21:12:33.195 | INFO | Combat auto check timer reached 2026-07-29 21:13:25.249 | INFO | Screenshot interval set to 0.3s 2026-07-29 21:13:25.252 | INFO | Auto Search combat status 2026-07-29 21:13:26.138 | INFO | Click (1017, 650) @ GET_SHIP 2026-07-29 21:13:27.644 | INFO | Click (1029, 655) @ GET_SHIP 2026-07-29 21:13:28.848 | INFO | Click (1024, 660) @ GET_SHIP 2026-07-29 21:13:30.036 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_1 ─────────────────────────────────────────────────────── 2026-07-29 21:13:30.040 | INFO | BATTLE_1 2026-07-29 21:13:30.042 | INFO | Auto search moving 2026-07-29 21:13:30.045 | INFO | Fleet: 1, fleet_current_index: 1 2026-07-29 21:13:30.098 | INFO | [OCR_OIL 0.051s] 17668 2026-07-29 21:13:30.168 | INFO | [OCR_COIN 0.066s] 109402 2026-07-29 21:13:35.150 | INFO | [Loading] 5% 2026-07-29 21:13:35.154 | INFO | Auto search combat loading 2026-07-29 21:13:35.157 | INFO | Screenshot interval set to 1.0s 2026-07-29 21:13:41.155 | INFO | [BattleUI] PAUSE 2026-07-29 21:13:41.158 | INFO | Auto Search combat execute 2026-07-29 21:13:41.161 | INFO | <<< EMOTION REDUCE >>> 2026-07-29 21:13:41.173 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-07-29 21:13:41.179 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=49, Main.Emotion.Fleet1Record=datetime.datetime(2026, 7, 29, 21, 13, 41), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 7, 29, 21, 13, 41) 2026-07-29 21:13:41.191 | INFO | [Emotion fleet_1] 49 2026-07-29 21:13:41.194 | INFO | [Emotion fleet_2] 119 2026-07-29 21:13:47.156 | INFO | Combat auto check timer reached 2026-07-29 21:14:25.212 | INFO | Click (1021, 647) @ GET_SHIP 2026-07-29 21:14:27.207 | INFO | Click (1032, 650) @ GET_SHIP 2026-07-29 21:14:28.208 | INFO | Click (1038, 652) @ GET_SHIP 2026-07-29 21:14:30.204 | INFO | Click (1029, 657) @ GET_SHIP 2026-07-29 21:14:32.213 | INFO | Screenshot interval set to 0.3s 2026-07-29 21:14:32.217 | INFO | Auto Search combat status 2026-07-29 21:14:32.222 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_2 ─────────────────────────────────────────────────────── 2026-07-29 21:14:32.226 | INFO | BATTLE_2 2026-07-29 21:14:32.230 | INFO | Auto search moving 2026-07-29 21:14:32.235 | INFO | Fleet: 1, fleet_current_index: 1 2026-07-29 21:14:32.303 | INFO | [OCR_OIL 0.065s] 17649 2026-07-29 21:14:32.354 | INFO | [OCR_COIN 0.048s] 109412 2026-07-29 21:14:35.798 | INFO | [Loading] 7% 2026-07-29 21:14:35.802 | INFO | Auto search combat loading 2026-07-29 21:14:35.806 | INFO | Screenshot interval set to 1.0s 2026-07-29 21:14:41.805 | INFO | [BattleUI] PAUSE 2026-07-29 21:14:41.809 | INFO | Auto Search combat execute 2026-07-29 21:14:41.812 | INFO | <<< EMOTION REDUCE >>> 2026-07-29 21:14:41.826 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-07-29 21:14:41.832 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=47, Main.Emotion.Fleet1Record=datetime.datetime(2026, 7, 29, 21, 14, 41), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 7, 29, 21, 14, 41) 2026-07-29 21:14:41.851 | INFO | [Emotion fleet_1] 47 2026-07-29 21:14:41.856 | INFO | [Emotion fleet_2] 119 2026-07-29 21:14:46.839 | INFO | Combat auto check timer reached 2026-07-29 21:15:11.840 | INFO | Screenshot interval set to 0.3s 2026-07-29 21:15:11.846 | INFO | Auto Search combat status 2026-07-29 21:15:13.631 | INFO | Click (1041, 665) @ GET_SHIP 2026-07-29 21:15:14.830 | INFO | Click (1027, 653) @ GET_SHIP 2026-07-29 21:15:16.042 | INFO | Click (1040, 665) @ GET_SHIP 2026-07-29 21:15:17.227 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_3 ─────────────────────────────────────────────────────── 2026-07-29 21:15:17.234 | INFO | BATTLE_3 2026-07-29 21:15:17.236 | INFO | Auto search moving 2026-07-29 21:15:17.239 | INFO | Fleet: 1, fleet_current_index: 1 2026-07-29 21:15:17.311 | INFO | [OCR_OIL 0.068s] 17630 2026-07-29 21:15:17.396 | INFO | [OCR_COIN 0.081s] 109435 2026-07-29 21:15:21.736 | INFO | [Loading] 7% 2026-07-29 21:15:21.741 | INFO | Auto search combat loading 2026-07-29 21:15:21.743 | INFO | Screenshot interval set to 1.0s 2026-07-29 21:15:27.747 | INFO | [BattleUI] PAUSE 2026-07-29 21:15:27.750 | INFO | Auto Search combat execute 2026-07-29 21:15:27.752 | INFO | <<< EMOTION REDUCE >>> 2026-07-29 21:15:27.764 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-07-29 21:15:27.767 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=45, Main.Emotion.Fleet1Record=datetime.datetime(2026, 7, 29, 21, 15, 27), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 7, 29, 21, 15, 27) 2026-07-29 21:15:27.784 | INFO | [Emotion fleet_1] 45 2026-07-29 21:15:27.787 | INFO | [Emotion fleet_2] 119 2026-07-29 21:15:33.735 | INFO | Combat auto check timer reached 2026-07-29 21:16:14.803 | INFO | Click (1021, 640) @ GET_SHIP 2026-07-29 21:16:15.800 | INFO | Screenshot interval set to 0.3s 2026-07-29 21:16:15.805 | INFO | Auto Search combat status 2026-07-29 21:16:15.817 | INFO | Click (1016, 649) @ GET_SHIP 2026-07-29 21:16:16.998 | INFO | Click (1028, 671) @ GET_SHIP 2026-07-29 21:16:18.170 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_4 ─────────────────────────────────────────────────────── 2026-07-29 21:16:18.177 | INFO | BATTLE_4 2026-07-29 21:16:18.179 | INFO | Auto search moving 2026-07-29 21:16:18.182 | INFO | Fleet: 1, fleet_current_index: 1 2026-07-29 21:16:18.249 | INFO | [OCR_OIL 0.064s] 17611 2026-07-29 21:16:18.353 | INFO | [OCR_COIN 0.101s] 109450 2026-07-29 21:16:23.286 | INFO | [Loading] 16% 2026-07-29 21:16:23.290 | INFO | Auto search combat loading 2026-07-29 21:16:23.294 | INFO | Screenshot interval set to 1.0s 2026-07-29 21:16:29.291 | INFO | [BattleUI] PAUSE 2026-07-29 21:16:29.296 | INFO | Auto Search combat execute 2026-07-29 21:16:29.299 | INFO | <<< EMOTION REDUCE >>> 2026-07-29 21:16:29.310 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-07-29 21:16:29.315 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=43, Main.Emotion.Fleet1Record=datetime.datetime(2026, 7, 29, 21, 16, 29), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 7, 29, 21, 16, 29) 2026-07-29 21:16:29.328 | INFO | [Emotion fleet_1] 43 2026-07-29 21:16:29.332 | INFO | [Emotion fleet_2] 119 2026-07-29 21:16:34.299 | INFO | Combat auto check timer reached 2026-07-29 21:17:28.346 | INFO | Screenshot interval set to 0.3s 2026-07-29 21:17:28.349 | INFO | Auto Search combat status 2026-07-29 21:17:29.236 | INFO | Click (1008, 656) @ GET_SHIP 2026-07-29 21:17:30.435 | INFO | Click (1034, 658) @ GET_SHIP 2026-07-29 21:17:31.638 | INFO | Click (1031, 668) @ GET_SHIP 2026-07-29 21:17:32.843 | INFO | Click (1029, 656) @ GET_SHIP 2026-07-29 21:17:34.053 | INFO | Click (1031, 654) @ GET_SHIP 2026-07-29 21:17:34.937 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_5 ─────────────────────────────────────────────────────── 2026-07-29 21:17:34.943 | INFO | BATTLE_5 2026-07-29 21:17:34.946 | INFO | Auto search moving 2026-07-29 21:17:34.951 | INFO | Fleet: 1, fleet_current_index: 1 2026-07-29 21:17:35.015 | INFO | [OCR_OIL 0.059s] 17592 2026-07-29 21:17:35.121 | INFO | [OCR_COIN 0.102s] 109473 2026-07-29 21:17:38.551 | INFO | [Loading] 5% 2026-07-29 21:17:38.554 | INFO | Auto search combat loading 2026-07-29 21:17:38.556 | INFO | Screenshot interval set to 1.0s 2026-07-29 21:17:44.561 | INFO | [BattleUI] PAUSE 2026-07-29 21:17:44.564 | INFO | Auto Search combat execute 2026-07-29 21:17:44.567 | INFO | <<< EMOTION REDUCE >>> 2026-07-29 21:17:44.579 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-07-29 21:17:44.584 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=41, Main.Emotion.Fleet1Record=datetime.datetime(2026, 7, 29, 21, 17, 44), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 7, 29, 21, 17, 44) 2026-07-29 21:17:44.601 | INFO | [Emotion fleet_1] 41 2026-07-29 21:17:44.604 | INFO | [Emotion fleet_2] 119 2026-07-29 21:17:50.556 | INFO | Combat auto check timer reached 2026-07-29 21:18:58.613 | INFO | Click (1034, 659) @ GET_SHIP 2026-07-29 21:21:58.760 | 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 L1543 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 L555 loop() alas.py L69 run() alas.py L352 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-07-29 21:21:58.781 | WARNING | Wait too long 2026-07-29 21:21:58.785 | WARNING | Waiting for {'EXP_INFO_A', 'MISSION_POPUP_GO', 'EVENT_CHECK', 'EXP_INFO_B', 'GUILD_POPUP_CONFIRM', 'POPUP_CONFIRM_WHITE', 'GET_MISSION', 'BATTLE_STATUS_S', 'EXP_INFO_S', 'GET_SHIP', 'SP_CHECK', 'CAMPAIGN_CHECK', 'AUTO_SEARCH_MAP_OPTION_ON', 'PAUSE', 'POPUP_CANCEL', 'NEW_SHIP', 'BATTLE_STATUS_A', 'BATTLE_STATUS_B'} 2026-07-29 21:21:58.839 | INFO | [Package_name] com.bilibili.azurlane 2026-07-29 21:21:58.842 | ERROR | GameStuckError: Wait too long 2026-07-29 21:21:58.845 | WARNING | Saving error: ./log/error/1785331318845