═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ MAIN ═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ ════════════════════════════════════════════════════ CAMPAIGN_13_1 ════════════════════════════════════════════════════ 2026-05-16 18:30:01.893 | INFO | CAMPAIGN_13_1 2026-05-16 18:30:01.896 | INFO | Count: 0 2026-05-16 18:30:01.913 | INFO | <<< UI ENSURE >>> 2026-05-16 18:30:01.916 | INFO | UI get current page 2026-05-16 18:30:02.439 | INFO | Unknown ui page 2026-05-16 18:30:02.900 | INFO | UI additional: IDLE -> REWARD_GOTO_MAIN 2026-05-16 18:30:02.906 | INFO | Click ( 855, 617) @ REWARD_GOTO_MAIN 2026-05-16 18:30:03.076 | INFO | Unknown ui page 2026-05-16 18:30:03.214 | INFO | [Package_name] com.bilibili.azurlane 2026-05-16 18:30:03.235 | INFO | [Device Orientation] 0 (Normal) 2026-05-16 18:30:03.383 | INFO | Unknown ui page 2026-05-16 18:30:03.680 | INFO | Unknown ui page 2026-05-16 18:30:03.910 | INFO | [UI] page_main 2026-05-16 18:30:03.914 | INFO | Goto page_campaign 2026-05-16 18:30:03.917 | INFO | <<< UI GOTO PAGE_CAMPAIGN >>> 2026-05-16 18:30:03.934 | INFO | Page switch: page_main_white -> page_campaign_menu 2026-05-16 18:30:03.940 | INFO | Click (1170, 499) @ MAIN_GOTO_CAMPAIGN_WHITE 2026-05-16 18:30:04.507 | INFO | Page switch: page_campaign_menu -> page_campaign 2026-05-16 18:30:04.511 | INFO | Click ( 331, 359) @ CAMPAIGN_MENU_GOTO_CAMPAIGN 2026-05-16 18:30:04.801 | INFO | Page arrive: page_campaign 2026-05-16 18:30:04.828 | INFO | Mode_switch_1 set to hard 2026-05-16 18:30:04.853 | INFO | [Mode_switch_1] hard 2026-05-16 18:30:04.857 | INFO | <<< UI ENSURE INDEX >>> 2026-05-16 18:30:04.927 | INFO | No stage found. 2026-05-16 18:30:05.165 | INFO | No stage found. 2026-05-16 18:30:05.467 | INFO | No stage found. 2026-05-16 18:30:05.880 | INFO | Loading OCR model: ./bin/cnocr_models/azur_lane 2026-05-16 18:30:05.997 | INFO | [campaign 0.223s] ['13--1', '13--3', '13--2', '13--4'] 2026-05-16 18:30:06.001 | INFO | [Chapter] 13 2026-05-16 18:30:06.005 | INFO | [Stage] 13-1, 13-3, 13-2, 13-4 2026-05-16 18:30:06.009 | INFO | [Index] 13 2026-05-16 18:30:06.098 | INFO | [OCR_OIL 0.061s] 18150 ──────────────────────────────────────────────────────── 13-1 ───────────────────────────────────────────────────────── 2026-05-16 18:30:06.102 | INFO | 13-1 2026-05-16 18:30:06.107 | INFO | Expect emotion reduce: (12, 2) 2026-05-16 18:30:06.119 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-05-16 18:30:06.124 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=53, Main.Emotion.Fleet1Record=datetime.datetime(2026, 5, 16, 18, 30, 6), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 5, 16, 18, 30, 6) 2026-05-16 18:30:06.141 | INFO | [Emotion fleet_1] 53 2026-05-16 18:30:06.145 | INFO | [Emotion fleet_2] 119 2026-05-16 18:30:06.148 | INFO | <<< ENTER MAP >>> 2026-05-16 18:30:06.224 | INFO | Click ( 184, 283) @ 13-1 2026-05-16 18:30:06.629 | INFO | [Map_clear_percentage] 5% 2026-05-16 18:30:06.928 | INFO | [Map_clear_percentage] 72% 2026-05-16 18:30:07.228 | INFO | [Map_clear_percentage] 99% 2026-05-16 18:30:07.253 | INFO | [MAP_CLEAR_ALL_THIS_TIME] False 2026-05-16 18:30:07.256 | INFO | [Map_info] 99%, star_1, star_2, star_3, 100_percent_clear, 3_stars, threat_safe, clear_mode 2026-05-16 18:30:07.261 | INFO | [StopCondition_MapAchievement] non_stop 2026-05-16 18:30:07.264 | INFO | Fast_Forward set to on 2026-05-16 18:30:07.267 | INFO | [Fast_Forward] on 2026-05-16 18:30:07.282 | INFO | Auto_Search set to on 2026-05-16 18:30:07.287 | INFO | [Auto_Search] on 2026-05-16 18:30:07.293 | INFO | Click ( 982, 515) @ MAP_PREPARATION 2026-05-16 18:30:07.528 | INFO | Handling 2x book setting, mode=prep. 2026-05-16 18:30:07.551 | INFO | Using fleet: [4, 3, 1] 2026-05-16 18:30:07.629 | INFO | Hard satisfied: Fleet_1: None, Fleet_2: None, Submarine: None 2026-05-16 18:30:07.638 | INFO | [map_allow_submarine] True 2026-05-16 18:30:07.645 | INFO | Click (1143, 336) @ FLEET_2_CLEAR 2026-05-16 18:30:07.699 | INFO | Click (1040, 469) @ SUBMARINE_CHOOSE 2026-05-16 18:30:07.825 | INFO | Current selected: [1] 2026-05-16 18:30:07.830 | INFO | Click (1052, 492) @ SUBMARINE_CHOOSE 2026-05-16 18:30:08.127 | INFO | Click (1054, 230) @ FLEET_1_CHOOSE 2026-05-16 18:30:08.425 | INFO | Current selected: [4] 2026-05-16 18:30:08.429 | INFO | Click (1054, 214) @ FLEET_1_CHOOSE 2026-05-16 18:30:08.721 | INFO | Click (1071, 332) @ FLEET_2_CHOOSE 2026-05-16 18:30:09.022 | INFO | Current selected: [4] 2026-05-16 18:30:09.028 | INFO | Click (1115, 486) @ FLEET_2_BAR_INDEX_3 2026-05-16 18:30:09.328 | INFO | Auto search setting 2026-05-16 18:30:09.345 | INFO | [_fleet_sidebar_offset] 0 2026-05-16 18:30:09.351 | INFO | [_fleet_sidebar_offset] 0 2026-05-16 18:30:09.355 | INFO | [Fleet_sidebar] 1/3 2026-05-16 18:30:09.362 | INFO | Click (1206, 397) @ FLEET_SIDEBAR_0_2 2026-05-16 18:30:09.625 | INFO | [_fleet_sidebar_offset] 0 2026-05-16 18:30:09.631 | INFO | [Fleet_sidebar] 3/3 2026-05-16 18:30:09.634 | INFO | [Auto_Search_Setting] fleet1_all_fleet2_standby, sub_standby 2026-05-16 18:30:09.637 | INFO | Click ( 502, 215) @ AUTO_SEARCH_SET_MOB 2026-05-16 18:30:10.107 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_standby 2026-05-16 18:30:10.110 | INFO | Selected to the correct auto search setting 2026-05-16 18:30:10.113 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_standby 2026-05-16 18:30:10.116 | INFO | Selected to the correct auto search setting 2026-05-16 18:30:10.118 | INFO | Click (1059, 606) @ FLEET_PREPARATION 2026-05-16 18:30:11.018 | INFO | is_auto_search_running appeared ────────────────────────────────────────────────────── BATTLE_0 ─────────────────────────────────────────────────────── 2026-05-16 18:30:11.023 | INFO | BATTLE_0 2026-05-16 18:30:11.026 | INFO | Auto search moving 2026-05-16 18:30:11.039 | INFO | Fleet: 1, fleet_current_index: 1 2026-05-16 18:30:11.121 | INFO | [OCR_OIL 0.076s] 18140 2026-05-16 18:30:11.219 | INFO | [OCR_COIN 0.094s] 386786 2026-05-16 18:30:15.708 | INFO | [Loading] 16% 2026-05-16 18:30:15.716 | INFO | Auto search combat loading 2026-05-16 18:30:15.720 | INFO | Screenshot interval set to 1.0s 2026-05-16 18:30:21.715 | INFO | [BattleUI] PAUSE 2026-05-16 18:30:21.719 | INFO | Auto Search combat execute 2026-05-16 18:30:21.721 | INFO | <<< EMOTION REDUCE >>> 2026-05-16 18:30:21.732 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-05-16 18:30:21.739 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=51, Main.Emotion.Fleet1Record=datetime.datetime(2026, 5, 16, 18, 30, 21), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 5, 16, 18, 30, 21) 2026-05-16 18:30:21.761 | INFO | [Emotion fleet_1] 51 2026-05-16 18:30:21.764 | INFO | [Emotion fleet_2] 119 2026-05-16 18:30:27.708 | INFO | Combat auto check timer reached 2026-05-16 18:31:05.758 | INFO | Click (1034, 665) @ GET_SHIP 2026-05-16 18:31:06.769 | INFO | Click (1013, 673) @ GET_SHIP 2026-05-16 18:31:08.758 | INFO | Click (1035, 651) @ GET_SHIP 2026-05-16 18:31:09.763 | INFO | Click (1024, 675) @ GET_SHIP 2026-05-16 18:31:11.767 | INFO | Screenshot interval set to 0.3s 2026-05-16 18:31:11.770 | INFO | Auto Search combat status 2026-05-16 18:31:11.775 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_1 ─────────────────────────────────────────────────────── 2026-05-16 18:31:11.782 | INFO | BATTLE_1 2026-05-16 18:31:11.785 | INFO | Auto search moving 2026-05-16 18:31:11.791 | INFO | Fleet: 1, fleet_current_index: 1 2026-05-16 18:31:11.880 | INFO | [OCR_OIL 0.085s] 18121 2026-05-16 18:31:11.954 | INFO | [OCR_COIN 0.070s] 386811 2026-05-16 18:31:15.661 | INFO | [Loading] 5% 2026-05-16 18:31:15.665 | INFO | Auto search combat loading 2026-05-16 18:31:15.671 | INFO | Screenshot interval set to 1.0s 2026-05-16 18:31:21.670 | INFO | [BattleUI] PAUSE 2026-05-16 18:31:21.674 | INFO | Auto Search combat execute 2026-05-16 18:31:21.676 | INFO | <<< EMOTION REDUCE >>> 2026-05-16 18:31:21.688 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-05-16 18:31:21.693 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=49, Main.Emotion.Fleet1Record=datetime.datetime(2026, 5, 16, 18, 31, 21), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 5, 16, 18, 31, 21) 2026-05-16 18:31:21.709 | INFO | [Emotion fleet_1] 49 2026-05-16 18:31:21.712 | INFO | [Emotion fleet_2] 119 2026-05-16 18:31:27.663 | INFO | Combat auto check timer reached 2026-05-16 18:32:03.707 | INFO | Click (1028, 649) @ GET_SHIP 2026-05-16 18:32:05.730 | INFO | Click (1017, 661) @ GET_SHIP 2026-05-16 18:32:07.718 | INFO | Screenshot interval set to 0.3s 2026-05-16 18:32:07.722 | INFO | Auto Search combat status 2026-05-16 18:32:07.728 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_2 ─────────────────────────────────────────────────────── 2026-05-16 18:32:07.740 | INFO | BATTLE_2 2026-05-16 18:32:07.753 | INFO | Auto search moving 2026-05-16 18:32:07.762 | INFO | Fleet: 1, fleet_current_index: 1 2026-05-16 18:32:07.867 | INFO | [OCR_OIL 0.099s] 18102 2026-05-16 18:32:07.957 | INFO | [OCR_COIN 0.087s] 386828 2026-05-16 18:32:11.944 | INFO | [Loading] 6% 2026-05-16 18:32:11.949 | INFO | Auto search combat loading 2026-05-16 18:32:11.952 | INFO | Screenshot interval set to 1.0s 2026-05-16 18:32:17.964 | INFO | [BattleUI] PAUSE 2026-05-16 18:32:17.970 | INFO | Auto Search combat execute 2026-05-16 18:32:17.975 | INFO | <<< EMOTION REDUCE >>> 2026-05-16 18:32:17.990 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-05-16 18:32:18.000 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=47, Main.Emotion.Fleet1Record=datetime.datetime(2026, 5, 16, 18, 32, 17), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 5, 16, 18, 32, 17) 2026-05-16 18:32:18.020 | INFO | [Emotion fleet_1] 47 2026-05-16 18:32:18.025 | INFO | [Emotion fleet_2] 119 2026-05-16 18:32:23.968 | INFO | Combat auto check timer reached 2026-05-16 18:32:59.996 | INFO | Screenshot interval set to 0.3s 2026-05-16 18:32:59.999 | INFO | Auto Search combat status 2026-05-16 18:33:00.878 | INFO | Click (1023, 673) @ GET_SHIP 2026-05-16 18:33:02.376 | INFO | Click (1036, 640) @ GET_SHIP 2026-05-16 18:33:03.594 | INFO | Click (1019, 671) @ GET_SHIP 2026-05-16 18:33:04.772 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_3 ─────────────────────────────────────────────────────── 2026-05-16 18:33:04.778 | INFO | BATTLE_3 2026-05-16 18:33:04.782 | INFO | Auto search moving 2026-05-16 18:33:04.785 | INFO | Fleet: 1, fleet_current_index: 1 2026-05-16 18:33:04.891 | INFO | [OCR_OIL 0.103s] 18083 2026-05-16 18:33:04.976 | INFO | [OCR_COIN 0.081s] 386849 2026-05-16 18:33:10.193 | INFO | [Loading] 15% 2026-05-16 18:33:10.197 | INFO | Auto search combat loading 2026-05-16 18:33:10.199 | INFO | Screenshot interval set to 1.0s 2026-05-16 18:33:15.202 | INFO | [BattleUI] PAUSE 2026-05-16 18:33:15.207 | INFO | Auto Search combat execute 2026-05-16 18:33:15.210 | INFO | <<< EMOTION REDUCE >>> 2026-05-16 18:33:15.226 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-05-16 18:33:15.233 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=45, Main.Emotion.Fleet1Record=datetime.datetime(2026, 5, 16, 18, 33, 15), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 5, 16, 18, 33, 15) 2026-05-16 18:33:15.254 | INFO | [Emotion fleet_1] 45 2026-05-16 18:33:15.258 | INFO | [Emotion fleet_2] 119 2026-05-16 18:33:21.197 | INFO | Combat auto check timer reached 2026-05-16 18:33:41.231 | INFO | Click (1015, 653) @ GET_SHIP 2026-05-16 18:33:42.236 | INFO | Click (1019, 677) @ GET_SHIP 2026-05-16 18:33:44.240 | INFO | Click (1028, 636) @ GET_SHIP 2026-05-16 18:33:45.233 | INFO | Screenshot interval set to 0.3s 2026-05-16 18:33:45.237 | INFO | Auto Search combat status 2026-05-16 18:33:45.249 | INFO | Click (1018, 646) @ GET_SHIP 2026-05-16 18:33:46.420 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_4 ─────────────────────────────────────────────────────── 2026-05-16 18:33:46.425 | INFO | BATTLE_4 2026-05-16 18:33:46.427 | INFO | Auto search moving 2026-05-16 18:33:46.433 | INFO | Fleet: 1, fleet_current_index: 1 2026-05-16 18:33:46.521 | INFO | [OCR_OIL 0.083s] 18064 2026-05-16 18:33:46.618 | INFO | [OCR_COIN 0.094s] 386866 2026-05-16 18:33:50.626 | INFO | [Loading] 9% 2026-05-16 18:33:50.630 | INFO | Auto search combat loading 2026-05-16 18:33:50.634 | INFO | Screenshot interval set to 1.0s 2026-05-16 18:33:56.635 | INFO | [BattleUI] PAUSE 2026-05-16 18:33:56.641 | INFO | Auto Search combat execute 2026-05-16 18:33:56.644 | INFO | <<< EMOTION REDUCE >>> 2026-05-16 18:33:56.656 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-05-16 18:33:56.663 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=43, Main.Emotion.Fleet1Record=datetime.datetime(2026, 5, 16, 18, 33, 56), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 5, 16, 18, 33, 56) 2026-05-16 18:33:56.684 | INFO | [Emotion fleet_1] 43 2026-05-16 18:33:56.689 | INFO | [Emotion fleet_2] 119 2026-05-16 18:34:02.626 | INFO | Combat auto check timer reached 2026-05-16 18:34:38.684 | INFO | Screenshot interval set to 0.3s 2026-05-16 18:34:38.689 | INFO | Auto Search combat status 2026-05-16 18:34:39.565 | INFO | Click (1020, 663) @ GET_SHIP 2026-05-16 18:34:40.770 | INFO | Click (1030, 653) @ GET_SHIP 2026-05-16 18:34:41.972 | INFO | Click (1031, 663) @ GET_SHIP 2026-05-16 18:34:43.167 | INFO | Click (1021, 658) @ GET_SHIP 2026-05-16 18:34:45.269 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_5 ─────────────────────────────────────────────────────── 2026-05-16 18:34:45.275 | INFO | BATTLE_5 2026-05-16 18:34:45.278 | INFO | Auto search moving 2026-05-16 18:34:45.282 | INFO | Fleet: 1, fleet_current_index: 1 2026-05-16 18:34:45.386 | INFO | [OCR_OIL 0.099s] 18045 2026-05-16 18:34:45.494 | INFO | [OCR_COIN 0.103s] 386890 2026-05-16 18:34:47.375 | INFO | [Loading] 14% 2026-05-16 18:34:47.379 | INFO | Auto search combat loading 2026-05-16 18:34:47.381 | INFO | Screenshot interval set to 1.0s 2026-05-16 18:34:53.391 | INFO | [BattleUI] PAUSE 2026-05-16 18:34:53.395 | INFO | Auto Search combat execute 2026-05-16 18:34:53.400 | INFO | <<< EMOTION REDUCE >>> 2026-05-16 18:34:53.411 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-05-16 18:34:53.420 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=41, Main.Emotion.Fleet1Record=datetime.datetime(2026, 5, 16, 18, 34, 53), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 5, 16, 18, 34, 53) 2026-05-16 18:34:53.444 | INFO | [Emotion fleet_1] 41 2026-05-16 18:34:53.449 | INFO | [Emotion fleet_2] 119 2026-05-16 18:34:59.381 | INFO | Combat auto check timer reached 2026-05-16 18:36:04.455 | INFO | Click (1030, 660) @ GET_SHIP 2026-05-16 18:39:04.603 | 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 L1543 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 L431 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-05-16 18:39:04.627 | WARNING | Wait too long 2026-05-16 18:39:04.630 | WARNING | Waiting for {'NEW_SHIP', 'CAMPAIGN_CHECK', 'POPUP_CANCEL', 'GUILD_POPUP_CONFIRM', 'EXP_INFO_S', 'SP_CHECK', 'MISSION_POPUP_GO', 'GET_SHIP', 'BATTLE_STATUS_S', 'POPUP_CONFIRM_WHITE', 'PAUSE', 'BATTLE_STATUS_A', 'AUTO_SEARCH_MAP_OPTION_ON', 'BATTLE_STATUS_B', 'EXP_INFO_B', 'GET_MISSION', 'EXP_INFO_A', 'EVENT_CHECK'} 2026-05-16 18:39:04.700 | INFO | [Package_name] com.bilibili.azurlane 2026-05-16 18:39:04.704 | ERROR | GameStuckError: Wait too long 2026-05-16 18:39:04.709 | WARNING | Saving error: ./log/error/1778927944709