2018-10-19T18:17:59.610Z,1539973079.610 [Supervisor](DEBUG): Initializing supervisor. 2018-10-19T18:17:59.613Z,1539973079.613 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2018-10-19T18:17:59.613Z,1539973079.613 [SyncHandler](INFO): Protected caller Thread ID is 799 2018-10-19T18:17:59.614Z,1539973079.614 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2018-10-19T18:17:59.615Z,1539973079.615 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2018-10-19T18:17:59.615Z,1539973079.615 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 800 2018-10-19T18:17:59.618Z,1539973079.618 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2018-10-19T18:17:59.629Z,1539973079.629 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2018-10-19T18:17:59.630Z,1539973079.630 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2018-10-19T18:17:59.631Z,1539973079.631 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 801 2018-10-19T18:17:59.631Z,1539973079.631 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2018-10-19T18:17:59.632Z,1539973079.632 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2018-10-19T18:17:59.633Z,1539973079.633 [logger ThreadHandler](INFO): Protected caller Thread ID is 802 2018-10-19T18:17:59.635Z,1539973079.635 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2018-10-19T18:17:59.635Z,1539973079.635 [Supervisor](INFO): Looking for Config files in directory: Config/ 2018-10-19T18:17:59.639Z,1539973079.639 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2018-10-19T18:17:59.739Z,1539973079.739 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample 2018-10-19T18:17:59.740Z,1539973079.740 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2018-10-19T18:17:59.841Z,1539973079.841 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2018-10-19T18:17:59.842Z,1539973079.842 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2018-10-19T18:18:00.043Z,1539973080.043 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2018-10-19T18:18:00.044Z,1539973080.044 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2018-10-19T18:18:00.471Z,1539973080.471 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2018-10-19T18:18:00.473Z,1539973080.473 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2018-10-19T18:18:00.817Z,1539973080.817 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2018-10-19T18:18:00.819Z,1539973080.819 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2018-10-19T18:18:01.278Z,1539973081.278 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2018-10-19T18:18:01.279Z,1539973081.279 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2018-10-19T18:18:01.740Z,1539973081.740 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2018-10-19T18:18:01.742Z,1539973081.742 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2018-10-19T18:18:02.192Z,1539973082.192 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2018-10-19T18:18:02.194Z,1539973082.194 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2018-10-19T18:18:02.278Z,1539973082.278 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2018-10-19T18:18:02.954Z,1539973082.954 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2018-10-19T18:18:02.956Z,1539973082.956 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2018-10-19T18:18:03.106Z,1539973083.106 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2018-10-19T18:18:03.107Z,1539973083.107 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2018-10-19T18:18:03.325Z,1539973083.325 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2018-10-19T18:18:03.326Z,1539973083.326 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2018-10-19T18:18:03.535Z,1539973083.535 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2018-10-19T18:18:03.537Z,1539973083.537 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2018-10-19T18:18:03.636Z,1539973083.636 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2018-10-19T18:18:03.636Z,1539973083.636 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2018-10-19T18:18:03.783Z,1539973083.783 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2018-10-19T18:18:03.785Z,1539973083.785 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/ 2018-10-19T18:18:03.787Z,1539973083.787 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg 2018-10-19T18:18:04.015Z,1539973084.015 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2018-10-19T18:18:04.016Z,1539973084.016 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg 2018-10-19T18:18:04.122Z,1539973084.122 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg 2018-10-19T18:18:04.273Z,1539973084.273 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg 2018-10-19T18:18:04.368Z,1539973084.368 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg 2018-10-19T18:18:04.455Z,1539973084.455 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg 2018-10-19T18:18:04.617Z,1539973084.617 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg 2018-10-19T18:18:04.825Z,1539973084.825 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg 2018-10-19T18:18:04.924Z,1539973084.924 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg 2018-10-19T18:18:05.021Z,1539973085.021 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg 2018-10-19T18:18:05.121Z,1539973085.121 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg 2018-10-19T18:18:05.206Z,1539973085.206 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/root/ 2018-10-19T18:18:05.206Z,1539973085.206 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg 2018-10-19T18:18:05.209Z,1539973085.209 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2018-10-19T18:18:05.339Z,1539973085.339 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2018-10-19T18:18:05.339Z,1539973085.339 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2018-10-19T18:18:05.363Z,1539973085.363 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2018-10-19T18:18:05.365Z,1539973085.365 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2018-10-19T18:18:05.421Z,1539973085.421 [DepthRateCalculator] Loaded 2018-10-19T18:18:05.421Z,1539973085.421 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2018-10-19T18:18:05.427Z,1539973085.427 [PitchRateCalculator] Loaded 2018-10-19T18:18:05.428Z,1539973085.428 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2018-10-19T18:18:05.443Z,1539973085.443 [SpeedCalculator] Loaded 2018-10-19T18:18:05.443Z,1539973085.443 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2018-10-19T18:18:05.464Z,1539973085.464 [TempGradientCalculator] Loaded 2018-10-19T18:18:05.465Z,1539973085.465 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread. 2018-10-19T18:18:05.470Z,1539973085.470 [YawRateCalculator] Loaded 2018-10-19T18:18:05.471Z,1539973085.471 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2018-10-19T18:18:05.510Z,1539973085.510 [ElevatorOffsetCalculator] Loaded 2018-10-19T18:18:05.511Z,1539973085.511 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2018-10-19T18:18:05.511Z,1539973085.511 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2018-10-19T18:18:05.512Z,1539973085.512 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2018-10-19T18:18:05.550Z,1539973085.550 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2018-10-19T18:18:05.550Z,1539973085.550 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2018-10-19T18:18:16.631Z,1539973096.631 [DataOverHttps] Loaded 2018-10-19T18:18:16.632Z,1539973096.632 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread. 2018-10-19T18:18:16.659Z,1539973096.659 [Depth_Keller] Loaded 2018-10-19T18:18:16.659Z,1539973096.659 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2018-10-19T18:18:16.668Z,1539973096.668 [GobyModem] Loaded 2018-10-19T18:18:16.668Z,1539973096.668 [ComponentRegistry](DEBUG): SyncComponent "GobyModem" handled in the control thread. 2018-10-19T18:18:16.764Z,1539973096.764 [NAL9602] Loaded 2018-10-19T18:18:16.764Z,1539973096.764 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2018-10-19T18:18:16.781Z,1539973096.781 [Onboard] Loaded 2018-10-19T18:18:16.781Z,1539973096.781 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread. 2018-10-19T18:18:16.791Z,1539973096.791 [Radio_Surface] Loaded 2018-10-19T18:18:16.791Z,1539973096.791 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2018-10-19T18:18:16.793Z,1539973096.793 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 419D44E0 2018-10-19T18:18:16.793Z,1539973096.793 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 883 2018-10-19T18:18:16.794Z,1539973096.794 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2018-10-19T18:18:16.795Z,1539973096.795 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2018-10-19T18:18:17.758Z,1539973097.758 [SBIT](DEBUG): Construct Startup Built In Test. 2018-10-19T18:18:17.781Z,1539973097.781 [SBIT] Loaded 2018-10-19T18:18:17.781Z,1539973097.781 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2018-10-19T18:18:17.782Z,1539973097.782 [IBIT](DEBUG): Construct Initiated Built In Test. 2018-10-19T18:18:17.794Z,1539973097.794 [IBIT] Loaded 2018-10-19T18:18:17.795Z,1539973097.795 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2018-10-19T18:18:17.798Z,1539973097.798 [CBIT](DEBUG): Construct Continuous Built In Test. 2018-10-19T18:18:17.947Z,1539973097.947 [CBIT] Loaded 2018-10-19T18:18:17.947Z,1539973097.947 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2018-10-19T18:18:17.948Z,1539973097.948 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2018-10-19T18:18:17.949Z,1539973097.949 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2018-10-19T18:18:18.139Z,1539973098.139 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2018-10-19T18:18:18.140Z,1539973098.140 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2018-10-19T18:18:18.425Z,1539973098.425 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2018-10-19T18:18:18.427Z,1539973098.427 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2018-10-19T18:18:18.515Z,1539973098.515 [VerticalControl](DEBUG): Construct VerticalControl. 2018-10-19T18:18:18.609Z,1539973098.609 [VerticalControl] Loaded 2018-10-19T18:18:18.609Z,1539973098.609 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2018-10-19T18:18:18.610Z,1539973098.610 [HorizontalControl](DEBUG): Construct HorizontalControl. 2018-10-19T18:18:18.670Z,1539973098.670 [HorizontalControl] Loaded 2018-10-19T18:18:18.670Z,1539973098.670 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2018-10-19T18:18:18.671Z,1539973098.671 [SpeedControl](DEBUG): Construct SpeedControl. 2018-10-19T18:18:18.676Z,1539973098.676 [SpeedControl] Loaded 2018-10-19T18:18:18.676Z,1539973098.676 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2018-10-19T18:18:18.677Z,1539973098.677 [LoopControl](DEBUG): Construct LoopControl. 2018-10-19T18:18:18.678Z,1539973098.678 [LoopControl] Loaded 2018-10-19T18:18:18.678Z,1539973098.678 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2018-10-19T18:18:18.678Z,1539973098.678 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2018-10-19T18:18:18.679Z,1539973098.679 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2018-10-19T18:18:18.783Z,1539973098.783 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2018-10-19T18:18:18.783Z,1539973098.783 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2018-10-19T18:18:18.904Z,1539973098.904 [BuoyancyServo] Loaded 2018-10-19T18:18:18.904Z,1539973098.904 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2018-10-19T18:18:18.916Z,1539973098.916 [ElevatorServo] Loaded 2018-10-19T18:18:18.916Z,1539973098.916 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2018-10-19T18:18:18.927Z,1539973098.927 [MassServo] Loaded 2018-10-19T18:18:18.927Z,1539973098.927 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2018-10-19T18:18:18.938Z,1539973098.938 [RudderServo] Loaded 2018-10-19T18:18:18.939Z,1539973098.939 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2018-10-19T18:18:18.949Z,1539973098.949 [ThrusterServo] Loaded 2018-10-19T18:18:18.949Z,1539973098.949 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread. 2018-10-19T18:18:18.950Z,1539973098.950 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2018-10-19T18:18:18.950Z,1539973098.950 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2018-10-19T18:18:19.057Z,1539973099.057 [DeadReckonUsingSpeedCalculator] Loaded 2018-10-19T18:18:19.057Z,1539973099.057 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread. 2018-10-19T18:18:19.062Z,1539973099.062 [UniversalFixResidualReporter] Loaded 2018-10-19T18:18:19.062Z,1539973099.062 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2018-10-19T18:18:19.062Z,1539973099.062 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2018-10-19T18:18:19.066Z,1539973099.066 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2018-10-19T18:18:19.067Z,1539973099.067 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2018-10-19T18:18:19.073Z,1539973099.073 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2018-10-19T18:18:19.074Z,1539973099.074 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 41BC84E0 2018-10-19T18:18:19.075Z,1539973099.075 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 884 2018-10-19T18:18:19.079Z,1539973099.079 [Supervisor](INFO): Main Thread ID is 794 2018-10-19T18:18:19.079Z,1539973099.079 [Supervisor](DEBUG): Running supervisor. 2018-10-19T18:18:19.080Z,1539973099.080 [CommandLine ThreadHandler](INFO): Handler Thread ID is 885 2018-10-19T18:18:19.083Z,1539973099.083 [controlThread ThreadHandler](INFO): Handler Thread ID is 886 2018-10-19T18:18:19.083Z,1539973099.083 [controlThread](DEBUG): Initializing ControlThread 2018-10-19T18:18:19.084Z,1539973099.084 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2018-10-19T18:18:19.084Z,1539973099.084 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2018-10-19T18:18:19.085Z,1539973099.085 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2018-10-19T18:18:19.085Z,1539973099.085 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator. 2018-10-19T18:18:19.086Z,1539973099.086 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2018-10-19T18:18:19.086Z,1539973099.086 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2018-10-19T18:18:19.112Z,1539973099.112 [logger ThreadHandler](INFO): Handler Thread ID is 887 2018-10-19T18:18:19.141Z,1539973099.141 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 888 2018-10-19T18:18:19.146Z,1539973099.146 [Radio_Surface](INFO): Powering up 2018-10-19T18:18:19.241Z,1539973099.241 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 889 2018-10-19T18:18:19.254Z,1539973099.254 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2018-10-19T18:18:19.254Z,1539973099.254 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2018-10-19T18:18:19.255Z,1539973099.255 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2018-10-19T18:18:19.255Z,1539973099.255 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2018-10-19T18:18:19.255Z,1539973099.255 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2018-10-19T18:18:19.255Z,1539973099.255 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2018-10-19T18:18:19.255Z,1539973099.255 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000 2018-10-19T18:18:19.256Z,1539973099.256 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000 2018-10-19T18:18:19.256Z,1539973099.256 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2018-10-19T18:18:19.256Z,1539973099.256 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2018-10-19T18:18:19.256Z,1539973099.256 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000 2018-10-19T18:18:19.256Z,1539973099.256 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000 2018-10-19T18:18:19.257Z,1539973099.257 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000 2018-10-19T18:18:19.257Z,1539973099.257 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000 2018-10-19T18:18:19.257Z,1539973099.257 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000 2018-10-19T18:18:19.257Z,1539973099.257 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000 2018-10-19T18:19:51.861Z,1539973191.861 [GobyModem](CRITICAL): exception at startup: Failed to startup. 2018-10-19T18:19:51.927Z,1539973191.927 [SBIT](INFO): Initialize SBIT Component. 2018-10-19T18:19:51.927Z,1539973191.927 [SBIT](IMPORTANT): git: 2018-10-09-15-g073c7cf 2018-10-19T18:19:51.927Z,1539973191.927 [SBIT](INFO): git hash: 073c7cfad008e3c02fc00b8e52c9ff77a81c70b1 2018-10-19T18:19:51.928Z,1539973191.928 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2018-10-19T18:19:51.928Z,1539973191.928 [SBIT](IMPORTANT): Kernel Version:#2 PREEMPT Thu Jan 11 20:13:48 PST 2018 2018-10-19T18:19:51.929Z,1539973191.929 [SBIT](INFO): Beginning SBIT in 24.000000 seconds. 2018-10-19T18:19:51.929Z,1539973191.929 [IBIT](INFO): Initialize IBIT Component. 2018-10-19T18:19:51.930Z,1539973191.930 [CBIT](DEBUG): Initialize CBIT Component. 2018-10-19T18:19:51.930Z,1539973191.930 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2018-10-19T18:19:52.040Z,1539973192.040 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2018-10-19T18:19:52.042Z,1539973192.042 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2018-10-19T18:19:52.043Z,1539973192.043 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2018-10-19T18:19:52.043Z,1539973192.043 [LoopControl](DEBUG): Initialize LoopControlComponent. 2018-10-19T18:19:52.045Z,1539973192.045 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2018-10-19T18:19:52.045Z,1539973192.045 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2018-10-19T18:19:52.046Z,1539973192.046 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2018-10-19T18:19:52.046Z,1539973192.046 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2018-10-19T18:19:52.047Z,1539973192.047 [MissionManager](INFO): Loading Mission: Missions/Startup.xml 2018-10-19T18:19:52.096Z,1539973192.096 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2018-10-19T18:19:52.128Z,1539973192.128 [MissionManager](DEBUG): 2018-10-19T18:19:52.129Z,1539973192.129 [MissionManager](INFO): Loading Mission: Missions/Default.xml 2018-10-19T18:19:52.187Z,1539973192.187 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2018-10-19T18:19:52.188Z,1539973192.188 [Default:A.Wait](DEBUG): Construct Wait. 2018-10-19T18:19:52.190Z,1539973192.190 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2018-10-19T18:19:52.202Z,1539973192.202 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2018-10-19T18:19:52.205Z,1539973192.205 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2018-10-19T18:19:52.210Z,1539973192.210 [Default:E.Execute](DEBUG): Construct Execute. 2018-10-19T18:19:52.215Z,1539973192.215 [MissionManager](DEBUG): 0 Wait a moment to see if the scheduler starts a new mission before starting to actually run Default. 13 Burn 300 Dropped weight due to communications timeout. 5 Default mission has been running for Restarting logs and Default mission. restart logs 2018-10-19T18:19:52.219Z,1539973192.219 [controlThread](DEBUG): Component order: CycleStarter,DataOverHttps,Depth_Keller,GobyModem,NAL9602,Onboard,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingSpeedCalculator,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter, 2018-10-19T18:19:52.227Z,1539973192.227 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2018-10-19T18:19:52.251Z,1539973192.251 [Depth_Keller](ERROR): Pressure reading out of range: 1895.684326 decibar 2018-10-19T18:19:52.279Z,1539973192.279 [NAL9602](INFO): Powering up NAL9602 2018-10-19T18:19:52.332Z,1539973192.332 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-10-19T18:19:52.374Z,1539973192.374 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:19:52.528Z,1539973192.528 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2018-10-19T18:19:52.536Z,1539973192.536 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2018-10-19T18:19:52.542Z,1539973192.542 [ElevatorServo](DEBUG): Initializing EZServoServo. 2018-10-19T18:19:52.548Z,1539973192.548 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2018-10-19T18:19:52.554Z,1539973192.554 [MassServo](DEBUG): Initializing EZServoServo. 2018-10-19T18:19:52.560Z,1539973192.560 [MassServo](DEBUG): Initializing MassServo. 2018-10-19T18:19:52.566Z,1539973192.566 [RudderServo](DEBUG): Initializing EZServoServo. 2018-10-19T18:19:52.572Z,1539973192.572 [RudderServo](DEBUG): Initializing RudderServo. 2018-10-19T18:19:52.578Z,1539973192.578 [ThrusterServo](DEBUG): Initializing EZServoServo. 2018-10-19T18:19:52.584Z,1539973192.584 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2018-10-19T18:19:52.604Z,1539973192.604 [CommandLine](FAULT): Scheduling is paused 2018-10-19T18:19:52.604Z,1539973192.604 [CBIT](INFO): Critical error at 20181019T181951 2018-10-19T18:19:52.605Z,1539973192.605 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2018-10-19T18:19:52.605Z,1539973192.605 [CBIT](FAULT): Main Battery Failure. Count: 1 2018-10-19T18:19:52.707Z,1539973192.707 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:19:53.061Z,1539973193.061 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:19:53.396Z,1539973193.396 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout 2018-10-19T18:19:53.396Z,1539973193.396 [BuoyancyServo](FAULT): Buoyancy failed to initialize 2018-10-19T18:19:53.396Z,1539973193.396 [BuoyancyServo] Communications Fault, FailCount= 1 2018-10-19T18:19:53.396Z,1539973193.396 [BuoyancyServo](ERROR): Communications Fault 2018-10-19T18:19:53.628Z,1539973193.628 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2018-10-19T18:19:53.670Z,1539973193.670 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:19:53.675Z,1539973193.675 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2018-10-19T18:19:53.677Z,1539973193.677 [BuoyancyServo](INFO): Powering down 2018-10-19T18:19:54.067Z,1539973194.067 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:19:54.475Z,1539973194.475 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:19:54.871Z,1539973194.871 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:19:55.264Z,1539973195.264 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:19:55.671Z,1539973195.671 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:19:55.724Z,1539973195.724 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2018-10-19T18:19:55.724Z,1539973195.724 [BuoyancyServo] No Fault, FailCount= 1 2018-10-19T18:19:56.071Z,1539973196.071 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:19:56.076Z,1539973196.076 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2018-10-19T18:19:56.197Z,1539973196.197 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2018-10-19T18:19:56.479Z,1539973196.479 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:19:56.867Z,1539973196.867 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:19:57.267Z,1539973197.267 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:19:57.671Z,1539973197.671 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:19:58.067Z,1539973198.067 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:19:58.471Z,1539973198.471 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:19:58.868Z,1539973198.868 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:19:59.271Z,1539973199.271 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:19:59.680Z,1539973199.680 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:00.071Z,1539973200.071 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:00.472Z,1539973200.472 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:00.872Z,1539973200.872 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:01.269Z,1539973201.269 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:01.669Z,1539973201.669 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:02.071Z,1539973202.071 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:02.083Z,1539973202.083 [CBIT](CRITICAL): Environmental Failure. Press:14.830569 PSI. Humidity:33%. Temp:28 C. ABORTING MISSION 2018-10-19T18:20:02.468Z,1539973202.468 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:02.477Z,1539973202.477 [CBIT](INFO): Critical error at 20181019T182002 2018-10-19T18:20:02.847Z,1539973202.847 [GobyModem](INFO): Added slot 1 2018-10-19T18:20:02.847Z,1539973202.847 [GobyModem](INFO): Added slot 2 2018-10-19T18:20:02.848Z,1539973202.848 [GobyModem](INFO): Added slot 3 2018-10-19T18:20:04.304Z,1539973204.304 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:04.404Z,1539973204.404 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:04.747Z,1539973204.747 [NAL9602](INFO): NAL9602 initialized 2018-10-19T18:20:04.783Z,1539973204.783 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:05.192Z,1539973205.192 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:05.588Z,1539973205.588 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:05.981Z,1539973205.981 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:06.408Z,1539973206.408 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:06.784Z,1539973206.784 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:07.179Z,1539973207.179 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:07.578Z,1539973207.578 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:07.978Z,1539973207.978 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:08.387Z,1539973208.387 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:08.784Z,1539973208.784 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:09.188Z,1539973209.188 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:09.579Z,1539973209.579 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:09.984Z,1539973209.984 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:10.384Z,1539973210.384 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:10.779Z,1539973210.779 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:11.171Z,1539973211.171 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:11.580Z,1539973211.580 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:11.979Z,1539973211.979 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:12.391Z,1539973212.391 [GobyModem](INFO): {control} starting send from me 2018-10-19T18:20:12.423Z,1539973212.423 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:12.784Z,1539973212.784 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:13.187Z,1539973213.187 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:13.584Z,1539973213.584 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:13.992Z,1539973213.992 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:14.387Z,1539973214.387 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:14.773Z,1539973214.773 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:15.180Z,1539973215.180 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:15.580Z,1539973215.580 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:15.975Z,1539973215.975 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:16.376Z,1539973216.376 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:16.384Z,1539973216.384 [SBIT](IMPORTANT): Beginning Startup BIT 2018-10-19T18:20:16.389Z,1539973216.389 [CBIT](IMPORTANT): Beginning ground fault scan 2018-10-19T18:20:16.779Z,1539973216.779 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:17.183Z,1539973217.183 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:17.580Z,1539973217.580 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:17.984Z,1539973217.984 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:18.387Z,1539973218.387 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:18.900Z,1539973218.900 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:19.320Z,1539973219.320 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:19.707Z,1539973219.707 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:20.087Z,1539973220.087 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:20.487Z,1539973220.487 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:20.886Z,1539973220.886 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:21.292Z,1539973221.292 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:21.687Z,1539973221.687 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:22.083Z,1539973222.083 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:22.492Z,1539973222.492 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:22.891Z,1539973222.891 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:23.286Z,1539973223.286 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:23.720Z,1539973223.720 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:24.118Z,1539973224.118 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:24.492Z,1539973224.492 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:24.920Z,1539973224.920 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:25.287Z,1539973225.287 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:25.691Z,1539973225.691 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:26.083Z,1539973226.083 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:26.492Z,1539973226.492 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:26.891Z,1539973226.891 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:27.285Z,1539973227.285 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:27.341Z,1539973227.341 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): -0.006622 CHAN A1 (24V): -0.012240 CHAN A2 (12V): -0.005140 CHAN A3 (5V): -0.002431 CHAN B0 (3.3V): -0.000999 CHAN B1 (3.15aV): -0.000702 CHAN B2 (3.15bV): -0.001226 CHAN B3 (GND): -0.000391 OPEN: 0.004073 Full Scale Calc: 4.765 mA, -1.589 mA 2018-10-19T18:20:27.692Z,1539973227.692 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:28.091Z,1539973228.091 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:28.487Z,1539973228.487 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:28.905Z,1539973228.905 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:29.299Z,1539973229.299 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:29.721Z,1539973229.721 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:30.120Z,1539973230.120 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:30.483Z,1539973230.483 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:30.885Z,1539973230.885 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:31.287Z,1539973231.287 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:31.686Z,1539973231.686 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:32.251Z,1539973232.251 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:32.652Z,1539973232.652 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:33.048Z,1539973233.048 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:33.456Z,1539973233.456 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:33.852Z,1539973233.852 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:34.273Z,1539973234.273 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:34.676Z,1539973234.676 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:35.080Z,1539973235.080 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:35.472Z,1539973235.472 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:35.856Z,1539973235.856 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:36.260Z,1539973236.260 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:36.656Z,1539973236.656 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:37.056Z,1539973237.056 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:37.456Z,1539973237.456 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:37.847Z,1539973237.847 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:38.256Z,1539973238.256 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:38.651Z,1539973238.651 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:39.052Z,1539973239.052 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:39.480Z,1539973239.480 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:39.871Z,1539973239.871 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:40.277Z,1539973240.277 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:40.672Z,1539973240.672 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:41.052Z,1539973241.052 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:41.455Z,1539973241.455 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:41.892Z,1539973241.892 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:42.260Z,1539973242.260 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:42.648Z,1539973242.648 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:43.060Z,1539973243.060 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:43.452Z,1539973243.452 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:43.851Z,1539973243.851 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:44.252Z,1539973244.252 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:44.680Z,1539973244.680 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:45.078Z,1539973245.078 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:45.476Z,1539973245.476 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:45.871Z,1539973245.871 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:45.886Z,1539973245.886 [CommandLine](IMPORTANT): got command restart application 2018-10-19T18:20:46.257Z,1539973246.257 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:46.652Z,1539973246.652 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:46.895Z,1539973246.895 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2018-10-19T18:20:46.895Z,1539973246.895 [CommandLine ThreadHandler](INFO): Thread cancelled. 2018-10-19T18:20:47.056Z,1539973247.056 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2018-10-19T18:20:47.056Z,1539973247.056 [CommandLine ThreadHandler](INFO): Thread cancelled. 2018-10-19T18:20:47.057Z,1539973247.057 [CommandLine](INFO): Join timeout helper Thread ID is 911 2018-10-19T18:20:47.057Z,1539973247.057 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2018-10-19T18:20:47.057Z,1539973247.057 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2018-10-19T18:20:47.058Z,1539973247.058 [NavChartDb](INFO): Join timeout helper Thread ID is 912 2018-10-19T18:20:47.062Z,1539973247.062 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:47.356Z,1539973247.356 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2018-10-19T18:20:47.356Z,1539973247.356 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2018-10-19T18:20:47.368Z,1539973247.368 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2018-10-19T18:20:47.368Z,1539973247.368 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2018-10-19T18:20:47.368Z,1539973247.368 [Radio_Surface](INFO): Join timeout helper Thread ID is 913 2018-10-19T18:20:47.454Z,1539973247.454 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-19T18:20:47.492Z,1539973247.4