AzurLaneAutoScript icon indicating copy to clipboard operation
AzurLaneAutoScript copied to clipboard

[大型作战] 自律寻敌有概率异常中止,导致隐秘海域 / 短猫 / 侵蚀1等多个功能运行出错

Open frostLotusw opened this issue 1 year ago • 7 comments

在提问之前...

  • [X] 我已经搜索了现有的 issues
  • [X] 我在提问题之前至少花费了 5 分钟来思考和准备
  • [X] 我已经阅读了 Wiki 中的 常见问题(FAQ)
  • [X] 我正在使用最新版的 Alas

描述你的问题

在运行依赖于游戏内自律寻敌的大型作战功能时,自律寻敌有小概率被异常打断,导致相关功能运行出错。

在短猫相接 / 侵蚀1练级中,通常表现为游戏停留在战斗结算页面,Alas 无任何操作直到抛出 Wait too long 错误;

在隐秘海域中,表现为自律中止后弹出掉落结算,Alas 认为作战完成并退出隐秘海域,浪费坐标;

类似问题截至目前最后一次复现于 2024-03-22 20:56,Alas 已保持最新。

如何复现

启用任何依赖于游戏内 “自律寻敌” 的大型作战功能,运行一段时间。

预期行为

较小概率下,当舰队在地图中自律移动时,观察到游戏中弹出消息 “当前舰队自律寻敌中止”。

由于自律寻敌中断这一行为并非预期,这往往会导致相关功能的运行逻辑出现错误。

例子 1(2024-03-20 17:36,侵蚀1练级,附日志):

  1. 我观察到游戏中弹出消息 “当前舰队自律寻敌中止” 后,舰队恰好遭遇塞壬敌人,进入战斗;
  2. 战斗完成后,由于自律寻敌异常中止,游戏会停留在 " 大获全胜 S " 结算界面;
  3. 此时 Alas 不会进行任何操作,约 3min 后抛出 ERROR | GameStuckError: Wait too long 报错;
  4. 一段时间内,上述情况反复出现 3 次,此时抛出 CRITICAL | Task OpsiHazard1Leveling failed 3 or more times.CRITICAL | Request human takeover ,Alas 终止运行;夜间无人值守时,这意味着此后的委托时间被浪费

// 2024-03-21 的 Alas 更新后,类似问题出现的概率似乎大幅降低了?我在人工值守时仍然注意到了一次上述 1~2 的情形,并手动恢复了自律寻敌;但 Alas 没有再因此终止运行过。

例子 2(2024-03-22 20:56,隐秘海域,附日志和截图):

  1. 这一问题是在无人值守时出现的,我在例行检查掉落截图时发现了异常;
  2. 截图中,海域内还有物资箱和据点(小地图黄色叹号),显然隐秘海域自律寻敌不是自然结束,而是被打断了;
  3. 通过日志内容和前后两次掉落截图的白币数量,基本可以推断出 Alas 此时并未继续自律,而是认为作战已经完成,直接退出了隐秘海域,浪费了一个 6 级坐标
  4. 上一个截图:白币余额 332078;出现问题的截图:白币掉落 1104,余额 333182;下一个截图:白币掉落 9171,余额 342353。不难判断,截图显示的掉落是该 6 级坐标从进入到退出的所有收益。

相关 Logs

// Example 1

