ATCPro Forums Homepage
Forum Home Forum Home > ATC Pro Forums > ATC Pro Official Support
  New Posts New Posts RSS Feed - DCB Mouse Clicks
  FAQ FAQ  Forum Search   Events   Register Register  Login Login

DCB Mouse Clicks

 Post Reply Post Reply
Author
Message
esel View Drop Down
Member
Member


Joined: 15 Oct 2017
Location: Winfield
Status: Offline
Points: 12
Post Options Post Options   Thanks (0) Thanks(0)   Quote esel Quote  Post ReplyReply Direct Link To This Post Topic: DCB Mouse Clicks
    Posted: 13 Sep 2018 at 5:08pm
Is there any solution for this crash?
This happens when I click a button on the DCB


Faulting application name: ATCpro.exe, version: 0.0.0.1, time stamp: 0x58974781
Faulting module name: KERNELBASE.dll, version: 10.0.17134.165, time stamp: 0xfa43f4b2
Exception code: 0xe0434352
Fault offset: 0x0010ddc2
Faulting process id: 0x2b88
Faulting application start time: 0x01d44ba4e2055861
Faulting application path: C:\Program Files (x86)\Flag Mountain\ATCpro\ATCpro.exe
Faulting module path: C:\WINDOWS\System32\KERNELBASE.dll
Report Id: c1def0dd-50a3-4e22-b050-fc4f4587ea95
Faulting package full name:
Faulting package-relative application ID:

Application: ATCpro.exe
Framework Version: v4.0.30319
Description: The process was terminated due to an unhandled exception.
Exception Info: System.Collections.Generic.KeyNotFoundException
   at System.Collections.Generic.Dictionary`2[[System.__Canon, mscorlib, Version=4.0.0.0, Culture=neutral, PublicKeyToken=b77a5c561934e089],[System.__Canon, mscorlib, Version=4.0.0.0, Culture=neutral, PublicKeyToken=b77a5c561934e089]].get_Item(System.__Canon)
   at ATCpro.TCW_ViewModel.(System.String)
   at ATCpro.TCW_ViewModel.(System.Object)
   at ATCpro.RelayCommand.Execute(System.Object)
   at ATCpro.CustomControls.dcbButton.OnMouseLeftButtonDown(System.Windows.Input.MouseButtonEventArgs)
   at System.Windows.UIElement.OnMouseLeftButtonDownThunk(System.Object, System.Windows.Input.MouseButtonEventArgs)
   at System.Windows.Input.MouseButtonEventArgs.InvokeEventHandler(System.Delegate, System.Object)
   at System.Windows.RoutedEventArgs.InvokeHandler(System.Delegate, System.Object)
   at System.Windows.RoutedEventHandlerInfo.InvokeHandler(System.Object, System.Windows.RoutedEventArgs)
   at System.Windows.EventRoute.InvokeHandlersImpl(System.Object, System.Windows.RoutedEventArgs, Boolean)
   at System.Windows.UIElement.ReRaiseEventAs(System.Windows.DependencyObject, System.Windows.RoutedEventArgs, System.Windows.RoutedEvent)
   at System.Windows.UIElement.OnMouseDownThunk(System.Object, System.Windows.Input.MouseButtonEventArgs)
   at System.Windows.Input.MouseButtonEventArgs.InvokeEventHandler(System.Delegate, System.Object)
   at System.Windows.RoutedEventArgs.InvokeHandler(System.Delegate, System.Object)
   at System.Windows.RoutedEventHandlerInfo.InvokeHandler(System.Object, System.Windows.RoutedEventArgs)
   at System.Windows.EventRoute.InvokeHandlersImpl(System.Object, System.Windows.RoutedEventArgs, Boolean)
   at System.Windows.UIElement.RaiseEventImpl(System.Windows.DependencyObject, System.Windows.RoutedEventArgs)
   at System.Windows.UIElement.RaiseTrustedEvent(System.Windows.RoutedEventArgs)
   at System.Windows.UIElement.RaiseEvent(System.Windows.RoutedEventArgs, Boolean)
   at System.Windows.Input.InputManager.ProcessStagingArea()
   at System.Windows.Input.InputManager.ProcessInput(System.Windows.Input.InputEventArgs)
   at System.Windows.Input.InputProviderSite.ReportInput(System.Windows.Input.InputReport)
   at System.Windows.Interop.HwndMouseInputProvider.ReportInput(IntPtr, System.Windows.Input.InputMode, Int32, System.Windows.Input.RawMouseActions, Int32, Int32, Int32)
   at System.Windows.Interop.HwndMouseInputProvider.FilterMessage(IntPtr, MS.Internal.Interop.WindowMessage, IntPtr, IntPtr, Boolean ByRef)
   at System.Windows.Interop.HwndSource.InputFilterMessage(IntPtr, Int32, IntPtr, IntPtr, Boolean ByRef)
   at MS.Win32.HwndWrapper.WndProc(IntPtr, Int32, IntPtr, IntPtr, Boolean ByRef)
   at MS.Win32.HwndSubclass.DispatcherCallbackOperation(System.Object)
   at System.Windows.Threading.ExceptionWrapper.InternalRealCall(System.Delegate, System.Object, Int32)
   at System.Windows.Threading.ExceptionWrapper.TryCatchWhen(System.Object, System.Delegate, System.Object, Int32, System.Delegate)
   at System.Windows.Threading.Dispatcher.LegacyInvokeImpl(System.Windows.Threading.DispatcherPriority, System.TimeSpan, System.Delegate, System.Object, Int32)
   at MS.Win32.HwndSubclass.SubclassWndProc(IntPtr, Int32, IntPtr, IntPtr)
   at MS.Win32.UnsafeNativeMethods.DispatchMessage(System.Windows.Interop.MSG ByRef)
   at System.Windows.Threading.Dispatcher.PushFrameImpl(System.Windows.Threading.DispatcherFrame)
   at System.Windows.Threading.Dispatcher.PushFrame(System.Windows.Threading.DispatcherFrame)
   at System.Windows.Application.RunDispatcher(System.Object)
   at System.Windows.Application.RunInternal(System.Windows.Window)
   at System.Windows.Application.Run(System.Windows.Window)
   at System.Windows.Application.Run()
   at ATCpro.Application.Main()


Faulting application name: ATCpro.exe, version: 0.0.0.1, time stamp: 0x58974781
Faulting module name: KERNELBASE.dll, version: 10.0.17134.165, time stamp: 0xfa43f4b2
Exception code: 0xe0434352
Fault offset: 0x0010ddc2
Faulting process id: 0x830
Faulting application start time: 0x01d44ba4b2ae99ea
Faulting application path: C:\Program Files (x86)\Flag Mountain\ATCpro\ATCpro.exe
Faulting module path: C:\WINDOWS\System32\KERNELBASE.dll
Report Id: 1f285ff0-efbd-421f-a9b4-4f886d093e0b
Faulting package full name:
Faulting package-relative application ID:


Application: ATCpro.exe
Framework Version: v4.0.30319
Description: The process was terminated due to an unhandled exception.
Exception Info: System.Collections.Generic.KeyNotFoundException
   at System.Collections.Generic.Dictionary`2[[System.__Canon, mscorlib, Version=4.0.0.0, Culture=neutral, PublicKeyToken=b77a5c561934e089],[System.__Canon, mscorlib, Version=4.0.0.0, Culture=neutral, PublicKeyToken=b77a5c561934e089]].get_Item(System.__Canon)
   at ATCpro.TCW_ViewModel.(System.String)
   at ATCpro.TCW_ViewModel.(System.Object)
   at ATCpro.RelayCommand.Execute(System.Object)
   at ATCpro.CustomControls.dcbButton.OnMouseLeftButtonDown(System.Windows.Input.MouseButtonEventArgs)
   at System.Windows.UIElement.OnMouseLeftButtonDownThunk(System.Object, System.Windows.Input.MouseButtonEventArgs)
   at System.Windows.Input.MouseButtonEventArgs.InvokeEventHandler(System.Delegate, System.Object)
   at System.Windows.RoutedEventArgs.InvokeHandler(System.Delegate, System.Object)
   at System.Windows.RoutedEventHandlerInfo.InvokeHandler(System.Object, System.Windows.RoutedEventArgs)
   at System.Windows.EventRoute.InvokeHandlersImpl(System.Object, System.Windows.RoutedEventArgs, Boolean)
   at System.Windows.UIElement.ReRaiseEventAs(System.Windows.DependencyObject, System.Windows.RoutedEventArgs, System.Windows.RoutedEvent)
   at System.Windows.UIElement.OnMouseDownThunk(System.Object, System.Windows.Input.MouseButtonEventArgs)
   at System.Windows.Input.MouseButtonEventArgs.InvokeEventHandler(System.Delegate, System.Object)
   at System.Windows.RoutedEventArgs.InvokeHandler(System.Delegate, System.Object)
   at System.Windows.RoutedEventHandlerInfo.InvokeHandler(System.Object, System.Windows.RoutedEventArgs)
   at System.Windows.EventRoute.InvokeHandlersImpl(System.Object, System.Windows.RoutedEventArgs, Boolean)
   at System.Windows.UIElement.RaiseEventImpl(System.Windows.DependencyObject, System.Windows.RoutedEventArgs)
   at System.Windows.UIElement.RaiseTrustedEvent(System.Windows.RoutedEventArgs)
   at System.Windows.UIElement.RaiseEvent(System.Windows.RoutedEventArgs, Boolean)
   at System.Windows.Input.InputManager.ProcessStagingArea()
   at System.Windows.Input.InputManager.ProcessInput(System.Windows.Input.InputEventArgs)
   at System.Windows.Input.InputProviderSite.ReportInput(System.Windows.Input.InputReport)
   at System.Windows.Interop.HwndMouseInputProvider.ReportInput(IntPtr, System.Windows.Input.InputMode, Int32, System.Windows.Input.RawMouseActions, Int32, Int32, Int32)
   at System.Windows.Interop.HwndMouseInputProvider.FilterMessage(IntPtr, MS.Internal.Interop.WindowMessage, IntPtr, IntPtr, Boolean ByRef)
   at System.Windows.Interop.HwndSource.InputFilterMessage(IntPtr, Int32, IntPtr, IntPtr, Boolean ByRef)
   at MS.Win32.HwndWrapper.WndProc(IntPtr, Int32, IntPtr, IntPtr, Boolean ByRef)
   at MS.Win32.HwndSubclass.DispatcherCallbackOperation(System.Object)
   at System.Windows.Threading.ExceptionWrapper.InternalRealCall(System.Delegate, System.Object, Int32)
   at System.Windows.Threading.ExceptionWrapper.TryCatchWhen(System.Object, System.Delegate, System.Object, Int32, System.Delegate)
   at System.Windows.Threading.Dispatcher.LegacyInvokeImpl(System.Windows.Threading.DispatcherPriority, System.TimeSpan, System.Delegate, System.Object, Int32)
   at MS.Win32.HwndSubclass.SubclassWndProc(IntPtr, Int32, IntPtr, IntPtr)
   at MS.Win32.UnsafeNativeMethods.DispatchMessage(System.Windows.Interop.MSG ByRef)
   at System.Windows.Threading.Dispatcher.PushFrameImpl(System.Windows.Threading.DispatcherFrame)
   at System.Windows.Threading.Dispatcher.PushFrame(System.Windows.Threading.DispatcherFrame)
   at System.Windows.Application.RunDispatcher(System.Object)
   at System.Windows.Application.RunInternal(System.Windows.Window)
   at System.Windows.Application.Run(System.Windows.Window)
   at System.Windows.Application.Run()
   at ATCpro.Application.Main()

Thanks

Sheldon

Back to Top
Tom@FlagMountain View Drop Down
Admin Group
Admin Group


Joined: 22 Oct 2014
Location: Albuquerque, NM
Status: Offline
Points: 507
Post Options Post Options   Thanks (0) Thanks(0)   Quote Tom@FlagMountain Quote  Post ReplyReply Direct Link To This Post Posted: 14 Sep 2018 at 8:31am
Sheldon:

Since we don't have others reporting this issue, I must assume that there is something about your system/installation that is the cause.  

First, please run a session and cause the problem.  Then, please send me your log file.  Since ATCpro crashes, I don't think the log file will be closed properly, but there might be something there that could indicate what is happening.

Second, is there anything non-standard about your system?   Did this problem suddenly start happening, or has it been happening ever since you first installed ATCpro?  I note that you joined the forum about a year go, so I suspect the former.  

What steps have you taken to resolve the issue?   Did you uninstall/reinstall?  

I will ask the team what might be causing this issue, and get back with you.

Regards

Tom
Tom Murdock
Flag Mountain Software
ATCpro Project Team
Back to Top
Tom@FlagMountain View Drop Down
Admin Group
Admin Group


Joined: 22 Oct 2014
Location: Albuquerque, NM
Status: Offline
Points: 507
Post Options Post Options   Thanks (0) Thanks(0)   Quote Tom@FlagMountain Quote  Post ReplyReply Direct Link To This Post Posted: 14 Sep 2018 at 10:01am
Sheldon:

Let's try this:

Open File Explorer and look in C:\ProgramData\Flag Mountain\ATCpro\Profiles\<your user name>  and find a file named ATCpro.xml.  Either delete that file or rename it  (ATCpro.xml.HIDE).

If you can't see the ProgramData folder in File Explorer, click on "View" and check the "Hidden Items" checkbox.

Restart ATCpro and test.

Regards

Tom


Edited by Tom@FlagMountain - 14 Sep 2018 at 10:03am
Tom Murdock
Flag Mountain Software
ATCpro Project Team
Back to Top
esel View Drop Down
Member
Member


Joined: 15 Oct 2017
Location: Winfield
Status: Offline
Points: 12
Post Options Post Options   Thanks (0) Thanks(0)   Quote esel Quote  Post ReplyReply Direct Link To This Post Posted: 14 Sep 2018 at 11:08am
Tom,
Thanks for the response, I will try the suggestion but have seen this same crash randomly since I installed the program back in Oct. 17, since this terminates the program there is nothing in the log file after the program closes but I can provide that on the next crash.

I have re-installed several times, created new profiles and waited before clicking on map buttons to avoid the crash but this crash is very random and as you know can occur at the most frustrating times.

Thanks

Sheldon


Back to Top
Tom@FlagMountain View Drop Down
Admin Group
Admin Group


Joined: 22 Oct 2014
Location: Albuquerque, NM
Status: Offline
Points: 507
Post Options Post Options   Thanks (0) Thanks(0)   Quote Tom@FlagMountain Quote  Post ReplyReply Direct Link To This Post Posted: 14 Sep 2018 at 6:24pm
Sheldon:

When did ATCpro first start crashing?

Could you please send me the log file from a session that did not crash?  

I continue to research this, but right now don't have any answers for you.  Perhaps a video of a session might help.  We can discuss.

Regards

Tom
Tom Murdock
Flag Mountain Software
ATCpro Project Team
Back to Top
esel View Drop Down
Member
Member


Joined: 15 Oct 2017
Location: Winfield
Status: Offline
Points: 12
Post Options Post Options   Thanks (0) Thanks(0)   Quote esel Quote  Post ReplyReply Direct Link To This Post Posted: 14 Sep 2018 at 9:26pm
since I bought it.

I will try a different mouse, this may be hardware.

I will post a log the next time i run a session that does not crash.




Back to Top
esel View Drop Down
Member
Member


Joined: 15 Oct 2017
Location: Winfield
Status: Offline
Points: 12
Post Options Post Options   Thanks (0) Thanks(0)   Quote esel Quote  Post ReplyReply Direct Link To This Post Posted: 14 Sep 2018 at 11:53pm
Here is a log with no crash.


[14 Sep 2018 22:31:54.680] Starting ATCpro session
[14 Sep 2018 22:31:54.682] Base Directory: C:\Program Files (x86)\Flag Mountain\ATCpro\
[14 Sep 2018 22:31:54.683] Executable: C:\Program Files (x86)\Flag Mountain\ATCpro\ATCpro.exe
[14 Sep 2018 22:31:54.683] Version: 1.0.0.0
[14 Sep 2018 22:31:54.683] Build Date: 2/5/2017 3:40:49 PM
[14 Sep 2018 22:31:54.683] Machine Name: DESKTOP-DRHC43U  User Name: Sheldon
[14 Sep 2018 22:31:54.683] Screen Resolution: 1920 by 1080
[14 Sep 2018 22:31:54.683] Operating System: Microsoft Windows NT 6.2.9200.0  64 Bit


[14 Sep 2018 22:31:55.117] There are 5 entries in CPVoicesPointers.
[14 Sep 2018 22:31:55.124] In SRProcesssor Init.  Logging Level = 0
[14 Sep 2018 22:31:57.802] SRProcessor - logging level changed from 0 to 3
[14 Sep 2018 22:31:57.802] TTSProcessor - logging level changed from 0 to 3
[14 Sep 2018 22:31:58.229] Information, gathering data for statistics display
[14 Sep 2018 22:31:58.241] Information, gathering data for statistics display
[14 Sep 2018 22:31:58.245] Information, gathering data for statistics display
[14 Sep 2018 22:31:58.249] Information, gathering data for statistics display
[14 Sep 2018 22:32:00.147] Information, beginning load of all data for random schedule creation
[14 Sep 2018 22:32:00.147] Information, beginning load of equipment data for random schedule creation
[14 Sep 2018 22:32:00.235] Information, beginning load of airport data for random schedule creation
[14 Sep 2018 22:32:00.235] Information, gathering airports for session in random schedule creation
[14 Sep 2018 22:32:00.388] Information, adding facility airports to session airports in random schedule creation
[14 Sep 2018 22:32:00.389] Information, assigning METARs to airports in random schedule creation
[14 Sep 2018 22:32:00.639] Information, beginning creation of random schedule
[14 Sep 2018 22:32:00.640] Information, creating pattern schedule in random schedule
[14 Sep 2018 22:32:00.641] Information, reading the pattern schedule in random schedule
[14 Sep 2018 22:32:00.648] Information, creating intinerant schedule in random schedule
[14 Sep 2018 22:32:00.648] Information, reading the itinerant schedule in random schedule
[14 Sep 2018 22:32:00.665] Information, creating overflight schedule in random schedule
[14 Sep 2018 22:32:00.666] Information, reading the overflight schedule in random schedule
[14 Sep 2018 22:32:00.671] Information, creating air taxi schedule in random schedule
[14 Sep 2018 22:32:00.672] Information, reading the air taxi schedule in random schedule
[14 Sep 2018 22:32:00.679] Information, reading the military schedule in random schedule
[14 Sep 2018 22:32:00.684] Information, creating custom schedule in random schedule
[14 Sep 2018 22:32:00.685] Information, reading the custom schedule in random schedule
[14 Sep 2018 22:32:00.686] Information, creating airline schedule in random schedule
[14 Sep 2018 22:32:00.687] Information, reading the airline schedule in random schedule
[14 Sep 2018 22:32:03.901] Information, beginning load of all data for random schedule creation
[14 Sep 2018 22:32:03.901] Information, beginning load of equipment data for random schedule creation
[14 Sep 2018 22:32:03.983] Information, beginning load of airport data for random schedule creation
[14 Sep 2018 22:32:03.984] Information, gathering airports for session in random schedule creation
[14 Sep 2018 22:32:04.123] Information, adding facility airports to session airports in random schedule creation
[14 Sep 2018 22:32:04.124] Information, assigning METARs to airports in random schedule creation
[14 Sep 2018 22:32:04.386] Information, beginning creation of random schedule
[14 Sep 2018 22:32:04.386] Information, creating pattern schedule in random schedule
[14 Sep 2018 22:32:04.386] Information, reading the pattern schedule in random schedule
[14 Sep 2018 22:32:04.389] Information, creating intinerant schedule in random schedule
[14 Sep 2018 22:32:04.389] Information, reading the itinerant schedule in random schedule
[14 Sep 2018 22:32:04.394] Information, creating overflight schedule in random schedule
[14 Sep 2018 22:32:04.394] Information, reading the overflight schedule in random schedule
[14 Sep 2018 22:32:04.398] Information, creating air taxi schedule in random schedule
[14 Sep 2018 22:32:04.398] Information, reading the air taxi schedule in random schedule
[14 Sep 2018 22:32:04.402] Information, reading the military schedule in random schedule
[14 Sep 2018 22:32:04.404] Information, creating custom schedule in random schedule
[14 Sep 2018 22:32:04.404] Information, reading the custom schedule in random schedule
[14 Sep 2018 22:32:04.405] Information, creating airline schedule in random schedule
[14 Sep 2018 22:32:04.405] Information, reading the airline schedule in random schedule
[14 Sep 2018 22:32:24.763] Beginning session initialization
[14 Sep 2018 22:32:24.763]     local start time: 4910
[14 Sep 2018 22:32:24.763]      zulu start time: 5270
[14 Sep 2018 22:32:24.763]          zulu offset: -360
[14 Sep 2018 22:32:24.763]             facility: Albuquerque ATCT/TRACON
[14 Sep 2018 22:32:24.763]     flight selections:
[14 Sep 2018 22:32:24.764]      gaPattern: 100
     gaLocal: 100
     milPattern: 100
     gaOutbound: 100
     gaInbound: 100
     corpOutbound: 100
     corpInbound: 100
     schedOutbound: 100
     schedInbound: 100
     milOutbound: 100
     milInbound: 100
     customOutbound: 100
     customInbound: 100

[14 Sep 2018 22:32:24.764]   session information:
[14 Sep 2018 22:32:24.764]      facID: ABQ
     flowID: W
     aptFlowID: W
     doWxDownload: False
     doUserWx: True
     windDir: 261
     windSpd: 6
     skySelection: sct
     tempC: 21
     isCareer: False
     isSandbox: True

