═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ MAIN ═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ ════════════════════════════════════════════════════ CAMPAIGN_13_1 ════════════════════════════════════════════════════ 2026-02-17 12:12:03.725 | INFO | CAMPAIGN_13_1 2026-02-17 12:12:03.729 | INFO | Count: 0 2026-02-17 12:12:03.748 | INFO | <<< UI ENSURE >>> 2026-02-17 12:12:03.752 | INFO | UI get current page 2026-02-17 12:12:03.766 | INFO | [UI] page_main 2026-02-17 12:12:03.770 | INFO | Goto page_campaign 2026-02-17 12:12:03.773 | INFO | <<< UI GOTO PAGE_CAMPAIGN >>> 2026-02-17 12:12:03.830 | INFO | Page switch: page_main_white -> page_campaign_menu 2026-02-17 12:12:03.835 | INFO | Click (1195, 527) @ MAIN_GOTO_CAMPAIGN_WHITE 2026-02-17 12:12:04.971 | INFO | Page switch: page_campaign_menu -> page_campaign 2026-02-17 12:12:04.975 | INFO | Click ( 244, 308) @ CAMPAIGN_MENU_GOTO_CAMPAIGN 2026-02-17 12:12:05.265 | INFO | Page arrive: page_campaign 2026-02-17 12:12:05.291 | INFO | Mode_switch_1 set to hard 2026-02-17 12:12:05.317 | INFO | [Mode_switch_1] hard 2026-02-17 12:12:05.321 | INFO | <<< UI ENSURE INDEX >>> 2026-02-17 12:12:05.391 | INFO | No stage found. 2026-02-17 12:12:05.631 | INFO | No stage found. 2026-02-17 12:12:05.952 | INFO | Loading OCR model: ./bin/cnocr_models/azur_lane 2026-02-17 12:12:06.061 | INFO | [campaign 0.127s] ['I3--1', 'I3--3', 'I3--2', 'I3--4'] 2026-02-17 12:12:06.064 | INFO | [Chapter] i3 2026-02-17 12:12:06.067 | INFO | [Stage] i3-1, i3-3, i3-2, i3-4 2026-02-17 12:12:06.164 | INFO | <<< UI ENSURE >>> 2026-02-17 12:12:06.170 | INFO | UI get current page 2026-02-17 12:12:06.179 | INFO | [UI] page_campaign 2026-02-17 12:12:06.183 | INFO | Already at page_campaign 2026-02-17 12:12:06.191 | INFO | Mode_switch_1 set to hard 2026-02-17 12:12:06.197 | INFO | [Mode_switch_1] hard 2026-02-17 12:12:06.201 | INFO | <<< UI ENSURE INDEX >>> 2026-02-17 12:12:06.330 | INFO | [campaign 0.054s] ['13--1', '13--3', '13--2', '13--4'] 2026-02-17 12:12:06.335 | INFO | [Chapter] 13 2026-02-17 12:12:06.338 | INFO | [Stage] 13-1, 13-3, 13-2, 13-4 2026-02-17 12:12:06.341 | INFO | [Index] 13 2026-02-17 12:12:06.419 | INFO | [OCR_OIL 0.050s] 20305 ──────────────────────────────────────────────────────── 13-1 ───────────────────────────────────────────────────────── 2026-02-17 12:12:06.424 | INFO | 13-1 2026-02-17 12:12:06.427 | INFO | Expect emotion reduce: (12, 2) 2026-02-17 12:12:06.438 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-02-17 12:12:06.442 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=53, Main.Emotion.Fleet1Record=datetime.datetime(2026, 2, 17, 12, 12, 6), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 2, 17, 12, 12, 6) 2026-02-17 12:12:06.455 | INFO | [Emotion fleet_1] 53 2026-02-17 12:12:06.459 | INFO | [Emotion fleet_2] 119 2026-02-17 12:12:06.463 | INFO | <<< ENTER MAP >>> 2026-02-17 12:12:06.539 | INFO | Click ( 199, 273) @ 13-1 2026-02-17 12:12:06.946 | INFO | [Map_clear_percentage] 5% 2026-02-17 12:12:07.255 | INFO | [Map_clear_percentage] 74% 2026-02-17 12:12:07.541 | INFO | [Map_clear_percentage] 99% 2026-02-17 12:12:07.566 | INFO | [MAP_CLEAR_ALL_THIS_TIME] False 2026-02-17 12:12:07.572 | INFO | [Map_info] 99%, star_1, star_2, star_3, 100_percent_clear, 3_stars, threat_safe, clear_mode 2026-02-17 12:12:07.575 | INFO | [StopCondition_MapAchievement] non_stop 2026-02-17 12:12:07.578 | INFO | Fast_Forward set to on 2026-02-17 12:12:07.580 | INFO | [Fast_Forward] on 2026-02-17 12:12:07.595 | INFO | Auto_Search set to on 2026-02-17 12:12:07.599 | INFO | [Auto_Search] on 2026-02-17 12:12:07.604 | INFO | Click (1007, 528) @ MAP_PREPARATION 2026-02-17 12:12:08.141 | INFO | Handling 2x book setting, mode=prep. 2026-02-17 12:12:08.164 | INFO | Using fleet: [4, 3, 1] 2026-02-17 12:12:08.242 | INFO | Hard satisfied: Fleet_1: None, Fleet_2: None, Submarine: None 2026-02-17 12:12:08.252 | INFO | [map_allow_submarine] True 2026-02-17 12:12:08.258 | INFO | Click (1137, 339) @ FLEET_2_CLEAR 2026-02-17 12:12:08.313 | INFO | Click (1043, 475) @ SUBMARINE_CHOOSE 2026-02-17 12:12:08.738 | INFO | Current selected: [1] 2026-02-17 12:12:08.742 | INFO | Click (1043, 461) @ SUBMARINE_CHOOSE 2026-02-17 12:12:09.046 | INFO | Click (1031, 222) @ FLEET_1_CHOOSE 2026-02-17 12:12:09.345 | INFO | Current selected: [3] 2026-02-17 12:12:09.349 | INFO | Click (1094, 412) @ FLEET_1_BAR_INDEX_4 2026-02-17 12:12:09.644 | INFO | Click (1038, 342) @ FLEET_2_CHOOSE 2026-02-17 12:12:09.940 | INFO | Current selected: [4] 2026-02-17 12:12:09.943 | INFO | Click (1074, 482) @ FLEET_2_BAR_INDEX_3 2026-02-17 12:12:10.239 | INFO | Auto search setting 2026-02-17 12:12:10.257 | INFO | [_fleet_sidebar_offset] 0 2026-02-17 12:12:10.263 | INFO | [Fleet_sidebar] 1/3 2026-02-17 12:12:10.267 | INFO | Click (1197, 438) @ FLEET_SIDEBAR_0_2 2026-02-17 12:12:10.843 | INFO | [_fleet_sidebar_offset] 0 2026-02-17 12:12:10.846 | INFO | [Fleet_sidebar] 3/3 2026-02-17 12:12:10.849 | INFO | [Auto_Search_Setting] fleet1_all_fleet2_standby, sub_standby 2026-02-17 12:12:10.852 | INFO | Click ( 504, 210) @ AUTO_SEARCH_SET_MOB 2026-02-17 12:12:11.373 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_standby 2026-02-17 12:12:11.377 | INFO | Selected to the correct auto search setting 2026-02-17 12:12:11.380 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_standby 2026-02-17 12:12:11.382 | INFO | Selected to the correct auto search setting 2026-02-17 12:12:11.384 | INFO | Click (1138, 570) @ FLEET_PREPARATION 2026-02-17 12:12:12.280 | INFO | is_auto_search_running appeared ────────────────────────────────────────────────────── BATTLE_0 ─────────────────────────────────────────────────────── 2026-02-17 12:12:12.285 | INFO | BATTLE_0 2026-02-17 12:12:12.288 | INFO | Auto search moving 2026-02-17 12:12:12.301 | INFO | Fleet: 1, fleet_current_index: 1 2026-02-17 12:12:12.369 | INFO | [OCR_OIL 0.060s] 20295 2026-02-17 12:12:12.462 | INFO | [OCR_COIN 0.088s] 104251 2026-02-17 12:12:16.637 | INFO | [Loading] 6% 2026-02-17 12:12:16.641 | INFO | Auto search combat loading 2026-02-17 12:12:16.646 | INFO | Screenshot interval set to 1.0s 2026-02-17 12:12:22.650 | INFO | [BattleUI] PAUSE 2026-02-17 12:12:22.654 | INFO | Auto Search combat execute 2026-02-17 12:12:22.657 | INFO | <<< EMOTION REDUCE >>> 2026-02-17 12:12:22.668 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-02-17 12:12:22.676 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=51, Main.Emotion.Fleet1Record=datetime.datetime(2026, 2, 17, 12, 12, 22), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 2, 17, 12, 12, 22) 2026-02-17 12:12:22.697 | INFO | [Emotion fleet_1] 51 2026-02-17 12:12:22.701 | INFO | [Emotion fleet_2] 119 2026-02-17 12:12:28.630 | INFO | Combat auto check timer reached 2026-02-17 12:12:49.666 | INFO | Screenshot interval set to 0.3s 2026-02-17 12:12:49.670 | INFO | Auto Search combat status 2026-02-17 12:12:50.258 | INFO | Click (1028, 674) @ GET_SHIP 2026-02-17 12:12:51.462 | INFO | Click (1038, 650) @ GET_SHIP 2026-02-17 12:12:52.663 | INFO | Click (1019, 660) @ GET_SHIP 2026-02-17 12:12:53.858 | INFO | Click (1021, 655) @ GET_SHIP 2026-02-17 12:12:55.665 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_1 ─────────────────────────────────────────────────────── 2026-02-17 12:12:55.675 | INFO | BATTLE_1 2026-02-17 12:12:55.689 | INFO | Auto search moving 2026-02-17 12:12:55.696 | INFO | Fleet: 1, fleet_current_index: 1 2026-02-17 12:12:55.790 | INFO | [OCR_OIL 0.089s] 20276 2026-02-17 12:12:55.863 | INFO | [OCR_COIN 0.069s] 104262 2026-02-17 12:12:59.871 | INFO | [Loading] 13% 2026-02-17 12:12:59.875 | INFO | Auto search combat loading 2026-02-17 12:12:59.877 | INFO | Screenshot interval set to 1.0s 2026-02-17 12:13:05.879 | INFO | [BattleUI] PAUSE 2026-02-17 12:13:05.882 | INFO | Auto Search combat execute 2026-02-17 12:13:05.885 | INFO | <<< EMOTION REDUCE >>> 2026-02-17 12:13:05.907 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-02-17 12:13:05.913 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=49, Main.Emotion.Fleet1Record=datetime.datetime(2026, 2, 17, 12, 13, 5), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 2, 17, 12, 13, 5) 2026-02-17 12:13:05.925 | INFO | [Emotion fleet_1] 49 2026-02-17 12:13:05.929 | INFO | [Emotion fleet_2] 119 2026-02-17 12:13:11.878 | INFO | Combat auto check timer reached 2026-02-17 12:13:29.897 | INFO | Screenshot interval set to 0.3s 2026-02-17 12:13:29.901 | INFO | Auto Search combat status 2026-02-17 12:13:30.792 | INFO | Click (1039, 665) @ GET_SHIP 2026-02-17 12:13:31.992 | INFO | Click (1035, 638) @ GET_SHIP 2026-02-17 12:13:33.190 | INFO | Click (1033, 655) @ GET_SHIP 2026-02-17 12:13:34.396 | INFO | Click (1013, 669) @ GET_SHIP 2026-02-17 12:13:36.194 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_2 ─────────────────────────────────────────────────────── 2026-02-17 12:13:36.199 | INFO | BATTLE_2 2026-02-17 12:13:36.201 | INFO | Auto search moving 2026-02-17 12:13:36.204 | INFO | Fleet: 1, fleet_current_index: 1 2026-02-17 12:13:36.322 | INFO | [OCR_OIL 0.113s] 20257 2026-02-17 12:13:36.401 | INFO | [OCR_COIN 0.076s] 104285 2026-02-17 12:13:40.105 | INFO | [Loading] 6% 2026-02-17 12:13:40.108 | INFO | Auto search combat loading 2026-02-17 12:13:40.112 | INFO | Screenshot interval set to 1.0s 2026-02-17 12:13:46.114 | INFO | [BattleUI] PAUSE 2026-02-17 12:13:46.118 | INFO | Auto Search combat execute 2026-02-17 12:13:46.123 | INFO | <<< EMOTION REDUCE >>> 2026-02-17 12:13:46.137 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-02-17 12:13:46.144 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=47, Main.Emotion.Fleet1Record=datetime.datetime(2026, 2, 17, 12, 13, 46), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 2, 17, 12, 13, 46) 2026-02-17 12:13:46.161 | INFO | [Emotion fleet_1] 47 2026-02-17 12:13:46.166 | INFO | [Emotion fleet_2] 119 2026-02-17 12:13:52.109 | INFO | Combat auto check timer reached 2026-02-17 12:14:30.153 | INFO | Click (1018, 660) @ GET_SHIP 2026-02-17 12:14:31.156 | INFO | Click (1030, 664) @ GET_SHIP 2026-02-17 12:14:33.159 | INFO | Screenshot interval set to 0.3s 2026-02-17 12:14:33.163 | INFO | Auto Search combat status 2026-02-17 12:14:33.166 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_3 ─────────────────────────────────────────────────────── 2026-02-17 12:14:33.172 | INFO | BATTLE_3 2026-02-17 12:14:33.176 | INFO | Auto search moving 2026-02-17 12:14:33.180 | INFO | Fleet: 1, fleet_current_index: 1 2026-02-17 12:14:33.291 | INFO | [OCR_OIL 0.107s] 20238 2026-02-17 12:14:33.393 | INFO | [OCR_COIN 0.095s] 104301 2026-02-17 12:14:37.688 | INFO | [Loading] 8% 2026-02-17 12:14:37.691 | INFO | Auto search combat loading 2026-02-17 12:14:37.693 | INFO | Screenshot interval set to 1.0s 2026-02-17 12:14:43.692 | INFO | [BattleUI] PAUSE 2026-02-17 12:14:43.697 | INFO | Auto Search combat execute 2026-02-17 12:14:43.700 | INFO | <<< EMOTION REDUCE >>> 2026-02-17 12:14:43.712 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-02-17 12:14:43.716 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=45, Main.Emotion.Fleet1Record=datetime.datetime(2026, 2, 17, 12, 14, 43), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 2, 17, 12, 14, 43) 2026-02-17 12:14:43.729 | INFO | [Emotion fleet_1] 45 2026-02-17 12:14:43.734 | INFO | [Emotion fleet_2] 119 2026-02-17 12:14:49.693 | INFO | Combat auto check timer reached 2026-02-17 12:15:26.735 | INFO | Screenshot interval set to 0.3s 2026-02-17 12:15:26.739 | INFO | Auto Search combat status 2026-02-17 12:15:27.323 | INFO | Click (1018, 652) @ GET_SHIP 2026-02-17 12:15:28.525 | INFO | Click (1023, 684) @ GET_SHIP 2026-02-17 12:15:29.727 | INFO | Click (1018, 647) @ GET_SHIP 2026-02-17 12:15:30.920 | INFO | Click (1012, 671) @ GET_SHIP 2026-02-17 12:15:32.729 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_4 ─────────────────────────────────────────────────────── 2026-02-17 12:15:32.733 | INFO | BATTLE_4 2026-02-17 12:15:32.736 | INFO | Auto search moving 2026-02-17 12:15:32.739 | INFO | Fleet: 1, fleet_current_index: 1 2026-02-17 12:15:32.826 | INFO | [OCR_OIL 0.081s] 20219 2026-02-17 12:15:32.910 | INFO | [OCR_COIN 0.080s] 104323 2026-02-17 12:15:36.933 | INFO | [Loading] 9% 2026-02-17 12:15:36.936 | INFO | Auto search combat loading 2026-02-17 12:15:36.939 | INFO | Screenshot interval set to 1.0s 2026-02-17 12:15:42.949 | INFO | [BattleUI] PAUSE 2026-02-17 12:15:42.953 | INFO | Auto Search combat execute 2026-02-17 12:15:42.957 | INFO | <<< EMOTION REDUCE >>> 2026-02-17 12:15:42.969 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-02-17 12:15:42.975 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=43, Main.Emotion.Fleet1Record=datetime.datetime(2026, 2, 17, 12, 15, 42), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 2, 17, 12, 15, 42) 2026-02-17 12:15:42.990 | INFO | [Emotion fleet_1] 43 2026-02-17 12:15:42.994 | INFO | [Emotion fleet_2] 119 2026-02-17 12:15:48.939 | INFO | Combat auto check timer reached 2026-02-17 12:16:40.989 | INFO | Screenshot interval set to 0.3s 2026-02-17 12:16:40.994 | INFO | Auto Search combat status 2026-02-17 12:16:42.484 | INFO | Click (1028, 670) @ GET_SHIP 2026-02-17 12:16:43.989 | INFO | Click (1038, 668) @ GET_SHIP 2026-02-17 12:16:45.200 | INFO | Click (1016, 662) @ GET_SHIP 2026-02-17 12:16:46.084 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_5 ─────────────────────────────────────────────────────── 2026-02-17 12:16:46.090 | INFO | BATTLE_5 2026-02-17 12:16:46.092 | INFO | Auto search moving 2026-02-17 12:16:46.095 | INFO | Fleet: 1, fleet_current_index: 1 2026-02-17 12:16:46.169 | INFO | [OCR_OIL 0.069s] 20200 2026-02-17 12:16:46.246 | INFO | [OCR_COIN 0.073s] 104333 2026-02-17 12:16:48.490 | INFO | [Loading] 9% 2026-02-17 12:16:48.494 | INFO | Auto search combat loading 2026-02-17 12:16:48.497 | INFO | Screenshot interval set to 1.0s 2026-02-17 12:16:54.499 | INFO | [BattleUI] PAUSE 2026-02-17 12:16:54.503 | INFO | Auto Search combat execute 2026-02-17 12:16:54.505 | INFO | <<< EMOTION REDUCE >>> 2026-02-17 12:16:54.520 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-02-17 12:16:54.528 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=41, Main.Emotion.Fleet1Record=datetime.datetime(2026, 2, 17, 12, 16, 54), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 2, 17, 12, 16, 54) 2026-02-17 12:16:54.541 | INFO | [Emotion fleet_1] 41 2026-02-17 12:16:54.546 | INFO | [Emotion fleet_2] 119 2026-02-17 12:17:00.492 | INFO | Combat auto check timer reached 2026-02-17 12:18:01.560 | INFO | Click (1043, 664) @ GET_SHIP 2026-02-17 12:21:01.705 | 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-17 12:21:01.726 | WARNING | Wait too long 2026-02-17 12:21:01.730 | 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-17 12:21:01.785 | INFO | [Package_name] com.bilibili.azurlane 2026-02-17 12:21:01.790 | ERROR | GameStuckError: Wait too long 2026-02-17 12:21:01.795 | WARNING | Saving error: ./log/error/1771302061795