═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ MAIN ═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ ════════════════════════════════════════════════════ CAMPAIGN_13_1 ════════════════════════════════════════════════════ 2025-10-01 23:42:05.231 | INFO | CAMPAIGN_13_1 2025-10-01 23:42:05.236 | INFO | Count: 0 2025-10-01 23:42:05.254 | INFO | <<< UI ENSURE >>> 2025-10-01 23:42:05.258 | INFO | UI get current page 2025-10-01 23:42:05.773 | INFO | Unknown ui page 2025-10-01 23:42:06.253 | INFO | UI additional: IDLE -> REWARD_GOTO_MAIN 2025-10-01 23:42:06.257 | INFO | Click ( 857, 625) @ REWARD_GOTO_MAIN 2025-10-01 23:42:06.433 | INFO | Unknown ui page 2025-10-01 23:42:06.584 | INFO | [Package_name] com.bilibili.azurlane 2025-10-01 23:42:06.608 | INFO | [Device Orientation] 0 (Normal) 2025-10-01 23:42:06.759 | INFO | Unknown ui page 2025-10-01 23:42:06.962 | INFO | [UI] page_main 2025-10-01 23:42:06.965 | INFO | Goto page_campaign 2025-10-01 23:42:06.968 | INFO | <<< UI GOTO PAGE_CAMPAIGN >>> 2025-10-01 23:42:06.990 | INFO | Page switch: page_main_white -> page_campaign_menu 2025-10-01 23:42:06.995 | INFO | Click (1234, 500) @ MAIN_GOTO_CAMPAIGN_WHITE 2025-10-01 23:42:07.565 | INFO | Page switch: page_campaign_menu -> page_campaign 2025-10-01 23:42:07.568 | INFO | Click ( 371, 274) @ CAMPAIGN_MENU_GOTO_CAMPAIGN 2025-10-01 23:42:07.859 | INFO | Page arrive: page_campaign 2025-10-01 23:42:07.885 | INFO | Mode_switch_1 set to hard 2025-10-01 23:42:07.914 | INFO | [Mode_switch_1] hard 2025-10-01 23:42:07.917 | INFO | <<< UI ENSURE INDEX >>> 2025-10-01 23:42:07.993 | INFO | No stage found. 2025-10-01 23:42:08.228 | INFO | No stage found. 2025-10-01 23:42:08.527 | INFO | No stage found. 2025-10-01 23:42:08.846 | INFO | Loading OCR model: ./bin/cnocr_models/azur_lane 2025-10-01 23:42:08.968 | INFO | [campaign 0.140s] ['13--1', '13--3', '13--2', '13--4'] 2025-10-01 23:42:08.972 | INFO | [Chapter] 13 2025-10-01 23:42:08.976 | INFO | [Stage] 13-1, 13-3, 13-2, 13-4 2025-10-01 23:42:08.978 | INFO | [Index] 13 2025-10-01 23:42:09.047 | INFO | [OCR_OIL 0.040s] 7388 ──────────────────────────────────────────────────────── 13-1 ───────────────────────────────────────────────────────── 2025-10-01 23:42:09.051 | INFO | 13-1 2025-10-01 23:42:09.055 | INFO | Expect emotion reduce: (12, 2) 2025-10-01 23:42:09.068 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-10-01 23:42:09.071 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=53, Main.Emotion.Fleet1Record=datetime.datetime(2025, 10, 1, 23, 42, 9), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 10, 1, 23, 42, 9) 2025-10-01 23:42:09.084 | INFO | [Emotion fleet_1] 53 2025-10-01 23:42:09.093 | INFO | [Emotion fleet_2] 119 2025-10-01 23:42:09.098 | INFO | <<< ENTER MAP >>> 2025-10-01 23:42:09.177 | INFO | Click ( 187, 275) @ 13-1 2025-10-01 23:42:09.887 | INFO | [Map_clear_percentage] 52% 2025-10-01 23:42:10.182 | INFO | [Map_clear_percentage] 99% 2025-10-01 23:42:10.208 | INFO | [MAP_CLEAR_ALL_THIS_TIME] False 2025-10-01 23:42:10.214 | INFO | [Map_info] 99%, star_1, star_2, star_3, 100_percent_clear, 3_stars, threat_safe, clear_mode 2025-10-01 23:42:10.220 | INFO | [StopCondition_MapAchievement] non_stop 2025-10-01 23:42:10.224 | INFO | Fast_Forward set to on 2025-10-01 23:42:10.228 | INFO | [Fast_Forward] on 2025-10-01 23:42:10.245 | INFO | Auto_Search set to on 2025-10-01 23:42:10.251 | INFO | [Auto_Search] on 2025-10-01 23:42:10.256 | INFO | Click ( 932, 530) @ MAP_PREPARATION 2025-10-01 23:42:10.782 | INFO | Handling 2x book setting, mode=prep. 2025-10-01 23:42:10.805 | INFO | Using fleet: [4, 3, 1] 2025-10-01 23:42:10.882 | INFO | Hard satisfied: Fleet_1: None, Fleet_2: None, Submarine: None 2025-10-01 23:42:10.891 | INFO | [map_allow_submarine] True 2025-10-01 23:42:10.896 | INFO | Click (1058, 473) @ SUBMARINE_CHOOSE 2025-10-01 23:42:11.077 | INFO | Current selected: [1] 2025-10-01 23:42:11.081 | INFO | Click (1065, 462) @ SUBMARINE_CHOOSE 2025-10-01 23:42:11.382 | INFO | Click (1131, 318) @ FLEET_2_CLEAR 2025-10-01 23:42:11.983 | INFO | Click (1041, 220) @ FLEET_1_CHOOSE 2025-10-01 23:42:12.280 | INFO | Current selected: [4] 2025-10-01 23:42:12.283 | INFO | Click (1062, 204) @ FLEET_1_CHOOSE 2025-10-01 23:42:12.581 | INFO | Click (1046, 340) @ FLEET_2_CHOOSE 2025-10-01 23:42:12.880 | INFO | Current selected: [4] 2025-10-01 23:42:12.883 | INFO | Click (1084, 471) @ FLEET_2_BAR_INDEX_3 2025-10-01 23:42:13.184 | INFO | Auto search setting 2025-10-01 23:42:13.199 | INFO | [_fleet_sidebar_offset] 0 2025-10-01 23:42:13.204 | INFO | [Fleet_sidebar] 1/3 2025-10-01 23:42:13.208 | INFO | Click (1205, 426) @ FLEET_SIDEBAR_0_2 2025-10-01 23:42:13.709 | INFO | [_fleet_sidebar_offset] 0 2025-10-01 23:42:13.713 | INFO | [Fleet_sidebar] 3/3 2025-10-01 23:42:13.716 | INFO | [Auto_Search_Setting] fleet1_all_fleet2_standby, sub_auto_call 2025-10-01 23:42:13.719 | INFO | Click ( 507, 219) @ AUTO_SEARCH_SET_MOB 2025-10-01 23:42:14.254 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_auto_call 2025-10-01 23:42:14.259 | INFO | Selected to the correct auto search setting 2025-10-01 23:42:14.261 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_auto_call 2025-10-01 23:42:14.265 | INFO | Selected to the correct auto search setting 2025-10-01 23:42:14.268 | INFO | Click (1075, 585) @ FLEET_PREPARATION 2025-10-01 23:42:15.169 | INFO | is_auto_search_running appeared ────────────────────────────────────────────────────── BATTLE_0 ─────────────────────────────────────────────────────── 2025-10-01 23:42:15.174 | INFO | BATTLE_0 2025-10-01 23:42:15.179 | INFO | Auto search moving 2025-10-01 23:42:15.194 | INFO | Fleet: 1, fleet_current_index: 1 2025-10-01 23:42:15.237 | INFO | [OCR_OIL 0.038s] 7378 2025-10-01 23:42:15.325 | INFO | [OCR_COIN 0.084s] 100173 2025-10-01 23:42:20.697 | INFO | [Loading] 11% 2025-10-01 23:42:20.701 | INFO | Auto search combat loading 2025-10-01 23:42:20.704 | INFO | Screenshot interval set to 1.0s 2025-10-01 23:42:26.698 | INFO | [BattleUI] PAUSE 2025-10-01 23:42:26.702 | INFO | Auto Search combat execute 2025-10-01 23:42:26.706 | INFO | <<< EMOTION REDUCE >>> 2025-10-01 23:42:26.723 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-10-01 23:42:26.731 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=51, Main.Emotion.Fleet1Record=datetime.datetime(2025, 10, 1, 23, 42, 26), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 10, 1, 23, 42, 26) 2025-10-01 23:42:26.749 | INFO | [Emotion fleet_1] 51 2025-10-01 23:42:26.763 | INFO | [Emotion fleet_2] 119 2025-10-01 23:42:32.699 | INFO | Combat auto check timer reached 2025-10-01 23:42:52.731 | INFO | Click (1022, 649) @ GET_SHIP 2025-10-01 23:42:53.730 | INFO | Screenshot interval set to 0.3s 2025-10-01 23:42:53.734 | INFO | Auto Search combat status 2025-10-01 23:42:53.751 | INFO | Click (1027, 664) @ GET_SHIP 2025-10-01 23:42:55.210 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_1 ─────────────────────────────────────────────────────── 2025-10-01 23:42:55.215 | INFO | BATTLE_1 2025-10-01 23:42:55.220 | INFO | Auto search moving 2025-10-01 23:42:55.225 | INFO | Fleet: 1, fleet_current_index: 1 2025-10-01 23:42:55.318 | INFO | [OCR_OIL 0.089s] 7337 2025-10-01 23:42:55.421 | INFO | [OCR_COIN 0.095s] 100189 2025-10-01 23:43:00.625 | INFO | Skip map cat attack 2025-10-01 23:43:00.629 | INFO | Click (1214, 686) @ MAP_CAT_ATTACK 2025-10-01 23:43:02.427 | INFO | [Loading] 9% 2025-10-01 23:43:02.430 | INFO | Auto search combat loading 2025-10-01 23:43:02.432 | INFO | Screenshot interval set to 1.0s 2025-10-01 23:43:08.438 | INFO | [BattleUI] PAUSE 2025-10-01 23:43:08.443 | INFO | Auto Search combat execute 2025-10-01 23:43:08.446 | INFO | <<< EMOTION REDUCE >>> 2025-10-01 23:43:08.456 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-10-01 23:43:08.460 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=49, Main.Emotion.Fleet1Record=datetime.datetime(2025, 10, 1, 23, 43, 8), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 10, 1, 23, 43, 8) 2025-10-01 23:43:08.476 | INFO | [Emotion fleet_1] 49 2025-10-01 23:43:08.481 | INFO | [Emotion fleet_2] 119 2025-10-01 23:43:14.437 | INFO | Combat auto check timer reached 2025-10-01 23:43:37.459 | INFO | Click (1016, 646) @ GET_SHIP 2025-10-01 23:43:38.475 | INFO | Click (1014, 658) @ GET_SHIP 2025-10-01 23:43:40.462 | INFO | Screenshot interval set to 0.3s 2025-10-01 23:43:40.466 | INFO | Auto Search combat status 2025-10-01 23:43:40.470 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_2 ─────────────────────────────────────────────────────── 2025-10-01 23:43:40.474 | INFO | BATTLE_2 2025-10-01 23:43:40.476 | INFO | Auto search moving 2025-10-01 23:43:40.481 | INFO | Fleet: 1, fleet_current_index: 1 2025-10-01 23:43:40.575 | INFO | [OCR_OIL 0.086s] 7296 2025-10-01 23:43:40.648 | INFO | [OCR_COIN 0.070s] 100212 2025-10-01 23:43:46.465 | INFO | [Loading] 7% 2025-10-01 23:43:46.469 | INFO | Auto search combat loading 2025-10-01 23:43:46.471 | INFO | Screenshot interval set to 1.0s 2025-10-01 23:43:52.463 | INFO | [BattleUI] PAUSE 2025-10-01 23:43:52.466 | INFO | Auto Search combat execute 2025-10-01 23:43:52.469 | INFO | <<< EMOTION REDUCE >>> 2025-10-01 23:43:52.479 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-10-01 23:43:52.488 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=47, Main.Emotion.Fleet1Record=datetime.datetime(2025, 10, 1, 23, 43, 52), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 10, 1, 23, 43, 52) 2025-10-01 23:43:52.505 | INFO | [Emotion fleet_1] 47 2025-10-01 23:43:52.508 | INFO | [Emotion fleet_2] 119 2025-10-01 23:43:58.468 | INFO | Combat auto check timer reached 2025-10-01 23:44:15.488 | INFO | Click (1028, 648) @ GET_SHIP 2025-10-01 23:44:16.498 | INFO | Click (1020, 681) @ GET_SHIP 2025-10-01 23:44:18.492 | INFO | Screenshot interval set to 0.3s 2025-10-01 23:44:18.495 | INFO | Auto Search combat status 2025-10-01 23:44:18.498 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_3 ─────────────────────────────────────────────────────── 2025-10-01 23:44:18.503 | INFO | BATTLE_3 2025-10-01 23:44:18.511 | INFO | Auto search moving 2025-10-01 23:44:18.515 | INFO | Fleet: 1, fleet_current_index: 1 2025-10-01 23:44:18.591 | INFO | [OCR_OIL 0.071s] 7255 2025-10-01 23:44:18.682 | INFO | [OCR_COIN 0.089s] 100225 2025-10-01 23:44:22.392 | INFO | [Loading] 4% 2025-10-01 23:44:22.396 | INFO | Auto search combat loading 2025-10-01 23:44:22.398 | INFO | Screenshot interval set to 1.0s 2025-10-01 23:44:28.398 | INFO | [BattleUI] PAUSE 2025-10-01 23:44:28.403 | INFO | Auto Search combat execute 2025-10-01 23:44:28.406 | INFO | <<< EMOTION REDUCE >>> 2025-10-01 23:44:28.425 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-10-01 23:44:28.433 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=45, Main.Emotion.Fleet1Record=datetime.datetime(2025, 10, 1, 23, 44, 28), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 10, 1, 23, 44, 28) 2025-10-01 23:44:28.461 | INFO | [Emotion fleet_1] 45 2025-10-01 23:44:28.471 | INFO | [Emotion fleet_2] 119 2025-10-01 23:44:34.404 | INFO | Combat auto check timer reached 2025-10-01 23:45:48.461 | INFO | Screenshot interval set to 0.3s 2025-10-01 23:45:48.466 | INFO | Auto Search combat status 2025-10-01 23:45:49.359 | INFO | Click (1039, 659) @ GET_SHIP 2025-10-01 23:45:50.557 | INFO | Click (1035, 676) @ GET_SHIP 2025-10-01 23:45:52.672 | INFO | Click (1020, 658) @ GET_SHIP 2025-10-01 23:45:53.869 | INFO | Click (1028, 659) @ GET_SHIP 2025-10-01 23:45:55.056 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_4 ─────────────────────────────────────────────────────── 2025-10-01 23:45:55.060 | INFO | BATTLE_4 2025-10-01 23:45:55.062 | INFO | Auto search moving 2025-10-01 23:45:55.066 | INFO | Fleet: 1, fleet_current_index: 1 2025-10-01 23:45:55.147 | INFO | [OCR_OIL 0.075s] 7232 2025-10-01 23:45:55.253 | INFO | [OCR_COIN 0.102s] 100245 2025-10-01 23:46:01.067 | INFO | [Loading] 11% 2025-10-01 23:46:01.070 | INFO | Auto search combat loading 2025-10-01 23:46:01.073 | INFO | Screenshot interval set to 1.0s 2025-10-01 23:46:07.070 | INFO | [BattleUI] PAUSE 2025-10-01 23:46:07.075 | INFO | Auto Search combat execute 2025-10-01 23:46:07.079 | INFO | <<< EMOTION REDUCE >>> 2025-10-01 23:46:07.090 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-10-01 23:46:07.095 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=43, Main.Emotion.Fleet1Record=datetime.datetime(2025, 10, 1, 23, 46, 7), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 10, 1, 23, 46, 7) 2025-10-01 23:46:07.112 | INFO | [Emotion fleet_1] 43 2025-10-01 23:46:07.117 | INFO | [Emotion fleet_2] 119 2025-10-01 23:46:13.077 | INFO | Combat auto check timer reached 2025-10-01 23:46:35.106 | INFO | Screenshot interval set to 0.3s 2025-10-01 23:46:35.111 | INFO | Auto Search combat status 2025-10-01 23:46:35.996 | INFO | Click (1005, 660) @ GET_SHIP 2025-10-01 23:46:37.196 | INFO | Click (1036, 678) @ GET_SHIP 2025-10-01 23:46:39.308 | INFO | Click (1031, 650) @ GET_SHIP 2025-10-01 23:46:40.511 | INFO | Click (1019, 663) @ GET_SHIP 2025-10-01 23:46:41.694 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_5 ─────────────────────────────────────────────────────── 2025-10-01 23:46:41.700 | INFO | BATTLE_5 2025-10-01 23:46:41.704 | INFO | Auto search moving 2025-10-01 23:46:41.708 | INFO | Fleet: 1, fleet_current_index: 1 2025-10-01 23:46:41.806 | INFO | [OCR_OIL 0.093s] 7209 2025-10-01 23:46:41.930 | INFO | [OCR_COIN 0.119s] 100258 2025-10-01 23:46:45.628 | INFO | Skip map cat attack 2025-10-01 23:46:45.632 | INFO | Click (1232, 672) @ MAP_CAT_ATTACK 2025-10-01 23:49:45.813 | 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 L1521 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 L422 run() campaign_base.py L143 run() campaign_base.py L177 auto_search_execute_a_battle() auto_search_combat.py L182 auto_search_moving() device.py L188 screenshot() device.py L250 stuck_record_check() device.py L43 show_function_call() 2025-10-01 23:49:45.834 | WARNING | Wait too long 2025-10-01 23:49:45.839 | WARNING | Waiting for {'CAMPAIGN_CHECK', 'SP_CHECK', 'PAUSE', 'EVENT_CHECK', 'GAME_TIPS3', 'AUTO_SEARCH_MAP_OPTION_OFF', 'GAME_TIPS4', 'DOCK_CHECK', 'RETIRE_APPEAR_3', 'GAME_TIPS', 'FLEET_NUM_1', 'AUTO_SEARCH_MAP_OPTION_ON'} 2025-10-01 23:49:45.904 | INFO | [Package_name] com.bilibili.azurlane 2025-10-01 23:49:45.910 | ERROR | GameStuckError: Wait too long 2025-10-01 23:49:45.914 | WARNING | Saving error: ./log/error/1759333785914