═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ MAIN ═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ ════════════════════════════════════════════════════ CAMPAIGN_13_1 ════════════════════════════════════════════════════ 2025-10-01 18:48:03.222 | INFO | CAMPAIGN_13_1 2025-10-01 18:48:03.228 | INFO | Count: 0 2025-10-01 18:48:03.255 | INFO | <<< UI ENSURE >>> 2025-10-01 18:48:03.262 | INFO | UI get current page 2025-10-01 18:48:03.792 | INFO | Unknown ui page 2025-10-01 18:48:04.260 | INFO | UI additional: IDLE -> REWARD_GOTO_MAIN 2025-10-01 18:48:04.264 | INFO | Click ( 826, 618) @ REWARD_GOTO_MAIN 2025-10-01 18:48:04.437 | INFO | Unknown ui page 2025-10-01 18:48:04.623 | INFO | [Package_name] com.bilibili.azurlane 2025-10-01 18:48:04.641 | INFO | [Device Orientation] 0 (Normal) 2025-10-01 18:48:04.781 | INFO | Unknown ui page 2025-10-01 18:48:04.991 | INFO | [UI] page_main 2025-10-01 18:48:04.997 | INFO | Goto page_campaign 2025-10-01 18:48:05.001 | INFO | <<< UI GOTO PAGE_CAMPAIGN >>> 2025-10-01 18:48:05.017 | INFO | Page switch: page_main_white -> page_campaign_menu 2025-10-01 18:48:05.024 | INFO | Click (1214, 487) @ MAIN_GOTO_CAMPAIGN_WHITE 2025-10-01 18:48:05.595 | INFO | Page switch: page_campaign_menu -> page_campaign 2025-10-01 18:48:05.599 | INFO | Click ( 367, 364) @ CAMPAIGN_MENU_GOTO_CAMPAIGN 2025-10-01 18:48:05.890 | INFO | Page arrive: page_campaign 2025-10-01 18:48:05.915 | INFO | Mode_switch_1 set to hard 2025-10-01 18:48:05.944 | INFO | [Mode_switch_1] hard 2025-10-01 18:48:05.948 | INFO | <<< UI ENSURE INDEX >>> 2025-10-01 18:48:06.027 | INFO | No stage found. 2025-10-01 18:48:06.256 | INFO | No stage found. 2025-10-01 18:48:06.575 | INFO | Loading OCR model: ./bin/cnocr_models/azur_lane 2025-10-01 18:48:06.689 | INFO | [campaign 0.133s] ['13--1', '13--3', '13--2', '13--4'] 2025-10-01 18:48:06.693 | INFO | [Chapter] 13 2025-10-01 18:48:06.695 | INFO | [Stage] 13-1, 13-3, 13-2, 13-4 2025-10-01 18:48:06.699 | INFO | [Index] 13 2025-10-01 18:48:06.767 | INFO | [OCR_OIL 0.042s] 10651 ──────────────────────────────────────────────────────── 13-1 ───────────────────────────────────────────────────────── 2025-10-01 18:48:06.771 | INFO | 13-1 2025-10-01 18:48:06.774 | INFO | Expect emotion reduce: (12, 2) 2025-10-01 18:48:06.787 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-10-01 18:48:06.791 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=53, Main.Emotion.Fleet1Record=datetime.datetime(2025, 10, 1, 18, 48, 6), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 10, 1, 18, 48, 6) 2025-10-01 18:48:06.807 | INFO | [Emotion fleet_1] 53 2025-10-01 18:48:06.812 | INFO | [Emotion fleet_2] 119 2025-10-01 18:48:06.817 | INFO | <<< ENTER MAP >>> 2025-10-01 18:48:06.896 | INFO | Click ( 184, 277) @ 13-1 2025-10-01 18:48:07.602 | INFO | [Map_clear_percentage] 55% 2025-10-01 18:48:07.898 | INFO | [Map_clear_percentage] 99% 2025-10-01 18:48:07.923 | INFO | [MAP_CLEAR_ALL_THIS_TIME] False 2025-10-01 18:48:07.927 | INFO | [Map_info] 99%, star_1, star_2, star_3, 100_percent_clear, 3_stars, threat_safe, clear_mode 2025-10-01 18:48:07.935 | INFO | [StopCondition_MapAchievement] non_stop 2025-10-01 18:48:07.939 | INFO | Fast_Forward set to on 2025-10-01 18:48:07.943 | INFO | [Fast_Forward] on 2025-10-01 18:48:07.959 | INFO | Auto_Search set to on 2025-10-01 18:48:07.969 | INFO | [Auto_Search] on 2025-10-01 18:48:07.974 | INFO | Click ( 999, 515) @ MAP_PREPARATION 2025-10-01 18:48:08.509 | INFO | Handling 2x book setting, mode=prep. 2025-10-01 18:48:08.532 | INFO | Using fleet: [4, 3, 1] 2025-10-01 18:48:08.609 | INFO | Hard satisfied: Fleet_1: None, Fleet_2: None, Submarine: None 2025-10-01 18:48:08.620 | INFO | [map_allow_submarine] True 2025-10-01 18:48:08.626 | INFO | Click (1043, 471) @ SUBMARINE_CHOOSE 2025-10-01 18:48:08.802 | INFO | Current selected: [1] 2025-10-01 18:48:08.807 | INFO | Click (1042, 479) @ SUBMARINE_CHOOSE 2025-10-01 18:48:09.101 | INFO | Click (1152, 333) @ FLEET_2_CLEAR 2025-10-01 18:48:09.702 | INFO | Click (1045, 214) @ FLEET_1_CHOOSE 2025-10-01 18:48:09.997 | INFO | Current selected: [4] 2025-10-01 18:48:10.002 | INFO | Click (1042, 215) @ FLEET_1_CHOOSE 2025-10-01 18:48:10.295 | INFO | Click (1052, 330) @ FLEET_2_CHOOSE 2025-10-01 18:48:10.596 | INFO | Current selected: [4] 2025-10-01 18:48:10.601 | INFO | Click (1112, 477) @ FLEET_2_BAR_INDEX_3 2025-10-01 18:48:10.901 | INFO | Auto search setting 2025-10-01 18:48:10.918 | INFO | [_fleet_sidebar_offset] 0 2025-10-01 18:48:10.923 | INFO | [Fleet_sidebar] 1/3 2025-10-01 18:48:10.926 | INFO | Click (1210, 410) @ FLEET_SIDEBAR_0_2 2025-10-01 18:48:11.456 | INFO | [_fleet_sidebar_offset] 0 2025-10-01 18:48:11.459 | INFO | [Fleet_sidebar] 3/3 2025-10-01 18:48:11.462 | INFO | [Auto_Search_Setting] fleet1_all_fleet2_standby, sub_auto_call 2025-10-01 18:48:11.467 | INFO | Click ( 512, 216) @ AUTO_SEARCH_SET_MOB 2025-10-01 18:48:12.031 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_auto_call 2025-10-01 18:48:12.036 | INFO | Selected to the correct auto search setting 2025-10-01 18:48:12.039 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_auto_call 2025-10-01 18:48:12.042 | INFO | Selected to the correct auto search setting 2025-10-01 18:48:12.045 | INFO | Click (1098, 601) @ FLEET_PREPARATION 2025-10-01 18:48:12.955 | INFO | is_auto_search_running appeared ────────────────────────────────────────────────────── BATTLE_0 ─────────────────────────────────────────────────────── 2025-10-01 18:48:12.960 | INFO | BATTLE_0 2025-10-01 18:48:12.962 | INFO | Auto search moving 2025-10-01 18:48:12.976 | INFO | Fleet: 1, fleet_current_index: 1 2025-10-01 18:48:13.047 | INFO | [OCR_OIL 0.066s] 10641 2025-10-01 18:48:13.122 | INFO | [OCR_COIN 0.072s] 89197 2025-10-01 18:48:17.862 | INFO | [Loading] 9% 2025-10-01 18:48:17.866 | INFO | Auto search combat loading 2025-10-01 18:48:17.868 | INFO | Screenshot interval set to 1.0s 2025-10-01 18:48:23.864 | INFO | [BattleUI] PAUSE 2025-10-01 18:48:23.867 | INFO | Auto Search combat execute 2025-10-01 18:48:23.869 | INFO | <<< EMOTION REDUCE >>> 2025-10-01 18:48:23.881 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-10-01 18:48:23.887 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=51, Main.Emotion.Fleet1Record=datetime.datetime(2025, 10, 1, 18, 48, 23), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 10, 1, 18, 48, 23) 2025-10-01 18:48:23.904 | INFO | [Emotion fleet_1] 51 2025-10-01 18:48:23.908 | INFO | [Emotion fleet_2] 119 2025-10-01 18:48:28.881 | INFO | Combat auto check timer reached 2025-10-01 18:48:49.894 | INFO | Screenshot interval set to 0.3s 2025-10-01 18:48:49.897 | INFO | Auto Search combat status 2025-10-01 18:48:52.586 | INFO | Click (1038, 657) @ GET_SHIP 2025-10-01 18:48:53.790 | INFO | Click (1041, 664) @ GET_SHIP 2025-10-01 18:48:54.679 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_1 ─────────────────────────────────────────────────────── 2025-10-01 18:48:54.686 | INFO | BATTLE_1 2025-10-01 18:48:54.689 | INFO | Auto search moving 2025-10-01 18:48:54.692 | INFO | Fleet: 1, fleet_current_index: 1 2025-10-01 18:48:54.765 | INFO | [OCR_OIL 0.068s] 10600 2025-10-01 18:48:54.838 | INFO | [OCR_COIN 0.069s] 89207 2025-10-01 18:49:00.091 | INFO | Skip map cat attack 2025-10-01 18:49:00.095 | INFO | Click (1193, 670) @ MAP_CAT_ATTACK 2025-10-01 18:49:01.899 | INFO | [Loading] 8% 2025-10-01 18:49:01.904 | INFO | Auto search combat loading 2025-10-01 18:49:01.908 | INFO | Screenshot interval set to 1.0s 2025-10-01 18:49:07.907 | INFO | [BattleUI] PAUSE 2025-10-01 18:49:07.912 | INFO | Auto Search combat execute 2025-10-01 18:49:07.916 | INFO | <<< EMOTION REDUCE >>> 2025-10-01 18:49:07.928 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-10-01 18:49:07.932 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=49, Main.Emotion.Fleet1Record=datetime.datetime(2025, 10, 1, 18, 49, 7), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 10, 1, 18, 49, 7) 2025-10-01 18:49:07.950 | INFO | [Emotion fleet_1] 49 2025-10-01 18:49:07.956 | INFO | [Emotion fleet_2] 119 2025-10-01 18:49:13.904 | INFO | Combat auto check timer reached 2025-10-01 18:50:09.970 | INFO | Screenshot interval set to 0.3s 2025-10-01 18:50:09.974 | INFO | Auto Search combat status 2025-10-01 18:50:10.556 | INFO | Click (1018, 669) @ GET_SHIP 2025-10-01 18:50:11.757 | INFO | Click (1022, 667) @ GET_SHIP 2025-10-01 18:50:13.870 | INFO | Click (1033, 650) @ GET_SHIP 2025-10-01 18:50:15.076 | INFO | Click (1008, 674) @ GET_SHIP 2025-10-01 18:50:16.255 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_2 ─────────────────────────────────────────────────────── 2025-10-01 18:50:16.262 | INFO | BATTLE_2 2025-10-01 18:50:16.264 | INFO | Auto search moving 2025-10-01 18:50:16.268 | INFO | Fleet: 1, fleet_current_index: 1 2025-10-01 18:50:16.354 | INFO | [OCR_OIL 0.083s] 10577 2025-10-01 18:50:16.445 | INFO | [OCR_COIN 0.088s] 89219 2025-10-01 18:50:22.865 | INFO | [Loading] 9% 2025-10-01 18:50:22.868 | INFO | Auto search combat loading 2025-10-01 18:50:22.871 | INFO | Screenshot interval set to 1.0s 2025-10-01 18:50:28.874 | INFO | [BattleUI] PAUSE 2025-10-01 18:50:28.877 | INFO | Auto Search combat execute 2025-10-01 18:50:28.880 | INFO | <<< EMOTION REDUCE >>> 2025-10-01 18:50:28.892 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-10-01 18:50:28.897 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=47, Main.Emotion.Fleet1Record=datetime.datetime(2025, 10, 1, 18, 50, 28), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 10, 1, 18, 50, 28) 2025-10-01 18:50:28.914 | INFO | [Emotion fleet_1] 47 2025-10-01 18:50:28.919 | INFO | [Emotion fleet_2] 119 2025-10-01 18:50:34.876 | INFO | Combat auto check timer reached 2025-10-01 18:50:54.906 | INFO | Click (1021, 658) @ GET_SHIP 2025-10-01 18:50:56.899 | INFO | Click (1026, 655) @ GET_SHIP 2025-10-01 18:50:59.925 | INFO | Click (1007, 655) @ GET_SHIP 2025-10-01 18:51:01.911 | INFO | Screenshot interval set to 0.3s 2025-10-01 18:51:01.915 | INFO | Auto Search combat status 2025-10-01 18:51:01.918 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_3 ─────────────────────────────────────────────────────── 2025-10-01 18:51:01.924 | INFO | BATTLE_3 2025-10-01 18:51:01.927 | INFO | Auto search moving 2025-10-01 18:51:01.932 | INFO | Fleet: 1, fleet_current_index: 1 2025-10-01 18:51:02.032 | INFO | [OCR_OIL 0.096s] 10536 2025-10-01 18:51:02.115 | INFO | [OCR_COIN 0.078s] 89231 2025-10-01 18:51:06.114 | INFO | [Loading] 6% 2025-10-01 18:51:06.118 | INFO | Auto search combat loading 2025-10-01 18:51:06.120 | INFO | Screenshot interval set to 1.0s 2025-10-01 18:51:12.110 | INFO | [BattleUI] PAUSE 2025-10-01 18:51:12.114 | INFO | Auto Search combat execute 2025-10-01 18:51:12.117 | INFO | <<< EMOTION REDUCE >>> 2025-10-01 18:51:12.128 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-10-01 18:51:12.134 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=45, Main.Emotion.Fleet1Record=datetime.datetime(2025, 10, 1, 18, 51, 12), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 10, 1, 18, 51, 12) 2025-10-01 18:51:12.151 | INFO | [Emotion fleet_1] 45 2025-10-01 18:51:12.154 | INFO | [Emotion fleet_2] 119 2025-10-01 18:51:18.122 | INFO | Combat auto check timer reached 2025-10-01 18:51:37.148 | INFO | Click (1015, 674) @ GET_SHIP 2025-10-01 18:51:38.158 | INFO | Click (1037, 661) @ GET_SHIP 2025-10-01 18:51:40.150 | INFO | Screenshot interval set to 0.3s 2025-10-01 18:51:40.154 | INFO | Auto Search combat status 2025-10-01 18:51:40.157 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_4 ─────────────────────────────────────────────────────── 2025-10-01 18:51:40.161 | INFO | BATTLE_4 2025-10-01 18:51:40.166 | INFO | Auto search moving 2025-10-01 18:51:40.171 | INFO | Fleet: 1, fleet_current_index: 1 2025-10-01 18:51:40.278 | INFO | [OCR_OIL 0.100s] 10495 2025-10-01 18:51:40.371 | INFO | [OCR_COIN 0.087s] 89248 2025-10-01 18:51:44.064 | INFO | [Loading] 8% 2025-10-01 18:51:44.068 | INFO | Auto search combat loading 2025-10-01 18:51:44.071 | INFO | Screenshot interval set to 1.0s 2025-10-01 18:51:50.074 | INFO | [BattleUI] PAUSE 2025-10-01 18:51:50.080 | INFO | Auto Search combat execute 2025-10-01 18:51:50.083 | INFO | <<< EMOTION REDUCE >>> 2025-10-01 18:51:50.097 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-10-01 18:51:50.102 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=43, Main.Emotion.Fleet1Record=datetime.datetime(2025, 10, 1, 18, 51, 50), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 10, 1, 18, 51, 50) 2025-10-01 18:51:50.121 | INFO | [Emotion fleet_1] 43 2025-10-01 18:51:50.124 | INFO | [Emotion fleet_2] 119 2025-10-01 18:51:56.067 | INFO | Combat auto check timer reached 2025-10-01 18:52:53.136 | INFO | Click (1017, 671) @ GET_SHIP 2025-10-01 18:52:55.130 | INFO | Screenshot interval set to 0.3s 2025-10-01 18:52:55.135 | INFO | Auto Search combat status 2025-10-01 18:52:55.139 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_5 ─────────────────────────────────────────────────────── 2025-10-01 18:52:55.143 | INFO | BATTLE_5 2025-10-01 18:52:55.147 | INFO | Auto search moving 2025-10-01 18:52:55.152 | INFO | Fleet: 1, fleet_current_index: 1 2025-10-01 18:52:55.232 | INFO | [OCR_OIL 0.076s] 10472 2025-10-01 18:52:55.319 | INFO | [OCR_COIN 0.083s] 89269 2025-10-01 18:55:55.317 | 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-01 18:55:55.345 | WARNING | Wait too long 2025-10-01 18:55:55.349 | 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-01 18:55:55.422 | INFO | [Package_name] com.bilibili.azurlane 2025-10-01 18:55:55.427 | ERROR | GameStuckError: Wait too long 2025-10-01 18:55:55.430 | WARNING | Saving error: ./log/error/1759316155430