═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ MAIN ═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ ════════════════════════════════════════════════════ CAMPAIGN_13_1 ════════════════════════════════════════════════════ 2026-09-27 01:52:42.361 | INFO | CAMPAIGN_13_1 2026-09-27 01:52:42.375 | INFO | Count: 0 2026-09-27 01:52:42.414 | INFO | <<< UI ENSURE >>> 2026-09-27 01:52:42.424 | INFO | UI get current page 2026-09-27 01:52:43.116 | INFO | Unknown ui page 2026-09-27 01:52:43.592 | INFO | UI additional: IDLE -> REWARD_GOTO_MAIN 2026-09-27 01:52:43.596 | INFO | Click ( 831, 618) @ REWARD_GOTO_MAIN 2026-09-27 01:52:43.791 | INFO | Unknown ui page 2026-09-27 01:52:43.926 | INFO | [Package_name] com.bilibili.azurlane 2026-09-27 01:52:43.946 | INFO | [Device Orientation] 0 (Normal) 2026-09-27 01:52:44.101 | INFO | Unknown ui page 2026-09-27 01:52:44.381 | INFO | Unknown ui page 2026-09-27 01:52:44.595 | INFO | [UI] page_main 2026-09-27 01:52:44.599 | INFO | Goto page_campaign 2026-09-27 01:52:44.604 | INFO | <<< UI GOTO PAGE_CAMPAIGN >>> 2026-09-27 01:52:44.619 | INFO | Page switch: page_main_white -> page_campaign_menu 2026-09-27 01:52:44.626 | INFO | Click (1195, 465) @ MAIN_GOTO_CAMPAIGN_WHITE 2026-09-27 01:52:45.197 | INFO | Page switch: page_campaign_menu -> page_campaign 2026-09-27 01:52:45.201 | INFO | Click ( 356, 395) @ CAMPAIGN_MENU_GOTO_CAMPAIGN 2026-09-27 01:52:45.488 | INFO | Page arrive: page_campaign 2026-09-27 01:52:45.513 | INFO | Mode_switch_1 set to hard 2026-09-27 01:52:45.539 | INFO | [Mode_switch_1] hard 2026-09-27 01:52:45.542 | INFO | <<< UI ENSURE INDEX >>> 2026-09-27 01:52:45.610 | INFO | No stage found. 2026-09-27 01:52:45.853 | INFO | No stage found. 2026-09-27 01:52:46.173 | INFO | Loading OCR model: ./bin/cnocr_models/azur_lane 2026-09-27 01:52:46.252 | INFO | [campaign 0.099s] -1 2026-09-27 01:52:46.502 | INFO | [campaign 0.046s] 16--1 2026-09-27 01:52:46.505 | INFO | [Chapter] 16 2026-09-27 01:52:46.508 | INFO | [Stage] 16-1 2026-09-27 01:52:46.510 | INFO | [Index] 16 2026-09-27 01:52:46.758 | INFO | Click ( 56, 371) @ CHAPTER_PREV 2026-09-27 01:52:47.003 | INFO | Click ( 54, 372) @ CHAPTER_PREV 2026-09-27 01:52:47.214 | INFO | Click ( 53, 371) @ CHAPTER_PREV 2026-09-27 01:52:47.396 | INFO | No stage found. 2026-09-27 01:52:47.708 | INFO | No stage found. 2026-09-27 01:52:47.977 | INFO | No stage found. 2026-09-27 01:52:48.342 | INFO | [campaign 0.059s] ['13--1', '13--3', '13--2', '13--4'] 2026-09-27 01:52:48.347 | INFO | [Chapter] 13 2026-09-27 01:52:48.349 | INFO | [Stage] 13-1, 13-3, 13-2, 13-4 2026-09-27 01:52:48.352 | INFO | [Index] 13 2026-09-27 01:52:48.414 | INFO | [OCR_OIL 0.036s] 3196 ──────────────────────────────────────────────────────── 13-1 ───────────────────────────────────────────────────────── 2026-09-27 01:52:48.420 | INFO | 13-1 2026-09-27 01:52:48.422 | INFO | Expect emotion reduce: (12, 2) 2026-09-27 01:52:48.437 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-09-27 01:52:48.441 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=119, Main.Emotion.Fleet1Record=datetime.datetime(2026, 9, 27, 1, 52, 48), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 9, 27, 1, 52, 48) 2026-09-27 01:52:48.457 | INFO | [Emotion fleet_1] 119 2026-09-27 01:52:48.461 | INFO | [Emotion fleet_2] 119 2026-09-27 01:52:48.466 | INFO | <<< ENTER MAP >>> 2026-09-27 01:52:48.541 | INFO | Click ( 202, 266) @ 13-1 2026-09-27 01:52:48.945 | INFO | [Map_clear_percentage] 5% 2026-09-27 01:52:49.245 | INFO | [Map_clear_percentage] 66% 2026-09-27 01:52:49.545 | INFO | [Map_clear_percentage] 99% 2026-09-27 01:52:49.575 | INFO | [MAP_CLEAR_ALL_THIS_TIME] False 2026-09-27 01:52:49.581 | INFO | [Map_info] 99%, star_1, star_2, star_3, 100_percent_clear, 3_stars, threat_safe, clear_mode 2026-09-27 01:52:49.585 | INFO | [StopCondition_MapAchievement] non_stop 2026-09-27 01:52:49.589 | INFO | Clear_Mode set to on 2026-09-27 01:52:49.593 | INFO | [Clear_Mode] on 2026-09-27 01:52:49.610 | INFO | Auto_Search set to on 2026-09-27 01:52:49.615 | INFO | [Auto_Search] on 2026-09-27 01:52:49.619 | INFO | Click (1064, 514) @ MAP_PREPARATION 2026-09-27 01:52:49.859 | INFO | Handling 2x book setting, mode=prep. 2026-09-27 01:52:50.149 | INFO | Using fleet: [4, 3, 1] 2026-09-27 01:52:50.228 | INFO | Hard satisfied: Fleet_1: None, Fleet_2: None, Submarine: None 2026-09-27 01:52:50.240 | INFO | [map_allow_submarine] True 2026-09-27 01:52:50.247 | INFO | Click (1140, 324) @ FLEET_2_CLEAR 2026-09-27 01:52:50.301 | INFO | Fleet SUBMARINE set to 1 2026-09-27 01:52:50.304 | INFO | Click (1044, 466) @ SUBMARINE_CHOOSE 2026-09-27 01:52:50.455 | INFO | FleetOption: [1] 2 2026-09-27 01:52:50.458 | INFO | Fleet option 1 is already selected 2026-09-27 01:52:50.461 | INFO | Click (1035, 485) @ SUBMARINE_CHOOSE 2026-09-27 01:52:50.748 | INFO | FleetOption: 2026-09-27 01:52:50.755 | INFO | Fleet FLEET_1 set to 4 2026-09-27 01:52:50.758 | INFO | Click (1050, 216) @ FLEET_1_CHOOSE 2026-09-27 01:52:51.055 | INFO | FleetOption: [1] 2 3 4 5 6 2026-09-27 01:52:51.058 | INFO | Click (1138, 410) @ FleetOption_4 2026-09-27 01:52:51.351 | INFO | FleetOption: 2026-09-27 01:52:51.355 | INFO | Fleet FLEET_2 set to 3 2026-09-27 01:52:51.357 | INFO | Click (1042, 341) @ FLEET_2_CHOOSE 2026-09-27 01:52:51.651 | INFO | FleetOption: 1 2 3 [4] 5 6 2026-09-27 01:52:51.655 | INFO | Click (1100, 493) @ FleetOption_3 2026-09-27 01:52:51.952 | INFO | FleetOption: 2026-09-27 01:52:51.955 | INFO | Auto search setting 2026-09-27 01:52:51.969 | INFO | [_fleet_sidebar_offset] 0 2026-09-27 01:52:51.977 | INFO | [_fleet_sidebar_offset] 0 2026-09-27 01:52:51.982 | INFO | [Fleet_sidebar] 1/3 2026-09-27 01:52:51.987 | INFO | Click (1202, 444) @ FLEET_SIDEBAR_0_2 2026-09-27 01:52:52.243 | INFO | [_fleet_sidebar_offset] 0 2026-09-27 01:52:52.248 | INFO | [Fleet_sidebar] 3/3 2026-09-27 01:52:52.251 | INFO | [Auto_Search_Setting] fleet1_all_fleet2_standby, sub_standby 2026-09-27 01:52:52.254 | INFO | Click ( 512, 215) @ AUTO_SEARCH_SET_MOB 2026-09-27 01:52:52.784 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_standby 2026-09-27 01:52:52.788 | INFO | Selected to the correct auto search setting 2026-09-27 01:52:52.792 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_standby 2026-09-27 01:52:52.795 | INFO | Selected to the correct auto search setting 2026-09-27 01:52:52.799 | INFO | Click (1072, 535) @ FLEET_PREPARATION 2026-09-27 01:52:57.894 | INFO | Handling 2x book setting, mode=prep. 2026-09-27 01:52:57.908 | INFO | Using fleet: [4, 3, 1] 2026-09-27 01:52:57.913 | INFO | Auto search setting 2026-09-27 01:52:57.917 | INFO | [_fleet_sidebar_offset] 0 2026-09-27 01:52:57.923 | INFO | [_fleet_sidebar_offset] 0 2026-09-27 01:52:57.930 | INFO | [Fleet_sidebar] 3/3 2026-09-27 01:52:57.934 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_standby 2026-09-27 01:52:57.938 | INFO | Selected to the correct auto search setting 2026-09-27 01:52:57.941 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_standby 2026-09-27 01:52:57.945 | INFO | Selected to the correct auto search setting 2026-09-27 01:52:57.948 | INFO | Click (1108, 583) @ FLEET_PREPARATION 2026-09-27 01:52:58.815 | INFO | is_auto_search_running appeared ────────────────────────────────────────────────────── BATTLE_0 ─────────────────────────────────────────────────────── 2026-09-27 01:52:58.820 | INFO | BATTLE_0 2026-09-27 01:52:58.823 | INFO | Auto search moving 2026-09-27 01:52:58.836 | INFO | Fleet: 1, fleet_current_index: 1 2026-09-27 01:52:58.896 | INFO | [OCR_OIL 0.055s] 3186 2026-09-27 01:52:58.966 | INFO | [OCR_COIN 0.066s] 15216 2026-09-27 01:53:03.511 | INFO | [Loading] 9% 2026-09-27 01:53:03.516 | INFO | Auto search combat loading 2026-09-27 01:53:03.520 | INFO | Screenshot interval set to 1.0s 2026-09-27 01:53:09.528 | INFO | [BattleUI] PAUSE 2026-09-27 01:53:09.534 | INFO | Auto Search combat execute 2026-09-27 01:53:09.539 | INFO | <<< EMOTION REDUCE >>> 2026-09-27 01:53:09.557 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-09-27 01:53:09.561 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=117, Main.Emotion.Fleet1Record=datetime.datetime(2026, 9, 27, 1, 53, 9), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 9, 27, 1, 53, 9) 2026-09-27 01:53:09.581 | INFO | [Emotion fleet_1] 117 2026-09-27 01:53:09.587 | INFO | [Emotion fleet_2] 119 2026-09-27 01:53:15.531 | INFO | Combat auto check timer reached 2026-09-27 01:53:46.562 | INFO | Screenshot interval set to 0.3s 2026-09-27 01:53:46.565 | INFO | Auto Search combat status 2026-09-27 01:53:47.459 | INFO | Click (1022, 667) @ GET_SHIP 2026-09-27 01:53:48.648 | INFO | Click (1014, 655) @ GET_SHIP 2026-09-27 01:53:52.841 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_1 ─────────────────────────────────────────────────────── 2026-09-27 01:53:52.846 | INFO | BATTLE_1 2026-09-27 01:53:52.849 | INFO | Auto search moving 2026-09-27 01:53:52.854 | INFO | Fleet: 1, fleet_current_index: 1 2026-09-27 01:53:52.931 | INFO | [OCR_OIL 0.073s] 3167 2026-09-27 01:53:53.025 | INFO | [OCR_COIN 0.090s] 15233 2026-09-27 01:53:57.055 | INFO | [Loading] 4% 2026-09-27 01:53:57.058 | INFO | Auto search combat loading 2026-09-27 01:53:57.061 | INFO | Screenshot interval set to 1.0s 2026-09-27 01:54:03.075 | INFO | [BattleUI] PAUSE 2026-09-27 01:54:03.079 | INFO | Auto Search combat execute 2026-09-27 01:54:03.082 | INFO | <<< EMOTION REDUCE >>> 2026-09-27 01:54:03.094 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-09-27 01:54:03.098 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=117, Main.Emotion.Fleet1Record=datetime.datetime(2026, 9, 27, 1, 54, 3), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 9, 27, 1, 54, 3) 2026-09-27 01:54:03.114 | INFO | [Emotion fleet_1] 117 2026-09-27 01:54:03.119 | INFO | [Emotion fleet_2] 119 2026-09-27 01:54:09.066 | INFO | Combat auto check timer reached 2026-09-27 01:54:28.105 | INFO | Click (1012, 656) @ GET_SHIP 2026-09-27 01:54:30.093 | INFO | Click (1016, 657) @ GET_SHIP 2026-09-27 01:54:33.111 | INFO | Screenshot interval set to 0.3s 2026-09-27 01:54:33.115 | INFO | Auto Search combat status 2026-09-27 01:54:34.285 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_2 ─────────────────────────────────────────────────────── 2026-09-27 01:54:34.291 | INFO | BATTLE_2 2026-09-27 01:54:34.293 | INFO | Auto search moving 2026-09-27 01:54:34.297 | INFO | Fleet: 1, fleet_current_index: 1 2026-09-27 01:54:34.369 | INFO | [OCR_OIL 0.070s] 3148 2026-09-27 01:54:34.443 | INFO | [OCR_COIN 0.070s] 15253 2026-09-27 01:54:39.096 | INFO | [Loading] 9% 2026-09-27 01:54:39.100 | INFO | Auto search combat loading 2026-09-27 01:54:39.102 | INFO | Screenshot interval set to 1.0s 2026-09-27 01:54:45.107 | INFO | [BattleUI] PAUSE 2026-09-27 01:54:45.110 | INFO | Auto Search combat execute 2026-09-27 01:54:45.112 | INFO | <<< EMOTION REDUCE >>> 2026-09-27 01:54:45.126 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-09-27 01:54:45.130 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=115, Main.Emotion.Fleet1Record=datetime.datetime(2026, 9, 27, 1, 54, 45), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 9, 27, 1, 54, 45) 2026-09-27 01:54:45.148 | INFO | [Emotion fleet_1] 115 2026-09-27 01:54:45.152 | INFO | [Emotion fleet_2] 119 2026-09-27 01:54:51.091 | INFO | Combat auto check timer reached 2026-09-27 01:55:11.132 | INFO | Click (1017, 653) @ GET_SHIP 2026-09-27 01:55:12.137 | INFO | Click (1036, 657) @ GET_SHIP 2026-09-27 01:55:15.141 | INFO | Screenshot interval set to 0.3s 2026-09-27 01:55:15.146 | INFO | Auto Search combat status 2026-09-27 01:55:16.319 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_3 ─────────────────────────────────────────────────────── 2026-09-27 01:55:16.324 | INFO | BATTLE_3 2026-09-27 01:55:16.326 | INFO | Auto search moving 2026-09-27 01:55:16.329 | INFO | Fleet: 1, fleet_current_index: 1 2026-09-27 01:55:16.391 | INFO | [OCR_OIL 0.060s] 3129 2026-09-27 01:55:16.475 | INFO | [OCR_COIN 0.081s] 15271 2026-09-27 01:55:20.831 | INFO | [Loading] 8% 2026-09-27 01:55:20.835 | INFO | Auto search combat loading 2026-09-27 01:55:20.840 | INFO | Screenshot interval set to 1.0s 2026-09-27 01:55:26.832 | INFO | [BattleUI] PAUSE 2026-09-27 01:55:26.837 | INFO | Auto Search combat execute 2026-09-27 01:55:26.839 | INFO | <<< EMOTION REDUCE >>> 2026-09-27 01:55:26.851 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-09-27 01:55:26.855 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=113, Main.Emotion.Fleet1Record=datetime.datetime(2026, 9, 27, 1, 55, 26), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 9, 27, 1, 55, 26) 2026-09-27 01:55:26.875 | INFO | [Emotion fleet_1] 113 2026-09-27 01:55:26.879 | INFO | [Emotion fleet_2] 119 2026-09-27 01:55:32.835 | INFO | Combat auto check timer reached 2026-09-27 01:56:08.891 | INFO | Screenshot interval set to 0.3s 2026-09-27 01:56:08.894 | INFO | Auto Search combat status 2026-09-27 01:56:10.369 | INFO | Click (1019, 664) @ GET_SHIP 2026-09-27 01:56:11.568 | INFO | Click (1023, 650) @ GET_SHIP 2026-09-27 01:56:15.770 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_4 ─────────────────────────────────────────────────────── 2026-09-27 01:56:15.776 | INFO | BATTLE_4 2026-09-27 01:56:15.780 | INFO | Auto search moving 2026-09-27 01:56:15.787 | INFO | Fleet: 1, fleet_current_index: 1 2026-09-27 01:56:15.844 | INFO | [OCR_OIL 0.053s] 3110 2026-09-27 01:56:15.901 | INFO | [OCR_COIN 0.054s] 15284 2026-09-27 01:56:20.290 | INFO | [Loading] 7% 2026-09-27 01:56:20.296 | INFO | Auto search combat loading 2026-09-27 01:56:20.302 | INFO | Screenshot interval set to 1.0s 2026-09-27 01:56:26.294 | INFO | [BattleUI] PAUSE 2026-09-27 01:56:26.300 | INFO | Auto Search combat execute 2026-09-27 01:56:26.304 | INFO | <<< EMOTION REDUCE >>> 2026-09-27 01:56:26.318 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-09-27 01:56:26.327 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=111, Main.Emotion.Fleet1Record=datetime.datetime(2026, 9, 27, 1, 56, 26), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 9, 27, 1, 56, 26) 2026-09-27 01:56:26.349 | INFO | [Emotion fleet_1] 111 2026-09-27 01:56:26.352 | INFO | [Emotion fleet_2] 119 2026-09-27 01:56:32.286 | INFO | Combat auto check timer reached 2026-09-27 01:57:03.324 | INFO | Screenshot interval set to 0.3s 2026-09-27 01:57:03.327 | INFO | Auto Search combat status 2026-09-27 01:57:08.106 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_5 ─────────────────────────────────────────────────────── 2026-09-27 01:57:08.110 | INFO | BATTLE_5 2026-09-27 01:57:08.114 | INFO | Auto search moving 2026-09-27 01:57:08.118 | INFO | Fleet: 1, fleet_current_index: 1 2026-09-27 01:57:08.219 | INFO | [OCR_OIL 0.096s] 3091 2026-09-27 01:57:08.292 | INFO | [OCR_COIN 0.070s] 15298 2026-09-27 01:57:09.912 | INFO | [Loading] 11% 2026-09-27 01:57:09.916 | INFO | Auto search combat loading 2026-09-27 01:57:09.920 | INFO | Screenshot interval set to 1.0s 2026-09-27 01:57:15.929 | INFO | [BattleUI] PAUSE 2026-09-27 01:57:15.933 | INFO | Auto Search combat execute 2026-09-27 01:57:15.936 | INFO | <<< EMOTION REDUCE >>> 2026-09-27 01:57:15.952 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-09-27 01:57:15.959 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=109, Main.Emotion.Fleet1Record=datetime.datetime(2026, 9, 27, 1, 57, 15), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 9, 27, 1, 57, 15) 2026-09-27 01:57:15.996 | INFO | [Emotion fleet_1] 109 2026-09-27 01:57:16.002 | INFO | [Emotion fleet_2] 119 2026-09-27 01:57:21.917 | INFO | Combat auto check timer reached 2026-09-27 02:00:16.095 | 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 L1550 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 L587 loop() alas.py L69 run() alas.py L356 main() run.py L438 run() campaign_base.py L143 run() campaign_base.py L178 auto_search_execute_a_battle() auto_search_combat.py L357 auto_search_combat() auto_search_combat.py L252 auto_search_combat_execute() base.py L169 loop() device.py L194 screenshot() device.py L256 stuck_record_check() device.py L43 show_function_call() 2026-09-27 02:00:16.117 | WARNING | Wait too long 2026-09-27 02:00:16.120 | WARNING | Waiting for {'EXP_INFO_B', 'BATTLE_STATUS_B', 'EXP_INFO_A', 'EXP_INFO_S', 'GET_MISSION', 'GET_SHIP', 'COMBAT_AUTO', 'POPUP_CONFIRM_WHITE', 'COMBAT_AUTO_133', 'SP_CHECK', 'POPUP_CANCEL', 'AUTO_SEARCH_MAP_OPTION_ON', 'BATTLE_STATUS_A', 'MISSION_POPUP_GO', 'EVENT_CHECK', 'GUILD_POPUP_CONFIRM', 'BATTLE_STATUS_S', 'COMBAT_AUTO_150', 'CAMPAIGN_CHECK', 'PAUSE'} 2026-09-27 02:00:16.178 | INFO | [Package_name] com.bilibili.azurlane 2026-09-27 02:00:16.180 | ERROR | GameStuckError: Wait too long 2026-09-27 02:00:16.183 | WARNING | Saving error: ./log/error/1790445616183