═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ MAIN ═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ ════════════════════════════════════════════════════ CAMPAIGN_13_1 ════════════════════════════════════════════════════ 2026-04-22 22:06:01.264 | INFO | CAMPAIGN_13_1 2026-04-22 22:06:01.267 | INFO | Count: 0 2026-04-22 22:06:01.288 | INFO | <<< UI ENSURE >>> 2026-04-22 22:06:01.294 | INFO | UI get current page 2026-04-22 22:06:01.816 | INFO | Unknown ui page 2026-04-22 22:06:02.285 | INFO | UI additional: IDLE_2 -> REWARD_GOTO_MAIN 2026-04-22 22:06:02.290 | INFO | Click ( 852, 626) @ REWARD_GOTO_MAIN 2026-04-22 22:06:02.463 | INFO | Unknown ui page 2026-04-22 22:06:02.615 | INFO | [Package_name] com.bilibili.azurlane 2026-04-22 22:06:02.638 | INFO | [Device Orientation] 0 (Normal) 2026-04-22 22:06:02.773 | INFO | Unknown ui page 2026-04-22 22:06:02.993 | INFO | [UI] page_main 2026-04-22 22:06:02.997 | INFO | Goto page_campaign 2026-04-22 22:06:03.001 | INFO | <<< UI GOTO PAGE_CAMPAIGN >>> 2026-04-22 22:06:03.017 | INFO | Page switch: page_main_white -> page_campaign_menu 2026-04-22 22:06:03.023 | INFO | Click (1192, 512) @ MAIN_GOTO_CAMPAIGN_WHITE 2026-04-22 22:06:03.598 | INFO | Page switch: page_campaign_menu -> page_campaign 2026-04-22 22:06:03.601 | INFO | Click ( 295, 364) @ CAMPAIGN_MENU_GOTO_CAMPAIGN 2026-04-22 22:06:03.892 | INFO | Page arrive: page_campaign 2026-04-22 22:06:03.916 | INFO | Mode_switch_1 set to hard 2026-04-22 22:06:03.942 | INFO | [Mode_switch_1] hard 2026-04-22 22:06:03.946 | INFO | <<< UI ENSURE INDEX >>> 2026-04-22 22:06:04.019 | INFO | No stage found. 2026-04-22 22:06:04.255 | INFO | No stage found. 2026-04-22 22:06:04.578 | INFO | Loading OCR model: ./bin/cnocr_models/azur_lane 2026-04-22 22:06:04.686 | INFO | [campaign 0.129s] ['I3--1', 'I3--3', 'I3--2', 'I3--4'] 2026-04-22 22:06:04.690 | INFO | [Chapter] 13 2026-04-22 22:06:04.693 | INFO | [Stage] 13-1, 13-3, 13-2, 13-4 2026-04-22 22:06:04.696 | INFO | [Index] 13 2026-04-22 22:06:04.769 | INFO | [OCR_OIL 0.044s] 21842 ──────────────────────────────────────────────────────── 13-1 ───────────────────────────────────────────────────────── 2026-04-22 22:06:04.777 | INFO | 13-1 2026-04-22 22:06:04.780 | INFO | Expect emotion reduce: (12, 2) 2026-04-22 22:06:04.791 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-04-22 22:06:04.794 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=53, Main.Emotion.Fleet1Record=datetime.datetime(2026, 4, 22, 22, 6, 4), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 4, 22, 22, 6, 4) 2026-04-22 22:06:04.827 | INFO | [Emotion fleet_1] 53 2026-04-22 22:06:04.830 | INFO | [Emotion fleet_2] 119 2026-04-22 22:06:04.833 | INFO | <<< ENTER MAP >>> 2026-04-22 22:06:04.906 | INFO | Click ( 196, 276) @ 13-1 2026-04-22 22:06:05.610 | INFO | [Map_clear_percentage] 67% 2026-04-22 22:06:05.920 | INFO | [Map_clear_percentage] 99% 2026-04-22 22:06:05.959 | INFO | [MAP_CLEAR_ALL_THIS_TIME] False 2026-04-22 22:06:05.966 | INFO | [Map_info] 99%, star_1, star_2, star_3, 100_percent_clear, 3_stars, threat_safe, clear_mode 2026-04-22 22:06:05.974 | INFO | [StopCondition_MapAchievement] non_stop 2026-04-22 22:06:05.980 | INFO | Fast_Forward set to on 2026-04-22 22:06:05.984 | INFO | [Fast_Forward] on 2026-04-22 22:06:06.005 | INFO | Auto_Search set to on 2026-04-22 22:06:06.015 | INFO | [Auto_Search] on 2026-04-22 22:06:06.024 | INFO | Click ( 979, 505) @ MAP_PREPARATION 2026-04-22 22:06:06.520 | INFO | Handling 2x book setting, mode=prep. 2026-04-22 22:06:06.547 | INFO | Using fleet: [4, 3, 1] 2026-04-22 22:06:06.636 | INFO | Hard satisfied: Fleet_1: None, Fleet_2: None, Submarine: None 2026-04-22 22:06:06.648 | INFO | [map_allow_submarine] True 2026-04-22 22:06:06.654 | INFO | Click (1148, 327) @ FLEET_2_CLEAR 2026-04-22 22:06:06.708 | INFO | Click (1060, 494) @ SUBMARINE_CHOOSE 2026-04-22 22:06:07.104 | INFO | Current selected: [1] 2026-04-22 22:06:07.112 | INFO | Click (1056, 475) @ SUBMARINE_CHOOSE 2026-04-22 22:06:07.412 | INFO | Click (1060, 234) @ FLEET_1_CHOOSE 2026-04-22 22:06:07.709 | INFO | Current selected: [4] 2026-04-22 22:06:07.714 | INFO | Click (1067, 211) @ FLEET_1_CHOOSE 2026-04-22 22:06:08.010 | INFO | Click (1062, 319) @ FLEET_2_CHOOSE 2026-04-22 22:06:08.311 | INFO | Current selected: [4] 2026-04-22 22:06:08.315 | INFO | Click (1114, 492) @ FLEET_2_BAR_INDEX_3 2026-04-22 22:06:08.615 | INFO | Auto search setting 2026-04-22 22:06:08.632 | INFO | [_fleet_sidebar_offset] 0 2026-04-22 22:06:08.639 | INFO | [_fleet_sidebar_offset] 0 2026-04-22 22:06:08.646 | INFO | [Fleet_sidebar] 1/3 2026-04-22 22:06:08.650 | INFO | Click (1204, 401) @ FLEET_SIDEBAR_0_2 2026-04-22 22:06:08.907 | INFO | [_fleet_sidebar_offset] 0 2026-04-22 22:06:08.911 | INFO | [Fleet_sidebar] 3/3 2026-04-22 22:06:08.915 | INFO | [Auto_Search_Setting] fleet1_all_fleet2_standby, sub_standby 2026-04-22 22:06:08.917 | INFO | Click ( 504, 210) @ AUTO_SEARCH_SET_MOB 2026-04-22 22:06:09.376 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_standby 2026-04-22 22:06:09.380 | INFO | Selected to the correct auto search setting 2026-04-22 22:06:09.384 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_standby 2026-04-22 22:06:09.386 | INFO | Selected to the correct auto search setting 2026-04-22 22:06:09.388 | INFO | Click (1106, 562) @ FLEET_PREPARATION 2026-04-22 22:06:10.288 | INFO | is_auto_search_running appeared ────────────────────────────────────────────────────── BATTLE_0 ─────────────────────────────────────────────────────── 2026-04-22 22:06:10.293 | INFO | BATTLE_0 2026-04-22 22:06:10.295 | INFO | Auto search moving 2026-04-22 22:06:10.308 | INFO | Fleet: 1, fleet_current_index: 1 2026-04-22 22:06:10.386 | INFO | [OCR_OIL 0.072s] 21832 2026-04-22 22:06:10.468 | INFO | [OCR_COIN 0.078s] 284076 2026-04-22 22:06:14.365 | INFO | [Loading] 11% 2026-04-22 22:06:14.370 | INFO | Auto search combat loading 2026-04-22 22:06:14.374 | INFO | Screenshot interval set to 1.0s 2026-04-22 22:06:20.371 | INFO | [BattleUI] PAUSE 2026-04-22 22:06:20.374 | INFO | Auto Search combat execute 2026-04-22 22:06:20.377 | INFO | <<< EMOTION REDUCE >>> 2026-04-22 22:06:20.389 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-04-22 22:06:20.395 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=51, Main.Emotion.Fleet1Record=datetime.datetime(2026, 4, 22, 22, 6, 20), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 4, 22, 22, 6, 20) 2026-04-22 22:06:20.414 | INFO | [Emotion fleet_1] 51 2026-04-22 22:06:20.418 | INFO | [Emotion fleet_2] 119 2026-04-22 22:06:26.369 | INFO | Combat auto check timer reached 2026-04-22 22:06:46.394 | INFO | Click (1031, 646) @ GET_SHIP 2026-04-22 22:06:47.395 | INFO | Click (1023, 643) @ GET_SHIP 2026-04-22 22:06:48.396 | INFO | Click (1019, 654) @ GET_SHIP 2026-04-22 22:06:49.400 | INFO | Click (1029, 659) @ GET_SHIP 2026-04-22 22:06:50.415 | INFO | Click (1012, 662) @ GET_SHIP 2026-04-22 22:06:51.406 | INFO | Screenshot interval set to 0.3s 2026-04-22 22:06:51.411 | INFO | Auto Search combat status 2026-04-22 22:06:51.414 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_1 ─────────────────────────────────────────────────────── 2026-04-22 22:06:51.418 | INFO | BATTLE_1 2026-04-22 22:06:51.422 | INFO | Auto search moving 2026-04-22 22:06:51.426 | INFO | Fleet: 1, fleet_current_index: 1 2026-04-22 22:06:51.496 | INFO | [OCR_OIL 0.067s] 21813 2026-04-22 22:06:51.584 | INFO | [OCR_COIN 0.085s] 284098 2026-04-22 22:06:55.897 | INFO | [Loading] 7% 2026-04-22 22:06:55.900 | INFO | Auto search combat loading 2026-04-22 22:06:55.902 | INFO | Screenshot interval set to 1.0s 2026-04-22 22:07:01.904 | INFO | [BattleUI] PAUSE 2026-04-22 22:07:01.910 | INFO | Auto Search combat execute 2026-04-22 22:07:01.913 | INFO | <<< EMOTION REDUCE >>> 2026-04-22 22:07:01.929 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-04-22 22:07:01.937 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=49, Main.Emotion.Fleet1Record=datetime.datetime(2026, 4, 22, 22, 7, 1), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 4, 22, 22, 7, 1) 2026-04-22 22:07:01.972 | INFO | [Emotion fleet_1] 49 2026-04-22 22:07:01.976 | INFO | [Emotion fleet_2] 119 2026-04-22 22:07:07.897 | INFO | Combat auto check timer reached 2026-04-22 22:07:33.948 | INFO | Click (1041, 662) @ GET_SHIP 2026-04-22 22:07:35.941 | INFO | Click (1028, 663) @ GET_SHIP 2026-04-22 22:07:36.964 | INFO | Click (1025, 655) @ GET_SHIP 2026-04-22 22:07:38.955 | INFO | Click (1024, 640) @ GET_SHIP 2026-04-22 22:07:39.947 | INFO | Screenshot interval set to 0.3s 2026-04-22 22:07:39.950 | INFO | Auto Search combat status 2026-04-22 22:07:39.953 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_2 ─────────────────────────────────────────────────────── 2026-04-22 22:07:39.958 | INFO | BATTLE_2 2026-04-22 22:07:39.960 | INFO | Auto search moving 2026-04-22 22:07:39.964 | INFO | Fleet: 1, fleet_current_index: 1 2026-04-22 22:07:40.029 | INFO | [OCR_OIL 0.060s] 21794 2026-04-22 22:07:40.104 | INFO | [OCR_COIN 0.071s] 284115 2026-04-22 22:07:44.441 | INFO | [Loading] 16% 2026-04-22 22:07:44.445 | INFO | Auto search combat loading 2026-04-22 22:07:44.448 | INFO | Screenshot interval set to 1.0s 2026-04-22 22:07:49.442 | INFO | [BattleUI] PAUSE 2026-04-22 22:07:49.445 | INFO | Auto Search combat execute 2026-04-22 22:07:49.448 | INFO | <<< EMOTION REDUCE >>> 2026-04-22 22:07:49.458 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-04-22 22:07:49.464 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=47, Main.Emotion.Fleet1Record=datetime.datetime(2026, 4, 22, 22, 7, 49), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 4, 22, 22, 7, 49) 2026-04-22 22:07:49.501 | INFO | [Emotion fleet_1] 47 2026-04-22 22:07:49.507 | INFO | [Emotion fleet_2] 119 2026-04-22 22:07:54.456 | INFO | Combat auto check timer reached 2026-04-22 22:08:32.484 | INFO | Screenshot interval set to 0.3s 2026-04-22 22:08:32.489 | INFO | Auto Search combat status 2026-04-22 22:08:33.080 | INFO | Click (1026, 660) @ GET_SHIP 2026-04-22 22:08:34.280 | INFO | Click (1012, 663) @ GET_SHIP 2026-04-22 22:08:35.479 | INFO | Click (1036, 656) @ GET_SHIP 2026-04-22 22:08:36.681 | INFO | Click (1027, 677) @ GET_SHIP 2026-04-22 22:08:38.473 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_3 ─────────────────────────────────────────────────────── 2026-04-22 22:08:38.479 | INFO | BATTLE_3 2026-04-22 22:08:38.482 | INFO | Auto search moving 2026-04-22 22:08:38.487 | INFO | Fleet: 1, fleet_current_index: 1 2026-04-22 22:08:38.592 | INFO | [OCR_OIL 0.100s] 21775 2026-04-22 22:08:38.678 | INFO | [OCR_COIN 0.082s] 284136 2026-04-22 22:08:42.689 | INFO | [Loading] 7% 2026-04-22 22:08:42.692 | INFO | Auto search combat loading 2026-04-22 22:08:42.694 | INFO | Screenshot interval set to 1.0s 2026-04-22 22:08:48.693 | INFO | [BattleUI] PAUSE 2026-04-22 22:08:48.697 | INFO | Auto Search combat execute 2026-04-22 22:08:48.701 | INFO | <<< EMOTION REDUCE >>> 2026-04-22 22:08:48.713 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-04-22 22:08:48.718 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=45, Main.Emotion.Fleet1Record=datetime.datetime(2026, 4, 22, 22, 8, 48), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 4, 22, 22, 8, 48) 2026-04-22 22:08:48.737 | INFO | [Emotion fleet_1] 45 2026-04-22 22:08:48.742 | INFO | [Emotion fleet_2] 119 2026-04-22 22:08:53.706 | INFO | Combat auto check timer reached 2026-04-22 22:09:30.754 | INFO | Click (1023, 644) @ GET_SHIP 2026-04-22 22:09:32.752 | INFO | Click (1017, 642) @ GET_SHIP 2026-04-22 22:09:33.746 | INFO | Screenshot interval set to 0.3s 2026-04-22 22:09:33.749 | INFO | Auto Search combat status 2026-04-22 22:09:33.752 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_4 ─────────────────────────────────────────────────────── 2026-04-22 22:09:33.756 | INFO | BATTLE_4 2026-04-22 22:09:33.758 | INFO | Auto search moving 2026-04-22 22:09:33.761 | INFO | Fleet: 1, fleet_current_index: 1 2026-04-22 22:09:33.856 | INFO | [OCR_OIL 0.091s] 21756 2026-04-22 22:09:33.943 | INFO | [OCR_COIN 0.082s] 284158 2026-04-22 22:09:38.839 | INFO | [Loading] 21% 2026-04-22 22:09:38.843 | INFO | Auto search combat loading 2026-04-22 22:09:38.845 | INFO | Screenshot interval set to 1.0s 2026-04-22 22:09:43.861 | INFO | [BattleUI] PAUSE 2026-04-22 22:09:43.864 | INFO | Auto Search combat execute 2026-04-22 22:09:43.867 | INFO | <<< EMOTION REDUCE >>> 2026-04-22 22:09:43.878 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-04-22 22:09:43.883 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=43, Main.Emotion.Fleet1Record=datetime.datetime(2026, 4, 22, 22, 9, 43), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 4, 22, 22, 9, 43) 2026-04-22 22:09:43.900 | INFO | [Emotion fleet_1] 43 2026-04-22 22:09:43.905 | INFO | [Emotion fleet_2] 119 2026-04-22 22:09:49.846 | INFO | Combat auto check timer reached 2026-04-22 22:10:15.879 | INFO | Click (1013, 672) @ GET_SHIP 2026-04-22 22:10:17.880 | INFO | Click (1031, 669) @ GET_SHIP 2026-04-22 22:10:19.881 | INFO | Click (1025, 651) @ GET_SHIP 2026-04-22 22:10:20.892 | INFO | Click (1029, 657) @ GET_SHIP 2026-04-22 22:10:21.885 | INFO | Screenshot interval set to 0.3s 2026-04-22 22:10:21.890 | INFO | Auto Search combat status 2026-04-22 22:10:21.893 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_5 ─────────────────────────────────────────────────────── 2026-04-22 22:10:21.897 | INFO | BATTLE_5 2026-04-22 22:10:21.899 | INFO | Auto search moving 2026-04-22 22:10:21.904 | INFO | Fleet: 1, fleet_current_index: 1 2026-04-22 22:10:21.979 | INFO | [OCR_OIL 0.072s] 21737 2026-04-22 22:10:22.058 | INFO | [OCR_COIN 0.073s] 284172 2026-04-22 22:10:25.776 | INFO | [Loading] 9% 2026-04-22 22:10:25.779 | INFO | Auto search combat loading 2026-04-22 22:10:25.781 | INFO | Screenshot interval set to 1.0s 2026-04-22 22:10:31.790 | INFO | [BattleUI] PAUSE 2026-04-22 22:10:31.794 | INFO | Auto Search combat execute 2026-04-22 22:10:31.796 | INFO | <<< EMOTION REDUCE >>> 2026-04-22 22:10:31.809 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-04-22 22:10:31.814 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=41, Main.Emotion.Fleet1Record=datetime.datetime(2026, 4, 22, 22, 10, 31), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 4, 22, 22, 10, 31) 2026-04-22 22:10:31.830 | INFO | [Emotion fleet_1] 41 2026-04-22 22:10:31.837 | INFO | [Emotion fleet_2] 119 2026-04-22 22:10:37.810 | INFO | Combat auto check timer reached 2026-04-22 22:11:45.853 | INFO | Click (1033, 658) @ GET_SHIP 2026-04-22 22:14:46.012 | 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 22:14:46.040 | WARNING | Wait too long 2026-04-22 22:14:46.044 | 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 22:14:46.118 | INFO | [Package_name] com.bilibili.azurlane 2026-04-22 22:14:46.121 | ERROR | GameStuckError: Wait too long 2026-04-22 22:14:46.125 | WARNING | Saving error: ./log/error/1776867286125