══════════════════════════════════════════ OS HAZARD 1 LEVELING, ZONE_ID=44 ═══════════════════════════════════════════
2024-03-20 17:28:57.614 | INFO | OS HAZARD 1 LEVELING, ZONE_ID=44                                                      
2024-03-20 17:28:57.615 | INFO | <<< FLEET SET TO 3 >>>                                                                
2024-03-20 17:28:57.619 | INFO | It is fleet 3 already                                                                 
───────────────────────────────────────────────── RUN STRATEGY SEARCH ─────────────────────────────────────────────────
2024-03-20 17:28:57.620 | INFO | RUN STRATEGY SEARCH                                                                   
2024-03-20 17:28:57.621 | INFO | <<< STRATEGIC SEARCH START >>>                                                        
2024-03-20 17:28:57.621 | INFO | Strategic search enter                                                                
2024-03-20 17:28:59.784 | INFO | Click (1220,  607) @ STRATEGIC_SEARCH_MAP_OPTION_OFF                                  
2024-03-20 17:29:00.105 | INFO | Strategic search set tab                                                              
2024-03-20 17:29:00.107 | INFO | Strategic search set option                                                           
2024-03-20 17:29:00.107 | INFO | [zone_mode] repeat                                                                    
2024-03-20 17:29:00.108 | INFO | [encounter_merchant] stop                                                             
2024-03-20 17:29:00.108 | INFO | STRATEGIC_SEARCH_SCROLL_AREA set to 0.5                                               
2024-03-20 17:29:00.109 | INFO | [STRATEGIC_SEARCH_SCROLL_AREA] 0.00 (34.5-35.0)/(193-70)                              
2024-03-20 17:29:00.110 | INFO | Swipe ( 906,  314) -> ( 907,  367)                                                    
2024-03-20 17:29:00.415 | INFO | [STRATEGIC_SEARCH_SCROLL_AREA] 0.00 (nan-0.0)/(193-0)                                 
2024-03-20 17:29:00.724 | INFO | [STRATEGIC_SEARCH_SCROLL_AREA] 0.43 (87.5-36.0)/(193-72)                              
2024-03-20 17:29:00.726 | INFO | [encounter_device] stop                                                               
2024-03-20 17:29:00.727 | INFO | STRATEGIC_SEARCH_SCROLL_AREA set to 1.0                                               
2024-03-20 17:29:00.727 | INFO | [STRATEGIC_SEARCH_SCROLL_AREA] 0.43 (87.5-36.0)/(193-72)                              
2024-03-20 17:29:00.728 | INFO | Swipe ( 908,  367) -> ( 902,  518)                                                    
2024-03-20 17:29:01.068 | INFO | [STRATEGIC_SEARCH_SCROLL_AREA] 1.00 (157.0-35.5)/(193-71)                             
2024-03-20 17:29:01.069 | INFO | [auto_submit] on                                                                      
2024-03-20 17:29:01.070 | INFO | Strategic search confirm                                                              
2024-03-20 17:29:01.072 | INFO | Click ( 784,  525) @ POPUP_CONFIRM_STRATEGIC_SEARCH                                   
─────────────────────────────────────────────────── OS AUTO SEARCH ────────────────────────────────────────────────────
2024-03-20 17:29:02.615 | INFO | OS AUTO SEARCH                                                                        
2024-03-20 17:29:12.888 | INFO | [Loading] 6%                                                                          
2024-03-20 17:29:12.889 | INFO | [battle_count] 1                                                                      
2024-03-20 17:29:12.897 | INFO | Pending tasks: ['OpsiHazard1Leveling']                                                
2024-03-20 17:29:12.897 | INFO | [Task] OpsiHazard1Leveling (Enable, 2024-03-20 12:58:58)                              
2024-03-20 17:29:12.898 | INFO | Continue task `OpsiHazard1Leveling (Enable, 2024-03-20 12:58:58)`                     
2024-03-20 17:29:12.899 | INFO | Auto search combat loading                                                            
2024-03-20 17:29:12.899 | INFO | Screenshot interval set to 1s                                                         
2024-03-20 17:29:19.957 | INFO | Auto Search combat execute                                                            
2024-03-20 17:29:25.014 | INFO | Submarine call timer reached                                                          
2024-03-20 17:29:38.144 | INFO | Screenshot interval set to 0.3s                                                       
2024-03-20 17:29:38.145 | INFO | Combat end.                                                                           
2024-03-20 17:29:39.407 | INFO | [Loading] 7%                                                                          
2024-03-20 17:29:39.408 | INFO | [battle_count] 2                                                                      
2024-03-20 17:29:39.415 | INFO | Pending tasks: ['OpsiHazard1Leveling']                                                
2024-03-20 17:29:39.416 | INFO | [Task] OpsiHazard1Leveling (Enable, 2024-03-20 12:58:58)                              
2024-03-20 17:29:39.417 | INFO | Continue task `OpsiHazard1Leveling (Enable, 2024-03-20 12:58:58)`                     
2024-03-20 17:29:39.417 | INFO | Auto search combat loading                                                            
2024-03-20 17:29:39.418 | INFO | Screenshot interval set to 1s                                                         
2024-03-20 17:29:47.483 | INFO | Auto Search combat execute                                                            
2024-03-20 17:29:52.519 | INFO | Submarine call timer reached                                                          
2024-03-20 17:30:00.623 | INFO | [Story_options] 0                                                                     
2024-03-20 17:30:04.669 | INFO | Screenshot interval set to 0.3s                                                       
2024-03-20 17:30:04.670 | INFO | Combat end.                                                                           
2024-03-20 17:30:07.483 | INFO | [Loading] 7%                                                                          
2024-03-20 17:30:07.484 | INFO | [battle_count] 3                                                                      
2024-03-20 17:30:07.485 | INFO | [CL1 time cost] 54.6s/round                                                           
2024-03-20 17:30:07.497 | INFO | Pending tasks: ['OpsiHazard1Leveling']                                                
2024-03-20 17:30:07.498 | INFO | [Task] OpsiHazard1Leveling (Enable, 2024-03-20 12:58:58)                              
2024-03-20 17:30:07.498 | INFO | Continue task `OpsiHazard1Leveling (Enable, 2024-03-20 12:58:58)`                     
2024-03-20 17:30:07.498 | INFO | Auto search combat loading                                                            
2024-03-20 17:30:07.500 | INFO | Screenshot interval set to 1s                                                         
2024-03-20 17:30:14.551 | INFO | Auto Search combat execute                                                            
2024-03-20 17:30:19.615 | INFO | Submarine call timer reached                                                          
2024-03-20 17:30:32.777 | INFO | Screenshot interval set to 0.3s                                                       
2024-03-20 17:30:32.778 | INFO | Combat end.                                                                           
2024-03-20 17:30:36.826 | INFO | [Loading] 7%                                                                          
2024-03-20 17:30:36.826 | INFO | [battle_count] 4                                                                      
2024-03-20 17:30:36.834 | INFO | Pending tasks: ['OpsiHazard1Leveling']                                                
2024-03-20 17:30:36.834 | INFO | [Task] OpsiHazard1Leveling (Enable, 2024-03-20 12:58:58)                              
2024-03-20 17:30:36.835 | INFO | Continue task `OpsiHazard1Leveling (Enable, 2024-03-20 12:58:58)`                     
2024-03-20 17:30:36.835 | INFO | Auto search combat loading                                                            
2024-03-20 17:30:36.836 | INFO | Screenshot interval set to 1s                                                         
2024-03-20 17:30:44.925 | INFO | Auto Search combat execute                                                            
2024-03-20 17:30:49.970 | INFO | Submarine call timer reached                                                          
2024-03-20 17:31:03.137 | INFO | [Story_options] 0                                                                     
2024-03-20 17:31:04.143 | INFO | Screenshot interval set to 0.3s                                                       
2024-03-20 17:31:04.144 | INFO | Combat end.                                                                           
2024-03-20 17:31:04.460 | INFO | [Story_options] 0                                                                     
2024-03-20 17:31:04.760 | INFO | [Story_options] 0                                                                     
2024-03-20 17:31:04.762 | INFO | Click (1177,  228) @ CLICK_SAFE_AREA                                                  
2024-03-20 17:31:10.671 | INFO | [Loading] 6%                                                                          
2024-03-20 17:31:10.672 | INFO | [battle_count] 5                                                                      
2024-03-20 17:31:10.673 | INFO | [CL1 time cost] 63.19s/round                                                          
2024-03-20 17:31:10.680 | INFO | Pending tasks: ['OpsiHazard1Leveling']                                                
2024-03-20 17:31:10.681 | INFO | [Task] OpsiHazard1Leveling (Enable, 2024-03-20 12:58:58)                              
2024-03-20 17:31:10.681 | INFO | Continue task `OpsiHazard1Leveling (Enable, 2024-03-20 12:58:58)`                     
2024-03-20 17:31:10.682 | INFO | Auto search combat loading                                                            
2024-03-20 17:31:10.682 | INFO | Screenshot interval set to 1s                                                         
2024-03-20 17:31:17.749 | INFO | Auto Search combat execute                                                            
2024-03-20 17:31:22.780 | INFO | Submarine call timer reached                                                          
2024-03-20 17:31:35.957 | INFO | Screenshot interval set to 0.3s                                                       
2024-03-20 17:31:35.958 | INFO | Combat end.                                                                           
2024-03-20 17:31:38.131 | INFO | [Loading] 7%                                                                          
2024-03-20 17:31:38.132 | INFO | [battle_count] 6                                                                      
2024-03-20 17:31:38.144 | INFO | Pending tasks: ['OpsiHazard1Leveling']                                                
2024-03-20 17:31:38.145 | INFO | [Task] OpsiHazard1Leveling (Enable, 2024-03-20 12:58:58)                              
2024-03-20 17:31:38.146 | INFO | Continue task `OpsiHazard1Leveling (Enable, 2024-03-20 12:58:58)`                     
2024-03-20 17:31:38.146 | INFO | Auto search combat loading                                                            
2024-03-20 17:31:38.147 | INFO | Screenshot interval set to 1s                                                         
2024-03-20 17:31:45.221 | INFO | Auto Search combat execute                                                            
2024-03-20 17:31:50.261 | INFO | Submarine call timer reached                                                          
2024-03-20 17:31:59.395 | INFO | Screenshot interval set to 0.3s                                                       
2024-03-20 17:31:59.396 | INFO | Combat end.                                                                           
2024-03-20 17:32:02.178 | INFO | [Story_options] 0                                                                     
2024-03-20 17:32:06.841 | INFO | [Story_options] 0                                                                     
2024-03-20 17:32:12.760 | INFO | [Story_options] 0                                                                     
2024-03-20 17:32:16.791 | INFO | [Loading] 6%                                                                          
2024-03-20 17:32:16.792 | INFO | [battle_count] 7                                                                      
2024-03-20 17:32:16.792 | INFO | [CL1 time cost] 66.12s/round                                                          
2024-03-20 17:32:16.799 | INFO | Pending tasks: ['OpsiHazard1Leveling']                                                
2024-03-20 17:32:16.800 | INFO | [Task] OpsiHazard1Leveling (Enable, 2024-03-20 12:58:58)                              
2024-03-20 17:32:16.801 | INFO | Continue task `OpsiHazard1Leveling (Enable, 2024-03-20 12:58:58)`                     
2024-03-20 17:32:16.801 | INFO | Auto search combat loading                                                            
2024-03-20 17:32:16.802 | INFO | Screenshot interval set to 1s                                                         
2024-03-20 17:32:23.887 | INFO | Auto Search combat execute                                                            
2024-03-20 17:32:28.920 | INFO | Submarine call timer reached                                                          
2024-03-20 17:32:43.092 | INFO | Screenshot interval set to 0.3s                                                       
2024-03-20 17:32:43.094 | INFO | Combat end.                                                                           
2024-03-20 17:32:45.598 | INFO | [Loading] 7%                                                                          
2024-03-20 17:32:45.599 | INFO | [battle_count] 8                                                                      
2024-03-20 17:32:45.610 | INFO | Pending tasks: ['OpsiHazard1Leveling']                                                
2024-03-20 17:32:45.611 | INFO | [Task] OpsiHazard1Leveling (Enable, 2024-03-20 12:58:58)                              
2024-03-20 17:32:45.612 | INFO | Continue task `OpsiHazard1Leveling (Enable, 2024-03-20 12:58:58)`                     
2024-03-20 17:32:45.612 | INFO | Auto search combat loading                                                            
2024-03-20 17:32:45.613 | INFO | Screenshot interval set to 1s                                                         
2024-03-20 17:32:52.661 | INFO | Auto Search combat execute                                                            
2024-03-20 17:32:57.708 | INFO | Submarine call timer reached                                                          
2024-03-20 17:33:08.848 | INFO | [Story_options] 0                                                                     
2024-03-20 17:33:12.898 | INFO | Screenshot interval set to 0.3s                                                       
2024-03-20 17:33:12.899 | INFO | Combat end.                                                                           
2024-03-20 17:33:14.785 | INFO | [Loading] 7%                                                                          
2024-03-20 17:33:14.786 | INFO | [battle_count] 9                                                                      
2024-03-20 17:33:14.787 | INFO | [CL1 time cost] 57.99s/round                                                          
2024-03-20 17:33:14.794 | INFO | Pending tasks: ['OpsiHazard1Leveling']                                                
2024-03-20 17:33:14.794 | INFO | [Task] OpsiHazard1Leveling (Enable, 2024-03-20 12:58:58)                              
2024-03-20 17:33:14.795 | INFO | Continue task `OpsiHazard1Leveling (Enable, 2024-03-20 12:58:58)`                     
2024-03-20 17:33:14.795 | INFO | Auto search combat loading                                                            
2024-03-20 17:33:14.796 | INFO | Screenshot interval set to 1s                                                         
2024-03-20 17:33:22.844 | INFO | Auto Search combat execute                                                            
2024-03-20 17:33:27.902 | INFO | Submarine call timer reached                                                          
2024-03-20 17:33:38.021 | INFO | Screenshot interval set to 0.3s                                                       
2024-03-20 17:33:38.022 | INFO | Combat end.                                                                           
2024-03-20 17:33:39.874 | INFO | [Story_options] 0                                                                     
2024-03-20 17:33:40.200 | INFO | [Story_options] 0                                                                     
2024-03-20 17:33:40.201 | INFO | Click (1149,  229) @ CLICK_SAFE_AREA                                                  
2024-03-20 17:33:41.105 | INFO | Click (1232,  540) @ AUTO_SEARCH_OS_MAP_OPTION_OFF                                    
2024-03-20 17:33:42.072 | INFO | [Loading] 6%                                                                          
2024-03-20 17:33:42.073 | INFO | [battle_count] 10                                                                     
2024-03-20 17:33:42.080 | INFO | Pending tasks: ['OpsiHazard1Leveling']                                                
2024-03-20 17:33:42.080 | INFO | [Task] OpsiHazard1Leveling (Enable, 2024-03-20 12:58:58)                              
2024-03-20 17:33:42.081 | INFO | Continue task `OpsiHazard1Leveling (Enable, 2024-03-20 12:58:58)`                     
2024-03-20 17:33:42.081 | INFO | Auto search combat loading                                                            
2024-03-20 17:33:42.082 | INFO | Screenshot interval set to 1s                                                         
2024-03-20 17:33:49.107 | INFO | Auto Search combat execute                                                            
2024-03-20 17:33:54.175 | INFO | Submarine call timer reached                                                          
2024-03-20 17:36:51.133 | INFO | Function calls:                                                                       
          <string>   L1 <module>                                                                                       
          spawn.py L105 spawn_main()                                                                                   
          spawn.py L118 _main()                                                                                        
        process.py L297 _bootstrap()                                                                                   
        process.py  L99 run()                                                                                          