[14 Sep 2018 22:32:24.766] Information, beginning generation of radar and radio los data
[14 Sep 2018 22:32:24.766] Information, radar and radio los data already exists, loading
[14 Sep 2018 22:32:27.834] Information, loading commercial flights at 4910 local
[14 Sep 2018 22:32:33.238] Information, copying DynamicRouteImpl.txt
[14 Sep 2018 22:32:33.253] Information, writing DynamicVehicleTypeImpl.txt
[14 Sep 2018 22:32:33.278] Entering LoadDynamicFiles
[14 Sep 2018 22:32:33.278] Entering CompileDynamicRules
[14 Sep 2018 22:32:33.279] LoadDynAirportName Complete.
[14 Sep 2018 22:32:33.280] LoadDynFacility Complete.
[14 Sep 2018 22:32:33.293] LoadDynFix Complete.
[14 Sep 2018 22:32:33.295] LoadDynFrequency Complete.
[14 Sep 2018 22:32:33.296] LoadDynIntercomFacility Complete.
[14 Sep 2018 22:32:33.297] LoadDynRunway Complete.
[14 Sep 2018 22:32:33.319] LoadDynVehicleType Complete.
[14 Sep 2018 22:32:33.380] LoadDynRoutes Complete.
[14 Sep 2018 22:32:33.380] Entering UpdateDynRadarAircrafts
[14 Sep 2018 22:32:33.412] UpdateDynRadarAircrafts Complete.
[14 Sep 2018 22:32:33.412] Exiting CompileDynamicRules
[14 Sep 2018 22:32:33.412] SRProcessor LoadDynamicFiles Complete.
[14 Sep 2018 22:32:33.413] Information, initializing a new scoring object
[14 Sep 2018 22:32:33.477] Failure, aircraft is not an inbound flight and can not brought into session, SWA345
[14 Sep 2018 22:32:33.481] Information, adding flight to active list (0): AMF1351voice: 4plan: KPHX to KABQ inbound IFR
[14 Sep 2018 22:32:33.509] Failure, aircraft has no valid one min position can not bring into session, CPZ5973
[14 Sep 2018 22:32:33.509] Failure, aircraft is not an inbound flight and can not brought into session, UAL342
[14 Sep 2018 22:32:33.509] Failure, aircraft is not an inbound flight and can not brought into session, BTQ654
[14 Sep 2018 22:32:33.509] Information, adding flight to active list (1): AMF1288voice: 5plan: KLRU to KABQ inbound IFR
[14 Sep 2018 22:32:33.509] Failure, aircraft is not an inbound flight and can not brought into session, ASH5614
[14 Sep 2018 22:32:33.509] Information, adding flight to active list (2): AMF1878voice: 6plan: KTCC to KABQ inbound IFR
[14 Sep 2018 22:32:33.509] Information, adding flight to active list (3): N485KCvoice: 7plan: KFSI to KAEG inbound IFR
[14 Sep 2018 22:32:33.510] Failure, aircraft is not an inbound flight and can not brought into session, N4208L
[14 Sep 2018 22:32:33.510] Failure, aircraft is not an inbound flight and can not brought into session, N603CN
[14 Sep 2018 22:32:33.510] Failure, aircraft is not an inbound flight and can not brought into session, N692AY
[14 Sep 2018 22:32:33.510] Failure, aircraft is not an inbound flight and can not brought into session, N461NW
[14 Sep 2018 22:32:33.510] Information, adding flight to active list (4): N473NPvoice: 8plan: KSOA to K1L1 overflight IFR
[14 Sep 2018 22:32:33.510] Failure, aircraft has no valid one min position can not bring into session, N9779H
[14 Sep 2018 22:32:33.510] Failure, aircraft is not an inbound flight and can not brought into session, N7107P
[14 Sep 2018 22:32:33.510] Failure, aircraft is not an inbound flight and can not brought into session, N151YN
[14 Sep 2018 22:32:33.510] Failure, aircraft is not an inbound flight and can not brought into session, N8253M
[14 Sep 2018 22:32:33.510] Failure, aircraft is not an inbound flight and can not brought into session, N579MZ
[14 Sep 2018 22:32:33.753] Information, adding flight to active list (5): N667HXvoice: 9plan: MMPE to KAEG inbound IFR
[14 Sep 2018 22:32:33.754] Information, removing active flight (6): N667HX
[14 Sep 2018 22:32:33.808] Information, adding flight to active list (5): N960JMvoice: 10plan: 1N1 to 1N1 pattern VFR
[14 Sep 2018 22:32:33.808] Information, adding flight to active list (6): N641NFvoice: 11plan: K1L1 to KAEG inbound IFR
[14 Sep 2018 22:32:33.812] Information, adding flight to active list (7): N788YBvoice: 12plan: E98 to K1L3 outbound IFR
[14 Sep 2018 22:32:33.821] Information, removing active flight (8): N641NF
[14 Sep 2018 22:32:33.824] Information, processing incoming tts request from N960JM
[14 Sep 2018 22:32:33.824] Information, no tts required, passing on commands to appropriate receiver
[14 Sep 2018 22:32:33.825] Information, processing incoming tts request from N788YB
[14 Sep 2018 22:32:33.827] Information, adding item to the ttsQueue: Pilot object from N788YB msgIndex: 1 voiceIndex: 12 freqIndex: 1
[14 Sep 2018 22:32:33.831] Information, processing incoming tts request from VFR
[14 Sep 2018 22:32:33.831] Information, no tts required, passing on commands to appropriate receiver
[14 Sep 2018 22:32:33.834] Information, sending tts queue item to SayAsSent: Pilot object from N788YB msgIndex: 1 voiceIndex: 12 freqIndex: 1
[14 Sep 2018 22:32:33.839] Information, building pilot tts for N788YB
[14 Sep 2018 22:32:33.862] Information, sending GenerateWAVfile to ttsProcessor: Pilot object from N788YB msgIndex: 1 voiceIndex: 12 freqIndex: 1
[14 Sep 2018 22:32:33.877] Information, ttsProcessor playback completed event received, msgIndex: 1
[14 Sep 2018 22:32:33.877] Information, processing commands from object: Pilot object from N788YB msgIndex: 1 voiceIndex: 12 freqIndex: 1
[14 Sep 2018 22:32:33.877] Information, removing object from the ttsQueue: Pilot object from N788YB msgIndex: 1 voiceIndex: 12 freqIndex: 1
[14 Sep 2018 22:32:33.880] Information, processing incoming tts request from 1S
[14 Sep 2018 22:32:33.882] Information, adding item to the ttsQueue: Controller object from 1S msgIndex: 2 voiceIndex: 0 freqIndex: 1
[14 Sep 2018 22:32:33.882] Information, sending tts queue item to SayAsSent: Controller object from 1S msgIndex: 2 voiceIndex: 0 freqIndex: 1
[14 Sep 2018 22:32:33.902] Information, sending GenerateWAVfile to ttsProcessor: Controller object from 1S msgIndex: 2 voiceIndex: 0 freqIndex: 1
[14 Sep 2018 22:32:33.910] Information, ttsProcessor playback completed event received, msgIndex: 2
[14 Sep 2018 22:32:33.910] Information, processing commands from object: Controller object from 1S msgIndex: 2 voiceIndex: 0 freqIndex: 1
[14 Sep 2018 22:32:33.910] Information, removing object from the ttsQueue: Controller object from 1S msgIndex: 2 voiceIndex: 0 freqIndex: 1
[14 Sep 2018 22:32:33.911] Information, processing incoming tts request from N788YB
[14 Sep 2018 22:32:33.911] Information, adding item to the ttsQueue: Pilot object from N788YB msgIndex: 3 voiceIndex: 12 freqIndex: 1
[14 Sep 2018 22:32:33.911] Information, sending tts queue item to SayAsSent: Pilot object from N788YB msgIndex: 3 voiceIndex: 12 freqIndex: 1
[14 Sep 2018 22:32:33.911] Information, building pilot tts for N788YB
[14 Sep 2018 22:32:33.912] Information, sending GenerateWAVfile to ttsProcessor: Pilot object from N788YB msgIndex: 3 voiceIndex: 12 freqIndex: 1
[14 Sep 2018 22:32:33.923] Information, ttsProcessor playback completed event received, msgIndex: 3
[14 Sep 2018 22:32:33.923] Information, processing commands from object: Pilot object from N788YB msgIndex: 3 voiceIndex: 12 freqIndex: 1
[14 Sep 2018 22:32:33.923] Information, removing object from the ttsQueue: Pilot object from N788YB msgIndex: 3 voiceIndex: 12 freqIndex: 1
[14 Sep 2018 22:32:34.011] Information, processing incoming tts request from N788YB
[14 Sep 2018 22:32:34.011] Information, no tts required, passing on commands to appropriate receiver
[14 Sep 2018 22:32:34.011] Information, processing incoming tts request from VFR
[14 Sep 2018 22:32:34.011] Information, no tts required, passing on commands to appropriate receiver
[14 Sep 2018 22:32:34.018] Information, adding flight to active list (7): SWA2202voice: 13plan: KMDW to KABQ inbound IFR
[14 Sep 2018 22:32:34.019] Information, adding flight to active list (8): N939SFvoice: 14plan: MMHO to KAEG inbound IFR
[14 Sep 2018 22:32:34.021] Information, removing active flight (9): N939SF
[14 Sep 2018 22:32:34.055] Information, processing incoming tts request from N960JM
[14 Sep 2018 22:32:34.055] Information, no tts required, passing on commands to appropriate receiver
[14 Sep 2018 22:32:34.069] Information, processing incoming tts request from VFR
[14 Sep 2018 22:32:34.069] Warning, (IncomingATCTTS) Unable to find etvsFrequencyInformation for freqIndex: 000.0
[14 Sep 2018 22:32:34.094] Information, processing incoming tts request from VFR
[14 Sep 2018 22:32:34.094] Warning, (IncomingATCTTS) Unable to find etvsFrequencyInformation for freqIndex: 000.0
[14 Sep 2018 22:32:34.099] Information, adding flight to active list (8): N750ZMvoice: 15plan: E80 to E80 pattern VFR
[14 Sep 2018 22:32:34.101] Information, processing incoming tts request from N750ZM
[14 Sep 2018 22:32:34.101] Information, no tts required, passing on commands to appropriate receiver
[14 Sep 2018 22:32:34.101] Information, processing incoming tts request from VFR
[14 Sep 2018 22:32:34.101] Information, no tts required, passing on commands to appropriate receiver
[14 Sep 2018 22:32:34.120] Information, processing incoming tts request from VFR
[14 Sep 2018 22:32:34.120] Warning, (IncomingATCTTS) Unable to find etvsFrequencyInformation for freqIndex: 000.0
[14 Sep 2018 22:32:34.129] Information, processing incoming tts request from N788YB
[14 Sep 2018 22:32:34.129] Information, adding item to the ttsQueue: Pilot object from N788YB msgIndex: 4 voiceIndex: 12 freqIndex: 1
[14 Sep 2018 22:32:34.129] Information, sending tts queue item to SayAsSent: Pilot object from N788YB msgIndex: 4 voiceIndex: 12 freqIndex: 1
[14 Sep 2018 22:32:34.131] Information, building pilot tts for N788YB
[14 Sep 2018 22:32:34.132] Information, sending GenerateWAVfile to ttsProcessor: Pilot object from N788YB msgIndex: 4 voiceIndex: 12 freqIndex: 1
[14 Sep 2018 22:32:34.139] Information, ttsProcessor playback completed event received, msgIndex: 4
[14 Sep 2018 22:32:34.139] Information, processing commands from object: Pilot object from N788YB msgIndex: 4 voiceIndex: 12 freqIndex: 1
[14 Sep 2018 22:32:34.139] Information, removing object from the ttsQueue: Pilot object from N788YB msgIndex: 4 voiceIndex: 12 freqIndex: 1
[14 Sep 2018 22:32:34.142] Information, processing incoming tts request from 1S
[14 Sep 2018 22:32:34.142] Information, adding item to the ttsQueue: Controller object from 1S msgIndex: 5 voiceIndex: 0 freqIndex: 1
[14 Sep 2018 22:32:34.142] Information, sending tts queue item to SayAsSent: Controller object from 1S msgIndex: 5 voiceIndex: 0 freqIndex: 1
[14 Sep 2018 22:32:34.142] Information, sending GenerateWAVfile to ttsProcessor: Controller object from 1S msgIndex: 5 voiceIndex: 0 freqIndex: 1
[14 Sep 2018 22:32:34.143] Information, ttsProcessor playback completed event received, msgIndex: 5
[14 Sep 2018 22:32:34.143] Information, processing commands from object: Controller object from 1S msgIndex: 5 voiceIndex: 0 freqIndex: 1
[14 Sep 2018 22:32:34.143] Information, removing object from the ttsQueue: Controller object from 1S msgIndex: 5 voiceIndex: 0 freqIndex: 1
[14 Sep 2018 22:32:34.157] Information, processing incoming tts request from 1S
[14 Sep 2018 22:32:34.157] Information, adding item to the ttsQueue: Controller object from 1S msgIndex: 6 voiceIndex: 0 freqIndex: 1
[14 Sep 2018 22:32:34.157] Information, current frequency (123.9) is busy, checking to unlock it
[14 Sep 2018 22:32:34.157] Information, sending tts queue item to SayAsSent: Controller object from 1S msgIndex: 6 voiceIndex: 0 freqIndex: 1
[14 Sep 2018 22:32:34.158] Information, sending GenerateWAVfile to ttsProcessor: Controller object from 1S msgIndex: 6 voiceIndex: 0 freqIndex: 1
[14 Sep 2018 22:32:34.161] Information, ttsProcessor playback completed event received, msgIndex: 6
[14 Sep 2018 22:32:34.161] Information, processing commands from object: Controller object from 1S msgIndex: 6 voiceIndex: 0 freqIndex: 1
[14 Sep 2018 22:32:34.161] Information, removing object from the ttsQueue: Controller object from 1S msgIndex: 6 voiceIndex: 0 freqIndex: 1
[14 Sep 2018 22:32:34.162] Information, processing incoming tts request from N788YB
[14 Sep 2018 22:32:34.162] Information, adding item to the ttsQueue: Pilot object from N788YB msgIndex: 7 voiceIndex: 12 freqIndex: 1
[14 Sep 2018 22:32:34.162] Information, sending tts queue item to SayAsSent: Pilot object from N788YB msgIndex: 7 voiceIndex: 12 freqIndex: 1
[14 Sep 2018 22:32:34.162] Information, building pilot tts for N788YB
[14 Sep 2018 22:32:34.162] Information, sending GenerateWAVfile to ttsProcessor: Pilot object from N788YB msgIndex: 7 voiceIndex: 12 freqIndex: 1
[14 Sep 2018 22:32:34.165] Information, ttsProcessor playback completed event received, msgIndex: 7
[14 Sep 2018 22:32:34.165] Information, processing commands from object: Pilot object from N788YB msgIndex: 7 voiceIndex: 12 freqIndex: 1
[14 Sep 2018 22:32:34.165] Information, removing object from the ttsQueue: Pilot object from N788YB msgIndex: 7 voiceIndex: 12 freqIndex: 1
[14 Sep 2018 22:32:34.183] Information, adding flight to active list (9): ASQ3825voice: 16plan: KIAH to KABQ inbound IFR
[14 Sep 2018 22:32:34.329] Information, processing incoming tts request from N750ZM
[14 Sep 2018 22:32:34.329] Information, no tts required, passing on commands to appropriate receiver
[14 Sep 2018 22:32:34.332] Information, processing incoming tts request from VFR
[14 Sep 2018 22:32:34.332] Warning, (IncomingATCTTS) Unable to find etvsFrequencyInformation for freqIndex: 000.0
[14 Sep 2018 22:32:34.402] Information, adding flight to active list (10): N549ZRvoice: 17plan: CYLW to KABQ inbound IFR
[14 Sep 2018 22:32:34.419] Information, processing incoming tts request from C17
[14 Sep 2018 22:32:34.419] Information, adding item to the ttsQueue: Controller object from C17 msgIndex: 8 voiceIndex: 0 freqIndex: 4
[14 Sep 2018 22:32:34.419] Information, sending tts queue item to SayAsSent: Controller object from C17 msgIndex: 8 voiceIndex: 0 freqIndex: 4
[14 Sep 2018 22:32:34.419] Information, sending GenerateWAVfile to ttsProcessor: Controller object from C17 msgIndex: 8 voiceIndex: 0 freqIndex: 4
[14 Sep 2018 22:32:34.425] Information, ttsProcessor playback completed event received, msgIndex: 8
[14 Sep 2018 22:32:34.425] Information, processing commands from object: Controller object from C17 msgIndex: 8 voiceIndex: 0 freqIndex: 4
[14 Sep 2018 22:32:34.425] Information, removing object from the ttsQueue: Controller object from C17 msgIndex: 8 voiceIndex: 0 freqIndex: 4
[14 Sep 2018 22:32:34.427] Information, processing incoming tts request from N549ZR
[14 Sep 2018 22:32:34.427] Information, adding item to the ttsQueue: Pilot object from N549ZR msgIndex: 9 voiceIndex: 17 freqIndex: 4
[14 Sep 2018 22:32:34.427] Information, sending tts queue item to SayAsSent: Pilot object from N549ZR msgIndex: 9 voiceIndex: 17 freqIndex: 4
[14 Sep 2018 22:32:34.427] Information, building pilot tts for N549ZR
[14 Sep 2018 22:32:34.427] Information, sending GenerateWAVfile to ttsProcessor: Pilot object from N549ZR msgIndex: 9 voiceIndex: 17 freqIndex: 4
[14 Sep 2018 22:32:34.430] Information, ttsProcessor playback completed event received, msgIndex: 9
[14 Sep 2018 22:32:34.431] Information, processing commands from object: Pilot object from N549ZR msgIndex: 9 voiceIndex: 17 freqIndex: 4
[14 Sep 2018 22:32:34.431] Information, removing object from the ttsQueue: Pilot object from N549ZR msgIndex: 9 voiceIndex: 17 freqIndex: 4
[14 Sep 2018 22:32:34.459] Information, processing incoming tts request from N788YB
[14 Sep 2018 22:32:34.459] Information, no tts required, passing on commands to appropriate receiver
[14 Sep 2018 22:32:34.462] Information, processing incoming tts request from 1S
[14 Sep 2018 22:32:34.462] Information, adding item to the ttsQueue: Controller object from 1S msgIndex: 10 voiceIndex: 0 freqIndex: 1
[14 Sep 2018 22:32:34.462] Information, sending tts queue item to SayAsSent: Controller object from 1S msgIndex: 10 voiceIndex: 0 freqIndex: 1
[14 Sep 2018 22:32:34.462] Information, sending GenerateWAVfile to ttsProcessor: Controller object from 1S msgIndex: 10 voiceIndex: 0 freqIndex: 1
[14 Sep 2018 22:32:34.469] Information, ttsProcessor playback completed event received, msgIndex: 10
[14 Sep 2018 22:32:34.469] Information, processing commands from object: Controller object from 1S msgIndex: 10 voiceIndex: 0 freqIndex: 1
[14 Sep 2018 22:32:34.469] Information, removing object from the ttsQueue: Controller object from 1S msgIndex: 10 voiceIndex: 0 freqIndex: 1
[14 Sep 2018 22:32:34.470] Information, processing incoming tts request from N788YB
[14 Sep 2018 22:32:34.470] Information, adding item to the ttsQueue: Pilot object from N788YB msgIndex: 11 voiceIndex: 12 freqIndex: 1
[14 Sep 2018 22:32:34.470] Information, sending tts queue item to SayAsSent: Pilot object from N788YB msgIndex: 11 voiceIndex: 12 freqIndex: 1
[14 Sep 2018 22:32:34.470] Information, building pilot tts for N788YB
[14 Sep 2018 22:32:34.470] Information, sending GenerateWAVfile to ttsProcessor: Pilot object from N788YB msgIndex: 11 voiceIndex: 12 freqIndex: 1
[14 Sep 2018 22:32:34.474] Information, ttsProcessor playback completed event received, msgIndex: 11
[14 Sep 2018 22:32:34.474] Information, processing commands from object: Pilot object from N788YB msgIndex: 11 voiceIndex: 12 freqIndex: 1
[14 Sep 2018 22:32:34.474] Information, removing object from the ttsQueue: Pilot object from N788YB msgIndex: 11 voiceIndex: 12 freqIndex: 1
[14 Sep 2018 22:32:34.485] Information, adding flight to active list (11): SWA4voice: 18plan: KABQ to KMCI outbound IFR
[14 Sep 2018 22:32:34.494] Information, processing incoming tts request from SWA4
[14 Sep 2018 22:32:34.494] Information, adding item to the ttsQueue: Pilot object from SWA4 msgIndex: 12 voiceIndex: 18 freqIndex: 2
[14 Sep 2018 22:32:34.495] Information, sending tts queue item to SayAsSent: Pilot object from SWA4 msgIndex: 12 voiceIndex: 18 freqIndex: 2
[14 Sep 2018 22:32:34.495] Information, building pilot tts for SWA4
[14 Sep 2018 22:32:34.496] Information, sending GenerateWAVfile to ttsProcessor: Pilot object from SWA4 msgIndex: 12 voiceIndex: 18 freqIndex: 2
[14 Sep 2018 22:32:34.501] Information, ttsProcessor playback completed event received, msgIndex: 12
[14 Sep 2018 22:32:34.501] Information, processing commands from object: Pilot object from SWA4 msgIndex: 12 voiceIndex: 18 freqIndex: 2
[14 Sep 2018 22:32:34.501] Information, removing object from the ttsQueue: Pilot object from SWA4 msgIndex: 12 voiceIndex: 18 freqIndex: 2
[14 Sep 2018 22:32:34.502] Information, processing incoming tts request from 1T
[14 Sep 2018 22:32:34.502] Information, adding item to the ttsQueue: Controller object from 1T msgIndex: 13 voiceIndex: 0 freqIndex: 2
[14 Sep 2018 22:32:34.502] Information, sending tts queue item to SayAsSent: Controller object from 1T msgIndex: 13 voiceIndex: 0 freqIndex: 2
[14 Sep 2018 22:32:34.502] Information, sending GenerateWAVfile to ttsProcessor: Controller object from 1T msgIndex: 13 voiceIndex: 0 freqIndex: 2
[14 Sep 2018 22:32:34.508] Information, ttsProcessor playback completed event received, msgIndex: 13
[14 Sep 2018 22:32:34.508] Information, processing commands from object: Controller object from 1T msgIndex: 13 voiceIndex: 0 freqIndex: 2
[14 Sep 2018 22:32:34.508] Information, removing object from the ttsQueue: Controller object from 1T msgIndex: 13 voiceIndex: 0 freqIndex: 2
[14 Sep 2018 22:32:34.509] Information, processing incoming tts request from SWA4
[14 Sep 2018 22:32:34.509] Information, adding item to the ttsQueue: Pilot object from SWA4 msgIndex: 14 voiceIndex: 18 freqIndex: 2
[14 Sep 2018 22:32:34.509] Information, sending tts queue item to SayAsSent: Pilot object from SWA4 msgIndex: 14 voiceIndex: 18 freqIndex: 2
[14 Sep 2018 22:32:34.509] Information, building pilot tts for SWA4
[14 Sep 2018 22:32:34.510] Information, sending GenerateWAVfile to ttsProcessor: Pilot object from SWA4 msgIndex: 14 voiceIndex: 18 freqIndex: 2
[14 Sep 2018 22:32:34.513] Information, ttsProcessor playback completed event received, msgIndex: 14
[14 Sep 2018 22:32:34.513] Information, processing commands from object: Pilot object from SWA4 msgIndex: 14 voiceIndex: 18 freqIndex: 2
[14 Sep 2018 22:32:34.513] Information, removing object from the ttsQueue: Pilot object from SWA4 msgIndex: 14 voiceIndex: 18 freqIndex: 2
[14 Sep 2018 22:32:34.567] Information, adding flight to active list (12): N532WAvoice: 19plan: KLQR to E98 inbound IFR
[14 Sep 2018 22:32:34.575] Information, processing incoming tts request from N960JM
[14 Sep 2018 22:32:34.575] Information, no tts required, passing on commands to appropriate receiver
[14 Sep 2018 22:32:34.578] Information, processing incoming tts request from VFR
[14 Sep 2018 22:32:34.578] Warning, (IncomingATCTTS) Unable to find etvsFrequencyInformation for freqIndex: 000.0
[14 Sep 2018 22:32:34.600] Information, processing incoming tts request from 1T
[14 Sep 2018 22:32:34.600] Information, adding item to the ttsQueue: Controller object from 1T msgIndex: 15 voiceIndex: 0 freqIndex: 2
[14 Sep 2018 22:32:34.600] Information, sending tts queue item to SayAsSent: Controller object from 1T msgIndex: 15 voiceIndex: 0 freqIndex: 2
[14 Sep 2018 22:32:34.600] Information, sending GenerateWAVfile to ttsProcessor: Controller object from 1T msgIndex: 15 voiceIndex: 0 freqIndex: 2
[14 Sep 2018 22:32:34.605] Information, ttsProcessor playback completed event received, msgIndex: 15
[14 Sep 2018 22:32:34.605] Information, processing commands from object: Controller object from 1T msgIndex: 15 voiceIndex: 0 freqIndex: 2
[14 Sep 2018 22:32:34.605] Information, removing object from the ttsQueue: Controller object from 1T msgIndex: 15 voiceIndex: 0 freqIndex: 2
[14 Sep 2018 22:32:34.607] Information, processing incoming tts request from SWA4
[14 Sep 2018 22:32:34.607] Information, adding item to the ttsQueue: Pilot object from SWA4 msgIndex: 16 voiceIndex: 18 freqIndex: 2
[14 Sep 2018 22:32:34.607] Information, sending tts queue item to SayAsSent: Pilot object from SWA4 msgIndex: 16 voiceIndex: 18 freqIndex: 2
[14 Sep 2018 22:32:34.607] Information, building pilot tts for SWA4
[14 Sep 2018 22:32:34.607] Information, sending GenerateWAVfile to ttsProcessor: Pilot object from SWA4 msgIndex: 16 voiceIndex: 18 freqIndex: 2
[14 Sep 2018 22:32:34.610] Information, ttsProcessor playback completed event received, msgIndex: 16
[14 Sep 2018 22:32:34.610] Information, processing commands from object: Pilot object from SWA4 msgIndex: 16 voiceIndex: 18 freqIndex: 2
[14 Sep 2018 22:32:34.610] Information, removing object from the ttsQueue: Pilot object from SWA4 msgIndex: 16 voiceIndex: 18 freqIndex: 2
[14 Sep 2018 22:32:34.611] Information, processing incoming tts request from SWA4
[14 Sep 2018 22:32:34.611] Information, adding item to the ttsQueue: Pilot object from SWA4 msgIndex: 17 voiceIndex: 18 freqIndex: 0
[14 Sep 2018 22:32:34.611] Information, sending tts queue item to SayAsSent: Pilot object from SWA4 msgIndex: 17 voiceIndex: 18 freqIndex: 0
[14 Sep 2018 22:32:34.611] Information, building pilot tts for SWA4
[14 Sep 2018 22:32:34.611] Information, sending GenerateWAVfile to ttsProcessor: Pilot object from SWA4 msgIndex: 17 voiceIndex: 18 freqIndex: 0
[14 Sep 2018 22:32:34.619] Information, ttsProcessor playback completed event received, msgIndex: 17
[14 Sep 2018 22:32:34.619] Information, processing commands from object: Pilot object from SWA4 msgIndex: 17 voiceIndex: 18 freqIndex: 0
[14 Sep 2018 22:32:34.619] Information, removing object from the ttsQueue: Pilot object from SWA4 msgIndex: 17 voiceIndex: 18 freqIndex: 0
[14 Sep 2018 22:32:34.622] Information, processing incoming tts request from 1N
[14 Sep 2018 22:32:34.622] Information, adding item to the ttsQueue: Controller object from 1N msgIndex: 18 voiceIndex: 0 freqIndex: 0
[14 Sep 2018 22:32:34.623] Information, sending tts queue item to SayAsSent: Controller object from 1N msgIndex: 18 voiceIndex: 0 freqIndex: 0
[14 Sep 2018 22:32:34.623] Information, sending GenerateWAVfile to ttsProcessor: Controller object from 1N msgIndex: 18 voiceIndex: 0 freqIndex: 0
[14 Sep 2018 22:32:34.632] Information, ttsProcessor playback completed event received, msgIndex: 18
[14 Sep 2018 22:32:34.632] Information, processing commands from object: Controller object from 1N msgIndex: 18 voiceIndex: 0 freqIndex: 0
[14 Sep 2018 22:32:34.632] Information, removing object from the ttsQueue: Controller object from 1N msgIndex: 18 voiceIndex: 0 freqIndex: 0
[14 Sep 2018 22:32:34.639] Information, processing incoming tts request from SWA4
[14 Sep 2018 22:32:34.639] Information, adding item to the ttsQueue: Pilot object from SWA4 msgIndex: 19 voiceIndex: 18 freqIndex: 0
[14 Sep 2018 22:32:34.639] Information, sending tts queue item to SayAsSent: Pilot object from SWA4 msgIndex: 19 voiceIndex: 18 freqIndex: 0
[14 Sep 2018 22:32:34.639] Information, building pilot tts for SWA4
[14 Sep 2018 22:32:34.639] Information, sending GenerateWAVfile to ttsProcessor: Pilot object from SWA4 msgIndex: 19 voiceIndex: 18 freqIndex: 0
[14 Sep 2018 22:32:34.648] Information, ttsProcessor playback completed event received, msgIndex: 19
[14 Sep 2018 22:32:34.648] Information, processing commands from object: Pilot object from SWA4 msgIndex: 19 voiceIndex: 18 freqIndex: 0
[14 Sep 2018 22:32:34.648] Information, removing object from the ttsQueue: Pilot object from SWA4 msgIndex: 19 voiceIndex: 18 freqIndex: 0
[14 Sep 2018 22:32:34.669] Information, processing incoming tts request from C16
[14 Sep 2018 22:32:34.669] Information, adding item to the ttsQueue: Controller object from C16 msgIndex: 20 voiceIndex: 0 freqIndex: 3
[14 Sep 2018 22:32:34.669] Information, sending tts queue item to SayAsSent: Controller object from C16 msgIndex: 20 voiceIndex: 0 freqIndex: 3
[14 Sep 2018 22:32:34.669] Information, sending GenerateWAVfile to ttsProcessor: Controller object from C16 msgIndex: 20 voiceIndex: 0 freqIndex: 3
[14 Sep 2018 22:32:34.675] Information, ttsProcessor playback completed event received, msgIndex: 20
[14 Sep 2018 22:32:34.675] Information, processing commands from object: Controller object from C16 msgIndex: 20 voiceIndex: 0 freqIndex: 3
[14 Sep 2018 22:32:34.675] Information, removing object from the ttsQueue: Controller object from C16 msgIndex: 20 voiceIndex: 0 freqIndex: 3
[14 Sep 2018 22:32:34.677] Information, processing incoming tts request from SWA2202
[14 Sep 2018 22:32:34.677] Information, adding item to the ttsQueue: Pilot object from SWA2202 msgIndex: 21 voiceIndex: 13 freqIndex: 3
[14 Sep 2018 22:32:34.677] Information, sending tts queue item to SayAsSent: Pilot object from SWA2202 msgIndex: 21 voiceIndex: 13 freqIndex: 3
[14 Sep 2018 22:32:34.677] Information, building pilot tts for SWA2202
[14 Sep 2018 22:32:34.677] Information, sending GenerateWAVfile to ttsProcessor: Pilot object from SWA2202 msgIndex: 21 voiceIndex: 13 freqIndex: 3
[14 Sep 2018 22:32:34.684] Information, ttsProcessor playback completed event received, msgIndex: 21
[14 Sep 2018 22:32:34.684] Information, processing commands from object: Pilot object from SWA2202 msgIndex: 21 voiceIndex: 13 freqIndex: 3
[14 Sep 2018 22:32:34.684] Information, removing object from the ttsQueue: Pilot object from SWA2202 msgIndex: 21 voiceIndex: 13 freqIndex: 3
[14 Sep 2018 22:32:34.747] Information, processing incoming tts request from 1S
[14 Sep 2018 22:32:34.747] Information, adding item to the ttsQueue: Controller object from 1S msgIndex: 22 voiceIndex: 0 freqIndex: 1
[14 Sep 2018 22:32:34.747] Information, sending tts queue item to SayAsSent: Controller object from 1S msgIndex: 22 voiceIndex: 0 freqIndex: 1
[14 Sep 2018 22:32:34.747] Information, sending GenerateWAVfile to ttsProcessor: Controller object from 1S msgIndex: 22 voiceIndex: 0 freqIndex: 1
[14 Sep 2018 22:32:35.573] Information, current local time 10:05 (4925)
[14 Sep 2018 22:32:35.573] Information, calling writeDynamic_RadarAircrafts
[14 Sep 2018 22:32:35.580] Entering LoadDynRadarAircrafts.  RecognitionInProcess = False  AircraftUpdatePending = False
[14 Sep 2018 22:32:35.580] Entering UpdateDynRadarAircrafts
[14 Sep 2018 22:32:35.603] UpdateDynRadarAircrafts Complete.
[14 Sep 2018 22:32:35.603] Exiting LoadDynRadarAircrafts.  RecognitionInProcess = False  AircraftUpdatePending = False
[14 Sep 2018 22:32:35.653] Information, ttsProcessor playback completed event received, msgIndex: 22
[14 Sep 2018 22:32:35.653] Information, processing commands from object: Controller object from 1S msgIndex: 22 voiceIndex: 0 freqIndex: 1
[14 Sep 2018 22:32:35.653] Information, removing object from the ttsQueue: Controller object from 1S msgIndex: 22 voiceIndex: 0 freqIndex: 1
[14 Sep 2018 22:32:35.668] Information, loading commercial flights at 4925 local
[14 Sep 2018 22:32:36.514] Information, processing incoming tts request from N788YB
[14 Sep 2018 22:32:36.514] Information, adding item to the ttsQueue: Pilot object from N788YB msgIndex: 23 voiceIndex: 12 freqIndex: 1
[14 Sep 2018 22:32:36.514] Information, sending tts queue item to SayAsSent: Pilot object from N788YB msgIndex: 23 voiceIndex: 12 freqIndex: 1
[14 Sep 2018 22:32:36.514] Information, building pilot tts for N788YB
[14 Sep 2018 22:32:36.514] Information, sending GenerateWAVfile to ttsProcessor: Pilot object from N788YB msgIndex: 23 voiceIndex: 12 freqIndex: 1
[14 Sep 2018 22:32:36.516] Entering GenerateWAVfile
[14 Sep 2018 22:32:36.516] VoiceNumber = 0  Name: Jack
[14 Sep 2018 22:32:36.516] ReadbackIndex = 23  VoiceNumber = 0  Readback: <prosody rate="150%">albuquerque on one twenty seven point four  socata eight yankee bravo</prosody>
[14 Sep 2018 22:32:36.518] Channel pointer = 1   Voice No. = 0 Voice Name = Jack
[14 Sep 2018 22:32:36.680] ReadbackWAVfile = C:\ProgramData\Flag Mountain\ATCpro\Speech\Voices\OutputWAVfile0023.WAV
[14 Sep 2018 22:32:36.681] Exiting GenerateWAVfile
[14 Sep 2018 22:32:36.707] Information, ttsProcessor playback started event received, msgIndex: 23
[14 Sep 2018 22:32:39.299] Information, microphone count = 1
[14 Sep 2018 22:32:39.299] Information, user has pressed CtrlKey mic switch
[14 Sep 2018 22:32:39.324] StartRecording message received
[14 Sep 2018 22:32:39.324] waveIn is null
[14 Sep 2018 22:32:39.324] Calling vrxLiveRecognizer.  RecognizerHandle = 152822016
[14 Sep 2018 22:32:39.326] Entering StartRecording
[14 Sep 2018 22:32:39.356] Exiting StartRecording
[14 Sep 2018 22:32:39.356] After call to vrxLiveRecognizerStart.  errorCode = 0
[14 Sep 2018 22:32:39.356] Information, received recording started event from SRProcessor
[14 Sep 2018 22:32:39.356] Exiting StartStopRecognition
[14 Sep 2018 22:32:39.685] Information, entering onCtrlKeyReleased
[14 Sep 2018 22:32:39.685] Information, onCtrlKeyReleased tcwWindow isVisible
[14 Sep 2018 22:32:39.685] Information, onCtrlKeyReleased _srAvailable is TRUE
[14 Sep 2018 22:32:39.685] Information, user has released CtrlKey mic switch
[14 Sep 2018 22:32:39.706] StopRecording message received
[14 Sep 2018 22:32:39.706] Entering StopRecording
[14 Sep 2018 22:32:39.708] Exiting StopRecording
[14 Sep 2018 22:32:39.708] Information, received recording stopped event from SRProcessor
[14 Sep 2018 22:32:39.708] Exiting StartStopRecognition
[14 Sep 2018 22:32:39.708] Information, exiting onCtrlKeyReleased
[14 Sep 2018 22:32:40.057] Information, ttsProcessor playback completed event received, msgIndex: 23
[14 Sep 2018 22:32:40.081] Information, processing commands from object: Pilot object from N788YB msgIndex: 23 voiceIndex: 12 freqIndex: 1
[14 Sep 2018 22:32:40.081] Information, removing object from the ttsQueue: Pilot object from N788YB msgIndex: 23 voiceIndex: 12 freqIndex: 1
[14 Sep 2018 22:32:40.515] Information, processing incoming tts request from N788YB
[14 Sep 2018 22:32:40.515] Information, adding item to the ttsQueue: Pilot object from N788YB msgIndex: 24 voiceIndex: 12 freqIndex: 0
[14 Sep 2018 22:32:40.516] Information, sending tts queue item to SayAsSent: Pilot object from N788YB msgIndex: 24 voiceIndex: 12 freqIndex: 0
[14 Sep 2018 22:32:40.516] Information, building pilot tts for N788YB
[14 Sep 2018 22:32:40.516] Information, sending GenerateWAVfile to ttsProcessor: Pilot object from N788YB msgIndex: 24 voiceIndex: 12 freqIndex: 0
[14 Sep 2018 22:32:40.516] Entering GenerateWAVfile
[14 Sep 2018 22:32:40.516] VoiceNumber = 0  Name: Jack
[14 Sep 2018 22:32:40.516] ReadbackIndex = 24  VoiceNumber = 0  Readback: <prosody rate="150%">albuquerque departure socata november seven eight eight yankee bravo   is with you out of ten thousand six hundred for one three thousand </prosody>
[14 Sep 2018 22:32:40.518] Channel pointer = 1   Voice No. = 0 Voice Name = Jack
[14 Sep 2018 22:32:40.859] ReadbackWAVfile = C:\ProgramData\Flag Mountain\ATCpro\Speech\Voices\OutputWAVfile0024.WAV
[14 Sep 2018 22:32:40.859] Exiting GenerateWAVfile
[14 Sep 2018 22:32:40.872] Information, ttsProcessor playback started event received, msgIndex: 24
[14 Sep 2018 22:32:46.657] Information, ttsProcessor playback completed event received, msgIndex: 24
[14 Sep 2018 22:32:46.680] Information, processing commands from object: Pilot object from N788YB msgIndex: 24 voiceIndex: 12 freqIndex: 0
[14 Sep 2018 22:32:46.680] Information, removing object from the ttsQueue: Pilot object from N788YB msgIndex: 24 voiceIndex: 12 freqIndex: 0
[14 Sep 2018 22:32:47.516] Information, processing incoming tts request from 1N
[14 Sep 2018 22:32:47.516] Information, adding item to the ttsQueue: Controller object from 1N msgIndex: 25 voiceIndex: 0 freqIndex: 0
[14 Sep 2018 22:32:47.516] Information, sending tts queue item to SayAsSent: Controller object from 1N msgIndex: 25 voiceIndex: 0 freqIndex: 0
[14 Sep 2018 22:32:47.516] Information, sending GenerateWAVfile to ttsProcessor: Controller object from 1N msgIndex: 25 voiceIndex: 0 freqIndex: 0
[14 Sep 2018 22:32:47.516] Entering GenerateWAVfile
[14 Sep 2018 22:32:47.516] VoiceNumber = 3  Name: Katherine
[14 Sep 2018 22:32:47.516] ReadbackIndex = 25  VoiceNumber = 3  Readback: <prosody rate="150%">socata eight yankee bravo albuquerque rodjer , turn left heading two eight zero</prosody>
[14 Sep 2018 22:32:47.518] Channel pointer = 1   Voice No. = 3 Voice Name = Katherine
[14 Sep 2018 22:32:47.653] ReadbackWAVfile = C:\ProgramData\Flag Mountain\ATCpro\Speech\Voices\OutputWAVfile0025.WAV
[14 Sep 2018 22:32:47.653] Exiting GenerateWAVfile
[14 Sep 2018 22:32:47.659] Information, ttsProcessor playback started event received, msgIndex: 25
[14 Sep 2018 22:32:51.457] Information, ttsProcessor playback completed event received, msgIndex: 25
[14 Sep 2018 22:32:51.480] Information, processing commands from object: Controller object from 1N msgIndex: 25 voiceIndex: 0 freqIndex: 0
[14 Sep 2018 22:32:51.480] Information, removing object from the ttsQueue: Controller object from 1N msgIndex: 25 voiceIndex: 0 freqIndex: 0
[14 Sep 2018 22:32:51.514] Information, processing incoming tts request from N788YB
[14 Sep 2018 22:32:51.514] Information, adding item to the ttsQueue: Pilot object from N788YB msgIndex: 26 voiceIndex: 12 freqIndex: 0
[14 Sep 2018 22:32:51.514] Information, sending tts queue item to SayAsSent: Pilot object from N788YB msgIndex: 26 voiceIndex: 12 freqIndex: 0
[14 Sep 2018 22:32:51.514] Information, building pilot tts for N788YB
[14 Sep 2018 22:32:51.514] Information, sending GenerateWAVfile to ttsProcessor: Pilot object from N788YB msgIndex: 26 voiceIndex: 12 freqIndex: 0
[14 Sep 2018 22:32:51.514] Entering GenerateWAVfile
[14 Sep 2018 22:32:51.514] VoiceNumber = 0  Name: Jack
[14 Sep 2018 22:32:51.514] ReadbackIndex = 26  VoiceNumber = 0  Readback: <prosody rate="150%">turn left heading two eight zero  socata eight yankee bravo</prosody>
[14 Sep 2018 22:32:51.516] Channel pointer = 1   Voice No. = 0 Voice Name = Jack
[14 Sep 2018 22:32:51.611] ReadbackWAVfile = C:\ProgramData\Flag Mountain\ATCpro\Speech\Voices\OutputWAVfile0026.WAV
[14 Sep 2018 22:32:51.611] Exiting GenerateWAVfile
[14 Sep 2018 22:32:51.618] Information, ttsProcessor playback started event received, msgIndex: 26
[14 Sep 2018 22:32:54.539] Information, in beginPositionReliefBriefing
[14 Sep 2018 22:32:54.539] Information, ownedControllerPositions.count is greater than 0, calling initialControllerBriefing
[14 Sep 2018 22:32:54.540] Information, in initialControllerBriefing, calling playControllerBriefing and createControllerBriefing
[14 Sep 2018 22:32:54.542] Information, in createControllerBriefing
[14 Sep 2018 22:32:54.543] Information, in controller briefing created
[14 Sep 2018 22:32:54.544] Entering GenerateWAVfile
[14 Sep 2018 22:32:54.544] VoiceNumber = 3  Name: Katherine
[14 Sep 2018 22:32:54.544] ReadbackIndex = -999  VoiceNumber = 3  Readback: <prosody rate="150%">Albuquerque airport is V F R, operating West flow.  Altimittur is two niner niner six, fully staffed.  Runways, two one, two six, three zero in use.   Climbing Socata eight yankee bravo to one three thousand.   Climbing southwest four to flight level two zero zero .  Oh kaye?  Your scope.</prosody>
[14 Sep 2018 22:32:54.546] Channel pointer = 1   Voice No. = 3 Voice Name = Katherine
[14 Sep 2018 22:32:55.160] ReadbackWAVfile = C:\ProgramData\Flag Mountain\ATCpro\Speech\Voices\OutputWAVfile-0999.WAV
[14 Sep 2018 22:32:55.160] Exiting GenerateWAVfile
[14 Sep 2018 22:32:55.160] Information, in playControllerBriefing, wave file requested
[14 Sep 2018 22:32:55.161] Information, ttsProcessor playback completed event received, msgIndex: 26
[14 Sep 2018 22:32:55.184] Information, processing commands from object: Pilot object from N788YB msgIndex: 26 voiceIndex: 12 freqIndex: 0
[14 Sep 2018 22:32:55.184] Information, removing object from the ttsQueue: Pilot object from N788YB msgIndex: 26 voiceIndex: 12 freqIndex: 0
[14 Sep 2018 22:33:01.852] Information, in beginPositionReliefBriefing
[14 Sep 2018 22:33:01.852] Information, ownedControllerPositions.count is greater than 0, calling initialControllerBriefing
[14 Sep 2018 22:33:01.852] Information, in initialControllerBriefing, calling playControllerBriefing and createControllerBriefing
[14 Sep 2018 22:33:01.852] Information, in createControllerBriefing
[14 Sep 2018 22:33:01.852] Information, in controller briefing created
[14 Sep 2018 22:33:01.852] Entering GenerateWAVfile
[14 Sep 2018 22:33:01.852] VoiceNumber = 3  Name: Katherine
[14 Sep 2018 22:33:01.852] ReadbackIndex = -999  VoiceNumber = 3  Readback: <prosody rate="150%">Albuquerque airport is V F R, operating West flow.  Altimittur is two niner niner six, fully staffed.  Runways, two one, two six, three zero in use.   Climbing Socata eight yankee bravo to one three thousand.   Climbing southwest four to flight level two zero zero .  Oh kaye?  Your scope.</prosody>
[14 Sep 2018 22:33:01.854] Channel pointer = 1   Voice No. = 3 Voice Name = Katherine
[14 Sep 2018 22:33:02.463] ReadbackWAVfile = C:\ProgramData\Flag Mountain\ATCpro\Speech\Voices\OutputWAVfile-0999.WAV
[14 Sep 2018 22:33:02.463] Exiting GenerateWAVfile
[14 Sep 2018 22:33:02.463] Information, in playControllerBriefing, wave file requested
[14 Sep 2018 22:33:35.575] Information, current local time 10:06 (4926)
[14 Sep 2018 22:33:35.622] Information, loading commercial flights at 4926 local
[14 Sep 2018 22:33:46.518] Information, processing incoming tts request from 1N
[14 Sep 2018 22:33:46.518] Information, no tts required, passing on commands to appropriate receiver
[14 Sep 2018 22:33:55.892] Information, microphone count = 2
[14 Sep 2018 22:33:55.892] Information, user has pressed CtrlKey mic switch
[14 Sep 2018 22:33:55.913] StartRecording message received
[14 Sep 2018 22:33:55.913] waveIn is null
[14 Sep 2018 22:33:55.913] Calling vrxLiveRecognizer.  RecognizerHandle = 152822016
[14 Sep 2018 22:33:55.914] Entering StartRecording
[14 Sep 2018 22:33:55.921] Exiting StartRecording
[14 Sep 2018 22:33:55.921] After call to vrxLiveRecognizerStart.  errorCode = 0
[14 Sep 2018 22:33:55.921] Information, received recording started event from SRProcessor
[14 Sep 2018 22:33:55.921] Exiting StartStopRecognition
[14 Sep 2018 22:34:01.096] Information, entering onCtrlKeyReleased
[14 Sep 2018 22:34:01.096] Information, onCtrlKeyReleased tcwWindow isVisible
[14 Sep 2018 22:34:01.096] Information, onCtrlKeyReleased _srAvailable is TRUE
[14 Sep 2018 22:34:01.096] Information, user has released CtrlKey mic switch
[14 Sep 2018 22:34:01.119] StopRecording message received
[14 Sep 2018 22:34:01.119] Entering StopRecording
[14 Sep 2018 22:34:01.119] Exiting StopRecording
[14 Sep 2018 22:34:01.119] Information, received recording stopped event from SRProcessor
[14 Sep 2018 22:34:01.119] Exiting StartStopRecognition
[14 Sep 2018 22:34:01.120] Information, exiting onCtrlKeyReleased
[14 Sep 2018 22:34:01.343] Entering ProcessVRXInterpretation
[14 Sep 2018 22:34:01.344] VRX Interpretation: <?xml version="1.0" encoding="utf-8"?> <VRXResultsTop><a>
<callsign>N788YB</callsign>
<cc_source>VPI_RADAR_CONTROLLER</cc_source>
<com1>
<command>
<commandName>VOICE_REC_CONTACT</commandName>
<szFacilityName>center</szFacilityName>
<enWhoToContact></enWhoToContact>
<fFrequency>124.32</fFrequency>
<enChangeToFreqType>CHG_TYPE_CONTACT</enChangeToFreqType>
</command>
</com1>
</a></VRXResultsTop>
[14 Sep 2018 22:34:01.344] Exiting ReformatIncomingMsg
[14 Sep 2018 22:34:01.344] VRX Best Hypothesis: eight yankee bravo contact center one two four point three two
[14 Sep 2018 22:34:01.344] Entering ParseVRXInterpretation
[14 Sep 2018 22:34:01.423] Information, beginning parse of communication type speech recognition command
[14 Sep 2018 22:34:01.426] OutgoingVRXResult = N788YB:1170:124.32
[14 Sep 2018 22:34:01.426] Exiting ParseIncomingMsg
[14 Sep 2018 22:34:01.426] Exiting ProcessVRXInterpretation
[14 Sep 2018 22:34:01.514] Information, processing incoming tts request from N788YB
[14 Sep 2018 22:34:01.514] Information, adding item to the ttsQueue: Pilot object from N788YB msgIndex: 27 voiceIndex: 12 freqIndex: 0
[14 Sep 2018 22:34:01.514] Information, sending tts queue item to SayAsSent: Pilot object from N788YB msgIndex: 27 voiceIndex: 12 freqIndex: 0
[14 Sep 2018 22:34:01.514] Information, building pilot tts for N788YB
[14 Sep 2018 22:34:01.514] Information, sending GenerateWAVfile to ttsProcessor: Pilot object from N788YB msgIndex: 27 voiceIndex: 12 freqIndex: 0
[14 Sep 2018 22:34:01.514] Entering GenerateWAVfile
[14 Sep 2018 22:34:01.514] VoiceNumber = 0  Name: Jack
[14 Sep 2018 22:34:01.514] ReadbackIndex = 27  VoiceNumber = 0  Readback: <prosody rate="150%">one twenty four point three two  socata eight yankee bravo</prosody>
[14 Sep 2018 22:34:01.516] Channel pointer = 1   Voice No. = 0 Voice Name = Jack
[14 Sep 2018 22:34:01.639] ReadbackWAVfile = C:\ProgramData\Flag Mountain\ATCpro\Speech\Voices\OutputWAVfile0027.WAV
[14 Sep 2018 22:34:01.639] Exiting GenerateWAVfile
[14 Sep 2018 22:34:01.649] Information, ttsProcessor playback started event received, msgIndex: 27
[14 Sep 2018 22:34:04.580] Information, ttsProcessor playback completed event received, msgIndex: 27
[14 Sep 2018 22:34:04.600] Information, processing commands from object: Pilot object from N788YB msgIndex: 27 voiceIndex: 12 freqIndex: 0
[14 Sep 2018 22:34:04.601] Information, removing object from the ttsQueue: Pilot object from N788YB msgIndex: 27 voiceIndex: 12 freqIndex: 0
[14 Sep 2018 22:34:05.517] Information, processing incoming tts request from N788YB
[14 Sep 2018 22:34:05.517] Information, adding item to the ttsQueue: Pilot object from N788YB msgIndex: 28 voiceIndex: 12 freqIndex: 4
[14 Sep 2018 22:34:05.517] Information, sending tts queue item to SayAsSent: Pilot object from N788YB msgIndex: 28 voiceIndex: 12 freqIndex: 4
[14 Sep 2018 22:34:05.517] Information, building pilot tts for N788YB
[14 Sep 2018 22:34:05.517] Information, sending GenerateWAVfile to ttsProcessor: Pilot object from N788YB msgIndex: 28 voiceIndex: 12 freqIndex: 4
[14 Sep 2018 22:34:12.513] Information, ttsProcessor playback completed event received, msgIndex: 28
[14 Sep 2018 22:34:12.513] Information, processing commands from object: Pilot object from N788YB msgIndex: 28 voiceIndex: 12 freqIndex: 4
[14 Sep 2018 22:34:12.513] Information, removing object from the ttsQueue: Pilot object from N788YB msgIndex: 28 voiceIndex: 12 freqIndex: 4
[14 Sep 2018 22:34:13.514] Information, processing incoming tts request from C17
[14 Sep 2018 22:34:13.514] Information, adding item to the ttsQueue: Controller object from C17 msgIndex: 29 voiceIndex: 0 freqIndex: 4
[14 Sep 2018 22:34:13.514] Information, sending tts queue item to SayAsSent: Controller object from C17 msgIndex: 29 voiceIndex: 0 freqIndex: 4
[14 Sep 2018 22:34:13.514] Information, sending GenerateWAVfile to ttsProcessor: Controller object from C17 msgIndex: 29 voiceIndex: 0 freqIndex: 4
[14 Sep 2018 22:34:16.515] Information, ttsProcessor playback completed event received, msgIndex: 29
[14 Sep 2018 22:34:16.515] Information, processing commands from object: Controller object from C17 msgIndex: 29 voiceIndex: 0 freqIndex: 4
[14 Sep 2018 22:34:16.515] Information, removing object from the ttsQueue: Controller object from C17 msgIndex: 29 voiceIndex: 0 freqIndex: 4
[14 Sep 2018 22:34:17.518] Information, processing incoming tts request from N788YB
[14 Sep 2018 22:34:17.518] Information, adding item to the ttsQueue: Pilot object from N788YB msgIndex: 30 voiceIndex: 12 freqIndex: 4
[14 Sep 2018 22:34:17.519] Information, sending tts queue item to SayAsSent: Pilot object from N788YB msgIndex: 30 voiceIndex: 12 freqIndex: 4
[14 Sep 2018 22:34:17.519] Information, building pilot tts for N788YB
[14 Sep 2018 22:34:17.519] Information, sending GenerateWAVfile to ttsProcessor: Pilot object from N788YB msgIndex: 30 voiceIndex: 12 freqIndex: 4
[14 Sep 2018 22:34:20.515] Information, ttsProcessor playback completed event received, msgIndex: 30
[14 Sep 2018 22:34:20.515] Information, processing commands from object: Pilot object from N788YB msgIndex: 30 voiceIndex: 12 freqIndex: 4
[14 Sep 2018 22:34:20.515] Information, removing object from the ttsQueue: Pilot object from N788YB msgIndex: 30 voiceIndex: 12 freqIndex: 4
[14 Sep 2018 22:34:35.571] Information, current local time 10:07 (4927)
[14 Sep 2018 22:34:35.619] Information, adding flight to active list (13): SWA271voice: 20plan: KDEN to KABQ inbound IFR
[14 Sep 2018 22:34:35.620] Information, removing active flight (14): SWA271
[14 Sep 2018 22:34:35.621] Information, loading commercial flights at 4927 local
[14 Sep 2018 22:34:47.515] Information, processing incoming tts request from N750ZM
[14 Sep 2018 22:34:47.515] Information, no tts required, passing on commands to appropriate receiver
[14 Sep 2018 22:34:52.515] Information, processing incoming tts request from VFR
[14 Sep 2018 22:34:52.515] Warning, (IncomingATCTTS) Unable to find etvsFrequencyInformation for freqIndex: 000.0
[14 Sep 2018 22:34:58.515] Information, processing incoming tts request from 1N
[14 Sep 2018 22:34:58.515] Information, no tts required, passing on commands to appropriate receiver
[14 Sep 2018 22:35:28.515] Information, processing incoming tts request from 1N
[14 Sep 2018 22:35:28.515] Information, no tts required, passing on commands to appropriate receiver
[14 Sep 2018 22:35:30.516] Information, processing incoming tts request from C94
[14 Sep 2018 22:35:30.516] Information, adding item to the ttsQueue: Controller object from C94 msgIndex: 31 voiceIndex: 0 freqIndex: 5
[14 Sep 2018 22:35:30.516] Information, sending tts queue item to SayAsSent: Controller object from C94 msgIndex: 31 voiceIndex: 0 freqIndex: 5
[14 Sep 2018 22:35:30.516] Information, sending GenerateWAVfile to ttsProcessor: Controller object from C94 msgIndex: 31 voiceIndex: 0 freqIndex: 5
[14 Sep 2018 22:35:33.514] Information, ttsProcessor playback completed event received, msgIndex: 31
[14 Sep 2018 22:35:33.514] Information, processing commands from object: Controller object from C94 msgIndex: 31 voiceIndex: 0 freqIndex: 5
[14 Sep 2018 22:35:33.514] Information, removing object from the ttsQueue: Controller object from C94 msgIndex: 31 voiceIndex: 0 freqIndex: 5
[14 Sep 2018 22:35:34.515] Information, processing incoming tts request from AMF1288
[14 Sep 2018 22:35:34.515] Information, adding item to the ttsQueue: Pilot object from AMF1288 msgIndex: 32 voiceIndex: 5 freqIndex: 5
[14 Sep 2018 22:35:34.515] Information, sending tts queue item to SayAsSent: Pilot object from AMF1288 msgIndex: 32 voiceIndex: 5 freqIndex: 5
[14 Sep 2018 22:35:34.515] Information, building pilot tts for AMF1288
[14 Sep 2018 22:35:34.516] Information, sending GenerateWAVfile to ttsProcessor: Pilot object from AMF1288 msgIndex: 32 voiceIndex: 5 freqIndex: 5
[14 Sep 2018 22:35:35.565] Information, current local time 10:08 (4928)
[14 Sep 2018 22:35:35.628] Information, loading commercial flights at 4928 local
[14 Sep 2018 22:35:37.190] Information, microphone count = 3
[14 Sep 2018 22:35:37.190] Information, user has pressed CtrlKey mic switch
[14 Sep 2018 22:35:37.200] StartRecording message received
[14 Sep 2018 22:35:37.200] waveIn is null
[14 Sep 2018 22:35:37.200] Calling vrxLiveRecognizer.  RecognizerHandle = 152822016
[14 Sep 2018 22:35:37.200] Entering StartRecording
[14 Sep 2018 22:35:37.207] Exiting StartRecording
[14 Sep 2018 22:35:37.207] After call to vrxLiveRecognizerStart.  errorCode = 0
[14 Sep 2018 22:35:37.207] Information, received recording started event from SRProcessor
[14 Sep 2018 22:35:37.207] Exiting StartStopRecognition
[14 Sep 2018 22:35:38.514] Information, ttsProcessor playback completed event received, msgIndex: 32
[14 Sep 2018 22:35:38.514] Information, processing commands from object: Pilot object from AMF1288 msgIndex: 32 voiceIndex: 5 freqIndex: 5
[14 Sep 2018 22:35:38.514] Information, removing object from the ttsQueue: Pilot object from AMF1288 msgIndex: 32 voiceIndex: 5 freqIndex: 5
[14 Sep 2018 22:35:39.514] Information, processing incoming tts request from AMF1288
[14 Sep 2018 22:35:39.514] Information, adding item to the ttsQueue: Pilot object from AMF1288 msgIndex: 33 voiceIndex: 5 freqIndex: 0
[14 Sep 2018 22:35:39.515] Information, skipping a tts queue item because the user has the mic button pressed
[14 Sep 2018 22:35:40.515] Information, skipping a tts queue item because the user has the mic button pressed
[14 Sep 2018 22:35:40.825] Information, entering onCtrlKeyReleased
[14 Sep 2018 22:35:40.825] Information, onCtrlKeyReleased tcwWindow isVisible
[14 Sep 2018 22:35:40.825] Information, onCtrlKeyReleased _srAvailable is TRUE
[14 Sep 2018 22:35:40.825] Information, user has released CtrlKey mic switch
[14 Sep 2018 22:35:40.836] StopRecording message received
[14 Sep 2018 22:35:40.836] Entering StopRecording
[14 Sep 2018 22:35:40.836] Exiting StopRecording
[14 Sep 2018 22:35:40.836] Information, received recording stopped event from SRProcessor
[14 Sep 2018 22:35:40.836] Exiting StartStopRecognition
[14 Sep 2018 22:35:40.836] Information, exiting onCtrlKeyReleased
[14 Sep 2018 22:35:41.005] Entering ProcessVRXInterpretation
[14 Sep 2018 22:35:41.005] VRX Interpretation: <?xml version="1.0" encoding="utf-8"?> <VRXResultsTop><a>
<callsign>SWA4</callsign>
<cc_source>VPI_RADAR_CONTROLLER</cc_source>
<com1>
<command>
<commandName>VOICE_REC_CONTACT</commandName>
<szFacilityName>center</szFacilityName>
<enWhoToContact></enWhoToContact>
<fFrequency>132.8</fFrequency>
<enChangeToFreqType>CHG_TYPE_CONTACT</enChangeToFreqType>
</command>
</com1>
</a></VRXResultsTop>
[14 Sep 2018 22:35:41.005] Exiting ReformatIncomingMsg
[14 Sep 2018 22:35:41.005] VRX Best Hypothesis: southwest four contact center one three two point eight
[14 Sep 2018 22:35:41.005] Entering ParseVRXInterpretation
[14 Sep 2018 22:35:41.005] Information, beginning parse of communication type speech recognition command
[14 Sep 2018 22:35:41.005] OutgoingVRXResult = SWA4:1170:132.8
[14 Sep 2018 22:35:41.005] Exiting ParseIncomingMsg
[14 Sep 2018 22:35:41.005] Exiting ProcessVRXInterpretation
[14 Sep 2018 22:35:41.513] Information, processing incoming tts request from SWA4
[14 Sep 2018 22:35:41.513] Information, adding item to the ttsQueue: Pilot object from SWA4 msgIndex: 34 voiceIndex: 18 freqIndex: 0
[14 Sep 2018 22:35:41.514] Information, current frequency (127.4) is busy, checking to unlock it
[14 Sep 2018 22:35:41.514] Information, current frequency (127.4) is busy, unlocking it
[14 Sep 2018 22:35:41.514] Information, sending tts queue item to SayAsSent: Pilot object from AMF1288 msgIndex: 33 voiceIndex: 5 freqIndex: 0
[14 Sep 2018 22:35:41.514] Information, building pilot tts for AMF1288
[14 Sep 2018 22:35:41.514] Information, sending GenerateWAVfile to ttsProcessor: Pilot object from AMF1288 msgIndex: 33 voiceIndex: 5 freqIndex: 0
[14 Sep 2018 22:35:41.514] Entering GenerateWAVfile
[14 Sep 2018 22:35:41.514] VoiceNumber = 2  Name: William
[14 Sep 2018 22:35:41.514] ReadbackIndex = 33  VoiceNumber = 2  Readback: <prosody rate="150%">albuquerque approach good morning amflight twelve eighty eight  is with you at one three thousand </prosody>
[14 Sep 2018 22:35:41.516] Channel pointer = 1   Voice No. = 2 Voice Name = William
[14 Sep 2018 22:35:41.703] ReadbackWAVfile = C:\ProgramData\Flag Mountain\ATCpro\Speech\Voices\OutputWAVfile0033.WAV
[14 Sep 2018 22:35:41.703] Exiting GenerateWAVfile
[14 Sep 2018 22:35:41.713] Information, ttsProcessor playback started event received, msgIndex: 33
[14 Sep 2018 22:35:45.869] Information, ttsProcessor playback completed event received, msgIndex: 33
[14 Sep 2018 22:35:45.879] Information, processing commands from object: Pilot object from AMF1288 msgIndex: 33 voiceIndex: 5 freqIndex: 0
[14 Sep 2018 22:35:45.879] Information, removing object from the ttsQueue: Pilot object from AMF1288 msgIndex: 33 voiceIndex: 5 freqIndex: 0
[14 Sep 2018 22:35:46.513] Information, current frequency (127.4) is busy, checking to unlock it
[14 Sep 2018 22:35:46.513] Information, sending tts queue item to SayAsSent: Pilot object from SWA4 msgIndex: 34 voiceIndex: 18 freqIndex: 0
[14 Sep 2018 22:35:46.513] Information, building pilot tts for SWA4
[14 Sep 2018 22:35:46.513] Information, sending GenerateWAVfile to ttsProcessor: Pilot object from SWA4 msgIndex: 34 voiceIndex: 18 freqIndex: 0
[14 Sep 2018 22:35:46.513] Entering GenerateWAVfile
[14 Sep 2018 22:35:46.513] VoiceNumber = 0  Name: Jack
[14 Sep 2018 22:35:46.513] ReadbackIndex = 34  VoiceNumber = 0  Readback: <prosody rate="150%">albuquerque center on one thirty two point eight  southwest four</prosody>
[14 Sep 2018 22:35:46.515] Channel pointer = 1   Voice No. = 0 Voice Name = Jack
[14 Sep 2018 22:35:46.650] ReadbackWAVfile = C:\ProgramData\Flag Mountain\ATCpro\Speech\Voices\OutputWAVfile0034.WAV
[14 Sep 2018 22:35:46.650] Exiting GenerateWAVfile
[14 Sep 2018 22:35:46.658] Information, ttsProcessor playback started event received, msgIndex: 34
[14 Sep 2018 22:35:49.619] Information, ttsProcessor playback completed event received, msgIndex: 34
[14 Sep 2018 22:35:49.629] Information, processing commands from object: Pilot object from SWA4 msgIndex: 34 voiceIndex: 18 freqIndex: 0
[14 Sep 2018 22:35:49.629] Information, removing object from the ttsQueue: Pilot object from SWA4 msgIndex: 34 voiceIndex: 18 freqIndex: 0
[14 Sep 2018 22:35:50.514] Information, processing incoming tts request from SWA4
[14 Sep 2018 22:35:50.514] Information, adding item to the ttsQueue: Pilot object from SWA4 msgIndex: 35 voiceIndex: 18 freqIndex: 3
[14 Sep 2018 22:35:50.514] Information, sending tts queue item to SayAsSent: Pilot object from SWA4 msgIndex: 35 voiceIndex: 18 freqIndex: 3
[14 Sep 2018 22:35:50.514] Information, building pilot tts for SWA4
[14 Sep 2018 22:35:50.514] Information, sending GenerateWAVfile to ttsProcessor: Pilot object from SWA4 msgIndex: 35 voiceIndex: 18 freqIndex: 3
[14 Sep 2018 22:35:53.283] Information, microphone count = 4
[14 Sep 2018 22:35:53.283] Information, user has pressed CtrlKey mic switch
[14 Sep 2018 22:35:53.293] StartRecording message received
[14 Sep 2018 22:35:53.293] waveIn is null
[14 Sep 2018 22:35:53.293] Calling vrxLiveRecognizer.  RecognizerHandle = 152822016
[14 Sep 2018 22:35:53.293] Entering StartRecording
[14 Sep 2018 22:35:53.300] Exiting StartRecording
[14 Sep 2018 22:35:53.300] After call to vrxLiveRecognizerStart.  errorCode = 0
[14 Sep 2018 22:35:53.300] Information, received recording started event from SRProcessor
[14 Sep 2018 22:35:53.300] Exiting StartStopRecognition
[14 Sep 2018 22:35:57.514] Information, ttsProcessor playback completed event received, msgIndex: 35
[14 Sep 2018 22:35:57.514] Information, processing commands from object: Pilot object from SWA4 msgIndex: 35 voiceIndex: 18 freqIndex: 3
[14 Sep 2018 22:35:57.514] Information, removing object from the ttsQueue: Pilot object from SWA4 msgIndex: 35 voiceIndex: 18 freqIndex: 3
[14 Sep 2018 22:35:58.515] Information, processing incoming tts request from C16
[14 Sep 2018 22:35:58.515] Information, adding item to the ttsQueue: Controller object from C16 msgIndex: 36 voiceIndex: 0 freqIndex: 3
[14 Sep 2018 22:35:58.515] Information, sending tts queue item to SayAsSent: Controller object from C16 msgIndex: 36 voiceIndex: 0 freqIndex: 3
[14 Sep 2018 22:35:58.516] Information, sending GenerateWAVfile to ttsProcessor: Controller object from C16 msgIndex: 36 voiceIndex: 0 freqIndex: 3
[14 Sep 2018 22:35:58.924] Information, entering onCtrlKeyReleased
[14 Sep 2018 22:35:58.924] Information, onCtrlKeyReleased tcwWindow isVisible
[14 Sep 2018 22:35:58.924] Information, onCtrlKeyReleased _srAvailable is TRUE
[14 Sep 2018 22:35:58.924] Information, user has released CtrlKey mic switch
[14 Sep 2018 22:35:58.934] StopRecording message received
[14 Sep 2018 22:35:58.934] Entering StopRecording
[14 Sep 2018 22:35:58.936] Exiting StopRecording
[14 Sep 2018 22:35:58.936] Information, received recording stopped event from SRProcessor
[14 Sep 2018 22:35:58.936] Exiting StartStopRecognition
[14 Sep 2018 22:35:58.936] Information, exiting onCtrlKeyReleased
[14 Sep 2018 22:35:59.065] Entering ProcessVRXInterpretation
[14 Sep 2018 22:35:59.065] VRX Interpretation: <?xml version="1.0" encoding="utf-8"?> <VRXResultsTop><a>
<callsign>AMF1288</callsign>
<cc_source>VPI_RADAR_CONTROLLER</cc_source>
<com1>
<command>
<commandName>VOICE_REC_ROGER_WILCO</commandName>
</command>
</com1>
<com2>
<command>
<commandName>VOICE_REC_EXPECT_RUNWAY</commandName>
<szRunway>21 </szRunway>
</command>
</com2>
</a></VRXResultsTop>
[14 Sep 2018 22:35:59.065] Exiting ReformatIncomingMsg
[14 Sep 2018 22:35:59.065] VRX Best Hypothesis: amflight twelve eighty eight roger expect runway two one
[14 Sep 2018 22:35:59.065] Entering ParseVRXInterpretation
[14 Sep 2018 22:35:59.071] Information, beginning parse of approach type speech recognition command
[14 Sep 2018 22:35:59.073] OutgoingVRXResult = AMF1288:9994@826:21
[14 Sep 2018 22:35:59.073] Exiting ParseIncomingMsg
[14 Sep 2018 22:35:59.073] Exiting ProcessVRXInterpretation
[14 Sep 2018 22:35:59.513] Information, processing incoming tts request from AMF1288
[14 Sep 2018 22:35:59.513] Information, adding item to the ttsQueue: Pilot object from AMF1288 msgIndex: 37 voiceIndex: 5 freqIndex: 0
[14 Sep 2018 22:35:59.514] Information, sending tts queue item to SayAsSent: Pilot object from AMF1288 msgIndex: 37 voiceIndex: 5 freqIndex: 0
[14 Sep 2018 22:35:59.514] Information, building pilot tts for AMF1288
[14 Sep 2018 22:35:59.514] Information, sending GenerateWAVfile to ttsProcessor: Pilot object from AMF1288 msgIndex: 37 voiceIndex: 5 freqIndex: 0
[14 Sep 2018 22:35:59.514] Entering GenerateWAVfile
[14 Sep 2018 22:35:59.514] VoiceNumber = 2  Name: William
[14 Sep 2018 22:35:59.515] ReadbackIndex = 37  VoiceNumber = 2  Readback: <prosody rate="150%">expect runway two one amflight twelve eighty eight</prosody>
[14 Sep 2018 22:35:59.516] Channel pointer = 1   Voice No. = 2 Voice Name = William
[14 Sep 2018 22:35:59.610] ReadbackWAVfile = C:\ProgramData\Flag Mountain\ATCpro\Speech\Voices\OutputWAVfile0037.WAV
[14 Sep 2018 22:35:59.610] Exiting GenerateWAVfile
[14 Sep 2018 22:35:59.618] Information, ttsProcessor playback started event received, msgIndex: 37
[14 Sep 2018 22:36:00.515] Information, ttsProcessor playback completed event received, msgIndex: 36
[14 Sep 2018 22:36:00.515] Information, processing commands from object: Controller object from C16 msgIndex: 36 voiceIndex: 0 freqIndex: 3
[14 Sep 2018 22:36:00.515] Information, removing object from the ttsQueue: Controller object from C16 msgIndex: 36 voiceIndex: 0 freqIndex: 3
[14 Sep 2018 22:36:02.068] Information, ttsProcessor playback completed event received, msgIndex: 37
[14 Sep 2018 22:36:02.078] Information, processing commands from object: Pilot object from AMF1288 msgIndex: 37 voiceIndex: 5 freqIndex: 0
[14 Sep 2018 22:36:02.078] Information, removing object from the ttsQueue: Pilot object from AMF1288 msgIndex: 37 voiceIndex: 5 freqIndex: 0
[14 Sep 2018 22:36:14.157] Information, microphone count = 5
[14 Sep 2018 22:36:14.157] Information, user has pressed CtrlKey mic switch
[14 Sep 2018 22:36:14.167] StartRecording message received
[14 Sep 2018 22:36:14.167] waveIn is null
[14 Sep 2018 22:36:14.167] Calling vrxLiveRecognizer.  RecognizerHandle = 152822016
[14 Sep 2018 22:36:14.167] Entering StartRecording
[14 Sep 2018 22:36:14.174] Exiting StartRecording
[14 Sep 2018 22:36:14.174] After call to vrxLiveRecognizerStart.  errorCode = 0
[14 Sep 2018 22:36:14.174] Information, received recording started event from SRProcessor
[14 Sep 2018 22:36:14.174] Exiting StartStopRecognition
[14 Sep 2018 22:36:17.451] Information, entering onCtrlKeyReleased
[14 Sep 2018 22:36:17.451] Information, onCtrlKeyReleased tcwWindow isVisible
[14 Sep 2018 22:36:17.451] Information, onCtrlKeyReleased _srAvailable is TRUE
[14 Sep 2018 22:36:17.451] Information, user has released CtrlKey mic switch
[14 Sep 2018 22:36:17.461] StopRecording message received
[14 Sep 2018 22:36:17.461] Entering StopRecording
[14 Sep 2018 22:36:17.462] Exiting StopRecording
[14 Sep 2018 22:36:17.462] Information, received recording stopped event from SRProcessor
[14 Sep 2018 22:36:17.462] Exiting StartStopRecognition
[14 Sep 2018 22:36:17.462] Information, exiting onCtrlKeyReleased
[14 Sep 2018 22:36:17.554] Entering ProcessVRXInterpretation
[14 Sep 2018 22:36:17.554] VRX Interpretation: <?xml version="1.0" encoding="utf-8"?> <VRXResultsTop><a>
<callsign>AMF1288</callsign>
<cc_source>VPI_RADAR_CONTROLLER</cc_source>
<com1>
<command>
<commandName>VOICE_REC_EXPECT_RUNWAY</commandName>
<szRunway>30 </szRunway>
</command>
</com1>
</a></VRXResultsTop>
[14 Sep 2018 22:36:17.554] Exiting ReformatIncomingMsg
[14 Sep 2018 22:36:17.554] VRX Best Hypothesis: amflight twelve eighty eight expect runway three zero
[14 Sep 2018 22:36:17.554] Entering ParseVRXInterpretation
[14 Sep 2018 22:36:17.554] Information, beginning parse of approach type speech recognition command
[14 Sep 2018 22:36:17.555] OutgoingVRXResult = AMF1288:826:30
[14 Sep 2018 22:36:17.555] Exiting ParseIncomingMsg
[14 Sep 2018 22:36:17.555] Exiting ProcessVRXInterpretation
[14 Sep 2018 22:36:18.513] Information, processing incoming tts request from AMF1288
[14 Sep 2018 22:36:18.513] Information, adding item to the ttsQueue: Pilot object from AMF1288 msgIndex: 38 voiceIndex: 5 freqIndex: 0
[14 Sep 2018 22:36:18.514] Information, sending tts queue item to SayAsSent: Pilot object from AMF1288 msgIndex: 38 voiceIndex: 5 freqIndex: 0
[14 Sep 2018 22:36:18.514] Information, building pilot tts for AMF1288
[14 Sep 2018 22:36:18.514] Information, sending GenerateWAVfile to ttsProcessor: Pilot object from AMF1288 msgIndex: 38 voiceIndex: 5 freqIndex: 0
[14 Sep 2018 22:36:18.514] Entering GenerateWAVfile
[14 Sep 2018 22:36:18.514] VoiceNumber = 2  Name: William
[14 Sep 2018 22:36:18.514] ReadbackIndex = 38  VoiceNumber = 2  Readback: <prosody rate="150%">expect runway three zero amflight twelve eighty eight</prosody>
[14 Sep 2018 22:36:18.516] Channel pointer = 1   Voice No. = 2 Voice Name = William
[14 Sep 2018 22:36:18.617] ReadbackWAVfile = C:\ProgramData\Flag Mountain\ATCpro\Speech\Voices\OutputWAVfile0038.WAV
[14 Sep 2018 22:36:18.617] Exiting GenerateWAVfile
[14 Sep 2018 22:36:18.626] Information, ttsProcessor playback started event received, msgIndex: 38
[14 Sep 2018 22:36:21.419] Information, ttsProcessor playback completed event received, msgIndex: 38
[14 Sep 2018 22:36:21.428] Information, processing commands from object: Pilot object from AMF1288 msgIndex: 38 voiceIndex: 5 freqIndex: 0
[14 Sep 2018 22:36:21.428] Information, removing object from the ttsQueue: Pilot object from AMF1288 msgIndex: 38 voiceIndex: 5 freqIndex: 0
[14 Sep 2018 22:36:35.580] Information, current local time 10:09 (4929)
[14 Sep 2018 22:36:35.626] Information, adding flight to active list (13): SWA1686voice: 21plan: KOAK to KABQ inbound IFR
[14 Sep 2018 22:36:35.627] Information, adding flight to active list (14): N358LZvoice: 22plan: MMPE to E80 inbound IFR
[14 Sep 2018 22:36:35.628] Information, removing active flight (15): N358LZ
[14 Sep 2018 22:36:35.628] Information, loading commercial flights at 4929 local
[14 Sep 2018 22:36:38.516] Information, processing incoming tts request from C16
[14 Sep 2018 22:36:38.516] Information, adding item to the ttsQueue: Controller object from C16 msgIndex: 39 voiceIndex: 0 freqIndex: 3
[14 Sep 2018 22:36:38.516] Information, sending tts queue item to SayAsSent: Controller object from C16 msgIndex: 39 voiceIndex: 0 freqIndex: 3
[14 Sep 2018 22:36:38.517] Information, sending GenerateWAVfile to ttsProcessor: Controller object from C16 msgIndex: 39 voiceIndex: 0 freqIndex: 3
[14 Sep 2018 22:36:45.514] Information, ttsProcessor playback completed event received, msgIndex: 39
[14 Sep 2018 22:36:45.514] Information, processing commands from object: Controller object from C16 msgIndex: 39 voiceIndex: 0 freqIndex: 3
[14 Sep 2018 22:36:45.514] Information, removing object from the ttsQueue: Controller object from C16 msgIndex: 39 voiceIndex: 0 freqIndex: 3
[14 Sep 2018 22:36:46.513] Information, processing incoming tts request from SWA2202
[14 Sep 2018 22:36:46.513] Information, adding item to the ttsQueue: Pilot object from SWA2202 msgIndex: 40 voiceIndex: 13 freqIndex: 3
[14 Sep 2018 22:36:46.513] Information, sending tts queue item to SayAsSent: Pilot object from SWA2202 msgIndex: 40 voiceIndex: 13 freqIndex: 3
[14 Sep 2018 22:36:46.513] Information, building pilot tts for SWA2202
[14 Sep 2018 22:36:46.514] Information, sending GenerateWAVfile to ttsProcessor: Pilot object from SWA2202 msgIndex: 40 voiceIndex: 13 freqIndex: 3
[14 Sep 2018 22:36:53.516] Information, ttsProcessor playback completed event received, msgIndex: 40
[14 Sep 2018 22:36:53.516] Information, processing commands from object: Pilot object from SWA2202 msgIndex: 40 voiceIndex: 13 freqIndex: 3
[14 Sep 2018 22:36:53.516] Information, removing object from the ttsQueue: Pilot object from SWA2202 msgIndex: 40 voiceIndex: 13 freqIndex: 3
[14 Sep 2018 22:37:10.515] Information, processing incoming tts request from C17
[14 Sep 2018 22:37:10.515] Information, adding item to the ttsQueue: Controller object from C17 msgIndex: 41 voiceIndex: 0 freqIndex: 4
[14 Sep 2018 22:37:10.515] Information, sending tts queue item to SayAsSent: Controller object from C17 msgIndex: 41 voiceIndex: 0 freqIndex: 4
[14 Sep 2018 22:37:10.515] Information, sending GenerateWAVfile to ttsProcessor: Controller object from C17 msgIndex: 41 voiceIndex: 0 freqIndex: 4
[14 Sep 2018 22:37:13.514] Information, ttsProcessor playback completed event received, msgIndex: 41
[14 Sep 2018 22:37:13.514] Information, processing commands from object: Controller object from C17 msgIndex: 41 voiceIndex: 0 freqIndex: 4
[14 Sep 2018 22:37:13.514] Information, removing object from the ttsQueue: Controller object from C17 msgIndex: 41 voiceIndex: 0 freqIndex: 4
[14 Sep 2018 22:37:14.513] Information, processing incoming tts request from AMF1351
[14 Sep 2018 22:37:14.513] Information, adding item to the ttsQueue: Pilot object from AMF1351 msgIndex: 42 voiceIndex: 4 freqIndex: 4
[14 Sep 2018 22:37:14.514] Information, sending tts queue item to SayAsSent: Pilot object from AMF1351 msgIndex: 42 voiceIndex: 4 freqIndex: 4
[14 Sep 2018 22:37:14.514] Information, building pilot tts for AMF1351
[14 Sep 2018 22:37:14.514] Information, sending GenerateWAVfile to ttsProcessor: Pilot object from AMF1351 msgIndex: 42 voiceIndex: 4 freqIndex: 4
[14 Sep 2018 22:37:17.513] Information, ttsProcessor playback completed event received, msgIndex: 42
[14 Sep 2018 22:37:17.513] Information, processing commands from object: Pilot object from AMF1351 msgIndex: 42 voiceIndex: 4 freqIndex: 4
[14 Sep 2018 22:37:17.513] Information, removing object from the ttsQueue: Pilot object from AMF1351 msgIndex: 42 voiceIndex: 4 freqIndex: 4
[14 Sep 2018 22:37:18.513] Information, processing incoming tts request from AMF1351
[14 Sep 2018 22:37:18.513] Information, adding item to the ttsQueue: Pilot object from AMF1351 msgIndex: 43 voiceIndex: 4 freqIndex: 0
[14 Sep 2018 22:37:18.514] Information, sending tts queue item to SayAsSent: Pilot object from AMF1351 msgIndex: 43 voiceIndex: 4 freqIndex: 0
[14 Sep 2018 22:37:18.514] Information, building pilot tts for AMF1351
[14 Sep 2018 22:37:18.514] Information, sending GenerateWAVfile to ttsProcessor: Pilot object from AMF1351 msgIndex: 43 voiceIndex: 4 freqIndex: 0
[14 Sep 2018 22:37:18.514] Entering GenerateWAVfile
[14 Sep 2018 22:37:18.514] VoiceNumber = 1  Name: Nathan
[14 Sep 2018 22:37:18.514] ReadbackIndex = 43  VoiceNumber = 1  Readback: <prosody rate="150%">albuquerque approach amflight thirteen fifty one  is with you level at one three thousand </prosody>
[14 Sep 2018 22:37:18.516] Channel pointer = 1   Voice No. = 1 Voice Name = Nathan
[14 Sep 2018 22:37:18.666] ReadbackWAVfile = C:\ProgramData\Flag Mountain\ATCpro\Speech\Voices\OutputWAVfile0043.WAV
[14 Sep 2018 22:37:18.666] Exiting GenerateWAVfile
[14 Sep 2018 22:37:18.675] Information, ttsProcessor playback started event received, msgIndex: 43
[14 Sep 2018 22:37:22.168] Information, ttsProcessor playback completed event received, msgIndex: 43
[14 Sep 2018 22:37:22.178] Information, processing commands from object: Pilot object from AMF1351 msgIndex: 43 voiceIndex: 4 freqIndex: 0
[14 Sep 2018 22:37:22.178] Information, removing object from the ttsQueue: Pilot object from AMF1351 msgIndex: 43 voiceIndex: 4 freqIndex: 0
[14 Sep 2018 22:37:25.514] Information, processing incoming tts request from N960JM
[14 Sep 2018 22:37:25.514] Information, no tts required, passing on commands to appropriate receiver
[14 Sep 2018 22:37:27.514] Information, processing incoming tts request from VFR
[14 Sep 2018 22:37:27.514] Warning, (IncomingATCTTS) Unable to find etvsFrequencyInformation for freqIndex: 000.0
[14 Sep 2018 22:37:35.576] Information, current local time 10:10 (4930)
[14 Sep 2018 22:37:35.576] Information, calling writeDynamic_RadarAircrafts
[14 Sep 2018 22:37:35.583] Entering LoadDynRadarAircrafts.  RecognitionInProcess = False  AircraftUpdatePending = False
[14 Sep 2018 22:37:35.583] Entering UpdateDynRadarAircrafts
[14 Sep 2018 22:37:35.610] UpdateDynRadarAircrafts Complete.
[14 Sep 2018 22:37:35.610] Exiting LoadDynRadarAircrafts.  RecognitionInProcess = False  AircraftUpdatePending = False
[14 Sep 2018 22:37:35.661] Information, loading commercial flights at 4930 local
[14 Sep 2018 22:38:31.513] Information, processing incoming tts request from C17
[14 Sep 2018 22:38:31.513] Information, adding item to the ttsQueue: Controller object from C17 msgIndex: 44 voiceIndex: 0 freqIndex: 4
[14 Sep 2018 22:38:31.513] Information, sending tts queue item to SayAsSent: Controller object from C17 msgIndex: 44 voiceIndex: 0 freqIndex: 4
[14 Sep 2018 22:38:31.513] Information, sending GenerateWAVfile to ttsProcessor: Controller object from C17 msgIndex: 44 voiceIndex: 0 freqIndex: 4
[14 Sep 2018 22:38:35.566] Information, current local time 10:11 (4931)
[14 Sep 2018 22:38:35.627] Information, ttsProcessor playback completed event received, msgIndex: 44
[14 Sep 2018 22:38:35.627] Information, processing commands from object: Controller object from C17 msgIndex: 44 voiceIndex: 0 freqIndex: 4
[14 Sep 2018 22:38:35.627] Information, removing object from the ttsQueue: Controller object from C17 msgIndex: 44 voiceIndex: 0 freqIndex: 4
[14 Sep 2018 22:38:35.627] Information, loading commercial flights at 4931 local
[14 Sep 2018 22:38:36.513] Information, processing incoming tts request from N549ZR
[14 Sep 2018 22:38:36.513] Information, adding item to the ttsQueue: Pilot object from N549ZR msgIndex: 45 voiceIndex: 17 freqIndex: 4
[14 Sep 2018 22:38:36.513] Information, sending tts queue item to SayAsSent: Pilot object from N549ZR msgIndex: 45 voiceIndex: 17 freqIndex: 4
[14 Sep 2018 22:38:36.513] Information, building pilot tts for N549ZR
[14 Sep 2018 22:38:36.514] Information, sending GenerateWAVfile to ttsProcessor: Pilot object from N549ZR msgIndex: 45 voiceIndex: 17 freqIndex: 4
[14 Sep 2018 22:38:39.514] Information, ttsProcessor playback completed event received, msgIndex: 45
[14 Sep 2018 22:38:39.514] Information, processing commands from object: Pilot object from N549ZR msgIndex: 45 voiceIndex: 17 freqIndex: 4
[14 Sep 2018 22:38:39.514] Information, removing object from the ttsQueue: Pilot object from N549ZR msgIndex: 45 voiceIndex: 17 freqIndex: 4
[14 Sep 2018 22:39:16.514] Information, processing incoming tts request from C17
[14 Sep 2018 22:39:16.514] Information, adding item to the ttsQueue: Controller object from C17 msgIndex: 46 voiceIndex: 0 freqIndex: 4
[14 Sep 2018 22:39:16.514] Information, sending tts queue item to SayAsSent: Controller object from C17 msgIndex: 46 voiceIndex: 0 freqIndex: 4
[14 Sep 2018 22:39:16.514] Information, sending GenerateWAVfile to ttsProcessor: Controller object from C17 msgIndex: 46 voiceIndex: 0 freqIndex: 4
[14 Sep 2018 22:39:20.515] Information, ttsProcessor playback completed event received, msgIndex: 46
[14 Sep 2018 22:39:20.515] Information, processing commands from object: Controller object from C17 msgIndex: 46 voiceIndex: 0 freqIndex: 4
[14 Sep 2018 22:39:20.515] Information, removing object from the ttsQueue: Controller object from C17 msgIndex: 46 voiceIndex: 0 freqIndex: 4
[14 Sep 2018 22:39:21.515] Information, processing incoming tts request from N549ZR
[14 Sep 2018 22:39:21.515] Information, adding item to the ttsQueue: Pilot object from N549ZR msgIndex: 47 voiceIndex: 17 freqIndex: 4
[14 Sep 2018 22:39:21.516] Information, sending tts queue item to SayAsSent: Pilot object from N549ZR msgIndex: 47 voiceIndex: 17 freqIndex: 4
[14 Sep 2018 22:39:21.516] Information, building pilot tts for N549ZR
[14 Sep 2018 22:39:21.516] Information, sending GenerateWAVfile to ttsProcessor: Pilot object from N549ZR msgIndex: 47 voiceIndex: 17 freqIndex: 4
[14 Sep 2018 22:39:25.515] Information, ttsProcessor playback completed event received, msgIndex: 47
[14 Sep 2018 22:39:25.515] Information, processing commands from object: Pilot object from N549ZR msgIndex: 47 voiceIndex: 17 freqIndex: 4
[14 Sep 2018 22:39:25.515] Information, removing object from the ttsQueue: Pilot object from N549ZR msgIndex: 47 voiceIndex: 17 freqIndex: 4
[14 Sep 2018 22:39:33.514] Information, processing incoming tts request from C16
[14 Sep 2018 22:39:33.514] Information, adding item to the ttsQueue: Controller object from C16 msgIndex: 48 voiceIndex: 0 freqIndex: 3
[14 Sep 2018 22:39:33.514] Information, sending tts queue item to SayAsSent: Controller object from C16 msgIndex: 48 voiceIndex: 0 freqIndex: 3
[14 Sep 2018 22:39:33.514] Information, sending GenerateWAVfile to ttsProcessor: Controller object from C16 msgIndex: 48 voiceIndex: 0 freqIndex: 3
[14 Sep 2018 22:39:35.577] Information, current local time 10:12 (4932)
[14 Sep 2018 22:39:35.627] Information, loading commercial flights at 4932 local
[14 Sep 2018 22:39:36.514] Information, ttsProcessor playback completed event received, msgIndex: 48
[14 Sep 2018 22:39:36.514] Information, processing commands from object: Controller object from C16 msgIndex: 48 voiceIndex: 0 freqIndex: 3
[14 Sep 2018 22:39:36.514] Information, removing object from the ttsQueue: Controller object from C16 msgIndex: 48 voiceIndex: 0 freqIndex: 3
[14 Sep 2018 22:39:37.512] Information, adding flight to active list (14): SWA391voice: 23plan: KLAS to KABQ inbound IFR
[14 Sep 2018 22:39:37.513] Information, processing incoming tts request from SWA4
[14 Sep 2018 22:39:37.513] Information, adding item to the ttsQueue: Pilot object from SWA4 msgIndex: 49 voiceIndex: 18 freqIndex: 3
[14 Sep 2018 22:39:37.513] Information, sending tts queue item to SayAsSent: Pilot object from SWA4 msgIndex: 49 voiceIndex: 18 freqIndex: 3
[14 Sep 2018 22:39:37.513] Information, building pilot tts for SWA4
[14 Sep 2018 22:39:37.513] Information, sending GenerateWAVfile to ttsProcessor: Pilot object from SWA4 msgIndex: 49 voiceIndex: 18 freqIndex: 3
[14 Sep 2018 22:39:40.513] Information, ttsProcessor playback completed event received, msgIndex: 49
[14 Sep 2018 22:39:40.513] Information, processing commands from object: Pilot object from SWA4 msgIndex: 49 voiceIndex: 18 freqIndex: 3
[14 Sep 2018 22:39:40.513] Information, removing object from the ttsQueue: Pilot object from SWA4 msgIndex: 49 voiceIndex: 18 freqIndex: 3
[14 Sep 2018 22:40:29.625] Information, microphone count = 6
[14 Sep 2018 22:40:29.625] Information, user has pressed CtrlKey mic switch
[14 Sep 2018 22:40:29.634] StartRecording message received
[14 Sep 2018 22:40:29.634] waveIn is null
[14 Sep 2018 22:40:29.634] Calling vrxLiveRecognizer.  RecognizerHandle = 152822016
[14 Sep 2018 22:40:29.635] Entering StartRecording
[14 Sep 2018 22:40:29.642] Exiting StartRecording
[14 Sep 2018 22:40:29.642] After call to vrxLiveRecognizerStart.  errorCode = 0
[14 Sep 2018 22:40:29.642] Information, received recording started event from SRProcessor
[14 Sep 2018 22:40:29.642] Exiting StartStopRecognition
[14 Sep 2018 22:40:32.608] Information, entering onCtrlKeyReleased
[14 Sep 2018 22:40:32.608] Information, onCtrlKeyReleased tcwWindow isVisible
[14 Sep 2018 22:40:32.608] Information, onCtrlKeyReleased _srAvailable is TRUE
[14 Sep 2018 22:40:32.608] Information, user has released CtrlKey mic switch
[14 Sep 2018 22:40:32.618] StopRecording message received
[14 Sep 2018 22:40:32.618] Entering StopRecording
[14 Sep 2018 22:40:32.619] Exiting StopRecording
[14 Sep 2018 22:40:32.619] Information, received recording stopped event from SRProcessor
[14 Sep 2018 22:40:32.619] Exiting StartStopRecognition
[14 Sep 2018 22:40:32.619] Information, exiting onCtrlKeyReleased
[14 Sep 2018 22:40:32.721] Entering ProcessVRXInterpretation
[14 Sep 2018 22:40:32.721] VRX Interpretation: <?xml version="1.0" encoding="utf-8"?> <VRXResultsTop><a>
<callsign>AMF1288</callsign>
<cc_source>VPI_RADAR_CONTROLLER</cc_source>
<com1>
<command>
<commandName>VOICE_REC_HEADING</commandName>
<enHeadingType>HEADING_TYPE_ABSOLUTE</enHeadingType>
<lHeading>250</lHeading>
<enDirection>DIRECTION_LEFT</enDirection>
<enHeadingInstruction>HDG_TURN</enHeadingInstruction>
</command>
</com1>
</a></VRXResultsTop>
[14 Sep 2018 22:40:32.721] Exiting ReformatIncomingMsg
[14 Sep 2018 22:40:32.721] VRX Best Hypothesis: amflight twelve eighty eight turn left heading two five zero
[14 Sep 2018 22:40:32.721] Entering ParseVRXInterpretation
[14 Sep 2018 22:40:32.728] Information, beginning parse of heading type speech recognition command
[14 Sep 2018 22:40:32.729] OutgoingVRXResult = AMF1288:120:250
[14 Sep 2018 22:40:32.729] Exiting ParseIncomingMsg
[14 Sep 2018 22:40:32.729] Exiting ProcessVRXInterpretation
[14 Sep 2018 22:40:33.512] Information, processing incoming tts request from AMF1288
[14 Sep 2018 22:40:33.512] Information, adding item to the ttsQueue: Pilot object from AMF1288 msgIndex: 50 voiceIndex: 5 freqIndex: 0
[14 Sep 2018 22:40:33.514] Information, sending tts queue item to SayAsSent: Pilot object from AMF1288 msgIndex: 50 voiceIndex: 5 freqIndex: 0
[14 Sep 2018 22:40:33.514] Information, building pilot tts for AMF1288
[14 Sep 2018 22:40:33.514] Information, sending GenerateWAVfile to ttsProcessor: Pilot object from AMF1288 msgIndex: 50 voiceIndex: 5 freqIndex: 0
[14 Sep 2018 22:40:33.514] Entering GenerateWAVfile
[14 Sep 2018 22:40:33.514] VoiceNumber = 2  Name: William
[14 Sep 2018 22:40:33.514] ReadbackIndex = 50  VoiceNumber = 2  Readback: <prosody rate="150%">heading two five zero  amflight twelve eighty eight</prosody>
[14 Sep 2018 22:40:33.516] Channel pointer = 1   Voice No. = 2 Voice Name = William
[14 Sep 2018 22:40:33.598] ReadbackWAVfile = C:\ProgramData\Flag Mountain\ATCpro\Speech\Voices\OutputWAVfile0050.WAV
[14 Sep 2018 22:40:33.598] Exiting GenerateWAVfile
[14 Sep 2018 22:40:33.606] Information, ttsProcessor playback started event received, msgIndex: 50
[14 Sep 2018 22:40:35.582] Information, current local time 10:13 (4933)
[14 Sep 2018 22:40:35.642] Information, adding flight to active list (15): GJS3699voice: 24plan: KABQ to KDEN outbound IFR
[14 Sep 2018 22:40:35.644] Information, loading commercial flights at 4933 local
[14 Sep 2018 22:40:36.118] Information, ttsProcessor playback completed event received, msgIndex: 50
[14 Sep 2018 22:40:36.131] Information, processing commands from object: Pilot object from AMF1288 msgIndex: 50 voiceIndex: 5 freqIndex: 0
[14 Sep 2018 22:40:36.131] Information, removing object from the ttsQueue: Pilot object from AMF1288 msgIndex: 50 voiceIndex: 5 freqIndex: 0
[14 Sep 2018 22:40:39.514] Information, processing incoming tts request from GJS3699
[14 Sep 2018 22:40:39.514] Information, adding item to the ttsQueue: Pilot object from GJS3699 msgIndex: 51 voiceIndex: 24 freqIndex: 2
[14 Sep 2018 22:40:39.514] Information, sending tts queue item to SayAsSent: Pilot object from GJS3699 msgIndex: 51 voiceIndex: 24 freqIndex: 2
[14 Sep 2018 22:40:39.514] Information, building pilot tts for GJS3699
[14 Sep 2018 22:40:39.514] Information, sending GenerateWAVfile to ttsProcessor: Pilot object from GJS3699 msgIndex: 51 voiceIndex: 24 freqIndex: 2
[14 Sep 2018 22:40:44.515] Information, ttsProcessor playback completed event received, msgIndex: 51
[14 Sep 2018 22:40:44.515] Information, processing commands from object: Pilot object from GJS3699 msgIndex: 51 voiceIndex: 24 freqIndex: 2
[14 Sep 2018 22:40:44.515] Information, removing object from the ttsQueue: Pilot object from GJS3699 msgIndex: 51 voiceIndex: 24 freqIndex: 2
[14 Sep 2018 22:40:45.514] Information, processing incoming tts request from 1T
[14 Sep 2018 22:40:45.514] Information, adding item to the ttsQueue: Controller object from 1T msgIndex: 52 voiceIndex: 0 freqIndex: 2
[14 Sep 2018 22:40:45.514] Information, sending tts queue item to SayAsSent: Controller object from 1T msgIndex: 52 voiceIndex: 0 freqIndex: 2
[14 Sep 2018 22:40:45.514] Information, sending GenerateWAVfile to ttsProcessor: Controller object from 1T msgIndex: 52 voiceIndex: 0 freqIndex: 2
[14 Sep 2018 22:40:50.516] Information, ttsProcessor playback completed event received, msgIndex: 52
[14 Sep 2018 22:40:50.516] Information, processing commands from object: Controller object from 1T msgIndex: 52 voiceIndex: 0 freqIndex: 2
[14 Sep 2018 22:40:50.516] Information, removing object from the ttsQueue: Controller object from 1T msgIndex: 52 voiceIndex: 0 freqIndex: 2
[14 Sep 2018 22:40:51.514] Information, processing incoming tts request from GJS3699
[14 Sep 2018 22:40:51.514] Information, adding item to the ttsQueue: Pilot object from GJS3699 msgIndex: 53 voiceIndex: 24 freqIndex: 2
[14 Sep 2018 22:40:51.518] Information, sending tts queue item to SayAsSent: Pilot object from GJS3699 msgIndex: 53 voiceIndex: 24 freqIndex: 2
[14 Sep 2018 22:40:51.518] Information, building pilot tts for GJS3699
[14 Sep 2018 22:40:51.518] Information, sending GenerateWAVfile to ttsProcessor: Pilot object from GJS3699 msgIndex: 53 voiceIndex: 24 freqIndex: 2
[14 Sep 2018 22:40:52.364] Information, microphone count = 7
[14 Sep 2018 22:40:52.364] Information, user has pressed CtrlKey mic switch
[14 Sep 2018 22:40:52.374] StartRecording message received
[14 Sep 2018 22:40:52.374] waveIn is null
[14 Sep 2018 22:40:52.374] Calling vrxLiveRecognizer.  RecognizerHandle = 152822016
[14 Sep 2018 22:40:52.374] Entering StartRecording
[14 Sep 2018 22:40:52.381] Exiting StartRecording
[14 Sep 2018 22:40:52.381] After call to vrxLiveRecognizerStart.  errorCode = 0
[14 Sep 2018 22:40:52.381] Information, received recording started event from SRProcessor
[14 Sep 2018 22:40:52.381] Exiting StartStopRecognition
[14 Sep 2018 22:40:55.514] Information, ttsProcessor playback completed event received, msgIndex: 53
[14 Sep 2018 22:40:55.514] Information, processing commands from object: Pilot object from GJS3699 msgIndex: 53 voiceIndex: 24 freqIndex: 2
[14 Sep 2018 22:40:55.514] Information, removing object from the ttsQueue: Pilot object from GJS3699 msgIndex: 53 voiceIndex: 24 freqIndex: 2
[14 Sep 2018 22:40:56.560] Information, entering onCtrlKeyReleased
[14 Sep 2018 22:40:56.560] Information, onCtrlKeyReleased tcwWindow isVisible
[14 Sep 2018 22:40:56.560] Information, onCtrlKeyReleased _srAvailable is TRUE
[14 Sep 2018 22:40:56.560] Information, user has released CtrlKey mic switch
[14 Sep 2018 22:40:56.569] StopRecording message received
[14 Sep 2018 22:40:56.569] Entering StopRecording
[14 Sep 2018 22:40:56.572] Exiting StopRecording
[14 Sep 2018 22:40:56.572] Information, received recording stopped event from SRProcessor
[14 Sep 2018 22:40:56.572] Exiting StartStopRecognition
[14 Sep 2018 22:40:56.572] Information, exiting onCtrlKeyReleased
[14 Sep 2018 22:40:56.672] Entering ProcessVRXInterpretation
[14 Sep 2018 22:40:56.672] VRX Interpretation: <?xml version="1.0" encoding="utf-8"?> <VRXResultsTop><a>
<callsign>AMF1351</callsign>
<cc_source>VPI_RADAR_CONTROLLER</cc_source>
<com1>
<command>
<commandName>VOICE_REC_ALTITUDE</commandName>
<lLevel>10000</lLevel>
<szLevel>one zero thousand</szLevel>
<enAchieveCommand>ACHIEVE_CMD_DESCEND</enAchieveCommand>
</command>
</com1>
</a></VRXResultsTop>
[14 Sep 2018 22:40:56.672] Exiting ReformatIncomingMsg
[14 Sep 2018 22:40:56.672] VRX Best Hypothesis: amflight thirteen fifty one descend and maintain one zero thousand
[14 Sep 2018 22:40:56.672] Entering ParseVRXInterpretation
[14 Sep 2018 22:40:56.676] Information, beginning parse of altitude type speech recognition command
[14 Sep 2018 22:40:56.679] OutgoingVRXResult = AMF1351:320:10000
[14 Sep 2018 22:40:56.679] Exiting ParseIncomingMsg
[14 Sep 2018 22:40:56.679] Exiting ProcessVRXInterpretation
[14 Sep 2018 22:40:57.513] Information, processing incoming tts request from AMF1351
[14 Sep 2018 22:40:57.513] Information, adding item to the ttsQueue: Pilot object from AMF1351 msgIndex: 54 voiceIndex: 4 freqIndex: 0
[14 Sep 2018 22:40:57.514] Information, sending tts queue item to SayAsSent: Pilot object from AMF1351 msgIndex: 54 voiceIndex: 4 freqIndex: 0
[14 Sep 2018 22:40:57.514] Information, building pilot tts for AMF1351
[14 Sep 2018 22:40:57.514] Information, sending GenerateWAVfile to ttsProcessor: Pilot object from AMF1351 msgIndex: 54 voiceIndex: 4 freqIndex: 0
[14 Sep 2018 22:40:57.514] Entering GenerateWAVfile
[14 Sep 2018 22:40:57.514] VoiceNumber = 1  Name: Nathan
[14 Sep 2018 22:40:57.514] ReadbackIndex = 54  VoiceNumber = 1  Readback: <prosody rate="150%">descending to one zero thousand  amflight thirteen fifty one</prosody>
[14 Sep 2018 22:40:57.516] Channel pointer = 1   Voice No. = 1 Voice Name = Nathan
[14 Sep 2018 22:40:57.639] ReadbackWAVfile = C:\ProgramData\Flag Mountain\ATCpro\Speech\Voices\OutputWAVfile0054.WAV
[14 Sep 2018 22:40:57.639] Exiting GenerateWAVfile
[14 Sep 2018 22:40:57.648] Information, ttsProcessor playback started event received, msgIndex: 54
[14 Sep 2018 22:41:00.418] Information, ttsProcessor playback completed event received, msgIndex: 54
[14 Sep 2018 22:41:00.428] Information, processing commands from object: Pilot object from AMF1351 msgIndex: 54 voiceIndex: 4 freqIndex: 0
[14 Sep 2018 22:41:00.428] Information, removing object from the ttsQueue: Pilot object from AMF1351 msgIndex: 54 voiceIndex: 4 freqIndex: 0
[14 Sep 2018 22:41:04.497] Information, microphone count = 8
[14 Sep 2018 22:41:04.497] Information, user has pressed CtrlKey mic switch
[14 Sep 2018 22:41:04.507] StartRecording message received
[14 Sep 2018 22:41:04.507] waveIn is null
[14 Sep 2018 22:41:04.507] Calling vrxLiveRecognizer.  RecognizerHandle = 152822016
[14 Sep 2018 22:41:04.507] Entering StartRecording
[14 Sep 2018 22:41:04.514] Exiting StartRecording
[14 Sep 2018 22:41:04.514] After call to vrxLiveRecognizerStart.  errorCode = 0
[14 Sep 2018 22:41:04.514] Information, received recording started event from SRProcessor
[14 Sep 2018 22:41:04.514] Exiting StartStopRecognition
[14 Sep 2018 22:41:09.017] Information, entering onCtrlKeyReleased
[14 Sep 2018 22:41:09.017] Information, onCtrlKeyReleased tcwWindow isVisible
[14 Sep 2018 22:41:09.017] Information, onCtrlKeyReleased _srAvailable is TRUE
[14 Sep 2018 22:41:09.017] Information, user has released CtrlKey mic switch
[14 Sep 2018 22:41:09.026] StopRecording message received
[14 Sep 2018 22:41:09.026] Entering StopRecording
[14 Sep 2018 22:41:09.027] Exiting StopRecording
[14 Sep 2018 22:41:09.027] Information, received recording stopped event from SRProcessor
[14 Sep 2018 22:41:09.027] Exiting StartStopRecognition
[14 Sep 2018 22:41:09.027] Information, exiting onCtrlKeyReleased
[14 Sep 2018 22:41:09.133] Entering ProcessVRXInterpretation
[14 Sep 2018 22:41:09.133] VRX Interpretation: <?xml version="1.0" encoding="utf-8"?> <VRXResultsTop><a>
<callsign>AMF1288</callsign>
<cc_source>VPI_RADAR_CONTROLLER</cc_source>
<com1>
<command>
<commandName>VOICE_REC_EXPECT_RUNWAY</commandName>
<szRunway>26 </szRunway>
</command>
</com1>
</a></VRXResultsTop>
[14 Sep 2018 22:41:09.133] Exiting ReformatIncomingMsg
[14 Sep 2018 22:41:09.133] VRX Best Hypothesis: amflight twelve eighty eight expect runway two six
[14 Sep 2018 22:41:09.133] Entering ParseVRXInterpretation
[14 Sep 2018 22:41:09.133] Information, beginning parse of approach type speech recognition command
[14 Sep 2018 22:41:09.133] OutgoingVRXResult = AMF1288:826:26
[14 Sep 2018 22:41:09.133] Exiting ParseIncomingMsg
[14 Sep 2018 22:41:09.133] Exiting ProcessVRXInterpretation
[14 Sep 2018 22:41:09.514] Information, processing incoming tts request from AMF1288
[14 Sep 2018 22:41:09.514] Information, adding item to the ttsQueue: Pilot object from AMF1288 msgIndex: 55 voiceIndex: 5 freqIndex: 0
[14 Sep 2018 22:41:09.515] Information, sending tts queue item to SayAsSent: Pilot object from AMF1288 msgIndex: 55 voiceIndex: 5 freqIndex: 0
[14 Sep 2018 22:41:09.515] Information, building pilot tts for AMF1288
[14 Sep 2018 22:41:09.515] Information, sending GenerateWAVfile to ttsProcessor: Pilot object from AMF1288 msgIndex: 55 voiceIndex: 5 freqIndex: 0
[14 Sep 2018 22:41:09.515] Entering GenerateWAVfile
[14 Sep 2018 22:41:09.515] VoiceNumber = 2  Name: William
[14 Sep 2018 22:41:09.515] ReadbackIndex = 55  VoiceNumber = 2  Readback: <prosody rate="150%">expect runway two six amflight twelve eighty eight</prosody>
[14 Sep 2018 22:41:09.517] Channel pointer = 1   Voice No. = 2 Voice Name = William
[14 Sep 2018 22:41:09.623] ReadbackWAVfile = C:\ProgramData\Flag Mountain\ATCpro\Speech\Voices\OutputWAVfile0055.WAV
[14 Sep 2018 22:41:09.623] Exiting GenerateWAVfile
[14 Sep 2018 22:41:09.632] Information, ttsProcessor playback started event received, msgIndex: 55
[14 Sep 2018 22:41:12.418] Information, ttsProcessor playback completed event received, msgIndex: 55
[14 Sep 2018 22:41:12.428] Information, processing commands from object: Pilot object from AMF1288 msgIndex: 55 voiceIndex: 5 freqIndex: 0
[14 Sep 2018 22:41:12.428] Information, removing object from the ttsQueue: Pilot object from AMF1288 msgIndex: 55 voiceIndex: 5 freqIndex: 0
[14 Sep 2018 22:41:12.781] Information, microphone count = 9
[14 Sep 2018 22:41:12.781] Information, user has pressed CtrlKey mic switch
[14 Sep 2018 22:41:12.790] StartRecording message received
[14 Sep 2018 22:41:12.790] waveIn is null
[14 Sep 2018 22:41:12.790] Calling vrxLiveRecognizer.  RecognizerHandle = 152822016
[14 Sep 2018 22:41:12.791] Entering StartRecording
[14 Sep 2018 22:41:12.798] Exiting StartRecording
[14 Sep 2018 22:41:12.798] After call to vrxLiveRecognizerStart.  errorCode = 0
[14 Sep 2018 22:41:12.798] Information, received recording started event from SRProcessor
[14 Sep 2018 22:41:12.798] Exiting StartStopRecognition
[14 Sep 2018 22:41:16.092] Information, entering onCtrlKeyReleased
[14 Sep 2018 22:41:16.092] Information, onCtrlKeyReleased tcwWindow isVisible
[14 Sep 2018 22:41:16.092] Information, onCtrlKeyReleased _srAvailable is TRUE
[14 Sep 2018 22:41:16.092] Information, user has released CtrlKey mic switch
[14 Sep 2018 22:41:16.102] StopRecording message received
[14 Sep 2018 22:41:16.102] Entering StopRecording
[14 Sep 2018 22:41:16.103] Exiting StopRecording
[14 Sep 2018 22:41:16.103] Information, received recording stopped event from SRProcessor
[14 Sep 2018 22:41:16.103] Exiting StartStopRecognition
[14 Sep 2018 22:41:16.103] Information, exiting onCtrlKeyReleased
[14 Sep 2018 22:41:16.205] Entering ProcessVRXInterpretation
[14 Sep 2018 22:41:16.205] VRX Interpretation: <?xml version="1.0" encoding="utf-8"?> <VRXResultsTop><a>
<callsign>AMF1351</callsign>
<cc_source>VPI_RADAR_CONTROLLER</cc_source>
<com1>
<command>
<commandName>VOICE_REC_EXPECT_RUNWAY</commandName>
<szRunway>36 </szRunway>
</command>
</com1>
</a></VRXResultsTop>
[14 Sep 2018 22:41:16.205] Exiting ReformatIncomingMsg
[14 Sep 2018 22:41:16.205] VRX Best Hypothesis: amflight thirteen fifty one expect runway three six
[14 Sep 2018 22:41:16.205] Entering ParseVRXInterpretation
[14 Sep 2018 22:41:16.205] Information, beginning parse of approach type speech recognition command
[14 Sep 2018 22:41:16.205] OutgoingVRXResult = AMF1351:826:36
[14 Sep 2018 22:41:16.205] Exiting ParseIncomingMsg
[14 Sep 2018 22:41:16.205] Exiting ProcessVRXInterpretation
[14 Sep 2018 22:41:16.514] Information, processing incoming tts request from AMF1351
[14 Sep 2018 22:41:16.514] Information, adding item to the ttsQueue: Pilot object from AMF1351 msgIndex: 56 voiceIndex: 4 freqIndex: 0
[14 Sep 2018 22:41:16.515] Information, sending tts queue item to SayAsSent: Pilot object from AMF1351 msgIndex: 56 voiceIndex: 4 freqIndex: 0
[14 Sep 2018 22:41:16.515] Information, building pilot tts for AMF1351
[14 Sep 2018 22:41:16.515] Information, sending GenerateWAVfile to ttsProcessor: Pilot object from AMF1351 msgIndex: 56 voiceIndex: 4 freqIndex: 0
[14 Sep 2018 22:41:16.515] Entering GenerateWAVfile
[14 Sep 2018 22:41:16.515] VoiceNumber = 1  Name: Nathan
[14 Sep 2018 22:41:16.515] ReadbackIndex = 56  VoiceNumber = 1  Readback: <prosody rate="150%">say again for amflight thirteen fifty one</prosody>
[14 Sep 2018 22:41:16.516] Channel pointer = 1   Voice No. = 1 Voice Name = Nathan
[14 Sep 2018 22:41:16.581] ReadbackWAVfile = C:\ProgramData\Flag Mountain\ATCpro\Speech\Voices\OutputWAVfile0056.WAV
[14 Sep 2018 22:41:16.581] Exiting GenerateWAVfile
[14 Sep 2018 22:41:16.589] Information, ttsProcessor playback started event received, msgIndex: 56
[14 Sep 2018 22:41:18.718] Information, ttsProcessor playback completed event received, msgIndex: 56
[14 Sep 2018 22:41:18.727] Information, processing commands from object: Pilot object from AMF1351 msgIndex: 56 voiceIndex: 4 freqIndex: 0
[14 Sep 2018 22:41:18.727] Information, removing object from the ttsQueue: Pilot object from AMF1351 msgIndex: 56 voiceIndex: 4 freqIndex: 0
[14 Sep 2018 22:41:19.613] Information, microphone count = 10
[14 Sep 2018 22:41:19.613] Information, user has pressed CtrlKey mic switch
[14 Sep 2018 22:41:19.623] StartRecording message received
[14 Sep 2018 22:41:19.623] waveIn is null
[14 Sep 2018 22:41:19.623] Calling vrxLiveRecognizer.  RecognizerHandle = 152822016
[14 Sep 2018 22:41:19.623] Entering StartRecording
[14 Sep 2018 22:41:19.629] Exiting StartRecording
[14 Sep 2018 22:41:19.629] After call to vrxLiveRecognizerStart.  errorCode = 0
[14 Sep 2018 22:41:19.629] Information, received recording started event from SRProcessor
[14 Sep 2018 22:41:19.629] Exiting StartStopRecognition
[14 Sep 2018 22:41:23.253] Information, entering onCtrlKeyReleased
[14 Sep 2018 22:41:23.253] Information, onCtrlKeyReleased tcwWindow isVisible
[14 Sep 2018 22:41:23.253] Information, onCtrlKeyReleased _srAvailable is TRUE
[14 Sep 2018 22:41:23.253] Information, user has released CtrlKey mic switch
[14 Sep 2018 22:41:23.263] StopRecording message received
[14 Sep 2018 22:41:23.263] Entering StopRecording
[14 Sep 2018 22:41:23.264] Exiting StopRecording
[14 Sep 2018 22:41:23.264] Information, received recording stopped event from SRProcessor
[14 Sep 2018 22:41:23.264] Exiting StartStopRecognition
[14 Sep 2018 22:41:23.264] Information, exiting onCtrlKeyReleased
[14 Sep 2018 22:41:23.460] Entering ProcessVRXInterpretation
[14 Sep 2018 22:41:23.460] VRX Interpretation: <?xml version="1.0" encoding="utf-8"?> <VRXResultsTop><a>
<callsign>AMF1351</callsign>
<cc_source>VPI_RADAR_CONTROLLER</cc_source>
<com1>
<command>
<commandName>VOICE_REC_EXPECT_RUNWAY</commandName>
<szRunway>26 </szRunway>
</command>
</com1>
</a></VRXResultsTop>
[14 Sep 2018 22:41:23.460] Exiting ReformatIncomingMsg
[14 Sep 2018 22:41:23.460] VRX Best Hypothesis: amflight thirteen fifty one expect runway two six
[14 Sep 2018 22:41:23.460] Entering ParseVRXInterpretation
[14 Sep 2018 22:41:23.461] Information, beginning parse of approach type speech recognition command
[14 Sep 2018 22:41:23.461] OutgoingVRXResult = AMF1351:826:26
[14 Sep 2018 22:41:23.461] Exiting ParseIncomingMsg
[14 Sep 2018 22:41:23.461] Exiting ProcessVRXInterpretation
[14 Sep 2018 22:41:23.513] Information, processing incoming tts request from AMF1351
[14 Sep 2018 22:41:23.513] Information, adding item to the ttsQueue: Pilot object from AMF1351 msgIndex: 57 voiceIndex: 4 freqIndex: 0
[14 Sep 2018 22:41:23.519] Information, sending tts queue item to SayAsSent: Pilot object from AMF1351 msgIndex: 57 voiceIndex: 4 freqIndex: 0
[14 Sep 2018 22:41:23.519] Information, building pilot tts for AMF1351
[14 Sep 2018 22:41:23.519] Information, sending GenerateWAVfile to ttsProcessor: Pilot object from AMF1351 msgIndex: 57 voiceIndex: 4 freqIndex: 0
[14 Sep 2018 22:41:23.519] Entering GenerateWAVfile
[14 Sep 2018 22:41:23.519] VoiceNumber = 1  Name: Nathan
[14 Sep 2018 22:41:23.519] ReadbackIndex = 57  VoiceNumber = 1  Readback: <prosody rate="150%">expect runway two six amflight thirteen fifty one</prosody>
[14 Sep 2018 22:41:23.521] Channel pointer = 1   Voice No. = 1 Voice Name = Nathan
[14 Sep 2018 22:41:23.618] ReadbackWAVfile = C:\ProgramData\Flag Mountain\ATCpro\Speech\Voices\OutputWAVfile0057.WAV
[14 Sep 2018 22:41:23.618] Exiting GenerateWAVfile
[14 Sep 2018 22:41:23.627] Information, ttsProcessor playback started event received, msgIndex: 57
[14 Sep 2018 22:41:24.515] Information, processing incoming tts request from C16
[14 Sep 2018 22:41:24.515] Information, adding item to the ttsQueue: Controller object from C16 msgIndex: 58 voiceIndex: 0 freqIndex: 3
[14 Sep 2018 22:41:24.515] Information, sending tts queue item to SayAsSent: Controller object from C16 msgIndex: 58 voiceIndex: 0 freqIndex: 3
[14 Sep 2018 22:41:24.515] Information, sending GenerateWAVfile to ttsProcessor: Controller object from C16 msgIndex: 58 voiceIndex: 0 freqIndex: 3
[14 Sep 2018 22:41:26.217] Information, ttsProcessor playback completed event received, msgIndex: 57
[14 Sep 2018 22:41:26.227] Information, processing commands from object: Pilot object from AMF1351 msgIndex: 57 voiceIndex: 4 freqIndex: 0
[14 Sep 2018 22:41:26.227] Information, removing object from the ttsQueue: Pilot object from AMF1351 msgIndex: 57 voiceIndex: 4 freqIndex: 0
[14 Sep 2018 22:41:28.515] Information, ttsProcessor playback completed event received, msgIndex: 58
[14 Sep 2018 22:41:28.515] Information, processing commands from object: Controller object from C16 msgIndex: 58 voiceIndex: 0 freqIndex: 3
[14 Sep 2018 22:41:28.515] Information, removing object from the ttsQueue: Controller object from C16 msgIndex: 58 voiceIndex: 0 freqIndex: 3
[14 Sep 2018 22:41:29.517] Information, processing incoming tts request from SWA2202
[14 Sep 2018 22:41:29.517] Information, adding item to the ttsQueue: Pilot object from SWA2202 msgIndex: 59 voiceIndex: 13 freqIndex: 3
[14 Sep 2018 22:41:29.517] Information, sending tts queue item to SayAsSent: Pilot object from SWA2202 msgIndex: 59 voiceIndex: 13 freqIndex: 3
[14 Sep 2018 22:41:29.517] Information, building pilot tts for SWA2202
[14 Sep 2018 22:41:29.518] Information, sending GenerateWAVfile to ttsProcessor: Pilot object from SWA2202 msgIndex: 59 voiceIndex: 13 freqIndex: 3
[14 Sep 2018 22:41:33.515] Information, ttsProcessor playback completed event received, msgIndex: 59
[14 Sep 2018 22:41:33.515] Information, processing commands from object: Pilot object from SWA2202 msgIndex: 59 voiceIndex: 13 freqIndex: 3
[14 Sep 2018 22:41:33.515] Information, removing object from the ttsQueue: Pilot object from SWA2202 msgIndex: 59 voiceIndex: 13 freqIndex: 3
[14 Sep 2018 22:41:34.515] Information, processing incoming tts request from SWA2202
[14 Sep 2018 22:41:34.515] Information, adding item to the ttsQueue: Pilot object from SWA2202 msgIndex: 60 voiceIndex: 13 freqIndex: 0
[14 Sep 2018 22:41:34.515] Information, sending tts queue item to SayAsSent: Pilot object from SWA2202 msgIndex: 60 voiceIndex: 13 freqIndex: 0
[14 Sep 2018 22:41:34.515] Information, building pilot tts for SWA2202
[14 Sep 2018 22:41:34.515] Information, sending GenerateWAVfile to ttsProcessor: Pilot object from SWA2202 msgIndex: 60 voiceIndex: 13 freqIndex: 0
[14 Sep 2018 22:41:34.515] Entering GenerateWAVfile
[14 Sep 2018 22:41:34.515] VoiceNumber = 1  Name: Nathan
[14 Sep 2018 22:41:34.515] ReadbackIndex = 60  VoiceNumber = 1  Readback: <prosody rate="150%">albuquerque approach southwest twenty two zero two  level at one five thousand two five zero knots assigned</prosody>
[14 Sep 2018 22:41:34.517] Channel pointer = 1   Voice No. = 1 Voice Name = Nathan
[14 Sep 2018 22:41:34.680] ReadbackWAVfile = C:\ProgramData\Flag Mountain\ATCpro\Speech\Voices\OutputWAVfile0060.WAV
[14 Sep 2018 22:41:34.680] Exiting GenerateWAVfile
[14 Sep 2018 22:41:34.692] Information, ttsProcessor playback started event received, msgIndex: 60
[14 Sep 2018 22:41:35.636] Information, current local time 10:14 (4934)
[14 Sep 2018 22:41:35.683] Information, adding flight to active list (16): ASH5642voice: 0plan: KPHX to KABQ inbound IFR
[14 Sep 2018 22:41:35.683] Information, adding flight to active list (17): N328ANvoice: 1plan: KAEG to KAEG pattern VFR
[14 Sep 2018 22:41:35.684] Information, adding flight to active list (18): N991TQvoice: 2plan: KRWL to KAEG inbound IFR
[14 Sep 2018 22:41:35.684] Information, adding flight to active list (19): N193FAvoice: 3plan: K1L1 to KCOM overflight IFR
[14 Sep 2018 22:41:35.686] Information, loading commercial flights at 4934 local
[14 Sep 2018 22:41:37.514] Information, processing incoming tts request from N328AN
[14 Sep 2018 22:41:37.514] Information, adding item to the ttsQueue: Pilot object from N328AN msgIndex: 61 voiceIndex: 1 freqIndex: 6
[14 Sep 2018 22:41:37.515] Information, sending tts queue item to SayAsSent: Pilot object from N328AN msgIndex: 61 voiceIndex: 1 freqIndex: 6
[14 Sep 2018 22:41:37.515] Information, building pilot tts for N328AN
[14 Sep 2018 22:41:37.515] Information, sending GenerateWAVfile to ttsProcessor: Pilot object from N328AN msgIndex: 61 voiceIndex: 1 freqIndex: 6
[14 Sep 2018 22:41:38.997] Information, ttsProcessor playback completed event received, msgIndex: 60
[14 Sep 2018 22:41:39.007] Information, processing commands from object: Pilot object from SWA2202 msgIndex: 60 voiceIndex: 13 freqIndex: 0
[14 Sep 2018 22:41:39.007] Information, removing object from the ttsQueue: Pilot object from SWA2202 msgIndex: 60 voiceIndex: 13 freqIndex: 0
[14 Sep 2018 22:41:39.497] Information, microphone count = 11
[14 Sep 2018 22:41:39.497] Information, user has pressed CtrlKey mic switch
[14 Sep 2018 22:41:39.509] StartRecording message received
[14 Sep 2018 22:41:39.509] waveIn is null
[14 Sep 2018 22:41:39.509] Calling vrxLiveRecognizer.  RecognizerHandle = 152822016
[14 Sep 2018 22:41:39.509] Entering StartRecording
[14 Sep 2018 22:41:39.516] Exiting StartRecording
[14 Sep 2018 22:41:39.516] After call to vrxLiveRecognizerStart.  errorCode = 0
[14 Sep 2018 22:41:39.516] Information, received recording started event from SRProcessor
[14 Sep 2018 22:41:39.516] Exiting StartStopRecognition
[14 Sep 2018 22:41:42.513] Information, ttsProcessor playback completed event received, msgIndex: 61
[14 Sep 2018 22:41:42.514] Information, processing commands from object: Pilot object from N328AN msgIndex: 61 voiceIndex: 1 freqIndex: 6
[14 Sep 2018 22:41:42.514] Information, removing object from the ttsQueue: Pilot object from N328AN msgIndex: 61 voiceIndex: 1 freqIndex: 6
[14 Sep 2018 22:41:43.514] Information, processing incoming tts request from ET
[14 Sep 2018 22:41:43.515] Information, adding item to the ttsQueue: Controller object from ET msgIndex: 62 voiceIndex: 0 freqIndex: 6
[14 Sep 2018 22:41:43.515] Information, sending tts queue item to SayAsSent: Controller object from ET msgIndex: 62 voiceIndex: 0 freqIndex: 6
[14 Sep 2018 22:41:43.515] Information, sending GenerateWAVfile to ttsProcessor: Controller object from ET msgIndex: 62 voiceIndex: 0 freqIndex: 6
[14 Sep 2018 22:41:45.107] Information, entering onCtrlKeyReleased
[14 Sep 2018 22:41:45.107] Information, onCtrlKeyReleased tcwWindow isVisible
[14 Sep 2018 22:41:45.107] Information, onCtrlKeyReleased _srAvailable is TRUE
[14 Sep 2018 22:41:45.107] Information, user has released CtrlKey mic switch
[14 Sep 2018 22:41:45.117] StopRecording message received
[14 Sep 2018 22:41:45.117] Entering StopRecording
[14 Sep 2018 22:41:45.118] Exiting StopRecording
[14 Sep 2018 22:41:45.118] Information, received recording stopped event from SRProcessor
[14 Sep 2018 22:41:45.118] Exiting StartStopRecognition
[14 Sep 2018 22:41:45.118] Information, exiting onCtrlKeyReleased
[14 Sep 2018 22:41:45.231] Entering ProcessVRXInterpretation
[14 Sep 2018 22:41:45.231] VRX Interpretation: <?xml version="1.0" encoding="utf-8"?> <VRXResultsTop><a>
<callsign>AMF1288</callsign>
<cc_source>VPI_RADAR_CONTROLLER</cc_source>
<com1>
<command>
<commandName>VOICE_REC_ALTITUDE</commandName>
<lLevel>9300</lLevel>
<szLevel>nine thousand three hundred</szLevel>
<enAchieveCommand>ACHIEVE_CMD_DESCEND</enAchieveCommand>
</command>
</com1>
</a></VRXResultsTop>
[14 Sep 2018 22:41:45.231] Exiting ReformatIncomingMsg
[14 Sep 2018 22:41:45.231] VRX Best Hypothesis: amflight twelve eighty eight descend and maintain nine thousand three hundred
[14 Sep 2018 22:41:45.231] Entering ParseVRXInterpretation
[14 Sep 2018 22:41:45.231] Information, beginning parse of altitude type speech recognition command
[14 Sep 2018 22:41:45.231] OutgoingVRXResult = AMF1288:320:9300
[14 Sep 2018 22:41:45.231] Exiting ParseIncomingMsg
[14 Sep 2018 22:41:45.231] Exiting ProcessVRXInterpretation
[14 Sep 2018 22:41:45.514] Information, processing incoming tts request from AMF1288
[14 Sep 2018 22:41:45.514] Information, adding item to the ttsQueue: Pilot object from AMF1288 msgIndex: 63 voiceIndex: 5 freqIndex: 0
[14 Sep 2018 22:41:45.520] Information, sending tts queue item to SayAsSent: Pilot object from AMF1288 msgIndex: 63 voiceIndex: 5 freqIndex: 0
[14 Sep 2018 22:41:45.520] Information, building pilot tts for AMF1288
[14 Sep 2018 22:41:45.520] Information, sending GenerateWAVfile to ttsProcessor: Pilot object from AMF1288 msgIndex: 63 voiceIndex: 5 freqIndex: 0
[14 Sep 2018 22:41:45.520] Entering GenerateWAVfile
[14 Sep 2018 22:41:45.520] VoiceNumber = 2  Name: William
[14 Sep 2018 22:41:45.520] ReadbackIndex = 63  VoiceNumber = 2  Readback: <prosody rate="150%">descending to niner thousand three hundred  amflight twelve eighty eight</prosody>
[14 Sep 2018 22:41:45.522] Channel pointer = 1   Voice No. = 2 Voice Name = William
[14 Sep 2018 22:41:45.708] ReadbackWAVfile = C:\ProgramData\Flag Mountain\ATCpro\Speech\Voices\OutputWAVfile0063.WAV
[14 Sep 2018 22:41:45.708] Exiting GenerateWAVfile
[14 Sep 2018 22:41:45.717] Information, ttsProcessor playback started event received, msgIndex: 63
[14 Sep 2018 22:41:46.515] Information, ttsProcessor playback completed event received, msgIndex: 62
[14 Sep 2018 22:41:46.515] Information, processing commands from object: Controller object from ET msgIndex: 62 voiceIndex: 0 freqIndex: 6
[14 Sep 2018 22:41:46.515] Information, removing object from the ttsQueue: Controller object from ET msgIndex: 62 voiceIndex: 0 freqIndex: 6
[14 Sep 2018 22:41:47.514] Information, processing incoming tts request from N328AN
[14 Sep 2018 22:41:47.514] Information, adding item to the ttsQueue: Pilot object from N328AN msgIndex: 64 voiceIndex: 1 freqIndex: 6
[14 Sep 2018 22:41:47.514] Information, sending tts queue item to SayAsSent: Pilot object from N328AN msgIndex: 64 voiceIndex: 1 freqIndex: 6
[14 Sep 2018 22:41:47.514] Information, building pilot tts for N328AN
[14 Sep 2018 22:41:47.514] Information, sending GenerateWAVfile to ttsProcessor: Pilot object from N328AN msgIndex: 64 voiceIndex: 1 freqIndex: 6
[14 Sep 2018 22:41:48.747] Information, ttsProcessor playback completed event received, msgIndex: 63
[14 Sep 2018 22:41:48.757] Information, processing commands from object: Pilot object from AMF1288 msgIndex: 63 voiceIndex: 5 freqIndex: 0
[14 Sep 2018 22:41:48.757] Information, removing object from the ttsQueue: Pilot object from AMF1288 msgIndex: 63 voiceIndex: 5 freqIndex: 0
[14 Sep 2018 22:41:49.326] Information, microphone count = 12
[14 Sep 2018 22:41:49.327] Information, user has pressed CtrlKey mic switch
[14 Sep 2018 22:41:49.336] StartRecording message received
[14 Sep 2018 22:41:49.336] waveIn is null
[14 Sep 2018 22:41:49.336] Calling vrxLiveRecognizer.  RecognizerHandle = 152822016
[14 Sep 2018 22:41:49.336] Entering StartRecording
[14 Sep 2018 22:41:49.343] Exiting StartRecording
[14 Sep 2018 22:41:49.343] After call to vrxLiveRecognizerStart.  errorCode = 0
[14 Sep 2018 22:41:49.343] Information, received recording started event from SRProcessor
[14 Sep 2018 22:41:49.343] Exiting StartStopRecognition
[14 Sep 2018 22:41:50.515] Information, processing incoming tts request from 1T
[14 Sep 2018 22:41:50.515] Information, adding item to the ttsQueue: Controller object from 1T msgIndex: 65 voiceIndex: 0 freqIndex: 2
[14 Sep 2018 22:41:50.515] Information, ttsProcessor playback completed event received, msgIndex: 64
[14 Sep 2018 22:41:50.515] Information, processing commands from object: Pilot object from N328AN msgIndex: 64 voiceIndex: 1 freqIndex: 6
[14 Sep 2018 22:41:50.515] Information, removing object from the ttsQueue: Pilot object from N328AN msgIndex: 64 voiceIndex: 1 freqIndex: 6
[14 Sep 2018 22:41:50.515] Information, sending tts queue item to SayAsSent: Controller object from 1T msgIndex: 65 voiceIndex: 0 freqIndex: 2
[14 Sep 2018 22:41:50.515] Information, sending GenerateWAVfile to ttsProcessor: Controller object from 1T msgIndex: 65 voiceIndex: 0 freqIndex: 2
[14 Sep 2018 22:41:53.562] Information, entering onCtrlKeyReleased
[14 Sep 2018 22:41:53.562] Information, onCtrlKeyReleased tcwWindow isVisible
[14 Sep 2018 22:41:53.562] Information, onCtrlKeyReleased _srAvailable is TRUE
[14 Sep 2018 22:41:53.562] Information, user has released CtrlKey mic switch
[14 Sep 2018 22:41:53.571] StopRecording message received
[14 Sep 2018 22:41:53.571] Entering StopRecording
[14 Sep 2018 22:41:53.572] Exiting StopRecording
[14 Sep 2018 22:41:53.572] Information, received recording stopped event from SRProcessor
[14 Sep 2018 22:41:53.572] Exiting StartStopRecognition
[14 Sep 2018 22:41:53.572] Information, exiting onCtrlKeyReleased
[14 Sep 2018 22:41:53.636] Entering ProcessVRXInterpretation
[14 Sep 2018 22:41:53.636] VRX Interpretation: <?xml version="1.0" encoding="utf-8"?> <VRXResultsTop><a>
<callsign>AMF1351</callsign>
<cc_source>VPI_RADAR_CONTROLLER</cc_source>
<com1>
<command>
<commandName>VOICE_REC_HEADING</commandName>
<enHeadingType>HEADING_TYPE_ABSOLUTE</enHeadingType>
<lHeading>090</lHeading>
<enDirection>DIRECTION_RIGHT</enDirection>
<enHeadingInstruction>HDG_TURN</enHeadingInstruction>
</command>
</com1>
</a></VRXResultsTop>
[14 Sep 2018 22:41:53.636] Exiting ReformatIncomingMsg
[14 Sep 2018 22:41:53.636] VRX Best Hypothesis: amflight thirteen fifty one turn right heading zero nine zero
[14 Sep 2018 22:41:53.636] Entering ParseVRXInterpretation
[14 Sep 2018 22:41:53.636] Information, beginning parse of heading type speech recognition command
[14 Sep 2018 22:41:53.636] OutgoingVRXResult = AMF1351:100:090
[14 Sep 2018 22:41:53.637] Exiting ParseIncomingMsg
[14 Sep 2018 22:41:53.637] Exiting ProcessVRXInterpretation
[14 Sep 2018 22:41:54.513] Information, processing incoming tts request from AMF1351
[14 Sep 2018 22:41:54.513] Information, adding item to the ttsQueue: Pilot object from AMF1351 msgIndex: 66 voiceIndex: 4 freqIndex: 0
[14 Sep 2018 22:41:54.520] Information, ttsProcessor playback completed event received, msgIndex: 65
[14 Sep 2018 22:41:54.520] Information, processing commands from object: Controller object from 1T msgIndex: 65 voiceIndex: 0 freqIndex: 2
[14 Sep 2018 22:41:54.520] Information, removing object from the ttsQueue: Controller object from 1T msgIndex: 65 voiceIndex: 0 freqIndex: 2
[14 Sep 2018 22:41:54.520] Information, sending tts queue item to SayAsSent: Pilot object from AMF1351 msgIndex: 66 voiceIndex: 4 freqIndex: 0
[14 Sep 2018 22:41:54.520] Information, building pilot tts for AMF1351
[14 Sep 2018 22:41:54.520] Information, sending GenerateWAVfile to ttsProcessor: Pilot object from AMF1351 msgIndex: 66 voiceIndex: 4 freqIndex: 0
[14 Sep 2018 22:41:54.520] Entering GenerateWAVfile
[14 Sep 2018 22:41:54.520] VoiceNumber = 1  Name: Nathan
[14 Sep 2018 22:41:54.520] ReadbackIndex = 66  VoiceNumber = 1  Readback: <prosody rate="150%">heading zero niner zero  amflight thirteen fifty one</prosody>
[14 Sep 2018 22:41:54.522] Channel pointer = 1   Voice No. = 1 Voice Name = Nathan
[14 Sep 2018 22:41:54.610] ReadbackWAVfile = C:\ProgramData\Flag Mountain\ATCpro\Speech\Voices\OutputWAVfile0066.WAV
[14 Sep 2018 22:41:54.610] Exiting GenerateWAVfile
[14 Sep 2018 22:41:54.620] Information, ttsProcessor playback started event received, msgIndex: 66
[14 Sep 2018 22:41:55.514] Information, processing incoming tts request from GJS3699
[14 Sep 2018 22:41:55.514] Information, adding item to the ttsQueue: Pilot object from GJS3699 msgIndex: 67 voiceIndex: 24 freqIndex: 2
[14 Sep 2018 22:41:55.515] Information, sending tts queue item to SayAsSent: Pilot object from GJS3699 msgIndex: 67 voiceIndex: 24 freqIndex: 2
[14 Sep 2018 22:41:55.515] Information, building pilot tts for GJS3699
[14 Sep 2018 22:41:55.515] Information, sending GenerateWAVfile to ttsProcessor: Pilot object from GJS3699 msgIndex: 67 voiceIndex: 24 freqIndex: 2
[14 Sep 2018 22:41:57.141] Information, microphone count = 13
[14 Sep 2018 22:41:57.141] Information, user has pressed CtrlKey mic switch
[14 Sep 2018 22:41:57.153] StartRecording message received
[14 Sep 2018 22:41:57.153] waveIn is null
[14 Sep 2018 22:41:57.153] Calling vrxLiveRecognizer.  RecognizerHandle = 152822016
[14 Sep 2018 22:41:57.153] Entering StartRecording
[14 Sep 2018 22:41:57.160] Exiting StartRecording
[14 Sep 2018 22:41:57.160] After call to vrxLiveRecognizerStart.  errorCode = 0
[14 Sep 2018 22:41:57.160] Information, received recording started event from SRProcessor
[14 Sep 2018 22:41:57.160] Exiting StartStopRecognition
[14 Sep 2018 22:41:57.297] Information, ttsProcessor playback completed event received, msgIndex: 66
[14 Sep 2018 22:41:57.307] Information, processing commands from object: Pilot object from AMF1351 msgIndex: 66 voiceIndex: 4 freqIndex: 0
[14 Sep 2018 22:41:57.307] Information, removing object from the ttsQueue: Pilot object from AMF1351 msgIndex: 66 voiceIndex: 4 freqIndex: 0
[14 Sep 2018 22:41:58.514] Information, processing incoming tts request from N750ZM
[14 Sep 2018 22:41:58.514] Information, no tts required, passing on commands to appropriate receiver
[14 Sep 2018 22:41:59.514] Information, ttsProcessor playback completed event received, msgIndex: 67
[14 Sep 2018 22:41:59.514] Information, processing commands from object: Pilot object from GJS3699 msgIndex: 67 voiceIndex: 24 freqIndex: 2
[14 Sep 2018 22:41:59.514] Information, removing object from the ttsQueue: Pilot object from GJS3699 msgIndex: 67 voiceIndex: 24 freqIndex: 2
[14 Sep 2018 22:42:00.514] Information, processing incoming tts request from GJS3699
[14 Sep 2018 22:42:00.514] Information, adding item to the ttsQueue: Pilot object from GJS3699 msgIndex: 68 voiceIndex: 24 freqIndex: 0
[14 Sep 2018 22:42:00.515] Information, skipping a tts queue item because the user has the mic button pressed
[14 Sep 2018 22:42:01.515] Information, skipping a tts queue item because the user has the mic button pressed
[14 Sep 2018 22:42:01.919] Information, entering onCtrlKeyReleased
[14 Sep 2018 22:42:01.919] Information, onCtrlKeyReleased tcwWindow isVisible
[14 Sep 2018 22:42:01.919] Information, onCtrlKeyReleased _srAvailable is TRUE
[14 Sep 2018 22:42:01.919] Information, user has released CtrlKey mic switch
[14 Sep 2018 22:42:01.931] StopRecording message received
[14 Sep 2018 22:42:01.931] Entering StopRecording
[14 Sep 2018 22:42:01.931] Exiting StopRecording
[14 Sep 2018 22:42:01.931] Information, received recording stopped event from SRProcessor
[14 Sep 2018 22:42:01.931] Exiting StartStopRecognition
[14 Sep 2018 22:42:01.931] Information, exiting onCtrlKeyReleased
[14 Sep 2018 22:42:02.029] Entering ProcessVRXInterpretation
[14 Sep 2018 22:42:02.029] VRX Interpretation: <?xml version="1.0" encoding="utf-8"?> <VRXResultsTop><a>
<callsign>SWA2202</callsign>
<cc_source>VPI_RADAR_CONTROLLER</cc_source>
<com1>
<command>
<commandName>VOICE_REC_ALTITUDE</commandName>
<lLevel>10000</lLevel>
<szLevel>one zero thousand</szLevel>
<enAchieveCommand>ACHIEVE_CMD_DESCEND</enAchieveCommand>
</command>
</com1>
</a></VRXResultsTop>
[14 Sep 2018 22:42:02.029] Exiting ReformatIncomingMsg
[14 Sep 2018 22:42:02.029] VRX Best Hypothesis: southwest twenty two zero two descend and maintain one zero thousand
[14 Sep 2018 22:42:02.029] Entering ParseVRXInterpretation
[14 Sep 2018 22:42:02.029] Information, beginning parse of altitude type speech recognition command
[14 Sep 2018 22:42:02.029] OutgoingVRXResult = SWA2202:320:10000
[14 Sep 2018 22:42:02.029] Exiting ParseIncomingMsg
[14 Sep 2018 22:42:02.029] Exiting ProcessVRXInterpretation
[14 Sep 2018 22:42:02.514] Information, processing incoming tts request from SWA2202
[14 Sep 2018 22:42:02.514] Information, adding item to the ttsQueue: Pilot object from SWA2202 msgIndex: 69 voiceIndex: 13 freqIndex: 0
[14 Sep 2018 22:42:02.514] Information, processing incoming tts request from VFR
[14 Sep 2018 22:42:02.514] Warning, (IncomingATCTTS) Unable to find etvsFrequencyInformation for freqIndex: 000.0
[14 Sep 2018 22:42:02.514] Information, current frequency (127.4) is busy, checking to unlock it
[14 Sep 2018 22:42:02.514] Information, current frequency (127.4) is busy, unlocking it
[14 Sep 2018 22:42:02.514] Information, sending tts queue item to SayAsSent: Pilot object from GJS3699 msgIndex: 68 voiceIndex: 24 freqIndex: 0
[14 Sep 2018 22:42:02.514] Information, building pilot tts for GJS3699
[14 Sep 2018 22:42:02.515] Information, sending GenerateWAVfile to ttsProcessor: Pilot object from GJS3699 msgIndex: 68 voiceIndex: 24 freqIndex: 0
[14 Sep 2018 22:42:02.515] Entering GenerateWAVfile
[14 Sep 2018 22:42:02.515] VoiceNumber = 4  Name: Adam
[14 Sep 2018 22:42:02.515] ReadbackIndex = 68  VoiceNumber = 4  Readback: <prosody rate="150%">albuquerque departure lindbergh thirty six ninety niner   is with you climbing out of six thousand three hundred for niner thousand </prosody>
[14 Sep 2018 22:42:02.517] Channel pointer = 1   Voice No. = 4 Voice Name = Adam
[14 Sep 2018 22:42:02.859] ReadbackWAVfile = C:\ProgramData\Flag Mountain\ATCpro\Speech\Voices\OutputWAVfile0068.WAV
[14 Sep 2018 22:42:02.859] Exiting GenerateWAVfile
[14 Sep 2018 22:42:02.872] Information, ttsProcessor playback started event received, msgIndex: 68
[14 Sep 2018 22:42:08.097] Information, ttsProcessor playback completed event received, msgIndex: 68
[14 Sep 2018 22:42:08.106] Information, processing commands from object: Pilot object from GJS3699 msgIndex: 68 voiceIndex: 24 freqIndex: 0
[14 Sep 2018 22:42:08.106] Information, removing object from the ttsQueue: Pilot object from GJS3699 msgIndex: 68 voiceIndex: 24 freqIndex: 0
[14 Sep 2018 22:42:08.515] Information, current frequency (127.4) is busy, checking to unlock it
[14 Sep 2018 22:42:08.515] Information, sending tts queue item to SayAsSent: Pilot object from SWA2202 msgIndex: 69 voiceIndex: 13 freqIndex: 0
[14 Sep 2018 22:42:08.515] Information, building pilot tts for SWA2202
[14 Sep 2018 22:42:08.515] Information, sending GenerateWAVfile to ttsProcessor: Pilot object from SWA2202 msgIndex: 69 voiceIndex: 13 freqIndex: 0
[14 Sep 2018 22:42:08.515] Entering GenerateWAVfile
[14 Sep 2018 22:42:08.515] VoiceNumber = 1  Name: Nathan
[14 Sep 2018 22:42:08.515] ReadbackIndex = 69  VoiceNumber = 1  Readback: <prosody rate="150%">descending to one zero thousand  southwest twenty two zero two</prosody>
[14 Sep 2018 22:42:08.516] Channel pointer = 1   Voice No. = 1 Voice Name = Nathan
[14 Sep 2018 22:42:08.639] ReadbackWAVfile = C:\ProgramData\Flag Mountain\ATCpro\Speech\Voices\OutputWAVfile0069.WAV
[14 Sep 2018 22:42:08.639] Exiting GenerateWAVfile
[14 Sep 2018 22:42:08.649] Information, ttsProcessor playback started event received, msgIndex: 69
[14 Sep 2018 22:42:08.694] Information, microphone count = 14
[14 Sep 2018 22:42:08.694] Information, user has pressed CtrlKey mic switch
[14 Sep 2018 22:42:08.694] StartRecording message received
[14 Sep 2018 22:42:08.694] waveIn is null
[14 Sep 2018 22:42:08.694] Calling vrxLiveRecognizer.  RecognizerHandle = 152822016
[14 Sep 2018 22:42:08.695] Entering StartRecording
[14 Sep 2018 22:42:08.702] Exiting StartRecording
[14 Sep 2018 22:42:08.702] After call to vrxLiveRecognizerStart.  errorCode = 0
[14 Sep 2018 22:42:08.702] Information, received recording started event from SRProcessor
[14 Sep 2018 22:42:08.702] Exiting StartStopRecognition
[14 Sep 2018 22:42:09.357] Information, entering onCtrlKeyReleased
[14 Sep 2018 22:42:09.357] Information, onCtrlKeyReleased tcwWindow isVisible
[14 Sep 2018 22:42:09.357] Information, onCtrlKeyReleased _srAvailable is TRUE
[14 Sep 2018 22:42:09.357] Information, user has released CtrlKey mic switch
[14 Sep 2018 22:42:09.366] StopRecording message received
[14 Sep 2018 22:42:09.366] Entering StopRecording
[14 Sep 2018 22:42:09.367] Exiting StopRecording
[14 Sep 2018 22:42:09.367] Information, received recording stopped event from SRProcessor
[14 Sep 2018 22:42:09.367] Exiting StartStopRecognition
[14 Sep 2018 22:42:09.367] Information, exiting onCtrlKeyReleased
[14 Sep 2018 22:42:09.500] Entering ProcessVRXInterpretation
[14 Sep 2018 22:42:09.500] VRX Interpretation: <?xml version="1.0" encoding="utf-8"?> <VRXResultsTop><a/></VRXResultsTop>
[14 Sep 2018 22:42:09.500] Exiting ReformatIncomingMsg
[14 Sep 2018 22:42:09.500] VRX Best Hypothesis: standby
[14 Sep 2018 22:42:09.500] Entering ParseVRXInterpretation
[14 Sep 2018 22:42:09.500] OutgoingVRXResult = :0
[14 Sep 2018 22:42:09.500] Exiting ParseIncomingMsg
[14 Sep 2018 22:42:09.500] Exiting ProcessVRXInterpretation
[14 Sep 2018 22:42:11.398] Information, ttsProcessor playback completed event received, msgIndex: 69
[14 Sep 2018 22:42:11.407] Information, processing commands from object: Pilot object from SWA2202 msgIndex: 69 voiceIndex: 13 freqIndex: 0
[14 Sep 2018 22:42:11.407] Information, removing object from the ttsQueue: Pilot object from SWA2202 msgIndex: 69 voiceIndex: 13 freqIndex: 0
[14 Sep 2018 22:42:11.779] Information, microphone count = 15
[14 Sep 2018 22:42:11.779] Information, user has pressed CtrlKey mic switch
[14 Sep 2018 22:42:11.789] StartRecording message received
[14 Sep 2018 22:42:11.789] waveIn is null
[14 Sep 2018 22:42:11.789] Calling vrxLiveRecognizer.  RecognizerHandle = 152822016
[14 Sep 2018 22:42:11.789] Entering StartRecording
[14 Sep 2018 22:42:11.796] Exiting StartRecording
[14 Sep 2018 22:42:11.796] After call to vrxLiveRecognizerStart.  errorCode = 0
[14 Sep 2018 22:42:11.796] Information, received recording started event from SRProcessor
[14 Sep 2018 22:42:11.796] Exiting StartStopRecognition
[14 Sep 2018 22:42:12.517] Information, processing incoming tts request from C16
[14 Sep 2018 22:42:12.517] Information, adding item to the ttsQueue: Controller object from C16 msgIndex: 70 voiceIndex: 0 freqIndex: 3
[14 Sep 2018 22:42:12.518] Information, sending tts queue item to SayAsSent: Controller object from C16 msgIndex: 70 voiceIndex: 0 freqIndex: 3
[14 Sep 2018 22:42:12.518] Information, sending GenerateWAVfile to ttsProcessor: Controller object from C16 msgIndex: 70 voiceIndex: 0 freqIndex: 3
[14 Sep 2018 22:42:17.513] Information, ttsProcessor playback completed event received, msgIndex: 70
[14 Sep 2018 22:42:17.513] Information, processing commands from object: Controller object from C16 msgIndex: 70 voiceIndex: 0 freqIndex: 3
[14 Sep 2018 22:42:17.513] Information, removing object from the ttsQueue: Controller object from C16 msgIndex: 70 voiceIndex: 0 freqIndex: 3
[14 Sep 2018 22:42:17.641] Information, entering onCtrlKeyReleased
[14 Sep 2018 22:42:17.641] Information, onCtrlKeyReleased tcwWindow isVisible
[14 Sep 2018 22:42:17.641] Information, onCtrlKeyReleased _srAvailable is TRUE
[14 Sep 2018 22:42:17.641] Information, user has released CtrlKey mic switch
[14 Sep 2018 22:42:17.651] StopRecording message received
[14 Sep 2018 22:42:17.651] Entering StopRecording
[14 Sep 2018 22:42:17.652] Exiting StopRecording
[14 Sep 2018 22:42:17.652] Information, received recording stopped event from SRProcessor
[14 Sep 2018 22:42:17.652] Exiting StartStopRecognition
[14 Sep 2018 22:42:17.652] Information, exiting onCtrlKeyReleased
[14 Sep 2018 22:42:17.730] Entering ProcessVRXInterpretation
[14 Sep 2018 22:42:17.730] VRX Interpretation: <?xml version="1.0" encoding="utf-8"?> <VRXResultsTop><a>
<callsign>GJS3699</callsign>
<cc_source>VPI_RADAR_CONTROLLER</cc_source>
<com1>
<command>
<commandName>VOICE_REC_ALTITUDE</commandName>
<lLevel>02000</lLevel>
<szLevel>zero two zero</szLevel>
<enDecisionState></enDecisionState>
<enAchieveCommand>ACHIEVE_CMD_CLIMB</enAchieveCommand>
</command>
</com1>
</a></VRXResultsTop>
[14 Sep 2018 22:42:17.730] Exiting ReformatIncomingMsg
[14 Sep 2018 22:42:17.730] VRX Best Hypothesis: lindbergh thirty six ninety niner climb and maintain flight level zero two zero
[14 Sep 2018 22:42:17.730] Entering ParseVRXInterpretation
[14 Sep 2018 22:42:17.730] Information, beginning parse of altitude type speech recognition command
[14 Sep 2018 22:42:17.730] OutgoingVRXResult = GJS3699:360:02000
[14 Sep 2018 22:42:17.730] Exiting ParseIncomingMsg
[14 Sep 2018 22:42:17.730] Exiting ProcessVRXInterpretation
[14 Sep 2018 22:42:18.520] Information, processing incoming tts request from GJS3699
[14 Sep 2018 22:42:18.520] Information, adding item to the ttsQueue: Pilot object from GJS3699 msgIndex: 71 voiceIndex: 24 freqIndex: 0
[14 Sep 2018 22:42:18.520] Information, processing incoming tts request from ASH5642
[14 Sep 2018 22:42:18.520] Information, adding item to the ttsQueue: Pilot object from ASH5642 msgIndex: 72 voiceIndex: 0 freqIndex: 3
[14 Sep 2018 22:42:18.521] Information, sending tts queue item to SayAsSent: Pilot object from GJS3699 msgIndex: 71 voiceIndex: 24 freqIndex: 0
[14 Sep 2018 22:42:18.521] Information, building pilot tts for GJS3699
[14 Sep 2018 22:42:18.521] Information, sending GenerateWAVfile to ttsProcessor: Pilot object from GJS3699 msgIndex: 71 voiceIndex: 24 freqIndex: 0
[14 Sep 2018 22:42:18.521] Entering GenerateWAVfile
[14 Sep 2018 22:42:18.521] VoiceNumber = 4  Name: Adam
[14 Sep 2018 22:42:18.521] ReadbackIndex = 71  VoiceNumber = 4  Readback: <prosody rate="150%">repeat the last for lindbergh thirty six ninety niner</prosody>
[14 Sep 2018 22:42:18.523] Channel pointer = 1   Voice No. = 4 Voice Name = Adam
[14 Sep 2018 22:42:18.686] ReadbackWAVfile = C:\ProgramData\Flag Mountain\ATCpro\Speech\Voices\OutputWAVfile0071.WAV
[14 Sep 2018 22:42:18.686] Exiting GenerateWAVfile
[14 Sep 2018 22:42:18.686] Information, sending tts queue item to SayAsSent: Pilot object from ASH5642 msgIndex: 72 voiceIndex: 0 freqIndex: 3
[14 Sep 2018 22:42:18.686] Information, building pilot tts for ASH5642
[14 Sep 2018 22:42:18.686] Information, sending GenerateWAVfile to ttsProcessor: Pilot object from ASH5642 msgIndex: 72 voiceIndex: 0 freqIndex: 3
[14 Sep 2018 22:42:18.694] Information, ttsProcessor playback started event received, msgIndex: 71
[14 Sep 2018 22:42:21.297] Information, ttsProcessor playback completed event received, msgIndex: 71
[14 Sep 2018 22:42:21.315] Information, processing commands from object: Pilot object from GJS3699 msgIndex: 71 voiceIndex: 24 freqIndex: 0
[14 Sep 2018 22:42:21.315] Information, removing object from the ttsQueue: Pilot object from GJS3699 msgIndex: 71 voiceIndex: 24 freqIndex: 0
[14 Sep 2018 22:42:21.701] Information, microphone count = 16
[14 Sep 2018 22:42:21.701] Information, user has pressed CtrlKey mic switch
[14 Sep 2018 22:42:21.710] StartRecording message received
[14 Sep 2018 22:42:21.710] waveIn is null
[14 Sep 2018 22:42:21.710] Calling vrxLiveRecognizer.  RecognizerHandle = 152822016
[14 Sep 2018 22:42:21.711] Entering StartRecording
[14 Sep 2018 22:42:21.718] Exiting StartRecording
[14 Sep 2018 22:42:21.718] After call to vrxLiveRecognizerStart.  errorCode = 0
[14 Sep 2018 22:42:21.718] Information, received recording started event from SRProcessor
[14 Sep 2018 22:42:21.718] Exiting StartStopRecognition
[14 Sep 2018 22:42:23.514] Information, ttsProcessor playback completed event received, msgIndex: 72
[14 Sep 2018 22:42:23.514] Information, processing commands from object: Pilot object from ASH5642 msgIndex: 72 voiceIndex: 0 freqIndex: 3
[14 Sep 2018 22:42:23.514] Information, removing object from the ttsQueue: Pilot object from ASH5642 msgIndex: 72 voiceIndex: 0 freqIndex: 3
[14 Sep 2018 22:42:24.516] Information, processing incoming tts request from ASH5642
[14 Sep 2018 22:42:24.516] Information, adding item to the ttsQueue: Pilot object from ASH5642 msgIndex: 73 voiceIndex: 0 freqIndex: 4
[14 Sep 2018 22:42:24.517] Information, sending tts queue item to SayAsSent: Pilot object from ASH5642 msgIndex: 73 voiceIndex: 0 freqIndex: 4
[14 Sep 2018 22:42:24.517] Information, building pilot tts for ASH5642
[14 Sep 2018 22:42:24.517] Information, sending GenerateWAVfile to ttsProcessor: Pilot object from ASH5642 msgIndex: 73 voiceIndex: 0 freqIndex: 4
[14 Sep 2018 22:42:26.893] Information, entering onCtrlKeyReleased
[14 Sep 2018 22:42:26.893] Information, onCtrlKeyReleased tcwWindow isVisible
[14 Sep 2018 22:42:26.893] Information, onCtrlKeyReleased _srAvailable is TRUE
[14 Sep 2018 22:42:26.893] Information, user has released CtrlKey mic switch
[14 Sep 2018 22:42:26.903] StopRecording message received
[14 Sep 2018 22:42:26.903] Entering StopRecording
[14 Sep 2018 22:42:26.904] Exiting StopRecording
[14 Sep 2018 22:42:26.904] Information, received recording stopped event from SRProcessor
[14 Sep 2018 22:42:26.904] Exiting StartStopRecognition
[14 Sep 2018 22:42:26.904] Information, exiting onCtrlKeyReleased
[14 Sep 2018 22:42:27.013] Entering ProcessVRXInterpretation
[14 Sep 2018 22:42:27.013] VRX Interpretation: <?xml version="1.0" encoding="utf-8"?> <VRXResultsTop><a>
<callsign>GJS3699</callsign>
<cc_source>VPI_RADAR_CONTROLLER</cc_source>
<com1>
<command>
<commandName>VOICE_REC_ALTITUDE</commandName>
<lLevel>20000</lLevel>
<szLevel>two zero zero</szLevel>
<enDecisionState></enDecisionState>
<enAchieveCommand>ACHIEVE_CMD_CLIMB</enAchieveCommand>
</command>
</com1>
</a></VRXResultsTop>
[14 Sep 2018 22:42:27.013] Exiting ReformatIncomingMsg
[14 Sep 2018 22:42:27.013] VRX Best Hypothesis: lindbergh thirty six ninety niner climb and maintain flight level two zero zero
[14 Sep 2018 22:42:27.013] Entering ParseVRXInterpretation
[14 Sep 2018 22:42:27.013] Information, beginning parse of altitude type speech recognition command
[14 Sep 2018 22:42:27.013] OutgoingVRXResult = GJS3699:360:20000
[14 Sep 2018 22:42:27.013] Exiting ParseIncomingMsg
[14 Sep 2018 22:42:27.013] Exiting ProcessVRXInterpretation
[14 Sep 2018 22:42:27.513] Information, processing incoming tts request from GJS3699
[14 Sep 2018 22:42:27.513] Information, adding item to the ttsQueue: Pilot object from GJS3699 msgIndex: 74 voiceIndex: 24 freqIndex: 0
[14 Sep 2018 22:42:27.513] Information, sending tts queue item to SayAsSent: Pilot object from GJS3699 msgIndex: 74 voiceIndex: 24 freqIndex: 0
[14 Sep 2018 22:42:27.514] Information, building pilot tts for GJS3699
[14 Sep 2018 22:42:27.514] Information, sending GenerateWAVfile to ttsProcessor: Pilot object from GJS3699 msgIndex: 74 voiceIndex: 24 freqIndex: 0
[14 Sep 2018 22:42:27.514] Entering GenerateWAVfile
[14 Sep 2018 22:42:27.514] VoiceNumber = 4  Name: Adam
[14 Sep 2018 22:42:27.514] ReadbackIndex = 74  VoiceNumber = 4  Readback: <prosody rate="150%">up to flight level two zero zero   lindbergh thirty six ninety niner</prosody>
[14 Sep 2018 22:42:27.515] Channel pointer = 1   Voice No. = 4 Voice Name = Adam
[14 Sep 2018 22:42:27.680] ReadbackWAVfile = C:\ProgramData\Flag Mountain\ATCpro\Speech\Voices\OutputWAVfile0074.WAV
[14 Sep 2018 22:42:27.680] Exiting GenerateWAVfile
[14 Sep 2018 22:42:27.689] Information, ttsProcessor playback started event received, msgIndex: 74
[14 Sep 2018 22:42:30.513] Information, ttsProcessor playback completed event received, msgIndex: 73
[14 Sep 2018 22:42:30.514] Information, processing commands from object: Pilot object from ASH5642 msgIndex: 73 voiceIndex: 0 freqIndex: 4
[14 Sep 2018 22:42:30.514] Information, removing object from the ttsQueue: Pilot object from ASH5642 msgIndex: 73 voiceIndex: 0 freqIndex: 4
[14 Sep 2018 22:42:30.747] Information, ttsProcessor playback completed event received, msgIndex: 74
[14 Sep 2018 22:42:30.757] Information, processing commands from object: Pilot object from GJS3699 msgIndex: 74 voiceIndex: 24 freqIndex: 0
[14 Sep 2018 22:42:30.757] Information, removing object from the ttsQueue: Pilot object from GJS3699 msgIndex: 74 voiceIndex: 24 freqIndex: 0
[14 Sep 2018 22:42:31.513] Information, processing incoming tts request from C17
[14 Sep 2018 22:42:31.514] Information, adding item to the ttsQueue: Controller object from C17 msgIndex: 75 voiceIndex: 0 freqIndex: 4
[14 Sep 2018 22:42:31.514] Information, processing incoming tts request from C17
[14 Sep 2018 22:42:31.514] Information, adding item to the ttsQueue: Controller object from C17 msgIndex: 76 voiceIndex: 0 freqIndex: 4
[14 Sep 2018 22:42:31.514] Information, sending tts queue item to SayAsSent: Controller object from C17 msgIndex: 75 voiceIndex: 0 freqIndex: 4
[14 Sep 2018 22:42:31.514] Information, sending GenerateWAVfile to ttsProcessor: Controller object from C17 msgIndex: 75 voiceIndex: 0 freqIndex: 4
[14 Sep 2018 22:42:34.516] Information, ttsProcessor playback completed event received, msgIndex: 75
[14 Sep 2018 22:42:34.516] Information, processing commands from object: Controller object from C17 msgIndex: 75 voiceIndex: 0 freqIndex: 4
[14 Sep 2018 22:42:34.516] Information, removing object from the ttsQueue: Controller object from C17 msgIndex: 75 voiceIndex: 0 freqIndex: 4
[14 Sep 2018 22:42:34.516] Information, sending tts queue item to SayAsSent: Controller object from C17 msgIndex: 76 voiceIndex: 0 freqIndex: 4
[14 Sep 2018 22:42:34.516] Information, sending GenerateWAVfile to ttsProcessor: Controller object from C17 msgIndex: 76 voiceIndex: 0 freqIndex: 4
[14 Sep 2018 22:42:35.666] Information, current local time 10:15 (4935)
[14 Sep 2018 22:42:35.666] Information, calling writeDynamic_RadarAircrafts
[14 Sep 2018 22:42:35.673] Entering LoadDynRadarAircrafts.  RecognitionInProcess = False  AircraftUpdatePending = False
[14 Sep 2018 22:42:35.673] Entering UpdateDynRadarAircrafts
[14 Sep 2018 22:42:35.697] UpdateDynRadarAircrafts Complete.
[14 Sep 2018 22:42:35.697] Exiting LoadDynRadarAircrafts.  RecognitionInProcess = False  AircraftUpdatePending = False
[14 Sep 2018 22:42:35.749] Information, loading commercial flights at 4935 local
[14 Sep 2018 22:42:38.514] Information, processing incoming tts request from C17
[14 Sep 2018 22:42:38.514] Information, adding item to the ttsQueue: Controller object from C17 msgIndex: 77 voiceIndex: 0 freqIndex: 4
[14 Sep 2018 22:42:38.514] Information, ttsProcessor playback completed event received, msgIndex: 76
[14 Sep 2018 22:42:38.514] Information, processing commands from object: Controller object from C17 msgIndex: 76 voiceIndex: 0 freqIndex: 4
[14 Sep 2018 22:42:38.514] Information, removing object from the ttsQueue: Controller object from C17 msgIndex: 76 voiceIndex: 0 freqIndex: 4
[14 Sep 2018 22:42:38.514] Information, current frequency (124.32) is busy, checking to unlock it
[14 Sep 2018 22:42:38.514] Information, sending tts queue item to SayAsSent: Controller object from C17 msgIndex: 77 voiceIndex: 0 freqIndex: 4
[14 Sep 2018 22:42:38.515] Information, sending GenerateWAVfile to ttsProcessor: Controller object from C17 msgIndex: 77 voiceIndex: 0 freqIndex: 4
[14 Sep 2018 22:42:39.514] Information, processing incoming tts request from N549ZR
[14 Sep 2018 22:42:39.514] Information, adding item to the ttsQueue: Pilot object from N549ZR msgIndex: 78 voiceIndex: 17 freqIndex: 4
[14 Sep 2018 22:42:42.517] Information, ttsProcessor playback completed event received, msgIndex: 77
[14 Sep 2018 22:42:42.517] Information, processing commands from object: Controller object from C17 msgIndex: 77 voiceIndex: 0 freqIndex: 4
[14 Sep 2018 22:42:42.517] Information, removing object from the ttsQueue: Controller object from C17 msgIndex: 77 voiceIndex: 0 freqIndex: 4
[14 Sep 2018 22:42:42.517] Information, current frequency (124.32) is busy, checking to unlock it
[14 Sep 2018 22:42:42.517] Information, sending tts queue item to SayAsSent: Pilot object from N549ZR msgIndex: 78 voiceIndex: 17 freqIndex: 4
[14 Sep 2018 22:42:42.517] Information, building pilot tts for N549ZR
[14 Sep 2018 22:42:42.517] Information, sending GenerateWAVfile to ttsProcessor: Pilot object from N549ZR msgIndex: 78 voiceIndex: 17 freqIndex: 4
[14 Sep 2018 22:42:43.514] Information, processing incoming tts request from SWA1686
[14 Sep 2018 22:42:43.514] Information, adding item to the ttsQueue: Pilot object from SWA1686 msgIndex: 79 voiceIndex: 21 freqIndex: 4
[14 Sep 2018 22:42:46.515] Information, ttsProcessor playback completed event received, msgIndex: 78
[14 Sep 2018 22:42:46.515] Information, processing commands from object: Pilot object from N549ZR msgIndex: 78 voiceIndex: 17 freqIndex: 4
[14 Sep 2018 22:42:46.515] Information, removing object from the ttsQueue: Pilot object from N549ZR msgIndex: 78 voiceIndex: 17 freqIndex: 4
[14 Sep 2018 22:42:46.515] Information, sending tts queue item to SayAsSent: Pilot object from SWA1686 msgIndex: 79 voiceIndex: 21 freqIndex: 4
[14 Sep 2018 22:42:46.515] Information, building pilot tts for SWA1686
[14 Sep 2018 22:42:46.516] Information, sending GenerateWAVfile to ttsProcessor: Pilot object from SWA1686 msgIndex: 79 voiceIndex: 21 freqIndex: 4
[14 Sep 2018 22:42:47.514] Information, processing incoming tts request from N549ZR
[14 Sep 2018 22:42:47.514] Information, adding item to the ttsQueue: Pilot object from N549ZR msgIndex: 80 voiceIndex: 17 freqIndex: 0
[14 Sep 2018 22:42:47.514] Information, sending tts queue item to SayAsSent: Pilot object from N549ZR msgIndex: 80 voiceIndex: 17 freqIndex: 0
[14 Sep 2018 22:42:47.515] Information, building pilot tts for N549ZR
[14 Sep 2018 22:42:47.515] Information, sending GenerateWAVfile to ttsProcessor: Pilot object from N549ZR msgIndex: 80 voiceIndex: 17 freqIndex: 0
[14 Sep 2018 22:42:47.515] Entering GenerateWAVfile
[14 Sep 2018 22:42:47.515] VoiceNumber = 1  Name: Nathan
[14 Sep 2018 22:42:47.515] ReadbackIndex = 80  VoiceNumber = 1  Readback: <prosody rate="150%">albuquerque approach good morning lear november five four niner zulu romeo  sixteen thousand eight hundred for one five thousand at two five zero, we have india</prosody>
[14 Sep 2018 22:42:47.517] Channel pointer = 1   Voice No. = 1 Voice Name = Nathan
[14 Sep 2018 22:42:47.773] ReadbackWAVfile = C:\ProgramData\Flag Mountain\ATCpro\Speech\Voices\OutputWAVfile0080.WAV
[14 Sep 2018 22:42:47.773] Exiting GenerateWAVfile
[14 Sep 2018 22:42:47.786] Information, ttsProcessor playback started event received, msgIndex: 80
[14 Sep 2018 22:42:49.515] Information, ttsProcessor playback completed event received, msgIndex: 79
[14 Sep 2018 22:42:49.515] Information, processing commands from object: Pilot object from SWA1686 msgIndex: 79 voiceIndex: 21 freqIndex: 4
[14 Sep 2018 22:42:49.515] Information, removing object from the ttsQueue: Pilot object from SWA1686 msgIndex: 79 voiceIndex: 21 freqIndex: 4
[14 Sep 2018 22:42:53.998] Information, ttsProcessor playback completed event received, msgIndex: 80
[14 Sep 2018 22:42:54.007] Information, processing commands from object: Pilot object from N549ZR msgIndex: 80 voiceIndex: 17 freqIndex: 0
[14 Sep 2018 22:42:54.008] Information, removing object from the ttsQueue: Pilot object from N549ZR msgIndex: 80 voiceIndex: 17 freqIndex: 0
[14 Sep 2018 22:42:59.516] Information, processing incoming tts request from C94
[14 Sep 2018 22:42:59.516] Information, adding item to the ttsQueue: Controller object from C94 msgIndex: 81 voiceIndex: 0 freqIndex: 5
[14 Sep 2018 22:42:59.516] Information, sending tts queue item to SayAsSent: Controller object from C94 msgIndex: 81 voiceIndex: 0 freqIndex: 5
[14 Sep 2018 22:42:59.516] Information, sending GenerateWAVfile to ttsProcessor: Controller object from C94 msgIndex: 81 voiceIndex: 0 freqIndex: 5
[14 Sep 2018 22:43:03.893] Information, microphone count = 17
[14 Sep 2018 22:43:03.893] Information, user has pressed CtrlKey mic switch
[14 Sep 2018 22:43:03.903] StartRecording message received
[14 Sep 2018 22:43:03.903] waveIn is null
[14 Sep 2018 22:43:03.903] Calling vrxLiveRecognizer.  RecognizerHandle = 152822016
[14 Sep 2018 22:43:03.903] Entering StartRecording
[14 Sep 2018 22:43:03.910] Exiting StartRecording
[14 Sep 2018 22:43:03.910] After call to vrxLiveRecognizerStart.  errorCode = 0
[14 Sep 2018 22:43:03.910] Information, received recording started event from SRProcessor
[14 Sep 2018 22:43:03.910] Exiting StartStopRecognition
[14 Sep 2018 22:43:06.513] Information, ttsProcessor playback completed event received, msgIndex: 81
[14 Sep 2018 22:43:06.513] Information, processing commands from object: Controller object from C94 msgIndex: 81 voiceIndex: 0 freqIndex: 5
[14 Sep 2018 22:43:06.513] Information, removing object from the ttsQueue: Controller object from C94 msgIndex: 81 voiceIndex: 0 freqIndex: 5
[14 Sep 2018 22:43:07.514] Information, processing incoming tts request from ASQ3825
[14 Sep 2018 22:43:07.514] Information, adding item to the ttsQueue: Pilot object from ASQ3825 msgIndex: 82 voiceIndex: 16 freqIndex: 5
[14 Sep 2018 22:43:07.514] Information, sending tts queue item to SayAsSent: Pilot object from ASQ3825 msgIndex: 82 voiceIndex: 16 freqIndex: 5
[14 Sep 2018 22:43:07.514] Information, building pilot tts for ASQ3825
[14 Sep 2018 22:43:07.515] Information, sending GenerateWAVfile to ttsProcessor: Pilot object from ASQ3825 msgIndex: 82 voiceIndex: 16 freqIndex: 5
[14 Sep 2018 22:43:08.970] Information, entering onCtrlKeyReleased
[14 Sep 2018 22:43:08.970] Information, onCtrlKeyReleased tcwWindow isVisible
[14 Sep 2018 22:43:08.970] Information, onCtrlKeyReleased _srAvailable is TRUE
[14 Sep 2018 22:43:08.970] Information, user has released CtrlKey mic switch
[14 Sep 2018 22:43:08.980] StopRecording message received
[14 Sep 2018 22:43:08.980] Entering StopRecording
[14 Sep 2018 22:43:08.981] Exiting StopRecording
[14 Sep 2018 22:43:08.981] Information, received recording stopped event from SRProcessor
[14 Sep 2018 22:43:08.981] Exiting StartStopRecognition
[14 Sep 2018 22:43:08.981] Information, exiting onCtrlKeyReleased
[14 Sep 2018 22:43:09.077] Entering ProcessVRXInterpretation
[14 Sep 2018 22:43:09.077] VRX Interpretation: <?xml version="1.0" encoding="utf-8"?> <VRXResultsTop><a>
<callsign>N549ZR</callsign>
<cc_source>VPI_RADAR_CONTROLLER</cc_source>
<com1>
<command>
<commandName>VOICE_REC_EXPECT_RUNWAY</commandName>
<szRunway>26 </szRunway>
</command>
</com1>
</a></VRXResultsTop>
[14 Sep 2018 22:43:09.077] Exiting ReformatIncomingMsg
[14 Sep 2018 22:43:09.077] VRX Best Hypothesis: lear five four niner zulu romeo expect runway two six
[14 Sep 2018 22:43:09.077] Entering ParseVRXInterpretation
[14 Sep 2018 22:43:09.078] Information, beginning parse of approach type speech recognition command
[14 Sep 2018 22:43:09.078] OutgoingVRXResult = N549ZR:826:26
[14 Sep 2018 22:43:09.078] Exiting ParseIncomingMsg
[14 Sep 2018 22:43:09.078] Exiting ProcessVRXInterpretation
[14 Sep 2018 22:43:09.514] Information, processing incoming tts request from N549ZR
[14 Sep 2018 22:43:09.514] Information, adding item to the ttsQueue: Pilot object from N549ZR msgIndex: 83 voiceIndex: 17 freqIndex: 0
[14 Sep 2018 22:43:09.514] Information, sending tts queue item to SayAsSent: Pilot object from N549ZR msgIndex: 83 voiceIndex: 17 freqIndex: 0
[14 Sep 2018 22:43:09.514] Information, building pilot tts for N549ZR
[14 Sep 2018 22:43:09.515] Information, sending GenerateWAVfile to ttsProcessor: Pilot object from N549ZR msgIndex: 83 voiceIndex: 17 freqIndex: 0
[14 Sep 2018 22:43:09.515] Entering GenerateWAVfile
[14 Sep 2018 22:43:09.515] VoiceNumber = 1  Name: Nathan
[14 Sep 2018 22:43:09.515] ReadbackIndex = 83  VoiceNumber = 1  Readback: <prosody rate="150%">expect runway two six lear niner zulu romeo</prosody>
[14 Sep 2018 22:43:09.516] Channel pointer = 1   Voice No. = 1 Voice Name = Nathan
[14 Sep 2018 22:43:09.599] ReadbackWAVfile = C:\ProgramData\Flag Mountain\ATCpro\Speech\Voices\OutputWAVfile0083.WAV
[14 Sep 2018 22:43:09.599] Exiting GenerateWAVfile
[14 Sep 2018 22:43:09.607] Information, ttsProcessor playback started event received, msgIndex: 83
[14 Sep 2018 22:43:12.147] Information, ttsProcessor playback completed event received, msgIndex: 83
[14 Sep 2018 22:43:12.157] Information, processing commands from object: Pilot object from N549ZR msgIndex: 83 voiceIndex: 17 freqIndex: 0
[14 Sep 2018 22:43:12.157] Information, removing object from the ttsQueue: Pilot object from N549ZR msgIndex: 83 voiceIndex: 17 freqIndex: 0
[14 Sep 2018 22:43:13.515] Information, ttsProcessor playback completed event received, msgIndex: 82
[14 Sep 2018 22:43:13.515] Information, processing commands from object: Pilot object from ASQ3825 msgIndex: 82 voiceIndex: 16 freqIndex: 5
[14 Sep 2018 22:43:13.515] Information, removing object from the ttsQueue: Pilot object from ASQ3825 msgIndex: 82 voiceIndex: 16 freqIndex: 5
[14 Sep 2018 22:43:19.513] Information, processing incoming tts request from AMF1288
[14 Sep 2018 22:43:19.513] Information, no tts required, passing on commands to appropriate receiver
[14 Sep 2018 22:43:20.512] Information, processing incoming tts request from AMF1288
[14 Sep 2018 22:43:20.513] Information, adding item to the ttsQueue: Pilot object from AMF1288 msgIndex: 84 voiceIndex: 5 freqIndex: 0
[14 Sep 2018 22:43:20.514] Information, sending tts queue item to SayAsSent: Pilot object from AMF1288 msgIndex: 84 voiceIndex: 5 freqIndex: 0
[14 Sep 2018 22:43:20.514] Information, building pilot tts for AMF1288
[14 Sep 2018 22:43:20.514] Information, sending GenerateWAVfile to ttsProcessor: Pilot object from AMF1288 msgIndex: 84 voiceIndex: 5 freqIndex: 0
[14 Sep 2018 22:43:20.514] Entering GenerateWAVfile
[14 Sep 2018 22:43:20.514] VoiceNumber = 2  Name: William
[14 Sep 2018 22:43:20.514] ReadbackIndex = 84  VoiceNumber = 2  Readback: <prosody rate="150%">amflight twelve eighty eight needs lower or clearance to make the approach</prosody>
[14 Sep 2018 22:43:20.516] Channel pointer = 1   Voice No. = 2 Voice Name = William
[14 Sep 2018 22:43:20.657] ReadbackWAVfile = C:\ProgramData\Flag Mountain\ATCpro\Speech\Voices\OutputWAVfile0084.WAV
[14 Sep 2018 22:43:20.657] Exiting GenerateWAVfile
[14 Sep 2018 22:43:20.666] Information, ttsProcessor playback started event received, msgIndex: 84
[14 Sep 2018 22:43:21.514] Information, processing incoming tts request from N485KC
[14 Sep 2018 22:43:21.514] Information, no tts required, passing on commands to appropriate receiver
[14 Sep 2018 22:43:21.516] Information, processing incoming tts request from C94
[14 Sep 2018 22:43:21.516] Information, adding item to the ttsQueue: Controller object from C94 msgIndex: 85 voiceIndex: 0 freqIndex: 5
[14 Sep 2018 22:43:21.516] Information, sending tts queue item to SayAsSent: Controller object from C94 msgIndex: 85 voiceIndex: 0 freqIndex: 5
[14 Sep 2018 22:43:21.517] Information, sending GenerateWAVfile to ttsProcessor: Controller object from C94 msgIndex: 85 voiceIndex: 0 freqIndex: 5
[14 Sep 2018 22:43:23.997] Information, ttsProcessor playback completed event received, msgIndex: 84
[14 Sep 2018 22:43:24.007] Information, processing commands from object: Pilot object from AMF1288 msgIndex: 84 voiceIndex: 5 freqIndex: 0
[14 Sep 2018 22:43:24.007] Information, removing object from the ttsQueue: Pilot object from AMF1288 msgIndex: 84 voiceIndex: 5 freqIndex: 0
[14 Sep 2018 22:43:24.515] Information, processing incoming tts request from AMF1288
[14 Sep 2018 22:43:24.515] Information, adding item to the ttsQueue: Pilot object from AMF1288 msgIndex: 86 voiceIndex: 5 freqIndex: 0
[14 Sep 2018 22:43:24.516] Information, ttsProcessor playback completed event received, msgIndex: 85
[14 Sep 2018 22:43:24.516] Information, processing commands from object: Controller object from C94 msgIndex: 85 voiceIndex: 0 freqIndex: 5
[14 Sep 2018 22:43:24.516] Information, removing object from the ttsQueue: Controller object from C94 msgIndex: 85 voiceIndex: 0 freqIndex: 5
[14 Sep 2018 22:43:24.516] Information, sending tts queue item to SayAsSent: Pilot object from AMF1288 msgIndex: 86 voiceIndex: 5 freqIndex: 0
[14 Sep 2018 22:43:24.516] Information, building pilot tts for AMF1288
[14 Sep 2018 22:43:24.516] Information, sending GenerateWAVfile to ttsProcessor: Pilot object from AMF1288 msgIndex: 86 voiceIndex: 5 freqIndex: 0
[14 Sep 2018 22:43:24.516] Entering GenerateWAVfile
[14 Sep 2018 22:43:24.516] VoiceNumber = 2  Name: William
[14 Sep 2018 22:43:24.516] ReadbackIndex = 86  VoiceNumber = 2  Readback: <prosody rate="150%">missed approach for amflight twelve eighty eight</prosody>
[14 Sep 2018 22:43:24.518] Channel pointer = 1   Voice No. = 2 Voice Name = William
[14 Sep 2018 22:43:24.619] ReadbackWAVfile = C:\ProgramData\Flag Mountain\ATCpro\Speech\Voices\OutputWAVfile0086.WAV
[14 Sep 2018 22:43:24.619] Exiting GenerateWAVfile
[14 Sep 2018 22:43:24.626] Information, ttsProcessor playback started event received, msgIndex: 86
[14 Sep 2018 22:43:25.514] Information, processing incoming tts request from N485KC
[14 Sep 2018 22:43:25.514] Information, adding item to the ttsQueue: Pilot object from N485KC msgIndex: 87 voiceIndex: 7 freqIndex: 5
[14 Sep 2018 22:43:25.515] Information, sending tts queue item to SayAsSent: Pilot object from N485KC msgIndex: 87 voiceIndex: 7 freqIndex: 5
[14 Sep 2018 22:43:25.515] Information, building pilot tts for N485KC
[14 Sep 2018 22:43:25.515] Information, sending GenerateWAVfile to ttsProcessor: Pilot object from N485KC msgIndex: 87 voiceIndex: 7 freqIndex: 5
[14 Sep 2018 22:43:26.847] Information, ttsProcessor playback completed event received, msgIndex: 86
[14 Sep 2018 22:43:26.857] Information, processing commands from object: Pilot object from AMF1288 msgIndex: 86 voiceIndex: 5 freqIndex: 0
[14 Sep 2018 22:43:26.857] Information, removing object from the ttsQueue: Pilot object from AMF1288 msgIndex: 86 voiceIndex: 5 freqIndex: 0
[14 Sep 2018 22:43:28.513] Information, ttsProcessor playback completed event received, msgIndex: 87
[14 Sep 2018 22:43:28.513] Information, processing commands from object: Pilot object from N485KC msgIndex: 87 voiceIndex: 7 freqIndex: 5
[14 Sep 2018 22:43:28.513] Information, removing object from the ttsQueue: Pilot object from N485KC msgIndex: 87 voiceIndex: 7 freqIndex: 5
[14 Sep 2018 22:43:35.593] Information, current local time 10:16 (4936)
[14 Sep 2018 22:43:35.644] Information, adding flight to active list (20): N781XXvoice: 4plan: KAEG to MMPE outbound IFR
[14 Sep 2018 22:43:35.644] Information, adding flight to active list (21): N182MVvoice: 5plan: KEYE to KABQ inbound IFR
[14 Sep 2018 22:43:35.644] Information, adding flight to active list (22): BURGLAR23voice: 6plan: KABQ to MORENCI outbound IFR
[14 Sep 2018 22:43:35.645] Information, loading commercial flights at 4936 local
[14 Sep 2018 22:43:37.514] Information, processing incoming tts request from N781XX
[14 Sep 2018 22:43:37.514] Information, no tts required, passing on commands to appropriate receiver
[14 Sep 2018 22:43:37.517] Information, processing incoming tts request from ET
[14 Sep 2018 22:43:37.517] Information, no tts required, passing on commands to appropriate receiver
[14 Sep 2018 22:43:38.517] Information, processing incoming tts request from 1N
[14 Sep 2018 22:43:38.517] Information, adding item to the ttsQueue: Controller object from 1N msgIndex: 88 voiceIndex: 0 freqIndex: 0
[14 Sep 2018 22:43:38.517] Information, sending tts queue item to SayAsSent: Controller object from 1N msgIndex: 88 voiceIndex: 0 freqIndex: 0
[14 Sep 2018 22:43:38.517] Information, sending GenerateWAVfile to ttsProcessor: Controller object from 1N msgIndex: 88 voiceIndex: 0 freqIndex: 0
[14 Sep 2018 22:43:38.517] Entering GenerateWAVfile
[14 Sep 2018 22:43:38.517] VoiceNumber = 3  Name: Katherine
[14 Sep 2018 22:43:38.517] ReadbackIndex = 88  VoiceNumber = 3  Readback: <prosody rate="150%">[albuquerque] north, double eagle [tower], request release baron one xray xray runway one seven</prosody>
[14 Sep 2018 22:43:38.519] Channel pointer = 1   Voice No. = 3 Voice Name = Katherine
[14 Sep 2018 22:43:38.780] ReadbackWAVfile = C:\ProgramData\Flag Mountain\ATCpro\Speech\Voices\OutputWAVfile0088.WAV
[14 Sep 2018 22:43:38.783] Exiting GenerateWAVfile
[14 Sep 2018 22:43:38.790] Information, ttsProcessor playback started event received, msgIndex: 88
[14 Sep 2018 22:43:43.516] Information, processing incoming tts request from BURGLAR23
[14 Sep 2018 22:43:43.516] Information, adding item to the ttsQueue: Pilot object from BURGLAR23 msgIndex: 89 voiceIndex: 6 freqIndex: 2
[14 Sep 2018 22:43:43.516] Information, sending tts queue item to SayAsSent: Pilot object from BURGLAR23 msgIndex: 89 voiceIndex: 6 freqIndex: 2
[14 Sep 2018 22:43:43.516] Information, building pilot tts for BURGLAR23
[14 Sep 2018 22:43:43.516] Information, sending GenerateWAVfile to ttsProcessor: Pilot object from BURGLAR23 msgIndex: 89 voiceIndex: 6 freqIndex: 2
[14 Sep 2018 22:43:43.646] Information, ttsProcessor playback completed event received, msgIndex: 88
[14 Sep 2018 22:43:43.656] Information, processing commands from object: Controller object from 1N msgIndex: 88 voiceIndex: 0 freqIndex: 0
[14 Sep 2018 22:43:43.656] Information, removing object from the ttsQueue: Controller object from 1N msgIndex: 88 voiceIndex: 0 freqIndex: 0
[14 Sep 2018 22:43:46.515] Information, ttsProcessor playback completed event received, msgIndex: 89
[14 Sep 2018 22:43:46.515] Information, processing commands from object: Pilot object from BURGLAR23 msgIndex: 89 voiceIndex: 6 freqIndex: 2
[14 Sep 2018 22:43:46.515] Information, removing object from the ttsQueue: Pilot object from BURGLAR23 msgIndex: 89 voiceIndex: 6 freqIndex: 2
[14 Sep 2018 22:43:47.514] Information, processing incoming tts request from 1T
[14 Sep 2018 22:43:47.514] Information, adding item to the ttsQueue: Controller object from 1T msgIndex: 90 voiceIndex: 0 freqIndex: 2
[14 Sep 2018 22:43:47.514] Information, sending tts queue item to SayAsSent: Controller object from 1T msgIndex: 90 voiceIndex: 0 freqIndex: 2
[14 Sep 2018 22:43:47.514] Information, sending GenerateWAVfile to ttsProcessor: Controller object from 1T msgIndex: 90 voiceIndex: 0 freqIndex: 2
[14 Sep 2018 22:43:51.519] Information, ttsProcessor playback completed event received, msgIndex: 90
[14 Sep 2018 22:43:51.519] Information, processing commands from object: Controller object from 1T msgIndex: 90 voiceIndex: 0 freqIndex: 2
[14 Sep 2018 22:43:51.519] Information, removing object from the ttsQueue: Controller object from 1T msgIndex: 90 voiceIndex: 0 freqIndex: 2
[14 Sep 2018 22:43:52.516] Information, processing incoming tts request from BURGLAR23
[14 Sep 2018 22:43:52.516] Information, adding item to the ttsQueue: Pilot object from BURGLAR23 msgIndex: 91 voiceIndex: 6 freqIndex: 2
[14 Sep 2018 22:43:52.516] Information, sending tts queue item to SayAsSent: Pilot object from BURGLAR23 msgIndex: 91 voiceIndex: 6 freqIndex: 2
[14 Sep 2018 22:43:52.516] Information, building pilot tts for BURGLAR23
[14 Sep 2018 22:43:52.517] Information, sending GenerateWAVfile to ttsProcessor: Pilot object from BURGLAR23 msgIndex: 91 voiceIndex: 6 freqIndex: 2
[14 Sep 2018 22:43:55.515] Information, ttsProcessor playback completed event received, msgIndex: 91
[14 Sep 2018 22:43:55.515] Information, processing commands from object: Pilot object from BURGLAR23 msgIndex: 91 voiceIndex: 6 freqIndex: 2
[14 Sep 2018 22:43:55.515] Information, removing object from the ttsQueue: Pilot object from BURGLAR23 msgIndex: 91 voiceIndex: 6 freqIndex: 2
[14 Sep 2018 22:43:56.575] Information, microphone count = 18
[14 Sep 2018 22:43:56.575] Information, user has pressed CtrlKey mic switch
[14 Sep 2018 22:43:56.589] StartRecording message received
[14 Sep 2018 22:43:56.589] waveIn is null
[14 Sep 2018 22:43:56.589] Calling vrxLiveRecognizer.  RecognizerHandle = 152822016
[14 Sep 2018 22:43:56.590] Entering StartRecording
[14 Sep 2018 22:43:56.596] Exiting StartRecording
[14 Sep 2018 22:43:56.596] After call to vrxLiveRecognizerStart.  errorCode = 0
[14 Sep 2018 22:43:56.596] Information, received recording started event from SRProcessor
[14 Sep 2018 22:43:56.596] Exiting StartStopRecognition
[14 Sep 2018 22:43:57.470] Information, entering onCtrlKeyReleased
[14 Sep 2018 22:43:57.470] Information, onCtrlKeyReleased tcwWindow isVisible
[14 Sep 2018 22:43:57.470] Information, onCtrlKeyReleased _srAvailable is TRUE
[14 Sep 2018 22:43:57.470] Information, user has released CtrlKey mic switch
[14 Sep 2018 22:43:57.483] StopRecording message received
[14 Sep 2018 22:43:57.483] Entering StopRecording
[14 Sep 2018 22:43:57.483] Exiting StopRecording
[14 Sep 2018 22:43:57.483] Information, received recording stopped event from SRProcessor
[14 Sep 2018 22:43:57.483] Exiting StartStopRecognition
[14 Sep 2018 22:43:57.483] Information, exiting onCtrlKeyReleased
[14 Sep 2018 22:43:57.524] Entering ProcessVRXInterpretation
[14 Sep 2018 22:43:57.524] VRX Interpretation: <?xml version="1.0" encoding="utf-8"?> <VRXResultsTop><a/></VRXResultsTop>
[14 Sep 2018 22:43:57.524] Exiting ReformatIncomingMsg
[14 Sep 2018 22:43:57.812] Information, microphone count = 19
[14 Sep 2018 22:43:57.812] Information, user has pressed CtrlKey mic switch
[14 Sep 2018 22:43:57.821] StartRecording message received
[14 Sep 2018 22:43:57.821] waveIn is null
[14 Sep 2018 22:43:57.821] Calling vrxLiveRecognizer.  RecognizerHandle = 152822016
[14 Sep 2018 22:43:57.822] Entering StartRecording
[14 Sep 2018 22:43:57.828] Exiting StartRecording
[14 Sep 2018 22:43:57.828] After call to vrxLiveRecognizerStart.  errorCode = 0
[14 Sep 2018 22:43:57.828] Information, received recording started event from SRProcessor
[14 Sep 2018 22:43:57.828] Exiting StartStopRecognition
[14 Sep 2018 22:43:58.514] Information, processing incoming tts request from N485KC
[14 Sep 2018 22:43:58.514] Information, no tts required, passing on commands to appropriate receiver
[14 Sep 2018 22:43:58.516] Information, processing incoming tts request from C94
[14 Sep 2018 22:43:58.516] Information, adding item to the ttsQueue: Controller object from C94 msgIndex: 92 voiceIndex: 0 freqIndex: 5
[14 Sep 2018 22:43:58.516] Information, sending tts queue item to SayAsSent: Controller object from C94 msgIndex: 92 voiceIndex: 0 freqIndex: 5
[14 Sep 2018 22:43:58.516] Information, sending GenerateWAVfile to ttsProcessor: Controller object from C94 msgIndex: 92 voiceIndex: 0 freqIndex: 5
[14 Sep 2018 22:44:01.520] Information, ttsProcessor playback completed event received, msgIndex: 92
[14 Sep 2018 22:44:01.520] Information, processing commands from object: Controller object from C94 msgIndex: 92 voiceIndex: 0 freqIndex: 5
[14 Sep 2018 22:44:01.521] Information, removing object from the ttsQueue: Controller object from C94 msgIndex: 92 voiceIndex: 0 freqIndex: 5
[14 Sep 2018 22:44:02.514] Information, processing incoming tts request from N485KC
[14 Sep 2018 22:44:02.514] Information, adding item to the ttsQueue: Pilot object from N485KC msgIndex: 93 voiceIndex: 7 freqIndex: 5
[14 Sep 2018 22:44:02.515] Information, sending tts queue item to SayAsSent: Pilot object from N485KC msgIndex: 93 voiceIndex: 7 freqIndex: 5
[14 Sep 2018 22:44:02.515] Information, building pilot tts for N485KC
[14 Sep 2018 22:44:02.515] Information, sending GenerateWAVfile to ttsProcessor: Pilot object from N485KC msgIndex: 93 voiceIndex: 7 freqIndex: 5
[14 Sep 2018 22:44:04.514] Information, ttsProcessor playback completed event received, msgIndex: 93
[14 Sep 2018 22:44:04.514] Information, processing commands from object: Pilot object from N485KC msgIndex: 93 voiceIndex: 7 freqIndex: 5
[14 Sep 2018 22:44:04.514] Information, removing object from the ttsQueue: Pilot object from N485KC msgIndex: 93 voiceIndex: 7 freqIndex: 5
[14 Sep 2018 22:44:05.107] Information, entering onCtrlKeyReleased
[14 Sep 2018 22:44:05.107] Information, onCtrlKeyReleased tcwWindow isVisible
[14 Sep 2018 22:44:05.107] Information, onCtrlKeyReleased _srAvailable is TRUE
[14 Sep 2018 22:44:05.107] Information, user has released CtrlKey mic switch
[14 Sep 2018 22:44:05.117] StopRecording message received
[14 Sep 2018 22:44:05.117] Entering StopRecording
[14 Sep 2018 22:44:05.118] Exiting StopRecording
[14 Sep 2018 22:44:05.118] Information, received recording stopped event from SRProcessor
[14 Sep 2018 22:44:05.118] Exiting StartStopRecognition
[14 Sep 2018 22:44:05.118] Information, exiting onCtrlKeyReleased
[14 Sep 2018 22:44:05.261] Entering ProcessVRXInterpretation
[14 Sep 2018 22:44:05.261] VRX Interpretation: <?xml version="1.0" encoding="utf-8"?> <VRXResultsTop><a>
<callsign>AMF1288</callsign>
<cc_source>VPI_RADAR_CONTROLLER</cc_source>
<com1>
<command>
<commandName>VOICE_REC_ALTITUDE</commandName>
<lLevel>8300</lLevel>
<szLevel>eight thousand three hundred</szLevel>
<enAchieveCommand>MAINTAIN_ALTITUDE</enAchieveCommand>
<enDecisionState></enDecisionState>
</command>
</com1>
<com2>
<command>
<commandName>VOICE_REC_HEADING</commandName>
<enHeadingType>HEADING_TYPE_ABSOLUTE</enHeadingType>
<lHeading>040</lHeading>
<enDirection>DIRECTION_RIGHT</enDirection>
<enHeadingInstruction>HDG_TURN</enHeadingInstruction>
</command>
</com2>
</a></VRXResultsTop>
[14 Sep 2018 22:44:05.261] Exiting ReformatIncomingMsg
[14 Sep 2018 22:44:05.261] VRX Best Hypothesis: amflight twelve eighty eight center maintain eight thousand three hundred turn right heading zero four zero
[14 Sep 2018 22:44:05.261] Entering ParseVRXInterpretation
[14 Sep 2018 22:44:05.261] Information, beginning parse of altitude type speech recognition command
[14 Sep 2018 22:44:05.261] Information, beginning parse of heading type speech recognition command
[14 Sep 2018 22:44:05.262] OutgoingVRXResult = AMF1288:390:8300@100:040
[14 Sep 2018 22:44:05.262] Exiting ParseIncomingMsg
[14 Sep 2018 22:44:05.262] Exiting ProcessVRXInterpretation
[14 Sep 2018 22:44:05.513] Information, processing incoming tts request from AMF1288
[14 Sep 2018 22:44:05.513] Information, adding item to the ttsQueue: Pilot object from AMF1288 msgIndex: 94 voiceIndex: 5 freqIndex: 0
[14 Sep 2018 22:44:05.515] Information, sending tts queue item to SayAsSent: Pilot object from AMF1288 msgIndex: 94 voiceIndex: 5 freqIndex: 0
[14 Sep 2018 22:44:05.515] Information, building pilot tts for AMF1288
[14 Sep 2018 22:44:05.515] Information, sending GenerateWAVfile to ttsProcessor: Pilot object from AMF1288 msgIndex: 94 voiceIndex: 5 freqIndex: 0
[14 Sep 2018 22:44:05.515] Entering GenerateWAVfile
[14 Sep 2018 22:44:05.515] VoiceNumber = 2  Name: William
[14 Sep 2018 22:44:05.515] ReadbackIndex = 94  VoiceNumber = 2  Readback: <prosody rate="150%">descending to eight thousand three hundred  zero four zero  amflight twelve eighty eight</prosody>
[14 Sep 2018 22:44:05.517] Channel pointer = 1   Voice No. = 2 Voice Name = William
[14 Sep 2018 22:44:05.697] ReadbackWAVfile = C:\ProgramData\Flag Mountain\ATCpro\Speech\Voices\OutputWAVfile0094.WAV
[14 Sep 2018 22:44:05.697] Exiting GenerateWAVfile
[14 Sep 2018 22:44:05.706] Information, ttsProcessor playback started event received, msgIndex: 94
[14 Sep 2018 22:44:09.597] Information, ttsProcessor playback completed event received, msgIndex: 94
[14 Sep 2018 22:44:09.607] Information, processing commands from object: Pilot object from AMF1288 msgIndex: 94 voiceIndex: 5 freqIndex: 0
[14 Sep 2018 22:44:09.607] Information, removing object from the ttsQueue: Pilot object from AMF1288 msgIndex: 94 voiceIndex: 5 freqIndex: 0
[14 Sep 2018 22:44:11.515] Information, processing incoming tts request from N960JM
[14 Sep 2018 22:44:11.515] Information, no tts required, passing on commands to appropriate receiver
[14 Sep 2018 22:44:12.514] Information, processing incoming tts request from VFR
[14 Sep 2018 22:44:12.514] Warning, (IncomingATCTTS) Unable to find etvsFrequencyInformation for freqIndex: 000.0
[14 Sep 2018 22:44:35.592] Information, current local time 10:17 (4937)
[14 Sep 2018 22:44:35.644] Information, loading commercial flights at 4937 local
[14 Sep 2018 22:44:44.515] Information, processing incoming tts request from 1T
[14 Sep 2018 22:44:44.515] Information, adding item to the ttsQueue: Controller object from 1T msgIndex: 95 voiceIndex: 0 freqIndex: 2
[14 Sep 2018 22:44:44.515] Information, sending tts queue item to SayAsSent: Controller object from 1T msgIndex: 95 voiceIndex: 0 freqIndex: 2
[14 Sep 2018 22:44:44.516] Information, sending GenerateWAVfile to ttsProcessor: Controller object from 1T msgIndex: 95 voiceIndex: 0 freqIndex: 2
[14 Sep 2018 22:44:45.044] Information, microphone count = 20
[14 Sep 2018 22:44:45.044] Information, user has pressed CtrlKey mic switch
[14 Sep 2018 22:44:45.054] StartRecording message received
[14 Sep 2018 22:44:45.054] waveIn is null
[14 Sep 2018 22:44:45.054] Calling vrxLiveRecognizer.  RecognizerHandle = 152822016
[14 Sep 2018 22:44:45.054] Entering StartRecording
[14 Sep 2018 22:44:45.061] Exiting StartRecording
[14 Sep 2018 22:44:45.061] After call to vrxLiveRecognizerStart.  errorCode = 0
[14 Sep 2018 22:44:45.061] Information, received recording started event from SRProcessor
[14 Sep 2018 22:44:45.061] Exiting StartStopRecognition
[14 Sep 2018 22:44:45.514] Information, processing incoming tts request from N328AN
[14 Sep 2018 22:44:45.514] Information, no tts required, passing on commands to appropriate receiver
[14 Sep 2018 22:44:48.515] Information, processing incoming tts request from ET
[14 Sep 2018 22:44:48.515] Information, adding item to the ttsQueue: Controller object from ET msgIndex: 96 voiceIndex: 0 freqIndex: 6
[14 Sep 2018 22:44:48.516] Information, ttsProcessor playback completed event received, msgIndex: 95
[14 Sep 2018 22:44:48.516] Information, processing commands from object: Controller object from 1T msgIndex: 95 voiceIndex: 0 freqIndex: 2
[14 Sep 2018 22:44:48.516] Information, removing object from the ttsQueue: Controller object from 1T msgIndex: 95 voiceIndex: 0 freqIndex: 2
[14 Sep 2018 22:44:48.516] Information, sending tts queue item to SayAsSent: Controller object from ET msgIndex: 96 voiceIndex: 0 freqIndex: 6
[14 Sep 2018 22:44:48.516] Information, sending GenerateWAVfile to ttsProcessor: Controller object from ET msgIndex: 96 voiceIndex: 0 freqIndex: 6
[14 Sep 2018 22:44:49.514] Information, processing incoming tts request from BURGLAR23
[14 Sep 2018 22:44:49.514] Information, adding item to the ttsQueue: Pilot object from BURGLAR23 msgIndex: 97 voiceIndex: 6 freqIndex: 2
[14 Sep 2018 22:44:49.514] Information, sending tts queue item to SayAsSent: Pilot object from BURGLAR23 msgIndex: 97 voiceIndex: 6 freqIndex: 2
[14 Sep 2018 22:44:49.514] Information, building pilot tts for BURGLAR23
[14 Sep 2018 22:44:49.514] Information, sending GenerateWAVfile to ttsProcessor: Pilot object from BURGLAR23 msgIndex: 97 voiceIndex: 6 freqIndex: 2
[14 Sep 2018 22:44:50.467] Information, entering onCtrlKeyReleased
[14 Sep 2018 22:44:50.467] Information, onCtrlKeyReleased tcwWindow isVisible
[14 Sep 2018 22:44:50.467] Information, onCtrlKeyReleased _srAvailable is TRUE
[14 Sep 2018 22:44:50.467] Information, user has released CtrlKey mic switch
[14 Sep 2018 22:44:50.477] StopRecording message received
[14 Sep 2018 22:44:50.477] Entering StopRecording
[14 Sep 2018 22:44:50.477] Exiting StopRecording
[14 Sep 2018 22:44:50.477] Information, received recording stopped event from SRProcessor
[14 Sep 2018 22:44:50.477] Exiting StartStopRecognition
[14 Sep 2018 22:44:50.477] Information, exiting onCtrlKeyReleased
[14 Sep 2018 22:44:50.606] Entering ProcessVRXInterpretation
[14 Sep 2018 22:44:50.606] VRX Interpretation: <?xml version="1.0" encoding="utf-8"?> <VRXResultsTop><a>
<callsign>AMF1288</callsign>
<cc_source>VPI_RADAR_CONTROLLER</cc_source>
<com1>
<command>
<commandName>VOICE_REC_REPORT_REQUEST</commandName>
<enReportRequestType>VRREP_APT_IN_SIGHT_DIR_DIST</enReportRequestType>
<enDirection>9</enDirection>
<distance>1</distance>
</command>
</com1>
</a></VRXResultsTop>
[14 Sep 2018 22:44:50.606] Exiting ReformatIncomingMsg
[14 Sep 2018 22:44:50.606] VRX Best Hypothesis: amflight twelve eighty eight report airport in sight nine oclock one mile
[14 Sep 2018 22:44:50.606] Entering ParseVRXInterpretation
[14 Sep 2018 22:44:50.610] Information, beginning parse of Miscellaneous speech recognition command
[14 Sep 2018 22:44:50.610] OutgoingVRXResult = AMF1288:790:9:1
[14 Sep 2018 22:44:50.610] Exiting ParseIncomingMsg
[14 Sep 2018 22:44:50.610] Exiting ProcessVRXInterpretation
[14 Sep 2018 22:44:51.514] Information, processing incoming tts request from AMF1288
[14 Sep 2018 22:44:51.514] Information, adding item to the ttsQueue: Pilot object from AMF1288 msgIndex: 98 voiceIndex: 5 freqIndex: 0
[14 Sep 2018 22:44:51.523] Information, ttsProcessor playback completed event received, msgIndex: 96
[14 Sep 2018 22:44:51.523] Information, processing commands from object: Controller object from ET msgIndex: 96 voiceIndex: 0 freqIndex: 6
[14 Sep 2018 22:44:51.523] Information, removing object from the ttsQueue: Controller object from ET msgIndex: 96 voiceIndex: 0 freqIndex: 6
[14 Sep 2018 22:44:51.523] Information, sending tts queue item to SayAsSent: Pilot object from AMF1288 msgIndex: 98 voiceIndex: 5 freqIndex: 0
[14 Sep 2018 22:44:51.523] Information, building pilot tts for AMF1288
[14 Sep 2018 22:44:51.523] Information, sending GenerateWAVfile to ttsProcessor: Pilot object from AMF1288 msgIndex: 98 voiceIndex: 5 freqIndex: 0
[14 Sep 2018 22:44:51.523] Entering GenerateWAVfile
[14 Sep 2018 22:44:51.523] VoiceNumber = 2  Name: William
[14 Sep 2018 22:44:51.523] ReadbackIndex = 98  VoiceNumber = 2  Readback: <prosody rate="150%">airport in sight amflight twelve eighty eight</prosody>
[14 Sep 2018 22:44:51.525] Channel pointer = 1   Voice No. = 2 Voice Name = William
[14 Sep 2018 22:44:51.599] ReadbackWAVfile = C:\ProgramData\Flag Mountain\ATCpro\Speech\Voices\OutputWAVfile0098.WAV
[14 Sep 2018 22:44:51.599] Exiting GenerateWAVfile
[14 Sep 2018 22:44:51.607] Information, ttsProcessor playback started event received, msgIndex: 98
[14 Sep 2018 22:44:52.515] Information, processing incoming tts request from N328AN
[14 Sep 2018 22:44:52.515] Information, adding item to the ttsQueue: Pilot object from N328AN msgIndex: 99 voiceIndex: 1 freqIndex: 6
[14 Sep 2018 22:44:52.516] Information, ttsProcessor playback completed event received, msgIndex: 97
[14 Sep 2018 22:44:52.516] Information, processing commands from object: Pilot object from BURGLAR23 msgIndex: 97 voiceIndex: 6 freqIndex: 2
[14 Sep 2018 22:44:52.516] Information, removing object from the ttsQueue: Pilot object from BURGLAR23 msgIndex: 97 voiceIndex: 6 freqIndex: 2
[14 Sep 2018 22:44:52.516] Information, sending tts queue item to SayAsSent: Pilot object from N328AN msgIndex: 99 voiceIndex: 1 freqIndex: 6
[14 Sep 2018 22:44:52.516] Information, building pilot tts for N328AN
[14 Sep 2018 22:44:52.516] Information, sending GenerateWAVfile to ttsProcessor: Pilot object from N328AN msgIndex: 99 voiceIndex: 1 freqIndex: 6
[14 Sep 2018 22:44:53.514] Information, processing incoming tts request from SWA2202
[14 Sep 2018 22:44:53.514] Information, adding item to the ttsQueue: Pilot object from SWA2202 msgIndex: 100 voiceIndex: 13 freqIndex: 0
[14 Sep 2018 22:44:53.515] Information, processing incoming tts request from BURGLAR23
[14 Sep 2018 22:44:53.515] Information, adding item to the ttsQueue: Pilot object from BURGLAR23 msgIndex: 101 voiceIndex: 6 freqIndex: 1
[14 Sep 2018 22:44:53.516] Information, sending tts queue item to SayAsSent: Pilot object from BURGLAR23 msgIndex: 101 voiceIndex: 6 freqIndex: 1
[14 Sep 2018 22:44:53.516] Information, building pilot tts for BURGLAR23
[14 Sep 2018 22:44:53.516] Information, sending GenerateWAVfile to ttsProcessor: Pilot object from BURGLAR23 msgIndex: 101 voiceIndex: 6 freqIndex: 1
[14 Sep 2018 22:44:53.516] Entering GenerateWAVfile
[14 Sep 2018 22:44:53.516] VoiceNumber = 3  Name: Katherine
[14 Sep 2018 22:44:53.516] ReadbackIndex = 101  VoiceNumber = 3  Readback: <prosody rate="150%">albuquerque departure good morning burglar twenty three   is with you climbing out of five thousand eight hundred for niner thousand </prosody>
[14 Sep 2018 22:44:53.519] Channel pointer = 1   Voice No. = 3 Voice Name = Katherine
[14 Sep 2018 22:44:53.789] ReadbackWAVfile = C:\ProgramData\Flag Mountain\ATCpro\Speech\Voices\OutputWAVfile0101.WAV
[14 Sep 2018 22:44:53.789] Exiting GenerateWAVfile
[14 Sep 2018 22:44:53.800] Information, ttsProcessor playback started event received, msgIndex: 101
[14 Sep 2018 22:44:53.996] Information, ttsProcessor playback completed event received, msgIndex: 98
[14 Sep 2018 22:44:54.006] Information, processing commands from object: Pilot object from AMF1288 msgIndex: 98 voiceIndex: 5 freqIndex: 0
[14 Sep 2018 22:44:54.006] Information, removing object from the ttsQueue: Pilot object from AMF1288 msgIndex: 98 voiceIndex: 5 freqIndex: 0
[14 Sep 2018 22:44:54.515] Information, sending tts queue item to SayAsSent: Pilot object from SWA2202 msgIndex: 100 voiceIndex: 13 freqIndex: 0
[14 Sep 2018 22:44:54.515] Information, building pilot tts for SWA2202
[14 Sep 2018 22:44:54.515] Information, sending GenerateWAVfile to ttsProcessor: Pilot object from SWA2202 msgIndex: 100 voiceIndex: 13 freqIndex: 0
[14 Sep 2018 22:44:54.515] Entering GenerateWAVfile
[14 Sep 2018 22:44:54.515] VoiceNumber = 1  Name: Nathan
[14 Sep 2018 22:44:54.516] ReadbackIndex = 100  VoiceNumber = 1  Readback: <prosody rate="150%">airport in sight southwest twenty two zero two</prosody>
[14 Sep 2018 22:44:54.518] Channel pointer = 1   Voice No. = 1 Voice Name = Nathan
[14 Sep 2018 22:44:54.603] ReadbackWAVfile = C:\ProgramData\Flag Mountain\ATCpro\Speech\Voices\OutputWAVfile0100.WAV
[14 Sep 2018 22:44:54.603] Exiting GenerateWAVfile
[14 Sep 2018 22:44:54.611] Information, ttsProcessor playback started event received, msgIndex: 100
[14 Sep 2018 22:44:55.514] Information, ttsProcessor playback completed event received, msgIndex: 99
[14 Sep 2018 22:44:55.514] Information, processing commands from object: Pilot object from N328AN msgIndex: 99 voiceIndex: 1 freqIndex: 6
[14 Sep 2018 22:44:55.514] Information, removing object from the ttsQueue: Pilot object from N328AN msgIndex: 99 voiceIndex: 1 freqIndex: 6
[14 Sep 2018 22:44:56.997] Information, ttsProcessor playback completed event received, msgIndex: 100
[14 Sep 2018 22:44:57.007] Information, processing commands from object: Pilot object from SWA2202 msgIndex: 100 voiceIndex: 13 freqIndex: 0
[14 Sep 2018 22:44:57.007] Information, removing object from the ttsQueue: Pilot object from SWA2202 msgIndex: 100 voiceIndex: 13 freqIndex: 0
[14 Sep 2018 22:44:58.497] Information, ttsProcessor playback completed event received, msgIndex: 101
[14 Sep 2018 22:44:58.507] Information, processing commands from object: Pilot object from BURGLAR23 msgIndex: 101 voiceIndex: 6 freqIndex: 1
[14 Sep 2018 22:44:58.507] Information, removing object from the ttsQueue: Pilot object from BURGLAR23 msgIndex: 101 voiceIndex: 6 freqIndex: 1
[14 Sep 2018 22:45:03.248] Information, microphone count = 21
[14 Sep 2018 22:45:03.248] Information, user has pressed CtrlKey mic switch
[14 Sep 2018 22:45:03.259] StartRecording message received
[14 Sep 2018 22:45:03.259] waveIn is null
[14 Sep 2018 22:45:03.259] Calling vrxLiveRecognizer.  RecognizerHandle = 152822016
[14 Sep 2018 22:45:03.259] Entering StartRecording
[14 Sep 2018 22:45:03.266] Exiting StartRecording
[14 Sep 2018 22:45:03.266] After call to vrxLiveRecognizerStart.  errorCode = 0
[14 Sep 2018 22:45:03.266] Information, received recording started event from SRProcessor
[14 Sep 2018 22:45:03.266] Exiting StartStopRecognition
[14 Sep 2018 22:45:06.472] Information, entering onCtrlKeyReleased
[14 Sep 2018 22:45:06.472] Information, onCtrlKeyReleased tcwWindow isVisible
[14 Sep 2018 22:45:06.472] Information, onCtrlKeyReleased _srAvailable is TRUE
[14 Sep 2018 22:45:06.472] Information, user has released CtrlKey mic switch
[14 Sep 2018 22:45:06.482] StopRecording message received
[14 Sep 2018 22:45:06.482] Entering StopRecording
[14 Sep 2018 22:45:06.483] Exiting StopRecording
[14 Sep 2018 22:45:06.483] Information, received recording stopped event from SRProcessor
[14 Sep 2018 22:45:06.483] Exiting StartStopRecognition
[14 Sep 2018 22:45:06.483] Information, exiting onCtrlKeyReleased
[14 Sep 2018 22:45:06.613] Entering ProcessVRXInterpretation
[14 Sep 2018 22:45:06.613] VRX Interpretation: <?xml version="1.0" encoding="utf-8"?> <VRXResultsTop><a>
<callsign>BURGLAR23</callsign>
<cc_source>VPI_RADAR_CONTROLLER</cc_source>
<com1>
<command>
<commandName>VOICE_REC_ALTITUDE</commandName>
<lLevel>20000</lLevel>
<szLevel>two zero zero</szLevel>
<enDecisionState></enDecisionState>
<enAchieveCommand>ACHIEVE_CMD_CLIMB</enAchieveCommand>
</command>
</com1>
<com2>
<command>
<commandName>SEQUENCE_CMD</commandName>
</command>
</com2>
</a></VRXResultsTop>
[14 Sep 2018 22:45:06.613] Exiting ReformatIncomingMsg
[14 Sep 2018 22:45:06.613] VRX Best Hypothesis: burglar twenty three climb and maintain flight level two zero zero then
[14 Sep 2018 22:45:06.613] Entering ParseVRXInterpretation
[14 Sep 2018 22:45:06.613] Information, beginning parse of altitude type speech recognition command
[14 Sep 2018 22:45:06.613] OutgoingVRXResult = BURGLAR23:360:20000@1360
[14 Sep 2018 22:45:06.613] Exiting ParseIncomingMsg
[14 Sep 2018 22:45:06.613] Exiting ProcessVRXInterpretation
[14 Sep 2018 22:45:07.522] Information, processing incoming tts request from BURGLAR23
[14 Sep 2018 22:45:07.522] Information, adding item to the ttsQueue: Pilot object from BURGLAR23 msgIndex: 102 voiceIndex: 6 freqIndex: 1
[14 Sep 2018 22:45:07.522] Information, sending tts queue item to SayAsSent: Pilot object from BURGLAR23 msgIndex: 102 voiceIndex: 6 freqIndex: 1
[14 Sep 2018 22:45:07.522] Information, building pilot tts for BURGLAR23
[14 Sep 2018 22:45:07.522] Information, sending GenerateWAVfile to ttsProcessor: Pilot object from BURGLAR23 msgIndex: 102 voiceIndex: 6 freqIndex: 1
[14 Sep 2018 22:45:07.522] Entering GenerateWAVfile
[14 Sep 2018 22:45:07.522] VoiceNumber = 3  Name: Katherine
[14 Sep 2018 22:45:07.522] ReadbackIndex = 102  VoiceNumber = 3  Readback: <prosody rate="150%">climb and maintain flight level two zero zero   burglar twenty three</prosody>
[14 Sep 2018 22:45:07.524] Channel pointer = 1   Voice No. = 3 Voice Name = Katherine
[14 Sep 2018 22:45:07.664] ReadbackWAVfile = C:\ProgramData\Flag Mountain\ATCpro\Speech\Voices\OutputWAVfile0102.WAV
[14 Sep 2018 22:45:07.664] Exiting GenerateWAVfile
[14 Sep 2018 22:45:07.672] Information, ttsProcessor playback started event received, msgIndex: 102
[14 Sep 2018 22:45:10.647] Information, ttsProcessor playback completed event received, msgIndex: 102
[14 Sep 2018 22:45:10.656] Information, processing commands from object: Pilot object from BURGLAR23 msgIndex: 102 voiceIndex: 6 freqIndex: 1
[14 Sep 2018 22:45:10.656] Information, removing object from the ttsQueue: Pilot object from BURGLAR23 msgIndex: 102 voiceIndex: 6 freqIndex: 1
[14 Sep 2018 22:45:26.297] Information, microphone count = 22
[14 Sep 2018 22:45:26.297] Information, user has pressed CtrlKey mic switch
[14 Sep 2018 22:45:26.306] StartRecording message received
[14 Sep 2018 22:45:26.306] waveIn is null
[14 Sep 2018 22:45:26.306] Calling vrxLiveRecognizer.  RecognizerHandle = 152822016
[14 Sep 2018 22:45:26.307] Entering StartRecording
[14 Sep 2018 22:45:26.314] Exiting StartRecording
[14 Sep 2018 22:45:26.314] After call to vrxLiveRecognizerStart.  errorCode = 0
[14 Sep 2018 22:45:26.314] Information, received recording started event from SRProcessor
[14 Sep 2018 22:45:26.314] Exiting StartStopRecognition
[14 Sep 2018 22:45:32.269] Information, entering onCtrlKeyReleased
[14 Sep 2018 22:45:32.269] Information, onCtrlKeyReleased tcwWindow isVisible
[14 Sep 2018 22:45:32.269] Information, onCtrlKeyReleased _srAvailable is TRUE
[14 Sep 2018 22:45:32.269] Information, user has released CtrlKey mic switch
[14 Sep 2018 22:45:32.280] StopReco
Back to Top
hnorgaar View Drop Down
Member
Member


