═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ MAIN ═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ ════════════════════════════════════════════════════ CAMPAIGN_13_1 ════════════════════════════════════════════════════ 2025-10-02 07:36:03.038 | INFO | CAMPAIGN_13_1 2025-10-02 07:36:03.042 | INFO | Count: 0 2025-10-02 07:36:03.066 | INFO | <<< UI ENSURE >>> 2025-10-02 07:36:03.070 | INFO | UI get current page 2025-10-02 07:36:03.091 | INFO | [UI] page_main 2025-10-02 07:36:03.097 | INFO | Goto page_campaign 2025-10-02 07:36:03.104 | INFO | <<< UI GOTO PAGE_CAMPAIGN >>> 2025-10-02 07:36:03.168 | INFO | Page switch: page_main_white -> page_campaign_menu 2025-10-02 07:36:03.172 | INFO | Click (1197, 548) @ MAIN_GOTO_CAMPAIGN_WHITE 2025-10-02 07:36:04.286 | INFO | Page switch: page_campaign_menu -> page_campaign 2025-10-02 07:36:04.290 | INFO | Click ( 311, 382) @ CAMPAIGN_MENU_GOTO_CAMPAIGN 2025-10-02 07:36:04.579 | INFO | Page arrive: page_campaign 2025-10-02 07:36:04.605 | INFO | Mode_switch_1 set to hard 2025-10-02 07:36:04.633 | INFO | [Mode_switch_1] hard 2025-10-02 07:36:04.637 | INFO | <<< UI ENSURE INDEX >>> 2025-10-02 07:36:04.710 | INFO | No stage found. 2025-10-02 07:36:04.944 | INFO | No stage found. 2025-10-02 07:36:05.262 | INFO | Loading OCR model: ./bin/cnocr_models/azur_lane 2025-10-02 07:36:05.387 | INFO | [campaign 0.144s] ['I3--1', 'I3--3', 'I3--2', 'I3--4'] 2025-10-02 07:36:05.391 | INFO | [Chapter] i3 2025-10-02 07:36:05.393 | INFO | [Stage] i3-1, i3-3, i3-2, i3-4 2025-10-02 07:36:05.479 | INFO | <<< UI ENSURE >>> 2025-10-02 07:36:05.483 | INFO | UI get current page 2025-10-02 07:36:05.492 | INFO | [UI] page_campaign 2025-10-02 07:36:05.496 | INFO | Already at page_campaign 2025-10-02 07:36:05.501 | INFO | Mode_switch_1 set to hard 2025-10-02 07:36:05.508 | INFO | [Mode_switch_1] hard 2025-10-02 07:36:05.513 | INFO | <<< UI ENSURE INDEX >>> 2025-10-02 07:36:05.658 | INFO | [campaign 0.064s] ['13--1', '13--3', '13--2', '13--4'] 2025-10-02 07:36:05.662 | INFO | [Chapter] 13 2025-10-02 07:36:05.664 | INFO | [Stage] 13-1, 13-3, 13-2, 13-4 2025-10-02 07:36:05.667 | INFO | [Index] 13 2025-10-02 07:36:05.736 | INFO | [OCR_OIL 0.042s] 3107 ──────────────────────────────────────────────────────── 13-1 ───────────────────────────────────────────────────────── 2025-10-02 07:36:05.741 | INFO | 13-1 2025-10-02 07:36:05.743 | INFO | Expect emotion reduce: (12, 2) 2025-10-02 07:36:05.758 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-10-02 07:36:05.762 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=53, Main.Emotion.Fleet1Record=datetime.datetime(2025, 10, 2, 7, 36, 5), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 10, 2, 7, 36, 5) 2025-10-02 07:36:05.782 | INFO | [Emotion fleet_1] 53 2025-10-02 07:36:05.787 | INFO | [Emotion fleet_2] 119 2025-10-02 07:36:05.792 | INFO | <<< ENTER MAP >>> 2025-10-02 07:36:05.868 | INFO | Click ( 196, 282) @ 13-1 2025-10-02 07:36:06.573 | INFO | [Map_clear_percentage] 52% 2025-10-02 07:36:06.873 | INFO | [Map_clear_percentage] 99% 2025-10-02 07:36:06.898 | INFO | [MAP_CLEAR_ALL_THIS_TIME] False 2025-10-02 07:36:06.902 | INFO | [Map_info] 99%, star_1, star_2, star_3, 100_percent_clear, 3_stars, threat_safe, clear_mode 2025-10-02 07:36:06.905 | INFO | [StopCondition_MapAchievement] non_stop 2025-10-02 07:36:06.908 | INFO | Fast_Forward set to on 2025-10-02 07:36:06.910 | INFO | [Fast_Forward] on 2025-10-02 07:36:06.925 | INFO | Auto_Search set to on 2025-10-02 07:36:06.929 | INFO | [Auto_Search] on 2025-10-02 07:36:06.934 | INFO | Click ( 983, 509) @ MAP_PREPARATION 2025-10-02 07:36:07.187 | INFO | Handling 2x book setting, mode=prep. 2025-10-02 07:36:07.211 | INFO | Using fleet: [4, 3, 1] 2025-10-02 07:36:07.284 | INFO | Hard satisfied: Fleet_1: None, Fleet_2: None, Submarine: None 2025-10-02 07:36:07.294 | INFO | [map_allow_submarine] True 2025-10-02 07:36:07.299 | INFO | Click (1056, 473) @ SUBMARINE_CHOOSE 2025-10-02 07:36:07.467 | INFO | Current selected: [1] 2025-10-02 07:36:07.472 | INFO | Click (1046, 480) @ SUBMARINE_CHOOSE 2025-10-02 07:36:07.772 | INFO | Click (1134, 339) @ FLEET_2_CLEAR 2025-10-02 07:36:08.382 | INFO | Click (1052, 206) @ FLEET_1_CHOOSE 2025-10-02 07:36:08.673 | INFO | Current selected: [4] 2025-10-02 07:36:08.677 | INFO | Click (1039, 224) @ FLEET_1_CHOOSE 2025-10-02 07:36:08.974 | INFO | Click (1060, 336) @ FLEET_2_CHOOSE 2025-10-02 07:36:09.270 | INFO | Current selected: [4] 2025-10-02 07:36:09.275 | INFO | Click (1076, 487) @ FLEET_2_BAR_INDEX_3 2025-10-02 07:36:09.574 | INFO | Auto search setting 2025-10-02 07:36:09.590 | INFO | [_fleet_sidebar_offset] 0 2025-10-02 07:36:09.594 | INFO | [Fleet_sidebar] 1/3 2025-10-02 07:36:09.598 | INFO | Click (1216, 436) @ FLEET_SIDEBAR_0_2 2025-10-02 07:36:10.097 | INFO | [_fleet_sidebar_offset] 0 2025-10-02 07:36:10.103 | INFO | [Fleet_sidebar] 3/3 2025-10-02 07:36:10.107 | INFO | [Auto_Search_Setting] fleet1_all_fleet2_standby, sub_auto_call 2025-10-02 07:36:10.110 | INFO | Click ( 499, 221) @ AUTO_SEARCH_SET_MOB 2025-10-02 07:36:10.618 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_auto_call 2025-10-02 07:36:10.623 | INFO | Selected to the correct auto search setting 2025-10-02 07:36:10.626 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_auto_call 2025-10-02 07:36:10.628 | INFO | Selected to the correct auto search setting 2025-10-02 07:36:10.630 | INFO | Click (1021, 586) @ FLEET_PREPARATION 2025-10-02 07:36:11.537 | INFO | is_auto_search_running appeared ────────────────────────────────────────────────────── BATTLE_0 ─────────────────────────────────────────────────────── 2025-10-02 07:36:11.543 | INFO | BATTLE_0 2025-10-02 07:36:11.545 | INFO | Auto search moving 2025-10-02 07:36:11.558 | INFO | Fleet: 1, fleet_current_index: 1 2025-10-02 07:36:11.632 | INFO | [OCR_OIL 0.071s] 3097 2025-10-02 07:36:11.721 | INFO | [OCR_COIN 0.084s] 121030 2025-10-02 07:36:18.267 | INFO | [Loading] 5% 2025-10-02 07:36:18.270 | INFO | Auto search combat loading 2025-10-02 07:36:18.273 | INFO | Screenshot interval set to 1.0s 2025-10-02 07:36:24.275 | INFO | [BattleUI] PAUSE 2025-10-02 07:36:24.280 | INFO | Auto Search combat execute 2025-10-02 07:36:24.282 | INFO | <<< EMOTION REDUCE >>> 2025-10-02 07:36:24.293 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-10-02 07:36:24.298 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=51, Main.Emotion.Fleet1Record=datetime.datetime(2025, 10, 2, 7, 36, 24), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 10, 2, 7, 36, 24) 2025-10-02 07:36:24.318 | INFO | [Emotion fleet_1] 51 2025-10-02 07:36:24.322 | INFO | [Emotion fleet_2] 119 2025-10-02 07:36:30.265 | INFO | Combat auto check timer reached 2025-10-02 07:36:52.298 | INFO | Click (1025, 656) @ GET_SHIP 2025-10-02 07:36:53.299 | INFO | Click (1031, 656) @ GET_SHIP 2025-10-02 07:36:56.306 | INFO | Click (1042, 664) @ GET_SHIP 2025-10-02 07:36:58.307 | INFO | Screenshot interval set to 0.3s 2025-10-02 07:36:58.310 | INFO | Auto Search combat status 2025-10-02 07:36:58.312 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_1 ─────────────────────────────────────────────────────── 2025-10-02 07:36:58.318 | INFO | BATTLE_1 2025-10-02 07:36:58.321 | INFO | Auto search moving 2025-10-02 07:36:58.325 | INFO | Fleet: 1, fleet_current_index: 1 2025-10-02 07:36:58.422 | INFO | [OCR_OIL 0.092s] 3056 2025-10-02 07:36:58.509 | INFO | [OCR_COIN 0.082s] 121055 2025-10-02 07:37:02.800 | INFO | [Loading] 9% 2025-10-02 07:37:02.804 | INFO | Auto search combat loading 2025-10-02 07:37:02.807 | INFO | Screenshot interval set to 1.0s 2025-10-02 07:37:08.805 | INFO | [BattleUI] PAUSE 2025-10-02 07:37:08.808 | INFO | Auto Search combat execute 2025-10-02 07:37:08.812 | INFO | <<< EMOTION REDUCE >>> 2025-10-02 07:37:08.826 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-10-02 07:37:08.831 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=49, Main.Emotion.Fleet1Record=datetime.datetime(2025, 10, 2, 7, 37, 8), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 10, 2, 7, 37, 8) 2025-10-02 07:37:08.847 | INFO | [Emotion fleet_1] 49 2025-10-02 07:37:08.853 | INFO | [Emotion fleet_2] 119 2025-10-02 07:37:14.802 | INFO | Combat auto check timer reached 2025-10-02 07:37:30.848 | INFO | Screenshot interval set to 0.3s 2025-10-02 07:37:30.853 | INFO | Auto Search combat status 2025-10-02 07:37:33.529 | INFO | Click (1026, 665) @ GET_SHIP 2025-10-02 07:37:34.739 | INFO | Click (1025, 651) @ GET_SHIP 2025-10-02 07:37:35.924 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_2 ─────────────────────────────────────────────────────── 2025-10-02 07:37:35.929 | INFO | BATTLE_2 2025-10-02 07:37:35.931 | INFO | Auto search moving 2025-10-02 07:37:35.935 | INFO | Fleet: 1, fleet_current_index: 1 2025-10-02 07:37:36.021 | INFO | [OCR_OIL 0.081s] 3015 2025-10-02 07:37:36.106 | INFO | [OCR_COIN 0.080s] 121073 2025-10-02 07:37:41.339 | INFO | Skip map cat attack 2025-10-02 07:37:41.344 | INFO | Click (1230, 670) @ MAP_CAT_ATTACK 2025-10-02 07:37:43.145 | INFO | [Loading] 9% 2025-10-02 07:37:43.149 | INFO | Auto search combat loading 2025-10-02 07:37:43.151 | INFO | Screenshot interval set to 1.0s 2025-10-02 07:37:49.163 | INFO | [BattleUI] PAUSE 2025-10-02 07:37:49.166 | INFO | Auto Search combat execute 2025-10-02 07:37:49.168 | INFO | <<< EMOTION REDUCE >>> 2025-10-02 07:37:49.180 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-10-02 07:37:49.187 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=47, Main.Emotion.Fleet1Record=datetime.datetime(2025, 10, 2, 7, 37, 49), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 10, 2, 7, 37, 49) 2025-10-02 07:37:49.205 | INFO | [Emotion fleet_1] 47 2025-10-02 07:37:49.209 | INFO | [Emotion fleet_2] 119 2025-10-02 07:37:55.141 | INFO | Combat auto check timer reached 2025-10-02 07:38:17.178 | INFO | Click (1025, 660) @ GET_SHIP 2025-10-02 07:38:19.179 | INFO | Click (1012, 659) @ GET_SHIP 2025-10-02 07:38:22.191 | INFO | Click (1024, 645) @ GET_SHIP 2025-10-02 07:38:24.190 | INFO | Screenshot interval set to 0.3s 2025-10-02 07:38:24.194 | INFO | Auto Search combat status 2025-10-02 07:38:24.197 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_3 ─────────────────────────────────────────────────────── 2025-10-02 07:38:24.203 | INFO | BATTLE_3 2025-10-02 07:38:24.207 | INFO | Auto search moving 2025-10-02 07:38:24.212 | INFO | Fleet: 1, fleet_current_index: 1 2025-10-02 07:38:24.320 | INFO | [OCR_OIL 0.102s] 2974 2025-10-02 07:38:24.430 | INFO | [OCR_COIN 0.105s] 121098 2025-10-02 07:38:31.127 | INFO | [Loading] 5% 2025-10-02 07:38:31.130 | INFO | Auto search combat loading 2025-10-02 07:38:31.133 | INFO | Screenshot interval set to 1.0s 2025-10-02 07:38:38.140 | INFO | [BattleUI] PAUSE 2025-10-02 07:38:38.144 | INFO | Auto Search combat execute 2025-10-02 07:38:38.146 | INFO | <<< EMOTION REDUCE >>> 2025-10-02 07:38:38.160 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-10-02 07:38:38.164 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=45, Main.Emotion.Fleet1Record=datetime.datetime(2025, 10, 2, 7, 38, 38), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 10, 2, 7, 38, 38) 2025-10-02 07:38:38.179 | INFO | [Emotion fleet_1] 45 2025-10-02 07:38:38.186 | INFO | [Emotion fleet_2] 119 2025-10-02 07:38:44.126 | INFO | Combat auto check timer reached 2025-10-02 07:39:06.166 | INFO | Click (1040, 656) @ GET_SHIP 2025-10-02 07:39:07.192 | INFO | Click (1031, 654) @ GET_SHIP 2025-10-02 07:39:09.172 | INFO | Screenshot interval set to 0.3s 2025-10-02 07:39:09.175 | INFO | Auto Search combat status 2025-10-02 07:39:09.179 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_4 ─────────────────────────────────────────────────────── 2025-10-02 07:39:09.186 | INFO | BATTLE_4 2025-10-02 07:39:09.191 | INFO | Auto search moving 2025-10-02 07:39:09.195 | INFO | Fleet: 1, fleet_current_index: 1 2025-10-02 07:39:09.275 | INFO | [OCR_OIL 0.071s] 2933 2025-10-02 07:39:09.363 | INFO | [OCR_COIN 0.085s] 121123 2025-10-02 07:39:16.067 | INFO | [Loading] 10% 2025-10-02 07:39:16.071 | INFO | Auto search combat loading 2025-10-02 07:39:16.074 | INFO | Screenshot interval set to 1.0s 2025-10-02 07:39:22.088 | INFO | [BattleUI] PAUSE 2025-10-02 07:39:22.091 | INFO | Auto Search combat execute 2025-10-02 07:39:22.095 | INFO | <<< EMOTION REDUCE >>> 2025-10-02 07:39:22.110 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-10-02 07:39:22.118 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=43, Main.Emotion.Fleet1Record=datetime.datetime(2025, 10, 2, 7, 39, 22), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 10, 2, 7, 39, 22) 2025-10-02 07:39:22.136 | INFO | [Emotion fleet_1] 43 2025-10-02 07:39:22.141 | INFO | [Emotion fleet_2] 119 2025-10-02 07:39:28.073 | INFO | Combat auto check timer reached 2025-10-02 07:39:51.101 | INFO | Click (1012, 650) @ GET_SHIP 2025-10-02 07:39:54.111 | INFO | Click (1037, 664) @ GET_SHIP 2025-10-02 07:39:56.106 | INFO | Screenshot interval set to 0.3s 2025-10-02 07:39:56.112 | INFO | Auto Search combat status 2025-10-02 07:39:56.115 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_5 ─────────────────────────────────────────────────────── 2025-10-02 07:39:56.120 | INFO | BATTLE_5 2025-10-02 07:39:56.122 | INFO | Auto search moving 2025-10-02 07:39:56.127 | INFO | Fleet: 1, fleet_current_index: 1 2025-10-02 07:39:56.220 | INFO | [OCR_OIL 0.089s] 2892 2025-10-02 07:39:56.323 | INFO | [OCR_COIN 0.099s] 121149 2025-10-02 07:42:56.296 | 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 07:42:56.328 | WARNING | Wait too long 2025-10-02 07:42:56.334 | 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 07:42:56.443 | INFO | [Package_name] com.bilibili.azurlane 2025-10-02 07:42:56.447 | ERROR | GameStuckError: Wait too long 2025-10-02 07:42:56.450 | WARNING | Saving error: ./log/error/1759362176450