═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ MAIN ═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ ════════════════════════════════════════════════════ CAMPAIGN_13_1 ════════════════════════════════════════════════════ 2025-10-01 15:06:05.604 | INFO | CAMPAIGN_13_1 2025-10-01 15:06:05.608 | INFO | Count: 0 2025-10-01 15:06:05.627 | INFO | <<< UI ENSURE >>> 2025-10-01 15:06:05.633 | INFO | UI get current page 2025-10-01 15:06:06.155 | INFO | Unknown ui page 2025-10-01 15:06:06.639 | INFO | UI additional: IDLE_2 -> REWARD_GOTO_MAIN 2025-10-01 15:06:06.643 | INFO | Click ( 796, 621) @ REWARD_GOTO_MAIN 2025-10-01 15:06:06.821 | INFO | Unknown ui page 2025-10-01 15:06:06.970 | INFO | [Package_name] com.bilibili.azurlane 2025-10-01 15:06:06.989 | INFO | [Device Orientation] 0 (Normal) 2025-10-01 15:06:07.140 | INFO | Unknown ui page 2025-10-01 15:06:07.345 | INFO | [UI] page_main 2025-10-01 15:06:07.349 | INFO | Goto page_campaign 2025-10-01 15:06:07.352 | INFO | <<< UI GOTO PAGE_CAMPAIGN >>> 2025-10-01 15:06:07.367 | INFO | Page switch: page_main_white -> page_campaign_menu 2025-10-01 15:06:07.373 | INFO | Click (1201, 525) @ MAIN_GOTO_CAMPAIGN_WHITE 2025-10-01 15:06:07.950 | INFO | Page switch: page_campaign_menu -> page_campaign 2025-10-01 15:06:07.955 | INFO | Click ( 337, 235) @ CAMPAIGN_MENU_GOTO_CAMPAIGN 2025-10-01 15:06:08.245 | INFO | Page arrive: page_campaign 2025-10-01 15:06:08.269 | INFO | Mode_switch_1 set to hard 2025-10-01 15:06:08.295 | INFO | [Mode_switch_1] hard 2025-10-01 15:06:08.299 | INFO | <<< UI ENSURE INDEX >>> 2025-10-01 15:06:08.372 | INFO | No stage found. 2025-10-01 15:06:08.604 | INFO | No stage found. 2025-10-01 15:06:08.910 | INFO | No stage found. 2025-10-01 15:06:09.227 | INFO | Loading OCR model: ./bin/cnocr_models/azur_lane 2025-10-01 15:06:09.351 | INFO | [campaign 0.143s] ['13--1', '13--3', '13--2', '13--4'] 2025-10-01 15:06:09.358 | INFO | [Chapter] 13 2025-10-01 15:06:09.361 | INFO | [Stage] 13-1, 13-3, 13-2, 13-4 2025-10-01 15:06:09.364 | INFO | [Index] 13 2025-10-01 15:06:09.437 | INFO | [OCR_OIL 0.047s] 12888 ──────────────────────────────────────────────────────── 13-1 ───────────────────────────────────────────────────────── 2025-10-01 15:06:09.443 | INFO | 13-1 2025-10-01 15:06:09.446 | INFO | Expect emotion reduce: (12, 2) 2025-10-01 15:06:09.458 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-10-01 15:06:09.462 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=53, Main.Emotion.Fleet1Record=datetime.datetime(2025, 10, 1, 15, 6, 9), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 10, 1, 15, 6, 9) 2025-10-01 15:06:09.480 | INFO | [Emotion fleet_1] 53 2025-10-01 15:06:09.484 | INFO | [Emotion fleet_2] 119 2025-10-01 15:06:09.489 | INFO | <<< ENTER MAP >>> 2025-10-01 15:06:09.564 | INFO | Click ( 193, 283) @ 13-1 2025-10-01 15:06:10.274 | INFO | [Map_clear_percentage] 52% 2025-10-01 15:06:10.566 | INFO | [Map_clear_percentage] 99% 2025-10-01 15:06:10.592 | INFO | [MAP_CLEAR_ALL_THIS_TIME] False 2025-10-01 15:06:10.597 | INFO | [Map_info] 99%, star_1, star_2, star_3, 100_percent_clear, 3_stars, threat_safe, clear_mode 2025-10-01 15:06:10.601 | INFO | [StopCondition_MapAchievement] non_stop 2025-10-01 15:06:10.606 | INFO | Fast_Forward set to on 2025-10-01 15:06:10.612 | INFO | [Fast_Forward] on 2025-10-01 15:06:10.630 | INFO | Auto_Search set to on 2025-10-01 15:06:10.636 | INFO | [Auto_Search] on 2025-10-01 15:06:10.643 | INFO | Click ( 954, 528) @ MAP_PREPARATION 2025-10-01 15:06:11.177 | INFO | Handling 2x book setting, mode=prep. 2025-10-01 15:06:11.199 | INFO | Using fleet: [4, 3, 1] 2025-10-01 15:06:11.274 | INFO | Hard satisfied: Fleet_1: None, Fleet_2: None, Submarine: None 2025-10-01 15:06:11.284 | INFO | [map_allow_submarine] True 2025-10-01 15:06:11.288 | INFO | Click (1048, 453) @ SUBMARINE_CHOOSE 2025-10-01 15:06:11.465 | INFO | Current selected: [1] 2025-10-01 15:06:11.469 | INFO | Click (1055, 470) @ SUBMARINE_CHOOSE 2025-10-01 15:06:11.785 | INFO | Click (1144, 327) @ FLEET_2_CLEAR 2025-10-01 15:06:12.367 | INFO | Click (1065, 209) @ FLEET_1_CHOOSE 2025-10-01 15:06:12.664 | INFO | Current selected: [1] 2025-10-01 15:06:12.668 | INFO | Click (1078, 413) @ FLEET_1_BAR_INDEX_4 2025-10-01 15:06:12.964 | INFO | Click (1050, 325) @ FLEET_2_CHOOSE 2025-10-01 15:06:13.264 | INFO | Current selected: [4] 2025-10-01 15:06:13.267 | INFO | Click (1064, 490) @ FLEET_2_BAR_INDEX_3 2025-10-01 15:06:13.568 | INFO | Auto search setting 2025-10-01 15:06:13.585 | INFO | [_fleet_sidebar_offset] 0 2025-10-01 15:06:13.590 | INFO | [Fleet_sidebar] 1/3 2025-10-01 15:06:13.594 | INFO | Click (1211, 454) @ FLEET_SIDEBAR_0_2 2025-10-01 15:06:14.060 | INFO | [_fleet_sidebar_offset] 0 2025-10-01 15:06:14.064 | INFO | [Fleet_sidebar] 3/3 2025-10-01 15:06:14.067 | INFO | [Auto_Search_Setting] fleet1_all_fleet2_standby, sub_auto_call 2025-10-01 15:06:14.070 | INFO | Click ( 502, 208) @ AUTO_SEARCH_SET_MOB 2025-10-01 15:06:14.637 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_auto_call 2025-10-01 15:06:14.640 | INFO | Selected to the correct auto search setting 2025-10-01 15:06:14.644 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_auto_call 2025-10-01 15:06:14.648 | INFO | Selected to the correct auto search setting 2025-10-01 15:06:14.651 | INFO | Click (1085, 587) @ FLEET_PREPARATION 2025-10-01 15:06:15.558 | INFO | is_auto_search_running appeared ────────────────────────────────────────────────────── BATTLE_0 ─────────────────────────────────────────────────────── 2025-10-01 15:06:15.562 | INFO | BATTLE_0 2025-10-01 15:06:15.565 | INFO | Auto search moving 2025-10-01 15:06:15.579 | INFO | Fleet: 1, fleet_current_index: 1 2025-10-01 15:06:15.638 | INFO | [OCR_OIL 0.054s] 12878 2025-10-01 15:06:15.708 | INFO | [OCR_COIN 0.067s] 85856 2025-10-01 15:06:20.778 | INFO | Skip map cat attack 2025-10-01 15:06:20.782 | INFO | Click (1224, 690) @ MAP_CAT_ATTACK 2025-10-01 15:06:22.583 | INFO | [Loading] 7% 2025-10-01 15:06:22.586 | INFO | Auto search combat loading 2025-10-01 15:06:22.589 | INFO | Screenshot interval set to 1.0s 2025-10-01 15:06:28.595 | INFO | [BattleUI] PAUSE 2025-10-01 15:06:28.601 | INFO | Auto Search combat execute 2025-10-01 15:06:28.604 | INFO | <<< EMOTION REDUCE >>> 2025-10-01 15:06:28.621 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-10-01 15:06:28.628 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=51, Main.Emotion.Fleet1Record=datetime.datetime(2025, 10, 1, 15, 6, 28), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 10, 1, 15, 6, 28) 2025-10-01 15:06:28.643 | INFO | [Emotion fleet_1] 51 2025-10-01 15:06:28.646 | INFO | [Emotion fleet_2] 119 2025-10-01 15:06:34.576 | INFO | Combat auto check timer reached 2025-10-01 15:06:57.611 | INFO | Click (1026, 669) @ GET_SHIP 2025-10-01 15:06:59.615 | INFO | Screenshot interval set to 0.3s 2025-10-01 15:06:59.618 | INFO | Auto Search combat status 2025-10-01 15:06:59.622 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_1 ─────────────────────────────────────────────────────── 2025-10-01 15:06:59.628 | INFO | BATTLE_1 2025-10-01 15:06:59.631 | INFO | Auto search moving 2025-10-01 15:06:59.637 | INFO | Fleet: 1, fleet_current_index: 1 2025-10-01 15:06:59.719 | INFO | [OCR_OIL 0.077s] 12837 2025-10-01 15:06:59.815 | INFO | [OCR_COIN 0.091s] 85880 2025-10-01 15:07:05.311 | INFO | [Loading] 10% 2025-10-01 15:07:05.316 | INFO | Auto search combat loading 2025-10-01 15:07:05.319 | INFO | Screenshot interval set to 1.0s 2025-10-01 15:07:11.317 | INFO | [BattleUI] PAUSE 2025-10-01 15:07:11.320 | INFO | Auto Search combat execute 2025-10-01 15:07:11.322 | INFO | <<< EMOTION REDUCE >>> 2025-10-01 15:07:11.334 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-10-01 15:07:11.339 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=49, Main.Emotion.Fleet1Record=datetime.datetime(2025, 10, 1, 15, 7, 11), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 10, 1, 15, 7, 11) 2025-10-01 15:07:11.358 | INFO | [Emotion fleet_1] 49 2025-10-01 15:07:11.361 | INFO | [Emotion fleet_2] 119 2025-10-01 15:07:17.307 | INFO | Combat auto check timer reached 2025-10-01 15:07:56.358 | INFO | Screenshot interval set to 0.3s 2025-10-01 15:07:56.361 | INFO | Auto Search combat status 2025-10-01 15:07:58.763 | INFO | Click (1045, 661) @ GET_SHIP 2025-10-01 15:07:59.954 | INFO | Click (1029, 639) @ GET_SHIP 2025-10-01 15:08:01.144 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_2 ─────────────────────────────────────────────────────── 2025-10-01 15:08:01.152 | INFO | BATTLE_2 2025-10-01 15:08:01.156 | INFO | Auto search moving 2025-10-01 15:08:01.159 | INFO | Fleet: 1, fleet_current_index: 1 2025-10-01 15:08:01.269 | INFO | [OCR_OIL 0.103s] 12814 2025-10-01 15:08:01.354 | INFO | [OCR_COIN 0.080s] 85909 2025-10-01 15:08:05.960 | INFO | Skip map cat attack 2025-10-01 15:08:05.964 | INFO | Click (1209, 670) @ MAP_CAT_ATTACK 2025-10-01 15:08:07.765 | INFO | [Loading] 12% 2025-10-01 15:08:07.769 | INFO | Auto search combat loading 2025-10-01 15:08:07.775 | INFO | Screenshot interval set to 1.0s 2025-10-01 15:08:13.766 | INFO | [BattleUI] PAUSE 2025-10-01 15:08:13.770 | INFO | Auto Search combat execute 2025-10-01 15:08:13.772 | INFO | <<< EMOTION REDUCE >>> 2025-10-01 15:08:13.784 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-10-01 15:08:13.790 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=47, Main.Emotion.Fleet1Record=datetime.datetime(2025, 10, 1, 15, 8, 13), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 10, 1, 15, 8, 13) 2025-10-01 15:08:13.808 | INFO | [Emotion fleet_1] 47 2025-10-01 15:08:13.813 | INFO | [Emotion fleet_2] 119 2025-10-01 15:08:19.758 | INFO | Combat auto check timer reached 2025-10-01 15:09:17.823 | INFO | Click (1018, 673) @ GET_SHIP 2025-10-01 15:09:19.827 | INFO | Click (1023, 642) @ GET_SHIP 2025-10-01 15:09:20.831 | INFO | Click (1040, 678) @ GET_SHIP 2025-10-01 15:09:22.838 | INFO | Screenshot interval set to 0.3s 2025-10-01 15:09:22.842 | INFO | Auto Search combat status 2025-10-01 15:09:22.846 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_3 ─────────────────────────────────────────────────────── 2025-10-01 15:09:22.850 | INFO | BATTLE_3 2025-10-01 15:09:22.853 | INFO | Auto search moving 2025-10-01 15:09:22.857 | INFO | Fleet: 1, fleet_current_index: 1 2025-10-01 15:09:22.947 | INFO | [OCR_OIL 0.087s] 12791 2025-10-01 15:09:23.022 | INFO | [OCR_COIN 0.072s] 85922 2025-10-01 15:09:27.928 | INFO | Skip map cat attack 2025-10-01 15:09:27.931 | INFO | Click (1207, 683) @ MAP_CAT_ATTACK 2025-10-01 15:09:29.727 | INFO | [Loading] 10% 2025-10-01 15:09:29.731 | INFO | Auto search combat loading 2025-10-01 15:09:29.734 | INFO | Screenshot interval set to 1.0s 2025-10-01 15:09:35.733 | INFO | [BattleUI] PAUSE 2025-10-01 15:09:35.737 | INFO | Auto Search combat execute 2025-10-01 15:09:35.740 | INFO | <<< EMOTION REDUCE >>> 2025-10-01 15:09:35.751 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-10-01 15:09:35.756 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=45, Main.Emotion.Fleet1Record=datetime.datetime(2025, 10, 1, 15, 9, 35), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 10, 1, 15, 9, 35) 2025-10-01 15:09:35.775 | INFO | [Emotion fleet_1] 45 2025-10-01 15:09:35.778 | INFO | [Emotion fleet_2] 119 2025-10-01 15:09:40.751 | INFO | Combat auto check timer reached 2025-10-01 15:09:59.760 | INFO | Screenshot interval set to 0.3s 2025-10-01 15:09:59.765 | INFO | Auto Search combat status 2025-10-01 15:10:02.156 | INFO | Click (1033, 671) @ GET_SHIP 2025-10-01 15:10:03.387 | INFO | Click (1022, 658) @ GET_SHIP 2025-10-01 15:10:04.244 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_4 ─────────────────────────────────────────────────────── 2025-10-01 15:10:04.252 | INFO | BATTLE_4 2025-10-01 15:10:04.254 | INFO | Auto search moving 2025-10-01 15:10:04.260 | INFO | Fleet: 1, fleet_current_index: 1 2025-10-01 15:10:04.344 | INFO | [OCR_OIL 0.081s] 12750 2025-10-01 15:10:04.415 | INFO | [OCR_COIN 0.064s] 85941 2025-10-01 15:10:09.662 | INFO | [Loading] 6% 2025-10-01 15:10:09.667 | INFO | Auto search combat loading 2025-10-01 15:10:09.671 | INFO | Screenshot interval set to 1.0s 2025-10-01 15:10:15.677 | INFO | [BattleUI] PAUSE 2025-10-01 15:10:15.681 | INFO | Auto Search combat execute 2025-10-01 15:10:15.684 | INFO | <<< EMOTION REDUCE >>> 2025-10-01 15:10:15.694 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-10-01 15:10:15.701 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=43, Main.Emotion.Fleet1Record=datetime.datetime(2025, 10, 1, 15, 10, 15), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 10, 1, 15, 10, 15) 2025-10-01 15:10:15.719 | INFO | [Emotion fleet_1] 43 2025-10-01 15:10:15.723 | INFO | [Emotion fleet_2] 119 2025-10-01 15:10:21.674 | INFO | Combat auto check timer reached 2025-10-01 15:10:42.696 | INFO | Screenshot interval set to 0.3s 2025-10-01 15:10:42.700 | INFO | Auto Search combat status 2025-10-01 15:10:43.584 | INFO | Click (1026, 673) @ GET_SHIP 2025-10-01 15:10:44.786 | INFO | Click (1011, 671) @ GET_SHIP 2025-10-01 15:10:46.888 | INFO | Click (1024, 661) @ GET_SHIP 2025-10-01 15:10:48.099 | INFO | Click (1024, 657) @ GET_SHIP 2025-10-01 15:10:49.284 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_5 ─────────────────────────────────────────────────────── 2025-10-01 15:10:49.290 | INFO | BATTLE_5 2025-10-01 15:10:49.292 | INFO | Auto search moving 2025-10-01 15:10:49.295 | INFO | Fleet: 1, fleet_current_index: 1 2025-10-01 15:10:49.391 | INFO | [OCR_OIL 0.093s] 12709 2025-10-01 15:10:49.492 | INFO | [OCR_COIN 0.097s] 85952 2025-10-01 15:13:49.492 | 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 15:13:49.522 | WARNING | Wait too long 2025-10-01 15:13:49.527 | 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 15:13:49.601 | INFO | [Package_name] com.bilibili.azurlane 2025-10-01 15:13:49.606 | ERROR | GameStuckError: Wait too long 2025-10-01 15:13:49.609 | WARNING | Saving error: ./log/error/1759302829609