═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ MAIN ═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ ════════════════════════════════════════════════════ CAMPAIGN_13_1 ════════════════════════════════════════════════════ 2025-10-02 08:06:01.667 | INFO | CAMPAIGN_13_1 2025-10-02 08:06:01.673 | INFO | Count: 0 2025-10-02 08:06:01.694 | INFO | <<< UI ENSURE >>> 2025-10-02 08:06:01.698 | INFO | UI get current page 2025-10-02 08:06:02.227 | INFO | Unknown ui page 2025-10-02 08:06:02.697 | INFO | UI additional: IDLE -> REWARD_GOTO_MAIN 2025-10-02 08:06:02.700 | INFO | Click ( 829, 616) @ REWARD_GOTO_MAIN 2025-10-02 08:06:02.883 | INFO | Unknown ui page 2025-10-02 08:06:03.027 | INFO | [Package_name] com.bilibili.azurlane 2025-10-02 08:06:03.047 | INFO | [Device Orientation] 0 (Normal) 2025-10-02 08:06:03.189 | INFO | Unknown ui page 2025-10-02 08:06:03.403 | INFO | [UI] page_main 2025-10-02 08:06:03.408 | INFO | Goto page_campaign 2025-10-02 08:06:03.413 | INFO | <<< UI GOTO PAGE_CAMPAIGN >>> 2025-10-02 08:06:03.429 | INFO | Page switch: page_main_white -> page_campaign_menu 2025-10-02 08:06:03.434 | INFO | Click (1174, 502) @ MAIN_GOTO_CAMPAIGN_WHITE 2025-10-02 08:06:04.012 | INFO | Page switch: page_campaign_menu -> page_campaign 2025-10-02 08:06:04.015 | INFO | Click ( 427, 354) @ CAMPAIGN_MENU_GOTO_CAMPAIGN 2025-10-02 08:06:04.304 | INFO | Page arrive: page_campaign 2025-10-02 08:06:04.329 | INFO | Mode_switch_1 set to hard 2025-10-02 08:06:04.359 | INFO | [Mode_switch_1] hard 2025-10-02 08:06:04.364 | INFO | <<< UI ENSURE INDEX >>> 2025-10-02 08:06:04.442 | INFO | No stage found. 2025-10-02 08:06:04.667 | INFO | No stage found. 2025-10-02 08:06:04.970 | INFO | No stage found. 2025-10-02 08:06:05.289 | INFO | Loading OCR model: ./bin/cnocr_models/azur_lane 2025-10-02 08:06:05.405 | INFO | [campaign 0.133s] ['13--1', '13--3', '13--2', '13--4'] 2025-10-02 08:06:05.409 | INFO | [Chapter] 13 2025-10-02 08:06:05.412 | INFO | [Stage] 13-1, 13-3, 13-2, 13-4 2025-10-02 08:06:05.414 | INFO | [Index] 13 2025-10-02 08:06:05.484 | INFO | [OCR_OIL 0.042s] 3105 ──────────────────────────────────────────────────────── 13-1 ───────────────────────────────────────────────────────── 2025-10-02 08:06:05.489 | INFO | 13-1 2025-10-02 08:06:05.494 | INFO | Expect emotion reduce: (12, 2) 2025-10-02 08:06:05.510 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-10-02 08:06:05.516 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=53, Main.Emotion.Fleet1Record=datetime.datetime(2025, 10, 2, 8, 6, 5), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 10, 2, 8, 6, 5) 2025-10-02 08:06:05.535 | INFO | [Emotion fleet_1] 53 2025-10-02 08:06:05.539 | INFO | [Emotion fleet_2] 119 2025-10-02 08:06:05.541 | INFO | <<< ENTER MAP >>> 2025-10-02 08:06:05.618 | INFO | Click ( 195, 280) @ 13-1 2025-10-02 08:06:06.324 | INFO | [Map_clear_percentage] 54% 2025-10-02 08:06:06.621 | INFO | [Map_clear_percentage] 99% 2025-10-02 08:06:06.649 | INFO | [MAP_CLEAR_ALL_THIS_TIME] False 2025-10-02 08:06:06.654 | INFO | [Map_info] 99%, star_1, star_2, star_3, 100_percent_clear, 3_stars, threat_safe, clear_mode 2025-10-02 08:06:06.658 | INFO | [StopCondition_MapAchievement] non_stop 2025-10-02 08:06:06.663 | INFO | Fast_Forward set to on 2025-10-02 08:06:06.666 | INFO | [Fast_Forward] on 2025-10-02 08:06:06.680 | INFO | Auto_Search set to on 2025-10-02 08:06:06.685 | INFO | [Auto_Search] on 2025-10-02 08:06:06.689 | INFO | Click ( 995, 517) @ MAP_PREPARATION 2025-10-02 08:06:07.221 | INFO | Handling 2x book setting, mode=prep. 2025-10-02 08:06:07.245 | INFO | Using fleet: [4, 3, 1] 2025-10-02 08:06:07.319 | INFO | Hard satisfied: Fleet_1: None, Fleet_2: None, Submarine: None 2025-10-02 08:06:07.329 | INFO | [map_allow_submarine] True 2025-10-02 08:06:07.335 | INFO | Click (1055, 470) @ SUBMARINE_CHOOSE 2025-10-02 08:06:07.518 | INFO | Current selected: [1] 2025-10-02 08:06:07.522 | INFO | Click (1049, 492) @ SUBMARINE_CHOOSE 2025-10-02 08:06:07.826 | INFO | Click (1130, 319) @ FLEET_2_CLEAR 2025-10-02 08:06:08.422 | INFO | Click (1049, 238) @ FLEET_1_CHOOSE 2025-10-02 08:06:08.720 | INFO | Current selected: [4] 2025-10-02 08:06:08.724 | INFO | Click (1035, 232) @ FLEET_1_CHOOSE 2025-10-02 08:06:09.019 | INFO | Click (1032, 334) @ FLEET_2_CHOOSE 2025-10-02 08:06:09.319 | INFO | Current selected: [4] 2025-10-02 08:06:09.323 | INFO | Click (1133, 481) @ FLEET_2_BAR_INDEX_3 2025-10-02 08:06:09.624 | INFO | Auto search setting 2025-10-02 08:06:09.641 | INFO | [_fleet_sidebar_offset] 0 2025-10-02 08:06:09.646 | INFO | [Fleet_sidebar] 1/3 2025-10-02 08:06:09.650 | INFO | Click (1221, 445) @ FLEET_SIDEBAR_0_2 2025-10-02 08:06:10.180 | INFO | [_fleet_sidebar_offset] 0 2025-10-02 08:06:10.184 | INFO | [Fleet_sidebar] 3/3 2025-10-02 08:06:10.187 | INFO | [Auto_Search_Setting] fleet1_all_fleet2_standby, sub_auto_call 2025-10-02 08:06:10.190 | INFO | Click ( 504, 214) @ AUTO_SEARCH_SET_MOB 2025-10-02 08:06:10.746 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_auto_call 2025-10-02 08:06:10.751 | INFO | Selected to the correct auto search setting 2025-10-02 08:06:10.754 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_auto_call 2025-10-02 08:06:10.756 | INFO | Selected to the correct auto search setting 2025-10-02 08:06:10.758 | INFO | Click (1135, 571) @ FLEET_PREPARATION 2025-10-02 08:06:11.661 | INFO | is_auto_search_running appeared ────────────────────────────────────────────────────── BATTLE_0 ─────────────────────────────────────────────────────── 2025-10-02 08:06:11.669 | INFO | BATTLE_0 2025-10-02 08:06:11.672 | INFO | Auto search moving 2025-10-02 08:06:11.685 | INFO | Fleet: 1, fleet_current_index: 1 2025-10-02 08:06:11.761 | INFO | [OCR_OIL 0.071s] 3095 2025-10-02 08:06:11.848 | INFO | [OCR_COIN 0.081s] 121260 2025-10-02 08:06:16.579 | INFO | Skip map cat attack 2025-10-02 08:06:16.583 | INFO | Click (1187, 696) @ MAP_CAT_ATTACK 2025-10-02 08:06:18.393 | INFO | [Loading] 8% 2025-10-02 08:06:18.398 | INFO | Auto search combat loading 2025-10-02 08:06:18.402 | INFO | Screenshot interval set to 1.0s 2025-10-02 08:06:24.399 | INFO | [BattleUI] PAUSE 2025-10-02 08:06:24.404 | INFO | Auto Search combat execute 2025-10-02 08:06:24.406 | INFO | <<< EMOTION REDUCE >>> 2025-10-02 08:06:24.416 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-10-02 08:06:24.421 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=51, Main.Emotion.Fleet1Record=datetime.datetime(2025, 10, 2, 8, 6, 24), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 10, 2, 8, 6, 24) 2025-10-02 08:06:24.439 | INFO | [Emotion fleet_1] 51 2025-10-02 08:06:24.444 | INFO | [Emotion fleet_2] 119 2025-10-02 08:06:30.385 | INFO | Combat auto check timer reached 2025-10-02 08:06:43.409 | INFO | Click (1036, 650) @ GET_SHIP 2025-10-02 08:06:44.412 | INFO | Click (1033, 655) @ GET_SHIP 2025-10-02 08:06:47.422 | INFO | Click (1038, 661) @ GET_SHIP 2025-10-02 08:06:49.429 | INFO | Screenshot interval set to 0.3s 2025-10-02 08:06:49.433 | INFO | Auto Search combat status 2025-10-02 08:06:49.436 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_1 ─────────────────────────────────────────────────────── 2025-10-02 08:06:49.441 | INFO | BATTLE_1 2025-10-02 08:06:49.443 | INFO | Auto search moving 2025-10-02 08:06:49.447 | INFO | Fleet: 1, fleet_current_index: 1 2025-10-02 08:06:49.537 | INFO | [OCR_OIL 0.086s] 3054 2025-10-02 08:06:49.620 | INFO | [OCR_COIN 0.080s] 121276 2025-10-02 08:06:55.114 | INFO | [Loading] 15% 2025-10-02 08:06:55.118 | INFO | Auto search combat loading 2025-10-02 08:06:55.123 | INFO | Screenshot interval set to 1.0s 2025-10-02 08:07:01.120 | INFO | [BattleUI] PAUSE 2025-10-02 08:07:01.124 | INFO | Auto Search combat execute 2025-10-02 08:07:01.127 | INFO | <<< EMOTION REDUCE >>> 2025-10-02 08:07:01.138 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-10-02 08:07:01.144 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=49, Main.Emotion.Fleet1Record=datetime.datetime(2025, 10, 2, 8, 7, 1), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 10, 2, 8, 7, 1) 2025-10-02 08:07:01.163 | INFO | [Emotion fleet_1] 49 2025-10-02 08:07:01.167 | INFO | [Emotion fleet_2] 119 2025-10-02 08:07:07.115 | INFO | Combat auto check timer reached 2025-10-02 08:08:03.172 | INFO | Screenshot interval set to 0.3s 2025-10-02 08:08:03.177 | INFO | Auto Search combat status 2025-10-02 08:08:04.064 | INFO | Click (1027, 651) @ GET_SHIP 2025-10-02 08:08:05.269 | INFO | Click (1015, 659) @ GET_SHIP 2025-10-02 08:08:07.375 | INFO | Click (1033, 645) @ GET_SHIP 2025-10-02 08:08:08.577 | INFO | Click (1028, 661) @ GET_SHIP 2025-10-02 08:08:09.764 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_2 ─────────────────────────────────────────────────────── 2025-10-02 08:08:09.770 | INFO | BATTLE_2 2025-10-02 08:08:09.773 | INFO | Auto search moving 2025-10-02 08:08:09.777 | INFO | Fleet: 1, fleet_current_index: 1 2025-10-02 08:08:09.889 | INFO | [OCR_OIL 0.108s] 3031 2025-10-02 08:08:09.976 | INFO | [OCR_COIN 0.084s] 121290 2025-10-02 08:08:15.479 | INFO | Skip map cat attack 2025-10-02 08:08:15.484 | INFO | Click (1183, 677) @ MAP_CAT_ATTACK 2025-10-02 08:08:17.278 | INFO | [Loading] 13% 2025-10-02 08:08:17.282 | INFO | Auto search combat loading 2025-10-02 08:08:17.287 | INFO | Screenshot interval set to 1.0s 2025-10-02 08:08:23.301 | INFO | [BattleUI] PAUSE 2025-10-02 08:08:23.305 | INFO | Auto Search combat execute 2025-10-02 08:08:23.308 | INFO | <<< EMOTION REDUCE >>> 2025-10-02 08:08:23.319 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-10-02 08:08:23.323 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=47, Main.Emotion.Fleet1Record=datetime.datetime(2025, 10, 2, 8, 8, 23), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 10, 2, 8, 8, 23) 2025-10-02 08:08:23.340 | INFO | [Emotion fleet_1] 47 2025-10-02 08:08:23.349 | INFO | [Emotion fleet_2] 119 2025-10-02 08:08:29.278 | INFO | Combat auto check timer reached 2025-10-02 08:09:08.324 | INFO | Click (1028, 678) @ GET_SHIP 2025-10-02 08:09:09.324 | INFO | Click (1013, 666) @ GET_SHIP 2025-10-02 08:09:11.333 | INFO | Click (1041, 669) @ GET_SHIP 2025-10-02 08:09:12.335 | INFO | Click (1019, 663) @ GET_SHIP 2025-10-02 08:09:14.335 | INFO | Screenshot interval set to 0.3s 2025-10-02 08:09:14.338 | INFO | Auto Search combat status 2025-10-02 08:09:14.343 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_3 ─────────────────────────────────────────────────────── 2025-10-02 08:09:14.348 | INFO | BATTLE_3 2025-10-02 08:09:14.352 | INFO | Auto search moving 2025-10-02 08:09:14.358 | INFO | Fleet: 1, fleet_current_index: 1 2025-10-02 08:09:14.438 | INFO | [OCR_OIL 0.076s] 3008 2025-10-02 08:09:14.522 | INFO | [OCR_COIN 0.078s] 121315 2025-10-02 08:09:20.934 | INFO | [Loading] 4% 2025-10-02 08:09:20.942 | INFO | Auto search combat loading 2025-10-02 08:09:20.945 | INFO | Screenshot interval set to 1.0s 2025-10-02 08:09:26.936 | INFO | [BattleUI] PAUSE 2025-10-02 08:09:26.939 | INFO | Auto Search combat execute 2025-10-02 08:09:26.941 | INFO | <<< EMOTION REDUCE >>> 2025-10-02 08:09:26.953 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-10-02 08:09:26.957 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=45, Main.Emotion.Fleet1Record=datetime.datetime(2025, 10, 2, 8, 9, 26), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 10, 2, 8, 9, 26) 2025-10-02 08:09:26.970 | INFO | [Emotion fleet_1] 45 2025-10-02 08:09:26.977 | INFO | [Emotion fleet_2] 119 2025-10-02 08:09:32.940 | INFO | Combat auto check timer reached 2025-10-02 08:10:10.976 | INFO | Screenshot interval set to 0.3s 2025-10-02 08:10:10.979 | INFO | Auto Search combat status 2025-10-02 08:10:11.877 | INFO | Click (1012, 671) @ GET_SHIP 2025-10-02 08:10:13.378 | INFO | Click (1013, 652) @ GET_SHIP 2025-10-02 08:10:14.600 | INFO | Click (1040, 653) @ GET_SHIP 2025-10-02 08:10:15.467 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_4 ─────────────────────────────────────────────────────── 2025-10-02 08:10:15.473 | INFO | BATTLE_4 2025-10-02 08:10:15.475 | INFO | Auto search moving 2025-10-02 08:10:15.479 | INFO | Fleet: 1, fleet_current_index: 1 2025-10-02 08:10:15.561 | INFO | [OCR_OIL 0.078s] 2985 2025-10-02 08:10:15.649 | INFO | [OCR_COIN 0.084s] 121337 2025-10-02 08:10:22.381 | INFO | [Loading] 12% 2025-10-02 08:10:22.387 | INFO | Auto search combat loading 2025-10-02 08:10:22.390 | INFO | Screenshot interval set to 1.0s 2025-10-02 08:10:28.393 | INFO | [BattleUI] PAUSE 2025-10-02 08:10:28.397 | INFO | Auto Search combat execute 2025-10-02 08:10:28.400 | INFO | <<< EMOTION REDUCE >>> 2025-10-02 08:10:28.410 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-10-02 08:10:28.415 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=43, Main.Emotion.Fleet1Record=datetime.datetime(2025, 10, 2, 8, 10, 28), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 10, 2, 8, 10, 28) 2025-10-02 08:10:28.428 | INFO | [Emotion fleet_1] 43 2025-10-02 08:10:28.436 | INFO | [Emotion fleet_2] 119 2025-10-02 08:10:34.385 | INFO | Combat auto check timer reached 2025-10-02 08:11:29.460 | INFO | Screenshot interval set to 0.3s 2025-10-02 08:11:29.465 | INFO | Auto Search combat status 2025-10-02 08:11:30.339 | INFO | Click (1007, 667) @ GET_SHIP 2025-10-02 08:11:31.534 | INFO | Click (1037, 667) @ GET_SHIP 2025-10-02 08:11:33.648 | INFO | Click (1020, 668) @ GET_SHIP 2025-10-02 08:11:34.847 | INFO | Click (1041, 656) @ GET_SHIP 2025-10-02 08:11:35.730 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_5 ─────────────────────────────────────────────────────── 2025-10-02 08:11:35.734 | INFO | BATTLE_5 2025-10-02 08:11:35.737 | INFO | Auto search moving 2025-10-02 08:11:35.742 | INFO | Fleet: 1, fleet_current_index: 1 2025-10-02 08:11:35.828 | INFO | [OCR_OIL 0.080s] 2962 2025-10-02 08:11:35.909 | INFO | [OCR_COIN 0.078s] 121366 2025-10-02 08:14:35.947 | 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 08:14:35.977 | WARNING | Wait too long 2025-10-02 08:14:35.981 | 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-02 08:14:36.049 | INFO | [Package_name] com.bilibili.azurlane 2025-10-02 08:14:36.055 | ERROR | GameStuckError: Wait too long 2025-10-02 08:14:36.061 | WARNING | Saving error: ./log/error/1759364076061