2019-06-07T15:47:10.253Z,1559922430.253 [NAL9602](INFO): Received command:restart logs 2019-06-07T15:47:10.294Z,1559922430.294 [CommandLine](IMPORTANT): got command restart logs 2019-06-07T15:47:29.947Z,1559922449.947 [NAL9602](INFO): SBD MO Status=1, MOMSN=29862, MT Status=0, MTMSN=0 2019-06-07T15:47:29.997Z,1559922449.997 [NAL9602](INFO): Sent 25 bytes from file Logs/20190607T035453/Courier0159.lzma 2019-06-07T15:47:29.997Z,1559922449.997 [NAL9602](INFO): Packets left to send: 0 2019-06-07T15:47:49.494Z,1559922469.494 [NAL9602](INFO): SBD MO Status=1, MOMSN=29863, MT Status=0, MTMSN=0 2019-06-07T15:47:49.545Z,1559922469.545 [NAL9602](INFO): Sent 187 bytes from file Logs/20190607T035453/Express0157.lzma 2019-06-07T15:47:49.545Z,1559922469.545 [NAL9602](INFO): Packets left to send: 0 2019-06-07T15:48:00.355Z,1559922480.355 [NAL9602](INFO): SBD MO Status=1, MOMSN=29864, MT Status=0, MTMSN=0 2019-06-07T15:48:00.405Z,1559922480.405 [NAL9602](INFO): Sent 107 bytes from file Logs/20190607T035453/Express0160.lzma 2019-06-07T15:48:00.405Z,1559922480.405 [NAL9602](INFO): Packets left to send: 0 2019-06-07T15:48:21.332Z,1559922501.332 [DVL_micro](FAULT): DVL failed to acquire valid data within timeout. 2019-06-07T15:48:21.332Z,1559922501.332 [DVL_micro] Data Fault, FailCount= 1 2019-06-07T15:48:21.332Z,1559922501.332 [DVL_micro](ERROR): Data Fault 2019-06-07T15:48:21.370Z,1559922501.370 [CBIT](ERROR): Data Fault in component: DVL_micro 2019-06-07T15:48:21.809Z,1559922501.809 [DVL_micro](INFO): uninitialize:Powering down 2019-06-07T15:48:22.589Z,1559922502.589 [CBIT](INFO): Clearing failed state for component DVL_micro 2019-06-07T15:48:22.589Z,1559922502.589 [DVL_micro] No Fault, FailCount= 1 2019-06-07T15:48:22.961Z,1559922502.961 [DVL_micro](INFO): Initializing 2019-06-07T15:48:46.782Z,1559922526.782 [NAL9602](INFO): SBD MO Status=0, MOMSN=29865, MT Status=0, MTMSN=0 2019-06-07T15:49:04.417Z,1559922544.417 [NAL9602](INFO): SBD MO Status=1, MOMSN=29866, MT Status=0, MTMSN=0 2019-06-07T15:49:04.465Z,1559922544.465 [NAL9602](INFO): Sent 25 bytes from file Logs/20190607T154710/Courier0000.lzma 2019-06-07T15:49:04.465Z,1559922544.465 [NAL9602](INFO): Packets left to send: 0 2019-06-07T15:49:25.606Z,1559922565.606 [NAL9602](INFO): SBD MO Status=1, MOMSN=29867, MT Status=0, MTMSN=0 2019-06-07T15:49:25.657Z,1559922565.657 [NAL9602](INFO): Sent 316 bytes from file Logs/20190607T154710/Express0001.lzma 2019-06-07T15:49:25.657Z,1559922565.657 [NAL9602](INFO): Packets left to send: 0 2019-06-07T15:49:36.029Z,1559922576.029 [NAL9602](INFO): SBD MO Status=0, MOMSN=29868, MT Status=0, MTMSN=0 2019-06-07T15:49:36.119Z,1559922576.119 [Default:CheckIn:Read_Iridium] Stopped 2019-06-07T15:49:36.120Z,1559922576.120 [Default:CheckIn:C.Wait] Running Loop=1 2019-06-07T15:49:36.120Z,1559922576.120 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2019-06-07T15:50:06.771Z,1559922606.771 [NAL9602](INFO): Not Powering down - fast GPS 2019-06-07T15:51:27.127Z,1559922687.127 [DVL_micro](FAULT): DVL failed to acquire valid data within timeout. 2019-06-07T15:51:27.127Z,1559922687.127 [DVL_micro] Data Fault, FailCount= 1 2019-06-07T15:51:27.128Z,1559922687.128 [DVL_micro](ERROR): Data Fault 2019-06-07T15:51:27.165Z,1559922687.165 [CBIT](ERROR): Data Fault in component: DVL_micro 2019-06-07T15:51:27.605Z,1559922687.605 [DVL_micro](INFO): uninitialize:Powering down 2019-06-07T15:51:28.378Z,1559922688.378 [CBIT](INFO): Clearing failed state for component DVL_micro 2019-06-07T15:51:28.379Z,1559922688.379 [DVL_micro] No Fault, FailCount= 1 2019-06-07T15:51:28.749Z,1559922688.749 [DVL_micro](INFO): Initializing 2019-06-07T15:54:32.974Z,1559922872.974 [DVL_micro](FAULT): DVL failed to acquire valid data within timeout. 2019-06-07T15:54:32.974Z,1559922872.974 [DVL_micro] Data Fault, FailCount= 1 2019-06-07T15:54:32.974Z,1559922872.974 [DVL_micro](ERROR): Data Fault 2019-06-07T15:54:33.006Z,1559922873.006 [CBIT](ERROR): Data Fault in component: DVL_micro 2019-06-07T15:54:33.441Z,1559922873.441 [DVL_micro](INFO): uninitialize:Powering down 2019-06-07T15:54:34.213Z,1559922874.213 [CBIT](INFO): Clearing failed state for component DVL_micro 2019-06-07T15:54:34.213Z,1559922874.213 [DVL_micro] No Fault, FailCount= 1 2019-06-07T15:54:34.598Z,1559922874.598 [DVL_micro](INFO): Initializing 2019-06-07T15:54:36.663Z,1559922876.663 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2019-06-07T15:54:36.664Z,1559922876.664 [Default:CheckIn:C.Wait] Stopped 2019-06-07T15:54:36.664Z,1559922876.664 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2019-06-07T15:54:36.664Z,1559922876.664 [Default:CheckIn:D] Running Loop=1 2019-06-07T15:54:37.038Z,1559922877.038 [Default:CheckIn:D] Stopped 2019-06-07T15:54:37.038Z,1559922877.038 [Default:CheckIn:E] Running Loop=1 2019-06-07T15:54:37.448Z,1559922877.448 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 36.412891 min 2019-06-07T15:54:37.448Z,1559922877.448 [Default:CheckIn:E] Stopped 2019-06-07T15:54:37.449Z,1559922877.449 [Default:CheckIn](INFO): Completed Default:CheckIn 2019-06-07T15:54:37.449Z,1559922877.449 [Default:CheckIn] Stopped 2019-06-07T15:54:37.449Z,1559922877.449 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2019-06-07T15:54:37.449Z,1559922877.449 [Default:CheckIn](INFO): Running loop #6 2019-06-07T15:54:37.449Z,1559922877.449 [Default:CheckIn] Running Loop=6 2019-06-07T15:54:37.449Z,1559922877.449 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2019-06-07T15:54:37.449Z,1559922877.449 [Default:CheckIn:Read_GPS] Running Loop=1 2019-06-07T15:54:39.045Z,1559922879.045 [NAL9602](DEBUG): Fix Requested 2019-06-07T15:54:39.434Z,1559922879.434 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,154955.00,A,3648.23570,N,12147.15233,W,5.054,200.26,070619,,,A*73 2019-06-07T15:54:39.436Z,1559922879.436 [NAL9602](INFO): GPS fix at 20190607T154955: (36.803928, -121.785872) 2019-06-07T15:54:39.459Z,1559922879.459 [Default:CheckIn:Read_GPS] Stopped 2019-06-07T15:54:39.459Z,1559922879.459 [Default:CheckIn:Read_Iridium] Running Loop=1 2019-06-07T15:54:41.110Z,1559922881.110 [NAL9602](ERROR): parseGSV uart error: serial buffer full 2019-06-07T15:55:03.829Z,1559922903.829 [NAL9602](INFO): SBD MO Status=1, MOMSN=29869, MT Status=0, MTMSN=0 2019-06-07T15:55:03.877Z,1559922903.877 [NAL9602](INFO): Sent 214 bytes from file Logs/20190607T154710/Courier0003.lzma 2019-06-07T15:55:03.877Z,1559922903.877 [NAL9602](INFO): Packets left to send: 0 2019-06-07T15:55:24.333Z,1559922924.333 [NAL9602](INFO): SBD MO Status=1, MOMSN=29870, MT Status=0, MTMSN=0 2019-06-07T15:55:24.381Z,1559922924.381 [NAL9602](INFO): Sent 218 bytes from file Logs/20190607T154710/Express0004.lzma 2019-06-07T15:55:24.381Z,1559922924.381 [NAL9602](INFO): Packets left to send: 0 2019-06-07T15:55:40.324Z,1559922940.324 [NAL9602](INFO): SBD MO Status=2, MOMSN=29871, MT Status=2, MTMSN=0 2019-06-07T15:55:40.324Z,1559922940.324 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-06-07T15:55:57.714Z,1559922957.714 [NAL9602](INFO): SBD MO Status=0, MOMSN=29871, MT Status=0, MTMSN=0 2019-06-07T15:55:57.804Z,1559922957.804 [Default:CheckIn:Read_Iridium] Stopped 2019-06-07T15:55:57.805Z,1559922957.805 [Default:CheckIn:C.Wait] Running Loop=1 2019-06-07T15:55:57.805Z,1559922957.805 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2019-06-07T15:56:28.416Z,1559922988.416 [NAL9602](INFO): Not Powering down - fast GPS 2019-06-07T15:57:39.115Z,1559923059.115 [DVL_micro](FAULT): DVL failed to acquire valid data within timeout. 2019-06-07T15:57:39.115Z,1559923059.115 [DVL_micro] Data Fault, FailCount= 1 2019-06-07T15:57:39.116Z,1559923059.115 [DVL_micro](ERROR): Data Fault 2019-06-07T15:57:39.151Z,1559923059.151 [CBIT](ERROR): Data Fault in component: DVL_micro 2019-06-07T15:57:39.589Z,1559923059.589 [DVL_micro](INFO): uninitialize:Powering down 2019-06-07T15:57:40.382Z,1559923060.382 [CBIT](INFO): Clearing failed state for component DVL_micro 2019-06-07T15:57:40.382Z,1559923060.382 [DVL_micro] No Fault, FailCount= 1 2019-06-07T15:57:40.744Z,1559923060.744 [DVL_micro](INFO): Initializing 2019-06-07T16:00:44.962Z,1559923244.962 [DVL_micro](FAULT): DVL failed to acquire valid data within timeout. 2019-06-07T16:00:44.962Z,1559923244.962 [DVL_micro] Data Fault, FailCount= 1 2019-06-07T16:00:44.962Z,1559923244.962 [DVL_micro](ERROR): Data Fault 2019-06-07T16:00:44.995Z,1559923244.995 [CBIT](ERROR): Data Fault in component: DVL_micro 2019-06-07T16:00:45.441Z,1559923245.441 [DVL_micro](INFO): uninitialize:Powering down 2019-06-07T16:00:46.225Z,1559923246.225 [CBIT](INFO): Clearing failed state for component DVL_micro 2019-06-07T16:00:46.226Z,1559923246.226 [DVL_micro] No Fault, FailCount= 1 2019-06-07T16:00:46.577Z,1559923246.577 [DVL_micro](INFO): Initializing 2019-06-07T16:00:58.320Z,1559923258.320 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2019-06-07T16:00:58.320Z,1559923258.320 [Default:CheckIn:C.Wait] Stopped 2019-06-07T16:00:58.320Z,1559923258.320 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2019-06-07T16:00:58.320Z,1559923258.320 [Default:CheckIn:D] Running Loop=1 2019-06-07T16:00:58.722Z,1559923258.722 [Default:CheckIn:D] Stopped 2019-06-07T16:00:58.723Z,1559923258.723 [Default:CheckIn:E] Running Loop=1 2019-06-07T16:00:59.136Z,1559923259.136 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 42.774300 min 2019-06-07T16:00:59.136Z,1559923259.136 [Default:CheckIn:E] Stopped 2019-06-07T16:00:59.136Z,1559923259.136 [Default:CheckIn](INFO): Completed Default:CheckIn 2019-06-07T16:00:59.136Z,1559923259.136 [Default:CheckIn] Stopped 2019-06-07T16:00:59.137Z,1559923259.137 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2019-06-07T16:00:59.137Z,1559923259.137 [Default:CheckIn](INFO): Running loop #7 2019-06-07T16:00:59.137Z,1559923259.137 [Default:CheckIn] Running Loop=7 2019-06-07T16:00:59.137Z,1559923259.137 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2019-06-07T16:00:59.137Z,1559923259.137 [Default:CheckIn:Read_GPS] Running Loop=1 2019-06-07T16:01:00.725Z,1559923260.725 [NAL9602](DEBUG): Fix Requested 2019-06-07T16:01:01.120Z,1559923261.120 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,155616.00,A,3648.16334,N,12147.21767,W,0.058,202.29,070619,,,D*78 2019-06-07T16:01:01.122Z,1559923261.122 [NAL9602](INFO): GPS fix at 20190607T155616: (36.802722, -121.786961) 2019-06-07T16:01:01.146Z,1559923261.146 [Default:CheckIn:Read_GPS] Stopped 2019-06-07T16:01:01.146Z,1559923261.146 [Default:CheckIn:Read_Iridium] Running Loop=1 2019-06-07T16:01:02.785Z,1559923262.785 [NAL9602](ERROR): parseGSV uart error: serial buffer full 2019-06-07T16:01:24.390Z,1559923284.390 [NAL9602](INFO): SBD MO Status=2, MOMSN=29872, MT Status=2, MTMSN=0 2019-06-07T16:01:24.390Z,1559923284.390 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-06-07T16:03:19.583Z,1559923399.583 [DVL_micro](ERROR): checksum mismatch: reported123 , calculated:3 2019-06-07T16:03:19.583Z,1559923399.583 [DVL_micro](ERROR): Failed to parse:$#NQ.RES 0 0 0 0 0 0 0 0 0 0 0 210 162 128 -57 4 3 2 3 109.4 292.3 119.4 2 -77.7 -302.3 119.4 2 109 292 119 2 -77 -302 119 2 1.99 -1.50 186.1 -3.0 14.0 0.005 35.0 1489 123 2019-06-07T16:03:21.126Z,1559923401.126 [NAL9602](INFO): SBD MO Status=1, MOMSN=29872, MT Status=0, MTMSN=0 2019-06-07T16:03:21.173Z,1559923401.173 [NAL9602](INFO): Sent 61 bytes from file Logs/20190607T154710/Courier0006.lzma 2019-06-07T16:03:21.173Z,1559923401.173 [NAL9602](INFO): Packets left to send: 0 2019-06-07T16:03:31.912Z,1559923411.912 [NAL9602](INFO): SBD MO Status=1, MOMSN=29873, MT Status=0, MTMSN=0 2019-06-07T16:03:31.961Z,1559923411.961 [NAL9602](INFO): Sent 173 bytes from file Logs/20190607T154710/Express0007.lzma 2019-06-07T16:03:31.961Z,1559923411.961 [NAL9602](INFO): Packets left to send: 0 2019-06-07T16:03:44.416Z,1559923424.416 [NAL9602](INFO): SBD MO Status=0, MOMSN=29874, MT Status=0, MTMSN=0 2019-06-07T16:03:44.520Z,1559923424.520 [Default:CheckIn:Read_Iridium] Stopped 2019-06-07T16:03:44.521Z,1559923424.521 [Default:CheckIn:C.Wait] Running Loop=1 2019-06-07T16:03:44.521Z,1559923424.521 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2019-06-07T16:03:50.882Z,1559923430.882 [DVL_micro](FAULT): DVL failed to acquire valid data within timeout. 2019-06-07T16:03:50.882Z,1559923430.882 [DVL_micro] Data Fault, FailCount= 1 2019-06-07T16:03:50.882Z,1559923430.882 [DVL_micro](ERROR): Data Fault 2019-06-07T16:03:50.920Z,1559923430.920 [CBIT](ERROR): Data Fault in component: DVL_micro 2019-06-07T16:03:51.361Z,1559923431.361 [DVL_micro](INFO): uninitialize:Powering down 2019-06-07T16:03:52.133Z,1559923432.133 [CBIT](INFO): Clearing failed state for component DVL_micro 2019-06-07T16:03:52.133Z,1559923432.133 [DVL_micro] No Fault, FailCount= 1 2019-06-07T16:03:52.504Z,1559923432.504 [DVL_micro](INFO): Initializing 2019-06-07T16:04:15.140Z,1559923455.140 [NAL9602](INFO): Not Powering down - fast GPS 2019-06-07T16:06:56.726Z,1559923616.726 [DVL_micro](FAULT): DVL failed to acquire valid data within timeout. 2019-06-07T16:06:56.726Z,1559923616.726 [DVL_micro] Data Fault, FailCount= 1 2019-06-07T16:06:56.726Z,1559923616.726 [DVL_micro](ERROR): Data Fault 2019-06-07T16:06:56.759Z,1559923616.759 [CBIT](ERROR): Data Fault in component: DVL_micro 2019-06-07T16:06:57.185Z,1559923617.185 [DVL_micro](INFO): uninitialize:Powering down 2019-06-07T16:06:57.991Z,1559923617.991 [CBIT](INFO): Clearing failed state for component DVL_micro 2019-06-07T16:06:57.991Z,1559923617.991 [DVL_micro] No Fault, FailCount= 1 2019-06-07T16:06:58.334Z,1559923618.334 [DVL_micro](INFO): Initializing 2019-06-07T16:08:45.036Z,1559923725.036 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2019-06-07T16:08:45.036Z,1559923725.036 [Default:CheckIn:C.Wait] Stopped 2019-06-07T16:08:45.036Z,1559923725.036 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2019-06-07T16:08:45.037Z,1559923725.037 [Default:CheckIn:D] Running Loop=1 2019-06-07T16:08:45.430Z,1559923725.430 [Default:CheckIn:D] Stopped 2019-06-07T16:08:45.430Z,1559923725.430 [Default:CheckIn:E] Running Loop=1 2019-06-07T16:08:45.824Z,1559923725.824 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 50.552755 min 2019-06-07T16:08:45.824Z,1559923725.824 [Default:CheckIn:E] Stopped 2019-06-07T16:08:45.824Z,1559923725.824 [Default:CheckIn](INFO): Completed Default:CheckIn 2019-06-07T16:08:45.824Z,1559923725.824 [Default:CheckIn] Stopped 2019-06-07T16:08:45.824Z,1559923725.824 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2019-06-07T16:08:45.824Z,1559923725.824 [Default:CheckIn](INFO): Running loop #8 2019-06-07T16:08:45.824Z,1559923725.824 [Default:CheckIn] Running Loop=8 2019-06-07T16:08:45.825Z,1559923725.825 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2019-06-07T16:08:45.825Z,1559923725.825 [Default:CheckIn:Read_GPS] Running Loop=1 2019-06-07T16:08:47.429Z,1559923727.429 [NAL9602](DEBUG): Fix Requested 2019-06-07T16:08:47.822Z,1559923727.822 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,160402.00,A,3648.17503,N,12147.27809,W,0.253,328.64,070619,,,D*72 2019-06-07T16:08:47.824Z,1559923727.824 [NAL9602](INFO): GPS fix at 20190607T160402: (36.802917, -121.787968) 2019-06-07T16:08:47.848Z,1559923727.848 [Default:CheckIn:Read_GPS] Stopped 2019-06-07T16:08:47.848Z,1559923727.848 [Default:CheckIn:Read_Iridium] Running Loop=1 2019-06-07T16:08:49.446Z,1559923729.446 [NAL9602](ERROR): parseGSV uart error: serial buffer full 2019-06-07T16:09:12.358Z,1559923752.358 [NAL9602](INFO): SBD MO Status=1, MOMSN=29875, MT Status=0, MTMSN=0 2019-06-07T16:09:12.405Z,1559923752.405 [NAL9602](INFO): Sent 61 bytes from file Logs/20190607T154710/Courier0009.lzma 2019-06-07T16:09:12.405Z,1559923752.405 [NAL9602](INFO): Packets left to send: 0 2019-06-07T16:09:25.710Z,1559923765.710 [NAL9602](INFO): SBD MO Status=2, MOMSN=29876, MT Status=2, MTMSN=0 2019-06-07T16:09:25.710Z,1559923765.710 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-06-07T16:09:52.898Z,1559923792.898 [NAL9602](INFO): SBD MO Status=1, MOMSN=29876, MT Status=0, MTMSN=0 2019-06-07T16:09:52.945Z,1559923792.945 [NAL9602](INFO): Sent 173 bytes from file Logs/20190607T154710/Express0010.lzma 2019-06-07T16:09:52.945Z,1559923792.945 [NAL9602](INFO): Packets left to send: 0 2019-06-07T16:09:59.646Z,1559923799.646 [DVL_micro](ERROR): only read 44 of 46 data items 2019-06-07T16:09:59.646Z,1559923799.646 [DVL_micro](ERROR): Failed to parse:$#NQ.RES 0X0000 0 0 0 0 0 0 0 0 0 0 0 0 267 294 -15 285 4 3 3 3 376.4 12.0 224.0 2 -130.5 -353.3 224.0 2 376 12 224 2 -130 -353 224 2 0.47 -0.44 247.9 -3.0 14.2 0.01489 113 2019-06-07T16:10:02.450Z,1559923802.450 [DVL_micro](FAULT): DVL failed to acquire valid data within timeout. 2019-06-07T16:10:02.450Z,1559923802.450 [DVL_micro] Data Fault, FailCount= 1 2019-06-07T16:10:02.450Z,1559923802.450 [DVL_micro](ERROR): Data Fault 2019-06-07T16:10:02.483Z,1559923802.483 [CBIT](ERROR): Data Fault in component: DVL_micro 2019-06-07T16:10:02.925Z,1559923802.925 [DVL_micro](INFO): uninitialize:Powering down 2019-06-07T16:10:03.697Z,1559923803.697 [CBIT](INFO): Clearing failed state for component DVL_micro 2019-06-07T16:10:03.697Z,1559923803.697 [DVL_micro] No Fault, FailCount= 1 2019-06-07T16:10:04.075Z,1559923804.075 [DVL_micro](INFO): Initializing 2019-06-07T16:10:10.555Z,1559923810.555 [NAL9602](INFO): SBD MO Status=2, MOMSN=29877, MT Status=2, MTMSN=0 2019-06-07T16:10:10.555Z,1559923810.555 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-06-07T16:10:18.517Z,1559923818.517 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-06-07T16:10:28.168Z,1559923828.168 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-06-07T16:10:37.346Z,1559923837.346 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-06-07T16:10:47.474Z,1559923847.474 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-06-07T16:10:47.621Z,1559923847.621 [PAR_Licor](INFO): A/D timeout, 7 tries over 130 ms 2019-06-07T16:10:47.621Z,1559923847.621 [PAR_Licor] Data Fault, FailCount= 1 2019-06-07T16:10:47.621Z,1559923847.621 [PAR_Licor](ERROR): Data Fault 2019-06-07T16:10:47.717Z,1559923847.717 [CBIT](ERROR): Data Fault in component: PAR_Licor 2019-06-07T16:10:47.718Z,1559923847.718 [CBIT](INFO): Clearing failed state for component PAR_Licor 2019-06-07T16:10:47.718Z,1559923847.718 [PAR_Licor] No Fault, FailCount= 1 2019-06-07T16:11:00.594Z,1559923860.594 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-06-07T16:11:15.142Z,1559923875.142 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-06-07T16:11:22.127Z,1559923882.127 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-06-07T16:11:35.129Z,1559923895.129 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-06-07T16:11:43.737Z,1559923903.737 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-06-07T16:11:48.891Z,1559923908.891 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-06-07T16:11:55.067Z,1559923915.067 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-06-07T16:12:00.051Z,1559923920.051 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-06-07T16:12:05.230Z,1559923925.230 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-06-07T16:12:10.416Z,1559923930.416 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-06-07T16:12:15.383Z,1559923935.383 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-06-07T16:12:23.145Z,1559923943.145 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-06-07T16:12:28.147Z,1559923948.147 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-06-07T16:12:36.169Z,1559923956.169 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-06-07T16:12:52.435Z,1559923972.435 [NAL9602](INFO): SBD MO Status=0, MOMSN=29877, MT Status=0, MTMSN=0 2019-06-07T16:12:52.528Z,1559923972.528 [Default:CheckIn:Read_Iridium] Stopped 2019-06-07T16:12:52.528Z,1559923972.528 [Default:CheckIn:C.Wait] Running Loop=1 2019-06-07T16:12:52.528Z,1559923972.528 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2019-06-07T16:13:08.190Z,1559923988.190 [DVL_micro](FAULT): DVL failed to acquire valid data within timeout. 2019-06-07T16:13:08.190Z,1559923988.190 [DVL_micro] Data Fault, FailCount= 1 2019-06-07T16:13:08.190Z,1559923988.190 [DVL_micro](ERROR): Data Fault 2019-06-07T16:13:08.250Z,1559923988.250 [CBIT](ERROR): Data Fault in component: DVL_micro 2019-06-07T16:13:08.665Z,1559923988.665 [DVL_micro](INFO): uninitialize:Powering down 2019-06-07T16:13:09.433Z,1559923989.433 [CBIT](INFO): Clearing failed state for component DVL_micro 2019-06-07T16:13:09.433Z,1559923989.433 [DVL_micro] No Fault, FailCount= 1 2019-06-07T16:13:09.802Z,1559923989.802 [DVL_micro](INFO): Initializing 2019-06-07T16:13:23.137Z,1559924003.137 [NAL9602](INFO): Not Powering down - fast GPS 2019-06-07T16:16:14.027Z,1559924174.027 [DVL_micro](FAULT): DVL failed to acquire valid data within timeout. 2019-06-07T16:16:14.027Z,1559924174.027 [DVL_micro] Data Fault, FailCount= 1 2019-06-07T16:16:14.027Z,1559924174.027 [DVL_micro](ERROR): Data Fault 2019-06-07T16:16:14.085Z,1559924174.085 [CBIT](ERROR): Data Fault in component: DVL_micro 2019-06-07T16:16:14.497Z,1559924174.497 [DVL_micro](INFO): uninitialize:Powering down 2019-06-07T16:16:15.276Z,1559924175.276 [CBIT](INFO): Clearing failed state for component DVL_micro 2019-06-07T16:16:15.276Z,1559924175.276 [DVL_micro] No Fault, FailCount= 1 2019-06-07T16:16:15.646Z,1559924175.646 [DVL_micro](INFO): Initializing 2019-06-07T16:16:54.434Z,1559924214.434 [DVL_micro](ERROR): only read 44 of 46 data items 2019-06-07T16:16:54.434Z,1559924214.434 [DVL_micro](ERROR): Failed to parse:$#NQ.RES 0X0000 0 0 0 0 0 0 0 0 0 0 0 0 536 351 -183 287 3 3 3 3 959.6 85.4 267.2 2 -14.9 963.2 267.2 2 959 85 267 2 -14 963 267 2 2.53 -3.88 85.8 -3.0 14.6 0.005 35.0 2019-06-07T16:17:53.048Z,1559924273.048 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2019-06-07T16:17:53.048Z,1559924273.048 [Default:CheckIn:C.Wait] Stopped 2019-06-07T16:17:53.048Z,1559924273.048 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2019-06-07T16:17:53.048Z,1559924273.048 [Default:CheckIn:D] Running Loop=1 2019-06-07T16:17:53.445Z,1559924273.445 [Default:CheckIn:D] Stopped 2019-06-07T16:17:53.445Z,1559924273.445 [Default:CheckIn:E] Running Loop=1 2019-06-07T16:17:53.851Z,1559924273.851 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 59.686336 min 2019-06-07T16:17:53.851Z,1559924273.851 [Default:CheckIn:E] Stopped 2019-06-07T16:17:53.852Z,1559924273.852 [Default:CheckIn](INFO): Completed Default:CheckIn 2019-06-07T16:17:53.852Z,1559924273.852 [Default:CheckIn] Stopped 2019-06-07T16:17:53.852Z,1559924273.852 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2019-06-07T16:17:53.852Z,1559924273.852 [Default:CheckIn](INFO): Running loop #9 2019-06-07T16:17:53.852Z,1559924273.852 [Default:CheckIn] Running Loop=9 2019-06-07T16:17:53.852Z,1559924273.852 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2019-06-07T16:17:53.852Z,1559924273.852 [Default:CheckIn:Read_GPS] Running Loop=1 2019-06-07T16:17:55.457Z,1559924275.457 [NAL9602](DEBUG): Fix Requested 2019-06-07T16:17:55.870Z,1559924275.870 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,161309.00,A,3648.16541,N,12147.28011,W,0.194,229.34,070619,,,A*7E 2019-06-07T16:17:55.872Z,1559924275.872 [NAL9602](INFO): GPS fix at 20190607T161309: (36.802757, -121.788002) 2019-06-07T16:17:55.895Z,1559924275.895 [Default:CheckIn:Read_GPS] Stopped 2019-06-07T16:17:55.895Z,1559924275.895 [Default:CheckIn:Read_Iridium] Running Loop=1 2019-06-07T16:17:57.113Z,1559924277.113 [NAL9602](ERROR): parseGSV uart error: serial buffer full 2019-06-07T16:19:20.965Z,1559924360.965 [DVL_micro](FAULT): DVL failed to acquire valid data within timeout. 2019-06-07T16:19:20.965Z,1559924360.965 [DVL_micro] Data Fault, FailCount= 1 2019-06-07T16:19:20.965Z,1559924360.965 [DVL_micro](ERROR): Data Fault 2019-06-07T16:19:21.031Z,1559924361.031 [CBIT](ERROR): Data Fault in component: DVL_micro 2019-06-07T16:19:21.389Z,1559924361.389 [DVL_micro](INFO): uninitialize:Powering down 2019-06-07T16:19:22.188Z,1559924362.188 [CBIT](INFO): Clearing failed state for component DVL_micro 2019-06-07T16:19:22.188Z,1559924362.188 [DVL_micro] No Fault, FailCount= 1 2019-06-07T16:19:22.534Z,1559924362.534 [DVL_micro](INFO): Initializing 2019-06-07T16:19:37.828Z,1559924377.828 [DVL_micro](ERROR): only read 40 of 46 data items 2019-06-07T16:19:37.829Z,1559924377.829 [DVL_micro](ERROR): Failed to parse:$#NQ.RES 0X0000 0 0 0 0 0 0 0 0 0 0 0 0 314 424 399 344 3 3 2 3 -113.499.3 2 -130.2 -85.5 399.3 2 -113 106 399 2 -130 -85 399 2 0.47 -1.36 76.6 - 0.005 35.0 1489 81 2019-06-07T16:22:12.542Z,1559924532.542 [DVL_micro](ERROR): only read 41 of 46 data items 2019-06-07T16:22:12.543Z,1559924532.543 [DVL_micro](ERROR): Failed to parse:$#NQ.RES 0X0000 0 0 0 0 0 0 0 0 500 409 484 356 3 3 2 3 21.4 70.7 471.5 2 -63.7 37.4 471.5 2 21 70 471 2471 2 0.49 -1.41 76.4 -3.0 14.9 0.005 35.0 1489 83 2019-06-07T16:22:30.650Z,1559924550.650 [DVL_micro](FAULT): DVL failed to acquire valid data within timeout. 2019-06-07T16:22:30.650Z,1559924550.650 [DVL_micro] Data Fault, FailCount= 1 2019-06-07T16:22:30.650Z,1559924550.650 [DVL_micro](ERROR): Data Fault 2019-06-07T16:22:32.432Z,1559924552.432 [CBIT](ERROR): Data Fault in component: DVL_micro 2019-06-07T16:22:32.605Z,1559924552.605 [DVL_micro](INFO): uninitialize:Powering down 2019-06-07T16:22:33.321Z,1559924553.321 [CBIT](INFO): Clearing failed state for component DVL_micro 2019-06-07T16:22:33.321Z,1559924553.321 [DVL_micro] No Fault, FailCount= 1 2019-06-07T16:22:33.670Z,1559924553.670 [DVL_micro](INFO): Initializing 2019-06-07T16:23:23.356Z,1559924603.356 [DVL_micro](ERROR): only read 45 of 46 data items 2019-06-07T16:23:23.357Z,1559924603.357 [DVL_micro](ERROR): Failed to parse:$#NQ.RES 0X0000 0 0 0 0 0 0 0 0 0 0 379 556 259 3 3 2 3 -216.2 160.2 428.2 2 -206.8 -172.1 428.2 2 -216 160 428 2 -206 -172 428 2 0.50 -1.67 76.3 -3.0 14.9 0.005 35.0 1489 90 2019-06-07T16:25:39.004Z,1559924739.004 [DVL_micro](FAULT): DVL failed to acquire valid data within timeout. 2019-06-07T16:25:39.005Z,1559924739.005 [DVL_micro] Data Fault, FailCount= 1 2019-06-07T16:25:39.005Z,1559924739.005 [DVL_micro](ERROR): Data Fault 2019-06-07T16:25:39.038Z,1559924739.038 [CBIT](ERROR): Data Fault in component: DVL_micro 2019-06-07T16:25:39.417Z,1559924739.417 [DVL_micro](INFO): uninitialize:Powering down 2019-06-07T16:25:40.201Z,1559924740.201 [CBIT](INFO): Clearing failed state for component DVL_micro 2019-06-07T16:25:40.201Z,1559924740.201 [DVL_micro] No Fault, FailCount= 1 2019-06-07T16:25:40.563Z,1559924740.563 [DVL_micro](INFO): Initializing 2019-06-07T16:28:47.449Z,1559924927.449 [DVL_micro](FAULT): DVL failed to acquire valid data within timeout. 2019-06-07T16:28:47.450Z,1559924927.450 [DVL_micro] Data Fault, FailCount= 1 2019-06-07T16:28:47.450Z,1559924927.450 [DVL_micro](ERROR): Data Fault 2019-06-07T16:28:47.533Z,1559924927.533 [CBIT](ERROR): Data Fault in component: DVL_micro 2019-06-07T16:28:47.917Z,1559924927.917 [DVL_micro](INFO): uninitialize:Powering down 2019-06-07T16:28:49.992Z,1559924929.992 [CBIT](INFO): Clearing failed state for component DVL_micro 2019-06-07T16:28:49.993Z,1559924929.993 [DVL_micro] No Fault, FailCount= 1 2019-06-07T16:28:50.357Z,1559924930.357 [DVL_micro](INFO): Initializing 2019-06-07T16:30:16.436Z,1559925016.436 [DVL_micro](ERROR): only read 43 of 46 data items 2019-06-07T16:30:16.437Z,1559925016.437 [DVL_micro](ERROR): Failed to parse:$#NQ.RES 0X0000 0 0 0 0 0 0 0 0 486 548 113 0 3 3 2 3 497.8 731.4 309.2 2 -598.3 651.7 309.2 2 497 731 309 2 -598 651 309 2 0.40 -1.65 76.8 -3.0 15.3 0.005 35.0 1489 83 2019-06-07T16:31:54.989Z,1559925114.989 [DVL_micro](FAULT): DVL failed to acquire valid data within timeout. 2019-06-07T16:31:54.989Z,1559925114.989 [DVL_micro] Data Fault, FailCount= 1 2019-06-07T16:31:54.989Z,1559925114.989 [DVL_micro](ERROR): Data Fault 2019-06-07T16:31:55.023Z,1559925115.023 [CBIT](ERROR): Data Fault in component: DVL_micro 2019-06-07T16:31:55.413Z,1559925115.413 [DVL_micro](INFO): uninitialize:Powering down 2019-06-07T16:31:56.178Z,1559925116.178 [CBIT](INFO): Clearing failed state for component DVL_micro 2019-06-07T16:31:56.178Z,1559925116.178 [DVL_micro] No Fault, FailCount= 1 2019-06-07T16:31:56.568Z,1559925116.568 [DVL_micro](INFO): Initializing 2019-06-07T16:32:11.647Z,1559925131.647 [DVL_micro](ERROR): No DVL communication! Re-initializing 2019-06-07T16:32:11.647Z,1559925131.647 [DVL_micro] Communications Fault, FailCount= 2 2019-06-07T16:32:11.647Z,1559925131.647 [DVL_micro](ERROR): Communications Fault 2019-06-07T16:32:11.680Z,1559925131.680 [CBIT](ERROR): Communications Fault in component: DVL_micro 2019-06-07T16:32:12.061Z,1559925132.061 [DVL_micro](INFO): uninitialize:Powering down 2019-06-07T16:32:12.828Z,1559925132.828 [CBIT](INFO): Clearing failed state for component DVL_micro 2019-06-07T16:32:12.829Z,1559925132.829 [DVL_micro] No Fault, FailCount= 2 2019-06-07T16:32:13.216Z,1559925133.216 [DVL_micro](INFO): Initializing 2019-06-07T16:32:47.558Z,1559925167.558 [DVL_micro](ERROR): only read 44 of 46 data items 2019-06-07T16:32:47.559Z,1559925167.559 [DVL_micro](ERROR): Failed to parse:$#NQ.RES 00 0 0 0 0 0 0 0 0 0 0 520 535 212 421 3 3 2 3 411.1 152.1 455.1 2 -53.4 435 2 411 152 455 2 -53 435 455 2 0.44 -1.59 76.7 -3.0 15.5 0.005 35.0 1489 95 2019-06-07T16:33:11.189Z,1559925191.189 [CommandLine](IMPORTANT): got command quit 2019-06-07T16:33:12.197Z,1559925192.197 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2019-06-07T16:33:12.197Z,1559925192.197 [CommandLine ThreadHandler](INFO): Thread cancelled. 2019-06-07T16:33:12.301Z,1559925192.301 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2019-06-07T16:33:12.301Z,1559925192.301 [CommandLine ThreadHandler](INFO): Thread cancelled. 2019-06-07T16:33:12.302Z,1559925192.302 [CommandLine](INFO): Join timeout helper Thread ID is 5625 2019-06-07T16:33:12.302Z,1559925192.302 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2019-06-07T16:33:12.302Z,1559925192.302 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2019-06-07T16:33:12.303Z,1559925192.303 [NavChartDb](INFO): Join timeout helper Thread ID is 5626 2019-06-07T16:33:12.325Z,1559925192.325 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2019-06-07T16:33:12.325Z,1559925192.325 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2019-06-07T16:33:12.341Z,1559925192.341 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2019-06-07T16:33:12.341Z,1559925192.341 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2019-06-07T16:33:12.341Z,1559925192.341 [DataOverHttps](INFO): Join timeout helper Thread ID is 5627 2019-06-07T16:33:12.621Z,1559925192.621 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2019-06-07T16:33:12.621Z,1559925192.621 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2019-06-07T16:33:12.641Z,1559925192.641 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2019-06-07T16:33:12.641Z,1559925192.641 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2019-06-07T16:33:12.641Z,1559925192.641 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 5628 2019-06-07T16:33:13.009Z,1559925193.009 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2019-06-07T16:33:13.009Z,1559925193.009 [WetLabsBB2FL](INFO): Powering down 2019-06-07T16:33:13.010Z,1559925193.010 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2019-06-07T16:33:13.021Z,1559925193.021 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2019-06-07T16:33:13.021Z,1559925193.021 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2019-06-07T16:33:13.021Z,1559925193.021 [CTD_Seabird](INFO): Join timeout helper Thread ID is 5629 2019-06-07T16:33:13.933Z,1559925193.933 [CTD_Seabird](INFO): Powering down 2019-06-07T16:33:13.945Z,1559925193.945 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2019-06-07T16:33:13.945Z,1559925193.945 [CTD_Seabird](INFO): Powering down 2019-06-07T16:33:13.961Z,1559925193.961 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2019-06-07T16:33:13.967Z,1559925193.967 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2019-06-07T16:33:13.967Z,1559925193.967 [logger ThreadHandler](INFO): Thread cancelled. 2019-06-07T16:33:13.967Z,1559925193.967 [logger](INFO): Join timeout helper Thread ID is 5630 2019-06-07T16:33:13.979Z,1559925193.979 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2019-06-07T16:33:13.979Z,1559925193.979 [logger ThreadHandler](INFO): Thread cancelled. 2019-06-07T16:33:13.985Z,1559925193.985 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2019-06-07T16:33:13.986Z,1559925193.986 [CommandLine ThreadHandler](INFO): Thread cancelled. 2019-06-07T16:33:13.986Z,1559925193.986 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2019-06-07T16:33:13.986Z,1559925193.986 [controlThread ThreadHandler](INFO): Thread cancelled. 2019-06-07T16:33:13.986Z,1559925193.986 [controlThread](INFO): Join timeout helper Thread ID is 5631 2019-06-07T16:33:14.093Z,1559925194.093 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2019-06-07T16:33:14.093Z,1559925194.093 [controlThread](DEBUG): Uninitializing ControlThread 2019-06-07T16:33:14.094Z,1559925194.094 [Aanderaa_O2](INFO): Powering down 2019-06-07T16:33:14.118Z,1559925194.118 [AHRS_M2](INFO): Powering down 2019-06-07T16:33:14.261Z,1559925194.261 [DVL_micro](INFO): uninitialize:Powering down 2019-06-07T16:33:14.262Z,1559925194.262 [NAL9602](INFO): Powering down 2019-06-07T16:33:14.263Z,1559925194.263 [DAT](INFO): Powering down 2019-06-07T16:33:14.382Z,1559925194.382 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2019-06-07T16:33:14.382Z,1559925194.382 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2019-06-07T16:33:14.383Z,1559925194.383 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2019-06-07T16:33:14.383Z,1559925194.383 [MissionManager](INFO): Uninitializing Mission Default 2019-06-07T16:33:14.384Z,1559925194.384 [Default] Stopped 2019-06-07T16:33:14.384Z,1559925194.384 [Default](DEBUG): Aggregate::uninitialize Default 2019-06-07T16:33:14.384Z,1559925194.384 [Default:B.GoToSurface] Stopped 2019-06-07T16:33:14.384Z,1559925194.384 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2019-06-07T16:33:14.384Z,1559925194.384 [Default:CheckIn] Stopped 2019-06-07T16:33:14.384Z,1559925194.384 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2019-06-07T16:33:14.384Z,1559925194.384 [Default:CheckIn:Read_Iridium] Stopped 2019-06-07T16:33:14.386Z,1559925194.386 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2019-06-07T16:33:14.387Z,1559925194.387 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2019-06-07T16:33:14.387Z,1559925194.387 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2019-06-07T16:33:14.387Z,1559925194.387 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2019-06-07T16:33:14.388Z,1559925194.388 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2019-06-07T16:33:14.388Z,1559925194.388 [BuoyancyServo](INFO): Powering down 2019-06-07T16:33:14.401Z,1559925194.401 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2019-06-07T16:33:14.401Z,1559925194.401 [ElevatorServo](INFO): Powering down 2019-06-07T16:33:14.402Z,1559925194.402 [MassServo](DEBUG): Uninitialize Mass Servo. 2019-06-07T16:33:14.402Z,1559925194.402 [MassServo](INFO): Powering down 2019-06-07T16:33:14.403Z,1559925194.403 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2019-06-07T16:33:14.403Z,1559925194.403 [RudderServo](INFO): Powering down 2019-06-07T16:33:14.403Z,1559925194.403 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2019-06-07T16:33:14.404Z,1559925194.404 [ThrusterServo](INFO): Powering down 2019-06-07T16:33:14.404Z,1559925194.404 [SBIT](DEBUG): Uninitialize SBIT Component. 2019-06-07T16:33:14.405Z,1559925194.405 [IBIT](DEBUG): Uninitialize IBIT Component. 2019-06-07T16:33:14.405Z,1559925194.405 [CBIT](DEBUG): Uninitialize CBIT Component. 2019-06-07T16:33:14.405Z,1559925194.405 [CBIT](DEBUG): Powering off loads. 2019-06-07T16:33:14.417Z,1559925194.417 [CBIT](DEBUG): Disabling WDT. 2019-06-07T16:33:14.429Z,1559925194.429 [CBIT](DEBUG): Opening all GF detection circuits. 2019-06-07T16:33:14.430Z,1559925194.430 [controlThread ThreadHandler](INFO): Thread cancelled. 2019-06-07T16:33:14.478Z,1559925194.478 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2019-06-07T16:33:14.483Z,1559925194.483 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2019-06-07T16:33:14.558Z,1559925194.558 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2019-06-07T16:33:14.607Z,1559925194.607 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2019-06-07T16:33:14.705Z,1559925194.705 [logger ThreadHandler](INFO): Thread cancelled.