2018-10-16T14:45:29.898Z,1539701129.898 [Supervisor](DEBUG): Initializing supervisor. 2018-10-16T14:45:29.900Z,1539701129.900 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2018-10-16T14:45:29.901Z,1539701129.901 [SyncHandler](INFO): Protected caller Thread ID is 2942 2018-10-16T14:45:29.901Z,1539701129.901 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2018-10-16T14:45:29.902Z,1539701129.902 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2018-10-16T14:45:29.903Z,1539701129.903 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 2943 2018-10-16T14:45:29.905Z,1539701129.905 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2018-10-16T14:45:29.917Z,1539701129.917 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2018-10-16T14:45:29.918Z,1539701129.918 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2018-10-16T14:45:29.919Z,1539701129.919 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 2944 2018-10-16T14:45:29.919Z,1539701129.919 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2018-10-16T14:45:29.920Z,1539701129.920 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2018-10-16T14:45:29.921Z,1539701129.921 [logger ThreadHandler](INFO): Protected caller Thread ID is 2945 2018-10-16T14:45:29.923Z,1539701129.923 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2018-10-16T14:45:29.923Z,1539701129.923 [Supervisor](INFO): Looking for Config files in directory: Config/ 2018-10-16T14:45:29.925Z,1539701129.925 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2018-10-16T14:45:30.023Z,1539701130.023 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample 2018-10-16T14:45:30.024Z,1539701130.024 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2018-10-16T14:45:30.123Z,1539701130.123 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2018-10-16T14:45:30.124Z,1539701130.124 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2018-10-16T14:45:30.322Z,1539701130.322 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2018-10-16T14:45:30.322Z,1539701130.322 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2018-10-16T14:45:30.657Z,1539701130.657 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2018-10-16T14:45:30.658Z,1539701130.658 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2018-10-16T14:45:31.001Z,1539701131.001 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2018-10-16T14:45:31.002Z,1539701131.002 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2018-10-16T14:45:31.459Z,1539701131.459 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2018-10-16T14:45:31.459Z,1539701131.459 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2018-10-16T14:45:31.919Z,1539701131.919 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2018-10-16T14:45:31.920Z,1539701131.920 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2018-10-16T14:45:32.369Z,1539701132.369 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2018-10-16T14:45:32.369Z,1539701132.369 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2018-10-16T14:45:32.449Z,1539701132.449 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2018-10-16T14:45:32.763Z,1539701132.763 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2018-10-16T14:45:32.764Z,1539701132.764 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2018-10-16T14:45:32.912Z,1539701132.912 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2018-10-16T14:45:32.913Z,1539701132.913 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2018-10-16T14:45:33.126Z,1539701133.126 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2018-10-16T14:45:33.127Z,1539701133.127 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2018-10-16T14:45:33.333Z,1539701133.333 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2018-10-16T14:45:33.333Z,1539701133.333 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2018-10-16T14:45:33.430Z,1539701133.430 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2018-10-16T14:45:33.431Z,1539701133.431 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2018-10-16T14:45:33.575Z,1539701133.575 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2018-10-16T14:45:33.577Z,1539701133.577 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/ 2018-10-16T14:45:33.578Z,1539701133.578 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg 2018-10-16T14:45:33.805Z,1539701133.805 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2018-10-16T14:45:33.805Z,1539701133.805 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg 2018-10-16T14:45:33.909Z,1539701133.909 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg 2018-10-16T14:45:34.059Z,1539701134.059 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg 2018-10-16T14:45:34.151Z,1539701134.151 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg 2018-10-16T14:45:34.236Z,1539701134.236 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg 2018-10-16T14:45:34.397Z,1539701134.397 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg 2018-10-16T14:45:34.603Z,1539701134.603 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg 2018-10-16T14:45:34.729Z,1539701134.729 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg 2018-10-16T14:45:35.074Z,1539701135.074 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg 2018-10-16T14:45:35.250Z,1539701135.250 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg 2018-10-16T14:45:35.395Z,1539701135.395 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/root/ 2018-10-16T14:45:35.395Z,1539701135.395 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg 2018-10-16T14:45:35.396Z,1539701135.396 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2018-10-16T14:45:35.598Z,1539701135.598 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2018-10-16T14:45:35.598Z,1539701135.598 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2018-10-16T14:45:35.611Z,1539701135.611 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2018-10-16T14:45:35.612Z,1539701135.612 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2018-10-16T14:45:35.781Z,1539701135.781 [DepthRateCalculator] Loaded 2018-10-16T14:45:35.782Z,1539701135.782 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2018-10-16T14:45:35.790Z,1539701135.790 [PitchRateCalculator] Loaded 2018-10-16T14:45:35.791Z,1539701135.791 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2018-10-16T14:45:35.807Z,1539701135.807 [SpeedCalculator] Loaded 2018-10-16T14:45:35.807Z,1539701135.807 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2018-10-16T14:45:35.828Z,1539701135.828 [TempGradientCalculator] Loaded 2018-10-16T14:45:35.828Z,1539701135.828 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread. 2018-10-16T14:45:35.836Z,1539701135.836 [YawRateCalculator] Loaded 2018-10-16T14:45:35.836Z,1539701135.836 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2018-10-16T14:45:35.879Z,1539701135.879 [ElevatorOffsetCalculator] Loaded 2018-10-16T14:45:35.879Z,1539701135.879 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2018-10-16T14:45:35.879Z,1539701135.879 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2018-10-16T14:45:35.880Z,1539701135.880 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2018-10-16T14:45:35.905Z,1539701135.905 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2018-10-16T14:45:35.905Z,1539701135.905 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2018-10-16T14:45:38.243Z,1539701138.243 [DataOverHttps] Loaded 2018-10-16T14:45:38.244Z,1539701138.244 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread. 2018-10-16T14:45:38.269Z,1539701138.269 [Depth_Keller] Loaded 2018-10-16T14:45:38.269Z,1539701138.269 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2018-10-16T14:45:38.278Z,1539701138.278 [GobyModem] Loaded 2018-10-16T14:45:38.278Z,1539701138.278 [ComponentRegistry](DEBUG): SyncComponent "GobyModem" handled in the control thread. 2018-10-16T14:45:38.375Z,1539701138.375 [NAL9602] Loaded 2018-10-16T14:45:38.375Z,1539701138.375 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2018-10-16T14:45:38.392Z,1539701138.392 [Onboard] Loaded 2018-10-16T14:45:38.392Z,1539701138.392 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread. 2018-10-16T14:45:38.402Z,1539701138.402 [Radio_Surface] Loaded 2018-10-16T14:45:38.402Z,1539701138.402 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2018-10-16T14:45:38.403Z,1539701138.403 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 419D44E0 2018-10-16T14:45:38.404Z,1539701138.404 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 3024 2018-10-16T14:45:38.405Z,1539701138.405 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2018-10-16T14:45:38.405Z,1539701138.405 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2018-10-16T14:45:38.533Z,1539701138.533 [SBIT](DEBUG): Construct Startup Built In Test. 2018-10-16T14:45:38.556Z,1539701138.556 [SBIT] Loaded 2018-10-16T14:45:38.556Z,1539701138.556 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2018-10-16T14:45:38.557Z,1539701138.557 [IBIT](DEBUG): Construct Initiated Built In Test. 2018-10-16T14:45:38.569Z,1539701138.569 [IBIT] Loaded 2018-10-16T14:45:38.570Z,1539701138.570 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2018-10-16T14:45:38.573Z,1539701138.573 [CBIT](DEBUG): Construct Continuous Built In Test. 2018-10-16T14:45:38.718Z,1539701138.718 [CBIT] Loaded 2018-10-16T14:45:38.718Z,1539701138.718 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2018-10-16T14:45:38.719Z,1539701138.719 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2018-10-16T14:45:38.719Z,1539701138.719 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2018-10-16T14:45:38.859Z,1539701138.859 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2018-10-16T14:45:38.860Z,1539701138.860 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2018-10-16T14:45:39.100Z,1539701139.100 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2018-10-16T14:45:39.100Z,1539701139.100 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2018-10-16T14:45:39.167Z,1539701139.167 [VerticalControl](DEBUG): Construct VerticalControl. 2018-10-16T14:45:39.261Z,1539701139.261 [VerticalControl] Loaded 2018-10-16T14:45:39.261Z,1539701139.261 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2018-10-16T14:45:39.262Z,1539701139.262 [HorizontalControl](DEBUG): Construct HorizontalControl. 2018-10-16T14:45:39.322Z,1539701139.322 [HorizontalControl] Loaded 2018-10-16T14:45:39.323Z,1539701139.323 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2018-10-16T14:45:39.323Z,1539701139.323 [SpeedControl](DEBUG): Construct SpeedControl. 2018-10-16T14:45:39.328Z,1539701139.328 [SpeedControl] Loaded 2018-10-16T14:45:39.329Z,1539701139.329 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2018-10-16T14:45:39.329Z,1539701139.329 [LoopControl](DEBUG): Construct LoopControl. 2018-10-16T14:45:39.330Z,1539701139.330 [LoopControl] Loaded 2018-10-16T14:45:39.330Z,1539701139.330 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2018-10-16T14:45:39.331Z,1539701139.331 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2018-10-16T14:45:39.331Z,1539701139.331 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2018-10-16T14:45:39.395Z,1539701139.395 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2018-10-16T14:45:39.396Z,1539701139.396 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2018-10-16T14:45:39.495Z,1539701139.495 [BuoyancyServo] Loaded 2018-10-16T14:45:39.495Z,1539701139.495 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2018-10-16T14:45:39.507Z,1539701139.507 [ElevatorServo] Loaded 2018-10-16T14:45:39.507Z,1539701139.507 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2018-10-16T14:45:39.518Z,1539701139.518 [MassServo] Loaded 2018-10-16T14:45:39.519Z,1539701139.519 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2018-10-16T14:45:39.530Z,1539701139.530 [RudderServo] Loaded 2018-10-16T14:45:39.530Z,1539701139.530 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2018-10-16T14:45:39.540Z,1539701139.540 [ThrusterServo] Loaded 2018-10-16T14:45:39.541Z,1539701139.541 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread. 2018-10-16T14:45:39.541Z,1539701139.541 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2018-10-16T14:45:39.542Z,1539701139.542 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2018-10-16T14:45:39.632Z,1539701139.632 [DeadReckonUsingSpeedCalculator] Loaded 2018-10-16T14:45:39.632Z,1539701139.632 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread. 2018-10-16T14:45:39.636Z,1539701139.636 [UniversalFixResidualReporter] Loaded 2018-10-16T14:45:39.637Z,1539701139.637 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2018-10-16T14:45:39.637Z,1539701139.637 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2018-10-16T14:45:39.641Z,1539701139.641 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2018-10-16T14:45:39.641Z,1539701139.641 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2018-10-16T14:45:39.648Z,1539701139.648 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2018-10-16T14:45:39.649Z,1539701139.649 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 41BC84E0 2018-10-16T14:45:39.649Z,1539701139.649 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 3025 2018-10-16T14:45:39.654Z,1539701139.654 [Supervisor](INFO): Main Thread ID is 2941 2018-10-16T14:45:39.654Z,1539701139.654 [Supervisor](DEBUG): Running supervisor. 2018-10-16T14:45:39.655Z,1539701139.655 [CommandLine ThreadHandler](INFO): Handler Thread ID is 3026 2018-10-16T14:45:39.657Z,1539701139.657 [controlThread ThreadHandler](INFO): Handler Thread ID is 3027 2018-10-16T14:45:39.658Z,1539701139.658 [controlThread](DEBUG): Initializing ControlThread 2018-10-16T14:45:39.659Z,1539701139.659 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2018-10-16T14:45:39.659Z,1539701139.659 [PitchRateCalculator](DEBUG): Initializing