process_manager.py L151 run_process()                                                                                  
           alas.py L514 loop()                                                                                         
           alas.py  L68 run()                                                                                          
           alas.py L334 opsi_hazard1_leveling()                                                                        
         os_run.py  L72 opsi_hazard1_leveling()                                                                        
operation_siren.py L439 os_hazard1_leveling()                                                                          
            map.py L723 run_strategic_search()                                                                         
            map.py L590 os_auto_search_run()                                                                           
            map.py L528 os_auto_search_daemon()                                                                        
         combat.py L251 auto_search_combat()                                                                           
         device.py L124 screenshot()                                                                                   
         device.py L170 stuck_record_check()                                                                           
         device.py  L41 show_function_call()                                                                           
2024-03-20 17:36:51.135 | WARNING | Wait too long                                                                      
2024-03-20 17:36:51.135 | WARNING | Waiting for {'MAP_GOTO_GLOBE_FOG', 'GET_MISSION', 'GET_ITEMS_1',                   
'GET_MEOWFFICER_ITEMS_1', 'OS_GAME_TIPS', 'GET_MEOWFFICER_ITEMS_2', 'GET_ITEMS_3', 'AUTO_SEARCH_OS_MAP_OPTION_OFF',    
'GET_ADAPTABILITY', 'POPUP_CONFIRM', 'EXP_INFO_C', 'GET_ITEMS_2', 'GUILD_POPUP_CONFIRM', 'STORY_SKIP_3',               
'BATTLE_STATUS_C', 'GAME_TIPS', 'STORY_CLOSE', 'IN_MAP', 'MAP_WORLD', 'PAUSE', 'EXP_INFO_D', 'AUTO_SEARCH_REWARD',     
'SUBMARINE_AVAILABLE_CHECK_1', 'MAP_ARCHIVES', 'BATTLE_STATUS_D'}                                                      
2024-03-20 17:36:51.144 | INFO | [Package_name] com.bilibili.azurlane                                                  
2024-03-20 17:36:51.145 | ERROR | GameStuckError: Wait too long                                                        
2024-03-20 17:36:51.145 | WARNING | Saving error: ./log/error/1710927411145                                            
2024-03-20 17:36:51.322 | WARNING | Game stuck, com.bilibili.azurlane will be restarted in 10 seconds                  
2024-03-20 17:36:51.322 | WARNING | If you are playing by hand, please stop Alas                                       
2024-03-20 17:36:51.323 | INFO | Task call: Restart                                                                    
2024-03-20 17:36:51.329 | INFO | Bind task ['General', 'Alas', 'OpsiGeneral', 'OpsiHazard1Leveling']                   
2024-03-20 17:36:51.330 | INFO | Save config ./config\alas.json, Restart.Scheduler.NextRun=datetime.datetime(2024, 3,  
20, 17, 36, 51), Restart.Scheduler.Enable=True                                                                         
2024-03-20 17:37:01.345 | INFO | Scheduler: End task `OpsiHazard1Leveling`                                             
2024-03-20 17:37:01.345 | CRITICAL | Task `OpsiHazard1Leveling` failed 3 or more times.                                
2024-03-20 17:37:01.347 | CRITICAL | Possible reason #1: You haven't used it correctly. Please read the help text of   
the options.                                                                                                           
2024-03-20 17:37:01.347 | CRITICAL | Possible reason #2: There is a problem with this task. Please contact developers  
or try to fix it yourself.                                                                                             
2024-03-20 17:37:01.348 | CRITICAL | Request human takeover                                                            
2024-03-20 17:37:01.349 | INFO | No provider specified, skip sending                                                   
2024-03-20 17:38:37.905 | INFO | Electron detected, remove log output to stdout                                        










