═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ MAIN ═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ ════════════════════════════════════════════════════ CAMPAIGN_13_1 ════════════════════════════════════════════════════ 2026-10-23 00:29:40.581 | INFO | CAMPAIGN_13_1 2026-10-23 00:29:40.585 | INFO | Campaign run: event="campaign_main", name=campaign_13_1 2026-10-23 00:29:40.588 | INFO | Count: 0 2026-10-23 00:29:40.606 | INFO | <<< UI ENSURE >>> 2026-10-23 00:29:40.610 | INFO | UI get current page 2026-10-23 00:29:40.656 | INFO | [UI] page_os 2026-10-23 00:29:40.659 | INFO | Goto page_campaign 2026-10-23 00:29:40.664 | INFO | <<< UI GOTO PAGE_CAMPAIGN >>> 2026-10-23 00:29:40.691 | INFO | Page switch: page_os -> page_main 2026-10-23 00:29:40.694 | INFO | Click (1238, 36) @ GOTO_MAIN 2026-10-23 00:29:41.522 | INFO | Page switch: page_main_white -> page_campaign_menu 2026-10-23 00:29:41.526 | INFO | Click (1209, 450) @ MAIN_GOTO_CAMPAIGN_WHITE 2026-10-23 00:29:42.119 | INFO | Page switch: page_campaign_menu -> page_campaign 2026-10-23 00:29:42.122 | INFO | Click ( 344, 356) @ CAMPAIGN_MENU_GOTO_CAMPAIGN 2026-10-23 00:29:42.412 | INFO | Page arrive: page_campaign 2026-10-23 00:29:42.437 | INFO | Mode_switch_1 set to hard 2026-10-23 00:29:42.462 | INFO | [Mode_switch_1] hard 2026-10-23 00:29:42.466 | INFO | <<< UI ENSURE INDEX >>> 2026-10-23 00:29:42.538 | INFO | No stage found. 2026-10-23 00:29:42.778 | INFO | No stage found. 2026-10-23 00:29:43.107 | INFO | [campaign 0.030s] -1 2026-10-23 00:29:43.414 | INFO | [campaign 0.039s] 16--1 2026-10-23 00:29:43.417 | INFO | [Chapter] 16 2026-10-23 00:29:43.420 | INFO | [Stage] 16-1 2026-10-23 00:29:43.423 | INFO | [Index] 16 2026-10-23 00:29:43.661 | INFO | Click ( 52, 372) @ CHAPTER_PREV 2026-10-23 00:29:43.922 | INFO | Click ( 50, 375) @ CHAPTER_PREV 2026-10-23 00:29:44.187 | INFO | Click ( 47, 374) @ CHAPTER_PREV 2026-10-23 00:29:44.350 | INFO | No stage found. 2026-10-23 00:29:44.644 | INFO | No stage found. 2026-10-23 00:29:44.950 | INFO | No stage found. 2026-10-23 00:29:45.302 | INFO | [campaign 0.054s] ['13--1', '13--3', '13--2', '13--4'] 2026-10-23 00:29:45.306 | INFO | [Chapter] 13 2026-10-23 00:29:45.309 | INFO | [Stage] 13-1, 13-3, 13-2, 13-4 2026-10-23 00:29:45.312 | INFO | [Index] 13 2026-10-23 00:29:45.384 | INFO | [OCR_OIL 0.046s] 22483 ──────────────────────────────────────────────────────── 13-1 ───────────────────────────────────────────────────────── 2026-10-23 00:29:45.390 | INFO | 13-1 2026-10-23 00:29:45.392 | INFO | Expect emotion reduce: (12, 2) 2026-10-23 00:29:45.404 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-10-23 00:29:45.408 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=57, Main.Emotion.Fleet1Record=datetime.datetime(2026, 10, 23, 0, 29, 45), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 10, 23, 0, 29, 45) 2026-10-23 00:29:45.424 | INFO | [Emotion fleet_1] 57 2026-10-23 00:29:45.427 | INFO | [Emotion fleet_2] 119 2026-10-23 00:29:45.430 | INFO | <<< ENTER MAP >>> 2026-10-23 00:29:45.484 | INFO | Click ( 192, 269) @ 13-1 2026-10-23 00:29:45.886 | INFO | [Map_clear_percentage] 5% 2026-10-23 00:29:46.193 | INFO | [Map_clear_percentage] 66% 2026-10-23 00:29:46.501 | INFO | [Map_clear_percentage] 99% 2026-10-23 00:29:46.534 | INFO | [MAP_CLEAR_ALL_THIS_TIME] False 2026-10-23 00:29:46.540 | INFO | [Map_info] 99%, star_1, star_2, star_3, 100_percent_clear, 3_stars, threat_safe, clear_mode 2026-10-23 00:29:46.545 | INFO | [StopCondition_MapAchievement] non_stop 2026-10-23 00:29:46.549 | INFO | Clear_Mode set to on 2026-10-23 00:29:46.553 | INFO | [Clear_Mode] on 2026-10-23 00:29:46.570 | INFO | Auto_Search set to on 2026-10-23 00:29:46.576 | INFO | [Auto_Search] on 2026-10-23 00:29:46.581 | INFO | Click (1031, 519) @ MAP_PREPARATION 2026-10-23 00:29:47.087 | INFO | Handling 2x book setting, mode=prep. 2026-10-23 00:29:47.111 | INFO | Using fleet: [4, 3, 1] 2026-10-23 00:29:47.186 | INFO | Hard satisfied: Fleet_1: None, Fleet_2: None, Submarine: None 2026-10-23 00:29:47.197 | INFO | [map_allow_submarine] True 2026-10-23 00:29:47.202 | INFO | Click (1132, 331) @ FLEET_2_CLEAR 2026-10-23 00:29:47.255 | INFO | Fleet SUBMARINE set to 1 2026-10-23 00:29:47.259 | INFO | Click (1046, 472) @ SUBMARINE_CHOOSE 2026-10-23 00:29:47.388 | INFO | FleetOption: [1] 2 2026-10-23 00:29:47.392 | INFO | Fleet option 1 is already selected 2026-10-23 00:29:47.396 | INFO | Click (1044, 479) @ SUBMARINE_CHOOSE 2026-10-23 00:29:47.680 | INFO | FleetOption: 2026-10-23 00:29:47.686 | INFO | Fleet FLEET_1 set to 4 2026-10-23 00:29:47.693 | INFO | Click (1064, 224) @ FLEET_1_CHOOSE 2026-10-23 00:29:47.986 | INFO | FleetOption: [1] 2 3 4 5 6 2026-10-23 00:29:47.991 | INFO | Click (1115, 421) @ FleetOption_4 2026-10-23 00:29:48.281 | INFO | FleetOption: 2026-10-23 00:29:48.284 | INFO | Fleet FLEET_2 set to 3 2026-10-23 00:29:48.287 | INFO | Click (1047, 331) @ FLEET_2_CHOOSE 2026-10-23 00:29:48.586 | INFO | FleetOption: 1 2 3 [4] 5 6 2026-10-23 00:29:48.591 | INFO | Click (1073, 487) @ FleetOption_3 2026-10-23 00:29:48.883 | INFO | FleetOption: 2026-10-23 00:29:48.886 | INFO | Auto search setting 2026-10-23 00:29:48.903 | INFO | [_fleet_sidebar_offset] 0 2026-10-23 00:29:48.911 | INFO | [_fleet_sidebar_offset] 0 2026-10-23 00:29:48.915 | INFO | [Fleet_sidebar] 1/3 2026-10-23 00:29:48.918 | INFO | Click (1208, 430) @ FLEET_SIDEBAR_0_2 2026-10-23 00:29:49.184 | INFO | [_fleet_sidebar_offset] 0 2026-10-23 00:29:49.188 | INFO | [Fleet_sidebar] 3/3 2026-10-23 00:29:49.193 | INFO | [Auto_Search_Setting] fleet1_all_fleet2_standby, sub_standby 2026-10-23 00:29:49.197 | INFO | Click ( 503, 215) @ AUTO_SEARCH_SET_MOB 2026-10-23 00:29:49.706 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_standby 2026-10-23 00:29:49.712 | INFO | Selected to the correct auto search setting 2026-10-23 00:29:49.715 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_standby 2026-10-23 00:29:49.717 | INFO | Selected to the correct auto search setting 2026-10-23 00:29:49.723 | INFO | Click (1065, 590) @ FLEET_PREPARATION 2026-10-23 00:29:50.955 | INFO | is_auto_search_running appeared ────────────────────────────────────────────────────── BATTLE_0 ─────────────────────────────────────────────────────── 2026-10-23 00:29:50.960 | INFO | BATTLE_0 2026-10-23 00:29:50.963 | INFO | Auto search moving 2026-10-23 00:29:50.978 | INFO | Fleet: 1, fleet_current_index: 1 2026-10-23 00:29:51.041 | INFO | [OCR_OIL 0.059s] 22473 2026-10-23 00:29:51.120 | INFO | [OCR_COIN 0.076s] 111929 2026-10-23 00:29:55.974 | INFO | [Loading] 5% 2026-10-23 00:29:55.978 | INFO | Auto search combat loading 2026-10-23 00:29:55.984 | INFO | Screenshot interval set to 1.0s 2026-10-23 00:30:02.000 | INFO | [BattleUI] PAUSE 2026-10-23 00:30:02.005 | INFO | Auto Search combat execute 2026-10-23 00:30:02.010 | INFO | <<< EMOTION REDUCE >>> 2026-10-23 00:30:02.025 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-10-23 00:30:02.030 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=57, Main.Emotion.Fleet1Record=datetime.datetime(2026, 10, 23, 0, 30, 2), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 10, 23, 0, 30, 2) 2026-10-23 00:30:02.051 | INFO | [Emotion fleet_1] 57 2026-10-23 00:30:02.054 | INFO | [Emotion fleet_2] 119 2026-10-23 00:30:07.984 | INFO | Combat auto check timer reached 2026-10-23 00:30:40.023 | INFO | Screenshot interval set to 0.3s 2026-10-23 00:30:40.027 | INFO | Auto Search combat status 2026-10-23 00:30:41.522 | INFO | Click (1037, 641) @ GET_SHIP 2026-10-23 00:30:42.721 | INFO | Click (1030, 665) @ GET_SHIP 2026-10-23 00:30:47.208 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_1 ─────────────────────────────────────────────────────── 2026-10-23 00:30:47.214 | INFO | BATTLE_1 2026-10-23 00:30:47.217 | INFO | Auto search moving 2026-10-23 00:30:47.222 | INFO | Fleet: 1, fleet_current_index: 1 2026-10-23 00:30:47.285 | INFO | [OCR_OIL 0.059s] 22454 2026-10-23 00:30:47.381 | INFO | [OCR_COIN 0.092s] 111946 2026-10-23 00:30:52.328 | INFO | [Loading] 10% 2026-10-23 00:30:52.332 | INFO | Auto search combat loading 2026-10-23 00:30:52.336 | INFO | Screenshot interval set to 1.0s 2026-10-23 00:30:58.331 | INFO | [BattleUI] PAUSE 2026-10-23 00:30:58.334 | INFO | Auto Search combat execute 2026-10-23 00:30:58.336 | INFO | <<< EMOTION REDUCE >>> 2026-10-23 00:30:58.350 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-10-23 00:30:58.354 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=55, Main.Emotion.Fleet1Record=datetime.datetime(2026, 10, 23, 0, 30, 58), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 10, 23, 0, 30, 58) 2026-10-23 00:30:58.372 | INFO | [Emotion fleet_1] 55 2026-10-23 00:30:58.375 | INFO | [Emotion fleet_2] 119 2026-10-23 00:31:04.335 | INFO | Combat auto check timer reached 2026-10-23 00:31:40.377 | INFO | Screenshot interval set to 0.3s 2026-10-23 00:31:40.380 | INFO | Auto Search combat status 2026-10-23 00:31:45.164 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_2 ─────────────────────────────────────────────────────── 2026-10-23 00:31:45.170 | INFO | BATTLE_2 2026-10-23 00:31:45.173 | INFO | Auto search moving 2026-10-23 00:31:45.178 | INFO | Fleet: 1, fleet_current_index: 1 2026-10-23 00:31:45.237 | INFO | [OCR_OIL 0.055s] 22435 2026-10-23 00:31:45.302 | INFO | [OCR_COIN 0.061s] 111968 2026-10-23 00:31:49.974 | INFO | [Loading] 11% 2026-10-23 00:31:49.979 | INFO | Auto search combat loading 2026-10-23 00:31:49.982 | INFO | Screenshot interval set to 1.0s 2026-10-23 00:31:55.992 | INFO | [BattleUI] PAUSE 2026-10-23 00:31:55.995 | INFO | Auto Search combat execute 2026-10-23 00:31:55.997 | INFO | <<< EMOTION REDUCE >>> 2026-10-23 00:31:56.015 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-10-23 00:31:56.020 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=53, Main.Emotion.Fleet1Record=datetime.datetime(2026, 10, 23, 0, 31, 56), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 10, 23, 0, 31, 56) 2026-10-23 00:31:56.038 | INFO | [Emotion fleet_1] 53 2026-10-23 00:31:56.043 | INFO | [Emotion fleet_2] 119 2026-10-23 00:32:01.045 | INFO | Combat auto check timer reached 2026-10-23 00:32:27.015 | INFO | Click (1037, 670) @ GET_SHIP 2026-10-23 00:32:28.018 | INFO | Click (1010, 672) @ GET_SHIP 2026-10-23 00:32:31.049 | INFO | Screenshot interval set to 0.3s 2026-10-23 00:32:31.054 | INFO | Auto Search combat status 2026-10-23 00:32:32.502 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_3 ─────────────────────────────────────────────────────── 2026-10-23 00:32:32.509 | INFO | BATTLE_3 2026-10-23 00:32:32.511 | INFO | Auto search moving 2026-10-23 00:32:32.514 | INFO | Fleet: 1, fleet_current_index: 1 2026-10-23 00:32:32.572 | INFO | [OCR_OIL 0.054s] 22416 2026-10-23 00:32:32.629 | INFO | [OCR_COIN 0.053s] 111992 2026-10-23 00:32:37.016 | INFO | [Loading] 7% 2026-10-23 00:32:37.019 | INFO | Auto search combat loading 2026-10-23 00:32:37.021 | INFO | Screenshot interval set to 1.0s 2026-10-23 00:32:43.021 | INFO | [BattleUI] PAUSE 2026-10-23 00:32:43.025 | INFO | Auto Search combat execute 2026-10-23 00:32:43.028 | INFO | <<< EMOTION REDUCE >>> 2026-10-23 00:32:43.043 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-10-23 00:32:43.049 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=51, Main.Emotion.Fleet1Record=datetime.datetime(2026, 10, 23, 0, 32, 43), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 10, 23, 0, 32, 43) 2026-10-23 00:32:43.064 | INFO | [Emotion fleet_1] 51 2026-10-23 00:32:43.068 | INFO | [Emotion fleet_2] 119 2026-10-23 00:32:49.015 | INFO | Combat auto check timer reached 2026-10-23 00:33:12.052 | INFO | Screenshot interval set to 0.3s 2026-10-23 00:33:12.055 | INFO | Auto Search combat status 2026-10-23 00:33:16.839 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_4 ─────────────────────────────────────────────────────── 2026-10-23 00:33:16.843 | INFO | BATTLE_4 2026-10-23 00:33:16.846 | INFO | Auto search moving 2026-10-23 00:33:16.850 | INFO | Fleet: 1, fleet_current_index: 1 2026-10-23 00:33:16.908 | INFO | [OCR_OIL 0.052s] 22397 2026-10-23 00:33:16.991 | INFO | [OCR_COIN 0.079s] 112013 2026-10-23 00:33:21.352 | INFO | [Loading] 7% 2026-10-23 00:33:21.356 | INFO | Auto search combat loading 2026-10-23 00:33:21.359 | INFO | Screenshot interval set to 1.0s 2026-10-23 00:33:27.373 | INFO | [BattleUI] PAUSE 2026-10-23 00:33:27.377 | INFO | Auto Search combat execute 2026-10-23 00:33:27.381 | INFO | <<< EMOTION REDUCE >>> 2026-10-23 00:33:27.394 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-10-23 00:33:27.397 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=49, Main.Emotion.Fleet1Record=datetime.datetime(2026, 10, 23, 0, 33, 27), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 10, 23, 0, 33, 27) 2026-10-23 00:33:27.414 | INFO | [Emotion fleet_1] 49 2026-10-23 00:33:27.418 | INFO | [Emotion fleet_2] 119 2026-10-23 00:33:33.353 | INFO | Combat auto check timer reached 2026-10-23 00:34:03.399 | INFO | Click (1030, 656) @ GET_SHIP 2026-10-23 00:34:04.401 | INFO | Click (1035, 642) @ GET_SHIP 2026-10-23 00:34:07.412 | INFO | Screenshot interval set to 0.3s 2026-10-23 00:34:07.418 | INFO | Auto Search combat status 2026-10-23 00:34:08.586 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_5 ─────────────────────────────────────────────────────── 2026-10-23 00:34:08.591 | INFO | BATTLE_5 2026-10-23 00:34:08.594 | INFO | Auto search moving 2026-10-23 00:34:08.598 | INFO | Fleet: 1, fleet_current_index: 1 2026-10-23 00:34:08.668 | INFO | [OCR_OIL 0.064s] 22378 2026-10-23 00:34:08.723 | INFO | [OCR_COIN 0.049s] 112035 2026-10-23 00:34:10.700 | INFO | [Loading] 4% 2026-10-23 00:34:10.704 | INFO | Auto search combat loading 2026-10-23 00:34:10.706 | INFO | Screenshot interval set to 1.0s 2026-10-23 00:34:16.706 | INFO | [BattleUI] PAUSE 2026-10-23 00:34:16.710 | INFO | Auto Search combat execute 2026-10-23 00:34:16.713 | INFO | <<< EMOTION REDUCE >>> 2026-10-23 00:34:16.724 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-10-23 00:34:16.728 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=47, Main.Emotion.Fleet1Record=datetime.datetime(2026, 10, 23, 0, 34, 16), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 10, 23, 0, 34, 16) 2026-10-23 00:34:16.748 | INFO | [Emotion fleet_1] 47 2026-10-23 00:34:16.751 | INFO | [Emotion fleet_2] 119 2026-10-23 00:34:22.693 | INFO | Combat auto check timer reached 2026-10-23 00:37:16.875 | 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 L439 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-23 00:37:16.904 | WARNING | Wait too long 2026-10-23 00:37:16.908 | 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-23 00:37:16.972 | INFO | [Package_name] com.bilibili.azurlane 2026-10-23 00:37:16.975 | ERROR | GameStuckError: Wait too long 2026-10-23 00:37:16.979 | WARNING | Saving error: ./log/error/1792687036979