═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ MAIN ═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ ════════════════════════════════════════════════════ CAMPAIGN_13_1 ════════════════════════════════════════════════════ 2025-10-01 17:12:03.159 | INFO | CAMPAIGN_13_1 2025-10-01 17:12:03.161 | INFO | Count: 0 2025-10-01 17:12:03.181 | INFO | <<< UI ENSURE >>> 2025-10-01 17:12:03.187 | INFO | UI get current page 2025-10-01 17:12:03.699 | INFO | Unknown ui page 2025-10-01 17:12:04.167 | INFO | UI additional: IDLE -> REWARD_GOTO_MAIN 2025-10-01 17:12:04.171 | INFO | Click ( 828, 630) @ REWARD_GOTO_MAIN 2025-10-01 17:12:04.349 | INFO | Unknown ui page 2025-10-01 17:12:04.510 | INFO | [Package_name] com.bilibili.azurlane 2025-10-01 17:12:04.527 | INFO | [Device Orientation] 0 (Normal) 2025-10-01 17:12:04.667 | INFO | Unknown ui page 2025-10-01 17:12:04.880 | INFO | [UI] page_main 2025-10-01 17:12:04.884 | INFO | Goto page_campaign 2025-10-01 17:12:04.888 | INFO | <<< UI GOTO PAGE_CAMPAIGN >>> 2025-10-01 17:12:04.903 | INFO | Page switch: page_main_white -> page_campaign_menu 2025-10-01 17:12:04.909 | INFO | Click (1210, 509) @ MAIN_GOTO_CAMPAIGN_WHITE 2025-10-01 17:12:05.482 | INFO | Page switch: page_campaign_menu -> page_campaign 2025-10-01 17:12:05.487 | INFO | Click ( 299, 249) @ CAMPAIGN_MENU_GOTO_CAMPAIGN 2025-10-01 17:12:05.778 | INFO | Page arrive: page_campaign 2025-10-01 17:12:05.807 | INFO | Mode_switch_1 set to hard 2025-10-01 17:12:05.832 | INFO | [Mode_switch_1] hard 2025-10-01 17:12:05.839 | INFO | <<< UI ENSURE INDEX >>> 2025-10-01 17:12:05.913 | INFO | No stage found. 2025-10-01 17:12:06.144 | INFO | No stage found. 2025-10-01 17:12:06.464 | INFO | Loading OCR model: ./bin/cnocr_models/azur_lane 2025-10-01 17:12:06.573 | INFO | [campaign 0.131s] ['13--1', '13--3', '13--2', '13--4'] 2025-10-01 17:12:06.577 | INFO | [Chapter] 13 2025-10-01 17:12:06.580 | INFO | [Stage] 13-1, 13-3, 13-2, 13-4 2025-10-01 17:12:06.585 | INFO | [Index] 13 2025-10-01 17:12:06.668 | INFO | [OCR_OIL 0.051s] 11501 ──────────────────────────────────────────────────────── 13-1 ───────────────────────────────────────────────────────── 2025-10-01 17:12:06.673 | INFO | 13-1 2025-10-01 17:12:06.676 | INFO | Expect emotion reduce: (12, 2) 2025-10-01 17:12:06.689 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-10-01 17:12:06.694 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=53, Main.Emotion.Fleet1Record=datetime.datetime(2025, 10, 1, 17, 12, 6), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 10, 1, 17, 12, 6) 2025-10-01 17:12:06.712 | INFO | [Emotion fleet_1] 53 2025-10-01 17:12:06.717 | INFO | [Emotion fleet_2] 119 2025-10-01 17:12:06.721 | INFO | <<< ENTER MAP >>> 2025-10-01 17:12:06.798 | INFO | Click ( 194, 283) @ 13-1 2025-10-01 17:12:07.505 | INFO | [Map_clear_percentage] 52% 2025-10-01 17:12:07.805 | INFO | [Map_clear_percentage] 99% 2025-10-01 17:12:07.830 | INFO | [MAP_CLEAR_ALL_THIS_TIME] False 2025-10-01 17:12:07.834 | INFO | [Map_info] 99%, star_1, star_2, star_3, 100_percent_clear, 3_stars, threat_safe, clear_mode 2025-10-01 17:12:07.839 | INFO | [StopCondition_MapAchievement] non_stop 2025-10-01 17:12:07.844 | INFO | Fast_Forward set to on 2025-10-01 17:12:07.848 | INFO | [Fast_Forward] on 2025-10-01 17:12:07.864 | INFO | Auto_Search set to on 2025-10-01 17:12:07.872 | INFO | [Auto_Search] on 2025-10-01 17:12:07.876 | INFO | Click ( 964, 529) @ MAP_PREPARATION 2025-10-01 17:12:08.413 | INFO | Handling 2x book setting, mode=prep. 2025-10-01 17:12:08.443 | INFO | Using fleet: [4, 3, 1] 2025-10-01 17:12:08.525 | INFO | Hard satisfied: Fleet_1: None, Fleet_2: None, Submarine: None 2025-10-01 17:12:08.535 | INFO | [map_allow_submarine] True 2025-10-01 17:12:08.540 | INFO | Click (1067, 478) @ SUBMARINE_CHOOSE 2025-10-01 17:12:08.698 | INFO | Current selected: [1] 2025-10-01 17:12:08.703 | INFO | Click (1055, 471) @ SUBMARINE_CHOOSE 2025-10-01 17:12:09.002 | INFO | Click (1141, 346) @ FLEET_2_CLEAR 2025-10-01 17:12:09.605 | INFO | Click (1061, 229) @ FLEET_1_CHOOSE 2025-10-01 17:12:09.906 | INFO | Current selected: [4] 2025-10-01 17:12:09.909 | INFO | Click (1052, 230) @ FLEET_1_CHOOSE 2025-10-01 17:12:10.206 | INFO | Click (1053, 329) @ FLEET_2_CHOOSE 2025-10-01 17:12:10.511 | INFO | Current selected: [4] 2025-10-01 17:12:10.514 | INFO | Click (1102, 492) @ FLEET_2_BAR_INDEX_3 2025-10-01 17:12:10.805 | INFO | Auto search setting 2025-10-01 17:12:10.824 | INFO | [_fleet_sidebar_offset] 0 2025-10-01 17:12:10.830 | INFO | [Fleet_sidebar] 1/3 2025-10-01 17:12:10.834 | INFO | Click (1224, 433) @ FLEET_SIDEBAR_0_2 2025-10-01 17:12:11.326 | INFO | [_fleet_sidebar_offset] 0 2025-10-01 17:12:11.330 | INFO | [Fleet_sidebar] 3/3 2025-10-01 17:12:11.333 | INFO | [Auto_Search_Setting] fleet1_all_fleet2_standby, sub_auto_call 2025-10-01 17:12:11.335 | INFO | Click ( 506, 210) @ AUTO_SEARCH_SET_MOB 2025-10-01 17:12:11.820 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_auto_call 2025-10-01 17:12:11.825 | INFO | Selected to the correct auto search setting 2025-10-01 17:12:11.829 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_auto_call 2025-10-01 17:12:11.831 | INFO | Selected to the correct auto search setting 2025-10-01 17:12:11.833 | INFO | Click (1093, 576) @ FLEET_PREPARATION 2025-10-01 17:12:12.741 | INFO | is_auto_search_running appeared ────────────────────────────────────────────────────── BATTLE_0 ─────────────────────────────────────────────────────── 2025-10-01 17:12:12.747 | INFO | BATTLE_0 2025-10-01 17:12:12.749 | INFO | Auto search moving 2025-10-01 17:12:12.762 | INFO | Fleet: 1, fleet_current_index: 1 2025-10-01 17:12:12.829 | INFO | [OCR_OIL 0.064s] 11491 2025-10-01 17:12:12.919 | INFO | [OCR_COIN 0.087s] 94342 2025-10-01 17:12:18.554 | INFO | Skip map cat attack 2025-10-01 17:12:18.558 | INFO | Click (1226, 680) @ MAP_CAT_ATTACK 2025-10-01 17:12:20.371 | INFO | [Loading] 9% 2025-10-01 17:12:20.375 | INFO | Auto search combat loading 2025-10-01 17:12:20.379 | INFO | Screenshot interval set to 1.0s 2025-10-01 17:12:26.371 | INFO | [BattleUI] PAUSE 2025-10-01 17:12:26.374 | INFO | Auto Search combat execute 2025-10-01 17:12:26.377 | INFO | <<< EMOTION REDUCE >>> 2025-10-01 17:12:26.388 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-10-01 17:12:26.392 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=51, Main.Emotion.Fleet1Record=datetime.datetime(2025, 10, 1, 17, 12, 26), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 10, 1, 17, 12, 26) 2025-10-01 17:12:26.407 | INFO | [Emotion fleet_1] 51 2025-10-01 17:12:26.412 | INFO | [Emotion fleet_2] 119 2025-10-01 17:12:32.372 | INFO | Combat auto check timer reached 2025-10-01 17:12:45.394 | INFO | Click (1029, 673) @ GET_SHIP 2025-10-01 17:12:47.397 | INFO | Click (1022, 660) @ GET_SHIP 2025-10-01 17:12:50.408 | INFO | Click (1026, 662) @ GET_SHIP 2025-10-01 17:12:52.403 | INFO | Screenshot interval set to 0.3s 2025-10-01 17:12:52.407 | INFO | Auto Search combat status 2025-10-01 17:12:52.410 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_1 ─────────────────────────────────────────────────────── 2025-10-01 17:12:52.414 | INFO | BATTLE_1 2025-10-01 17:12:52.418 | INFO | Auto search moving 2025-10-01 17:12:52.422 | INFO | Fleet: 1, fleet_current_index: 1 2025-10-01 17:12:52.499 | INFO | [OCR_OIL 0.074s] 11450 2025-10-01 17:12:52.588 | INFO | [OCR_COIN 0.083s] 94363 2025-10-01 17:12:57.798 | INFO | [Loading] 6% 2025-10-01 17:12:57.802 | INFO | Auto search combat loading 2025-10-01 17:12:57.806 | INFO | Screenshot interval set to 1.0s 2025-10-01 17:13:04.802 | INFO | [BattleUI] PAUSE 2025-10-01 17:13:04.805 | INFO | Auto Search combat execute 2025-10-01 17:13:04.808 | INFO | <<< EMOTION REDUCE >>> 2025-10-01 17:13:04.819 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-10-01 17:13:04.822 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=49, Main.Emotion.Fleet1Record=datetime.datetime(2025, 10, 1, 17, 13, 4), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 10, 1, 17, 13, 4) 2025-10-01 17:13:04.838 | INFO | [Emotion fleet_1] 49 2025-10-01 17:13:04.842 | INFO | [Emotion fleet_2] 119 2025-10-01 17:13:10.800 | INFO | Combat auto check timer reached 2025-10-01 17:13:30.839 | INFO | Screenshot interval set to 0.3s 2025-10-01 17:13:30.843 | INFO | Auto Search combat status 2025-10-01 17:13:34.144 | INFO | Click (1035, 634) @ GET_SHIP 2025-10-01 17:13:35.337 | INFO | Click (1042, 650) @ GET_SHIP 2025-10-01 17:13:36.530 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_2 ─────────────────────────────────────────────────────── 2025-10-01 17:13:36.536 | INFO | BATTLE_2 2025-10-01 17:13:36.538 | INFO | Auto search moving 2025-10-01 17:13:36.543 | INFO | Fleet: 1, fleet_current_index: 1 2025-10-01 17:13:36.615 | INFO | [OCR_OIL 0.067s] 11409 2025-10-01 17:13:36.709 | INFO | [OCR_COIN 0.089s] 94387 2025-10-01 17:13:41.342 | INFO | [Loading] 12% 2025-10-01 17:13:41.346 | INFO | Auto search combat loading 2025-10-01 17:13:41.348 | INFO | Screenshot interval set to 1.0s 2025-10-01 17:13:47.341 | INFO | [BattleUI] PAUSE 2025-10-01 17:13:47.345 | INFO | Auto Search combat execute 2025-10-01 17:13:47.349 | INFO | <<< EMOTION REDUCE >>> 2025-10-01 17:13:47.360 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-10-01 17:13:47.365 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=47, Main.Emotion.Fleet1Record=datetime.datetime(2025, 10, 1, 17, 13, 47), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 10, 1, 17, 13, 47) 2025-10-01 17:13:47.384 | INFO | [Emotion fleet_1] 47 2025-10-01 17:13:47.388 | INFO | [Emotion fleet_2] 119 2025-10-01 17:13:53.347 | INFO | Combat auto check timer reached 2025-10-01 17:14:31.405 | INFO | Screenshot interval set to 0.3s 2025-10-01 17:14:31.408 | INFO | Auto Search combat status 2025-10-01 17:14:32.277 | INFO | Click (1039, 673) @ GET_SHIP 2025-10-01 17:14:33.479 | INFO | Click (1036, 649) @ GET_SHIP 2025-10-01 17:14:35.585 | INFO | Click (1028, 648) @ GET_SHIP 2025-10-01 17:14:36.790 | INFO | Click (1034, 662) @ GET_SHIP 2025-10-01 17:14:37.977 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_3 ─────────────────────────────────────────────────────── 2025-10-01 17:14:37.982 | INFO | BATTLE_3 2025-10-01 17:14:37.985 | INFO | Auto search moving 2025-10-01 17:14:37.990 | INFO | Fleet: 1, fleet_current_index: 1 2025-10-01 17:14:38.080 | INFO | [OCR_OIL 0.085s] 11386 2025-10-01 17:14:38.185 | INFO | [OCR_COIN 0.100s] 94413 2025-10-01 17:14:43.391 | INFO | [Loading] 5% 2025-10-01 17:14:43.394 | INFO | Auto search combat loading 2025-10-01 17:14:43.397 | INFO | Screenshot interval set to 1.0s 2025-10-01 17:14:49.390 | INFO | [BattleUI] PAUSE 2025-10-01 17:14:49.395 | INFO | Auto Search combat execute 2025-10-01 17:14:49.398 | INFO | <<< EMOTION REDUCE >>> 2025-10-01 17:14:49.411 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-10-01 17:14:49.417 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=45, Main.Emotion.Fleet1Record=datetime.datetime(2025, 10, 1, 17, 14, 49), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 10, 1, 17, 14, 49) 2025-10-01 17:14:49.434 | INFO | [Emotion fleet_1] 45 2025-10-01 17:14:49.438 | INFO | [Emotion fleet_2] 119 2025-10-01 17:14:55.396 | INFO | Combat auto check timer reached 2025-10-01 17:15:14.441 | INFO | Screenshot interval set to 0.3s 2025-10-01 17:15:14.445 | INFO | Auto Search combat status 2025-10-01 17:15:15.918 | INFO | Click (1040, 654) @ GET_SHIP 2025-10-01 17:15:17.122 | INFO | Click (1036, 666) @ GET_SHIP 2025-10-01 17:15:19.536 | INFO | Click (1017, 646) @ GET_SHIP 2025-10-01 17:15:20.739 | INFO | Click (1019, 668) @ GET_SHIP 2025-10-01 17:15:21.616 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_4 ─────────────────────────────────────────────────────── 2025-10-01 17:15:21.622 | INFO | BATTLE_4 2025-10-01 17:15:21.625 | INFO | Auto search moving 2025-10-01 17:15:21.629 | INFO | Fleet: 1, fleet_current_index: 1 2025-10-01 17:15:21.706 | INFO | [OCR_OIL 0.074s] 11345 2025-10-01 17:15:21.777 | INFO | [OCR_COIN 0.068s] 94424 2025-10-01 17:15:28.534 | INFO | [Loading] 11% 2025-10-01 17:15:28.538 | INFO | Auto search combat loading 2025-10-01 17:15:28.540 | INFO | Screenshot interval set to 1.0s 2025-10-01 17:15:34.545 | INFO | [BattleUI] PAUSE 2025-10-01 17:15:34.550 | INFO | Auto Search combat execute 2025-10-01 17:15:34.554 | INFO | <<< EMOTION REDUCE >>> 2025-10-01 17:15:34.575 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-10-01 17:15:34.589 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=43, Main.Emotion.Fleet1Record=datetime.datetime(2025, 10, 1, 17, 15, 34), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 10, 1, 17, 15, 34) 2025-10-01 17:15:34.604 | INFO | [Emotion fleet_1] 43 2025-10-01 17:15:34.609 | INFO | [Emotion fleet_2] 119 2025-10-01 17:15:40.544 | INFO | Combat auto check timer reached 2025-10-01 17:16:18.597 | INFO | Screenshot interval set to 0.3s 2025-10-01 17:16:18.600 | INFO | Auto Search combat status 2025-10-01 17:16:20.674 | INFO | Click (1036, 657) @ GET_SHIP 2025-10-01 17:16:21.888 | INFO | Click (1021, 655) @ GET_SHIP 2025-10-01 17:16:23.069 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_5 ─────────────────────────────────────────────────────── 2025-10-01 17:16:23.075 | INFO | BATTLE_5 2025-10-01 17:16:23.079 | INFO | Auto search moving 2025-10-01 17:16:23.083 | INFO | Fleet: 1, fleet_current_index: 1 2025-10-01 17:16:23.165 | INFO | [OCR_OIL 0.078s] 11322 2025-10-01 17:16:23.271 | INFO | [OCR_COIN 0.102s] 94448 2025-10-01 17:19:23.274 | 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 17:19:23.300 | WARNING | Wait too long 2025-10-01 17:19:23.304 | 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 17:19:23.419 | INFO | [Package_name] com.bilibili.azurlane 2025-10-01 17:19:23.423 | ERROR | GameStuckError: Wait too long 2025-10-01 17:19:23.426 | WARNING | Saving error: ./log/error/1759310363426