═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ MAIN ═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ ════════════════════════════════════════════════════ CAMPAIGN_13_1 ════════════════════════════════════════════════════ 2025-10-02 01:48:05.360 | INFO | CAMPAIGN_13_1 2025-10-02 01:48:05.365 | INFO | Count: 0 2025-10-02 01:48:05.385 | INFO | <<< UI ENSURE >>> 2025-10-02 01:48:05.390 | INFO | UI get current page 2025-10-02 01:48:05.912 | INFO | Unknown ui page 2025-10-02 01:48:06.392 | INFO | UI additional: IDLE_2 -> REWARD_GOTO_MAIN 2025-10-02 01:48:06.397 | INFO | Click ( 826, 611) @ REWARD_GOTO_MAIN 2025-10-02 01:48:06.573 | INFO | Unknown ui page 2025-10-02 01:48:06.719 | INFO | [Package_name] com.bilibili.azurlane 2025-10-02 01:48:06.739 | INFO | [Device Orientation] 0 (Normal) 2025-10-02 01:48:06.882 | INFO | Unknown ui page 2025-10-02 01:48:07.094 | INFO | [UI] page_main 2025-10-02 01:48:07.099 | INFO | Goto page_campaign 2025-10-02 01:48:07.103 | INFO | <<< UI GOTO PAGE_CAMPAIGN >>> 2025-10-02 01:48:07.120 | INFO | Page switch: page_main_white -> page_campaign_menu 2025-10-02 01:48:07.124 | INFO | Click (1178, 516) @ MAIN_GOTO_CAMPAIGN_WHITE 2025-10-02 01:48:07.700 | INFO | Page switch: page_campaign_menu -> page_campaign 2025-10-02 01:48:07.703 | INFO | Click ( 378, 336) @ CAMPAIGN_MENU_GOTO_CAMPAIGN 2025-10-02 01:48:07.996 | INFO | Page arrive: page_campaign 2025-10-02 01:48:08.024 | INFO | Mode_switch_1 set to hard 2025-10-02 01:48:08.050 | INFO | [Mode_switch_1] hard 2025-10-02 01:48:08.054 | INFO | <<< UI ENSURE INDEX >>> 2025-10-02 01:48:08.132 | INFO | No stage found. 2025-10-02 01:48:08.364 | INFO | No stage found. 2025-10-02 01:48:08.682 | INFO | Loading OCR model: ./bin/cnocr_models/azur_lane 2025-10-02 01:48:08.804 | INFO | [campaign 0.140s] ['13--1', '13--3', '13--2', '13--4'] 2025-10-02 01:48:08.808 | INFO | [Chapter] 13 2025-10-02 01:48:08.810 | INFO | [Stage] 13-1, 13-3, 13-2, 13-4 2025-10-02 01:48:08.812 | INFO | [Index] 13 2025-10-02 01:48:08.893 | INFO | [OCR_OIL 0.051s] 6468 ──────────────────────────────────────────────────────── 13-1 ───────────────────────────────────────────────────────── 2025-10-02 01:48:08.899 | INFO | 13-1 2025-10-02 01:48:08.902 | INFO | Expect emotion reduce: (12, 2) 2025-10-02 01:48:08.912 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-10-02 01:48:08.916 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=53, Main.Emotion.Fleet1Record=datetime.datetime(2025, 10, 2, 1, 48, 8), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 10, 2, 1, 48, 8) 2025-10-02 01:48:08.931 | INFO | [Emotion fleet_1] 53 2025-10-02 01:48:08.936 | INFO | [Emotion fleet_2] 119 2025-10-02 01:48:08.940 | INFO | <<< ENTER MAP >>> 2025-10-02 01:48:09.017 | INFO | Click ( 187, 274) @ 13-1 2025-10-02 01:48:09.727 | INFO | [Map_clear_percentage] 49% 2025-10-02 01:48:10.022 | INFO | [Map_clear_percentage] 99% 2025-10-02 01:48:10.049 | INFO | [MAP_CLEAR_ALL_THIS_TIME] False 2025-10-02 01:48:10.053 | INFO | [Map_info] 99%, star_1, star_2, star_3, 100_percent_clear, 3_stars, threat_safe, clear_mode 2025-10-02 01:48:10.057 | INFO | [StopCondition_MapAchievement] non_stop 2025-10-02 01:48:10.060 | INFO | Fast_Forward set to on 2025-10-02 01:48:10.064 | INFO | [Fast_Forward] on 2025-10-02 01:48:10.078 | INFO | Auto_Search set to on 2025-10-02 01:48:10.082 | INFO | [Auto_Search] on 2025-10-02 01:48:10.090 | INFO | Click ( 922, 509) @ MAP_PREPARATION 2025-10-02 01:48:10.620 | INFO | Handling 2x book setting, mode=prep. 2025-10-02 01:48:10.644 | INFO | Using fleet: [4, 3, 1] 2025-10-02 01:48:10.726 | INFO | Hard satisfied: Fleet_1: None, Fleet_2: None, Submarine: None 2025-10-02 01:48:10.736 | INFO | [map_allow_submarine] True 2025-10-02 01:48:10.740 | INFO | Click (1066, 479) @ SUBMARINE_CHOOSE 2025-10-02 01:48:10.917 | INFO | Current selected: [1] 2025-10-02 01:48:10.924 | INFO | Click (1070, 462) @ SUBMARINE_CHOOSE 2025-10-02 01:48:11.223 | INFO | Click (1134, 332) @ FLEET_2_CLEAR 2025-10-02 01:48:11.819 | INFO | Click (1054, 234) @ FLEET_1_CHOOSE 2025-10-02 01:48:12.118 | INFO | Current selected: [4] 2025-10-02 01:48:12.124 | INFO | Click (1049, 224) @ FLEET_1_CHOOSE 2025-10-02 01:48:12.419 | INFO | Click (1042, 340) @ FLEET_2_CHOOSE 2025-10-02 01:48:12.718 | INFO | Current selected: [4] 2025-10-02 01:48:12.724 | INFO | Click (1093, 478) @ FLEET_2_BAR_INDEX_3 2025-10-02 01:48:13.021 | INFO | Auto search setting 2025-10-02 01:48:13.036 | INFO | [_fleet_sidebar_offset] 0 2025-10-02 01:48:13.041 | INFO | [Fleet_sidebar] 1/3 2025-10-02 01:48:13.045 | INFO | Click (1195, 441) @ FLEET_SIDEBAR_0_2 2025-10-02 01:48:13.515 | INFO | [_fleet_sidebar_offset] 0 2025-10-02 01:48:13.520 | INFO | [Fleet_sidebar] 3/3 2025-10-02 01:48:13.525 | INFO | [Auto_Search_Setting] fleet1_all_fleet2_standby, sub_auto_call 2025-10-02 01:48:13.528 | INFO | Click ( 505, 219) @ AUTO_SEARCH_SET_MOB 2025-10-02 01:48:13.976 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_auto_call 2025-10-02 01:48:13.980 | INFO | Selected to the correct auto search setting 2025-10-02 01:48:13.983 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_auto_call 2025-10-02 01:48:13.986 | INFO | Selected to the correct auto search setting 2025-10-02 01:48:13.992 | INFO | Click (1063, 579) @ FLEET_PREPARATION 2025-10-02 01:48:14.894 | INFO | is_auto_search_running appeared ────────────────────────────────────────────────────── BATTLE_0 ─────────────────────────────────────────────────────── 2025-10-02 01:48:14.900 | INFO | BATTLE_0 2025-10-02 01:48:14.902 | INFO | Auto search moving 2025-10-02 01:48:14.914 | INFO | Fleet: 1, fleet_current_index: 1 2025-10-02 01:48:14.978 | INFO | [OCR_OIL 0.060s] 6458 2025-10-02 01:48:15.048 | INFO | [OCR_COIN 0.066s] 103074 2025-10-02 01:48:20.988 | INFO | [Loading] 7% 2025-10-02 01:48:20.992 | INFO | Auto search combat loading 2025-10-02 01:48:20.995 | INFO | Screenshot interval set to 1.0s 2025-10-02 01:48:26.992 | INFO | [BattleUI] PAUSE 2025-10-02 01:48:26.995 | INFO | Auto Search combat execute 2025-10-02 01:48:26.998 | INFO | <<< EMOTION REDUCE >>> 2025-10-02 01:48:27.011 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-10-02 01:48:27.018 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=51, Main.Emotion.Fleet1Record=datetime.datetime(2025, 10, 2, 1, 48, 27), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 10, 2, 1, 48, 27) 2025-10-02 01:48:27.033 | INFO | [Emotion fleet_1] 51 2025-10-02 01:48:27.041 | INFO | [Emotion fleet_2] 119 2025-10-02 01:48:32.999 | INFO | Combat auto check timer reached 2025-10-02 01:48:52.031 | INFO | Screenshot interval set to 0.3s 2025-10-02 01:48:52.035 | INFO | Auto Search combat status 2025-10-02 01:48:53.511 | INFO | Click (1029, 658) @ GET_SHIP 2025-10-02 01:48:54.709 | INFO | Click (1034, 665) @ GET_SHIP 2025-10-02 01:48:57.129 | INFO | Click (1043, 653) @ GET_SHIP 2025-10-02 01:48:58.323 | INFO | Click (1039, 651) @ GET_SHIP 2025-10-02 01:48:59.206 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_1 ─────────────────────────────────────────────────────── 2025-10-02 01:48:59.210 | INFO | BATTLE_1 2025-10-02 01:48:59.212 | INFO | Auto search moving 2025-10-02 01:48:59.217 | INFO | Fleet: 1, fleet_current_index: 1 2025-10-02 01:48:59.286 | INFO | [OCR_OIL 0.064s] 6417 2025-10-02 01:48:59.380 | INFO | [OCR_COIN 0.087s] 103091 2025-10-02 01:49:04.015 | INFO | Skip map cat attack 2025-10-02 01:49:04.019 | INFO | Click (1201, 677) @ MAP_CAT_ATTACK 2025-10-02 01:49:05.823 | INFO | [Loading] 10% 2025-10-02 01:49:05.828 | INFO | Auto search combat loading 2025-10-02 01:49:05.831 | INFO | Screenshot interval set to 1.0s 2025-10-02 01:49:11.839 | INFO | [BattleUI] PAUSE 2025-10-02 01:49:11.843 | INFO | Auto Search combat execute 2025-10-02 01:49:11.845 | INFO | <<< EMOTION REDUCE >>> 2025-10-02 01:49:11.856 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-10-02 01:49:11.861 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=49, Main.Emotion.Fleet1Record=datetime.datetime(2025, 10, 2, 1, 49, 11), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 10, 2, 1, 49, 11) 2025-10-02 01:49:11.878 | INFO | [Emotion fleet_1] 49 2025-10-02 01:49:11.883 | INFO | [Emotion fleet_2] 119 2025-10-02 01:49:17.827 | INFO | Combat auto check timer reached 2025-10-02 01:49:37.855 | INFO | Click (1034, 675) @ GET_SHIP 2025-10-02 01:49:39.856 | INFO | Click (1013, 657) @ GET_SHIP 2025-10-02 01:49:42.865 | INFO | Click (1025, 660) @ GET_SHIP 2025-10-02 01:49:44.866 | INFO | Screenshot interval set to 0.3s 2025-10-02 01:49:44.869 | INFO | Auto Search combat status 2025-10-02 01:49:44.872 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_2 ─────────────────────────────────────────────────────── 2025-10-02 01:49:44.876 | INFO | BATTLE_2 2025-10-02 01:49:44.882 | INFO | Auto search moving 2025-10-02 01:49:44.887 | INFO | Fleet: 1, fleet_current_index: 1 2025-10-02 01:49:44.973 | INFO | [OCR_OIL 0.077s] 6376 2025-10-02 01:49:45.068 | INFO | [OCR_COIN 0.091s] 103109 2025-10-02 01:49:49.665 | INFO | [Loading] 9% 2025-10-02 01:49:49.669 | INFO | Auto search combat loading 2025-10-02 01:49:49.672 | INFO | Screenshot interval set to 1.0s 2025-10-02 01:49:55.666 | INFO | [BattleUI] PAUSE 2025-10-02 01:49:55.669 | INFO | Auto Search combat execute 2025-10-02 01:49:55.671 | INFO | <<< EMOTION REDUCE >>> 2025-10-02 01:49:55.682 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-10-02 01:49:55.686 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=47, Main.Emotion.Fleet1Record=datetime.datetime(2025, 10, 2, 1, 49, 55), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 10, 2, 1, 49, 55) 2025-10-02 01:49:55.704 | INFO | [Emotion fleet_1] 47 2025-10-02 01:49:55.711 | INFO | [Emotion fleet_2] 119 2025-10-02 01:50:01.673 | INFO | Combat auto check timer reached 2025-10-02 01:50:17.704 | INFO | Click (1036, 658) @ GET_SHIP 2025-10-02 01:50:18.707 | INFO | Click (1039, 665) @ GET_SHIP 2025-10-02 01:50:20.700 | INFO | Screenshot interval set to 0.3s 2025-10-02 01:50:20.704 | INFO | Auto Search combat status 2025-10-02 01:50:20.707 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_3 ─────────────────────────────────────────────────────── 2025-10-02 01:50:20.710 | INFO | BATTLE_3 2025-10-02 01:50:20.714 | INFO | Auto search moving 2025-10-02 01:50:20.719 | INFO | Fleet: 1, fleet_current_index: 1 2025-10-02 01:50:20.795 | INFO | [OCR_OIL 0.072s] 6335 2025-10-02 01:50:20.891 | INFO | [OCR_COIN 0.091s] 103128 2025-10-02 01:50:26.401 | INFO | Skip map cat attack 2025-10-02 01:50:26.406 | INFO | Click (1217, 678) @ MAP_CAT_ATTACK 2025-10-02 01:50:28.202 | INFO | [Loading] 9% 2025-10-02 01:50:28.206 | INFO | Auto search combat loading 2025-10-02 01:50:28.209 | INFO | Screenshot interval set to 1.0s 2025-10-02 01:50:34.217 | INFO | [BattleUI] PAUSE 2025-10-02 01:50:34.223 | INFO | Auto Search combat execute 2025-10-02 01:50:34.227 | INFO | <<< EMOTION REDUCE >>> 2025-10-02 01:50:34.239 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-10-02 01:50:34.244 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=45, Main.Emotion.Fleet1Record=datetime.datetime(2025, 10, 2, 1, 50, 34), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 10, 2, 1, 50, 34) 2025-10-02 01:50:34.262 | INFO | [Emotion fleet_1] 45 2025-10-02 01:50:34.268 | INFO | [Emotion fleet_2] 119 2025-10-02 01:50:40.199 | INFO | Combat auto check timer reached 2025-10-02 01:50:59.233 | INFO | Screenshot interval set to 0.3s 2025-10-02 01:50:59.238 | INFO | Auto Search combat status 2025-10-02 01:51:00.130 | INFO | Click (1021, 662) @ GET_SHIP 2025-10-02 01:51:01.328 | INFO | Click (1031, 670) @ GET_SHIP 2025-10-02 01:51:03.731 | INFO | Click (1040, 654) @ GET_SHIP 2025-10-02 01:51:04.943 | INFO | Click (1032, 671) @ GET_SHIP 2025-10-02 01:51:05.827 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_4 ─────────────────────────────────────────────────────── 2025-10-02 01:51:05.832 | INFO | BATTLE_4 2025-10-02 01:51:05.835 | INFO | Auto search moving 2025-10-02 01:51:05.838 | INFO | Fleet: 1, fleet_current_index: 1 2025-10-02 01:51:05.908 | INFO | [OCR_OIL 0.067s] 6294 2025-10-02 01:51:05.998 | INFO | [OCR_COIN 0.085s] 103138 2025-10-02 01:51:11.840 | INFO | [Loading] 10% 2025-10-02 01:51:11.844 | INFO | Auto search combat loading 2025-10-02 01:51:11.846 | INFO | Screenshot interval set to 1.0s 2025-10-02 01:51:17.843 | INFO | [BattleUI] PAUSE 2025-10-02 01:51:17.848 | INFO | Auto Search combat execute 2025-10-02 01:51:17.851 | INFO | <<< EMOTION REDUCE >>> 2025-10-02 01:51:17.863 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-10-02 01:51:17.868 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=43, Main.Emotion.Fleet1Record=datetime.datetime(2025, 10, 2, 1, 51, 17), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 10, 2, 1, 51, 17) 2025-10-02 01:51:17.890 | INFO | [Emotion fleet_1] 43 2025-10-02 01:51:17.894 | INFO | [Emotion fleet_2] 119 2025-10-02 01:51:22.852 | INFO | Combat auto check timer reached 2025-10-02 01:52:02.886 | INFO | Click (1005, 660) @ GET_SHIP 2025-10-02 01:52:03.886 | INFO | Click (1046, 659) @ GET_SHIP 2025-10-02 01:52:05.909 | INFO | Click (1028, 663) @ GET_SHIP 2025-10-02 01:52:06.891 | INFO | Screenshot interval set to 0.3s 2025-10-02 01:52:06.895 | INFO | Auto Search combat status 2025-10-02 01:52:07.183 | INFO | Click (1036, 655) @ GET_SHIP 2025-10-02 01:52:08.074 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_5 ─────────────────────────────────────────────────────── 2025-10-02 01:52:08.079 | INFO | BATTLE_5 2025-10-02 01:52:08.081 | INFO | Auto search moving 2025-10-02 01:52:08.084 | INFO | Fleet: 1, fleet_current_index: 1 2025-10-02 01:52:08.157 | INFO | [OCR_OIL 0.070s] 6271 2025-10-02 01:52:08.243 | INFO | [OCR_COIN 0.079s] 103162 2025-10-02 01:55:08.283 | 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 L1521 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 L422 run() campaign_base.py L143 run() campaign_base.py L177 auto_search_execute_a_battle() auto_search_combat.py L182 auto_search_moving() device.py L188 screenshot() device.py L250 stuck_record_check() device.py L43 show_function_call() 2025-10-02 01:55:08.313 | WARNING | Wait too long 2025-10-02 01:55:08.316 | WARNING | Waiting for {'CAMPAIGN_CHECK', 'SP_CHECK', 'PAUSE', 'EVENT_CHECK', 'GAME_TIPS3', 'AUTO_SEARCH_MAP_OPTION_OFF', 'GAME_TIPS4', 'OCR_OIL_CHECK', 'RETIRE_APPEAR_3', 'DOCK_CHECK', 'GAME_TIPS', 'FLEET_NUM_1', 'AUTO_SEARCH_MAP_OPTION_ON'} 2025-10-02 01:55:08.427 | INFO | [Package_name] com.bilibili.azurlane 2025-10-02 01:55:08.431 | ERROR | GameStuckError: Wait too long 2025-10-02 01:55:08.433 | WARNING | Saving error: ./log/error/1759341308433