═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ MAIN ═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ ════════════════════════════════════════════════════ CAMPAIGN_13_1 ════════════════════════════════════════════════════ 2025-10-02 06:30:01.547 | INFO | CAMPAIGN_13_1 2025-10-02 06:30:01.552 | INFO | Count: 0 2025-10-02 06:30:01.578 | INFO | <<< UI ENSURE >>> 2025-10-02 06:30:01.581 | INFO | UI get current page 2025-10-02 06:30:02.100 | INFO | Unknown ui page 2025-10-02 06:30:02.570 | INFO | UI additional: IDLE -> REWARD_GOTO_MAIN 2025-10-02 06:30:02.573 | INFO | Click ( 831, 629) @ REWARD_GOTO_MAIN 2025-10-02 06:30:02.750 | INFO | Unknown ui page 2025-10-02 06:30:02.890 | INFO | [Package_name] com.bilibili.azurlane 2025-10-02 06:30:02.914 | INFO | [Device Orientation] 0 (Normal) 2025-10-02 06:30:03.067 | INFO | Unknown ui page 2025-10-02 06:30:03.277 | INFO | [UI] page_main 2025-10-02 06:30:03.281 | INFO | Goto page_campaign 2025-10-02 06:30:03.284 | INFO | <<< UI GOTO PAGE_CAMPAIGN >>> 2025-10-02 06:30:03.300 | INFO | Page switch: page_main_white -> page_campaign_menu 2025-10-02 06:30:03.305 | INFO | Click (1164, 522) @ MAIN_GOTO_CAMPAIGN_WHITE 2025-10-02 06:30:03.880 | INFO | Page switch: page_campaign_menu -> page_campaign 2025-10-02 06:30:03.884 | INFO | Click ( 357, 374) @ CAMPAIGN_MENU_GOTO_CAMPAIGN 2025-10-02 06:30:04.174 | INFO | Page arrive: page_campaign 2025-10-02 06:30:04.199 | INFO | Mode_switch_1 set to hard 2025-10-02 06:30:04.227 | INFO | [Mode_switch_1] hard 2025-10-02 06:30:04.231 | INFO | <<< UI ENSURE INDEX >>> 2025-10-02 06:30:04.303 | INFO | No stage found. 2025-10-02 06:30:04.543 | INFO | No stage found. 2025-10-02 06:30:04.844 | INFO | No stage found. 2025-10-02 06:30:05.160 | INFO | Loading OCR model: ./bin/cnocr_models/azur_lane 2025-10-02 06:30:05.282 | INFO | [campaign 0.140s] ['13--1', '13--3', '13--2', '13--4'] 2025-10-02 06:30:05.285 | INFO | [Chapter] 13 2025-10-02 06:30:05.288 | INFO | [Stage] 13-1, 13-3, 13-2, 13-4 2025-10-02 06:30:05.290 | INFO | [Index] 13 2025-10-02 06:30:05.366 | INFO | [OCR_OIL 0.046s] 3801 ──────────────────────────────────────────────────────── 13-1 ───────────────────────────────────────────────────────── 2025-10-02 06:30:05.371 | INFO | 13-1 2025-10-02 06:30:05.373 | INFO | Expect emotion reduce: (12, 2) 2025-10-02 06:30:05.384 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-10-02 06:30:05.388 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=53, Main.Emotion.Fleet1Record=datetime.datetime(2025, 10, 2, 6, 30, 5), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 10, 2, 6, 30, 5) 2025-10-02 06:30:05.412 | INFO | [Emotion fleet_1] 53 2025-10-02 06:30:05.415 | INFO | [Emotion fleet_2] 119 2025-10-02 06:30:05.420 | INFO | <<< ENTER MAP >>> 2025-10-02 06:30:05.497 | INFO | Click ( 194, 284) @ 13-1 2025-10-02 06:30:06.206 | INFO | [Map_clear_percentage] 46% 2025-10-02 06:30:06.505 | INFO | [Map_clear_percentage] 99% 2025-10-02 06:30:06.530 | INFO | [MAP_CLEAR_ALL_THIS_TIME] False 2025-10-02 06:30:06.535 | INFO | [Map_info] 99%, star_1, star_2, star_3, 100_percent_clear, 3_stars, threat_safe, clear_mode 2025-10-02 06:30:06.538 | INFO | [StopCondition_MapAchievement] non_stop 2025-10-02 06:30:06.540 | INFO | Fast_Forward set to on 2025-10-02 06:30:06.544 | INFO | [Fast_Forward] on 2025-10-02 06:30:06.561 | INFO | Auto_Search set to on 2025-10-02 06:30:06.567 | INFO | [Auto_Search] on 2025-10-02 06:30:06.571 | INFO | Click ( 917, 516) @ MAP_PREPARATION 2025-10-02 06:30:07.104 | INFO | Handling 2x book setting, mode=prep. 2025-10-02 06:30:07.126 | INFO | Using fleet: [4, 3, 1] 2025-10-02 06:30:07.209 | INFO | Hard satisfied: Fleet_1: None, Fleet_2: None, Submarine: None 2025-10-02 06:30:07.221 | INFO | [map_allow_submarine] True 2025-10-02 06:30:07.226 | INFO | Click (1059, 471) @ SUBMARINE_CHOOSE 2025-10-02 06:30:07.402 | INFO | Current selected: [1] 2025-10-02 06:30:07.405 | INFO | Click (1055, 468) @ SUBMARINE_CHOOSE 2025-10-02 06:30:07.703 | INFO | Click (1145, 333) @ FLEET_2_CLEAR 2025-10-02 06:30:08.309 | INFO | Click (1058, 213) @ FLEET_1_CHOOSE 2025-10-02 06:30:08.602 | INFO | Current selected: [4] 2025-10-02 06:30:08.606 | INFO | Click (1071, 216) @ FLEET_1_CHOOSE 2025-10-02 06:30:08.900 | INFO | Click (1051, 318) @ FLEET_2_CHOOSE 2025-10-02 06:30:09.203 | INFO | Current selected: [4] 2025-10-02 06:30:09.206 | INFO | Click (1120, 491) @ FLEET_2_BAR_INDEX_3 2025-10-02 06:30:09.504 | INFO | Auto search setting 2025-10-02 06:30:09.520 | INFO | [_fleet_sidebar_offset] 0 2025-10-02 06:30:09.526 | INFO | [Fleet_sidebar] 1/3 2025-10-02 06:30:09.530 | INFO | Click (1205, 428) @ FLEET_SIDEBAR_0_2 2025-10-02 06:30:10.032 | INFO | [_fleet_sidebar_offset] 0 2025-10-02 06:30:10.037 | INFO | [Fleet_sidebar] 3/3 2025-10-02 06:30:10.040 | INFO | [Auto_Search_Setting] fleet1_all_fleet2_standby, sub_auto_call 2025-10-02 06:30:10.043 | INFO | Click ( 503, 222) @ AUTO_SEARCH_SET_MOB 2025-10-02 06:30:10.492 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_auto_call 2025-10-02 06:30:10.496 | INFO | Selected to the correct auto search setting 2025-10-02 06:30:10.500 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_auto_call 2025-10-02 06:30:10.503 | INFO | Selected to the correct auto search setting 2025-10-02 06:30:10.507 | INFO | Click (1078, 577) @ FLEET_PREPARATION 2025-10-02 06:30:11.415 | INFO | is_auto_search_running appeared ────────────────────────────────────────────────────── BATTLE_0 ─────────────────────────────────────────────────────── 2025-10-02 06:30:11.421 | INFO | BATTLE_0 2025-10-02 06:30:11.425 | INFO | Auto search moving 2025-10-02 06:30:11.442 | INFO | Fleet: 1, fleet_current_index: 1 2025-10-02 06:30:11.505 | INFO | [OCR_OIL 0.058s] 3791 2025-10-02 06:30:11.612 | INFO | [OCR_COIN 0.103s] 116323 2025-10-02 06:30:17.271 | INFO | [Loading] 9% 2025-10-02 06:30:17.277 | INFO | Auto search combat loading 2025-10-02 06:30:17.280 | INFO | Screenshot interval set to 1.0s 2025-10-02 06:30:23.277 | INFO | [BattleUI] PAUSE 2025-10-02 06:30:23.282 | INFO | Auto Search combat execute 2025-10-02 06:30:23.284 | INFO | <<< EMOTION REDUCE >>> 2025-10-02 06:30:23.300 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-10-02 06:30:23.304 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=51, Main.Emotion.Fleet1Record=datetime.datetime(2025, 10, 2, 6, 30, 23), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 10, 2, 6, 30, 23) 2025-10-02 06:30:23.321 | INFO | [Emotion fleet_1] 51 2025-10-02 06:30:23.326 | INFO | [Emotion fleet_2] 119 2025-10-02 06:30:29.275 | INFO | Combat auto check timer reached 2025-10-02 06:30:47.320 | INFO | Screenshot interval set to 0.3s 2025-10-02 06:30:47.326 | INFO | Auto Search combat status 2025-10-02 06:30:48.795 | INFO | Click (1023, 660) @ GET_SHIP 2025-10-02 06:30:49.999 | INFO | Click (1035, 646) @ GET_SHIP 2025-10-02 06:30:52.099 | INFO | Click (1039, 673) @ GET_SHIP 2025-10-02 06:30:53.303 | INFO | Click (1031, 650) @ GET_SHIP 2025-10-02 06:30:54.490 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_1 ─────────────────────────────────────────────────────── 2025-10-02 06:30:54.498 | INFO | BATTLE_1 2025-10-02 06:30:54.501 | INFO | Auto search moving 2025-10-02 06:30:54.505 | INFO | Fleet: 1, fleet_current_index: 1 2025-10-02 06:30:54.584 | INFO | [OCR_OIL 0.075s] 3750 2025-10-02 06:30:54.679 | INFO | [OCR_COIN 0.092s] 116340 2025-10-02 06:31:00.211 | INFO | [Loading] 5% 2025-10-02 06:31:00.216 | INFO | Auto search combat loading 2025-10-02 06:31:00.218 | INFO | Screenshot interval set to 1.0s 2025-10-02 06:31:06.216 | INFO | [BattleUI] PAUSE 2025-10-02 06:31:06.220 | INFO | Auto Search combat execute 2025-10-02 06:31:06.222 | INFO | <<< EMOTION REDUCE >>> 2025-10-02 06:31:06.234 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-10-02 06:31:06.240 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=49, Main.Emotion.Fleet1Record=datetime.datetime(2025, 10, 2, 6, 31, 6), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 10, 2, 6, 31, 6) 2025-10-02 06:31:06.257 | INFO | [Emotion fleet_1] 49 2025-10-02 06:31:06.261 | INFO | [Emotion fleet_2] 119 2025-10-02 06:31:12.221 | INFO | Combat auto check timer reached 2025-10-02 06:31:31.244 | INFO | Click (1021, 647) @ GET_SHIP 2025-10-02 06:31:32.245 | INFO | Click (1026, 666) @ GET_SHIP 2025-10-02 06:31:35.250 | INFO | Click (1019, 661) @ GET_SHIP 2025-10-02 06:31:37.250 | INFO | Screenshot interval set to 0.3s 2025-10-02 06:31:37.254 | INFO | Auto Search combat status 2025-10-02 06:31:37.258 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_2 ─────────────────────────────────────────────────────── 2025-10-02 06:31:37.262 | INFO | BATTLE_2 2025-10-02 06:31:37.264 | INFO | Auto search moving 2025-10-02 06:31:37.269 | INFO | Fleet: 1, fleet_current_index: 1 2025-10-02 06:31:37.354 | INFO | [OCR_OIL 0.080s] 3709 2025-10-02 06:31:37.447 | INFO | [OCR_COIN 0.088s] 116353 2025-10-02 06:31:41.444 | INFO | [Loading] 5% 2025-10-02 06:31:41.448 | INFO | Auto search combat loading 2025-10-02 06:31:41.453 | INFO | Screenshot interval set to 1.0s 2025-10-02 06:31:47.453 | INFO | [BattleUI] PAUSE 2025-10-02 06:31:47.458 | INFO | Auto Search combat execute 2025-10-02 06:31:47.460 | INFO | <<< EMOTION REDUCE >>> 2025-10-02 06:31:47.471 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-10-02 06:31:47.476 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=47, Main.Emotion.Fleet1Record=datetime.datetime(2025, 10, 2, 6, 31, 47), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 10, 2, 6, 31, 47) 2025-10-02 06:31:47.492 | INFO | [Emotion fleet_1] 47 2025-10-02 06:31:47.498 | INFO | [Emotion fleet_2] 119 2025-10-02 06:31:53.453 | INFO | Combat auto check timer reached 2025-10-02 06:32:13.472 | INFO | Click (1016, 665) @ GET_SHIP 2025-10-02 06:32:14.474 | INFO | Click (1013, 673) @ GET_SHIP 2025-10-02 06:32:17.485 | INFO | Click (1025, 661) @ GET_SHIP 2025-10-02 06:32:19.496 | INFO | Screenshot interval set to 0.3s 2025-10-02 06:32:19.500 | INFO | Auto Search combat status 2025-10-02 06:32:19.504 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_3 ─────────────────────────────────────────────────────── 2025-10-02 06:32:19.509 | INFO | BATTLE_3 2025-10-02 06:32:19.511 | INFO | Auto search moving 2025-10-02 06:32:19.516 | INFO | Fleet: 1, fleet_current_index: 1 2025-10-02 06:32:19.602 | INFO | [OCR_OIL 0.080s] 3668 2025-10-02 06:32:19.704 | INFO | [OCR_COIN 0.099s] 116374 2025-10-02 06:32:24.893 | INFO | Skip map cat attack 2025-10-02 06:32:24.897 | INFO | Click (1209, 679) @ MAP_CAT_ATTACK 2025-10-02 06:32:26.695 | INFO | [Loading] 13% 2025-10-02 06:32:26.697 | INFO | Auto search combat loading 2025-10-02 06:32:26.700 | INFO | Screenshot interval set to 1.0s 2025-10-02 06:32:32.699 | INFO | [BattleUI] PAUSE 2025-10-02 06:32:32.704 | INFO | Auto Search combat execute 2025-10-02 06:32:32.708 | INFO | <<< EMOTION REDUCE >>> 2025-10-02 06:32:32.719 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-10-02 06:32:32.724 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=45, Main.Emotion.Fleet1Record=datetime.datetime(2025, 10, 2, 6, 32, 32), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 10, 2, 6, 32, 32) 2025-10-02 06:32:32.743 | INFO | [Emotion fleet_1] 45 2025-10-02 06:32:32.747 | INFO | [Emotion fleet_2] 119 2025-10-02 06:32:38.692 | INFO | Combat auto check timer reached 2025-10-02 06:33:17.746 | INFO | Click (1042, 657) @ GET_SHIP 2025-10-02 06:33:19.746 | INFO | Click (1021, 647) @ GET_SHIP 2025-10-02 06:33:21.754 | INFO | Click (1041, 667) @ GET_SHIP 2025-10-02 06:33:22.749 | INFO | Screenshot interval set to 0.3s 2025-10-02 06:33:22.753 | INFO | Auto Search combat status 2025-10-02 06:33:22.769 | INFO | Click (1035, 658) @ GET_SHIP 2025-10-02 06:33:23.932 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_4 ─────────────────────────────────────────────────────── 2025-10-02 06:33:23.939 | INFO | BATTLE_4 2025-10-02 06:33:23.942 | INFO | Auto search moving 2025-10-02 06:33:23.945 | INFO | Fleet: 1, fleet_current_index: 1 2025-10-02 06:33:24.038 | INFO | [OCR_OIL 0.088s] 3645 2025-10-02 06:33:24.123 | INFO | [OCR_COIN 0.079s] 116389 2025-10-02 06:33:28.750 | INFO | [Loading] 4% 2025-10-02 06:33:28.753 | INFO | Auto search combat loading 2025-10-02 06:33:28.755 | INFO | Screenshot interval set to 1.0s 2025-10-02 06:33:34.757 | INFO | [BattleUI] PAUSE 2025-10-02 06:33:34.760 | INFO | Auto Search combat execute 2025-10-02 06:33:34.765 | INFO | <<< EMOTION REDUCE >>> 2025-10-02 06:33:34.776 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-10-02 06:33:34.781 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=43, Main.Emotion.Fleet1Record=datetime.datetime(2025, 10, 2, 6, 33, 34), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 10, 2, 6, 33, 34) 2025-10-02 06:33:34.796 | INFO | [Emotion fleet_1] 43 2025-10-02 06:33:34.802 | INFO | [Emotion fleet_2] 119 2025-10-02 06:33:40.761 | INFO | Combat auto check timer reached 2025-10-02 06:34:18.797 | INFO | Screenshot interval set to 0.3s 2025-10-02 06:34:18.800 | INFO | Auto Search combat status 2025-10-02 06:34:19.690 | INFO | Click (1031, 652) @ GET_SHIP 2025-10-02 06:34:21.196 | INFO | Click (1032, 667) @ GET_SHIP 2025-10-02 06:34:22.401 | INFO | Click (1018, 655) @ GET_SHIP 2025-10-02 06:34:23.583 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_5 ─────────────────────────────────────────────────────── 2025-10-02 06:34:23.588 | INFO | BATTLE_5 2025-10-02 06:34:23.592 | INFO | Auto search moving 2025-10-02 06:34:23.596 | INFO | Fleet: 1, fleet_current_index: 1 2025-10-02 06:34:23.679 | INFO | [OCR_OIL 0.078s] 3622 2025-10-02 06:34:23.776 | INFO | [OCR_COIN 0.093s] 116413 2025-10-02 06:37:23.766 | 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 06:37:23.787 | WARNING | Wait too long 2025-10-02 06:37:23.791 | 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 06:37:23.857 | INFO | [Package_name] com.bilibili.azurlane 2025-10-02 06:37:23.861 | ERROR | GameStuckError: Wait too long 2025-10-02 06:37:23.864 | WARNING | Saving error: ./log/error/1759358243864