═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ MAIN ═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ ════════════════════════════════════════════════════ CAMPAIGN_13_1 ════════════════════════════════════════════════════ 2026-03-13 12:54:04.535 | INFO | CAMPAIGN_13_1 2026-03-13 12:54:04.537 | INFO | Count: 0 2026-03-13 12:54:04.553 | INFO | <<< UI ENSURE >>> 2026-03-13 12:54:04.559 | INFO | UI get current page 2026-03-13 12:54:05.075 | INFO | Unknown ui page 2026-03-13 12:54:05.534 | INFO | UI additional: IDLE -> REWARD_GOTO_MAIN 2026-03-13 12:54:05.537 | INFO | Click ( 813, 621) @ REWARD_GOTO_MAIN 2026-03-13 12:54:05.709 | INFO | Unknown ui page 2026-03-13 12:54:05.852 | INFO | [Package_name] com.bilibili.azurlane 2026-03-13 12:54:05.872 | INFO | [Device Orientation] 0 (Normal) 2026-03-13 12:54:06.016 | INFO | Unknown ui page 2026-03-13 12:54:06.316 | INFO | Unknown ui page 2026-03-13 12:54:06.540 | INFO | [UI] page_main 2026-03-13 12:54:06.543 | INFO | Goto page_campaign 2026-03-13 12:54:06.546 | INFO | <<< UI GOTO PAGE_CAMPAIGN >>> 2026-03-13 12:54:06.563 | INFO | Page switch: page_main_white -> page_campaign_menu 2026-03-13 12:54:06.567 | INFO | Click (1184, 510) @ MAIN_GOTO_CAMPAIGN_WHITE 2026-03-13 12:54:07.138 | INFO | Page switch: page_campaign_menu -> page_campaign 2026-03-13 12:54:07.142 | INFO | Click ( 310, 373) @ CAMPAIGN_MENU_GOTO_CAMPAIGN 2026-03-13 12:54:07.433 | INFO | Page arrive: page_campaign 2026-03-13 12:54:07.459 | INFO | Mode_switch_1 set to hard 2026-03-13 12:54:07.488 | INFO | [Mode_switch_1] hard 2026-03-13 12:54:07.491 | INFO | <<< UI ENSURE INDEX >>> 2026-03-13 12:54:07.566 | INFO | No stage found. 2026-03-13 12:54:07.821 | INFO | No stage found. 2026-03-13 12:54:08.097 | INFO | No stage found. 2026-03-13 12:54:08.417 | INFO | Loading OCR model: ./bin/cnocr_models/azur_lane 2026-03-13 12:54:08.540 | INFO | [campaign 0.141s] ['13--1', '13--3', '13--2', '13--4'] 2026-03-13 12:54:08.546 | INFO | [Chapter] 13 2026-03-13 12:54:08.549 | INFO | [Stage] 13-1, 13-3, 13-2, 13-4 2026-03-13 12:54:08.552 | INFO | [Index] 13 2026-03-13 12:54:08.624 | INFO | [OCR_OIL 0.047s] 4194 ──────────────────────────────────────────────────────── 13-1 ───────────────────────────────────────────────────────── 2026-03-13 12:54:08.629 | INFO | 13-1 2026-03-13 12:54:08.632 | INFO | Expect emotion reduce: (12, 2) 2026-03-13 12:54:08.641 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-03-13 12:54:08.647 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=53, Main.Emotion.Fleet1Record=datetime.datetime(2026, 3, 13, 12, 54, 8), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 3, 13, 12, 54, 8) 2026-03-13 12:54:08.660 | INFO | [Emotion fleet_1] 53 2026-03-13 12:54:08.664 | INFO | [Emotion fleet_2] 119 2026-03-13 12:54:08.667 | INFO | <<< ENTER MAP >>> 2026-03-13 12:54:08.740 | INFO | Click ( 182, 281) @ 13-1 2026-03-13 12:54:09.147 | INFO | [Map_clear_percentage] 5% 2026-03-13 12:54:09.445 | INFO | [Map_clear_percentage] 62% 2026-03-13 12:54:09.747 | INFO | [Map_clear_percentage] 99% 2026-03-13 12:54:09.773 | INFO | [MAP_CLEAR_ALL_THIS_TIME] False 2026-03-13 12:54:09.777 | INFO | [Map_info] 99%, star_1, star_2, star_3, 100_percent_clear, 3_stars, threat_safe, clear_mode 2026-03-13 12:54:09.781 | INFO | [StopCondition_MapAchievement] non_stop 2026-03-13 12:54:09.784 | INFO | Fast_Forward set to on 2026-03-13 12:54:09.787 | INFO | [Fast_Forward] on 2026-03-13 12:54:09.801 | INFO | Auto_Search set to on 2026-03-13 12:54:09.805 | INFO | [Auto_Search] on 2026-03-13 12:54:09.809 | INFO | Click ( 971, 515) @ MAP_PREPARATION 2026-03-13 12:54:10.044 | INFO | Handling 2x book setting, mode=prep. 2026-03-13 12:54:10.070 | INFO | Using fleet: [4, 3, 1] 2026-03-13 12:54:10.148 | INFO | Hard satisfied: Fleet_1: None, Fleet_2: None, Submarine: None 2026-03-13 12:54:10.158 | INFO | [map_allow_submarine] True 2026-03-13 12:54:10.163 | INFO | Click (1139, 329) @ FLEET_2_CLEAR 2026-03-13 12:54:10.218 | INFO | Click (1058, 479) @ SUBMARINE_CHOOSE 2026-03-13 12:54:10.339 | INFO | Current selected: [1] 2026-03-13 12:54:10.342 | INFO | Click (1049, 456) @ SUBMARINE_CHOOSE 2026-03-13 12:54:10.641 | INFO | Click (1035, 228) @ FLEET_1_CHOOSE 2026-03-13 12:54:10.941 | INFO | Current selected: [4] 2026-03-13 12:54:10.945 | INFO | Click (1037, 231) @ FLEET_1_CHOOSE 2026-03-13 12:54:11.238 | INFO | Click (1049, 346) @ FLEET_2_CHOOSE 2026-03-13 12:54:11.538 | INFO | Current selected: [4] 2026-03-13 12:54:11.541 | INFO | Click (1095, 491) @ FLEET_2_BAR_INDEX_3 2026-03-13 12:54:11.841 | INFO | Auto search setting 2026-03-13 12:54:11.857 | INFO | [_fleet_sidebar_offset] 0 2026-03-13 12:54:11.864 | INFO | [_fleet_sidebar_offset] 0 2026-03-13 12:54:11.869 | INFO | [Fleet_sidebar] 1/3 2026-03-13 12:54:11.873 | INFO | Click (1201, 420) @ FLEET_SIDEBAR_0_2 2026-03-13 12:54:12.143 | INFO | [_fleet_sidebar_offset] 0 2026-03-13 12:54:12.151 | INFO | [Fleet_sidebar] 3/3 2026-03-13 12:54:12.155 | INFO | [Auto_Search_Setting] fleet1_all_fleet2_standby, sub_standby 2026-03-13 12:54:12.158 | INFO | Click ( 508, 218) @ AUTO_SEARCH_SET_MOB 2026-03-13 12:54:12.720 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_standby 2026-03-13 12:54:12.725 | INFO | Selected to the correct auto search setting 2026-03-13 12:54:12.729 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_standby 2026-03-13 12:54:12.732 | INFO | Selected to the correct auto search setting 2026-03-13 12:54:12.736 | INFO | Click (1018, 581) @ FLEET_PREPARATION 2026-03-13 12:54:13.634 | INFO | is_auto_search_running appeared ────────────────────────────────────────────────────── BATTLE_0 ─────────────────────────────────────────────────────── 2026-03-13 12:54:13.639 | INFO | BATTLE_0 2026-03-13 12:54:13.641 | INFO | Auto search moving 2026-03-13 12:54:13.655 | INFO | Fleet: 1, fleet_current_index: 1 2026-03-13 12:54:13.711 | INFO | [OCR_OIL 0.052s] 4184 2026-03-13 12:54:13.798 | INFO | [OCR_COIN 0.084s] 54476 2026-03-13 12:54:18.286 | INFO | [Loading] 9% 2026-03-13 12:54:18.291 | INFO | Auto search combat loading 2026-03-13 12:54:18.296 | INFO | Screenshot interval set to 1.0s 2026-03-13 12:54:24.295 | INFO | [BattleUI] PAUSE 2026-03-13 12:54:24.299 | INFO | Auto Search combat execute 2026-03-13 12:54:24.302 | INFO | <<< EMOTION REDUCE >>> 2026-03-13 12:54:24.313 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-03-13 12:54:24.321 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=51, Main.Emotion.Fleet1Record=datetime.datetime(2026, 3, 13, 12, 54, 24), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 3, 13, 12, 54, 24) 2026-03-13 12:54:24.344 | INFO | [Emotion fleet_1] 51 2026-03-13 12:54:24.352 | INFO | [Emotion fleet_2] 119 2026-03-13 12:54:30.294 | INFO | Combat auto check timer reached 2026-03-13 12:54:50.315 | INFO | Click (1037, 663) @ GET_SHIP 2026-03-13 12:54:51.320 | INFO | Click (1020, 667) @ GET_SHIP 2026-03-13 12:54:52.322 | INFO | Click (1014, 647) @ GET_SHIP 2026-03-13 12:54:54.329 | INFO | Screenshot interval set to 0.3s 2026-03-13 12:54:54.333 | INFO | Auto Search combat status 2026-03-13 12:54:54.336 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_1 ─────────────────────────────────────────────────────── 2026-03-13 12:54:54.340 | INFO | BATTLE_1 2026-03-13 12:54:54.345 | INFO | Auto search moving 2026-03-13 12:54:54.349 | INFO | Fleet: 1, fleet_current_index: 1 2026-03-13 12:54:54.419 | INFO | [OCR_OIL 0.066s] 4165 2026-03-13 12:54:54.508 | INFO | [OCR_COIN 0.084s] 54496 2026-03-13 12:54:58.511 | INFO | [Loading] 8% 2026-03-13 12:54:58.516 | INFO | Auto search combat loading 2026-03-13 12:54:58.519 | INFO | Screenshot interval set to 1.0s 2026-03-13 12:55:04.517 | INFO | [BattleUI] PAUSE 2026-03-13 12:55:04.524 | INFO | Auto Search combat execute 2026-03-13 12:55:04.527 | INFO | <<< EMOTION REDUCE >>> 2026-03-13 12:55:04.537 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-03-13 12:55:04.544 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=49, Main.Emotion.Fleet1Record=datetime.datetime(2026, 3, 13, 12, 55, 4), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 3, 13, 12, 55, 4) 2026-03-13 12:55:04.559 | INFO | [Emotion fleet_1] 49 2026-03-13 12:55:04.564 | INFO | [Emotion fleet_2] 119 2026-03-13 12:55:10.519 | INFO | Combat auto check timer reached 2026-03-13 12:55:48.562 | INFO | Click (1013, 662) @ GET_SHIP 2026-03-13 12:55:50.563 | INFO | Click (1026, 657) @ GET_SHIP 2026-03-13 12:55:51.577 | INFO | Click (1037, 654) @ GET_SHIP 2026-03-13 12:55:52.581 | INFO | Click (1027, 638) @ GET_SHIP 2026-03-13 12:55:53.678 | INFO | Click (1030, 661) @ GET_SHIP 2026-03-13 12:55:55.583 | INFO | Screenshot interval set to 0.3s 2026-03-13 12:55:55.588 | INFO | Auto Search combat status 2026-03-13 12:55:55.592 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_2 ─────────────────────────────────────────────────────── 2026-03-13 12:55:55.596 | INFO | BATTLE_2 2026-03-13 12:55:55.598 | INFO | Auto search moving 2026-03-13 12:55:55.605 | INFO | Fleet: 1, fleet_current_index: 1 2026-03-13 12:55:55.681 | INFO | [OCR_OIL 0.069s] 4146 2026-03-13 12:55:55.761 | INFO | [OCR_COIN 0.075s] 54520 2026-03-13 12:55:58.863 | INFO | [Loading] 16% 2026-03-13 12:55:58.866 | INFO | Auto search combat loading 2026-03-13 12:55:58.868 | INFO | Screenshot interval set to 1.0s 2026-03-13 12:56:03.883 | INFO | [BattleUI] PAUSE 2026-03-13 12:56:03.888 | INFO | Auto Search combat execute 2026-03-13 12:56:03.891 | INFO | <<< EMOTION REDUCE >>> 2026-03-13 12:56:03.905 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-03-13 12:56:03.911 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=47, Main.Emotion.Fleet1Record=datetime.datetime(2026, 3, 13, 12, 56, 3), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 3, 13, 12, 56, 3) 2026-03-13 12:56:03.938 | INFO | [Emotion fleet_1] 47 2026-03-13 12:56:03.942 | INFO | [Emotion fleet_2] 119 2026-03-13 12:56:09.874 | INFO | Combat auto check timer reached 2026-03-13 12:56:35.903 | INFO | Click (1017, 664) @ GET_SHIP 2026-03-13 12:56:36.917 | INFO | Click (1020, 654) @ GET_SHIP 2026-03-13 12:56:38.911 | INFO | Screenshot interval set to 0.3s 2026-03-13 12:56:38.918 | INFO | Auto Search combat status 2026-03-13 12:56:38.926 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_3 ─────────────────────────────────────────────────────── 2026-03-13 12:56:38.934 | INFO | BATTLE_3 2026-03-13 12:56:38.938 | INFO | Auto search moving 2026-03-13 12:56:38.943 | INFO | Fleet: 1, fleet_current_index: 1 2026-03-13 12:56:39.047 | INFO | [OCR_OIL 0.096s] 4127 2026-03-13 12:56:39.141 | INFO | [OCR_COIN 0.090s] 54531 2026-03-13 12:56:43.136 | INFO | [Loading] 9% 2026-03-13 12:56:43.140 | INFO | Auto search combat loading 2026-03-13 12:56:43.143 | INFO | Screenshot interval set to 1.0s 2026-03-13 12:56:49.159 | INFO | [BattleUI] PAUSE 2026-03-13 12:56:49.164 | INFO | Auto Search combat execute 2026-03-13 12:56:49.167 | INFO | <<< EMOTION REDUCE >>> 2026-03-13 12:56:49.183 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-03-13 12:56:49.191 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=45, Main.Emotion.Fleet1Record=datetime.datetime(2026, 3, 13, 12, 56, 49), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 3, 13, 12, 56, 49) 2026-03-13 12:56:49.210 | INFO | [Emotion fleet_1] 45 2026-03-13 12:56:49.216 | INFO | [Emotion fleet_2] 119 2026-03-13 12:56:55.141 | INFO | Combat auto check timer reached 2026-03-13 12:57:49.192 | INFO | Screenshot interval set to 0.3s 2026-03-13 12:57:49.196 | INFO | Auto Search combat status 2026-03-13 12:57:50.686 | INFO | Click (1038, 650) @ GET_SHIP 2026-03-13 12:57:51.887 | INFO | Click (1016, 657) @ GET_SHIP 2026-03-13 12:57:53.087 | INFO | Click (1034, 670) @ GET_SHIP 2026-03-13 12:57:54.288 | INFO | Click (1026, 659) @ GET_SHIP 2026-03-13 12:57:56.383 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_4 ─────────────────────────────────────────────────────── 2026-03-13 12:57:56.390 | INFO | BATTLE_4 2026-03-13 12:57:56.392 | INFO | Auto search moving 2026-03-13 12:57:56.398 | INFO | Fleet: 1, fleet_current_index: 1 2026-03-13 12:57:56.519 | INFO | [OCR_OIL 0.118s] 4108 2026-03-13 12:57:56.613 | INFO | [OCR_COIN 0.090s] 54543 2026-03-13 12:58:00.599 | INFO | [Loading] 12% 2026-03-13 12:58:00.602 | INFO | Auto search combat loading 2026-03-13 12:58:00.605 | INFO | Screenshot interval set to 1.0s 2026-03-13 12:58:06.606 | INFO | [BattleUI] PAUSE 2026-03-13 12:58:06.609 | INFO | Auto Search combat execute 2026-03-13 12:58:06.612 | INFO | <<< EMOTION REDUCE >>> 2026-03-13 12:58:06.624 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-03-13 12:58:06.630 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=43, Main.Emotion.Fleet1Record=datetime.datetime(2026, 3, 13, 12, 58, 6), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 3, 13, 12, 58, 6) 2026-03-13 12:58:06.656 | INFO | [Emotion fleet_1] 43 2026-03-13 12:58:06.661 | INFO | [Emotion fleet_2] 119 2026-03-13 12:58:12.600 | INFO | Combat auto check timer reached 2026-03-13 12:59:06.669 | INFO | Screenshot interval set to 0.3s 2026-03-13 12:59:06.672 | INFO | Auto Search combat status 2026-03-13 12:59:08.158 | INFO | Click (1019, 659) @ GET_SHIP 2026-03-13 12:59:09.357 | INFO | Click (1037, 671) @ GET_SHIP 2026-03-13 12:59:10.560 | INFO | Click (1034, 669) @ GET_SHIP 2026-03-13 12:59:11.755 | INFO | Click (1016, 659) @ GET_SHIP 2026-03-13 12:59:13.555 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_5 ─────────────────────────────────────────────────────── 2026-03-13 12:59:13.560 | INFO | BATTLE_5 2026-03-13 12:59:13.562 | INFO | Auto search moving 2026-03-13 12:59:13.566 | INFO | Fleet: 1, fleet_current_index: 1 2026-03-13 12:59:13.628 | INFO | [OCR_OIL 0.057s] 4089 2026-03-13 12:59:13.714 | INFO | [OCR_COIN 0.083s] 54573 2026-03-13 12:59:15.364 | INFO | [Loading] 9% 2026-03-13 12:59:15.368 | INFO | Auto search combat loading 2026-03-13 12:59:15.370 | INFO | Screenshot interval set to 1.0s 2026-03-13 12:59:21.371 | INFO | [BattleUI] PAUSE 2026-03-13 12:59:21.375 | INFO | Auto Search combat execute 2026-03-13 12:59:21.377 | INFO | <<< EMOTION REDUCE >>> 2026-03-13 12:59:21.389 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-03-13 12:59:21.394 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=41, Main.Emotion.Fleet1Record=datetime.datetime(2026, 3, 13, 12, 59, 21), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 3, 13, 12, 59, 21) 2026-03-13 12:59:21.411 | INFO | [Emotion fleet_1] 41 2026-03-13 12:59:21.415 | INFO | [Emotion fleet_2] 119 2026-03-13 12:59:27.365 | INFO | Combat auto check timer reached 2026-03-13 13:00:25.445 | INFO | Click (1048, 659) @ GET_SHIP 2026-03-13 13:03:25.587 | 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 L1523 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 L426 run() campaign_base.py L143 run() campaign_base.py L178 auto_search_execute_a_battle() auto_search_combat.py L349 auto_search_combat() auto_search_combat.py L246 auto_search_combat_execute() base.py L169 loop() device.py L188 screenshot() device.py L250 stuck_record_check() device.py L43 show_function_call() 2026-03-13 13:03:25.611 | WARNING | Wait too long 2026-03-13 13:03:25.616 | WARNING | Waiting for {'SP_CHECK', 'EXP_INFO_B', 'EVENT_CHECK', 'POPUP_CONFIRM_WHITE', 'GUILD_POPUP_CONFIRM', 'GET_MISSION', 'GET_SHIP', 'PAUSE', 'EXP_INFO_S', 'AUTO_SEARCH_MAP_OPTION_ON', 'NEW_SHIP', 'BATTLE_STATUS_S', 'CAMPAIGN_CHECK', 'EXP_INFO_A', 'POPUP_CANCEL', 'BATTLE_STATUS_A', 'BATTLE_STATUS_B', 'MISSION_POPUP_GO'} 2026-03-13 13:03:25.675 | INFO | [Package_name] com.bilibili.azurlane 2026-03-13 13:03:25.679 | ERROR | GameStuckError: Wait too long 2026-03-13 13:03:25.681 | WARNING | Saving error: ./log/error/1773378205681