═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ MAIN ═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ ════════════════════════════════════════════════════ CAMPAIGN_13_1 ════════════════════════════════════════════════════ 2026-03-16 22:06:01.831 | INFO | CAMPAIGN_13_1 2026-03-16 22:06:01.833 | INFO | Count: 0 2026-03-16 22:06:01.850 | INFO | <<< UI ENSURE >>> 2026-03-16 22:06:01.855 | INFO | UI get current page 2026-03-16 22:06:02.373 | INFO | Unknown ui page 2026-03-16 22:06:02.839 | INFO | UI additional: IDLE -> REWARD_GOTO_MAIN 2026-03-16 22:06:02.843 | INFO | Click ( 822, 622) @ REWARD_GOTO_MAIN 2026-03-16 22:06:03.017 | INFO | Unknown ui page 2026-03-16 22:06:03.195 | INFO | [Package_name] com.bilibili.azurlane 2026-03-16 22:06:03.214 | INFO | [Device Orientation] 0 (Normal) 2026-03-16 22:06:03.348 | INFO | Unknown ui page 2026-03-16 22:06:03.647 | INFO | Unknown ui page 2026-03-16 22:06:03.874 | INFO | [UI] page_main 2026-03-16 22:06:03.879 | INFO | Goto page_campaign 2026-03-16 22:06:03.882 | INFO | <<< UI GOTO PAGE_CAMPAIGN >>> 2026-03-16 22:06:03.899 | INFO | Page switch: page_main_white -> page_campaign_menu 2026-03-16 22:06:03.905 | INFO | Click (1237, 499) @ MAIN_GOTO_CAMPAIGN_WHITE 2026-03-16 22:06:04.471 | INFO | Page switch: page_campaign_menu -> page_campaign 2026-03-16 22:06:04.475 | INFO | Click ( 423, 272) @ CAMPAIGN_MENU_GOTO_CAMPAIGN 2026-03-16 22:06:04.768 | INFO | Page arrive: page_campaign 2026-03-16 22:06:04.793 | INFO | Mode_switch_1 set to hard 2026-03-16 22:06:04.820 | INFO | [Mode_switch_1] hard 2026-03-16 22:06:04.824 | INFO | <<< UI ENSURE INDEX >>> 2026-03-16 22:06:04.898 | INFO | No stage found. 2026-03-16 22:06:05.136 | INFO | No stage found. 2026-03-16 22:06:05.453 | INFO | Loading OCR model: ./bin/cnocr_models/azur_lane 2026-03-16 22:06:05.567 | INFO | [campaign 0.132s] ['I3--1', 'I3--3', 'I3--2', 'I3--4'] 2026-03-16 22:06:05.570 | INFO | [Chapter] 13 2026-03-16 22:06:05.572 | INFO | [Stage] 13-1, 13-3, 13-2, 13-4 2026-03-16 22:06:05.577 | INFO | [Index] 13 2026-03-16 22:06:05.650 | INFO | [OCR_OIL 0.046s] 12793 ──────────────────────────────────────────────────────── 13-1 ───────────────────────────────────────────────────────── 2026-03-16 22:06:05.655 | INFO | 13-1 2026-03-16 22:06:05.657 | INFO | Expect emotion reduce: (12, 2) 2026-03-16 22:06:05.668 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-03-16 22:06:05.672 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=53, Main.Emotion.Fleet1Record=datetime.datetime(2026, 3, 16, 22, 6, 5), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 3, 16, 22, 6, 5) 2026-03-16 22:06:05.691 | INFO | [Emotion fleet_1] 53 2026-03-16 22:06:05.694 | INFO | [Emotion fleet_2] 119 2026-03-16 22:06:05.697 | INFO | <<< ENTER MAP >>> 2026-03-16 22:06:05.770 | INFO | Click ( 196, 273) @ 13-1 2026-03-16 22:06:06.176 | INFO | [Map_clear_percentage] 5% 2026-03-16 22:06:06.477 | INFO | [Map_clear_percentage] 59% 2026-03-16 22:06:06.779 | INFO | [Map_clear_percentage] 99% 2026-03-16 22:06:06.804 | INFO | [MAP_CLEAR_ALL_THIS_TIME] False 2026-03-16 22:06:06.808 | INFO | [Map_info] 99%, star_1, star_2, star_3, 100_percent_clear, 3_stars, threat_safe, clear_mode 2026-03-16 22:06:06.814 | INFO | [StopCondition_MapAchievement] non_stop 2026-03-16 22:06:06.819 | INFO | Fast_Forward set to on 2026-03-16 22:06:06.824 | INFO | [Fast_Forward] on 2026-03-16 22:06:06.841 | INFO | Auto_Search set to on 2026-03-16 22:06:06.848 | INFO | [Auto_Search] on 2026-03-16 22:06:06.854 | INFO | Click ( 983, 517) @ MAP_PREPARATION 2026-03-16 22:06:07.094 | INFO | Handling 2x book setting, mode=prep. 2026-03-16 22:06:07.379 | INFO | Using fleet: [4, 3, 1] 2026-03-16 22:06:07.455 | INFO | Hard satisfied: Fleet_1: None, Fleet_2: None, Submarine: None 2026-03-16 22:06:07.465 | INFO | [map_allow_submarine] True 2026-03-16 22:06:07.472 | INFO | Click (1139, 326) @ FLEET_2_CLEAR 2026-03-16 22:06:07.526 | INFO | Click (1050, 461) @ SUBMARINE_CHOOSE 2026-03-16 22:06:07.679 | INFO | Current selected: [1] 2026-03-16 22:06:07.684 | INFO | Click (1056, 473) @ SUBMARINE_CHOOSE 2026-03-16 22:06:07.984 | INFO | Click (1056, 218) @ FLEET_1_CHOOSE 2026-03-16 22:06:08.285 | INFO | Current selected: [4] 2026-03-16 22:06:08.288 | INFO | Click (1037, 227) @ FLEET_1_CHOOSE 2026-03-16 22:06:08.583 | INFO | Click (1065, 346) @ FLEET_2_CHOOSE 2026-03-16 22:06:08.885 | INFO | Current selected: [4] 2026-03-16 22:06:08.888 | INFO | Click (1122, 483) @ FLEET_2_BAR_INDEX_3 2026-03-16 22:06:09.214 | INFO | Auto search setting 2026-03-16 22:06:09.235 | INFO | [_fleet_sidebar_offset] 0 2026-03-16 22:06:09.242 | INFO | [_fleet_sidebar_offset] 0 2026-03-16 22:06:09.250 | INFO | [Fleet_sidebar] 1/3 2026-03-16 22:06:09.254 | INFO | Click (1205, 412) @ FLEET_SIDEBAR_0_2 2026-03-16 22:06:09.487 | INFO | [_fleet_sidebar_offset] 0 2026-03-16 22:06:09.491 | INFO | [Fleet_sidebar] 3/3 2026-03-16 22:06:09.493 | INFO | [Auto_Search_Setting] fleet1_all_fleet2_standby, sub_standby 2026-03-16 22:06:09.498 | INFO | Click ( 509, 216) @ AUTO_SEARCH_SET_MOB 2026-03-16 22:06:09.983 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_standby 2026-03-16 22:06:09.987 | INFO | Selected to the correct auto search setting 2026-03-16 22:06:09.989 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_standby 2026-03-16 22:06:09.992 | INFO | Selected to the correct auto search setting 2026-03-16 22:06:09.994 | INFO | Click (1060, 580) @ FLEET_PREPARATION 2026-03-16 22:06:10.899 | INFO | is_auto_search_running appeared ────────────────────────────────────────────────────── BATTLE_0 ─────────────────────────────────────────────────────── 2026-03-16 22:06:10.905 | INFO | BATTLE_0 2026-03-16 22:06:10.907 | INFO | Auto search moving 2026-03-16 22:06:10.921 | INFO | Fleet: 1, fleet_current_index: 1 2026-03-16 22:06:10.976 | INFO | [OCR_OIL 0.050s] 12783 2026-03-16 22:06:11.055 | INFO | [OCR_COIN 0.076s] 113330 2026-03-16 22:06:16.145 | INFO | [Loading] 20% 2026-03-16 22:06:16.148 | INFO | Auto search combat loading 2026-03-16 22:06:16.150 | INFO | Screenshot interval set to 1.0s 2026-03-16 22:06:22.160 | INFO | [BattleUI] PAUSE 2026-03-16 22:06:22.167 | INFO | Auto Search combat execute 2026-03-16 22:06:22.171 | INFO | <<< EMOTION REDUCE >>> 2026-03-16 22:06:22.186 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-03-16 22:06:22.196 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=51, Main.Emotion.Fleet1Record=datetime.datetime(2026, 3, 16, 22, 6, 22), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 3, 16, 22, 6, 22) 2026-03-16 22:06:22.216 | INFO | [Emotion fleet_1] 51 2026-03-16 22:06:22.221 | INFO | [Emotion fleet_2] 119 2026-03-16 22:06:28.145 | INFO | Combat auto check timer reached 2026-03-16 22:06:47.177 | INFO | Screenshot interval set to 0.3s 2026-03-16 22:06:47.181 | INFO | Auto Search combat status 2026-03-16 22:06:48.364 | INFO | Click (1023, 681) @ GET_SHIP 2026-03-16 22:06:49.567 | INFO | Click (1022, 656) @ GET_SHIP 2026-03-16 22:06:50.788 | INFO | Click (1046, 661) @ GET_SHIP 2026-03-16 22:06:51.659 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_1 ─────────────────────────────────────────────────────── 2026-03-16 22:06:51.665 | INFO | BATTLE_1 2026-03-16 22:06:51.667 | INFO | Auto search moving 2026-03-16 22:06:51.670 | INFO | Fleet: 1, fleet_current_index: 1 2026-03-16 22:06:51.740 | INFO | [OCR_OIL 0.065s] 12764 2026-03-16 22:06:51.814 | INFO | [OCR_COIN 0.067s] 113347 2026-03-16 22:06:57.074 | INFO | [Loading] 13% 2026-03-16 22:06:57.078 | INFO | Auto search combat loading 2026-03-16 22:06:57.081 | INFO | Screenshot interval set to 1.0s 2026-03-16 22:07:03.089 | INFO | [BattleUI] PAUSE 2026-03-16 22:07:03.093 | INFO | Auto Search combat execute 2026-03-16 22:07:03.096 | INFO | <<< EMOTION REDUCE >>> 2026-03-16 22:07:03.112 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-03-16 22:07:03.120 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=49, Main.Emotion.Fleet1Record=datetime.datetime(2026, 3, 16, 22, 7, 3), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 3, 16, 22, 7, 3) 2026-03-16 22:07:03.142 | INFO | [Emotion fleet_1] 49 2026-03-16 22:07:03.146 | INFO | [Emotion fleet_2] 119 2026-03-16 22:07:09.081 | INFO | Combat auto check timer reached 2026-03-16 22:07:28.102 | INFO | Screenshot interval set to 0.3s 2026-03-16 22:07:28.105 | INFO | Auto Search combat status 2026-03-16 22:07:28.993 | INFO | Click (1037, 660) @ GET_SHIP 2026-03-16 22:07:30.201 | INFO | Click (1037, 657) @ GET_SHIP 2026-03-16 22:07:31.395 | INFO | Click (1033, 660) @ GET_SHIP 2026-03-16 22:07:32.593 | INFO | Click (1027, 659) @ GET_SHIP 2026-03-16 22:07:34.387 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_2 ─────────────────────────────────────────────────────── 2026-03-16 22:07:34.392 | INFO | BATTLE_2 2026-03-16 22:07:34.395 | INFO | Auto search moving 2026-03-16 22:07:34.400 | INFO | Fleet: 1, fleet_current_index: 1 2026-03-16 22:07:34.481 | INFO | [OCR_OIL 0.075s] 12745 2026-03-16 22:07:34.565 | INFO | [OCR_COIN 0.080s] 113365 2026-03-16 22:07:38.607 | INFO | [Loading] 6% 2026-03-16 22:07:38.611 | INFO | Auto search combat loading 2026-03-16 22:07:38.614 | INFO | Screenshot interval set to 1.0s 2026-03-16 22:07:44.616 | INFO | [BattleUI] PAUSE 2026-03-16 22:07:44.621 | INFO | Auto Search combat execute 2026-03-16 22:07:44.624 | INFO | <<< EMOTION REDUCE >>> 2026-03-16 22:07:44.635 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-03-16 22:07:44.639 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=47, Main.Emotion.Fleet1Record=datetime.datetime(2026, 3, 16, 22, 7, 44), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 3, 16, 22, 7, 44) 2026-03-16 22:07:44.654 | INFO | [Emotion fleet_1] 47 2026-03-16 22:07:44.659 | INFO | [Emotion fleet_2] 119 2026-03-16 22:07:50.611 | INFO | Combat auto check timer reached 2026-03-16 22:08:46.675 | INFO | Click (1027, 663) @ GET_SHIP 2026-03-16 22:08:47.677 | INFO | Click (1023, 668) @ GET_SHIP 2026-03-16 22:08:49.678 | INFO | Click (1039, 667) @ GET_SHIP 2026-03-16 22:08:50.684 | INFO | Click (1031, 651) @ GET_SHIP 2026-03-16 22:08:52.685 | INFO | Screenshot interval set to 0.3s 2026-03-16 22:08:52.688 | INFO | Auto Search combat status 2026-03-16 22:08:52.693 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_3 ─────────────────────────────────────────────────────── 2026-03-16 22:08:52.698 | INFO | BATTLE_3 2026-03-16 22:08:52.702 | INFO | Auto search moving 2026-03-16 22:08:52.705 | INFO | Fleet: 1, fleet_current_index: 1 2026-03-16 22:08:52.794 | INFO | [OCR_OIL 0.085s] 12726 2026-03-16 22:08:52.862 | INFO | [OCR_COIN 0.064s] 113382 2026-03-16 22:08:56.573 | INFO | [Loading] 17% 2026-03-16 22:08:56.578 | INFO | Auto search combat loading 2026-03-16 22:08:56.582 | INFO | Screenshot interval set to 1.0s 2026-03-16 22:09:02.582 | INFO | [BattleUI] PAUSE 2026-03-16 22:09:02.586 | INFO | Auto Search combat execute 2026-03-16 22:09:02.589 | INFO | <<< EMOTION REDUCE >>> 2026-03-16 22:09:02.600 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-03-16 22:09:02.605 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=45, Main.Emotion.Fleet1Record=datetime.datetime(2026, 3, 16, 22, 9, 2), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 3, 16, 22, 9, 2) 2026-03-16 22:09:02.623 | INFO | [Emotion fleet_1] 45 2026-03-16 22:09:02.629 | INFO | [Emotion fleet_2] 119 2026-03-16 22:09:08.567 | INFO | Combat auto check timer reached 2026-03-16 22:09:43.625 | INFO | Screenshot interval set to 0.3s 2026-03-16 22:09:43.630 | INFO | Auto Search combat status 2026-03-16 22:09:44.806 | INFO | Click (1010, 680) @ GET_SHIP 2026-03-16 22:09:46.003 | INFO | Click (1020, 661) @ GET_SHIP 2026-03-16 22:09:47.222 | INFO | Click (1023, 663) @ GET_SHIP 2026-03-16 22:09:48.402 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_4 ─────────────────────────────────────────────────────── 2026-03-16 22:09:48.409 | INFO | BATTLE_4 2026-03-16 22:09:48.413 | INFO | Auto search moving 2026-03-16 22:09:48.420 | INFO | Fleet: 1, fleet_current_index: 1 2026-03-16 22:09:48.497 | INFO | [OCR_OIL 0.072s] 12707 2026-03-16 22:09:48.602 | INFO | [OCR_COIN 0.101s] 113402 2026-03-16 22:09:53.511 | INFO | [Loading] 16% 2026-03-16 22:09:53.514 | INFO | Auto search combat loading 2026-03-16 22:09:53.516 | INFO | Screenshot interval set to 1.0s 2026-03-16 22:09:59.537 | INFO | [BattleUI] PAUSE 2026-03-16 22:09:59.540 | INFO | Auto Search combat execute 2026-03-16 22:09:59.544 | INFO | <<< EMOTION REDUCE >>> 2026-03-16 22:09:59.559 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-03-16 22:09:59.565 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=43, Main.Emotion.Fleet1Record=datetime.datetime(2026, 3, 16, 22, 9, 59), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 3, 16, 22, 9, 59) 2026-03-16 22:09:59.612 | INFO | [Emotion fleet_1] 43 2026-03-16 22:09:59.618 | INFO | [Emotion fleet_2] 119 2026-03-16 22:10:05.517 | INFO | Combat auto check timer reached 2026-03-16 22:10:57.577 | INFO | Click (1025, 667) @ GET_SHIP 2026-03-16 22:10:58.580 | INFO | Click (1027, 643) @ GET_SHIP 2026-03-16 22:11:00.605 | INFO | Click (1036, 672) @ GET_SHIP 2026-03-16 22:11:01.587 | INFO | Screenshot interval set to 0.3s 2026-03-16 22:11:01.590 | INFO | Auto Search combat status 2026-03-16 22:11:01.876 | INFO | Click (1031, 643) @ GET_SHIP 2026-03-16 22:11:02.767 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_5 ─────────────────────────────────────────────────────── 2026-03-16 22:11:02.772 | INFO | BATTLE_5 2026-03-16 22:11:02.774 | INFO | Auto search moving 2026-03-16 22:11:02.777 | INFO | Fleet: 1, fleet_current_index: 1 2026-03-16 22:11:02.843 | INFO | [OCR_OIL 0.063s] 12688 2026-03-16 22:11:02.926 | INFO | [OCR_COIN 0.080s] 113414 2026-03-16 22:11:04.871 | INFO | [Loading] 9% 2026-03-16 22:11:04.875 | INFO | Auto search combat loading 2026-03-16 22:11:04.880 | INFO | Screenshot interval set to 1.0s 2026-03-16 22:11:10.890 | INFO | [BattleUI] PAUSE 2026-03-16 22:11:10.894 | INFO | Auto Search combat execute 2026-03-16 22:11:10.897 | INFO | <<< EMOTION REDUCE >>> 2026-03-16 22:11:10.912 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-03-16 22:11:10.921 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=41, Main.Emotion.Fleet1Record=datetime.datetime(2026, 3, 16, 22, 11, 10), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 3, 16, 22, 11, 10) 2026-03-16 22:11:10.939 | INFO | [Emotion fleet_1] 41 2026-03-16 22:11:10.944 | INFO | [Emotion fleet_2] 119 2026-03-16 22:11:16.892 | INFO | Combat auto check timer reached 2026-03-16 22:12:15.952 | INFO | Click (1010, 672) @ GET_SHIP 2026-03-16 22:15:16.102 | 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 L570 loop() alas.py L70 run() alas.py L367 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-03-16 22:15:16.119 | WARNING | Wait too long 2026-03-16 22:15:16.121 | WARNING | Waiting for {'SP_CHECK', 'EXP_INFO_B', 'EVENT_CHECK', 'POPUP_CONFIRM_WHITE', 'GUILD_POPUP_CONFIRM', 'GET_MISSION', 'GET_SHIP', 'PAUSE', 'EXP_INFO_S', 'AUTO_SEARCH_MAP_OPTION_ON', 'NEW_SHIP', 'BATTLE_STATUS_S', 'CAMPAIGN_CHECK', 'EXP_INFO_A', 'POPUP_CANCEL', 'BATTLE_STATUS_A', 'BATTLE_STATUS_B', 'MISSION_POPUP_GO'} 2026-03-16 22:15:16.183 | INFO | [Package_name] com.bilibili.azurlane 2026-03-16 22:15:16.186 | ERROR | GameStuckError: Wait too long 2026-03-16 22:15:16.189 | WARNING | Saving error: ./log/error/1773670516189