2021-06-29T18:45:52.069Z,1624992352.069 [CommandLine](IMPORTANT): got command restart logs 2021-06-29T18:46:12.549Z,1624992372.549 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2021-06-29T18:46:12.549Z,1624992372.549 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2021-06-29T18:46:12.560Z,1624992372.560 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2021-06-29T18:46:12.965Z,1624992372.965 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2021-06-29T18:46:12.965Z,1624992372.965 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2021-06-29T18:46:21.829Z,1624992381.829 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2021-06-29T18:46:46.926Z,1624992406.926 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-06-29T18:46:46.926Z,1624992406.926 [Default:CheckIn:C.Wait] Stopped 2021-06-29T18:46:46.927Z,1624992406.927 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-06-29T18:46:46.927Z,1624992406.927 [Default:CheckIn:D] Running Loop=1 2021-06-29T18:46:47.394Z,1624992407.394 [Default:CheckIn:D] Stopped 2021-06-29T18:46:47.394Z,1624992407.394 [Default:CheckIn:E] Running Loop=1 2021-06-29T18:46:47.781Z,1624992407.781 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 15.063003 min 2021-06-29T18:46:47.781Z,1624992407.781 [Default:CheckIn:E] Stopped 2021-06-29T18:46:47.782Z,1624992407.782 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-06-29T18:46:47.782Z,1624992407.782 [Default:CheckIn] Stopped 2021-06-29T18:46:47.782Z,1624992407.782 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-06-29T18:46:47.782Z,1624992407.782 [Default:CheckIn](INFO): Running loop #3 2021-06-29T18:46:47.782Z,1624992407.782 [Default:CheckIn] Running Loop=3 2021-06-29T18:46:47.782Z,1624992407.782 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-06-29T18:46:47.782Z,1624992407.782 [Default:CheckIn:Read_GPS] Running Loop=1 2021-06-29T18:46:49.726Z,1624992409.726 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,184648.00,A,3648.16705,N,12147.28431,W,0.991,9.64,290621,,,A*7E 2021-06-29T18:46:49.728Z,1624992409.728 [NAL9602](INFO): GPS fix at 20210629T184648: (36.802784, -121.788072) 2021-06-29T18:46:49.746Z,1624992409.746 [Default:CheckIn:Read_GPS] Stopped 2021-06-29T18:46:49.746Z,1624992409.746 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-06-29T18:47:00.051Z,1624992420.051 [DataOverHttps](INFO): Sending 51 bytes from file Logs/20210629T180041/Courier0016.lzma 2021-06-29T18:47:01.054Z,1624992421.054 [DataOverHttps](INFO): Moved sent file to Logs/20210629T180041/Courier0016.lzma.bak 2021-06-29T18:47:01.054Z,1624992421.054 [DataOverHttps](INFO): SBD MOMSN=15737044 2021-06-29T18:47:16.523Z,1624992436.523 [DataOverHttps](INFO): Sending 152 bytes from file Logs/20210629T184541/Courier0000.lzma 2021-06-29T18:47:17.526Z,1624992437.526 [DataOverHttps](INFO): Moved sent file to Logs/20210629T184541/Courier0000.lzma.bak 2021-06-29T18:47:17.526Z,1624992437.526 [DataOverHttps](INFO): SBD MOMSN=15737046 2021-06-29T18:47:21.773Z,1624992441.773 [NAL9602](INFO): Not Powering down - fast GPS 2021-06-29T18:47:33.840Z,1624992453.840 [DataOverHttps](INFO): Sending 267 bytes from file Logs/20210629T184552/Courier0000.lzma 2021-06-29T18:47:34.842Z,1624992454.842 [DataOverHttps](INFO): Moved sent file to Logs/20210629T184552/Courier0000.lzma.bak 2021-06-29T18:47:34.842Z,1624992454.842 [DataOverHttps](INFO): SBD MOMSN=15737051 2021-06-29T18:47:50.459Z,1624992470.459 [DataOverHttps](INFO): Sending 93 bytes from file Logs/20210629T180041/Express0017.lzma 2021-06-29T18:47:51.462Z,1624992471.462 [DataOverHttps](INFO): Moved sent file to Logs/20210629T180041/Express0017.lzma.bak 2021-06-29T18:47:51.462Z,1624992471.462 [DataOverHttps](INFO): SBD MOMSN=15737055 2021-06-29T18:48:07.100Z,1624992487.100 [DataOverHttps](INFO): Sending 283 bytes from file Logs/20210629T184541/Express0001.lzma 2021-06-29T18:48:08.101Z,1624992488.101 [DataOverHttps](INFO): Moved sent file to Logs/20210629T184541/Express0001.lzma.bak 2021-06-29T18:48:08.102Z,1624992488.102 [DataOverHttps](INFO): SBD MOMSN=15737058 2021-06-29T18:48:23.689Z,1624992503.689 [DataOverHttps](INFO): Sending 512 bytes from file Logs/20210629T184552/Express0001.lzma 2021-06-29T18:48:24.690Z,1624992504.690 [DataOverHttps](INFO): Moved sent file to Logs/20210629T184552/Express0001.lzma.bak 2021-06-29T18:48:24.690Z,1624992504.690 [DataOverHttps](INFO): SBD MOMSN=15737062 2021-06-29T18:48:26.849Z,1624992506.849 [Default:CheckIn:Read_Iridium] Stopped 2021-06-29T18:48:26.849Z,1624992506.849 [Default:CheckIn:C.Wait] Running Loop=1 2021-06-29T18:48:26.850Z,1624992506.850 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-06-29T18:49:13.429Z,1624992553.429 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2021-06-29T18:49:13.429Z,1624992553.429 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2021-06-29T18:49:13.452Z,1624992553.452 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2021-06-29T18:49:13.901Z,1624992553.901 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2021-06-29T18:49:13.901Z,1624992553.901 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2021-06-29T18:52:14.436Z,1624992734.436 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2021-06-29T18:52:14.436Z,1624992734.436 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2021-06-29T18:52:14.446Z,1624992734.446 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2021-06-29T18:52:14.856Z,1624992734.856 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2021-06-29T18:52:14.856Z,1624992734.856 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2021-06-29T18:53:27.568Z,1624992807.568 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-06-29T18:53:27.568Z,1624992807.568 [Default:CheckIn:C.Wait] Stopped 2021-06-29T18:53:27.568Z,1624992807.568 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-06-29T18:53:27.568Z,1624992807.568 [Default:CheckIn:D] Running Loop=1 2021-06-29T18:53:27.973Z,1624992807.973 [Default:CheckIn:D] Stopped 2021-06-29T18:53:27.974Z,1624992807.974 [Default:CheckIn:E] Running Loop=1 2021-06-29T18:53:28.380Z,1624992808.380 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 21.739333 min 2021-06-29T18:53:28.380Z,1624992808.380 [Default:CheckIn:E] Stopped 2021-06-29T18:53:28.380Z,1624992808.380 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-06-29T18:53:28.380Z,1624992808.380 [Default:CheckIn] Stopped 2021-06-29T18:53:28.380Z,1624992808.380 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-06-29T18:53:28.380Z,1624992808.380 [Default:CheckIn](INFO): Running loop #4 2021-06-29T18:53:28.380Z,1624992808.380 [Default:CheckIn] Running Loop=4 2021-06-29T18:53:28.380Z,1624992808.380 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-06-29T18:53:28.381Z,1624992808.381 [Default:CheckIn:Read_GPS] Running Loop=1 2021-06-29T18:53:30.398Z,1624992810.398 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,185329.00,A,3648.16588,N,12147.28146,W,0.117,9.64,290621,,,A*79 2021-06-29T18:53:30.408Z,1624992810.408 [NAL9602](INFO): GPS fix at 20210629T185329: (36.802765, -121.788024) 2021-06-29T18:53:30.433Z,1624992810.433 [Default:CheckIn:Read_GPS] Stopped 2021-06-29T18:53:30.433Z,1624992810.433 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-06-29T18:53:37.791Z,1624992817.791 [DataOverHttps](INFO): Sending 71 bytes from file Logs/20210629T184552/Courier0005.lzma 2021-06-29T18:53:38.793Z,1624992818.793 [DataOverHttps](INFO): Moved sent file to Logs/20210629T184552/Courier0005.lzma.bak 2021-06-29T18:53:38.793Z,1624992818.793 [DataOverHttps](INFO): SBD MOMSN=15737070 2021-06-29T18:53:54.147Z,1624992834.147 [DataOverHttps](INFO): Sending 153 bytes from file Logs/20210629T184552/Express0007.lzma 2021-06-29T18:53:55.149Z,1624992835.149 [DataOverHttps](INFO): Moved sent file to Logs/20210629T184552/Express0007.lzma.bak 2021-06-29T18:53:55.149Z,1624992835.149 [DataOverHttps](INFO): SBD MOMSN=15737074 2021-06-29T18:53:57.057Z,1624992837.057 [Default:CheckIn:Read_Iridium] Stopped 2021-06-29T18:53:57.057Z,1624992837.057 [Default:CheckIn:C.Wait] Running Loop=1 2021-06-29T18:53:57.057Z,1624992837.057 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-06-29T18:54:01.089Z,1624992841.089 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2021-06-29T18:54:01.163Z,1624992841.163 [NAL9602](ERROR): received: +CSQ:0 OK76, 2, 0, 0, 0 OK 2021-06-29T18:55:15.593Z,1624992915.593 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2021-06-29T18:55:15.593Z,1624992915.593 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2021-06-29T18:55:15.658Z,1624992915.658 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2021-06-29T18:55:16.022Z,1624992916.022 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2021-06-29T18:55:16.022Z,1624992916.022 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2021-06-29T18:56:00.029Z,1624992960.029 [BPC1](ERROR): BPC1B: No match for serial number 0C29 in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-06-29T18:56:13.355Z,1624992973.355 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-06-29T18:56:27.091Z,1624992987.091 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-06-29T18:56:40.916Z,1624993000.916 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-06-29T18:56:54.158Z,1624993014.158 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-06-29T18:57:07.491Z,1624993027.491 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-06-29T18:57:21.228Z,1624993041.228 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-06-29T18:57:34.564Z,1624993054.564 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-06-29T18:57:47.891Z,1624993067.891 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-06-29T18:58:01.223Z,1624993081.223 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-06-29T18:58:14.962Z,1624993094.962 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-06-29T18:58:16.592Z,1624993096.592 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2021-06-29T18:58:16.592Z,1624993096.592 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2021-06-29T18:58:16.603Z,1624993096.603 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2021-06-29T18:58:17.022Z,1624993097.022 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2021-06-29T18:58:17.022Z,1624993097.022 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2021-06-29T18:58:32.342Z,1624993112.342 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2021-06-29T18:58:57.473Z,1624993137.473 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-06-29T18:58:57.473Z,1624993137.473 [Default:CheckIn:C.Wait] Stopped 2021-06-29T18:58:57.473Z,1624993137.473 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-06-29T18:58:57.473Z,1624993137.473 [Default:CheckIn:D] Running Loop=1 2021-06-29T18:58:57.884Z,1624993137.884 [Default:CheckIn:D] Stopped 2021-06-29T18:58:57.884Z,1624993137.884 [Default:CheckIn:E] Running Loop=1 2021-06-29T18:58:58.264Z,1624993138.264 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 27.237842 min 2021-06-29T18:58:58.264Z,1624993138.264 [Default:CheckIn:E] Stopped 2021-06-29T18:58:58.264Z,1624993138.264 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-06-29T18:58:58.264Z,1624993138.264 [Default:CheckIn] Stopped 2021-06-29T18:58:58.264Z,1624993138.264 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-06-29T18:58:58.264Z,1624993138.264 [Default:CheckIn](INFO): Running loop #5 2021-06-29T18:58:58.264Z,1624993138.264 [Default:CheckIn] Running Loop=5 2021-06-29T18:58:58.264Z,1624993138.264 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-06-29T18:58:58.265Z,1624993138.265 [Default:CheckIn:Read_GPS] Running Loop=1 2021-06-29T18:59:00.275Z,1624993140.275 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,185859.00,A,3648.16384,N,12147.28454,W,0.350,9.64,290621,,,D*7D 2021-06-29T18:59:00.277Z,1624993140.277 [NAL9602](INFO): GPS fix at 20210629T185859: (36.802731, -121.788076) 2021-06-29T18:59:00.307Z,1624993140.307 [Default:CheckIn:Read_GPS] Stopped 2021-06-29T18:59:00.307Z,1624993140.307 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-06-29T18:59:07.299Z,1624993147.299 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20210629T184552/Courier0009.lzma 2021-06-29T18:59:08.301Z,1624993148.301 [DataOverHttps](INFO): Moved sent file to Logs/20210629T184552/Courier0009.lzma.bak 2021-06-29T18:59:08.301Z,1624993148.301 [DataOverHttps](INFO): SBD MOMSN=15737083 2021-06-29T18:59:24.995Z,1624993164.995 [DataOverHttps](INFO): Sending 235 bytes from file Logs/20210629T184552/Express0010.lzma 2021-06-29T18:59:25.997Z,1624993165.997 [DataOverHttps](INFO): Moved sent file to Logs/20210629T184552/Express0010.lzma.bak 2021-06-29T18:59:25.997Z,1624993165.997 [DataOverHttps](INFO): SBD MOMSN=15737086 2021-06-29T18:59:27.765Z,1624993167.765 [Default:CheckIn:Read_Iridium] Stopped 2021-06-29T18:59:27.765Z,1624993167.765 [Default:CheckIn:C.Wait] Running Loop=1 2021-06-29T18:59:27.765Z,1624993167.765 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-06-29T18:59:32.600Z,1624993172.600 [NAL9602](INFO): Not Powering down - fast GPS 2021-06-29T19:00:57.092Z,1624993257.092 [BPC1](INFO): Calculating totals. Valid battery stick count: 53. Valid reserve battery stick count: 5. 2021-06-29T19:00:57.094Z,1624993257.094 [BPC1](INFO): Received data from all battery sticks. 2021-06-29T19:01:17.715Z,1624993277.715 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2021-06-29T19:01:17.715Z,1624993277.715 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2021-06-29T19:01:17.758Z,1624993277.758 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2021-06-29T19:01:18.126Z,1624993278.126 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2021-06-29T19:01:18.127Z,1624993278.127 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2021-06-29T19:04:18.690Z,1624993458.690 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2021-06-29T19:04:18.690Z,1624993458.690 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2021-06-29T19:04:18.721Z,1624993458.721 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2021-06-29T19:04:19.103Z,1624993459.103 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2021-06-29T19:04:19.104Z,1624993459.104 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2021-06-29T19:04:28.396Z,1624993468.396 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-06-29T19:04:28.396Z,1624993468.396 [Default:CheckIn:C.Wait] Stopped 2021-06-29T19:04:28.396Z,1624993468.396 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-06-29T19:04:28.396Z,1624993468.396 [Default:CheckIn:D] Running Loop=1 2021-06-29T19:04:28.793Z,1624993468.793 [Default:CheckIn:D] Stopped 2021-06-29T19:04:28.794Z,1624993468.794 [Default:CheckIn:E] Running Loop=1 2021-06-29T19:04:29.190Z,1624993469.190 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 32.752999 min 2021-06-29T19:04:29.190Z,1624993469.190 [Default:CheckIn:E] Stopped 2021-06-29T19:04:29.190Z,1624993469.190 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-06-29T19:04:29.190Z,1624993469.190 [Default:CheckIn] Stopped 2021-06-29T19:04:29.190Z,1624993469.190 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-06-29T19:04:29.190Z,1624993469.190 [Default:CheckIn](INFO): Running loop #6 2021-06-29T19:04:29.190Z,1624993469.190 [Default:CheckIn] Running Loop=6 2021-06-29T19:04:29.191Z,1624993469.191 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-06-29T19:04:29.191Z,1624993469.191 [Default:CheckIn:Read_GPS] Running Loop=1 2021-06-29T19:04:31.214Z,1624993471.214 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,190430.00,A,3648.16846,N,12147.28232,W,0.194,17.17,290621,,,D*48 2021-06-29T19:04:31.217Z,1624993471.217 [NAL9602](INFO): GPS fix at 20210629T190430: (36.802808, -121.788039) 2021-06-29T19:04:31.227Z,1624993471.227 [Default:CheckIn:Read_GPS] Stopped 2021-06-29T19:04:31.227Z,1624993471.227 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-06-29T19:04:42.711Z,1624993482.711 [DataOverHttps](INFO): Sending 201 bytes from file Logs/20210629T184552/Courier0012.lzma 2021-06-29T19:04:43.710Z,1624993483.710 [DataOverHttps](INFO): Moved sent file to Logs/20210629T184552/Courier0012.lzma.bak 2021-06-29T19:04:43.710Z,1624993483.710 [DataOverHttps](INFO): SBD MOMSN=15737098 2021-06-29T19:05:03.515Z,1624993503.515 [DataOverHttps](INFO): Sending 140 bytes from file Logs/20210629T184552/Express0013.lzma 2021-06-29T19:05:04.517Z,1624993504.517 [DataOverHttps](INFO): Moved sent file to Logs/20210629T184552/Express0013.lzma.bak 2021-06-29T19:05:04.517Z,1624993504.517 [DataOverHttps](INFO): SBD MOMSN=15737101 2021-06-29T19:05:06.478Z,1624993506.478 [Default:CheckIn:Read_Iridium] Stopped 2021-06-29T19:05:06.478Z,1624993506.478 [Default:CheckIn:C.Wait] Running Loop=1 2021-06-29T19:05:06.478Z,1624993506.478 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-06-29T19:07:19.803Z,1624993639.803 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2021-06-29T19:07:19.803Z,1624993639.803 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2021-06-29T19:07:19.814Z,1624993639.814 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2021-06-29T19:07:20.221Z,1624993640.221 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2021-06-29T19:07:20.221Z,1624993640.221 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2021-06-29T19:08:12.722Z,1624993692.722 [NAL9602](INFO): SBD MO Status=2, MOMSN=4876, MT Status=2, MTMSN=0 2021-06-29T19:08:12.722Z,1624993692.722 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-06-29T19:09:33.581Z,1624993773.581 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2021-06-29T19:10:04.288Z,1624993804.288 [NAL9602](INFO): Not Powering down - fast GPS 2021-06-29T19:10:07.124Z,1624993807.124 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-06-29T19:10:07.124Z,1624993807.124 [Default:CheckIn:C.Wait] Stopped 2021-06-29T19:10:07.124Z,1624993807.124 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-06-29T19:10:07.124Z,1624993807.124 [Default:CheckIn:D] Running Loop=1 2021-06-29T19:10:07.536Z,1624993807.536 [Default:CheckIn:D] Stopped 2021-06-29T19:10:07.536Z,1624993807.536 [Default:CheckIn:E] Running Loop=1 2021-06-29T19:10:07.932Z,1624993807.932 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 38.398710 min 2021-06-29T19:10:07.932Z,1624993807.932 [Default:CheckIn:E] Stopped 2021-06-29T19:10:07.932Z,1624993807.932 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-06-29T19:10:07.932Z,1624993807.932 [Default:CheckIn] Stopped 2021-06-29T19:10:07.932Z,1624993807.932 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-06-29T19:10:07.932Z,1624993807.932 [Default:CheckIn](INFO): Running loop #7 2021-06-29T19:10:07.932Z,1624993807.932 [Default:CheckIn] Running Loop=7 2021-06-29T19:10:07.933Z,1624993807.933 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-06-29T19:10:07.933Z,1624993807.933 [Default:CheckIn:Read_GPS] Running Loop=1 2021-06-29T19:10:09.947Z,1624993809.947 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,191009.00,A,3648.16370,N,12147.28773,W,0.175,17.17,290621,,,D*46 2021-06-29T19:10:09.949Z,1624993809.949 [NAL9602](INFO): GPS fix at 20210629T191009: (36.802728, -121.788129) 2021-06-29T19:10:09.959Z,1624993809.959 [Default:CheckIn:Read_GPS] Stopped 2021-06-29T19:10:09.959Z,1624993809.959 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-06-29T19:10:17.527Z,1624993817.527 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20210629T184552/Courier0015.lzma 2021-06-29T19:10:18.529Z,1624993818.529 [DataOverHttps](INFO): Moved sent file to Logs/20210629T184552/Courier0015.lzma.bak 2021-06-29T19:10:18.529Z,1624993818.529 [DataOverHttps](INFO): SBD MOMSN=15737113 2021-06-29T19:10:20.859Z,1624993820.859 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2021-06-29T19:10:20.859Z,1624993820.859 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2021-06-29T19:10:20.894Z,1624993820.894 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2021-06-29T19:10:21.314Z,1624993821.314 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2021-06-29T19:10:21.314Z,1624993821.314 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2021-06-29T19:10:35.127Z,1624993835.127 [DataOverHttps](INFO): Sending 214 bytes from file Logs/20210629T184552/Express0016.lzma 2021-06-29T19:10:36.129Z,1624993836.129 [DataOverHttps](INFO): Moved sent file to Logs/20210629T184552/Express0016.lzma.bak 2021-06-29T19:10:36.129Z,1624993836.129 [DataOverHttps](INFO): SBD MOMSN=15737116 2021-06-29T19:10:38.674Z,1624993838.674 [Default:CheckIn:Read_Iridium] Stopped 2021-06-29T19:10:38.674Z,1624993838.674 [Default:CheckIn:C.Wait] Running Loop=1 2021-06-29T19:10:38.674Z,1624993838.674 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-06-29T19:13:22.011Z,1624994002.011 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2021-06-29T19:13:22.011Z,1624994002.011 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2021-06-29T19:13:22.048Z,1624994002.048 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2021-06-29T19:13:22.425Z,1624994002.425 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2021-06-29T19:13:22.425Z,1624994002.425 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2021-06-29T19:13:27.265Z,1624994007.265 [BPC1](ERROR): BPC1B: No match for serial number 0C29 in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-06-29T19:13:41.051Z,1624994021.051 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-06-29T19:13:54.731Z,1624994034.731 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-06-29T19:14:08.467Z,1624994048.467 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-06-29T19:14:21.451Z,1624994061.451 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-06-29T19:14:34.720Z,1624994074.720 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-06-29T19:14:48.520Z,1624994088.520 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-06-29T19:15:01.911Z,1624994101.911 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-06-29T19:15:12.706Z,1624994112.706 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2021-06-29T19:15:15.586Z,1624994115.586 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-06-29T19:15:28.854Z,1624994128.854 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-06-29T19:15:39.374Z,1624994139.374 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-06-29T19:15:39.374Z,1624994139.374 [Default:CheckIn:C.Wait] Stopped 2021-06-29T19:15:39.375Z,1624994139.375 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-06-29T19:15:39.375Z,1624994139.375 [Default:CheckIn:D] Running Loop=1 2021-06-29T19:15:39.784Z,1624994139.784 [Default:CheckIn:D] Stopped 2021-06-29T19:15:39.784Z,1624994139.784 [Default:CheckIn:E] Running Loop=1 2021-06-29T19:15:40.180Z,1624994140.180 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 43.936182 min 2021-06-29T19:15:40.180Z,1624994140.180 [Default:CheckIn:E] Stopped 2021-06-29T19:15:40.180Z,1624994140.180 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-06-29T19:15:40.180Z,1624994140.180 [Default:CheckIn] Stopped 2021-06-29T19:15:40.180Z,1624994140.180 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-06-29T19:15:40.181Z,1624994140.181 [Default:CheckIn](INFO): Running loop #8 2021-06-29T19:15:40.181Z,1624994140.181 [Default:CheckIn] Running Loop=8 2021-06-29T19:15:40.181Z,1624994140.181 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-06-29T19:15:40.181Z,1624994140.181 [Default:CheckIn:Read_GPS] Running Loop=1 2021-06-29T19:15:42.186Z,1624994142.186 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-06-29T19:15:42.195Z,1624994142.195 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,191541.00,A,3648.16360,N,12147.28751,W,0.194,17.17,290621,,,D*41 2021-06-29T19:15:42.197Z,1624994142.197 [NAL9602](INFO): GPS fix at 20210629T191541: (36.802727, -121.788125) 2021-06-29T19:15:42.212Z,1624994142.212 [Default:CheckIn:Read_GPS] Stopped 2021-06-29T19:15:42.212Z,1624994142.212 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-06-29T19:15:49.979Z,1624994149.979 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20210629T184552/Courier0018.lzma 2021-06-29T19:15:50.981Z,1624994150.981 [DataOverHttps](INFO): Moved sent file to Logs/20210629T184552/Courier0018.lzma.bak 2021-06-29T19:15:50.981Z,1624994150.981 [DataOverHttps](INFO): SBD MOMSN=15737130 2021-06-29T19:16:06.727Z,1624994166.727 [DataOverHttps](INFO): Sending 218 bytes from file Logs/20210629T184552/Express0019.lzma 2021-06-29T19:16:07.729Z,1624994167.729 [DataOverHttps](INFO): Moved sent file to Logs/20210629T184552/Express0019.lzma.bak 2021-06-29T19:16:07.729Z,1624994167.729 [DataOverHttps](INFO): SBD MOMSN=15737133 2021-06-29T19:16:09.707Z,1624994169.707 [Default:CheckIn:Read_Iridium] Stopped 2021-06-29T19:16:09.708Z,1624994169.708 [Default:CheckIn:C.Wait] Running Loop=1 2021-06-29T19:16:09.708Z,1624994169.708 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-06-29T19:16:14.506Z,1624994174.506 [NAL9602](INFO): Not Powering down - fast GPS 2021-06-29T19:16:23.082Z,1624994183.082 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2021-06-29T19:16:23.082Z,1624994183.082 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2021-06-29T19:16:23.094Z,1624994183.094 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2021-06-29T19:16:23.424Z,1624994183.424 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2021-06-29T19:16:23.424Z,1624994183.424 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2021-06-29T19:18:23.793Z,1624994303.793 [BPC1](INFO): Calculating totals. Valid battery stick count: 54. Valid reserve battery stick count: 5. 2021-06-29T19:18:23.796Z,1624994303.796 [BPC1](INFO): Received data from all battery sticks. 2021-06-29T19:19:24.059Z,1624994364.059 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2021-06-29T19:19:24.059Z,1624994364.059 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2021-06-29T19:19:24.070Z,1624994364.070 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2021-06-29T19:19:24.484Z,1624994364.484 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2021-06-29T19:19:24.485Z,1624994364.485 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2021-06-29T19:21:10.308Z,1624994470.308 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-06-29T19:21:10.308Z,1624994470.308 [Default:CheckIn:C.Wait] Stopped 2021-06-29T19:21:10.308Z,1624994470.308 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-06-29T19:21:10.308Z,1624994470.308 [Default:CheckIn:D] Running Loop=1 2021-06-29T19:21:10.711Z,1624994470.711 [Default:CheckIn:D] Stopped 2021-06-29T19:21:10.712Z,1624994470.712 [Default:CheckIn:E] Running Loop=1 2021-06-29T19:21:11.116Z,1624994471.116 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 49.451632 min 2021-06-29T19:21:11.116Z,1624994471.116 [Default:CheckIn:E] Stopped 2021-06-29T19:21:11.116Z,1624994471.116 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-06-29T19:21:11.116Z,1624994471.116 [Default:CheckIn] Stopped 2021-06-29T19:21:11.116Z,1624994471.116 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-06-29T19:21:11.117Z,1624994471.117 [Default:CheckIn](INFO): Running loop #9 2021-06-29T19:21:11.117Z,1624994471.117 [Default:CheckIn] Running Loop=9 2021-06-29T19:21:11.117Z,1624994471.117 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-06-29T19:21:11.117Z,1624994471.117 [Default:CheckIn:Read_GPS] Running Loop=1 2021-06-29T19:21:13.132Z,1624994473.132 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,192112.00,A,3648.16247,N,12147.28006,W,0.136,17.17,290621,,,D*49 2021-06-29T19:21:13.135Z,1624994473.135 [NAL9602](INFO): GPS fix at 20210629T192112: (36.802708, -121.788001) 2021-06-29T19:21:13.152Z,1624994473.152 [Default:CheckIn:Read_GPS] Stopped 2021-06-29T19:21:13.152Z,1624994473.152 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-06-29T19:21:19.750Z,1624994479.750 [DataOverHttps](INFO): Sending 84 bytes from file Logs/20210629T184552/Courier0021.lzma 2021-06-29T19:21:20.753Z,1624994480.753 [DataOverHttps](INFO): Moved sent file to Logs/20210629T184552/Courier0021.lzma.bak 2021-06-29T19:21:20.753Z,1624994480.753 [DataOverHttps](INFO): SBD MOMSN=15737146 2021-06-29T19:21:36.215Z,1624994496.215 [DataOverHttps](INFO): Sending 141 bytes from file Logs/20210629T184552/Express0022.lzma 2021-06-29T19:21:37.217Z,1624994497.217 [DataOverHttps](INFO): Moved sent file to Logs/20210629T184552/Express0022.lzma.bak 2021-06-29T19:21:37.217Z,1624994497.217 [DataOverHttps](INFO): SBD MOMSN=15737149 2021-06-29T19:21:39.316Z,1624994499.316 [Default:CheckIn:Read_Iridium] Stopped 2021-06-29T19:21:39.316Z,1624994499.316 [Default:CheckIn:C.Wait] Running Loop=1 2021-06-29T19:21:39.316Z,1624994499.316 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-06-29T19:21:43.729Z,1624994503.729 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2021-06-29T19:21:43.803Z,1624994503.803 [NAL9602](ERROR): received: +CSQ:0 OK76, 2, 0, 0, 0 OK 2021-06-29T19:22:24.985Z,1624994544.985 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2021-06-29T19:22:24.986Z,1624994544.986 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2021-06-29T19:22:25.062Z,1624994545.062 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2021-06-29T19:22:25.362Z,1624994545.362 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2021-06-29T19:22:25.363Z,1624994545.363 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2021-06-29T19:25:25.939Z,1624994725.939 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2021-06-29T19:25:25.939Z,1624994725.939 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2021-06-29T19:25:25.974Z,1624994725.974 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2021-06-29T19:25:26.352Z,1624994726.352 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2021-06-29T19:25:26.352Z,1624994726.352 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2021-06-29T19:26:15.221Z,1624994775.221 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2021-06-29T19:26:39.912Z,1624994799.912 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-06-29T19:26:39.912Z,1624994799.912 [Default:CheckIn:C.Wait] Stopped 2021-06-29T19:26:39.912Z,1624994799.912 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-06-29T19:26:39.913Z,1624994799.913 [Default:CheckIn:D] Running Loop=1 2021-06-29T19:26:40.316Z,1624994800.316 [Default:CheckIn:D] Stopped 2021-06-29T19:26:40.316Z,1624994800.316 [Default:CheckIn:E] Running Loop=1 2021-06-29T19:26:40.742Z,1624994800.742 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 54.945032 min 2021-06-29T19:26:40.742Z,1624994800.742 [Default:CheckIn:E] Stopped 2021-06-29T19:26:40.742Z,1624994800.742 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-06-29T19:26:40.742Z,1624994800.742 [Default:CheckIn] Stopped 2021-06-29T19:26:40.743Z,1624994800.743 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-06-29T19:26:40.743Z,1624994800.743 [Default:CheckIn](INFO): Running loop #10 2021-06-29T19:26:40.743Z,1624994800.743 [Default:CheckIn] Running Loop=10 2021-06-29T19:26:40.743Z,1624994800.743 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-06-29T19:26:40.743Z,1624994800.743 [Default:CheckIn:Read_GPS] Running Loop=1 2021-06-29T19:26:42.738Z,1624994802.738 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,192641.00,A,3648.16528,N,12147.27928,W,0.078,0.00,290621,,,D*77 2021-06-29T19:26:42.741Z,1624994802.741 [NAL9602](INFO): GPS fix at 20210629T192641: (36.802755, -121.787988) 2021-06-29T19:26:42.759Z,1624994802.759 [Default:CheckIn:Read_GPS] Stopped 2021-06-29T19:26:42.759Z,1624994802.759 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-06-29T19:26:52.511Z,1624994812.511 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20210629T184552/Courier0024.lzma 2021-06-29T19:26:53.521Z,1624994813.521 [DataOverHttps](INFO): Moved sent file to Logs/20210629T184552/Courier0024.lzma.bak 2021-06-29T19:26:53.521Z,1624994813.521 [DataOverHttps](INFO): SBD MOMSN=15737164 2021-06-29T19:27:10.279Z,1624994830.279 [DataOverHttps](INFO): Sending 217 bytes from file Logs/20210629T184552/Express0025.lzma 2021-06-29T19:27:11.281Z,1624994831.281 [DataOverHttps](INFO): Moved sent file to Logs/20210629T184552/Express0025.lzma.bak 2021-06-29T19:27:11.281Z,1624994831.281 [DataOverHttps](INFO): SBD MOMSN=15737167 2021-06-29T19:27:13.528Z,1624994833.528 [Default:CheckIn:Read_Iridium] Stopped 2021-06-29T19:27:13.528Z,1624994833.528 [Default:CheckIn:C.Wait] Running Loop=1 2021-06-29T19:27:13.528Z,1624994833.528 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-06-29T19:27:15.516Z,1624994835.516 [NAL9602](INFO): Not Powering down - fast GPS 2021-06-29T19:28:27.036Z,1624994907.036 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2021-06-29T19:28:27.036Z,1624994907.036 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2021-06-29T19:28:27.069Z,1624994907.069 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2021-06-29T19:28:27.461Z,1624994907.461 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2021-06-29T19:28:27.461Z,1624994907.461 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2021-06-29T19:30:52.941Z,1624995052.941 [BPC1](ERROR): BPC1B: No match for serial number 0C29 in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-06-29T19:31:06.683Z,1624995066.683 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-06-29T19:31:20.060Z,1624995080.060 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-06-29T19:31:28.096Z,1624995088.096 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2021-06-29T19:31:28.096Z,1624995088.096 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2021-06-29T19:31:28.107Z,1624995088.107 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2021-06-29T19:31:28.516Z,1624995088.516 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2021-06-29T19:31:28.516Z,1624995088.516 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2021-06-29T19:31:34.149Z,1624995094.149 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-06-29T19:31:47.475Z,1624995107.475 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-06-29T19:32:01.210Z,1624995121.210 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-06-29T19:32:14.208Z,1624995134.208 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-06-29T19:32:14.208Z,1624995134.208 [Default:CheckIn:C.Wait] Stopped 2021-06-29T19:32:14.208Z,1624995134.208 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-06-29T19:32:14.209Z,1624995134.209 [Default:CheckIn:D] Running Loop=1 2021-06-29T19:32:14.636Z,1624995134.636 [Default:CheckIn:D] Stopped 2021-06-29T19:32:14.637Z,1624995134.637 [Default:CheckIn:E] Running Loop=1 2021-06-29T19:32:14.949Z,1624995134.949 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-06-29T19:32:14.964Z,1624995134.964 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 60.517049 min 2021-06-29T19:32:14.964Z,1624995134.964 [Default:CheckIn:E] Stopped 2021-06-29T19:32:14.964Z,1624995134.964 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-06-29T19:32:14.964Z,1624995134.964 [Default:CheckIn] Stopped 2021-06-29T19:32:14.964Z,1624995134.964 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-06-29T19:32:14.964Z,1624995134.964 [Default:CheckIn](INFO): Running loop #11 2021-06-29T19:32:14.964Z,1624995134.964 [Default:CheckIn] Running Loop=11 2021-06-29T19:32:14.964Z,1624995134.964 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-06-29T19:32:14.965Z,1624995134.965 [Default:CheckIn:Read_GPS] Running Loop=1 2021-06-29T19:32:16.967Z,1624995136.967 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,193216.00,A,3648.16253,N,12147.27732,W,0.330,109.04,290621,,,D*7D 2021-06-29T19:32:16.978Z,1624995136.978 [NAL9602](INFO): GPS fix at 20210629T193216: (36.802709, -121.787955) 2021-06-29T19:32:16.988Z,1624995136.988 [Default:CheckIn:Read_GPS] Stopped 2021-06-29T19:32:16.989Z,1624995136.989 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-06-29T19:32:24.139Z,1624995144.139 [DataOverHttps](INFO): Sending 71 bytes from file Logs/20210629T184552/Courier0027.lzma 2021-06-29T19:32:25.141Z,1624995145.141 [DataOverHttps](INFO): Moved sent file to Logs/20210629T184552/Courier0027.lzma.bak 2021-06-29T19:32:25.141Z,1624995145.141 [DataOverHttps](INFO): SBD MOMSN=15737180 2021-06-29T19:32:28.378Z,1624995148.378 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-06-29T19:32:42.176Z,1624995162.176 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-06-29T19:32:43.675Z,1624995163.675 [DataOverHttps](INFO): Sending 140 bytes from file Logs/20210629T184552/Express0028.lzma 2021-06-29T19:32:44.677Z,1624995164.677 [DataOverHttps](INFO): Moved sent file to Logs/20210629T184552/Express0028.lzma.bak 2021-06-29T19:32:44.677Z,1624995164.677 [DataOverHttps](INFO): SBD MOMSN=15737183 2021-06-29T19:32:47.414Z,1624995167.414 [Default:CheckIn:Read_Iridium] Stopped 2021-06-29T19:32:47.414Z,1624995167.414 [Default:CheckIn:C.Wait] Running Loop=1 2021-06-29T19:32:47.414Z,1624995167.414 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-06-29T19:32:47.777Z,1624995167.777 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2021-06-29T19:32:47.855Z,1624995167.855 [NAL9602](ERROR): received: +CSQ:0 OK76, 2, 0, 0, 0 OK 2021-06-29T19:32:56.433Z,1624995176.433 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-06-29T19:33:10.085Z,1624995190.085 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-06-29T19:34:00.181Z,1624995240.181 [NAL9602](INFO): SBD MO Status=2, MOMSN=4876, MT Status=2, MTMSN=0 2021-06-29T19:34:00.181Z,1624995240.181 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-06-29T19:34:16.449Z,1624995256.449 [NAL9602](INFO): SBD MO Status=2, MOMSN=4876, MT Status=2, MTMSN=0 2021-06-29T19:34:16.449Z,1624995256.449 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-06-29T19:34:29.270Z,1624995269.270 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2021-06-29T19:34:29.271Z,1624995269.271 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2021-06-29T19:34:29.302Z,1624995269.302 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2021-06-29T19:34:29.756Z,1624995269.756 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2021-06-29T19:34:29.756Z,1624995269.756 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2021-06-29T19:34:38.958Z,1624995278.958 [NAL9602](INFO): SBD MO Status=2, MOMSN=4876, MT Status=2, MTMSN=0 2021-06-29T19:34:38.958Z,1624995278.958 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-06-29T19:34:57.964Z,1624995297.964 [NAL9602](INFO): SBD MO Status=1, MOMSN=4876, MT Status=0, MTMSN=0 2021-06-29T19:34:57.964Z,1624995297.964 [NAL9602](INFO): No messages in MT queue 2021-06-29T19:35:28.652Z,1624995328.652 [NAL9602](INFO): Not Powering down - fast GPS 2021-06-29T19:35:50.468Z,1624995350.468 [BPC1](INFO): Calculating totals. Valid battery stick count: 53. Valid reserve battery stick count: 5. 2021-06-29T19:35:50.471Z,1624995350.471 [BPC1](INFO): Received data from all battery sticks. 2021-06-29T19:37:30.326Z,1624995450.326 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2021-06-29T19:37:30.326Z,1624995450.326 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2021-06-29T19:37:30.362Z,1624995450.362 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2021-06-29T19:37:30.735Z,1624995450.735 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2021-06-29T19:37:30.735Z,1624995450.735 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2021-06-29T19:37:48.124Z,1624995468.124 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-06-29T19:37:48.124Z,1624995468.124 [Default:CheckIn:C.Wait] Stopped 2021-06-29T19:37:48.124Z,1624995468.124 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-06-29T19:37:48.124Z,1624995468.124 [Default:CheckIn:D] Running Loop=1 2021-06-29T19:37:48.525Z,1624995468.525 [Default:CheckIn:D] Stopped 2021-06-29T19:37:48.525Z,1624995468.525 [Default:CheckIn:E] Running Loop=1 2021-06-29T19:37:48.922Z,1624995468.922 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 66.081852 min 2021-06-29T19:37:48.922Z,1624995468.922 [Default:CheckIn:E] Stopped 2021-06-29T19:37:48.922Z,1624995468.922 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-06-29T19:37:48.922Z,1624995468.922 [Default:CheckIn] Stopped 2021-06-29T19:37:48.922Z,1624995468.922 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-06-29T19:37:48.923Z,1624995468.923 [Default:CheckIn](INFO): Running loop #12 2021-06-29T19:37:48.923Z,1624995468.923 [Default:CheckIn] Running Loop=12 2021-06-29T19:37:48.955Z,1624995468.955 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-06-29T19:37:48.955Z,1624995468.955 [Default:CheckIn:Read_GPS] Running Loop=1 2021-06-29T19:37:50.923Z,1624995470.923 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,193750.00,A,3648.16295,N,12147.28188,W,0.058,55.56,290621,,,D*4A 2021-06-29T19:37:50.925Z,1624995470.925 [NAL9602](INFO): GPS fix at 20210629T193750: (36.802716, -121.788031) 2021-06-29T19:37:50.936Z,1624995470.936 [Default:CheckIn:Read_GPS] Stopped 2021-06-29T19:37:50.937Z,1624995470.937 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-06-29T19:37:58.203Z,1624995478.203 [DataOverHttps](INFO): Sending 85 bytes from file Logs/20210629T184552/Courier0030.lzma 2021-06-29T19:37:59.205Z,1624995479.205 [DataOverHttps](INFO): Moved sent file to Logs/20210629T184552/Courier0030.lzma.bak 2021-06-29T19:37:59.205Z,1624995479.205 [DataOverHttps](INFO): SBD MOMSN=15737204 2021-06-29T19:38:16.259Z,1624995496.259 [DataOverHttps](INFO): Sending 141 bytes from file Logs/20210629T184552/Express0031.lzma 2021-06-29T19:38:17.261Z,1624995497.261 [DataOverHttps](INFO): Moved sent file to Logs/20210629T184552/Express0031.lzma.bak 2021-06-29T19:38:17.261Z,1624995497.261 [DataOverHttps](INFO): SBD MOMSN=15737208 2021-06-29T19:38:19.220Z,1624995499.220 [Default:CheckIn:Read_Iridium] Stopped 2021-06-29T19:38:19.220Z,1624995499.220 [Default:CheckIn:C.Wait] Running Loop=1 2021-06-29T19:38:19.220Z,1624995499.220 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-06-29T19:40:31.344Z,1624995631.344 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2021-06-29T19:40:31.344Z,1624995631.344 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2021-06-29T19:40:31.355Z,1624995631.355 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2021-06-29T19:40:31.741Z,1624995631.741 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2021-06-29T19:40:31.741Z,1624995631.741 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2021-06-29T19:42:49.938Z,1624995769.938 [NAL9602](INFO): SBD MO Status=2, MOMSN=4877, MT Status=2, MTMSN=0 2021-06-29T19:42:49.938Z,1624995769.938 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-06-29T19:42:53.577Z,1624995773.577 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2021-06-29T19:43:19.839Z,1624995799.839 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-06-29T19:43:19.839Z,1624995799.839 [Default:CheckIn:C.Wait] Stopped 2021-06-29T19:43:19.840Z,1624995799.840 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-06-29T19:43:19.840Z,1624995799.840 [Default:CheckIn:D] Running Loop=1 2021-06-29T19:43:20.244Z,1624995800.244 [Default:CheckIn:D] Stopped 2021-06-29T19:43:20.244Z,1624995800.244 [Default:CheckIn:E] Running Loop=1 2021-06-29T19:43:20.652Z,1624995800.652 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 71.610498 min 2021-06-29T19:43:20.652Z,1624995800.652 [Default:CheckIn:E] Stopped 2021-06-29T19:43:20.652Z,1624995800.652 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-06-29T19:43:20.652Z,1624995800.652 [Default:CheckIn] Stopped 2021-06-29T19:43:20.652Z,1624995800.652 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-06-29T19:43:20.653Z,1624995800.653 [Default:CheckIn](INFO): Running loop #13 2021-06-29T19:43:20.653Z,1624995800.653 [Default:CheckIn] Running Loop=13 2021-06-29T19:43:20.653Z,1624995800.653 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-06-29T19:43:20.653Z,1624995800.653 [Default:CheckIn:Read_GPS] Running Loop=1 2021-06-29T19:43:22.659Z,1624995802.659 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,194321.00,A,3648.16596,N,12147.28254,W,0.194,55.56,290621,,,A*4D 2021-06-29T19:43:22.661Z,1624995802.661 [NAL9602](INFO): GPS fix at 20210629T194321: (36.802766, -121.788042) 2021-06-29T19:43:22.702Z,1624995802.702 [Default:CheckIn:Read_GPS] Stopped 2021-06-29T19:43:22.702Z,1624995802.702 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-06-29T19:43:29.707Z,1624995809.707 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20210629T184552/Courier0033.lzma 2021-06-29T19:43:30.709Z,1624995810.709 [DataOverHttps](INFO): Moved sent file to Logs/20210629T184552/Courier0033.lzma.bak 2021-06-29T19:43:30.709Z,1624995810.709 [DataOverHttps](INFO): SBD MOMSN=15737221 2021-06-29T19:43:32.384Z,1624995812.384 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2021-06-29T19:43:32.384Z,1624995812.384 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2021-06-29T19:43:32.394Z,1624995812.394 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2021-06-29T19:43:32.794Z,1624995812.794 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2021-06-29T19:43:32.794Z,1624995812.794 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2021-06-29T19:43:47.051Z,1624995827.051 [DataOverHttps](INFO): Sending 216 bytes from file Logs/20210629T184552/Express0034.lzma 2021-06-29T19:43:48.053Z,1624995828.053 [DataOverHttps](INFO): Moved sent file to Logs/20210629T184552/Express0034.lzma.bak 2021-06-29T19:43:48.053Z,1624995828.053 [DataOverHttps](INFO): SBD MOMSN=15737224 2021-06-29T19:43:50.156Z,1624995830.156 [Default:CheckIn:Read_Iridium] Stopped 2021-06-29T19:43:50.156Z,1624995830.156 [Default:CheckIn:C.Wait] Running Loop=1 2021-06-29T19:43:50.156Z,1624995830.156 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-06-29T19:43:54.576Z,1624995834.576 [NAL9602](INFO): Not Powering down - fast GPS 2021-06-29T19:46:33.418Z,1624995993.418 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2021-06-29T19:46:33.418Z,1624995993.418 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2021-06-29T19:46:33.458Z,1624995993.458 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2021-06-29T19:46:33.834Z,1624995993.834 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2021-06-29T19:46:33.834Z,1624995993.834 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2021-06-29T19:48:20.511Z,1624996100.511 [BPC1](ERROR): BPC1B: No match for serial number 0C29 in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-06-29T19:48:34.043Z,1624996114.043 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-06-29T19:48:48.044Z,1624996128.044 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-06-29T19:48:50.836Z,1624996130.836 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-06-29T19:48:50.836Z,1624996130.836 [Default:CheckIn:C.Wait] Stopped 2021-06-29T19:48:50.836Z,1624996130.836 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-06-29T19:48:50.837Z,1624996130.837 [Default:CheckIn:D] Running Loop=1 2021-06-29T19:48:51.185Z,1624996131.185 [Default:CheckIn:D] Stopped 2021-06-29T19:48:51.185Z,1624996131.185 [Default:CheckIn:E] Running Loop=1 2021-06-29T19:48:51.601Z,1624996131.601 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 77.126180 min 2021-06-29T19:48:51.601Z,1624996131.601 [Default:CheckIn:E] Stopped 2021-06-29T19:48:51.601Z,1624996131.601 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-06-29T19:48:51.601Z,1624996131.601 [Default:CheckIn] Stopped 2021-06-29T19:48:51.601Z,1624996131.601 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-06-29T19:48:51.601Z,1624996131.601 [Default:CheckIn](INFO): Running loop #14 2021-06-29T19:48:51.601Z,1624996131.601 [Default:CheckIn] Running Loop=14 2021-06-29T19:48:51.602Z,1624996131.602 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-06-29T19:48:51.602Z,1624996131.602 [Default:CheckIn:Read_GPS] Running Loop=1 2021-06-29T19:48:53.594Z,1624996133.594 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,194852.00,A,3648.16511,N,12147.28144,W,0.058,166.19,290621,,,D*71 2021-06-29T19:48:53.597Z,1624996133.597 [NAL9602](INFO): GPS fix at 20210629T194852: (36.802752, -121.788024) 2021-06-29T19:48:53.617Z,1624996133.617 [Default:CheckIn:Read_GPS] Stopped 2021-06-29T19:48:53.617Z,1624996133.617 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-06-29T19:49:01.214Z,1624996141.214 [DataOverHttps](INFO): Sending 71 bytes from file Logs/20210629T184552/Courier0036.lzma 2021-06-29T19:49:01.330Z,1624996141.330 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-06-29T19:49:02.217Z,1624996142.217 [DataOverHttps](INFO): Moved sent file to Logs/20210629T184552/Courier0036.lzma.bak 2021-06-29T19:49:02.217Z,1624996142.217 [DataOverHttps](INFO): SBD MOMSN=15737234 2021-06-29T19:49:14.597Z,1624996154.597 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-06-29T19:49:17.843Z,1624996157.843 [DataOverHttps](INFO): Sending 371 bytes from file Logs/20210629T184552/Express0037.lzma 2021-06-29T19:49:18.845Z,1624996158.845 [DataOverHttps](INFO): Moved sent file to Logs/20210629T184552/Express0037.lzma.bak 2021-06-29T19:49:18.845Z,1624996158.845 [DataOverHttps](INFO): SBD MOMSN=15737239 2021-06-29T19:49:20.679Z,1624996160.679 [Default:CheckIn:Read_Iridium] Stopped 2021-06-29T19:49:20.680Z,1624996160.680 [Default:CheckIn:C.Wait] Running Loop=1 2021-06-29T19:49:20.680Z,1624996160.680 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-06-29T19:49:24.293Z,1624996164.293 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2021-06-29T19:49:24.371Z,1624996164.371 [NAL9602](ERROR): received: +SBDI: 2, 4877, 2, 0, 0, 0 OK 2021-06-29T19:49:27.523Z,1624996167.523 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-06-29T19:49:34.424Z,1624996174.424 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2021-06-29T19:49:34.424Z,1624996174.424 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2021-06-29T19:49:34.458Z,1624996174.458 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2021-06-29T19:49:34.834Z,1624996174.834 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2021-06-29T19:49:34.834Z,1624996174.834 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2021-06-29T19:49:40.855Z,1624996180.855 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-06-29T19:49:54.187Z,1624996194.187 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-06-29T19:50:07.519Z,1624996207.519 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-06-29T19:50:18.860Z,1624996218.860 [NAL9602](INFO): SBD MO Status=2, MOMSN=4877, MT Status=2, MTMSN=0 2021-06-29T19:50:18.861Z,1624996218.861 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-06-29T19:50:21.320Z,1624996221.320 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-06-29T19:50:35.183Z,1624996235.183 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-06-29T19:51:44.938Z,1624996304.938 [NAL9602](INFO): SBD MO Status=1, MOMSN=4877, MT Status=0, MTMSN=0 2021-06-29T19:51:44.938Z,1624996304.938 [NAL9602](INFO): No messages in MT queue 2021-06-29T19:52:15.644Z,1624996335.644 [NAL9602](INFO): Not Powering down - fast GPS 2021-06-29T19:52:35.455Z,1624996355.455 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2021-06-29T19:52:35.455Z,1624996355.455 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2021-06-29T19:52:35.469Z,1624996355.469 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2021-06-29T19:52:35.980Z,1624996355.980 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2021-06-29T19:52:35.980Z,1624996355.980 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2021-06-29T19:53:16.256Z,1624996396.256 [BPC1](INFO): Calculating totals. Valid battery stick count: 54. Valid reserve battery stick count: 5. 2021-06-29T19:53:16.259Z,1624996396.259 [BPC1](INFO): Received data from all battery sticks. 2021-06-29T19:53:35.881Z,1624996415.881 [DataOverHttps](IMPORTANT): SBD MTMSN=20210629T195334 2021-06-29T19:53:42.995Z,1624996422.995 [DataOverHttps](INFO): Received command:sched asap "load Maintenance/tank_ballast_and_trim_backseat.xml;set tank_ballast_and_trim_backseat.MissionTimeout 40 min;set tank_ballast_and_trim_backseat.SettleTime 5 min;set tank_ballast_and_trim_backseat.EstimationTimeout 30 min" ehwu 1 2 2021-06-29T19:53:43.032Z,1624996423.032 [CommandLine](IMPORTANT): got command schedule asap "load Maintenance/tank_ballast_and_trim_backseat.xml;set tank_ballast_and_trim_backseat.MissionTimeout 40 min;set tank_ballast_and_trim_backseat.SettleTime 5 min;set tank_ballast_and_trim_backseat.EstimationTimeout 30 min" ehwu 1 2.000000 2021-06-29T19:53:43.033Z,1624996423.033 [CommandLine](IMPORTANT): Scheduling command #1 of 2 with id=ehwu 2021-06-29T19:53:43.034Z,1624996423.034 [CommandLine](IMPORTANT): Scheduled #3 (#1 of 2 with id='ehwu'): "load Maintenance/tank_ballast_and_trim_backseat.xml;set tank_ballast_and_trim_backseat.MissionTimeout 40 min;set tank_ballast_and_trim_backseat.SettleTime 5 min;set tank_ballast_and_trim_backseat.EstimationTimeout 30 min" ASAP 2021-06-29T19:53:43.997Z,1624996423.997 [DataOverHttps](IMPORTANT): SBD MTMSN=20210629T195342 2021-06-29T19:53:51.383Z,1624996431.383 [DataOverHttps](INFO): Received command:sched asap "set tank_ballast_and_trim_backseat.MassEstimationErrorBound 5 mm;set tank_ballast_and_trim_backseat.BuoyEstimationErrorBound 25 cc;run" ehwu 2 2 2021-06-29T19:53:51.436Z,1624996431.436 [CommandLine](IMPORTANT): got command schedule asap "set tank_ballast_and_trim_backseat.MassEstimationErrorBound 5 mm;set tank_ballast_and_trim_backseat.BuoyEstimationErrorBound 25 cc;run" ehwu 2 2.000000 2021-06-29T19:53:51.437Z,1624996431.437 [CommandLine](IMPORTANT): Scheduling command #2 of 2 with id=ehwu 2021-06-29T19:53:51.438Z,1624996431.438 [CommandLine](IMPORTANT): Scheduled #4 (#2 of 2 with id='ehwu'): "set tank_ballast_and_trim_backseat.MassEstimationErrorBound 5 mm;set tank_ballast_and_trim_backseat.BuoyEstimationErrorBound 25 cc;run" ASAP 2021-06-29T19:53:51.647Z,1624996431.647 [CommandLine](IMPORTANT): got command load ./Missions/Maintenance/tank_ballast_and_trim_backseat.xml 2021-06-29T19:53:51.648Z,1624996431.648 [MissionManager](INFO): Loading Mission: ./Missions/Maintenance/tank_ballast_and_trim_backseat.xml 2021-06-29T19:53:51.706Z,1624996431.706 [MissionManager](INFO): DefineArg tank_ballast_and_trim_backseat.MissionTimeout = 120.000000 min 2021-06-29T19:53:51.708Z,1624996431.708 [MissionManager](INFO): DefineArg tank_ballast_and_trim_backseat.SkipComms = 0 bool 2021-06-29T19:53:51.711Z,1624996431.711 [MissionManager](INFO): DefineArg tank_ballast_and_trim_backseat.Depth1 = 7.000000 m 2021-06-29T19:53:51.728Z,1624996431.728 [MissionManager](INFO): DefineArg tank_ballast_and_trim_backseat.Depth2 = nan m 2021-06-29T19:53:51.730Z,1624996431.730 [MissionManager](INFO): DefineArg tank_ballast_and_trim_backseat.DepthDeadband = 0.100000 m 2021-06-29T19:53:51.733Z,1624996431.733 [MissionManager](INFO): DefineArg tank_ballast_and_trim_backseat.SurfaceThreshold = 2.500000 m 2021-06-29T19:53:51.735Z,1624996431.735 [MissionManager](INFO): DefineArg tank_ballast_and_trim_backseat.MaxWaitOnSurface = 20.000000 min 2021-06-29T19:53:51.738Z,1624996431.738 [MissionManager](INFO): DefineArg tank_ballast_and_trim_backseat.SettleTime = 10.000000 min 2021-06-29T19:53:51.740Z,1624996431.740 [MissionManager](INFO): DefineArg tank_ballast_and_trim_backseat.EstimationTimeout = 45.000000 min 2021-06-29T19:53:51.742Z,1624996431.742 [MissionManager](INFO): DefineArg tank_ballast_and_trim_backseat.MinEstimationTime = 10.000000 min 2021-06-29T19:53:51.745Z,1624996431.745 [MissionManager](INFO): DefineArg tank_ballast_and_trim_backseat.MassEstimationErrorBound = 0.250000 mm 2021-06-29T19:53:51.747Z,1624996431.747 [MissionManager](INFO): DefineArg tank_ballast_and_trim_backseat.BuoyEstimationErrorBound = 15.000000 cc 2021-06-29T19:53:51.750Z,1624996431.750 [MissionManager](INFO): DefineArg tank_ballast_and_trim_backseat.EstimationConfidence = 99.900000 % 2021-06-29T19:53:51.752Z,1624996431.752 [MissionManager](INFO): DefineArg tank_ballast_and_trim_backseat.WaitToFloat = 5.000000 min 2021-06-29T19:53:51.752Z,1624996431.752 [MissionManager](INFO): Inserting Stack: Missions/Insert/Science.xml 2021-06-29T19:53:52.064Z,1624996432.064 [MissionManager](INFO): DefineArg tank_ballast_and_trim_backseat:Science.PeakDetectChlActive = 0 bool 2021-06-29T19:53:52.066Z,1624996432.066 [MissionManager](INFO): DefineArg tank_ballast_and_trim_backseat:Science.TimeWindowPeakReport = nan min 2021-06-29T19:53:52.068Z,1624996432.068 [MissionManager](INFO): DefineArg tank_ballast_and_trim_backseat:Science.HighestChlPeakReportActive = 0 bool 2021-06-29T19:53:52.070Z,1624996432.070 [MissionManager](INFO): DefineArg tank_ballast_and_trim_backseat:Science.HighestSaltPeakReportActive = 0 bool 2021-06-29T19:53:52.073Z,1624996432.073 [MissionManager](INFO): DefineArg tank_ballast_and_trim_backseat:Science.HighestOilPeakReportActive = 0 bool 2021-06-29T19:53:52.075Z,1624996432.075 [MissionManager](INFO): DefineArg tank_ballast_and_trim_backseat:Science.PatchTracking = 0 bool 2021-06-29T19:53:52.077Z,1624996432.077 [MissionManager](INFO): DefineArg tank_ballast_and_trim_backseat:Science.FilterWidthHorizontal = 3.000000 count 2021-06-29T19:53:52.080Z,1624996432.080 [MissionManager](INFO): DefineArg tank_ballast_and_trim_backseat:Science.NumProfilesSlidingwindow = 100.000000 count 2021-06-29T19:53:52.082Z,1624996432.082 [MissionManager](INFO): DefineArg tank_ballast_and_trim_backseat:Science.OffPeakFractionHorizontal = 80.000000 % 2021-06-29T19:53:52.084Z,1624996432.084 [MissionManager](INFO): DefineArg tank_ballast_and_trim_backseat:Science.PeakDetectNO3Active = 0 bool 2021-06-29T19:53:52.086Z,1624996432.086 [MissionManager](INFO): DefineArg tank_ballast_and_trim_backseat:Science.PeakDetectOilActive = 0 bool 2021-06-29T19:53:52.088Z,1624996432.088 [MissionManager](INFO): DefineArg tank_ballast_and_trim_backseat:Science.PeakDetectFDOMActive = 0 bool 2021-06-29T19:53:52.090Z,1624996432.090 [MissionManager](INFO): DefineArg tank_ballast_and_trim_backseat:Science.PeakDetectSalinityActive = 0 bool 2021-06-29T19:53:52.092Z,1624996432.092 [MissionManager](INFO): DefineArg tank_ballast_and_trim_backseat:Science.UpwardDerivativeOfTemperatureActive = 0 bool 2021-06-29T19:53:52.123Z,1624996432.123 [MissionManager](INFO): DefineArg tank_ballast_and_trim_backseat:Science.EnabledAanderaaO2 = 0.000000 bool 2021-06-29T19:53:52.126Z,1624996432.126 [MissionManager](INFO): DefineArg tank_ballast_and_trim_backseat:Science.EnabledNeilBrown = 0.000000 bool 2021-06-29T19:53:52.129Z,1624996432.129 [MissionManager](INFO): DefineArg tank_ballast_and_trim_backseat:Science.EnabledSeabird = 1.000000 bool 2021-06-29T19:53:52.132Z,1624996432.132 [MissionManager](INFO): DefineArg tank_ballast_and_trim_backseat:Science.EnabledWetLabsBB2FL = 1.000000 bool 2021-06-29T19:53:52.134Z,1624996432.134 [MissionManager](INFO): DefineArg tank_ballast_and_trim_backseat:Science.EnabledWetLabsSeaOWL_UV_A = 0.000000 bool 2021-06-29T19:53:52.148Z,1624996432.148 [MissionManager](INFO): DefineArg tank_ballast_and_trim_backseat:Science.EnabledWetLabsUBAT = 0.000000 bool 2021-06-29T19:53:52.150Z,1624996432.150 [MissionManager](INFO): DefineArg tank_ballast_and_trim_backseat:Science.LowPassWindowLength = 20.000000 count 2021-06-29T19:53:52.153Z,1624996432.153 [MissionManager](INFO): DefineArg tank_ballast_and_trim_backseat:Science.MedianFilterLen = 5.000000 count 2021-06-29T19:53:52.170Z,1624996432.170 [MissionManager](INFO): DefineArg tank_ballast_and_trim_backseat:Science.PeakShallowBound = nan m 2021-06-29T19:53:52.173Z,1624996432.173 [MissionManager](INFO): DefineArg tank_ballast_and_trim_backseat:Science.PeakDeepBound = nan m 2021-06-29T19:53:52.175Z,1624996432.175 [MissionManager](INFO): DefineArg tank_ballast_and_trim_backseat:Science.DepChangeThreshForAttitudeFlip = 2.000000 m 2021-06-29T19:53:52.178Z,1624996432.178 [MissionManager](INFO): DefineOutput tank_ballast_and_trim_backseat:Science.PeakChl = 0.000000 ug/l 2021-06-29T19:53:52.224Z,1624996432.224 [MissionManager](INFO): DefineOutput tank_ballast_and_trim_backseat:Science.PeakChlDepth = 0.000000 m 2021-06-29T19:53:52.231Z,1624996432.231 [MissionManager](INFO): DefineOutput tank_ballast_and_trim_backseat:Science.PeakChlTemperature = 0.000000 degC 2021-06-29T19:53:52.234Z,1624996432.234 [MissionManager](INFO): DefineOutput tank_ballast_and_trim_backseat:Science.PeakChlLatitude = nan arcdeg 2021-06-29T19:53:52.241Z,1624996432.241 [MissionManager](INFO): DefineOutput tank_ballast_and_trim_backseat:Science.PeakChlLongitude = nan arcdeg 2021-06-29T19:53:52.248Z,1624996432.248 [MissionManager](INFO): DefineOutput tank_ballast_and_trim_backseat:Science.PeakNO3 = 0.000000 umol/l 2021-06-29T19:53:52.250Z,1624996432.250 [MissionManager](INFO): DefineOutput tank_ballast_and_trim_backseat:Science.PeakNO3Depth = 0.000000 m 2021-06-29T19:53:52.257Z,1624996432.257 [MissionManager](INFO): DefineOutput tank_ballast_and_trim_backseat:Science.PeakNO3Latitude = nan arcdeg 2021-06-29T19:53:52.264Z,1624996432.264 [MissionManager](INFO): DefineOutput tank_ballast_and_trim_backseat:Science.PeakNO3Longitude = nan arcdeg 2021-06-29T19:53:52.266Z,1624996432.266 [MissionManager](INFO): DefineOutput tank_ballast_and_trim_backseat:Science.PeakOil = 0.000000 kg/m3 2021-06-29T19:53:52.273Z,1624996432.273 [MissionManager](INFO): DefineOutput tank_ballast_and_trim_backseat:Science.PeakOilDepth = 0.000000 m 2021-06-29T19:53:52.280Z,1624996432.280 [MissionManager](INFO): DefineOutput tank_ballast_and_trim_backseat:Science.PeakOilLatitude = nan arcdeg 2021-06-29T19:53:52.282Z,1624996432.282 [MissionManager](INFO): DefineOutput tank_ballast_and_trim_backseat:Science.PeakOilLongitude = nan arcdeg 2021-06-29T19:53:52.293Z,1624996432.293 [MissionManager](INFO): DefineOutput tank_ballast_and_trim_backseat:Science.PeakFDOM = 0.000000 ppb 2021-06-29T19:53:52.300Z,1624996432.300 [MissionManager](INFO): DefineOutput tank_ballast_and_trim_backseat:Science.PeakFDOMDepth = 0.000000 m 2021-06-29T19:53:52.302Z,1624996432.302 [MissionManager](INFO): DefineOutput tank_ballast_and_trim_backseat:Science.PeakFDOMTemperature = nan degC 2021-06-29T19:53:52.309Z,1624996432.309 [MissionManager](INFO): DefineOutput tank_ballast_and_trim_backseat:Science.PeakFDOMLatitude = nan arcdeg 2021-06-29T19:53:52.320Z,1624996432.320 [MissionManager](INFO): DefineOutput tank_ballast_and_trim_backseat:Science.PeakFDOMLongitude = nan arcdeg 2021-06-29T19:53:52.322Z,1624996432.322 [MissionManager](INFO): DefineOutput tank_ballast_and_trim_backseat:Science.PatchFDOMDistance = nan m 2021-06-29T19:53:52.329Z,1624996432.329 [MissionManager](INFO): DefineOutput tank_ballast_and_trim_backseat:Science.PeakSalt = 0.000000 psu 2021-06-29T19:53:52.336Z,1624996432.336 [MissionManager](INFO): DefineOutput tank_ballast_and_trim_backseat:Science.PeakSaltDepth = 0.000000 m 2021-06-29T19:53:52.338Z,1624996432.338 [MissionManager](INFO): DefineOutput tank_ballast_and_trim_backseat:Science.PeakSaltTemperature = 0.000000 degC 2021-06-29T19:53:52.357Z,1624996432.357 [MissionManager](INFO): DefineOutput tank_ballast_and_trim_backseat:Science.PeakSaltLatitude = nan arcdeg 2021-06-29T19:53:52.364Z,1624996432.364 [MissionManager](INFO): DefineOutput tank_ballast_and_trim_backseat:Science.PeakSaltLongitude = nan arcdeg 2021-06-29T19:53:52.368Z,1624996432.368 [MissionManager](INFO): DefineOutput tank_ballast_and_trim_backseat:Science.PatchChl = 0.000000 ug/l 2021-06-29T19:53:52.374Z,1624996432.374 [MissionManager](INFO): DefineOutput tank_ballast_and_trim_backseat:Science.PatchChlDepth = 0.000000 m 2021-06-29T19:53:52.389Z,1624996432.389 [MissionManager](INFO): DefineOutput tank_ballast_and_trim_backseat:Science.PatchChlLatitude = nan arcdeg 2021-06-29T19:53:52.391Z,1624996432.391 [MissionManager](INFO): DefineOutput tank_ballast_and_trim_backseat:Science.PatchChlLongitude = nan arcdeg 2021-06-29T19:53:52.394Z,1624996432.394 [MissionManager](INFO): DefineOutput tank_ballast_and_trim_backseat:Science.PatchChlDistance = nan m 2021-06-29T19:53:52.397Z,1624996432.397 [MissionManager](INFO): DefineOutput tank_ballast_and_trim_backseat:Science.PatchSalt = 0.000000 psu 2021-06-29T19:53:52.399Z,1624996432.399 [MissionManager](INFO): DefineOutput tank_ballast_and_trim_backseat:Science.PatchSaltDepth = 0.000000 m 2021-06-29T19:53:52.402Z,1624996432.402 [MissionManager](INFO): DefineOutput tank_ballast_and_trim_backseat:Science.PatchSaltLatitude = nan arcdeg 2021-06-29T19:53:52.404Z,1624996432.404 [MissionManager](INFO): DefineOutput tank_ballast_and_trim_backseat:Science.PatchSaltLongitude = nan arcdeg 2021-06-29T19:53:52.430Z,1624996432.430 [MissionManager](INFO): DefineOutput tank_ballast_and_trim_backseat:Science.PatchSaltDistance = nan m 2021-06-29T19:53:52.432Z,1624996432.432 [MissionManager](INFO): DefineOutput tank_ballast_and_trim_backseat:Science.PatchOil = 0.000000 psu 2021-06-29T19:53:52.435Z,1624996432.435 [MissionManager](INFO): DefineOutput tank_ballast_and_trim_backseat:Science.PatchOilDepth = 0.000000 m 2021-06-29T19:53:52.437Z,1624996432.437 [MissionManager](INFO): DefineOutput tank_ballast_and_trim_backseat:Science.PatchOilLatitude = nan arcdeg 2021-06-29T19:53:52.456Z,1624996432.456 [MissionManager](INFO): DefineOutput tank_ballast_and_trim_backseat:Science.PatchOilLongitude = nan arcdeg 2021-06-29T19:53:52.459Z,1624996432.459 [MissionManager](INFO): DefineOutput tank_ballast_and_trim_backseat:Science.PatchOilDistance = nan m 2021-06-29T19:53:52.488Z,1624996432.488 [tank_ballast_and_trim_backseat:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2021-06-29T19:53:52.532Z,1624996432.532 [tank_ballast_and_trim_backseat:Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal. 2021-06-29T19:53:52.568Z,1624996432.568 [tank_ballast_and_trim_backseat:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2021-06-29T19:53:52.623Z,1624996432.623 [tank_ballast_and_trim_backseat:Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2021-06-29T19:53:52.654Z,1624996432.654 [tank_ballast_and_trim_backseat:Science:HighestOilPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal. 2021-06-29T19:53:52.684Z,1624996432.684 [tank_ballast_and_trim_backseat:Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2021-06-29T19:53:52.709Z,1624996432.709 [tank_ballast_and_trim_backseat:Science:PeakDetectSalinity:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2021-06-29T19:53:52.758Z,1624996432.758 [tank_ballast_and_trim_backseat:Science:HighestSaltPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal. 2021-06-29T19:53:52.795Z,1624996432.795 [tank_ballast_and_trim_backseat:RunBallastAndTrim:B.BackseatDriver](DEBUG): Construct BackseatDriver. 2021-06-29T19:53:52.797Z,1624996432.797 [MissionManager](INFO): Inserting Stack: Missions/Insert/BallastAndTrim.xml 2021-06-29T19:53:52.913Z,1624996432.913 [MissionManager](INFO): DefineArg tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim.InsertDepth = 25.000000 m 2021-06-29T19:53:52.915Z,1624996432.915 [MissionManager](INFO): DefineArg tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim.InsertApproachSpeed = 0.000000 m/s 2021-06-29T19:53:52.917Z,1624996432.917 [MissionManager](INFO): DefineArg tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim.InsertApproachDepthRate = 0.400000 m/s 2021-06-29T19:53:52.920Z,1624996432.920 [MissionManager](INFO): DefineArg tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim.InsertApproachPitchLimit = 20.000000 arcdeg 2021-06-29T19:53:52.922Z,1624996432.922 [MissionManager](INFO): DefineArg tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim.InsertApproachSettleTimePreDive = 0.000000 min 2021-06-29T19:53:52.925Z,1624996432.925 [MissionManager](INFO): DefineArg tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim.InsertApproachDepthTimeout = 20.000000 min 2021-06-29T19:53:52.927Z,1624996432.927 [MissionManager](INFO): DefineArg tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim.InsertSettleTime = 10.000000 min 2021-06-29T19:53:52.930Z,1624996432.930 [MissionManager](INFO): DefineArg tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim.EstTimeout = 45.000000 min 2021-06-29T19:53:52.954Z,1624996432.954 [MissionManager](INFO): DefineArg tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim.MinEstTime = 10.000000 min 2021-06-29T19:53:52.956Z,1624996432.956 [MissionManager](INFO): DefineArg tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim.MassEstErrorBound = 0.250000 mm 2021-06-29T19:53:52.959Z,1624996432.959 [MissionManager](INFO): DefineArg tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim.BuoyEstErrorBound = 15.000000 cc 2021-06-29T19:53:52.961Z,1624996432.961 [MissionManager](INFO): DefineArg tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim.EstConfidence = 99.900000 % 2021-06-29T19:53:52.979Z,1624996432.979 [MissionManager](INFO): DefineArg tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim.InsertDepthDeadband = 1.000000 m 2021-06-29T19:53:52.981Z,1624996432.981 [MissionManager](INFO): DefineArg tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim.InsertKiDepthBuoy = 0.300000 1/s 2021-06-29T19:53:52.984Z,1624996432.984 [MissionManager](INFO): DefineArg tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim.InsertMassDeadband = 0.250000 mm 2021-06-29T19:53:53.056Z,1624996433.056 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ActuatorHold:A.Point](DEBUG): Construct. 2021-06-29T19:53:53.062Z,1624996433.062 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ActuatorHold:B.Buoyancy](DEBUG): Construct Buoyancy. 2021-06-29T19:53:53.085Z,1624996433.085 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ActuatorHold:C.Pitch](DEBUG): Construct. 2021-06-29T19:53:53.093Z,1624996433.093 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:WaitPreDive:B.Wait](DEBUG): Construct Wait. 2021-06-29T19:53:53.096Z,1624996433.096 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ApproachDepth:B.SetSpeed](DEBUG): Construct. 2021-06-29T19:53:53.099Z,1624996433.099 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ApproachDepth:C.Pitch](DEBUG): Construct. 2021-06-29T19:53:53.117Z,1624996433.117 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ApproachDepth:C.Pitch:A_Timeout:B.Execute](DEBUG): Construct Execute. 2021-06-29T19:53:53.121Z,1624996433.121 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:BallastAndTrimAtTargetDepth:A.SetSpeed](DEBUG): Construct. 2021-06-29T19:53:53.124Z,1624996433.124 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:BallastAndTrimAtTargetDepth:B.Pitch](DEBUG): Construct. 2021-06-29T19:53:53.144Z,1624996433.144 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:BallastAndTrimAtTargetDepth:D.Wait](DEBUG): Construct Wait. 2021-06-29T19:53:53.148Z,1624996433.148 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:BallastAndTrimAtTargetDepth:F.](DEBUG): Construct BallastAndTrim. 2021-06-29T19:53:53.190Z,1624996433.190 [MissionManager](INFO): RedefineArg tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim.InsertDepthDeadband = reader:tank_ballast_and_trim_backseat.DepthDeadband 2021-06-29T19:53:53.192Z,1624996433.192 [MissionManager](INFO): RedefineArg tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim.InsertApproachDepthTimeout = reader:tank_ballast_and_trim_backseat.MaxWaitOnSurface 2021-06-29T19:53:53.194Z,1624996433.194 [MissionManager](INFO): RedefineArg tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim.InsertSettleTime = reader:tank_ballast_and_trim_backseat.SettleTime 2021-06-29T19:53:53.195Z,1624996433.195 [MissionManager](INFO): RedefineArg tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim.EstTimeout = reader:tank_ballast_and_trim_backseat.EstimationTimeout 2021-06-29T19:53:53.197Z,1624996433.197 [MissionManager](INFO): RedefineArg tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim.MinEstTime = reader:tank_ballast_and_trim_backseat.MinEstimationTime 2021-06-29T19:53:53.198Z,1624996433.198 [MissionManager](INFO): RedefineArg tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim.MassEstErrorBound = reader:tank_ballast_and_trim_backseat.MassEstimationErrorBound 2021-06-29T19:53:53.212Z,1624996433.212 [MissionManager](INFO): RedefineArg tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim.BuoyEstErrorBound = reader:tank_ballast_and_trim_backseat.BuoyEstimationErrorBound 2021-06-29T19:53:53.214Z,1624996433.214 [MissionManager](INFO): RedefineArg tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim.EstConfidence = reader:tank_ballast_and_trim_backseat.EstimationConfidence 2021-06-29T19:53:53.253Z,1624996433.253 [tank_ballast_and_trim_backseat:Float_Up:A.Buoyancy](DEBUG): Construct Buoyancy. 2021-06-29T19:53:53.256Z,1624996433.256 [tank_ballast_and_trim_backseat:Float_Up:B.Wait](DEBUG): Construct Wait. 2021-06-29T19:53:53.292Z,1624996433.292 [MissionManager](DEBUG): Maximum duration of mission 120 Skip communications at start of mission. 7 NaN How much vertical drift from the specified depth is allowed durnig the mission. 0.1 Surface threshold depth. 2.5 Maximum wait time for the vehicle to go under the surface (i.e., reach the surface threshold depth). 20 How long to wait after reaching target depth before starting ballast and trim. 10 Timeout for ballast and trim estimation. 45 Minimum time to run ballast and trim estimation before determining convergence (must be shorter than timeout). 10 Desired range of the estimated sample mean from the true mean statistic (smaller values take longer to converge). 0.25 Desired range of the estimated sample mean from the true mean statistic (smaller values take longer to converge). 15 Confidence level that the estimator has reached the desired error range (larger values take longer to converge). 99.9 5 Powering up backseat... Backseat powered. Float to surface instead of driving. 2021-06-29T19:53:53.293Z,1624996433.293 [CommandLine](IMPORTANT): Loaded ./Missions/Maintenance/tank_ballast_and_trim_backseat.xml 2021-06-29T19:54:02.801Z,1624996442.801 [CommandLine](IMPORTANT): got command set tank_ballast_and_trim_backseat.MissionTimeout 40.000000 minute 2021-06-29T19:54:02.802Z,1624996442.802 [CommandLine](IMPORTANT): got command set tank_ballast_and_trim_backseat.SettleTime 5.000000 minute 2021-06-29T19:54:02.803Z,1624996442.803 [CommandLine](IMPORTANT): got command set tank_ballast_and_trim_backseat.EstimationTimeout 30.000000 minute 2021-06-29T19:54:10.763Z,1624996450.763 [CommandLine](IMPORTANT): got command set tank_ballast_and_trim_backseat.MassEstimationErrorBound 5.000000 millimeter 2021-06-29T19:54:10.764Z,1624996450.764 [CommandLine](IMPORTANT): got command set tank_ballast_and_trim_backseat.BuoyEstimationErrorBound 25.000000 cubic_centimeter 2021-06-29T19:54:10.765Z,1624996450.765 [CommandLine](IMPORTANT): got command run 2021-06-29T19:54:10.766Z,1624996450.766 [CommandLine](IMPORTANT): Running 2021-06-29T19:54:10.800Z,1624996450.800 [Default] Stopped 2021-06-29T19:54:10.801Z,1624996450.801 [Default](DEBUG): Aggregate::uninitialize Default 2021-06-29T19:54:10.801Z,1624996450.801 [Default:B.GoToSurface] Stopped 2021-06-29T19:54:10.801Z,1624996450.801 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2021-06-29T19:54:10.801Z,1624996450.801 [Default:CheckIn] Stopped 2021-06-29T19:54:10.801Z,1624996450.801 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-06-29T19:54:10.801Z,1624996450.801 [Default:CheckIn:C.Wait] Stopped 2021-06-29T19:54:10.801Z,1624996450.801 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-06-29T19:54:10.801Z,1624996450.801 [MissionManager](IMPORTANT): Started mission tank_ballast_and_trim_backseat 2021-06-29T19:54:10.802Z,1624996450.802 [tank_ballast_and_trim_backseat] Running Loop=1 2021-06-29T19:54:10.802Z,1624996450.802 [tank_ballast_and_trim_backseat](DEBUG): Aggregate::initialize tank_ballast_and_trim_backseat 2021-06-29T19:54:10.802Z,1624996450.802 [tank_ballast_and_trim_backseat:Science] Running Loop=1 2021-06-29T19:54:10.802Z,1624996450.802 [tank_ballast_and_trim_backseat:Science](DEBUG): Aggregate::initialize tank_ballast_and_trim_backseat:Science 2021-06-29T19:54:10.802Z,1624996450.802 [tank_ballast_and_trim_backseat:Science:A] Running Loop=1 2021-06-29T19:54:10.802Z,1624996450.802 [tank_ballast_and_trim_backseat:Science:B] Running Loop=1 2021-06-29T19:54:10.802Z,1624996450.802 [tank_ballast_and_trim_backseat:Science:C] Running Loop=1 2021-06-29T19:54:10.802Z,1624996450.802 [tank_ballast_and_trim_backseat:Science:D] Running Loop=1 2021-06-29T19:54:10.803Z,1624996450.803 [tank_ballast_and_trim_backseat:Science:E] Running Loop=1 2021-06-29T19:54:10.803Z,1624996450.803 [tank_ballast_and_trim_backseat:Science:F] Running Loop=1 2021-06-29T19:54:10.803Z,1624996450.803 [tank_ballast_and_trim_backseat:Science:Read_Oil] Running Loop=1 2021-06-29T19:54:10.803Z,1624996450.803 [tank_ballast_and_trim_backseat:Science:PeakDetectChl] Running Loop=1 2021-06-29T19:54:10.803Z,1624996450.803 [tank_ballast_and_trim_backseat:Science:PeakDetectChl](DEBUG): Aggregate::initialize tank_ballast_and_trim_backseat:Science:PeakDetectChl 2021-06-29T19:54:10.803Z,1624996450.803 [tank_ballast_and_trim_backseat:Science:PeakDetectChl:A.PeakDetectVsDepth] Running Loop=1 2021-06-29T19:54:10.803Z,1624996450.803 [tank_ballast_and_trim_backseat:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Initialize. 2021-06-29T19:54:10.805Z,1624996450.805 [tank_ballast_and_trim_backseat:Science:HighestChlPeakReport] Running Loop=1 2021-06-29T19:54:10.805Z,1624996450.805 [tank_ballast_and_trim_backseat:Science:HighestChlPeakReport](DEBUG): Aggregate::initialize tank_ballast_and_trim_backseat:Science:HighestChlPeakReport 2021-06-29T19:54:10.805Z,1624996450.805 [tank_ballast_and_trim_backseat:Science:HighestChlPeakReport:A.PeakDetectHorizontal] Running Loop=1 2021-06-29T19:54:10.805Z,1624996450.805 [tank_ballast_and_trim_backseat:Science:HighestChlPeakReport:A.PeakDetectHorizontal](INFO): Initialize. 2021-06-29T19:54:10.806Z,1624996450.806 [tank_ballast_and_trim_backseat:Science:PeakDetectNO3] Running Loop=1 2021-06-29T19:54:10.806Z,1624996450.806 [tank_ballast_and_trim_backseat:Science:PeakDetectNO3](DEBUG): Aggregate::initialize tank_ballast_and_trim_backseat:Science:PeakDetectNO3 2021-06-29T19:54:10.806Z,1624996450.806 [tank_ballast_and_trim_backseat:Science:PeakDetectNO3:A.PeakDetectVsDepth] Running Loop=1 2021-06-29T19:54:10.806Z,1624996450.806 [tank_ballast_and_trim_backseat:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Initialize. 2021-06-29T19:54:10.808Z,1624996450.808 [tank_ballast_and_trim_backseat:Science:PeakDetectOil] Running Loop=1 2021-06-29T19:54:10.808Z,1624996450.808 [tank_ballast_and_trim_backseat:Science:PeakDetectOil](DEBUG): Aggregate::initialize tank_ballast_and_trim_backseat:Science:PeakDetectOil 2021-06-29T19:54:10.808Z,1624996450.808 [tank_ballast_and_trim_backseat:Science:PeakDetectOil:A.PeakDetectVsDepth] Running Loop=1 2021-06-29T19:54:10.808Z,1624996450.808 [tank_ballast_and_trim_backseat:Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Initialize. 2021-06-29T19:54:10.809Z,1624996450.809 [tank_ballast_and_trim_backseat:Science:HighestOilPeakReport] Running Loop=1 2021-06-29T19:54:10.809Z,1624996450.809 [tank_ballast_and_trim_backseat:Science:HighestOilPeakReport](DEBUG): Aggregate::initialize tank_ballast_and_trim_backseat:Science:HighestOilPeakReport 2021-06-29T19:54:10.809Z,1624996450.809 [tank_ballast_and_trim_backseat:Science:HighestOilPeakReport:A.PeakDetectHorizontal] Running Loop=1 2021-06-29T19:54:10.810Z,1624996450.810 [tank_ballast_and_trim_backseat:Science:HighestOilPeakReport:A.PeakDetectHorizontal](INFO): Initialize. 2021-06-29T19:54:10.810Z,1624996450.810 [tank_ballast_and_trim_backseat:Science:PeakDetectFDOM] Running Loop=1 2021-06-29T19:54:10.810Z,1624996450.810 [tank_ballast_and_trim_backseat:Science:PeakDetectFDOM](DEBUG): Aggregate::initialize tank_ballast_and_trim_backseat:Science:PeakDetectFDOM 2021-06-29T19:54:10.810Z,1624996450.810 [tank_ballast_and_trim_backseat:Science:PeakDetectFDOM:A.PeakDetectVsDepth] Running Loop=1 2021-06-29T19:54:10.810Z,1624996450.810 [tank_ballast_and_trim_backseat:Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Initialize. 2021-06-29T19:54:10.840Z,1624996450.840 [tank_ballast_and_trim_backseat:Science:PeakDetectSalinity] Running Loop=1 2021-06-29T19:54:10.840Z,1624996450.840 [tank_ballast_and_trim_backseat:Science:PeakDetectSalinity](DEBUG): Aggregate::initialize tank_ballast_and_trim_backseat:Science:PeakDetectSalinity 2021-06-29T19:54:10.840Z,1624996450.840 [tank_ballast_and_trim_backseat:Science:PeakDetectSalinity:A.PeakDetectVsDepth] Running Loop=1 2021-06-29T19:54:10.840Z,1624996450.840 [tank_ballast_and_trim_backseat:Science:PeakDetectSalinity:A.PeakDetectVsDepth](DEBUG): Initialize. 2021-06-29T19:54:10.842Z,1624996450.842 [tank_ballast_and_trim_backseat:Science:HighestSaltPeakReport] Running Loop=1 2021-06-29T19:54:10.842Z,1624996450.842 [tank_ballast_and_trim_backseat:Science:HighestSaltPeakReport](DEBUG): Aggregate::initialize tank_ballast_and_trim_backseat:Science:HighestSaltPeakReport 2021-06-29T19:54:10.842Z,1624996450.842 [tank_ballast_and_trim_backseat:Science:HighestSaltPeakReport:A.PeakDetectHorizontal] Running Loop=1 2021-06-29T19:54:10.842Z,1624996450.842 [tank_ballast_and_trim_backseat:Science:HighestSaltPeakReport:A.PeakDetectHorizontal](INFO): Initialize. 2021-06-29T19:54:10.843Z,1624996450.843 [tank_ballast_and_trim_backseat:Science:OceanCurrent] Running Loop=1 2021-06-29T19:54:10.843Z,1624996450.843 [tank_ballast_and_trim_backseat:Science:OceanCurrent](DEBUG): Aggregate::initialize tank_ballast_and_trim_backseat:Science:OceanCurrent 2021-06-29T19:54:10.843Z,1624996450.843 [tank_ballast_and_trim_backseat:Science:OceanCurrent:A.] Running Loop=1 2021-06-29T19:54:10.843Z,1624996450.843 [tank_ballast_and_trim_backseat:Science:OceanCurrent:A.](INFO): Initializing CurrentEstimator. 2021-06-29T19:54:10.844Z,1624996450.844 [tank_ballast_and_trim_backseat:RunBallastAndTrim] Running Loop=1 2021-06-29T19:54:10.844Z,1624996450.844 [tank_ballast_and_trim_backseat:RunBallastAndTrim](DEBUG): Aggregate::initialize tank_ballast_and_trim_backseat:RunBallastAndTrim 2021-06-29T19:54:10.844Z,1624996450.844 [tank_ballast_and_trim_backseat:RunBallastAndTrim:B.BackseatDriver] Running Loop=1 2021-06-29T19:54:10.844Z,1624996450.844 [tank_ballast_and_trim_backseat:RunBallastAndTrim:B.BackseatDriver](DEBUG): Initialize. 2021-06-29T19:54:10.885Z,1624996450.885 [tank_ballast_and_trim_backseat:RunBallastAndTrim:A] Running Loop=1 2021-06-29T19:54:10.886Z,1624996450.886 [tank_ballast_and_trim_backseat:RunBallastAndTrim:B.BackseatDriver] Running Loop=1 2021-06-29T19:54:10.891Z,1624996450.891 [BackseatComponent](INFO): Powering up 2021-06-29T19:54:10.892Z,1624996450.892 [BackseatComponent](INFO): Subscribing to LCM channels. 2021-06-29T19:54:10.911Z,1624996450.911 [tank_ballast_and_trim_backseat:RunBallastAndTrim:A](INFO): Powering up backseat... 2021-06-29T19:54:10.911Z,1624996450.911 [tank_ballast_and_trim_backseat:RunBallastAndTrim:A] Stopped 2021-06-29T19:54:10.911Z,1624996450.911 [tank_ballast_and_trim_backseat:RunBallastAndTrim:C] Running Loop=1 2021-06-29T19:54:10.912Z,1624996450.912 [tank_ballast_and_trim_backseat:Science] Running Loop=1 2021-06-29T19:54:10.913Z,1624996450.913 [tank_ballast_and_trim_backseat:Science:HighestSaltPeakReport] Stopped 2021-06-29T19:54:10.913Z,1624996450.913 [tank_ballast_and_trim_backseat:Science:HighestSaltPeakReport](DEBUG): Aggregate::uninitialize tank_ballast_and_trim_backseat:Science:HighestSaltPeakReport 2021-06-29T19:54:10.913Z,1624996450.913 [tank_ballast_and_trim_backseat:Science:HighestSaltPeakReport:A.PeakDetectHorizontal] Stopped 2021-06-29T19:54:10.913Z,1624996450.913 [tank_ballast_and_trim_backseat:Science:HighestSaltPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize. 2021-06-29T19:54:10.913Z,1624996450.913 [tank_ballast_and_trim_backseat:Science:PeakDetectSalinity] Stopped 2021-06-29T19:54:10.913Z,1624996450.913 [tank_ballast_and_trim_backseat:Science:PeakDetectSalinity](DEBUG): Aggregate::uninitialize tank_ballast_and_trim_backseat:Science:PeakDetectSalinity 2021-06-29T19:54:10.913Z,1624996450.913 [tank_ballast_and_trim_backseat:Science:PeakDetectSalinity:A.PeakDetectVsDepth] Stopped 2021-06-29T19:54:10.913Z,1624996450.913 [tank_ballast_and_trim_backseat:Science:PeakDetectSalinity:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2021-06-29T19:54:10.914Z,1624996450.914 [tank_ballast_and_trim_backseat:Science:PeakDetectFDOM] Stopped 2021-06-29T19:54:10.914Z,1624996450.914 [tank_ballast_and_trim_backseat:Science:PeakDetectFDOM](DEBUG): Aggregate::uninitialize tank_ballast_and_trim_backseat:Science:PeakDetectFDOM 2021-06-29T19:54:10.914Z,1624996450.914 [tank_ballast_and_trim_backseat:Science:PeakDetectFDOM:A.PeakDetectVsDepth] Stopped 2021-06-29T19:54:10.914Z,1624996450.914 [tank_ballast_and_trim_backseat:Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2021-06-29T19:54:10.914Z,1624996450.914 [tank_ballast_and_trim_backseat:Science:HighestOilPeakReport] Stopped 2021-06-29T19:54:10.914Z,1624996450.914 [tank_ballast_and_trim_backseat:Science:HighestOilPeakReport](DEBUG): Aggregate::uninitialize tank_ballast_and_trim_backseat:Science:HighestOilPeakReport 2021-06-29T19:54:10.914Z,1624996450.914 [tank_ballast_and_trim_backseat:Science:HighestOilPeakReport:A.PeakDetectHorizontal] Stopped 2021-06-29T19:54:10.914Z,1624996450.914 [tank_ballast_and_trim_backseat:Science:HighestOilPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize. 2021-06-29T19:54:10.914Z,1624996450.914 [tank_ballast_and_trim_backseat:Science:PeakDetectOil] Stopped 2021-06-29T19:54:10.914Z,1624996450.914 [tank_ballast_and_trim_backseat:Science:PeakDetectOil](DEBUG): Aggregate::uninitialize tank_ballast_and_trim_backseat:Science:PeakDetectOil 2021-06-29T19:54:10.915Z,1624996450.915 [tank_ballast_and_trim_backseat:Science:PeakDetectOil:A.PeakDetectVsDepth] Stopped 2021-06-29T19:54:10.915Z,1624996450.915 [tank_ballast_and_trim_backseat:Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2021-06-29T19:54:10.915Z,1624996450.915 [tank_ballast_and_trim_backseat:Science:PeakDetectNO3] Stopped 2021-06-29T19:54:10.915Z,1624996450.915 [tank_ballast_and_trim_backseat:Science:PeakDetectNO3](DEBUG): Aggregate::uninitialize tank_ballast_and_trim_backseat:Science:PeakDetectNO3 2021-06-29T19:54:10.915Z,1624996450.915 [tank_ballast_and_trim_backseat:Science:PeakDetectNO3:A.PeakDetectVsDepth] Stopped 2021-06-29T19:54:10.915Z,1624996450.915 [tank_ballast_and_trim_backseat:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2021-06-29T19:54:10.915Z,1624996450.915 [tank_ballast_and_trim_backseat:Science:HighestChlPeakReport] Stopped 2021-06-29T19:54:10.915Z,1624996450.915 [tank_ballast_and_trim_backseat:Science:HighestChlPeakReport](DEBUG): Aggregate::uninitialize tank_ballast_and_trim_backseat:Science:HighestChlPeakReport 2021-06-29T19:54:10.915Z,1624996450.915 [tank_ballast_and_trim_backseat:Science:HighestChlPeakReport:A.PeakDetectHorizontal] Stopped 2021-06-29T19:54:10.916Z,1624996450.916 [tank_ballast_and_trim_backseat:Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize. 2021-06-29T19:54:10.916Z,1624996450.916 [tank_ballast_and_trim_backseat:Science:PeakDetectChl] Stopped 2021-06-29T19:54:10.916Z,1624996450.916 [tank_ballast_and_trim_backseat:Science:PeakDetectChl](DEBUG): Aggregate::uninitialize tank_ballast_and_trim_backseat:Science:PeakDetectChl 2021-06-29T19:54:10.916Z,1624996450.916 [tank_ballast_and_trim_backseat:Science:PeakDetectChl:A.PeakDetectVsDepth] Stopped 2021-06-29T19:54:10.916Z,1624996450.916 [tank_ballast_and_trim_backseat:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2021-06-29T19:54:10.916Z,1624996450.916 [tank_ballast_and_trim_backseat:Science:OceanCurrent:A.] Running Loop=1 2021-06-29T19:54:10.916Z,1624996450.916 [tank_ballast_and_trim_backseat:Science:Read_Oil] Stopped 2021-06-29T19:54:10.916Z,1624996450.916 [tank_ballast_and_trim_backseat:Science:F] Stopped 2021-06-29T19:54:10.917Z,1624996450.917 [tank_ballast_and_trim_backseat:Science:E] Running Loop=1 2021-06-29T19:54:10.917Z,1624996450.917 [tank_ballast_and_trim_backseat:Science:E](DEBUG): Initialize ReadDataComponent to sense mass_concentration_of_chlorophyll_in_sea_water 2021-06-29T19:54:10.917Z,1624996450.917 [tank_ballast_and_trim_backseat:Science:D] Stopped 2021-06-29T19:54:10.917Z,1624996450.917 [tank_ballast_and_trim_backseat:Science:C] Running Loop=1 2021-06-29T19:54:10.918Z,1624996450.918 [tank_ballast_and_trim_backseat:Science:C](DEBUG): Initialize ReadDataComponent to sense CTD_Seabird.sea_water_temperature 2021-06-29T19:54:10.918Z,1624996450.918 [tank_ballast_and_trim_backseat:Science:C](DEBUG): Initialize ReadDataComponent to sense CTD_Seabird.sea_water_salinity 2021-06-29T19:54:10.918Z,1624996450.918 [tank_ballast_and_trim_backseat:Science:B] Running Loop=1 2021-06-29T19:54:10.919Z,1624996450.919 [tank_ballast_and_trim_backseat:Science:B](DEBUG): Initialize ReadDataComponent to sense sea_water_temperature 2021-06-29T19:54:10.920Z,1624996450.920 [tank_ballast_and_trim_backseat:Science:B](DEBUG): Initialize ReadDataComponent to sense sea_water_salinity 2021-06-29T19:54:10.920Z,1624996450.920 [tank_ballast_and_trim_backseat:Science:A] Stopped 2021-06-29T19:54:11.205Z,1624996451.205 [tank_ballast_and_trim_backseat:RunBallastAndTrim:C](INFO): Backseat powered. 2021-06-29T19:54:11.205Z,1624996451.205 [tank_ballast_and_trim_backseat:RunBallastAndTrim:C] Stopped 2021-06-29T19:54:11.205Z,1624996451.205 [tank_ballast_and_trim_backseat:RunBallastAndTrim:Depth1] Running Loop=1 2021-06-29T19:54:11.205Z,1624996451.205 [tank_ballast_and_trim_backseat:RunBallastAndTrim:Depth1](DEBUG): Aggregate::initialize tank_ballast_and_trim_backseat:RunBallastAndTrim:Depth1 2021-06-29T19:54:11.205Z,1624996451.205 [tank_ballast_and_trim_backseat:RunBallastAndTrim:Depth1:A] Running Loop=1 2021-06-29T19:54:11.288Z,1624996451.288 [WetLabsBB2FL](INFO): Powering up 2021-06-29T19:54:11.602Z,1624996451.602 [tank_ballast_and_trim_backseat:RunBallastAndTrim:Depth1:A] Stopped 2021-06-29T19:54:11.602Z,1624996451.602 [tank_ballast_and_trim_backseat:RunBallastAndTrim:Depth1:B] Running Loop=1 2021-06-29T19:54:11.602Z,1624996451.602 [tank_ballast_and_trim_backseat:RunBallastAndTrim:Depth1:B](DEBUG): Aggregate::initialize tank_ballast_and_trim_backseat:RunBallastAndTrim:Depth1:B 2021-06-29T19:54:12.004Z,1624996452.004 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim] Running Loop=1 2021-06-29T19:54:12.004Z,1624996452.004 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim](DEBUG): Aggregate::initialize tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim 2021-06-29T19:54:12.004Z,1624996452.004 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:A] Running Loop=1 2021-06-29T19:54:12.004Z,1624996452.004 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:B] Running Loop=1 2021-06-29T19:54:12.004Z,1624996452.004 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:C] Running Loop=1 2021-06-29T19:54:12.004Z,1624996452.004 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:D] Running Loop=1 2021-06-29T19:54:12.004Z,1624996452.004 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:E] Running Loop=1 2021-06-29T19:54:12.005Z,1624996452.005 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:F] Running Loop=1 2021-06-29T19:54:12.005Z,1624996452.005 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:G] Running Loop=1 2021-06-29T19:54:12.007Z,1624996452.007 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:G](INFO): Going to target depth. Speed set to 0.000000 m/s 2021-06-29T19:54:12.007Z,1624996452.007 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:G] Stopped 2021-06-29T19:54:12.008Z,1624996452.008 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth] Running Loop=1 2021-06-29T19:54:12.008Z,1624996452.008 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth](DEBUG): Aggregate::initialize tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth 2021-06-29T19:54:12.008Z,1624996452.008 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:A] Running Loop=1 2021-06-29T19:54:12.008Z,1624996452.008 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ActuatorHold] Running Loop=1 2021-06-29T19:54:12.008Z,1624996452.008 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ActuatorHold](DEBUG): Aggregate::initialize tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ActuatorHold 2021-06-29T19:54:12.008Z,1624996452.008 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ActuatorHold:A.Point] Running Loop=1 2021-06-29T19:54:12.008Z,1624996452.008 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ActuatorHold:A.Point](DEBUG): Initialize. 2021-06-29T19:54:12.008Z,1624996452.008 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ActuatorHold:B.Buoyancy] Running Loop=1 2021-06-29T19:54:12.008Z,1624996452.008 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ActuatorHold:B.Buoyancy](DEBUG): Initialize Buoyancy Component. 2021-06-29T19:54:12.009Z,1624996452.009 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ActuatorHold:C.Pitch] Running Loop=1 2021-06-29T19:54:12.009Z,1624996452.009 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ActuatorHold:C.Pitch](DEBUG): Initialize. 2021-06-29T19:54:12.009Z,1624996452.009 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:WaitPreDive] Running Loop=1 2021-06-29T19:54:12.009Z,1624996452.009 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:WaitPreDive](DEBUG): Aggregate::initialize tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:WaitPreDive 2021-06-29T19:54:12.009Z,1624996452.009 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:WaitPreDive:A] Running Loop=1 2021-06-29T19:54:12.009Z,1624996452.009 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:F] Running Loop=1 2021-06-29T19:54:12.010Z,1624996452.010 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:E] Running Loop=1 2021-06-29T19:54:12.010Z,1624996452.010 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:D] Running Loop=1 2021-06-29T19:54:12.010Z,1624996452.010 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:C] Running Loop=1 2021-06-29T19:54:12.010Z,1624996452.010 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:B] Running Loop=1 2021-06-29T19:54:12.011Z,1624996452.011 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:A] Running Loop=1 2021-06-29T19:54:12.406Z,1624996452.406 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:WaitPreDive] Stopped 2021-06-29T19:54:12.407Z,1624996452.407 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:WaitPreDive](DEBUG): Aggregate::uninitialize tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:WaitPreDive 2021-06-29T19:54:12.407Z,1624996452.407 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:WaitPreDive:A] Stopped 2021-06-29T19:54:12.407Z,1624996452.407 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ApproachDepth] Running Loop=1 2021-06-29T19:54:12.407Z,1624996452.407 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ApproachDepth](DEBUG): Aggregate::initialize tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ApproachDepth 2021-06-29T19:54:12.407Z,1624996452.407 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ApproachDepth:B.SetSpeed] Running Loop=1 2021-06-29T19:54:12.407Z,1624996452.407 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ApproachDepth:B.SetSpeed](DEBUG): Initialize. 2021-06-29T19:54:12.407Z,1624996452.407 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ApproachDepth:A] Running Loop=1 2021-06-29T19:54:12.408Z,1624996452.408 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ActuatorHold] Stopped 2021-06-29T19:54:12.408Z,1624996452.408 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ActuatorHold](DEBUG): Aggregate::uninitialize tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ActuatorHold 2021-06-29T19:54:12.408Z,1624996452.408 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ActuatorHold:A.Point] Stopped 2021-06-29T19:54:12.408Z,1624996452.408 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ActuatorHold:B.Buoyancy] Stopped 2021-06-29T19:54:12.408Z,1624996452.408 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ActuatorHold:B.Buoyancy](DEBUG): Uninitialize Buoyancy Component. 2021-06-29T19:54:12.408Z,1624996452.408 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ActuatorHold:C.Pitch] Stopped 2021-06-29T19:54:12.408Z,1624996452.408 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:A] Running Loop=1 2021-06-29T19:54:12.817Z,1624996452.817 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ApproachDepth:B.SetSpeed] Running Loop=1 2021-06-29T19:54:12.818Z,1624996452.818 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ApproachDepth:A](INFO): Moving to 7.000000 m 2021-06-29T19:54:12.818Z,1624996452.818 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ApproachDepth:A] Stopped 2021-06-29T19:54:12.818Z,1624996452.818 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ApproachDepth:C.Pitch] Running Loop=1 2021-06-29T19:54:12.819Z,1624996452.819 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ApproachDepth:C.Pitch](DEBUG): Initialize. 2021-06-29T19:54:13.936Z,1624996453.936 [CTD_Seabird](ERROR): Failed to parse device response: 2021-06-29T19:54:57.642Z,1624996497.642 [BackseatComponent](IMPORTANT): IBASE917-01: running backseat application. 2021-06-29T19:55:25.652Z,1624996525.652 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2021-06-29T19:55:28.664Z,1624996528.664 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.243195 2021-06-29T19:55:36.445Z,1624996536.445 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3 2021-06-29T19:55:36.445Z,1624996536.445 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2021-06-29T19:55:36.556Z,1624996536.556 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2021-06-29T19:55:36.960Z,1624996536.960 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2021-06-29T19:55:36.960Z,1624996536.960 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3 2021-06-29T19:56:00.800Z,1624996560.800 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2021-06-29T19:56:06.359Z,1624996566.359 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ApproachDepth:C.Pitch] Stopped 2021-06-29T19:56:06.360Z,1624996566.360 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ApproachDepth](INFO): Completed tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ApproachDepth 2021-06-29T19:56:06.360Z,1624996566.360 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ApproachDepth] Stopped 2021-06-29T19:56:06.360Z,1624996566.360 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ApproachDepth](DEBUG): Aggregate::uninitialize tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ApproachDepth 2021-06-29T19:56:06.360Z,1624996566.360 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ApproachDepth:B.SetSpeed] Stopped 2021-06-29T19:56:06.360Z,1624996566.360 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ApproachDepth:B.SetSpeed](DEBUG): Uninitialize. 2021-06-29T19:56:06.361Z,1624996566.361 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth](INFO): Completed tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth 2021-06-29T19:56:06.361Z,1624996566.361 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth] Stopped 2021-06-29T19:56:06.361Z,1624996566.361 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth](DEBUG): Aggregate::uninitialize tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth 2021-06-29T19:56:06.361Z,1624996566.361 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:A] Stopped 2021-06-29T19:56:06.361Z,1624996566.361 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:BallastAndTrimAtTargetDepth] Running Loop=1 2021-06-29T19:56:06.361Z,1624996566.361 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:BallastAndTrimAtTargetDepth](DEBUG): Aggregate::initialize tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:BallastAndTrimAtTargetDepth 2021-06-29T19:56:06.362Z,1624996566.362 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:BallastAndTrimAtTargetDepth:A.SetSpeed] Running Loop=1 2021-06-29T19:56:06.362Z,1624996566.362 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:BallastAndTrimAtTargetDepth:A.SetSpeed](DEBUG): Initialize. 2021-06-29T19:56:06.362Z,1624996566.362 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:BallastAndTrimAtTargetDepth:B.Pitch] Running Loop=1 2021-06-29T19:56:06.362Z,1624996566.362 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:BallastAndTrimAtTargetDepth:B.Pitch](DEBUG): Initialize. 2021-06-29T19:56:06.362Z,1624996566.362 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:BallastAndTrimAtTargetDepth:C] Running Loop=1 2021-06-29T19:56:06.756Z,1624996566.756 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:BallastAndTrimAtTargetDepth:C](INFO): Waiting for the vehicle to settle. Depth = 7.068116 m 2021-06-29T19:56:06.757Z,1624996566.757 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:BallastAndTrimAtTargetDepth:C] Stopped 2021-06-29T19:56:06.757Z,1624996566.757 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:BallastAndTrimAtTargetDepth:D.Wait] Running Loop=1 2021-06-29T19:56:06.757Z,1624996566.757 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:BallastAndTrimAtTargetDepth:D.Wait](DEBUG): Initialize Wait Component. 2021-06-29T19:56:06.757Z,1624996566.757 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:BallastAndTrimAtTargetDepth:B.Pitch] Running Loop=1 2021-06-29T19:56:06.758Z,1624996566.758 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:BallastAndTrimAtTargetDepth:A.SetSpeed] Running Loop=1 2021-06-29T19:56:09.103Z,1624996569.103 [Radio_Surface](INFO): Powering down 2021-06-29T19:56:35.949Z,1624996595.949 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2021-06-29T19:56:36.952Z,1624996596.952 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2021-06-29T19:58:37.435Z,1624996717.435 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4 2021-06-29T19:58:37.435Z,1624996717.435 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2021-06-29T19:58:37.544Z,1624996717.544 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2021-06-29T19:58:37.957Z,1624996717.957 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2021-06-29T19:58:37.957Z,1624996717.957 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4 2021-06-29T20:01:07.336Z,1624996867.336 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:BallastAndTrimAtTargetDepth:D.Wait](INFO): Done Waiting. 2021-06-29T20:01:07.336Z,1624996867.336 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:BallastAndTrimAtTargetDepth:D.Wait] Stopped 2021-06-29T20:01:07.336Z,1624996867.336 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:BallastAndTrimAtTargetDepth:D.Wait](DEBUG): Uninitialize Wait Component. 2021-06-29T20:01:07.336Z,1624996867.336 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:BallastAndTrimAtTargetDepth:E] Running Loop=1 2021-06-29T20:01:07.743Z,1624996867.743 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:BallastAndTrimAtTargetDepth:E](INFO): Running ballast and trim. Depth = 9.502511 m 2021-06-29T20:01:07.743Z,1624996867.743 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:BallastAndTrimAtTargetDepth:E] Stopped 2021-06-29T20:01:07.743Z,1624996867.743 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:BallastAndTrimAtTargetDepth:F.] Running Loop=1 2021-06-29T20:01:07.743Z,1624996867.743 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:BallastAndTrimAtTargetDepth:F.](INFO): Initializing BallastAndTrim. 2021-06-29T20:01:38.434Z,1624996898.434 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5 2021-06-29T20:01:38.434Z,1624996898.434 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2021-06-29T20:01:38.556Z,1624996898.556 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2021-06-29T20:01:38.948Z,1624996898.948 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2021-06-29T20:01:38.948Z,1624996898.948 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5 2021-06-29T20:04:39.459Z,1624997079.459 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6 2021-06-29T20:04:39.459Z,1624997079.459 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2021-06-29T20:04:39.524Z,1624997079.524 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2021-06-29T20:04:39.918Z,1624997079.918 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2021-06-29T20:04:39.918Z,1624997079.918 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6 2021-06-29T20:05:47.309Z,1624997147.309 [BPC1](ERROR): BPC1B: No match for serial number 0C29 in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-06-29T20:06:01.041Z,1624997161.041 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-06-29T20:06:14.371Z,1624997174.371 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-06-29T20:06:28.117Z,1624997188.117 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-06-29T20:06:41.446Z,1624997201.446 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-06-29T20:06:54.784Z,1624997214.784 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-06-29T20:07:08.499Z,1624997228.499 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-06-29T20:07:22.235Z,1624997242.235 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-06-29T20:07:35.567Z,1624997255.567 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-06-29T20:07:40.436Z,1624997260.436 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7 2021-06-29T20:07:40.436Z,1624997260.436 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2021-06-29T20:07:40.494Z,1624997260.494 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2021-06-29T20:07:40.903Z,1624997260.903 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2021-06-29T20:07:40.903Z,1624997260.903 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7 2021-06-29T20:07:48.505Z,1624997268.505 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-06-29T20:08:01.833Z,1624997281.833 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-06-29T20:10:41.472Z,1624997441.472 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8 2021-06-29T20:10:41.472Z,1624997441.472 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2021-06-29T20:10:41.651Z,1624997441.651 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2021-06-29T20:10:41.927Z,1624997441.927 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2021-06-29T20:10:41.928Z,1624997441.928 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8 2021-06-29T20:10:42.636Z,1624997442.636 [BPC1](INFO): Calculating totals. Valid battery stick count: 55. Valid reserve battery stick count: 5. 2021-06-29T20:10:42.655Z,1624997442.655 [BPC1](INFO): Received data from all battery sticks. 2021-06-29T20:11:08.489Z,1624997468.489 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:BallastAndTrimAtTargetDepth:F.](IMPORTANT): BallastAndTrim completed. Estimation time: 10.01 minutes. 2021-06-29T20:11:08.491Z,1624997468.491 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:BallastAndTrimAtTargetDepth:F.](IMPORTANT): Estimated buoyancyNeutral: 656.690825 +/- 8.933923 cc (conf. level 99.90%, sigma: 10.894189 cc). 2021-06-29T20:11:08.492Z,1624997468.492 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:BallastAndTrimAtTargetDepth:F.](IMPORTANT): Estimated massDefault: 1.727606 +/- 1.129015 mm (conf. level 99.90%, sigma: 1.376741 mm). 2021-06-29T20:11:08.492Z,1624997468.492 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:BallastAndTrimAtTargetDepth:F.](IMPORTANT): Changing persisted config values to: 656.690825 cc buoyancy neutral and 1.727606 mm mass default 2021-06-29T20:11:08.497Z,1624997468.497 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:BallastAndTrimAtTargetDepth:F.](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2021-06-29T20:11:08.497Z,1624997468.497 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:BallastAndTrimAtTargetDepth:F.](IMPORTANT): BPC1.batteryMissingStickThreshold=8 count; 2021-06-29T20:11:08.497Z,1624997468.497 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:BallastAndTrimAtTargetDepth:F.](IMPORTANT): BPC1.batterySamplingInterval=1 minute; 2021-06-29T20:11:08.498Z,1624997468.498 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:BallastAndTrimAtTargetDepth:F.](IMPORTANT): BPC1.batteryStickCommsTimeout=10 second; 2021-06-29T20:11:08.498Z,1624997468.498 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:BallastAndTrimAtTargetDepth:F.](IMPORTANT): BackseatComponent.loadAtStartup=1 bool; 2021-06-29T20:11:08.498Z,1624997468.498 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:BallastAndTrimAtTargetDepth:F.](IMPORTANT): CBIT.abortDepth=115 meter; 2021-06-29T20:11:08.498Z,1624997468.498 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:BallastAndTrimAtTargetDepth:F.](IMPORTANT): CBIT.gf24Offset=-27 microampere; 2021-06-29T20:11:08.498Z,1624997468.498 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:BallastAndTrimAtTargetDepth:F.](IMPORTANT): CBIT.stopDepth=110 meter; 2021-06-29T20:11:08.498Z,1624997468.498 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:BallastAndTrimAtTargetDepth:F.](IMPORTANT): DAT.loadAtStartup=0 bool; 2021-06-29T20:11:08.498Z,1624997468.498 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:BallastAndTrimAtTargetDepth:F.](IMPORTANT): DropWeight.loadAtStartup=0 bool; 2021-06-29T20:11:08.499Z,1624997468.499 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:BallastAndTrimAtTargetDepth:F.](IMPORTANT): Express none WetLabsBB2FL.bin_mean_mass_concentration_of_chlorophyll_in_sea_water; 2021-06-29T20:11:08.499Z,1624997468.499 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:BallastAndTrimAtTargetDepth:F.](IMPORTANT): Express linearApproximation platform_roll_angle 2.000000 degree; 2021-06-29T20:11:08.499Z,1624997468.499 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:BallastAndTrimAtTargetDepth:F.](IMPORTANT): ThrusterServo.loadAtStartup=0 bool; 2021-06-29T20:11:08.499Z,1624997468.499 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:BallastAndTrimAtTargetDepth:F.](IMPORTANT): VerticalControl.buoyancyNeutral=656.690825 cubic_centimeter; 2021-06-29T20:11:08.499Z,1624997468.499 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:BallastAndTrimAtTargetDepth:F.](IMPORTANT): VerticalControl.massDefault=1.727606 millimeter; 2021-06-29T20:11:08.500Z,1624997468.500 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:BallastAndTrimAtTargetDepth:F.] Stopped 2021-06-29T20:11:08.500Z,1624997468.500 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:BallastAndTrimAtTargetDepth:F.](INFO): Uninitializing BallastAndTrim. 2021-06-29T20:11:08.501Z,1624997468.501 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:BallastAndTrimAtTargetDepth](INFO): Completed tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:BallastAndTrimAtTargetDepth 2021-06-29T20:11:08.501Z,1624997468.501 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:BallastAndTrimAtTargetDepth] Stopped 2021-06-29T20:11:08.501Z,1624997468.501 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:BallastAndTrimAtTargetDepth](DEBUG): Aggregate::uninitialize tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:BallastAndTrimAtTargetDepth 2021-06-29T20:11:08.501Z,1624997468.501 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:BallastAndTrimAtTargetDepth:A.SetSpeed] Stopped 2021-06-29T20:11:08.501Z,1624997468.501 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:BallastAndTrimAtTargetDepth:A.SetSpeed](DEBUG): Uninitialize. 2021-06-29T20:11:08.501Z,1624997468.501 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:BallastAndTrimAtTargetDepth:B.Pitch] Stopped 2021-06-29T20:11:08.519Z,1624997468.519 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim](INFO): Completed tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim 2021-06-29T20:11:08.519Z,1624997468.519 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim] Stopped 2021-06-29T20:11:08.519Z,1624997468.519 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim](DEBUG): Aggregate::uninitialize tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim 2021-06-29T20:11:08.519Z,1624997468.519 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:A] Stopped 2021-06-29T20:11:08.519Z,1624997468.519 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:B] Stopped 2021-06-29T20:11:08.520Z,1624997468.520 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:C] Stopped 2021-06-29T20:11:08.520Z,1624997468.520 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:D] Stopped 2021-06-29T20:11:08.520Z,1624997468.520 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:E] Stopped 2021-06-29T20:11:08.520Z,1624997468.520 [tank_ballast_and_trim_backseat:RunBallastAndTrim:BallastAndTrim:F] Stopped 2021-06-29T20:11:08.898Z,1624997468.898 [tank_ballast_and_trim_backseat:RunBallastAndTrim:Depth1:B](INFO): Completed tank_ballast_and_trim_backseat:RunBallastAndTrim:Depth1:B 2021-06-29T20:11:08.898Z,1624997468.898 [tank_ballast_and_trim_backseat:RunBallastAndTrim:Depth1:B] Stopped 2021-06-29T20:11:08.898Z,1624997468.898 [tank_ballast_and_trim_backseat:RunBallastAndTrim:Depth1:B](DEBUG): Aggregate::uninitialize tank_ballast_and_trim_backseat:RunBallastAndTrim:Depth1:B 2021-06-29T20:11:08.898Z,1624997468.898 [tank_ballast_and_trim_backseat:RunBallastAndTrim:Depth1](INFO): Completed tank_ballast_and_trim_backseat:RunBallastAndTrim:Depth1 2021-06-29T20:11:08.898Z,1624997468.898 [tank_ballast_and_trim_backseat:RunBallastAndTrim:Depth1] Stopped 2021-06-29T20:11:08.898Z,1624997468.898 [tank_ballast_and_trim_backseat:RunBallastAndTrim:Depth1](DEBUG): Aggregate::uninitialize tank_ballast_and_trim_backseat:RunBallastAndTrim:Depth1 2021-06-29T20:11:08.899Z,1624997468.899 [tank_ballast_and_trim_backseat:RunBallastAndTrim:Depth2] Running Loop=1 2021-06-29T20:11:08.907Z,1624997468.907 [tank_ballast_and_trim_backseat:RunBallastAndTrim:Depth2](DEBUG): Aggregate::initialize tank_ballast_and_trim_backseat:RunBallastAndTrim:Depth2 2021-06-29T20:11:08.907Z,1624997468.907 [tank_ballast_and_trim_backseat:RunBallastAndTrim:Depth2:A] Running Loop=1 2021-06-29T20:11:09.300Z,1624997469.300 [tank_ballast_and_trim_backseat:RunBallastAndTrim:Depth2] Stopped 2021-06-29T20:11:09.300Z,1624997469.300 [tank_ballast_and_trim_backseat:RunBallastAndTrim:Depth2](DEBUG): Aggregate::uninitialize tank_ballast_and_trim_backseat:RunBallastAndTrim:Depth2 2021-06-29T20:11:09.300Z,1624997469.300 [tank_ballast_and_trim_backseat:RunBallastAndTrim:Depth2:A] Stopped 2021-06-29T20:11:09.327Z,1624997469.327 [tank_ballast_and_trim_backseat:RunBallastAndTrim](INFO): Completed tank_ballast_and_trim_backseat:RunBallastAndTrim 2021-06-29T20:11:09.327Z,1624997469.327 [tank_ballast_and_trim_backseat:RunBallastAndTrim] Stopped 2021-06-29T20:11:09.328Z,1624997469.328 [tank_ballast_and_trim_backseat:RunBallastAndTrim](DEBUG): Aggregate::uninitialize tank_ballast_and_trim_backseat:RunBallastAndTrim 2021-06-29T20:11:09.328Z,1624997469.328 [tank_ballast_and_trim_backseat:RunBallastAndTrim:B.BackseatDriver] Stopped 2021-06-29T20:11:09.328Z,1624997469.328 [tank_ballast_and_trim_backseat:RunBallastAndTrim:B.BackseatDriver](DEBUG): Uninitialize. 2021-06-29T20:11:09.328Z,1624997469.328 [tank_ballast_and_trim_backseat:Float_Up] Running Loop=1 2021-06-29T20:11:09.328Z,1624997469.328 [tank_ballast_and_trim_backseat:Float_Up](DEBUG): Aggregate::initialize tank_ballast_and_trim_backseat:Float_Up 2021-06-29T20:11:09.328Z,1624997469.328 [tank_ballast_and_trim_backseat:Float_Up:A.Buoyancy] Running Loop=1 2021-06-29T20:11:09.328Z,1624997469.328 [tank_ballast_and_trim_backseat:Float_Up:A.Buoyancy](DEBUG): Initialize Buoyancy Component. 2021-06-29T20:11:09.328Z,1624997469.328 [tank_ballast_and_trim_backseat:Float_Up:B.Wait] Running Loop=1 2021-06-29T20:11:09.329Z,1624997469.329 [tank_ballast_and_trim_backseat:Float_Up:B.Wait](DEBUG): Initialize Wait Component. 2021-06-29T20:11:09.688Z,1624997469.688 [BackseatComponent](INFO): Sent LCM shutdown request. 2021-06-29T20:11:09.698Z,1624997469.698 [tank_ballast_and_trim_backseat:Float_Up:A.Buoyancy] Running Loop=1 2021-06-29T20:11:24.799Z,1624997484.799 [BackseatComponent](INFO): Powering down 2021-06-29T20:11:25.004Z,1624997485.004 [BackseatComponent](INFO): Unsubscribing from LCM channels. 2021-06-29T20:11:25.004Z,1624997485.004 [LcmUniversalReporter](INFO): Deactivating messaging. 2021-06-29T20:11:25.005Z,1624997485.005 [BackseatComponent](FAULT): LCB fault: Software Overcurrent. 2021-06-29T20:11:25.005Z,1624997485.005 [BackseatComponent] Hardware Fault, FailCount= 1 2021-06-29T20:11:25.005Z,1624997485.005 [BackseatComponent](ERROR): Hardware Fault 2021-06-29T20:11:25.128Z,1624997485.128 [CBIT](ERROR): Hardware Fault in component: BackseatComponent 2021-06-29T20:11:25.500Z,1624997485.500 [CBIT](INFO): Clearing failed state for component BackseatComponent 2021-06-29T20:11:25.500Z,1624997485.500 [BackseatComponent] No Fault, FailCount= 1 2021-06-29T20:11:25.812Z,1624997485.812 [BackseatComponent](INFO): Powering up 2021-06-29T20:11:25.812Z,1624997485.812 [BackseatComponent](INFO): Subscribing to LCM channels. 2021-06-29T20:11:41.324Z,1624997501.324 [BackseatComponent](INFO): Sent LCM shutdown request. 2021-06-29T20:11:56.424Z,1624997516.424 [BackseatComponent](INFO): Powering down 2021-06-29T20:11:56.623Z,1624997516.623 [BackseatComponent](INFO): Unsubscribing from LCM channels. 2021-06-29T20:11:56.623Z,1624997516.623 [LcmUniversalReporter](INFO): Deactivating messaging. 2021-06-29T20:12:41.402Z,1624997561.402 [tank_ballast_and_trim_backseat:Float_Up] Stopped 2021-06-29T20:12:41.402Z,1624997561.402 [tank_ballast_and_trim_backseat:Float_Up](DEBUG): Aggregate::uninitialize tank_ballast_and_trim_backseat:Float_Up 2021-06-29T20:12:41.402Z,1624997561.402 [tank_ballast_and_trim_backseat:Float_Up:A.Buoyancy] Stopped 2021-06-29T20:12:41.402Z,1624997561.402 [tank_ballast_and_trim_backseat:Float_Up:A.Buoyancy](DEBUG): Uninitialize Buoyancy Component. 2021-06-29T20:12:41.402Z,1624997561.402 [tank_ballast_and_trim_backseat:Float_Up:B.Wait] Stopped 2021-06-29T20:12:41.402Z,1624997561.402 [tank_ballast_and_trim_backseat:Float_Up:B.Wait](DEBUG): Uninitialize Wait Component. 2021-06-29T20:12:41.404Z,1624997561.404 [tank_ballast_and_trim_backseat](INFO): Completed tank_ballast_and_trim_backseat 2021-06-29T20:12:41.404Z,1624997561.404 [MissionManager](INFO): tank_ballast_and_trim_backseat is completed. 2021-06-29T20:12:41.405Z,1624997561.405 [MissionManager](INFO): Uninitializing Mission tank_ballast_and_trim_backseat 2021-06-29T20:12:41.405Z,1624997561.405 [tank_ballast_and_trim_backseat] Stopped 2021-06-29T20:12:41.405Z,1624997561.405 [tank_ballast_and_trim_backseat](DEBUG): Aggregate::uninitialize tank_ballast_and_trim_backseat 2021-06-29T20:12:41.405Z,1624997561.405 [tank_ballast_and_trim_backseat:Science] Stopped 2021-06-29T20:12:41.405Z,1624997561.405 [tank_ballast_and_trim_backseat:Science](DEBUG): Aggregate::uninitialize tank_ballast_and_trim_backseat:Science 2021-06-29T20:12:41.405Z,1624997561.405 [tank_ballast_and_trim_backseat:Science:B] Stopped 2021-06-29T20:12:41.405Z,1624997561.405 [tank_ballast_and_trim_backseat:Science:C] Stopped 2021-06-29T20:12:41.405Z,1624997561.405 [tank_ballast_and_trim_backseat:Science:E] Stopped 2021-06-29T20:12:41.405Z,1624997561.405 [tank_ballast_and_trim_backseat:Science:OceanCurrent] Stopped 2021-06-29T20:12:41.406Z,1624997561.406 [tank_ballast_and_trim_backseat:Science:OceanCurrent](DEBUG): Aggregate::uninitialize tank_ballast_and_trim_backseat:Science:OceanCurrent 2021-06-29T20:12:41.406Z,1624997561.406 [tank_ballast_and_trim_backseat:Science:OceanCurrent:A.] Stopped 2021-06-29T20:12:41.735Z,1624997561.735 [WetLabsBB2FL](INFO): Powering down 2021-06-29T20:12:41.818Z,1624997561.818 [MissionManager](IMPORTANT): Started mission Default 2021-06-29T20:12:41.818Z,1624997561.818 [Default] Running Loop=1 2021-06-29T20:12:41.818Z,1624997561.818 [Default](DEBUG): Aggregate::initialize Default 2021-06-29T20:12:41.818Z,1624997561.818 [Default:B.GoToSurface] Running Loop=1 2021-06-29T20:12:41.818Z,1624997561.818 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2021-06-29T20:12:41.819Z,1624997561.819 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2021-06-29T20:12:41.819Z,1624997561.819 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2021-06-29T20:12:41.819Z,1624997561.819 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2021-06-29T20:12:41.820Z,1624997561.820 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2021-06-29T20:12:41.820Z,1624997561.820 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2021-06-29T20:12:41.821Z,1624997561.821 [Default:A.Wait] Running Loop=1 2021-06-29T20:12:41.821Z,1624997561.821 [Default:A.Wait](DEBUG): Initialize Wait Component. 2021-06-29T20:12:42.167Z,1624997562.167 [Radio_Surface](INFO): Powering up 2021-06-29T20:12:47.999Z,1624997567.999 [DataOverHttps](INFO): Radio surface powered ON. 2021-06-29T20:12:55.138Z,1624997575.138 [Default:A.Wait](INFO): Done Waiting. 2021-06-29T20:12:55.139Z,1624997575.139 [Default:A.Wait] Stopped 2021-06-29T20:12:55.139Z,1624997575.139 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2021-06-29T20:12:55.554Z,1624997575.554 [Default:CheckIn] Running Loop=1 2021-06-29T20:12:55.554Z,1624997575.554 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-06-29T20:12:55.554Z,1624997575.554 [Default:CheckIn:Read_GPS] Running Loop=1 2021-06-29T20:13:18.131Z,1624997598.131 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2021-06-29T20:13:42.436Z,1624997622.436 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9 2021-06-29T20:13:42.436Z,1624997622.436 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2021-06-29T20:13:42.451Z,1624997622.451 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2021-06-29T20:13:42.851Z,1624997622.851 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2021-06-29T20:13:42.851Z,1624997622.851 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9 2021-06-29T20:13:53.283Z,1624997633.283 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2021-06-29T20:14:28.427Z,1624997668.427 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2021-06-29T20:15:03.583Z,1624997703.583 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2021-06-29T20:15:38.723Z,1624997738.723 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2021-06-29T20:16:13.524Z,1624997773.524 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003511 2021-06-29T20:16:43.451Z,1624997803.451 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10 2021-06-29T20:16:43.451Z,1624997803.451 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2021-06-29T20:16:43.491Z,1624997803.491 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2021-06-29T20:16:43.865Z,1624997803.865 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2021-06-29T20:16:43.865Z,1624997803.865 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10