// Example 2

═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════
                                                      OPSIOBSCURE                                                      
═══════════════════════════════════════════════════════════════════════════════════════════════════════════════════════
═══════════════════════════════════════════════════════ OS INIT ═══════════════════════════════════════════════════════
2024-03-22 20:54:10.755 | INFO | OS INIT                                                                               
2024-03-22 20:54:10.766 | INFO | <<< UI ENSURE >>>                                                                     
2024-03-22 20:54:10.767 | INFO | UI get current page                                                                   
2024-03-22 20:54:10.769 | INFO | [UI] page_campaign                                                                    
2024-03-22 20:54:10.770 | INFO | Goto page_os                                                                          
2024-03-22 20:54:10.770 | INFO | <<< UI GOTO PAGE_OS >>>                                                               
2024-03-22 20:54:10.772 | INFO | Page switch: page_campaign -> page_campaign_menu                                      
2024-03-22 20:54:10.773 | INFO | Click (  44,   41) @ BACK_ARROW                                                       
2024-03-22 20:54:11.070 | INFO | Page switch: page_campaign_menu -> page_os                                            
2024-03-22 20:54:11.071 | INFO | Click ( 672,  453) @ CAMPAIGN_MENU_GOTO_OS                                            
2024-03-22 20:54:12.057 | INFO | Page arrive: page_os                                                                  
2024-03-22 20:54:12.058 | INFO | <<< ZONE INIT >>>                                                                     
2024-03-22 20:54:12.061 | INFO | Get zone name                                                                         
2024-03-22 20:54:12.081 | INFO | Loading OCR model: ./bin/cnocr_models/cnocr                                           
2024-03-22 20:54:12.136 | INFO | [MAP_NAME 0.062s] NY                                                                  
2024-03-22 20:54:12.137 | INFO | Map name processed: NY                                                                
2024-03-22 20:54:12.138 | INFO | [Zone] [0|NY City]                                                                    
────────────────────────────────────────────────── AFTER AUTO SEARCH ──────────────────────────────────────────────────
2024-03-22 20:54:12.139 | INFO | AFTER AUTO SEARCH                                                                     
2024-03-22 20:54:12.148 | INFO | No EMP debuff on current fleet                                                        
2024-03-22 20:54:12.150 | INFO | [HP]  96%  96%  98%  96%  98%  98%                                                    
2024-03-22 20:54:12.153 | INFO | [Repair icon] [False, False, False, False, False, False]                              
2024-03-22 20:54:12.154 | INFO | No ship found to be below threshold 40%, continue OS exploration                      
2024-03-22 20:54:12.155 | INFO | Handle after auto search finished, solved=False                                       
2024-03-22 20:54:12.155 | INFO | Current fleet is not afflicted with the low resolve debuff                            
2024-03-22 20:54:12.157 | INFO | Ash beacon status: gray                                                               
2024-03-22 20:54:12.182 | INFO | [ASH_COLLECT_STATUS 0.025s] 0/200                                                     
2024-03-22 20:54:12.204 | INFO | [ASH_DAILY_STATUS 0.021s] 200/200                                                     
2024-03-22 20:54:12.205 | INFO | Ash beacon fully collected today                                                      
2024-03-22 20:54:12.206 | INFO | Run auto search, question=True, rescan=False                                          
─────────────────────────────────────────────────── OS AUTO SEARCH ────────────────────────────────────────────────────
2024-03-22 20:54:12.208 | INFO | OS AUTO SEARCH                                                                        
2024-03-22 20:54:12.223 | INFO | Click (1244,  539) @ AUTO_SEARCH_OS_MAP_OPTION_OFF                                    
2024-03-22 20:54:13.886 | INFO | OS auto search finished                                                               
2024-03-22 20:54:13.887 | INFO | Drop record added, genre=opsi_obscure, amount=1                                       
2024-03-22 20:54:13.888 | INFO | [HP]  96%  96%  98%  96%  98%  98%                                                    
2024-03-22 20:54:13.890 | INFO | [Repair icon] [False, False, False, False, False, False]                              
─────────────────────────────────────────────────── CLEAR QUESTION ────────────────────────────────────────────────────
2024-03-22 20:54:13.891 | INFO | CLEAR QUESTION                                                                        
2024-03-22 20:54:13.918 | INFO |             -- -- --                                                                  
2024-03-22 20:54:13.919 | INFO |       -- -- -- -- -- -- --                                                            
2024-03-22 20:54:13.919 | INFO |    -- -- -- -- -- -- -- -- --                                                         
2024-03-22 20:54:13.920 | INFO |    -- -- -- -- -- -- -- -- --                                                         
2024-03-22 20:54:13.921 | INFO | -- -- -- -- -- -- -- -- -- -- --                                                      
2024-03-22 20:54:13.922 | INFO | -- -- -- -- -- FL -- -- -- -- --                                                      
2024-03-22 20:54:13.922 | INFO | -- -- -- -- -- -- -- -- -- -- --                                                      
2024-03-22 20:54:13.923 | INFO |    -- -- -- -- PO -- -- -- --                                                         
2024-03-22 20:54:13.923 | INFO |    -- -- -- -- QU -- -- -- --                                                         
2024-03-22 20:54:13.923 | INFO |       -- -- -- -- -- -- --                                                            
2024-03-22 20:54:13.924 | INFO |             -- -- --                                                                  
2024-03-22 20:54:13.924 | INFO | No question mark above current fleet on this radar                                    
────────────────────────────────────────────────── AFTER AUTO SEARCH ──────────────────────────────────────────────────
2024-03-22 20:54:13.925 | INFO | AFTER AUTO SEARCH                                                                     
2024-03-22 20:54:13.926 | INFO | No EMP debuff on current fleet                                                        
2024-03-22 20:54:13.929 | INFO | [HP]  96%  96%  98%  96%  98%  98%                                                    
2024-03-22 20:54:13.930 | INFO | [Repair icon] [False, False, False, False, False, False]                              
2024-03-22 20:54:13.931 | INFO | No ship found to be below threshold 40%, continue OS exploration                      
2024-03-22 20:54:13.931 | INFO | Handle after auto search finished, solved=False                                       
══════════════════════════════════════════════════ OS CLEAR OBSCURE ═══════════════════════════════════════════════════
2024-03-22 20:54:13.932 | INFO | OS CLEAR OBSCURE                                                                      
2024-03-22 20:54:13.933 | INFO | <<< OS GET NEXT OBSCURE >>>                                                           
2024-03-22 20:54:13.934 | INFO | Storage enter                                                                         
2024-03-22 20:54:13.939 | INFO | Click ( 660,  681) @ STORAGE_ENTER                                                    
2024-03-22 20:54:15.456 | INFO | <<< STORAGE CHECKOUT ITEM OBSCURE >>>                                                 
2024-03-22 20:54:15.473 | INFO | [Storage_OBSCURE] 3                                                                   
2024-03-22 20:54:15.474 | INFO | Click ( 193,  152) @ TEMPLATE_STORAGE_OBSCURE                                         
2024-03-22 20:54:15.768 | INFO | Click ( 656,  514) @ STORAGE_COORDINATE_CHECKOUT                                      
2024-03-22 20:54:18.882 | INFO | Already selected at OBSCURE                                                           
2024-03-22 20:54:18.887 | INFO | Click ( 486,  297) @ ZONE_ENTRANCE                                                    
2024-03-22 20:54:21.094 | INFO | [Story_options] 0                                                                     
2024-03-22 20:54:21.346 | INFO | [Story_options] 0                                                                     
2024-03-22 20:54:21.347 | INFO | Click (1194,  261) @ CLICK_SAFE_AREA                                                  
2024-03-22 20:54:21.662 | INFO | [Story_options] 0                                                                     
2024-03-22 20:54:21.971 | INFO | <<< ZONE INIT >>>                                                                     
2024-03-22 20:54:21.972 | INFO | Get zone name                                                                         
2024-03-22 20:54:22.017 | INFO | [MAP_NAME 0.037s] 西北航道F-隐秘海域                                                  
2024-03-22 20:54:22.018 | INFO | Map name processed: 西北航道F                                                         
2024-03-22 20:54:22.018 | INFO | [Zone] [106|Northwest Passage F]                                                      
2024-03-22 20:54:22.019 | INFO | <<< FLEET SET TO 1 >>>                                                                
2024-03-22 20:54:22.026 | INFO | It is fleet 1 already                                                                 
2024-03-22 20:54:22.028 | INFO | <<< ORDER_SCAN >>>                                                                    
2024-03-22 20:54:22.028 | INFO | Order enter                                                                           
2024-03-22 20:54:22.033 | INFO | Click (1036,  175) @ ORDER_ENTER                                                      
2024-03-22 20:54:22.597 | INFO | Click (1110,  412) @ ORDER_SCAN                                                       
2024-03-22 20:54:22.902 | INFO | Click ( 771,  533) @ POPUP_CONFIRM_ORDER_SCAN                                         
2024-03-22 20:54:24.457 | INFO | Delay task `OpsiObscure` to 2024-03-22 21:21:24 (recon_scan=True,                     
submarine_call=False, ap_limit=False, cl1_preserve=False)                                                              
2024-03-22 20:54:24.458 | INFO | Delay task `OpsiStronghold` to 2024-03-22 21:21:24 (recon_scan=True,                  
submarine_call=False, ap_limit=False, cl1_preserve=False)                                                              
2024-03-22 20:54:24.466 | INFO | Bind task ['General', 'Alas', 'OpsiGeneral', 'OpsiObscure']                           
2024-03-22 20:54:24.466 | INFO | Save config ./config\alas.json, OpsiObscure.Scheduler.NextRun=datetime.datetime(2024, 
3, 22, 21, 21, 24), OpsiStronghold.Scheduler.NextRun=datetime.datetime(2024, 3, 22, 21, 21, 24)                        
2024-03-22 20:54:24.482 | INFO | Run auto search, question=True, rescan=current                                        
─────────────────────────────────────────────────── OS AUTO SEARCH ────────────────────────────────────────────────────
2024-03-22 20:54:24.484 | INFO | OS AUTO SEARCH                                                                        
2024-03-22 20:54:24.488 | INFO | Click (1239,  542) @ AUTO_SEARCH_OS_MAP_OPTION_OFF                                    
2024-03-22 20:54:32.268 | INFO | [Loading] 4%                                                                          
2024-03-22 20:54:32.269 | INFO | [battle_count] 1                                                                      
2024-03-22 20:54:32.270 | INFO | Auto search combat loading                                                            
2024-03-22 20:54:32.270 | INFO | Screenshot interval set to 1s                                                         
2024-03-22 20:54:40.358 | INFO | Auto Search combat execute                                                            
2024-03-22 20:54:45.440 | INFO | Submarine call timer reached                                                          
2024-03-22 20:55:31.886 | INFO | [Story_options] 0                                                                     
2024-03-22 20:55:32.896 | INFO | Screenshot interval set to 0.3s                                                       
2024-03-22 20:55:32.897 | INFO | Combat end.                                                                           
2024-03-22 20:55:36.053 | INFO | [Story_options] 1                                                                     
2024-03-22 20:55:36.331 | INFO | [Story_options] 1                                                                     
2024-03-22 20:55:36.332 | INFO | Click (1170,  247) @ CLICK_SAFE_AREA                                                  
2024-03-22 20:55:41.940 | INFO | [Story_options] 0                                                                     
2024-03-22 20:55:44.103 | INFO | [Story_options] 0                                                                     
2024-03-22 20:55:45.061 | INFO | [Loading] 6%                                                                          
2024-03-22 20:55:45.061 | INFO | [battle_count] 2                                                                      
2024-03-22 20:55:45.062 | INFO | Auto search combat loading                                                            
2024-03-22 20:55:45.062 | INFO | Screenshot interval set to 1s                                                         
2024-03-22 20:55:53.125 | INFO | Auto Search combat execute                                                            
2024-03-22 20:55:58.198 | INFO | Submarine call timer reached                                                          
2024-03-22 20:56:44.706 | INFO | Screenshot interval set to 0.3s                                                       
2024-03-22 20:56:44.706 | INFO | Combat end.                                                                           
2024-03-22 20:56:45.007 | INFO | [Story_options] 0                                                                     
2024-03-22 20:56:45.321 | INFO | [Story_options] 0                                                                     
2024-03-22 20:56:45.322 | INFO | Click (1135,  222) @ CLICK_SAFE_AREA                                                  
2024-03-22 20:56:45.647 | INFO | [Story_options] 0                                                                     
2024-03-22 20:56:47.823 | INFO | [Story_options] 0                                                                     
2024-03-22 20:56:48.120 | INFO | [Story_options] 0                                                                     
2024-03-22 20:56:48.121 | INFO | Click (1165,  241) @ CLICK_SAFE_AREA                                                  
2024-03-22 20:56:55.605 | INFO | Drop record added, genre=opsi_obscure, amount=1                                       
2024-03-22 20:56:55.606 | INFO | Click ( 674,  629) @ AUTO_SEARCH_REWARD                                               
2024-03-22 20:56:57.151 | INFO | OS auto search finished                                                               
2024-03-22 20:56:57.151 | INFO | Drop record added, genre=opsi_obscure, amount=2                                       
2024-03-22 20:56:57.153 | INFO | [HP]  90%  98%  98%  93%  83%  93%                                                    
2024-03-22 20:56:57.154 | INFO | [Repair icon] [False, False, False, False, False, False]                              
─────────────────────────────────────────────────── CLEAR QUESTION ────────────────────────────────────────────────────
2024-03-22 20:56:57.155 | INFO | CLEAR QUESTION                                                                        
2024-03-22 20:56:57.172 | INFO |             -- -- --                                                                  
2024-03-22 20:56:57.173 | INFO |       -- -- -- -- -- -- --                                                            
2024-03-22 20:56:57.173 | INFO |    -- -- -- -- -- -- -- -- --                                                         
2024-03-22 20:56:57.174 | INFO |    -- -- -- -- -- -- -- -- --                                                         
2024-03-22 20:56:57.174 | INFO | -- -- -- -- -- -- -- -- -- -- --                                                      
2024-03-22 20:56:57.175 | INFO | -- -- -- -- -- FL -- -- -- -- --                                                      
2024-03-22 20:56:57.176 | INFO | -- -- -- -- -- -- -- -- -- -- --                                                      
2024-03-22 20:56:57.176 | INFO |    -- -- -- -- -- -- -- EN --                                                         
2024-03-22 20:56:57.177 | INFO |    -- -- -- EN RE -- -- -- --                                                         
2024-03-22 20:56:57.177 | INFO |       -- -- -- -- -- -- EN                                                            
2024-03-22 20:56:57.179 | INFO |             -- -- --                                                                  
2024-03-22 20:56:57.179 | INFO | No question mark above current fleet on this radar                                    
2024-03-22 20:56:57.180 | INFO | <<< FLEET SET TO 1 >>>                                                                
2024-03-22 20:56:57.184 | INFO | It is fleet 1 already                                                                 
───────────────────────────────────────────────── MAP RESCAN CURRENT ──────────────────────────────────────────────────
2024-03-22 20:56:57.185 | INFO | MAP RESCAN CURRENT                                                                    
2024-03-22 20:56:57.186 | INFO | Load map_data, has_loop=False, use_loop=False                                         
2024-03-22 20:56:57.187 | INFO | Load spawn_data, has_loop=False, use_loop=False                                       
2024-03-22 20:56:57.187 | INFO | grid_connection: wall=False, portal=False                                             
2024-03-22 20:56:57.190 | INFO | Load mechanism, land_base=False, maze=False, fortress=False, bouncing_enemy=False     
2024-03-22 20:56:57.478 | INFO | [homo_storage] ((10, 7), [(110.307, 103.657), (1012.311, 103.657), (-32.959, 600.567),
(1113.057, 600.567)])                                                                                                  
2024-03-22 20:56:57.538 | INFO |            tile_center: 0.929 (good match)                                            
2024-03-22 20:56:57.539 | INFO | 0.042s      edge_lines: 0 hori, 0 vert                                                
2024-03-22 20:56:57.540 | INFO | Edges:       homo_loca: ( 53,  58)                                                    
2024-03-22 20:56:57.544 | INFO |            center_loca: (5, 4)                                                        
2024-03-22 20:56:57.545 | INFO |                 Camera: A1                                                            
2024-03-22 20:56:57.586 | INFO | 0.040s         predict: 84                                                            
2024-03-22 20:56:57.586 | INFO | -- -- -- -- -- -- -- -- -- -- -- --                                                   
2024-03-22 20:56:57.587 | INFO | -- -- -- -- -- -- -- -- -- -- -- --                                                   
2024-03-22 20:56:57.588 | INFO | .. -- -- -- -- -- -- -- -- -- -- --                                                   
2024-03-22 20:56:57.589 | INFO | .. -- -- -- -- -- -- -- -- -- -- ..                                                   
2024-03-22 20:56:57.589 | INFO | .. -- -- -- -- FL -- -- -- -- -- ..                                                   
2024-03-22 20:56:57.589 | INFO | .. -- -- -- -- -- -- -- -- -- -- ..                                                   
2024-03-22 20:56:57.590 | INFO | .. -- -- -- -- -- -- -- -- -- -- ..                                                   
2024-03-22 20:56:57.590 | INFO | .. .. -- -- -- -- -- -- -- -- -- ..                                                   
2024-03-22 20:56:57.590 | INFO | No map event                                                                          
2024-03-22 20:56:57.591 | INFO | Map rescan once end, result=False                                                     
2024-03-22 20:56:57.591 | INFO | [Solved_map_event] set()                                                              
2024-03-22 20:56:57.592 | INFO | <<< FLEET SET TO 1 >>>                                                                
2024-03-22 20:56:57.596 | INFO | It is fleet 1 already                                                                 
2024-03-22 20:56:57.597 | INFO | Drop record commit, genre=opsi_obscure, amount=2, save=True, upload=False             
2024-03-22 20:56:57.600 | INFO | <<< MAP EXIT >>>                                                                      
2024-03-22 20:56:57.602 | INFO | Click (1216,  669) @ MAP_EXIT                                                         
2024-03-22 20:56:57.793 | INFO | Click ( 795,  517) @ POPUP_CONFIRM_MAP_EXIT                                           
2024-03-22 20:56:57.886 | INFO | Image save success, file: ./screenshots\opsi_obscure\1711112217600.png                
2024-03-22 20:56:59.032 | INFO | Click ( 682,  683) @ MAP_WORLD                                                        
2024-03-22 20:57:01.809 | INFO | <<< ZONE INIT >>>                                                                     
2024-03-22 20:57:01.810 | INFO | Get zone name                                                                         
2024-03-22 20:57:01.862 | INFO | [MAP_NAME 0.046s] NY                                                                  
2024-03-22 20:57:01.864 | INFO | Map name processed: NY                                                                
2024-03-22 20:57:01.864 | INFO | [Zone] [0|NY City]                                                                    
────────────────────────────────────────────────── AFTER AUTO SEARCH ──────────────────────────────────────────────────
2024-03-22 20:57:01.866 | INFO | AFTER AUTO SEARCH                                                                     
2024-03-22 20:57:01.867 | INFO | No EMP debuff on current fleet                                                        
2024-03-22 20:57:01.869 | INFO | [HP]  90%  98%  98%  93%  83%  93%                                                    
2024-03-22 20:57:01.872 | INFO | [Repair icon] [False, False, False, False, False, False]                              
2024-03-22 20:57:01.873 | INFO | No ship found to be below threshold 40%, continue OS exploration                      
2024-03-22 20:57:01.874 | INFO | Handle after auto search finished, solved=False                                       
2024-03-22 20:57:01.874 | INFO | Scheduler: End task `OpsiObscure`                                                     
2024-03-22 20:57:01.875 | INFO | [Server] cn                                                                           
2024-03-22 20:57:01.892 | INFO | Bind task ['General', 'Alas']                                                         
2024-03-22 20:57:01.894 | INFO | Pending tasks: ['Main2', 'Main3']                                                     
2024-03-22 20:57:01.895 | INFO | [Task] Main2 (Enable, 2024-03-22 20:48:00)                                            
2024-03-22 20:57:01.896 | INFO | Bind task ['General', 'Alas', 'Main2']                                                
2024-03-22 20:57:01.906 | INFO | Scheduler: Start task `Main2`

