═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ MAIN ═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ ════════════════════════════════════════════════════ CAMPAIGN_13_1 ════════════════════════════════════════════════════ 2026-02-15 04:30:05.668 | INFO | CAMPAIGN_13_1 2026-02-15 04:30:05.671 | INFO | Count: 0 2026-02-15 04:30:05.688 | INFO | <<< UI ENSURE >>> 2026-02-15 04:30:05.692 | INFO | UI get current page 2026-02-15 04:30:06.229 | INFO | Unknown ui page 2026-02-15 04:30:06.696 | INFO | UI additional: IDLE -> REWARD_GOTO_MAIN 2026-02-15 04:30:06.701 | INFO | Click ( 837, 613) @ REWARD_GOTO_MAIN 2026-02-15 04:30:06.873 | INFO | Unknown ui page 2026-02-15 04:30:07.020 | INFO | [Package_name] com.bilibili.azurlane 2026-02-15 04:30:07.040 | INFO | [Device Orientation] 0 (Normal) 2026-02-15 04:30:07.182 | INFO | Unknown ui page 2026-02-15 04:30:07.474 | INFO | Unknown ui page 2026-02-15 04:30:07.701 | INFO | [UI] page_main 2026-02-15 04:30:07.706 | INFO | Goto page_campaign 2026-02-15 04:30:07.709 | INFO | <<< UI GOTO PAGE_CAMPAIGN >>> 2026-02-15 04:30:07.725 | INFO | Page switch: page_main_white -> page_campaign_menu 2026-02-15 04:30:07.729 | INFO | Click (1198, 514) @ MAIN_GOTO_CAMPAIGN_WHITE 2026-02-15 04:30:08.304 | INFO | Page switch: page_campaign_menu -> page_campaign 2026-02-15 04:30:08.307 | INFO | Click ( 302, 273) @ CAMPAIGN_MENU_GOTO_CAMPAIGN 2026-02-15 04:30:08.600 | INFO | Page arrive: page_campaign 2026-02-15 04:30:08.630 | INFO | Mode_switch_1 set to hard 2026-02-15 04:30:08.656 | INFO | [Mode_switch_1] hard 2026-02-15 04:30:08.661 | INFO | <<< UI ENSURE INDEX >>> 2026-02-15 04:30:08.740 | INFO | No stage found. 2026-02-15 04:30:08.966 | INFO | No stage found. 2026-02-15 04:30:09.286 | INFO | Loading OCR model: ./bin/cnocr_models/azur_lane 2026-02-15 04:30:09.397 | INFO | [campaign 0.132s] ['I3-1', 'I3--3', 'I3--2', 'I3--4'] 2026-02-15 04:30:09.400 | INFO | [Chapter] i3 2026-02-15 04:30:09.404 | INFO | [Stage] i3-1, i3-3, i3-2, i3-4 2026-02-15 04:30:09.505 | INFO | <<< UI ENSURE >>> 2026-02-15 04:30:09.508 | INFO | UI get current page 2026-02-15 04:30:09.518 | INFO | [UI] page_campaign 2026-02-15 04:30:09.522 | INFO | Already at page_campaign 2026-02-15 04:30:09.528 | INFO | Mode_switch_1 set to hard 2026-02-15 04:30:09.535 | INFO | [Mode_switch_1] hard 2026-02-15 04:30:09.539 | INFO | <<< UI ENSURE INDEX >>> 2026-02-15 04:30:09.668 | INFO | [campaign 0.053s] ['13--1', '13--3', '13--2', '13--4'] 2026-02-15 04:30:09.672 | INFO | [Chapter] 13 2026-02-15 04:30:09.674 | INFO | [Stage] 13-1, 13-3, 13-2, 13-4 2026-02-15 04:30:09.676 | INFO | [Index] 13 2026-02-15 04:30:09.747 | INFO | [OCR_OIL 0.043s] 17669 ──────────────────────────────────────────────────────── 13-1 ───────────────────────────────────────────────────────── 2026-02-15 04:30:09.754 | INFO | 13-1 2026-02-15 04:30:09.757 | INFO | Expect emotion reduce: (12, 2) 2026-02-15 04:30:09.767 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-02-15 04:30:09.771 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=53, Main.Emotion.Fleet1Record=datetime.datetime(2026, 2, 15, 4, 30, 9), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 2, 15, 4, 30, 9) 2026-02-15 04:30:09.790 | INFO | [Emotion fleet_1] 53 2026-02-15 04:30:09.793 | INFO | [Emotion fleet_2] 119 2026-02-15 04:30:09.796 | INFO | <<< ENTER MAP >>> 2026-02-15 04:30:09.870 | INFO | Click ( 195, 285) @ 13-1 2026-02-15 04:30:10.274 | INFO | [Map_clear_percentage] 5% 2026-02-15 04:30:10.583 | INFO | [Map_clear_percentage] 66% 2026-02-15 04:30:10.880 | INFO | [Map_clear_percentage] 99% 2026-02-15 04:30:10.908 | INFO | [MAP_CLEAR_ALL_THIS_TIME] False 2026-02-15 04:30:10.912 | INFO | [Map_info] 99%, star_1, star_2, star_3, 100_percent_clear, 3_stars, threat_safe, clear_mode 2026-02-15 04:30:10.915 | INFO | [StopCondition_MapAchievement] non_stop 2026-02-15 04:30:10.920 | INFO | Fast_Forward set to on 2026-02-15 04:30:10.924 | INFO | [Fast_Forward] on 2026-02-15 04:30:10.938 | INFO | Auto_Search set to on 2026-02-15 04:30:10.943 | INFO | [Auto_Search] on 2026-02-15 04:30:10.946 | INFO | Click ( 940, 521) @ MAP_PREPARATION 2026-02-15 04:30:11.180 | INFO | Handling 2x book setting, mode=prep. 2026-02-15 04:30:11.478 | INFO | Using fleet: [4, 3, 1] 2026-02-15 04:30:11.559 | INFO | Hard satisfied: Fleet_1: None, Fleet_2: None, Submarine: None 2026-02-15 04:30:11.568 | INFO | [map_allow_submarine] True 2026-02-15 04:30:11.574 | INFO | Click (1155, 331) @ FLEET_2_CLEAR 2026-02-15 04:30:11.627 | INFO | Click (1069, 469) @ SUBMARINE_CHOOSE 2026-02-15 04:30:11.774 | INFO | Current selected: [1] 2026-02-15 04:30:11.777 | INFO | Click (1050, 471) @ SUBMARINE_CHOOSE 2026-02-15 04:30:12.071 | INFO | Click (1047, 225) @ FLEET_1_CHOOSE 2026-02-15 04:30:12.371 | INFO | Current selected: [4] 2026-02-15 04:30:12.376 | INFO | Click (1052, 214) @ FLEET_1_CHOOSE 2026-02-15 04:30:12.670 | INFO | Click (1040, 342) @ FLEET_2_CHOOSE 2026-02-15 04:30:12.973 | INFO | Current selected: [4] 2026-02-15 04:30:12.976 | INFO | Click (1101, 489) @ FLEET_2_BAR_INDEX_3 2026-02-15 04:30:13.275 | INFO | Auto search setting 2026-02-15 04:30:13.291 | INFO | [_fleet_sidebar_offset] 0 2026-02-15 04:30:13.296 | INFO | [Fleet_sidebar] 1/3 2026-02-15 04:30:13.300 | INFO | Click (1213, 401) @ FLEET_SIDEBAR_0_2 2026-02-15 04:30:13.749 | INFO | [_fleet_sidebar_offset] 0 2026-02-15 04:30:13.753 | INFO | [Fleet_sidebar] 3/3 2026-02-15 04:30:13.759 | INFO | [Auto_Search_Setting] fleet1_all_fleet2_standby, sub_standby 2026-02-15 04:30:13.763 | INFO | Click ( 504, 217) @ AUTO_SEARCH_SET_MOB 2026-02-15 04:30:14.255 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_standby 2026-02-15 04:30:14.259 | INFO | Selected to the correct auto search setting 2026-02-15 04:30:14.262 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_standby 2026-02-15 04:30:14.265 | INFO | Selected to the correct auto search setting 2026-02-15 04:30:14.267 | INFO | Click (1028, 577) @ FLEET_PREPARATION 2026-02-15 04:30:15.174 | INFO | is_auto_search_running appeared ────────────────────────────────────────────────────── BATTLE_0 ─────────────────────────────────────────────────────── 2026-02-15 04:30:15.180 | INFO | BATTLE_0 2026-02-15 04:30:15.182 | INFO | Auto search moving 2026-02-15 04:30:15.195 | INFO | Fleet: 1, fleet_current_index: 1 2026-02-15 04:30:15.301 | INFO | [OCR_OIL 0.101s] 17659 2026-02-15 04:30:15.426 | INFO | [OCR_COIN 0.116s] 104706 2026-02-15 04:30:19.950 | INFO | [Loading] 6% 2026-02-15 04:30:19.953 | INFO | Auto search combat loading 2026-02-15 04:30:19.955 | INFO | Screenshot interval set to 1.0s 2026-02-15 04:30:25.960 | INFO | [BattleUI] PAUSE 2026-02-15 04:30:25.967 | INFO | Auto Search combat execute 2026-02-15 04:30:25.970 | INFO | <<< EMOTION REDUCE >>> 2026-02-15 04:30:25.981 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-02-15 04:30:25.986 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=51, Main.Emotion.Fleet1Record=datetime.datetime(2026, 2, 15, 4, 30, 25), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 2, 15, 4, 30, 25) 2026-02-15 04:30:26.011 | INFO | [Emotion fleet_1] 51 2026-02-15 04:30:26.023 | INFO | [Emotion fleet_2] 119 2026-02-15 04:30:31.954 | INFO | Combat auto check timer reached 2026-02-15 04:30:55.984 | INFO | Click (1036, 668) @ GET_SHIP 2026-02-15 04:30:56.982 | INFO | Screenshot interval set to 0.3s 2026-02-15 04:30:56.986 | INFO | Auto Search combat status 2026-02-15 04:30:57.000 | INFO | Click (1021, 658) @ GET_SHIP 2026-02-15 04:30:58.766 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_1 ─────────────────────────────────────────────────────── 2026-02-15 04:30:58.771 | INFO | BATTLE_1 2026-02-15 04:30:58.774 | INFO | Auto search moving 2026-02-15 04:30:58.777 | INFO | Fleet: 1, fleet_current_index: 1 2026-02-15 04:30:58.841 | INFO | [OCR_OIL 0.061s] 17640 2026-02-15 04:30:58.912 | INFO | [OCR_COIN 0.068s] 104722 2026-02-15 04:31:03.284 | INFO | [Loading] 6% 2026-02-15 04:31:03.289 | INFO | Auto search combat loading 2026-02-15 04:31:03.292 | INFO | Screenshot interval set to 1.0s 2026-02-15 04:31:09.285 | INFO | [BattleUI] PAUSE 2026-02-15 04:31:09.290 | INFO | Auto Search combat execute 2026-02-15 04:31:09.293 | INFO | <<< EMOTION REDUCE >>> 2026-02-15 04:31:09.306 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-02-15 04:31:09.314 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=49, Main.Emotion.Fleet1Record=datetime.datetime(2026, 2, 15, 4, 31, 9), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 2, 15, 4, 31, 9) 2026-02-15 04:31:09.374 | INFO | [Emotion fleet_1] 49 2026-02-15 04:31:09.379 | INFO | [Emotion fleet_2] 119 2026-02-15 04:31:15.277 | INFO | Combat auto check timer reached 2026-02-15 04:31:51.324 | INFO | Screenshot interval set to 0.3s 2026-02-15 04:31:51.327 | INFO | Auto Search combat status 2026-02-15 04:31:52.817 | INFO | Click (1039, 661) @ GET_SHIP 2026-02-15 04:31:54.018 | INFO | Click (1049, 658) @ GET_SHIP 2026-02-15 04:31:55.220 | INFO | Click (1031, 662) @ GET_SHIP 2026-02-15 04:31:56.418 | INFO | Click (1015, 655) @ GET_SHIP 2026-02-15 04:31:58.213 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_2 ─────────────────────────────────────────────────────── 2026-02-15 04:31:58.220 | INFO | BATTLE_2 2026-02-15 04:31:58.223 | INFO | Auto search moving 2026-02-15 04:31:58.228 | INFO | Fleet: 1, fleet_current_index: 1 2026-02-15 04:31:58.314 | INFO | [OCR_OIL 0.081s] 17621 2026-02-15 04:31:58.423 | INFO | [OCR_COIN 0.105s] 104745 2026-02-15 04:32:02.428 | INFO | [Loading] 13% 2026-02-15 04:32:02.431 | INFO | Auto search combat loading 2026-02-15 04:32:02.434 | INFO | Screenshot interval set to 1.0s 2026-02-15 04:32:07.435 | INFO | [BattleUI] PAUSE 2026-02-15 04:32:07.440 | INFO | Auto Search combat execute 2026-02-15 04:32:07.444 | INFO | <<< EMOTION REDUCE >>> 2026-02-15 04:32:07.456 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-02-15 04:32:07.460 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=47, Main.Emotion.Fleet1Record=datetime.datetime(2026, 2, 15, 4, 32, 7), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 2, 15, 4, 32, 7) 2026-02-15 04:32:07.481 | INFO | [Emotion fleet_1] 47 2026-02-15 04:32:07.485 | INFO | [Emotion fleet_2] 119 2026-02-15 04:32:13.436 | INFO | Combat auto check timer reached 2026-02-15 04:33:07.489 | INFO | Screenshot interval set to 0.3s 2026-02-15 04:33:07.492 | INFO | Auto Search combat status 2026-02-15 04:33:08.386 | INFO | Click (1032, 649) @ GET_SHIP 2026-02-15 04:33:09.579 | INFO | Click (1017, 653) @ GET_SHIP 2026-02-15 04:33:10.793 | INFO | Click (1023, 647) @ GET_SHIP 2026-02-15 04:33:11.982 | INFO | Click (1024, 672) @ GET_SHIP 2026-02-15 04:33:13.776 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_3 ─────────────────────────────────────────────────────── 2026-02-15 04:33:13.781 | INFO | BATTLE_3 2026-02-15 04:33:13.786 | INFO | Auto search moving 2026-02-15 04:33:13.793 | INFO | Fleet: 1, fleet_current_index: 1 2026-02-15 04:33:13.867 | INFO | [OCR_OIL 0.070s] 17602 2026-02-15 04:33:13.954 | INFO | [OCR_COIN 0.082s] 104760 2026-02-15 04:33:17.688 | INFO | [Loading] 5% 2026-02-15 04:33:17.695 | INFO | Auto search combat loading 2026-02-15 04:33:17.699 | INFO | Screenshot interval set to 1.0s 2026-02-15 04:33:23.694 | INFO | [BattleUI] PAUSE 2026-02-15 04:33:23.698 | INFO | Auto Search combat execute 2026-02-15 04:33:23.700 | INFO | <<< EMOTION REDUCE >>> 2026-02-15 04:33:23.712 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-02-15 04:33:23.716 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=45, Main.Emotion.Fleet1Record=datetime.datetime(2026, 2, 15, 4, 33, 23), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 2, 15, 4, 33, 23) 2026-02-15 04:33:23.729 | INFO | [Emotion fleet_1] 45 2026-02-15 04:33:23.733 | INFO | [Emotion fleet_2] 119 2026-02-15 04:33:29.712 | INFO | Combat auto check timer reached 2026-02-15 04:34:07.742 | INFO | Click (1035, 675) @ GET_SHIP 2026-02-15 04:34:09.743 | INFO | Click (1026, 665) @ GET_SHIP 2026-02-15 04:34:10.746 | INFO | Click (1018, 653) @ GET_SHIP 2026-02-15 04:34:11.747 | INFO | Screenshot interval set to 0.3s 2026-02-15 04:34:11.751 | INFO | Auto Search combat status 2026-02-15 04:34:11.757 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_4 ─────────────────────────────────────────────────────── 2026-02-15 04:34:11.764 | INFO | BATTLE_4 2026-02-15 04:34:11.768 | INFO | Auto search moving 2026-02-15 04:34:11.772 | INFO | Fleet: 1, fleet_current_index: 1 2026-02-15 04:34:11.864 | INFO | [OCR_OIL 0.084s] 17583 2026-02-15 04:34:11.968 | INFO | [OCR_COIN 0.100s] 104777 2026-02-15 04:34:16.561 | INFO | [Loading] 8% 2026-02-15 04:34:16.566 | INFO | Auto search combat loading 2026-02-15 04:34:16.570 | INFO | Screenshot interval set to 1.0s 2026-02-15 04:34:22.579 | INFO | [BattleUI] PAUSE 2026-02-15 04:34:22.583 | INFO | Auto Search combat execute 2026-02-15 04:34:22.585 | INFO | <<< EMOTION REDUCE >>> 2026-02-15 04:34:22.596 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-02-15 04:34:22.601 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=43, Main.Emotion.Fleet1Record=datetime.datetime(2026, 2, 15, 4, 34, 22), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 2, 15, 4, 34, 22) 2026-02-15 04:34:22.619 | INFO | [Emotion fleet_1] 43 2026-02-15 04:34:22.625 | INFO | [Emotion fleet_2] 119 2026-02-15 04:34:28.569 | INFO | Combat auto check timer reached 2026-02-15 04:35:06.614 | INFO | Screenshot interval set to 0.3s 2026-02-15 04:35:06.617 | INFO | Auto Search combat status 2026-02-15 04:35:08.111 | INFO | Click (1030, 652) @ GET_SHIP 2026-02-15 04:35:09.313 | INFO | Click (1048, 646) @ GET_SHIP 2026-02-15 04:35:10.513 | INFO | Click (1011, 654) @ GET_SHIP 2026-02-15 04:35:11.711 | INFO | Click (1027, 666) @ GET_SHIP 2026-02-15 04:35:13.501 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_5 ─────────────────────────────────────────────────────── 2026-02-15 04:35:13.506 | INFO | BATTLE_5 2026-02-15 04:35:13.512 | INFO | Auto search moving 2026-02-15 04:35:13.519 | INFO | Fleet: 1, fleet_current_index: 1 2026-02-15 04:35:13.589 | INFO | [OCR_OIL 0.066s] 17564 2026-02-15 04:35:13.678 | INFO | [OCR_COIN 0.085s] 104799 2026-02-15 04:35:15.316 | INFO | [Loading] 5% 2026-02-15 04:35:15.321 | INFO | Auto search combat loading 2026-02-15 04:35:15.324 | INFO | Screenshot interval set to 1.0s 2026-02-15 04:35:21.340 | INFO | [BattleUI] PAUSE 2026-02-15 04:35:21.343 | INFO | Auto Search combat execute 2026-02-15 04:35:21.346 | INFO | <<< EMOTION REDUCE >>> 2026-02-15 04:35:21.357 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-02-15 04:35:21.361 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=41, Main.Emotion.Fleet1Record=datetime.datetime(2026, 2, 15, 4, 35, 21), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 2, 15, 4, 35, 21) 2026-02-15 04:35:21.383 | INFO | [Emotion fleet_1] 41 2026-02-15 04:35:21.388 | INFO | [Emotion fleet_2] 119 2026-02-15 04:35:27.314 | INFO | Combat auto check timer reached 2026-02-15 04:36:35.405 | INFO | Click (1027, 664) @ GET_SHIP 2026-02-15 04:39:35.539 | 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-02-15 04:39:35.563 | WARNING | Wait too long 2026-02-15 04:39:35.566 | 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-02-15 04:39:35.627 | INFO | [Package_name] com.bilibili.azurlane 2026-02-15 04:39:35.631 | ERROR | GameStuckError: Wait too long 2026-02-15 04:39:35.634 | WARNING | Saving error: ./log/error/1771101575634