═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ MAIN ═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ ════════════════════════════════════════════════════ CAMPAIGN_13_1 ════════════════════════════════════════════════════ 2026-05-12 23:54:01.665 | INFO | CAMPAIGN_13_1 2026-05-12 23:54:01.668 | INFO | Count: 0 2026-05-12 23:54:01.695 | INFO | <<< UI ENSURE >>> 2026-05-12 23:54:01.701 | INFO | UI get current page 2026-05-12 23:54:02.239 | INFO | Unknown ui page 2026-05-12 23:54:02.716 | INFO | UI additional: IDLE -> REWARD_GOTO_MAIN 2026-05-12 23:54:02.719 | INFO | Click ( 841, 617) @ REWARD_GOTO_MAIN 2026-05-12 23:54:02.887 | INFO | Unknown ui page 2026-05-12 23:54:03.069 | INFO | [Package_name] com.bilibili.azurlane 2026-05-12 23:54:03.085 | INFO | [Device Orientation] 0 (Normal) 2026-05-12 23:54:03.218 | INFO | Unknown ui page 2026-05-12 23:54:03.510 | INFO | Unknown ui page 2026-05-12 23:54:03.743 | INFO | [UI] page_main 2026-05-12 23:54:03.746 | INFO | Goto page_campaign 2026-05-12 23:54:03.749 | INFO | <<< UI GOTO PAGE_CAMPAIGN >>> 2026-05-12 23:54:03.768 | INFO | Page switch: page_main_white -> page_campaign_menu 2026-05-12 23:54:03.773 | INFO | Click (1180, 536) @ MAIN_GOTO_CAMPAIGN_WHITE 2026-05-12 23:54:04.339 | INFO | Page switch: page_campaign_menu -> page_campaign 2026-05-12 23:54:04.343 | INFO | Click ( 305, 354) @ CAMPAIGN_MENU_GOTO_CAMPAIGN 2026-05-12 23:54:04.638 | INFO | Page arrive: page_campaign 2026-05-12 23:54:04.666 | INFO | Mode_switch_1 set to hard 2026-05-12 23:54:04.692 | INFO | [Mode_switch_1] hard 2026-05-12 23:54:04.697 | INFO | <<< UI ENSURE INDEX >>> 2026-05-12 23:54:04.775 | INFO | No stage found. 2026-05-12 23:54:05.002 | INFO | No stage found. 2026-05-12 23:54:05.319 | INFO | Loading OCR model: ./bin/cnocr_models/azur_lane 2026-05-12 23:54:05.436 | INFO | [campaign 0.134s] ['13--1', '13--3', '13--2', '13--4'] 2026-05-12 23:54:05.439 | INFO | [Chapter] 13 2026-05-12 23:54:05.442 | INFO | [Stage] 13-1, 13-3, 13-2, 13-4 2026-05-12 23:54:05.445 | INFO | [Index] 13 2026-05-12 23:54:05.510 | INFO | [OCR_OIL 0.039s] 17917 ──────────────────────────────────────────────────────── 13-1 ───────────────────────────────────────────────────────── 2026-05-12 23:54:05.516 | INFO | 13-1 2026-05-12 23:54:05.518 | INFO | Expect emotion reduce: (12, 2) 2026-05-12 23:54:05.529 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-05-12 23:54:05.533 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=53, Main.Emotion.Fleet1Record=datetime.datetime(2026, 5, 12, 23, 54, 5), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 5, 12, 23, 54, 5) 2026-05-12 23:54:05.550 | INFO | [Emotion fleet_1] 53 2026-05-12 23:54:05.553 | INFO | [Emotion fleet_2] 119 2026-05-12 23:54:05.556 | INFO | <<< ENTER MAP >>> 2026-05-12 23:54:05.633 | INFO | Click ( 181, 287) @ 13-1 2026-05-12 23:54:06.034 | INFO | [Map_clear_percentage] 5% 2026-05-12 23:54:06.337 | INFO | [Map_clear_percentage] 66% 2026-05-12 23:54:06.643 | INFO | [Map_clear_percentage] 99% 2026-05-12 23:54:06.668 | INFO | [MAP_CLEAR_ALL_THIS_TIME] False 2026-05-12 23:54:06.673 | INFO | [Map_info] 99%, star_1, star_2, star_3, 100_percent_clear, 3_stars, threat_safe, clear_mode 2026-05-12 23:54:06.677 | INFO | [StopCondition_MapAchievement] non_stop 2026-05-12 23:54:06.681 | INFO | Fast_Forward set to on 2026-05-12 23:54:06.685 | INFO | [Fast_Forward] on 2026-05-12 23:54:06.699 | INFO | Auto_Search set to on 2026-05-12 23:54:06.706 | INFO | [Auto_Search] on 2026-05-12 23:54:06.711 | INFO | Click ( 938, 504) @ MAP_PREPARATION 2026-05-12 23:54:12.049 | INFO | [Map_clear_percentage] 99% 2026-05-12 23:54:12.059 | INFO | [MAP_CLEAR_ALL_THIS_TIME] False 2026-05-12 23:54:12.063 | INFO | [Map_info] 99%, star_1, star_2, star_3, 100_percent_clear, 3_stars, threat_safe, clear_mode 2026-05-12 23:54:12.070 | INFO | [StopCondition_MapAchievement] non_stop 2026-05-12 23:54:12.075 | INFO | Fast_Forward set to on 2026-05-12 23:54:12.080 | INFO | [Fast_Forward] on 2026-05-12 23:54:12.089 | INFO | Auto_Search set to on 2026-05-12 23:54:12.096 | INFO | [Auto_Search] on 2026-05-12 23:54:12.102 | INFO | Click ( 971, 512) @ MAP_PREPARATION 2026-05-12 23:54:12.342 | INFO | Handling 2x book setting, mode=prep. 2026-05-12 23:54:12.367 | INFO | Using fleet: [4, 3, 1] 2026-05-12 23:54:12.446 | INFO | Hard satisfied: Fleet_1: None, Fleet_2: None, Submarine: None 2026-05-12 23:54:12.455 | INFO | [map_allow_submarine] True 2026-05-12 23:54:12.460 | INFO | Click (1142, 328) @ FLEET_2_CLEAR 2026-05-12 23:54:12.514 | INFO | Click (1044, 472) @ SUBMARINE_CHOOSE 2026-05-12 23:54:12.636 | INFO | Current selected: [1] 2026-05-12 23:54:12.641 | INFO | Click (1051, 494) @ SUBMARINE_CHOOSE 2026-05-12 23:54:12.946 | INFO | Click (1064, 234) @ FLEET_1_CHOOSE 2026-05-12 23:54:13.239 | INFO | Current selected: [4] 2026-05-12 23:54:13.244 | INFO | Click (1051, 211) @ FLEET_1_CHOOSE 2026-05-12 23:54:13.543 | INFO | Click (1053, 325) @ FLEET_2_CHOOSE 2026-05-12 23:54:13.840 | INFO | Current selected: [4] 2026-05-12 23:54:13.845 | INFO | Click (1076, 487) @ FLEET_2_BAR_INDEX_3 2026-05-12 23:54:14.169 | INFO | Auto search setting 2026-05-12 23:54:14.199 | INFO | [_fleet_sidebar_offset] 0 2026-05-12 23:54:14.214 | INFO | [_fleet_sidebar_offset] 0 2026-05-12 23:54:14.224 | INFO | [Fleet_sidebar] 1/3 2026-05-12 23:54:14.233 | INFO | Click (1231, 411) @ FLEET_SIDEBAR_0_2 2026-05-12 23:54:14.440 | INFO | [_fleet_sidebar_offset] 0 2026-05-12 23:54:14.444 | INFO | [Fleet_sidebar] 3/3 2026-05-12 23:54:14.449 | INFO | [Auto_Search_Setting] fleet1_all_fleet2_standby, sub_standby 2026-05-12 23:54:14.452 | INFO | Click ( 506, 220) @ AUTO_SEARCH_SET_MOB 2026-05-12 23:54:14.919 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_standby 2026-05-12 23:54:14.922 | INFO | Selected to the correct auto search setting 2026-05-12 23:54:14.925 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_standby 2026-05-12 23:54:14.928 | INFO | Selected to the correct auto search setting 2026-05-12 23:54:14.931 | INFO | Click (1095, 571) @ FLEET_PREPARATION 2026-05-12 23:54:15.841 | INFO | is_auto_search_running appeared ────────────────────────────────────────────────────── BATTLE_0 ─────────────────────────────────────────────────────── 2026-05-12 23:54:15.846 | INFO | BATTLE_0 2026-05-12 23:54:15.848 | INFO | Auto search moving 2026-05-12 23:54:15.861 | INFO | Fleet: 1, fleet_current_index: 1 2026-05-12 23:54:15.929 | INFO | [OCR_OIL 0.063s] 17907 2026-05-12 23:54:16.022 | INFO | [OCR_COIN 0.089s] 272214 2026-05-12 23:54:20.812 | INFO | [Loading] 18% 2026-05-12 23:54:20.815 | INFO | Auto search combat loading 2026-05-12 23:54:20.818 | INFO | Screenshot interval set to 1.0s 2026-05-12 23:54:25.817 | INFO | [BattleUI] PAUSE 2026-05-12 23:54:25.822 | INFO | Auto Search combat execute 2026-05-12 23:54:25.824 | INFO | <<< EMOTION REDUCE >>> 2026-05-12 23:54:25.835 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-05-12 23:54:25.839 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=51, Main.Emotion.Fleet1Record=datetime.datetime(2026, 5, 12, 23, 54, 25), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 5, 12, 23, 54, 25) 2026-05-12 23:54:25.856 | INFO | [Emotion fleet_1] 51 2026-05-12 23:54:25.861 | INFO | [Emotion fleet_2] 119 2026-05-12 23:54:31.829 | INFO | Combat auto check timer reached 2026-05-12 23:54:50.864 | INFO | Screenshot interval set to 0.3s 2026-05-12 23:54:50.867 | INFO | Auto Search combat status 2026-05-12 23:54:51.738 | INFO | Click (1023, 661) @ GET_SHIP 2026-05-12 23:54:52.938 | INFO | Click (1027, 666) @ GET_SHIP 2026-05-12 23:54:54.136 | INFO | Click (1014, 658) @ GET_SHIP 2026-05-12 23:54:55.340 | INFO | Click (1029, 668) @ GET_SHIP 2026-05-12 23:54:57.134 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_1 ─────────────────────────────────────────────────────── 2026-05-12 23:54:57.140 | INFO | BATTLE_1 2026-05-12 23:54:57.142 | INFO | Auto search moving 2026-05-12 23:54:57.146 | INFO | Fleet: 1, fleet_current_index: 1 2026-05-12 23:54:57.219 | INFO | [OCR_OIL 0.070s] 17888 2026-05-12 23:54:57.298 | INFO | [OCR_COIN 0.075s] 272226 2026-05-12 23:55:02.252 | INFO | [Loading] 13% 2026-05-12 23:55:02.255 | INFO | Auto search combat loading 2026-05-12 23:55:02.258 | INFO | Screenshot interval set to 1.0s 2026-05-12 23:55:08.272 | INFO | [BattleUI] PAUSE 2026-05-12 23:55:08.276 | INFO | Auto Search combat execute 2026-05-12 23:55:08.279 | INFO | <<< EMOTION REDUCE >>> 2026-05-12 23:55:08.290 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-05-12 23:55:08.296 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=49, Main.Emotion.Fleet1Record=datetime.datetime(2026, 5, 12, 23, 55, 8), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 5, 12, 23, 55, 8) 2026-05-12 23:55:08.311 | INFO | [Emotion fleet_1] 49 2026-05-12 23:55:08.316 | INFO | [Emotion fleet_2] 119 2026-05-12 23:55:14.291 | INFO | Combat auto check timer reached 2026-05-12 23:56:11.322 | INFO | Click (1044, 638) @ GET_SHIP 2026-05-12 23:56:12.331 | INFO | Click (1031, 669) @ GET_SHIP 2026-05-12 23:56:13.334 | INFO | Click (1012, 654) @ GET_SHIP 2026-05-12 23:56:14.363 | INFO | Screenshot interval set to 0.3s 2026-05-12 23:56:14.366 | INFO | Auto Search combat status 2026-05-12 23:56:14.370 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_2 ─────────────────────────────────────────────────────── 2026-05-12 23:56:14.377 | INFO | BATTLE_2 2026-05-12 23:56:14.382 | INFO | Auto search moving 2026-05-12 23:56:14.387 | INFO | Fleet: 1, fleet_current_index: 1 2026-05-12 23:56:14.486 | INFO | [OCR_OIL 0.089s] 17869 2026-05-12 23:56:14.581 | INFO | [OCR_COIN 0.090s] 272253 2026-05-12 23:56:18.868 | INFO | [Loading] 7% 2026-05-12 23:56:18.873 | INFO | Auto search combat loading 2026-05-12 23:56:18.876 | INFO | Screenshot interval set to 1.0s 2026-05-12 23:56:24.901 | INFO | [BattleUI] PAUSE 2026-05-12 23:56:24.905 | INFO | Auto Search combat execute 2026-05-12 23:56:24.911 | INFO | <<< EMOTION REDUCE >>> 2026-05-12 23:56:24.928 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-05-12 23:56:24.934 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=47, Main.Emotion.Fleet1Record=datetime.datetime(2026, 5, 12, 23, 56, 24), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 5, 12, 23, 56, 24) 2026-05-12 23:56:24.955 | INFO | [Emotion fleet_1] 47 2026-05-12 23:56:24.961 | INFO | [Emotion fleet_2] 119 2026-05-12 23:56:30.880 | INFO | Combat auto check timer reached 2026-05-12 23:57:24.931 | INFO | Screenshot interval set to 0.3s 2026-05-12 23:57:24.934 | INFO | Auto Search combat status 2026-05-12 23:57:26.421 | INFO | Click (1033, 665) @ GET_SHIP 2026-05-12 23:57:27.622 | INFO | Click (1039, 663) @ GET_SHIP 2026-05-12 23:57:28.823 | INFO | Click (1024, 665) @ GET_SHIP 2026-05-12 23:57:30.027 | INFO | Click (1030, 665) @ GET_SHIP 2026-05-12 23:57:31.816 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_3 ─────────────────────────────────────────────────────── 2026-05-12 23:57:31.823 | INFO | BATTLE_3 2026-05-12 23:57:31.828 | INFO | Auto search moving 2026-05-12 23:57:31.832 | INFO | Fleet: 1, fleet_current_index: 1 2026-05-12 23:57:31.915 | INFO | [OCR_OIL 0.080s] 17850 2026-05-12 23:57:31.989 | INFO | [OCR_COIN 0.069s] 272274 2026-05-12 23:57:36.637 | INFO | [Loading] 9% 2026-05-12 23:57:36.640 | INFO | Auto search combat loading 2026-05-12 23:57:36.642 | INFO | Screenshot interval set to 1.0s 2026-05-12 23:57:42.653 | INFO | [BattleUI] PAUSE 2026-05-12 23:57:42.658 | INFO | Auto Search combat execute 2026-05-12 23:57:42.665 | INFO | <<< EMOTION REDUCE >>> 2026-05-12 23:57:42.676 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-05-12 23:57:42.680 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=45, Main.Emotion.Fleet1Record=datetime.datetime(2026, 5, 12, 23, 57, 42), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 5, 12, 23, 57, 42) 2026-05-12 23:57:42.698 | INFO | [Emotion fleet_1] 45 2026-05-12 23:57:42.703 | INFO | [Emotion fleet_2] 119 2026-05-12 23:57:48.640 | INFO | Combat auto check timer reached 2026-05-12 23:58:23.678 | INFO | Screenshot interval set to 0.3s 2026-05-12 23:58:23.682 | INFO | Auto Search combat status 2026-05-12 23:58:24.273 | INFO | Click (1017, 657) @ GET_SHIP 2026-05-12 23:58:25.777 | INFO | Click (1028, 643) @ GET_SHIP 2026-05-12 23:58:26.976 | INFO | Click (1032, 650) @ GET_SHIP 2026-05-12 23:58:28.165 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_4 ─────────────────────────────────────────────────────── 2026-05-12 23:58:28.170 | INFO | BATTLE_4 2026-05-12 23:58:28.173 | INFO | Auto search moving 2026-05-12 23:58:28.177 | INFO | Fleet: 1, fleet_current_index: 1 2026-05-12 23:58:28.295 | INFO | [OCR_OIL 0.112s] 17831 2026-05-12 23:58:28.398 | INFO | [OCR_COIN 0.099s] 272291 2026-05-12 23:58:32.690 | INFO | [Loading] 12% 2026-05-12 23:58:32.693 | INFO | Auto search combat loading 2026-05-12 23:58:32.697 | INFO | Screenshot interval set to 1.0s 2026-05-12 23:58:38.692 | INFO | [BattleUI] PAUSE 2026-05-12 23:58:38.696 | INFO | Auto Search combat execute 2026-05-12 23:58:38.700 | INFO | <<< EMOTION REDUCE >>> 2026-05-12 23:58:38.711 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-05-12 23:58:38.715 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=43, Main.Emotion.Fleet1Record=datetime.datetime(2026, 5, 12, 23, 58, 38), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 5, 12, 23, 58, 38) 2026-05-12 23:58:38.733 | INFO | [Emotion fleet_1] 43 2026-05-12 23:58:38.737 | INFO | [Emotion fleet_2] 119 2026-05-12 23:58:44.687 | INFO | Combat auto check timer reached 2026-05-12 23:59:21.733 | INFO | Screenshot interval set to 0.3s 2026-05-12 23:59:21.737 | INFO | Auto Search combat status 2026-05-12 23:59:22.622 | INFO | Click (1017, 668) @ GET_SHIP 2026-05-12 23:59:23.834 | INFO | Click (1031, 673) @ GET_SHIP 2026-05-12 23:59:25.040 | INFO | Click (1031, 664) @ GET_SHIP 2026-05-12 23:59:26.220 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_5 ─────────────────────────────────────────────────────── 2026-05-12 23:59:26.224 | INFO | BATTLE_5 2026-05-12 23:59:26.226 | INFO | Auto search moving 2026-05-12 23:59:26.230 | INFO | Fleet: 1, fleet_current_index: 1 2026-05-12 23:59:26.319 | INFO | [OCR_OIL 0.086s] 17812 2026-05-12 23:59:26.420 | INFO | [OCR_COIN 0.096s] 272308 2026-05-12 23:59:29.534 | INFO | [Loading] 16% 2026-05-12 23:59:29.539 | INFO | Auto search combat loading 2026-05-12 23:59:29.543 | INFO | Screenshot interval set to 1.0s 2026-05-12 23:59:35.544 | INFO | [BattleUI] PAUSE 2026-05-12 23:59:35.549 | INFO | Auto Search combat execute 2026-05-12 23:59:35.553 | INFO | <<< EMOTION REDUCE >>> 2026-05-12 23:59:35.565 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-05-12 23:59:35.571 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=41, Main.Emotion.Fleet1Record=datetime.datetime(2026, 5, 12, 23, 59, 35), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 5, 12, 23, 59, 35) 2026-05-12 23:59:35.591 | INFO | [Emotion fleet_1] 41 2026-05-12 23:59:35.595 | INFO | [Emotion fleet_2] 119 2026-05-12 23:59:41.541 | INFO | Combat auto check timer reached 2026-05-13 00:00:29.595 | INFO | Click (1040, 664) @ GET_SHIP 2026-05-13 00:03:29.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 L431 run() campaign_base.py L143 run() campaign_base.py L178 auto_search_execute_a_battle() auto_search_combat.py L349 auto_search_combat() auto_search_combat.py L246 auto_search_combat_execute() base.py L169 loop() device.py L188 screenshot() device.py L250 stuck_record_check() device.py L43 show_function_call() 2026-05-13 00:03:29.780 | WARNING | Wait too long 2026-05-13 00:03:29.785 | WARNING | Waiting for {'NEW_SHIP', 'CAMPAIGN_CHECK', 'POPUP_CANCEL', 'GUILD_POPUP_CONFIRM', 'EXP_INFO_S', 'SP_CHECK', 'MISSION_POPUP_GO', 'GET_SHIP', 'BATTLE_STATUS_S', 'POPUP_CONFIRM_WHITE', 'PAUSE', 'BATTLE_STATUS_A', 'AUTO_SEARCH_MAP_OPTION_ON', 'BATTLE_STATUS_B', 'EXP_INFO_B', 'GET_MISSION', 'EXP_INFO_A', 'EVENT_CHECK'} 2026-05-13 00:03:29.851 | INFO | [Package_name] com.bilibili.azurlane 2026-05-13 00:03:29.854 | ERROR | GameStuckError: Wait too long 2026-05-13 00:03:29.858 | WARNING | Saving error: ./log/error/1778601809858