═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ MAIN ═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ ════════════════════════════════════════════════════ CAMPAIGN_13_1 ════════════════════════════════════════════════════ 2026-04-22 13:06:01.794 | INFO | CAMPAIGN_13_1 2026-04-22 13:06:01.798 | INFO | Count: 0 2026-04-22 13:06:01.824 | INFO | <<< UI ENSURE >>> 2026-04-22 13:06:01.828 | INFO | UI get current page 2026-04-22 13:06:02.362 | INFO | Unknown ui page 2026-04-22 13:06:02.829 | INFO | UI additional: IDLE -> REWARD_GOTO_MAIN 2026-04-22 13:06:02.833 | INFO | Click ( 840, 624) @ REWARD_GOTO_MAIN 2026-04-22 13:06:03.007 | INFO | Unknown ui page 2026-04-22 13:06:03.149 | INFO | [Package_name] com.bilibili.azurlane 2026-04-22 13:06:03.167 | INFO | [Device Orientation] 0 (Normal) 2026-04-22 13:06:03.312 | INFO | Unknown ui page 2026-04-22 13:06:03.604 | INFO | Unknown ui page 2026-04-22 13:06:03.832 | INFO | [UI] page_main 2026-04-22 13:06:03.837 | INFO | Goto page_campaign 2026-04-22 13:06:03.841 | INFO | <<< UI GOTO PAGE_CAMPAIGN >>> 2026-04-22 13:06:03.859 | INFO | Page switch: page_main_white -> page_campaign_menu 2026-04-22 13:06:03.863 | INFO | Click (1166, 466) @ MAIN_GOTO_CAMPAIGN_WHITE 2026-04-22 13:06:04.436 | INFO | Page switch: page_campaign_menu -> page_campaign 2026-04-22 13:06:04.440 | INFO | Click ( 264, 229) @ CAMPAIGN_MENU_GOTO_CAMPAIGN 2026-04-22 13:06:04.732 | INFO | Page arrive: page_campaign 2026-04-22 13:06:04.757 | INFO | Mode_switch_1 set to hard 2026-04-22 13:06:04.785 | INFO | [Mode_switch_1] hard 2026-04-22 13:06:04.791 | INFO | <<< UI ENSURE INDEX >>> 2026-04-22 13:06:04.866 | INFO | No stage found. 2026-04-22 13:06:05.097 | INFO | No stage found. 2026-04-22 13:06:05.416 | INFO | Loading OCR model: ./bin/cnocr_models/azur_lane 2026-04-22 13:06:05.532 | INFO | [campaign 0.134s] ['13--1', '13--3', '13--2', '13--4'] 2026-04-22 13:06:05.535 | INFO | [Chapter] 13 2026-04-22 13:06:05.537 | INFO | [Stage] 13-1, 13-3, 13-2, 13-4 2026-04-22 13:06:05.542 | INFO | [Index] 13 2026-04-22 13:06:05.609 | INFO | [OCR_OIL 0.041s] 23360 ──────────────────────────────────────────────────────── 13-1 ───────────────────────────────────────────────────────── 2026-04-22 13:06:05.613 | INFO | 13-1 2026-04-22 13:06:05.616 | INFO | Expect emotion reduce: (12, 2) 2026-04-22 13:06:05.628 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-04-22 13:06:05.632 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=53, Main.Emotion.Fleet1Record=datetime.datetime(2026, 4, 22, 13, 6, 5), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 4, 22, 13, 6, 5) 2026-04-22 13:06:05.649 | INFO | [Emotion fleet_1] 53 2026-04-22 13:06:05.652 | INFO | [Emotion fleet_2] 119 2026-04-22 13:06:05.656 | INFO | <<< ENTER MAP >>> 2026-04-22 13:06:05.729 | INFO | Click ( 189, 282) @ 13-1 2026-04-22 13:06:06.153 | INFO | [Map_clear_percentage] 5% 2026-04-22 13:06:06.442 | INFO | [Map_clear_percentage] 66% 2026-04-22 13:06:06.735 | INFO | [Map_clear_percentage] 99% 2026-04-22 13:06:06.762 | INFO | [MAP_CLEAR_ALL_THIS_TIME] False 2026-04-22 13:06:06.767 | INFO | [Map_info] 99%, star_1, star_2, star_3, 100_percent_clear, 3_stars, threat_safe, clear_mode 2026-04-22 13:06:06.770 | INFO | [StopCondition_MapAchievement] non_stop 2026-04-22 13:06:06.774 | INFO | Fast_Forward set to on 2026-04-22 13:06:06.777 | INFO | [Fast_Forward] on 2026-04-22 13:06:06.790 | INFO | Auto_Search set to on 2026-04-22 13:06:06.795 | INFO | [Auto_Search] on 2026-04-22 13:06:06.800 | INFO | Click ( 929, 529) @ MAP_PREPARATION 2026-04-22 13:06:07.029 | INFO | Handling 2x book setting, mode=prep. 2026-04-22 13:06:07.332 | INFO | Using fleet: [4, 3, 1] 2026-04-22 13:06:07.408 | INFO | Hard satisfied: Fleet_1: None, Fleet_2: None, Submarine: None 2026-04-22 13:06:07.417 | INFO | [map_allow_submarine] True 2026-04-22 13:06:07.422 | INFO | Click (1131, 325) @ FLEET_2_CLEAR 2026-04-22 13:06:07.476 | INFO | Click (1052, 464) @ SUBMARINE_CHOOSE 2026-04-22 13:06:07.625 | INFO | Current selected: [1] 2026-04-22 13:06:07.629 | INFO | Click (1065, 482) @ SUBMARINE_CHOOSE 2026-04-22 13:06:07.929 | INFO | Click (1042, 242) @ FLEET_1_CHOOSE 2026-04-22 13:06:08.228 | INFO | Current selected: [4] 2026-04-22 13:06:08.232 | INFO | Click (1066, 231) @ FLEET_1_CHOOSE 2026-04-22 13:06:08.527 | INFO | Click (1052, 322) @ FLEET_2_CHOOSE 2026-04-22 13:06:08.828 | INFO | Current selected: [4] 2026-04-22 13:06:08.832 | INFO | Click (1142, 483) @ FLEET_2_BAR_INDEX_3 2026-04-22 13:06:09.128 | INFO | Auto search setting 2026-04-22 13:06:09.143 | INFO | [_fleet_sidebar_offset] 0 2026-04-22 13:06:09.149 | INFO | [_fleet_sidebar_offset] 0 2026-04-22 13:06:09.154 | INFO | [Fleet_sidebar] 1/3 2026-04-22 13:06:09.161 | INFO | Click (1229, 399) @ FLEET_SIDEBAR_0_2 2026-04-22 13:06:09.430 | INFO | [_fleet_sidebar_offset] 0 2026-04-22 13:06:09.434 | INFO | [Fleet_sidebar] 3/3 2026-04-22 13:06:09.437 | INFO | [Auto_Search_Setting] fleet1_all_fleet2_standby, sub_standby 2026-04-22 13:06:09.442 | INFO | Click ( 504, 216) @ AUTO_SEARCH_SET_MOB 2026-04-22 13:06:09.915 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_standby 2026-04-22 13:06:09.919 | INFO | Selected to the correct auto search setting 2026-04-22 13:06:09.923 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_standby 2026-04-22 13:06:09.925 | INFO | Selected to the correct auto search setting 2026-04-22 13:06:09.929 | INFO | Click (1020, 583) @ FLEET_PREPARATION 2026-04-22 13:06:10.831 | INFO | is_auto_search_running appeared ────────────────────────────────────────────────────── BATTLE_0 ─────────────────────────────────────────────────────── 2026-04-22 13:06:10.836 | INFO | BATTLE_0 2026-04-22 13:06:10.839 | INFO | Auto search moving 2026-04-22 13:06:10.852 | INFO | Fleet: 1, fleet_current_index: 1 2026-04-22 13:06:10.920 | INFO | [OCR_OIL 0.064s] 23350 2026-04-22 13:06:10.998 | INFO | [OCR_COIN 0.076s] 280646 2026-04-22 13:06:14.885 | INFO | [Loading] 11% 2026-04-22 13:06:14.890 | INFO | Auto search combat loading 2026-04-22 13:06:14.895 | INFO | Screenshot interval set to 1.0s 2026-04-22 13:06:20.890 | INFO | [BattleUI] PAUSE 2026-04-22 13:06:20.893 | INFO | Auto Search combat execute 2026-04-22 13:06:20.895 | INFO | <<< EMOTION REDUCE >>> 2026-04-22 13:06:20.907 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-04-22 13:06:20.911 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=51, Main.Emotion.Fleet1Record=datetime.datetime(2026, 4, 22, 13, 6, 20), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 4, 22, 13, 6, 20) 2026-04-22 13:06:20.927 | INFO | [Emotion fleet_1] 51 2026-04-22 13:06:20.932 | INFO | [Emotion fleet_2] 119 2026-04-22 13:06:25.898 | INFO | Combat auto check timer reached 2026-04-22 13:06:45.926 | INFO | Click (1020, 646) @ GET_SHIP 2026-04-22 13:06:47.932 | INFO | Click (1021, 661) @ GET_SHIP 2026-04-22 13:06:49.935 | INFO | Click (1023, 675) @ GET_SHIP 2026-04-22 13:06:50.945 | INFO | Click (1017, 649) @ GET_SHIP 2026-04-22 13:06:51.931 | INFO | Screenshot interval set to 0.3s 2026-04-22 13:06:51.936 | INFO | Auto Search combat status 2026-04-22 13:06:51.939 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_1 ─────────────────────────────────────────────────────── 2026-04-22 13:06:51.944 | INFO | BATTLE_1 2026-04-22 13:06:51.948 | INFO | Auto search moving 2026-04-22 13:06:51.953 | INFO | Fleet: 1, fleet_current_index: 1 2026-04-22 13:06:52.046 | INFO | [OCR_OIL 0.089s] 23331 2026-04-22 13:06:52.121 | INFO | [OCR_COIN 0.070s] 280668 2026-04-22 13:06:56.435 | INFO | [Loading] 11% 2026-04-22 13:06:56.439 | INFO | Auto search combat loading 2026-04-22 13:06:56.442 | INFO | Screenshot interval set to 1.0s 2026-04-22 13:07:01.431 | INFO | [BattleUI] PAUSE 2026-04-22 13:07:01.435 | INFO | Auto Search combat execute 2026-04-22 13:07:01.437 | INFO | <<< EMOTION REDUCE >>> 2026-04-22 13:07:01.448 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-04-22 13:07:01.452 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=49, Main.Emotion.Fleet1Record=datetime.datetime(2026, 4, 22, 13, 7, 1), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 4, 22, 13, 7, 1) 2026-04-22 13:07:01.468 | INFO | [Emotion fleet_1] 49 2026-04-22 13:07:01.471 | INFO | [Emotion fleet_2] 119 2026-04-22 13:07:06.437 | INFO | Combat auto check timer reached 2026-04-22 13:07:45.478 | INFO | Click (1013, 661) @ GET_SHIP 2026-04-22 13:07:47.480 | INFO | Click (1018, 668) @ GET_SHIP 2026-04-22 13:07:48.488 | INFO | Click (1026, 667) @ GET_SHIP 2026-04-22 13:07:50.500 | INFO | Click (1012, 669) @ GET_SHIP 2026-04-22 13:07:51.485 | INFO | Screenshot interval set to 0.3s 2026-04-22 13:07:51.489 | INFO | Auto Search combat status 2026-04-22 13:07:51.493 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_2 ─────────────────────────────────────────────────────── 2026-04-22 13:07:51.501 | INFO | BATTLE_2 2026-04-22 13:07:51.504 | INFO | Auto search moving 2026-04-22 13:07:51.508 | INFO | Fleet: 1, fleet_current_index: 1 2026-04-22 13:07:51.574 | INFO | [OCR_OIL 0.060s] 23312 2026-04-22 13:07:51.675 | INFO | [OCR_COIN 0.097s] 280696 2026-04-22 13:07:55.676 | INFO | [Loading] 7% 2026-04-22 13:07:55.678 | INFO | Auto search combat loading 2026-04-22 13:07:55.683 | INFO | Screenshot interval set to 1.0s 2026-04-22 13:08:01.695 | INFO | [BattleUI] PAUSE 2026-04-22 13:08:01.698 | INFO | Auto Search combat execute 2026-04-22 13:08:01.700 | INFO | <<< EMOTION REDUCE >>> 2026-04-22 13:08:01.715 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-04-22 13:08:01.723 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=47, Main.Emotion.Fleet1Record=datetime.datetime(2026, 4, 22, 13, 8, 1), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 4, 22, 13, 8, 1) 2026-04-22 13:08:01.737 | INFO | [Emotion fleet_1] 47 2026-04-22 13:08:01.743 | INFO | [Emotion fleet_2] 119 2026-04-22 13:08:07.703 | INFO | Combat auto check timer reached 2026-04-22 13:08:44.729 | INFO | Click (1038, 650) @ GET_SHIP 2026-04-22 13:08:45.730 | INFO | Click (1033, 659) @ GET_SHIP 2026-04-22 13:08:46.738 | INFO | Click (1024, 657) @ GET_SHIP 2026-04-22 13:08:48.742 | INFO | Screenshot interval set to 0.3s 2026-04-22 13:08:48.746 | INFO | Auto Search combat status 2026-04-22 13:08:48.750 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_3 ─────────────────────────────────────────────────────── 2026-04-22 13:08:48.754 | INFO | BATTLE_3 2026-04-22 13:08:48.757 | INFO | Auto search moving 2026-04-22 13:08:48.761 | INFO | Fleet: 1, fleet_current_index: 1 2026-04-22 13:08:48.850 | INFO | [OCR_OIL 0.086s] 23293 2026-04-22 13:08:48.922 | INFO | [OCR_COIN 0.068s] 280709 2026-04-22 13:08:52.928 | INFO | [Loading] 11% 2026-04-22 13:08:52.930 | INFO | Auto search combat loading 2026-04-22 13:08:52.933 | INFO | Screenshot interval set to 1.0s 2026-04-22 13:08:58.944 | INFO | [BattleUI] PAUSE 2026-04-22 13:08:58.951 | INFO | Auto Search combat execute 2026-04-22 13:08:58.955 | INFO | <<< EMOTION REDUCE >>> 2026-04-22 13:08:58.972 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-04-22 13:08:58.978 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=45, Main.Emotion.Fleet1Record=datetime.datetime(2026, 4, 22, 13, 8, 58), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 4, 22, 13, 8, 58) 2026-04-22 13:08:58.990 | INFO | [Emotion fleet_1] 45 2026-04-22 13:08:58.997 | INFO | [Emotion fleet_2] 119 2026-04-22 13:09:04.943 | INFO | Combat auto check timer reached 2026-04-22 13:09:40.982 | INFO | Click (1047, 651) @ GET_SHIP 2026-04-22 13:09:41.992 | INFO | Click (1039, 661) @ GET_SHIP 2026-04-22 13:09:42.981 | INFO | Screenshot interval set to 0.3s 2026-04-22 13:09:42.986 | INFO | Auto Search combat status 2026-04-22 13:09:42.999 | INFO | Click (1032, 650) @ GET_SHIP 2026-04-22 13:09:44.463 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_4 ─────────────────────────────────────────────────────── 2026-04-22 13:09:44.468 | INFO | BATTLE_4 2026-04-22 13:09:44.471 | INFO | Auto search moving 2026-04-22 13:09:44.477 | INFO | Fleet: 1, fleet_current_index: 1 2026-04-22 13:09:44.553 | INFO | [OCR_OIL 0.072s] 23274 2026-04-22 13:09:44.623 | INFO | [OCR_COIN 0.068s] 280723 2026-04-22 13:09:49.878 | INFO | [Loading] 19% 2026-04-22 13:09:49.884 | INFO | Auto search combat loading 2026-04-22 13:09:49.888 | INFO | Screenshot interval set to 1.0s 2026-04-22 13:09:54.883 | INFO | [BattleUI] PAUSE 2026-04-22 13:09:54.886 | INFO | Auto Search combat execute 2026-04-22 13:09:54.889 | INFO | <<< EMOTION REDUCE >>> 2026-04-22 13:09:54.900 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-04-22 13:09:54.906 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=43, Main.Emotion.Fleet1Record=datetime.datetime(2026, 4, 22, 13, 9, 54), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 4, 22, 13, 9, 54) 2026-04-22 13:09:54.924 | INFO | [Emotion fleet_1] 43 2026-04-22 13:09:54.928 | INFO | [Emotion fleet_2] 119 2026-04-22 13:10:00.877 | INFO | Combat auto check timer reached 2026-04-22 13:10:22.926 | INFO | Click (1011, 656) @ GET_SHIP 2026-04-22 13:10:23.930 | INFO | Click (1032, 664) @ GET_SHIP 2026-04-22 13:10:24.917 | INFO | Screenshot interval set to 0.3s 2026-04-22 13:10:24.920 | INFO | Auto Search combat status 2026-04-22 13:10:24.933 | INFO | Click (1036, 662) @ GET_SHIP 2026-04-22 13:10:26.099 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_5 ─────────────────────────────────────────────────────── 2026-04-22 13:10:26.104 | INFO | BATTLE_5 2026-04-22 13:10:26.107 | INFO | Auto search moving 2026-04-22 13:10:26.110 | INFO | Fleet: 1, fleet_current_index: 1 2026-04-22 13:10:26.212 | INFO | [OCR_OIL 0.097s] 23255 2026-04-22 13:10:26.356 | INFO | [OCR_COIN 0.137s] 280734 2026-04-22 13:10:28.551 | INFO | [Loading] 13% 2026-04-22 13:10:28.556 | INFO | Auto search combat loading 2026-04-22 13:10:28.560 | INFO | Screenshot interval set to 1.0s 2026-04-22 13:10:34.556 | INFO | [BattleUI] PAUSE 2026-04-22 13:10:34.560 | INFO | Auto Search combat execute 2026-04-22 13:10:34.563 | INFO | <<< EMOTION REDUCE >>> 2026-04-22 13:10:34.577 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-04-22 13:10:34.582 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=41, Main.Emotion.Fleet1Record=datetime.datetime(2026, 4, 22, 13, 10, 34), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 4, 22, 13, 10, 34) 2026-04-22 13:10:34.598 | INFO | [Emotion fleet_1] 41 2026-04-22 13:10:34.608 | INFO | [Emotion fleet_2] 119 2026-04-22 13:10:40.554 | INFO | Combat auto check timer reached 2026-04-22 13:11:48.621 | INFO | Click (1022, 652) @ GET_SHIP 2026-04-22 13:14:48.767 | 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 L1525 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 L431 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-04-22 13:14:48.789 | WARNING | Wait too long 2026-04-22 13:14:48.791 | 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-04-22 13:14:48.848 | INFO | [Package_name] com.bilibili.azurlane 2026-04-22 13:14:48.851 | ERROR | GameStuckError: Wait too long 2026-04-22 13:14:48.854 | WARNING | Saving error: ./log/error/1776834888854