═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ MAIN ═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ ════════════════════════════════════════════════════ CAMPAIGN_13_1 ════════════════════════════════════════════════════ 2025-10-01 17:42:04.941 | INFO | CAMPAIGN_13_1 2025-10-01 17:42:04.944 | INFO | Count: 0 2025-10-01 17:42:04.967 | INFO | <<< UI ENSURE >>> 2025-10-01 17:42:04.973 | INFO | UI get current page 2025-10-01 17:42:05.496 | INFO | Unknown ui page 2025-10-01 17:42:05.971 | INFO | UI additional: IDLE -> REWARD_GOTO_MAIN 2025-10-01 17:42:05.975 | INFO | Click ( 824, 620) @ REWARD_GOTO_MAIN 2025-10-01 17:42:06.152 | INFO | Unknown ui page 2025-10-01 17:42:06.299 | INFO | [Package_name] com.bilibili.azurlane 2025-10-01 17:42:06.315 | INFO | [Device Orientation] 0 (Normal) 2025-10-01 17:42:06.468 | INFO | Unknown ui page 2025-10-01 17:42:06.676 | INFO | [UI] page_main 2025-10-01 17:42:06.679 | INFO | Goto page_campaign 2025-10-01 17:42:06.682 | INFO | <<< UI GOTO PAGE_CAMPAIGN >>> 2025-10-01 17:42:06.698 | INFO | Page switch: page_main_white -> page_campaign_menu 2025-10-01 17:42:06.703 | INFO | Click (1220, 533) @ MAIN_GOTO_CAMPAIGN_WHITE 2025-10-01 17:42:07.278 | INFO | Page switch: page_campaign_menu -> page_campaign 2025-10-01 17:42:07.282 | INFO | Click ( 386, 329) @ CAMPAIGN_MENU_GOTO_CAMPAIGN 2025-10-01 17:42:07.573 | INFO | Page arrive: page_campaign 2025-10-01 17:42:07.600 | INFO | Mode_switch_1 set to hard 2025-10-01 17:42:07.629 | INFO | [Mode_switch_1] hard 2025-10-01 17:42:07.632 | INFO | <<< UI ENSURE INDEX >>> 2025-10-01 17:42:07.708 | INFO | No stage found. 2025-10-01 17:42:07.937 | INFO | No stage found. 2025-10-01 17:42:08.235 | INFO | No stage found. 2025-10-01 17:42:08.558 | INFO | Loading OCR model: ./bin/cnocr_models/azur_lane 2025-10-01 17:42:08.670 | INFO | [campaign 0.130s] ['13--1', '13--3', '13--2', '13--4'] 2025-10-01 17:42:08.676 | INFO | [Chapter] 13 2025-10-01 17:42:08.679 | INFO | [Stage] 13-1, 13-3, 13-2, 13-4 2025-10-01 17:42:08.681 | INFO | [Index] 13 2025-10-01 17:42:08.754 | INFO | [OCR_OIL 0.041s] 11064 ──────────────────────────────────────────────────────── 13-1 ───────────────────────────────────────────────────────── 2025-10-01 17:42:08.760 | INFO | 13-1 2025-10-01 17:42:08.762 | INFO | Expect emotion reduce: (12, 2) 2025-10-01 17:42:08.772 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-10-01 17:42:08.778 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=53, Main.Emotion.Fleet1Record=datetime.datetime(2025, 10, 1, 17, 42, 8), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 10, 1, 17, 42, 8) 2025-10-01 17:42:08.795 | INFO | [Emotion fleet_1] 53 2025-10-01 17:42:08.800 | INFO | [Emotion fleet_2] 119 2025-10-01 17:42:08.804 | INFO | <<< ENTER MAP >>> 2025-10-01 17:42:08.882 | INFO | Click ( 199, 266) @ 13-1 2025-10-01 17:42:09.584 | INFO | [Map_clear_percentage] 44% 2025-10-01 17:42:09.885 | INFO | [Map_clear_percentage] 99% 2025-10-01 17:42:09.912 | INFO | [MAP_CLEAR_ALL_THIS_TIME] False 2025-10-01 17:42:09.917 | INFO | [Map_info] 99%, star_1, star_2, star_3, 100_percent_clear, 3_stars, threat_safe, clear_mode 2025-10-01 17:42:09.920 | INFO | [StopCondition_MapAchievement] non_stop 2025-10-01 17:42:09.926 | INFO | Fast_Forward set to on 2025-10-01 17:42:09.930 | INFO | [Fast_Forward] on 2025-10-01 17:42:09.946 | INFO | Auto_Search set to on 2025-10-01 17:42:09.952 | INFO | [Auto_Search] on 2025-10-01 17:42:09.957 | INFO | Click ( 939, 520) @ MAP_PREPARATION 2025-10-01 17:42:10.483 | INFO | Handling 2x book setting, mode=prep. 2025-10-01 17:42:10.505 | INFO | Using fleet: [4, 3, 1] 2025-10-01 17:42:10.580 | INFO | Hard satisfied: Fleet_1: None, Fleet_2: None, Submarine: None 2025-10-01 17:42:10.590 | INFO | [map_allow_submarine] True 2025-10-01 17:42:10.594 | INFO | Click (1062, 471) @ SUBMARINE_CHOOSE 2025-10-01 17:42:10.782 | INFO | Current selected: [1] 2025-10-01 17:42:10.787 | INFO | Click (1052, 475) @ SUBMARINE_CHOOSE 2025-10-01 17:42:11.085 | INFO | Click (1136, 330) @ FLEET_2_CLEAR 2025-10-01 17:42:11.687 | INFO | Click (1060, 227) @ FLEET_1_CHOOSE 2025-10-01 17:42:11.982 | INFO | Current selected: [4] 2025-10-01 17:42:11.985 | INFO | Click (1070, 217) @ FLEET_1_CHOOSE 2025-10-01 17:42:12.289 | INFO | Click (1058, 318) @ FLEET_2_CHOOSE 2025-10-01 17:42:12.585 | INFO | Current selected: [4] 2025-10-01 17:42:12.590 | INFO | Click (1057, 480) @ FLEET_2_BAR_INDEX_3 2025-10-01 17:42:12.887 | INFO | Auto search setting 2025-10-01 17:42:12.903 | INFO | [_fleet_sidebar_offset] 0 2025-10-01 17:42:12.907 | INFO | [Fleet_sidebar] 1/3 2025-10-01 17:42:12.914 | INFO | Click (1216, 441) @ FLEET_SIDEBAR_0_2 2025-10-01 17:42:13.461 | INFO | [_fleet_sidebar_offset] 0 2025-10-01 17:42:13.466 | INFO | [Fleet_sidebar] 3/3 2025-10-01 17:42:13.469 | INFO | [Auto_Search_Setting] fleet1_all_fleet2_standby, sub_auto_call 2025-10-01 17:42:13.471 | INFO | Click ( 504, 215) @ AUTO_SEARCH_SET_MOB 2025-10-01 17:42:13.967 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_auto_call 2025-10-01 17:42:13.970 | INFO | Selected to the correct auto search setting 2025-10-01 17:42:13.972 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_auto_call 2025-10-01 17:42:13.974 | INFO | Selected to the correct auto search setting 2025-10-01 17:42:13.979 | INFO | Click (1019, 586) @ FLEET_PREPARATION 2025-10-01 17:42:14.883 | INFO | is_auto_search_running appeared ────────────────────────────────────────────────────── BATTLE_0 ─────────────────────────────────────────────────────── 2025-10-01 17:42:14.888 | INFO | BATTLE_0 2025-10-01 17:42:14.891 | INFO | Auto search moving 2025-10-01 17:42:14.904 | INFO | Fleet: 1, fleet_current_index: 1 2025-10-01 17:42:14.966 | INFO | [OCR_OIL 0.059s] 11054 2025-10-01 17:42:15.055 | INFO | [OCR_COIN 0.086s] 95950 2025-10-01 17:42:21.910 | INFO | Skip map cat attack 2025-10-01 17:42:21.916 | INFO | Click (1216, 677) @ MAP_CAT_ATTACK 2025-10-01 17:42:23.720 | INFO | [Loading] 11% 2025-10-01 17:42:23.724 | INFO | Auto search combat loading 2025-10-01 17:42:23.726 | INFO | Screenshot interval set to 1.0s 2025-10-01 17:42:29.723 | INFO | [BattleUI] PAUSE 2025-10-01 17:42:29.726 | INFO | Auto Search combat execute 2025-10-01 17:42:29.728 | INFO | <<< EMOTION REDUCE >>> 2025-10-01 17:42:29.740 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-10-01 17:42:29.745 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=51, Main.Emotion.Fleet1Record=datetime.datetime(2025, 10, 1, 17, 42, 29), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 10, 1, 17, 42, 29) 2025-10-01 17:42:29.762 | INFO | [Emotion fleet_1] 51 2025-10-01 17:42:29.768 | INFO | [Emotion fleet_2] 119 2025-10-01 17:42:34.733 | INFO | Combat auto check timer reached 2025-10-01 17:42:58.753 | INFO | Click (1036, 661) @ GET_SHIP 2025-10-01 17:42:59.761 | INFO | Click (1032, 661) @ GET_SHIP 2025-10-01 17:43:01.758 | INFO | Screenshot interval set to 0.3s 2025-10-01 17:43:01.764 | INFO | Auto Search combat status 2025-10-01 17:43:01.769 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_1 ─────────────────────────────────────────────────────── 2025-10-01 17:43:01.774 | INFO | BATTLE_1 2025-10-01 17:43:01.777 | INFO | Auto search moving 2025-10-01 17:43:01.781 | INFO | Fleet: 1, fleet_current_index: 1 2025-10-01 17:43:01.851 | INFO | [OCR_OIL 0.066s] 11013 2025-10-01 17:43:01.933 | INFO | [OCR_COIN 0.080s] 95961 2025-10-01 17:43:07.753 | INFO | [Loading] 9% 2025-10-01 17:43:07.756 | INFO | Auto search combat loading 2025-10-01 17:43:07.760 | INFO | Screenshot interval set to 1.0s 2025-10-01 17:43:13.765 | INFO | [BattleUI] PAUSE 2025-10-01 17:43:13.770 | INFO | Auto Search combat execute 2025-10-01 17:43:13.773 | INFO | <<< EMOTION REDUCE >>> 2025-10-01 17:43:13.785 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-10-01 17:43:13.791 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=49, Main.Emotion.Fleet1Record=datetime.datetime(2025, 10, 1, 17, 43, 13), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 10, 1, 17, 43, 13) 2025-10-01 17:43:13.805 | INFO | [Emotion fleet_1] 49 2025-10-01 17:43:13.810 | INFO | [Emotion fleet_2] 119 2025-10-01 17:43:19.754 | INFO | Combat auto check timer reached 2025-10-01 17:43:38.801 | INFO | Screenshot interval set to 0.3s 2025-10-01 17:43:38.805 | INFO | Auto Search combat status 2025-10-01 17:43:40.277 | INFO | Click (1041, 660) @ GET_SHIP 2025-10-01 17:43:41.479 | INFO | Click (1029, 657) @ GET_SHIP 2025-10-01 17:43:43.895 | INFO | Click (1040, 663) @ GET_SHIP 2025-10-01 17:43:45.087 | INFO | Click (1017, 649) @ GET_SHIP 2025-10-01 17:43:45.975 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_2 ─────────────────────────────────────────────────────── 2025-10-01 17:43:45.980 | INFO | BATTLE_2 2025-10-01 17:43:45.982 | INFO | Auto search moving 2025-10-01 17:43:45.985 | INFO | Fleet: 1, fleet_current_index: 1 2025-10-01 17:43:46.049 | INFO | [OCR_OIL 0.060s] 10972 2025-10-01 17:43:46.131 | INFO | [OCR_COIN 0.077s] 95978 2025-10-01 17:43:50.788 | INFO | [Loading] 11% 2025-10-01 17:43:50.792 | INFO | Auto search combat loading 2025-10-01 17:43:50.795 | INFO | Screenshot interval set to 1.0s 2025-10-01 17:43:56.792 | INFO | [BattleUI] PAUSE 2025-10-01 17:43:56.796 | INFO | Auto Search combat execute 2025-10-01 17:43:56.799 | INFO | <<< EMOTION REDUCE >>> 2025-10-01 17:43:56.810 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-10-01 17:43:56.816 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=47, Main.Emotion.Fleet1Record=datetime.datetime(2025, 10, 1, 17, 43, 56), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 10, 1, 17, 43, 56) 2025-10-01 17:43:56.837 | INFO | [Emotion fleet_1] 47 2025-10-01 17:43:56.840 | INFO | [Emotion fleet_2] 119 2025-10-01 17:44:02.784 | INFO | Combat auto check timer reached 2025-10-01 17:44:41.841 | INFO | Click (1037, 645) @ GET_SHIP 2025-10-01 17:44:43.838 | INFO | Click (1018, 660) @ GET_SHIP 2025-10-01 17:44:45.854 | INFO | Click (1014, 647) @ GET_SHIP 2025-10-01 17:44:46.847 | INFO | Screenshot interval set to 0.3s 2025-10-01 17:44:46.850 | INFO | Auto Search combat status 2025-10-01 17:44:46.863 | INFO | Click (1038, 662) @ GET_SHIP 2025-10-01 17:44:48.023 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_3 ─────────────────────────────────────────────────────── 2025-10-01 17:44:48.028 | INFO | BATTLE_3 2025-10-01 17:44:48.030 | INFO | Auto search moving 2025-10-01 17:44:48.033 | INFO | Fleet: 1, fleet_current_index: 1 2025-10-01 17:44:48.107 | INFO | [OCR_OIL 0.069s] 10949 2025-10-01 17:44:48.191 | INFO | [OCR_COIN 0.081s] 95991 2025-10-01 17:44:53.439 | INFO | [Loading] 14% 2025-10-01 17:44:53.443 | INFO | Auto search combat loading 2025-10-01 17:44:53.445 | INFO | Screenshot interval set to 1.0s 2025-10-01 17:44:59.443 | INFO | [BattleUI] PAUSE 2025-10-01 17:44:59.446 | INFO | Auto Search combat execute 2025-10-01 17:44:59.449 | INFO | <<< EMOTION REDUCE >>> 2025-10-01 17:44:59.460 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-10-01 17:44:59.465 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=45, Main.Emotion.Fleet1Record=datetime.datetime(2025, 10, 1, 17, 44, 59), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 10, 1, 17, 44, 59) 2025-10-01 17:44:59.483 | INFO | [Emotion fleet_1] 45 2025-10-01 17:44:59.487 | INFO | [Emotion fleet_2] 119 2025-10-01 17:45:05.443 | INFO | Combat auto check timer reached 2025-10-01 17:45:39.484 | INFO | Screenshot interval set to 0.3s 2025-10-01 17:45:39.489 | INFO | Auto Search combat status 2025-10-01 17:45:40.974 | INFO | Click (1039, 663) @ GET_SHIP 2025-10-01 17:45:42.178 | INFO | Click (1010, 672) @ GET_SHIP 2025-10-01 17:45:44.281 | INFO | Click (1023, 675) @ GET_SHIP 2025-10-01 17:45:45.503 | INFO | Click (1030, 679) @ GET_SHIP 2025-10-01 17:45:46.379 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_4 ─────────────────────────────────────────────────────── 2025-10-01 17:45:46.385 | INFO | BATTLE_4 2025-10-01 17:45:46.387 | INFO | Auto search moving 2025-10-01 17:45:46.390 | INFO | Fleet: 1, fleet_current_index: 1 2025-10-01 17:45:46.459 | INFO | [OCR_OIL 0.064s] 10926 2025-10-01 17:45:46.555 | INFO | [OCR_COIN 0.091s] 96001 2025-10-01 17:45:51.188 | INFO | [Loading] 14% 2025-10-01 17:45:51.193 | INFO | Auto search combat loading 2025-10-01 17:45:51.196 | INFO | Screenshot interval set to 1.0s 2025-10-01 17:45:57.190 | INFO | [BattleUI] PAUSE 2025-10-01 17:45:57.194 | INFO | Auto Search combat execute 2025-10-01 17:45:57.196 | INFO | <<< EMOTION REDUCE >>> 2025-10-01 17:45:57.210 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-10-01 17:45:57.216 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=43, Main.Emotion.Fleet1Record=datetime.datetime(2025, 10, 1, 17, 45, 57), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 10, 1, 17, 45, 57) 2025-10-01 17:45:57.233 | INFO | [Emotion fleet_1] 43 2025-10-01 17:45:57.239 | INFO | [Emotion fleet_2] 119 2025-10-01 17:46:03.197 | INFO | Combat auto check timer reached 2025-10-01 17:47:01.249 | INFO | Click (1026, 665) @ GET_SHIP 2025-10-01 17:47:03.266 | INFO | Click (1018, 653) @ GET_SHIP 2025-10-01 17:47:04.263 | INFO | Screenshot interval set to 0.3s 2025-10-01 17:47:04.266 | INFO | Auto Search combat status 2025-10-01 17:47:04.280 | INFO | Click (1019, 668) @ GET_SHIP 2025-10-01 17:47:05.439 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_5 ─────────────────────────────────────────────────────── 2025-10-01 17:47:05.445 | INFO | BATTLE_5 2025-10-01 17:47:05.447 | INFO | Auto search moving 2025-10-01 17:47:05.450 | INFO | Fleet: 1, fleet_current_index: 1 2025-10-01 17:47:05.546 | INFO | [OCR_OIL 0.092s] 10903 2025-10-01 17:47:05.625 | INFO | [OCR_COIN 0.076s] 96030 2025-10-01 17:50:05.634 | 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:50:05.655 | WARNING | Wait too long 2025-10-01 17:50:05.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 17:50:05.720 | INFO | [Package_name] com.bilibili.azurlane 2025-10-01 17:50:05.726 | ERROR | GameStuckError: Wait too long 2025-10-01 17:50:05.731 | WARNING | Saving error: ./log/error/1759312205731