═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ MAIN ═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ ════════════════════════════════════════════════════ CAMPAIGN_13_1 ════════════════════════════════════════════════════ 2026-05-22 14:54:01.395 | INFO | CAMPAIGN_13_1 2026-05-22 14:54:01.398 | INFO | Count: 0 2026-05-22 14:54:01.415 | INFO | <<< UI ENSURE >>> 2026-05-22 14:54:01.420 | INFO | UI get current page 2026-05-22 14:54:01.968 | INFO | Unknown ui page 2026-05-22 14:54:02.430 | INFO | UI additional: IDLE -> REWARD_GOTO_MAIN 2026-05-22 14:54:02.435 | INFO | Click ( 822, 629) @ REWARD_GOTO_MAIN 2026-05-22 14:54:02.604 | INFO | Unknown ui page 2026-05-22 14:54:02.743 | INFO | [Package_name] com.bilibili.azurlane 2026-05-22 14:54:02.764 | INFO | [Device Orientation] 0 (Normal) 2026-05-22 14:54:02.906 | INFO | Unknown ui page 2026-05-22 14:54:03.132 | INFO | [UI] page_main 2026-05-22 14:54:03.135 | INFO | Goto page_campaign 2026-05-22 14:54:03.138 | INFO | <<< UI GOTO PAGE_CAMPAIGN >>> 2026-05-22 14:54:03.154 | INFO | Page switch: page_main_white -> page_campaign_menu 2026-05-22 14:54:03.160 | INFO | Click (1181, 484) @ MAIN_GOTO_CAMPAIGN_WHITE 2026-05-22 14:54:03.731 | INFO | Page switch: page_campaign_menu -> page_campaign 2026-05-22 14:54:03.736 | INFO | Click ( 345, 344) @ CAMPAIGN_MENU_GOTO_CAMPAIGN 2026-05-22 14:54:04.029 | INFO | Page arrive: page_campaign 2026-05-22 14:54:04.056 | INFO | Mode_switch_1 set to hard 2026-05-22 14:54:04.082 | INFO | [Mode_switch_1] hard 2026-05-22 14:54:04.084 | INFO | <<< UI ENSURE INDEX >>> 2026-05-22 14:54:04.158 | INFO | No stage found. 2026-05-22 14:54:04.397 | INFO | No stage found. 2026-05-22 14:54:04.698 | INFO | No stage found. 2026-05-22 14:54:05.015 | INFO | Loading OCR model: ./bin/cnocr_models/azur_lane 2026-05-22 14:54:05.126 | INFO | [campaign 0.129s] ['13--1', '13--3', '13--2', '13--4'] 2026-05-22 14:54:05.131 | INFO | [Chapter] 13 2026-05-22 14:54:05.135 | INFO | [Stage] 13-1, 13-3, 13-2, 13-4 2026-05-22 14:54:05.138 | INFO | [Index] 13 2026-05-22 14:54:05.210 | INFO | [OCR_OIL 0.046s] 18222 ──────────────────────────────────────────────────────── 13-1 ───────────────────────────────────────────────────────── 2026-05-22 14:54:05.214 | INFO | 13-1 2026-05-22 14:54:05.217 | INFO | Expect emotion reduce: (12, 2) 2026-05-22 14:54:05.230 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-05-22 14:54:05.236 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=53, Main.Emotion.Fleet1Record=datetime.datetime(2026, 5, 22, 14, 54, 5), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 5, 22, 14, 54, 5) 2026-05-22 14:54:05.252 | INFO | [Emotion fleet_1] 53 2026-05-22 14:54:05.255 | INFO | [Emotion fleet_2] 119 2026-05-22 14:54:05.257 | INFO | <<< ENTER MAP >>> 2026-05-22 14:54:05.331 | INFO | Click ( 175, 288) @ 13-1 2026-05-22 14:54:05.731 | INFO | [Map_clear_percentage] 0% 2026-05-22 14:54:06.033 | INFO | [Map_clear_percentage] 67% 2026-05-22 14:54:06.331 | INFO | [Map_clear_percentage] 99% 2026-05-22 14:54:06.357 | INFO | [MAP_CLEAR_ALL_THIS_TIME] False 2026-05-22 14:54:06.360 | INFO | [Map_info] 99%, star_1, star_2, star_3, 100_percent_clear, 3_stars, threat_safe, clear_mode 2026-05-22 14:54:06.364 | INFO | [StopCondition_MapAchievement] non_stop 2026-05-22 14:54:06.370 | INFO | Fast_Forward set to on 2026-05-22 14:54:06.373 | INFO | [Fast_Forward] on 2026-05-22 14:54:06.387 | INFO | Auto_Search set to on 2026-05-22 14:54:06.391 | INFO | [Auto_Search] on 2026-05-22 14:54:06.395 | INFO | Click ( 927, 509) @ MAP_PREPARATION 2026-05-22 14:54:06.935 | INFO | Handling 2x book setting, mode=prep. 2026-05-22 14:54:06.958 | INFO | Using fleet: [4, 3, 1] 2026-05-22 14:54:07.036 | INFO | Hard satisfied: Fleet_1: None, Fleet_2: None, Submarine: None 2026-05-22 14:54:07.044 | INFO | [map_allow_submarine] True 2026-05-22 14:54:07.050 | INFO | Click (1145, 334) @ FLEET_2_CLEAR 2026-05-22 14:54:07.106 | INFO | Click (1057, 449) @ SUBMARINE_CHOOSE 2026-05-22 14:54:07.230 | INFO | Current selected: [1] 2026-05-22 14:54:07.237 | INFO | Click (1037, 473) @ SUBMARINE_CHOOSE 2026-05-22 14:54:07.536 | INFO | Click (1075, 209) @ FLEET_1_CHOOSE 2026-05-22 14:54:07.834 | INFO | Current selected: [4] 2026-05-22 14:54:07.839 | INFO | Click (1044, 216) @ FLEET_1_CHOOSE 2026-05-22 14:54:08.132 | INFO | Click (1053, 333) @ FLEET_2_CHOOSE 2026-05-22 14:54:08.435 | INFO | Current selected: [4] 2026-05-22 14:54:08.441 | INFO | Click (1126, 489) @ FLEET_2_BAR_INDEX_3 2026-05-22 14:54:08.727 | INFO | Auto search setting 2026-05-22 14:54:08.742 | INFO | [_fleet_sidebar_offset] 0 2026-05-22 14:54:08.749 | INFO | [_fleet_sidebar_offset] 0 2026-05-22 14:54:08.753 | INFO | [Fleet_sidebar] 1/3 2026-05-22 14:54:08.758 | INFO | Click (1203, 423) @ FLEET_SIDEBAR_0_2 2026-05-22 14:54:09.029 | INFO | [_fleet_sidebar_offset] 0 2026-05-22 14:54:09.033 | INFO | [Fleet_sidebar] 3/3 2026-05-22 14:54:09.039 | INFO | [Auto_Search_Setting] fleet1_all_fleet2_standby, sub_standby 2026-05-22 14:54:09.043 | INFO | Click ( 502, 215) @ AUTO_SEARCH_SET_MOB 2026-05-22 14:54:09.511 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_standby 2026-05-22 14:54:09.515 | INFO | Selected to the correct auto search setting 2026-05-22 14:54:09.518 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_standby 2026-05-22 14:54:09.521 | INFO | Selected to the correct auto search setting 2026-05-22 14:54:09.524 | INFO | Click (1056, 563) @ FLEET_PREPARATION 2026-05-22 14:54:10.429 | INFO | is_auto_search_running appeared ────────────────────────────────────────────────────── BATTLE_0 ─────────────────────────────────────────────────────── 2026-05-22 14:54:10.435 | INFO | BATTLE_0 2026-05-22 14:54:10.438 | INFO | Auto search moving 2026-05-22 14:54:10.454 | INFO | Fleet: 1, fleet_current_index: 1 2026-05-22 14:54:10.516 | INFO | [OCR_OIL 0.055s] 18212 2026-05-22 14:54:10.608 | INFO | [OCR_COIN 0.087s] 102561 2026-05-22 14:54:15.423 | INFO | [Loading] 11% 2026-05-22 14:54:15.427 | INFO | Auto search combat loading 2026-05-22 14:54:15.431 | INFO | Screenshot interval set to 1.0s 2026-05-22 14:54:21.428 | INFO | [BattleUI] PAUSE 2026-05-22 14:54:21.434 | INFO | Auto Search combat execute 2026-05-22 14:54:21.437 | INFO | <<< EMOTION REDUCE >>> 2026-05-22 14:54:21.449 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-05-22 14:54:21.455 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=51, Main.Emotion.Fleet1Record=datetime.datetime(2026, 5, 22, 14, 54, 21), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 5, 22, 14, 54, 21) 2026-05-22 14:54:21.480 | INFO | [Emotion fleet_1] 51 2026-05-22 14:54:21.485 | INFO | [Emotion fleet_2] 119 2026-05-22 14:54:26.449 | INFO | Combat auto check timer reached 2026-05-22 14:54:47.453 | INFO | Click (1027, 659) @ GET_SHIP 2026-05-22 14:54:48.475 | INFO | Click (1027, 659) @ GET_SHIP 2026-05-22 14:54:49.466 | INFO | Screenshot interval set to 0.3s 2026-05-22 14:54:49.469 | INFO | Auto Search combat status 2026-05-22 14:54:49.483 | INFO | Click (1022, 648) @ GET_SHIP 2026-05-22 14:54:50.938 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_1 ─────────────────────────────────────────────────────── 2026-05-22 14:54:50.942 | INFO | BATTLE_1 2026-05-22 14:54:50.946 | INFO | Auto search moving 2026-05-22 14:54:50.951 | INFO | Fleet: 1, fleet_current_index: 1 2026-05-22 14:54:51.063 | INFO | [OCR_OIL 0.107s] 18193 2026-05-22 14:54:51.146 | INFO | [OCR_COIN 0.078s] 102571 2026-05-22 14:54:54.853 | INFO | [Loading] 5% 2026-05-22 14:54:54.857 | INFO | Auto search combat loading 2026-05-22 14:54:54.861 | INFO | Screenshot interval set to 1.0s 2026-05-22 14:55:00.861 | INFO | [BattleUI] PAUSE 2026-05-22 14:55:00.866 | INFO | Auto Search combat execute 2026-05-22 14:55:00.869 | INFO | <<< EMOTION REDUCE >>> 2026-05-22 14:55:00.889 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-05-22 14:55:00.894 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=49, Main.Emotion.Fleet1Record=datetime.datetime(2026, 5, 22, 14, 55), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 5, 22, 14, 55) 2026-05-22 14:55:00.911 | INFO | [Emotion fleet_1] 49 2026-05-22 14:55:00.914 | INFO | [Emotion fleet_2] 119 2026-05-22 14:55:06.851 | INFO | Combat auto check timer reached 2026-05-22 14:55:24.889 | INFO | Screenshot interval set to 0.3s 2026-05-22 14:55:24.892 | INFO | Auto Search combat status 2026-05-22 14:55:26.381 | INFO | Click (1025, 647) @ GET_SHIP 2026-05-22 14:55:27.886 | INFO | Click (1022, 654) @ GET_SHIP 2026-05-22 14:55:29.089 | INFO | Click (1008, 653) @ GET_SHIP 2026-05-22 14:55:30.276 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_2 ─────────────────────────────────────────────────────── 2026-05-22 14:55:30.283 | INFO | BATTLE_2 2026-05-22 14:55:30.286 | INFO | Auto search moving 2026-05-22 14:55:30.289 | INFO | Fleet: 1, fleet_current_index: 1 2026-05-22 14:55:30.371 | INFO | [OCR_OIL 0.079s] 18174 2026-05-22 14:55:30.463 | INFO | [OCR_COIN 0.088s] 102584 2026-05-22 14:55:34.487 | INFO | [Loading] 5% 2026-05-22 14:55:34.490 | INFO | Auto search combat loading 2026-05-22 14:55:34.493 | INFO | Screenshot interval set to 1.0s 2026-05-22 14:55:40.509 | INFO | [BattleUI] PAUSE 2026-05-22 14:55:40.514 | INFO | Auto Search combat execute 2026-05-22 14:55:40.517 | INFO | <<< EMOTION REDUCE >>> 2026-05-22 14:55:40.530 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-05-22 14:55:40.536 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=47, Main.Emotion.Fleet1Record=datetime.datetime(2026, 5, 22, 14, 55, 40), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 5, 22, 14, 55, 40) 2026-05-22 14:55:40.558 | INFO | [Emotion fleet_1] 47 2026-05-22 14:55:40.563 | INFO | [Emotion fleet_2] 119 2026-05-22 14:55:46.495 | INFO | Combat auto check timer reached 2026-05-22 14:56:11.534 | INFO | Click (1023, 654) @ GET_SHIP 2026-05-22 14:56:12.539 | INFO | Click (1018, 650) @ GET_SHIP 2026-05-22 14:56:14.538 | INFO | Screenshot interval set to 0.3s 2026-05-22 14:56:14.545 | INFO | Auto Search combat status 2026-05-22 14:56:14.549 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_3 ─────────────────────────────────────────────────────── 2026-05-22 14:56:14.554 | INFO | BATTLE_3 2026-05-22 14:56:14.558 | INFO | Auto search moving 2026-05-22 14:56:14.563 | INFO | Fleet: 1, fleet_current_index: 1 2026-05-22 14:56:14.640 | INFO | [OCR_OIL 0.073s] 18155 2026-05-22 14:56:14.721 | INFO | [OCR_COIN 0.077s] 102601 2026-05-22 14:56:19.029 | INFO | [Loading] 11% 2026-05-22 14:56:19.033 | INFO | Auto search combat loading 2026-05-22 14:56:19.036 | INFO | Screenshot interval set to 1.0s 2026-05-22 14:56:25.050 | INFO | [BattleUI] PAUSE 2026-05-22 14:56:25.055 | INFO | Auto Search combat execute 2026-05-22 14:56:25.063 | INFO | <<< EMOTION REDUCE >>> 2026-05-22 14:56:25.075 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-05-22 14:56:25.087 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=45, Main.Emotion.Fleet1Record=datetime.datetime(2026, 5, 22, 14, 56, 25), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 5, 22, 14, 56, 25) 2026-05-22 14:56:25.101 | INFO | [Emotion fleet_1] 45 2026-05-22 14:56:25.105 | INFO | [Emotion fleet_2] 119 2026-05-22 14:56:31.033 | INFO | Combat auto check timer reached 2026-05-22 14:57:27.100 | INFO | Click (1035, 671) @ GET_SHIP 2026-05-22 14:57:29.113 | INFO | Click (1024, 653) @ GET_SHIP 2026-05-22 14:57:31.105 | INFO | Screenshot interval set to 0.3s 2026-05-22 14:57:31.110 | INFO | Auto Search combat status 2026-05-22 14:57:31.114 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_4 ─────────────────────────────────────────────────────── 2026-05-22 14:57:31.120 | INFO | BATTLE_4 2026-05-22 14:57:31.126 | INFO | Auto search moving 2026-05-22 14:57:31.131 | INFO | Fleet: 1, fleet_current_index: 1 2026-05-22 14:57:31.215 | INFO | [OCR_OIL 0.078s] 18136 2026-05-22 14:57:31.331 | INFO | [OCR_COIN 0.113s] 102624 2026-05-22 14:57:35.620 | INFO | [Loading] 5% 2026-05-22 14:57:35.623 | INFO | Auto search combat loading 2026-05-22 14:57:35.627 | INFO | Screenshot interval set to 1.0s 2026-05-22 14:57:41.624 | INFO | [BattleUI] PAUSE 2026-05-22 14:57:41.628 | INFO | Auto Search combat execute 2026-05-22 14:57:41.630 | INFO | <<< EMOTION REDUCE >>> 2026-05-22 14:57:41.643 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-05-22 14:57:41.648 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=43, Main.Emotion.Fleet1Record=datetime.datetime(2026, 5, 22, 14, 57, 41), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 5, 22, 14, 57, 41) 2026-05-22 14:57:41.669 | INFO | [Emotion fleet_1] 43 2026-05-22 14:57:41.673 | INFO | [Emotion fleet_2] 119 2026-05-22 14:57:47.619 | INFO | Combat auto check timer reached 2026-05-22 14:58:41.682 | INFO | Click (1023, 659) @ GET_SHIP 2026-05-22 14:58:43.695 | INFO | Click (1035, 667) @ GET_SHIP 2026-05-22 14:58:45.694 | INFO | Screenshot interval set to 0.3s 2026-05-22 14:58:45.698 | INFO | Auto Search combat status 2026-05-22 14:58:45.703 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_5 ─────────────────────────────────────────────────────── 2026-05-22 14:58:45.708 | INFO | BATTLE_5 2026-05-22 14:58:45.711 | INFO | Auto search moving 2026-05-22 14:58:45.716 | INFO | Fleet: 1, fleet_current_index: 1 2026-05-22 14:58:45.819 | INFO | [OCR_OIL 0.099s] 18117 2026-05-22 14:58:45.910 | INFO | [OCR_COIN 0.087s] 102646 2026-05-22 14:58:47.497 | INFO | [Loading] 4% 2026-05-22 14:58:47.500 | INFO | Auto search combat loading 2026-05-22 14:58:47.503 | INFO | Screenshot interval set to 1.0s 2026-05-22 14:58:53.508 | INFO | [BattleUI] PAUSE 2026-05-22 14:58:53.513 | INFO | Auto Search combat execute 2026-05-22 14:58:53.516 | INFO | <<< EMOTION REDUCE >>> 2026-05-22 14:58:53.531 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-05-22 14:58:53.535 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=41, Main.Emotion.Fleet1Record=datetime.datetime(2026, 5, 22, 14, 58, 53), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 5, 22, 14, 58, 53) 2026-05-22 14:58:53.556 | INFO | [Emotion fleet_1] 41 2026-05-22 14:58:53.561 | INFO | [Emotion fleet_2] 119 2026-05-22 14:58:59.503 | INFO | Combat auto check timer reached 2026-05-22 15:00:07.562 | INFO | Click (1028, 659) @ GET_SHIP 2026-05-22 15:03:07.712 | INFO | Function calls: threading.py L890 _bootstrap() threading.py L926 _bootstrap_inner() threading.py L870 run() threadbased.py L254 run() output.py L801 click_callback() app.py L457 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 L570 loop() alas.py L70 run() alas.py L367 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-22 15:03:07.728 | WARNING | Wait too long 2026-05-22 15:03:07.734 | 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-22 15:03:07.811 | INFO | [Package_name] com.bilibili.azurlane 2026-05-22 15:03:07.816 | ERROR | GameStuckError: Wait too long 2026-05-22 15:03:07.821 | WARNING | Saving error: ./log/error/1779433387821