2019-02-08T05:29:41.741Z,1549603781.741 [Supervisor](DEBUG): Initializing supervisor. 2019-02-08T05:29:41.744Z,1549603781.744 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2019-02-08T05:29:41.745Z,1549603781.745 [SyncHandler](INFO): Protected caller Thread ID is 4540 2019-02-08T05:29:41.745Z,1549603781.745 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2019-02-08T05:29:41.747Z,1549603781.747 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2019-02-08T05:29:41.747Z,1549603781.747 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 4541 2019-02-08T05:29:41.750Z,1549603781.750 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2019-02-08T05:29:41.762Z,1549603781.762 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2019-02-08T05:29:41.763Z,1549603781.763 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2019-02-08T05:29:41.764Z,1549603781.764 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 4542 2019-02-08T05:29:41.764Z,1549603781.764 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2019-02-08T05:29:41.765Z,1549603781.765 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2019-02-08T05:29:41.766Z,1549603781.766 [logger ThreadHandler](INFO): Protected caller Thread ID is 4543 2019-02-08T05:29:41.768Z,1549603781.768 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2019-02-08T05:29:41.768Z,1549603781.768 [Supervisor](INFO): Looking for Config files in directory: Config/ 2019-02-08T05:29:41.770Z,1549603781.770 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2019-02-08T05:29:41.862Z,1549603781.862 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2019-02-08T05:29:41.863Z,1549603781.863 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2019-02-08T05:29:42.055Z,1549603782.055 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2019-02-08T05:29:42.056Z,1549603782.056 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2019-02-08T05:29:42.189Z,1549603782.189 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2019-02-08T05:29:42.189Z,1549603782.189 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2019-02-08T05:29:42.641Z,1549603782.641 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2019-02-08T05:29:42.641Z,1549603782.641 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2019-02-08T05:29:43.069Z,1549603783.069 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2019-02-08T05:29:43.070Z,1549603783.070 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2019-02-08T05:29:43.534Z,1549603783.534 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2019-02-08T05:29:43.535Z,1549603783.535 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2019-02-08T05:29:43.835Z,1549603783.835 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2019-02-08T05:29:43.835Z,1549603783.835 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2019-02-08T05:29:44.173Z,1549603784.173 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2019-02-08T05:29:44.174Z,1549603784.174 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2019-02-08T05:29:44.724Z,1549603784.724 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2019-02-08T05:29:44.725Z,1549603784.725 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2019-02-08T05:29:44.949Z,1549603784.949 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2019-02-08T05:29:44.949Z,1549603784.949 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2019-02-08T05:29:45.053Z,1549603785.053 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2019-02-08T05:29:45.054Z,1549603785.054 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2019-02-08T05:29:45.133Z,1549603785.133 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2019-02-08T05:29:45.233Z,1549603785.233 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample 2019-02-08T05:29:45.233Z,1549603785.233 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2019-02-08T05:29:45.424Z,1549603785.424 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2019-02-08T05:29:45.424Z,1549603785.424 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2019-02-08T05:29:45.626Z,1549603785.626 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2019-02-08T05:29:45.628Z,1549603785.628 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/ 2019-02-08T05:29:45.629Z,1549603785.629 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg 2019-02-08T05:29:45.711Z,1549603785.711 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg 2019-02-08T05:29:45.944Z,1549603785.944 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2019-02-08T05:29:45.944Z,1549603785.944 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg 2019-02-08T05:29:46.037Z,1549603786.037 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg 2019-02-08T05:29:46.193Z,1549603786.193 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg 2019-02-08T05:29:46.392Z,1549603786.392 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg 2019-02-08T05:29:46.502Z,1549603786.502 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg 2019-02-08T05:29:46.673Z,1549603786.673 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg 2019-02-08T05:29:46.889Z,1549603786.889 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg 2019-02-08T05:29:47.157Z,1549603787.157 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg 2019-02-08T05:29:47.338Z,1549603787.338 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg 2019-02-08T05:29:47.703Z,1549603787.703 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg 2019-02-08T05:29:47.705Z,1549603787.705 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2019-02-08T05:29:47.808Z,1549603787.808 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2019-02-08T05:29:47.808Z,1549603787.808 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2019-02-08T05:29:47.913Z,1549603787.913 [BuoyancyServo] Loaded 2019-02-08T05:29:47.914Z,1549603787.914 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2019-02-08T05:29:47.929Z,1549603787.929 [ElevatorServo] Loaded 2019-02-08T05:29:47.929Z,1549603787.929 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2019-02-08T05:29:47.944Z,1549603787.944 [MassServo] Loaded 2019-02-08T05:29:47.944Z,1549603787.944 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2019-02-08T05:29:47.960Z,1549603787.960 [RudderServo] Loaded 2019-02-08T05:29:47.960Z,1549603787.960 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2019-02-08T05:29:47.974Z,1549603787.974 [ThrusterServo] Loaded 2019-02-08T05:29:47.975Z,1549603787.974 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread. 2019-02-08T05:29:47.975Z,1549603787.975 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2019-02-08T05:29:47.975Z,1549603787.975 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2019-02-08T05:29:48.115Z,1549603788.115 [SBIT](DEBUG): Construct Startup Built In Test. 2019-02-08T05:29:48.145Z,1549603788.145 [SBIT] Loaded 2019-02-08T05:29:48.145Z,1549603788.145 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2019-02-08T05:29:48.146Z,1549603788.146 [IBIT](DEBUG): Construct Initiated Built In Test. 2019-02-08T05:29:48.174Z,1549603788.174 [IBIT] Loaded 2019-02-08T05:29:48.174Z,1549603788.174 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2019-02-08T05:29:48.177Z,1549603788.177 [CBIT](DEBUG): Construct Continuous Built In Test. 2019-02-08T05:29:48.573Z,1549603788.573 [CBIT] Loaded 2019-02-08T05:29:48.573Z,1549603788.573 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2019-02-08T05:29:48.573Z,1549603788.573 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2019-02-08T05:29:48.574Z,1549603788.574 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2019-02-08T05:29:48.753Z,1549603788.753 [Aanderaa_O2] Loaded 2019-02-08T05:29:48.753Z,1549603788.753 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread. 2019-02-08T05:29:48.763Z,1549603788.763 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_density 2019-02-08T05:29:48.768Z,1549603788.768 [CTD_Seabird](INFO): created writer for : sea_water_density 2019-02-08T05:29:48.770Z,1549603788.770 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): depth 2019-02-08T05:29:48.775Z,1549603788.775 [CTD_Seabird](INFO): created writer for : depth 2019-02-08T05:29:48.776Z,1549603788.776 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_pressure 2019-02-08T05:29:48.781Z,1549603788.781 [CTD_Seabird](INFO): created writer for : sea_water_pressure 2019-02-08T05:29:48.782Z,1549603788.782 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_salinity 2019-02-08T05:29:48.787Z,1549603788.787 [CTD_Seabird](INFO): created writer for : sea_water_salinity 2019-02-08T05:29:48.787Z,1549603788.787 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_temperature 2019-02-08T05:29:48.793Z,1549603788.793 [CTD_Seabird](INFO): created writer for : sea_water_temperature 2019-02-08T05:29:48.794Z,1549603788.794 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_electrical_conductivity 2019-02-08T05:29:48.799Z,1549603788.799 [CTD_Seabird](INFO): created writer for : sea_water_electrical_conductivity 2019-02-08T05:29:48.800Z,1549603788.800 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): speed_of_sound_in_sea_water 2019-02-08T05:29:48.805Z,1549603788.805 [CTD_Seabird](INFO): created writer for : speed_of_sound_in_sea_water 2019-02-08T05:29:48.832Z,1549603788.832 [CTD_Seabird] Loaded 2019-02-08T05:29:48.833Z,1549603788.833 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2019-02-08T05:29:48.834Z,1549603788.834 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 4062E4E0 2019-02-08T05:29:48.834Z,1549603788.834 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 4622 2019-02-08T05:29:48.855Z,1549603788.855 [ESPComponent] Loaded 2019-02-08T05:29:48.856Z,1549603788.856 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread. 2019-02-08T05:29:48.870Z,1549603788.870 [PAR_Licor] Loaded 2019-02-08T05:29:48.870Z,1549603788.870 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2019-02-08T05:29:48.919Z,1549603788.919 [WetLabsBB2FL] Loaded 2019-02-08T05:29:48.919Z,1549603788.919 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2019-02-08T05:29:48.920Z,1549603788.920 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 4065E4E0 2019-02-08T05:29:48.920Z,1549603788.920 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 4623 2019-02-08T05:29:48.921Z,1549603788.921 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2019-02-08T05:29:48.922Z,1549603788.922 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2019-02-08T05:29:48.964Z,1549603788.964 [DepthRateCalculator] Loaded 2019-02-08T05:29:48.964Z,1549603788.964 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2019-02-08T05:29:48.970Z,1549603788.970 [PitchRateCalculator] Loaded 2019-02-08T05:29:48.970Z,1549603788.970 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2019-02-08T05:29:48.986Z,1549603788.986 [SpeedCalculator] Loaded 2019-02-08T05:29:48.986Z,1549603788.986 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2019-02-08T05:29:49.007Z,1549603789.007 [TempGradientCalculator] Loaded 2019-02-08T05:29:49.008Z,1549603789.008 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread. 2019-02-08T05:29:49.013Z,1549603789.013 [YawRateCalculator] Loaded 2019-02-08T05:29:49.014Z,1549603789.014 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2019-02-08T05:29:49.048Z,1549603789.048 [ElevatorOffsetCalculator] Loaded 2019-02-08T05:29:49.048Z,1549603789.048 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2019-02-08T05:29:49.048Z,1549603789.048 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2019-02-08T05:29:49.049Z,1549603789.049 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2019-02-08T05:29:49.076Z,1549603789.076 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2019-02-08T05:29:49.077Z,1549603789.077 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2019-02-08T05:29:49.179Z,1549603789.179 [DeadReckonUsingMultipleVelocitySources] Loaded 2019-02-08T05:29:49.180Z,1549603789.180 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2019-02-08T05:29:49.240Z,1549603789.240 [DeadReckonUsingSpeedCalculator] Loaded 2019-02-08T05:29:49.241Z,1549603789.241 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread. 2019-02-08T05:29:49.301Z,1549603789.301 [DeadReckonWithRespectToSeafloor] Loaded 2019-02-08T05:29:49.301Z,1549603789.301 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread. 2019-02-08T05:29:49.317Z,1549603789.317 [NavChart] Loaded 2019-02-08T05:29:49.318Z,1549603789.318 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2019-02-08T05:29:49.322Z,1549603789.322 [UniversalFixResidualReporter] Loaded 2019-02-08T05:29:49.322Z,1549603789.322 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2019-02-08T05:29:49.322Z,1549603789.322 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2019-02-08T05:29:49.323Z,1549603789.323 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2019-02-08T05:29:49.615Z,1549603789.615 [AcousticModem_Benthos_ATM900] Loaded 2019-02-08T05:29:49.616Z,1549603789.616 [ComponentRegistry](DEBUG): SyncComponent "AcousticModem_Benthos_ATM900" handled in the control thread. 2019-02-08T05:29:49.686Z,1549603789.686 [DataOverHttps] Loaded 2019-02-08T05:29:49.686Z,1549603789.686 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread. 2019-02-08T05:29:49.699Z,1549603789.699 [Depth_Keller] Loaded 2019-02-08T05:29:49.700Z,1549603789.700 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2019-02-08T05:29:49.705Z,1549603789.705 [DropWeight] Loaded 2019-02-08T05:29:49.705Z,1549603789.705 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2019-02-08T05:29:49.799Z,1549603789.799 [NAL9602] Loaded 2019-02-08T05:29:49.799Z,1549603789.799 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2019-02-08T05:29:49.804Z,1549603789.804 [Onboard] Loaded 2019-02-08T05:29:49.805Z,1549603789.805 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread. 2019-02-08T05:29:49.811Z,1549603789.811 [Radio_Surface] Loaded 2019-02-08T05:29:49.812Z,1549603789.812 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2019-02-08T05:29:49.813Z,1549603789.813 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409254E0 2019-02-08T05:29:49.813Z,1549603789.813 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 4624 2019-02-08T05:29:49.861Z,1549603789.861 [PNI_TCM] Loaded 2019-02-08T05:29:49.861Z,1549603789.861 [ComponentRegistry](DEBUG): SyncComponent "PNI_TCM" handled in the control thread. 2019-02-08T05:29:49.923Z,1549603789.923 [Rowe_600LCM] Loaded 2019-02-08T05:29:49.923Z,1549603789.923 [ComponentRegistry](DEBUG): Component "Rowe_600LCM" handled in its own thread. 2019-02-08T05:29:49.924Z,1549603789.924 [Rowe_600LCM ThreadHandler](DEBUG): Created PCaller Thread at 409554E0 2019-02-08T05:29:49.924Z,1549603789.924 [Rowe_600LCM ThreadHandler](INFO): Protected caller Thread ID is 4625 2019-02-08T05:29:51.544Z,1549603791.544 [BPC1] Loaded 2019-02-08T05:29:51.544Z,1549603791.544 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2019-02-08T05:29:51.544Z,1549603791.544 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2019-02-08T05:29:51.545Z,1549603791.545 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2019-02-08T05:29:51.621Z,1549603791.621 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2019-02-08T05:29:51.622Z,1549603791.622 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2019-02-08T05:29:51.693Z,1549603791.693 [VerticalControl](DEBUG): Construct VerticalControl. 2019-02-08T05:29:51.778Z,1549603791.778 [VerticalControl] Loaded 2019-02-08T05:29:51.778Z,1549603791.778 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2019-02-08T05:29:51.779Z,1549603791.779 [HorizontalControl](DEBUG): Construct HorizontalControl. 2019-02-08T05:29:51.838Z,1549603791.838 [HorizontalControl] Loaded 2019-02-08T05:29:51.838Z,1549603791.838 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2019-02-08T05:29:51.839Z,1549603791.839 [SpeedControl](DEBUG): Construct SpeedControl. 2019-02-08T05:29:51.840Z,1549603791.840 [SpeedControl] Loaded 2019-02-08T05:29:51.841Z,1549603791.841 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2019-02-08T05:29:51.841Z,1549603791.841 [LoopControl](DEBUG): Construct LoopControl. 2019-02-08T05:29:51.842Z,1549603791.842 [LoopControl] Loaded 2019-02-08T05:29:51.842Z,1549603791.842 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2019-02-08T05:29:51.843Z,1549603791.843 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2019-02-08T05:29:51.843Z,1549603791.843 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2019-02-08T05:29:51.856Z,1549603791.856 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2019-02-08T05:29:51.857Z,1549603791.857 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2019-02-08T05:29:52.100Z,1549603792.100 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2019-02-08T05:29:52.104Z,1549603792.104 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2019-02-08T05:29:52.105Z,1549603792.105 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2019-02-08T05:29:52.112Z,1549603792.112 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2019-02-08T05:29:52.113Z,1549603792.113 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40A774E0 2019-02-08T05:29:52.113Z,1549603792.113 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 4626 2019-02-08T05:29:52.118Z,1549603792.118 [Supervisor](INFO): Main Thread ID is 4539 2019-02-08T05:29:52.118Z,1549603792.118 [Supervisor](DEBUG): Running supervisor. 2019-02-08T05:29:52.119Z,1549603792.119 [CommandLine ThreadHandler](INFO): Handler Thread ID is 4627 2019-02-08T05:29:52.121Z,1549603792.121 [controlThread ThreadHandler](INFO): Handler Thread ID is 4628 2019-02-08T05:29:52.122Z,1549603792.122 [controlThread](DEBUG): Initializing ControlThread 2019-02-08T05:29:52.124Z,1549603792.124 [SBIT](INFO): Initialize SBIT Component. 2019-02-08T05:29:52.124Z,1549603792.124 [SBIT](IMPORTANT): git: 2019-01-14A-57-g72ba51e 2019-02-08T05:29:52.124Z,1549603792.124 [SBIT](INFO): git hash: 72ba51edeec12b341e49a5bae224e2abbf93cde2 2019-02-08T05:29:52.125Z,1549603792.125 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2019-02-08T05:29:52.126Z,1549603792.126 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018 Kernel Reported: #1 PREEMPT Tue Dec 18 21:19:28 PST 2018 2019-02-08T05:29:52.127Z,1549603792.127 [SBIT](INFO): Beginning SBIT in 24.000000 seconds. 2019-02-08T05:29:52.128Z,1549603792.128 [IBIT](INFO): Initialize IBIT Component. 2019-02-08T05:29:52.129Z,1549603792.129 [CBIT](DEBUG): Initialize CBIT Component. 2019-02-08T05:29:52.129Z,1549603792.129 [logger ThreadHandler](INFO): Handler Thread ID is 4629 2019-02-08T05:29:52.142Z,1549603792.142 [CBIT](DEBUG): Initialized mux pins. 2019-02-08T05:29:52.142Z,1549603792.142 [CBIT](DEBUG): Initializing the watchdog timer. 2019-02-08T05:29:52.150Z,1549603792.150 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 4630 2019-02-08T05:29:52.151Z,1549603792.151 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2019-02-08T05:29:52.155Z,1549603792.155 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20 2019-02-08T05:29:52.156Z,1549603792.156 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 4632 2019-02-08T05:29:52.157Z,1549603792.157 [WetLabsBB2FL](INFO): Powering down 2019-02-08T05:29:52.170Z,1549603792.170 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2019-02-08T05:29:52.172Z,1549603792.172 [CBIT](DEBUG): Initializing heartbeat. 2019-02-08T05:29:52.214Z,1549603792.214 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 4633 2019-02-08T05:29:52.220Z,1549603792.220 [Radio_Surface](INFO): Powering up 2019-02-08T05:29:52.233Z,1549603792.233 [logger ThreadHandler](INFO): b: 1549603792.129899, a: 1549603792.229899 2019-02-08T05:29:52.242Z,1549603792.242 [CBIT](DEBUG): Deactivating GF circuits. 2019-02-08T05:29:52.242Z,1549603792.242 [CBIT](DEBUG): Deactivating emergency mode. 2019-02-08T05:29:52.254Z,1549603792.254 [Rowe_600LCM ThreadHandler](INFO): Handler Thread ID is 4634 2019-02-08T05:29:52.255Z,1549603792.255 [Rowe_600LCM](INFO): Initializing 2019-02-08T05:29:52.264Z,1549603792.264 [Rowe_600LCM](INFO): Powering up 2019-02-08T05:29:52.282Z,1549603792.282 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2019-02-08T05:29:52.283Z,1549603792.283 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2019-02-08T05:29:52.283Z,1549603792.283 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2019-02-08T05:29:52.283Z,1549603792.283 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator. 2019-02-08T05:29:52.284Z,1549603792.284 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2019-02-08T05:29:52.284Z,1549603792.284 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2019-02-08T05:29:52.285Z,1549603792.285 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2019-02-08T05:29:52.286Z,1549603792.286 [NavChart](DEBUG): Initialize NavChart Navigation. 2019-02-08T05:29:52.287Z,1549603792.287 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2019-02-08T05:29:52.293Z,1549603792.293 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2019-02-08T05:29:52.298Z,1549603792.298 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 4635 2019-02-08T05:29:52.302Z,1549603792.302 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2019-02-08T05:29:52.302Z,1549603792.302 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2019-02-08T05:29:52.303Z,1549603792.303 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2019-02-08T05:29:52.303Z,1549603792.303 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2019-02-08T05:29:52.303Z,1549603792.303 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2019-02-08T05:29:52.303Z,1549603792.303 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2019-02-08T05:29:52.303Z,1549603792.303 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000 2019-02-08T05:29:52.304Z,1549603792.304 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000 2019-02-08T05:29:52.304Z,1549603792.304 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2019-02-08T05:29:52.304Z,1549603792.304 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2019-02-08T05:29:52.304Z,1549603792.304 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000 2019-02-08T05:29:52.304Z,1549603792.304 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000 2019-02-08T05:29:52.305Z,1549603792.305 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000 2019-02-08T05:29:52.305Z,1549603792.305 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000 2019-02-08T05:29:52.305Z,1549603792.305 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000 2019-02-08T05:29:52.305Z,1549603792.305 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000 2019-02-08T05:29:52.323Z,1549603792.323 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2019-02-08T05:29:52.323Z,1549603792.323 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2019-02-08T05:29:52.324Z,1549603792.324 [LoopControl](DEBUG): Initialize LoopControlComponent. 2019-02-08T05:29:52.325Z,1549603792.325 [MissionManager](INFO): Loading Mission: Missions/Startup.xml 2019-02-08T05:29:52.343Z,1549603792.343 [logger ThreadHandler](INFO): b: 1549603792.233172, a: 1549603792.333172 2019-02-08T05:29:52.388Z,1549603792.388 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2019-02-08T05:29:52.431Z,1549603792.431 [MissionManager](DEBUG): 2019-02-08T05:29:52.432Z,1549603792.432 [MissionManager](INFO): Loading Mission: Missions/Default.xml 2019-02-08T05:29:52.448Z,1549603792.448 [logger ThreadHandler](INFO): b: 1549603792.343305, a: 1549603792.443305 2019-02-08T05:29:52.554Z,1549603792.554 [logger ThreadHandler](INFO): b: 1549603792.448116, a: 1549603792.548116 2019-02-08T05:29:52.571Z,1549603792.571 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2019-02-08T05:29:52.572Z,1549603792.572 [Default:A.Wait](DEBUG): Construct Wait. 2019-02-08T05:29:52.574Z,1549603792.574 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2019-02-08T05:29:52.633Z,1549603792.633 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2019-02-08T05:29:52.636Z,1549603792.636 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2019-02-08T05:29:52.663Z,1549603792.663 [logger ThreadHandler](INFO): b: 1549603792.562354, a: 1549603792.662354 2019-02-08T05:29:52.675Z,1549603792.675 [Default:E.Execute](DEBUG): Construct Execute. 2019-02-08T05:29:52.710Z,1549603792.710 [MissionManager](DEBUG): 0 Wait a moment to see if the scheduler starts a new mission before starting to actually run Default. 13 Burn on Dropped weight due to communications timeout. 5 Default mission has been running for Restarting logs and Default mission. restart logs 2019-02-08T05:29:52.715Z,1549603792.715 [controlThread](DEBUG): Component order: CycleStarter,Aanderaa_O2,ESPComponent,PAR_Licor,AcousticModem_Benthos_ATM900,DataOverHttps,Depth_Keller,DropWeight,NAL9602,Onboard,PNI_TCM,BPC1,PAR_Licor,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,DeadReckonWithRespectToSeafloor,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter, 2019-02-08T05:29:52.769Z,1549603792.769 [ESPComponent](INFO): powering down ESP 2019-02-08T05:29:52.807Z,1549603792.807 [logger ThreadHandler](INFO): b: 1549603792.663560, a: 1549603792.763560 2019-02-08T05:29:52.927Z,1549603792.927 [logger ThreadHandler](INFO): b: 1549603792.806604, a: 1549603792.906604 2019-02-08T05:29:53.052Z,1549603793.052 [logger ThreadHandler](INFO): b: 1549603792.927295, a: 1549603793.027295 2019-02-08T05:29:53.159Z,1549603793.159 [logger ThreadHandler](INFO): b: 1549603793.052302, a: 1549603793.152302 2019-02-08T05:29:53.188Z,1549603793.188 [AcousticModem_Benthos_ATM900](INFO): Powering up 2019-02-08T05:29:53.188Z,1549603793.188 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900. 2019-02-08T05:29:53.221Z,1549603793.221 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2019-02-08T05:29:53.280Z,1549603793.280 [logger ThreadHandler](INFO): b: 1549603793.159205, a: 1549603793.259205 2019-02-08T05:29:53.383Z,1549603793.383 [logger ThreadHandler](INFO): b: 1549603793.279937, a: 1549603793.379937 2019-02-08T05:29:53.495Z,1549603793.495 [logger ThreadHandler](INFO): b: 1549603793.383191, a: 1549603793.483191 2019-02-08T05:29:53.600Z,1549603793.600 [logger ThreadHandler](INFO): b: 1549603793.494705, a: 1549603793.594705 2019-02-08T05:29:53.705Z,1549603793.705 [logger ThreadHandler](INFO): b: 1549603793.600045, a: 1549603793.700045 2019-02-08T05:29:53.819Z,1549603793.819 [logger ThreadHandler](INFO): b: 1549603793.705098, a: 1549603793.805098 2019-02-08T05:29:53.875Z,1549603793.875 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2019-02-08T05:29:53.882Z,1549603793.882 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2019-02-08T05:29:53.913Z,1549603793.913 [ElevatorServo](DEBUG): Initializing EZServoServo. 2019-02-08T05:29:53.920Z,1549603793.920 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2019-02-08T05:29:53.927Z,1549603793.927 [logger ThreadHandler](INFO): b: 1549603793.818698, a: 1549603793.918698 2019-02-08T05:29:53.938Z,1549603793.938 [MassServo](DEBUG): Initializing EZServoServo. 2019-02-08T05:29:53.954Z,1549603793.954 [MassServo](DEBUG): Initializing MassServo. 2019-02-08T05:29:53.970Z,1549603793.970 [RudderServo](DEBUG): Initializing EZServoServo. 2019-02-08T05:29:53.982Z,1549603793.982 [RudderServo](DEBUG): Initializing RudderServo. 2019-02-08T05:29:54.026Z,1549603794.026 [ThrusterServo](DEBUG): Initializing EZServoServo. 2019-02-08T05:29:54.036Z,1549603794.036 [logger ThreadHandler](INFO): b: 1549603793.926666, a: 1549603794.026666 2019-02-08T05:29:54.039Z,1549603794.039 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2019-02-08T05:29:54.159Z,1549603794.159 [logger ThreadHandler](INFO): b: 1549603794.036100, a: 1549603794.136100 2019-02-08T05:29:54.172Z,1549603794.172 [controlThread ThreadHandler](INFO): b: 1549603792.715369, a: 1549603793.115369 2019-02-08T05:29:54.263Z,1549603794.263 [logger ThreadHandler](INFO): b: 1549603794.158861, a: 1549603794.258861 2019-02-08T05:29:54.324Z,1549603794.324 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2019-02-08T05:29:54.324Z,1549603794.324 [DropWeight] Hardware Fault, FailCount= 1 2019-02-08T05:29:54.324Z,1549603794.324 [DropWeight](ERROR): Hardware Fault 2019-02-08T05:29:54.375Z,1549603794.375 [logger ThreadHandler](INFO): b: 1549603794.263480, a: 1549603794.363480 2019-02-08T05:29:54.503Z,1549603794.503 [logger ThreadHandler](INFO): b: 1549603794.375548, a: 1549603794.475548 2019-02-08T05:29:54.604Z,1549603794.604 [logger ThreadHandler](INFO): b: 1549603794.503198, a: 1549603794.603198 2019-02-08T05:29:54.715Z,1549603794.715 [logger ThreadHandler](INFO): b: 1549603794.604538, a: 1549603794.704538 2019-02-08T05:29:54.738Z,1549603794.738 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout 2019-02-08T05:29:54.738Z,1549603794.738 [BuoyancyServo](FAULT): Buoyancy failed to initialize 2019-02-08T05:29:54.738Z,1549603794.738 [BuoyancyServo] Communications Fault, FailCount= 1 2019-02-08T05:29:54.738Z,1549603794.738 [BuoyancyServo](ERROR): Communications Fault 2019-02-08T05:29:54.831Z,1549603794.831 [logger ThreadHandler](INFO): b: 1549603794.715062, a: 1549603794.815062 2019-02-08T05:29:54.940Z,1549603794.940 [logger ThreadHandler](INFO): b: 1549603794.831393, a: 1549603794.931393 2019-02-08T05:29:54.992Z,1549603794.992 [CommandLine](FAULT): Scheduling is paused 2019-02-08T05:29:54.992Z,1549603794.992 [CBIT](INFO): Critical error at 20190208T052954 2019-02-08T05:29:54.992Z,1549603794.992 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2019-02-08T05:29:54.995Z,1549603794.995 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2019-02-08T05:29:54.996Z,1549603794.996 [CBIT](ERROR): Hardware Fault in component: DropWeight 2019-02-08T05:29:54.996Z,1549603794.996 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2019-02-08T05:29:54.998Z,1549603794.998 [controlThread ThreadHandler](INFO): b: 1549603794.171679, a: 1549603794.571679 2019-02-08T05:29:55.052Z,1549603795.052 [logger ThreadHandler](INFO): b: 1549603794.940654, a: 1549603795.040654 2019-02-08T05:29:55.180Z,1549603795.180 [logger ThreadHandler](INFO): b: 1549603795.052266, a: 1549603795.152266 2019-02-08T05:29:55.290Z,1549603795.290 [logger ThreadHandler](INFO): b: 1549603795.180001, a: 1549603795.280001 2019-02-08T05:29:55.403Z,1549603795.403 [logger ThreadHandler](INFO): b: 1549603795.290456, a: 1549603795.390456 2019-02-08T05:29:55.507Z,1549603795.507 [logger ThreadHandler](INFO): b: 1549603795.403247, a: 1549603795.503247 2019-02-08T05:29:55.609Z,1549603795.609 [logger ThreadHandler](INFO): b: 1549603795.507591, a: 1549603795.607591 2019-02-08T05:29:55.710Z,1549603795.710 [logger ThreadHandler](INFO): b: 1549603795.609123, a: 1549603795.709123 2019-02-08T05:29:55.812Z,1549603795.812 [logger ThreadHandler](INFO): b: 1549603795.710456, a: 1549603795.810456 2019-02-08T05:29:55.917Z,1549603795.917 [logger ThreadHandler](INFO): b: 1549603795.812226, a: 1549603795.912226 2019-02-08T05:29:56.035Z,1549603796.035 [logger ThreadHandler](INFO): b: 1549603795.917545, a: 1549603796.017545 2019-02-08T05:29:56.163Z,1549603796.163 [logger ThreadHandler](INFO): b: 1549603796.035469, a: 1549603796.135469 2019-02-08T05:29:56.290Z,1549603796.290 [logger ThreadHandler](INFO): b: 1549603796.163102, a: 1549603796.263102 2019-02-08T05:29:56.392Z,1549603796.392 [logger ThreadHandler](INFO): b: 1549603796.290494, a: 1549603796.390494 2019-02-08T05:29:56.499Z,1549603796.499 [logger ThreadHandler](INFO): b: 1549603796.392124, a: 1549603796.492124 2019-02-08T05:29:56.608Z,1549603796.608 [logger ThreadHandler](INFO): b: 1549603796.499205, a: 1549603796.599205 2019-02-08T05:29:56.682Z,1549603796.682 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface 2019-02-08T05:29:56.728Z,1549603796.728 [logger ThreadHandler](INFO): b: 1549603796.607938, a: 1549603796.707938 2019-02-08T05:29:56.875Z,1549603796.875 [logger ThreadHandler](INFO): b: 1549603796.728380, a: 1549603796.828380 2019-02-08T05:29:56.963Z,1549603796.963 [Rowe_600LCM](INFO): Started Rowe LCM interface with command:nohup ./lrauv-framework/onboard/bin/roweadcp -ldir /mnt/mmc/LRAUV/Logs/latest/ -dev /dev/ttyB4 -b 9600 >& /dev/null & 2019-02-08T05:29:57.003Z,1549603797.003 [logger ThreadHandler](INFO): b: 1549603796.875589, a: 1549603796.975589 2019-02-08T05:29:57.115Z,1549603797.115 [logger ThreadHandler](INFO): b: 1549603797.002841, a: 1549603797.102841 2019-02-08T05:29:57.239Z,1549603797.239 [logger ThreadHandler](INFO): b: 1549603797.115229, a: 1549603797.215229 2019-02-08T05:29:57.368Z,1549603797.368 [logger ThreadHandler](INFO): b: 1549603797.239502, a: 1549603797.339502 2019-02-08T05:29:57.476Z,1549603797.476 [logger ThreadHandler](INFO): b: 1549603797.367670, a: 1549603797.467670 2019-02-08T05:29:57.577Z,1549603797.577 [logger ThreadHandler](INFO): b: 1549603797.475669, a: 1549603797.575669 2019-02-08T05:29:57.711Z,1549603797.711 [logger ThreadHandler](INFO): b: 1549603797.576941, a: 1549603797.676941 2019-02-08T05:29:57.825Z,1549603797.825 [logger ThreadHandler](INFO): b: 1549603797.711523, a: 1549603797.811523 2019-02-08T05:29:57.963Z,1549603797.963 [logger ThreadHandler](INFO): b: 1549603797.825426, a: 1549603797.925426 2019-02-08T05:29:58.071Z,1549603798.071 [logger ThreadHandler](INFO): b: 1549603797.963462, a: 1549603798.063462 2019-02-08T05:29:58.193Z,1549603798.193 [logger ThreadHandler](INFO): b: 1549603798.071383, a: 1549603798.171383 2019-02-08T05:29:58.344Z,1549603798.344 [logger ThreadHandler](INFO): b: 1549603798.193384, a: 1549603798.293384 2019-02-08T05:29:58.463Z,1549603798.463 [logger ThreadHandler](INFO): b: 1549603798.344041, a: 1549603798.444041 2019-02-08T05:29:58.568Z,1549603798.568 [logger ThreadHandler](INFO): b: 1549603798.462610, a: 1549603798.562610 2019-02-08T05:29:58.673Z,1549603798.673 [logger ThreadHandler](INFO): b: 1549603798.567913, a: 1549603798.667913 2019-02-08T05:29:58.808Z,1549603798.808 [logger ThreadHandler](INFO): b: 1549603798.673552, a: 1549603798.773552 2019-02-08T05:29:58.941Z,1549603798.941 [logger ThreadHandler](INFO): b: 1549603798.807663, a: 1549603798.907663 2019-02-08T05:29:59.057Z,1549603799.057 [logger ThreadHandler](INFO): b: 1549603798.940925, a: 1549603799.040925 2019-02-08T05:29:59.175Z,1549603799.175 [logger ThreadHandler](INFO): b: 1549603799.056727, a: 1549603799.156727 2019-02-08T05:29:59.253Z,1549603799.253 [CTD_Seabird](ERROR): Device message queue exceeded the allowed limit. 2019-02-08T05:29:59.295Z,1549603799.295 [logger ThreadHandler](INFO): b: 1549603799.174884, a: 1549603799.274884 2019-02-08T05:29:59.404Z,1549603799.404 [logger ThreadHandler](INFO): b: 1549603799.295197, a: 1549603799.395197 2019-02-08T05:29:59.507Z,1549603799.507 [logger ThreadHandler](INFO): b: 1549603799.403616, a: 1549603799.503616 2019-02-08T05:29:59.609Z,1549603799.609 [logger ThreadHandler](INFO): b: 1549603799.507112, a: 1549603799.607112 2019-02-08T05:29:59.728Z,1549603799.728 [logger ThreadHandler](INFO): b: 1549603799.609182, a: 1549603799.709182 2019-02-08T05:29:59.839Z,1549603799.839 [logger ThreadHandler](INFO): b: 1549603799.727830, a: 1549603799.827830 2019-02-08T05:29:59.944Z,1549603799.944 [logger ThreadHandler](INFO): b: 1549603799.839127, a: 1549603799.939127 2019-02-08T05:30:00.046Z,1549603800.046 [logger ThreadHandler](INFO): b: 1549603799.944131, a: 1549603800.044131 2019-02-08T05:30:00.163Z,1549603800.163 [logger ThreadHandler](INFO): b: 1549603800.046194, a: 1549603800.146194 2019-02-08T05:30:00.265Z,1549603800.265 [logger ThreadHandler](INFO): b: 1549603800.163017, a: 1549603800.263017 2019-02-08T05:30:00.371Z,1549603800.371 [logger ThreadHandler](INFO): b: 1549603800.265174, a: 1549603800.365174 2019-02-08T05:30:00.479Z,1549603800.479 [logger ThreadHandler](INFO): b: 1549603800.371161, a: 1549603800.471161 2019-02-08T05:30:00.595Z,1549603800.595 [logger ThreadHandler](INFO): b: 1549603800.479163, a: 1549603800.579163 2019-02-08T05:30:00.697Z,1549603800.697 [logger ThreadHandler](INFO): b: 1549603800.595298, a: 1549603800.695298 2019-02-08T05:30:00.803Z,1549603800.803 [logger ThreadHandler](INFO): b: 1549603800.697294, a: 1549603800.797294 2019-02-08T05:30:00.912Z,1549603800.912 [logger ThreadHandler](INFO): b: 1549603800.803139, a: 1549603800.903139 2019-02-08T05:30:01.014Z,1549603801.014 [logger ThreadHandler](INFO): b: 1549603800.911787, a: 1549603801.011787 2019-02-08T05:30:01.116Z,1549603801.116 [logger ThreadHandler](INFO): b: 1549603801.013837, a: 1549603801.113837 2019-02-08T05:30:01.223Z,1549603801.223 [logger ThreadHandler](INFO): b: 1549603801.116050, a: 1549603801.216050 2019-02-08T05:30:01.332Z,1549603801.332 [logger ThreadHandler](INFO): b: 1549603801.222643, a: 1549603801.322643 2019-02-08T05:30:01.447Z,1549603801.447 [logger ThreadHandler](INFO): b: 1549603801.331726, a: 1549603801.431726 2019-02-08T05:30:01.555Z,1549603801.555 [logger ThreadHandler](INFO): b: 1549603801.447183, a: 1549603801.547183 2019-02-08T05:30:01.663Z,1549603801.663 [logger ThreadHandler](INFO): b: 1549603801.555068, a: 1549603801.655068 2019-02-08T05:30:01.765Z,1549603801.765 [logger ThreadHandler](INFO): b: 1549603801.663147, a: 1549603801.763147 2019-02-08T05:30:01.882Z,1549603801.882 [logger ThreadHandler](INFO): b: 1549603801.765060, a: 1549603801.865060 2019-02-08T05:30:02.011Z,1549603802.011 [logger ThreadHandler](INFO): b: 1549603801.881612, a: 1549603801.981612 2019-02-08T05:30:02.114Z,1549603802.114 [logger ThreadHandler](INFO): b: 1549603802.011510, a: 1549603802.111510 2019-02-08T05:30:02.154Z,1549603802.154 [NavChartDb ThreadHandler](INFO): b: 1549603792.319129, a: 1549603792.419129 2019-02-08T05:30:02.224Z,1549603802.224 [logger ThreadHandler](INFO): b: 1549603802.114013, a: 1549603802.214013 2019-02-08T05:30:02.332Z,1549603802.332 [logger ThreadHandler](INFO): b: 1549603802.223757, a: 1549603802.323757 2019-02-08T05:30:02.439Z,1549603802.439 [logger ThreadHandler](INFO): b: 1549603802.332368, a: 1549603802.432368 2019-02-08T05:30:02.552Z,1549603802.552 [logger ThreadHandler](INFO): b: 1549603802.439361, a: 1549603802.539361 2019-02-08T05:30:02.659Z,1549603802.659 [logger ThreadHandler](INFO): b: 1549603802.552094, a: 1549603802.652094 2019-02-08T05:30:02.763Z,1549603802.763 [logger ThreadHandler](INFO): b: 1549603802.659270, a: 1549603802.759270 2019-02-08T05:30:02.873Z,1549603802.873 [logger ThreadHandler](INFO): b: 1549603802.763094, a: 1549603802.863094 2019-02-08T05:30:02.983Z,1549603802.983 [logger ThreadHandler](INFO): b: 1549603802.872945, a: 1549603802.972945 2019-02-08T05:30:03.088Z,1549603803.088 [logger ThreadHandler](INFO): b: 1549603802.982799, a: 1549603803.082799 2019-02-08T05:30:03.191Z,1549603803.191 [logger ThreadHandler](INFO): b: 1549603803.088367, a: 1549603803.188367 2019-02-08T05:30:03.298Z,1549603803.298 [logger ThreadHandler](INFO): b: 1549603803.191153, a: 1549603803.291153 2019-02-08T05:30:03.406Z,1549603803.406 [logger ThreadHandler](INFO): b: 1549603803.298508, a: 1549603803.398508 2019-02-08T05:30:03.519Z,1549603803.519 [logger ThreadHandler](INFO): b: 1549603803.406512, a: 1549603803.506512 2019-02-08T05:30:03.623Z,1549603803.623 [logger ThreadHandler](INFO): b: 1549603803.519108, a: 1549603803.619108 2019-02-08T05:30:03.736Z,1549603803.736 [logger ThreadHandler](INFO): b: 1549603803.623563, a: 1549603803.723563 2019-02-08T05:30:03.844Z,1549603803.844 [logger ThreadHandler](INFO): b: 1549603803.735707, a: 1549603803.835707 2019-02-08T05:30:03.968Z,1549603803.968 [logger ThreadHandler](INFO): b: 1549603803.844223, a: 1549603803.944223 2019-02-08T05:30:04.070Z,1549603804.070 [logger ThreadHandler](INFO): b: 1549603803.967977, a: 1549603804.067977 2019-02-08T05:30:04.179Z,1549603804.179 [logger ThreadHandler](INFO): b: 1549603804.070184, a: 1549603804.170184 2019-02-08T05:30:04.295Z,1549603804.295 [logger ThreadHandler](INFO): b: 1549603804.179332, a: 1549603804.279332 2019-02-08T05:30:04.411Z,1549603804.411 [logger ThreadHandler](INFO): b: 1549603804.295240, a: 1549603804.395240 2019-02-08T05:30:04.518Z,1549603804.518 [logger ThreadHandler](INFO): b: 1549603804.410850, a: 1549603804.510850 2019-02-08T05:30:04.627Z,1549603804.627 [logger ThreadHandler](INFO): b: 1549603804.518514, a: 1549603804.618514 2019-02-08T05:30:04.729Z,1549603804.729 [logger ThreadHandler](INFO): b: 1549603804.627122, a: 1549603804.727122 2019-02-08T05:30:04.840Z,1549603804.840 [logger ThreadHandler](INFO): b: 1549603804.728689, a: 1549603804.828689 2019-02-08T05:30:04.951Z,1549603804.951 [logger ThreadHandler](INFO): b: 1549603804.840325, a: 1549603804.940325 2019-02-08T05:30:05.060Z,1549603805.060 [logger ThreadHandler](INFO): b: 1549603804.951125, a: 1549603805.051125 2019-02-08T05:30:05.166Z,1549603805.166 [logger ThreadHandler](INFO): b: 1549603805.060555, a: 1549603805.160555 2019-02-08T05:30:05.271Z,1549603805.271 [logger ThreadHandler](INFO): b: 1549603805.166514, a: 1549603805.266514 2019-02-08T05:30:05.380Z,1549603805.380 [logger ThreadHandler](INFO): b: 1549603805.271482, a: 1549603805.371482 2019-02-08T05:30:05.487Z,1549603805.487 [logger ThreadHandler](INFO): b: 1549603805.379605, a: 1549603805.479605 2019-02-08T05:30:05.599Z,1549603805.599 [logger ThreadHandler](INFO): b: 1549603805.487220, a: 1549603805.587220 2019-02-08T05:30:05.706Z,1549603805.706 [logger ThreadHandler](INFO): b: 1549603805.599397, a: 1549603805.699397 2019-02-08T05:30:05.815Z,1549603805.815 [logger ThreadHandler](INFO): b: 1549603805.706531, a: 1549603805.806531 2019-02-08T05:30:05.925Z,1549603805.925 [logger ThreadHandler](INFO): b: 1549603805.815228, a: 1549603805.915228 2019-02-08T05:30:06.058Z,1549603806.058 [logger ThreadHandler](INFO): b: 1549603805.925319, a: 1549603806.025319 2019-02-08T05:30:06.175Z,1549603806.175 [logger ThreadHandler](INFO): b: 1549603806.058132, a: 1549603806.158132 2019-02-08T05:30:06.282Z,1549603806.282 [logger ThreadHandler](INFO): b: 1549603806.174971, a: 1549603806.274971 2019-02-08T05:30:06.377Z,1549603806.377 [CBIT](INFO): Critical error at 20190208T052954 2019-02-08T05:30:06.380Z,1549603806.380 [CBIT](CRITICAL): Environmental Failure. Press:14.841851 PSI. Humidity:26%. Temp:26 C. ABORTING MISSION 2019-02-08T05:30:06.392Z,1549603806.392 [logger ThreadHandler](INFO): b: 1549603806.282491, a: 1549603806.382491 2019-02-08T05:30:06.395Z,1549603806.395 [controlThread ThreadHandler](INFO): b: 1549603794.998588, a: 1549603795.398588 2019-02-08T05:30:06.431Z,1549603806.431 [AcousticModem_Benthos_ATM900](DEBUG): 2019-02-08T05:30:06.432Z,1549603806.432 [AcousticModem_Benthos_ATM900](DEBUG): Teledyne Benthos ATM-900 Series OEM w/burn wire 2019-02-08T05:30:06.433Z,1549603806.433 [AcousticModem_Benthos_ATM900](DEBUG): MF Frequency Band 2019-02-08T05:30:06.433Z,1549603806.433 [AcousticModem_Benthos_ATM900](DEBUG): Standard version 8.6.3 2019-02-08T05:30:06.442Z,1549603806.442 [AcousticModem_Benthos_ATM900](DEBUG): Feb 8 2019 05:32:49 2019-02-08T05:30:06.443Z,1549603806.443 [AcousticModem_Benthos_ATM900](DEBUG): WARNING: battery low 2019-02-08T05:30:06.499Z,1549603806.499 [logger ThreadHandler](INFO): b: 1549603806.392260, a: 1549603806.492260 2019-02-08T05:30:06.603Z,1549603806.603 [logger ThreadHandler](INFO): b: 1549603806.499276, a: 1549603806.599276 2019-02-08T05:30:06.656Z,1549603806.656 [CBIT](INFO): Critical error at 20190208T053006 2019-02-08T05:30:06.661Z,1549603806.661 [controlThread ThreadHandler](INFO): b: 1549603806.395062, a: 1549603806.795062 2019-02-08T05:30:06.704Z,1549603806.704 [logger ThreadHandler](INFO): b: 1549603806.603120, a: 1549603806.703120 2019-02-08T05:30:06.807Z,1549603806.807 [logger ThreadHandler](INFO): b: 1549603806.704550, a: 1549603806.804550 2019-02-08T05:30:06.913Z,1549603806.913 [logger ThreadHandler](INFO): b: 1549603806.807530, a: 1549603806.907530 2019-02-08T05:30:07.024Z,1549603807.024 [logger ThreadHandler](INFO): b: 1549603806.913455, a: 1549603807.013455 2019-02-08T05:30:07.139Z,1549603807.139 [logger ThreadHandler](INFO): b: 1549603807.024185, a: 1549603807.124185 2019-02-08T05:30:07.240Z,1549603807.240 [logger ThreadHandler](INFO): b: 1549603807.138633, a: 1549603807.238633 2019-02-08T05:30:07.342Z,1549603807.342 [logger ThreadHandler](INFO): b: 1549603807.239938, a: 1549603807.339938 2019-02-08T05:30:07.446Z,1549603807.446 [logger ThreadHandler](INFO): b: 1549603807.343173, a: 1549603807.443173 2019-02-08T05:30:07.555Z,1549603807.555 [logger ThreadHandler](INFO): b: 1549603807.445762, a: 1549603807.545762 2019-02-08T05:30:07.659Z,1549603807.659 [logger ThreadHandler](INFO): b: 1549603807.555212, a: 1549603807.655212 2019-02-08T05:30:07.760Z,1549603807.760 [logger ThreadHandler](INFO): b: 1549603807.659140, a: 1549603807.759140 2019-02-08T05:30:07.863Z,1549603807.863 [logger ThreadHandler](INFO): b: 1549603807.760329, a: 1549603807.860329 2019-02-08T05:30:07.969Z,1549603807.969 [logger ThreadHandler](INFO): b: 1549603807.862996, a: 1549603807.962996 2019-02-08T05:30:08.073Z,1549603808.073 [logger ThreadHandler](INFO): b: 1549603807.969070, a: 1549603808.069070 2019-02-08T05:30:08.187Z,1549603808.187 [logger ThreadHandler](INFO): b: 1549603808.073438, a: 1549603808.173438 2019-02-08T05:30:08.292Z,1549603808.292 [logger ThreadHandler](INFO): b: 1549603808.186987, a: 1549603808.286987 2019-02-08T05:30:08.393Z,1549603808.393 [logger ThreadHandler](INFO): b: 1549603808.291610, a: 1549603808.391610 2019-02-08T05:30:08.495Z,1549603808.495 [logger ThreadHandler](INFO): b: 1549603808.392944, a: 1549603808.492944 2019-02-08T05:30:08.606Z,1549603808.606 [logger ThreadHandler](INFO): b: 1549603808.494946, a: 1549603808.594946 2019-02-08T05:30:08.711Z,1549603808.711 [logger ThreadHandler](INFO): b: 1549603808.606572, a: 1549603808.706572 2019-02-08T05:30:08.819Z,1549603808.819 [logger ThreadHandler](INFO): b: 1549603808.710913, a: 1549603808.810913 2019-02-08T05:30:08.930Z,1549603808.930 [logger ThreadHandler](INFO): b: 1549603808.819582, a: 1549603808.919582 2019-02-08T05:30:09.040Z,1549603809.040 [logger ThreadHandler](INFO): b: 1549603808.930437, a: 1549603809.030437 2019-02-08T05:30:09.151Z,1549603809.151 [logger ThreadHandler](INFO): b: 1549603809.040509, a: 1549603809.140509 2019-02-08T05:30:09.253Z,1549603809.253 [logger ThreadHandler](INFO): b: 1549603809.150977, a: 1549603809.250977 2019-02-08T05:30:09.355Z,1549603809.355 [logger ThreadHandler](INFO): b: 1549603809.252879, a: 1549603809.352879 2019-02-08T05:30:09.459Z,1549603809.459 [logger ThreadHandler](INFO): b: 1549603809.355173, a: 1549603809.455173 2019-02-08T05:30:09.581Z,1549603809.581 [logger ThreadHandler](INFO): b: 1549603809.459006, a: 1549603809.559006 2019-02-08T05:30:09.695Z,1549603809.695 [logger ThreadHandler](INFO): b: 1549603809.580668, a: 1549603809.680668 2019-02-08T05:30:09.807Z,1549603809.807 [logger ThreadHandler](INFO): b: 1549603809.694918, a: 1549603809.794918 2019-02-08T05:30:09.910Z,1549603809.910 [logger ThreadHandler](INFO): b: 1549603809.806853, a: 1549603809.906853 2019-02-08T05:30:10.017Z,1549603810.017 [logger ThreadHandler](INFO): b: 1549603809.910313, a: 1549603810.010313 2019-02-08T05:30:10.121Z,1549603810.121 [logger ThreadHandler](INFO): b: 1549603810.017525, a: 1549603810.117525 2019-02-08T05:30:10.222Z,1549603810.222 [logger ThreadHandler](INFO): b: 1549603810.121265, a: 1549603810.221265 2019-02-08T05:30:10.334Z,1549603810.334 [logger ThreadHandler](INFO): b: 1549603810.222559, a: 1549603810.322559 2019-02-08T05:30:10.439Z,1549603810.439 [logger ThreadHandler](INFO): b: 1549603810.334477, a: 1549603810.434477 2019-02-08T05:30:10.551Z,1549603810.551 [logger ThreadHandler](INFO): b: 1549603810.439582, a: 1549603810.539582 2019-02-08T05:30:10.663Z,1549603810.663 [logger ThreadHandler](INFO): b: 1549603810.551144, a: 1549603810.651144 2019-02-08T05:30:10.765Z,1549603810.765 [logger ThreadHandler](INFO): b: 1549603810.662818, a: 1549603810.762818 2019-02-08T05:30:10.878Z,1549603810.878 [logger ThreadHandler](INFO): b: 1549603810.765153, a: 1549603810.865153 2019-02-08T05:30:10.983Z,1549603810.983 [logger ThreadHandler](INFO): b: 1549603810.878424, a: 1549603810.978424 2019-02-08T05:30:11.086Z,1549603811.086 [logger ThreadHandler](INFO): b: 1549603810.982607, a: 1549603811.082607 2019-02-08T05:30:11.192Z,1549603811.192 [logger ThreadHandler](INFO): b: 1549603811.085964, a: 1549603811.185964 2019-02-08T05:30:11.295Z,1549603811.295 [logger ThreadHandler](INFO): b: 1549603811.192109, a: 1549603811.292109 2019-02-08T05:30:11.399Z,1549603811.399 [logger ThreadHandler](INFO): b: 1549603811.294915, a: 1549603811.394915 2019-02-08T05:30:11.504Z,1549603811.504 [logger ThreadHandler](INFO): b: 1549603811.399505, a: 1549603811.499505 2019-02-08T05:30:11.608Z,1549603811.608 [logger ThreadHandler](INFO): b: 1549603811.503917, a: 1549603811.603917 2019-02-08T05:30:11.710Z,1549603811.710 [logger ThreadHandler](INFO): b: 1549603811.608234, a: 1549603811.708234 2019-02-08T05:30:11.819Z,1549603811.819 [logger ThreadHandler](INFO): b: 1549603811.710096, a: 1549603811.810096 2019-02-08T05:30:11.927Z,1549603811.927 [logger ThreadHandler](INFO): b: 1549603811.819348, a: 1549603811.919348 2019-02-08T05:30:12.052Z,1549603812.052 [logger ThreadHandler](INFO): b: 1549603811.926927, a: 1549603812.026927 2019-02-08T05:30:12.154Z,1549603812.154 [logger ThreadHandler](INFO): b: 1549603812.051993, a: 1549603812.151993 2019-02-08T05:30:12.256Z,1549603812.256 [logger ThreadHandler](INFO): b: 1549603812.154211, a: 1549603812.254211 2019-02-08T05:30:12.357Z,1549603812.357 [logger ThreadHandler](INFO): b: 1549603812.255668, a: 1549603812.355668 2019-02-08T05:30:12.463Z,1549603812.463 [logger ThreadHandler](INFO): b: 1549603812.356927, a: 1549603812.456927 2019-02-08T05:30:12.524Z,1549603812.524 [NavChartDb ThreadHandler](INFO): b: 1549603802.154372, a: 1549603802.254372 2019-02-08T05:30:12.565Z,1549603812.565 [logger ThreadHandler](INFO): b: 1549603812.463407, a: 1549603812.563407 2019-02-08T05:30:12.666Z,1549603812.666 [logger ThreadHandler](INFO): b: 1549603812.564714, a: 1549603812.664714 2019-02-08T05:30:12.772Z,1549603812.772 [logger ThreadHandler](INFO): b: 1549603812.666324, a: 1549603812.766324 2019-02-08T05:30:12.876Z,1549603812.876 [logger ThreadHandler](INFO): b: 1549603812.771762, a: 1549603812.871762 2019-02-08T05:30:12.000Z,1549603813.000 [logger ThreadHandler](INFO): b: 1549603812.876114, a: 1549603812.976114 2019-02-08T05:30:13.111Z,1549603813.111 [logger ThreadHandler](INFO): b: 1549603812.999844, a: 1549603813.099844 2019-02-08T05:30:13.212Z,1549603813.212 [logger ThreadHandler](INFO): b: 1549603813.110859, a: 1549603813.210859 2019-02-08T05:30:13.322Z,1549603813.322 [logger ThreadHandler](INFO): b: 1549603813.212417, a: 1549603813.312417 2019-02-08T05:30:13.434Z,1549603813.434 [logger ThreadHandler](INFO): b: 1549603813.322504, a: 1549603813.422504 2019-02-08T05:30:13.536Z,1549603813.536 [logger ThreadHandler](INFO): b: 1549603813.434478, a: 1549603813.534478 2019-02-08T05:30:13.640Z,1549603813.640 [logger ThreadHandler](INFO): b: 1549603813.535867, a: 1549603813.635867 2019-02-08T05:30:13.747Z,1549603813.747 [logger ThreadHandler](INFO): b: 1549603813.640534, a: 1549603813.740534 2019-02-08T05:30:13.851Z,1549603813.851 [logger ThreadHandler](INFO): b: 1549603813.746866, a: 1549603813.846866 2019-02-08T05:30:13.954Z,1549603813.954 [logger ThreadHandler](INFO): b: 1549603813.851349, a: 1549603813.951349 2019-02-08T05:30:14.061Z,1549603814.061 [logger ThreadHandler](INFO): b: 1549603813.954609, a: 1549603814.054609 2019-02-08T05:30:14.172Z,1549603814.172 [logger ThreadHandler](INFO): b: 1549603814.061250, a: 1549603814.161250 2019-02-08T05:30:14.232Z,1549603814.232 [NavChartDb ThreadHandler](INFO): b: 1549603812.524522, a: 1549603812.624522 2019-02-08T05:30:14.278Z,1549603814.278 [logger ThreadHandler](INFO): b: 1549603814.172141, a: 1549603814.272141 2019-02-08T05:30:14.399Z,1549603814.399 [logger ThreadHandler](INFO): b: 1549603814.278561, a: 1549603814.378561 2019-02-08T05:30:14.507Z,1549603814.507 [logger ThreadHandler](INFO): b: 1549603814.399006, a: 1549603814.499006 2019-02-08T05:30:14.615Z,1549603814.615 [logger ThreadHandler](INFO): b: 1549603814.506900, a: 1549603814.606900 2019-02-08T05:30:14.716Z,1549603814.716 [logger ThreadHandler](INFO): b: 1549603814.614943, a: 1549603814.714943 2019-02-08T05:30:14.827Z,1549603814.827 [logger ThreadHandler](INFO): b: 1549603814.716384, a: 1549603814.816384 2019-02-08T05:30:14.937Z,1549603814.937 [logger ThreadHandler](INFO): b: 1549603814.827044, a: 1549603814.927044 2019-02-08T05:30:15.053Z,1549603815.053 [logger ThreadHandler](INFO): b: 1549603814.936951, a: 1549603815.036951 2019-02-08T05:30:15.161Z,1549603815.161 [logger ThreadHandler](INFO): b: 1549603815.052983, a: 1549603815.152983 2019-02-08T05:30:15.274Z,1549603815.274 [logger ThreadHandler](INFO): b: 1549603815.161155, a: 1549603815.261155 2019-02-08T05:30:15.384Z,1549603815.384 [logger ThreadHandler](INFO): b: 1549603815.274517, a: 1549603815.374517 2019-02-08T05:30:15.495Z,1549603815.495 [logger ThreadHandler](INFO): b: 1549603815.383714, a: 1549603815.483714 2019-02-08T05:30:15.596Z,1549603815.596 [logger ThreadHandler](INFO): b: 1549603815.495251, a: 1549603815.595251 2019-02-08T05:30:15.707Z,1549603815.707 [logger ThreadHandler](INFO): b: 1549603815.596567, a: 1549603815.696567 2019-02-08T05:30:15.811Z,1549603815.811 [logger ThreadHandler](INFO): b: 1549603815.707082, a: 1549603815.807082 2019-02-08T05:30:15.917Z,1549603815.917 [logger ThreadHandler](INFO): b: 1549603815.811328, a: 1549603815.911328 2019-02-08T05:30:16.019Z,1549603816.019 [NavChartDb ThreadHandler](INFO): b: 1549603814.231867, a: 1549603814.331867 2019-02-08T05:30:16.030Z,1549603816.030 [logger ThreadHandler](INFO): b: 1549603815.917120, a: 1549603816.017120 2019-02-08T05:30:16.136Z,1549603816.136 [logger ThreadHandler](INFO): b: 1549603816.029662, a: 1549603816.129662 2019-02-08T05:30:16.239Z,1549603816.239 [logger ThreadHandler](INFO): b: 1549603816.135783, a: 1549603816.235783 2019-02-08T05:30:16.359Z,1549603816.359 [logger ThreadHandler](INFO): b: 1549603816.238869, a: 1549603816.338869 2019-02-08T05:30:16.463Z,1549603816.463 [logger ThreadHandler](INFO): b: 1549603816.359205, a: 1549603816.459205 2019-02-08T05:30:16.575Z,1549603816.575 [logger ThreadHandler](INFO): b: 1549603816.463259, a: 1549603816.563259 2019-02-08T05:30:16.684Z,1549603816.684 [logger ThreadHandler](INFO): b: 1549603816.575094, a: 1549603816.675094 2019-02-08T05:30:16.798Z,1549603816.798 [logger ThreadHandler](INFO): b: 1549603816.684391, a: 1549603816.784391 2019-02-08T05:30:16.908Z,1549603816.908 [logger ThreadHandler](INFO): b: 1549603816.798195, a: 1549603816.898195 2019-02-08T05:30:17.014Z,1549603817.014 [logger ThreadHandler](INFO): b: 1549603816.908435, a: 1549603817.008435 2019-02-08T05:30:17.116Z,1549603817.116 [logger ThreadHandler](INFO): b: 1549603817.014020, a: 1549603817.114020 2019-02-08T05:30:17.219Z,1549603817.219 [logger ThreadHandler](INFO): b: 1549603817.116381, a: 1549603817.216381 2019-02-08T05:30:17.320Z,1549603817.320 [logger ThreadHandler](INFO): b: 1549603817.218745, a: 1549603817.318745 2019-02-08T05:30:17.430Z,1549603817.430 [logger ThreadHandler](INFO): b: 1549603817.320519, a: 1549603817.420519 2019-02-08T05:30:17.532Z,1549603817.532 [logger ThreadHandler](INFO): b: 1549603817.430059, a: 1549603817.530059 2019-02-08T05:30:17.636Z,1549603817.636 [logger ThreadHandler](INFO): b: 1549603817.531653, a: 1549603817.631653 2019-02-08T05:30:17.739Z,1549603817.739 [logger ThreadHandler](INFO): b: 1549603817.635857, a: 1549603817.735857 2019-02-08T05:30:17.843Z,1549603817.843 [logger ThreadHandler](INFO): b: 1549603817.738653, a: 1549603817.838653 2019-02-08T05:30:17.950Z,1549603817.950 [logger ThreadHandler](INFO): b: 1549603817.843093, a: 1549603817.943093 2019-02-08T05:30:18.057Z,1549603818.057 [logger ThreadHandler](INFO): b: 1549603817.950331, a: 1549603818.050331 2019-02-08T05:30:18.160Z,1549603818.160 [logger ThreadHandler](INFO): b: 1549603818.057349, a: 1549603818.157349 2019-02-08T05:30:18.263Z,1549603818.263 [logger ThreadHandler](INFO): b: 1549603818.160227, a: 1549603818.260227 2019-02-08T05:30:18.364Z,1549603818.364 [logger ThreadHandler](INFO): b: 1549603818.263103, a: 1549603818.363103 2019-02-08T05:30:18.476Z,1549603818.476 [logger ThreadHandler](INFO): b: 1549603818.364352, a: 1549603818.464352 2019-02-08T05:30:18.579Z,1549603818.579 [logger ThreadHandler](INFO): b: 1549603818.475894, a: 1549603818.575894 2019-02-08T05:30:18.683Z,1549603818.683 [logger ThreadHandler](INFO): b: 1549603818.578955, a: 1549603818.678955 2019-02-08T05:30:18.794Z,1549603818.794 [logger ThreadHandler](INFO): b: 1549603818.682993, a: 1549603818.782993 2019-02-08T05:30:18.897Z,1549603818.897 [logger ThreadHandler](INFO): b: 1549603818.794504, a: 1549603818.894504 2019-02-08T05:30:19.006Z,1549603819.006 [logger ThreadHandler](INFO): b: 1549603818.897423, a: 1549603818.997423 2019-02-08T05:30:19.118Z,1549603819.118 [logger ThreadHandler](INFO): b: 1549603819.005633, a: 1549603819.105633 2019-02-08T05:30:19.224Z,1549603819.224 [logger ThreadHandler](INFO): b: 1549603819.118490, a: 1549603819.218490 2019-02-08T05:30:19.327Z,1549603819.327 [logger ThreadHandler](INFO): b: 1549603819.223966, a: 1549603819.323966 2019-02-08T05:30:19.431Z,1549603819.431 [logger ThreadHandler](INFO): b: 1549603819.327186, a: 1549603819.427186 2019-02-08T05:30:19.533Z,1549603819.533 [logger ThreadHandler](INFO): b: 1549603819.430883, a: 1549603819.530883 2019-02-08T05:30:19.542Z,1549603819.542 [NavChartDb ThreadHandler](INFO): b: 1549603816.019812, a: 1549603816.119812 2019-02-08T05:30:19.635Z,1549603819.635 [logger ThreadHandler](INFO): b: 1549603819.532878, a: 1549603819.632878 2019-02-08T05:30:19.736Z,1549603819.736 [logger ThreadHandler](INFO): b: 1549603819.635078, a: 1549603819.735078 2019-02-08T05:30:19.839Z,1549603819.839 [logger ThreadHandler](INFO): b: 1549603819.736578, a: 1549603819.836578 2019-02-08T05:30:19.942Z,1549603819.942 [logger ThreadHandler](INFO): b: 1549603819.839257, a: 1549603819.