═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ MAIN ═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ ════════════════════════════════════════════════════ CAMPAIGN_13_1 ════════════════════════════════════════════════════ 2026-10-07 15:48:04.742 | INFO | CAMPAIGN_13_1 2026-10-07 15:48:04.746 | INFO | Count: 0 2026-10-07 15:48:04.769 | INFO | <<< UI ENSURE >>> 2026-10-07 15:48:04.775 | INFO | UI get current page 2026-10-07 15:48:05.453 | INFO | Unknown ui page 2026-10-07 15:48:05.943 | INFO | UI additional: IDLE_2 -> REWARD_GOTO_MAIN 2026-10-07 15:48:05.946 | INFO | Click ( 817, 627) @ REWARD_GOTO_MAIN 2026-10-07 15:48:06.139 | INFO | Unknown ui page 2026-10-07 15:48:06.287 | INFO | [Package_name] com.bilibili.azurlane 2026-10-07 15:48:06.307 | INFO | [Device Orientation] 0 (Normal) 2026-10-07 15:48:06.451 | INFO | Unknown ui page 2026-10-07 15:48:06.653 | INFO | [UI] page_main 2026-10-07 15:48:06.658 | INFO | Goto page_campaign 2026-10-07 15:48:06.665 | INFO | <<< UI GOTO PAGE_CAMPAIGN >>> 2026-10-07 15:48:06.680 | INFO | Page switch: page_main_white -> page_campaign_menu 2026-10-07 15:48:06.684 | INFO | Click (1179, 513) @ MAIN_GOTO_CAMPAIGN_WHITE 2026-10-07 15:48:07.260 | INFO | Page switch: page_campaign_menu -> page_campaign 2026-10-07 15:48:07.264 | INFO | Click ( 344, 289) @ CAMPAIGN_MENU_GOTO_CAMPAIGN 2026-10-07 15:48:07.554 | INFO | Page arrive: page_campaign 2026-10-07 15:48:07.580 | INFO | Mode_switch_1 set to hard 2026-10-07 15:48:07.604 | INFO | [Mode_switch_1] hard 2026-10-07 15:48:07.607 | INFO | <<< UI ENSURE INDEX >>> 2026-10-07 15:48:07.678 | INFO | No stage found. 2026-10-07 15:48:07.921 | INFO | No stage found. 2026-10-07 15:48:08.243 | INFO | Loading OCR model: ./bin/cnocr_models/azur_lane 2026-10-07 15:48:08.388 | INFO | [campaign 0.165s] ['I3--1', 'I3--3', 'I3--2', 'I3--4'] 2026-10-07 15:48:08.392 | INFO | [Chapter] 13 2026-10-07 15:48:08.396 | INFO | [Stage] 13-1, 13-3, 13-2, 13-4 2026-10-07 15:48:08.399 | INFO | [Index] 13 2026-10-07 15:48:08.469 | INFO | [OCR_OIL 0.045s] 17046 ──────────────────────────────────────────────────────── 13-1 ───────────────────────────────────────────────────────── 2026-10-07 15:48:08.474 | INFO | 13-1 2026-10-07 15:48:08.477 | INFO | Expect emotion reduce: (12, 2) 2026-10-07 15:48:08.487 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-10-07 15:48:08.490 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=53, Main.Emotion.Fleet1Record=datetime.datetime(2026, 10, 7, 15, 48, 8), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 10, 7, 15, 48, 8) 2026-10-07 15:48:08.510 | INFO | [Emotion fleet_1] 53 2026-10-07 15:48:08.513 | INFO | [Emotion fleet_2] 119 2026-10-07 15:48:08.515 | INFO | <<< ENTER MAP >>> 2026-10-07 15:48:08.584 | INFO | Click ( 198, 289) @ 13-1 2026-10-07 15:48:09.296 | INFO | [Map_clear_percentage] 68% 2026-10-07 15:48:09.588 | INFO | [Map_clear_percentage] 99% 2026-10-07 15:48:09.616 | INFO | [MAP_CLEAR_ALL_THIS_TIME] False 2026-10-07 15:48:09.619 | INFO | [Map_info] 99%, star_1, star_2, star_3, 100_percent_clear, 3_stars, threat_safe, clear_mode 2026-10-07 15:48:09.623 | INFO | [StopCondition_MapAchievement] non_stop 2026-10-07 15:48:09.625 | INFO | Clear_Mode set to on 2026-10-07 15:48:09.629 | INFO | [Clear_Mode] on 2026-10-07 15:48:09.642 | INFO | Auto_Search set to on 2026-10-07 15:48:09.649 | INFO | [Auto_Search] on 2026-10-07 15:48:09.652 | INFO | Click (1013, 514) @ MAP_PREPARATION 2026-10-07 15:48:09.893 | INFO | Handling 2x book setting, mode=prep. 2026-10-07 15:48:09.918 | INFO | Using fleet: [4, 3, 1] 2026-10-07 15:48:09.990 | INFO | Hard satisfied: Fleet_1: None, Fleet_2: None, Submarine: None 2026-10-07 15:48:10.000 | INFO | [map_allow_submarine] True 2026-10-07 15:48:10.004 | INFO | Click (1129, 332) @ FLEET_2_CLEAR 2026-10-07 15:48:10.058 | INFO | Fleet SUBMARINE set to 1 2026-10-07 15:48:10.061 | INFO | Click (1053, 482) @ SUBMARINE_CHOOSE 2026-10-07 15:48:10.194 | INFO | FleetOption: [1] 2 2026-10-07 15:48:10.198 | INFO | Fleet option 1 is already selected 2026-10-07 15:48:10.200 | INFO | Click (1068, 476) @ SUBMARINE_CHOOSE 2026-10-07 15:48:10.492 | INFO | FleetOption: 2026-10-07 15:48:10.499 | INFO | Fleet FLEET_1 set to 4 2026-10-07 15:48:10.502 | INFO | Click (1071, 228) @ FLEET_1_CHOOSE 2026-10-07 15:48:10.793 | INFO | FleetOption: 1 2 3 [4] 5 6 2026-10-07 15:48:10.797 | INFO | Fleet option 4 is already selected 2026-10-07 15:48:10.799 | INFO | Click (1052, 224) @ FLEET_1_CHOOSE 2026-10-07 15:48:11.087 | INFO | FleetOption: 2026-10-07 15:48:11.091 | INFO | Fleet FLEET_2 set to 3 2026-10-07 15:48:11.094 | INFO | Click (1057, 334) @ FLEET_2_CHOOSE 2026-10-07 15:48:11.399 | INFO | FleetOption: 1 2 3 [4] 5 6 2026-10-07 15:48:11.402 | INFO | Click (1084, 486) @ FleetOption_3 2026-10-07 15:48:11.689 | INFO | FleetOption: 2026-10-07 15:48:11.693 | INFO | Auto search setting 2026-10-07 15:48:11.707 | INFO | [_fleet_sidebar_offset] 0 2026-10-07 15:48:11.713 | INFO | [_fleet_sidebar_offset] 0 2026-10-07 15:48:11.718 | INFO | [Fleet_sidebar] 1/3 2026-10-07 15:48:11.722 | INFO | Click (1213, 404) @ FLEET_SIDEBAR_0_2 2026-10-07 15:48:11.989 | INFO | [_fleet_sidebar_offset] 0 2026-10-07 15:48:11.994 | INFO | [Fleet_sidebar] 3/3 2026-10-07 15:48:11.997 | INFO | [Auto_Search_Setting] fleet1_all_fleet2_standby, sub_standby 2026-10-07 15:48:12.001 | INFO | Click ( 509, 221) @ AUTO_SEARCH_SET_MOB 2026-10-07 15:48:12.549 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_standby 2026-10-07 15:48:12.554 | INFO | Selected to the correct auto search setting 2026-10-07 15:48:12.557 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_standby 2026-10-07 15:48:12.560 | INFO | Selected to the correct auto search setting 2026-10-07 15:48:12.567 | INFO | Click (1079, 586) @ FLEET_PREPARATION 2026-10-07 15:48:13.468 | INFO | is_auto_search_running appeared ────────────────────────────────────────────────────── BATTLE_0 ─────────────────────────────────────────────────────── 2026-10-07 15:48:13.473 | INFO | BATTLE_0 2026-10-07 15:48:13.475 | INFO | Auto search moving 2026-10-07 15:48:13.489 | INFO | Fleet: 1, fleet_current_index: 1 2026-10-07 15:48:13.536 | INFO | [OCR_OIL 0.043s] 17036 2026-10-07 15:48:13.611 | INFO | [OCR_COIN 0.072s] 77327 2026-10-07 15:48:18.766 | INFO | [Loading] 12% 2026-10-07 15:48:18.771 | INFO | Auto search combat loading 2026-10-07 15:48:18.774 | INFO | Screenshot interval set to 1.0s 2026-10-07 15:48:24.761 | INFO | [BattleUI] PAUSE 2026-10-07 15:48:24.765 | INFO | Auto Search combat execute 2026-10-07 15:48:24.768 | INFO | <<< EMOTION REDUCE >>> 2026-10-07 15:48:24.784 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-10-07 15:48:24.788 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=51, Main.Emotion.Fleet1Record=datetime.datetime(2026, 10, 7, 15, 48, 24), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 10, 7, 15, 48, 24) 2026-10-07 15:48:24.808 | INFO | [Emotion fleet_1] 51 2026-10-07 15:48:24.811 | INFO | [Emotion fleet_2] 119 2026-10-07 15:48:30.755 | INFO | Combat auto check timer reached 2026-10-07 15:49:06.795 | INFO | Screenshot interval set to 0.3s 2026-10-07 15:49:06.799 | INFO | Auto Search combat status 2026-10-07 15:49:07.382 | INFO | Click (1023, 664) @ GET_SHIP 2026-10-07 15:49:08.585 | INFO | Click (1026, 671) @ GET_SHIP 2026-10-07 15:49:13.078 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_1 ─────────────────────────────────────────────────────── 2026-10-07 15:49:13.083 | INFO | BATTLE_1 2026-10-07 15:49:13.085 | INFO | Auto search moving 2026-10-07 15:49:13.089 | INFO | Fleet: 1, fleet_current_index: 1 2026-10-07 15:49:13.157 | INFO | [OCR_OIL 0.063s] 17017 2026-10-07 15:49:13.256 | INFO | [OCR_COIN 0.093s] 77338 2026-10-07 15:49:18.497 | INFO | [Loading] 4% 2026-10-07 15:49:18.501 | INFO | Auto search combat loading 2026-10-07 15:49:18.503 | INFO | Screenshot interval set to 1.0s 2026-10-07 15:49:24.498 | INFO | [BattleUI] PAUSE 2026-10-07 15:49:24.501 | INFO | Auto Search combat execute 2026-10-07 15:49:24.503 | INFO | <<< EMOTION REDUCE >>> 2026-10-07 15:49:24.517 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-10-07 15:49:24.522 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=49, Main.Emotion.Fleet1Record=datetime.datetime(2026, 10, 7, 15, 49, 24), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 10, 7, 15, 49, 24) 2026-10-07 15:49:24.538 | INFO | [Emotion fleet_1] 49 2026-10-07 15:49:24.541 | INFO | [Emotion fleet_2] 119 2026-10-07 15:49:30.498 | INFO | Combat auto check timer reached 2026-10-07 15:49:48.524 | INFO | Screenshot interval set to 0.3s 2026-10-07 15:49:48.527 | INFO | Auto Search combat status 2026-10-07 15:49:53.315 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_2 ─────────────────────────────────────────────────────── 2026-10-07 15:49:53.320 | INFO | BATTLE_2 2026-10-07 15:49:53.323 | INFO | Auto search moving 2026-10-07 15:49:53.326 | INFO | Fleet: 1, fleet_current_index: 1 2026-10-07 15:49:53.395 | INFO | [OCR_OIL 0.065s] 16998 2026-10-07 15:49:53.494 | INFO | [OCR_COIN 0.094s] 77357 2026-10-07 15:49:57.837 | INFO | [Loading] 7% 2026-10-07 15:49:57.840 | INFO | Auto search combat loading 2026-10-07 15:49:57.842 | INFO | Screenshot interval set to 1.0s 2026-10-07 15:50:03.835 | INFO | [BattleUI] PAUSE 2026-10-07 15:50:03.840 | INFO | Auto Search combat execute 2026-10-07 15:50:03.842 | INFO | <<< EMOTION REDUCE >>> 2026-10-07 15:50:03.853 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-10-07 15:50:03.862 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=47, Main.Emotion.Fleet1Record=datetime.datetime(2026, 10, 7, 15, 50, 3), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 10, 7, 15, 50, 3) 2026-10-07 15:50:03.880 | INFO | [Emotion fleet_1] 47 2026-10-07 15:50:03.883 | INFO | [Emotion fleet_2] 119 2026-10-07 15:50:08.844 | INFO | Combat auto check timer reached 2026-10-07 15:50:44.881 | INFO | Click (1014, 650) @ GET_SHIP 2026-10-07 15:50:45.899 | INFO | Click (1026, 673) @ GET_SHIP 2026-10-07 15:50:48.904 | INFO | Screenshot interval set to 0.3s 2026-10-07 15:50:48.908 | INFO | Auto Search combat status 2026-10-07 15:50:50.056 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_3 ─────────────────────────────────────────────────────── 2026-10-07 15:50:50.061 | INFO | BATTLE_3 2026-10-07 15:50:50.064 | INFO | Auto search moving 2026-10-07 15:50:50.068 | INFO | Fleet: 1, fleet_current_index: 1 2026-10-07 15:50:50.122 | INFO | [OCR_OIL 0.051s] 16979 2026-10-07 15:50:50.183 | INFO | [OCR_COIN 0.057s] 77376 2026-10-07 15:50:54.277 | INFO | [Loading] 5% 2026-10-07 15:50:54.281 | INFO | Auto search combat loading 2026-10-07 15:50:54.284 | INFO | Screenshot interval set to 1.0s 2026-10-07 15:51:00.280 | INFO | [BattleUI] PAUSE 2026-10-07 15:51:00.283 | INFO | Auto Search combat execute 2026-10-07 15:51:00.285 | INFO | <<< EMOTION REDUCE >>> 2026-10-07 15:51:00.298 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-10-07 15:51:00.302 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=45, Main.Emotion.Fleet1Record=datetime.datetime(2026, 10, 7, 15, 51), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 10, 7, 15, 51) 2026-10-07 15:51:00.318 | INFO | [Emotion fleet_1] 45 2026-10-07 15:51:00.321 | INFO | [Emotion fleet_2] 119 2026-10-07 15:51:06.273 | INFO | Combat auto check timer reached 2026-10-07 15:51:29.326 | INFO | Screenshot interval set to 0.3s 2026-10-07 15:51:29.329 | INFO | Auto Search combat status 2026-10-07 15:51:30.493 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_4 ─────────────────────────────────────────────────────── 2026-10-07 15:51:30.499 | INFO | BATTLE_4 2026-10-07 15:51:30.503 | INFO | Auto search moving 2026-10-07 15:51:30.508 | INFO | Fleet: 1, fleet_current_index: 1 2026-10-07 15:51:30.571 | INFO | [OCR_OIL 0.059s] 16960 2026-10-07 15:51:30.660 | INFO | [OCR_COIN 0.085s] 77392 2026-10-07 15:51:35.006 | INFO | [Loading] 5% 2026-10-07 15:51:35.012 | INFO | Auto search combat loading 2026-10-07 15:51:35.015 | INFO | Screenshot interval set to 1.0s 2026-10-07 15:51:41.013 | INFO | [BattleUI] PAUSE 2026-10-07 15:51:41.017 | INFO | Auto Search combat execute 2026-10-07 15:51:41.021 | INFO | <<< EMOTION REDUCE >>> 2026-10-07 15:51:41.034 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-10-07 15:51:41.038 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=43, Main.Emotion.Fleet1Record=datetime.datetime(2026, 10, 7, 15, 51, 41), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 10, 7, 15, 51, 41) 2026-10-07 15:51:41.057 | INFO | [Emotion fleet_1] 43 2026-10-07 15:51:41.060 | INFO | [Emotion fleet_2] 119 2026-10-07 15:51:47.019 | INFO | Combat auto check timer reached 2026-10-07 15:52:22.061 | INFO | Screenshot interval set to 0.3s 2026-10-07 15:52:22.064 | INFO | Auto Search combat status 2026-10-07 15:52:27.447 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_5 ─────────────────────────────────────────────────────── 2026-10-07 15:52:27.451 | INFO | BATTLE_5 2026-10-07 15:52:27.457 | INFO | Auto search moving 2026-10-07 15:52:27.462 | INFO | Fleet: 1, fleet_current_index: 1 2026-10-07 15:52:27.558 | INFO | [OCR_OIL 0.092s] 16941 2026-10-07 15:52:27.636 | INFO | [OCR_COIN 0.074s] 77410 2026-10-07 15:52:29.554 | INFO | [Loading] 7% 2026-10-07 15:52:29.558 | INFO | Auto search combat loading 2026-10-07 15:52:29.561 | INFO | Screenshot interval set to 1.0s 2026-10-07 15:52:35.589 | INFO | [BattleUI] PAUSE 2026-10-07 15:52:35.591 | INFO | Auto Search combat execute 2026-10-07 15:52:35.594 | INFO | <<< EMOTION REDUCE >>> 2026-10-07 15:52:35.610 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-10-07 15:52:35.614 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=41, Main.Emotion.Fleet1Record=datetime.datetime(2026, 10, 7, 15, 52, 35), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 10, 7, 15, 52, 35) 2026-10-07 15:52:35.626 | INFO | [Emotion fleet_1] 41 2026-10-07 15:52:35.630 | INFO | [Emotion fleet_2] 119 2026-10-07 15:52:41.563 | INFO | Combat auto check timer reached 2026-10-07 15:55:35.721 | 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-10-07 15:55:35.736 | WARNING | Wait too long 2026-10-07 15:55:35.739 | 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-07 15:55:35.796 | INFO | [Package_name] com.bilibili.azurlane 2026-10-07 15:55:35.799 | ERROR | GameStuckError: Wait too long 2026-10-07 15:55:35.802 | WARNING | Saving error: ./log/error/1791359735802