═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ MAIN ═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ ════════════════════════════════════════════════════ CAMPAIGN_13_1 ════════════════════════════════════════════════════ 2026-09-15 04:30:46.258 | INFO | CAMPAIGN_13_1 2026-09-15 04:30:46.261 | INFO | Count: 0 2026-09-15 04:30:46.278 | INFO | <<< UI ENSURE >>> 2026-09-15 04:30:46.282 | INFO | UI get current page 2026-09-15 04:30:46.296 | INFO | [UI] page_main 2026-09-15 04:30:46.299 | INFO | Goto page_campaign 2026-09-15 04:30:46.303 | INFO | <<< UI GOTO PAGE_CAMPAIGN >>> 2026-09-15 04:30:46.321 | INFO | Page switch: page_main_white -> page_campaign_menu 2026-09-15 04:30:46.324 | INFO | Click (1202, 511) @ MAIN_GOTO_CAMPAIGN_WHITE 2026-09-15 04:30:46.851 | INFO | Page switch: page_campaign_menu -> page_campaign 2026-09-15 04:30:46.855 | INFO | Click ( 342, 300) @ CAMPAIGN_MENU_GOTO_CAMPAIGN 2026-09-15 04:30:47.148 | INFO | Page arrive: page_campaign 2026-09-15 04:30:47.175 | INFO | Mode_switch_1 set to hard 2026-09-15 04:30:47.202 | INFO | [Mode_switch_1] hard 2026-09-15 04:30:47.205 | INFO | <<< UI ENSURE INDEX >>> 2026-09-15 04:30:47.291 | INFO | No stage found. 2026-09-15 04:30:47.509 | INFO | No stage found. 2026-09-15 04:30:47.869 | INFO | [campaign 0.052s] ['13--1', '13--3', '13--2', '13--4'] 2026-09-15 04:30:47.872 | INFO | [Chapter] 13 2026-09-15 04:30:47.875 | INFO | [Stage] 13-1, 13-3, 13-2, 13-4 2026-09-15 04:30:47.879 | INFO | [Index] 13 2026-09-15 04:30:47.950 | INFO | [OCR_OIL 0.042s] 22941 ──────────────────────────────────────────────────────── 13-1 ───────────────────────────────────────────────────────── 2026-09-15 04:30:47.954 | INFO | 13-1 2026-09-15 04:30:47.957 | INFO | Expect emotion reduce: (12, 2) 2026-09-15 04:30:47.969 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-09-15 04:30:47.972 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=53, Main.Emotion.Fleet1Record=datetime.datetime(2026, 9, 15, 4, 30, 47), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 9, 15, 4, 30, 47) 2026-09-15 04:30:47.988 | INFO | [Emotion fleet_1] 53 2026-09-15 04:30:47.991 | INFO | [Emotion fleet_2] 119 2026-09-15 04:30:47.993 | INFO | <<< ENTER MAP >>> 2026-09-15 04:30:48.048 | INFO | Click ( 187, 270) @ 13-1 2026-09-15 04:30:48.450 | INFO | [Map_clear_percentage] 6% 2026-09-15 04:30:48.752 | INFO | [Map_clear_percentage] 66% 2026-09-15 04:30:49.058 | INFO | [Map_clear_percentage] 99% 2026-09-15 04:30:49.090 | INFO | [MAP_CLEAR_ALL_THIS_TIME] False 2026-09-15 04:30:49.093 | INFO | [Map_info] 99%, star_1, star_2, star_3, 100_percent_clear, 3_stars, threat_safe, clear_mode 2026-09-15 04:30:49.097 | INFO | [StopCondition_MapAchievement] non_stop 2026-09-15 04:30:49.100 | INFO | Clear_Mode set to on 2026-09-15 04:30:49.103 | INFO | [Clear_Mode] on 2026-09-15 04:30:49.117 | INFO | Auto_Search set to on 2026-09-15 04:30:49.123 | INFO | [Auto_Search] on 2026-09-15 04:30:49.125 | INFO | Click (1039, 512) @ MAP_PREPARATION 2026-09-15 04:30:49.354 | INFO | Handling 2x book setting, mode=prep. 2026-09-15 04:30:49.658 | INFO | Using fleet: [4, 3, 1] 2026-09-15 04:30:49.739 | INFO | Hard satisfied: Fleet_1: None, Fleet_2: None, Submarine: None 2026-09-15 04:30:49.749 | INFO | [map_allow_submarine] True 2026-09-15 04:30:49.753 | INFO | Click (1138, 328) @ FLEET_2_CLEAR 2026-09-15 04:30:49.807 | INFO | Click (1046, 479) @ SUBMARINE_CHOOSE 2026-09-15 04:30:49.950 | INFO | Current selected: [1] 2026-09-15 04:30:49.954 | INFO | Click (1055, 481) @ SUBMARINE_CHOOSE 2026-09-15 04:30:50.252 | INFO | Click (1052, 221) @ FLEET_1_CHOOSE 2026-09-15 04:30:50.549 | INFO | Current selected: [4] 2026-09-15 04:30:50.555 | INFO | Click (1054, 201) @ FLEET_1_CHOOSE 2026-09-15 04:30:50.847 | INFO | Click (1072, 356) @ FLEET_2_CHOOSE 2026-09-15 04:30:51.150 | INFO | Current selected: [4] 2026-09-15 04:30:51.156 | INFO | Click (1088, 477) @ FLEET_2_BAR_INDEX_3 2026-09-15 04:30:51.448 | INFO | Auto search setting 2026-09-15 04:30:51.467 | INFO | [_fleet_sidebar_offset] 0 2026-09-15 04:30:51.472 | INFO | [_fleet_sidebar_offset] 0 2026-09-15 04:30:51.476 | INFO | [Fleet_sidebar] 1/3 2026-09-15 04:30:51.483 | INFO | Click (1204, 439) @ FLEET_SIDEBAR_0_2 2026-09-15 04:30:51.757 | INFO | [_fleet_sidebar_offset] 0 2026-09-15 04:30:51.763 | INFO | [Fleet_sidebar] 3/3 2026-09-15 04:30:51.768 | INFO | [Auto_Search_Setting] fleet1_all_fleet2_standby, sub_standby 2026-09-15 04:30:51.773 | INFO | Click ( 507, 218) @ AUTO_SEARCH_SET_MOB 2026-09-15 04:30:52.264 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_standby 2026-09-15 04:30:52.268 | INFO | Selected to the correct auto search setting 2026-09-15 04:30:52.272 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_standby 2026-09-15 04:30:52.274 | INFO | Selected to the correct auto search setting 2026-09-15 04:30:52.277 | INFO | Click (1077, 583) @ FLEET_PREPARATION 2026-09-15 04:30:53.178 | INFO | is_auto_search_running appeared ────────────────────────────────────────────────────── BATTLE_0 ─────────────────────────────────────────────────────── 2026-09-15 04:30:53.185 | INFO | BATTLE_0 2026-09-15 04:30:53.188 | INFO | Auto search moving 2026-09-15 04:30:53.201 | INFO | Fleet: 1, fleet_current_index: 1 2026-09-15 04:30:53.256 | INFO | [OCR_OIL 0.051s] 22931 2026-09-15 04:30:53.338 | INFO | [OCR_COIN 0.078s] 15158 2026-09-15 04:30:58.168 | INFO | [Loading] 4% 2026-09-15 04:30:58.174 | INFO | Auto search combat loading 2026-09-15 04:30:58.177 | INFO | Screenshot interval set to 1.0s 2026-09-15 04:31:04.171 | INFO | [BattleUI] PAUSE 2026-09-15 04:31:04.174 | INFO | Auto Search combat execute 2026-09-15 04:31:04.176 | INFO | <<< EMOTION REDUCE >>> 2026-09-15 04:31:04.187 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-09-15 04:31:04.191 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=51, Main.Emotion.Fleet1Record=datetime.datetime(2026, 9, 15, 4, 31, 4), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 9, 15, 4, 31, 4) 2026-09-15 04:31:04.207 | INFO | [Emotion fleet_1] 51 2026-09-15 04:31:04.210 | INFO | [Emotion fleet_2] 119 2026-09-15 04:31:09.180 | INFO | Combat auto check timer reached 2026-09-15 04:31:47.223 | INFO | Click (1029, 679) @ GET_SHIP 2026-09-15 04:31:48.226 | INFO | Click (1022, 677) @ GET_SHIP 2026-09-15 04:31:49.228 | INFO | Click (1013, 668) @ GET_SHIP 2026-09-15 04:31:50.228 | INFO | Screenshot interval set to 0.3s 2026-09-15 04:31:50.232 | INFO | Auto Search combat status 2026-09-15 04:31:50.235 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_1 ─────────────────────────────────────────────────────── 2026-09-15 04:31:50.239 | INFO | BATTLE_1 2026-09-15 04:31:50.241 | INFO | Auto search moving 2026-09-15 04:31:50.244 | INFO | Fleet: 1, fleet_current_index: 1 2026-09-15 04:31:50.296 | INFO | [OCR_OIL 0.049s] 22912 2026-09-15 04:31:50.367 | INFO | [OCR_COIN 0.067s] 15174 2026-09-15 04:31:55.616 | INFO | [Loading] 18% 2026-09-15 04:31:55.619 | INFO | Auto search combat loading 2026-09-15 04:31:55.621 | INFO | Screenshot interval set to 1.0s 2026-09-15 04:32:00.633 | INFO | [BattleUI] PAUSE 2026-09-15 04:32:00.638 | INFO | Auto Search combat execute 2026-09-15 04:32:00.642 | INFO | <<< EMOTION REDUCE >>> 2026-09-15 04:32:00.655 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-09-15 04:32:00.658 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=49, Main.Emotion.Fleet1Record=datetime.datetime(2026, 9, 15, 4, 32), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 9, 15, 4, 32) 2026-09-15 04:32:00.673 | INFO | [Emotion fleet_1] 49 2026-09-15 04:32:00.676 | INFO | [Emotion fleet_2] 119 2026-09-15 04:32:06.617 | INFO | Combat auto check timer reached 2026-09-15 04:32:25.653 | INFO | Screenshot interval set to 0.3s 2026-09-15 04:32:25.656 | INFO | Auto Search combat status 2026-09-15 04:32:27.147 | INFO | Click (1044, 655) @ GET_SHIP 2026-09-15 04:32:28.648 | INFO | Click (1027, 646) @ GET_SHIP 2026-09-15 04:32:29.859 | INFO | Click (1026, 665) @ GET_SHIP 2026-09-15 04:32:31.040 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_2 ─────────────────────────────────────────────────────── 2026-09-15 04:32:31.046 | INFO | BATTLE_2 2026-09-15 04:32:31.048 | INFO | Auto search moving 2026-09-15 04:32:31.052 | INFO | Fleet: 1, fleet_current_index: 1 2026-09-15 04:32:31.111 | INFO | [OCR_OIL 0.054s] 22893 2026-09-15 04:32:31.189 | INFO | [OCR_COIN 0.073s] 15184 2026-09-15 04:32:35.555 | INFO | [Loading] 13% 2026-09-15 04:32:35.559 | INFO | Auto search combat loading 2026-09-15 04:32:35.561 | INFO | Screenshot interval set to 1.0s 2026-09-15 04:32:41.585 | INFO | [BattleUI] PAUSE 2026-09-15 04:32:41.589 | INFO | Auto Search combat execute 2026-09-15 04:32:41.591 | INFO | <<< EMOTION REDUCE >>> 2026-09-15 04:32:41.604 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-09-15 04:32:41.607 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=47, Main.Emotion.Fleet1Record=datetime.datetime(2026, 9, 15, 4, 32, 41), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 9, 15, 4, 32, 41) 2026-09-15 04:32:41.624 | INFO | [Emotion fleet_1] 47 2026-09-15 04:32:41.627 | INFO | [Emotion fleet_2] 119 2026-09-15 04:32:47.557 | INFO | Combat auto check timer reached 2026-09-15 04:33:22.611 | INFO | Screenshot interval set to 0.3s 2026-09-15 04:33:22.615 | INFO | Auto Search combat status 2026-09-15 04:33:23.797 | INFO | Click (1036, 671) @ GET_SHIP 2026-09-15 04:33:24.997 | INFO | Click (1016, 646) @ GET_SHIP 2026-09-15 04:33:26.197 | INFO | Click (1014, 662) @ GET_SHIP 2026-09-15 04:33:27.391 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_3 ─────────────────────────────────────────────────────── 2026-09-15 04:33:27.405 | INFO | BATTLE_3 2026-09-15 04:33:27.414 | INFO | Auto search moving 2026-09-15 04:33:27.427 | INFO | Fleet: 1, fleet_current_index: 1 2026-09-15 04:33:27.563 | INFO | [OCR_OIL 0.120s] 22874 2026-09-15 04:33:27.654 | INFO | [OCR_COIN 0.088s] 15199 2026-09-15 04:33:32.843 | INFO | [Loading] 14% 2026-09-15 04:33:32.847 | INFO | Auto search combat loading 2026-09-15 04:33:32.849 | INFO | Screenshot interval set to 1.0s 2026-09-15 04:33:38.853 | INFO | [BattleUI] PAUSE 2026-09-15 04:33:38.857 | INFO | Auto Search combat execute 2026-09-15 04:33:38.860 | INFO | <<< EMOTION REDUCE >>> 2026-09-15 04:33:38.876 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-09-15 04:33:38.880 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=45, Main.Emotion.Fleet1Record=datetime.datetime(2026, 9, 15, 4, 33, 38), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 9, 15, 4, 33, 38) 2026-09-15 04:33:38.895 | INFO | [Emotion fleet_1] 45 2026-09-15 04:33:38.901 | INFO | [Emotion fleet_2] 119 2026-09-15 04:33:44.849 | INFO | Combat auto check timer reached 2026-09-15 04:34:08.896 | INFO | Screenshot interval set to 0.3s 2026-09-15 04:34:08.901 | INFO | Auto Search combat status 2026-09-15 04:34:10.079 | INFO | Click (1020, 673) @ GET_SHIP 2026-09-15 04:34:11.285 | INFO | Click (1041, 661) @ GET_SHIP 2026-09-15 04:34:12.489 | INFO | Click (1021, 672) @ GET_SHIP 2026-09-15 04:34:13.974 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_4 ─────────────────────────────────────────────────────── 2026-09-15 04:34:13.982 | INFO | BATTLE_4 2026-09-15 04:34:13.985 | INFO | Auto search moving 2026-09-15 04:34:13.991 | INFO | Fleet: 1, fleet_current_index: 1 2026-09-15 04:34:14.079 | INFO | [OCR_OIL 0.083s] 22855 2026-09-15 04:34:14.162 | INFO | [OCR_COIN 0.080s] 15209 2026-09-15 04:34:18.484 | INFO | [Loading] 6% 2026-09-15 04:34:18.487 | INFO | Auto search combat loading 2026-09-15 04:34:18.491 | INFO | Screenshot interval set to 1.0s 2026-09-15 04:34:24.492 | INFO | [BattleUI] PAUSE 2026-09-15 04:34:24.496 | INFO | Auto Search combat execute 2026-09-15 04:34:24.499 | INFO | <<< EMOTION REDUCE >>> 2026-09-15 04:34:24.510 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-09-15 04:34:24.516 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=43, Main.Emotion.Fleet1Record=datetime.datetime(2026, 9, 15, 4, 34, 24), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 9, 15, 4, 34, 24) 2026-09-15 04:34:24.533 | INFO | [Emotion fleet_1] 43 2026-09-15 04:34:24.537 | INFO | [Emotion fleet_2] 119 2026-09-15 04:34:30.482 | INFO | Combat auto check timer reached 2026-09-15 04:35:25.543 | INFO | Screenshot interval set to 0.3s 2026-09-15 04:35:25.547 | INFO | Auto Search combat status 2026-09-15 04:35:26.133 | INFO | Click (1029, 650) @ GET_SHIP 2026-09-15 04:35:27.346 | INFO | Click (1027, 662) @ GET_SHIP 2026-09-15 04:35:28.536 | INFO | Click (1032, 669) @ GET_SHIP 2026-09-15 04:35:29.741 | INFO | Click (1015, 671) @ GET_SHIP 2026-09-15 04:35:31.834 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_5 ─────────────────────────────────────────────────────── 2026-09-15 04:35:31.839 | INFO | BATTLE_5 2026-09-15 04:35:31.843 | INFO | Auto search moving 2026-09-15 04:35:31.847 | INFO | Fleet: 1, fleet_current_index: 1 2026-09-15 04:35:31.958 | INFO | [OCR_OIL 0.107s] 22836 2026-09-15 04:35:32.065 | INFO | [OCR_COIN 0.104s] 15233 2026-09-15 04:35:34.248 | INFO | [Loading] 7% 2026-09-15 04:35:34.252 | INFO | Auto search combat loading 2026-09-15 04:35:34.255 | INFO | Screenshot interval set to 1.0s 2026-09-15 04:35:40.262 | INFO | [BattleUI] PAUSE 2026-09-15 04:35:40.265 | INFO | Auto Search combat execute 2026-09-15 04:35:40.267 | INFO | <<< EMOTION REDUCE >>> 2026-09-15 04:35:40.282 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-09-15 04:35:40.286 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=41, Main.Emotion.Fleet1Record=datetime.datetime(2026, 9, 15, 4, 35, 40), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 9, 15, 4, 35, 40) 2026-09-15 04:35:40.302 | INFO | [Emotion fleet_1] 41 2026-09-15 04:35:40.306 | INFO | [Emotion fleet_2] 119 2026-09-15 04:35:46.258 | INFO | Combat auto check timer reached 2026-09-15 04:36:54.329 | INFO | Click (1019, 650) @ GET_SHIP 2026-09-15 04:39:54.488 | INFO | Function calls: threading.py L890 _bootstrap() threading.py L926 _bootstrap_inner() threading.py L870 run() threadbased.py L254 run() output.py L801 click_callback() app.py L457 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 L602 loop() alas.py L70 run() alas.py L371 main() run.py L438 run() campaign_base.py L143 run() campaign_base.py L178 auto_search_execute_a_battle() auto_search_combat.py L357 auto_search_combat() auto_search_combat.py L252 auto_search_combat_execute() base.py L169 loop() device.py L194 screenshot() device.py L256 stuck_record_check() device.py L43 show_function_call() 2026-09-15 04:39:54.504 | WARNING | Wait too long 2026-09-15 04:39:54.508 | WARNING | Waiting for {'EXP_INFO_A', 'MISSION_POPUP_GO', 'EVENT_CHECK', 'EXP_INFO_B', 'GUILD_POPUP_CONFIRM', 'POPUP_CONFIRM_WHITE', 'GET_MISSION', 'BATTLE_STATUS_S', 'EXP_INFO_S', 'GET_SHIP', 'SP_CHECK', 'CAMPAIGN_CHECK', 'AUTO_SEARCH_MAP_OPTION_ON', 'PAUSE', 'POPUP_CANCEL', 'NEW_SHIP', 'BATTLE_STATUS_A', 'BATTLE_STATUS_B'} 2026-09-15 04:39:54.562 | INFO | [Package_name] com.bilibili.azurlane 2026-09-15 04:39:54.567 | ERROR | GameStuckError: Wait too long 2026-09-15 04:39:54.571 | WARNING | Saving error: ./log/error/1789418394571