═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ MAIN ═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ ════════════════════════════════════════════════════ CAMPAIGN_13_1 ════════════════════════════════════════════════════ 2026-09-15 18:18:42.200 | INFO | CAMPAIGN_13_1 2026-09-15 18:18:42.203 | INFO | Count: 0 2026-09-15 18:18:42.220 | INFO | <<< UI ENSURE >>> 2026-09-15 18:18:42.225 | INFO | UI get current page 2026-09-15 18:18:42.241 | INFO | [UI] page_main 2026-09-15 18:18:42.243 | INFO | Goto page_campaign 2026-09-15 18:18:42.248 | INFO | <<< UI GOTO PAGE_CAMPAIGN >>> 2026-09-15 18:18:42.265 | INFO | Page switch: page_main_white -> page_campaign_menu 2026-09-15 18:18:42.269 | INFO | Click (1217, 521) @ MAIN_GOTO_CAMPAIGN_WHITE 2026-09-15 18:18:42.784 | INFO | Page switch: page_campaign_menu -> page_campaign 2026-09-15 18:18:42.788 | INFO | Click ( 389, 279) @ CAMPAIGN_MENU_GOTO_CAMPAIGN 2026-09-15 18:18:43.386 | INFO | Page arrive: page_campaign 2026-09-15 18:18:43.413 | INFO | Mode_switch_1 set to hard 2026-09-15 18:18:43.439 | INFO | [Mode_switch_1] hard 2026-09-15 18:18:43.444 | INFO | <<< UI ENSURE INDEX >>> 2026-09-15 18:18:43.515 | INFO | No stage found. 2026-09-15 18:18:43.742 | INFO | No stage found. 2026-09-15 18:18:44.093 | INFO | [campaign 0.052s] ['13--1', '13--3', '13--2', '13--4'] 2026-09-15 18:18:44.096 | INFO | [Chapter] 13 2026-09-15 18:18:44.098 | INFO | [Stage] 13-1, 13-3, 13-2, 13-4 2026-09-15 18:18:44.100 | INFO | [Index] 13 2026-09-15 18:18:44.164 | INFO | [OCR_OIL 0.036s] 22426 ──────────────────────────────────────────────────────── 13-1 ───────────────────────────────────────────────────────── 2026-09-15 18:18:44.168 | INFO | 13-1 2026-09-15 18:18:44.173 | INFO | Expect emotion reduce: (12, 2) 2026-09-15 18:18:44.187 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-09-15 18:18:44.190 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=53, Main.Emotion.Fleet1Record=datetime.datetime(2026, 9, 15, 18, 18, 44), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 9, 15, 18, 18, 44) 2026-09-15 18:18:44.228 | INFO | [Emotion fleet_1] 53 2026-09-15 18:18:44.231 | INFO | [Emotion fleet_2] 119 2026-09-15 18:18:44.233 | INFO | <<< ENTER MAP >>> 2026-09-15 18:18:44.288 | INFO | Click ( 189, 270) @ 13-1 2026-09-15 18:18:44.691 | INFO | [Map_clear_percentage] 10% 2026-09-15 18:18:44.990 | INFO | [Map_clear_percentage] 66% 2026-09-15 18:18:45.290 | INFO | [Map_clear_percentage] 99% 2026-09-15 18:18:45.317 | INFO | [MAP_CLEAR_ALL_THIS_TIME] False 2026-09-15 18:18:45.320 | INFO | [Map_info] 99%, star_1, star_2, star_3, 100_percent_clear, 3_stars, threat_safe, clear_mode 2026-09-15 18:18:45.323 | INFO | [StopCondition_MapAchievement] non_stop 2026-09-15 18:18:45.325 | INFO | Clear_Mode set to on 2026-09-15 18:18:45.330 | INFO | [Clear_Mode] on 2026-09-15 18:18:45.343 | INFO | Auto_Search set to on 2026-09-15 18:18:45.348 | INFO | [Auto_Search] on 2026-09-15 18:18:45.353 | INFO | Click (1002, 509) @ MAP_PREPARATION 2026-09-15 18:18:45.594 | INFO | Handling 2x book setting, mode=prep. 2026-09-15 18:18:45.617 | INFO | Using fleet: [4, 3, 1] 2026-09-15 18:18:45.692 | INFO | Hard satisfied: Fleet_1: None, Fleet_2: None, Submarine: None 2026-09-15 18:18:45.702 | INFO | [map_allow_submarine] True 2026-09-15 18:18:45.707 | INFO | Click (1150, 329) @ FLEET_2_CLEAR 2026-09-15 18:18:45.763 | INFO | Click (1049, 481) @ SUBMARINE_CHOOSE 2026-09-15 18:18:45.886 | INFO | Current selected: [1] 2026-09-15 18:18:45.890 | INFO | Click (1048, 474) @ SUBMARINE_CHOOSE 2026-09-15 18:18:46.192 | INFO | Click (1058, 226) @ FLEET_1_CHOOSE 2026-09-15 18:18:46.491 | INFO | Current selected: [4] 2026-09-15 18:18:46.495 | INFO | Click (1052, 223) @ FLEET_1_CHOOSE 2026-09-15 18:18:46.790 | INFO | Click (1057, 345) @ FLEET_2_CHOOSE 2026-09-15 18:18:47.088 | INFO | Current selected: [4] 2026-09-15 18:18:47.092 | INFO | Click (1097, 479) @ FLEET_2_BAR_INDEX_3 2026-09-15 18:18:47.387 | INFO | Auto search setting 2026-09-15 18:18:47.403 | INFO | [_fleet_sidebar_offset] 0 2026-09-15 18:18:47.409 | INFO | [_fleet_sidebar_offset] 0 2026-09-15 18:18:47.414 | INFO | [Fleet_sidebar] 1/3 2026-09-15 18:18:47.418 | INFO | Click (1229, 409) @ FLEET_SIDEBAR_0_2 2026-09-15 18:18:47.693 | INFO | [_fleet_sidebar_offset] 0 2026-09-15 18:18:47.697 | INFO | [Fleet_sidebar] 3/3 2026-09-15 18:18:47.700 | INFO | [Auto_Search_Setting] fleet1_all_fleet2_standby, sub_standby 2026-09-15 18:18:47.703 | INFO | Click ( 497, 225) @ AUTO_SEARCH_SET_MOB 2026-09-15 18:18:48.158 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_standby 2026-09-15 18:18:48.161 | INFO | Selected to the correct auto search setting 2026-09-15 18:18:48.165 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_standby 2026-09-15 18:18:48.168 | INFO | Selected to the correct auto search setting 2026-09-15 18:18:48.170 | INFO | Click (1094, 567) @ FLEET_PREPARATION 2026-09-15 18:18:49.075 | INFO | is_auto_search_running appeared ────────────────────────────────────────────────────── BATTLE_0 ─────────────────────────────────────────────────────── 2026-09-15 18:18:49.080 | INFO | BATTLE_0 2026-09-15 18:18:49.083 | INFO | Auto search moving 2026-09-15 18:18:49.095 | INFO | Fleet: 1, fleet_current_index: 1 2026-09-15 18:18:49.152 | INFO | [OCR_OIL 0.052s] 22416 2026-09-15 18:18:49.251 | INFO | [OCR_COIN 0.096s] 17895 2026-09-15 18:18:53.482 | INFO | [Loading] 7% 2026-09-15 18:18:53.485 | INFO | Auto search combat loading 2026-09-15 18:18:53.491 | INFO | Screenshot interval set to 1.0s 2026-09-15 18:18:59.483 | INFO | [BattleUI] PAUSE 2026-09-15 18:18:59.487 | INFO | Auto Search combat execute 2026-09-15 18:18:59.490 | INFO | <<< EMOTION REDUCE >>> 2026-09-15 18:18:59.507 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-09-15 18:18:59.511 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=51, Main.Emotion.Fleet1Record=datetime.datetime(2026, 9, 15, 18, 18, 59), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 9, 15, 18, 18, 59) 2026-09-15 18:18:59.528 | INFO | [Emotion fleet_1] 51 2026-09-15 18:18:59.531 | INFO | [Emotion fleet_2] 119 2026-09-15 18:19:04.498 | INFO | Combat auto check timer reached 2026-09-15 18:19:37.522 | INFO | Click (1041, 649) @ GET_SHIP 2026-09-15 18:19:39.539 | INFO | Click (1025, 649) @ GET_SHIP 2026-09-15 18:19:41.528 | INFO | Click (1030, 676) @ GET_SHIP 2026-09-15 18:19:42.537 | INFO | Click (1018, 661) @ GET_SHIP 2026-09-15 18:19:44.546 | INFO | Screenshot interval set to 0.3s 2026-09-15 18:19:44.549 | INFO | Auto Search combat status 2026-09-15 18:19:44.553 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_1 ─────────────────────────────────────────────────────── 2026-09-15 18:19:44.560 | INFO | BATTLE_1 2026-09-15 18:19:44.564 | INFO | Auto search moving 2026-09-15 18:19:44.570 | INFO | Fleet: 1, fleet_current_index: 1 2026-09-15 18:19:44.631 | INFO | [OCR_OIL 0.056s] 22397 2026-09-15 18:19:44.719 | INFO | [OCR_COIN 0.084s] 17905 2026-09-15 18:19:49.624 | INFO | [Loading] 12% 2026-09-15 18:19:49.627 | INFO | Auto search combat loading 2026-09-15 18:19:49.629 | INFO | Screenshot interval set to 1.0s 2026-09-15 18:19:55.642 | INFO | [BattleUI] PAUSE 2026-09-15 18:19:55.646 | INFO | Auto Search combat execute 2026-09-15 18:19:55.649 | INFO | <<< EMOTION REDUCE >>> 2026-09-15 18:19:55.661 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-09-15 18:19:55.667 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=49, Main.Emotion.Fleet1Record=datetime.datetime(2026, 9, 15, 18, 19, 55), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 9, 15, 18, 19, 55) 2026-09-15 18:19:55.687 | INFO | [Emotion fleet_1] 49 2026-09-15 18:19:55.692 | INFO | [Emotion fleet_2] 119 2026-09-15 18:20:01.627 | INFO | Combat auto check timer reached 2026-09-15 18:20:20.657 | INFO | Screenshot interval set to 0.3s 2026-09-15 18:20:20.661 | INFO | Auto Search combat status 2026-09-15 18:20:21.549 | INFO | Click (1031, 653) @ GET_SHIP 2026-09-15 18:20:22.750 | INFO | Click (1033, 676) @ GET_SHIP 2026-09-15 18:20:23.955 | INFO | Click (1031, 684) @ GET_SHIP 2026-09-15 18:20:25.745 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_2 ─────────────────────────────────────────────────────── 2026-09-15 18:20:25.750 | INFO | BATTLE_2 2026-09-15 18:20:25.752 | INFO | Auto search moving 2026-09-15 18:20:25.755 | INFO | Fleet: 1, fleet_current_index: 1 2026-09-15 18:20:25.823 | INFO | [OCR_OIL 0.065s] 22378 2026-09-15 18:20:25.880 | INFO | [OCR_COIN 0.050s] 17921 2026-09-15 18:20:30.555 | INFO | [Loading] 13% 2026-09-15 18:20:30.559 | INFO | Auto search combat loading 2026-09-15 18:20:30.562 | INFO | Screenshot interval set to 1.0s 2026-09-15 18:20:35.555 | INFO | [BattleUI] PAUSE 2026-09-15 18:20:35.560 | INFO | Auto Search combat execute 2026-09-15 18:20:35.563 | INFO | <<< EMOTION REDUCE >>> 2026-09-15 18:20:35.575 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-09-15 18:20:35.578 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=47, Main.Emotion.Fleet1Record=datetime.datetime(2026, 9, 15, 18, 20, 35), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 9, 15, 18, 20, 35) 2026-09-15 18:20:35.593 | INFO | [Emotion fleet_1] 47 2026-09-15 18:20:35.597 | INFO | [Emotion fleet_2] 119 2026-09-15 18:20:40.571 | INFO | Combat auto check timer reached 2026-09-15 18:21:20.606 | INFO | Click (1040, 655) @ GET_SHIP 2026-09-15 18:21:21.622 | INFO | Click (1025, 668) @ GET_SHIP 2026-09-15 18:21:23.608 | INFO | Click (1013, 652) @ GET_SHIP 2026-09-15 18:21:24.611 | INFO | Click (1033, 675) @ GET_SHIP 2026-09-15 18:21:26.616 | INFO | Screenshot interval set to 0.3s 2026-09-15 18:21:26.620 | INFO | Auto Search combat status 2026-09-15 18:21:26.623 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_3 ─────────────────────────────────────────────────────── 2026-09-15 18:21:26.629 | INFO | BATTLE_3 2026-09-15 18:21:26.634 | INFO | Auto search moving 2026-09-15 18:21:26.642 | INFO | Fleet: 1, fleet_current_index: 1 2026-09-15 18:21:26.730 | INFO | [OCR_OIL 0.085s] 22359 2026-09-15 18:21:26.807 | INFO | [OCR_COIN 0.073s] 17937 2026-09-15 18:21:30.805 | INFO | [Loading] 10% 2026-09-15 18:21:30.809 | INFO | Auto search combat loading 2026-09-15 18:21:30.811 | INFO | Screenshot interval set to 1.0s 2026-09-15 18:21:36.818 | INFO | [BattleUI] PAUSE 2026-09-15 18:21:36.822 | INFO | Auto Search combat execute 2026-09-15 18:21:36.826 | INFO | <<< EMOTION REDUCE >>> 2026-09-15 18:21:36.840 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-09-15 18:21:36.846 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=45, Main.Emotion.Fleet1Record=datetime.datetime(2026, 9, 15, 18, 21, 36), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 9, 15, 18, 21, 36) 2026-09-15 18:21:36.868 | INFO | [Emotion fleet_1] 45 2026-09-15 18:21:36.872 | INFO | [Emotion fleet_2] 119 2026-09-15 18:21:42.814 | INFO | Combat auto check timer reached 2026-09-15 18:22:19.861 | INFO | Click (1026, 652) @ GET_SHIP 2026-09-15 18:22:20.862 | INFO | Click (1041, 650) @ GET_SHIP 2026-09-15 18:22:22.864 | INFO | Click (1020, 677) @ GET_SHIP 2026-09-15 18:22:23.863 | INFO | Screenshot interval set to 0.3s 2026-09-15 18:22:23.868 | INFO | Auto Search combat status 2026-09-15 18:22:23.880 | INFO | Click (1026, 674) @ GET_SHIP 2026-09-15 18:22:25.647 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_4 ─────────────────────────────────────────────────────── 2026-09-15 18:22:25.654 | INFO | BATTLE_4 2026-09-15 18:22:25.656 | INFO | Auto search moving 2026-09-15 18:22:25.660 | INFO | Fleet: 1, fleet_current_index: 1 2026-09-15 18:22:25.724 | INFO | [OCR_OIL 0.061s] 22340 2026-09-15 18:22:25.821 | INFO | [OCR_COIN 0.093s] 17950 2026-09-15 18:22:30.756 | INFO | [Loading] 11% 2026-09-15 18:22:30.760 | INFO | Auto search combat loading 2026-09-15 18:22:30.762 | INFO | Screenshot interval set to 1.0s 2026-09-15 18:22:36.765 | INFO | [BattleUI] PAUSE 2026-09-15 18:22:36.770 | INFO | Auto Search combat execute 2026-09-15 18:22:36.773 | INFO | <<< EMOTION REDUCE >>> 2026-09-15 18:22:36.786 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-09-15 18:22:36.789 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=43, Main.Emotion.Fleet1Record=datetime.datetime(2026, 9, 15, 18, 22, 36), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 9, 15, 18, 22, 36) 2026-09-15 18:22:36.806 | INFO | [Emotion fleet_1] 43 2026-09-15 18:22:36.809 | INFO | [Emotion fleet_2] 119 2026-09-15 18:22:42.757 | INFO | Combat auto check timer reached 2026-09-15 18:23:20.805 | INFO | Click (1027, 658) @ GET_SHIP 2026-09-15 18:23:21.811 | INFO | Click (1017, 653) @ GET_SHIP 2026-09-15 18:23:22.811 | INFO | Click (1011, 662) @ GET_SHIP 2026-09-15 18:23:23.819 | INFO | Click (1023, 670) @ GET_SHIP 2026-09-15 18:23:24.815 | INFO | Screenshot interval set to 0.3s 2026-09-15 18:23:24.819 | INFO | Auto Search combat status 2026-09-15 18:23:24.833 | INFO | Click (1016, 657) @ GET_SHIP 2026-09-15 18:23:26.592 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_5 ─────────────────────────────────────────────────────── 2026-09-15 18:23:26.598 | INFO | BATTLE_5 2026-09-15 18:23:26.601 | INFO | Auto search moving 2026-09-15 18:23:26.606 | INFO | Fleet: 1, fleet_current_index: 1 2026-09-15 18:23:26.658 | INFO | [OCR_OIL 0.047s] 22321 2026-09-15 18:23:26.726 | INFO | [OCR_COIN 0.064s] 17964 2026-09-15 18:23:29.615 | INFO | [Loading] 8% 2026-09-15 18:23:29.619 | INFO | Auto search combat loading 2026-09-15 18:23:29.621 | INFO | Screenshot interval set to 1.0s 2026-09-15 18:23:35.612 | INFO | [BattleUI] PAUSE 2026-09-15 18:23:35.615 | INFO | Auto Search combat execute 2026-09-15 18:23:35.620 | INFO | <<< EMOTION REDUCE >>> 2026-09-15 18:23:35.633 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-09-15 18:23:35.637 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=41, Main.Emotion.Fleet1Record=datetime.datetime(2026, 9, 15, 18, 23, 35), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 9, 15, 18, 23, 35) 2026-09-15 18:23:35.653 | INFO | [Emotion fleet_1] 41 2026-09-15 18:23:35.657 | INFO | [Emotion fleet_2] 119 2026-09-15 18:23:41.604 | INFO | Combat auto check timer reached 2026-09-15 18:24:29.666 | INFO | Click (1036, 683) @ GET_SHIP 2026-09-15 18:27:29.809 | 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 L602 loop() alas.py L70 run() alas.py L371 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-15 18:27:29.824 | WARNING | Wait too long 2026-09-15 18:27:29.827 | WARNING | Waiting for {'EXP_INFO_A', 'MISSION_POPUP_GO', 'EVENT_CHECK', 'EXP_INFO_B', 'GUILD_POPUP_CONFIRM', 'POPUP_CONFIRM_WHITE', 'GET_MISSION', 'BATTLE_STATUS_S', 'EXP_INFO_S', 'GET_SHIP', 'SP_CHECK', 'CAMPAIGN_CHECK', 'AUTO_SEARCH_MAP_OPTION_ON', 'PAUSE', 'POPUP_CANCEL', 'NEW_SHIP', 'BATTLE_STATUS_A', 'BATTLE_STATUS_B'} 2026-09-15 18:27:29.952 | INFO | [Package_name] com.bilibili.azurlane 2026-09-15 18:27:29.955 | ERROR | GameStuckError: Wait too long 2026-09-15 18:27:29.957 | WARNING | Saving error: ./log/error/1789468049957