═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ MAIN ═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ ════════════════════════════════════════════════════ CAMPAIGN_13_1 ════════════════════════════════════════════════════ 2026-01-28 23:30:03.021 | INFO | CAMPAIGN_13_1 2026-01-28 23:30:03.027 | INFO | Count: 0 2026-01-28 23:30:03.046 | INFO | <<< UI ENSURE >>> 2026-01-28 23:30:03.054 | INFO | UI get current page 2026-01-28 23:30:03.623 | INFO | Unknown ui page 2026-01-28 23:30:04.113 | INFO | UI additional: IDLE -> REWARD_GOTO_MAIN 2026-01-28 23:30:04.117 | INFO | Click ( 834, 621) @ REWARD_GOTO_MAIN 2026-01-28 23:30:04.315 | INFO | Unknown ui page 2026-01-28 23:30:04.485 | INFO | [Package_name] com.bilibili.azurlane 2026-01-28 23:30:04.509 | INFO | [Device Orientation] 0 (Normal) 2026-01-28 23:30:04.662 | INFO | Unknown ui page 2026-01-28 23:30:04.951 | INFO | Unknown ui page 2026-01-28 23:30:05.177 | INFO | [UI] page_main 2026-01-28 23:30:05.182 | INFO | Goto page_campaign 2026-01-28 23:30:05.189 | INFO | <<< UI GOTO PAGE_CAMPAIGN >>> 2026-01-28 23:30:05.209 | INFO | Page switch: page_main_white -> page_campaign_menu 2026-01-28 23:30:05.215 | INFO | Click (1186, 508) @ MAIN_GOTO_CAMPAIGN_WHITE 2026-01-28 23:30:05.763 | INFO | Page switch: page_campaign_menu -> page_campaign 2026-01-28 23:30:05.766 | INFO | Click ( 337, 302) @ CAMPAIGN_MENU_GOTO_CAMPAIGN 2026-01-28 23:30:06.095 | INFO | Page arrive: page_campaign 2026-01-28 23:30:06.143 | INFO | Mode_switch_1 set to hard 2026-01-28 23:30:06.179 | INFO | [Mode_switch_1] hard 2026-01-28 23:30:06.187 | INFO | <<< UI ENSURE INDEX >>> 2026-01-28 23:30:06.288 | INFO | No stage found. 2026-01-28 23:30:06.467 | INFO | No stage found. 2026-01-28 23:30:06.751 | INFO | Loading OCR model: ./bin/cnocr_models/azur_lane 2026-01-28 23:30:06.869 | INFO | [campaign 0.141s] ['I3--1', 'I3--3', 'I3--2', 'I3--4'] 2026-01-28 23:30:06.873 | INFO | [Chapter] i3 2026-01-28 23:30:06.879 | INFO | [Stage] i3-1, i3-3, i3-2, i3-4 2026-01-28 23:30:06.968 | INFO | <<< UI ENSURE >>> 2026-01-28 23:30:06.971 | INFO | UI get current page 2026-01-28 23:30:06.989 | INFO | [UI] page_campaign 2026-01-28 23:30:06.995 | INFO | Already at page_campaign 2026-01-28 23:30:07.005 | INFO | Mode_switch_1 set to hard 2026-01-28 23:30:07.018 | INFO | [Mode_switch_1] hard 2026-01-28 23:30:07.023 | INFO | <<< UI ENSURE INDEX >>> 2026-01-28 23:30:07.182 | INFO | [campaign 0.077s] ['13--1', '13--3', '13--2', '13--4'] 2026-01-28 23:30:07.186 | INFO | [Chapter] 13 2026-01-28 23:30:07.189 | INFO | [Stage] 13-1, 13-3, 13-2, 13-4 2026-01-28 23:30:07.195 | INFO | [Index] 13 2026-01-28 23:30:07.301 | INFO | [OCR_OIL 0.071s] 2220 ──────────────────────────────────────────────────────── 13-1 ───────────────────────────────────────────────────────── 2026-01-28 23:30:07.310 | INFO | 13-1 2026-01-28 23:30:07.315 | INFO | Expect emotion reduce: (12, 2) 2026-01-28 23:30:07.328 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-01-28 23:30:07.333 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=53, Main.Emotion.Fleet1Record=datetime.datetime(2026, 1, 28, 23, 30, 7), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 1, 28, 23, 30, 7) 2026-01-28 23:30:07.369 | INFO | [Emotion fleet_1] 53 2026-01-28 23:30:07.377 | INFO | [Emotion fleet_2] 119 2026-01-28 23:30:07.384 | INFO | <<< ENTER MAP >>> 2026-01-28 23:30:07.476 | INFO | Click ( 179, 266) @ 13-1 2026-01-28 23:30:07.891 | INFO | [Map_clear_percentage] 4% 2026-01-28 23:30:08.189 | INFO | [Map_clear_percentage] 67% 2026-01-28 23:30:08.488 | INFO | [Map_clear_percentage] 99% 2026-01-28 23:30:08.515 | INFO | [MAP_CLEAR_ALL_THIS_TIME] False 2026-01-28 23:30:08.520 | INFO | [Map_info] 99%, star_1, star_2, star_3, 100_percent_clear, 3_stars, threat_safe, clear_mode 2026-01-28 23:30:08.526 | INFO | [StopCondition_MapAchievement] non_stop 2026-01-28 23:30:08.529 | INFO | Fast_Forward set to on 2026-01-28 23:30:08.532 | INFO | [Fast_Forward] on 2026-01-28 23:30:08.545 | INFO | Auto_Search set to on 2026-01-28 23:30:08.556 | INFO | [Auto_Search] on 2026-01-28 23:30:08.563 | INFO | Click ( 981, 502) @ MAP_PREPARATION 2026-01-28 23:30:09.088 | INFO | Handling 2x book setting, mode=prep. 2026-01-28 23:30:09.113 | INFO | Using fleet: [4, 3, 1] 2026-01-28 23:30:09.194 | INFO | Hard satisfied: Fleet_1: None, Fleet_2: None, Submarine: None 2026-01-28 23:30:09.204 | INFO | [map_allow_submarine] True 2026-01-28 23:30:09.208 | INFO | Click (1151, 334) @ FLEET_2_CLEAR 2026-01-28 23:30:09.264 | INFO | Click (1069, 471) @ SUBMARINE_CHOOSE 2026-01-28 23:30:09.687 | INFO | Current selected: [1] 2026-01-28 23:30:09.691 | INFO | Click (1053, 463) @ SUBMARINE_CHOOSE 2026-01-28 23:30:09.991 | INFO | Click (1030, 212) @ FLEET_1_CHOOSE 2026-01-28 23:30:10.284 | INFO | Current selected: [3] 2026-01-28 23:30:10.289 | INFO | Click (1123, 410) @ FLEET_1_BAR_INDEX_4 2026-01-28 23:30:10.598 | INFO | Click (1054, 342) @ FLEET_2_CHOOSE 2026-01-28 23:30:10.894 | INFO | Current selected: [4] 2026-01-28 23:30:10.900 | INFO | Click (1104, 488) @ FLEET_2_BAR_INDEX_3 2026-01-28 23:30:11.186 | INFO | Auto search setting 2026-01-28 23:30:11.202 | INFO | [_fleet_sidebar_offset] 0 2026-01-28 23:30:11.207 | INFO | [Fleet_sidebar] 1/3 2026-01-28 23:30:11.210 | INFO | Click (1199, 445) @ FLEET_SIDEBAR_0_2 2026-01-28 23:30:11.711 | INFO | [_fleet_sidebar_offset] 0 2026-01-28 23:30:11.719 | INFO | [Fleet_sidebar] 3/3 2026-01-28 23:30:11.723 | INFO | [Auto_Search_Setting] fleet1_all_fleet2_standby, sub_standby 2026-01-28 23:30:11.727 | INFO | Click ( 510, 217) @ AUTO_SEARCH_SET_MOB 2026-01-28 23:30:12.264 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_standby 2026-01-28 23:30:12.268 | INFO | Selected to the correct auto search setting 2026-01-28 23:30:12.271 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_standby 2026-01-28 23:30:12.274 | INFO | Selected to the correct auto search setting 2026-01-28 23:30:12.276 | INFO | Click (1112, 568) @ FLEET_PREPARATION 2026-01-28 23:30:13.210 | INFO | is_auto_search_running appeared ────────────────────────────────────────────────────── BATTLE_0 ─────────────────────────────────────────────────────── 2026-01-28 23:30:13.219 | INFO | BATTLE_0 2026-01-28 23:30:13.223 | INFO | Auto search moving 2026-01-28 23:30:13.243 | INFO | Fleet: 1, fleet_current_index: 1 2026-01-28 23:30:13.366 | INFO | [OCR_OIL 0.119s] 2210 2026-01-28 23:30:13.479 | INFO | [OCR_COIN 0.106s] 138312 2026-01-28 23:30:18.277 | INFO | [Loading] 6% 2026-01-28 23:30:18.282 | INFO | Auto search combat loading 2026-01-28 23:30:18.288 | INFO | Screenshot interval set to 1.0s 2026-01-28 23:30:24.268 | INFO | [BattleUI] PAUSE 2026-01-28 23:30:24.271 | INFO | Auto Search combat execute 2026-01-28 23:30:24.274 | INFO | <<< EMOTION REDUCE >>> 2026-01-28 23:30:24.290 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-01-28 23:30:24.295 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=51, Main.Emotion.Fleet1Record=datetime.datetime(2026, 1, 28, 23, 30, 24), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 1, 28, 23, 30, 24) 2026-01-28 23:30:24.314 | INFO | [Emotion fleet_1] 51 2026-01-28 23:30:24.318 | INFO | [Emotion fleet_2] 119 2026-01-28 23:30:30.278 | INFO | Combat auto check timer reached 2026-01-28 23:30:50.309 | INFO | Screenshot interval set to 0.3s 2026-01-28 23:30:50.313 | INFO | Auto Search combat status 2026-01-28 23:30:51.192 | INFO | Click (1024, 669) @ GET_SHIP 2026-01-28 23:30:52.393 | INFO | Click (1034, 658) @ GET_SHIP 2026-01-28 23:30:53.618 | INFO | Click (1044, 650) @ GET_SHIP 2026-01-28 23:30:54.850 | INFO | Click (1017, 650) @ GET_SHIP 2026-01-28 23:30:56.639 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_1 ─────────────────────────────────────────────────────── 2026-01-28 23:30:56.654 | INFO | BATTLE_1 2026-01-28 23:30:56.662 | INFO | Auto search moving 2026-01-28 23:30:56.669 | INFO | Fleet: 1, fleet_current_index: 1 2026-01-28 23:30:56.835 | INFO | [OCR_OIL 0.155s] 2191 2026-01-28 23:30:56.999 | INFO | [OCR_COIN 0.155s] 138335 2026-01-28 23:31:01.923 | INFO | [Loading] 11% 2026-01-28 23:31:01.928 | INFO | Auto search combat loading 2026-01-28 23:31:01.932 | INFO | Screenshot interval set to 1.0s 2026-01-28 23:31:07.962 | INFO | [BattleUI] PAUSE 2026-01-28 23:31:07.971 | INFO | Auto Search combat execute 2026-01-28 23:31:07.976 | INFO | <<< EMOTION REDUCE >>> 2026-01-28 23:31:07.997 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-01-28 23:31:08.000 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=49, Main.Emotion.Fleet1Record=datetime.datetime(2026, 1, 28, 23, 31, 7), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 1, 28, 23, 31, 7) 2026-01-28 23:31:08.015 | INFO | [Emotion fleet_1] 49 2026-01-28 23:31:08.025 | INFO | [Emotion fleet_2] 119 2026-01-28 23:31:13.918 | INFO | Combat auto check timer reached 2026-01-28 23:31:32.947 | INFO | Screenshot interval set to 0.3s 2026-01-28 23:31:32.951 | INFO | Auto Search combat status 2026-01-28 23:31:33.838 | INFO | Click (1008, 653) @ GET_SHIP 2026-01-28 23:31:35.034 | INFO | Click (1023, 639) @ GET_SHIP 2026-01-28 23:31:36.236 | INFO | Click (1042, 649) @ GET_SHIP 2026-01-28 23:31:37.472 | INFO | Click (1050, 640) @ GET_SHIP 2026-01-28 23:31:39.536 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_2 ─────────────────────────────────────────────────────── 2026-01-28 23:31:39.546 | INFO | BATTLE_2 2026-01-28 23:31:39.549 | INFO | Auto search moving 2026-01-28 23:31:39.559 | INFO | Fleet: 1, fleet_current_index: 1 2026-01-28 23:31:39.719 | INFO | [OCR_OIL 0.154s] 2172 2026-01-28 23:31:39.870 | INFO | [OCR_COIN 0.141s] 138345 2026-01-28 23:31:43.891 | INFO | [Loading] 17% 2026-01-28 23:31:43.897 | INFO | Auto search combat loading 2026-01-28 23:31:43.902 | INFO | Screenshot interval set to 1.0s 2026-01-28 23:31:49.926 | INFO | [BattleUI] PAUSE 2026-01-28 23:31:49.931 | INFO | Auto Search combat execute 2026-01-28 23:31:49.938 | INFO | <<< EMOTION REDUCE >>> 2026-01-28 23:31:49.954 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-01-28 23:31:49.963 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=47, Main.Emotion.Fleet1Record=datetime.datetime(2026, 1, 28, 23, 31, 49), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 1, 28, 23, 31, 49) 2026-01-28 23:31:49.985 | INFO | [Emotion fleet_1] 47 2026-01-28 23:31:49.988 | INFO | [Emotion fleet_2] 119 2026-01-28 23:31:55.894 | INFO | Combat auto check timer reached 2026-01-28 23:32:20.936 | INFO | Click (1041, 666) @ GET_SHIP 2026-01-28 23:32:21.939 | INFO | Click (1025, 661) @ GET_SHIP 2026-01-28 23:32:22.942 | INFO | Click (1032, 673) @ GET_SHIP 2026-01-28 23:32:23.945 | INFO | Click (1032, 647) @ GET_SHIP 2026-01-28 23:32:24.937 | INFO | Screenshot interval set to 0.3s 2026-01-28 23:32:24.940 | INFO | Auto Search combat status 2026-01-28 23:32:24.943 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_3 ─────────────────────────────────────────────────────── 2026-01-28 23:32:24.949 | INFO | BATTLE_3 2026-01-28 23:32:24.955 | INFO | Auto search moving 2026-01-28 23:32:24.960 | INFO | Fleet: 1, fleet_current_index: 1 2026-01-28 23:32:25.094 | INFO | [OCR_OIL 0.130s] 2153 2026-01-28 23:32:25.223 | INFO | [OCR_COIN 0.124s] 138356 2026-01-28 23:32:29.240 | INFO | [Loading] 12% 2026-01-28 23:32:29.244 | INFO | Auto search combat loading 2026-01-28 23:32:29.247 | INFO | Screenshot interval set to 1.0s 2026-01-28 23:32:35.241 | INFO | [BattleUI] PAUSE 2026-01-28 23:32:35.247 | INFO | Auto Search combat execute 2026-01-28 23:32:35.250 | INFO | <<< EMOTION REDUCE >>> 2026-01-28 23:32:35.263 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-01-28 23:32:35.270 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=45, Main.Emotion.Fleet1Record=datetime.datetime(2026, 1, 28, 23, 32, 35), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 1, 28, 23, 32, 35) 2026-01-28 23:32:35.288 | INFO | [Emotion fleet_1] 45 2026-01-28 23:32:35.292 | INFO | [Emotion fleet_2] 119 2026-01-28 23:32:41.243 | INFO | Combat auto check timer reached 2026-01-28 23:33:19.372 | INFO | Click (1025, 664) @ GET_SHIP 2026-01-28 23:33:21.284 | INFO | Click (1039, 662) @ GET_SHIP 2026-01-28 23:33:22.285 | INFO | Click (1026, 655) @ GET_SHIP 2026-01-28 23:33:23.286 | INFO | Click (1038, 673) @ GET_SHIP 2026-01-28 23:33:24.299 | INFO | Click (1039, 669) @ GET_SHIP 2026-01-28 23:33:25.292 | INFO | Screenshot interval set to 0.3s 2026-01-28 23:33:25.298 | INFO | Auto Search combat status 2026-01-28 23:33:25.301 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_4 ─────────────────────────────────────────────────────── 2026-01-28 23:33:25.305 | INFO | BATTLE_4 2026-01-28 23:33:25.308 | INFO | Auto search moving 2026-01-28 23:33:25.316 | INFO | Fleet: 1, fleet_current_index: 1 2026-01-28 23:33:25.406 | INFO | [OCR_OIL 0.086s] 2134 2026-01-28 23:33:25.507 | INFO | [OCR_COIN 0.098s] 138375 2026-01-28 23:33:30.704 | INFO | [Loading] 5% 2026-01-28 23:33:30.709 | INFO | Auto search combat loading 2026-01-28 23:33:30.711 | INFO | Screenshot interval set to 1.0s 2026-01-28 23:33:36.713 | INFO | [BattleUI] PAUSE 2026-01-28 23:33:36.716 | INFO | Auto Search combat execute 2026-01-28 23:33:36.719 | INFO | <<< EMOTION REDUCE >>> 2026-01-28 23:33:36.734 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-01-28 23:33:36.741 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=43, Main.Emotion.Fleet1Record=datetime.datetime(2026, 1, 28, 23, 33, 36), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 1, 28, 23, 33, 36) 2026-01-28 23:33:36.756 | INFO | [Emotion fleet_1] 43 2026-01-28 23:33:36.761 | INFO | [Emotion fleet_2] 119 2026-01-28 23:33:42.714 | INFO | Combat auto check timer reached 2026-01-28 23:34:37.768 | INFO | Click (1041, 668) @ GET_SHIP 2026-01-28 23:34:38.818 | INFO | Click (1044, 653) @ GET_SHIP 2026-01-28 23:34:40.777 | INFO | Click (1032, 652) @ GET_SHIP 2026-01-28 23:34:41.782 | INFO | Click (1033, 654) @ GET_SHIP 2026-01-28 23:34:43.783 | INFO | Screenshot interval set to 0.3s 2026-01-28 23:34:43.786 | INFO | Auto Search combat status 2026-01-28 23:34:43.792 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_5 ─────────────────────────────────────────────────────── 2026-01-28 23:34:43.802 | INFO | BATTLE_5 2026-01-28 23:34:43.807 | INFO | Auto search moving 2026-01-28 23:34:43.815 | INFO | Fleet: 1, fleet_current_index: 1 2026-01-28 23:34:43.928 | INFO | [OCR_OIL 0.109s] 2115 2026-01-28 23:34:44.083 | INFO | [OCR_COIN 0.144s] 138399 2026-01-28 23:34:45.449 | INFO | [Loading] 4% 2026-01-28 23:34:45.456 | INFO | Auto search combat loading 2026-01-28 23:34:45.463 | INFO | Screenshot interval set to 1.0s 2026-01-28 23:34:52.390 | INFO | [BattleUI] PAUSE 2026-01-28 23:34:52.394 | INFO | Auto Search combat execute 2026-01-28 23:34:52.397 | INFO | <<< EMOTION REDUCE >>> 2026-01-28 23:34:52.415 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-01-28 23:34:52.419 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=41, Main.Emotion.Fleet1Record=datetime.datetime(2026, 1, 28, 23, 34, 52), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 1, 28, 23, 34, 52) 2026-01-28 23:34:52.435 | INFO | [Emotion fleet_1] 41 2026-01-28 23:34:52.441 | INFO | [Emotion fleet_2] 119 2026-01-28 23:34:58.384 | INFO | Combat auto check timer reached 2026-01-28 23:36:21.483 | INFO | Click (1036, 663) @ GET_SHIP 2026-01-28 23:39:21.632 | 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 L437 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-01-28 23:39:21.650 | WARNING | Wait too long 2026-01-28 23:39:21.658 | WARNING | Waiting for {'SP_CHECK', 'EXP_INFO_S', 'GET_SHIP', 'EVENT_CHECK', 'EXP_INFO_A', 'BATTLE_STATUS_B', 'CAMPAIGN_CHECK', 'GET_MISSION', 'BATTLE_STATUS_A', 'EXP_INFO_B', 'MISSION_POPUP_GO', 'POPUP_CONFIRM_WHITE', 'PAUSE', 'AUTO_SEARCH_MAP_OPTION_ON', 'NEW_SHIP', 'GUILD_POPUP_CONFIRM', 'BATTLE_STATUS_S', 'POPUP_CANCEL'} 2026-01-28 23:39:21.766 | INFO | [Package_name] com.bilibili.azurlane 2026-01-28 23:39:21.777 | ERROR | GameStuckError: Wait too long 2026-01-28 23:39:21.782 | WARNING | Saving error: ./log/error/1769614761782