═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ MAIN ═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ 2026-03-12 21:41:06.663 | INFO | Reuse forward: ForwardItem(serial='192.168.240.112:5555', local='tcp:20014', remote='tcp:53516') 2026-03-12 21:41:06.672 | INFO | [Device Orientation] 0 (Normal) 2026-03-12 21:41:06.679 | INFO | Reuse forward: ForwardItem(serial='192.168.240.112:5555', local='tcp:20065', remote='localabstract:minitouch') 2026-03-12 21:41:06.702 | INFO | 2026-03-12 21:41:06.709 | INFO | 2026-03-12 21:41:06.745 | INFO | [Screen_size] 1280x720 2026-03-12 21:41:07.097 | INFO | early_ocr_import call 2026-03-12 21:41:07.100 | INFO | early_ocr_import start 2026-03-12 21:41:07.105 | INFO | Loading OCR dependencies ════════════════════════════════════════════════════ CAMPAIGN_13_1 ════════════════════════════════════════════════════ 2026-03-12 21:41:07.130 | INFO | CAMPAIGN_13_1 2026-03-12 21:41:07.133 | INFO | Count: 0 2026-03-12 21:41:07.243 | INFO | <<< UI ENSURE >>> 2026-03-12 21:41:07.250 | INFO | UI get current page 2026-03-12 21:41:07.551 | INFO | [UI] page_event 2026-03-12 21:41:07.564 | INFO | Goto page_campaign 2026-03-12 21:41:07.568 | INFO | <<< UI GOTO PAGE_CAMPAIGN >>> 2026-03-12 21:41:07.604 | INFO | Page switch: page_event -> page_campaign 2026-03-12 21:41:07.608 | INFO | Click ( 59, 52) @ BACK_ARROW 2026-03-12 21:41:07.742 | INFO | v 1 2026-03-12 21:41:07.783 | INFO | ^ 10 1280 720 0 2026-03-12 21:41:07.808 | INFO | $ 2028 2026-03-12 21:41:07.817 | INFO | minitouch running on port: 20065, pid: 2028 2026-03-12 21:41:07.833 | INFO | max_contact: 10; max_x: 1280; max_y: 720; max_pressure: 0 2026-03-12 21:41:08.491 | INFO | early_ocr_import finish 2026-03-12 21:41:09.274 | INFO | Page arrive: page_campaign 2026-03-12 21:41:09.299 | INFO | Mode_switch_1 set to hard 2026-03-12 21:41:09.323 | INFO | [Mode_switch_1] hard 2026-03-12 21:41:09.326 | INFO | <<< UI ENSURE INDEX >>> 2026-03-12 21:41:09.425 | INFO | Loading OCR model: ./bin/cnocr_models/azur_lane 2026-03-12 21:41:09.572 | INFO | [campaign 0.170s] ['13--1', '13--3', '13--2', '13--4'] 2026-03-12 21:41:09.576 | INFO | [Chapter] 13 2026-03-12 21:41:09.581 | INFO | [Stage] 13-1, 13-3, 13-2, 13-4 2026-03-12 21:41:09.587 | INFO | [Index] 13 2026-03-12 21:41:09.675 | INFO | [OCR_OIL 0.055s] 4853 ──────────────────────────────────────────────────────── 13-1 ───────────────────────────────────────────────────────── 2026-03-12 21:41:09.682 | INFO | 13-1 2026-03-12 21:41:09.685 | INFO | Expect emotion reduce: (12, 2) 2026-03-12 21:41:09.695 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-03-12 21:41:09.698 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=119, Main.Emotion.Fleet1Record=datetime.datetime(2026, 3, 12, 21, 41, 9), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 3, 12, 21, 41, 9) 2026-03-12 21:41:09.714 | INFO | [Emotion fleet_1] 119 2026-03-12 21:41:09.719 | INFO | [Emotion fleet_2] 119 2026-03-12 21:41:09.722 | INFO | <<< ENTER MAP >>> 2026-03-12 21:41:09.796 | INFO | Click ( 176, 284) @ 13-1 2026-03-12 21:41:10.201 | INFO | [Map_clear_percentage] 5% 2026-03-12 21:41:10.509 | INFO | [Map_clear_percentage] 66% 2026-03-12 21:41:10.802 | INFO | [Map_clear_percentage] 99% 2026-03-12 21:41:10.828 | INFO | [MAP_CLEAR_ALL_THIS_TIME] False 2026-03-12 21:41:10.831 | INFO | [Map_info] 99%, star_1, star_2, star_3, 100_percent_clear, 3_stars, threat_safe, clear_mode 2026-03-12 21:41:10.836 | INFO | [StopCondition_MapAchievement] non_stop 2026-03-12 21:41:10.839 | INFO | Fast_Forward set to on 2026-03-12 21:41:10.842 | INFO | [Fast_Forward] on 2026-03-12 21:41:10.858 | INFO | Auto_Search set to on 2026-03-12 21:41:10.863 | INFO | [Auto_Search] on 2026-03-12 21:41:10.868 | INFO | Click ( 961, 515) @ MAP_PREPARATION 2026-03-12 21:41:11.398 | INFO | Handling 2x book setting, mode=prep. 2026-03-12 21:41:11.421 | INFO | Using fleet: [4, 3, 1] 2026-03-12 21:41:11.499 | INFO | Hard satisfied: Fleet_1: None, Fleet_2: None, Submarine: None 2026-03-12 21:41:11.509 | INFO | [map_allow_submarine] True 2026-03-12 21:41:11.515 | INFO | Click (1126, 335) @ FLEET_2_CLEAR 2026-03-12 21:41:11.569 | INFO | Click (1058, 463) @ SUBMARINE_CHOOSE 2026-03-12 21:41:11.995 | INFO | Current selected: [1] 2026-03-12 21:41:11.999 | INFO | Click (1040, 476) @ SUBMARINE_CHOOSE 2026-03-12 21:41:12.302 | INFO | Click (1053, 221) @ FLEET_1_CHOOSE 2026-03-12 21:41:12.597 | INFO | Current selected: [1] 2026-03-12 21:41:12.601 | INFO | Click (1056, 401) @ FLEET_1_BAR_INDEX_4 2026-03-12 21:41:12.899 | INFO | Click (1038, 349) @ FLEET_2_CHOOSE 2026-03-12 21:41:13.194 | INFO | Current selected: [4] 2026-03-12 21:41:13.199 | INFO | Click (1081, 485) @ FLEET_2_BAR_INDEX_3 2026-03-12 21:41:13.493 | INFO | Auto search setting 2026-03-12 21:41:13.508 | INFO | [_fleet_sidebar_offset] 0 2026-03-12 21:41:13.514 | INFO | [_fleet_sidebar_offset] 0 2026-03-12 21:41:13.518 | INFO | [Fleet_sidebar] 1/3 2026-03-12 21:41:13.523 | INFO | Click (1210, 452) @ FLEET_SIDEBAR_0_2 2026-03-12 21:41:13.798 | INFO | [_fleet_sidebar_offset] 0 2026-03-12 21:41:13.804 | INFO | [Fleet_sidebar] 3/3 2026-03-12 21:41:13.808 | INFO | [Auto_Search_Setting] fleet1_all_fleet2_standby, sub_auto_call 2026-03-12 21:41:13.813 | INFO | Click ( 507, 217) @ AUTO_SEARCH_SET_MOB 2026-03-12 21:41:14.315 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_auto_call 2026-03-12 21:41:14.320 | INFO | Selected to the correct auto search setting 2026-03-12 21:41:14.324 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_auto_call 2026-03-12 21:41:14.328 | INFO | Click ( 907, 473) @ AUTO_SEARCH_SET_SUB_STANDBY 2026-03-12 21:41:14.860 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_standby 2026-03-12 21:41:14.863 | INFO | Selected to the correct auto search setting 2026-03-12 21:41:14.865 | INFO | Click (1091, 596) @ FLEET_PREPARATION 2026-03-12 21:41:15.779 | INFO | is_auto_search_running appeared ────────────────────────────────────────────────────── BATTLE_0 ─────────────────────────────────────────────────────── 2026-03-12 21:41:15.784 | INFO | BATTLE_0 2026-03-12 21:41:15.787 | INFO | Auto search moving 2026-03-12 21:41:15.799 | INFO | Fleet: 1, fleet_current_index: 1 2026-03-12 21:41:15.884 | INFO | [OCR_OIL 0.080s] 4843 2026-03-12 21:41:15.998 | INFO | [OCR_COIN 0.111s] 42856 2026-03-12 21:41:20.492 | INFO | [Loading] 6% 2026-03-12 21:41:20.496 | INFO | Auto search combat loading 2026-03-12 21:41:20.500 | INFO | Screenshot interval set to 1.0s 2026-03-12 21:41:26.500 | INFO | [BattleUI] PAUSE 2026-03-12 21:41:26.503 | INFO | Auto Search combat execute 2026-03-12 21:41:26.507 | INFO | <<< EMOTION REDUCE >>> 2026-03-12 21:41:26.521 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-03-12 21:41:26.526 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=117, Main.Emotion.Fleet1Record=datetime.datetime(2026, 3, 12, 21, 41, 26), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 3, 12, 21, 41, 26) 2026-03-12 21:41:26.569 | INFO | [Emotion fleet_1] 117 2026-03-12 21:41:26.573 | INFO | [Emotion fleet_2] 119 2026-03-12 21:41:32.491 | INFO | Combat auto check timer reached 2026-03-12 21:42:10.545 | INFO | Click (1006, 654) @ GET_SHIP 2026-03-12 21:42:12.554 | INFO | Click (1023, 645) @ GET_SHIP 2026-03-12 21:42:14.549 | INFO | Click (1032, 662) @ GET_SHIP 2026-03-12 21:42:15.572 | INFO | Click (1016, 672) @ GET_SHIP 2026-03-12 21:42:16.572 | INFO | Screenshot interval set to 0.3s 2026-03-12 21:42:16.577 | INFO | Auto Search combat status 2026-03-12 21:42:16.582 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_1 ─────────────────────────────────────────────────────── 2026-03-12 21:42:16.592 | INFO | BATTLE_1 2026-03-12 21:42:16.597 | INFO | Auto search moving 2026-03-12 21:42:16.609 | INFO | Fleet: 1, fleet_current_index: 1 2026-03-12 21:42:16.786 | INFO | [OCR_OIL 0.163s] 4824 2026-03-12 21:42:16.886 | INFO | [OCR_COIN 0.096s] 42873 2026-03-12 21:42:20.569 | INFO | [Loading] 12% 2026-03-12 21:42:20.573 | INFO | Auto search combat loading 2026-03-12 21:42:20.576 | INFO | Screenshot interval set to 1.0s 2026-03-12 21:42:26.595 | INFO | [BattleUI] PAUSE 2026-03-12 21:42:26.600 | INFO | Auto Search combat execute 2026-03-12 21:42:26.604 | INFO | <<< EMOTION REDUCE >>> 2026-03-12 21:42:26.621 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-03-12 21:42:26.632 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=117, Main.Emotion.Fleet1Record=datetime.datetime(2026, 3, 12, 21, 42, 26), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 3, 12, 21, 42, 26) 2026-03-12 21:42:26.646 | INFO | [Emotion fleet_1] 117 2026-03-12 21:42:26.651 | INFO | [Emotion fleet_2] 119 2026-03-12 21:42:32.573 | INFO | Combat auto check timer reached 2026-03-12 21:42:51.614 | INFO | Screenshot interval set to 0.3s 2026-03-12 21:42:51.618 | INFO | Auto Search combat status 2026-03-12 21:42:52.192 | INFO | Click (1021, 651) @ GET_SHIP 2026-03-12 21:42:53.394 | INFO | Click (1019, 668) @ GET_SHIP 2026-03-12 21:42:54.594 | INFO | Click (1014, 653) @ GET_SHIP 2026-03-12 21:42:55.794 | INFO | Click (1014, 651) @ GET_SHIP 2026-03-12 21:42:57.594 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_2 ─────────────────────────────────────────────────────── 2026-03-12 21:42:57.599 | INFO | BATTLE_2 2026-03-12 21:42:57.602 | INFO | Auto search moving 2026-03-12 21:42:57.606 | INFO | Fleet: 1, fleet_current_index: 1 2026-03-12 21:42:57.748 | INFO | [OCR_OIL 0.138s] 4805 2026-03-12 21:42:57.830 | INFO | [OCR_COIN 0.074s] 42888 2026-03-12 21:43:02.416 | INFO | [Loading] 12% 2026-03-12 21:43:02.420 | INFO | Auto search combat loading 2026-03-12 21:43:02.423 | INFO | Screenshot interval set to 1.0s 2026-03-12 21:43:07.444 | INFO | [BattleUI] PAUSE 2026-03-12 21:43:07.449 | INFO | Auto Search combat execute 2026-03-12 21:43:07.453 | INFO | <<< EMOTION REDUCE >>> 2026-03-12 21:43:07.466 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-03-12 21:43:07.474 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=115, Main.Emotion.Fleet1Record=datetime.datetime(2026, 3, 12, 21, 43, 7), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 3, 12, 21, 43, 7) 2026-03-12 21:43:07.492 | INFO | [Emotion fleet_1] 115 2026-03-12 21:43:07.496 | INFO | [Emotion fleet_2] 119 2026-03-12 21:43:13.432 | INFO | Combat auto check timer reached 2026-03-12 21:43:32.466 | INFO | Screenshot interval set to 0.3s 2026-03-12 21:43:32.470 | INFO | Auto Search combat status 2026-03-12 21:43:33.644 | INFO | Click (1018, 650) @ GET_SHIP 2026-03-12 21:43:34.845 | INFO | Click (1017, 667) @ GET_SHIP 2026-03-12 21:43:36.935 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_3 ─────────────────────────────────────────────────────── 2026-03-12 21:43:36.940 | INFO | BATTLE_3 2026-03-12 21:43:36.943 | INFO | Auto search moving 2026-03-12 21:43:36.947 | INFO | Fleet: 1, fleet_current_index: 1 2026-03-12 21:43:37.062 | INFO | [OCR_OIL 0.110s] 4786 2026-03-12 21:43:37.155 | INFO | [OCR_COIN 0.089s] 42911 2026-03-12 21:43:41.754 | INFO | [Loading] 8% 2026-03-12 21:43:41.759 | INFO | Auto search combat loading 2026-03-12 21:43:41.762 | INFO | Screenshot interval set to 1.0s 2026-03-12 21:43:46.754 | INFO | [BattleUI] PAUSE 2026-03-12 21:43:46.757 | INFO | Auto Search combat execute 2026-03-12 21:43:46.761 | INFO | <<< EMOTION REDUCE >>> 2026-03-12 21:43:46.772 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-03-12 21:43:46.776 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=113, Main.Emotion.Fleet1Record=datetime.datetime(2026, 3, 12, 21, 43, 46), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 3, 12, 21, 43, 46) 2026-03-12 21:43:46.789 | INFO | [Emotion fleet_1] 113 2026-03-12 21:43:46.792 | INFO | [Emotion fleet_2] 119 2026-03-12 21:43:52.758 | INFO | Combat auto check timer reached 2026-03-12 21:44:28.809 | INFO | Screenshot interval set to 0.3s 2026-03-12 21:44:28.813 | INFO | Auto Search combat status 2026-03-12 21:44:30.293 | INFO | Click (1038, 673) @ GET_SHIP 2026-03-12 21:44:31.485 | INFO | Click (1018, 680) @ GET_SHIP 2026-03-12 21:44:32.688 | INFO | Click (1015, 671) @ GET_SHIP 2026-03-12 21:44:33.891 | INFO | Click (1023, 656) @ GET_SHIP 2026-03-12 21:44:35.694 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_4 ─────────────────────────────────────────────────────── 2026-03-12 21:44:35.699 | INFO | BATTLE_4 2026-03-12 21:44:35.701 | INFO | Auto search moving 2026-03-12 21:44:35.706 | INFO | Fleet: 1, fleet_current_index: 1 2026-03-12 21:44:35.810 | INFO | [OCR_OIL 0.099s] 4767 2026-03-12 21:44:35.957 | INFO | [OCR_COIN 0.142s] 42934 2026-03-12 21:44:39.639 | INFO | [Loading] 11% 2026-03-12 21:44:39.644 | INFO | Auto search combat loading 2026-03-12 21:44:39.647 | INFO | Screenshot interval set to 1.0s 2026-03-12 21:44:45.651 | INFO | [BattleUI] PAUSE 2026-03-12 21:44:45.654 | INFO | Auto Search combat execute 2026-03-12 21:44:45.656 | INFO | <<< EMOTION REDUCE >>> 2026-03-12 21:44:45.668 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-03-12 21:44:45.673 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=111, Main.Emotion.Fleet1Record=datetime.datetime(2026, 3, 12, 21, 44, 45), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 3, 12, 21, 44, 45) 2026-03-12 21:44:45.689 | INFO | [Emotion fleet_1] 111 2026-03-12 21:44:45.692 | INFO | [Emotion fleet_2] 119 2026-03-12 21:44:50.661 | INFO | Combat auto check timer reached 2026-03-12 21:45:27.690 | INFO | Screenshot interval set to 0.3s 2026-03-12 21:45:27.695 | INFO | Auto Search combat status 2026-03-12 21:45:29.182 | INFO | Click (1019, 671) @ GET_SHIP 2026-03-12 21:45:30.683 | INFO | Click (1023, 666) @ GET_SHIP 2026-03-12 21:45:31.890 | INFO | Click (1027, 670) @ GET_SHIP 2026-03-12 21:45:32.776 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_5 ─────────────────────────────────────────────────────── 2026-03-12 21:45:32.783 | INFO | BATTLE_5 2026-03-12 21:45:32.787 | INFO | Auto search moving 2026-03-12 21:45:32.791 | INFO | Fleet: 1, fleet_current_index: 1 2026-03-12 21:45:32.869 | INFO | [OCR_OIL 0.075s] 4748 2026-03-12 21:45:32.989 | INFO | [OCR_COIN 0.117s] 42950 2026-03-12 21:45:36.396 | INFO | [Loading] 17% 2026-03-12 21:45:36.400 | INFO | Auto search combat loading 2026-03-12 21:45:36.404 | INFO | Screenshot interval set to 1.0s 2026-03-12 21:45:42.408 | INFO | [BattleUI] PAUSE 2026-03-12 21:45:42.414 | INFO | Auto Search combat execute 2026-03-12 21:45:42.418 | INFO | <<< EMOTION REDUCE >>> 2026-03-12 21:45:42.434 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-03-12 21:45:42.441 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=109, Main.Emotion.Fleet1Record=datetime.datetime(2026, 3, 12, 21, 45, 42), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 3, 12, 21, 45, 42) 2026-03-12 21:45:42.462 | INFO | [Emotion fleet_1] 109 2026-03-12 21:45:42.470 | INFO | [Emotion fleet_2] 119 2026-03-12 21:45:48.391 | INFO | Combat auto check timer reached 2026-03-12 21:47:29.497 | INFO | Click (1027, 644) @ GET_SHIP 2026-03-12 21:50:29.648 | INFO | Function calls: threading.py L890 _bootstrap() threading.py L926 _bootstrap_inner() threading.py L870 run() threadbased.py L254 run() output.py L801 click_callback() app.py L437 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 L570 loop() alas.py L70 run() alas.py L367 main() run.py L426 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-03-12 21:50:29.663 | WARNING | Wait too long 2026-03-12 21:50:29.666 | 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-03-12 21:50:29.691 | INFO | newCommandTimeout updated to 168h0m0s 2026-03-12 21:50:29.696 | INFO | [u2.Device] Device(atx_agent_url=http://127.0.0.1:41975) 2026-03-12 21:50:29.769 | INFO | [Package_name] com.bilibili.azurlane 2026-03-12 21:50:29.772 | ERROR | GameStuckError: Wait too long 2026-03-12 21:50:29.775 | WARNING | Saving error: ./log/error/1773323429775