═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ MAIN ═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ ════════════════════════════════════════════════════ CAMPAIGN_13_1 ════════════════════════════════════════════════════ 2026-04-22 05:54:05.543 | INFO | CAMPAIGN_13_1 2026-04-22 05:54:05.546 | INFO | Count: 0 2026-04-22 05:54:05.563 | INFO | <<< UI ENSURE >>> 2026-04-22 05:54:05.569 | INFO | UI get current page 2026-04-22 05:54:06.091 | INFO | Unknown ui page 2026-04-22 05:54:06.568 | INFO | UI additional: IDLE -> REWARD_GOTO_MAIN 2026-04-22 05:54:06.572 | INFO | Click ( 862, 611) @ REWARD_GOTO_MAIN 2026-04-22 05:54:06.746 | INFO | Unknown ui page 2026-04-22 05:54:06.888 | INFO | [Package_name] com.bilibili.azurlane 2026-04-22 05:54:06.909 | INFO | [Device Orientation] 0 (Normal) 2026-04-22 05:54:07.052 | INFO | Unknown ui page 2026-04-22 05:54:07.348 | INFO | Unknown ui page 2026-04-22 05:54:07.574 | INFO | [UI] page_main 2026-04-22 05:54:07.578 | INFO | Goto page_campaign 2026-04-22 05:54:07.582 | INFO | <<< UI GOTO PAGE_CAMPAIGN >>> 2026-04-22 05:54:07.600 | INFO | Page switch: page_main_white -> page_campaign_menu 2026-04-22 05:54:07.606 | INFO | Click (1211, 508) @ MAIN_GOTO_CAMPAIGN_WHITE 2026-04-22 05:54:08.172 | INFO | Page switch: page_campaign_menu -> page_campaign 2026-04-22 05:54:08.175 | INFO | Click ( 364, 358) @ CAMPAIGN_MENU_GOTO_CAMPAIGN 2026-04-22 05:54:08.473 | INFO | Page arrive: page_campaign 2026-04-22 05:54:08.507 | INFO | Mode_switch_1 set to hard 2026-04-22 05:54:08.536 | INFO | [Mode_switch_1] hard 2026-04-22 05:54:08.540 | INFO | <<< UI ENSURE INDEX >>> 2026-04-22 05:54:08.612 | INFO | No stage found. 2026-04-22 05:54:08.830 | INFO | No stage found. 2026-04-22 05:54:09.130 | INFO | No stage found. 2026-04-22 05:54:09.453 | INFO | Loading OCR model: ./bin/cnocr_models/azur_lane 2026-04-22 05:54:09.575 | INFO | [campaign 0.139s] ['13--1', '13--3', '13--2', '13--4'] 2026-04-22 05:54:09.578 | INFO | [Chapter] 13 2026-04-22 05:54:09.580 | INFO | [Stage] 13-1, 13-3, 13-2, 13-4 2026-04-22 05:54:09.583 | INFO | [Index] 13 2026-04-22 05:54:09.648 | INFO | [OCR_OIL 0.038s] 24389 ──────────────────────────────────────────────────────── 13-1 ───────────────────────────────────────────────────────── 2026-04-22 05:54:09.654 | INFO | 13-1 2026-04-22 05:54:09.657 | INFO | Expect emotion reduce: (12, 2) 2026-04-22 05:54:09.668 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-04-22 05:54:09.674 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=53, Main.Emotion.Fleet1Record=datetime.datetime(2026, 4, 22, 5, 54, 9), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 4, 22, 5, 54, 9) 2026-04-22 05:54:09.690 | INFO | [Emotion fleet_1] 53 2026-04-22 05:54:09.693 | INFO | [Emotion fleet_2] 119 2026-04-22 05:54:09.696 | INFO | <<< ENTER MAP >>> 2026-04-22 05:54:09.770 | INFO | Click ( 187, 268) @ 13-1 2026-04-22 05:54:10.175 | INFO | [Map_clear_percentage] 5% 2026-04-22 05:54:10.481 | INFO | [Map_clear_percentage] 65% 2026-04-22 05:54:10.770 | INFO | [Map_clear_percentage] 99% 2026-04-22 05:54:10.796 | INFO | [MAP_CLEAR_ALL_THIS_TIME] False 2026-04-22 05:54:10.799 | INFO | [Map_info] 99%, star_1, star_2, star_3, 100_percent_clear, 3_stars, threat_safe, clear_mode 2026-04-22 05:54:10.805 | INFO | [StopCondition_MapAchievement] non_stop 2026-04-22 05:54:10.810 | INFO | Fast_Forward set to on 2026-04-22 05:54:10.815 | INFO | [Fast_Forward] on 2026-04-22 05:54:10.830 | INFO | Auto_Search set to on 2026-04-22 05:54:10.840 | INFO | [Auto_Search] on 2026-04-22 05:54:10.845 | INFO | Click ( 956, 518) @ MAP_PREPARATION 2026-04-22 05:54:11.079 | INFO | Handling 2x book setting, mode=prep. 2026-04-22 05:54:11.378 | INFO | Using fleet: [4, 3, 1] 2026-04-22 05:54:11.453 | INFO | Hard satisfied: Fleet_1: None, Fleet_2: None, Submarine: None 2026-04-22 05:54:11.462 | INFO | [map_allow_submarine] True 2026-04-22 05:54:11.467 | INFO | Click (1145, 332) @ FLEET_2_CLEAR 2026-04-22 05:54:11.522 | INFO | Click (1058, 475) @ SUBMARINE_CHOOSE 2026-04-22 05:54:11.669 | INFO | Current selected: [1] 2026-04-22 05:54:11.673 | INFO | Click (1045, 496) @ SUBMARINE_CHOOSE 2026-04-22 05:54:11.968 | INFO | Click (1059, 225) @ FLEET_1_CHOOSE 2026-04-22 05:54:12.268 | INFO | Current selected: [4] 2026-04-22 05:54:12.272 | INFO | Click (1049, 214) @ FLEET_1_CHOOSE 2026-04-22 05:54:12.568 | INFO | Click (1060, 337) @ FLEET_2_CHOOSE 2026-04-22 05:54:12.867 | INFO | Current selected: [4] 2026-04-22 05:54:12.872 | INFO | Click (1099, 481) @ FLEET_2_BAR_INDEX_3 2026-04-22 05:54:13.168 | INFO | Auto search setting 2026-04-22 05:54:13.183 | INFO | [_fleet_sidebar_offset] 0 2026-04-22 05:54:13.193 | INFO | [_fleet_sidebar_offset] 0 2026-04-22 05:54:13.198 | INFO | [Fleet_sidebar] 1/3 2026-04-22 05:54:13.204 | INFO | Click (1218, 434) @ FLEET_SIDEBAR_0_2 2026-04-22 05:54:13.470 | INFO | [_fleet_sidebar_offset] 0 2026-04-22 05:54:13.475 | INFO | [Fleet_sidebar] 3/3 2026-04-22 05:54:13.478 | INFO | [Auto_Search_Setting] fleet1_all_fleet2_standby, sub_standby 2026-04-22 05:54:13.481 | INFO | Click ( 510, 221) @ AUTO_SEARCH_SET_MOB 2026-04-22 05:54:13.975 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_standby 2026-04-22 05:54:13.979 | INFO | Selected to the correct auto search setting 2026-04-22 05:54:13.983 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_standby 2026-04-22 05:54:13.988 | INFO | Selected to the correct auto search setting 2026-04-22 05:54:13.995 | INFO | Click (1074, 593) @ FLEET_PREPARATION 2026-04-22 05:54:14.888 | INFO | is_auto_search_running appeared ────────────────────────────────────────────────────── BATTLE_0 ─────────────────────────────────────────────────────── 2026-04-22 05:54:14.894 | INFO | BATTLE_0 2026-04-22 05:54:14.897 | INFO | Auto search moving 2026-04-22 05:54:14.910 | INFO | Fleet: 1, fleet_current_index: 1 2026-04-22 05:54:14.976 | INFO | [OCR_OIL 0.062s] 24379 2026-04-22 05:54:15.056 | INFO | [OCR_COIN 0.075s] 277525 2026-04-22 05:54:19.537 | INFO | [Loading] 10% 2026-04-22 05:54:19.541 | INFO | Auto search combat loading 2026-04-22 05:54:19.544 | INFO | Screenshot interval set to 1.0s 2026-04-22 05:54:25.549 | INFO | [BattleUI] PAUSE 2026-04-22 05:54:25.553 | INFO | Auto Search combat execute 2026-04-22 05:54:25.556 | INFO | <<< EMOTION REDUCE >>> 2026-04-22 05:54:25.566 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-04-22 05:54:25.573 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=51, Main.Emotion.Fleet1Record=datetime.datetime(2026, 4, 22, 5, 54, 25), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 4, 22, 5, 54, 25) 2026-04-22 05:54:25.594 | INFO | [Emotion fleet_1] 51 2026-04-22 05:54:25.598 | INFO | [Emotion fleet_2] 119 2026-04-22 05:54:31.540 | INFO | Combat auto check timer reached 2026-04-22 05:54:51.572 | INFO | Click (1028, 638) @ GET_SHIP 2026-04-22 05:54:52.579 | INFO | Click (1041, 655) @ GET_SHIP 2026-04-22 05:54:53.588 | INFO | Click (1008, 655) @ GET_SHIP 2026-04-22 05:54:55.581 | INFO | Screenshot interval set to 0.3s 2026-04-22 05:54:55.585 | INFO | Auto Search combat status 2026-04-22 05:54:55.588 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_1 ─────────────────────────────────────────────────────── 2026-04-22 05:54:55.591 | INFO | BATTLE_1 2026-04-22 05:54:55.593 | INFO | Auto search moving 2026-04-22 05:54:55.598 | INFO | Fleet: 1, fleet_current_index: 1 2026-04-22 05:54:55.685 | INFO | [OCR_OIL 0.080s] 24360 2026-04-22 05:54:55.770 | INFO | [OCR_COIN 0.083s] 277544 2026-04-22 05:54:59.779 | INFO | [Loading] 13% 2026-04-22 05:54:59.782 | INFO | Auto search combat loading 2026-04-22 05:54:59.786 | INFO | Screenshot interval set to 1.0s 2026-04-22 05:55:05.783 | INFO | [BattleUI] PAUSE 2026-04-22 05:55:05.787 | INFO | Auto Search combat execute 2026-04-22 05:55:05.790 | INFO | <<< EMOTION REDUCE >>> 2026-04-22 05:55:05.805 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-04-22 05:55:05.811 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=49, Main.Emotion.Fleet1Record=datetime.datetime(2026, 4, 22, 5, 55, 5), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 4, 22, 5, 55, 5) 2026-04-22 05:55:05.827 | INFO | [Emotion fleet_1] 49 2026-04-22 05:55:05.832 | INFO | [Emotion fleet_2] 119 2026-04-22 05:55:11.779 | INFO | Combat auto check timer reached 2026-04-22 05:55:29.821 | INFO | Screenshot interval set to 0.3s 2026-04-22 05:55:29.825 | INFO | Auto Search combat status 2026-04-22 05:55:30.707 | INFO | Click (1023, 637) @ GET_SHIP 2026-04-22 05:55:31.908 | INFO | Click (1028, 667) @ GET_SHIP 2026-04-22 05:55:33.111 | INFO | Click (1025, 666) @ GET_SHIP 2026-04-22 05:55:34.292 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_2 ─────────────────────────────────────────────────────── 2026-04-22 05:55:34.297 | INFO | BATTLE_2 2026-04-22 05:55:34.299 | INFO | Auto search moving 2026-04-22 05:55:34.303 | INFO | Fleet: 1, fleet_current_index: 1 2026-04-22 05:55:34.389 | INFO | [OCR_OIL 0.082s] 24341 2026-04-22 05:55:34.453 | INFO | [OCR_COIN 0.060s] 277554 2026-04-22 05:55:39.405 | INFO | [Loading] 12% 2026-04-22 05:55:39.409 | INFO | Auto search combat loading 2026-04-22 05:55:39.413 | INFO | Screenshot interval set to 1.0s 2026-04-22 05:55:45.425 | INFO | [BattleUI] PAUSE 2026-04-22 05:55:45.433 | INFO | Auto Search combat execute 2026-04-22 05:55:45.438 | INFO | <<< EMOTION REDUCE >>> 2026-04-22 05:55:45.456 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-04-22 05:55:45.465 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=47, Main.Emotion.Fleet1Record=datetime.datetime(2026, 4, 22, 5, 55, 45), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 4, 22, 5, 55, 45) 2026-04-22 05:55:45.483 | INFO | [Emotion fleet_1] 47 2026-04-22 05:55:45.488 | INFO | [Emotion fleet_2] 119 2026-04-22 05:55:51.414 | INFO | Combat auto check timer reached 2026-04-22 05:56:10.440 | INFO | Screenshot interval set to 0.3s 2026-04-22 05:56:10.444 | INFO | Auto Search combat status 2026-04-22 05:56:11.031 | INFO | Click (1029, 657) @ GET_SHIP 2026-04-22 05:56:12.232 | INFO | Click (1038, 656) @ GET_SHIP 2026-04-22 05:56:13.439 | INFO | Click (1032, 652) @ GET_SHIP 2026-04-22 05:56:14.643 | INFO | Click (1022, 674) @ GET_SHIP 2026-04-22 05:56:16.456 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_3 ─────────────────────────────────────────────────────── 2026-04-22 05:56:16.466 | INFO | BATTLE_3 2026-04-22 05:56:16.469 | INFO | Auto search moving 2026-04-22 05:56:16.476 | INFO | Fleet: 1, fleet_current_index: 1 2026-04-22 05:56:16.567 | INFO | [OCR_OIL 0.084s] 24322 2026-04-22 05:56:16.665 | INFO | [OCR_COIN 0.093s] 277579 2026-04-22 05:56:20.655 | INFO | [Loading] 16% 2026-04-22 05:56:20.660 | INFO | Auto search combat loading 2026-04-22 05:56:20.664 | INFO | Screenshot interval set to 1.0s 2026-04-22 05:56:25.657 | INFO | [BattleUI] PAUSE 2026-04-22 05:56:25.663 | INFO | Auto Search combat execute 2026-04-22 05:56:25.666 | INFO | <<< EMOTION REDUCE >>> 2026-04-22 05:56:25.676 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-04-22 05:56:25.681 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=45, Main.Emotion.Fleet1Record=datetime.datetime(2026, 4, 22, 5, 56, 25), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 4, 22, 5, 56, 25) 2026-04-22 05:56:25.700 | INFO | [Emotion fleet_1] 45 2026-04-22 05:56:25.704 | INFO | [Emotion fleet_2] 119 2026-04-22 05:56:30.672 | INFO | Combat auto check timer reached 2026-04-22 05:57:08.706 | INFO | Screenshot interval set to 0.3s 2026-04-22 05:57:08.710 | INFO | Auto Search combat status 2026-04-22 05:57:09.595 | INFO | Click (1029, 662) @ GET_SHIP 2026-04-22 05:57:10.796 | INFO | Click (1026, 672) @ GET_SHIP 2026-04-22 05:57:11.995 | INFO | Click (1028, 679) @ GET_SHIP 2026-04-22 05:57:13.201 | INFO | Click (1035, 668) @ GET_SHIP 2026-04-22 05:57:14.996 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_4 ─────────────────────────────────────────────────────── 2026-04-22 05:57:15.004 | INFO | BATTLE_4 2026-04-22 05:57:15.008 | INFO | Auto search moving 2026-04-22 05:57:15.014 | INFO | Fleet: 1, fleet_current_index: 1 2026-04-22 05:57:15.096 | INFO | [OCR_OIL 0.078s] 24303 2026-04-22 05:57:15.188 | INFO | [OCR_COIN 0.089s] 277609 2026-04-22 05:57:18.905 | INFO | [Loading] 6% 2026-04-22 05:57:18.909 | INFO | Auto search combat loading 2026-04-22 05:57:18.913 | INFO | Screenshot interval set to 1.0s 2026-04-22 05:57:24.917 | INFO | [BattleUI] PAUSE 2026-04-22 05:57:24.920 | INFO | Auto Search combat execute 2026-04-22 05:57:24.923 | INFO | <<< EMOTION REDUCE >>> 2026-04-22 05:57:24.935 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-04-22 05:57:24.942 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=43, Main.Emotion.Fleet1Record=datetime.datetime(2026, 4, 22, 5, 57, 24), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 4, 22, 5, 57, 24) 2026-04-22 05:57:24.956 | INFO | [Emotion fleet_1] 43 2026-04-22 05:57:24.960 | INFO | [Emotion fleet_2] 119 2026-04-22 05:57:30.903 | INFO | Combat auto check timer reached 2026-04-22 05:58:09.959 | INFO | Click (1030, 646) @ GET_SHIP 2026-04-22 05:58:10.960 | INFO | Click (1015, 656) @ GET_SHIP 2026-04-22 05:58:12.966 | INFO | Click (1017, 672) @ GET_SHIP 2026-04-22 05:58:13.971 | INFO | Click (1030, 666) @ GET_SHIP 2026-04-22 05:58:14.965 | INFO | Screenshot interval set to 0.3s 2026-04-22 05:58:14.970 | INFO | Auto Search combat status 2026-04-22 05:58:14.974 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_5 ─────────────────────────────────────────────────────── 2026-04-22 05:58:14.979 | INFO | BATTLE_5 2026-04-22 05:58:14.981 | INFO | Auto search moving 2026-04-22 05:58:14.985 | INFO | Fleet: 1, fleet_current_index: 1 2026-04-22 05:58:15.067 | INFO | [OCR_OIL 0.078s] 24284 2026-04-22 05:58:15.157 | INFO | [OCR_COIN 0.085s] 277627 2026-04-22 05:58:17.055 | INFO | [Loading] 9% 2026-04-22 05:58:17.059 | INFO | Auto search combat loading 2026-04-22 05:58:17.062 | INFO | Screenshot interval set to 1.0s 2026-04-22 05:58:23.064 | INFO | [BattleUI] PAUSE 2026-04-22 05:58:23.071 | INFO | Auto Search combat execute 2026-04-22 05:58:23.074 | INFO | <<< EMOTION REDUCE >>> 2026-04-22 05:58:23.089 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-04-22 05:58:23.100 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=41, Main.Emotion.Fleet1Record=datetime.datetime(2026, 4, 22, 5, 58, 23), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 4, 22, 5, 58, 23) 2026-04-22 05:58:23.114 | INFO | [Emotion fleet_1] 41 2026-04-22 05:58:23.120 | INFO | [Emotion fleet_2] 119 2026-04-22 05:58:29.068 | INFO | Combat auto check timer reached 2026-04-22 06:01:23.222 | 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 06:01:23.245 | WARNING | Wait too long 2026-04-22 06:01:23.249 | WARNING | Waiting for {'POPUP_CONFIRM_WHITE', 'GET_MISSION', 'POPUP_CANCEL', 'MISSION_POPUP_GO', 'SP_CHECK', 'PAUSE', 'BATTLE_STATUS_S', 'EXP_INFO_A', 'BATTLE_STATUS_B', 'COMBAT_AUTO', 'COMBAT_AUTO_150', 'EVENT_CHECK', 'GUILD_POPUP_CONFIRM', 'EXP_INFO_S', 'CAMPAIGN_CHECK', 'COMBAT_AUTO_133', 'EXP_INFO_B', 'GET_SHIP', 'AUTO_SEARCH_MAP_OPTION_ON', 'BATTLE_STATUS_A'} 2026-04-22 06:01:23.304 | INFO | [Package_name] com.bilibili.azurlane 2026-04-22 06:01:23.311 | ERROR | GameStuckError: Wait too long 2026-04-22 06:01:23.317 | WARNING | Saving error: ./log/error/1776808883317