═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ MAIN ═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════ ════════════════════════════════════════════════════ CAMPAIGN_13_1 ════════════════════════════════════════════════════ 2026-02-04 14:30:46.852 | INFO | CAMPAIGN_13_1 2026-02-04 14:30:46.858 | INFO | Count: 0 2026-02-04 14:30:46.882 | INFO | <<< UI ENSURE >>> 2026-02-04 14:30:46.888 | INFO | UI get current page 2026-02-04 14:30:46.961 | INFO | [UI] page_commission 2026-02-04 14:30:46.967 | INFO | Goto page_campaign 2026-02-04 14:30:46.972 | INFO | <<< UI GOTO PAGE_CAMPAIGN >>> 2026-02-04 14:30:47.018 | INFO | Page switch: page_commission -> page_main 2026-02-04 14:30:47.023 | INFO | Click (1246, 31) @ GOTO_MAIN 2026-02-04 14:30:48.112 | INFO | Page switch: page_main_white -> page_campaign_menu 2026-02-04 14:30:48.117 | INFO | Click (1142, 521) @ MAIN_GOTO_CAMPAIGN_WHITE 2026-02-04 14:30:48.705 | INFO | Page switch: page_campaign_menu -> page_campaign 2026-02-04 14:30:48.711 | INFO | Click ( 403, 290) @ CAMPAIGN_MENU_GOTO_CAMPAIGN 2026-02-04 14:30:49.006 | INFO | Page arrive: page_campaign 2026-02-04 14:30:49.039 | INFO | Mode_switch_1 set to hard 2026-02-04 14:30:49.072 | INFO | [Mode_switch_1] hard 2026-02-04 14:30:49.084 | INFO | <<< UI ENSURE INDEX >>> 2026-02-04 14:30:49.183 | INFO | No stage found. 2026-02-04 14:30:49.446 | INFO | No stage found. 2026-02-04 14:30:49.697 | INFO | No stage found. 2026-02-04 14:30:50.096 | INFO | [campaign 0.100s] ['13--1', '13--3', '13--2', '13--4'] 2026-02-04 14:30:50.101 | INFO | [Chapter] 13 2026-02-04 14:30:50.106 | INFO | [Stage] 13-1, 13-3, 13-2, 13-4 2026-02-04 14:30:50.111 | INFO | [Index] 13 2026-02-04 14:30:50.274 | INFO | [OCR_OIL 0.131s] 12382 ──────────────────────────────────────────────────────── 13-1 ───────────────────────────────────────────────────────── 2026-02-04 14:30:50.284 | INFO | 13-1 2026-02-04 14:30:50.289 | INFO | Expect emotion reduce: (12, 2) 2026-02-04 14:30:50.305 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-02-04 14:30:50.312 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=97, Main.Emotion.Fleet1Record=datetime.datetime(2026, 2, 4, 14, 30, 50), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 2, 4, 14, 30, 50) 2026-02-04 14:30:50.335 | INFO | [Emotion fleet_1] 97 2026-02-04 14:30:50.354 | INFO | [Emotion fleet_2] 119 2026-02-04 14:30:50.361 | INFO | <<< ENTER MAP >>> 2026-02-04 14:30:50.446 | INFO | Click ( 195, 285) @ 13-1 2026-02-04 14:30:51.172 | INFO | [Map_clear_percentage] 25% 2026-02-04 14:30:51.487 | INFO | [Map_clear_percentage] 85% 2026-02-04 14:30:51.854 | INFO | [Map_clear_percentage] 99% 2026-02-04 14:30:51.890 | INFO | [MAP_CLEAR_ALL_THIS_TIME] False 2026-02-04 14:30:51.906 | INFO | [Map_info] 99%, star_1, star_2, star_3, 100_percent_clear, 3_stars, threat_safe, clear_mode 2026-02-04 14:30:51.915 | INFO | [StopCondition_MapAchievement] non_stop 2026-02-04 14:30:51.932 | INFO | Fast_Forward set to on 2026-02-04 14:30:51.942 | INFO | [Fast_Forward] on 2026-02-04 14:30:51.971 | INFO | Auto_Search set to on 2026-02-04 14:30:51.979 | INFO | [Auto_Search] on 2026-02-04 14:30:51.986 | INFO | Click ( 964, 523) @ MAP_PREPARATION 2026-02-04 14:30:52.424 | INFO | Handling 2x book setting, mode=prep. 2026-02-04 14:30:52.727 | INFO | Using fleet: [4, 3, 1] 2026-02-04 14:30:52.818 | INFO | Hard satisfied: Fleet_1: None, Fleet_2: None, Submarine: None 2026-02-04 14:30:52.830 | INFO | [map_allow_submarine] True 2026-02-04 14:30:52.838 | INFO | Click (1146, 330) @ FLEET_2_CLEAR 2026-02-04 14:30:52.894 | INFO | Click (1065, 480) @ SUBMARINE_CHOOSE 2026-02-04 14:30:53.317 | INFO | Current selected: [1] 2026-02-04 14:30:53.329 | INFO | Click (1053, 476) @ SUBMARINE_CHOOSE 2026-02-04 14:30:53.700 | INFO | Click (1059, 231) @ FLEET_1_CHOOSE 2026-02-04 14:30:53.939 | INFO | Current selected: [4] 2026-02-04 14:30:53.946 | INFO | Click (1047, 220) @ FLEET_1_CHOOSE 2026-02-04 14:30:54.207 | INFO | Click (1058, 349) @ FLEET_2_CHOOSE 2026-02-04 14:30:54.527 | INFO | Current selected: [4] 2026-02-04 14:30:54.537 | INFO | Click (1119, 487) @ FLEET_2_BAR_INDEX_3 2026-02-04 14:30:54.815 | INFO | Auto search setting 2026-02-04 14:30:54.835 | INFO | [_fleet_sidebar_offset] 0 2026-02-04 14:30:54.840 | INFO | [Fleet_sidebar] 1/3 2026-02-04 14:30:54.845 | INFO | Click (1216, 473) @ FLEET_SIDEBAR_0_2 2026-02-04 14:30:55.386 | INFO | [_fleet_sidebar_offset] 0 2026-02-04 14:30:55.392 | INFO | [Fleet_sidebar] 3/3 2026-02-04 14:30:55.398 | INFO | [Auto_Search_Setting] fleet1_all_fleet2_standby, sub_standby 2026-02-04 14:30:55.404 | INFO | Click ( 505, 216) @ AUTO_SEARCH_SET_MOB 2026-02-04 14:30:55.967 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_standby 2026-02-04 14:30:55.979 | INFO | Selected to the correct auto search setting 2026-02-04 14:30:55.984 | INFO | [Auto_Search_Setting] fleet1_mob_fleet2_boss, sub_standby 2026-02-04 14:30:55.992 | INFO | Selected to the correct auto search setting 2026-02-04 14:30:55.996 | INFO | Click (1082, 587) @ FLEET_PREPARATION 2026-02-04 14:30:57.555 | INFO | is_auto_search_running appeared ────────────────────────────────────────────────────── BATTLE_0 ─────────────────────────────────────────────────────── 2026-02-04 14:30:57.574 | INFO | BATTLE_0 2026-02-04 14:30:57.584 | INFO | Auto search moving 2026-02-04 14:30:57.622 | INFO | Fleet: 1, fleet_current_index: 1 2026-02-04 14:30:57.789 | INFO | [OCR_OIL 0.156s] 12372 2026-02-04 14:30:57.955 | INFO | [OCR_COIN 0.156s] 87415 2026-02-04 14:31:02.491 | INFO | [Loading] 5% 2026-02-04 14:31:02.498 | INFO | Auto search combat loading 2026-02-04 14:31:02.507 | INFO | Screenshot interval set to 1.0s 2026-02-04 14:31:08.509 | INFO | [BattleUI] PAUSE 2026-02-04 14:31:08.512 | INFO | Auto Search combat execute 2026-02-04 14:31:08.516 | INFO | <<< EMOTION REDUCE >>> 2026-02-04 14:31:08.536 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-02-04 14:31:08.542 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=95, Main.Emotion.Fleet1Record=datetime.datetime(2026, 2, 4, 14, 31, 8), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 2, 4, 14, 31, 8) 2026-02-04 14:31:08.560 | INFO | [Emotion fleet_1] 95 2026-02-04 14:31:08.566 | INFO | [Emotion fleet_2] 119 2026-02-04 14:31:13.551 | INFO | Combat auto check timer reached 2026-02-04 14:31:36.521 | INFO | Click (1017, 679) @ GET_SHIP 2026-02-04 14:31:37.514 | INFO | Screenshot interval set to 0.3s 2026-02-04 14:31:37.519 | INFO | Auto Search combat status 2026-02-04 14:31:37.537 | INFO | Click (1042, 663) @ GET_SHIP 2026-02-04 14:31:39.291 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_1 ─────────────────────────────────────────────────────── 2026-02-04 14:31:39.301 | INFO | BATTLE_1 2026-02-04 14:31:39.306 | INFO | Auto search moving 2026-02-04 14:31:39.311 | INFO | Fleet: 1, fleet_current_index: 1 2026-02-04 14:31:39.427 | INFO | [OCR_OIL 0.112s] 12353 2026-02-04 14:31:39.632 | INFO | [OCR_COIN 0.196s] 87436 2026-02-04 14:31:43.988 | INFO | [Loading] 8% 2026-02-04 14:31:43.997 | INFO | Auto search combat loading 2026-02-04 14:31:44.007 | INFO | Screenshot interval set to 1.0s 2026-02-04 14:31:50.000 | INFO | [BattleUI] PAUSE 2026-02-04 14:31:50.004 | INFO | Auto Search combat execute 2026-02-04 14:31:50.008 | INFO | <<< EMOTION REDUCE >>> 2026-02-04 14:31:50.034 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-02-04 14:31:50.044 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=93, Main.Emotion.Fleet1Record=datetime.datetime(2026, 2, 4, 14, 31, 50), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 2, 4, 14, 31, 50) 2026-02-04 14:31:50.059 | INFO | [Emotion fleet_1] 93 2026-02-04 14:31:50.066 | INFO | [Emotion fleet_2] 119 2026-02-04 14:31:55.944 | INFO | Combat auto check timer reached 2026-02-04 14:32:33.992 | INFO | Click (1029, 657) @ GET_SHIP 2026-02-04 14:32:35.000 | INFO | Click (1007, 659) @ GET_SHIP 2026-02-04 14:32:36.006 | INFO | Click (1011, 642) @ GET_SHIP 2026-02-04 14:32:38.012 | INFO | Screenshot interval set to 0.3s 2026-02-04 14:32:38.018 | INFO | Auto Search combat status 2026-02-04 14:32:38.023 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_2 ─────────────────────────────────────────────────────── 2026-02-04 14:32:38.027 | INFO | BATTLE_2 2026-02-04 14:32:38.035 | INFO | Auto search moving 2026-02-04 14:32:38.041 | INFO | Fleet: 1, fleet_current_index: 1 2026-02-04 14:32:38.137 | INFO | [OCR_OIL 0.086s] 12334 2026-02-04 14:32:38.296 | INFO | [OCR_COIN 0.151s] 87455 2026-02-04 14:32:42.947 | INFO | [Loading] 14% 2026-02-04 14:32:42.956 | INFO | Auto search combat loading 2026-02-04 14:32:42.968 | INFO | Screenshot interval set to 1.0s 2026-02-04 14:32:48.914 | INFO | [BattleUI] PAUSE 2026-02-04 14:32:48.918 | INFO | Auto Search combat execute 2026-02-04 14:32:48.923 | INFO | <<< EMOTION REDUCE >>> 2026-02-04 14:32:48.937 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-02-04 14:32:48.942 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=91, Main.Emotion.Fleet1Record=datetime.datetime(2026, 2, 4, 14, 32, 48), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 2, 4, 14, 32, 48) 2026-02-04 14:32:48.957 | INFO | [Emotion fleet_1] 91 2026-02-04 14:32:48.965 | INFO | [Emotion fleet_2] 119 2026-02-04 14:32:54.910 | INFO | Combat auto check timer reached 2026-02-04 14:33:34.981 | INFO | Screenshot interval set to 0.3s 2026-02-04 14:33:34.986 | INFO | Auto Search combat status 2026-02-04 14:33:35.589 | INFO | Click (1025, 668) @ GET_SHIP 2026-02-04 14:33:36.751 | INFO | Click (1021, 667) @ GET_SHIP 2026-02-04 14:33:37.949 | INFO | Click (1021, 657) @ GET_SHIP 2026-02-04 14:33:39.147 | INFO | Click (1028, 650) @ GET_SHIP 2026-02-04 14:33:41.240 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_3 ─────────────────────────────────────────────────────── 2026-02-04 14:33:41.247 | INFO | BATTLE_3 2026-02-04 14:33:41.253 | INFO | Auto search moving 2026-02-04 14:33:41.257 | INFO | Fleet: 1, fleet_current_index: 1 2026-02-04 14:33:41.347 | INFO | [OCR_OIL 0.087s] 12315 2026-02-04 14:33:41.440 | INFO | [OCR_COIN 0.090s] 87474 2026-02-04 14:33:46.659 | INFO | [Loading] 10% 2026-02-04 14:33:46.663 | INFO | Auto search combat loading 2026-02-04 14:33:46.665 | INFO | Screenshot interval set to 1.0s 2026-02-04 14:33:52.673 | INFO | [BattleUI] PAUSE 2026-02-04 14:33:52.679 | INFO | Auto Search combat execute 2026-02-04 14:33:52.684 | INFO | <<< EMOTION REDUCE >>> 2026-02-04 14:33:52.702 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-02-04 14:33:52.711 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=89, Main.Emotion.Fleet1Record=datetime.datetime(2026, 2, 4, 14, 33, 52), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 2, 4, 14, 33, 52) 2026-02-04 14:33:52.729 | INFO | [Emotion fleet_1] 89 2026-02-04 14:33:52.734 | INFO | [Emotion fleet_2] 119 2026-02-04 14:33:58.671 | INFO | Combat auto check timer reached 2026-02-04 14:34:35.709 | INFO | Screenshot interval set to 0.3s 2026-02-04 14:34:35.713 | INFO | Auto Search combat status 2026-02-04 14:34:36.344 | INFO | Click (1032, 659) @ GET_SHIP 2026-02-04 14:34:37.511 | INFO | Click (1026, 666) @ GET_SHIP 2026-02-04 14:34:38.697 | INFO | Click (1010, 676) @ GET_SHIP 2026-02-04 14:34:39.899 | INFO | Click (1008, 673) @ GET_SHIP 2026-02-04 14:34:41.696 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_4 ─────────────────────────────────────────────────────── 2026-02-04 14:34:41.704 | INFO | BATTLE_4 2026-02-04 14:34:41.708 | INFO | Auto search moving 2026-02-04 14:34:41.719 | INFO | Fleet: 1, fleet_current_index: 1 2026-02-04 14:34:41.992 | INFO | [OCR_OIL 0.262s] 12296 2026-02-04 14:34:42.184 | INFO | [OCR_COIN 0.166s] 87495 2026-02-04 14:34:46.500 | INFO | [Loading] 8% 2026-02-04 14:34:46.507 | INFO | Auto search combat loading 2026-02-04 14:34:46.512 | INFO | Screenshot interval set to 1.0s 2026-02-04 14:34:52.502 | INFO | [BattleUI] PAUSE 2026-02-04 14:34:52.508 | INFO | Auto Search combat execute 2026-02-04 14:34:52.514 | INFO | <<< EMOTION REDUCE >>> 2026-02-04 14:34:52.530 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-02-04 14:34:52.538 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=87, Main.Emotion.Fleet1Record=datetime.datetime(2026, 2, 4, 14, 34, 52), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 2, 4, 14, 34, 52) 2026-02-04 14:34:52.557 | INFO | [Emotion fleet_1] 87 2026-02-04 14:34:52.566 | INFO | [Emotion fleet_2] 119 2026-02-04 14:34:58.520 | INFO | Combat auto check timer reached 2026-02-04 14:35:53.558 | INFO | Screenshot interval set to 0.3s 2026-02-04 14:35:53.564 | INFO | Auto Search combat status 2026-02-04 14:35:54.472 | INFO | Click (1015, 648) @ GET_SHIP 2026-02-04 14:35:55.665 | INFO | Click (1023, 661) @ GET_SHIP 2026-02-04 14:35:56.891 | INFO | Click (1033, 659) @ GET_SHIP 2026-02-04 14:35:58.072 | INFO | Click (1030, 658) @ GET_SHIP 2026-02-04 14:35:59.270 | INFO | Click (1023, 677) @ GET_SHIP 2026-02-04 14:36:00.455 | INFO | Combat end. ────────────────────────────────────────────────────── BATTLE_5 ─────────────────────────────────────────────────────── 2026-02-04 14:36:00.460 | INFO | BATTLE_5 2026-02-04 14:36:00.464 | INFO | Auto search moving 2026-02-04 14:36:00.469 | INFO | Fleet: 1, fleet_current_index: 1 2026-02-04 14:36:00.615 | INFO | [OCR_OIL 0.142s] 12277 2026-02-04 14:36:00.774 | INFO | [OCR_COIN 0.147s] 87523 2026-02-04 14:36:03.882 | INFO | [Loading] 4% 2026-02-04 14:36:03.887 | INFO | Auto search combat loading 2026-02-04 14:36:03.891 | INFO | Screenshot interval set to 1.0s 2026-02-04 14:36:10.924 | INFO | [BattleUI] PAUSE 2026-02-04 14:36:10.929 | INFO | Auto Search combat execute 2026-02-04 14:36:10.933 | INFO | <<< EMOTION REDUCE >>> 2026-02-04 14:36:10.946 | INFO | Bind task ['General', 'Alas', 'Main'] 2026-02-04 14:36:10.951 | INFO | Save config ./config/alas-pc.json, Main.Emotion.Fleet1Value=87, Main.Emotion.Fleet1Record=datetime.datetime(2026, 2, 4, 14, 36, 10), Main.Emotion.Fleet2Value=119, Main.Emotion.Fleet2Record=datetime.datetime(2026, 2, 4, 14, 36, 10) 2026-02-04 14:36:10.973 | INFO | [Emotion fleet_1] 87 2026-02-04 14:36:10.980 | INFO | [Emotion fleet_2] 119 2026-02-04 14:36:15.948 | INFO | Combat auto check timer reached 2026-02-04 14:37:24.964 | INFO | Click (1032, 675) @ GET_SHIP 2026-02-04 14:40:25.121 | 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-02-04 14:40:25.145 | WARNING | Wait too long 2026-02-04 14:40:25.151 | WARNING | Waiting for {'SP_CHECK', 'EXP_INFO_S', 'GET_SHIP', 'EVENT_CHECK', 'EXP_INFO_A', 'BATTLE_STATUS_B', 'CAMPAIGN_CHECK', 'GET_MISSION', 'BATTLE_STATUS_A', 'EXP_INFO_B', 'MISSION_POPUP_GO', 'POPUP_CONFIRM_WHITE', 'PAUSE', 'AUTO_SEARCH_MAP_OPTION_ON', 'NEW_SHIP', 'GUILD_POPUP_CONFIRM', 'BATTLE_STATUS_S', 'POPUP_CANCEL'} 2026-02-04 14:40:25.242 | INFO | [Package_name] com.bilibili.azurlane 2026-02-04 14:40:25.247 | ERROR | GameStuckError: Wait too long 2026-02-04 14:40:25.254 | WARNING | Saving error: ./log/error/1770187225254