═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ MAIN ═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ ════════════════════════════════════════════════════ CAMPAIGN_13_1 ════════════════════════════════════════════════════ 2026-04-18 20:54:01.596 | INFO | CAMPAIGN_13_1 2026-04-18 20:54:01.599 | INFO | Count: 0 2026-04-18 20:54:01.616 | INFO | <<< UI ENSURE >>> 2026-04-18 20:54:01.623 | INFO | UI get current page 2026-04-18 20:54:01.638 | INFO | [UI] page_main 2026-04-18 20:54:01.641 | INFO | Goto page_campaign 2026-04-18 20:54:01.645 | INFO | <<< UI GOTO PAGE_CAMPAIGN >>> 2026-04-18 20:54:01.703 | INFO | Page switch: page_main_white -> page_campaign_menu 2026-04-18 20:54:01.707 | INFO | Click (1201, 486) @ MAIN_GOTO_CAMPAIGN_WHITE 2026-04-18 20:54:02.825 | INFO | Page switch: page_campaign_menu -> page_campaign 2026-04-18 20:54:02.828 | INFO | Click ( 375, 273) @ CAMPAIGN_MENU_GOTO_CAMPAIGN 2026-04-18 20:54:03.118 | INFO | Page arrive: page_campaign 2026-04-18 20:54:03.144 | INFO | Mode_switch_1 set to hard 2026-04-18 20:54:03.170 | INFO | [Mode_switch_1] hard 2026-04-18 20:54:03.173 | INFO | <<< UI ENSURE INDEX >>> 2026-04-18 20:54:03.246 | INFO | No stage found. 2026-04-18 20:54:03.482 | INFO | No stage found. 2026-04-18 20:54:03.803 | INFO | Loading OCR model: ./bin/cnocr_models/azur_lane 2026-04-18 20:54:03.907 | INFO | [campaign 0.122s] ['3-1', '3--3', '3--2', '3--4'] 2026-04-18 20:54:03.911 | INFO | [Chapter] 3 2026-04-18 20:54:03.913 | INFO | [Stage] 3-1, 3-3, 3-2, 3-4 2026-04-18 20:54:03.916 | INFO | [Index] 3 2026-04-18 20:54:04.152 | INFO | [campaign 0.067s] ['13--1', '13--3', '13--2', '13--4'] 2026-04-18 20:54:04.156 | INFO | [Chapter] 13 2026-04-18 20:54:04.158 | INFO | [Stage] 13-1, 13-3, 13-2, 13-4 2026-04-18 20:54:04.161 | INFO | [Index] 13 2026-04-18 20:54:04.227 | INFO | [OCR_OIL 0.040s] 17957 ──────────────────────────────────────────────────────── 13-1 ───────────────────────────────────────────────────────── 2026-04-18 20:54:04.231 | INFO | 13-1 2026-04-18 20:54:04.233 | INFO | Expect emotion reduce: (12, 2) 2026-04-18 20:54:04.246 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-04-18 20:54:04.250 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=53, Main.Emotion.Fleet1Record=datetime.datetime(2026, 4, 18, 20, 54, 4), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 4, 18, 20, 54, 4) 2026-04-18 20:54:04.262 | INFO | [Emotion fleet_1] 53 2026-04-18 20:54:04.265 | INFO | [Emotion fleet_2] 119 2026-04-18 20:54:04.270 | INFO | <<< ENTER MAP >>> 2026-04-18 20:54:04.343 | INFO | Click ( 196, 287) @ 13-1 2026-04-18 20:54:05.042 | INFO | [Map_clear_percentage] 69% 2026-04-18 20:54:05.347 | INFO | [Map_clear_percentage] 99% 2026-04-18 20:54:05.378 | INFO | [MAP_CLEAR_ALL_THIS_TIME] False 2026-04-18 20:54:05.381 | INFO | [Map_info] 99%, star_1, star_2, star_3, 100_percent_clear, 3_stars, threat_safe, clear_mode 2026-04-18 20:54:05.385 | INFO | [StopCondition_MapAchievement] non_stop 2026-04-18 20:54:05.390 | INFO | Fast_Forward set to on 2026-04-18 20:54:05.395 | INFO | [Fast_Forward] on 2026-04-18 20:54:05.412 | INFO | Auto_Search set to on 2026-04-18 20:54:05.417 | INFO | [Auto_Search] on 2026-04-18 20:54:05.423 | INFO | Click ( 983, 512) @ MAP_PREPARATION 2026-04-18 20:54:05.651 | INFO | Handling 2x book setting, mode=prep. 2026-04-18 20:54:05.950 | INFO | Using fleet: [4, 3, 1] 2026-04-18 20:54:06.027 | INFO | Hard satisfied: Fleet_1: None, Fleet_2: None, Submarine: None 2026-04-18 20:54:06.036 | INFO | [map_allow_submarine] True 2026-04-18 20:54:06.044 | INFO | Click (1150, 331) @ FLEET_2_CLEAR 2026-04-18 20:54:06.099 | INFO | Click (1045, 465) @ SUBMARINE_CHOOSE 2026-04-18 20:54:06.248 | INFO | Current selected: [1] 2026-04-18 20:54:06.252 | INFO | Click (1044, 463) @ SUBMARINE_CHOOSE 2026-04-18 20:54:06.546 | INFO | Click (1065, 232) @ FLEET_1_CHOOSE 2026-04-18 20:54:06.844 | INFO | Current selected: [4] 2026-04-18 20:54:06.849 | INFO | Click (1044, 222) @ FLEET_1_CHOOSE 2026-04-18 20:54:07.145 | INFO | Click (1074, 339) @ FLEET_2_CHOOSE 2026-04-18 20:54:07.445 | INFO | Current selected: [4] 2026-04-18 20:54:07.450 | INFO | Click (1083, 473) @ FLEET_2_BAR_INDEX_3 2026-04-18 20:54:07.748 | INFO | Auto search setting 2026-04-18 20:54:07.763 | INFO | [_fleet_sidebar_offset] 0 2026-04-18 20:54:07.770 | INFO | [_fleet_sidebar_offset] 0 2026-04-18 20:54:07.776 | INFO | [Fleet_sidebar] 1/3 2026-04-18 20:54:07.781 | INFO | Click (1216, 457) @ FLEET_SIDEBAR_0_2 2026-04-18 20:54:08.052 | INFO | [_fleet_sidebar_offset] 0 2026-04-18 20:54:08.058 | INFO | [Fleet_sidebar] 3/3 2026-04-18 20:54:08.061 | INFO | [Auto_Search_Setting] fleet1_all_fleet2_standby, sub_standby 2026-04-18 20:54:08.064 | INFO | Click ( 507, 218) @ AUTO_SEARCH_SET_MOB 2026-04-18 20:54:08.539 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_standby 2026-04-18 20:54:08.544 | INFO | Selected to the correct auto search setting 2026-04-18 20:54:08.547 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_standby 2026-04-18 20:54:08.550 | INFO | Selected to the correct auto search setting 2026-04-18 20:54:08.552 | INFO | Click (1117, 565) @ FLEET_PREPARATION 2026-04-18 20:54:09.463 | INFO | is_auto_search_running appeared ────────────────────────────────────────────────────── BATTLE_0 ─────────────────────────────────────────────────────── 2026-04-18 20:54:09.468 | INFO | BATTLE_0 2026-04-18 20:54:09.473 | INFO | Auto search moving 2026-04-18 20:54:09.487 | INFO | Fleet: 1, fleet_current_index: 1 2026-04-18 20:54:09.543 | INFO | [OCR_OIL 0.052s] 17947 2026-04-18 20:54:09.614 | INFO | [OCR_COIN 0.067s] 268243 2026-04-18 20:54:14.415 | INFO | [Loading] 13% 2026-04-18 20:54:14.419 | INFO | Auto search combat loading 2026-04-18 20:54:14.421 | INFO | Screenshot interval set to 1.0s 2026-04-18 20:54:20.434 | INFO | [BattleUI] PAUSE 2026-04-18 20:54:20.439 | INFO | Auto Search combat execute 2026-04-18 20:54:20.441 | INFO | <<< EMOTION REDUCE >>> 2026-04-18 20:54:20.452 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-04-18 20:54:20.459 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=51, Main.Emotion.Fleet1Record=datetime.datetime(2026, 4, 18, 20, 54, 20), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 4, 18, 20, 54, 20) 2026-04-18 20:54:20.496 | INFO | [Emotion fleet_1] 51 2026-04-18 20:54:20.503 | INFO | [Emotion fleet_2] 119 2026-04-18 20:54:26.414 | INFO | Combat auto check timer reached 2026-04-18 20:55:00.454 | INFO | Screenshot interval set to 0.3s 2026-04-18 20:55:00.457 | INFO | Auto Search combat status 2026-04-18 20:55:01.947 | INFO | Click (1029, 677) @ GET_SHIP 2026-04-18 20:55:03.148 | INFO | Click (1028, 675) @ GET_SHIP 2026-04-18 20:55:07.344 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_1 ─────────────────────────────────────────────────────── 2026-04-18 20:55:07.349 | INFO | BATTLE_1 2026-04-18 20:55:07.351 | INFO | Auto search moving 2026-04-18 20:55:07.355 | INFO | Fleet: 1, fleet_current_index: 1 2026-04-18 20:55:07.415 | INFO | [OCR_OIL 0.057s] 17928 2026-04-18 20:55:07.491 | INFO | [OCR_COIN 0.072s] 268264 2026-04-18 20:55:12.163 | INFO | [Loading] 21% 2026-04-18 20:55:12.167 | INFO | Auto search combat loading 2026-04-18 20:55:12.169 | INFO | Screenshot interval set to 1.0s 2026-04-18 20:55:17.161 | INFO | [BattleUI] PAUSE 2026-04-18 20:55:17.165 | INFO | Auto Search combat execute 2026-04-18 20:55:17.169 | INFO | <<< EMOTION REDUCE >>> 2026-04-18 20:55:17.181 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-04-18 20:55:17.186 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=49, Main.Emotion.Fleet1Record=datetime.datetime(2026, 4, 18, 20, 55, 17), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 4, 18, 20, 55, 17) 2026-04-18 20:55:17.206 | INFO | [Emotion fleet_1] 49 2026-04-18 20:55:17.209 | INFO | [Emotion fleet_2] 119 2026-04-18 20:55:22.169 | INFO | Combat auto check timer reached 2026-04-18 20:55:44.212 | INFO | Click (1041, 665) @ GET_SHIP 2026-04-18 20:55:45.196 | INFO | Screenshot interval set to 0.3s 2026-04-18 20:55:45.199 | INFO | Auto Search combat status 2026-04-18 20:55:45.483 | INFO | Click (1021, 656) @ GET_SHIP 2026-04-18 20:55:46.980 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_2 ─────────────────────────────────────────────────────── 2026-04-18 20:55:46.986 | INFO | BATTLE_2 2026-04-18 20:55:46.991 | INFO | Auto search moving 2026-04-18 20:55:46.997 | INFO | Fleet: 1, fleet_current_index: 1 2026-04-18 20:55:47.071 | INFO | [OCR_OIL 0.069s] 17909 2026-04-18 20:55:47.158 | INFO | [OCR_COIN 0.084s] 268274 2026-04-18 20:55:52.095 | INFO | [Loading] 22% 2026-04-18 20:55:52.103 | INFO | Auto search combat loading 2026-04-18 20:55:52.107 | INFO | Screenshot interval set to 1.0s 2026-04-18 20:55:57.095 | INFO | [BattleUI] PAUSE 2026-04-18 20:55:57.099 | INFO | Auto Search combat execute 2026-04-18 20:55:57.103 | INFO | <<< EMOTION REDUCE >>> 2026-04-18 20:55:57.119 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-04-18 20:55:57.127 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=47, Main.Emotion.Fleet1Record=datetime.datetime(2026, 4, 18, 20, 55, 57), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 4, 18, 20, 55, 57) 2026-04-18 20:55:57.144 | INFO | [Emotion fleet_1] 47 2026-04-18 20:55:57.148 | INFO | [Emotion fleet_2] 119 2026-04-18 20:56:02.104 | INFO | Combat auto check timer reached 2026-04-18 20:56:23.136 | INFO | Click (1031, 666) @ GET_SHIP 2026-04-18 20:56:25.129 | INFO | Click (1038, 656) @ GET_SHIP 2026-04-18 20:56:26.141 | INFO | Click (1044, 653) @ GET_SHIP 2026-04-18 20:56:28.134 | INFO | Click (1028, 653) @ GET_SHIP 2026-04-18 20:56:29.137 | INFO | Screenshot interval set to 0.3s 2026-04-18 20:56:29.141 | INFO | Auto Search combat status 2026-04-18 20:56:29.145 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_3 ─────────────────────────────────────────────────────── 2026-04-18 20:56:29.153 | INFO | BATTLE_3 2026-04-18 20:56:29.157 | INFO | Auto search moving 2026-04-18 20:56:29.162 | INFO | Fleet: 1, fleet_current_index: 1 2026-04-18 20:56:29.235 | INFO | [OCR_OIL 0.067s] 17890 2026-04-18 20:56:29.330 | INFO | [OCR_COIN 0.092s] 268292 2026-04-18 20:56:33.632 | INFO | [Loading] 8% 2026-04-18 20:56:33.635 | INFO | Auto search combat loading 2026-04-18 20:56:33.638 | INFO | Screenshot interval set to 1.0s 2026-04-18 20:56:38.637 | INFO | [BattleUI] PAUSE 2026-04-18 20:56:38.640 | INFO | Auto Search combat execute 2026-04-18 20:56:38.644 | INFO | <<< EMOTION REDUCE >>> 2026-04-18 20:56:38.660 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-04-18 20:56:38.665 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=45, Main.Emotion.Fleet1Record=datetime.datetime(2026, 4, 18, 20, 56, 38), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 4, 18, 20, 56, 38) 2026-04-18 20:56:38.681 | INFO | [Emotion fleet_1] 45 2026-04-18 20:56:38.685 | INFO | [Emotion fleet_2] 119 2026-04-18 20:56:44.639 | INFO | Combat auto check timer reached 2026-04-18 20:57:31.697 | INFO | Click (1021, 663) @ GET_SHIP 2026-04-18 20:57:33.697 | INFO | Click (1015, 658) @ GET_SHIP 2026-04-18 20:57:35.712 | INFO | Click (1025, 655) @ GET_SHIP 2026-04-18 20:57:36.703 | INFO | Screenshot interval set to 0.3s 2026-04-18 20:57:36.707 | INFO | Auto Search combat status 2026-04-18 20:57:36.721 | INFO | Click (1026, 662) @ GET_SHIP 2026-04-18 20:57:37.575 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_4 ─────────────────────────────────────────────────────── 2026-04-18 20:57:37.579 | INFO | BATTLE_4 2026-04-18 20:57:37.581 | INFO | Auto search moving 2026-04-18 20:57:37.587 | INFO | Fleet: 1, fleet_current_index: 1 2026-04-18 20:57:37.668 | INFO | [OCR_OIL 0.077s] 17871 2026-04-18 20:57:37.745 | INFO | [OCR_COIN 0.073s] 268311 2026-04-18 20:57:42.393 | INFO | [Loading] 9% 2026-04-18 20:57:42.396 | INFO | Auto search combat loading 2026-04-18 20:57:42.398 | INFO | Screenshot interval set to 1.0s 2026-04-18 20:57:48.418 | INFO | [BattleUI] PAUSE 2026-04-18 20:57:48.422 | INFO | Auto Search combat execute 2026-04-18 20:57:48.424 | INFO | <<< EMOTION REDUCE >>> 2026-04-18 20:57:48.437 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-04-18 20:57:48.443 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=43, Main.Emotion.Fleet1Record=datetime.datetime(2026, 4, 18, 20, 57, 48), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 4, 18, 20, 57, 48) 2026-04-18 20:57:48.462 | INFO | [Emotion fleet_1] 43 2026-04-18 20:57:48.467 | INFO | [Emotion fleet_2] 119 2026-04-18 20:57:54.413 | INFO | Combat auto check timer reached 2026-04-18 20:58:49.454 | INFO | Click (1031, 662) @ GET_SHIP 2026-04-18 20:58:50.507 | INFO | Click (1031, 654) @ GET_SHIP 2026-04-18 20:58:52.471 | INFO | Click (1018, 659) @ GET_SHIP 2026-04-18 20:58:53.466 | INFO | Screenshot interval set to 0.3s 2026-04-18 20:58:53.470 | INFO | Auto Search combat status 2026-04-18 20:58:53.483 | INFO | Click (1028, 671) @ GET_SHIP 2026-04-18 20:58:54.641 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_5 ─────────────────────────────────────────────────────── 2026-04-18 20:58:54.647 | INFO | BATTLE_5 2026-04-18 20:58:54.651 | INFO | Auto search moving 2026-04-18 20:58:54.655 | INFO | Fleet: 1, fleet_current_index: 1 2026-04-18 20:58:54.770 | INFO | [OCR_OIL 0.109s] 17852 2026-04-18 20:58:54.885 | INFO | [OCR_COIN 0.113s] 268323 2026-04-18 20:58:57.074 | INFO | [Loading] 8% 2026-04-18 20:58:57.077 | INFO | Auto search combat loading 2026-04-18 20:58:57.079 | INFO | Screenshot interval set to 1.0s 2026-04-18 20:59:03.108 | INFO | [BattleUI] PAUSE 2026-04-18 20:59:03.112 | INFO | Auto Search combat execute 2026-04-18 20:59:03.115 | INFO | <<< EMOTION REDUCE >>> 2026-04-18 20:59:03.129 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-04-18 20:59:03.134 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=41, Main.Emotion.Fleet1Record=datetime.datetime(2026, 4, 18, 20, 59, 3), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 4, 18, 20, 59, 3) 2026-04-18 20:59:03.151 | INFO | [Emotion fleet_1] 41 2026-04-18 20:59:03.155 | INFO | [Emotion fleet_2] 119 2026-04-18 20:59:09.075 | INFO | Combat auto check timer reached 2026-04-18 21:00:24.167 | INFO | Click (1022, 657) @ GET_SHIP 2026-04-18 21:03:24.321 | 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 L1525 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 L431 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-04-18 21:03:24.352 | WARNING | Wait too long 2026-04-18 21:03:24.358 | WARNING | Waiting for {'SP_CHECK', 'EXP_INFO_B', 'EVENT_CHECK', 'POPUP_CONFIRM_WHITE', 'GUILD_POPUP_CONFIRM', 'GET_MISSION', 'GET_SHIP', 'PAUSE', 'EXP_INFO_S', 'AUTO_SEARCH_MAP_OPTION_ON', 'NEW_SHIP', 'BATTLE_STATUS_S', 'CAMPAIGN_CHECK', 'EXP_INFO_A', 'POPUP_CANCEL', 'BATTLE_STATUS_A', 'BATTLE_STATUS_B', 'MISSION_POPUP_GO'} 2026-04-18 21:03:24.436 | INFO | [Package_name] com.bilibili.azurlane 2026-04-18 21:03:24.439 | ERROR | GameStuckError: Wait too long 2026-04-18 21:03:24.442 | WARNING | Saving error: ./log/error/1776517404442