2019-07-01T20:29:49.137Z,1562012989.137 [NAL9602](INFO): Received command:restart logs 2019-07-01T20:29:49.142Z,1562012989.142 [CommandLine](IMPORTANT): got command restart logs 2019-07-01T20:29:49.869Z,1562012989.869 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:29:53.105Z,1562012993.105 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:29:55.937Z,1562012995.937 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:29:59.165Z,1562012999.165 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:30:01.993Z,1562013001.993 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:30:04.816Z,1562013004.816 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:30:07.244Z,1562013007.244 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:30:10.085Z,1562013010.085 [NAL9602](FAULT): GPS failed to acquire within timeout. 2019-07-01T20:30:10.085Z,1562013010.085 [NAL9602] Data Fault, FailCount= 1 2019-07-01T20:30:10.085Z,1562013010.085 [NAL9602](ERROR): Data Fault 2019-07-01T20:30:10.172Z,1562013010.172 [CBIT](ERROR): Data Fault in component: NAL9602 2019-07-01T20:30:10.476Z,1562013010.476 [NAL9602](INFO): Powering down 2019-07-01T20:30:11.318Z,1562013011.318 [CBIT](INFO): Clearing failed state for component NAL9602 2019-07-01T20:30:11.318Z,1562013011.318 [NAL9602] No Fault, FailCount= 1 2019-07-01T20:30:40.759Z,1562013040.759 [NAL9602](INFO): Powering up NAL9602 2019-07-01T20:30:51.667Z,1562013051.667 [NAL9602](INFO): NAL9602 initialized 2019-07-01T20:30:52.484Z,1562013052.484 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:30:55.725Z,1562013055.725 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:30:58.965Z,1562013058.965 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:31:01.784Z,1562013061.784 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:31:05.016Z,1562013065.016 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:31:07.837Z,1562013067.837 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:31:11.079Z,1562013071.079 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:31:13.937Z,1562013073.937 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:31:16.724Z,1562013076.724 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:31:19.156Z,1562013079.156 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:31:21.984Z,1562013081.984 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:31:25.213Z,1562013085.213 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:31:28.044Z,1562013088.044 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:31:30.864Z,1562013090.864 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:31:33.697Z,1562013093.697 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:31:36.928Z,1562013096.928 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:31:39.752Z,1562013099.752 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:31:42.997Z,1562013102.997 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:31:45.821Z,1562013105.821 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:31:49.049Z,1562013109.049 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:31:51.884Z,1562013111.884 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:31:55.125Z,1562013115.125 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:31:57.961Z,1562013117.961 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:32:01.168Z,1562013121.168 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:32:03.992Z,1562013123.992 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:32:07.229Z,1562013127.229 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:32:10.065Z,1562013130.065 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:32:13.288Z,1562013133.288 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:32:15.721Z,1562013135.721 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:32:18.973Z,1562013138.973 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:32:21.780Z,1562013141.780 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:32:25.008Z,1562013145.008 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:32:27.836Z,1562013147.836 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:32:31.084Z,1562013151.084 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:32:33.925Z,1562013153.925 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:32:37.124Z,1562013157.124 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:32:39.957Z,1562013159.957 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:32:43.188Z,1562013163.188 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:32:46.016Z,1562013166.016 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:32:49.249Z,1562013169.249 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:32:52.072Z,1562013172.072 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:32:54.925Z,1562013174.925 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:32:58.136Z,1562013178.136 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:33:00.965Z,1562013180.965 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:33:03.793Z,1562013183.793 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:33:07.040Z,1562013187.040 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:33:09.849Z,1562013189.849 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:33:13.084Z,1562013193.084 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:33:15.920Z,1562013195.920 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:33:19.144Z,1562013199.144 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:33:21.972Z,1562013201.972 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:33:25.201Z,1562013205.201 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:33:28.033Z,1562013208.033 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:33:31.284Z,1562013211.284 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:33:34.093Z,1562013214.093 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:33:36.924Z,1562013216.924 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:33:40.157Z,1562013220.157 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:33:42.981Z,1562013222.981 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:33:45.813Z,1562013225.813 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:33:49.037Z,1562013229.037 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:33:51.868Z,1562013231.868 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:33:55.100Z,1562013235.100 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:33:57.944Z,1562013237.944 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:34:01.161Z,1562013241.161 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:34:03.993Z,1562013243.993 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:34:07.224Z,1562013247.224 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:34:10.053Z,1562013250.053 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:34:13.280Z,1562013253.280 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:34:15.704Z,1562013255.704 [NAL9602](DEBUG): Fix Requested 2019-07-01T20:34:17.756Z,1562013257.756 [Default:CheckIn:Read_GPS](INFO): Timed out from 2019-07-01T20:29:17.6Z 2019-07-01T20:34:17.756Z,1562013257.756 [Default:CheckIn:Read_GPS] Stopped 2019-07-01T20:34:17.756Z,1562013257.756 [Default:CheckIn:Read_Iridium] Running Loop=1 2019-07-01T20:34:25.993Z,1562013265.993 [DataOverHttps](INFO): Sending 162 bytes from file Logs/20190701T162312/Express0083.lzma 2019-07-01T20:34:27.210Z,1562013267.210 [DataOverHttps](INFO): Moved sent file to Logs/20190701T162312/Express0083.lzma.bak 2019-07-01T20:34:27.211Z,1562013267.211 [DataOverHttps](INFO): SBD MOMSN=11417592 2019-07-01T20:34:45.436Z,1562013285.436 [DataOverHttps](INFO): Sending 163 bytes from file Logs/20190701T162312/Express0086.lzma 2019-07-01T20:34:46.242Z,1562013286.242 [DataOverHttps](INFO): Moved sent file to Logs/20190701T162312/Express0086.lzma.bak 2019-07-01T20:34:46.242Z,1562013286.242 [DataOverHttps](INFO): SBD MOMSN=11417596 2019-07-01T20:34:50.659Z,1562013290.659 [NAL9602](INFO): Powering down 2019-07-01T20:35:04.242Z,1562013304.242 [DataOverHttps](INFO): Sending 312 bytes from file Logs/20190701T202949/Express0001.lzma 2019-07-01T20:35:05.046Z,1562013305.046 [DataOverHttps](INFO): Moved sent file to Logs/20190701T202949/Express0001.lzma.bak 2019-07-01T20:35:05.046Z,1562013305.046 [DataOverHttps](INFO): SBD MOMSN=11417600 2019-07-01T20:35:07.532Z,1562013307.532 [Default:CheckIn:Read_Iridium] Stopped 2019-07-01T20:35:07.532Z,1562013307.532 [Default:CheckIn:C.Wait] Running Loop=1 2019-07-01T20:35:07.532Z,1562013307.532 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2019-07-01T20:37:51.265Z,1562013471.265 [RDI_Pathfinder](ERROR): Failed to parse: :.9, 0 2019-07-01T20:38:12.630Z,1562013492.630 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2019-07-01T20:38:12.630Z,1562013492.630 [RDI_Pathfinder](ERROR): Failed to parse: :RA, 0.00, 0.00, 0.00, 0.00 2019-07-01T20:38:16.794Z,1562013496.794 [DataOverHttps](IMPORTANT): SBD MTMSN=20190701T203816 2019-07-01T20:38:22.345Z,1562013502.345 [DataOverHttps](INFO): Received command:restart app 2019-07-01T20:38:22.409Z,1562013502.409 [CommandLine](IMPORTANT): got command restart application 2019-07-01T20:38:23.413Z,1562013503.413 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2019-07-01T20:38:23.413Z,1562013503.413 [CommandLine ThreadHandler](INFO): Thread cancelled. 2019-07-01T20:38:23.488Z,1562013503.488 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2019-07-01T20:38:23.489Z,1562013503.489 [CommandLine ThreadHandler](INFO): Thread cancelled. 2019-07-01T20:38:23.489Z,1562013503.489 [CommandLine](INFO): Join timeout helper Thread ID is 1501 2019-07-01T20:38:23.490Z,1562013503.490 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2019-07-01T20:38:23.490Z,1562013503.490 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2019-07-01T20:38:23.490Z,1562013503.490 [NavChartDb](INFO): Join timeout helper Thread ID is 1502 2019-07-01T20:38:23.709Z,1562013503.709 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2019-07-01T20:38:23.709Z,1562013503.709 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2019-07-01T20:38:23.717Z,1562013503.717 [ComponentRegistry](INFO): Shutting down WetLabsSeaOWL_UV_A ThreadHandler 2019-07-01T20:38:23.717Z,1562013503.717 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled. 2019-07-01T20:38:23.717Z,1562013503.717 [WetLabsSeaOWL_UV_A](INFO): Join timeout helper Thread ID is 1503 2019-07-01T20:38:23.737Z,1562013503.737 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Uninitializing protected caller thread. 2019-07-01T20:38:23.737Z,1562013503.737 [WetLabsSeaOWL_UV_A](INFO): Powering down 2019-07-01T20:38:23.738Z,1562013503.738 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled. 2019-07-01T20:38:23.756Z,1562013503.756 [ComponentRegistry](INFO): Shutting down CTD_NeilBrown ThreadHandler 2019-07-01T20:38:23.757Z,1562013503.757 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled. 2019-07-01T20:38:23.757Z,1562013503.757 [CTD_NeilBrown](INFO): Join timeout helper Thread ID is 1504 2019-07-01T20:38:23.917Z,1562013503.917 [CTD_NeilBrown ThreadHandler](INFO): Uninitializing protected caller thread. 2019-07-01T20:38:23.917Z,1562013503.917 [CTD_NeilBrown](INFO): Powering down 2019-07-01T20:38:23.929Z,1562013503.929 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled. 2019-07-01T20:38:23.929Z,1562013503.929 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2019-07-01T20:38:23.929Z,1562013503.929 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2019-07-01T20:38:23.930Z,1562013503.930 [Radio_Surface](INFO): Join timeout helper Thread ID is 1505 2019-07-01T20:38:24.149Z,1562013504.149 [Radio_Surface](INFO): Powering down 2019-07-01T20:38:24.149Z,1562013504.149 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2019-07-01T20:38:24.150Z,1562013504.150 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2019-07-01T20:38:24.153Z,1562013504.153 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2019-07-01T20:38:24.154Z,1562013504.154 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2019-07-01T20:38:24.154Z,1562013504.154 [DataOverHttps](INFO): Join timeout helper Thread ID is 1506 2019-07-01T20:38:24.361Z,1562013504.361 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2019-07-01T20:38:24.361Z,1562013504.361 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2019-07-01T20:38:24.365Z,1562013504.365 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2019-07-01T20:38:24.365Z,1562013504.365 [logger ThreadHandler](INFO): Thread cancelled. 2019-07-01T20:38:24.366Z,1562013504.366 [logger](INFO): Join timeout helper Thread ID is 1507 2019-07-01T20:38:24.437Z,1562013504.437 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2019-07-01T20:38:24.437Z,1562013504.437 [logger ThreadHandler](INFO): Thread cancelled. 2019-07-01T20:38:24.449Z,1562013504.449 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2019-07-01T20:38:24.449Z,1562013504.449 [CommandLine ThreadHandler](INFO): Thread cancelled. 2019-07-01T20:38:24.450Z,1562013504.450 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2019-07-01T20:38:24.450Z,1562013504.450 [controlThread ThreadHandler](INFO): Thread cancelled. 2019-07-01T20:38:24.450Z,1562013504.450 [controlThread](INFO): Join timeout helper Thread ID is 1508 2019-07-01T20:38:24.713Z,1562013504.713 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2019-07-01T20:38:24.713Z,1562013504.713 [controlThread](DEBUG): Uninitializing ControlThread 2019-07-01T20:38:24.713Z,1562013504.713 [AHRS_M2](INFO): Powering down 2019-07-01T20:38:24.785Z,1562013504.785 [DUSBL_Hydroid](INFO): Powering down 2019-07-01T20:38:24.877Z,1562013504.877 [Micromodem](INFO): Powering down 2019-07-01T20:38:24.973Z,1562013504.973 [NAL9602](INFO): Powering down 2019-07-01T20:38:25.045Z,1562013505.045 [RDI_Pathfinder](INFO): Powering down 2019-07-01T20:38:25.046Z,1562013505.046 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2019-07-01T20:38:25.047Z,1562013505.047 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2019-07-01T20:38:25.047Z,1562013505.047 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2019-07-01T20:38:25.048Z,1562013505.048 [MissionManager](INFO): Uninitializing Mission Default 2019-07-01T20:38:25.048Z,1562013505.048 [Default] Stopped 2019-07-01T20:38:25.048Z,1562013505.048 [Default](DEBUG): Aggregate::uninitialize Default 2019-07-01T20:38:25.048Z,1562013505.048 [Default:B.GoToSurface] Stopped 2019-07-01T20:38:25.048Z,1562013505.048 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2019-07-01T20:38:25.048Z,1562013505.048 [Default:CheckIn] Stopped 2019-07-01T20:38:25.048Z,1562013505.048 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2019-07-01T20:38:25.049Z,1562013505.049 [Default:CheckIn:C.Wait] Stopped 2019-07-01T20:38:25.049Z,1562013505.049 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2019-07-01T20:38:25.051Z,1562013505.051 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2019-07-01T20:38:25.051Z,1562013505.051 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2019-07-01T20:38:25.051Z,1562013505.051 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2019-07-01T20:38:25.052Z,1562013505.052 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2019-07-01T20:38:25.052Z,1562013505.052 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2019-07-01T20:38:25.052Z,1562013505.052 [BuoyancyServo](INFO): Powering down 2019-07-01T20:38:25.065Z,1562013505.065 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2019-07-01T20:38:25.065Z,1562013505.065 [ElevatorServo](INFO): Powering down 2019-07-01T20:38:25.066Z,1562013505.066 [MassServo](DEBUG): Uninitialize Mass Servo. 2019-07-01T20:38:25.066Z,1562013505.066 [MassServo](INFO): Powering down 2019-07-01T20:38:25.066Z,1562013505.066 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2019-07-01T20:38:25.066Z,1562013505.066 [RudderServo](INFO): Powering down 2019-07-01T20:38:25.067Z,1562013505.067 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2019-07-01T20:38:25.067Z,1562013505.067 [ThrusterServo](INFO): Powering down 2019-07-01T20:38:25.068Z,1562013505.068 [SBIT](DEBUG): Uninitialize SBIT Component. 2019-07-01T20:38:25.069Z,1562013505.069 [IBIT](DEBUG): Uninitialize IBIT Component. 2019-07-01T20:38:25.069Z,1562013505.069 [CBIT](DEBUG): Uninitialize CBIT Component. 2019-07-01T20:38:25.069Z,1562013505.069 [CBIT](DEBUG): Powering off loads. 2019-07-01T20:38:25.080Z,1562013505.080 [CBIT](DEBUG): Disabling WDT. 2019-07-01T20:38:25.092Z,1562013505.092 [CBIT](DEBUG): Opening all GF detection circuits. 2019-07-01T20:38:25.093Z,1562013505.093 [controlThread ThreadHandler](INFO): Thread cancelled. 2019-07-01T20:38:25.150Z,1562013505.150 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2019-07-01T20:38:25.159Z,1562013505.159 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2019-07-01T20:38:25.201Z,1562013505.201 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled. 2019-07-01T20:38:25.203Z,1562013505.203 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled. 2019-07-01T20:38:25.262Z,1562013505.262 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2019-07-01T20:38:25.338Z,1562013505.338 [logger ThreadHandler](INFO): Thread cancelled.