═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ MAIN ═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ ════════════════════════════════════════════════════ CAMPAIGN_13_1 ════════════════════════════════════════════════════ 2025-10-01 19:18:04.857 | INFO | CAMPAIGN_13_1 2025-10-01 19:18:04.862 | INFO | Count: 0 2025-10-01 19:18:04.881 | INFO | <<< UI ENSURE >>> 2025-10-01 19:18:04.888 | INFO | UI get current page 2025-10-01 19:18:05.409 | INFO | Unknown ui page 2025-10-01 19:18:05.878 | INFO | UI additional: IDLE -> REWARD_GOTO_MAIN 2025-10-01 19:18:05.882 | INFO | Click ( 819, 621) @ REWARD_GOTO_MAIN 2025-10-01 19:18:06.057 | INFO | Unknown ui page 2025-10-01 19:18:06.202 | INFO | [Package_name] com.bilibili.azurlane 2025-10-01 19:18:06.221 | INFO | [Device Orientation] 0 (Normal) 2025-10-01 19:18:06.370 | INFO | Unknown ui page 2025-10-01 19:18:06.581 | INFO | [UI] page_main 2025-10-01 19:18:06.585 | INFO | Goto page_campaign 2025-10-01 19:18:06.590 | INFO | <<< UI GOTO PAGE_CAMPAIGN >>> 2025-10-01 19:18:06.606 | INFO | Page switch: page_main_white -> page_campaign_menu 2025-10-01 19:18:06.613 | INFO | Click (1213, 509) @ MAIN_GOTO_CAMPAIGN_WHITE 2025-10-01 19:18:07.186 | INFO | Page switch: page_campaign_menu -> page_campaign 2025-10-01 19:18:07.189 | INFO | Click ( 361, 334) @ CAMPAIGN_MENU_GOTO_CAMPAIGN 2025-10-01 19:18:07.485 | INFO | Page arrive: page_campaign 2025-10-01 19:18:07.513 | INFO | Mode_switch_1 set to hard 2025-10-01 19:18:07.542 | INFO | [Mode_switch_1] hard 2025-10-01 19:18:07.548 | INFO | <<< UI ENSURE INDEX >>> 2025-10-01 19:18:07.642 | INFO | No stage found. 2025-10-01 19:18:07.843 | INFO | No stage found. 2025-10-01 19:18:08.162 | INFO | Loading OCR model: ./bin/cnocr_models/azur_lane 2025-10-01 19:18:08.277 | INFO | [campaign 0.133s] ['I--1', 'I--3', 'I--2', 'I--4'] 2025-10-01 19:18:08.281 | INFO | [Chapter] i 2025-10-01 19:18:08.284 | INFO | [Stage] i-1, i-3, i-2, i-4 2025-10-01 19:18:08.379 | INFO | <<< UI ENSURE >>> 2025-10-01 19:18:08.383 | INFO | UI get current page 2025-10-01 19:18:08.392 | INFO | [UI] page_campaign 2025-10-01 19:18:08.397 | INFO | Already at page_campaign 2025-10-01 19:18:08.402 | INFO | Mode_switch_1 set to hard 2025-10-01 19:18:08.407 | INFO | [Mode_switch_1] hard 2025-10-01 19:18:08.411 | INFO | <<< UI ENSURE INDEX >>> 2025-10-01 19:18:08.543 | INFO | [campaign 0.058s] ['13--1', '13--3', '13--2', '13--4'] 2025-10-01 19:18:08.546 | INFO | [Chapter] 13 2025-10-01 19:18:08.549 | INFO | [Stage] 13-1, 13-3, 13-2, 13-4 2025-10-01 19:18:08.551 | INFO | [Index] 13 2025-10-01 19:18:08.620 | INFO | [OCR_OIL 0.043s] 10141 ──────────────────────────────────────────────────────── 13-1 ───────────────────────────────────────────────────────── 2025-10-01 19:18:08.624 | INFO | 13-1 2025-10-01 19:18:08.627 | INFO | Expect emotion reduce: (12, 2) 2025-10-01 19:18:08.640 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-10-01 19:18:08.644 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=53, Main.Emotion.Fleet1Record=datetime.datetime(2025, 10, 1, 19, 18, 8), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 10, 1, 19, 18, 8) 2025-10-01 19:18:08.664 | INFO | [Emotion fleet_1] 53 2025-10-01 19:18:08.669 | INFO | [Emotion fleet_2] 119 2025-10-01 19:18:08.675 | INFO | <<< ENTER MAP >>> 2025-10-01 19:18:08.749 | INFO | Click ( 191, 289) @ 13-1 2025-10-01 19:18:09.453 | INFO | [Map_clear_percentage] 58% 2025-10-01 19:18:09.751 | INFO | [Map_clear_percentage] 99% 2025-10-01 19:18:09.777 | INFO | [MAP_CLEAR_ALL_THIS_TIME] False 2025-10-01 19:18:09.784 | INFO | [Map_info] 99%, star_1, star_2, star_3, 100_percent_clear, 3_stars, threat_safe, clear_mode 2025-10-01 19:18:09.788 | INFO | [StopCondition_MapAchievement] non_stop 2025-10-01 19:18:09.791 | INFO | Fast_Forward set to on 2025-10-01 19:18:09.794 | INFO | [Fast_Forward] on 2025-10-01 19:18:09.808 | INFO | Auto_Search set to on 2025-10-01 19:18:09.815 | INFO | [Auto_Search] on 2025-10-01 19:18:09.822 | INFO | Click ( 979, 539) @ MAP_PREPARATION 2025-10-01 19:18:10.349 | INFO | Handling 2x book setting, mode=prep. 2025-10-01 19:18:10.373 | INFO | Using fleet: [4, 3, 1] 2025-10-01 19:18:10.448 | INFO | Hard satisfied: Fleet_1: None, Fleet_2: None, Submarine: None 2025-10-01 19:18:10.460 | INFO | [map_allow_submarine] True 2025-10-01 19:18:10.464 | INFO | Click (1038, 476) @ SUBMARINE_CHOOSE 2025-10-01 19:18:10.650 | INFO | Current selected: [1] 2025-10-01 19:18:10.655 | INFO | Click (1049, 485) @ SUBMARINE_CHOOSE 2025-10-01 19:18:10.953 | INFO | Click (1141, 350) @ FLEET_2_CLEAR 2025-10-01 19:18:11.554 | INFO | Click (1050, 228) @ FLEET_1_CHOOSE 2025-10-01 19:18:11.850 | INFO | Current selected: [4] 2025-10-01 19:18:11.855 | INFO | Click (1058, 216) @ FLEET_1_CHOOSE 2025-10-01 19:18:12.149 | INFO | Click (1056, 326) @ FLEET_2_CHOOSE 2025-10-01 19:18:12.452 | INFO | Current selected: [4] 2025-10-01 19:18:12.457 | INFO | Click (1080, 481) @ FLEET_2_BAR_INDEX_3 2025-10-01 19:18:12.755 | INFO | Auto search setting 2025-10-01 19:18:12.771 | INFO | [_fleet_sidebar_offset] 0 2025-10-01 19:18:12.775 | INFO | [Fleet_sidebar] 1/3 2025-10-01 19:18:12.778 | INFO | Click (1203, 433) @ FLEET_SIDEBAR_0_2 2025-10-01 19:18:13.314 | INFO | [_fleet_sidebar_offset] 0 2025-10-01 19:18:13.320 | INFO | [Fleet_sidebar] 3/3 2025-10-01 19:18:13.324 | INFO | [Auto_Search_Setting] fleet1_all_fleet2_standby, sub_auto_call 2025-10-01 19:18:13.327 | INFO | Click ( 508, 217) @ AUTO_SEARCH_SET_MOB 2025-10-01 19:18:13.839 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_auto_call 2025-10-01 19:18:13.842 | INFO | Selected to the correct auto search setting 2025-10-01 19:18:13.845 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_auto_call 2025-10-01 19:18:13.847 | INFO | Selected to the correct auto search setting 2025-10-01 19:18:13.850 | INFO | Click (1043, 580) @ FLEET_PREPARATION 2025-10-01 19:18:14.758 | INFO | is_auto_search_running appeared ────────────────────────────────────────────────────── BATTLE_0 ─────────────────────────────────────────────────────── 2025-10-01 19:18:14.764 | INFO | BATTLE_0 2025-10-01 19:18:14.766 | INFO | Auto search moving 2025-10-01 19:18:14.779 | INFO | Fleet: 1, fleet_current_index: 1 2025-10-01 19:18:14.842 | INFO | [OCR_OIL 0.059s] 10131 2025-10-01 19:18:14.939 | INFO | [OCR_COIN 0.094s] 90516 2025-10-01 19:18:21.814 | INFO | [Loading] 8% 2025-10-01 19:18:21.817 | INFO | Auto search combat loading 2025-10-01 19:18:21.821 | INFO | Screenshot interval set to 1.0s 2025-10-01 19:18:27.819 | INFO | [BattleUI] PAUSE 2025-10-01 19:18:27.822 | INFO | Auto Search combat execute 2025-10-01 19:18:27.824 | INFO | <<< EMOTION REDUCE >>> 2025-10-01 19:18:27.838 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-10-01 19:18:27.844 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=51, Main.Emotion.Fleet1Record=datetime.datetime(2025, 10, 1, 19, 18, 27), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 10, 1, 19, 18, 27) 2025-10-01 19:18:27.860 | INFO | [Emotion fleet_1] 51 2025-10-01 19:18:27.866 | INFO | [Emotion fleet_2] 119 2025-10-01 19:18:33.816 | INFO | Combat auto check timer reached 2025-10-01 19:18:54.849 | INFO | Click (1018, 662) @ GET_SHIP 2025-10-01 19:18:56.849 | INFO | Click (1026, 664) @ GET_SHIP 2025-10-01 19:18:59.862 | INFO | Click (1029, 662) @ GET_SHIP 2025-10-01 19:19:01.861 | INFO | Screenshot interval set to 0.3s 2025-10-01 19:19:01.864 | INFO | Auto Search combat status 2025-10-01 19:19:01.871 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_1 ─────────────────────────────────────────────────────── 2025-10-01 19:19:01.876 | INFO | BATTLE_1 2025-10-01 19:19:01.879 | INFO | Auto search moving 2025-10-01 19:19:01.883 | INFO | Fleet: 1, fleet_current_index: 1 2025-10-01 19:19:01.957 | INFO | [OCR_OIL 0.069s] 10090 2025-10-01 19:19:02.039 | INFO | [OCR_COIN 0.079s] 90534 2025-10-01 19:19:07.554 | INFO | [Loading] 9% 2025-10-01 19:19:07.558 | INFO | Auto search combat loading 2025-10-01 19:19:07.561 | INFO | Screenshot interval set to 1.0s 2025-10-01 19:19:13.554 | INFO | [BattleUI] PAUSE 2025-10-01 19:19:13.557 | INFO | Auto Search combat execute 2025-10-01 19:19:13.560 | INFO | <<< EMOTION REDUCE >>> 2025-10-01 19:19:13.578 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-10-01 19:19:13.582 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=49, Main.Emotion.Fleet1Record=datetime.datetime(2025, 10, 1, 19, 19, 13), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 10, 1, 19, 19, 13) 2025-10-01 19:19:13.595 | INFO | [Emotion fleet_1] 49 2025-10-01 19:19:13.601 | INFO | [Emotion fleet_2] 119 2025-10-01 19:19:19.555 | INFO | Combat auto check timer reached 2025-10-01 19:19:35.582 | INFO | Click (1027, 676) @ GET_SHIP 2025-10-01 19:19:37.587 | INFO | Click (1025, 667) @ GET_SHIP 2025-10-01 19:19:40.594 | INFO | Click (1026, 650) @ GET_SHIP 2025-10-01 19:19:42.596 | INFO | Screenshot interval set to 0.3s 2025-10-01 19:19:42.601 | INFO | Auto Search combat status 2025-10-01 19:19:42.606 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_2 ─────────────────────────────────────────────────────── 2025-10-01 19:19:42.613 | INFO | BATTLE_2 2025-10-01 19:19:42.616 | INFO | Auto search moving 2025-10-01 19:19:42.620 | INFO | Fleet: 1, fleet_current_index: 1 2025-10-01 19:19:42.714 | INFO | [OCR_OIL 0.090s] 10049 2025-10-01 19:19:42.817 | INFO | [OCR_COIN 0.099s] 90556 2025-10-01 19:19:46.806 | INFO | Skip map cat attack 2025-10-01 19:19:46.809 | INFO | Click (1181, 679) @ MAP_CAT_ATTACK 2025-10-01 19:19:48.611 | INFO | [Loading] 10% 2025-10-01 19:19:48.616 | INFO | Auto search combat loading 2025-10-01 19:19:48.619 | INFO | Screenshot interval set to 1.0s 2025-10-01 19:19:54.626 | INFO | [BattleUI] PAUSE 2025-10-01 19:19:54.630 | INFO | Auto Search combat execute 2025-10-01 19:19:54.633 | INFO | <<< EMOTION REDUCE >>> 2025-10-01 19:19:54.644 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-10-01 19:19:54.648 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=47, Main.Emotion.Fleet1Record=datetime.datetime(2025, 10, 1, 19, 19, 54), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 10, 1, 19, 19, 54) 2025-10-01 19:19:54.671 | INFO | [Emotion fleet_1] 47 2025-10-01 19:19:54.675 | INFO | [Emotion fleet_2] 119 2025-10-01 19:20:00.616 | INFO | Combat auto check timer reached 2025-10-01 19:20:19.659 | INFO | Screenshot interval set to 0.3s 2025-10-01 19:20:19.663 | INFO | Auto Search combat status 2025-10-01 19:20:20.536 | INFO | Click (1022, 663) @ GET_SHIP 2025-10-01 19:20:22.042 | INFO | Click (1018, 661) @ GET_SHIP 2025-10-01 19:20:23.247 | INFO | Click (1041, 650) @ GET_SHIP 2025-10-01 19:20:24.129 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_3 ─────────────────────────────────────────────────────── 2025-10-01 19:20:24.135 | INFO | BATTLE_3 2025-10-01 19:20:24.139 | INFO | Auto search moving 2025-10-01 19:20:24.143 | INFO | Fleet: 1, fleet_current_index: 1 2025-10-01 19:20:24.224 | INFO | [OCR_OIL 0.077s] 10026 2025-10-01 19:20:24.295 | INFO | [OCR_COIN 0.068s] 90569 2025-10-01 19:20:29.243 | INFO | Skip map cat attack 2025-10-01 19:20:29.248 | INFO | Click (1226, 694) @ MAP_CAT_ATTACK 2025-10-01 19:20:31.059 | INFO | [Loading] 9% 2025-10-01 19:20:31.063 | INFO | Auto search combat loading 2025-10-01 19:20:31.066 | INFO | Screenshot interval set to 1.0s 2025-10-01 19:20:37.063 | INFO | [BattleUI] PAUSE 2025-10-01 19:20:37.068 | INFO | Auto Search combat execute 2025-10-01 19:20:37.071 | INFO | <<< EMOTION REDUCE >>> 2025-10-01 19:20:37.083 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-10-01 19:20:37.088 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=45, Main.Emotion.Fleet1Record=datetime.datetime(2025, 10, 1, 19, 20, 37), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 10, 1, 19, 20, 37) 2025-10-01 19:20:37.108 | INFO | [Emotion fleet_1] 45 2025-10-01 19:20:37.112 | INFO | [Emotion fleet_2] 119 2025-10-01 19:20:43.049 | INFO | Combat auto check timer reached 2025-10-01 19:21:05.096 | INFO | Click (1035, 668) @ GET_SHIP 2025-10-01 19:21:07.094 | INFO | Click (1026, 661) @ GET_SHIP 2025-10-01 19:21:09.090 | INFO | Click (1045, 669) @ GET_SHIP 2025-10-01 19:21:10.097 | INFO | Click (1029, 670) @ GET_SHIP 2025-10-01 19:21:12.091 | INFO | Screenshot interval set to 0.3s 2025-10-01 19:21:12.095 | INFO | Auto Search combat status 2025-10-01 19:21:12.099 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_4 ─────────────────────────────────────────────────────── 2025-10-01 19:21:12.108 | INFO | BATTLE_4 2025-10-01 19:21:12.113 | INFO | Auto search moving 2025-10-01 19:21:12.118 | INFO | Fleet: 1, fleet_current_index: 1 2025-10-01 19:21:12.220 | INFO | [OCR_OIL 0.098s] 10003 2025-10-01 19:21:12.314 | INFO | [OCR_COIN 0.090s] 90595 2025-10-01 19:21:18.402 | INFO | [Loading] 12% 2025-10-01 19:21:18.407 | INFO | Auto search combat loading 2025-10-01 19:21:18.411 | INFO | Screenshot interval set to 1.0s 2025-10-01 19:21:24.416 | INFO | [BattleUI] PAUSE 2025-10-01 19:21:24.421 | INFO | Auto Search combat execute 2025-10-01 19:21:24.424 | INFO | <<< EMOTION REDUCE >>> 2025-10-01 19:21:24.435 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-10-01 19:21:24.441 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=43, Main.Emotion.Fleet1Record=datetime.datetime(2025, 10, 1, 19, 21, 24), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 10, 1, 19, 21, 24) 2025-10-01 19:21:24.458 | INFO | [Emotion fleet_1] 43 2025-10-01 19:21:24.464 | INFO | [Emotion fleet_2] 119 2025-10-01 19:21:29.429 | INFO | Combat auto check timer reached 2025-10-01 19:21:52.449 | INFO | Click (1025, 660) @ GET_SHIP 2025-10-01 19:21:53.450 | INFO | Click (1048, 664) @ GET_SHIP 2025-10-01 19:21:55.450 | INFO | Screenshot interval set to 0.3s 2025-10-01 19:21:55.454 | INFO | Auto Search combat status 2025-10-01 19:21:55.458 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_5 ─────────────────────────────────────────────────────── 2025-10-01 19:21:55.463 | INFO | BATTLE_5 2025-10-01 19:21:55.466 | INFO | Auto search moving 2025-10-01 19:21:55.470 | INFO | Fleet: 1, fleet_current_index: 1 2025-10-01 19:21:55.543 | INFO | [OCR_OIL 0.070s] 9962 2025-10-01 19:21:55.629 | INFO | [OCR_COIN 0.080s] 90615 2025-10-01 19:24:55.627 | 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 19:24:55.654 | WARNING | Wait too long 2025-10-01 19:24:55.660 | 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 19:24:55.734 | INFO | [Package_name] com.bilibili.azurlane 2025-10-01 19:24:55.738 | ERROR | GameStuckError: Wait too long 2025-10-01 19:24:55.741 | WARNING | Saving error: ./log/error/1759317895741