═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ MAIN ═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ ════════════════════════════════════════════════════ CAMPAIGN_13_1 ════════════════════════════════════════════════════ 2026-10-25 00:44:21.656 | INFO | CAMPAIGN_13_1 2026-10-25 00:44:21.660 | INFO | Campaign run: event="campaign_main", name=campaign_13_1 2026-10-25 00:44:21.662 | INFO | Count: 0 2026-10-25 00:44:21.680 | INFO | <<< UI ENSURE >>> 2026-10-25 00:44:21.684 | INFO | UI get current page 2026-10-25 00:44:21.854 | INFO | Unknown ui page 2026-10-25 00:44:21.859 | INFO | Click (1231, 47) @ GOTO_MAIN 2026-10-25 00:44:22.046 | INFO | Unknown ui page 2026-10-25 00:44:22.197 | INFO | [Package_name] com.bilibili.azurlane 2026-10-25 00:44:22.214 | INFO | [Device Orientation] 0 (Normal) 2026-10-25 00:44:22.357 | INFO | Unknown ui page 2026-10-25 00:44:22.562 | INFO | [UI] page_main 2026-10-25 00:44:22.566 | INFO | Goto page_campaign 2026-10-25 00:44:22.573 | INFO | <<< UI GOTO PAGE_CAMPAIGN >>> 2026-10-25 00:44:22.593 | INFO | Page switch: page_main_white -> page_campaign_menu 2026-10-25 00:44:22.596 | INFO | Click (1213, 507) @ MAIN_GOTO_CAMPAIGN_WHITE 2026-10-25 00:44:23.166 | INFO | Page switch: page_campaign_menu -> page_campaign 2026-10-25 00:44:23.170 | INFO | Click ( 332, 325) @ CAMPAIGN_MENU_GOTO_CAMPAIGN 2026-10-25 00:44:23.482 | INFO | Page arrive: page_campaign 2026-10-25 00:44:23.506 | INFO | Mode_switch_1 set to hard 2026-10-25 00:44:23.530 | INFO | [Mode_switch_1] hard 2026-10-25 00:44:23.533 | INFO | <<< UI ENSURE INDEX >>> 2026-10-25 00:44:23.609 | INFO | No stage found. 2026-10-25 00:44:23.821 | INFO | No stage found. 2026-10-25 00:44:24.172 | INFO | [campaign 0.048s] ['13--2', '13--4'] 2026-10-25 00:44:24.176 | INFO | [Chapter] 13 2026-10-25 00:44:24.178 | INFO | [Stage] 13-2, 13-4 2026-10-25 00:44:24.180 | INFO | [Index] 13 2026-10-25 00:44:24.182 | WARNING | Stage not found: 13-1 2026-10-25 00:44:24.356 | INFO | <<< UI ENSURE >>> 2026-10-25 00:44:24.359 | INFO | UI get current page 2026-10-25 00:44:24.368 | INFO | [UI] page_campaign 2026-10-25 00:44:24.372 | INFO | Already at page_campaign 2026-10-25 00:44:24.377 | INFO | Mode_switch_1 set to hard 2026-10-25 00:44:24.381 | INFO | [Mode_switch_1] hard 2026-10-25 00:44:24.384 | INFO | <<< UI ENSURE INDEX >>> 2026-10-25 00:44:24.491 | INFO | [campaign 0.039s] ['13--2', '13--4'] 2026-10-25 00:44:24.494 | INFO | [Chapter] 13 2026-10-25 00:44:24.496 | INFO | [Stage] 13-2, 13-4 2026-10-25 00:44:24.500 | INFO | [Index] 13 2026-10-25 00:44:24.504 | WARNING | Stage not found: 13-1 2026-10-25 00:44:24.656 | INFO | <<< UI ENSURE >>> 2026-10-25 00:44:24.659 | INFO | UI get current page 2026-10-25 00:44:24.668 | INFO | [UI] page_campaign 2026-10-25 00:44:24.673 | INFO | Already at page_campaign 2026-10-25 00:44:24.678 | INFO | Mode_switch_1 set to hard 2026-10-25 00:44:24.682 | INFO | [Mode_switch_1] hard 2026-10-25 00:44:24.685 | INFO | <<< UI ENSURE INDEX >>> 2026-10-25 00:44:24.809 | INFO | [campaign 0.056s] ['13--1', '13--3', '13--2', '13--4'] 2026-10-25 00:44:24.813 | INFO | [Chapter] 13 2026-10-25 00:44:24.816 | INFO | [Stage] 13-1, 13-3, 13-2, 13-4 2026-10-25 00:44:24.818 | INFO | [Index] 13 2026-10-25 00:44:24.893 | INFO | [OCR_OIL 0.049s] 18540 ──────────────────────────────────────────────────────── 13-1 ───────────────────────────────────────────────────────── 2026-10-25 00:44:24.898 | INFO | 13-1 2026-10-25 00:44:24.901 | INFO | Expect emotion reduce: (12, 2) 2026-10-25 00:44:24.913 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-10-25 00:44:24.916 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=55, Main.Emotion.Fleet1Record=datetime.datetime(2026, 10, 25, 0, 44, 24), Main.Emotion.Fleet2Value=117, Main.Emotion.Fleet2Record=datetime.datetime(2026, 10, 25, 0, 44, 24) 2026-10-25 00:44:24.927 | INFO | [Emotion fleet_1] 55 2026-10-25 00:44:24.930 | INFO | [Emotion fleet_2] 117 2026-10-25 00:44:24.933 | INFO | <<< ENTER MAP >>> 2026-10-25 00:44:24.985 | INFO | Click ( 185, 282) @ 13-1 2026-10-25 00:44:25.389 | INFO | [Map_clear_percentage] 5% 2026-10-25 00:44:25.684 | INFO | [Map_clear_percentage] 63% 2026-10-25 00:44:26.022 | INFO | [Map_clear_percentage] 99% 2026-10-25 00:44:26.053 | INFO | [MAP_CLEAR_ALL_THIS_TIME] False 2026-10-25 00:44:26.060 | INFO | [Map_info] 99%, star_1, star_2, star_3, 100_percent_clear, 3_stars, threat_safe, clear_mode 2026-10-25 00:44:26.064 | INFO | [StopCondition_MapAchievement] non_stop 2026-10-25 00:44:26.073 | INFO | Clear_Mode set to on 2026-10-25 00:44:26.078 | INFO | [Clear_Mode] on 2026-10-25 00:44:26.093 | INFO | Auto_Search set to on 2026-10-25 00:44:26.097 | INFO | [Auto_Search] on 2026-10-25 00:44:26.101 | INFO | Click (1009, 521) @ MAP_PREPARATION 2026-10-25 00:44:26.587 | INFO | Handling 2x book setting, mode=prep. 2026-10-25 00:44:26.609 | INFO | Using fleet: [4, 3, 1] 2026-10-25 00:44:26.683 | INFO | Hard satisfied: Fleet_1: None, Fleet_2: None, Submarine: None 2026-10-25 00:44:26.695 | INFO | [map_allow_submarine] True 2026-10-25 00:44:26.701 | INFO | Click (1142, 329) @ FLEET_2_CLEAR 2026-10-25 00:44:26.756 | INFO | Fleet SUBMARINE set to 1 2026-10-25 00:44:26.759 | INFO | Click (1050, 466) @ SUBMARINE_CHOOSE 2026-10-25 00:44:26.886 | INFO | FleetOption: [1] 2 2026-10-25 00:44:26.891 | INFO | Fleet option 1 is already selected 2026-10-25 00:44:26.895 | INFO | Click (1065, 470) @ SUBMARINE_CHOOSE 2026-10-25 00:44:27.179 | INFO | FleetOption: 2026-10-25 00:44:27.186 | INFO | Fleet FLEET_1 set to 4 2026-10-25 00:44:27.191 | INFO | Click (1059, 222) @ FLEET_1_CHOOSE 2026-10-25 00:44:27.483 | INFO | FleetOption: 1 2 3 [4] 5 6 2026-10-25 00:44:27.488 | INFO | Fleet option 4 is already selected 2026-10-25 00:44:27.492 | INFO | Click (1052, 233) @ FLEET_1_CHOOSE 2026-10-25 00:44:27.780 | INFO | FleetOption: 2026-10-25 00:44:27.785 | INFO | Fleet FLEET_2 set to 3 2026-10-25 00:44:27.788 | INFO | Click (1043, 353) @ FLEET_2_CHOOSE 2026-10-25 00:44:28.086 | INFO | FleetOption: 1 2 3 [4] 5 6 2026-10-25 00:44:28.092 | INFO | Click (1106, 486) @ FleetOption_3 2026-10-25 00:44:28.380 | INFO | FleetOption: 2026-10-25 00:44:28.384 | INFO | Auto search setting 2026-10-25 00:44:28.400 | INFO | [_fleet_sidebar_offset] 0 2026-10-25 00:44:28.405 | INFO | [_fleet_sidebar_offset] 0 2026-10-25 00:44:28.409 | INFO | [Fleet_sidebar] 1/3 2026-10-25 00:44:28.412 | INFO | Click (1203, 451) @ FLEET_SIDEBAR_0_2 2026-10-25 00:44:28.685 | INFO | [_fleet_sidebar_offset] 0 2026-10-25 00:44:28.691 | INFO | [Fleet_sidebar] 3/3 2026-10-25 00:44:28.695 | INFO | [Auto_Search_Setting] fleet1_all_fleet2_standby, sub_standby 2026-10-25 00:44:28.700 | INFO | Click ( 504, 219) @ AUTO_SEARCH_SET_MOB 2026-10-25 00:44:29.177 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_standby 2026-10-25 00:44:29.181 | INFO | Selected to the correct auto search setting 2026-10-25 00:44:29.183 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_standby 2026-10-25 00:44:29.186 | INFO | Selected to the correct auto search setting 2026-10-25 00:44:29.196 | INFO | Click (1095, 578) @ FLEET_PREPARATION 2026-10-25 00:44:30.395 | INFO | is_auto_search_running appeared ────────────────────────────────────────────────────── BATTLE_0 ─────────────────────────────────────────────────────── 2026-10-25 00:44:30.401 | INFO | BATTLE_0 2026-10-25 00:44:30.403 | INFO | Auto search moving 2026-10-25 00:44:30.416 | INFO | Fleet: 1, fleet_current_index: 1 2026-10-25 00:44:30.470 | INFO | [OCR_OIL 0.051s] 18530 2026-10-25 00:44:30.546 | INFO | [OCR_COIN 0.072s] 103127 2026-10-25 00:44:35.701 | INFO | [Loading] 4% 2026-10-25 00:44:35.704 | INFO | Auto search combat loading 2026-10-25 00:44:35.707 | INFO | Screenshot interval set to 1.0s 2026-10-25 00:44:41.703 | INFO | [BattleUI] PAUSE 2026-10-25 00:44:41.709 | INFO | Auto Search combat execute 2026-10-25 00:44:41.712 | INFO | <<< EMOTION REDUCE >>> 2026-10-25 00:44:41.724 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-10-25 00:44:41.728 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=53, Main.Emotion.Fleet1Record=datetime.datetime(2026, 10, 25, 0, 44, 41), Main.Emotion.Fleet2Value=117, Main.Emotion.Fleet2Record=datetime.datetime(2026, 10, 25, 0, 44, 41) 2026-10-25 00:44:41.744 | INFO | [Emotion fleet_1] 53 2026-10-25 00:44:41.748 | INFO | [Emotion fleet_2] 117 2026-10-25 00:44:47.701 | INFO | Combat auto check timer reached 2026-10-25 00:45:07.733 | INFO | Click (1019, 658) @ GET_SHIP 2026-10-25 00:45:09.730 | INFO | Click (1034, 661) @ GET_SHIP 2026-10-25 00:45:12.745 | INFO | Screenshot interval set to 0.3s 2026-10-25 00:45:12.750 | INFO | Auto Search combat status 2026-10-25 00:45:13.915 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_1 ─────────────────────────────────────────────────────── 2026-10-25 00:45:13.920 | INFO | BATTLE_1 2026-10-25 00:45:13.923 | INFO | Auto search moving 2026-10-25 00:45:13.926 | INFO | Fleet: 1, fleet_current_index: 1 2026-10-25 00:45:13.985 | INFO | [OCR_OIL 0.056s] 18511 2026-10-25 00:45:14.039 | INFO | [OCR_COIN 0.050s] 103142 2026-10-25 00:45:19.336 | INFO | [Loading] 7% 2026-10-25 00:45:19.344 | INFO | Auto search combat loading 2026-10-25 00:45:19.347 | INFO | Screenshot interval set to 1.0s 2026-10-25 00:45:25.331 | INFO | [BattleUI] PAUSE 2026-10-25 00:45:25.335 | INFO | Auto Search combat execute 2026-10-25 00:45:25.339 | INFO | <<< EMOTION REDUCE >>> 2026-10-25 00:45:25.351 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-10-25 00:45:25.354 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=51, Main.Emotion.Fleet1Record=datetime.datetime(2026, 10, 25, 0, 45, 25), Main.Emotion.Fleet2Value=117, Main.Emotion.Fleet2Record=datetime.datetime(2026, 10, 25, 0, 45, 25) 2026-10-25 00:45:25.370 | INFO | [Emotion fleet_1] 51 2026-10-25 00:45:25.374 | INFO | [Emotion fleet_2] 117 2026-10-25 00:45:31.329 | INFO | Combat auto check timer reached 2026-10-25 00:45:54.373 | INFO | Click (1042, 656) @ GET_SHIP 2026-10-25 00:45:55.376 | INFO | Click (1022, 656) @ GET_SHIP 2026-10-25 00:45:58.380 | INFO | Screenshot interval set to 0.3s 2026-10-25 00:45:58.384 | INFO | Auto Search combat status 2026-10-25 00:45:59.863 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_2 ─────────────────────────────────────────────────────── 2026-10-25 00:45:59.869 | INFO | BATTLE_2 2026-10-25 00:45:59.872 | INFO | Auto search moving 2026-10-25 00:45:59.875 | INFO | Fleet: 1, fleet_current_index: 1 2026-10-25 00:45:59.932 | INFO | [OCR_OIL 0.053s] 18492 2026-10-25 00:46:00.006 | INFO | [OCR_COIN 0.070s] 103162 2026-10-25 00:46:04.372 | INFO | [Loading] 7% 2026-10-25 00:46:04.376 | INFO | Auto search combat loading 2026-10-25 00:46:04.379 | INFO | Screenshot interval set to 1.0s 2026-10-25 00:46:10.379 | INFO | [BattleUI] PAUSE 2026-10-25 00:46:10.383 | INFO | Auto Search combat execute 2026-10-25 00:46:10.386 | INFO | <<< EMOTION REDUCE >>> 2026-10-25 00:46:10.401 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-10-25 00:46:10.404 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=49, Main.Emotion.Fleet1Record=datetime.datetime(2026, 10, 25, 0, 46, 10), Main.Emotion.Fleet2Value=117, Main.Emotion.Fleet2Record=datetime.datetime(2026, 10, 25, 0, 46, 10) 2026-10-25 00:46:10.424 | INFO | [Emotion fleet_1] 49 2026-10-25 00:46:10.427 | INFO | [Emotion fleet_2] 117 2026-10-25 00:46:16.368 | INFO | Combat auto check timer reached 2026-10-25 00:47:10.446 | INFO | Screenshot interval set to 0.3s 2026-10-25 00:47:10.450 | INFO | Auto Search combat status 2026-10-25 00:47:11.334 | INFO | Click (1014, 649) @ GET_SHIP 2026-10-25 00:47:12.525 | INFO | Click (1032, 664) @ GET_SHIP 2026-10-25 00:47:17.023 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_3 ─────────────────────────────────────────────────────── 2026-10-25 00:47:17.029 | INFO | BATTLE_3 2026-10-25 00:47:17.031 | INFO | Auto search moving 2026-10-25 00:47:17.035 | INFO | Fleet: 1, fleet_current_index: 1 2026-10-25 00:47:17.097 | INFO | [OCR_OIL 0.059s] 18473 2026-10-25 00:47:17.175 | INFO | [OCR_COIN 0.075s] 103186 2026-10-25 00:47:22.437 | INFO | [Loading] 4% 2026-10-25 00:47:22.442 | INFO | Auto search combat loading 2026-10-25 00:47:22.445 | INFO | Screenshot interval set to 1.0s 2026-10-25 00:47:28.449 | INFO | [BattleUI] PAUSE 2026-10-25 00:47:28.457 | INFO | Auto Search combat execute 2026-10-25 00:47:28.463 | INFO | <<< EMOTION REDUCE >>> 2026-10-25 00:47:28.489 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-10-25 00:47:28.499 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=47, Main.Emotion.Fleet1Record=datetime.datetime(2026, 10, 25, 0, 47, 28), Main.Emotion.Fleet2Value=117, Main.Emotion.Fleet2Record=datetime.datetime(2026, 10, 25, 0, 47, 28) 2026-10-25 00:47:28.519 | INFO | [Emotion fleet_1] 47 2026-10-25 00:47:28.525 | INFO | [Emotion fleet_2] 117 2026-10-25 00:47:34.434 | INFO | Combat auto check timer reached 2026-10-25 00:47:53.472 | INFO | Screenshot interval set to 0.3s 2026-10-25 00:47:53.476 | INFO | Auto Search combat status 2026-10-25 00:47:54.359 | INFO | Click (1025, 668) @ GET_SHIP 2026-10-25 00:47:55.558 | INFO | Click (1026, 670) @ GET_SHIP 2026-10-25 00:48:00.062 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_4 ─────────────────────────────────────────────────────── 2026-10-25 00:48:00.067 | INFO | BATTLE_4 2026-10-25 00:48:00.072 | INFO | Auto search moving 2026-10-25 00:48:00.076 | INFO | Fleet: 1, fleet_current_index: 1 2026-10-25 00:48:00.155 | INFO | [OCR_OIL 0.074s] 18454 2026-10-25 00:48:00.271 | INFO | [OCR_COIN 0.112s] 103205 2026-10-25 00:48:04.879 | INFO | [Loading] 4% 2026-10-25 00:48:04.882 | INFO | Auto search combat loading 2026-10-25 00:48:04.886 | INFO | Screenshot interval set to 1.0s 2026-10-25 00:48:10.872 | INFO | [BattleUI] PAUSE 2026-10-25 00:48:10.876 | INFO | Auto Search combat execute 2026-10-25 00:48:10.879 | INFO | <<< EMOTION REDUCE >>> 2026-10-25 00:48:10.894 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-10-25 00:48:10.898 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=47, Main.Emotion.Fleet1Record=datetime.datetime(2026, 10, 25, 0, 48, 10), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 10, 25, 0, 48, 10) 2026-10-25 00:48:10.916 | INFO | [Emotion fleet_1] 47 2026-10-25 00:48:10.921 | INFO | [Emotion fleet_2] 119 2026-10-25 00:48:16.870 | INFO | Combat auto check timer reached 2026-10-25 00:48:56.924 | INFO | Click (1041, 666) @ GET_SHIP 2026-10-25 00:48:59.928 | INFO | Screenshot interval set to 0.3s 2026-10-25 00:48:59.931 | INFO | Auto Search combat status 2026-10-25 00:49:01.407 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_5 ─────────────────────────────────────────────────────── 2026-10-25 00:49:01.413 | INFO | BATTLE_5 2026-10-25 00:49:01.415 | INFO | Auto search moving 2026-10-25 00:49:01.419 | INFO | Fleet: 1, fleet_current_index: 1 2026-10-25 00:49:01.473 | INFO | [OCR_OIL 0.049s] 18435 2026-10-25 00:49:01.525 | INFO | [OCR_COIN 0.048s] 103226 2026-10-25 00:49:03.822 | INFO | [Loading] 7% 2026-10-25 00:49:03.827 | INFO | Auto search combat loading 2026-10-25 00:49:03.833 | INFO | Screenshot interval set to 1.0s 2026-10-25 00:49:09.849 | INFO | [BattleUI] PAUSE 2026-10-25 00:49:09.853 | INFO | Auto Search combat execute 2026-10-25 00:49:09.856 | INFO | <<< EMOTION REDUCE >>> 2026-10-25 00:49:09.871 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-10-25 00:49:09.875 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=45, Main.Emotion.Fleet1Record=datetime.datetime(2026, 10, 25, 0, 49, 9), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 10, 25, 0, 49, 9) 2026-10-25 00:49:09.892 | INFO | [Emotion fleet_1] 45 2026-10-25 00:49:09.895 | INFO | [Emotion fleet_2] 119 2026-10-25 00:49:15.829 | INFO | Combat auto check timer reached 2026-10-25 00:52:09.995 | 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 L445 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-10-25 00:52:10.018 | WARNING | Wait too long 2026-10-25 00:52:10.021 | 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-10-25 00:52:10.081 | INFO | [Package_name] com.bilibili.azurlane 2026-10-25 00:52:10.086 | ERROR | GameStuckError: Wait too long 2026-10-25 00:52:10.088 | WARNING | Saving error: ./log/error/1792860730088