═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ MAIN ═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ ════════════════════════════════════════════════════ CAMPAIGN_13_1 ════════════════════════════════════════════════════ 2026-09-24 19:01:23.759 | INFO | CAMPAIGN_13_1 2026-09-24 19:01:23.762 | INFO | Count: 0 2026-09-24 19:01:23.783 | INFO | <<< UI ENSURE >>> 2026-09-24 19:01:23.787 | INFO | UI get current page 2026-09-24 19:01:24.449 | INFO | Unknown ui page 2026-09-24 19:01:24.942 | INFO | UI additional: IDLE -> REWARD_GOTO_MAIN 2026-09-24 19:01:24.947 | INFO | Click ( 839, 627) @ REWARD_GOTO_MAIN 2026-09-24 19:01:25.128 | INFO | Unknown ui page 2026-09-24 19:01:25.261 | INFO | [Package_name] com.bilibili.azurlane 2026-09-24 19:01:25.278 | INFO | [Device Orientation] 0 (Normal) 2026-09-24 19:01:25.431 | INFO | Unknown ui page 2026-09-24 19:01:25.729 | INFO | Unknown ui page 2026-09-24 19:01:25.943 | INFO | [UI] page_main 2026-09-24 19:01:25.946 | INFO | Goto page_campaign 2026-09-24 19:01:25.954 | INFO | <<< UI GOTO PAGE_CAMPAIGN >>> 2026-09-24 19:01:25.970 | INFO | Page switch: page_main_white -> page_campaign_menu 2026-09-24 19:01:25.974 | INFO | Click (1214, 523) @ MAIN_GOTO_CAMPAIGN_WHITE 2026-09-24 19:01:26.552 | INFO | Page switch: page_campaign_menu -> page_campaign 2026-09-24 19:01:26.556 | INFO | Click ( 316, 306) @ CAMPAIGN_MENU_GOTO_CAMPAIGN 2026-09-24 19:01:26.843 | INFO | Page arrive: page_campaign 2026-09-24 19:01:26.868 | INFO | Mode_switch_1 set to hard 2026-09-24 19:01:26.893 | INFO | [Mode_switch_1] hard 2026-09-24 19:01:26.896 | INFO | <<< UI ENSURE INDEX >>> 2026-09-24 19:01:26.970 | INFO | No stage found. 2026-09-24 19:01:27.209 | INFO | No stage found. 2026-09-24 19:01:27.511 | INFO | No stage found. 2026-09-24 19:01:27.832 | INFO | Loading OCR model: ./bin/cnocr_models/azur_lane 2026-09-24 19:01:27.944 | INFO | [campaign 0.131s] ['13--1', '13--3', '13--2', '13--4'] 2026-09-24 19:01:27.949 | INFO | [Chapter] 13 2026-09-24 19:01:27.952 | INFO | [Stage] 13-1, 13-3, 13-2, 13-4 2026-09-24 19:01:27.956 | INFO | [Index] 13 2026-09-24 19:01:28.023 | INFO | [OCR_OIL 0.039s] 2224 ──────────────────────────────────────────────────────── 13-1 ───────────────────────────────────────────────────────── 2026-09-24 19:01:28.028 | INFO | 13-1 2026-09-24 19:01:28.031 | INFO | Expect emotion reduce: (12, 2) 2026-09-24 19:01:28.045 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-09-24 19:01:28.049 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=119, Main.Emotion.Fleet1Record=datetime.datetime(2026, 9, 24, 19, 1, 28), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 9, 24, 19, 1, 28) 2026-09-24 19:01:28.068 | INFO | [Emotion fleet_1] 119 2026-09-24 19:01:28.073 | INFO | [Emotion fleet_2] 119 2026-09-24 19:01:28.076 | INFO | <<< ENTER MAP >>> 2026-09-24 19:01:28.149 | INFO | Click ( 178, 284) @ 13-1 2026-09-24 19:01:28.552 | INFO | [Map_clear_percentage] 4% 2026-09-24 19:01:28.853 | INFO | [Map_clear_percentage] 73% 2026-09-24 19:01:29.152 | INFO | [Map_clear_percentage] 99% 2026-09-24 19:01:29.179 | INFO | [MAP_CLEAR_ALL_THIS_TIME] False 2026-09-24 19:01:29.183 | INFO | [Map_info] 99%, star_1, star_2, star_3, 100_percent_clear, 3_stars, threat_safe, clear_mode 2026-09-24 19:01:29.186 | INFO | [StopCondition_MapAchievement] non_stop 2026-09-24 19:01:29.189 | INFO | Clear_Mode set to on 2026-09-24 19:01:29.193 | INFO | [Clear_Mode] on 2026-09-24 19:01:29.206 | INFO | Auto_Search set to on 2026-09-24 19:01:29.211 | INFO | [Auto_Search] on 2026-09-24 19:01:29.214 | INFO | Click (1042, 504) @ MAP_PREPARATION 2026-09-24 19:01:29.459 | INFO | Handling 2x book setting, mode=prep. 2026-09-24 19:01:29.755 | INFO | Using fleet: [4, 3, 1] 2026-09-24 19:01:29.832 | INFO | Hard satisfied: Fleet_1: None, Fleet_2: None, Submarine: None 2026-09-24 19:01:29.841 | INFO | [map_allow_submarine] True 2026-09-24 19:01:29.846 | INFO | Click (1138, 328) @ FLEET_2_CLEAR 2026-09-24 19:01:29.900 | INFO | Fleet SUBMARINE set to 1 2026-09-24 19:01:29.903 | INFO | Click (1034, 454) @ SUBMARINE_CHOOSE 2026-09-24 19:01:30.052 | INFO | FleetOption: [1] 2 2026-09-24 19:01:30.057 | INFO | Fleet option 1 is already selected 2026-09-24 19:01:30.061 | INFO | Click (1044, 488) @ SUBMARINE_CHOOSE 2026-09-24 19:01:30.355 | INFO | FleetOption: 2026-09-24 19:01:30.363 | INFO | Fleet FLEET_1 set to 4 2026-09-24 19:01:30.367 | INFO | Click (1041, 212) @ FLEET_1_CHOOSE 2026-09-24 19:01:30.648 | INFO | FleetOption: [1] 2 3 4 5 6 2026-09-24 19:01:30.652 | INFO | Click (1116, 407) @ FleetOption_4 2026-09-24 19:01:30.946 | INFO | FleetOption: 2026-09-24 19:01:30.949 | INFO | Fleet FLEET_2 set to 3 2026-09-24 19:01:30.951 | INFO | Click (1049, 344) @ FLEET_2_CHOOSE 2026-09-24 19:01:31.247 | INFO | FleetOption: 1 2 3 [4] 5 6 2026-09-24 19:01:31.250 | INFO | Click (1072, 489) @ FleetOption_3 2026-09-24 19:01:31.547 | INFO | FleetOption: 2026-09-24 19:01:31.550 | INFO | Auto search setting 2026-09-24 19:01:31.565 | INFO | [_fleet_sidebar_offset] 0 2026-09-24 19:01:31.571 | INFO | [_fleet_sidebar_offset] 0 2026-09-24 19:01:31.575 | INFO | [Fleet_sidebar] 1/3 2026-09-24 19:01:31.578 | INFO | Click (1215, 450) @ FLEET_SIDEBAR_0_2 2026-09-24 19:01:31.846 | INFO | [_fleet_sidebar_offset] 0 2026-09-24 19:01:31.850 | INFO | [Fleet_sidebar] 3/3 2026-09-24 19:01:31.853 | INFO | [Auto_Search_Setting] fleet1_all_fleet2_standby, sub_auto_call 2026-09-24 19:01:31.859 | INFO | Click ( 507, 214) @ AUTO_SEARCH_SET_MOB 2026-09-24 19:01:32.416 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_auto_call 2026-09-24 19:01:32.421 | INFO | Selected to the correct auto search setting 2026-09-24 19:01:32.426 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_auto_call 2026-09-24 19:01:32.430 | INFO | Click ( 909, 465) @ AUTO_SEARCH_SET_SUB_STANDBY 2026-09-24 19:01:32.934 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_standby 2026-09-24 19:01:32.938 | INFO | Selected to the correct auto search setting 2026-09-24 19:01:32.940 | INFO | Click (1056, 509) @ FLEET_PREPARATION 2026-09-24 19:01:38.051 | INFO | Handling 2x book setting, mode=prep. 2026-09-24 19:01:38.064 | INFO | Using fleet: [4, 3, 1] 2026-09-24 19:01:38.069 | INFO | Auto search setting 2026-09-24 19:01:38.074 | INFO | [_fleet_sidebar_offset] 0 2026-09-24 19:01:38.079 | INFO | [_fleet_sidebar_offset] 0 2026-09-24 19:01:38.083 | INFO | [Fleet_sidebar] 3/3 2026-09-24 19:01:38.086 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_standby 2026-09-24 19:01:38.089 | INFO | Selected to the correct auto search setting 2026-09-24 19:01:38.091 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_standby 2026-09-24 19:01:38.097 | INFO | Selected to the correct auto search setting 2026-09-24 19:01:38.100 | INFO | Click (1084, 578) @ FLEET_PREPARATION 2026-09-24 19:01:38.972 | INFO | is_auto_search_running appeared ────────────────────────────────────────────────────── BATTLE_0 ─────────────────────────────────────────────────────── 2026-09-24 19:01:38.978 | INFO | BATTLE_0 2026-09-24 19:01:38.981 | INFO | Auto search moving 2026-09-24 19:01:38.999 | INFO | Fleet: 1, fleet_current_index: 1 2026-09-24 19:01:39.040 | INFO | [OCR_OIL 0.035s] 2214 2026-09-24 19:01:39.089 | INFO | [OCR_COIN 0.046s] 1892 2026-09-24 19:01:43.616 | INFO | [Loading] 11% 2026-09-24 19:01:43.620 | INFO | Auto search combat loading 2026-09-24 19:01:43.623 | INFO | Screenshot interval set to 1.0s 2026-09-24 19:01:49.636 | INFO | [BattleUI] PAUSE 2026-09-24 19:01:49.640 | INFO | Auto Search combat execute 2026-09-24 19:01:49.643 | INFO | <<< EMOTION REDUCE >>> 2026-09-24 19:01:49.661 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-09-24 19:01:49.665 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=117, Main.Emotion.Fleet1Record=datetime.datetime(2026, 9, 24, 19, 1, 49), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 9, 24, 19, 1, 49) 2026-09-24 19:01:49.680 | INFO | [Emotion fleet_1] 117 2026-09-24 19:01:49.683 | INFO | [Emotion fleet_2] 119 2026-09-24 19:01:55.624 | INFO | Combat auto check timer reached 2026-09-24 19:02:15.654 | INFO | Click (1029, 666) @ GET_SHIP 2026-09-24 19:02:16.664 | INFO | Click (1014, 656) @ GET_SHIP 2026-09-24 19:02:19.656 | INFO | Screenshot interval set to 0.3s 2026-09-24 19:02:19.659 | INFO | Auto Search combat status 2026-09-24 19:02:20.837 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_1 ─────────────────────────────────────────────────────── 2026-09-24 19:02:20.846 | INFO | BATTLE_1 2026-09-24 19:02:20.849 | INFO | Auto search moving 2026-09-24 19:02:20.853 | INFO | Fleet: 1, fleet_current_index: 1 2026-09-24 19:02:20.915 | INFO | [OCR_OIL 0.058s] 2195 2026-09-24 19:02:20.965 | INFO | [OCR_COIN 0.048s] 1914 2026-09-24 19:02:26.245 | INFO | [Loading] 9% 2026-09-24 19:02:26.250 | INFO | Auto search combat loading 2026-09-24 19:02:26.254 | INFO | Screenshot interval set to 1.0s 2026-09-24 19:02:32.273 | INFO | [BattleUI] PAUSE 2026-09-24 19:02:32.277 | INFO | Auto Search combat execute 2026-09-24 19:02:32.281 | INFO | <<< EMOTION REDUCE >>> 2026-09-24 19:02:32.294 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-09-24 19:02:32.300 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=115, Main.Emotion.Fleet1Record=datetime.datetime(2026, 9, 24, 19, 2, 32), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 9, 24, 19, 2, 32) 2026-09-24 19:02:32.315 | INFO | [Emotion fleet_1] 115 2026-09-24 19:02:32.318 | INFO | [Emotion fleet_2] 119 2026-09-24 19:02:38.253 | INFO | Combat auto check timer reached 2026-09-24 19:03:16.317 | INFO | Screenshot interval set to 0.3s 2026-09-24 19:03:16.322 | INFO | Auto Search combat status 2026-09-24 19:03:17.490 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_2 ─────────────────────────────────────────────────────── 2026-09-24 19:03:17.496 | INFO | BATTLE_2 2026-09-24 19:03:17.499 | INFO | Auto search moving 2026-09-24 19:03:17.503 | INFO | Fleet: 1, fleet_current_index: 1 2026-09-24 19:03:17.554 | INFO | [OCR_OIL 0.046s] 2176 2026-09-24 19:03:17.631 | INFO | [OCR_COIN 0.073s] 1926 2026-09-24 19:03:21.994 | INFO | [Loading] 11% 2026-09-24 19:03:21.999 | INFO | Auto search combat loading 2026-09-24 19:03:22.002 | INFO | Screenshot interval set to 1.0s 2026-09-24 19:03:28.009 | INFO | [BattleUI] PAUSE 2026-09-24 19:03:28.013 | INFO | Auto Search combat execute 2026-09-24 19:03:28.015 | INFO | <<< EMOTION REDUCE >>> 2026-09-24 19:03:28.028 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-09-24 19:03:28.032 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=113, Main.Emotion.Fleet1Record=datetime.datetime(2026, 9, 24, 19, 3, 28), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 9, 24, 19, 3, 28) 2026-09-24 19:03:28.047 | INFO | [Emotion fleet_1] 113 2026-09-24 19:03:28.052 | INFO | [Emotion fleet_2] 119 2026-09-24 19:03:34.002 | INFO | Combat auto check timer reached 2026-09-24 19:04:09.048 | INFO | Screenshot interval set to 0.3s 2026-09-24 19:04:09.051 | INFO | Auto Search combat status 2026-09-24 19:04:09.933 | INFO | Click (1010, 655) @ GET_SHIP 2026-09-24 19:04:11.138 | INFO | Click (1038, 668) @ GET_SHIP 2026-09-24 19:04:15.632 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_3 ─────────────────────────────────────────────────────── 2026-09-24 19:04:15.638 | INFO | BATTLE_3 2026-09-24 19:04:15.640 | INFO | Auto search moving 2026-09-24 19:04:15.644 | INFO | Fleet: 1, fleet_current_index: 1 2026-09-24 19:04:15.707 | INFO | [OCR_OIL 0.059s] 2157 2026-09-24 19:04:15.770 | INFO | [OCR_COIN 0.058s] 1954 2026-09-24 19:04:20.145 | INFO | [Loading] 9% 2026-09-24 19:04:20.149 | INFO | Auto search combat loading 2026-09-24 19:04:20.153 | INFO | Screenshot interval set to 1.0s 2026-09-24 19:04:26.155 | INFO | [BattleUI] PAUSE 2026-09-24 19:04:26.160 | INFO | Auto Search combat execute 2026-09-24 19:04:26.164 | INFO | <<< EMOTION REDUCE >>> 2026-09-24 19:04:26.177 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-09-24 19:04:26.182 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=111, Main.Emotion.Fleet1Record=datetime.datetime(2026, 9, 24, 19, 4, 26), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 9, 24, 19, 4, 26) 2026-09-24 19:04:26.197 | INFO | [Emotion fleet_1] 111 2026-09-24 19:04:26.201 | INFO | [Emotion fleet_2] 119 2026-09-24 19:04:32.158 | INFO | Combat auto check timer reached 2026-09-24 19:05:08.202 | INFO | Click (1027, 647) @ GET_SHIP 2026-09-24 19:05:10.215 | INFO | Click (1027, 637) @ GET_SHIP 2026-09-24 19:05:13.207 | INFO | Screenshot interval set to 0.3s 2026-09-24 19:05:13.210 | INFO | Auto Search combat status 2026-09-24 19:05:14.691 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_4 ─────────────────────────────────────────────────────── 2026-09-24 19:05:14.698 | INFO | BATTLE_4 2026-09-24 19:05:14.703 | INFO | Auto search moving 2026-09-24 19:05:14.709 | INFO | Fleet: 1, fleet_current_index: 1 2026-09-24 19:05:14.808 | INFO | [OCR_OIL 0.094s] 2138 2026-09-24 19:05:14.874 | INFO | [OCR_COIN 0.059s] 1966 2026-09-24 19:05:19.197 | INFO | [Loading] 13% 2026-09-24 19:05:19.202 | INFO | Auto search combat loading 2026-09-24 19:05:19.204 | INFO | Screenshot interval set to 1.0s 2026-09-24 19:05:25.212 | INFO | [BattleUI] PAUSE 2026-09-24 19:05:25.215 | INFO | Auto Search combat execute 2026-09-24 19:05:25.219 | INFO | <<< EMOTION REDUCE >>> 2026-09-24 19:05:25.233 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-09-24 19:05:25.237 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=109, Main.Emotion.Fleet1Record=datetime.datetime(2026, 9, 24, 19, 5, 25), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 9, 24, 19, 5, 25) 2026-09-24 19:05:25.249 | INFO | [Emotion fleet_1] 109 2026-09-24 19:05:25.253 | INFO | [Emotion fleet_2] 119 2026-09-24 19:05:31.213 | INFO | Combat auto check timer reached 2026-09-24 19:06:07.249 | INFO | Screenshot interval set to 0.3s 2026-09-24 19:06:07.252 | INFO | Auto Search combat status 2026-09-24 19:06:08.139 | INFO | Click (1018, 659) @ GET_SHIP 2026-09-24 19:06:09.342 | INFO | Click (1015, 665) @ GET_SHIP 2026-09-24 19:06:13.839 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_5 ─────────────────────────────────────────────────────── 2026-09-24 19:06:13.846 | INFO | BATTLE_5 2026-09-24 19:06:13.849 | INFO | Auto search moving 2026-09-24 19:06:13.853 | INFO | Fleet: 1, fleet_current_index: 1 2026-09-24 19:06:13.948 | INFO | [OCR_OIL 0.091s] 2119 2026-09-24 19:06:14.030 | INFO | [OCR_COIN 0.077s] 1983 2026-09-24 19:06:15.643 | INFO | [Loading] 10% 2026-09-24 19:06:15.646 | INFO | Auto search combat loading 2026-09-24 19:06:15.648 | INFO | Screenshot interval set to 1.0s 2026-09-24 19:06:21.667 | INFO | [BattleUI] PAUSE 2026-09-24 19:06:21.670 | INFO | Auto Search combat execute 2026-09-24 19:06:21.674 | INFO | <<< EMOTION REDUCE >>> 2026-09-24 19:06:21.697 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-09-24 19:06:21.701 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=109, Main.Emotion.Fleet1Record=datetime.datetime(2026, 9, 24, 19, 6, 21), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 9, 24, 19, 6, 21) 2026-09-24 19:06:21.720 | INFO | [Emotion fleet_1] 109 2026-09-24 19:06:21.724 | INFO | [Emotion fleet_2] 119 2026-09-24 19:06:27.655 | INFO | Combat auto check timer reached 2026-09-24 19:09:21.820 | 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-24 19:09:21.842 | WARNING | Wait too long 2026-09-24 19:09:21.847 | 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-24 19:09:21.904 | INFO | [Package_name] com.bilibili.azurlane 2026-09-24 19:09:21.910 | ERROR | GameStuckError: Wait too long 2026-09-24 19:09:21.913 | WARNING | Saving error: ./log/error/1790248161913