═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ MAIN ═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ ════════════════════════════════════════════════════ CAMPAIGN_13_1 ════════════════════════════════════════════════════ 2026-03-25 13:42:01.312 | INFO | CAMPAIGN_13_1 2026-03-25 13:42:01.316 | INFO | Count: 0 2026-03-25 13:42:01.338 | INFO | <<< UI ENSURE >>> 2026-03-25 13:42:01.341 | INFO | UI get current page 2026-03-25 13:42:01.888 | INFO | Unknown ui page 2026-03-25 13:42:02.351 | INFO | UI additional: IDLE -> REWARD_GOTO_MAIN 2026-03-25 13:42:02.355 | INFO | Click ( 825, 624) @ REWARD_GOTO_MAIN 2026-03-25 13:42:02.527 | INFO | Unknown ui page 2026-03-25 13:42:02.664 | INFO | [Package_name] com.bilibili.azurlane 2026-03-25 13:42:02.684 | INFO | [Device Orientation] 0 (Normal) 2026-03-25 13:42:02.835 | INFO | Unknown ui page 2026-03-25 13:42:03.127 | INFO | Unknown ui page 2026-03-25 13:42:03.352 | INFO | [UI] page_main 2026-03-25 13:42:03.357 | INFO | Goto page_campaign 2026-03-25 13:42:03.360 | INFO | <<< UI GOTO PAGE_CAMPAIGN >>> 2026-03-25 13:42:03.379 | INFO | Page switch: page_main_white -> page_campaign_menu 2026-03-25 13:42:03.384 | INFO | Click (1177, 527) @ MAIN_GOTO_CAMPAIGN_WHITE 2026-03-25 13:42:03.957 | INFO | Page switch: page_campaign_menu -> page_campaign 2026-03-25 13:42:03.960 | INFO | Click ( 347, 357) @ CAMPAIGN_MENU_GOTO_CAMPAIGN 2026-03-25 13:42:04.253 | INFO | Page arrive: page_campaign 2026-03-25 13:42:04.280 | INFO | Mode_switch_1 set to hard 2026-03-25 13:42:04.306 | INFO | [Mode_switch_1] hard 2026-03-25 13:42:04.309 | INFO | <<< UI ENSURE INDEX >>> 2026-03-25 13:42:04.381 | INFO | No stage found. 2026-03-25 13:42:04.618 | INFO | No stage found. 2026-03-25 13:42:04.938 | INFO | Loading OCR model: ./bin/cnocr_models/azur_lane 2026-03-25 13:42:05.053 | INFO | [campaign 0.133s] ['13--1', '13--3', '13--2', '13--4'] 2026-03-25 13:42:05.057 | INFO | [Chapter] 13 2026-03-25 13:42:05.060 | INFO | [Stage] 13-1, 13-3, 13-2, 13-4 2026-03-25 13:42:05.062 | INFO | [Index] 13 2026-03-25 13:42:05.142 | INFO | [OCR_OIL 0.051s] 17760 ──────────────────────────────────────────────────────── 13-1 ───────────────────────────────────────────────────────── 2026-03-25 13:42:05.149 | INFO | 13-1 2026-03-25 13:42:05.151 | INFO | Expect emotion reduce: (12, 2) 2026-03-25 13:42:05.161 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-03-25 13:42:05.165 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=53, Main.Emotion.Fleet1Record=datetime.datetime(2026, 3, 25, 13, 42, 5), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 3, 25, 13, 42, 5) 2026-03-25 13:42:05.180 | INFO | [Emotion fleet_1] 53 2026-03-25 13:42:05.184 | INFO | [Emotion fleet_2] 119 2026-03-25 13:42:05.188 | INFO | <<< ENTER MAP >>> 2026-03-25 13:42:05.265 | INFO | Click ( 184, 282) @ 13-1 2026-03-25 13:42:05.670 | INFO | [Map_clear_percentage] 5% 2026-03-25 13:42:05.970 | INFO | [Map_clear_percentage] 66% 2026-03-25 13:42:06.275 | INFO | [Map_clear_percentage] 99% 2026-03-25 13:42:06.302 | INFO | [MAP_CLEAR_ALL_THIS_TIME] False 2026-03-25 13:42:06.309 | INFO | [Map_info] 99%, star_1, star_2, star_3, 100_percent_clear, 3_stars, threat_safe, clear_mode 2026-03-25 13:42:06.313 | INFO | [StopCondition_MapAchievement] non_stop 2026-03-25 13:42:06.316 | INFO | Fast_Forward set to on 2026-03-25 13:42:06.319 | INFO | [Fast_Forward] on 2026-03-25 13:42:06.333 | INFO | Auto_Search set to on 2026-03-25 13:42:06.339 | INFO | [Auto_Search] on 2026-03-25 13:42:06.344 | INFO | Click ( 960, 503) @ MAP_PREPARATION 2026-03-25 13:42:06.575 | INFO | Handling 2x book setting, mode=prep. 2026-03-25 13:42:06.875 | INFO | Using fleet: [4, 3, 1] 2026-03-25 13:42:06.951 | INFO | Hard satisfied: Fleet_1: None, Fleet_2: None, Submarine: None 2026-03-25 13:42:06.960 | INFO | [map_allow_submarine] True 2026-03-25 13:42:06.965 | INFO | Click (1134, 328) @ FLEET_2_CLEAR 2026-03-25 13:42:07.019 | INFO | Click (1048, 463) @ SUBMARINE_CHOOSE 2026-03-25 13:42:07.165 | INFO | Current selected: [1] 2026-03-25 13:42:07.168 | INFO | Click (1042, 484) @ SUBMARINE_CHOOSE 2026-03-25 13:42:07.468 | INFO | Click (1052, 222) @ FLEET_1_CHOOSE 2026-03-25 13:42:07.764 | INFO | Current selected: [4] 2026-03-25 13:42:07.768 | INFO | Click (1065, 220) @ FLEET_1_CHOOSE 2026-03-25 13:42:08.063 | INFO | Click (1056, 347) @ FLEET_2_CHOOSE 2026-03-25 13:42:08.369 | INFO | Current selected: [4] 2026-03-25 13:42:08.373 | INFO | Click (1071, 475) @ FLEET_2_BAR_INDEX_3 2026-03-25 13:42:08.673 | INFO | Auto search setting 2026-03-25 13:42:08.691 | INFO | [_fleet_sidebar_offset] 0 2026-03-25 13:42:08.699 | INFO | [_fleet_sidebar_offset] 0 2026-03-25 13:42:08.707 | INFO | [Fleet_sidebar] 1/3 2026-03-25 13:42:08.711 | INFO | Click (1224, 428) @ FLEET_SIDEBAR_0_2 2026-03-25 13:42:08.975 | INFO | [_fleet_sidebar_offset] 0 2026-03-25 13:42:08.979 | INFO | [Fleet_sidebar] 3/3 2026-03-25 13:42:08.982 | INFO | [Auto_Search_Setting] fleet1_all_fleet2_standby, sub_standby 2026-03-25 13:42:08.985 | INFO | Click ( 503, 218) @ AUTO_SEARCH_SET_MOB 2026-03-25 13:42:09.454 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_standby 2026-03-25 13:42:09.458 | INFO | Selected to the correct auto search setting 2026-03-25 13:42:09.463 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_standby 2026-03-25 13:42:09.466 | INFO | Selected to the correct auto search setting 2026-03-25 13:42:09.469 | INFO | Click (1057, 564) @ FLEET_PREPARATION 2026-03-25 13:42:10.378 | INFO | is_auto_search_running appeared ────────────────────────────────────────────────────── BATTLE_0 ─────────────────────────────────────────────────────── 2026-03-25 13:42:10.384 | INFO | BATTLE_0 2026-03-25 13:42:10.387 | INFO | Auto search moving 2026-03-25 13:42:10.400 | INFO | Fleet: 1, fleet_current_index: 1 2026-03-25 13:42:10.463 | INFO | [OCR_OIL 0.060s] 17750 2026-03-25 13:42:10.538 | INFO | [OCR_COIN 0.070s] 262800 2026-03-25 13:42:15.022 | INFO | [Loading] 20% 2026-03-25 13:42:15.025 | INFO | Auto search combat loading 2026-03-25 13:42:15.028 | INFO | Screenshot interval set to 1.0s 2026-03-25 13:42:20.025 | INFO | [BattleUI] PAUSE 2026-03-25 13:42:20.028 | INFO | Auto Search combat execute 2026-03-25 13:42:20.031 | INFO | <<< EMOTION REDUCE >>> 2026-03-25 13:42:20.042 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-03-25 13:42:20.046 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=51, Main.Emotion.Fleet1Record=datetime.datetime(2026, 3, 25, 13, 42, 20), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 3, 25, 13, 42, 20) 2026-03-25 13:42:20.059 | INFO | [Emotion fleet_1] 51 2026-03-25 13:42:20.063 | INFO | [Emotion fleet_2] 119 2026-03-25 13:42:26.026 | INFO | Combat auto check timer reached 2026-03-25 13:42:47.076 | INFO | Click (1031, 660) @ GET_SHIP 2026-03-25 13:42:48.065 | INFO | Screenshot interval set to 0.3s 2026-03-25 13:42:48.069 | INFO | Auto Search combat status 2026-03-25 13:42:48.081 | INFO | Click (1032, 663) @ GET_SHIP 2026-03-25 13:42:49.284 | INFO | Click (1038, 659) @ GET_SHIP 2026-03-25 13:42:50.144 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_1 ─────────────────────────────────────────────────────── 2026-03-25 13:42:50.151 | INFO | BATTLE_1 2026-03-25 13:42:50.154 | INFO | Auto search moving 2026-03-25 13:42:50.157 | INFO | Fleet: 1, fleet_current_index: 1 2026-03-25 13:42:50.238 | INFO | [OCR_OIL 0.078s] 17731 2026-03-25 13:42:50.323 | INFO | [OCR_COIN 0.082s] 262824 2026-03-25 13:42:54.356 | INFO | [Loading] 19% 2026-03-25 13:42:54.361 | INFO | Auto search combat loading 2026-03-25 13:42:54.365 | INFO | Screenshot interval set to 1.0s 2026-03-25 13:42:59.367 | INFO | [BattleUI] PAUSE 2026-03-25 13:42:59.372 | INFO | Auto Search combat execute 2026-03-25 13:42:59.376 | INFO | <<< EMOTION REDUCE >>> 2026-03-25 13:42:59.392 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-03-25 13:42:59.401 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=49, Main.Emotion.Fleet1Record=datetime.datetime(2026, 3, 25, 13, 42, 59), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 3, 25, 13, 42, 59) 2026-03-25 13:42:59.421 | INFO | [Emotion fleet_1] 49 2026-03-25 13:42:59.429 | INFO | [Emotion fleet_2] 119 2026-03-25 13:43:05.372 | INFO | Combat auto check timer reached 2026-03-25 13:43:44.415 | INFO | Click (1018, 652) @ GET_SHIP 2026-03-25 13:43:46.416 | INFO | Click (1023, 656) @ GET_SHIP 2026-03-25 13:43:47.423 | INFO | Click (1013, 662) @ GET_SHIP 2026-03-25 13:43:48.412 | INFO | Screenshot interval set to 0.3s 2026-03-25 13:43:48.416 | INFO | Auto Search combat status 2026-03-25 13:43:48.431 | INFO | Click (1015, 669) @ GET_SHIP 2026-03-25 13:43:49.621 | INFO | Click (1027, 648) @ GET_SHIP 2026-03-25 13:43:50.800 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_2 ─────────────────────────────────────────────────────── 2026-03-25 13:43:50.805 | INFO | BATTLE_2 2026-03-25 13:43:50.809 | INFO | Auto search moving 2026-03-25 13:43:50.816 | INFO | Fleet: 1, fleet_current_index: 1 2026-03-25 13:43:50.890 | INFO | [OCR_OIL 0.070s] 17712 2026-03-25 13:43:50.998 | INFO | [OCR_COIN 0.104s] 262843 2026-03-25 13:43:55.609 | INFO | [Loading] 11% 2026-03-25 13:43:55.612 | INFO | Auto search combat loading 2026-03-25 13:43:55.615 | INFO | Screenshot interval set to 1.0s 2026-03-25 13:44:01.632 | INFO | [BattleUI] PAUSE 2026-03-25 13:44:01.637 | INFO | Auto Search combat execute 2026-03-25 13:44:01.640 | INFO | <<< EMOTION REDUCE >>> 2026-03-25 13:44:01.652 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-03-25 13:44:01.660 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=47, Main.Emotion.Fleet1Record=datetime.datetime(2026, 3, 25, 13, 44, 1), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 3, 25, 13, 44, 1) 2026-03-25 13:44:01.674 | INFO | [Emotion fleet_1] 47 2026-03-25 13:44:01.677 | INFO | [Emotion fleet_2] 119 2026-03-25 13:44:07.630 | INFO | Combat auto check timer reached 2026-03-25 13:44:36.657 | INFO | Click (1017, 659) @ GET_SHIP 2026-03-25 13:44:37.661 | INFO | Click (1011, 659) @ GET_SHIP 2026-03-25 13:44:39.682 | INFO | Click (1025, 636) @ GET_SHIP 2026-03-25 13:44:40.663 | INFO | Screenshot interval set to 0.3s 2026-03-25 13:44:40.667 | INFO | Auto Search combat status 2026-03-25 13:44:40.682 | INFO | Click (1026, 672) @ GET_SHIP 2026-03-25 13:44:41.868 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_3 ─────────────────────────────────────────────────────── 2026-03-25 13:44:41.880 | INFO | BATTLE_3 2026-03-25 13:44:41.886 | INFO | Auto search moving 2026-03-25 13:44:41.893 | INFO | Fleet: 1, fleet_current_index: 1 2026-03-25 13:44:42.012 | INFO | [OCR_OIL 0.110s] 17693 2026-03-25 13:44:42.130 | INFO | [OCR_COIN 0.114s] 262859 2026-03-25 13:44:46.716 | INFO | [Loading] 6% 2026-03-25 13:44:46.720 | INFO | Auto search combat loading 2026-03-25 13:44:46.722 | INFO | Screenshot interval set to 1.0s 2026-03-25 13:44:52.729 | INFO | [BattleUI] PAUSE 2026-03-25 13:44:52.733 | INFO | Auto Search combat execute 2026-03-25 13:44:52.735 | INFO | <<< EMOTION REDUCE >>> 2026-03-25 13:44:52.751 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-03-25 13:44:52.757 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=45, Main.Emotion.Fleet1Record=datetime.datetime(2026, 3, 25, 13, 44, 52), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 3, 25, 13, 44, 52) 2026-03-25 13:44:52.770 | INFO | [Emotion fleet_1] 45 2026-03-25 13:44:52.776 | INFO | [Emotion fleet_2] 119 2026-03-25 13:44:58.719 | INFO | Combat auto check timer reached 2026-03-25 13:45:35.771 | INFO | Click (1027, 645) @ GET_SHIP 2026-03-25 13:45:37.776 | INFO | Click (1035, 657) @ GET_SHIP 2026-03-25 13:45:38.784 | INFO | Click (1036, 647) @ GET_SHIP 2026-03-25 13:45:40.779 | INFO | Click (1022, 650) @ GET_SHIP 2026-03-25 13:45:42.773 | INFO | Screenshot interval set to 0.3s 2026-03-25 13:45:42.778 | INFO | Auto Search combat status 2026-03-25 13:45:42.780 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_4 ─────────────────────────────────────────────────────── 2026-03-25 13:45:42.784 | INFO | BATTLE_4 2026-03-25 13:45:42.786 | INFO | Auto search moving 2026-03-25 13:45:42.791 | INFO | Fleet: 1, fleet_current_index: 1 2026-03-25 13:45:42.876 | INFO | [OCR_OIL 0.080s] 17674 2026-03-25 13:45:42.951 | INFO | [OCR_COIN 0.071s] 262873 2026-03-25 13:45:46.367 | INFO | [Loading] 8% 2026-03-25 13:45:46.371 | INFO | Auto search combat loading 2026-03-25 13:45:46.375 | INFO | Screenshot interval set to 1.0s 2026-03-25 13:45:52.372 | INFO | [BattleUI] PAUSE 2026-03-25 13:45:52.378 | INFO | Auto Search combat execute 2026-03-25 13:45:52.382 | INFO | <<< EMOTION REDUCE >>> 2026-03-25 13:45:52.397 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-03-25 13:45:52.403 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=43, Main.Emotion.Fleet1Record=datetime.datetime(2026, 3, 25, 13, 45, 52), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 3, 25, 13, 45, 52) 2026-03-25 13:45:52.423 | INFO | [Emotion fleet_1] 43 2026-03-25 13:45:52.426 | INFO | [Emotion fleet_2] 119 2026-03-25 13:45:58.380 | INFO | Combat auto check timer reached 2026-03-25 13:46:34.418 | INFO | Screenshot interval set to 0.3s 2026-03-25 13:46:34.421 | INFO | Auto Search combat status 2026-03-25 13:46:35.909 | INFO | Click (1022, 671) @ GET_SHIP 2026-03-25 13:46:37.111 | INFO | Click (1032, 676) @ GET_SHIP 2026-03-25 13:46:38.326 | INFO | Click (1044, 646) @ GET_SHIP 2026-03-25 13:46:39.515 | INFO | Click (1040, 661) @ GET_SHIP 2026-03-25 13:46:41.302 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_5 ─────────────────────────────────────────────────────── 2026-03-25 13:46:41.307 | INFO | BATTLE_5 2026-03-25 13:46:41.309 | INFO | Auto search moving 2026-03-25 13:46:41.312 | INFO | Fleet: 1, fleet_current_index: 1 2026-03-25 13:46:41.378 | INFO | [OCR_OIL 0.059s] 17655 2026-03-25 13:46:41.466 | INFO | [OCR_COIN 0.085s] 262902 2026-03-25 13:46:43.721 | INFO | [Loading] 7% 2026-03-25 13:46:43.725 | INFO | Auto search combat loading 2026-03-25 13:46:43.728 | INFO | Screenshot interval set to 1.0s 2026-03-25 13:46:49.756 | INFO | [BattleUI] PAUSE 2026-03-25 13:46:49.763 | INFO | Auto Search combat execute 2026-03-25 13:46:49.768 | INFO | <<< EMOTION REDUCE >>> 2026-03-25 13:46:49.796 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-03-25 13:46:49.801 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=41, Main.Emotion.Fleet1Record=datetime.datetime(2026, 3, 25, 13, 46, 49), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 3, 25, 13, 46, 49) 2026-03-25 13:46:49.824 | INFO | [Emotion fleet_1] 41 2026-03-25 13:46:49.831 | INFO | [Emotion fleet_2] 119 2026-03-25 13:46:55.734 | INFO | Combat auto check timer reached 2026-03-25 13:47:43.780 | INFO | Click (1016, 656) @ GET_SHIP 2026-03-25 13:50:43.931 | 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-25 13:50:43.957 | WARNING | Wait too long 2026-03-25 13:50:43.960 | 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-25 13:50:44.023 | INFO | [Package_name] com.bilibili.azurlane 2026-03-25 13:50:44.028 | ERROR | GameStuckError: Wait too long 2026-03-25 13:50:44.034 | WARNING | Saving error: ./log/error/1774417844034