2021-07-28T17:48:45.337Z,1627494525.337 [DataOverHttps](INFO): Received command:restart logs 2021-07-28T17:48:45.380Z,1627494525.380 [CommandLine](IMPORTANT): got command restart logs 2021-07-28T17:48:46.687Z,1627494526.687 [DataOverHttps](INFO): Moved sent file to Logs/20210728T171020/Express0008.lzma.bak 2021-07-28T17:48:46.691Z,1627494526.691 [DataOverHttps](INFO): SBD MOMSN=15767363 2021-07-28T17:49:06.876Z,1627494546.876 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20210728T171020/Courier0016.lzma 2021-07-28T17:49:07.877Z,1627494547.877 [DataOverHttps](INFO): Moved sent file to Logs/20210728T171020/Courier0016.lzma.bak 2021-07-28T17:49:07.877Z,1627494547.877 [DataOverHttps](INFO): SBD MOMSN=15767370 2021-07-28T17:49:35.168Z,1627494575.168 [DataOverHttps](INFO): Sending 321 bytes from file Logs/20210728T171020/Express0011.lzma 2021-07-28T17:49:36.169Z,1627494576.169 [DataOverHttps](INFO): Moved sent file to Logs/20210728T171020/Express0011.lzma.bak 2021-07-28T17:49:36.169Z,1627494576.169 [DataOverHttps](INFO): SBD MOMSN=15767373 2021-07-28T17:50:01.906Z,1627494601.906 [DataOverHttps](INFO): Sending 1168 bytes from file Logs/20210728T171020/Express0014.lzma 2021-07-28T17:50:02.905Z,1627494602.905 [DataOverHttps](INFO): Moved sent file to Logs/20210728T171020/Express0014.lzma.bak 2021-07-28T17:50:02.905Z,1627494602.905 [DataOverHttps](INFO): SBD MOMSN=15767380 2021-07-28T17:50:29.704Z,1627494629.704 [DataOverHttps](INFO): Sending 212 bytes from file Logs/20210728T171020/Express0017.lzma 2021-07-28T17:50:30.705Z,1627494630.705 [DataOverHttps](INFO): Moved sent file to Logs/20210728T171020/Express0017.lzma.bak 2021-07-28T17:50:30.705Z,1627494630.705 [DataOverHttps](INFO): SBD MOMSN=15767413 2021-07-28T17:50:36.253Z,1627494636.253 [Default:CheckIn:Read_Iridium] Stopped 2021-07-28T17:50:36.254Z,1627494636.254 [Default:CheckIn:C.Wait] Running Loop=1 2021-07-28T17:50:36.254Z,1627494636.254 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-07-28T17:55:37.024Z,1627494937.024 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-07-28T17:55:37.024Z,1627494937.024 [Default:CheckIn:C.Wait] Stopped 2021-07-28T17:55:37.024Z,1627494937.024 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-07-28T17:55:37.024Z,1627494937.024 [Default:CheckIn:D] Running Loop=1 2021-07-28T17:55:37.427Z,1627494937.427 [Default:CheckIn:D] Stopped 2021-07-28T17:55:37.427Z,1627494937.427 [Default:CheckIn:E] Running Loop=1 2021-07-28T17:55:37.832Z,1627494937.832 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 12.694827 min 2021-07-28T17:55:37.832Z,1627494937.832 [Default:CheckIn:E] Stopped 2021-07-28T17:55:37.832Z,1627494937.832 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-07-28T17:55:37.832Z,1627494937.832 [Default:CheckIn] Stopped 2021-07-28T17:55:37.832Z,1627494937.832 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-07-28T17:55:37.832Z,1627494937.832 [Default:CheckIn](INFO): Running loop #2 2021-07-28T17:55:37.832Z,1627494937.832 [Default:CheckIn] Running Loop=2 2021-07-28T17:55:37.832Z,1627494937.832 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-07-28T17:55:37.833Z,1627494937.833 [Default:CheckIn:Read_GPS] Running Loop=1 2021-07-28T17:55:39.429Z,1627494939.429 [NAL9602](FAULT): GPS failed to acquire within timeout. 2021-07-28T17:55:39.429Z,1627494939.429 [NAL9602] Data Fault, FailCount= 1 2021-07-28T17:55:39.429Z,1627494939.429 [NAL9602](ERROR): Data Fault 2021-07-28T17:55:39.481Z,1627494939.481 [CBIT](ERROR): Data Fault in component: NAL9602 2021-07-28T17:55:39.833Z,1627494939.833 [NAL9602](INFO): Powering down 2021-07-28T17:55:40.236Z,1627494940.236 [NAL9602](FAULT): LCB fault: Software Overcurrent. 2021-07-28T17:55:40.236Z,1627494940.236 [NAL9602] Hardware Fault, FailCount= 1 2021-07-28T17:55:40.236Z,1627494940.236 [NAL9602](ERROR): Hardware Fault 2021-07-28T17:55:40.674Z,1627494940.674 [CBIT](INFO): Clearing failed state for component NAL9602 2021-07-28T17:55:40.675Z,1627494940.675 [NAL9602] No Fault, FailCount= 1 2021-07-28T17:56:10.136Z,1627494970.136 [NAL9602](INFO): Powering up NAL9602 2021-07-28T17:56:21.041Z,1627494981.041 [NAL9602](INFO): NAL9602 initialized 2021-07-28T17:59:36.585Z,1627495176.585 [DataOverHttps](IMPORTANT): SBD MTMSN=20210728T175935 2021-07-28T17:59:44.105Z,1627495184.105 [DataOverHttps](INFO): Received command:configSet VerticalControl.kpDepthBuoy 120 ratio persist;configSet VerticalControl.kiDepthBuoy 0.15 1/s persist;configSet VerticalControl.kdDepthBuoy 1000 s persist;restart app 2021-07-28T17:59:44.918Z,1627495184.918 [CommandLine](IMPORTANT): got command configSet VerticalControl.kpDepthBuoy 120.000000 ratio persist 2021-07-28T17:59:44.921Z,1627495184.921 [CommandLine](IMPORTANT): got command configSet VerticalControl.kiDepthBuoy 0.150000 reciprocal_second persist 2021-07-28T17:59:44.924Z,1627495184.924 [CommandLine](IMPORTANT): got command configSet VerticalControl.kdDepthBuoy 1000.000000 second persist 2021-07-28T17:59:44.926Z,1627495184.926 [CommandLine](IMPORTANT): got command restart application 2021-07-28T17:59:45.931Z,1627495185.931 [Supervisor](INFO): Stop Mission called by Supervisor::terminate 2021-07-28T17:59:45.932Z,1627495185.932 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2021-07-28T17:59:45.932Z,1627495185.932 [CommandLine ThreadHandler](INFO): Thread cancelled. 2021-07-28T17:59:45.935Z,1627495185.935 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2021-07-28T17:59:45.935Z,1627495185.935 [CommandLine ThreadHandler](INFO): Thread cancelled. 2021-07-28T17:59:45.936Z,1627495185.936 [CommandLine](INFO): Join timeout helper Thread ID is 7091 2021-07-28T17:59:45.936Z,1627495185.936 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2021-07-28T17:59:45.937Z,1627495185.937 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2021-07-28T17:59:45.937Z,1627495185.937 [NavChartDb](INFO): Join timeout helper Thread ID is 7092 2021-07-28T17:59:46.255Z,1627495186.255 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2021-07-28T17:59:46.256Z,1627495186.256 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2021-07-28T17:59:46.271Z,1627495186.271 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2021-07-28T17:59:46.271Z,1627495186.271 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2021-07-28T17:59:46.272Z,1627495186.272 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 7093 2021-07-28T17:59:46.299Z,1627495186.299 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2021-07-28T17:59:46.300Z,1627495186.300 [WetLabsBB2FL](INFO): Powering down 2021-07-28T17:59:46.300Z,1627495186.300 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2021-07-28T17:59:46.311Z,1627495186.311 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2021-07-28T17:59:46.311Z,1627495186.311 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2021-07-28T17:59:46.312Z,1627495186.312 [CTD_Seabird](INFO): Join timeout helper Thread ID is 7094 2021-07-28T17:59:46.911Z,1627495186.911 [CTD_Seabird](INFO): Powering down 2021-07-28T17:59:46.923Z,1627495186.923 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2021-07-28T17:59:46.923Z,1627495186.923 [CTD_Seabird](INFO): Powering down 2021-07-28T17:59:46.943Z,1627495186.943 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2021-07-28T17:59:46.944Z,1627495186.944 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2021-07-28T17:59:46.944Z,1627495186.944 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2021-07-28T17:59:46.944Z,1627495186.944 [Radio_Surface](INFO): Join timeout helper Thread ID is 7095 2021-07-28T17:59:46.951Z,1627495186.951 [Radio_Surface](INFO): Powering down 2021-07-28T17:59:46.952Z,1627495186.952 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2021-07-28T17:59:46.953Z,1627495186.953 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2021-07-28T17:59:46.954Z,1627495186.954 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2021-07-28T17:59:46.954Z,1627495186.954 [Onboard ThreadHandler](INFO): Thread cancelled. 2021-07-28T17:59:46.955Z,1627495186.955 [Onboard](INFO): Join timeout helper Thread ID is 7096 2021-07-28T17:59:47.111Z,1627495187.111 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2021-07-28T17:59:47.435Z,1627495187.435 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2021-07-28T17:59:47.436Z,1627495187.436 [Onboard ThreadHandler](INFO): Thread cancelled. 2021-07-28T17:59:47.448Z,1627495187.448 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2021-07-28T17:59:47.448Z,1627495187.448 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2021-07-28T17:59:47.448Z,1627495187.448 [DataOverHttps](INFO): Join timeout helper Thread ID is 7097 2021-07-28T17:59:48.115Z,1627495188.115 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2021-07-28T17:59:48.116Z,1627495188.116 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2021-07-28T17:59:48.128Z,1627495188.128 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2021-07-28T17:59:48.128Z,1627495188.128 [logger ThreadHandler](INFO): Thread cancelled. 2021-07-28T17:59:48.128Z,1627495188.128 [logger](INFO): Join timeout helper Thread ID is 7098 2021-07-28T17:59:48.131Z,1627495188.131 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2021-07-28T17:59:48.132Z,1627495188.132 [logger ThreadHandler](INFO): Thread cancelled. 2021-07-28T17:59:48.148Z,1627495188.148 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2021-07-28T17:59:48.148Z,1627495188.148 [CommandLine ThreadHandler](INFO): Thread cancelled. 2021-07-28T17:59:48.148Z,1627495188.148 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2021-07-28T17:59:48.148Z,1627495188.148 [controlThread ThreadHandler](INFO): Thread cancelled. 2021-07-28T17:59:48.149Z,1627495188.149 [controlThread](INFO): Join timeout helper Thread ID is 7099 2021-07-28T17:59:48.379Z,1627495188.379 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2021-07-28T17:59:48.380Z,1627495188.380 [controlThread](DEBUG): Uninitializing ControlThread 2021-07-28T17:59:48.380Z,1627495188.380 [AHRS_M2](INFO): Powering down 2021-07-28T17:59:48.452Z,1627495188.452 [NAL9602](INFO): Powering down 2021-07-28T17:59:48.455Z,1627495188.455 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2021-07-28T17:59:48.456Z,1627495188.456 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2021-07-28T17:59:48.457Z,1627495188.457 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2021-07-28T17:59:48.457Z,1627495188.457 [MissionManager](INFO): Uninitializing Mission Default 2021-07-28T17:59:48.457Z,1627495188.457 [Default] Stopped 2021-07-28T17:59:48.457Z,1627495188.457 [Default](DEBUG): Aggregate::uninitialize Default 2021-07-28T17:59:48.457Z,1627495188.457 [Default:B.GoToSurface] Stopped 2021-07-28T17:59:48.458Z,1627495188.458 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2021-07-28T17:59:48.458Z,1627495188.458 [Default:CheckIn] Stopped 2021-07-28T17:59:48.458Z,1627495188.458 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-07-28T17:59:48.458Z,1627495188.458 [Default:CheckIn:Read_GPS] Stopped 2021-07-28T17:59:48.461Z,1627495188.461 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2021-07-28T17:59:48.462Z,1627495188.462 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2021-07-28T17:59:48.462Z,1627495188.462 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2021-07-28T17:59:48.462Z,1627495188.462 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2021-07-28T17:59:48.463Z,1627495188.463 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2021-07-28T17:59:48.463Z,1627495188.463 [BuoyancyServo](INFO): Powering down 2021-07-28T17:59:48.475Z,1627495188.475 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2021-07-28T17:59:48.476Z,1627495188.476 [ElevatorServo](INFO): Powering down 2021-07-28T17:59:48.476Z,1627495188.476 [MassServo](DEBUG): Uninitialize Mass Servo. 2021-07-28T17:59:48.477Z,1627495188.477 [MassServo](INFO): Powering down 2021-07-28T17:59:48.477Z,1627495188.477 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2021-07-28T17:59:48.478Z,1627495188.478 [RudderServo](INFO): Powering down 2021-07-28T17:59:48.479Z,1627495188.479 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2021-07-28T17:59:48.479Z,1627495188.479 [ThrusterServo](INFO): Powering down 2021-07-28T17:59:48.480Z,1627495188.480 [SBIT](DEBUG): Uninitialize SBIT Component. 2021-07-28T17:59:48.480Z,1627495188.480 [IBIT](DEBUG): Uninitialize IBIT Component. 2021-07-28T17:59:48.480Z,1627495188.480 [CBIT](DEBUG): Uninitialize CBIT Component. 2021-07-28T17:59:48.480Z,1627495188.480 [CBIT](DEBUG): Powering off loads. 2021-07-28T17:59:48.491Z,1627495188.491 [CBIT](DEBUG): Disabling WDT. 2021-07-28T17:59:48.503Z,1627495188.503 [CBIT](DEBUG): Opening all GF detection circuits. 2021-07-28T17:59:48.504Z,1627495188.504 [controlThread ThreadHandler](INFO): Thread cancelled. 2021-07-28T17:59:48.542Z,1627495188.542 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2021-07-28T17:59:48.545Z,1627495188.545 [Onboard ThreadHandler](INFO): Thread cancelled. 2021-07-28T17:59:48.552Z,1627495188.552 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2021-07-28T17:59:48.623Z,1627495188.623 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2021-07-28T17:59:48.629Z,1627495188.629 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2021-07-28T17:59:48.668Z,1627495188.668 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2021-07-28T17:59:48.743Z,1627495188.743 [logger ThreadHandler](INFO): Thread cancelled.