═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ MAIN ═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ 2026-07-24 03:53:24.904 | INFO | Reuse forward: ForwardItem(serial='192.168.240.112:5555', local='tcp:20387', remote='tcp:53516') 2026-07-24 03:53:24.925 | INFO | [Device Orientation] 0 (Normal) 2026-07-24 03:53:24.929 | INFO | Reuse forward: ForwardItem(serial='192.168.240.112:5555', local='tcp:20894', remote='localabstract:minitouch') 2026-07-24 03:53:24.950 | INFO | 2026-07-24 03:53:24.969 | INFO | [Screen_size] 1280x720 2026-07-24 03:53:25.000 | INFO | 2026-07-24 03:53:25.344 | INFO | early_ocr_import call 2026-07-24 03:53:25.347 | INFO | early_ocr_import start ════════════════════════════════════════════════════ CAMPAIGN_13_1 ════════════════════════════════════════════════════ 2026-07-24 03:53:25.372 | INFO | CAMPAIGN_13_1 2026-07-24 03:53:25.376 | INFO | Loading OCR dependencies 2026-07-24 03:53:25.379 | INFO | Count: 0 2026-07-24 03:53:25.533 | INFO | <<< UI ENSURE >>> 2026-07-24 03:53:25.538 | INFO | UI get current page 2026-07-24 03:53:25.703 | INFO | [UI] page_campaign 2026-07-24 03:53:25.724 | INFO | Already at page_campaign 2026-07-24 03:53:25.807 | INFO | Mode_switch_1 set to hard 2026-07-24 03:53:25.875 | INFO | [Mode_switch_1] hard 2026-07-24 03:53:25.880 | INFO | <<< UI ENSURE INDEX >>> 2026-07-24 03:53:26.040 | INFO | v 1 2026-07-24 03:53:26.070 | INFO | ^ 10 1280 720 0 2026-07-24 03:53:26.094 | INFO | $ 6118 2026-07-24 03:53:26.098 | INFO | minitouch running on port: 20894, pid: 6118 2026-07-24 03:53:26.181 | INFO | max_contact: 10; max_x: 1280; max_y: 720; max_pressure: 0 2026-07-24 03:53:26.620 | INFO | early_ocr_import finish 2026-07-24 03:53:26.643 | INFO | Loading OCR model: ./bin/cnocr_models/azur_lane 2026-07-24 03:53:26.786 | INFO | [campaign 0.762s] ['13--1', '13--3', '13--2', '13--4'] 2026-07-24 03:53:26.790 | INFO | [Chapter] 13 2026-07-24 03:53:26.793 | INFO | [Stage] 13-1, 13-3, 13-2, 13-4 2026-07-24 03:53:26.796 | INFO | [Index] 13 2026-07-24 03:53:26.862 | INFO | [OCR_OIL 0.038s] 24850 ──────────────────────────────────────────────────────── 13-1 ───────────────────────────────────────────────────────── 2026-07-24 03:53:26.867 | INFO | 13-1 2026-07-24 03:53:26.869 | INFO | Expect emotion reduce: (12, 2) 2026-07-24 03:53:26.880 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-07-24 03:53:26.883 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=109, Main.Emotion.Fleet1Record=datetime.datetime(2026, 7, 24, 3, 53, 26), Main.Emotion.Fleet2Value=117, Main.Emotion.Fleet2Record=datetime.datetime(2026, 7, 24, 3, 53, 26) 2026-07-24 03:53:26.939 | INFO | [Emotion fleet_1] 109 2026-07-24 03:53:26.943 | INFO | [Emotion fleet_2] 117 2026-07-24 03:53:26.946 | INFO | <<< ENTER MAP >>> 2026-07-24 03:53:27.096 | INFO | Click ( 189, 269) @ 13-1 2026-07-24 03:53:27.497 | INFO | [Map_clear_percentage] 5% 2026-07-24 03:53:27.795 | INFO | [Map_clear_percentage] 66% 2026-07-24 03:53:28.096 | INFO | [Map_clear_percentage] 99% 2026-07-24 03:53:28.120 | INFO | [MAP_CLEAR_ALL_THIS_TIME] False 2026-07-24 03:53:28.124 | INFO | [Map_info] 99%, star_1, star_2, star_3, 100_percent_clear, 3_stars, threat_safe, clear_mode 2026-07-24 03:53:28.127 | INFO | [StopCondition_MapAchievement] non_stop 2026-07-24 03:53:28.131 | INFO | Fast_Forward set to on 2026-07-24 03:53:28.134 | INFO | [Fast_Forward] on 2026-07-24 03:53:28.146 | INFO | Auto_Search set to on 2026-07-24 03:53:28.151 | INFO | [Auto_Search] on 2026-07-24 03:53:28.153 | INFO | Click ( 955, 496) @ MAP_PREPARATION 2026-07-24 03:53:28.397 | INFO | Handling 2x book setting, mode=prep. 2026-07-24 03:53:28.418 | INFO | Using fleet: [4, 3, 1] 2026-07-24 03:53:28.490 | INFO | Hard satisfied: Fleet_1: None, Fleet_2: None, Submarine: None 2026-07-24 03:53:28.501 | INFO | [map_allow_submarine] True 2026-07-24 03:53:28.506 | INFO | Click (1148, 337) @ FLEET_2_CLEAR 2026-07-24 03:53:28.559 | INFO | Click (1029, 455) @ SUBMARINE_CHOOSE 2026-07-24 03:53:28.694 | INFO | Current selected: [1] 2026-07-24 03:53:28.699 | INFO | Click (1052, 466) @ SUBMARINE_CHOOSE 2026-07-24 03:53:29.014 | INFO | Click (1058, 231) @ FLEET_1_CHOOSE 2026-07-24 03:53:29.292 | INFO | Current selected: [4] 2026-07-24 03:53:29.296 | INFO | Click (1046, 220) @ FLEET_1_CHOOSE 2026-07-24 03:53:29.592 | INFO | Click (1051, 347) @ FLEET_2_CHOOSE 2026-07-24 03:53:29.899 | INFO | Current selected: [4] 2026-07-24 03:53:29.903 | INFO | Click (1083, 479) @ FLEET_2_BAR_INDEX_3 2026-07-24 03:53:30.191 | INFO | Auto search setting 2026-07-24 03:53:30.208 | INFO | [_fleet_sidebar_offset] 0 2026-07-24 03:53:30.214 | INFO | [_fleet_sidebar_offset] 0 2026-07-24 03:53:30.217 | INFO | [Fleet_sidebar] 1/3 2026-07-24 03:53:30.220 | INFO | Click (1215, 442) @ FLEET_SIDEBAR_0_2 2026-07-24 03:53:30.499 | INFO | [_fleet_sidebar_offset] 0 2026-07-24 03:53:30.503 | INFO | [Fleet_sidebar] 3/3 2026-07-24 03:53:30.506 | INFO | [Auto_Search_Setting] fleet1_all_fleet2_standby, sub_standby 2026-07-24 03:53:30.509 | INFO | Click ( 497, 217) @ AUTO_SEARCH_SET_MOB 2026-07-24 03:53:31.006 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_standby 2026-07-24 03:53:31.010 | INFO | Selected to the correct auto search setting 2026-07-24 03:53:31.012 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_standby 2026-07-24 03:53:31.016 | INFO | Selected to the correct auto search setting 2026-07-24 03:53:31.018 | INFO | Click (1060, 565) @ FLEET_PREPARATION 2026-07-24 03:53:31.922 | INFO | is_auto_search_running appeared ────────────────────────────────────────────────────── BATTLE_0 ─────────────────────────────────────────────────────── 2026-07-24 03:53:31.928 | INFO | BATTLE_0 2026-07-24 03:53:31.930 | INFO | Auto search moving 2026-07-24 03:53:31.946 | INFO | Fleet: 1, fleet_current_index: 1 2026-07-24 03:53:31.991 | INFO | [OCR_OIL 0.042s] 24840 2026-07-24 03:53:32.075 | INFO | [OCR_COIN 0.080s] 103048 2026-07-24 03:53:36.302 | INFO | [Loading] 11% 2026-07-24 03:53:36.305 | INFO | Auto search combat loading 2026-07-24 03:53:36.307 | INFO | Screenshot interval set to 1.0s 2026-07-24 03:53:42.320 | INFO | [BattleUI] PAUSE 2026-07-24 03:53:42.325 | INFO | Auto Search combat execute 2026-07-24 03:53:42.328 | INFO | <<< EMOTION REDUCE >>> 2026-07-24 03:53:42.342 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-07-24 03:53:42.346 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=107, Main.Emotion.Fleet1Record=datetime.datetime(2026, 7, 24, 3, 53, 42), Main.Emotion.Fleet2Value=117, Main.Emotion.Fleet2Record=datetime.datetime(2026, 7, 24, 3, 53, 42) 2026-07-24 03:53:42.360 | INFO | [Emotion fleet_1] 107 2026-07-24 03:53:42.365 | INFO | [Emotion fleet_2] 117 2026-07-24 03:53:48.303 | INFO | Combat auto check timer reached 2026-07-24 03:54:08.340 | INFO | Screenshot interval set to 0.3s 2026-07-24 03:54:08.343 | INFO | Auto Search combat status 2026-07-24 03:54:09.833 | INFO | Click (1023, 672) @ GET_SHIP 2026-07-24 03:54:11.037 | INFO | Click (1038, 657) @ GET_SHIP 2026-07-24 03:54:15.528 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_1 ─────────────────────────────────────────────────────── 2026-07-24 03:54:15.534 | INFO | BATTLE_1 2026-07-24 03:54:15.537 | INFO | Auto search moving 2026-07-24 03:54:15.541 | INFO | Fleet: 1, fleet_current_index: 1 2026-07-24 03:54:15.662 | INFO | [OCR_OIL 0.115s] 24821 2026-07-24 03:54:15.750 | INFO | [OCR_COIN 0.085s] 103073 2026-07-24 03:54:19.747 | INFO | [Loading] 12% 2026-07-24 03:54:19.752 | INFO | Auto search combat loading 2026-07-24 03:54:19.756 | INFO | Screenshot interval set to 1.0s 2026-07-24 03:54:25.764 | INFO | [BattleUI] PAUSE 2026-07-24 03:54:25.768 | INFO | Auto Search combat execute 2026-07-24 03:54:25.770 | INFO | <<< EMOTION REDUCE >>> 2026-07-24 03:54:25.782 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-07-24 03:54:25.787 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=107, Main.Emotion.Fleet1Record=datetime.datetime(2026, 7, 24, 3, 54, 25), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 7, 24, 3, 54, 25) 2026-07-24 03:54:25.800 | INFO | [Emotion fleet_1] 107 2026-07-24 03:54:25.804 | INFO | [Emotion fleet_2] 119 2026-07-24 03:54:31.751 | INFO | Combat auto check timer reached 2026-07-24 03:55:03.791 | INFO | Click (1037, 659) @ GET_SHIP 2026-07-24 03:55:05.787 | INFO | Click (1020, 654) @ GET_SHIP 2026-07-24 03:55:06.803 | INFO | Click (1051, 664) @ GET_SHIP 2026-07-24 03:55:08.794 | INFO | Click (1042, 664) @ GET_SHIP 2026-07-24 03:55:10.800 | INFO | Screenshot interval set to 0.3s 2026-07-24 03:55:10.805 | INFO | Auto Search combat status 2026-07-24 03:55:10.808 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_2 ─────────────────────────────────────────────────────── 2026-07-24 03:55:10.813 | INFO | BATTLE_2 2026-07-24 03:55:10.818 | INFO | Auto search moving 2026-07-24 03:55:10.822 | INFO | Fleet: 1, fleet_current_index: 1 2026-07-24 03:55:10.886 | INFO | [OCR_OIL 0.060s] 24802 2026-07-24 03:55:10.953 | INFO | [OCR_COIN 0.063s] 103083 2026-07-24 03:55:15.287 | INFO | [Loading] 8% 2026-07-24 03:55:15.290 | INFO | Auto search combat loading 2026-07-24 03:55:15.292 | INFO | Screenshot interval set to 1.0s 2026-07-24 03:55:21.291 | INFO | [BattleUI] PAUSE 2026-07-24 03:55:21.295 | INFO | Auto Search combat execute 2026-07-24 03:55:21.298 | INFO | <<< EMOTION REDUCE >>> 2026-07-24 03:55:21.309 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-07-24 03:55:21.314 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=105, Main.Emotion.Fleet1Record=datetime.datetime(2026, 7, 24, 3, 55, 21), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 7, 24, 3, 55, 21) 2026-07-24 03:55:21.328 | INFO | [Emotion fleet_1] 105 2026-07-24 03:55:21.332 | INFO | [Emotion fleet_2] 119 2026-07-24 03:55:26.303 | INFO | Combat auto check timer reached 2026-07-24 03:56:08.336 | INFO | Screenshot interval set to 0.3s 2026-07-24 03:56:08.340 | INFO | Auto Search combat status 2026-07-24 03:56:09.832 | INFO | Click (1023, 656) @ GET_SHIP 2026-07-24 03:56:11.030 | INFO | Click (1013, 663) @ GET_SHIP 2026-07-24 03:56:12.229 | INFO | Click (1023, 660) @ GET_SHIP 2026-07-24 03:56:13.435 | INFO | Click (1047, 660) @ GET_SHIP 2026-07-24 03:56:14.659 | INFO | Click (1028, 656) @ GET_SHIP 2026-07-24 03:56:15.522 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_3 ─────────────────────────────────────────────────────── 2026-07-24 03:56:15.528 | INFO | BATTLE_3 2026-07-24 03:56:15.531 | INFO | Auto search moving 2026-07-24 03:56:15.536 | INFO | Fleet: 1, fleet_current_index: 1 2026-07-24 03:56:15.598 | INFO | [OCR_OIL 0.057s] 24783 2026-07-24 03:56:15.720 | INFO | [OCR_COIN 0.118s] 103112 2026-07-24 03:56:20.038 | INFO | [Loading] 5% 2026-07-24 03:56:20.042 | INFO | Auto search combat loading 2026-07-24 03:56:20.047 | INFO | Screenshot interval set to 1.0s 2026-07-24 03:56:26.046 | INFO | [BattleUI] PAUSE 2026-07-24 03:56:26.052 | INFO | Auto Search combat execute 2026-07-24 03:56:26.054 | INFO | <<< EMOTION REDUCE >>> 2026-07-24 03:56:26.064 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-07-24 03:56:26.069 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=103, Main.Emotion.Fleet1Record=datetime.datetime(2026, 7, 24, 3, 56, 26), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 7, 24, 3, 56, 26) 2026-07-24 03:56:26.086 | INFO | [Emotion fleet_1] 103 2026-07-24 03:56:26.090 | INFO | [Emotion fleet_2] 119 2026-07-24 03:56:31.059 | INFO | Combat auto check timer reached 2026-07-24 03:57:26.103 | INFO | Screenshot interval set to 0.3s 2026-07-24 03:57:26.106 | INFO | Auto Search combat status 2026-07-24 03:57:27.292 | INFO | Click (1022, 655) @ GET_SHIP 2026-07-24 03:57:28.496 | INFO | Click (1016, 655) @ GET_SHIP 2026-07-24 03:57:29.705 | INFO | Click (1027, 662) @ GET_SHIP 2026-07-24 03:57:31.186 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_4 ─────────────────────────────────────────────────────── 2026-07-24 03:57:31.193 | INFO | BATTLE_4 2026-07-24 03:57:31.196 | INFO | Auto search moving 2026-07-24 03:57:31.199 | INFO | Fleet: 1, fleet_current_index: 1 2026-07-24 03:57:31.302 | INFO | [OCR_OIL 0.098s] 24764 2026-07-24 03:57:31.458 | INFO | [OCR_COIN 0.153s] 103133 2026-07-24 03:57:35.741 | INFO | [Loading] 13% 2026-07-24 03:57:35.745 | INFO | Auto search combat loading 2026-07-24 03:57:35.750 | INFO | Screenshot interval set to 1.0s 2026-07-24 03:57:41.756 | INFO | [BattleUI] PAUSE 2026-07-24 03:57:41.760 | INFO | Auto Search combat execute 2026-07-24 03:57:41.767 | INFO | <<< EMOTION REDUCE >>> 2026-07-24 03:57:41.778 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-07-24 03:57:41.784 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=101, Main.Emotion.Fleet1Record=datetime.datetime(2026, 7, 24, 3, 57, 41), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 7, 24, 3, 57, 41) 2026-07-24 03:57:41.798 | INFO | [Emotion fleet_1] 101 2026-07-24 03:57:41.801 | INFO | [Emotion fleet_2] 119 2026-07-24 03:57:47.747 | INFO | Combat auto check timer reached 2026-07-24 03:58:41.831 | INFO | Click (1017, 663) @ GET_SHIP 2026-07-24 03:58:43.806 | INFO | Click (1027, 663) @ GET_SHIP 2026-07-24 03:58:45.807 | INFO | Click (1027, 680) @ GET_SHIP 2026-07-24 03:58:46.813 | INFO | Click (1029, 661) @ GET_SHIP 2026-07-24 03:58:48.815 | INFO | Screenshot interval set to 0.3s 2026-07-24 03:58:48.819 | INFO | Auto Search combat status 2026-07-24 03:58:48.821 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_5 ─────────────────────────────────────────────────────── 2026-07-24 03:58:48.825 | INFO | BATTLE_5 2026-07-24 03:58:48.827 | INFO | Auto search moving 2026-07-24 03:58:48.834 | INFO | Fleet: 1, fleet_current_index: 1 2026-07-24 03:58:48.893 | INFO | [OCR_OIL 0.053s] 24745 2026-07-24 03:58:48.955 | INFO | [OCR_COIN 0.058s] 103153 2026-07-24 03:58:50.903 | INFO | [Loading] 16% 2026-07-24 03:58:50.906 | INFO | Auto search combat loading 2026-07-24 03:58:50.909 | INFO | Screenshot interval set to 1.0s 2026-07-24 03:58:56.914 | INFO | [BattleUI] PAUSE 2026-07-24 03:58:56.918 | INFO | Auto Search combat execute 2026-07-24 03:58:56.926 | INFO | <<< EMOTION REDUCE >>> 2026-07-24 03:58:56.939 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-07-24 03:58:56.945 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=99, Main.Emotion.Fleet1Record=datetime.datetime(2026, 7, 24, 3, 58, 56), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 7, 24, 3, 58, 56) 2026-07-24 03:58:56.965 | INFO | [Emotion fleet_1] 99 2026-07-24 03:58:56.970 | INFO | [Emotion fleet_2] 119 2026-07-24 03:59:02.905 | INFO | Combat auto check timer reached 2026-07-24 03:59:59.979 | INFO | Click (1019, 664) @ GET_SHIP 2026-07-24 04:03:00.128 | 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 L438 run() campaign_base.py L143 run() campaign_base.py L178 auto_search_execute_a_battle() auto_search_combat.py L357 auto_search_combat() auto_search_combat.py L252 auto_search_combat_execute() base.py L169 loop() device.py L194 screenshot() device.py L256 stuck_record_check() device.py L43 show_function_call() 2026-07-24 04:03:00.154 | WARNING | Wait too long 2026-07-24 04:03:00.159 | WARNING | Waiting for {'EXP_INFO_A', 'MISSION_POPUP_GO', 'EVENT_CHECK', 'EXP_INFO_B', 'GUILD_POPUP_CONFIRM', 'POPUP_CONFIRM_WHITE', 'GET_MISSION', 'BATTLE_STATUS_S', 'EXP_INFO_S', 'GET_SHIP', 'SP_CHECK', 'CAMPAIGN_CHECK', 'AUTO_SEARCH_MAP_OPTION_ON', 'PAUSE', 'POPUP_CANCEL', 'NEW_SHIP', 'BATTLE_STATUS_A', 'BATTLE_STATUS_B'} 2026-07-24 04:03:00.176 | INFO | newCommandTimeout updated to 168h0m0s 2026-07-24 04:03:00.180 | INFO | [u2.Device] Device(atx_agent_url=http://127.0.0.1:58515) 2026-07-24 04:03:00.231 | INFO | [Package_name] com.bilibili.azurlane 2026-07-24 04:03:00.237 | ERROR | GameStuckError: Wait too long 2026-07-24 04:03:00.243 | WARNING | Saving error: ./log/error/1784836980243