═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ MAIN ═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ ════════════════════════════════════════════════════ CAMPAIGN_13_1 ════════════════════════════════════════════════════ 2026-02-18 21:48:05.993 | INFO | CAMPAIGN_13_1 2026-02-18 21:48:05.996 | INFO | Count: 0 2026-02-18 21:48:06.012 | INFO | <<< UI ENSURE >>> 2026-02-18 21:48:06.016 | INFO | UI get current page 2026-02-18 21:48:06.541 | INFO | Unknown ui page 2026-02-18 21:48:07.014 | INFO | UI additional: IDLE -> REWARD_GOTO_MAIN 2026-02-18 21:48:07.017 | INFO | Click ( 820, 616) @ REWARD_GOTO_MAIN 2026-02-18 21:48:07.192 | INFO | Unknown ui page 2026-02-18 21:48:07.338 | INFO | [Package_name] com.bilibili.azurlane 2026-02-18 21:48:07.358 | INFO | [Device Orientation] 0 (Normal) 2026-02-18 21:48:07.522 | INFO | Unknown ui page 2026-02-18 21:48:07.790 | INFO | Unknown ui page 2026-02-18 21:48:08.020 | INFO | [UI] page_main 2026-02-18 21:48:08.023 | INFO | Goto page_campaign 2026-02-18 21:48:08.028 | INFO | <<< UI GOTO PAGE_CAMPAIGN >>> 2026-02-18 21:48:08.045 | INFO | Page switch: page_main_white -> page_campaign_menu 2026-02-18 21:48:08.049 | INFO | Click (1171, 526) @ MAIN_GOTO_CAMPAIGN_WHITE 2026-02-18 21:48:08.621 | INFO | Page switch: page_campaign_menu -> page_campaign 2026-02-18 21:48:08.625 | INFO | Click ( 353, 298) @ CAMPAIGN_MENU_GOTO_CAMPAIGN 2026-02-18 21:48:08.918 | INFO | Page arrive: page_campaign 2026-02-18 21:48:08.943 | INFO | Mode_switch_1 set to hard 2026-02-18 21:48:08.970 | INFO | [Mode_switch_1] hard 2026-02-18 21:48:08.975 | INFO | <<< UI ENSURE INDEX >>> 2026-02-18 21:48:09.046 | INFO | No stage found. 2026-02-18 21:48:09.289 | INFO | No stage found. 2026-02-18 21:48:09.605 | INFO | Loading OCR model: ./bin/cnocr_models/azur_lane 2026-02-18 21:48:09.808 | INFO | [campaign 0.222s] ['I3--1', 'I3--3', 'I3--2', 'I3--4'] 2026-02-18 21:48:09.813 | INFO | [Chapter] i3 2026-02-18 21:48:09.815 | INFO | [Stage] i3-1, i3-3, i3-2, i3-4 2026-02-18 21:48:09.865 | INFO | <<< UI ENSURE >>> 2026-02-18 21:48:09.868 | INFO | UI get current page 2026-02-18 21:48:09.879 | INFO | [UI] page_campaign 2026-02-18 21:48:09.883 | INFO | Already at page_campaign 2026-02-18 21:48:09.888 | INFO | Mode_switch_1 set to hard 2026-02-18 21:48:09.893 | INFO | [Mode_switch_1] hard 2026-02-18 21:48:09.896 | INFO | <<< UI ENSURE INDEX >>> 2026-02-18 21:48:10.029 | INFO | [campaign 0.063s] ['13--1', '13--3', '13--2', '13--4'] 2026-02-18 21:48:10.032 | INFO | [Chapter] 13 2026-02-18 21:48:10.035 | INFO | [Stage] 13-1, 13-3, 13-2, 13-4 2026-02-18 21:48:10.038 | INFO | [Index] 13 2026-02-18 21:48:10.124 | INFO | [OCR_OIL 0.055s] 18050 ──────────────────────────────────────────────────────── 13-1 ───────────────────────────────────────────────────────── 2026-02-18 21:48:10.130 | INFO | 13-1 2026-02-18 21:48:10.133 | INFO | Expect emotion reduce: (12, 2) 2026-02-18 21:48:10.150 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-02-18 21:48:10.154 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=53, Main.Emotion.Fleet1Record=datetime.datetime(2026, 2, 18, 21, 48, 10), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 2, 18, 21, 48, 10) 2026-02-18 21:48:10.172 | INFO | [Emotion fleet_1] 53 2026-02-18 21:48:10.175 | INFO | [Emotion fleet_2] 119 2026-02-18 21:48:10.178 | INFO | <<< ENTER MAP >>> 2026-02-18 21:48:10.250 | INFO | Click ( 188, 287) @ 13-1 2026-02-18 21:48:10.661 | INFO | [Map_clear_percentage] 5% 2026-02-18 21:48:10.962 | INFO | [Map_clear_percentage] 66% 2026-02-18 21:48:11.262 | INFO | [Map_clear_percentage] 99% 2026-02-18 21:48:11.288 | INFO | [MAP_CLEAR_ALL_THIS_TIME] False 2026-02-18 21:48:11.291 | INFO | [Map_info] 99%, star_1, star_2, star_3, 100_percent_clear, 3_stars, threat_safe, clear_mode 2026-02-18 21:48:11.296 | INFO | [StopCondition_MapAchievement] non_stop 2026-02-18 21:48:11.299 | INFO | Fast_Forward set to on 2026-02-18 21:48:11.302 | INFO | [Fast_Forward] on 2026-02-18 21:48:11.318 | INFO | Auto_Search set to on 2026-02-18 21:48:11.322 | INFO | [Auto_Search] on 2026-02-18 21:48:11.325 | INFO | Click ( 962, 519) @ MAP_PREPARATION 2026-02-18 21:48:11.557 | INFO | Handling 2x book setting, mode=prep. 2026-02-18 21:48:11.860 | INFO | Using fleet: [4, 3, 1] 2026-02-18 21:48:11.944 | INFO | Hard satisfied: Fleet_1: None, Fleet_2: None, Submarine: None 2026-02-18 21:48:11.952 | INFO | [map_allow_submarine] True 2026-02-18 21:48:11.957 | INFO | Click (1140, 332) @ FLEET_2_CLEAR 2026-02-18 21:48:12.012 | INFO | Click (1056, 471) @ SUBMARINE_CHOOSE 2026-02-18 21:48:12.149 | INFO | Current selected: [1] 2026-02-18 21:48:12.152 | INFO | Click (1056, 472) @ SUBMARINE_CHOOSE 2026-02-18 21:48:12.482 | INFO | Click (1067, 227) @ FLEET_1_CHOOSE 2026-02-18 21:48:12.756 | INFO | Current selected: [4] 2026-02-18 21:48:12.763 | INFO | Click (1056, 220) @ FLEET_1_CHOOSE 2026-02-18 21:48:13.054 | INFO | Click (1059, 332) @ FLEET_2_CHOOSE 2026-02-18 21:48:13.354 | INFO | Current selected: [4] 2026-02-18 21:48:13.360 | INFO | Click (1042, 483) @ FLEET_2_BAR_INDEX_3 2026-02-18 21:48:13.656 | INFO | Auto search setting 2026-02-18 21:48:13.672 | INFO | [_fleet_sidebar_offset] 0 2026-02-18 21:48:13.678 | INFO | [Fleet_sidebar] 1/3 2026-02-18 21:48:13.683 | INFO | Click (1213, 397) @ FLEET_SIDEBAR_0_2 2026-02-18 21:48:14.142 | INFO | [_fleet_sidebar_offset] 0 2026-02-18 21:48:14.148 | INFO | [Fleet_sidebar] 3/3 2026-02-18 21:48:14.152 | INFO | [Auto_Search_Setting] fleet1_all_fleet2_standby, sub_standby 2026-02-18 21:48:14.155 | INFO | Click ( 507, 223) @ AUTO_SEARCH_SET_MOB 2026-02-18 21:48:14.606 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_standby 2026-02-18 21:48:14.610 | INFO | Selected to the correct auto search setting 2026-02-18 21:48:14.616 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_standby 2026-02-18 21:48:14.619 | INFO | Selected to the correct auto search setting 2026-02-18 21:48:14.623 | INFO | Click (1043, 574) @ FLEET_PREPARATION 2026-02-18 21:48:15.527 | INFO | is_auto_search_running appeared ────────────────────────────────────────────────────── BATTLE_0 ─────────────────────────────────────────────────────── 2026-02-18 21:48:15.533 | INFO | BATTLE_0 2026-02-18 21:48:15.536 | INFO | Auto search moving 2026-02-18 21:48:15.551 | INFO | Fleet: 1, fleet_current_index: 1 2026-02-18 21:48:15.642 | INFO | [OCR_OIL 0.087s] 18040 2026-02-18 21:48:15.740 | INFO | [OCR_COIN 0.095s] 106039 2026-02-18 21:48:19.913 | INFO | [Loading] 15% 2026-02-18 21:48:19.918 | INFO | Auto search combat loading 2026-02-18 21:48:19.922 | INFO | Screenshot interval set to 1.0s 2026-02-18 21:48:24.920 | INFO | [BattleUI] PAUSE 2026-02-18 21:48:24.924 | INFO | Auto Search combat execute 2026-02-18 21:48:24.927 | INFO | <<< EMOTION REDUCE >>> 2026-02-18 21:48:24.941 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-02-18 21:48:24.947 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=51, Main.Emotion.Fleet1Record=datetime.datetime(2026, 2, 18, 21, 48, 24), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 2, 18, 21, 48, 24) 2026-02-18 21:48:24.963 | INFO | [Emotion fleet_1] 51 2026-02-18 21:48:24.968 | INFO | [Emotion fleet_2] 119 2026-02-18 21:48:30.920 | INFO | Combat auto check timer reached 2026-02-18 21:48:51.953 | INFO | Click (1019, 644) @ GET_SHIP 2026-02-18 21:48:52.962 | INFO | Click (1043, 663) @ GET_SHIP 2026-02-18 21:48:54.957 | INFO | Screenshot interval set to 0.3s 2026-02-18 21:48:54.960 | INFO | Auto Search combat status 2026-02-18 21:48:54.964 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_1 ─────────────────────────────────────────────────────── 2026-02-18 21:48:54.968 | INFO | BATTLE_1 2026-02-18 21:48:54.971 | INFO | Auto search moving 2026-02-18 21:48:54.975 | INFO | Fleet: 1, fleet_current_index: 1 2026-02-18 21:48:55.054 | INFO | [OCR_OIL 0.076s] 18021 2026-02-18 21:48:55.139 | INFO | [OCR_COIN 0.079s] 106061 2026-02-18 21:48:59.439 | INFO | [Loading] 11% 2026-02-18 21:48:59.444 | INFO | Auto search combat loading 2026-02-18 21:48:59.447 | INFO | Screenshot interval set to 1.0s 2026-02-18 21:49:04.457 | INFO | [BattleUI] PAUSE 2026-02-18 21:49:04.463 | INFO | Auto Search combat execute 2026-02-18 21:49:04.468 | INFO | <<< EMOTION REDUCE >>> 2026-02-18 21:49:04.484 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-02-18 21:49:04.490 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=49, Main.Emotion.Fleet1Record=datetime.datetime(2026, 2, 18, 21, 49, 4), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 2, 18, 21, 49, 4) 2026-02-18 21:49:04.508 | INFO | [Emotion fleet_1] 49 2026-02-18 21:49:04.514 | INFO | [Emotion fleet_2] 119 2026-02-18 21:49:10.449 | INFO | Combat auto check timer reached 2026-02-18 21:49:31.489 | INFO | Click (1018, 673) @ GET_SHIP 2026-02-18 21:49:32.541 | INFO | Click (1023, 649) @ GET_SHIP 2026-02-18 21:49:33.481 | INFO | Screenshot interval set to 0.3s 2026-02-18 21:49:33.485 | INFO | Auto Search combat status 2026-02-18 21:49:34.660 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_2 ─────────────────────────────────────────────────────── 2026-02-18 21:49:34.667 | INFO | BATTLE_2 2026-02-18 21:49:34.671 | INFO | Auto search moving 2026-02-18 21:49:34.679 | INFO | Fleet: 1, fleet_current_index: 1 2026-02-18 21:49:34.773 | INFO | [OCR_OIL 0.086s] 18002 2026-02-18 21:49:34.870 | INFO | [OCR_COIN 0.090s] 106085 2026-02-18 21:49:38.876 | INFO | [Loading] 14% 2026-02-18 21:49:38.879 | INFO | Auto search combat loading 2026-02-18 21:49:38.881 | INFO | Screenshot interval set to 1.0s 2026-02-18 21:49:44.896 | INFO | [BattleUI] PAUSE 2026-02-18 21:49:44.901 | INFO | Auto Search combat execute 2026-02-18 21:49:44.905 | INFO | <<< EMOTION REDUCE >>> 2026-02-18 21:49:44.919 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-02-18 21:49:44.925 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=47, Main.Emotion.Fleet1Record=datetime.datetime(2026, 2, 18, 21, 49, 44), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 2, 18, 21, 49, 44) 2026-02-18 21:49:44.939 | INFO | [Emotion fleet_1] 47 2026-02-18 21:49:44.944 | INFO | [Emotion fleet_2] 119 2026-02-18 21:49:50.883 | INFO | Combat auto check timer reached 2026-02-18 21:50:26.920 | INFO | Screenshot interval set to 0.3s 2026-02-18 21:50:26.923 | INFO | Auto Search combat status 2026-02-18 21:50:28.118 | INFO | Click (1011, 653) @ GET_SHIP 2026-02-18 21:50:29.323 | INFO | Click (1029, 671) @ GET_SHIP 2026-02-18 21:50:30.528 | INFO | Click (1033, 660) @ GET_SHIP 2026-02-18 21:50:31.712 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_3 ─────────────────────────────────────────────────────── 2026-02-18 21:50:31.718 | INFO | BATTLE_3 2026-02-18 21:50:31.722 | INFO | Auto search moving 2026-02-18 21:50:31.725 | INFO | Fleet: 1, fleet_current_index: 1 2026-02-18 21:50:31.844 | INFO | [OCR_OIL 0.116s] 17983 2026-02-18 21:50:31.938 | INFO | [OCR_COIN 0.091s] 106099 2026-02-18 21:50:35.933 | INFO | [Loading] 5% 2026-02-18 21:50:35.938 | INFO | Auto search combat loading 2026-02-18 21:50:35.940 | INFO | Screenshot interval set to 1.0s 2026-02-18 21:50:41.941 | INFO | [BattleUI] PAUSE 2026-02-18 21:50:41.946 | INFO | Auto Search combat execute 2026-02-18 21:50:41.949 | INFO | <<< EMOTION REDUCE >>> 2026-02-18 21:50:41.970 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-02-18 21:50:41.977 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=45, Main.Emotion.Fleet1Record=datetime.datetime(2026, 2, 18, 21, 50, 41), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 2, 18, 21, 50, 41) 2026-02-18 21:50:41.992 | INFO | [Emotion fleet_1] 45 2026-02-18 21:50:41.996 | INFO | [Emotion fleet_2] 119 2026-02-18 21:50:47.934 | INFO | Combat auto check timer reached 2026-02-18 21:51:25.977 | INFO | Click (1023, 666) @ GET_SHIP 2026-02-18 21:51:26.981 | INFO | Click (1042, 649) @ GET_SHIP 2026-02-18 21:51:28.993 | INFO | Click (1025, 661) @ GET_SHIP 2026-02-18 21:51:29.975 | INFO | Screenshot interval set to 0.3s 2026-02-18 21:51:29.979 | INFO | Auto Search combat status 2026-02-18 21:51:30.274 | INFO | Click (1034, 657) @ GET_SHIP 2026-02-18 21:51:31.154 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_4 ─────────────────────────────────────────────────────── 2026-02-18 21:51:31.159 | INFO | BATTLE_4 2026-02-18 21:51:31.164 | INFO | Auto search moving 2026-02-18 21:51:31.170 | INFO | Fleet: 1, fleet_current_index: 1 2026-02-18 21:51:31.269 | INFO | [OCR_OIL 0.094s] 17964 2026-02-18 21:51:31.346 | INFO | [OCR_COIN 0.073s] 106119 2026-02-18 21:51:35.971 | INFO | [Loading] 6% 2026-02-18 21:51:35.974 | INFO | Auto search combat loading 2026-02-18 21:51:35.976 | INFO | Screenshot interval set to 1.0s 2026-02-18 21:51:41.992 | INFO | [BattleUI] PAUSE 2026-02-18 21:51:41.996 | INFO | Auto Search combat execute 2026-02-18 21:51:41.999 | INFO | <<< EMOTION REDUCE >>> 2026-02-18 21:51:42.009 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-02-18 21:51:42.014 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=43, Main.Emotion.Fleet1Record=datetime.datetime(2026, 2, 18, 21, 51, 42), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 2, 18, 21, 51, 42) 2026-02-18 21:51:42.031 | INFO | [Emotion fleet_1] 43 2026-02-18 21:51:42.037 | INFO | [Emotion fleet_2] 119 2026-02-18 21:51:48.005 | INFO | Combat auto check timer reached 2026-02-18 21:52:41.035 | INFO | Screenshot interval set to 0.3s 2026-02-18 21:52:41.039 | INFO | Auto Search combat status 2026-02-18 21:52:42.528 | INFO | Click (1030, 656) @ GET_SHIP 2026-02-18 21:52:43.726 | INFO | Click (1028, 657) @ GET_SHIP 2026-02-18 21:52:44.924 | INFO | Click (1018, 669) @ GET_SHIP 2026-02-18 21:52:46.126 | INFO | Click (1028, 654) @ GET_SHIP 2026-02-18 21:52:47.920 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_5 ─────────────────────────────────────────────────────── 2026-02-18 21:52:47.928 | INFO | BATTLE_5 2026-02-18 21:52:47.930 | INFO | Auto search moving 2026-02-18 21:52:47.934 | INFO | Fleet: 1, fleet_current_index: 1 2026-02-18 21:52:48.010 | INFO | [OCR_OIL 0.071s] 17945 2026-02-18 21:52:48.094 | INFO | [OCR_COIN 0.080s] 106147 2026-02-18 21:52:50.641 | INFO | [Loading] 13% 2026-02-18 21:52:50.644 | INFO | Auto search combat loading 2026-02-18 21:52:50.647 | INFO | Screenshot interval set to 1.0s 2026-02-18 21:52:56.658 | INFO | [BattleUI] PAUSE 2026-02-18 21:52:56.661 | INFO | Auto Search combat execute 2026-02-18 21:52:56.665 | INFO | <<< EMOTION REDUCE >>> 2026-02-18 21:52:56.677 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-02-18 21:52:56.684 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=41, Main.Emotion.Fleet1Record=datetime.datetime(2026, 2, 18, 21, 52, 56), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 2, 18, 21, 52, 56) 2026-02-18 21:52:56.702 | INFO | [Emotion fleet_1] 41 2026-02-18 21:52:56.705 | INFO | [Emotion fleet_2] 119 2026-02-18 21:53:02.695 | INFO | Combat auto check timer reached 2026-02-18 21:54:09.717 | INFO | Click (1020, 665) @ GET_SHIP 2026-02-18 21:57:09.855 | INFO | Function calls: gui.py L94 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() gui.py L85 func() main.py L463 run() server.py L60 run() runners.py L43 run() on.py L84 main() proxy_headers.py L75 __call__() applications.py L112 __call__() errors.py L146 __call__() base.py L21 __call__() exceptions.py L58 __call__() routing.py L569 __call__() routing.py L540 lifespan() routing.py L481 default_lifespan() routing.py L518 startup() app.py L1523 process_manager.py L227 restart_processes() 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-02-18 21:57:09.876 | WARNING | Wait too long 2026-02-18 21:57:09.879 | 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-02-18 21:57:09.945 | INFO | [Package_name] com.bilibili.azurlane 2026-02-18 21:57:09.948 | ERROR | GameStuckError: Wait too long 2026-02-18 21:57:09.952 | WARNING | Saving error: ./log/error/1771423029952