═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ MAIN ═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ ════════════════════════════════════════════════════ CAMPAIGN_13_1 ════════════════════════════════════════════════════ 2026-03-31 21:36:04.515 | INFO | CAMPAIGN_13_1 2026-03-31 21:36:04.518 | INFO | Count: 0 2026-03-31 21:36:04.536 | INFO | <<< UI ENSURE >>> 2026-03-31 21:36:04.540 | INFO | UI get current page 2026-03-31 21:36:05.064 | INFO | Unknown ui page 2026-03-31 21:36:05.542 | INFO | UI additional: IDLE_2 -> REWARD_GOTO_MAIN 2026-03-31 21:36:05.548 | INFO | Click ( 836, 622) @ REWARD_GOTO_MAIN 2026-03-31 21:36:05.719 | INFO | Unknown ui page 2026-03-31 21:36:05.858 | INFO | [Package_name] com.bilibili.azurlane 2026-03-31 21:36:05.883 | INFO | [Device Orientation] 0 (Normal) 2026-03-31 21:36:06.024 | INFO | Unknown ui page 2026-03-31 21:36:06.249 | INFO | [UI] page_main 2026-03-31 21:36:06.252 | INFO | Goto page_campaign 2026-03-31 21:36:06.256 | INFO | <<< UI GOTO PAGE_CAMPAIGN >>> 2026-03-31 21:36:06.274 | INFO | Page switch: page_main_white -> page_campaign_menu 2026-03-31 21:36:06.278 | INFO | Click (1207, 490) @ MAIN_GOTO_CAMPAIGN_WHITE 2026-03-31 21:36:06.849 | INFO | Page switch: page_campaign_menu -> page_campaign 2026-03-31 21:36:06.853 | INFO | Click ( 352, 307) @ CAMPAIGN_MENU_GOTO_CAMPAIGN 2026-03-31 21:36:07.145 | INFO | Page arrive: page_campaign 2026-03-31 21:36:07.170 | INFO | Mode_switch_1 set to hard 2026-03-31 21:36:07.197 | INFO | [Mode_switch_1] hard 2026-03-31 21:36:07.203 | INFO | <<< UI ENSURE INDEX >>> 2026-03-31 21:36:07.280 | INFO | No stage found. 2026-03-31 21:36:07.521 | INFO | No stage found. 2026-03-31 21:36:07.812 | INFO | No stage found. 2026-03-31 21:36:08.129 | INFO | Loading OCR model: ./bin/cnocr_models/azur_lane 2026-03-31 21:36:08.245 | INFO | [campaign 0.133s] ['13--1', '13--3', '13--2', '13--4'] 2026-03-31 21:36:08.248 | INFO | [Chapter] 13 2026-03-31 21:36:08.251 | INFO | [Stage] 13-1, 13-3, 13-2, 13-4 2026-03-31 21:36:08.253 | INFO | [Index] 13 2026-03-31 21:36:08.322 | INFO | [OCR_OIL 0.042s] 20634 ──────────────────────────────────────────────────────── 13-1 ───────────────────────────────────────────────────────── 2026-03-31 21:36:08.327 | INFO | 13-1 2026-03-31 21:36:08.329 | INFO | Expect emotion reduce: (12, 2) 2026-03-31 21:36:08.342 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-03-31 21:36:08.346 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=53, Main.Emotion.Fleet1Record=datetime.datetime(2026, 3, 31, 21, 36, 8), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 3, 31, 21, 36, 8) 2026-03-31 21:36:08.360 | INFO | [Emotion fleet_1] 53 2026-03-31 21:36:08.364 | INFO | [Emotion fleet_2] 119 2026-03-31 21:36:08.368 | INFO | <<< ENTER MAP >>> 2026-03-31 21:36:08.442 | INFO | Click ( 198, 283) @ 13-1 2026-03-31 21:36:08.851 | INFO | [Map_clear_percentage] 5% 2026-03-31 21:36:09.148 | INFO | [Map_clear_percentage] 66% 2026-03-31 21:36:09.449 | INFO | [Map_clear_percentage] 99% 2026-03-31 21:36:09.476 | INFO | [MAP_CLEAR_ALL_THIS_TIME] False 2026-03-31 21:36:09.480 | INFO | [Map_info] 99%, star_1, star_2, star_3, 100_percent_clear, 3_stars, threat_safe, clear_mode 2026-03-31 21:36:09.485 | INFO | [StopCondition_MapAchievement] non_stop 2026-03-31 21:36:09.488 | INFO | Fast_Forward set to on 2026-03-31 21:36:09.491 | INFO | [Fast_Forward] on 2026-03-31 21:36:09.504 | INFO | Auto_Search set to on 2026-03-31 21:36:09.510 | INFO | [Auto_Search] on 2026-03-31 21:36:09.515 | INFO | Click ( 963, 529) @ MAP_PREPARATION 2026-03-31 21:36:09.748 | INFO | Handling 2x book setting, mode=prep. 2026-03-31 21:36:10.051 | INFO | Using fleet: [4, 3, 1] 2026-03-31 21:36:10.126 | INFO | Hard satisfied: Fleet_1: None, Fleet_2: None, Submarine: None 2026-03-31 21:36:10.136 | INFO | [map_allow_submarine] True 2026-03-31 21:36:10.142 | INFO | Click (1149, 330) @ FLEET_2_CLEAR 2026-03-31 21:36:10.197 | INFO | Click (1030, 485) @ SUBMARINE_CHOOSE 2026-03-31 21:36:10.350 | INFO | Current selected: [1] 2026-03-31 21:36:10.354 | INFO | Click (1034, 463) @ SUBMARINE_CHOOSE 2026-03-31 21:36:10.653 | INFO | Click (1054, 231) @ FLEET_1_CHOOSE 2026-03-31 21:36:10.949 | INFO | Current selected: [4] 2026-03-31 21:36:10.954 | INFO | Click (1042, 248) @ FLEET_1_CHOOSE 2026-03-31 21:36:11.244 | INFO | Click (1063, 359) @ FLEET_2_CHOOSE 2026-03-31 21:36:11.546 | INFO | Current selected: [4] 2026-03-31 21:36:11.550 | INFO | Click (1099, 480) @ FLEET_2_BAR_INDEX_3 2026-03-31 21:36:11.844 | INFO | Auto search setting 2026-03-31 21:36:11.860 | INFO | [_fleet_sidebar_offset] 0 2026-03-31 21:36:11.866 | INFO | [_fleet_sidebar_offset] 0 2026-03-31 21:36:11.872 | INFO | [Fleet_sidebar] 1/3 2026-03-31 21:36:11.876 | INFO | Click (1219, 442) @ FLEET_SIDEBAR_0_2 2026-03-31 21:36:12.151 | INFO | [_fleet_sidebar_offset] 0 2026-03-31 21:36:12.156 | INFO | [Fleet_sidebar] 3/3 2026-03-31 21:36:12.160 | INFO | [Auto_Search_Setting] fleet1_all_fleet2_standby, sub_standby 2026-03-31 21:36:12.162 | INFO | Click ( 508, 216) @ AUTO_SEARCH_SET_MOB 2026-03-31 21:36:12.695 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_standby 2026-03-31 21:36:12.699 | INFO | Selected to the correct auto search setting 2026-03-31 21:36:12.703 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_standby 2026-03-31 21:36:12.707 | INFO | Selected to the correct auto search setting 2026-03-31 21:36:12.712 | INFO | Click (1050, 597) @ FLEET_PREPARATION 2026-03-31 21:36:13.620 | INFO | is_auto_search_running appeared ────────────────────────────────────────────────────── BATTLE_0 ─────────────────────────────────────────────────────── 2026-03-31 21:36:13.626 | INFO | BATTLE_0 2026-03-31 21:36:13.629 | INFO | Auto search moving 2026-03-31 21:36:13.642 | INFO | Fleet: 1, fleet_current_index: 1 2026-03-31 21:36:13.709 | INFO | [OCR_OIL 0.063s] 20624 2026-03-31 21:36:13.798 | INFO | [OCR_COIN 0.086s] 247316 2026-03-31 21:36:18.569 | INFO | [Loading] 20% 2026-03-31 21:36:18.573 | INFO | Auto search combat loading 2026-03-31 21:36:18.577 | INFO | Screenshot interval set to 1.0s 2026-03-31 21:36:23.575 | INFO | [BattleUI] PAUSE 2026-03-31 21:36:23.580 | INFO | Auto Search combat execute 2026-03-31 21:36:23.584 | INFO | <<< EMOTION REDUCE >>> 2026-03-31 21:36:23.600 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-03-31 21:36:23.603 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=51, Main.Emotion.Fleet1Record=datetime.datetime(2026, 3, 31, 21, 36, 23), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 3, 31, 21, 36, 23) 2026-03-31 21:36:23.619 | INFO | [Emotion fleet_1] 51 2026-03-31 21:36:23.622 | INFO | [Emotion fleet_2] 119 2026-03-31 21:36:29.580 | INFO | Combat auto check timer reached 2026-03-31 21:36:49.603 | INFO | Screenshot interval set to 0.3s 2026-03-31 21:36:49.606 | INFO | Auto Search combat status 2026-03-31 21:36:51.096 | INFO | Click (1023, 656) @ GET_SHIP 2026-03-31 21:36:52.300 | INFO | Click (1040, 660) @ GET_SHIP 2026-03-31 21:36:53.498 | INFO | Click (1022, 655) @ GET_SHIP 2026-03-31 21:36:54.700 | INFO | Click (1019, 662) @ GET_SHIP 2026-03-31 21:36:56.494 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_1 ─────────────────────────────────────────────────────── 2026-03-31 21:36:56.499 | INFO | BATTLE_1 2026-03-31 21:36:56.502 | INFO | Auto search moving 2026-03-31 21:36:56.505 | INFO | Fleet: 1, fleet_current_index: 1 2026-03-31 21:36:56.586 | INFO | [OCR_OIL 0.078s] 20605 2026-03-31 21:36:56.691 | INFO | [OCR_COIN 0.101s] 247331 2026-03-31 21:37:02.209 | INFO | [Loading] 15% 2026-03-31 21:37:02.213 | INFO | Auto search combat loading 2026-03-31 21:37:02.216 | INFO | Screenshot interval set to 1.0s 2026-03-31 21:37:08.215 | INFO | [BattleUI] PAUSE 2026-03-31 21:37:08.218 | INFO | Auto Search combat execute 2026-03-31 21:37:08.221 | INFO | <<< EMOTION REDUCE >>> 2026-03-31 21:37:08.234 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-03-31 21:37:08.244 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=49, Main.Emotion.Fleet1Record=datetime.datetime(2026, 3, 31, 21, 37, 8), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 3, 31, 21, 37, 8) 2026-03-31 21:37:08.261 | INFO | [Emotion fleet_1] 49 2026-03-31 21:37:08.265 | INFO | [Emotion fleet_2] 119 2026-03-31 21:37:14.207 | INFO | Combat auto check timer reached 2026-03-31 21:37:33.254 | INFO | Screenshot interval set to 0.3s 2026-03-31 21:37:33.259 | INFO | Auto Search combat status 2026-03-31 21:37:34.430 | INFO | Click (1023, 666) @ GET_SHIP 2026-03-31 21:37:35.637 | INFO | Click (1036, 669) @ GET_SHIP 2026-03-31 21:37:36.874 | INFO | Click (1013, 662) @ GET_SHIP 2026-03-31 21:37:37.726 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_2 ─────────────────────────────────────────────────────── 2026-03-31 21:37:37.731 | INFO | BATTLE_2 2026-03-31 21:37:37.733 | INFO | Auto search moving 2026-03-31 21:37:37.737 | INFO | Fleet: 1, fleet_current_index: 1 2026-03-31 21:37:37.817 | INFO | [OCR_OIL 0.074s] 20586 2026-03-31 21:37:37.906 | INFO | [OCR_COIN 0.085s] 247343 2026-03-31 21:37:41.942 | INFO | [Loading] 5% 2026-03-31 21:37:41.946 | INFO | Auto search combat loading 2026-03-31 21:37:41.950 | INFO | Screenshot interval set to 1.0s 2026-03-31 21:37:47.944 | INFO | [BattleUI] PAUSE 2026-03-31 21:37:47.950 | INFO | Auto Search combat execute 2026-03-31 21:37:47.953 | INFO | <<< EMOTION REDUCE >>> 2026-03-31 21:37:47.964 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-03-31 21:37:47.971 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=47, Main.Emotion.Fleet1Record=datetime.datetime(2026, 3, 31, 21, 37, 47), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 3, 31, 21, 37, 47) 2026-03-31 21:37:47.987 | INFO | [Emotion fleet_1] 47 2026-03-31 21:37:47.991 | INFO | [Emotion fleet_2] 119 2026-03-31 21:37:53.936 | INFO | Combat auto check timer reached 2026-03-31 21:38:34.991 | INFO | Click (1030, 652) @ GET_SHIP 2026-03-31 21:38:36.004 | INFO | Click (1041, 659) @ GET_SHIP 2026-03-31 21:38:37.990 | INFO | Click (1046, 660) @ GET_SHIP 2026-03-31 21:38:39.007 | INFO | Click (1027, 649) @ GET_SHIP 2026-03-31 21:38:40.999 | INFO | Screenshot interval set to 0.3s 2026-03-31 21:38:41.003 | INFO | Auto Search combat status 2026-03-31 21:38:41.009 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_3 ─────────────────────────────────────────────────────── 2026-03-31 21:38:41.018 | INFO | BATTLE_3 2026-03-31 21:38:41.023 | INFO | Auto search moving 2026-03-31 21:38:41.028 | INFO | Fleet: 1, fleet_current_index: 1 2026-03-31 21:38:41.109 | INFO | [OCR_OIL 0.076s] 20567 2026-03-31 21:38:41.180 | INFO | [OCR_COIN 0.066s] 247358 2026-03-31 21:38:44.886 | INFO | [Loading] 7% 2026-03-31 21:38:44.889 | INFO | Auto search combat loading 2026-03-31 21:38:44.894 | INFO | Screenshot interval set to 1.0s 2026-03-31 21:38:50.893 | INFO | [BattleUI] PAUSE 2026-03-31 21:38:50.897 | INFO | Auto Search combat execute 2026-03-31 21:38:50.900 | INFO | <<< EMOTION REDUCE >>> 2026-03-31 21:38:50.911 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-03-31 21:38:50.916 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=45, Main.Emotion.Fleet1Record=datetime.datetime(2026, 3, 31, 21, 38, 50), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 3, 31, 21, 38, 50) 2026-03-31 21:38:50.933 | INFO | [Emotion fleet_1] 45 2026-03-31 21:38:50.938 | INFO | [Emotion fleet_2] 119 2026-03-31 21:38:56.894 | INFO | Combat auto check timer reached 2026-03-31 21:39:30.938 | INFO | Screenshot interval set to 0.3s 2026-03-31 21:39:30.943 | INFO | Auto Search combat status 2026-03-31 21:39:31.826 | INFO | Click (1021, 651) @ GET_SHIP 2026-03-31 21:39:33.029 | INFO | Click (1004, 668) @ GET_SHIP 2026-03-31 21:39:34.229 | INFO | Click (1020, 652) @ GET_SHIP 2026-03-31 21:39:35.427 | INFO | Click (1017, 668) @ GET_SHIP 2026-03-31 21:39:37.226 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_4 ─────────────────────────────────────────────────────── 2026-03-31 21:39:37.233 | INFO | BATTLE_4 2026-03-31 21:39:37.236 | INFO | Auto search moving 2026-03-31 21:39:37.240 | INFO | Fleet: 1, fleet_current_index: 1 2026-03-31 21:39:37.313 | INFO | [OCR_OIL 0.069s] 20548 2026-03-31 21:39:37.392 | INFO | [OCR_COIN 0.076s] 247376 2026-03-31 21:39:41.742 | INFO | [Loading] 13% 2026-03-31 21:39:41.745 | INFO | Auto search combat loading 2026-03-31 21:39:41.747 | INFO | Screenshot interval set to 1.0s 2026-03-31 21:39:46.750 | INFO | [BattleUI] PAUSE 2026-03-31 21:39:46.754 | INFO | Auto Search combat execute 2026-03-31 21:39:46.757 | INFO | <<< EMOTION REDUCE >>> 2026-03-31 21:39:46.771 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-03-31 21:39:46.774 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=43, Main.Emotion.Fleet1Record=datetime.datetime(2026, 3, 31, 21, 39, 46), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 3, 31, 21, 39, 46) 2026-03-31 21:39:46.790 | INFO | [Emotion fleet_1] 43 2026-03-31 21:39:46.797 | INFO | [Emotion fleet_2] 119 2026-03-31 21:39:52.749 | INFO | Combat auto check timer reached 2026-03-31 21:40:48.806 | INFO | Click (1024, 643) @ GET_SHIP 2026-03-31 21:40:49.810 | INFO | Click (1025, 650) @ GET_SHIP 2026-03-31 21:40:51.824 | INFO | Click (1034, 651) @ GET_SHIP 2026-03-31 21:40:52.814 | INFO | Screenshot interval set to 0.3s 2026-03-31 21:40:52.818 | INFO | Auto Search combat status 2026-03-31 21:40:52.831 | INFO | Click (1023, 663) @ GET_SHIP 2026-03-31 21:40:53.986 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_5 ─────────────────────────────────────────────────────── 2026-03-31 21:40:53.992 | INFO | BATTLE_5 2026-03-31 21:40:53.996 | INFO | Auto search moving 2026-03-31 21:40:54.003 | INFO | Fleet: 1, fleet_current_index: 1 2026-03-31 21:40:54.079 | INFO | [OCR_OIL 0.070s] 20529 2026-03-31 21:40:54.169 | INFO | [OCR_COIN 0.087s] 247388 2026-03-31 21:40:56.104 | INFO | [Loading] 13% 2026-03-31 21:40:56.108 | INFO | Auto search combat loading 2026-03-31 21:40:56.112 | INFO | Screenshot interval set to 1.0s 2026-03-31 21:41:02.131 | INFO | [BattleUI] PAUSE 2026-03-31 21:41:02.137 | INFO | Auto Search combat execute 2026-03-31 21:41:02.140 | INFO | <<< EMOTION REDUCE >>> 2026-03-31 21:41:02.158 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-03-31 21:41:02.164 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=41, Main.Emotion.Fleet1Record=datetime.datetime(2026, 3, 31, 21, 41, 2), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 3, 31, 21, 41, 2) 2026-03-31 21:41:02.184 | INFO | [Emotion fleet_1] 41 2026-03-31 21:41:02.189 | INFO | [Emotion fleet_2] 119 2026-03-31 21:41:08.108 | INFO | Combat auto check timer reached 2026-03-31 21:42:16.192 | INFO | Click (1034, 639) @ GET_SHIP 2026-03-31 21:45:16.321 | 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 L428 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-31 21:45:16.345 | WARNING | Wait too long 2026-03-31 21:45:16.348 | 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-31 21:45:16.413 | INFO | [Package_name] com.bilibili.azurlane 2026-03-31 21:45:16.416 | ERROR | GameStuckError: Wait too long 2026-03-31 21:45:16.418 | WARNING | Saving error: ./log/error/1774964716418