═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ MAIN ═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ ════════════════════════════════════════════════════ CAMPAIGN_13_1 ════════════════════════════════════════════════════ 2026-10-22 22:24:05.857 | INFO | CAMPAIGN_13_1 2026-10-22 22:24:05.861 | INFO | Campaign run: event="campaign_main", name=campaign_13_1 2026-10-22 22:24:05.863 | INFO | Count: 0 2026-10-22 22:24:05.880 | INFO | <<< UI ENSURE >>> 2026-10-22 22:24:05.883 | INFO | UI get current page 2026-10-22 22:24:06.564 | INFO | Unknown ui page 2026-10-22 22:24:07.072 | INFO | UI additional: IDLE -> REWARD_GOTO_MAIN 2026-10-22 22:24:07.078 | INFO | Click ( 826, 628) @ REWARD_GOTO_MAIN 2026-10-22 22:24:07.262 | INFO | Unknown ui page 2026-10-22 22:24:07.398 | INFO | [Package_name] com.bilibili.azurlane 2026-10-22 22:24:07.416 | INFO | [Device Orientation] 0 (Normal) 2026-10-22 22:24:07.567 | INFO | Unknown ui page 2026-10-22 22:24:07.862 | INFO | Unknown ui page 2026-10-22 22:24:08.073 | INFO | [UI] page_main 2026-10-22 22:24:08.078 | INFO | Goto page_campaign 2026-10-22 22:24:08.083 | INFO | <<< UI GOTO PAGE_CAMPAIGN >>> 2026-10-22 22:24:08.099 | INFO | Page switch: page_main_white -> page_campaign_menu 2026-10-22 22:24:08.102 | INFO | Click (1204, 511) @ MAIN_GOTO_CAMPAIGN_WHITE 2026-10-22 22:24:08.678 | INFO | Page switch: page_campaign_menu -> page_campaign 2026-10-22 22:24:08.683 | INFO | Click ( 447, 319) @ CAMPAIGN_MENU_GOTO_CAMPAIGN 2026-10-22 22:24:08.974 | INFO | Page arrive: page_campaign 2026-10-22 22:24:09.001 | INFO | Mode_switch_1 set to hard 2026-10-22 22:24:09.026 | INFO | [Mode_switch_1] hard 2026-10-22 22:24:09.030 | INFO | <<< UI ENSURE INDEX >>> 2026-10-22 22:24:09.099 | INFO | No stage found. 2026-10-22 22:24:09.337 | INFO | No stage found. 2026-10-22 22:24:09.659 | INFO | Loading OCR model: ./bin/cnocr_models/azur_lane 2026-10-22 22:24:09.762 | INFO | [campaign 0.124s] ['I3--1', 'I3--3', 'I3--2', 'I3--4'] 2026-10-22 22:24:09.766 | INFO | [Chapter] 13 2026-10-22 22:24:09.768 | INFO | [Stage] 13-1, 13-3, 13-2, 13-4 2026-10-22 22:24:09.770 | INFO | [Index] 13 2026-10-22 22:24:09.834 | INFO | [OCR_OIL 0.035s] 21801 ──────────────────────────────────────────────────────── 13-1 ───────────────────────────────────────────────────────── 2026-10-22 22:24:09.839 | INFO | 13-1 2026-10-22 22:24:09.845 | INFO | Expect emotion reduce: (12, 2) 2026-10-22 22:24:09.858 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-10-22 22:24:09.861 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=53, Main.Emotion.Fleet1Record=datetime.datetime(2026, 10, 22, 22, 24, 9), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 10, 22, 22, 24, 9) 2026-10-22 22:24:09.877 | INFO | [Emotion fleet_1] 53 2026-10-22 22:24:09.881 | INFO | [Emotion fleet_2] 119 2026-10-22 22:24:09.883 | INFO | <<< ENTER MAP >>> 2026-10-22 22:24:09.957 | INFO | Click ( 196, 277) @ 13-1 2026-10-22 22:24:10.357 | INFO | [Map_clear_percentage] 5% 2026-10-22 22:24:10.660 | INFO | [Map_clear_percentage] 73% 2026-10-22 22:24:10.960 | INFO | [Map_clear_percentage] 99% 2026-10-22 22:24:10.986 | INFO | [MAP_CLEAR_ALL_THIS_TIME] False 2026-10-22 22:24:10.990 | INFO | [Map_info] 99%, star_1, star_2, star_3, 100_percent_clear, 3_stars, threat_safe, clear_mode 2026-10-22 22:24:10.993 | INFO | [StopCondition_MapAchievement] non_stop 2026-10-22 22:24:10.995 | INFO | Clear_Mode set to on 2026-10-22 22:24:11.000 | INFO | [Clear_Mode] on 2026-10-22 22:24:11.013 | INFO | Auto_Search set to on 2026-10-22 22:24:11.018 | INFO | [Auto_Search] on 2026-10-22 22:24:11.022 | INFO | Click (1043, 506) @ MAP_PREPARATION 2026-10-22 22:24:11.260 | INFO | Handling 2x book setting, mode=prep. 2026-10-22 22:24:11.282 | INFO | Using fleet: [4, 3, 1] 2026-10-22 22:24:11.357 | INFO | Hard satisfied: Fleet_1: None, Fleet_2: None, Submarine: None 2026-10-22 22:24:11.366 | INFO | [map_allow_submarine] True 2026-10-22 22:24:11.370 | INFO | Click (1147, 331) @ FLEET_2_CLEAR 2026-10-22 22:24:11.424 | INFO | Fleet SUBMARINE set to 1 2026-10-22 22:24:11.427 | INFO | Click (1058, 475) @ SUBMARINE_CHOOSE 2026-10-22 22:24:11.565 | INFO | FleetOption: [1] 2 2026-10-22 22:24:11.569 | INFO | Fleet option 1 is already selected 2026-10-22 22:24:11.571 | INFO | Click (1060, 457) @ SUBMARINE_CHOOSE 2026-10-22 22:24:11.858 | INFO | FleetOption: 2026-10-22 22:24:11.864 | INFO | Fleet FLEET_1 set to 4 2026-10-22 22:24:11.868 | INFO | Click (1054, 236) @ FLEET_1_CHOOSE 2026-10-22 22:24:12.157 | INFO | FleetOption: 1 2 3 [4] 5 6 2026-10-22 22:24:12.162 | INFO | Fleet option 4 is already selected 2026-10-22 22:24:12.165 | INFO | Click (1051, 215) @ FLEET_1_CHOOSE 2026-10-22 22:24:12.453 | INFO | FleetOption: 2026-10-22 22:24:12.455 | INFO | Fleet FLEET_2 set to 3 2026-10-22 22:24:12.458 | INFO | Click (1029, 351) @ FLEET_2_CHOOSE 2026-10-22 22:24:12.757 | INFO | FleetOption: 1 2 3 [4] 5 6 2026-10-22 22:24:12.762 | INFO | Click (1089, 492) @ FleetOption_3 2026-10-22 22:24:13.053 | INFO | FleetOption: 2026-10-22 22:24:13.056 | INFO | Auto search setting 2026-10-22 22:24:13.070 | INFO | [_fleet_sidebar_offset] 0 2026-10-22 22:24:13.076 | INFO | [_fleet_sidebar_offset] 0 2026-10-22 22:24:13.080 | INFO | [Fleet_sidebar] 1/3 2026-10-22 22:24:13.084 | INFO | Click (1219, 436) @ FLEET_SIDEBAR_0_2 2026-10-22 22:24:13.356 | INFO | [_fleet_sidebar_offset] 0 2026-10-22 22:24:13.360 | INFO | [Fleet_sidebar] 3/3 2026-10-22 22:24:13.366 | INFO | [Auto_Search_Setting] fleet1_all_fleet2_standby, sub_standby 2026-10-22 22:24:13.370 | INFO | Click ( 509, 217) @ AUTO_SEARCH_SET_MOB 2026-10-22 22:24:13.900 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_standby 2026-10-22 22:24:13.905 | INFO | Selected to the correct auto search setting 2026-10-22 22:24:13.907 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_standby 2026-10-22 22:24:13.911 | INFO | Selected to the correct auto search setting 2026-10-22 22:24:13.918 | INFO | Click (1045, 588) @ FLEET_PREPARATION 2026-10-22 22:24:14.819 | INFO | is_auto_search_running appeared ────────────────────────────────────────────────────── BATTLE_0 ─────────────────────────────────────────────────────── 2026-10-22 22:24:14.825 | INFO | BATTLE_0 2026-10-22 22:24:14.828 | INFO | Auto search moving 2026-10-22 22:24:14.842 | INFO | Fleet: 1, fleet_current_index: 1 2026-10-22 22:24:14.883 | INFO | [OCR_OIL 0.038s] 21791 2026-10-22 22:24:14.932 | INFO | [OCR_COIN 0.045s] 122670 2026-10-22 22:24:19.172 | INFO | [Loading] 4% 2026-10-22 22:24:19.176 | INFO | Auto search combat loading 2026-10-22 22:24:19.179 | INFO | Screenshot interval set to 1.0s 2026-10-22 22:24:25.185 | INFO | [BattleUI] PAUSE 2026-10-22 22:24:25.188 | INFO | Auto Search combat execute 2026-10-22 22:24:25.191 | INFO | <<< EMOTION REDUCE >>> 2026-10-22 22:24:25.205 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-10-22 22:24:25.212 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=51, Main.Emotion.Fleet1Record=datetime.datetime(2026, 10, 22, 22, 24, 25), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 10, 22, 22, 24, 25) 2026-10-22 22:24:25.228 | INFO | [Emotion fleet_1] 51 2026-10-22 22:24:25.233 | INFO | [Emotion fleet_2] 119 2026-10-22 22:24:31.179 | INFO | Combat auto check timer reached 2026-10-22 22:24:50.213 | INFO | Screenshot interval set to 0.3s 2026-10-22 22:24:50.216 | INFO | Auto Search combat status 2026-10-22 22:24:51.103 | INFO | Click (1018, 650) @ GET_SHIP 2026-10-22 22:24:52.305 | INFO | Click (1009, 659) @ GET_SHIP 2026-10-22 22:24:56.497 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_1 ─────────────────────────────────────────────────────── 2026-10-22 22:24:56.502 | INFO | BATTLE_1 2026-10-22 22:24:56.504 | INFO | Auto search moving 2026-10-22 22:24:56.508 | INFO | Fleet: 1, fleet_current_index: 1 2026-10-22 22:24:56.565 | INFO | [OCR_OIL 0.050s] 21772 2026-10-22 22:24:56.622 | INFO | [OCR_COIN 0.055s] 122683 2026-10-22 22:25:01.009 | INFO | [Loading] 10% 2026-10-22 22:25:01.013 | INFO | Auto search combat loading 2026-10-22 22:25:01.017 | INFO | Screenshot interval set to 1.0s 2026-10-22 22:25:07.022 | INFO | [BattleUI] PAUSE 2026-10-22 22:25:07.028 | INFO | Auto Search combat execute 2026-10-22 22:25:07.033 | INFO | <<< EMOTION REDUCE >>> 2026-10-22 22:25:07.047 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-10-22 22:25:07.051 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=49, Main.Emotion.Fleet1Record=datetime.datetime(2026, 10, 22, 22, 25, 7), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 10, 22, 22, 25, 7) 2026-10-22 22:25:07.073 | INFO | [Emotion fleet_1] 49 2026-10-22 22:25:07.075 | INFO | [Emotion fleet_2] 119 2026-10-22 22:25:13.014 | INFO | Combat auto check timer reached 2026-10-22 22:25:49.060 | INFO | Screenshot interval set to 0.3s 2026-10-22 22:25:49.063 | INFO | Auto Search combat status 2026-10-22 22:25:49.952 | INFO | Click (1036, 655) @ GET_SHIP 2026-10-22 22:25:51.155 | INFO | Click (1029, 670) @ GET_SHIP 2026-10-22 22:25:55.644 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_2 ─────────────────────────────────────────────────────── 2026-10-22 22:25:55.650 | INFO | BATTLE_2 2026-10-22 22:25:55.653 | INFO | Auto search moving 2026-10-22 22:25:55.657 | INFO | Fleet: 1, fleet_current_index: 1 2026-10-22 22:25:55.736 | INFO | [OCR_OIL 0.073s] 21753 2026-10-22 22:25:55.803 | INFO | [OCR_COIN 0.063s] 122711 2026-10-22 22:26:00.466 | INFO | [Loading] 7% 2026-10-22 22:26:00.470 | INFO | Auto search combat loading 2026-10-22 22:26:00.472 | INFO | Screenshot interval set to 1.0s 2026-10-22 22:26:06.471 | INFO | [BattleUI] PAUSE 2026-10-22 22:26:06.475 | INFO | Auto Search combat execute 2026-10-22 22:26:06.477 | INFO | <<< EMOTION REDUCE >>> 2026-10-22 22:26:06.491 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-10-22 22:26:06.494 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=47, Main.Emotion.Fleet1Record=datetime.datetime(2026, 10, 22, 22, 26, 6), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 10, 22, 22, 26, 6) 2026-10-22 22:26:06.506 | INFO | [Emotion fleet_1] 47 2026-10-22 22:26:06.511 | INFO | [Emotion fleet_2] 119 2026-10-22 22:26:12.474 | INFO | Combat auto check timer reached 2026-10-22 22:26:50.524 | INFO | Click (1027, 659) @ GET_SHIP 2026-10-22 22:26:52.513 | INFO | Click (1036, 664) @ GET_SHIP 2026-10-22 22:26:55.530 | INFO | Screenshot interval set to 0.3s 2026-10-22 22:26:55.535 | INFO | Auto Search combat status 2026-10-22 22:26:56.703 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_3 ─────────────────────────────────────────────────────── 2026-10-22 22:26:56.708 | INFO | BATTLE_3 2026-10-22 22:26:56.710 | INFO | Auto search moving 2026-10-22 22:26:56.713 | INFO | Fleet: 1, fleet_current_index: 1 2026-10-22 22:26:56.769 | INFO | [OCR_OIL 0.054s] 21734 2026-10-22 22:26:56.837 | INFO | [OCR_COIN 0.063s] 122729 2026-10-22 22:27:00.912 | INFO | [Loading] 5% 2026-10-22 22:27:00.915 | INFO | Auto search combat loading 2026-10-22 22:27:00.917 | INFO | Screenshot interval set to 1.0s 2026-10-22 22:27:06.931 | INFO | [BattleUI] PAUSE 2026-10-22 22:27:06.934 | INFO | Auto Search combat execute 2026-10-22 22:27:06.937 | INFO | <<< EMOTION REDUCE >>> 2026-10-22 22:27:06.951 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-10-22 22:27:06.957 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=45, Main.Emotion.Fleet1Record=datetime.datetime(2026, 10, 22, 22, 27, 6), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 10, 22, 22, 27, 6) 2026-10-22 22:27:06.970 | INFO | [Emotion fleet_1] 45 2026-10-22 22:27:06.972 | INFO | [Emotion fleet_2] 119 2026-10-22 22:27:12.919 | INFO | Combat auto check timer reached 2026-10-22 22:27:40.969 | INFO | Screenshot interval set to 0.3s 2026-10-22 22:27:40.973 | INFO | Auto Search combat status 2026-10-22 22:27:42.135 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_4 ─────────────────────────────────────────────────────── 2026-10-22 22:27:42.142 | INFO | BATTLE_4 2026-10-22 22:27:42.145 | INFO | Auto search moving 2026-10-22 22:27:42.150 | INFO | Fleet: 1, fleet_current_index: 1 2026-10-22 22:27:42.223 | INFO | [OCR_OIL 0.070s] 21715 2026-10-22 22:27:42.330 | INFO | [OCR_COIN 0.104s] 122747 2026-10-22 22:27:46.649 | INFO | [Loading] 15% 2026-10-22 22:27:46.651 | INFO | Auto search combat loading 2026-10-22 22:27:46.654 | INFO | Screenshot interval set to 1.0s 2026-10-22 22:27:52.673 | INFO | [BattleUI] PAUSE 2026-10-22 22:27:52.679 | INFO | Auto Search combat execute 2026-10-22 22:27:52.683 | INFO | <<< EMOTION REDUCE >>> 2026-10-22 22:27:52.698 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-10-22 22:27:52.704 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=43, Main.Emotion.Fleet1Record=datetime.datetime(2026, 10, 22, 22, 27, 52), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 10, 22, 22, 27, 52) 2026-10-22 22:27:52.722 | INFO | [Emotion fleet_1] 43 2026-10-22 22:27:52.726 | INFO | [Emotion fleet_2] 119 2026-10-22 22:27:58.664 | INFO | Combat auto check timer reached 2026-10-22 22:28:22.698 | INFO | Screenshot interval set to 0.3s 2026-10-22 22:28:22.702 | INFO | Auto Search combat status 2026-10-22 22:28:23.579 | INFO | Click (1028, 644) @ GET_SHIP 2026-10-22 22:28:24.784 | INFO | Click (1024, 667) @ GET_SHIP 2026-10-22 22:28:28.983 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_5 ─────────────────────────────────────────────────────── 2026-10-22 22:28:28.990 | INFO | BATTLE_5 2026-10-22 22:28:28.992 | INFO | Auto search moving 2026-10-22 22:28:28.996 | INFO | Fleet: 1, fleet_current_index: 1 2026-10-22 22:28:29.061 | INFO | [OCR_OIL 0.061s] 21696 2026-10-22 22:28:29.123 | INFO | [OCR_COIN 0.057s] 122763 2026-10-22 22:28:31.087 | INFO | [Loading] 10% 2026-10-22 22:28:31.091 | INFO | Auto search combat loading 2026-10-22 22:28:31.093 | INFO | Screenshot interval set to 1.0s 2026-10-22 22:28:37.109 | INFO | [BattleUI] PAUSE 2026-10-22 22:28:37.114 | INFO | Auto Search combat execute 2026-10-22 22:28:37.117 | INFO | <<< EMOTION REDUCE >>> 2026-10-22 22:28:37.130 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-10-22 22:28:37.133 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=41, Main.Emotion.Fleet1Record=datetime.datetime(2026, 10, 22, 22, 28, 37), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 10, 22, 22, 28, 37) 2026-10-22 22:28:37.150 | INFO | [Emotion fleet_1] 41 2026-10-22 22:28:37.154 | INFO | [Emotion fleet_2] 119 2026-10-22 22:28:43.093 | INFO | Combat auto check timer reached 2026-10-22 22:31:37.246 | 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 L439 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-22 22:31:37.266 | WARNING | Wait too long 2026-10-22 22:31:37.270 | 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-22 22:31:37.330 | INFO | [Package_name] com.bilibili.azurlane 2026-10-22 22:31:37.336 | ERROR | GameStuckError: Wait too long 2026-10-22 22:31:37.339 | WARNING | Saving error: ./log/error/1792679497339