Joined: 24 Aug 2016
Status: Offline
Points: 91
Post Options Post Options   Thanks (0) Thanks(0)   Quote hnorgaar Quote  Post ReplyReply Direct Link To This Post Posted: 15 Sep 2018 at 12:39am
First thing that comes to my mind Microsoft Framework, you seems to be using a very old version, however you are not mentioning what operating system you are using.

Second thing that I think about is Antivirus, plus are you using a UHD monitor, if so try to use 1920x1080 resolution

Henrik
Back to Top
Tom@FlagMountain View Drop Down
Admin Group
Admin Group


Joined: 22 Oct 2014
Location: Albuquerque, NM
Status: Offline
Points: 507
Post Options Post Options   Thanks (0) Thanks(0)   Quote Tom@FlagMountain Quote  Post ReplyReply Direct Link To This Post Posted: 23 Sep 2018 at 7:37pm
esel:

Don't see anything obvious in your log file, although the comments from hnorgaar are worth noting.  Not sure what to do to try to help you.

I don't think it is your mouse, but you might try the other suggestions.

Once you have resolved the problem, please be sure to post the information here.

Regards

Tom


Edited by Tom@FlagMountain - 23 Sep 2018 at 7:42pm
Tom Murdock
Flag Mountain Software
ATCpro Project Team
Back to Top
 Post Reply Post Reply
  Share Topic   

Forum Jump Forum Permissions View Drop Down

Forum Software by Web Wiz Forums® version 11.10
Copyright ©2001-2017 Web Wiz Ltd.

This page was generated in 0.156 seconds.