═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ MAIN ═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ ════════════════════════════════════════════════════ CAMPAIGN_13_1 ════════════════════════════════════════════════════ 2026-02-16 21:12:05.131 | INFO | CAMPAIGN_13_1 2026-02-16 21:12:05.134 | INFO | Count: 0 2026-02-16 21:12:05.151 | INFO | <<< UI ENSURE >>> 2026-02-16 21:12:05.154 | INFO | UI get current page 2026-02-16 21:12:05.692 | INFO | Unknown ui page 2026-02-16 21:12:06.165 | INFO | UI additional: IDLE -> REWARD_GOTO_MAIN 2026-02-16 21:12:06.169 | INFO | Click ( 828, 624) @ REWARD_GOTO_MAIN 2026-02-16 21:12:06.344 | INFO | Unknown ui page 2026-02-16 21:12:06.487 | INFO | [Package_name] com.bilibili.azurlane 2026-02-16 21:12:06.509 | INFO | [Device Orientation] 0 (Normal) 2026-02-16 21:12:06.646 | INFO | Unknown ui page 2026-02-16 21:12:06.958 | INFO | Unknown ui page 2026-02-16 21:12:07.170 | INFO | [UI] page_main 2026-02-16 21:12:07.174 | INFO | Goto page_campaign 2026-02-16 21:12:07.177 | INFO | <<< UI GOTO PAGE_CAMPAIGN >>> 2026-02-16 21:12:07.193 | INFO | Page switch: page_main_white -> page_campaign_menu 2026-02-16 21:12:07.199 | INFO | Click (1211, 482) @ MAIN_GOTO_CAMPAIGN_WHITE 2026-02-16 21:12:07.769 | INFO | Page switch: page_campaign_menu -> page_campaign 2026-02-16 21:12:07.773 | INFO | Click ( 343, 255) @ CAMPAIGN_MENU_GOTO_CAMPAIGN 2026-02-16 21:12:08.068 | INFO | Page arrive: page_campaign 2026-02-16 21:12:08.095 | INFO | Mode_switch_1 set to hard 2026-02-16 21:12:08.122 | INFO | [Mode_switch_1] hard 2026-02-16 21:12:08.126 | INFO | <<< UI ENSURE INDEX >>> 2026-02-16 21:12:08.196 | INFO | No stage found. 2026-02-16 21:12:08.430 | INFO | No stage found. 2026-02-16 21:12:08.755 | INFO | Loading OCR model: ./bin/cnocr_models/azur_lane 2026-02-16 21:12:08.871 | INFO | [campaign 0.139s] ['I3--1', 'I3--3', 'I3--2', 'I3--4'] 2026-02-16 21:12:08.874 | INFO | [Chapter] i3 2026-02-16 21:12:08.877 | INFO | [Stage] i3-1, i3-3, i3-2, i3-4 2026-02-16 21:12:08.964 | INFO | <<< UI ENSURE >>> 2026-02-16 21:12:08.967 | INFO | UI get current page 2026-02-16 21:12:08.976 | INFO | [UI] page_campaign 2026-02-16 21:12:08.983 | INFO | Already at page_campaign 2026-02-16 21:12:08.989 | INFO | Mode_switch_1 set to hard 2026-02-16 21:12:08.995 | INFO | [Mode_switch_1] hard 2026-02-16 21:12:08.999 | INFO | <<< UI ENSURE INDEX >>> 2026-02-16 21:12:09.127 | INFO | [campaign 0.055s] ['13--1', '13--3', '13--2', '13--4'] 2026-02-16 21:12:09.130 | INFO | [Chapter] 13 2026-02-16 21:12:09.133 | INFO | [Stage] 13-1, 13-3, 13-2, 13-4 2026-02-16 21:12:09.136 | INFO | [Index] 13 2026-02-16 21:12:09.204 | INFO | [OCR_OIL 0.041s] 21703 ──────────────────────────────────────────────────────── 13-1 ───────────────────────────────────────────────────────── 2026-02-16 21:12:09.208 | INFO | 13-1 2026-02-16 21:12:09.213 | INFO | Expect emotion reduce: (12, 2) 2026-02-16 21:12:09.225 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-02-16 21:12:09.229 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=53, Main.Emotion.Fleet1Record=datetime.datetime(2026, 2, 16, 21, 12, 9), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 2, 16, 21, 12, 9) 2026-02-16 21:12:09.244 | INFO | [Emotion fleet_1] 53 2026-02-16 21:12:09.251 | INFO | [Emotion fleet_2] 119 2026-02-16 21:12:09.254 | INFO | <<< ENTER MAP >>> 2026-02-16 21:12:09.330 | INFO | Click ( 184, 279) @ 13-1 2026-02-16 21:12:09.734 | INFO | [Map_clear_percentage] 5% 2026-02-16 21:12:10.034 | INFO | [Map_clear_percentage] 66% 2026-02-16 21:12:10.334 | INFO | [Map_clear_percentage] 99% 2026-02-16 21:12:10.360 | INFO | [MAP_CLEAR_ALL_THIS_TIME] False 2026-02-16 21:12:10.364 | INFO | [Map_info] 99%, star_1, star_2, star_3, 100_percent_clear, 3_stars, threat_safe, clear_mode 2026-02-16 21:12:10.368 | INFO | [StopCondition_MapAchievement] non_stop 2026-02-16 21:12:10.371 | INFO | Fast_Forward set to on 2026-02-16 21:12:10.374 | INFO | [Fast_Forward] on 2026-02-16 21:12:10.387 | INFO | Auto_Search set to on 2026-02-16 21:12:10.392 | INFO | [Auto_Search] on 2026-02-16 21:12:10.396 | INFO | Click ( 920, 517) @ MAP_PREPARATION 2026-02-16 21:12:10.635 | INFO | Handling 2x book setting, mode=prep. 2026-02-16 21:12:10.658 | INFO | Using fleet: [4, 3, 1] 2026-02-16 21:12:10.737 | INFO | Hard satisfied: Fleet_1: None, Fleet_2: None, Submarine: None 2026-02-16 21:12:10.746 | INFO | [map_allow_submarine] True 2026-02-16 21:12:10.753 | INFO | Click (1137, 325) @ FLEET_2_CLEAR 2026-02-16 21:12:10.808 | INFO | Click (1035, 472) @ SUBMARINE_CHOOSE 2026-02-16 21:12:11.229 | INFO | Current selected: [1] 2026-02-16 21:12:11.233 | INFO | Click (1034, 464) @ SUBMARINE_CHOOSE 2026-02-16 21:12:11.532 | INFO | Click (1058, 227) @ FLEET_1_CHOOSE 2026-02-16 21:12:11.880 | INFO | Current selected: [4] 2026-02-16 21:12:11.885 | INFO | Click (1048, 206) @ FLEET_1_CHOOSE 2026-02-16 21:12:12.139 | INFO | Click (1067, 339) @ FLEET_2_CHOOSE 2026-02-16 21:12:12.440 | INFO | Current selected: [4] 2026-02-16 21:12:12.445 | INFO | Click (1086, 484) @ FLEET_2_BAR_INDEX_3 2026-02-16 21:12:12.734 | INFO | Auto search setting 2026-02-16 21:12:12.753 | INFO | [_fleet_sidebar_offset] 0 2026-02-16 21:12:12.758 | INFO | [Fleet_sidebar] 1/3 2026-02-16 21:12:12.763 | INFO | Click (1204, 432) @ FLEET_SIDEBAR_0_2 2026-02-16 21:12:13.279 | INFO | [_fleet_sidebar_offset] 0 2026-02-16 21:12:13.285 | INFO | [Fleet_sidebar] 3/3 2026-02-16 21:12:13.290 | INFO | [Auto_Search_Setting] fleet1_all_fleet2_standby, sub_standby 2026-02-16 21:12:13.293 | INFO | Click ( 505, 211) @ AUTO_SEARCH_SET_MOB 2026-02-16 21:12:13.831 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_standby 2026-02-16 21:12:13.835 | INFO | Selected to the correct auto search setting 2026-02-16 21:12:13.838 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_standby 2026-02-16 21:12:13.841 | INFO | Selected to the correct auto search setting 2026-02-16 21:12:13.844 | INFO | Click (1114, 588) @ FLEET_PREPARATION 2026-02-16 21:12:14.746 | INFO | is_auto_search_running appeared ────────────────────────────────────────────────────── BATTLE_0 ─────────────────────────────────────────────────────── 2026-02-16 21:12:14.751 | INFO | BATTLE_0 2026-02-16 21:12:14.753 | INFO | Auto search moving 2026-02-16 21:12:14.767 | INFO | Fleet: 1, fleet_current_index: 1 2026-02-16 21:12:14.831 | INFO | [OCR_OIL 0.059s] 21693 2026-02-16 21:12:14.924 | INFO | [OCR_COIN 0.089s] 116290 2026-02-16 21:12:19.690 | INFO | [Loading] 11% 2026-02-16 21:12:19.697 | INFO | Auto search combat loading 2026-02-16 21:12:19.700 | INFO | Screenshot interval set to 1.0s 2026-02-16 21:12:25.696 | INFO | [BattleUI] PAUSE 2026-02-16 21:12:25.699 | INFO | Auto Search combat execute 2026-02-16 21:12:25.701 | INFO | <<< EMOTION REDUCE >>> 2026-02-16 21:12:25.713 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-02-16 21:12:25.718 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=51, Main.Emotion.Fleet1Record=datetime.datetime(2026, 2, 16, 21, 12, 25), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 2, 16, 21, 12, 25) 2026-02-16 21:12:25.734 | INFO | [Emotion fleet_1] 51 2026-02-16 21:12:25.738 | INFO | [Emotion fleet_2] 119 2026-02-16 21:12:31.694 | INFO | Combat auto check timer reached 2026-02-16 21:13:08.738 | INFO | Click (1027, 652) @ GET_SHIP 2026-02-16 21:13:10.738 | INFO | Click (1019, 675) @ GET_SHIP 2026-02-16 21:13:11.738 | INFO | Click (1051, 654) @ GET_SHIP 2026-02-16 21:13:12.744 | INFO | Click (1020, 667) @ GET_SHIP 2026-02-16 21:13:13.750 | INFO | Click (1022, 656) @ GET_SHIP 2026-02-16 21:13:15.758 | INFO | Screenshot interval set to 0.3s 2026-02-16 21:13:15.762 | INFO | Auto Search combat status 2026-02-16 21:13:15.767 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_1 ─────────────────────────────────────────────────────── 2026-02-16 21:13:15.772 | INFO | BATTLE_1 2026-02-16 21:13:15.775 | INFO | Auto search moving 2026-02-16 21:13:15.779 | INFO | Fleet: 1, fleet_current_index: 1 2026-02-16 21:13:15.849 | INFO | [OCR_OIL 0.065s] 21674 2026-02-16 21:13:15.922 | INFO | [OCR_COIN 0.070s] 116310 2026-02-16 21:13:19.042 | INFO | [Loading] 8% 2026-02-16 21:13:19.046 | INFO | Auto search combat loading 2026-02-16 21:13:19.049 | INFO | Screenshot interval set to 1.0s 2026-02-16 21:13:25.064 | INFO | [BattleUI] PAUSE 2026-02-16 21:13:25.067 | INFO | Auto Search combat execute 2026-02-16 21:13:25.070 | INFO | <<< EMOTION REDUCE >>> 2026-02-16 21:13:25.085 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-02-16 21:13:25.089 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=49, Main.Emotion.Fleet1Record=datetime.datetime(2026, 2, 16, 21, 13, 25), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 2, 16, 21, 13, 25) 2026-02-16 21:13:25.107 | INFO | [Emotion fleet_1] 49 2026-02-16 21:13:25.113 | INFO | [Emotion fleet_2] 119 2026-02-16 21:13:31.054 | INFO | Combat auto check timer reached 2026-02-16 21:13:49.076 | INFO | Screenshot interval set to 0.3s 2026-02-16 21:13:49.079 | INFO | Auto Search combat status 2026-02-16 21:13:49.965 | INFO | Click (1011, 650) @ GET_SHIP 2026-02-16 21:13:51.167 | INFO | Click (1021, 654) @ GET_SHIP 2026-02-16 21:13:52.373 | INFO | Click (1028, 677) @ GET_SHIP 2026-02-16 21:13:53.580 | INFO | Click (1020, 653) @ GET_SHIP 2026-02-16 21:13:55.365 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_2 ─────────────────────────────────────────────────────── 2026-02-16 21:13:55.371 | INFO | BATTLE_2 2026-02-16 21:13:55.375 | INFO | Auto search moving 2026-02-16 21:13:55.378 | INFO | Fleet: 1, fleet_current_index: 1 2026-02-16 21:13:55.456 | INFO | [OCR_OIL 0.075s] 21655 2026-02-16 21:13:55.550 | INFO | [OCR_COIN 0.091s] 116323 2026-02-16 21:13:59.581 | INFO | [Loading] 6% 2026-02-16 21:13:59.586 | INFO | Auto search combat loading 2026-02-16 21:13:59.590 | INFO | Screenshot interval set to 1.0s 2026-02-16 21:14:05.589 | INFO | [BattleUI] PAUSE 2026-02-16 21:14:05.593 | INFO | Auto Search combat execute 2026-02-16 21:14:05.597 | INFO | <<< EMOTION REDUCE >>> 2026-02-16 21:14:05.615 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-02-16 21:14:05.620 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=47, Main.Emotion.Fleet1Record=datetime.datetime(2026, 2, 16, 21, 14, 5), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 2, 16, 21, 14, 5) 2026-02-16 21:14:05.648 | INFO | [Emotion fleet_1] 47 2026-02-16 21:14:05.653 | INFO | [Emotion fleet_2] 119 2026-02-16 21:14:11.582 | INFO | Combat auto check timer reached 2026-02-16 21:14:47.641 | INFO | Screenshot interval set to 0.3s 2026-02-16 21:14:47.645 | INFO | Auto Search combat status 2026-02-16 21:14:48.516 | INFO | Click (1035, 662) @ GET_SHIP 2026-02-16 21:14:49.716 | INFO | Click (1021, 653) @ GET_SHIP 2026-02-16 21:14:50.917 | INFO | Click (1013, 664) @ GET_SHIP 2026-02-16 21:14:52.120 | INFO | Click (1022, 656) @ GET_SHIP 2026-02-16 21:14:53.911 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_3 ─────────────────────────────────────────────────────── 2026-02-16 21:14:53.920 | INFO | BATTLE_3 2026-02-16 21:14:53.923 | INFO | Auto search moving 2026-02-16 21:14:53.927 | INFO | Fleet: 1, fleet_current_index: 1 2026-02-16 21:14:54.007 | INFO | [OCR_OIL 0.075s] 21636 2026-02-16 21:14:54.088 | INFO | [OCR_COIN 0.078s] 116338 2026-02-16 21:14:58.427 | INFO | [Loading] 11% 2026-02-16 21:14:58.431 | INFO | Auto search combat loading 2026-02-16 21:14:58.433 | INFO | Screenshot interval set to 1.0s 2026-02-16 21:15:04.437 | INFO | [BattleUI] PAUSE 2026-02-16 21:15:04.441 | INFO | Auto Search combat execute 2026-02-16 21:15:04.444 | INFO | <<< EMOTION REDUCE >>> 2026-02-16 21:15:04.454 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-02-16 21:15:04.461 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=45, Main.Emotion.Fleet1Record=datetime.datetime(2026, 2, 16, 21, 15, 4), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 2, 16, 21, 15, 4) 2026-02-16 21:15:04.488 | INFO | [Emotion fleet_1] 45 2026-02-16 21:15:04.494 | INFO | [Emotion fleet_2] 119 2026-02-16 21:15:09.446 | INFO | Combat auto check timer reached 2026-02-16 21:15:46.482 | INFO | Click (1027, 661) @ GET_SHIP 2026-02-16 21:15:47.484 | INFO | Click (1029, 659) @ GET_SHIP 2026-02-16 21:15:49.483 | INFO | Click (1046, 643) @ GET_SHIP 2026-02-16 21:15:50.486 | INFO | Click (1026, 665) @ GET_SHIP 2026-02-16 21:15:51.477 | INFO | Screenshot interval set to 0.3s 2026-02-16 21:15:51.480 | INFO | Auto Search combat status 2026-02-16 21:15:51.484 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_4 ─────────────────────────────────────────────────────── 2026-02-16 21:15:51.493 | INFO | BATTLE_4 2026-02-16 21:15:51.499 | INFO | Auto search moving 2026-02-16 21:15:51.503 | INFO | Fleet: 1, fleet_current_index: 1 2026-02-16 21:15:51.581 | INFO | [OCR_OIL 0.074s] 21617 2026-02-16 21:15:51.652 | INFO | [OCR_COIN 0.067s] 116352 2026-02-16 21:15:56.868 | INFO | [Loading] 9% 2026-02-16 21:15:56.872 | INFO | Auto search combat loading 2026-02-16 21:15:56.875 | INFO | Screenshot interval set to 1.0s 2026-02-16 21:16:02.884 | INFO | [BattleUI] PAUSE 2026-02-16 21:16:02.888 | INFO | Auto Search combat execute 2026-02-16 21:16:02.891 | INFO | <<< EMOTION REDUCE >>> 2026-02-16 21:16:02.906 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-02-16 21:16:02.910 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=43, Main.Emotion.Fleet1Record=datetime.datetime(2026, 2, 16, 21, 16, 2), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 2, 16, 21, 16, 2) 2026-02-16 21:16:02.927 | INFO | [Emotion fleet_1] 43 2026-02-16 21:16:02.931 | INFO | [Emotion fleet_2] 119 2026-02-16 21:16:08.885 | INFO | Combat auto check timer reached 2026-02-16 21:17:02.933 | INFO | Screenshot interval set to 0.3s 2026-02-16 21:17:02.936 | INFO | Auto Search combat status 2026-02-16 21:17:03.521 | INFO | Click (1026, 657) @ GET_SHIP 2026-02-16 21:17:04.726 | INFO | Click (1026, 666) @ GET_SHIP 2026-02-16 21:17:05.934 | INFO | Click (1033, 669) @ GET_SHIP 2026-02-16 21:17:07.134 | INFO | Click (1030, 657) @ GET_SHIP 2026-02-16 21:17:08.917 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_5 ─────────────────────────────────────────────────────── 2026-02-16 21:17:08.921 | INFO | BATTLE_5 2026-02-16 21:17:08.923 | INFO | Auto search moving 2026-02-16 21:17:08.927 | INFO | Fleet: 1, fleet_current_index: 1 2026-02-16 21:17:08.985 | INFO | [OCR_OIL 0.049s] 21598 2026-02-16 21:17:09.053 | INFO | [OCR_COIN 0.065s] 116371 2026-02-16 21:17:11.026 | INFO | [Loading] 9% 2026-02-16 21:17:11.029 | INFO | Auto search combat loading 2026-02-16 21:17:11.032 | INFO | Screenshot interval set to 1.0s 2026-02-16 21:17:17.030 | INFO | [BattleUI] PAUSE 2026-02-16 21:17:17.033 | INFO | Auto Search combat execute 2026-02-16 21:17:17.036 | INFO | <<< EMOTION REDUCE >>> 2026-02-16 21:17:17.048 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-02-16 21:17:17.051 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=41, Main.Emotion.Fleet1Record=datetime.datetime(2026, 2, 16, 21, 17, 17), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 2, 16, 21, 17, 17) 2026-02-16 21:17:17.068 | INFO | [Emotion fleet_1] 41 2026-02-16 21:17:17.071 | INFO | [Emotion fleet_2] 119 2026-02-16 21:17:22.081 | INFO | Combat auto check timer reached 2026-02-16 21:19:00.124 | INFO | Click (1016, 641) @ GET_SHIP 2026-02-16 21:22:00.282 | 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 L1523 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 L426 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-02-16 21:22:00.305 | WARNING | Wait too long 2026-02-16 21:22:00.310 | WARNING | Waiting for {'SP_CHECK', 'EXP_INFO_B', 'EVENT_CHECK', 'POPUP_CONFIRM_WHITE', 'GUILD_POPUP_CONFIRM', 'GET_MISSION', 'GET_SHIP', 'PAUSE', 'EXP_INFO_S', 'AUTO_SEARCH_MAP_OPTION_ON', 'NEW_SHIP', 'BATTLE_STATUS_S', 'CAMPAIGN_CHECK', 'EXP_INFO_A', 'POPUP_CANCEL', 'BATTLE_STATUS_A', 'BATTLE_STATUS_B', 'MISSION_POPUP_GO'} 2026-02-16 21:22:00.367 | INFO | [Package_name] com.bilibili.azurlane 2026-02-16 21:22:00.370 | ERROR | GameStuckError: Wait too long 2026-02-16 21:22:00.373 | WARNING | Saving error: ./log/error/1771248120373