═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ MAIN ═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ ════════════════════════════════════════════════════ CAMPAIGN_13_1 ════════════════════════════════════════════════════ 2026-01-26 13:54:00.963 | INFO | CAMPAIGN_13_1 2026-01-26 13:54:00.965 | INFO | Count: 0 2026-01-26 13:54:00.982 | INFO | <<< UI ENSURE >>> 2026-01-26 13:54:00.985 | INFO | UI get current page 2026-01-26 13:54:01.047 | INFO | [UI] page_commission 2026-01-26 13:54:01.051 | INFO | Goto page_campaign 2026-01-26 13:54:01.054 | INFO | <<< UI GOTO PAGE_CAMPAIGN >>> 2026-01-26 13:54:01.096 | INFO | Page switch: page_commission -> page_main 2026-01-26 13:54:01.099 | INFO | Click (1246, 40) @ GOTO_MAIN 2026-01-26 13:54:02.157 | INFO | Page switch: page_main_white -> page_campaign_menu 2026-01-26 13:54:02.164 | INFO | Click (1175, 524) @ MAIN_GOTO_CAMPAIGN_WHITE 2026-01-26 13:54:02.749 | INFO | Page switch: page_campaign_menu -> page_campaign 2026-01-26 13:54:02.753 | INFO | Click ( 434, 369) @ CAMPAIGN_MENU_GOTO_CAMPAIGN 2026-01-26 13:54:03.047 | INFO | Page arrive: page_campaign 2026-01-26 13:54:03.075 | INFO | Mode_switch_1 set to hard 2026-01-26 13:54:03.102 | INFO | [Mode_switch_1] hard 2026-01-26 13:54:03.105 | INFO | <<< UI ENSURE INDEX >>> 2026-01-26 13:54:03.198 | INFO | No stage found. 2026-01-26 13:54:03.424 | INFO | No stage found. 2026-01-26 13:54:03.778 | INFO | No stage found. 2026-01-26 13:54:04.101 | INFO | [campaign 0.076s] ['13--1', '13--3', '13--2', '13--4'] 2026-01-26 13:54:04.105 | INFO | [Chapter] 13 2026-01-26 13:54:04.107 | INFO | [Stage] 13-1, 13-3, 13-2, 13-4 2026-01-26 13:54:04.112 | INFO | [Index] 13 2026-01-26 13:54:04.262 | INFO | [OCR_OIL 0.120s] 3028 ──────────────────────────────────────────────────────── 13-1 ───────────────────────────────────────────────────────── 2026-01-26 13:54:04.271 | INFO | 13-1 2026-01-26 13:54:04.277 | INFO | Expect emotion reduce: (12, 2) 2026-01-26 13:54:04.292 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-01-26 13:54:04.301 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=53, Main.Emotion.Fleet1Record=datetime.datetime(2026, 1, 26, 13, 54, 4), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 1, 26, 13, 54, 4) 2026-01-26 13:54:04.319 | INFO | [Emotion fleet_1] 53 2026-01-26 13:54:04.322 | INFO | [Emotion fleet_2] 119 2026-01-26 13:54:04.327 | INFO | <<< ENTER MAP >>> 2026-01-26 13:54:04.426 | INFO | Click ( 194, 289) @ 13-1 2026-01-26 13:54:04.880 | INFO | [Map_clear_percentage] 6% 2026-01-26 13:54:05.173 | INFO | [Map_clear_percentage] 66% 2026-01-26 13:54:05.476 | INFO | [Map_clear_percentage] 99% 2026-01-26 13:54:05.514 | INFO | [MAP_CLEAR_ALL_THIS_TIME] False 2026-01-26 13:54:05.521 | INFO | [Map_info] 99%, star_1, star_2, star_3, 100_percent_clear, 3_stars, threat_safe, clear_mode 2026-01-26 13:54:05.527 | INFO | [StopCondition_MapAchievement] non_stop 2026-01-26 13:54:05.534 | INFO | Fast_Forward set to on 2026-01-26 13:54:05.545 | INFO | [Fast_Forward] on 2026-01-26 13:54:05.567 | INFO | Auto_Search set to on 2026-01-26 13:54:05.574 | INFO | [Auto_Search] on 2026-01-26 13:54:05.584 | INFO | Click ( 954, 514) @ MAP_PREPARATION 2026-01-26 13:54:06.114 | INFO | Handling 2x book setting, mode=prep. 2026-01-26 13:54:06.147 | INFO | Using fleet: [4, 3, 1] 2026-01-26 13:54:06.240 | INFO | Hard satisfied: Fleet_1: None, Fleet_2: None, Submarine: None 2026-01-26 13:54:06.253 | INFO | [map_allow_submarine] True 2026-01-26 13:54:06.260 | INFO | Click (1149, 334) @ FLEET_2_CLEAR 2026-01-26 13:54:06.317 | INFO | Click (1061, 482) @ SUBMARINE_CHOOSE 2026-01-26 13:54:06.790 | INFO | Current selected: [1] 2026-01-26 13:54:06.797 | INFO | Click (1064, 463) @ SUBMARINE_CHOOSE 2026-01-26 13:54:07.087 | INFO | Click (1068, 229) @ FLEET_1_CHOOSE 2026-01-26 13:54:07.450 | INFO | Current selected: [4] 2026-01-26 13:54:07.456 | INFO | Click (1058, 211) @ FLEET_1_CHOOSE 2026-01-26 13:54:07.685 | INFO | Click (1066, 316) @ FLEET_2_CHOOSE 2026-01-26 13:54:07.956 | INFO | Current selected: [4] 2026-01-26 13:54:07.966 | INFO | Click (1107, 480) @ FLEET_2_BAR_INDEX_3 2026-01-26 13:54:08.271 | INFO | Auto search setting 2026-01-26 13:54:08.303 | INFO | [_fleet_sidebar_offset] 0 2026-01-26 13:54:08.316 | INFO | [Fleet_sidebar] 1/3 2026-01-26 13:54:08.325 | INFO | Click (1209, 446) @ FLEET_SIDEBAR_0_2 2026-01-26 13:54:08.863 | INFO | [_fleet_sidebar_offset] 0 2026-01-26 13:54:08.871 | INFO | [Fleet_sidebar] 3/3 2026-01-26 13:54:08.877 | INFO | [Auto_Search_Setting] fleet1_all_fleet2_standby, sub_standby 2026-01-26 13:54:08.884 | INFO | Click ( 503, 216) @ AUTO_SEARCH_SET_MOB 2026-01-26 13:54:09.407 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_standby 2026-01-26 13:54:09.414 | INFO | Selected to the correct auto search setting 2026-01-26 13:54:09.419 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_standby 2026-01-26 13:54:09.426 | INFO | Selected to the correct auto search setting 2026-01-26 13:54:09.430 | INFO | Click (1079, 573) @ FLEET_PREPARATION 2026-01-26 13:54:10.316 | INFO | is_auto_search_running appeared ────────────────────────────────────────────────────── BATTLE_0 ─────────────────────────────────────────────────────── 2026-01-26 13:54:10.325 | INFO | BATTLE_0 2026-01-26 13:54:10.330 | INFO | Auto search moving 2026-01-26 13:54:10.352 | INFO | Fleet: 1, fleet_current_index: 1 2026-01-26 13:54:10.447 | INFO | [OCR_OIL 0.085s] 3018 2026-01-26 13:54:10.588 | INFO | [OCR_COIN 0.135s] 118418 2026-01-26 13:54:14.837 | INFO | [Loading] 10% 2026-01-26 13:54:14.841 | INFO | Auto search combat loading 2026-01-26 13:54:14.845 | INFO | Screenshot interval set to 1.0s 2026-01-26 13:54:20.838 | INFO | [BattleUI] PAUSE 2026-01-26 13:54:20.843 | INFO | Auto Search combat execute 2026-01-26 13:54:20.846 | INFO | <<< EMOTION REDUCE >>> 2026-01-26 13:54:20.863 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-01-26 13:54:20.883 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=51, Main.Emotion.Fleet1Record=datetime.datetime(2026, 1, 26, 13, 54, 20), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 1, 26, 13, 54, 20) 2026-01-26 13:54:20.912 | INFO | [Emotion fleet_1] 51 2026-01-26 13:54:20.923 | INFO | [Emotion fleet_2] 119 2026-01-26 13:54:25.916 | INFO | Combat auto check timer reached 2026-01-26 13:54:47.880 | INFO | Click (1039, 665) @ GET_SHIP 2026-01-26 13:54:48.896 | INFO | Click (1031, 658) @ GET_SHIP 2026-01-26 13:54:49.902 | INFO | Click (1041, 669) @ GET_SHIP 2026-01-26 13:54:50.883 | INFO | Screenshot interval set to 0.3s 2026-01-26 13:54:50.887 | INFO | Auto Search combat status 2026-01-26 13:54:50.895 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_1 ─────────────────────────────────────────────────────── 2026-01-26 13:54:50.907 | INFO | BATTLE_1 2026-01-26 13:54:50.913 | INFO | Auto search moving 2026-01-26 13:54:50.919 | INFO | Fleet: 1, fleet_current_index: 1 2026-01-26 13:54:51.043 | INFO | [OCR_OIL 0.121s] 2999 2026-01-26 13:54:51.182 | INFO | [OCR_COIN 0.131s] 118443 2026-01-26 13:54:54.881 | INFO | [Loading] 9% 2026-01-26 13:54:54.888 | INFO | Auto search combat loading 2026-01-26 13:54:54.894 | INFO | Screenshot interval set to 1.0s 2026-01-26 13:55:00.890 | INFO | [BattleUI] PAUSE 2026-01-26 13:55:00.893 | INFO | Auto Search combat execute 2026-01-26 13:55:00.896 | INFO | <<< EMOTION REDUCE >>> 2026-01-26 13:55:00.915 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-01-26 13:55:00.921 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=49, Main.Emotion.Fleet1Record=datetime.datetime(2026, 1, 26, 13, 55), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 1, 26, 13, 55) 2026-01-26 13:55:00.936 | INFO | [Emotion fleet_1] 49 2026-01-26 13:55:00.942 | INFO | [Emotion fleet_2] 119 2026-01-26 13:55:06.897 | INFO | Combat auto check timer reached 2026-01-26 13:55:46.967 | INFO | Click (1030, 686) @ GET_SHIP 2026-01-26 13:55:48.002 | INFO | Click (1018, 657) @ GET_SHIP 2026-01-26 13:55:49.956 | INFO | Click (1037, 657) @ GET_SHIP 2026-01-26 13:55:51.964 | INFO | Screenshot interval set to 0.3s 2026-01-26 13:55:51.969 | INFO | Auto Search combat status 2026-01-26 13:55:51.974 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_2 ─────────────────────────────────────────────────────── 2026-01-26 13:55:51.978 | INFO | BATTLE_2 2026-01-26 13:55:51.981 | INFO | Auto search moving 2026-01-26 13:55:51.986 | INFO | Fleet: 1, fleet_current_index: 1 2026-01-26 13:55:52.075 | INFO | [OCR_OIL 0.084s] 2980 2026-01-26 13:55:52.202 | INFO | [OCR_COIN 0.122s] 118453 2026-01-26 13:55:56.226 | INFO | [Loading] 10% 2026-01-26 13:55:56.230 | INFO | Auto search combat loading 2026-01-26 13:55:56.233 | INFO | Screenshot interval set to 1.0s 2026-01-26 13:56:02.245 | INFO | [BattleUI] PAUSE 2026-01-26 13:56:02.250 | INFO | Auto Search combat execute 2026-01-26 13:56:02.254 | INFO | <<< EMOTION REDUCE >>> 2026-01-26 13:56:02.272 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-01-26 13:56:02.280 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=47, Main.Emotion.Fleet1Record=datetime.datetime(2026, 1, 26, 13, 56, 2), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 1, 26, 13, 56, 2) 2026-01-26 13:56:02.313 | INFO | [Emotion fleet_1] 47 2026-01-26 13:56:02.322 | INFO | [Emotion fleet_2] 119 2026-01-26 13:56:07.257 | INFO | Combat auto check timer reached 2026-01-26 13:56:44.272 | INFO | Click (1033, 664) @ GET_SHIP 2026-01-26 13:56:45.287 | INFO | Click (1023, 647) @ GET_SHIP 2026-01-26 13:56:46.275 | INFO | Screenshot interval set to 0.3s 2026-01-26 13:56:46.279 | INFO | Auto Search combat status 2026-01-26 13:56:46.292 | INFO | Click (1035, 636) @ GET_SHIP 2026-01-26 13:56:47.483 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_3 ─────────────────────────────────────────────────────── 2026-01-26 13:56:47.494 | INFO | BATTLE_3 2026-01-26 13:56:47.508 | INFO | Auto search moving 2026-01-26 13:56:47.526 | INFO | Fleet: 1, fleet_current_index: 1 2026-01-26 13:56:47.673 | INFO | [OCR_OIL 0.140s] 2961 2026-01-26 13:56:47.800 | INFO | [OCR_COIN 0.121s] 118466 2026-01-26 13:56:51.528 | INFO | [Loading] 11% 2026-01-26 13:56:51.533 | INFO | Auto search combat loading 2026-01-26 13:56:51.537 | INFO | Screenshot interval set to 1.0s 2026-01-26 13:56:57.589 | INFO | [BattleUI] PAUSE 2026-01-26 13:56:57.594 | INFO | Auto Search combat execute 2026-01-26 13:56:57.597 | INFO | <<< EMOTION REDUCE >>> 2026-01-26 13:56:57.612 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-01-26 13:56:57.615 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=45, Main.Emotion.Fleet1Record=datetime.datetime(2026, 1, 26, 13, 56, 57), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 1, 26, 13, 56, 57) 2026-01-26 13:56:57.635 | INFO | [Emotion fleet_1] 45 2026-01-26 13:56:57.643 | INFO | [Emotion fleet_2] 119 2026-01-26 13:57:03.522 | INFO | Combat auto check timer reached 2026-01-26 13:57:59.594 | INFO | Click (1030, 675) @ GET_SHIP 2026-01-26 13:58:00.601 | INFO | Click (1033, 651) @ GET_SHIP 2026-01-26 13:58:02.591 | INFO | Click (1026, 655) @ GET_SHIP 2026-01-26 13:58:03.603 | INFO | Click (1048, 674) @ GET_SHIP 2026-01-26 13:58:05.592 | INFO | Screenshot interval set to 0.3s 2026-01-26 13:58:05.598 | INFO | Auto Search combat status 2026-01-26 13:58:05.603 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_4 ─────────────────────────────────────────────────────── 2026-01-26 13:58:05.616 | INFO | BATTLE_4 2026-01-26 13:58:05.627 | INFO | Auto search moving 2026-01-26 13:58:05.641 | INFO | Fleet: 1, fleet_current_index: 1 2026-01-26 13:58:05.733 | INFO | [OCR_OIL 0.083s] 2942 2026-01-26 13:58:05.862 | INFO | [OCR_COIN 0.120s] 118480 2026-01-26 13:58:09.875 | INFO | [Loading] 14% 2026-01-26 13:58:09.880 | INFO | Auto search combat loading 2026-01-26 13:58:09.885 | INFO | Screenshot interval set to 1.0s 2026-01-26 13:58:15.877 | INFO | [BattleUI] PAUSE 2026-01-26 13:58:15.884 | INFO | Auto Search combat execute 2026-01-26 13:58:15.887 | INFO | <<< EMOTION REDUCE >>> 2026-01-26 13:58:15.902 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-01-26 13:58:15.915 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=43, Main.Emotion.Fleet1Record=datetime.datetime(2026, 1, 26, 13, 58, 15), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 1, 26, 13, 58, 15) 2026-01-26 13:58:15.938 | INFO | [Emotion fleet_1] 43 2026-01-26 13:58:15.949 | INFO | [Emotion fleet_2] 119 2026-01-26 13:58:20.903 | INFO | Combat auto check timer reached 2026-01-26 13:59:00.932 | INFO | Screenshot interval set to 0.3s 2026-01-26 13:59:00.938 | INFO | Auto Search combat status 2026-01-26 13:59:01.541 | INFO | Click (1027, 647) @ GET_SHIP 2026-01-26 13:59:02.746 | INFO | Click (1024, 651) @ GET_SHIP 2026-01-26 13:59:03.929 | INFO | Click (1027, 676) @ GET_SHIP 2026-01-26 13:59:05.143 | INFO | Click (1027, 670) @ GET_SHIP 2026-01-26 13:59:06.339 | INFO | Click (1005, 653) @ GET_SHIP 2026-01-26 13:59:07.522 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_5 ─────────────────────────────────────────────────────── 2026-01-26 13:59:07.527 | INFO | BATTLE_5 2026-01-26 13:59:07.530 | INFO | Auto search moving 2026-01-26 13:59:07.534 | INFO | Fleet: 1, fleet_current_index: 1 2026-01-26 13:59:07.671 | INFO | [OCR_OIL 0.133s] 2923 2026-01-26 13:59:07.810 | INFO | [OCR_COIN 0.133s] 118501 2026-01-26 13:59:09.731 | INFO | [Loading] 5% 2026-01-26 13:59:09.741 | INFO | Auto search combat loading 2026-01-26 13:59:09.751 | INFO | Screenshot interval set to 1.0s 2026-01-26 13:59:15.726 | INFO | [BattleUI] PAUSE 2026-01-26 13:59:15.731 | INFO | Auto Search combat execute 2026-01-26 13:59:15.733 | INFO | <<< EMOTION REDUCE >>> 2026-01-26 13:59:15.746 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-01-26 13:59:15.750 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=41, Main.Emotion.Fleet1Record=datetime.datetime(2026, 1, 26, 13, 59, 15), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 1, 26, 13, 59, 15) 2026-01-26 13:59:15.765 | INFO | [Emotion fleet_1] 41 2026-01-26 13:59:15.770 | INFO | [Emotion fleet_2] 119 2026-01-26 13:59:21.725 | INFO | Combat auto check timer reached 2026-01-26 14:00:20.794 | INFO | Click (1024, 663) @ GET_SHIP 2026-01-26 14:03:20.938 | 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-26 14:03:20.957 | WARNING | Wait too long 2026-01-26 14:03:20.961 | 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-26 14:03:21.032 | INFO | [Package_name] com.bilibili.azurlane 2026-01-26 14:03:21.036 | ERROR | GameStuckError: Wait too long 2026-01-26 14:03:21.042 | WARNING | Saving error: ./log/error/1769407401042