NEW - AVCS Voice Controlled Bug Report

[=VG= SemlerPDX]

Profile:  AVCS4 BMS - Immersive Voice Control Radios
Issue:  Save File issues related to any game profile
Profile Version:  1.5.1
VoiceAttack Version:  1.8.5

Steps to reproduce:

1. set wingman as human pilot  ||  AI COMMS - Human Player Callsigns
2. f_sfs_to_file  ||  Script Functions - Save File System
3. f_sfs_sort  ||  Script Functions - Save File System

Expected Behavior:
default functional operation

Observed Behavior:
(avcs automated debugging has flagged 1 error for review - see details in debug log below)
(see attached error log file, if available)

Personal Testing:
(AVCS Automated Debug and Reporting used)

Comments:
AVCS CORE Version: "0.88.5" CORE App Version: "0.88.99"Session Command Count:223 RAM(total):34271133696 RAM(available):27163246592
LastCMD:two say fuel PreviousCMD:u.s.
Playback:VoiceMeeter Input (VB-Audio VoiceMeeter VAIO) Playback(comms):VoiceMeeter Input (VB-Audio VoiceMeeter VAIO)
Playback Volume:100 Playback Mute:0
Microphone:Microphone (Logitech G933 Gaming Headset) Microphone(comms):Microphone (Logitech G933 Gaming Headset)
Microphone Volume:70 Microphone Mute:0
Speech Device Volume:70 Speech Device Mute:0
JOYSTICK1:0 JOYSTICK2:0 JOYSTICK3:0 JOYSTICK4:0
GAMEPAD1:0 GAMEPAD2:0 GAMEPAD3:0 GAMEPAD4:0

