═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ MAIN ═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ ════════════════════════════════════════════════════ CAMPAIGN_13_1 ════════════════════════════════════════════════════ 2025-10-01 21:30:05.548 | INFO | CAMPAIGN_13_1 2025-10-01 21:30:05.550 | INFO | Count: 0 2025-10-01 21:30:05.568 | INFO | <<< UI ENSURE >>> 2025-10-01 21:30:05.572 | INFO | UI get current page 2025-10-01 21:30:06.094 | INFO | Unknown ui page 2025-10-01 21:30:06.573 | INFO | UI additional: IDLE_2 -> REWARD_GOTO_MAIN 2025-10-01 21:30:06.577 | INFO | Click ( 827, 614) @ REWARD_GOTO_MAIN 2025-10-01 21:30:06.754 | INFO | Unknown ui page 2025-10-01 21:30:06.921 | INFO | [Package_name] com.bilibili.azurlane 2025-10-01 21:30:06.939 | INFO | [Device Orientation] 0 (Normal) 2025-10-01 21:30:07.084 | INFO | Unknown ui page 2025-10-01 21:30:07.291 | INFO | [UI] page_main 2025-10-01 21:30:07.296 | INFO | Goto page_campaign 2025-10-01 21:30:07.300 | INFO | <<< UI GOTO PAGE_CAMPAIGN >>> 2025-10-01 21:30:07.317 | INFO | Page switch: page_main_white -> page_campaign_menu 2025-10-01 21:30:07.321 | INFO | Click (1185, 516) @ MAIN_GOTO_CAMPAIGN_WHITE 2025-10-01 21:30:07.895 | INFO | Page switch: page_campaign_menu -> page_campaign 2025-10-01 21:30:07.899 | INFO | Click ( 380, 290) @ CAMPAIGN_MENU_GOTO_CAMPAIGN 2025-10-01 21:30:08.191 | INFO | Page arrive: page_campaign 2025-10-01 21:30:08.216 | INFO | Mode_switch_1 set to hard 2025-10-01 21:30:08.246 | INFO | [Mode_switch_1] hard 2025-10-01 21:30:08.252 | INFO | <<< UI ENSURE INDEX >>> 2025-10-01 21:30:08.328 | INFO | No stage found. 2025-10-01 21:30:08.558 | INFO | No stage found. 2025-10-01 21:30:08.882 | INFO | Loading OCR model: ./bin/cnocr_models/azur_lane 2025-10-01 21:30:08.992 | INFO | [campaign 0.131s] ['-1', '--3', '--2', '--4'] 2025-10-01 21:30:09.226 | INFO | [campaign 0.062s] ['13--1', '13--3', '13--2', '13--4'] 2025-10-01 21:30:09.231 | INFO | [Chapter] 13 2025-10-01 21:30:09.234 | INFO | [Stage] 13-1, 13-3, 13-2, 13-4 2025-10-01 21:30:09.237 | INFO | [Index] 13 2025-10-01 21:30:09.315 | INFO | [OCR_OIL 0.050s] 8760 ──────────────────────────────────────────────────────── 13-1 ───────────────────────────────────────────────────────── 2025-10-01 21:30:09.321 | INFO | 13-1 2025-10-01 21:30:09.325 | INFO | Expect emotion reduce: (12, 2) 2025-10-01 21:30:09.336 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-10-01 21:30:09.339 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=53, Main.Emotion.Fleet1Record=datetime.datetime(2025, 10, 1, 21, 30, 9), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 10, 1, 21, 30, 9) 2025-10-01 21:30:09.359 | INFO | [Emotion fleet_1] 53 2025-10-01 21:30:09.364 | INFO | [Emotion fleet_2] 119 2025-10-01 21:30:09.368 | INFO | <<< ENTER MAP >>> 2025-10-01 21:30:09.447 | INFO | Click ( 199, 283) @ 13-1 2025-10-01 21:30:10.151 | INFO | [Map_clear_percentage] 53% 2025-10-01 21:30:10.453 | INFO | [Map_clear_percentage] 99% 2025-10-01 21:30:10.478 | INFO | [MAP_CLEAR_ALL_THIS_TIME] False 2025-10-01 21:30:10.484 | INFO | [Map_info] 99%, star_1, star_2, star_3, 100_percent_clear, 3_stars, threat_safe, clear_mode 2025-10-01 21:30:10.490 | INFO | [StopCondition_MapAchievement] non_stop 2025-10-01 21:30:10.493 | INFO | Fast_Forward set to on 2025-10-01 21:30:10.496 | INFO | [Fast_Forward] on 2025-10-01 21:30:10.511 | INFO | Auto_Search set to on 2025-10-01 21:30:10.516 | INFO | [Auto_Search] on 2025-10-01 21:30:10.523 | INFO | Click ( 931, 510) @ MAP_PREPARATION 2025-10-01 21:30:11.050 | INFO | Handling 2x book setting, mode=prep. 2025-10-01 21:30:11.073 | INFO | Using fleet: [4, 3, 1] 2025-10-01 21:30:11.150 | INFO | Hard satisfied: Fleet_1: None, Fleet_2: None, Submarine: None 2025-10-01 21:30:11.161 | INFO | [map_allow_submarine] True 2025-10-01 21:30:11.164 | INFO | Click (1068, 472) @ SUBMARINE_CHOOSE 2025-10-01 21:30:11.346 | INFO | Current selected: [1] 2025-10-01 21:30:11.350 | INFO | Click (1055, 470) @ SUBMARINE_CHOOSE 2025-10-01 21:30:11.653 | INFO | Click (1137, 328) @ FLEET_2_CLEAR 2025-10-01 21:30:12.254 | INFO | Click (1067, 225) @ FLEET_1_CHOOSE 2025-10-01 21:30:12.549 | INFO | Current selected: [4] 2025-10-01 21:30:12.555 | INFO | Click (1057, 215) @ FLEET_1_CHOOSE 2025-10-01 21:30:12.849 | INFO | Click (1059, 352) @ FLEET_2_CHOOSE 2025-10-01 21:30:13.153 | INFO | Current selected: [4] 2025-10-01 21:30:13.159 | INFO | Click (1129, 486) @ FLEET_2_BAR_INDEX_3 2025-10-01 21:30:13.453 | INFO | Auto search setting 2025-10-01 21:30:13.468 | INFO | [_fleet_sidebar_offset] 0 2025-10-01 21:30:13.473 | INFO | [Fleet_sidebar] 1/3 2025-10-01 21:30:13.476 | INFO | Click (1204, 437) @ FLEET_SIDEBAR_0_2 2025-10-01 21:30:13.991 | INFO | [_fleet_sidebar_offset] 0 2025-10-01 21:30:13.994 | INFO | [Fleet_sidebar] 3/3 2025-10-01 21:30:13.997 | INFO | [Auto_Search_Setting] fleet1_all_fleet2_standby, sub_auto_call 2025-10-01 21:30:14.002 | INFO | Click ( 506, 218) @ AUTO_SEARCH_SET_MOB 2025-10-01 21:30:14.487 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_auto_call 2025-10-01 21:30:14.491 | INFO | Selected to the correct auto search setting 2025-10-01 21:30:14.493 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_auto_call 2025-10-01 21:30:14.496 | INFO | Selected to the correct auto search setting 2025-10-01 21:30:14.498 | INFO | Click (1094, 594) @ FLEET_PREPARATION 2025-10-01 21:30:15.403 | INFO | is_auto_search_running appeared ────────────────────────────────────────────────────── BATTLE_0 ─────────────────────────────────────────────────────── 2025-10-01 21:30:15.409 | INFO | BATTLE_0 2025-10-01 21:30:15.412 | INFO | Auto search moving 2025-10-01 21:30:15.424 | INFO | Fleet: 1, fleet_current_index: 1 2025-10-01 21:30:15.493 | INFO | [OCR_OIL 0.065s] 8750 2025-10-01 21:30:15.577 | INFO | [OCR_COIN 0.080s] 98172 2025-10-01 21:30:20.030 | INFO | [Loading] 6% 2025-10-01 21:30:20.035 | INFO | Auto search combat loading 2025-10-01 21:30:20.039 | INFO | Screenshot interval set to 1.0s 2025-10-01 21:30:26.037 | INFO | [BattleUI] PAUSE 2025-10-01 21:30:26.042 | INFO | Auto Search combat execute 2025-10-01 21:30:26.045 | INFO | <<< EMOTION REDUCE >>> 2025-10-01 21:30:26.060 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-10-01 21:30:26.067 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=51, Main.Emotion.Fleet1Record=datetime.datetime(2025, 10, 1, 21, 30, 26), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 10, 1, 21, 30, 26) 2025-10-01 21:30:26.087 | INFO | [Emotion fleet_1] 51 2025-10-01 21:30:26.091 | INFO | [Emotion fleet_2] 119 2025-10-01 21:30:32.040 | INFO | Combat auto check timer reached 2025-10-01 21:30:51.061 | INFO | Click (1026, 660) @ GET_SHIP 2025-10-01 21:30:52.062 | INFO | Click (1031, 671) @ GET_SHIP 2025-10-01 21:30:55.082 | INFO | Click (1022, 646) @ GET_SHIP 2025-10-01 21:30:57.071 | INFO | Screenshot interval set to 0.3s 2025-10-01 21:30:57.075 | INFO | Auto Search combat status 2025-10-01 21:30:57.080 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_1 ─────────────────────────────────────────────────────── 2025-10-01 21:30:57.093 | INFO | BATTLE_1 2025-10-01 21:30:57.099 | INFO | Auto search moving 2025-10-01 21:30:57.105 | INFO | Fleet: 1, fleet_current_index: 1 2025-10-01 21:30:57.199 | INFO | [OCR_OIL 0.091s] 8709 2025-10-01 21:30:57.287 | INFO | [OCR_COIN 0.084s] 98187 2025-10-01 21:31:02.182 | INFO | [Loading] 9% 2025-10-01 21:31:02.187 | INFO | Auto search combat loading 2025-10-01 21:31:02.191 | INFO | Screenshot interval set to 1.0s 2025-10-01 21:31:08.191 | INFO | [BattleUI] PAUSE 2025-10-01 21:31:08.196 | INFO | Auto Search combat execute 2025-10-01 21:31:08.199 | INFO | <<< EMOTION REDUCE >>> 2025-10-01 21:31:08.210 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-10-01 21:31:08.215 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=49, Main.Emotion.Fleet1Record=datetime.datetime(2025, 10, 1, 21, 31, 8), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 10, 1, 21, 31, 8) 2025-10-01 21:31:08.229 | INFO | [Emotion fleet_1] 49 2025-10-01 21:31:08.236 | INFO | [Emotion fleet_2] 119 2025-10-01 21:31:14.190 | INFO | Combat auto check timer reached 2025-10-01 21:31:57.235 | INFO | Screenshot interval set to 0.3s 2025-10-01 21:31:57.239 | INFO | Auto Search combat status 2025-10-01 21:31:58.124 | INFO | Click (1036, 668) @ GET_SHIP 2025-10-01 21:31:59.337 | INFO | Click (1025, 663) @ GET_SHIP 2025-10-01 21:32:01.434 | INFO | Click (1043, 661) @ GET_SHIP 2025-10-01 21:32:02.638 | INFO | Click (1021, 660) @ GET_SHIP 2025-10-01 21:32:03.820 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_2 ─────────────────────────────────────────────────────── 2025-10-01 21:32:03.825 | INFO | BATTLE_2 2025-10-01 21:32:03.827 | INFO | Auto search moving 2025-10-01 21:32:03.832 | INFO | Fleet: 1, fleet_current_index: 1 2025-10-01 21:32:03.925 | INFO | [OCR_OIL 0.088s] 8686 2025-10-01 21:32:04.022 | INFO | [OCR_COIN 0.090s] 98204 2025-10-01 21:32:08.639 | INFO | [Loading] 11% 2025-10-01 21:32:08.643 | INFO | Auto search combat loading 2025-10-01 21:32:08.646 | INFO | Screenshot interval set to 1.0s 2025-10-01 21:32:14.644 | INFO | [BattleUI] PAUSE 2025-10-01 21:32:14.648 | INFO | Auto Search combat execute 2025-10-01 21:32:14.653 | INFO | <<< EMOTION REDUCE >>> 2025-10-01 21:32:14.665 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-10-01 21:32:14.672 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=47, Main.Emotion.Fleet1Record=datetime.datetime(2025, 10, 1, 21, 32, 14), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 10, 1, 21, 32, 14) 2025-10-01 21:32:14.688 | INFO | [Emotion fleet_1] 47 2025-10-01 21:32:14.692 | INFO | [Emotion fleet_2] 119 2025-10-01 21:32:20.639 | INFO | Combat auto check timer reached 2025-10-01 21:32:58.684 | INFO | Screenshot interval set to 0.3s 2025-10-01 21:32:58.687 | INFO | Auto Search combat status 2025-10-01 21:32:59.574 | INFO | Click (1011, 672) @ GET_SHIP 2025-10-01 21:33:01.078 | INFO | Click (1044, 652) @ GET_SHIP 2025-10-01 21:33:02.291 | INFO | Click (1048, 680) @ GET_SHIP 2025-10-01 21:33:03.168 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_3 ─────────────────────────────────────────────────────── 2025-10-01 21:33:03.176 | INFO | BATTLE_3 2025-10-01 21:33:03.180 | INFO | Auto search moving 2025-10-01 21:33:03.185 | INFO | Fleet: 1, fleet_current_index: 1 2025-10-01 21:33:03.262 | INFO | [OCR_OIL 0.074s] 8663 2025-10-01 21:33:03.346 | INFO | [OCR_COIN 0.081s] 98229 2025-10-01 21:33:07.383 | INFO | [Loading] 6% 2025-10-01 21:33:07.386 | INFO | Auto search combat loading 2025-10-01 21:33:07.390 | INFO | Screenshot interval set to 1.0s 2025-10-01 21:33:13.399 | INFO | [BattleUI] PAUSE 2025-10-01 21:33:13.404 | INFO | Auto Search combat execute 2025-10-01 21:33:13.407 | INFO | <<< EMOTION REDUCE >>> 2025-10-01 21:33:13.418 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-10-01 21:33:13.423 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=45, Main.Emotion.Fleet1Record=datetime.datetime(2025, 10, 1, 21, 33, 13), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 10, 1, 21, 33, 13) 2025-10-01 21:33:13.442 | INFO | [Emotion fleet_1] 45 2025-10-01 21:33:13.447 | INFO | [Emotion fleet_2] 119 2025-10-01 21:33:19.383 | INFO | Combat auto check timer reached 2025-10-01 21:33:58.433 | INFO | Click (1034, 676) @ GET_SHIP 2025-10-01 21:33:59.435 | INFO | Click (1027, 665) @ GET_SHIP 2025-10-01 21:34:01.453 | INFO | Click (1021, 653) @ GET_SHIP 2025-10-01 21:34:02.443 | INFO | Screenshot interval set to 0.3s 2025-10-01 21:34:02.446 | INFO | Auto Search combat status 2025-10-01 21:34:02.461 | INFO | Click (1037, 676) @ GET_SHIP 2025-10-01 21:34:03.922 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_4 ─────────────────────────────────────────────────────── 2025-10-01 21:34:03.927 | INFO | BATTLE_4 2025-10-01 21:34:03.930 | INFO | Auto search moving 2025-10-01 21:34:03.935 | INFO | Fleet: 1, fleet_current_index: 1 2025-10-01 21:34:04.037 | INFO | [OCR_OIL 0.099s] 8640 2025-10-01 21:34:04.146 | INFO | [OCR_COIN 0.104s] 98247 2025-10-01 21:34:08.444 | INFO | [Loading] 8% 2025-10-01 21:34:08.449 | INFO | Auto search combat loading 2025-10-01 21:34:08.454 | INFO | Screenshot interval set to 1.0s 2025-10-01 21:34:14.452 | INFO | [BattleUI] PAUSE 2025-10-01 21:34:14.456 | INFO | Auto Search combat execute 2025-10-01 21:34:14.459 | INFO | <<< EMOTION REDUCE >>> 2025-10-01 21:34:14.470 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-10-01 21:34:14.475 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=43, Main.Emotion.Fleet1Record=datetime.datetime(2025, 10, 1, 21, 34, 14), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 10, 1, 21, 34, 14) 2025-10-01 21:34:14.489 | INFO | [Emotion fleet_1] 43 2025-10-01 21:34:14.497 | INFO | [Emotion fleet_2] 119 2025-10-01 21:34:19.462 | INFO | Combat auto check timer reached 2025-10-01 21:34:58.504 | INFO | Screenshot interval set to 0.3s 2025-10-01 21:34:58.511 | INFO | Auto Search combat status 2025-10-01 21:34:59.377 | INFO | Click (1029, 671) @ GET_SHIP 2025-10-01 21:35:00.580 | INFO | Click (1032, 662) @ GET_SHIP 2025-10-01 21:35:02.683 | INFO | Click (1028, 655) @ GET_SHIP 2025-10-01 21:35:03.889 | INFO | Click (1049, 672) @ GET_SHIP 2025-10-01 21:35:05.082 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_5 ─────────────────────────────────────────────────────── 2025-10-01 21:35:05.087 | INFO | BATTLE_5 2025-10-01 21:35:05.089 | INFO | Auto search moving 2025-10-01 21:35:05.094 | INFO | Fleet: 1, fleet_current_index: 1 2025-10-01 21:35:05.187 | INFO | [OCR_OIL 0.087s] 8617 2025-10-01 21:35:05.289 | INFO | [OCR_COIN 0.097s] 98259 2025-10-01 21:38:05.250 | 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 21:38:05.272 | WARNING | Wait too long 2025-10-01 21:38:05.275 | WARNING | Waiting for {'CAMPAIGN_CHECK', 'SP_CHECK', 'PAUSE', 'EVENT_CHECK', 'GAME_TIPS3', 'AUTO_SEARCH_MAP_OPTION_OFF', 'GAME_TIPS4', 'OCR_OIL_CHECK', 'RETIRE_APPEAR_3', 'DOCK_CHECK', 'GAME_TIPS', 'FLEET_NUM_1', 'AUTO_SEARCH_MAP_OPTION_ON'} 2025-10-01 21:38:05.345 | INFO | [Package_name] com.bilibili.azurlane 2025-10-01 21:38:05.349 | ERROR | GameStuckError: Wait too long 2025-10-01 21:38:05.351 | WARNING | Saving error: ./log/error/1759325885351