截图

截图为日志中的 ./screenshots\opsi_obscure\1711112217600.png

1711112217600

还有别的吗?

上述例子均在没有人为干扰的情况下观察到; 运行环境如下: 模拟器:Bluestacks 5.13.220.1001 Hyper-V (Android : Pie 64-bit) 截图方案:DroidCast_raw 控制方案:minitouch 主机硬件配置及模拟器分配的硬件资源不低于目前主流水平,因此无需考虑性能因素; 类似的自律被打断的问题在不使用 Alas(例如:手动运行计划作战)时没有出现过。

对日志的简单分析 我注意到问题发生时,日志中往往反复出现 INFO | [Story_options] 0INFO | Click (..., ...) @ CLICK_SAFE_AREA; 前者通常在识别到需要点击的剧情时出现,且跟随的数字 (1~3) 是剧情选项的数量——那么数字 0 的含义是? 后者可能是一个单击操作,或许是这个操作导致了自律异常中止?

frostLotusw avatar Mar 22 '24 15:03 frostLotusw

数字0代表目前TB在讲话(类似剧情),所以通过点击加快跳过;正常来说TB的对话应该是10倍速自动(如果你在游戏设置里面合理设置的话),可以检查一下是不是卡在对话里面了。

guoh064 avatar Mar 22 '24 15:03 guoh064

