═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ MAIN ═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ ════════════════════════════════════════════════════ CAMPAIGN_13_1 ════════════════════════════════════════════════════ 2026-05-15 10:42:03.700 | INFO | CAMPAIGN_13_1 2026-05-15 10:42:03.703 | INFO | Count: 0 2026-05-15 10:42:03.719 | INFO | <<< UI ENSURE >>> 2026-05-15 10:42:03.725 | INFO | UI get current page 2026-05-15 10:42:04.259 | INFO | Unknown ui page 2026-05-15 10:42:04.727 | INFO | UI additional: IDLE -> REWARD_GOTO_MAIN 2026-05-15 10:42:04.730 | INFO | Click ( 814, 632) @ REWARD_GOTO_MAIN 2026-05-15 10:42:04.905 | INFO | Unknown ui page 2026-05-15 10:42:05.045 | INFO | [Package_name] com.bilibili.azurlane 2026-05-15 10:42:05.067 | INFO | [Device Orientation] 0 (Normal) 2026-05-15 10:42:05.208 | INFO | Unknown ui page 2026-05-15 10:42:05.432 | INFO | [UI] page_main 2026-05-15 10:42:05.436 | INFO | Goto page_campaign 2026-05-15 10:42:05.439 | INFO | <<< UI GOTO PAGE_CAMPAIGN >>> 2026-05-15 10:42:05.458 | INFO | Page switch: page_main_white -> page_campaign_menu 2026-05-15 10:42:05.467 | INFO | Click (1213, 484) @ MAIN_GOTO_CAMPAIGN_WHITE 2026-05-15 10:42:06.032 | INFO | Page switch: page_campaign_menu -> page_campaign 2026-05-15 10:42:06.037 | INFO | Click ( 345, 291) @ CAMPAIGN_MENU_GOTO_CAMPAIGN 2026-05-15 10:42:06.328 | INFO | Page arrive: page_campaign 2026-05-15 10:42:06.352 | INFO | Mode_switch_1 set to hard 2026-05-15 10:42:06.378 | INFO | [Mode_switch_1] hard 2026-05-15 10:42:06.382 | INFO | <<< UI ENSURE INDEX >>> 2026-05-15 10:42:06.454 | INFO | No stage found. 2026-05-15 10:42:06.692 | INFO | No stage found. 2026-05-15 10:42:07.013 | INFO | Loading OCR model: ./bin/cnocr_models/azur_lane 2026-05-15 10:42:07.128 | INFO | [campaign 0.133s] ['I3--1', 'I3--3', '13--2', '13--4'] 2026-05-15 10:42:07.131 | INFO | [Chapter] 13 2026-05-15 10:42:07.133 | INFO | [Stage] 13-1, 13-3, 13-2, 13-4 2026-05-15 10:42:07.136 | INFO | [Index] 13 2026-05-15 10:42:07.215 | INFO | [OCR_OIL 0.052s] 18150 ──────────────────────────────────────────────────────── 13-1 ───────────────────────────────────────────────────────── 2026-05-15 10:42:07.221 | INFO | 13-1 2026-05-15 10:42:07.223 | INFO | Expect emotion reduce: (12, 2) 2026-05-15 10:42:07.238 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-05-15 10:42:07.243 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=53, Main.Emotion.Fleet1Record=datetime.datetime(2026, 5, 15, 10, 42, 7), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 5, 15, 10, 42, 7) 2026-05-15 10:42:07.261 | INFO | [Emotion fleet_1] 53 2026-05-15 10:42:07.264 | INFO | [Emotion fleet_2] 119 2026-05-15 10:42:07.267 | INFO | <<< ENTER MAP >>> 2026-05-15 10:42:07.345 | INFO | Click ( 187, 287) @ 13-1 2026-05-15 10:42:07.747 | INFO | [Map_clear_percentage] 5% 2026-05-15 10:42:08.047 | INFO | [Map_clear_percentage] 65% 2026-05-15 10:42:08.350 | INFO | [Map_clear_percentage] 99% 2026-05-15 10:42:08.376 | INFO | [MAP_CLEAR_ALL_THIS_TIME] False 2026-05-15 10:42:08.382 | INFO | [Map_info] 99%, star_1, star_2, star_3, 100_percent_clear, 3_stars, threat_safe, clear_mode 2026-05-15 10:42:08.388 | INFO | [StopCondition_MapAchievement] non_stop 2026-05-15 10:42:08.392 | INFO | Fast_Forward set to on 2026-05-15 10:42:08.396 | INFO | [Fast_Forward] on 2026-05-15 10:42:08.410 | INFO | Auto_Search set to on 2026-05-15 10:42:08.417 | INFO | [Auto_Search] on 2026-05-15 10:42:08.421 | INFO | Click ( 960, 522) @ MAP_PREPARATION 2026-05-15 10:42:08.651 | INFO | Handling 2x book setting, mode=prep. 2026-05-15 10:42:08.951 | INFO | Using fleet: [4, 3, 1] 2026-05-15 10:42:09.030 | INFO | Hard satisfied: Fleet_1: None, Fleet_2: None, Submarine: None 2026-05-15 10:42:09.040 | INFO | [map_allow_submarine] True 2026-05-15 10:42:09.046 | INFO | Click (1131, 326) @ FLEET_2_CLEAR 2026-05-15 10:42:09.100 | INFO | Click (1028, 487) @ SUBMARINE_CHOOSE 2026-05-15 10:42:09.245 | INFO | Current selected: [1] 2026-05-15 10:42:09.249 | INFO | Click (1035, 469) @ SUBMARINE_CHOOSE 2026-05-15 10:42:09.551 | INFO | Click (1059, 197) @ FLEET_1_CHOOSE 2026-05-15 10:42:09.849 | INFO | Current selected: [4] 2026-05-15 10:42:09.853 | INFO | Click (1061, 218) @ FLEET_1_CHOOSE 2026-05-15 10:42:10.149 | INFO | Click (1044, 315) @ FLEET_2_CHOOSE 2026-05-15 10:42:10.449 | INFO | Current selected: [4] 2026-05-15 10:42:10.455 | INFO | Click (1093, 476) @ FLEET_2_BAR_INDEX_3 2026-05-15 10:42:10.744 | INFO | Auto search setting 2026-05-15 10:42:10.762 | INFO | [_fleet_sidebar_offset] 0 2026-05-15 10:42:10.768 | INFO | [_fleet_sidebar_offset] 0 2026-05-15 10:42:10.772 | INFO | [Fleet_sidebar] 1/3 2026-05-15 10:42:10.781 | INFO | Click (1206, 444) @ FLEET_SIDEBAR_0_2 2026-05-15 10:42:11.045 | INFO | [_fleet_sidebar_offset] 0 2026-05-15 10:42:11.051 | INFO | [Fleet_sidebar] 3/3 2026-05-15 10:42:11.054 | INFO | [Auto_Search_Setting] fleet1_all_fleet2_standby, sub_standby 2026-05-15 10:42:11.058 | INFO | Click ( 509, 223) @ AUTO_SEARCH_SET_MOB 2026-05-15 10:42:11.586 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_standby 2026-05-15 10:42:11.590 | INFO | Selected to the correct auto search setting 2026-05-15 10:42:11.593 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_standby 2026-05-15 10:42:11.596 | INFO | Selected to the correct auto search setting 2026-05-15 10:42:11.599 | INFO | Click (1097, 587) @ FLEET_PREPARATION 2026-05-15 10:42:12.504 | INFO | is_auto_search_running appeared ────────────────────────────────────────────────────── BATTLE_0 ─────────────────────────────────────────────────────── 2026-05-15 10:42:12.509 | INFO | BATTLE_0 2026-05-15 10:42:12.512 | INFO | Auto search moving 2026-05-15 10:42:12.526 | INFO | Fleet: 1, fleet_current_index: 1 2026-05-15 10:42:12.616 | INFO | [OCR_OIL 0.082s] 18140 2026-05-15 10:42:12.718 | INFO | [OCR_COIN 0.098s] 362165 2026-05-15 10:42:17.200 | INFO | [Loading] 4% 2026-05-15 10:42:17.205 | INFO | Auto search combat loading 2026-05-15 10:42:17.210 | INFO | Screenshot interval set to 1.0s 2026-05-15 10:42:23.208 | INFO | [BattleUI] PAUSE 2026-05-15 10:42:23.212 | INFO | Auto Search combat execute 2026-05-15 10:42:23.217 | INFO | <<< EMOTION REDUCE >>> 2026-05-15 10:42:23.231 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-05-15 10:42:23.235 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=51, Main.Emotion.Fleet1Record=datetime.datetime(2026, 5, 15, 10, 42, 23), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 5, 15, 10, 42, 23) 2026-05-15 10:42:23.257 | INFO | [Emotion fleet_1] 51 2026-05-15 10:42:23.261 | INFO | [Emotion fleet_2] 119 2026-05-15 10:42:29.203 | INFO | Combat auto check timer reached 2026-05-15 10:43:06.268 | INFO | Click (1035, 668) @ GET_SHIP 2026-05-15 10:43:08.262 | INFO | Click (1017, 670) @ GET_SHIP 2026-05-15 10:43:10.257 | INFO | Click (1027, 674) @ GET_SHIP 2026-05-15 10:43:11.263 | INFO | Click (1018, 653) @ GET_SHIP 2026-05-15 10:43:13.258 | INFO | Screenshot interval set to 0.3s 2026-05-15 10:43:13.262 | INFO | Auto Search combat status 2026-05-15 10:43:13.265 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_1 ─────────────────────────────────────────────────────── 2026-05-15 10:43:13.269 | INFO | BATTLE_1 2026-05-15 10:43:13.273 | INFO | Auto search moving 2026-05-15 10:43:13.279 | INFO | Fleet: 1, fleet_current_index: 1 2026-05-15 10:43:13.367 | INFO | [OCR_OIL 0.083s] 18121 2026-05-15 10:43:13.534 | INFO | [OCR_COIN 0.161s] 362185 2026-05-15 10:43:16.336 | INFO | [Loading] 5% 2026-05-15 10:43:16.342 | INFO | Auto search combat loading 2026-05-15 10:43:16.345 | INFO | Screenshot interval set to 1.0s 2026-05-15 10:43:22.352 | INFO | [BattleUI] PAUSE 2026-05-15 10:43:22.356 | INFO | Auto Search combat execute 2026-05-15 10:43:22.358 | INFO | <<< EMOTION REDUCE >>> 2026-05-15 10:43:22.370 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-05-15 10:43:22.375 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=49, Main.Emotion.Fleet1Record=datetime.datetime(2026, 5, 15, 10, 43, 22), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 5, 15, 10, 43, 22) 2026-05-15 10:43:22.394 | INFO | [Emotion fleet_1] 49 2026-05-15 10:43:22.397 | INFO | [Emotion fleet_2] 119 2026-05-15 10:43:28.357 | INFO | Combat auto check timer reached 2026-05-15 10:43:46.375 | INFO | Screenshot interval set to 0.3s 2026-05-15 10:43:46.379 | INFO | Auto Search combat status 2026-05-15 10:43:47.864 | INFO | Click (1025, 651) @ GET_SHIP 2026-05-15 10:43:49.065 | INFO | Click (1026, 660) @ GET_SHIP 2026-05-15 10:43:50.267 | INFO | Click (1042, 653) @ GET_SHIP 2026-05-15 10:43:51.472 | INFO | Click (1030, 666) @ GET_SHIP 2026-05-15 10:43:53.259 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_2 ─────────────────────────────────────────────────────── 2026-05-15 10:43:53.265 | INFO | BATTLE_2 2026-05-15 10:43:53.268 | INFO | Auto search moving 2026-05-15 10:43:53.273 | INFO | Fleet: 1, fleet_current_index: 1 2026-05-15 10:43:53.366 | INFO | [OCR_OIL 0.088s] 18102 2026-05-15 10:43:53.532 | INFO | [OCR_COIN 0.158s] 362202 2026-05-15 10:43:57.841 | INFO | [Loading] 17% 2026-05-15 10:43:57.845 | INFO | Auto search combat loading 2026-05-15 10:43:57.849 | INFO | Screenshot interval set to 1.0s 2026-05-15 10:44:02.864 | INFO | [BattleUI] PAUSE 2026-05-15 10:44:02.869 | INFO | Auto Search combat execute 2026-05-15 10:44:02.874 | INFO | <<< EMOTION REDUCE >>> 2026-05-15 10:44:02.891 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-05-15 10:44:02.897 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=47, Main.Emotion.Fleet1Record=datetime.datetime(2026, 5, 15, 10, 44, 2), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 5, 15, 10, 44, 2) 2026-05-15 10:44:02.910 | INFO | [Emotion fleet_1] 47 2026-05-15 10:44:02.915 | INFO | [Emotion fleet_2] 119 2026-05-15 10:44:08.859 | INFO | Combat auto check timer reached 2026-05-15 10:44:36.884 | INFO | Screenshot interval set to 0.3s 2026-05-15 10:44:36.888 | INFO | Auto Search combat status 2026-05-15 10:44:37.473 | INFO | Click (1053, 674) @ GET_SHIP 2026-05-15 10:44:38.972 | INFO | Click (1021, 657) @ GET_SHIP 2026-05-15 10:44:40.177 | INFO | Click (1029, 663) @ GET_SHIP 2026-05-15 10:44:41.067 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_3 ─────────────────────────────────────────────────────── 2026-05-15 10:44:41.074 | INFO | BATTLE_3 2026-05-15 10:44:41.076 | INFO | Auto search moving 2026-05-15 10:44:41.080 | INFO | Fleet: 1, fleet_current_index: 1 2026-05-15 10:44:41.181 | INFO | [OCR_OIL 0.098s] 18083 2026-05-15 10:44:41.286 | INFO | [OCR_COIN 0.102s] 362224 2026-05-15 10:44:45.877 | INFO | [Loading] 7% 2026-05-15 10:44:45.880 | INFO | Auto search combat loading 2026-05-15 10:44:45.882 | INFO | Screenshot interval set to 1.0s 2026-05-15 10:44:51.885 | INFO | [BattleUI] PAUSE 2026-05-15 10:44:51.888 | INFO | Auto Search combat execute 2026-05-15 10:44:51.891 | INFO | <<< EMOTION REDUCE >>> 2026-05-15 10:44:51.905 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-05-15 10:44:51.912 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=45, Main.Emotion.Fleet1Record=datetime.datetime(2026, 5, 15, 10, 44, 51), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 5, 15, 10, 44, 51) 2026-05-15 10:44:51.931 | INFO | [Emotion fleet_1] 45 2026-05-15 10:44:51.936 | INFO | [Emotion fleet_2] 119 2026-05-15 10:44:57.880 | INFO | Combat auto check timer reached 2026-05-15 10:45:34.934 | INFO | Click (1041, 651) @ GET_SHIP 2026-05-15 10:45:35.934 | INFO | Click (1033, 660) @ GET_SHIP 2026-05-15 10:45:36.935 | INFO | Click (1052, 643) @ GET_SHIP 2026-05-15 10:45:37.951 | INFO | Click (1024, 669) @ GET_SHIP 2026-05-15 10:45:38.935 | INFO | Screenshot interval set to 0.3s 2026-05-15 10:45:38.940 | INFO | Auto Search combat status 2026-05-15 10:45:38.953 | INFO | Click (1033, 660) @ GET_SHIP 2026-05-15 10:45:40.114 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_4 ─────────────────────────────────────────────────────── 2026-05-15 10:45:40.119 | INFO | BATTLE_4 2026-05-15 10:45:40.123 | INFO | Auto search moving 2026-05-15 10:45:40.129 | INFO | Fleet: 1, fleet_current_index: 1 2026-05-15 10:45:40.230 | INFO | [OCR_OIL 0.096s] 18064 2026-05-15 10:45:40.329 | INFO | [OCR_COIN 0.096s] 362244 2026-05-15 10:45:44.625 | INFO | [Loading] 8% 2026-05-15 10:45:44.629 | INFO | Auto search combat loading 2026-05-15 10:45:44.632 | INFO | Screenshot interval set to 1.0s 2026-05-15 10:45:50.629 | INFO | [BattleUI] PAUSE 2026-05-15 10:45:50.633 | INFO | Auto Search combat execute 2026-05-15 10:45:50.636 | INFO | <<< EMOTION REDUCE >>> 2026-05-15 10:45:50.647 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-05-15 10:45:50.653 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=43, Main.Emotion.Fleet1Record=datetime.datetime(2026, 5, 15, 10, 45, 50), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 5, 15, 10, 45, 50) 2026-05-15 10:45:50.670 | INFO | [Emotion fleet_1] 43 2026-05-15 10:45:50.674 | INFO | [Emotion fleet_2] 119 2026-05-15 10:45:55.639 | INFO | Combat auto check timer reached 2026-05-15 10:46:49.699 | INFO | Screenshot interval set to 0.3s 2026-05-15 10:46:49.703 | INFO | Auto Search combat status 2026-05-15 10:46:50.877 | INFO | Click (1023, 654) @ GET_SHIP 2026-05-15 10:46:52.083 | INFO | Click (1039, 665) @ GET_SHIP 2026-05-15 10:46:53.296 | INFO | Click (1028, 644) @ GET_SHIP 2026-05-15 10:46:54.478 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_5 ─────────────────────────────────────────────────────── 2026-05-15 10:46:54.483 | INFO | BATTLE_5 2026-05-15 10:46:54.485 | INFO | Auto search moving 2026-05-15 10:46:54.488 | INFO | Fleet: 1, fleet_current_index: 1 2026-05-15 10:46:54.574 | INFO | [OCR_OIL 0.084s] 18045 2026-05-15 10:46:54.667 | INFO | [OCR_COIN 0.088s] 362262 2026-05-15 10:46:56.591 | INFO | [Loading] 7% 2026-05-15 10:46:56.596 | INFO | Auto search combat loading 2026-05-15 10:46:56.599 | INFO | Screenshot interval set to 1.0s 2026-05-15 10:47:02.591 | INFO | [BattleUI] PAUSE 2026-05-15 10:47:02.596 | INFO | Auto Search combat execute 2026-05-15 10:47:02.600 | INFO | <<< EMOTION REDUCE >>> 2026-05-15 10:47:02.612 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-05-15 10:47:02.619 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=41, Main.Emotion.Fleet1Record=datetime.datetime(2026, 5, 15, 10, 47, 2), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 5, 15, 10, 47, 2) 2026-05-15 10:47:02.641 | INFO | [Emotion fleet_1] 41 2026-05-15 10:47:02.645 | INFO | [Emotion fleet_2] 119 2026-05-15 10:47:08.602 | INFO | Combat auto check timer reached 2026-05-15 10:48:06.659 | INFO | Click (1024, 656) @ GET_SHIP 2026-05-15 10:51:06.821 | 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 L1543 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-05-15 10:51:06.848 | WARNING | Wait too long 2026-05-15 10:51:06.854 | WARNING | Waiting for {'NEW_SHIP', 'CAMPAIGN_CHECK', 'POPUP_CANCEL', 'GUILD_POPUP_CONFIRM', 'EXP_INFO_S', 'SP_CHECK', 'MISSION_POPUP_GO', 'GET_SHIP', 'BATTLE_STATUS_S', 'POPUP_CONFIRM_WHITE', 'PAUSE', 'BATTLE_STATUS_A', 'AUTO_SEARCH_MAP_OPTION_ON', 'BATTLE_STATUS_B', 'EXP_INFO_B', 'GET_MISSION', 'EXP_INFO_A', 'EVENT_CHECK'} 2026-05-15 10:51:06.924 | INFO | [Package_name] com.bilibili.azurlane 2026-05-15 10:51:06.928 | ERROR | GameStuckError: Wait too long 2026-05-15 10:51:06.931 | WARNING | Saving error: ./log/error/1778813466931