═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ MAIN ═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ ════════════════════════════════════════════════════ CAMPAIGN_13_1 ════════════════════════════════════════════════════ 2025-10-02 00:48:02.802 | INFO | CAMPAIGN_13_1 2025-10-02 00:48:02.805 | INFO | Count: 0 2025-10-02 00:48:02.822 | INFO | <<< UI ENSURE >>> 2025-10-02 00:48:02.827 | INFO | UI get current page 2025-10-02 00:48:03.344 | INFO | Unknown ui page 2025-10-02 00:48:03.809 | INFO | UI additional: IDLE -> REWARD_GOTO_MAIN 2025-10-02 00:48:03.813 | INFO | Click ( 833, 629) @ REWARD_GOTO_MAIN 2025-10-02 00:48:03.985 | INFO | Unknown ui page 2025-10-02 00:48:04.171 | INFO | [Package_name] com.bilibili.azurlane 2025-10-02 00:48:04.188 | INFO | [Device Orientation] 0 (Normal) 2025-10-02 00:48:04.330 | INFO | Unknown ui page 2025-10-02 00:48:04.541 | INFO | [UI] page_main 2025-10-02 00:48:04.544 | INFO | Goto page_campaign 2025-10-02 00:48:04.547 | INFO | <<< UI GOTO PAGE_CAMPAIGN >>> 2025-10-02 00:48:04.563 | INFO | Page switch: page_main_white -> page_campaign_menu 2025-10-02 00:48:04.567 | INFO | Click (1218, 515) @ MAIN_GOTO_CAMPAIGN_WHITE 2025-10-02 00:48:05.143 | INFO | Page switch: page_campaign_menu -> page_campaign 2025-10-02 00:48:05.146 | INFO | Click ( 387, 250) @ CAMPAIGN_MENU_GOTO_CAMPAIGN 2025-10-02 00:48:05.441 | INFO | Page arrive: page_campaign 2025-10-02 00:48:05.470 | INFO | Mode_switch_1 set to hard 2025-10-02 00:48:05.499 | INFO | [Mode_switch_1] hard 2025-10-02 00:48:05.503 | INFO | <<< UI ENSURE INDEX >>> 2025-10-02 00:48:05.581 | INFO | No stage found. 2025-10-02 00:48:05.804 | INFO | No stage found. 2025-10-02 00:48:06.122 | INFO | Loading OCR model: ./bin/cnocr_models/azur_lane 2025-10-02 00:48:06.238 | INFO | [campaign 0.134s] ['13--1', '13--3', '13--2', '13--4'] 2025-10-02 00:48:06.241 | INFO | [Chapter] 13 2025-10-02 00:48:06.244 | INFO | [Stage] 13-1, 13-3, 13-2, 13-4 2025-10-02 00:48:06.247 | INFO | [Index] 13 2025-10-02 00:48:06.316 | INFO | [OCR_OIL 0.041s] 6674 ──────────────────────────────────────────────────────── 13-1 ───────────────────────────────────────────────────────── 2025-10-02 00:48:06.321 | INFO | 13-1 2025-10-02 00:48:06.326 | INFO | Expect emotion reduce: (12, 2) 2025-10-02 00:48:06.339 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-10-02 00:48:06.343 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=53, Main.Emotion.Fleet1Record=datetime.datetime(2025, 10, 2, 0, 48, 6), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 10, 2, 0, 48, 6) 2025-10-02 00:48:06.359 | INFO | [Emotion fleet_1] 53 2025-10-02 00:48:06.364 | INFO | [Emotion fleet_2] 119 2025-10-02 00:48:06.367 | INFO | <<< ENTER MAP >>> 2025-10-02 00:48:06.443 | INFO | Click ( 189, 272) @ 13-1 2025-10-02 00:48:07.151 | INFO | [Map_clear_percentage] 52% 2025-10-02 00:48:07.446 | INFO | [Map_clear_percentage] 99% 2025-10-02 00:48:07.470 | INFO | [MAP_CLEAR_ALL_THIS_TIME] False 2025-10-02 00:48:07.474 | INFO | [Map_info] 99%, star_1, star_2, star_3, 100_percent_clear, 3_stars, threat_safe, clear_mode 2025-10-02 00:48:07.479 | INFO | [StopCondition_MapAchievement] non_stop 2025-10-02 00:48:07.482 | INFO | Fast_Forward set to on 2025-10-02 00:48:07.485 | INFO | [Fast_Forward] on 2025-10-02 00:48:07.500 | INFO | Auto_Search set to on 2025-10-02 00:48:07.506 | INFO | [Auto_Search] on 2025-10-02 00:48:07.511 | INFO | Click ( 970, 504) @ MAP_PREPARATION 2025-10-02 00:48:07.756 | INFO | Handling 2x book setting, mode=prep. 2025-10-02 00:48:08.051 | INFO | Using fleet: [4, 3, 1] 2025-10-02 00:48:08.128 | INFO | Hard satisfied: Fleet_1: None, Fleet_2: None, Submarine: None 2025-10-02 00:48:08.138 | INFO | [map_allow_submarine] True 2025-10-02 00:48:08.143 | INFO | Click (1064, 469) @ SUBMARINE_CHOOSE 2025-10-02 00:48:08.345 | INFO | Current selected: [1] 2025-10-02 00:48:08.349 | INFO | Click (1049, 482) @ SUBMARINE_CHOOSE 2025-10-02 00:48:08.648 | INFO | Click (1144, 323) @ FLEET_2_CLEAR 2025-10-02 00:48:09.245 | INFO | Click (1031, 218) @ FLEET_1_CHOOSE 2025-10-02 00:48:09.541 | INFO | Current selected: [4] 2025-10-02 00:48:09.547 | INFO | Click (1050, 208) @ FLEET_1_CHOOSE 2025-10-02 00:48:09.841 | INFO | Click (1045, 331) @ FLEET_2_CHOOSE 2025-10-02 00:48:10.141 | INFO | Current selected: [4] 2025-10-02 00:48:10.147 | INFO | Click (1092, 490) @ FLEET_2_BAR_INDEX_3 2025-10-02 00:48:10.451 | INFO | Auto search setting 2025-10-02 00:48:10.466 | INFO | [_fleet_sidebar_offset] 0 2025-10-02 00:48:10.471 | INFO | [Fleet_sidebar] 1/3 2025-10-02 00:48:10.476 | INFO | Click (1226, 424) @ FLEET_SIDEBAR_0_2 2025-10-02 00:48:11.029 | INFO | [_fleet_sidebar_offset] 0 2025-10-02 00:48:11.034 | INFO | [Fleet_sidebar] 3/3 2025-10-02 00:48:11.037 | INFO | [Auto_Search_Setting] fleet1_all_fleet2_standby, sub_auto_call 2025-10-02 00:48:11.039 | INFO | Click ( 509, 216) @ AUTO_SEARCH_SET_MOB 2025-10-02 00:48:11.484 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_auto_call 2025-10-02 00:48:11.488 | INFO | Selected to the correct auto search setting 2025-10-02 00:48:11.492 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_auto_call 2025-10-02 00:48:11.495 | INFO | Selected to the correct auto search setting 2025-10-02 00:48:11.500 | INFO | Click (1055, 577) @ FLEET_PREPARATION 2025-10-02 00:48:12.401 | INFO | is_auto_search_running appeared ────────────────────────────────────────────────────── BATTLE_0 ─────────────────────────────────────────────────────── 2025-10-02 00:48:12.406 | INFO | BATTLE_0 2025-10-02 00:48:12.408 | INFO | Auto search moving 2025-10-02 00:48:12.423 | INFO | Fleet: 1, fleet_current_index: 1 2025-10-02 00:48:12.477 | INFO | [OCR_OIL 0.050s] 6664 2025-10-02 00:48:12.554 | INFO | [OCR_COIN 0.072s] 104569 2025-10-02 00:48:17.002 | INFO | [Loading] 5% 2025-10-02 00:48:17.004 | INFO | Auto search combat loading 2025-10-02 00:48:17.009 | INFO | Screenshot interval set to 1.0s 2025-10-02 00:48:23.021 | INFO | [BattleUI] PAUSE 2025-10-02 00:48:23.026 | INFO | Auto Search combat execute 2025-10-02 00:48:23.029 | INFO | <<< EMOTION REDUCE >>> 2025-10-02 00:48:23.045 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-10-02 00:48:23.051 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=51, Main.Emotion.Fleet1Record=datetime.datetime(2025, 10, 2, 0, 48, 23), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 10, 2, 0, 48, 23) 2025-10-02 00:48:23.070 | INFO | [Emotion fleet_1] 51 2025-10-02 00:48:23.077 | INFO | [Emotion fleet_2] 119 2025-10-02 00:48:29.018 | INFO | Combat auto check timer reached 2025-10-02 00:48:49.031 | INFO | Screenshot interval set to 0.3s 2025-10-02 00:48:49.035 | INFO | Auto Search combat status 2025-10-02 00:48:51.738 | INFO | Click (1011, 653) @ GET_SHIP 2025-10-02 00:48:52.927 | INFO | Click (1038, 665) @ GET_SHIP 2025-10-02 00:48:54.116 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_1 ─────────────────────────────────────────────────────── 2025-10-02 00:48:54.121 | INFO | BATTLE_1 2025-10-02 00:48:54.123 | INFO | Auto search moving 2025-10-02 00:48:54.130 | INFO | Fleet: 1, fleet_current_index: 1 2025-10-02 00:48:54.221 | INFO | [OCR_OIL 0.085s] 6623 2025-10-02 00:48:54.298 | INFO | [OCR_COIN 0.068s] 104583 2025-10-02 00:48:58.635 | INFO | [Loading] 4% 2025-10-02 00:48:58.639 | INFO | Auto search combat loading 2025-10-02 00:48:58.642 | INFO | Screenshot interval set to 1.0s 2025-10-02 00:49:04.638 | INFO | [BattleUI] PAUSE 2025-10-02 00:49:04.641 | INFO | Auto Search combat execute 2025-10-02 00:49:04.644 | INFO | <<< EMOTION REDUCE >>> 2025-10-02 00:49:04.660 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-10-02 00:49:04.664 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=49, Main.Emotion.Fleet1Record=datetime.datetime(2025, 10, 2, 0, 49, 4), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 10, 2, 0, 49, 4) 2025-10-02 00:49:04.680 | INFO | [Emotion fleet_1] 49 2025-10-02 00:49:04.686 | INFO | [Emotion fleet_2] 119 2025-10-02 00:49:10.635 | INFO | Combat auto check timer reached 2025-10-02 00:49:34.670 | INFO | Screenshot interval set to 0.3s 2025-10-02 00:49:34.674 | INFO | Auto Search combat status 2025-10-02 00:49:35.259 | INFO | Click (1022, 641) @ GET_SHIP 2025-10-02 00:49:36.457 | INFO | Click (1037, 646) @ GET_SHIP 2025-10-02 00:49:38.565 | INFO | Click (1019, 654) @ GET_SHIP 2025-10-02 00:49:39.771 | INFO | Click (1017, 654) @ GET_SHIP 2025-10-02 00:49:40.955 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_2 ─────────────────────────────────────────────────────── 2025-10-02 00:49:40.961 | INFO | BATTLE_2 2025-10-02 00:49:40.964 | INFO | Auto search moving 2025-10-02 00:49:40.969 | INFO | Fleet: 1, fleet_current_index: 1 2025-10-02 00:49:41.048 | INFO | [OCR_OIL 0.073s] 6600 2025-10-02 00:49:41.151 | INFO | [OCR_COIN 0.094s] 104600 2025-10-02 00:49:46.367 | INFO | Skip map cat attack 2025-10-02 00:49:46.370 | INFO | Click (1218, 692) @ MAP_CAT_ATTACK 2025-10-02 00:49:48.175 | INFO | [Loading] 15% 2025-10-02 00:49:48.179 | INFO | Auto search combat loading 2025-10-02 00:49:48.181 | INFO | Screenshot interval set to 1.0s 2025-10-02 00:49:53.175 | INFO | [BattleUI] PAUSE 2025-10-02 00:49:53.178 | INFO | Auto Search combat execute 2025-10-02 00:49:53.181 | INFO | <<< EMOTION REDUCE >>> 2025-10-02 00:49:53.193 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-10-02 00:49:53.199 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=47, Main.Emotion.Fleet1Record=datetime.datetime(2025, 10, 2, 0, 49, 53), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 10, 2, 0, 49, 53) 2025-10-02 00:49:53.212 | INFO | [Emotion fleet_1] 47 2025-10-02 00:49:53.218 | INFO | [Emotion fleet_2] 119 2025-10-02 00:49:59.178 | INFO | Combat auto check timer reached 2025-10-02 00:50:40.224 | INFO | Click (1048, 650) @ GET_SHIP 2025-10-02 00:50:42.226 | INFO | Click (1028, 653) @ GET_SHIP 2025-10-02 00:50:44.226 | INFO | Click (1027, 651) @ GET_SHIP 2025-10-02 00:50:45.244 | INFO | Click (1029, 660) @ GET_SHIP 2025-10-02 00:50:47.246 | INFO | Screenshot interval set to 0.3s 2025-10-02 00:50:47.249 | INFO | Auto Search combat status 2025-10-02 00:50:47.253 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_3 ─────────────────────────────────────────────────────── 2025-10-02 00:50:47.259 | INFO | BATTLE_3 2025-10-02 00:50:47.265 | INFO | Auto search moving 2025-10-02 00:50:47.271 | INFO | Fleet: 1, fleet_current_index: 1 2025-10-02 00:50:47.366 | INFO | [OCR_OIL 0.091s] 6577 2025-10-02 00:50:47.447 | INFO | [OCR_COIN 0.077s] 104619 2025-10-02 00:50:51.443 | INFO | [Loading] 4% 2025-10-02 00:50:51.446 | INFO | Auto search combat loading 2025-10-02 00:50:51.450 | INFO | Screenshot interval set to 1.0s 2025-10-02 00:50:57.453 | INFO | [BattleUI] PAUSE 2025-10-02 00:50:57.457 | INFO | Auto Search combat execute 2025-10-02 00:50:57.460 | INFO | <<< EMOTION REDUCE >>> 2025-10-02 00:50:57.471 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-10-02 00:50:57.475 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=45, Main.Emotion.Fleet1Record=datetime.datetime(2025, 10, 2, 0, 50, 57), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 10, 2, 0, 50, 57) 2025-10-02 00:50:57.490 | INFO | [Emotion fleet_1] 45 2025-10-02 00:50:57.498 | INFO | [Emotion fleet_2] 119 2025-10-02 00:51:03.450 | INFO | Combat auto check timer reached 2025-10-02 00:51:42.501 | INFO | Click (1017, 680) @ GET_SHIP 2025-10-02 00:51:44.494 | INFO | Click (1041, 644) @ GET_SHIP 2025-10-02 00:51:46.496 | INFO | Click (1034, 657) @ GET_SHIP 2025-10-02 00:51:47.511 | INFO | Click (1036, 660) @ GET_SHIP 2025-10-02 00:51:49.508 | INFO | Screenshot interval set to 0.3s 2025-10-02 00:51:49.511 | INFO | Auto Search combat status 2025-10-02 00:51:49.513 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_4 ─────────────────────────────────────────────────────── 2025-10-02 00:51:49.519 | INFO | BATTLE_4 2025-10-02 00:51:49.523 | INFO | Auto search moving 2025-10-02 00:51:49.529 | INFO | Fleet: 1, fleet_current_index: 1 2025-10-02 00:51:49.619 | INFO | [OCR_OIL 0.086s] 6554 2025-10-02 00:51:49.699 | INFO | [OCR_COIN 0.073s] 104635 2025-10-02 00:51:53.994 | INFO | Skip map cat attack 2025-10-02 00:51:53.997 | INFO | Click (1211, 669) @ MAP_CAT_ATTACK 2025-10-02 00:51:55.793 | INFO | [Loading] 9% 2025-10-02 00:51:55.797 | INFO | Auto search combat loading 2025-10-02 00:51:55.801 | INFO | Screenshot interval set to 1.0s 2025-10-02 00:52:01.800 | INFO | [BattleUI] PAUSE 2025-10-02 00:52:01.803 | INFO | Auto Search combat execute 2025-10-02 00:52:01.805 | INFO | <<< EMOTION REDUCE >>> 2025-10-02 00:52:01.818 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-10-02 00:52:01.823 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=43, Main.Emotion.Fleet1Record=datetime.datetime(2025, 10, 2, 0, 52, 1), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 10, 2, 0, 52, 1) 2025-10-02 00:52:01.835 | INFO | [Emotion fleet_1] 43 2025-10-02 00:52:01.840 | INFO | [Emotion fleet_2] 119 2025-10-02 00:52:06.810 | INFO | Combat auto check timer reached 2025-10-02 00:52:28.829 | INFO | Click (1052, 658) @ GET_SHIP 2025-10-02 00:52:29.829 | INFO | Click (1026, 658) @ GET_SHIP 2025-10-02 00:52:32.843 | INFO | Click (1035, 669) @ GET_SHIP 2025-10-02 00:52:34.836 | INFO | Screenshot interval set to 0.3s 2025-10-02 00:52:34.841 | INFO | Auto Search combat status 2025-10-02 00:52:34.848 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_5 ─────────────────────────────────────────────────────── 2025-10-02 00:52:34.852 | INFO | BATTLE_5 2025-10-02 00:52:34.856 | INFO | Auto search moving 2025-10-02 00:52:34.862 | INFO | Fleet: 1, fleet_current_index: 1 2025-10-02 00:52:34.967 | INFO | [OCR_OIL 0.099s] 6513 2025-10-02 00:52:35.055 | INFO | [OCR_COIN 0.085s] 104663 2025-10-02 00:52:38.143 | INFO | Skip map cat attack 2025-10-02 00:52:38.146 | INFO | Click (1197, 673) @ MAP_CAT_ATTACK 2025-10-02 00:55:38.317 | 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-02 00:55:38.339 | WARNING | Wait too long 2025-10-02 00:55:38.343 | 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-02 00:55:38.410 | INFO | [Package_name] com.bilibili.azurlane 2025-10-02 00:55:38.414 | ERROR | GameStuckError: Wait too long 2025-10-02 00:55:38.418 | WARNING | Saving error: ./log/error/1759337738418