═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ MAIN ═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ ════════════════════════════════════════════════════ CAMPAIGN_13_1 ════════════════════════════════════════════════════ 2026-10-25 09:36:06.040 | INFO | CAMPAIGN_13_1 2026-10-25 09:36:06.044 | INFO | Campaign run: event="campaign_main", name=campaign_13_1 2026-10-25 09:36:06.048 | INFO | Count: 0 2026-10-25 09:36:06.068 | INFO | <<< UI ENSURE >>> 2026-10-25 09:36:06.071 | INFO | UI get current page 2026-10-25 09:36:06.745 | INFO | Unknown ui page 2026-10-25 09:36:07.235 | INFO | UI additional: IDLE -> REWARD_GOTO_MAIN 2026-10-25 09:36:07.238 | INFO | Click ( 834, 620) @ REWARD_GOTO_MAIN 2026-10-25 09:36:07.424 | INFO | Unknown ui page 2026-10-25 09:36:07.601 | INFO | [Package_name] com.bilibili.azurlane 2026-10-25 09:36:07.619 | INFO | [Device Orientation] 0 (Normal) 2026-10-25 09:36:07.755 | INFO | Unknown ui page 2026-10-25 09:36:07.964 | INFO | [UI] page_main 2026-10-25 09:36:07.969 | INFO | Goto page_campaign 2026-10-25 09:36:07.975 | INFO | <<< UI GOTO PAGE_CAMPAIGN >>> 2026-10-25 09:36:07.990 | INFO | Page switch: page_main_white -> page_campaign_menu 2026-10-25 09:36:07.994 | INFO | Click (1217, 491) @ MAIN_GOTO_CAMPAIGN_WHITE 2026-10-25 09:36:08.570 | INFO | Page switch: page_campaign_menu -> page_campaign 2026-10-25 09:36:08.573 | INFO | Click ( 421, 365) @ CAMPAIGN_MENU_GOTO_CAMPAIGN 2026-10-25 09:36:08.865 | INFO | Page arrive: page_campaign 2026-10-25 09:36:08.891 | INFO | Mode_switch_1 set to hard 2026-10-25 09:36:08.916 | INFO | [Mode_switch_1] hard 2026-10-25 09:36:08.920 | INFO | <<< UI ENSURE INDEX >>> 2026-10-25 09:36:08.991 | INFO | No stage found. 2026-10-25 09:36:09.230 | INFO | No stage found. 2026-10-25 09:36:09.529 | INFO | No stage found. 2026-10-25 09:36:09.848 | INFO | Loading OCR model: ./bin/cnocr_models/azur_lane 2026-10-25 09:36:09.959 | INFO | [campaign 0.129s] ['13--1', '13--3', '13--2', '13--4'] 2026-10-25 09:36:09.963 | INFO | [Chapter] 13 2026-10-25 09:36:09.965 | INFO | [Stage] 13-1, 13-3, 13-2, 13-4 2026-10-25 09:36:09.968 | INFO | [Index] 13 2026-10-25 09:36:10.033 | INFO | [OCR_OIL 0.039s] 18686 ──────────────────────────────────────────────────────── 13-1 ───────────────────────────────────────────────────────── 2026-10-25 09:36:10.038 | INFO | 13-1 2026-10-25 09:36:10.040 | INFO | Expect emotion reduce: (12, 2) 2026-10-25 09:36:10.052 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-10-25 09:36:10.056 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=53, Main.Emotion.Fleet1Record=datetime.datetime(2026, 10, 25, 9, 36, 10), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 10, 25, 9, 36, 10) 2026-10-25 09:36:10.070 | INFO | [Emotion fleet_1] 53 2026-10-25 09:36:10.073 | INFO | [Emotion fleet_2] 119 2026-10-25 09:36:10.075 | INFO | <<< ENTER MAP >>> 2026-10-25 09:36:10.146 | INFO | Click ( 197, 269) @ 13-1 2026-10-25 09:36:10.849 | INFO | [Map_clear_percentage] 69% 2026-10-25 09:36:11.150 | INFO | [Map_clear_percentage] 99% 2026-10-25 09:36:11.179 | INFO | [MAP_CLEAR_ALL_THIS_TIME] False 2026-10-25 09:36:11.182 | INFO | [Map_info] 99%, star_1, star_2, star_3, 100_percent_clear, 3_stars, threat_safe, clear_mode 2026-10-25 09:36:11.185 | INFO | [StopCondition_MapAchievement] non_stop 2026-10-25 09:36:11.188 | INFO | Clear_Mode set to on 2026-10-25 09:36:11.192 | INFO | [Clear_Mode] on 2026-10-25 09:36:11.206 | INFO | Auto_Search set to on 2026-10-25 09:36:11.210 | INFO | [Auto_Search] on 2026-10-25 09:36:11.214 | INFO | Click (1050, 514) @ MAP_PREPARATION 2026-10-25 09:36:11.447 | INFO | Handling 2x book setting, mode=prep. 2026-10-25 09:36:11.471 | INFO | Using fleet: [4, 3, 1] 2026-10-25 09:36:11.545 | INFO | Hard satisfied: Fleet_1: None, Fleet_2: None, Submarine: None 2026-10-25 09:36:11.554 | INFO | [map_allow_submarine] True 2026-10-25 09:36:11.559 | INFO | Click (1131, 336) @ FLEET_2_CLEAR 2026-10-25 09:36:11.613 | INFO | Fleet SUBMARINE set to 1 2026-10-25 09:36:11.616 | INFO | Click (1073, 480) @ SUBMARINE_CHOOSE 2026-10-25 09:36:11.747 | INFO | FleetOption: [1] 2 2026-10-25 09:36:11.753 | INFO | Fleet option 1 is already selected 2026-10-25 09:36:11.757 | INFO | Click (1044, 470) @ SUBMARINE_CHOOSE 2026-10-25 09:36:12.043 | INFO | FleetOption: 2026-10-25 09:36:12.050 | INFO | Fleet FLEET_1 set to 4 2026-10-25 09:36:12.055 | INFO | Click (1059, 237) @ FLEET_1_CHOOSE 2026-10-25 09:36:12.348 | INFO | FleetOption: 1 2 3 [4] 5 6 2026-10-25 09:36:12.354 | INFO | Fleet option 4 is already selected 2026-10-25 09:36:12.357 | INFO | Click (1066, 231) @ FLEET_1_CHOOSE 2026-10-25 09:36:12.642 | INFO | FleetOption: 2026-10-25 09:36:12.645 | INFO | Fleet FLEET_2 set to 3 2026-10-25 09:36:12.647 | INFO | Click (1049, 337) @ FLEET_2_CHOOSE 2026-10-25 09:36:12.948 | INFO | FleetOption: 1 2 3 [4] 5 6 2026-10-25 09:36:12.954 | INFO | Click (1081, 498) @ FleetOption_3 2026-10-25 09:36:13.244 | INFO | FleetOption: 2026-10-25 09:36:13.247 | INFO | Auto search setting 2026-10-25 09:36:13.262 | INFO | [_fleet_sidebar_offset] 0 2026-10-25 09:36:13.268 | INFO | [_fleet_sidebar_offset] 0 2026-10-25 09:36:13.272 | INFO | [Fleet_sidebar] 1/3 2026-10-25 09:36:13.275 | INFO | Click (1207, 441) @ FLEET_SIDEBAR_0_2 2026-10-25 09:36:13.548 | INFO | [_fleet_sidebar_offset] 0 2026-10-25 09:36:13.554 | INFO | [Fleet_sidebar] 3/3 2026-10-25 09:36:13.559 | INFO | [Auto_Search_Setting] fleet1_all_fleet2_standby, sub_standby 2026-10-25 09:36:13.563 | INFO | Click ( 499, 212) @ AUTO_SEARCH_SET_MOB 2026-10-25 09:36:14.072 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_standby 2026-10-25 09:36:14.076 | INFO | Selected to the correct auto search setting 2026-10-25 09:36:14.078 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_standby 2026-10-25 09:36:14.081 | INFO | Selected to the correct auto search setting 2026-10-25 09:36:14.087 | INFO | Click (1084, 583) @ FLEET_PREPARATION 2026-10-25 09:36:15.288 | INFO | is_auto_search_running appeared ────────────────────────────────────────────────────── BATTLE_0 ─────────────────────────────────────────────────────── 2026-10-25 09:36:15.294 | INFO | BATTLE_0 2026-10-25 09:36:15.296 | INFO | Auto search moving 2026-10-25 09:36:15.309 | INFO | Fleet: 1, fleet_current_index: 1 2026-10-25 09:36:15.344 | INFO | [OCR_OIL 0.032s] 18676 2026-10-25 09:36:15.409 | INFO | [OCR_COIN 0.062s] 100030 2026-10-25 09:36:20.544 | INFO | [Loading] 7% 2026-10-25 09:36:20.549 | INFO | Auto search combat loading 2026-10-25 09:36:20.554 | INFO | Screenshot interval set to 1.0s 2026-10-25 09:36:26.552 | INFO | [BattleUI] PAUSE 2026-10-25 09:36:26.557 | INFO | Auto Search combat execute 2026-10-25 09:36:26.560 | INFO | <<< EMOTION REDUCE >>> 2026-10-25 09:36:26.571 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-10-25 09:36:26.577 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=51, Main.Emotion.Fleet1Record=datetime.datetime(2026, 10, 25, 9, 36, 26), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 10, 25, 9, 36, 26) 2026-10-25 09:36:26.593 | INFO | [Emotion fleet_1] 51 2026-10-25 09:36:26.597 | INFO | [Emotion fleet_2] 119 2026-10-25 09:36:32.546 | INFO | Combat auto check timer reached 2026-10-25 09:36:49.575 | INFO | Screenshot interval set to 0.3s 2026-10-25 09:36:49.580 | INFO | Auto Search combat status 2026-10-25 09:36:51.067 | INFO | Click (1045, 670) @ GET_SHIP 2026-10-25 09:36:52.278 | INFO | Click (1020, 651) @ GET_SHIP 2026-10-25 09:36:56.762 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_1 ─────────────────────────────────────────────────────── 2026-10-25 09:36:56.769 | INFO | BATTLE_1 2026-10-25 09:36:56.773 | INFO | Auto search moving 2026-10-25 09:36:56.778 | INFO | Fleet: 1, fleet_current_index: 1 2026-10-25 09:36:56.851 | INFO | [OCR_OIL 0.068s] 18657 2026-10-25 09:36:56.929 | INFO | [OCR_COIN 0.071s] 100047 2026-10-25 09:37:01.580 | INFO | [Loading] 6% 2026-10-25 09:37:01.583 | INFO | Auto search combat loading 2026-10-25 09:37:01.587 | INFO | Screenshot interval set to 1.0s 2026-10-25 09:37:07.594 | INFO | [BattleUI] PAUSE 2026-10-25 09:37:07.599 | INFO | Auto Search combat execute 2026-10-25 09:37:07.602 | INFO | <<< EMOTION REDUCE >>> 2026-10-25 09:37:07.616 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-10-25 09:37:07.620 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=49, Main.Emotion.Fleet1Record=datetime.datetime(2026, 10, 25, 9, 37, 7), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 10, 25, 9, 37, 7) 2026-10-25 09:37:07.635 | INFO | [Emotion fleet_1] 49 2026-10-25 09:37:07.639 | INFO | [Emotion fleet_2] 119 2026-10-25 09:37:13.577 | INFO | Combat auto check timer reached 2026-10-25 09:37:32.615 | INFO | Screenshot interval set to 0.3s 2026-10-25 09:37:32.618 | INFO | Auto Search combat status 2026-10-25 09:37:33.505 | INFO | Click (1017, 662) @ GET_SHIP 2026-10-25 09:37:34.707 | INFO | Click (1032, 663) @ GET_SHIP 2026-10-25 09:37:39.204 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_2 ─────────────────────────────────────────────────────── 2026-10-25 09:37:39.210 | INFO | BATTLE_2 2026-10-25 09:37:39.213 | INFO | Auto search moving 2026-10-25 09:37:39.220 | INFO | Fleet: 1, fleet_current_index: 1 2026-10-25 09:37:39.305 | INFO | [OCR_OIL 0.080s] 18638 2026-10-25 09:37:39.387 | INFO | [OCR_COIN 0.074s] 100060 2026-10-25 09:37:44.011 | INFO | [Loading] 16% 2026-10-25 09:37:44.014 | INFO | Auto search combat loading 2026-10-25 09:37:44.016 | INFO | Screenshot interval set to 1.0s 2026-10-25 09:37:50.017 | INFO | [BattleUI] PAUSE 2026-10-25 09:37:50.022 | INFO | Auto Search combat execute 2026-10-25 09:37:50.026 | INFO | <<< EMOTION REDUCE >>> 2026-10-25 09:37:50.038 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-10-25 09:37:50.043 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=47, Main.Emotion.Fleet1Record=datetime.datetime(2026, 10, 25, 9, 37, 50), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 10, 25, 9, 37, 50) 2026-10-25 09:37:50.061 | INFO | [Emotion fleet_1] 47 2026-10-25 09:37:50.065 | INFO | [Emotion fleet_2] 119 2026-10-25 09:37:56.015 | INFO | Combat auto check timer reached 2026-10-25 09:38:15.057 | INFO | Screenshot interval set to 0.3s 2026-10-25 09:38:15.061 | INFO | Auto Search combat status 2026-10-25 09:38:15.635 | INFO | Click (1023, 671) @ GET_SHIP 2026-10-25 09:38:16.836 | INFO | Click (1027, 650) @ GET_SHIP 2026-10-25 09:38:21.030 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_3 ─────────────────────────────────────────────────────── 2026-10-25 09:38:21.034 | INFO | BATTLE_3 2026-10-25 09:38:21.039 | INFO | Auto search moving 2026-10-25 09:38:21.045 | INFO | Fleet: 1, fleet_current_index: 1 2026-10-25 09:38:21.095 | INFO | [OCR_OIL 0.046s] 18619 2026-10-25 09:38:21.152 | INFO | [OCR_COIN 0.054s] 100072 2026-10-25 09:38:26.151 | INFO | [Loading] 7% 2026-10-25 09:38:26.154 | INFO | Auto search combat loading 2026-10-25 09:38:26.159 | INFO | Screenshot interval set to 1.0s 2026-10-25 09:38:32.168 | INFO | [BattleUI] PAUSE 2026-10-25 09:38:32.172 | INFO | Auto Search combat execute 2026-10-25 09:38:32.178 | INFO | <<< EMOTION REDUCE >>> 2026-10-25 09:38:32.199 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-10-25 09:38:32.204 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=45, Main.Emotion.Fleet1Record=datetime.datetime(2026, 10, 25, 9, 38, 32), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 10, 25, 9, 38, 32) 2026-10-25 09:38:32.221 | INFO | [Emotion fleet_1] 45 2026-10-25 09:38:32.224 | INFO | [Emotion fleet_2] 119 2026-10-25 09:38:38.163 | INFO | Combat auto check timer reached 2026-10-25 09:38:59.188 | INFO | Click (1018, 667) @ GET_SHIP 2026-10-25 09:39:02.193 | INFO | Screenshot interval set to 0.3s 2026-10-25 09:39:02.196 | INFO | Auto Search combat status 2026-10-25 09:39:03.669 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_4 ─────────────────────────────────────────────────────── 2026-10-25 09:39:03.674 | INFO | BATTLE_4 2026-10-25 09:39:03.677 | INFO | Auto search moving 2026-10-25 09:39:03.681 | INFO | Fleet: 1, fleet_current_index: 1 2026-10-25 09:39:03.766 | INFO | [OCR_OIL 0.081s] 18600 2026-10-25 09:39:03.868 | INFO | [OCR_COIN 0.097s] 100082 2026-10-25 09:39:09.082 | INFO | [Loading] 8% 2026-10-25 09:39:09.086 | INFO | Auto search combat loading 2026-10-25 09:39:09.089 | INFO | Screenshot interval set to 1.0s 2026-10-25 09:39:15.103 | INFO | [BattleUI] PAUSE 2026-10-25 09:39:15.108 | INFO | Auto Search combat execute 2026-10-25 09:39:15.111 | INFO | <<< EMOTION REDUCE >>> 2026-10-25 09:39:15.126 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-10-25 09:39:15.131 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=43, Main.Emotion.Fleet1Record=datetime.datetime(2026, 10, 25, 9, 39, 15), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 10, 25, 9, 39, 15) 2026-10-25 09:39:15.145 | INFO | [Emotion fleet_1] 43 2026-10-25 09:39:15.152 | INFO | [Emotion fleet_2] 119 2026-10-25 09:39:21.079 | INFO | Combat auto check timer reached 2026-10-25 09:40:14.168 | INFO | Click (1038, 669) @ GET_SHIP 2026-10-25 09:40:16.150 | INFO | Click (1048, 659) @ GET_SHIP 2026-10-25 09:40:19.168 | INFO | Screenshot interval set to 0.3s 2026-10-25 09:40:19.172 | INFO | Auto Search combat status 2026-10-25 09:40:20.339 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_5 ─────────────────────────────────────────────────────── 2026-10-25 09:40:20.346 | INFO | BATTLE_5 2026-10-25 09:40:20.348 | INFO | Auto search moving 2026-10-25 09:40:20.352 | INFO | Fleet: 1, fleet_current_index: 1 2026-10-25 09:40:20.406 | INFO | [OCR_OIL 0.050s] 18581 2026-10-25 09:40:20.457 | INFO | [OCR_COIN 0.047s] 100101 2026-10-25 09:40:23.344 | INFO | [Loading] 16% 2026-10-25 09:40:23.347 | INFO | Auto search combat loading 2026-10-25 09:40:23.351 | INFO | Screenshot interval set to 1.0s 2026-10-25 09:40:29.361 | INFO | [BattleUI] PAUSE 2026-10-25 09:40:29.364 | INFO | Auto Search combat execute 2026-10-25 09:40:29.366 | INFO | <<< EMOTION REDUCE >>> 2026-10-25 09:40:29.381 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-10-25 09:40:29.385 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=41, Main.Emotion.Fleet1Record=datetime.datetime(2026, 10, 25, 9, 40, 29), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 10, 25, 9, 40, 29) 2026-10-25 09:40:29.403 | INFO | [Emotion fleet_1] 41 2026-10-25 09:40:29.407 | INFO | [Emotion fleet_2] 119 2026-10-25 09:40:35.349 | INFO | Combat auto check timer reached 2026-10-25 09:43:29.510 | 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 L445 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-10-25 09:43:29.531 | WARNING | Wait too long 2026-10-25 09:43:29.536 | 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-10-25 09:43:29.594 | INFO | [Package_name] com.bilibili.azurlane 2026-10-25 09:43:29.597 | ERROR | GameStuckError: Wait too long 2026-10-25 09:43:29.601 | WARNING | Saving error: ./log/error/1792892609601