133453575 CID:1791 -DEBUG-000- || IS:0 || ACT:Profile || CMD:F_CORE_INITIALIZE
133453581 CID:1791 -DEBUG-000- || RID:500 || CAT:Script Functions - AVCS CORE Systems
133454271 CID:1791 -DEBUG-19- || INFO:  Executing Sub-Command (F_CORE_SFS) with RID:4323 - valid Return should == 4557
133454321 CID:3588 -DEBUG-000- || IS:1 || ACT:Profile || CMD:f_core_sfs
133454327 CID:3588 -DEBUG-000- || RID:4323 || CAT:Script Functions - AVCS CORE Systems
133454930 CID:3588 -DEBUG-03- || INFO:  SFS Path Loaded - C:\Program Files (x86)\VoiceAttack\Apps\AVCS\save_files\core_save\80\save.txt
133455164 CID:1791 -DEBUG-20b- || INFO:  Sub-Command (F_CORE_SFS) COMPLETE -- Return equals 4557
133455290 CID:1791 -DEBUG-30- || INFO:  BEGIN CORE INIT
133455608 CID:1791 -DEBUG-39- || INFO:  Checking Update ID Path --   ~update_ID_path = C:\Program Files (x86)\VoiceAttack\Apps\AVCS\CORE\CORE\80\avcs_core_versionID.core
133455793 CID:1791 -DEBUG-41b- || INFO:  Executing Sub-Command (F_CORE_APP) with RID:1160 - valid Return should == 1394
133455949 CID:2050 -DEBUG-000- || IS:1 || ACT:Profile || CMD:f_core_app
133455955 CID:2050 -DEBUG-000- || RID:1160 || CAT:Script Functions - AVCS CORE Systems
133457474 CID:1791 -DEBUG-42b- || INFO:  Sub-Command (F_CORE_APP) COMPLETE -- Return equals 1394
133457515 CID:1791 -DEBUG-44- || INFO:  CORE IS ONLINE
133457563 CID:1791 -DEBUG-46- || INFO:  SUCCESS --  at 'Log current CORE Update ID'    ~module_update_ID = 20051521   ||   ~update_ID_text = 20051521
133500575 CID:1791 -DEBUG-49- || INFO:  Online Update ID - ~online_update_ID = 20051521
133500790 CID:1791 -DEBUG-62- || INFO:  REPEAT USER RUN INIT - (CFG)  ~profile_to_init = CORE
133501969 CID:1791 -DEBUG-75- || INFO:  DATA LOAD -   ~profile_to_init = CORE  ||  ~data_index = 0
133502220 CID:1791 -DEBUG-75- || INFO:  DATA LOAD -   ~profile_to_init = CORE  ||  ~data_index = 1
133502271 CID:1791 -DEBUG-77- || INFO:  FIRST DEPMOD INIT -   ~profile_to_init = CORE   ||   ~primary_init_profile = CORE
133502320 CID:1791 -DEBUG-78- || INFO:  DEPMOD INIT LOOP -   ~profile_to_init = CORE
133502352 CID:1791 -DEBUG-79- || INFO:  DEPMOD INIT LOOP 2 - DEPMOD NAME   ~profile_to_init = VAS
133502509 CID:1791 -DEBUG-39- || INFO:  Checking Update ID Path --   ~update_ID_path = C:\Program Files (x86)\VoiceAttack\Apps\AVCS\CORE\VAS\80\avcs_vas_versionID.core
133502593 CID:1791 -DEBUG-46- || INFO:  SUCCESS --  at 'Log current CORE Update ID'    ~module_update_ID = 20031222   ||   ~update_ID_text = 20031222
133502773 CID:1791 -DEBUG-49- || INFO:  Online Update ID - ~online_update_ID = 20031222
133502865 CID:1791 -DEBUG-62- || INFO:  REPEAT USER RUN INIT - (CFG)  ~profile_to_init = VAS
133503279 CID:1791 -DEBUG-75- || INFO:  DATA LOAD -   ~profile_to_init = VAS  ||  ~data_index = 0
133503579 CID:1791 -DEBUG-75- || INFO:  DATA LOAD -   ~profile_to_init = VAS  ||  ~data_index = 1
133503866 CID:1791 -DEBUG-75- || INFO:  DATA LOAD -   ~profile_to_init = VAS  ||  ~data_index = 2
133503935 CID:1791 -DEBUG-78- || INFO:  DEPMOD INIT LOOP -   ~profile_to_init = VAS
133503978 CID:1791 -DEBUG-81- || INFO:  COMPLETE -   CORE AND MODULE INITIALIZED
133503985 CID:1791 -DEBUG-81b- || INFO:  AVCS_CORE_INIT = True  ||  AVCS_BMS_INIT = Not set  ||  AVCS_VAS_INIT = True  ||  AVCS_SFS_INIT = True
133504076 CID:1791 -DEBUG-93- || INFO:  Executing Sub-Command (F_SFS_LOAD_ALL) with RID:3996 - valid Return should == 4230
133504145 CID:3304 -DEBUG-000- || IS:1 || ACT:Profile || CMD:f_sfs_load_all
133504150 CID:3304 -DEBUG-000- || RID:3996 || CAT:Script Functions - Save File System
133505217 CID:3304 -DEBUG-07- || INFO:  Executing AVCS Inline "LoadAll" and subsequent SFS TO PROFILE command
133505223 CID:3304 -DEBUG-07b- || INFO:  Executing Sub-Command (Inline LoadAll) with RID:1646 - valid Return should == 1880
133505459 CID:3304 -DEBUG-08b- || INFO:  Sub-Command (Inline LoadAll) COMPLETE -- Return equals 1880
133505494 CID:3304 -DEBUG-09- || INFO:  SFS File Loaded from C:\Program Files (x86)\VoiceAttack\Apps\AVCS\save_files\core_save\80\save.txt
133505838 CID:1791 -DEBUG-94b- || INFO:  Sub-Command (F_SFS_LOAD_ALL) COMPLETE -- Return equals 4230
133505889 CID:1791 -DEBUG-99- || INFO:  Executing Sub-Command (F_SFS_TO_FILE) with RID:2644 - valid Return should == 2878
133505979 CID:3267 -DEBUG-000- || IS:1 || ACT:Profile || CMD:f_sfs_to_file
133505985 CID:3267 -DEBUG-000- || RID:2644 || CAT:Script Functions - Save File System
133505990 CID:3267 -DEBUG-01- || INFO:  AVCS_SFS_DELETE_saved = False   ||   AVCS_SFS_BACKUP_bypass = True
133506662 CID:3267 -DEBUG-11- || INFO:  COMPLETE --   should have sent text to: C:\Program Files (x86)\VoiceAttack\Apps\AVCS\save_files\core_save\80\save.txt
133506711 CID:3267 -DEBUG-15- || INFO:  SFS Variable(s) Saved to C:\Program Files (x86)\VoiceAttack\Apps\AVCS\save_files\core_save\80\save.txt
133506984 CID:1791 -DEBUG-100b- || INFO:  Sub-Command (F_SFS_TO_FILE) COMPLETE -- Return equals 2878
133507009 CID:1791 -DEBUG-101- || INFO:  ----------RESERVED FOR CORE PROFILE  ------------- ONE TIME FULLY LOADED CHECK RESETS ONLY HERE!!! ONE TIME !!!-------
133507168 CID:1791 -DEBUG-104x- || INFO:  Marker AVCS_CORE_END -- (exiting core cmd)
133507263 CID:3397 -DEBUG-000- || IS:0 || ACT:ProfileUnloadChange || CMD:F_CORE_INITIALIZE
133507269 CID:3397 -DEBUG-000- || RID:500 || CAT:Script Functions - AVCS CORE Systems
133507591 CID:3397 -DEBUG-00- || INFO:  RELOAD CORE is true so Jumping to End of CORE INIT (bypass main/exit)
133507613 CID:3397 -DEBUG-104x- || INFO:  Marker AVCS_CORE_END -- (exiting core cmd)
133508080 CID:2532 -DEBUG-000- || IS:0 || ACT:Profile || CMD:F_CORE_INITIALIZE
133508085 CID:2532 -DEBUG-000- || RID:500 || CAT:Script Functions - AVCS CORE Systems
133508613 CID:2532 -DEBUG-21- || INFO:  RELOAD CORE == TRUE  (jumping to title marker)   --------------- RESERVED FOR AVCSCORE ------------------------------------------
133508719 CID:2532 -DEBUG-104x- || INFO:  Marker AVCS_CORE_END -- (exiting core cmd)
133522943 CID:4381 -DEBUG-000- || IS:0 || ACT:ProfileUnloadChange || CMD:F_CORE_INITIALIZE
133522949 CID:4381 -DEBUG-000- || RID:500 || CAT:Script Functions - AVCS CORE Systems
133523489 CID:4381 -DEBUG-24- || INFO:  --------------------------------RESERVED FOR NON CORE PROFILES------------------------------------------
133523493 CID:4381 -DEBUG-24b- || INFO:  ----->  ~check_switchto_profile = BMS   <------------
133523515 CID:4381 -DEBUG-25- || INFO:  ------>  SWITCH TO AVCS PROFILE THAT IS NOT INITIALIZED   <------------
133523595 CID:4381 -DEBUG-31- || INFO:  ---------------------------------RESERVED FOR NON CORE PROFILES------------------------------------------
133523603 CID:4381 -DEBUG-31b- || INFO:  BEGIN MODULE INIT
133523611 CID:4381 -DEBUG-31c- || ERROR:  "OOPS" AVCS_CORE_INIT = True and also AVCS_INIT_PROFILE = BMS (dev)
133523661 CID:4381 -DEBUG-33- || INFO:  ----------------------------------RESERVED FOR NON CORE PROFILES------------------------------------------
133523772 CID:4381 -DEBUG-39- || INFO:  Checking Update ID Path --   ~update_ID_path = C:\Program Files (x86)\VoiceAttack\Apps\AVCS\CORE\BMS\80\avcs_bms_versionID.core
133523961 CID:4381 -DEBUG-41b- || INFO:  Executing Sub-Command (F_CORE_APP) with RID:4350 - valid Return should == 4584
133524123 CID:1303 -DEBUG-000- || IS:1 || ACT:ProfileUnloadChange || CMD:f_core_app
133524129 CID:1303 -DEBUG-000- || RID:4350 || CAT:Script Functions - AVCS CORE Systems
133529188 CID:4381 -DEBUG-42b- || INFO:  Sub-Command (F_CORE_APP) COMPLETE -- Return equals 4584
133529233 CID:4381 -DEBUG-44- || INFO:  CORE IS ONLINE
133529283 CID:4381 -DEBUG-46- || INFO:  SUCCESS --  at 'Log current CORE Update ID'    ~module_update_ID = 20031607   ||   ~update_ID_text = 20031607
133529769 CID:4381 -DEBUG-49- || INFO:  Online Update ID - ~online_update_ID = 20031607
133529997 CID:4381 -DEBUG-62- || INFO:  REPEAT USER RUN INIT - (CFG)  ~profile_to_init = BMS
133530907 CID:4381 -DEBUG-75- || INFO:  DATA LOAD -   ~profile_to_init = BMS  ||  ~data_index = 0
133531199 CID:4381 -DEBUG-75- || INFO:  DATA LOAD -   ~profile_to_init = BMS  ||  ~data_index = 1
133531459 CID:4381 -DEBUG-75- || INFO:  DATA LOAD -   ~profile_to_init = BMS  ||  ~data_index = 2
133531678 CID:4381 -DEBUG-75- || INFO:  DATA LOAD -   ~profile_to_init = BMS  ||  ~data_index = 3
133531725 CID:4381 -DEBUG-77- || INFO:  FIRST DEPMOD INIT -   ~profile_to_init = BMS   ||   ~primary_init_profile = BMS
133531793 CID:4381 -DEBUG-81- || INFO:  COMPLETE -   CORE AND MODULE INITIALIZED
133531801 CID:4381 -DEBUG-81b- || INFO:  AVCS_CORE_INIT = True  ||  AVCS_BMS_INIT = True  ||  AVCS_VAS_INIT = True  ||  AVCS_SFS_INIT = True
133531860 CID:4381 -DEBUG-83- || INFO:  [~next_avcs_profile] Does Not Equal '' AND [AVCS_CORE_FULLYLOADED] Equals True)
133531867 CID:4381 -DEBUG-83b- || INFO:  -(switching to 'next_avcs_profile')----------------------------------RESERVED FOR NON CORE PROFILES------------------------------------------
133531875 CID:4381 -DEBUG-83c- || INFO:  CORE INITIALIZE COMPLETE - PROFILE SWITCH BEGIN
133531906 CID:4381 -DEBUG-84- || INFO:  Executing Sub-Command (F_CORE_SFS) with RID:2657 - valid Return should == 2891
133531955 CID:1330 -DEBUG-000- || IS:1 || ACT:ProfileUnloadChange || CMD:f_core_sfs
133531961 CID:1330 -DEBUG-000- || RID:2657 || CAT:Script Functions - AVCS CORE Systems
133532916 CID:1330 -DEBUG-03- || INFO:  SFS Path Loaded - C:\Program Files (x86)\VoiceAttack\Apps\AVCS\save_files\bms_save\80\save.txt
133533153 CID:4381 -DEBUG-85b- || INFO:  Sub-Command (F_CORE_SFS) COMPLETE -- Return equals 2891
133533179 CID:4381 -DEBUG-86- || INFO:  SAVE FILE PATH IS VALID == 1
133533213 CID:4381 -DEBUG-87- || INFO:  SAVE FILE PATH HAS DATA TO LOAD --------
133533240 CID:4381 -DEBUG-88- || INFO:  Executing Sub-Command (F_SFS_LOAD_ALL) with RID:2443 - valid Return should == 2677
133533304 CID:2252 -DEBUG-000- || IS:1 || ACT:ProfileUnloadChange || CMD:f_sfs_load_all
133533312 CID:2252 -DEBUG-000- || RID:2443 || CAT:Script Functions - Save File System
133533762 CID:2252 -DEBUG-07- || INFO:  Executing AVCS Inline "LoadAll" and subsequent SFS TO PROFILE command
133533768 CID:2252 -DEBUG-07b- || INFO:  Executing Sub-Command (Inline LoadAll) with RID:2515 - valid Return should == 2749
133533816 CID:2252 -DEBUG-08b- || INFO:  Sub-Command (Inline LoadAll) COMPLETE -- Return equals 2749
133533849 CID:2252 -DEBUG-09- || INFO:  SFS File Loaded from C:\Program Files (x86)\VoiceAttack\Apps\AVCS\save_files\bms_save\80\save.txt
133534192 CID:4381 -DEBUG-89b- || INFO:  Sub-Command (F_SFS_LOAD_ALL) COMPLETE -- Return equals 2677
133534223 CID:4381 -DEBUG-91- || INFO:  -(switching to 'next_avcs_profile')----------------------------------RESERVED FOR NON CORE PROFILES------------------------------------------
133534293 CID:4381 -DEBUG-93- || INFO:  Executing Sub-Command (F_SFS_LOAD_ALL) with RID:4223 - valid Return should == 4457
133534361 CID:4197 -DEBUG-000- || IS:1 || ACT:ProfileUnloadChange || CMD:f_sfs_load_all
133534367 CID:4197 -DEBUG-000- || RID:4223 || CAT:Script Functions - Save File System
133534766 CID:4197 -DEBUG-07- || INFO:  Executing AVCS Inline "LoadAll" and subsequent SFS TO PROFILE command
133534772 CID:4197 -DEBUG-07b- || INFO:  Executing Sub-Command (Inline LoadAll) with RID:1518 - valid Return should == 1752
133534819 CID:4197 -DEBUG-08b- || INFO:  Sub-Command (Inline LoadAll) COMPLETE -- Return equals 1752
133534851 CID:4197 -DEBUG-09- || INFO:  SFS File Loaded from C:\Program Files (x86)\VoiceAttack\Apps\AVCS\save_files\bms_save\80\save.txt
133535186 CID:4381 -DEBUG-94b- || INFO:  Sub-Command (F_SFS_LOAD_ALL) COMPLETE -- Return equals 4457
133535232 CID:4381 -DEBUG-99- || INFO:  Executing Sub-Command (F_SFS_TO_FILE) with RID:3409 - valid Return should == 3643
133535323 CID:3550 -DEBUG-000- || IS:1 || ACT:ProfileUnloadChange || CMD:f_sfs_to_file
133535329 CID:3550 -DEBUG-000- || RID:3409 || CAT:Script Functions - Save File System
133535335 CID:3550 -DEBUG-01- || INFO:  AVCS_SFS_DELETE_saved = False   ||   AVCS_SFS_BACKUP_bypass = True
133535826 CID:3550 -DEBUG-11- || INFO:  COMPLETE --   should have sent text to: C:\Program Files (x86)\VoiceAttack\Apps\AVCS\save_files\bms_save\80\save.txt
133535879 CID:3550 -DEBUG-15- || INFO:  SFS Variable(s) Saved to C:\Program Files (x86)\VoiceAttack\Apps\AVCS\save_files\bms_save\80\save.txt
133536153 CID:4381 -DEBUG-100b- || INFO:  Sub-Command (F_SFS_TO_FILE) COMPLETE -- Return equals 3643
133536266 CID:4381 -DEBUG-104x- || INFO:  Marker AVCS_CORE_END -- (exiting core cmd)
133544127 CID:3037 -DEBUG-000- || IS:0 || ACT:Profile || CMD:init_MAIN
133544131 CID:3037 -DEBUG-000- || RID:500 || CAT:(initialization)
133544392 CID:3037 -DEBUG-00- || INFO:  BMS Profile Switch Complete --  PROFILE_SWITCH_SET=TRUE Recognized
133548594 CID:3037 -DEBUG-02- || INFO:  Executing Sub-Command (F_SFS_BACKUP) with RID:2211 - valid Return should == 2445
133548664 CID:4273 -DEBUG-000- || IS:1 || ACT:Profile || CMD:f_sfs_backup
133548670 CID:4273 -DEBUG-000- || RID:2211 || CAT:Script Functions - Save File System
133549064 CID:4273 -DEBUG-01- || INFO:  AVCS_SFS_SaveFileBackupCount=10  ||  AVCS_SFS_CurrentBackupIndex=6
133549074 CID:4273 -DEBUG-01b- || INFO:  NEW Backup of Save File created at C:\Program Files (x86)\VoiceAttack\Apps\AVCS\save_files\bms_save\80\backup\save_backup_6.txt
133549366 CID:3037 -DEBUG-03b- || INFO:  Sub-Command (F_SFS_BACKUP) COMPLETE -- Return == 2445
150420676 CID:Not set -DEBUG-##- || INFO:  ====================NEW REPORT====================
150436126 CID:1222 -DEBUG-000- || IS:0 || ACT:Spoken || CMD:set wingman as human pilot
150436130 CID:1222 -DEBUG-000- || RID:500 || CAT:AI COMMS - Human Player Callsigns
150438861 CID:1222 -DEBUG-0#- || INFO:  Executing Sub-Command (F_SFS_TO_FILE) with RID:3439 - valid Return should == 3673
150438961 CID:3906 -DEBUG-000- || IS:1 || ACT:Spoken || CMD:f_sfs_to_file
150438967 CID:3906 -DEBUG-000- || RID:3439 || CAT:Script Functions - Save File System
150438973 CID:3906 -DEBUG-01- || INFO:  AVCS_SFS_DELETE_saved = False   ||   AVCS_SFS_BACKUP_bypass = True
150439415 CID:3906 -DEBUG-11- || INFO:  COMPLETE --   should have sent text to: C:\Program Files (x86)\VoiceAttack\Apps\AVCS\save_files\bms_save\80\save.txt
150439437 CID:3906 -DEBUG-12- || INFO:  Executing Sub-Command (F_SFS_SORT) with RID:2504 - valid Return should == 2738
150439511 CID:1504 -DEBUG-000- || IS:1 || ACT:Spoken || CMD:f_sfs_sort
150439517 CID:1504 -DEBUG-000- || RID:2504 || CAT:Script Functions - Save File System
150439848 CID:1504 -DEBUG-05- || INFO:  SORT Command Bypassed by parameter (AVCS_SFS_SORT_bypass = True)
150440090 CID:3906 -DEBUG-13b- || INFO:  Sub-Command (F_SFS_SORT) COMPLETE -- Return equals 2738
150440132 CID:3906 -DEBUG-15- || INFO:  SFS Variable(s) Saved to C:\Program Files (x86)\VoiceAttack\Apps\AVCS\save_files\bms_save\80\save.txt
150440394 CID:1222 -DEBUG-0#b- || INFO:  Sub-Command (F_SFS_TO_FILE) COMPLETE -- Return == 3673

---

Severity / Status:      Resolved (live update pushed to all users)

---

View full bug report