═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ MAIN ═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ ════════════════════════════════════════════════════ CAMPAIGN_13_1 ════════════════════════════════════════════════════ 2026-10-28 18:18:03.042 | INFO | CAMPAIGN_13_1 2026-10-28 18:18:03.048 | INFO | Campaign run: event="campaign_main", name=campaign_13_1 2026-10-28 18:18:03.052 | INFO | Count: 0 2026-10-28 18:18:03.071 | INFO | <<< UI ENSURE >>> 2026-10-28 18:18:03.077 | INFO | UI get current page 2026-10-28 18:18:03.762 | INFO | Unknown ui page 2026-10-28 18:18:04.257 | INFO | UI additional: IDLE -> REWARD_GOTO_MAIN 2026-10-28 18:18:04.261 | INFO | Click ( 819, 614) @ REWARD_GOTO_MAIN 2026-10-28 18:18:04.458 | INFO | Unknown ui page 2026-10-28 18:18:04.595 | INFO | [Package_name] com.bilibili.azurlane 2026-10-28 18:18:04.612 | INFO | [Device Orientation] 0 (Normal) 2026-10-28 18:18:04.756 | INFO | Unknown ui page 2026-10-28 18:18:05.051 | INFO | Unknown ui page 2026-10-28 18:18:05.263 | INFO | [UI] page_main 2026-10-28 18:18:05.267 | INFO | Goto page_campaign 2026-10-28 18:18:05.271 | INFO | <<< UI GOTO PAGE_CAMPAIGN >>> 2026-10-28 18:18:05.287 | INFO | Page switch: page_main_white -> page_campaign_menu 2026-10-28 18:18:05.292 | INFO | Click (1196, 517) @ MAIN_GOTO_CAMPAIGN_WHITE 2026-10-28 18:18:05.868 | INFO | Page switch: page_campaign_menu -> page_campaign 2026-10-28 18:18:05.871 | INFO | Click ( 299, 320) @ CAMPAIGN_MENU_GOTO_CAMPAIGN 2026-10-28 18:18:06.166 | INFO | Page arrive: page_campaign 2026-10-28 18:18:06.192 | INFO | Mode_switch_1 set to hard 2026-10-28 18:18:06.218 | INFO | [Mode_switch_1] hard 2026-10-28 18:18:06.221 | INFO | <<< UI ENSURE INDEX >>> 2026-10-28 18:18:06.291 | INFO | No stage found. 2026-10-28 18:18:06.526 | INFO | No stage found. 2026-10-28 18:18:06.854 | INFO | Loading OCR model: ./bin/cnocr_models/azur_lane 2026-10-28 18:18:07.004 | INFO | [campaign 0.178s] ['3--1', '3--3', '3--2', '3--4'] 2026-10-28 18:18:07.007 | INFO | [Chapter] 3 2026-10-28 18:18:07.010 | INFO | [Stage] 3-1, 3-3, 3-2, 3-4 2026-10-28 18:18:07.013 | INFO | [Index] 3 2026-10-28 18:18:07.182 | INFO | [campaign 0.052s] ['13--1', '13--3', '13--2', '13--4'] 2026-10-28 18:18:07.186 | INFO | [Chapter] 13 2026-10-28 18:18:07.189 | INFO | [Stage] 13-1, 13-3, 13-2, 13-4 2026-10-28 18:18:07.191 | INFO | [Index] 13 2026-10-28 18:18:07.262 | INFO | [OCR_OIL 0.045s] 18250 ──────────────────────────────────────────────────────── 13-1 ───────────────────────────────────────────────────────── 2026-10-28 18:18:07.267 | INFO | 13-1 2026-10-28 18:18:07.270 | INFO | Expect emotion reduce: (12, 2) 2026-10-28 18:18:07.281 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-10-28 18:18:07.286 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=53, Main.Emotion.Fleet1Record=datetime.datetime(2026, 10, 28, 18, 18, 7), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 10, 28, 18, 18, 7) 2026-10-28 18:18:07.301 | INFO | [Emotion fleet_1] 53 2026-10-28 18:18:07.304 | INFO | [Emotion fleet_2] 119 2026-10-28 18:18:07.306 | INFO | <<< ENTER MAP >>> 2026-10-28 18:18:07.382 | INFO | Click ( 186, 281) @ 13-1 2026-10-28 18:18:07.781 | INFO | [Map_clear_percentage] 0% 2026-10-28 18:18:08.093 | INFO | [Map_clear_percentage] 67% 2026-10-28 18:18:08.385 | INFO | [Map_clear_percentage] 99% 2026-10-28 18:18:08.411 | INFO | [MAP_CLEAR_ALL_THIS_TIME] False 2026-10-28 18:18:08.414 | INFO | [Map_info] 99%, star_1, star_2, star_3, 100_percent_clear, 3_stars, threat_safe, clear_mode 2026-10-28 18:18:08.420 | INFO | [StopCondition_MapAchievement] non_stop 2026-10-28 18:18:08.423 | INFO | Clear_Mode set to on 2026-10-28 18:18:08.427 | INFO | [Clear_Mode] on 2026-10-28 18:18:08.440 | INFO | Auto_Search set to on 2026-10-28 18:18:08.444 | INFO | [Auto_Search] on 2026-10-28 18:18:08.448 | INFO | Click (1028, 505) @ MAP_PREPARATION 2026-10-28 18:18:08.689 | INFO | Handling 2x book setting, mode=prep. 2026-10-28 18:18:08.990 | INFO | Using fleet: [4, 3, 1] 2026-10-28 18:18:09.062 | INFO | Hard satisfied: Fleet_1: None, Fleet_2: None, Submarine: None 2026-10-28 18:18:09.072 | INFO | [map_allow_submarine] True 2026-10-28 18:18:09.078 | INFO | Click (1158, 327) @ FLEET_2_CLEAR 2026-10-28 18:18:09.131 | INFO | Fleet SUBMARINE set to 1 2026-10-28 18:18:09.135 | INFO | Click (1069, 482) @ SUBMARINE_CHOOSE 2026-10-28 18:18:09.288 | INFO | FleetOption: [1] 2 2026-10-28 18:18:09.291 | INFO | Fleet option 1 is already selected 2026-10-28 18:18:09.294 | INFO | Click (1057, 471) @ SUBMARINE_CHOOSE 2026-10-28 18:18:09.584 | INFO | FleetOption: 2026-10-28 18:18:09.590 | INFO | Fleet FLEET_1 set to 4 2026-10-28 18:18:09.593 | INFO | Click (1064, 214) @ FLEET_1_CHOOSE 2026-10-28 18:18:09.889 | INFO | FleetOption: 1 2 3 [4] 5 6 2026-10-28 18:18:09.892 | INFO | Fleet option 4 is already selected 2026-10-28 18:18:09.894 | INFO | Click (1051, 240) @ FLEET_1_CHOOSE 2026-10-28 18:18:10.185 | INFO | FleetOption: 2026-10-28 18:18:10.189 | INFO | Fleet FLEET_2 set to 3 2026-10-28 18:18:10.192 | INFO | Click (1055, 334) @ FLEET_2_CHOOSE 2026-10-28 18:18:10.490 | INFO | FleetOption: 1 2 3 [4] 5 6 2026-10-28 18:18:10.494 | INFO | Click (1067, 491) @ FleetOption_3 2026-10-28 18:18:10.785 | INFO | FleetOption: 2026-10-28 18:18:10.790 | INFO | Auto search setting 2026-10-28 18:18:10.805 | INFO | [_fleet_sidebar_offset] 0 2026-10-28 18:18:10.811 | INFO | [_fleet_sidebar_offset] 0 2026-10-28 18:18:10.815 | INFO | [Fleet_sidebar] 1/3 2026-10-28 18:18:10.819 | INFO | Click (1195, 420) @ FLEET_SIDEBAR_0_2 2026-10-28 18:18:11.089 | INFO | [_fleet_sidebar_offset] 0 2026-10-28 18:18:11.093 | INFO | [Fleet_sidebar] 3/3 2026-10-28 18:18:11.096 | INFO | [Auto_Search_Setting] fleet1_all_fleet2_standby, sub_standby 2026-10-28 18:18:11.099 | INFO | Click ( 507, 216) @ AUTO_SEARCH_SET_MOB 2026-10-28 18:18:11.618 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_standby 2026-10-28 18:18:11.621 | INFO | Selected to the correct auto search setting 2026-10-28 18:18:11.625 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_standby 2026-10-28 18:18:11.628 | INFO | Selected to the correct auto search setting 2026-10-28 18:18:11.634 | INFO | Click (1147, 591) @ FLEET_PREPARATION 2026-10-28 18:18:12.835 | INFO | is_auto_search_running appeared ────────────────────────────────────────────────────── BATTLE_0 ─────────────────────────────────────────────────────── 2026-10-28 18:18:12.841 | INFO | BATTLE_0 2026-10-28 18:18:12.844 | INFO | Auto search moving 2026-10-28 18:18:12.860 | INFO | Fleet: 1, fleet_current_index: 1 2026-10-28 18:18:12.925 | INFO | [OCR_OIL 0.061s] 18240 2026-10-28 18:18:12.989 | INFO | [OCR_COIN 0.058s] 52901 2026-10-28 18:18:17.262 | INFO | [Loading] 8% 2026-10-28 18:18:17.265 | INFO | Auto search combat loading 2026-10-28 18:18:17.267 | INFO | Screenshot interval set to 1.0s 2026-10-28 18:18:23.268 | INFO | [BattleUI] PAUSE 2026-10-28 18:18:23.273 | INFO | Auto Search combat execute 2026-10-28 18:18:23.276 | INFO | <<< EMOTION REDUCE >>> 2026-10-28 18:18:23.288 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-10-28 18:18:23.291 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=51, Main.Emotion.Fleet1Record=datetime.datetime(2026, 10, 28, 18, 18, 23), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 10, 28, 18, 18, 23) 2026-10-28 18:18:23.306 | INFO | [Emotion fleet_1] 51 2026-10-28 18:18:23.313 | INFO | [Emotion fleet_2] 119 2026-10-28 18:18:29.261 | INFO | Combat auto check timer reached 2026-10-28 18:18:50.297 | INFO | Click (1032, 661) @ GET_SHIP 2026-10-28 18:18:51.306 | INFO | Click (1026, 671) @ GET_SHIP 2026-10-28 18:18:54.313 | INFO | Screenshot interval set to 0.3s 2026-10-28 18:18:54.316 | INFO | Auto Search combat status 2026-10-28 18:18:55.486 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_1 ─────────────────────────────────────────────────────── 2026-10-28 18:18:55.492 | INFO | BATTLE_1 2026-10-28 18:18:55.494 | INFO | Auto search moving 2026-10-28 18:18:55.497 | INFO | Fleet: 1, fleet_current_index: 1 2026-10-28 18:18:55.564 | INFO | [OCR_OIL 0.062s] 18221 2026-10-28 18:18:55.631 | INFO | [OCR_COIN 0.063s] 52914 2026-10-28 18:19:00.596 | INFO | [Loading] 5% 2026-10-28 18:19:00.601 | INFO | Auto search combat loading 2026-10-28 18:19:00.603 | INFO | Screenshot interval set to 1.0s 2026-10-28 18:19:06.621 | INFO | [BattleUI] PAUSE 2026-10-28 18:19:06.624 | INFO | Auto Search combat execute 2026-10-28 18:19:06.627 | INFO | <<< EMOTION REDUCE >>> 2026-10-28 18:19:06.642 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-10-28 18:19:06.649 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=49, Main.Emotion.Fleet1Record=datetime.datetime(2026, 10, 28, 18, 19, 6), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 10, 28, 18, 19, 6) 2026-10-28 18:19:06.662 | INFO | [Emotion fleet_1] 49 2026-10-28 18:19:06.664 | INFO | [Emotion fleet_2] 119 2026-10-28 18:19:12.602 | INFO | Combat auto check timer reached 2026-10-28 18:20:04.668 | INFO | Screenshot interval set to 0.3s 2026-10-28 18:20:04.672 | INFO | Auto Search combat status 2026-10-28 18:20:05.557 | INFO | Click (1017, 658) @ GET_SHIP 2026-10-28 18:20:06.755 | INFO | Click (1019, 672) @ GET_SHIP 2026-10-28 18:20:11.251 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_2 ─────────────────────────────────────────────────────── 2026-10-28 18:20:11.257 | INFO | BATTLE_2 2026-10-28 18:20:11.259 | INFO | Auto search moving 2026-10-28 18:20:11.262 | INFO | Fleet: 1, fleet_current_index: 1 2026-10-28 18:20:11.329 | INFO | [OCR_OIL 0.063s] 18202 2026-10-28 18:20:11.395 | INFO | [OCR_COIN 0.063s] 52940 2026-10-28 18:20:15.767 | INFO | [Loading] 13% 2026-10-28 18:20:15.771 | INFO | Auto search combat loading 2026-10-28 18:20:15.775 | INFO | Screenshot interval set to 1.0s 2026-10-28 18:20:21.770 | INFO | [BattleUI] PAUSE 2026-10-28 18:20:21.773 | INFO | Auto Search combat execute 2026-10-28 18:20:21.775 | INFO | <<< EMOTION REDUCE >>> 2026-10-28 18:20:21.788 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-10-28 18:20:21.793 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=47, Main.Emotion.Fleet1Record=datetime.datetime(2026, 10, 28, 18, 20, 21), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 10, 28, 18, 20, 21) 2026-10-28 18:20:21.808 | INFO | [Emotion fleet_1] 47 2026-10-28 18:20:21.811 | INFO | [Emotion fleet_2] 119 2026-10-28 18:20:27.775 | INFO | Combat auto check timer reached 2026-10-28 18:20:46.800 | INFO | Click (1050, 668) @ GET_SHIP 2026-10-28 18:20:47.802 | INFO | Click (1035, 665) @ GET_SHIP 2026-10-28 18:20:50.815 | INFO | Screenshot interval set to 0.3s 2026-10-28 18:20:50.819 | INFO | Auto Search combat status 2026-10-28 18:20:51.985 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_3 ─────────────────────────────────────────────────────── 2026-10-28 18:20:51.989 | INFO | BATTLE_3 2026-10-28 18:20:51.991 | INFO | Auto search moving 2026-10-28 18:20:51.996 | INFO | Fleet: 1, fleet_current_index: 1 2026-10-28 18:20:52.080 | INFO | [OCR_OIL 0.079s] 18183 2026-10-28 18:20:52.157 | INFO | [OCR_COIN 0.074s] 52949 2026-10-28 18:20:56.799 | INFO | [Loading] 7% 2026-10-28 18:20:56.805 | INFO | Auto search combat loading 2026-10-28 18:20:56.808 | INFO | Screenshot interval set to 1.0s 2026-10-28 18:21:02.817 | INFO | [BattleUI] PAUSE 2026-10-28 18:21:02.823 | INFO | Auto Search combat execute 2026-10-28 18:21:02.827 | INFO | <<< EMOTION REDUCE >>> 2026-10-28 18:21:02.843 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-10-28 18:21:02.849 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=45, Main.Emotion.Fleet1Record=datetime.datetime(2026, 10, 28, 18, 21, 2), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 10, 28, 18, 21, 2) 2026-10-28 18:21:02.871 | INFO | [Emotion fleet_1] 45 2026-10-28 18:21:02.876 | INFO | [Emotion fleet_2] 119 2026-10-28 18:21:08.806 | INFO | Combat auto check timer reached 2026-10-28 18:21:28.836 | INFO | Click (1025, 646) @ GET_SHIP 2026-10-28 18:21:29.843 | INFO | Click (1031, 662) @ GET_SHIP 2026-10-28 18:21:32.853 | INFO | Screenshot interval set to 0.3s 2026-10-28 18:21:32.856 | INFO | Auto Search combat status 2026-10-28 18:21:34.022 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_4 ─────────────────────────────────────────────────────── 2026-10-28 18:21:34.027 | INFO | BATTLE_4 2026-10-28 18:21:34.031 | INFO | Auto search moving 2026-10-28 18:21:34.035 | INFO | Fleet: 1, fleet_current_index: 1 2026-10-28 18:21:34.090 | INFO | [OCR_OIL 0.051s] 18164 2026-10-28 18:21:34.157 | INFO | [OCR_COIN 0.061s] 52973 2026-10-28 18:21:38.533 | INFO | [Loading] 5% 2026-10-28 18:21:38.537 | INFO | Auto search combat loading 2026-10-28 18:21:38.540 | INFO | Screenshot interval set to 1.0s 2026-10-28 18:21:44.556 | INFO | [BattleUI] PAUSE 2026-10-28 18:21:44.560 | INFO | Auto Search combat execute 2026-10-28 18:21:44.563 | INFO | <<< EMOTION REDUCE >>> 2026-10-28 18:21:44.577 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-10-28 18:21:44.588 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=43, Main.Emotion.Fleet1Record=datetime.datetime(2026, 10, 28, 18, 21, 44), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 10, 28, 18, 21, 44) 2026-10-28 18:21:44.611 | INFO | [Emotion fleet_1] 43 2026-10-28 18:21:44.615 | INFO | [Emotion fleet_2] 119 2026-10-28 18:21:50.541 | INFO | Combat auto check timer reached 2026-10-28 18:22:45.605 | INFO | Screenshot interval set to 0.3s 2026-10-28 18:22:45.609 | INFO | Auto Search combat status 2026-10-28 18:22:46.192 | INFO | Click (1039, 657) @ GET_SHIP 2026-10-28 18:22:47.391 | INFO | Click (1026, 652) @ GET_SHIP 2026-10-28 18:22:51.886 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_5 ─────────────────────────────────────────────────────── 2026-10-28 18:22:51.890 | INFO | BATTLE_5 2026-10-28 18:22:51.892 | INFO | Auto search moving 2026-10-28 18:22:51.895 | INFO | Fleet: 1, fleet_current_index: 1 2026-10-28 18:22:51.962 | INFO | [OCR_OIL 0.063s] 18145 2026-10-28 18:22:52.020 | INFO | [OCR_COIN 0.054s] 52993 2026-10-28 18:22:54.003 | INFO | [Loading] 4% 2026-10-28 18:22:54.007 | INFO | Auto search combat loading 2026-10-28 18:22:54.009 | INFO | Screenshot interval set to 1.0s 2026-10-28 18:23:00.003 | INFO | [BattleUI] PAUSE 2026-10-28 18:23:00.009 | INFO | Auto Search combat execute 2026-10-28 18:23:00.014 | INFO | <<< EMOTION REDUCE >>> 2026-10-28 18:23:00.032 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-10-28 18:23:00.037 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=41, Main.Emotion.Fleet1Record=datetime.datetime(2026, 10, 28, 18, 23), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 10, 28, 18, 23) 2026-10-28 18:23:00.051 | INFO | [Emotion fleet_1] 41 2026-10-28 18:23:00.056 | INFO | [Emotion fleet_2] 119 2026-10-28 18:23:06.002 | INFO | Combat auto check timer reached 2026-10-28 18:26:00.159 | 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 L1550 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 L591 loop() alas.py L69 run() alas.py L356 main() run.py L445 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-10-28 18:26:00.180 | WARNING | Wait too long 2026-10-28 18:26:00.183 | WARNING | Waiting for {'EXP_INFO_B', 'BATTLE_STATUS_B', 'EXP_INFO_A', 'EXP_INFO_S', 'GET_MISSION', 'GET_SHIP', 'COMBAT_AUTO', 'POPUP_CONFIRM_WHITE', 'COMBAT_AUTO_133', 'SP_CHECK', 'POPUP_CANCEL', 'AUTO_SEARCH_MAP_OPTION_ON', 'BATTLE_STATUS_A', 'MISSION_POPUP_GO', 'EVENT_CHECK', 'GUILD_POPUP_CONFIRM', 'BATTLE_STATUS_S', 'COMBAT_AUTO_150', 'CAMPAIGN_CHECK', 'PAUSE'} 2026-10-28 18:26:00.241 | INFO | [Package_name] com.bilibili.azurlane 2026-10-28 18:26:00.244 | ERROR | GameStuckError: Wait too long 2026-10-28 18:26:00.246 | WARNING | Saving error: ./log/error/1793183160246