═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ MAIN ═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ ════════════════════════════════════════════════════ CAMPAIGN_13_1 ════════════════════════════════════════════════════ 2026-01-25 19:20:53.616 | INFO | CAMPAIGN_13_1 2026-01-25 19:20:53.621 | INFO | Count: 0 2026-01-25 19:20:53.638 | INFO | <<< UI ENSURE >>> 2026-01-25 19:20:53.649 | INFO | UI get current page 2026-01-25 19:20:53.714 | INFO | [UI] page_coalition 2026-01-25 19:20:53.719 | INFO | Goto page_campaign 2026-01-25 19:20:53.725 | INFO | <<< UI GOTO PAGE_CAMPAIGN >>> 2026-01-25 19:20:53.758 | INFO | Page switch: page_coalition -> page_campaign_menu 2026-01-25 19:20:53.762 | INFO | Click ( 61, 46) @ BACK_ARROW 2026-01-25 19:20:54.175 | INFO | Page switch: page_campaign_menu -> page_campaign 2026-01-25 19:20:54.180 | INFO | Click ( 312, 347) @ CAMPAIGN_MENU_GOTO_CAMPAIGN 2026-01-25 19:20:54.516 | INFO | Page arrive: page_campaign 2026-01-25 19:20:54.553 | INFO | Mode_switch_1 set to hard 2026-01-25 19:20:54.587 | INFO | [Mode_switch_1] hard 2026-01-25 19:20:54.595 | INFO | <<< UI ENSURE INDEX >>> 2026-01-25 19:20:54.686 | INFO | No stage found. 2026-01-25 19:20:54.923 | INFO | No stage found. 2026-01-25 19:20:55.291 | INFO | [campaign 0.071s] ['-1', '--3', '--2', '--4'] 2026-01-25 19:20:55.563 | INFO | [campaign 0.111s] ['13--1', '13--3', '13--2', '13--4'] 2026-01-25 19:20:55.568 | INFO | [Chapter] 13 2026-01-25 19:20:55.571 | INFO | [Stage] 13-1, 13-3, 13-2, 13-4 2026-01-25 19:20:55.574 | INFO | [Index] 13 2026-01-25 19:20:55.682 | INFO | [OCR_OIL 0.072s] 4943 ──────────────────────────────────────────────────────── 13-1 ───────────────────────────────────────────────────────── 2026-01-25 19:20:55.689 | INFO | 13-1 2026-01-25 19:20:55.692 | INFO | Expect emotion reduce: (12, 2) 2026-01-25 19:20:55.709 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-01-25 19:20:55.718 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=53, Main.Emotion.Fleet1Record=datetime.datetime(2026, 1, 25, 19, 20, 55), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 1, 25, 19, 20, 55) 2026-01-25 19:20:55.733 | INFO | [Emotion fleet_1] 53 2026-01-25 19:20:55.737 | INFO | [Emotion fleet_2] 119 2026-01-25 19:20:55.743 | INFO | <<< ENTER MAP >>> 2026-01-25 19:20:55.815 | INFO | Click ( 188, 279) @ 13-1 2026-01-25 19:20:56.292 | INFO | [Map_clear_percentage] 11% 2026-01-25 19:20:56.572 | INFO | [Map_clear_percentage] 71% 2026-01-25 19:20:56.836 | INFO | [Map_clear_percentage] 99% 2026-01-25 19:20:56.863 | INFO | [MAP_CLEAR_ALL_THIS_TIME] False 2026-01-25 19:20:56.873 | INFO | [Map_info] 99%, star_1, star_2, star_3, 100_percent_clear, 3_stars, threat_safe, clear_mode 2026-01-25 19:20:56.880 | INFO | [StopCondition_MapAchievement] non_stop 2026-01-25 19:20:56.887 | INFO | Fast_Forward set to on 2026-01-25 19:20:56.892 | INFO | [Fast_Forward] on 2026-01-25 19:20:56.909 | INFO | Auto_Search set to on 2026-01-25 19:20:56.913 | INFO | [Auto_Search] on 2026-01-25 19:20:56.917 | INFO | Click ( 968, 530) @ MAP_PREPARATION 2026-01-25 19:20:57.425 | INFO | Handling 2x book setting, mode=prep. 2026-01-25 19:20:57.448 | INFO | Using fleet: [4, 3, 1] 2026-01-25 19:20:57.531 | INFO | Hard satisfied: Fleet_1: None, Fleet_2: None, Submarine: None 2026-01-25 19:20:57.546 | INFO | [map_allow_submarine] True 2026-01-25 19:20:57.555 | INFO | Click (1144, 328) @ FLEET_2_CLEAR 2026-01-25 19:20:57.612 | INFO | Click (1059, 460) @ SUBMARINE_CHOOSE 2026-01-25 19:20:58.020 | INFO | Current selected: [1] 2026-01-25 19:20:58.025 | INFO | Click (1056, 462) @ SUBMARINE_CHOOSE 2026-01-25 19:20:58.335 | INFO | Click (1043, 217) @ FLEET_1_CHOOSE 2026-01-25 19:20:58.625 | INFO | Current selected: [4] 2026-01-25 19:20:58.631 | INFO | Click (1047, 219) @ FLEET_1_CHOOSE 2026-01-25 19:20:58.931 | INFO | Click (1063, 334) @ FLEET_2_CHOOSE 2026-01-25 19:20:59.234 | INFO | Current selected: [4] 2026-01-25 19:20:59.243 | INFO | Click (1076, 491) @ FLEET_2_BAR_INDEX_3 2026-01-25 19:20:59.542 | INFO | Auto search setting 2026-01-25 19:20:59.560 | INFO | [_fleet_sidebar_offset] 0 2026-01-25 19:20:59.581 | INFO | [Fleet_sidebar] 1/3 2026-01-25 19:20:59.594 | INFO | Click (1212, 457) @ FLEET_SIDEBAR_0_2 2026-01-25 19:21:00.159 | INFO | [_fleet_sidebar_offset] 0 2026-01-25 19:21:00.163 | INFO | [Fleet_sidebar] 3/3 2026-01-25 19:21:00.167 | INFO | [Auto_Search_Setting] fleet1_all_fleet2_standby, sub_standby 2026-01-25 19:21:00.172 | INFO | Click ( 504, 217) @ AUTO_SEARCH_SET_MOB 2026-01-25 19:21:00.674 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_standby 2026-01-25 19:21:00.678 | INFO | Selected to the correct auto search setting 2026-01-25 19:21:00.681 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_standby 2026-01-25 19:21:00.686 | INFO | Selected to the correct auto search setting 2026-01-25 19:21:00.691 | INFO | Click (1123, 583) @ FLEET_PREPARATION 2026-01-25 19:21:01.593 | INFO | is_auto_search_running appeared ────────────────────────────────────────────────────── BATTLE_0 ─────────────────────────────────────────────────────── 2026-01-25 19:21:01.599 | INFO | BATTLE_0 2026-01-25 19:21:01.601 | INFO | Auto search moving 2026-01-25 19:21:01.623 | INFO | Fleet: 1, fleet_current_index: 1 2026-01-25 19:21:01.712 | INFO | [OCR_OIL 0.083s] 4933 2026-01-25 19:21:01.823 | INFO | [OCR_COIN 0.107s] 62545 2026-01-25 19:21:06.929 | INFO | [Loading] 13% 2026-01-25 19:21:06.933 | INFO | Auto search combat loading 2026-01-25 19:21:06.936 | INFO | Screenshot interval set to 1.0s 2026-01-25 19:21:12.922 | INFO | [BattleUI] PAUSE 2026-01-25 19:21:12.927 | INFO | Auto Search combat execute 2026-01-25 19:21:12.942 | INFO | <<< EMOTION REDUCE >>> 2026-01-25 19:21:13.005 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-01-25 19:21:13.042 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=51, Main.Emotion.Fleet1Record=datetime.datetime(2026, 1, 25, 19, 21, 12), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 1, 25, 19, 21, 12) 2026-01-25 19:21:13.105 | INFO | [Emotion fleet_1] 51 2026-01-25 19:21:13.113 | INFO | [Emotion fleet_2] 119 2026-01-25 19:21:18.931 | INFO | Combat auto check timer reached 2026-01-25 19:22:12.987 | INFO | Click (1025, 672) @ GET_SHIP 2026-01-25 19:22:13.989 | INFO | Click (1020, 669) @ GET_SHIP 2026-01-25 19:22:14.994 | INFO | Click (1033, 657) @ GET_SHIP 2026-01-25 19:22:17.043 | INFO | Click (1008, 653) @ GET_SHIP 2026-01-25 19:22:19.001 | INFO | Screenshot interval set to 0.3s 2026-01-25 19:22:19.006 | INFO | Auto Search combat status 2026-01-25 19:22:19.012 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_1 ─────────────────────────────────────────────────────── 2026-01-25 19:22:19.021 | INFO | BATTLE_1 2026-01-25 19:22:19.024 | INFO | Auto search moving 2026-01-25 19:22:19.028 | INFO | Fleet: 1, fleet_current_index: 1 2026-01-25 19:22:19.124 | INFO | [OCR_OIL 0.090s] 4914 2026-01-25 19:22:19.200 | INFO | [OCR_COIN 0.072s] 62570 2026-01-25 19:22:23.214 | INFO | [Loading] 9% 2026-01-25 19:22:23.220 | INFO | Auto search combat loading 2026-01-25 19:22:23.224 | INFO | Screenshot interval set to 1.0s 2026-01-25 19:22:29.209 | INFO | [BattleUI] PAUSE 2026-01-25 19:22:29.213 | INFO | Auto Search combat execute 2026-01-25 19:22:29.216 | INFO | <<< EMOTION REDUCE >>> 2026-01-25 19:22:29.227 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-01-25 19:22:29.235 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=49, Main.Emotion.Fleet1Record=datetime.datetime(2026, 1, 25, 19, 22, 29), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 1, 25, 19, 22, 29) 2026-01-25 19:22:29.254 | INFO | [Emotion fleet_1] 49 2026-01-25 19:22:29.258 | INFO | [Emotion fleet_2] 119 2026-01-25 19:22:35.205 | INFO | Combat auto check timer reached 2026-01-25 19:23:28.265 | INFO | Screenshot interval set to 0.3s 2026-01-25 19:23:28.271 | INFO | Auto Search combat status 2026-01-25 19:23:29.491 | INFO | Click (1024, 658) @ GET_SHIP 2026-01-25 19:23:30.665 | INFO | Click (1022, 674) @ GET_SHIP 2026-01-25 19:23:31.859 | INFO | Click (1024, 659) @ GET_SHIP 2026-01-25 19:23:33.421 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_2 ─────────────────────────────────────────────────────── 2026-01-25 19:23:33.436 | INFO | BATTLE_2 2026-01-25 19:23:33.448 | INFO | Auto search moving 2026-01-25 19:23:33.463 | INFO | Fleet: 1, fleet_current_index: 1 2026-01-25 19:23:33.628 | INFO | [OCR_OIL 0.157s] 4895 2026-01-25 19:23:33.869 | INFO | [OCR_COIN 0.227s] 62585 2026-01-25 19:23:38.185 | INFO | [Loading] 8% 2026-01-25 19:23:38.191 | INFO | Auto search combat loading 2026-01-25 19:23:38.196 | INFO | Screenshot interval set to 1.0s 2026-01-25 19:23:44.195 | INFO | [BattleUI] PAUSE 2026-01-25 19:23:44.199 | INFO | Auto Search combat execute 2026-01-25 19:23:44.202 | INFO | <<< EMOTION REDUCE >>> 2026-01-25 19:23:44.228 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-01-25 19:23:44.237 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=47, Main.Emotion.Fleet1Record=datetime.datetime(2026, 1, 25, 19, 23, 44), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 1, 25, 19, 23, 44) 2026-01-25 19:23:44.273 | INFO | [Emotion fleet_1] 47 2026-01-25 19:23:44.281 | INFO | [Emotion fleet_2] 119 2026-01-25 19:23:50.179 | INFO | Combat auto check timer reached 2026-01-25 19:24:45.252 | INFO | Screenshot interval set to 0.3s 2026-01-25 19:24:45.256 | INFO | Auto Search combat status 2026-01-25 19:24:46.493 | INFO | Click (1033, 654) @ GET_SHIP 2026-01-25 19:24:47.653 | INFO | Click (1037, 663) @ GET_SHIP 2026-01-25 19:24:48.853 | INFO | Click (1024, 661) @ GET_SHIP 2026-01-25 19:24:50.395 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_3 ─────────────────────────────────────────────────────── 2026-01-25 19:24:50.409 | INFO | BATTLE_3 2026-01-25 19:24:50.420 | INFO | Auto search moving 2026-01-25 19:24:50.426 | INFO | Fleet: 1, fleet_current_index: 1 2026-01-25 19:24:50.569 | INFO | [OCR_OIL 0.127s] 4876 2026-01-25 19:24:50.747 | INFO | [OCR_COIN 0.164s] 62597 2026-01-25 19:24:55.054 | INFO | [Loading] 18% 2026-01-25 19:24:55.060 | INFO | Auto search combat loading 2026-01-25 19:24:55.063 | INFO | Screenshot interval set to 1.0s 2026-01-25 19:25:01.052 | INFO | [BattleUI] PAUSE 2026-01-25 19:25:01.060 | INFO | Auto Search combat execute 2026-01-25 19:25:01.067 | INFO | <<< EMOTION REDUCE >>> 2026-01-25 19:25:01.092 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-01-25 19:25:01.099 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=47, Main.Emotion.Fleet1Record=datetime.datetime(2026, 1, 25, 19, 25, 1), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 1, 25, 19, 25, 1) 2026-01-25 19:25:01.118 | INFO | [Emotion fleet_1] 47 2026-01-25 19:25:01.122 | INFO | [Emotion fleet_2] 119 2026-01-25 19:25:07.096 | INFO | Combat auto check timer reached 2026-01-25 19:25:36.094 | INFO | Click (1023, 644) @ GET_SHIP 2026-01-25 19:25:37.131 | INFO | Click (1024, 659) @ GET_SHIP 2026-01-25 19:25:39.096 | INFO | Click (1028, 658) @ GET_SHIP 2026-01-25 19:25:40.097 | INFO | Click (1009, 641) @ GET_SHIP 2026-01-25 19:25:42.103 | INFO | Screenshot interval set to 0.3s 2026-01-25 19:25:42.107 | INFO | Auto Search combat status 2026-01-25 19:25:42.110 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_4 ─────────────────────────────────────────────────────── 2026-01-25 19:25:42.115 | INFO | BATTLE_4 2026-01-25 19:25:42.118 | INFO | Auto search moving 2026-01-25 19:25:42.123 | INFO | Fleet: 1, fleet_current_index: 1 2026-01-25 19:25:42.210 | INFO | [OCR_OIL 0.082s] 4857 2026-01-25 19:25:42.380 | INFO | [OCR_COIN 0.166s] 62625 2026-01-25 19:25:45.530 | INFO | [Loading] 7% 2026-01-25 19:25:45.540 | INFO | Auto search combat loading 2026-01-25 19:25:45.546 | INFO | Screenshot interval set to 1.0s 2026-01-25 19:25:52.515 | INFO | [BattleUI] PAUSE 2026-01-25 19:25:52.521 | INFO | Auto Search combat execute 2026-01-25 19:25:52.525 | INFO | <<< EMOTION REDUCE >>> 2026-01-25 19:25:52.540 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-01-25 19:25:52.545 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=45, Main.Emotion.Fleet1Record=datetime.datetime(2026, 1, 25, 19, 25, 52), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 1, 25, 19, 25, 52) 2026-01-25 19:25:52.563 | INFO | [Emotion fleet_1] 45 2026-01-25 19:25:52.569 | INFO | [Emotion fleet_2] 119 2026-01-25 19:25:57.547 | INFO | Combat auto check timer reached 2026-01-25 19:26:36.567 | INFO | Click (1020, 667) @ GET_SHIP 2026-01-25 19:26:37.568 | INFO | Click (1022, 673) @ GET_SHIP 2026-01-25 19:26:38.579 | INFO | Click (1018, 663) @ GET_SHIP 2026-01-25 19:26:39.610 | INFO | Click (1014, 648) @ GET_SHIP 2026-01-25 19:26:41.569 | INFO | Screenshot interval set to 0.3s 2026-01-25 19:26:41.574 | INFO | Auto Search combat status 2026-01-25 19:26:41.578 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_5 ─────────────────────────────────────────────────────── 2026-01-25 19:26:41.588 | INFO | BATTLE_5 2026-01-25 19:26:41.593 | INFO | Auto search moving 2026-01-25 19:26:41.599 | INFO | Fleet: 1, fleet_current_index: 1 2026-01-25 19:26:41.698 | INFO | [OCR_OIL 0.092s] 4838 2026-01-25 19:26:41.786 | INFO | [OCR_COIN 0.082s] 62649 2026-01-25 19:26:43.976 | INFO | [Loading] 16% 2026-01-25 19:26:43.981 | INFO | Auto search combat loading 2026-01-25 19:26:43.985 | INFO | Screenshot interval set to 1.0s 2026-01-25 19:26:50.026 | INFO | [BattleUI] PAUSE 2026-01-25 19:26:50.031 | INFO | Auto Search combat execute 2026-01-25 19:26:50.034 | INFO | <<< EMOTION REDUCE >>> 2026-01-25 19:26:50.047 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-01-25 19:26:50.050 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=43, Main.Emotion.Fleet1Record=datetime.datetime(2026, 1, 25, 19, 26, 50), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 1, 25, 19, 26, 50) 2026-01-25 19:26:50.066 | INFO | [Emotion fleet_1] 43 2026-01-25 19:26:50.073 | INFO | [Emotion fleet_2] 119 2026-01-25 19:26:55.980 | INFO | Combat auto check timer reached 2026-01-25 19:27:55.060 | INFO | Click (1015, 651) @ GET_SHIP 2026-01-25 19:30:55.197 | 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 L437 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 L555 loop() alas.py L69 run() alas.py L352 main() run.py L426 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-01-25 19:30:55.218 | WARNING | Wait too long 2026-01-25 19:30:55.222 | WARNING | Waiting for {'MISSION_POPUP_GO', 'CAMPAIGN_CHECK', 'NEW_SHIP', 'SP_CHECK', 'PAUSE', 'EXP_INFO_S', 'AUTO_SEARCH_MAP_OPTION_ON', 'BATTLE_STATUS_S', 'POPUP_CANCEL', 'GET_MISSION', 'BATTLE_STATUS_A', 'POPUP_CONFIRM_WHITE', 'GET_SHIP', 'EVENT_CHECK', 'EXP_INFO_B', 'BATTLE_STATUS_B', 'EXP_INFO_A', 'GUILD_POPUP_CONFIRM'} 2026-01-25 19:30:55.299 | INFO | [Package_name] com.bilibili.azurlane 2026-01-25 19:30:55.303 | ERROR | GameStuckError: Wait too long 2026-01-25 19:30:55.308 | WARNING | Saving error: ./log/error/1769340655308