数字0代表目前TB在讲话(类似剧情),所以通过点击加快跳过;正常来说TB的对话应该是10倍速自动(如果你在游戏设置里面合理设置的话),可以检查一下是不是卡在对话里面了。

检查了游戏设置,均和 README 中的设置要求一致(退役设置除外,但这对大型作战不会有影响); 另外,我人工值守发现 INFO | [Story_options] 0 出现时,并未注意到游戏中出现过任何剧情对话。 正常情况下,侵蚀1除了塞壬装置和明石,也不会出现剧情对话的吧?

image

frostLotusw avatar Mar 22 '24 15:03 frostLotusw

是否可能是 Alas 在正常的舰队移动画面错误识别到了 TB 对话并点击以加速,而点击导致了自律被打断?

frostLotusw avatar Mar 22 '24 15:03 frostLotusw

emmm,你人工值守的时候可以试着看看alas在点击什么,又看到什么,对比一下

guoh064 avatar Mar 22 '24 15:03 guoh064

仔细观察了一下,INFO | [Story_options] 0 出现时,确实出现了一闪而过的 TB 对话;

之前确实没有注意到这一情况,issue 中没有提及,非常抱歉;

经检查,设置里的 减少TB引导 一直是打开的,因此应该不是设置的问题?

frostLotusw avatar Mar 22 '24 15:03 frostLotusw

问题基本解决

在设置里暂时关闭 减少TB引导,重启游戏,再重新打开 减少TB引导

运行大型作战,TB 对话没有再出现,Alas 日志也没有再出现 INFO | [Story_options] 0

到此应该可以排除 Alas 的问题,怀疑是游戏程序的偶然错误导致设置未能正常生效?

非常感谢 @guoh064 提供的指导帮助;如果观察一段时间后问题不再复现,这个 issue 可以关闭了。

frostLotusw avatar Mar 22 '24 16:03 frostLotusw

如果在舰队赶路的时候点击了“停止自律”,且舰队的落脚点刚好是敌方舰队,那么在战斗结束的时候就会卡在“战斗胜利”的页面,71经常出现这个问题。Alas有时候会通过重启游戏来解决,但有时候会直接卡死。

lzy-personal avatar Mar 23 '24 06:03 lzy-personal