═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ MAIN ═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ ════════════════════════════════════════════════════ CAMPAIGN_13_1 ════════════════════════════════════════════════════ 2025-12-11 08:00:03.001 | INFO | CAMPAIGN_13_1 2025-12-11 08:00:03.006 | INFO | Count: 0 2025-12-11 08:00:03.030 | INFO | <<< UI ENSURE >>> 2025-12-11 08:00:03.034 | INFO | UI get current page 2025-12-11 08:00:03.553 | INFO | Unknown ui page 2025-12-11 08:00:04.024 | INFO | UI additional: IDLE -> REWARD_GOTO_MAIN 2025-12-11 08:00:04.027 | INFO | Click ( 834, 607) @ REWARD_GOTO_MAIN 2025-12-11 08:00:04.197 | INFO | Unknown ui page 2025-12-11 08:00:04.336 | INFO | [Package_name] com.bilibili.azurlane 2025-12-11 08:00:04.358 | INFO | [Device Orientation] 0 (Normal) 2025-12-11 08:00:04.496 | INFO | Unknown ui page 2025-12-11 08:00:04.722 | INFO | [UI] page_main 2025-12-11 08:00:04.725 | INFO | Goto page_campaign 2025-12-11 08:00:04.728 | INFO | <<< UI GOTO PAGE_CAMPAIGN >>> 2025-12-11 08:00:04.744 | INFO | Page switch: page_main_white -> page_campaign_menu 2025-12-11 08:00:04.750 | INFO | Click (1162, 519) @ MAIN_GOTO_CAMPAIGN_WHITE 2025-12-11 08:00:05.327 | INFO | Page switch: page_campaign_menu -> page_campaign 2025-12-11 08:00:05.330 | INFO | Click ( 319, 399) @ CAMPAIGN_MENU_GOTO_CAMPAIGN 2025-12-11 08:00:05.621 | INFO | Page arrive: page_campaign 2025-12-11 08:00:05.652 | INFO | Mode_switch_1 set to hard 2025-12-11 08:00:05.690 | INFO | [Mode_switch_1] hard 2025-12-11 08:00:05.697 | INFO | <<< UI ENSURE INDEX >>> 2025-12-11 08:00:05.782 | INFO | No stage found. 2025-12-11 08:00:05.986 | INFO | No stage found. 2025-12-11 08:00:06.305 | INFO | Loading OCR model: ./bin/cnocr_models/azur_lane 2025-12-11 08:00:06.414 | INFO | [campaign 0.127s] ['I3--1', 'I3--3', 'I3--2', 'I3--4'] 2025-12-11 08:00:06.418 | INFO | [Chapter] i3 2025-12-11 08:00:06.420 | INFO | [Stage] i3-1, i3-3, i3-2, i3-4 2025-12-11 08:00:06.522 | INFO | <<< UI ENSURE >>> 2025-12-11 08:00:06.526 | INFO | UI get current page 2025-12-11 08:00:06.534 | INFO | [UI] page_campaign 2025-12-11 08:00:06.540 | INFO | Already at page_campaign 2025-12-11 08:00:06.546 | INFO | Mode_switch_1 set to hard 2025-12-11 08:00:06.552 | INFO | [Mode_switch_1] hard 2025-12-11 08:00:06.556 | INFO | <<< UI ENSURE INDEX >>> 2025-12-11 08:00:06.684 | INFO | [campaign 0.051s] ['13--1', '13--3', '13--2', '13--4'] 2025-12-11 08:00:06.688 | INFO | [Chapter] 13 2025-12-11 08:00:06.691 | INFO | [Stage] 13-1, 13-3, 13-2, 13-4 2025-12-11 08:00:06.694 | INFO | [Index] 13 2025-12-11 08:00:06.756 | INFO | [OCR_OIL 0.036s] 7195 ──────────────────────────────────────────────────────── 13-1 ───────────────────────────────────────────────────────── 2025-12-11 08:00:06.761 | INFO | 13-1 2025-12-11 08:00:06.763 | INFO | Expect emotion reduce: (12, 2) 2025-12-11 08:00:06.775 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-12-11 08:00:06.779 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=53, Main.Emotion.Fleet1Record=datetime.datetime(2025, 12, 11, 8, 0, 6), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 12, 11, 8, 0, 6) 2025-12-11 08:00:06.791 | INFO | [Emotion fleet_1] 53 2025-12-11 08:00:06.794 | INFO | [Emotion fleet_2] 119 2025-12-11 08:00:06.798 | INFO | <<< ENTER MAP >>> 2025-12-11 08:00:06.871 | INFO | Click ( 184, 280) @ 13-1 2025-12-11 08:00:07.270 | INFO | [Map_clear_percentage] 5% 2025-12-11 08:00:07.570 | INFO | [Map_clear_percentage] 65% 2025-12-11 08:00:07.873 | INFO | [Map_clear_percentage] 99% 2025-12-11 08:00:07.898 | INFO | [MAP_CLEAR_ALL_THIS_TIME] False 2025-12-11 08:00:07.902 | INFO | [Map_info] 99%, star_1, star_2, star_3, 100_percent_clear, 3_stars, threat_safe, clear_mode 2025-12-11 08:00:07.908 | INFO | [StopCondition_MapAchievement] non_stop 2025-12-11 08:00:07.913 | INFO | Fast_Forward set to on 2025-12-11 08:00:07.918 | INFO | [Fast_Forward] on 2025-12-11 08:00:07.932 | INFO | Auto_Search set to on 2025-12-11 08:00:07.938 | INFO | [Auto_Search] on 2025-12-11 08:00:07.944 | INFO | Click (1027, 498) @ MAP_PREPARATION 2025-12-11 08:00:08.474 | INFO | Handling 2x book setting, mode=prep. 2025-12-11 08:00:08.497 | INFO | Using fleet: [4, 3, 1] 2025-12-11 08:00:08.579 | INFO | Hard satisfied: Fleet_1: None, Fleet_2: None, Submarine: None 2025-12-11 08:00:08.588 | INFO | [map_allow_submarine] True 2025-12-11 08:00:08.593 | INFO | Click (1053, 469) @ SUBMARINE_CHOOSE 2025-12-11 08:00:08.771 | INFO | Current selected: [1] 2025-12-11 08:00:08.774 | INFO | Click (1065, 466) @ SUBMARINE_CHOOSE 2025-12-11 08:00:09.075 | INFO | Click (1135, 321) @ FLEET_2_CLEAR 2025-12-11 08:00:09.674 | INFO | Click (1050, 219) @ FLEET_1_CHOOSE 2025-12-11 08:00:09.971 | INFO | Current selected: [4] 2025-12-11 08:00:09.975 | INFO | Click (1056, 213) @ FLEET_1_CHOOSE 2025-12-11 08:00:10.271 | INFO | Click (1048, 342) @ FLEET_2_CHOOSE 2025-12-11 08:00:10.573 | INFO | Current selected: [4] 2025-12-11 08:00:10.578 | INFO | Click (1089, 480) @ FLEET_2_BAR_INDEX_3 2025-12-11 08:00:10.882 | INFO | Auto search setting 2025-12-11 08:00:10.900 | INFO | [_fleet_sidebar_offset] 0 2025-12-11 08:00:10.906 | INFO | [Fleet_sidebar] 1/3 2025-12-11 08:00:10.912 | INFO | Click (1199, 409) @ FLEET_SIDEBAR_0_2 2025-12-11 08:00:11.376 | INFO | [_fleet_sidebar_offset] 0 2025-12-11 08:00:11.381 | INFO | [Fleet_sidebar] 3/3 2025-12-11 08:00:11.384 | INFO | [Auto_Search_Setting] fleet1_all_fleet2_standby, sub_auto_call 2025-12-11 08:00:11.387 | INFO | Click ( 506, 220) @ AUTO_SEARCH_SET_MOB 2025-12-11 08:00:11.951 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_auto_call 2025-12-11 08:00:11.954 | INFO | Selected to the correct auto search setting 2025-12-11 08:00:11.957 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_auto_call 2025-12-11 08:00:11.962 | INFO | Selected to the correct auto search setting 2025-12-11 08:00:11.967 | INFO | Click (1070, 566) @ FLEET_PREPARATION 2025-12-11 08:00:12.865 | INFO | is_auto_search_running appeared ────────────────────────────────────────────────────── BATTLE_0 ─────────────────────────────────────────────────────── 2025-12-11 08:00:12.870 | INFO | BATTLE_0 2025-12-11 08:00:12.873 | INFO | Auto search moving 2025-12-11 08:00:12.886 | INFO | Fleet: 1, fleet_current_index: 1 2025-12-11 08:00:12.952 | INFO | [OCR_OIL 0.062s] 7185 2025-12-11 08:00:13.037 | INFO | [OCR_COIN 0.082s] 275863 2025-12-11 08:00:17.206 | INFO | [Loading] 7% 2025-12-11 08:00:17.212 | INFO | Auto search combat loading 2025-12-11 08:00:17.217 | INFO | Screenshot interval set to 1.0s 2025-12-11 08:00:24.239 | INFO | [BattleUI] PAUSE 2025-12-11 08:00:24.243 | INFO | Auto Search combat execute 2025-12-11 08:00:24.249 | INFO | <<< EMOTION REDUCE >>> 2025-12-11 08:00:24.266 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-12-11 08:00:24.275 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=51, Main.Emotion.Fleet1Record=datetime.datetime(2025, 12, 11, 8, 0, 24), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 12, 11, 8, 0, 24) 2025-12-11 08:00:24.294 | INFO | [Emotion fleet_1] 51 2025-12-11 08:00:24.298 | INFO | [Emotion fleet_2] 119 2025-12-11 08:00:30.216 | INFO | Combat auto check timer reached 2025-12-11 08:00:49.240 | INFO | Screenshot interval set to 0.3s 2025-12-11 08:00:49.243 | INFO | Auto Search combat status 2025-12-11 08:00:51.939 | INFO | Click (1013, 651) @ GET_SHIP 2025-12-11 08:00:53.168 | INFO | Click (1023, 649) @ GET_SHIP 2025-12-11 08:00:54.030 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_1 ─────────────────────────────────────────────────────── 2025-12-11 08:00:54.036 | INFO | BATTLE_1 2025-12-11 08:00:54.040 | INFO | Auto search moving 2025-12-11 08:00:54.045 | INFO | Fleet: 1, fleet_current_index: 1 2025-12-11 08:00:54.129 | INFO | [OCR_OIL 0.078s] 7144 2025-12-11 08:00:54.236 | INFO | [OCR_COIN 0.103s] 275882 2025-12-11 08:00:58.851 | INFO | [Loading] 10% 2025-12-11 08:00:58.855 | INFO | Auto search combat loading 2025-12-11 08:00:58.860 | INFO | Screenshot interval set to 1.0s 2025-12-11 08:01:04.856 | INFO | [BattleUI] PAUSE 2025-12-11 08:01:04.860 | INFO | Auto Search combat execute 2025-12-11 08:01:04.863 | INFO | <<< EMOTION REDUCE >>> 2025-12-11 08:01:04.875 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-12-11 08:01:04.882 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=49, Main.Emotion.Fleet1Record=datetime.datetime(2025, 12, 11, 8, 1, 4), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 12, 11, 8, 1, 4) 2025-12-11 08:01:04.902 | INFO | [Emotion fleet_1] 49 2025-12-11 08:01:04.906 | INFO | [Emotion fleet_2] 119 2025-12-11 08:01:10.847 | INFO | Combat auto check timer reached 2025-12-11 08:01:18.866 | INFO | Screenshot interval set to 0.3s 2025-12-11 08:01:18.869 | INFO | Auto Search combat status 2025-12-11 08:01:19.764 | INFO | Click (1036, 651) @ GET_SHIP 2025-12-11 08:01:20.959 | INFO | Click (1027, 662) @ GET_SHIP 2025-12-11 08:01:23.061 | INFO | Click (1030, 653) @ GET_SHIP 2025-12-11 08:01:24.065 | INFO | Click (1025, 676) @ GET_SHIP 2025-12-11 08:01:25.156 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_2 ─────────────────────────────────────────────────────── 2025-12-11 08:01:25.161 | INFO | BATTLE_2 2025-12-11 08:01:25.164 | INFO | Auto search moving 2025-12-11 08:01:25.172 | INFO | Fleet: 1, fleet_current_index: 1 2025-12-11 08:01:25.239 | INFO | [OCR_OIL 0.061s] 7103 2025-12-11 08:01:25.317 | INFO | [OCR_COIN 0.073s] 275902 2025-12-11 08:01:29.672 | INFO | [Loading] 8% 2025-12-11 08:01:29.675 | INFO | Auto search combat loading 2025-12-11 08:01:29.679 | INFO | Screenshot interval set to 1.0s 2025-12-11 08:01:35.686 | INFO | [BattleUI] PAUSE 2025-12-11 08:01:35.689 | INFO | Auto Search combat execute 2025-12-11 08:01:35.691 | INFO | <<< EMOTION REDUCE >>> 2025-12-11 08:01:35.705 | INFO | Bind task ['General', 'Alas', 'Main'] 2025-12-11 08:01:35.710 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=47, Main.Emotion.Fleet1Record=datetime.datetime(2025, 12, 11, 8, 1, 35), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2025, 12, 11, 8, 1, 35) 2025-12-11 08:01:35.738 | INFO | [Emotion fleet_1] 47 2025-12-11 08:01:35.748 | INFO | [Emotion fleet_2] 119 2025-12-11 08:01:41.675 | INFO | Combat auto check timer reached 2025-12-11 08:02:02.699 | INFO | Click (1038, 665) @ GET_SHIP 2025-12-11 08:02:04.702 | INFO | Click (1037, 672) @ GET_SHIP 2025-12-11 08:02:06.708 | INFO | Click (1009, 674) @ GET_SHIP 2025-12-11 08:02:07.714 | INFO | Click (1039, 663) @ GET_SHIP 2025-12-11 08:02:09.717 | INFO | Screenshot interval set to 0.3s 2025-12-11 08:02:09.722 | INFO | Auto Search combat status 2025-12-11 08:02:09.726 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_3 ─────────────────────────────────────────────────────── 2025-12-11 08:02:09.730 | INFO | BATTLE_3 2025-12-11 08:02:09.734 | INFO | Auto search moving 2025-12-11 08:02:09.738 | INFO | Fleet: 1, fleet_current_index: 1 2025-12-11 08:02:09.814 | INFO | [OCR_OIL 0.073s] 7062 2025-12-11 08:02:09.897 | INFO | [OCR_COIN 0.080s] 275917 2025-12-11 08:05:09.874 | 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 L426 run() campaign_base.py L143 run() campaign_base.py L177 auto_search_execute_a_battle() auto_search_combat.py L170 auto_search_moving() base.py L169 loop() device.py L188 screenshot() device.py L250 stuck_record_check() device.py L43 show_function_call() 2025-12-11 08:05:09.895 | WARNING | Wait too long 2025-12-11 08:05:09.900 | WARNING | Waiting for {'AUTO_SEARCH_MAP_OPTION_OFF', 'RETIRE_APPEAR_3', 'PAUSE', 'CAMPAIGN_CHECK', 'DOCK_CHECK', 'SP_CHECK', 'FLEET_NUM_1', 'GAME_TIPS', 'EVENT_CHECK', 'AUTO_SEARCH_MAP_OPTION_ON', 'OCR_OIL_CHECK', 'GAME_TIPS4', 'GAME_TIPS3'} 2025-12-11 08:05:09.954 | INFO | [Package_name] com.bilibili.azurlane 2025-12-11 08:05:09.957 | ERROR | GameStuckError: Wait too long 2025-12-11 08:05:09.961 | WARNING | Saving error: ./log/error/1765411509961