2018-03-23T17:36:17.009Z,1521826577.009 [CommandLine](IMPORTANT): got command restart logs 2018-03-23T17:36:26.567Z,1521826586.567 [NAL9602](INFO): SBD MO Status=1, MOMSN=5588, MT Status=0, MTMSN=0 2018-03-23T17:36:26.621Z,1521826586.621 [NAL9602](INFO): Sent 25 bytes from file Logs/20180323T173607/Courier0000.lzma 2018-03-23T17:36:26.621Z,1521826586.621 [NAL9602](INFO): Packets left to send: 0 2018-03-23T17:36:26.623Z,1521826586.623 [NAL9602](DEBUG): Stored copy of sent data in Logs/20180323T173607/Courier0000.lzma.parts/0000.sbd 2018-03-23T17:36:26.623Z,1521826586.623 [NAL9602](DEBUG): Completed sending Logs/20180323T173607/Courier0000.lzma 2018-03-23T17:36:33.487Z,1521826593.487 [NAL9602](INFO): SBD MO Status=1, MOMSN=5589, MT Status=0, MTMSN=0 2018-03-23T17:36:33.541Z,1521826593.541 [NAL9602](INFO): Sent 274 bytes from file Logs/20180323T170725/Express0013.lzma 2018-03-23T17:36:33.541Z,1521826593.541 [NAL9602](INFO): Packets left to send: 0 2018-03-23T17:36:33.543Z,1521826593.543 [NAL9602](DEBUG): Stored copy of sent data in Logs/20180323T170725/Express0013.lzma.parts/0000.sbd 2018-03-23T17:36:33.543Z,1521826593.543 [NAL9602](DEBUG): Completed sending Logs/20180323T170725/Express0013.lzma 2018-03-23T17:36:37.180Z,1521826597.180 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2018-03-23T17:36:44.383Z,1521826604.383 [NAL9602](INFO): SBD MO Status=1, MOMSN=5590, MT Status=0, MTMSN=0 2018-03-23T17:36:44.441Z,1521826604.441 [NAL9602](INFO): Sent 108 bytes from file Logs/20180323T170725/Express0017.lzma 2018-03-23T17:36:44.441Z,1521826604.441 [NAL9602](INFO): Packets left to send: 0 2018-03-23T17:36:44.446Z,1521826604.446 [NAL9602](DEBUG): Stored copy of sent data in Logs/20180323T170725/Express0017.lzma.parts/0000.sbd 2018-03-23T17:36:44.447Z,1521826604.447 [NAL9602](DEBUG): Completed sending Logs/20180323T170725/Express0017.lzma 2018-03-23T17:36:55.667Z,1521826615.667 [NAL9602](INFO): SBD MO Status=1, MOMSN=5591, MT Status=0, MTMSN=0 2018-03-23T17:36:55.720Z,1521826615.720 [NAL9602](INFO): Sent 315 bytes from file Logs/20180323T173549/Express0001.lzma 2018-03-23T17:36:55.720Z,1521826615.720 [NAL9602](INFO): Packets left to send: 0 2018-03-23T17:36:55.722Z,1521826615.722 [NAL9602](DEBUG): Stored copy of sent data in Logs/20180323T173549/Express0001.lzma.parts/0000.sbd 2018-03-23T17:36:55.722Z,1521826615.722 [NAL9602](DEBUG): Completed sending Logs/20180323T173549/Express0001.lzma 2018-03-23T17:37:04.175Z,1521826624.175 [NAL9602](INFO): SBD MO Status=1, MOMSN=5592, MT Status=0, MTMSN=0 2018-03-23T17:37:04.225Z,1521826624.225 [NAL9602](INFO): Sent 315 bytes from file Logs/20180323T173607/Express0001.lzma 2018-03-23T17:37:04.225Z,1521826624.225 [NAL9602](INFO): Packets left to send: 0 2018-03-23T17:37:04.227Z,1521826624.227 [NAL9602](DEBUG): Stored copy of sent data in Logs/20180323T173607/Express0001.lzma.parts/0000.sbd 2018-03-23T17:37:04.227Z,1521826624.227 [NAL9602](DEBUG): Completed sending Logs/20180323T173607/Express0001.lzma 2018-03-23T17:37:13.380Z,1521826633.380 [NAL9602](INFO): SBD MO Status=0, MOMSN=5593, MT Status=0, MTMSN=0 2018-03-23T17:37:30.655Z,1521826650.655 [NAL9602](INFO): SBD MO Status=1, MOMSN=5594, MT Status=0, MTMSN=0 2018-03-23T17:37:30.709Z,1521826650.709 [NAL9602](INFO): Sent 25 bytes from file Logs/20180323T173617/Courier0000.lzma 2018-03-23T17:37:30.709Z,1521826650.709 [NAL9602](INFO): Packets left to send: 0 2018-03-23T17:37:30.711Z,1521826650.711 [NAL9602](DEBUG): Stored copy of sent data in Logs/20180323T173617/Courier0000.lzma.parts/0000.sbd 2018-03-23T17:37:30.711Z,1521826650.711 [NAL9602](DEBUG): Completed sending Logs/20180323T173617/Courier0000.lzma 2018-03-23T17:37:35.595Z,1521826655.595 [CBIT](DEBUG): EFC running - data check-sum false 2018-03-23T17:37:37.536Z,1521826657.536 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2018-03-23T17:37:42.739Z,1521826662.739 [NAL9602](INFO): SBD MO Status=1, MOMSN=5595, MT Status=0, MTMSN=0 2018-03-23T17:37:42.789Z,1521826662.789 [NAL9602](INFO): Sent 258 bytes from file Logs/20180323T173617/Express0001.lzma 2018-03-23T17:37:42.789Z,1521826662.789 [NAL9602](INFO): Packets left to send: 0 2018-03-23T17:37:42.791Z,1521826662.791 [NAL9602](DEBUG): Stored copy of sent data in Logs/20180323T173617/Express0001.lzma.parts/0000.sbd 2018-03-23T17:37:42.791Z,1521826662.791 [NAL9602](DEBUG): Completed sending Logs/20180323T173617/Express0001.lzma 2018-03-23T17:37:45.182Z,1521826665.182 [DeadReckonWithRespectToSeafloor](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-03-23T17:37:45.182Z,1521826665.182 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2018-03-23T17:37:45.182Z,1521826665.182 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2018-03-23T17:37:45.218Z,1521826665.218 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2018-03-23T17:37:45.588Z,1521826665.588 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2018-03-23T17:37:45.588Z,1521826665.588 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2018-03-23T17:37:45.989Z,1521826665.989 [DeadReckonWithRespectToSeafloor](DEBUG): Initializing DeadReckonWithRespectToSeafloor component. 2018-03-23T17:37:45.989Z,1521826665.989 [DeadReckonWithRespectToSeafloor](INFO): Will consider orientation measurement stale after 120s. 2018-03-23T17:37:45.990Z,1521826665.990 [DeadReckonWithRespectToSeafloor](INFO): Will consider velocity measurement stale after 20s. 2018-03-23T17:37:51.939Z,1521826671.939 [NAL9602](INFO): SBD MO Status=0, MOMSN=5596, MT Status=0, MTMSN=0 2018-03-23T17:37:52.051Z,1521826672.051 [Default:CheckIn:Read_Iridium] Stopped 2018-03-23T17:37:52.051Z,1521826672.051 [Default:CheckIn:C.Wait] Running Loop=1 2018-03-23T17:37:52.051Z,1521826672.051 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2018-03-23T17:38:22.738Z,1521826702.738 [NAL9602](INFO): Powering down 2018-03-23T17:38:37.936Z,1521826717.936 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2018-03-23T17:39:38.336Z,1521826778.336 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2018-03-23T17:40:38.336Z,1521826838.336 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2018-03-23T17:40:46.378Z,1521826846.378 [DeadReckonWithRespectToSeafloor](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-03-23T17:40:46.378Z,1521826846.378 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2 2018-03-23T17:40:46.378Z,1521826846.378 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2018-03-23T17:40:46.390Z,1521826846.390 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2018-03-23T17:40:46.814Z,1521826846.814 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2018-03-23T17:40:46.814Z,1521826846.814 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2 2018-03-23T17:40:47.177Z,1521826847.177 [DeadReckonWithRespectToSeafloor](DEBUG): Initializing DeadReckonWithRespectToSeafloor component. 2018-03-23T17:40:47.178Z,1521826847.178 [DeadReckonWithRespectToSeafloor](INFO): Will consider orientation measurement stale after 120s. 2018-03-23T17:40:47.178Z,1521826847.178 [DeadReckonWithRespectToSeafloor](INFO): Will consider velocity measurement stale after 20s. 2018-03-23T17:41:38.736Z,1521826898.736 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2018-03-23T17:42:38.736Z,1521826958.736 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2018-03-23T17:42:52.797Z,1521826972.797 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2018-03-23T17:42:52.797Z,1521826972.797 [Default:CheckIn:C.Wait] Stopped 2018-03-23T17:42:52.797Z,1521826972.797 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2018-03-23T17:42:52.797Z,1521826972.797 [Default:CheckIn:D] Running Loop=1 2018-03-23T17:42:53.190Z,1521826973.190 [Default:CheckIn:D] Stopped 2018-03-23T17:42:53.190Z,1521826973.190 [Default:CheckIn:E] Running Loop=1 2018-03-23T17:42:53.595Z,1521826973.595 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 31.986904 min 2018-03-23T17:42:53.595Z,1521826973.595 [Default:CheckIn:E] Stopped 2018-03-23T17:42:53.595Z,1521826973.595 [Default:CheckIn](INFO): Completed Default:CheckIn 2018-03-23T17:42:53.595Z,1521826973.595 [Default:CheckIn] Stopped 2018-03-23T17:42:53.595Z,1521826973.595 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2018-03-23T17:42:53.595Z,1521826973.595 [Default:CheckIn](INFO): Running loop #4 2018-03-23T17:42:53.595Z,1521826973.595 [Default:CheckIn] Running Loop=4 2018-03-23T17:42:53.596Z,1521826973.596 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2018-03-23T17:42:53.596Z,1521826973.596 [Default:CheckIn:Read_GPS] Running Loop=1 2018-03-23T17:42:54.338Z,1521826974.338 [NAL9602](INFO): Powering up 2018-03-23T17:43:05.538Z,1521826985.538 [NAL9602](INFO): NAL9602 initialized 2018-03-23T17:43:32.743Z,1521827012.743 [NAL9602](INFO): SBD MO Status=2, MOMSN=5597, MT Status=2, MTMSN=0 2018-03-23T17:43:32.744Z,1521827012.744 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2018-03-23T17:43:38.338Z,1521827018.338 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2018-03-23T17:43:47.180Z,1521827027.180 [DeadReckonWithRespectToSeafloor](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-03-23T17:43:47.180Z,1521827027.180 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 3 2018-03-23T17:43:47.180Z,1521827027.180 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2018-03-23T17:43:47.192Z,1521827027.192 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2018-03-23T17:43:47.618Z,1521827027.618 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2018-03-23T17:43:47.618Z,1521827027.618 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 3 2018-03-23T17:43:47.988Z,1521827027.988 [DeadReckonWithRespectToSeafloor](DEBUG): Initializing DeadReckonWithRespectToSeafloor component. 2018-03-23T17:43:47.989Z,1521827027.989 [DeadReckonWithRespectToSeafloor](INFO): Will consider orientation measurement stale after 120s. 2018-03-23T17:43:47.989Z,1521827027.989 [DeadReckonWithRespectToSeafloor](INFO): Will consider velocity measurement stale after 20s. 2018-03-23T17:43:51.144Z,1521827031.144 [NAL9602](INFO): SBD MO Status=0, MOMSN=5597, MT Status=0, MTMSN=0 2018-03-23T17:43:51.144Z,1521827031.144 [NAL9602](INFO): No messages in MT queue 2018-03-23T17:44:39.136Z,1521827079.136 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2018-03-23T17:45:06.742Z,1521827106.742 [NAL9602](INFO): GPS fix at 20180323T174431: (36.808157, -121.787353) 2018-03-23T17:45:06.796Z,1521827106.796 [Default:CheckIn:Read_GPS] Stopped 2018-03-23T17:45:06.796Z,1521827106.796 [Default:CheckIn:Read_Iridium] Running Loop=1 2018-03-23T17:45:26.823Z,1521827126.823 [NAL9602](INFO): SBD MO Status=1, MOMSN=5598, MT Status=0, MTMSN=0 2018-03-23T17:45:26.873Z,1521827126.873 [NAL9602](INFO): Sent 213 bytes from file Logs/20180323T173617/Courier0004.lzma 2018-03-23T17:45:26.873Z,1521827126.873 [NAL9602](INFO): Packets left to send: 0 2018-03-23T17:45:26.875Z,1521827126.875 [NAL9602](DEBUG): Stored copy of sent data in Logs/20180323T173617/Courier0004.lzma.parts/0000.sbd 2018-03-23T17:45:26.875Z,1521827126.875 [NAL9602](DEBUG): Completed sending Logs/20180323T173617/Courier0004.lzma 2018-03-23T17:45:36.951Z,1521827136.951 [NAL9602](INFO): SBD MO Status=1, MOMSN=5599, MT Status=0, MTMSN=0 2018-03-23T17:45:37.001Z,1521827137.001 [NAL9602](INFO): Sent 168 bytes from file Logs/20180323T173617/Express0005.lzma 2018-03-23T17:45:37.001Z,1521827137.001 [NAL9602](INFO): Packets left to send: 0 2018-03-23T17:45:37.003Z,1521827137.003 [NAL9602](DEBUG): Stored copy of sent data in Logs/20180323T173617/Express0005.lzma.parts/0000.sbd 2018-03-23T17:45:37.003Z,1521827137.003 [NAL9602](DEBUG): Completed sending Logs/20180323T173617/Express0005.lzma 2018-03-23T17:45:38.948Z,1521827138.948 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2018-03-23T17:45:44.951Z,1521827144.951 [NAL9602](INFO): SBD MO Status=0, MOMSN=5600, MT Status=0, MTMSN=0 2018-03-23T17:45:45.055Z,1521827145.055 [Default:CheckIn:Read_Iridium] Stopped 2018-03-23T17:45:45.056Z,1521827145.056 [Default:CheckIn:C.Wait] Running Loop=1 2018-03-23T17:45:45.056Z,1521827145.056 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2018-03-23T17:46:15.750Z,1521827175.750 [NAL9602](INFO): Powering down 2018-03-23T17:46:39.348Z,1521827199.348 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2018-03-23T17:46:48.190Z,1521827208.190 [DeadReckonWithRespectToSeafloor](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-03-23T17:46:48.190Z,1521827208.190 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2018-03-23T17:46:48.190Z,1521827208.190 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2018-03-23T17:46:48.224Z,1521827208.224 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2018-03-23T17:46:48.644Z,1521827208.644 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2018-03-23T17:46:48.644Z,1521827208.644 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2018-03-23T17:46:48.987Z,1521827208.987 [DeadReckonWithRespectToSeafloor](DEBUG): Initializing DeadReckonWithRespectToSeafloor component. 2018-03-23T17:46:48.988Z,1521827208.988 [DeadReckonWithRespectToSeafloor](INFO): Will consider orientation measurement stale after 120s. 2018-03-23T17:46:48.988Z,1521827208.988 [DeadReckonWithRespectToSeafloor](INFO): Will consider velocity measurement stale after 20s. 2018-03-23T17:47:35.817Z,1521827255.817 [CBIT](DEBUG): EFC running - data check-sum false 2018-03-23T17:47:39.748Z,1521827259.748 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2018-03-23T17:48:39.748Z,1521827319.748 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2018-03-23T17:49:40.148Z,1521827380.148 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2018-03-23T17:49:49.007Z,1521827389.007 [DeadReckonWithRespectToSeafloor](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-03-23T17:49:49.007Z,1521827389.007 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2 2018-03-23T17:49:49.007Z,1521827389.007 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2018-03-23T17:49:49.032Z,1521827389.032 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2018-03-23T17:49:49.429Z,1521827389.429 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2018-03-23T17:49:49.429Z,1521827389.429 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2 2018-03-23T17:49:49.824Z,1521827389.824 [DeadReckonWithRespectToSeafloor](DEBUG): Initializing DeadReckonWithRespectToSeafloor component. 2018-03-23T17:49:49.824Z,1521827389.824 [DeadReckonWithRespectToSeafloor](INFO): Will consider orientation measurement stale after 120s. 2018-03-23T17:49:49.824Z,1521827389.824 [DeadReckonWithRespectToSeafloor](INFO): Will consider velocity measurement stale after 20s. 2018-03-23T17:50:40.548Z,1521827440.548 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2018-03-23T17:50:45.796Z,1521827445.796 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2018-03-23T17:50:45.797Z,1521827445.797 [Default:CheckIn:C.Wait] Stopped 2018-03-23T17:50:45.797Z,1521827445.797 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2018-03-23T17:50:45.797Z,1521827445.797 [Default:CheckIn:D] Running Loop=1 2018-03-23T17:50:46.195Z,1521827446.195 [Default:CheckIn:D] Stopped 2018-03-23T17:50:46.195Z,1521827446.195 [Default:CheckIn:E] Running Loop=1 2018-03-23T17:50:46.593Z,1521827446.593 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 39.870308 min 2018-03-23T17:50:46.593Z,1521827446.593 [Default:CheckIn:E] Stopped 2018-03-23T17:50:46.593Z,1521827446.593 [Default:CheckIn](INFO): Completed Default:CheckIn 2018-03-23T17:50:46.593Z,1521827446.593 [Default:CheckIn] Stopped 2018-03-23T17:50:46.593Z,1521827446.593 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2018-03-23T17:50:46.593Z,1521827446.593 [Default:CheckIn](INFO): Running loop #5 2018-03-23T17:50:46.594Z,1521827446.594 [Default:CheckIn] Running Loop=5 2018-03-23T17:50:46.594Z,1521827446.594 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2018-03-23T17:50:46.594Z,1521827446.594 [Default:CheckIn:Read_GPS] Running Loop=1 2018-03-23T17:50:47.354Z,1521827447.354 [NAL9602](INFO): Powering up 2018-03-23T17:50:58.159Z,1521827458.159 [NAL9602](INFO): NAL9602 initialized 2018-03-23T17:51:15.040Z,1521827475.040 [NAL9602](INFO): SBD MO Status=0, MOMSN=5601, MT Status=0, MTMSN=0 2018-03-23T17:51:15.040Z,1521827475.040 [NAL9602](INFO): No messages in MT queue 2018-03-23T17:51:15.940Z,1521827475.940 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.002791 2018-03-23T17:52:50.160Z,1521827570.160 [DeadReckonWithRespectToSeafloor](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-03-23T17:52:50.160Z,1521827570.160 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 3 2018-03-23T17:52:50.160Z,1521827570.160 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2018-03-23T17:52:50.172Z,1521827570.172 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2018-03-23T17:52:50.580Z,1521827570.580 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2018-03-23T17:52:50.580Z,1521827570.580 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 3 2018-03-23T17:52:51.025Z,1521827571.025 [DeadReckonWithRespectToSeafloor](DEBUG): Initializing DeadReckonWithRespectToSeafloor component. 2018-03-23T17:52:51.026Z,1521827571.026 [DeadReckonWithRespectToSeafloor](INFO): Will consider orientation measurement stale after 120s. 2018-03-23T17:52:51.026Z,1521827571.026 [DeadReckonWithRespectToSeafloor](INFO): Will consider velocity measurement stale after 20s. 2018-03-23T17:54:07.720Z,1521827647.720 [NAL9602](INFO): GPS fix at 20180323T175332: (36.802493, -121.787013) 2018-03-23T17:54:07.800Z,1521827647.800 [Default:CheckIn:Read_GPS] Stopped 2018-03-23T17:54:07.800Z,1521827647.800 [Default:CheckIn:Read_Iridium] Running Loop=1 2018-03-23T17:54:12.163Z,1521827652.163 [DataOverHttps](INFO): Sending 61 bytes from file Logs/20180323T173617/Courier0008.lzma 2018-03-23T17:54:12.961Z,1521827652.961 [DataOverHttps](INFO): Moved sent file to Logs/20180323T173617/Courier0008.lzma.bak 2018-03-23T17:54:12.961Z,1521827652.961 [DataOverHttps](INFO): SBD MOMSN=8181200 2018-03-23T17:54:21.842Z,1521827661.842 [DataOverHttps](INFO): Sending 135 bytes from file Logs/20180323T173617/Express0009.lzma 2018-03-23T17:54:22.621Z,1521827662.621 [DataOverHttps](INFO): Moved sent file to Logs/20180323T173617/Express0009.lzma.bak 2018-03-23T17:54:22.622Z,1521827662.622 [DataOverHttps](INFO): SBD MOMSN=8181203 2018-03-23T17:54:23.225Z,1521827663.225 [Default:CheckIn:Read_Iridium] Stopped 2018-03-23T17:54:23.225Z,1521827663.225 [Default:CheckIn:C.Wait] Running Loop=1 2018-03-23T17:54:23.226Z,1521827663.226 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2018-03-23T17:54:42.390Z,1521827682.390 [NAL9602](INFO): Powering down 2018-03-23T17:55:51.208Z,1521827751.208 [DeadReckonWithRespectToSeafloor](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-03-23T17:55:51.208Z,1521827751.208 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2018-03-23T17:55:51.208Z,1521827751.208 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2018-03-23T17:55:51.221Z,1521827751.221 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2018-03-23T17:55:51.631Z,1521827751.631 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2018-03-23T17:55:51.631Z,1521827751.631 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2018-03-23T17:55:52.013Z,1521827752.013 [DeadReckonWithRespectToSeafloor](DEBUG): Initializing DeadReckonWithRespectToSeafloor component. 2018-03-23T17:55:52.013Z,1521827752.013 [DeadReckonWithRespectToSeafloor](INFO): Will consider orientation measurement stale after 120s. 2018-03-23T17:55:52.014Z,1521827752.014 [DeadReckonWithRespectToSeafloor](INFO): Will consider velocity measurement stale after 20s. 2018-03-23T17:57:36.146Z,1521827856.146 [CBIT](DEBUG): EFC running - data check-sum false 2018-03-23T17:58:52.294Z,1521827932.294 [DeadReckonWithRespectToSeafloor](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-03-23T17:58:52.295Z,1521827932.295 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2 2018-03-23T17:58:52.295Z,1521827932.295 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2018-03-23T17:58:52.319Z,1521827932.319 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2018-03-23T17:58:52.692Z,1521827932.692 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2018-03-23T17:58:52.692Z,1521827932.692 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2 2018-03-23T17:58:53.081Z,1521827933.081 [DeadReckonWithRespectToSeafloor](DEBUG): Initializing DeadReckonWithRespectToSeafloor component. 2018-03-23T17:58:53.081Z,1521827933.081 [DeadReckonWithRespectToSeafloor](INFO): Will consider orientation measurement stale after 120s. 2018-03-23T17:58:53.082Z,1521827933.082 [DeadReckonWithRespectToSeafloor](INFO): Will consider velocity measurement stale after 20s. 2018-03-23T17:59:23.490Z,1521827963.490 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2018-03-23T17:59:23.490Z,1521827963.490 [Default:CheckIn:C.Wait] Stopped 2018-03-23T17:59:23.490Z,1521827963.490 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2018-03-23T17:59:23.490Z,1521827963.490 [Default:CheckIn:D] Running Loop=1 2018-03-23T17:59:23.890Z,1521827963.890 [Default:CheckIn:D] Stopped 2018-03-23T17:59:23.890Z,1521827963.890 [Default:CheckIn:E] Running Loop=1 2018-03-23T17:59:24.292Z,1521827964.292 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 48.498572 min 2018-03-23T17:59:24.292Z,1521827964.292 [Default:CheckIn:E] Stopped 2018-03-23T17:59:24.293Z,1521827964.293 [Default:CheckIn](INFO): Completed Default:CheckIn 2018-03-23T17:59:24.293Z,1521827964.293 [Default:CheckIn] Stopped 2018-03-23T17:59:24.293Z,1521827964.293 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2018-03-23T17:59:24.293Z,1521827964.293 [Default:CheckIn](INFO): Running loop #6 2018-03-23T17:59:24.293Z,1521827964.293 [Default:CheckIn] Running Loop=6 2018-03-23T17:59:24.293Z,1521827964.293 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2018-03-23T17:59:24.293Z,1521827964.293 [Default:CheckIn:Read_GPS] Running Loop=1 2018-03-23T17:59:25.047Z,1521827965.047 [NAL9602](INFO): Powering up 2018-03-23T17:59:35.858Z,1521827975.858 [NAL9602](INFO): NAL9602 initialized 2018-03-23T18:00:59.887Z,1521828059.887 [NAL9602](INFO): SBD MO Status=0, MOMSN=5602, MT Status=0, MTMSN=0 2018-03-23T18:00:59.887Z,1521828059.887 [NAL9602](INFO): No messages in MT queue 2018-03-23T18:01:53.178Z,1521828113.178 [DeadReckonWithRespectToSeafloor](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-03-23T18:01:53.178Z,1521828113.178 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 3 2018-03-23T18:01:53.178Z,1521828113.178 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2018-03-23T18:01:53.190Z,1521828113.190 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2018-03-23T18:01:53.598Z,1521828113.598 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2018-03-23T18:01:53.598Z,1521828113.598 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 3 2018-03-23T18:01:53.980Z,1521828113.980 [DeadReckonWithRespectToSeafloor](DEBUG): Initializing DeadReckonWithRespectToSeafloor component. 2018-03-23T18:01:53.980Z,1521828113.980 [DeadReckonWithRespectToSeafloor](INFO): Will consider orientation measurement stale after 120s. 2018-03-23T18:01:53.981Z,1521828113.981 [DeadReckonWithRespectToSeafloor](INFO): Will consider velocity measurement stale after 20s. 2018-03-23T18:04:24.396Z,1521828264.396 [Default:CheckIn:Read_GPS](INFO): Timed out from 2018-03-23T17:59:24.3Z 2018-03-23T18:04:24.396Z,1521828264.396 [Default:CheckIn:Read_GPS] Stopped 2018-03-23T18:04:24.397Z,1521828264.397 [Default:CheckIn:Read_Iridium] Running Loop=1 2018-03-23T18:04:28.743Z,1521828268.743 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20180323T173617/Courier0012.lzma 2018-03-23T18:04:29.521Z,1521828269.521 [DataOverHttps](INFO): Moved sent file to Logs/20180323T173617/Courier0012.lzma.bak 2018-03-23T18:04:29.521Z,1521828269.521 [DataOverHttps](INFO): SBD MOMSN=8181264 2018-03-23T18:04:38.892Z,1521828278.892 [DataOverHttps](INFO): Sending 121 bytes from file Logs/20180323T173617/Express0013.lzma 2018-03-23T18:04:39.689Z,1521828279.689 [DataOverHttps](INFO): Moved sent file to Logs/20180323T173617/Express0013.lzma.bak 2018-03-23T18:04:39.690Z,1521828279.690 [DataOverHttps](INFO): SBD MOMSN=8181266 2018-03-23T18:04:40.345Z,1521828280.345 [Default:CheckIn:Read_Iridium] Stopped 2018-03-23T18:04:40.345Z,1521828280.345 [Default:CheckIn:C.Wait] Running Loop=1 2018-03-23T18:04:40.345Z,1521828280.345 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2018-03-23T18:04:54.200Z,1521828294.200 [DeadReckonWithRespectToSeafloor](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-03-23T18:04:54.200Z,1521828294.200 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 4 2018-03-23T18:04:54.200Z,1521828294.200 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2018-03-23T18:04:54.212Z,1521828294.212 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2018-03-23T18:04:54.649Z,1521828294.649 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2018-03-23T18:04:54.649Z,1521828294.649 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 4 2018-03-23T18:04:54.958Z,1521828294.958 [NAL9602](INFO): Powering down 2018-03-23T18:04:55.031Z,1521828295.031 [DeadReckonWithRespectToSeafloor](DEBUG): Initializing DeadReckonWithRespectToSeafloor component. 2018-03-23T18:04:55.031Z,1521828295.031 [DeadReckonWithRespectToSeafloor](INFO): Will consider orientation measurement stale after 120s. 2018-03-23T18:04:55.032Z,1521828295.032 [DeadReckonWithRespectToSeafloor](INFO): Will consider velocity measurement stale after 20s. 2018-03-23T18:07:36.377Z,1521828456.377 [CBIT](DEBUG): EFC running - data check-sum false 2018-03-23T18:07:55.170Z,1521828475.170 [DeadReckonWithRespectToSeafloor](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-03-23T18:07:55.170Z,1521828475.170 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 5 2018-03-23T18:07:55.170Z,1521828475.170 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2018-03-23T18:07:55.182Z,1521828475.182 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2018-03-23T18:07:55.592Z,1521828475.592 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2018-03-23T18:07:55.592Z,1521828475.592 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 5 2018-03-23T18:07:55.980Z,1521828475.980 [DeadReckonWithRespectToSeafloor](DEBUG): Initializing DeadReckonWithRespectToSeafloor component. 2018-03-23T18:07:55.980Z,1521828475.980 [DeadReckonWithRespectToSeafloor](INFO): Will consider orientation measurement stale after 120s. 2018-03-23T18:07:55.980Z,1521828475.980 [DeadReckonWithRespectToSeafloor](INFO): Will consider velocity measurement stale after 20s. 2018-03-23T18:09:40.890Z,1521828580.890 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2018-03-23T18:09:40.890Z,1521828580.890 [Default:CheckIn:C.Wait] Stopped 2018-03-23T18:09:40.890Z,1521828580.890 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2018-03-23T18:09:40.891Z,1521828580.891 [Default:CheckIn:D] Running Loop=1 2018-03-23T18:09:41.295Z,1521828581.295 [Default:CheckIn:D] Stopped 2018-03-23T18:09:41.295Z,1521828581.295 [Default:CheckIn:E] Running Loop=1 2018-03-23T18:09:44.597Z,1521828584.597 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 58.788652 min 2018-03-23T18:09:44.597Z,1521828584.597 [Default:CheckIn:E] Stopped 2018-03-23T18:09:44.598Z,1521828584.598 [Default:CheckIn](INFO): Completed Default:CheckIn 2018-03-23T18:09:44.598Z,1521828584.598 [Default:CheckIn] Stopped 2018-03-23T18:09:44.598Z,1521828584.598 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2018-03-23T18:09:44.598Z,1521828584.598 [Default:CheckIn](INFO): Running loop #7 2018-03-23T18:09:44.598Z,1521828584.598 [Default:CheckIn] Running Loop=7 2018-03-23T18:09:44.598Z,1521828584.598 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2018-03-23T18:09:44.598Z,1521828584.598 [Default:CheckIn:Read_GPS] Running Loop=1 2018-03-23T18:09:45.046Z,1521828585.046 [NAL9602](INFO): Powering up 2018-03-23T18:09:56.242Z,1521828596.242 [NAL9602](INFO): NAL9602 initialized 2018-03-23T18:09:57.042Z,1521828597.042 [NAL9602](FAULT): GPS failed to acquire within timeout. 2018-03-23T18:09:57.042Z,1521828597.042 [NAL9602] Data Fault, FailCount= 1 2018-03-23T18:09:57.042Z,1521828597.042 [NAL9602](ERROR): Data Fault 2018-03-23T18:09:57.135Z,1521828597.135 [CBIT](ERROR): Data Fault in component: NAL9602 2018-03-23T18:09:57.442Z,1521828597.442 [NAL9602](INFO): Powering down 2018-03-23T18:09:58.309Z,1521828598.309 [CBIT](INFO): Clearing failed state for component NAL9602 2018-03-23T18:09:58.309Z,1521828598.309 [NAL9602] No Fault, FailCount= 1 2018-03-23T18:10:27.846Z,1521828627.846 [NAL9602](INFO): Powering up NAL9602 2018-03-23T18:10:39.049Z,1521828639.049 [NAL9602](INFO): NAL9602 initialized 2018-03-23T18:10:56.308Z,1521828656.308 [DeadReckonWithRespectToSeafloor](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-03-23T18:10:56.308Z,1521828656.308 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 6 2018-03-23T18:10:56.308Z,1521828656.308 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2018-03-23T18:10:56.321Z,1521828656.321 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2018-03-23T18:10:56.767Z,1521828656.767 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2018-03-23T18:10:56.767Z,1521828656.767 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 6 2018-03-23T18:10:57.126Z,1521828657.126 [DeadReckonWithRespectToSeafloor](DEBUG): Initializing DeadReckonWithRespectToSeafloor component. 2018-03-23T18:10:57.126Z,1521828657.126 [DeadReckonWithRespectToSeafloor](INFO): Will consider orientation measurement stale after 120s. 2018-03-23T18:10:57.127Z,1521828657.127 [DeadReckonWithRespectToSeafloor](INFO): Will consider velocity measurement stale after 20s. 2018-03-23T18:11:11.856Z,1521828671.856 [NAL9602](INFO): SBD MO Status=0, MOMSN=5603, MT Status=0, MTMSN=0 2018-03-23T18:11:11.856Z,1521828671.856 [NAL9602](INFO): No messages in MT queue 2018-03-23T18:13:57.442Z,1521828837.442 [DeadReckonWithRespectToSeafloor](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-03-23T18:13:57.442Z,1521828837.442 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 7 2018-03-23T18:13:57.442Z,1521828837.442 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2018-03-23T18:13:57.454Z,1521828837.454 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2018-03-23T18:13:57.851Z,1521828837.851 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2018-03-23T18:13:57.851Z,1521828837.851 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 7 2018-03-23T18:13:58.255Z,1521828838.255 [DeadReckonWithRespectToSeafloor](DEBUG): Initializing DeadReckonWithRespectToSeafloor component. 2018-03-23T18:13:58.256Z,1521828838.256 [DeadReckonWithRespectToSeafloor](INFO): Will consider orientation measurement stale after 120s. 2018-03-23T18:13:58.256Z,1521828838.256 [DeadReckonWithRespectToSeafloor](INFO): Will consider velocity measurement stale after 20s. 2018-03-23T18:14:45.350Z,1521828885.350 [Default:CheckIn:Read_GPS](INFO): Timed out from 2018-03-23T18:09:44.6Z 2018-03-23T18:14:45.350Z,1521828885.350 [Default:CheckIn:Read_GPS] Stopped 2018-03-23T18:14:45.350Z,1521828885.350 [Default:CheckIn:Read_Iridium] Running Loop=1 2018-03-23T18:14:45.862Z,1521828885.862 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20180323T173617/Courier0016.lzma 2018-03-23T18:14:46.569Z,1521828886.569 [DataOverHttps](INFO): Moved sent file to Logs/20180323T173617/Courier0016.lzma.bak 2018-03-23T18:14:46.570Z,1521828886.570 [DataOverHttps](INFO): SBD MOMSN=8181341 2018-03-23T18:14:55.644Z,1521828895.644 [DataOverHttps](INFO): Sending 186 bytes from file Logs/20180323T173617/Express0017.lzma 2018-03-23T18:14:56.441Z,1521828896.441 [DataOverHttps](INFO): Moved sent file to Logs/20180323T173617/Express0017.lzma.bak 2018-03-23T18:14:56.442Z,1521828896.442 [DataOverHttps](INFO): SBD MOMSN=8181343 2018-03-23T18:14:57.292Z,1521828897.292 [Default:CheckIn:Read_Iridium] Stopped 2018-03-23T18:14:57.292Z,1521828897.292 [Default:CheckIn:C.Wait] Running Loop=1 2018-03-23T18:14:57.292Z,1521828897.292 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2018-03-23T18:15:17.438Z,1521828917.438 [NAL9602](INFO): Powering down 2018-03-23T18:16:58.273Z,1521829018.273 [DeadReckonWithRespectToSeafloor](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-03-23T18:16:58.273Z,1521829018.273 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 8 2018-03-23T18:16:58.273Z,1521829018.273 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2018-03-23T18:16:58.338Z,1521829018.338 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2018-03-23T18:17:01.710Z,1521829021.710 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2018-03-23T18:17:01.710Z,1521829021.710 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 8 2018-03-23T18:17:01.871Z,1521829021.871 [DeadReckonWithRespectToSeafloor](DEBUG): Initializing DeadReckonWithRespectToSeafloor component. 2018-03-23T18:17:01.871Z,1521829021.871 [DeadReckonWithRespectToSeafloor](INFO): Will consider orientation measurement stale after 120s. 2018-03-23T18:17:01.872Z,1521829021.872 [DeadReckonWithRespectToSeafloor](INFO): Will consider velocity measurement stale after 20s. 2018-03-23T18:17:36.588Z,1521829056.588 [CBIT](DEBUG): EFC running - data check-sum false 2018-03-23T18:19:57.764Z,1521829197.764 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2018-03-23T18:19:57.764Z,1521829197.764 [Default:CheckIn:C.Wait] Stopped 2018-03-23T18:19:57.764Z,1521829197.764 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2018-03-23T18:19:57.764Z,1521829197.764 [Default:CheckIn:D] Running Loop=1 2018-03-23T18:19:58.159Z,1521829198.159 [Default:CheckIn:D] Stopped 2018-03-23T18:19:58.159Z,1521829198.159 [Default:CheckIn:E] Running Loop=1 2018-03-23T18:19:58.562Z,1521829198.562 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 69.069710 min 2018-03-23T18:19:58.563Z,1521829198.563 [Default:CheckIn:E] Stopped 2018-03-23T18:19:58.563Z,1521829198.563 [Default:CheckIn](INFO): Completed Default:CheckIn 2018-03-23T18:19:58.563Z,1521829198.563 [Default:CheckIn] Stopped 2018-03-23T18:19:58.563Z,1521829198.563 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2018-03-23T18:19:58.563Z,1521829198.563 [Default:CheckIn](INFO): Running loop #8 2018-03-23T18:19:58.563Z,1521829198.563 [Default:CheckIn] Running Loop=8 2018-03-23T18:19:58.563Z,1521829198.563 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2018-03-23T18:19:58.563Z,1521829198.563 [Default:CheckIn:Read_GPS] Running Loop=1 2018-03-23T18:20:02.098Z,1521829202.098 [NAL9602](INFO): Powering up 2018-03-23T18:20:02.178Z,1521829202.178 [DeadReckonWithRespectToSeafloor](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-03-23T18:20:02.179Z,1521829202.179 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 9 2018-03-23T18:20:02.179Z,1521829202.179 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2018-03-23T18:20:02.204Z,1521829202.204 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2018-03-23T18:20:02.300Z,1521829202.300 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2018-03-23T18:20:02.300Z,1521829202.300 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 9 2018-03-23T18:20:02.677Z,1521829202.677 [DeadReckonWithRespectToSeafloor](DEBUG): Initializing DeadReckonWithRespectToSeafloor component. 2018-03-23T18:20:02.678Z,1521829202.678 [DeadReckonWithRespectToSeafloor](INFO): Will consider orientation measurement stale after 120s. 2018-03-23T18:20:02.678Z,1521829202.678 [DeadReckonWithRespectToSeafloor](INFO): Will consider velocity measurement stale after 20s. 2018-03-23T18:20:13.022Z,1521829213.022 [NAL9602](INFO): NAL9602 initialized 2018-03-23T18:23:02.958Z,1521829382.958 [DeadReckonWithRespectToSeafloor](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-03-23T18:23:02.958Z,1521829382.958 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 10 2018-03-23T18:23:02.958Z,1521829382.958 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2018-03-23T18:23:02.994Z,1521829382.994 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2018-03-23T18:23:03.123Z,1521829383.123 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2018-03-23T18:23:03.123Z,1521829383.123 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 10 2018-03-23T18:23:03.460Z,1521829383.460 [DeadReckonWithRespectToSeafloor](DEBUG): Initializing DeadReckonWithRespectToSeafloor component. 2018-03-23T18:23:03.460Z,1521829383.460 [DeadReckonWithRespectToSeafloor](INFO): Will consider orientation measurement stale after 120s. 2018-03-23T18:23:03.460Z,1521829383.460 [DeadReckonWithRespectToSeafloor](INFO): Will consider velocity measurement stale after 20s. 2018-03-23T18:24:58.880Z,1521829498.880 [Default:CheckIn:Read_GPS](INFO): Timed out from 2018-03-23T18:19:58.6Z 2018-03-23T18:24:58.880Z,1521829498.880 [Default:CheckIn:Read_GPS] Stopped 2018-03-23T18:24:58.880Z,1521829498.880 [Default:CheckIn:Read_Iridium] Running Loop=1 2018-03-23T18:25:03.222Z,1521829503.222 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20180323T173617/Courier0020.lzma 2018-03-23T18:25:04.013Z,1521829504.013 [DataOverHttps](INFO): Moved sent file to Logs/20180323T173617/Courier0020.lzma.bak 2018-03-23T18:25:04.014Z,1521829504.014 [DataOverHttps](INFO): SBD MOMSN=8181423 2018-03-23T18:25:13.034Z,1521829513.034 [DataOverHttps](INFO): Sending 120 bytes from file Logs/20180323T173617/Express0021.lzma 2018-03-23T18:25:13.833Z,1521829513.833 [DataOverHttps](INFO): Moved sent file to Logs/20180323T173617/Express0021.lzma.bak 2018-03-23T18:25:13.834Z,1521829513.834 [DataOverHttps](INFO): SBD MOMSN=8181425 2018-03-23T18:25:14.448Z,1521829514.448 [Default:CheckIn:Read_Iridium] Stopped 2018-03-23T18:25:14.448Z,1521829514.448 [Default:CheckIn:C.Wait] Running Loop=1 2018-03-23T18:25:14.448Z,1521829514.448 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2018-03-23T18:25:17.744Z,1521829517.744 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2018-03-23T18:25:48.254Z,1521829548.254 [NAL9602](INFO): Powering down 2018-03-23T18:26:03.498Z,1521829563.498 [DeadReckonWithRespectToSeafloor](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-03-23T18:26:03.498Z,1521829563.498 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 11 2018-03-23T18:26:03.498Z,1521829563.498 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2018-03-23T18:26:03.527Z,1521829563.527 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2018-03-23T18:26:03.905Z,1521829563.905 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2018-03-23T18:26:03.905Z,1521829563.905 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 11 2018-03-23T18:26:04.293Z,1521829564.293 [DeadReckonWithRespectToSeafloor](DEBUG): Initializing DeadReckonWithRespectToSeafloor component. 2018-03-23T18:26:04.294Z,1521829564.294 [DeadReckonWithRespectToSeafloor](INFO): Will consider orientation measurement stale after 120s. 2018-03-23T18:26:04.294Z,1521829564.294 [DeadReckonWithRespectToSeafloor](INFO): Will consider velocity measurement stale after 20s. 2018-03-23T18:27:36.770Z,1521829656.770 [CBIT](DEBUG): EFC running - data check-sum false 2018-03-23T18:29:04.513Z,1521829744.513 [DeadReckonWithRespectToSeafloor](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-03-23T18:29:04.513Z,1521829744.513 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 12 2018-03-23T18:29:04.514Z,1521829744.514 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2018-03-23T18:29:04.559Z,1521829744.559 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2018-03-23T18:29:04.953Z,1521829744.953 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2018-03-23T18:29:04.953Z,1521829744.953 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 12 2018-03-23T18:29:05.315Z,1521829745.315 [DeadReckonWithRespectToSeafloor](DEBUG): Initializing DeadReckonWithRespectToSeafloor component. 2018-03-23T18:29:05.315Z,1521829745.315 [DeadReckonWithRespectToSeafloor](INFO): Will consider orientation measurement stale after 120s. 2018-03-23T18:29:05.315Z,1521829745.315 [DeadReckonWithRespectToSeafloor](INFO): Will consider velocity measurement stale after 20s. 2018-03-23T18:30:14.951Z,1521829814.951 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2018-03-23T18:30:14.951Z,1521829814.951 [Default:CheckIn:C.Wait] Stopped 2018-03-23T18:30:14.951Z,1521829814.951 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2018-03-23T18:30:14.951Z,1521829814.951 [Default:CheckIn:D] Running Loop=1 2018-03-23T18:30:15.345Z,1521829815.345 [Default:CheckIn:D] Stopped 2018-03-23T18:30:15.345Z,1521829815.345 [Default:CheckIn:E] Running Loop=1 2018-03-23T18:30:18.594Z,1521829818.594 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 79.356144 min 2018-03-23T18:30:18.594Z,1521829818.594 [Default:CheckIn:E] Stopped 2018-03-23T18:30:18.594Z,1521829818.594 [Default:CheckIn](INFO): Completed Default:CheckIn 2018-03-23T18:30:18.594Z,1521829818.594 [Default:CheckIn] Stopped 2018-03-23T18:30:18.594Z,1521829818.594 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2018-03-23T18:30:18.595Z,1521829818.595 [Default:CheckIn](INFO): Running loop #9 2018-03-23T18:30:18.595Z,1521829818.595 [Default:CheckIn] Running Loop=9 2018-03-23T18:30:18.595Z,1521829818.595 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2018-03-23T18:30:18.595Z,1521829818.595 [Default:CheckIn:Read_GPS] Running Loop=1 2018-03-23T18:30:19.018Z,1521829819.018 [NAL9602](INFO): Powering up 2018-03-23T18:30:30.214Z,1521829830.214 [NAL9602](INFO): NAL9602 initialized 2018-03-23T18:30:31.014Z,1521829831.014 [NAL9602](FAULT): GPS failed to acquire within timeout. 2018-03-23T18:30:31.014Z,1521829831.014 [NAL9602] Data Fault, FailCount= 1 2018-03-23T18:30:31.014Z,1521829831.014 [NAL9602](ERROR): Data Fault 2018-03-23T18:30:31.097Z,1521829831.097 [CBIT](ERROR): Data Fault in component: NAL9602 2018-03-23T18:30:31.414Z,1521829831.414 [NAL9602](INFO): Powering down 2018-03-23T18:30:32.275Z,1521829832.275 [CBIT](INFO): Clearing failed state for component NAL9602 2018-03-23T18:30:32.275Z,1521829832.275 [NAL9602] No Fault, FailCount= 1 2018-03-23T18:31:01.418Z,1521829861.418 [NAL9602](INFO): Powering up NAL9602 2018-03-23T18:31:12.619Z,1521829872.619 [NAL9602](INFO): NAL9602 initialized 2018-03-23T18:32:05.644Z,1521829925.644 [DeadReckonWithRespectToSeafloor](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-03-23T18:32:05.644Z,1521829925.644 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 13 2018-03-23T18:32:05.644Z,1521829925.644 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2018-03-23T18:32:05.657Z,1521829925.657 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2018-03-23T18:32:06.082Z,1521829926.082 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2018-03-23T18:32:06.082Z,1521829926.082 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 13 2018-03-23T18:32:06.446Z,1521829926.446 [DeadReckonWithRespectToSeafloor](DEBUG): Initializing DeadReckonWithRespectToSeafloor component. 2018-03-23T18:32:06.446Z,1521829926.446 [DeadReckonWithRespectToSeafloor](INFO): Will consider orientation measurement stale after 120s. 2018-03-23T18:32:06.447Z,1521829926.447 [DeadReckonWithRespectToSeafloor](INFO): Will consider velocity measurement stale after 20s. 2018-03-23T18:35:06.546Z,1521830106.546 [DeadReckonWithRespectToSeafloor](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-03-23T18:35:06.546Z,1521830106.546 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 14 2018-03-23T18:35:06.546Z,1521830106.546 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2018-03-23T18:35:06.587Z,1521830106.587 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2018-03-23T18:35:07.005Z,1521830107.005 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2018-03-23T18:35:07.005Z,1521830107.005 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 14 2018-03-23T18:35:07.346Z,1521830107.346 [DeadReckonWithRespectToSeafloor](DEBUG): Initializing DeadReckonWithRespectToSeafloor component. 2018-03-23T18:35:07.347Z,1521830107.347 [DeadReckonWithRespectToSeafloor](INFO): Will consider orientation measurement stale after 120s. 2018-03-23T18:35:07.347Z,1521830107.347 [DeadReckonWithRespectToSeafloor](INFO): Will consider velocity measurement stale after 20s. 2018-03-23T18:35:19.261Z,1521830119.261 [Default:CheckIn:Read_GPS](INFO): Timed out from 2018-03-23T18:30:18.6Z 2018-03-23T18:35:19.261Z,1521830119.261 [Default:CheckIn:Read_GPS] Stopped 2018-03-23T18:35:19.262Z,1521830119.262 [Default:CheckIn:Read_Iridium] Running Loop=1 2018-03-23T18:35:24.176Z,1521830124.176 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20180323T173617/Courier0024.lzma 2018-03-23T18:35:24.979Z,1521830124.979 [DataOverHttps](INFO): Moved sent file to Logs/20180323T173617/Courier0024.lzma.bak 2018-03-23T18:35:24.979Z,1521830124.979 [DataOverHttps](INFO): SBD MOMSN=8181494 2018-03-23T18:35:34.556Z,1521830134.556 [DataOverHttps](INFO): Sending 214 bytes from file Logs/20180323T173617/Express0025.lzma 2018-03-23T18:35:35.754Z,1521830135.754 [DataOverHttps](INFO): Moved sent file to Logs/20180323T173617/Express0025.lzma.bak 2018-03-23T18:35:35.754Z,1521830135.754 [DataOverHttps](INFO): SBD MOMSN=8181496 2018-03-23T18:35:36.377Z,1521830136.377 [Default:CheckIn:Read_Iridium] Stopped 2018-03-23T18:35:36.377Z,1521830136.377 [Default:CheckIn:C.Wait] Running Loop=1 2018-03-23T18:35:36.377Z,1521830136.377 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2018-03-23T18:36:19.037Z,1521830179.037 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2018-03-23T18:36:49.445Z,1521830209.445 [NAL9602](INFO): Powering down 2018-03-23T18:37:37.104Z,1521830257.104 [CBIT](DEBUG): EFC running - data check-sum false 2018-03-23T18:38:07.506Z,1521830287.506 [DeadReckonWithRespectToSeafloor](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-03-23T18:38:07.506Z,1521830287.506 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 15 2018-03-23T18:38:07.506Z,1521830287.506 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2018-03-23T18:38:07.551Z,1521830287.551 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2018-03-23T18:38:07.936Z,1521830287.936 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2018-03-23T18:38:07.936Z,1521830287.936 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 15 2018-03-23T18:38:08.307Z,1521830288.307 [DeadReckonWithRespectToSeafloor](DEBUG): Initializing DeadReckonWithRespectToSeafloor component. 2018-03-23T18:38:08.308Z,1521830288.308 [DeadReckonWithRespectToSeafloor](INFO): Will consider orientation measurement stale after 120s. 2018-03-23T18:38:08.308Z,1521830288.308 [DeadReckonWithRespectToSeafloor](INFO): Will consider velocity measurement stale after 20s. 2018-03-23T18:40:36.804Z,1521830436.804 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2018-03-23T18:40:36.805Z,1521830436.805 [Default:CheckIn:C.Wait] Stopped 2018-03-23T18:40:36.805Z,1521830436.805 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2018-03-23T18:40:36.805Z,1521830436.805 [Default:CheckIn:D] Running Loop=1 2018-03-23T18:40:37.211Z,1521830437.211 [Default:CheckIn:D] Stopped 2018-03-23T18:40:37.211Z,1521830437.211 [Default:CheckIn:E] Running Loop=1 2018-03-23T18:40:40.351Z,1521830440.351 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 89.720581 min 2018-03-23T18:40:40.352Z,1521830440.352 [Default:CheckIn:E] Stopped 2018-03-23T18:40:40.352Z,1521830440.352 [Default:CheckIn](INFO): Completed Default:CheckIn 2018-03-23T18:40:40.352Z,1521830440.352 [Default:CheckIn] Stopped 2018-03-23T18:40:40.352Z,1521830440.352 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2018-03-23T18:40:40.352Z,1521830440.352 [Default:CheckIn](INFO): Running loop #10 2018-03-23T18:40:40.352Z,1521830440.352 [Default:CheckIn] Running Loop=10 2018-03-23T18:40:40.352Z,1521830440.352 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2018-03-23T18:40:40.353Z,1521830440.353 [Default:CheckIn:Read_GPS] Running Loop=1 2018-03-23T18:40:40.774Z,1521830440.774 [NAL9602](INFO): Powering up 2018-03-23T18:40:51.975Z,1521830451.975 [NAL9602](INFO): NAL9602 initialized 2018-03-23T18:41:08.422Z,1521830468.422 [DeadReckonWithRespectToSeafloor](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-03-23T18:41:08.423Z,1521830468.423 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 16 2018-03-23T18:41:08.423Z,1521830468.423 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2018-03-23T18:41:08.435Z,1521830468.435 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2018-03-23T18:41:08.837Z,1521830468.837 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2018-03-23T18:41:08.837Z,1521830468.837 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 16 2018-03-23T18:41:09.228Z,1521830469.228 [DeadReckonWithRespectToSeafloor](DEBUG): Initializing DeadReckonWithRespectToSeafloor component. 2018-03-23T18:41:09.228Z,1521830469.228 [DeadReckonWithRespectToSeafloor](INFO): Will consider orientation measurement stale after 120s. 2018-03-23T18:41:09.233Z,1521830469.233 [DeadReckonWithRespectToSeafloor](INFO): Will consider velocity measurement stale after 20s. 2018-03-23T18:41:23.970Z,1521830483.970 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2018-03-23T18:41:24.045Z,1521830484.045 [NAL9602](FAULT): received: +CSQ:0 OK03, 0, 0, 0, 0 OK 2018-03-23T18:41:24.045Z,1521830484.045 [NAL9602] Data Fault, FailCount= 2 2018-03-23T18:41:24.045Z,1521830484.045 [NAL9602](ERROR): Data Fault 2018-03-23T18:41:24.111Z,1521830484.111 [CBIT](ERROR): Data Fault in component: NAL9602 2018-03-23T18:41:24.370Z,1521830484.370 [NAL9602](INFO): Powering down 2018-03-23T18:41:25.232Z,1521830485.232 [CBIT](INFO): Clearing failed state for component NAL9602 2018-03-23T18:41:25.232Z,1521830485.232 [NAL9602] No Fault, FailCount= 2 2018-03-23T18:41:54.742Z,1521830514.742 [NAL9602](INFO): Powering up NAL9602 2018-03-23T18:42:05.942Z,1521830525.942 [NAL9602](INFO): NAL9602 initialized 2018-03-23T18:42:06.742Z,1521830526.742 [NAL9602](FAULT): GPS failed to acquire within timeout. 2018-03-23T18:42:06.742Z,1521830526.742 [NAL9602] Data Fault, FailCount= 3 2018-03-23T18:42:06.742Z,1521830526.742 [NAL9602](ERROR): Data Fault 2018-03-23T18:42:06.826Z,1521830526.826 [CBIT](ERROR): Data Fault in component: NAL9602 2018-03-23T18:42:07.142Z,1521830527.142 [NAL9602](INFO): Powering down 2018-03-23T18:42:08.005Z,1521830528.005 [CBIT](INFO): Clearing failed state for component NAL9602 2018-03-23T18:42:08.005Z,1521830528.005 [NAL9602] No Fault, FailCount= 3 2018-03-23T18:42:37.146Z,1521830557.146 [NAL9602](INFO): Powering up NAL9602 2018-03-23T18:42:48.330Z,1521830568.330 [NAL9602](INFO): NAL9602 initialized 2018-03-23T18:43:13.131Z,1521830593.131 [NAL9602](INFO): SBD MO Status=2, MOMSN=5604, MT Status=2, MTMSN=0 2018-03-23T18:43:13.131Z,1521830593.131 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2018-03-23T18:44:09.256Z,1521830649.256 [DeadReckonWithRespectToSeafloor](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-03-23T18:44:09.256Z,1521830649.256 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 17 2018-03-23T18:44:09.256Z,1521830649.256 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2018-03-23T18:44:09.268Z,1521830649.268 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2018-03-23T18:44:09.665Z,1521830649.665 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2018-03-23T18:44:09.665Z,1521830649.665 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 17 2018-03-23T18:44:10.035Z,1521830650.035 [DeadReckonWithRespectToSeafloor](DEBUG): Initializing DeadReckonWithRespectToSeafloor component. 2018-03-23T18:44:10.036Z,1521830650.036 [DeadReckonWithRespectToSeafloor](INFO): Will consider orientation measurement stale after 120s. 2018-03-23T18:44:10.036Z,1521830650.036 [DeadReckonWithRespectToSeafloor](INFO): Will consider velocity measurement stale after 20s. 2018-03-23T18:45:41.339Z,1521830741.339 [Default:CheckIn:Read_GPS](INFO): Timed out from 2018-03-23T18:40:40.4Z 2018-03-23T18:45:41.339Z,1521830741.339 [Default:CheckIn:Read_GPS] Stopped 2018-03-23T18:45:41.339Z,1521830741.339 [Default:CheckIn:Read_Iridium] Running Loop=1 2018-03-23T18:45:41.849Z,1521830741.849 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20180323T173617/Courier0028.lzma 2018-03-23T18:45:42.557Z,1521830742.557 [DataOverHttps](INFO): Moved sent file to Logs/20180323T173617/Courier0028.lzma.bak 2018-03-23T18:45:42.558Z,1521830742.558 [DataOverHttps](INFO): SBD MOMSN=8181574 2018-03-23T18:45:52.240Z,1521830752.240 [DataOverHttps](INFO): Sending 251 bytes from file Logs/20180323T173617/Express0029.lzma 2018-03-23T18:45:53.038Z,1521830753.038 [DataOverHttps](INFO): Moved sent file to Logs/20180323T173617/Express0029.lzma.bak 2018-03-23T18:45:53.038Z,1521830753.038 [DataOverHttps](INFO): SBD MOMSN=8181576 2018-03-23T18:45:53.648Z,1521830753.648 [Default:CheckIn:Read_Iridium] Stopped 2018-03-23T18:45:53.648Z,1521830753.648 [Default:CheckIn:C.Wait] Running Loop=1 2018-03-23T18:45:53.648Z,1521830753.648 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2018-03-23T18:45:56.959Z,1521830756.959 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2018-03-23T18:46:27.462Z,1521830787.462 [NAL9602](INFO): Powering down 2018-03-23T18:47:10.085Z,1521830830.085 [DeadReckonWithRespectToSeafloor](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-03-23T18:47:10.085Z,1521830830.085 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 18 2018-03-23T18:47:10.085Z,1521830830.085 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2018-03-23T18:47:10.117Z,1521830830.117 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2018-03-23T18:47:10.517Z,1521830830.517 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2018-03-23T18:47:10.517Z,1521830830.517 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 18 2018-03-23T18:47:10.880Z,1521830830.880 [DeadReckonWithRespectToSeafloor](DEBUG): Initializing DeadReckonWithRespectToSeafloor component. 2018-03-23T18:47:10.880Z,1521830830.880 [DeadReckonWithRespectToSeafloor](INFO): Will consider orientation measurement stale after 120s. 2018-03-23T18:47:10.880Z,1521830830.880 [DeadReckonWithRespectToSeafloor](INFO): Will consider velocity measurement stale after 20s. 2018-03-23T18:47:37.322Z,1521830857.322 [CBIT](DEBUG): EFC running - data check-sum false 2018-03-23T18:50:11.088Z,1521831011.088 [DeadReckonWithRespectToSeafloor](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-03-23T18:50:11.088Z,1521831011.088 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 19 2018-03-23T18:50:11.088Z,1521831011.088 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2018-03-23T18:50:11.101Z,1521831011.101 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2018-03-23T18:50:11.497Z,1521831011.497 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2018-03-23T18:50:11.497Z,1521831011.497 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 19 2018-03-23T18:50:11.893Z,1521831011.893 [DeadReckonWithRespectToSeafloor](DEBUG): Initializing DeadReckonWithRespectToSeafloor component. 2018-03-23T18:50:11.894Z,1521831011.894 [DeadReckonWithRespectToSeafloor](INFO): Will consider orientation measurement stale after 120s. 2018-03-23T18:50:11.894Z,1521831011.894 [DeadReckonWithRespectToSeafloor](INFO): Will consider velocity measurement stale after 20s. 2018-03-23T18:50:54.297Z,1521831054.297 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2018-03-23T18:50:54.297Z,1521831054.297 [Default:CheckIn:C.Wait] Stopped 2018-03-23T18:50:54.297Z,1521831054.297 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2018-03-23T18:50:54.298Z,1521831054.298 [Default:CheckIn:D] Running Loop=1 2018-03-23T18:50:54.690Z,1521831054.690 [Default:CheckIn:D] Stopped 2018-03-23T18:50:54.690Z,1521831054.690 [Default:CheckIn:E] Running Loop=1 2018-03-23T18:50:57.897Z,1521831057.897 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 100.011898 min 2018-03-23T18:50:57.897Z,1521831057.897 [Default:CheckIn:E] Stopped 2018-03-23T18:50:57.897Z,1521831057.897 [Default:CheckIn](INFO): Completed Default:CheckIn 2018-03-23T18:50:57.897Z,1521831057.897 [Default:CheckIn] Stopped 2018-03-23T18:50:57.898Z,1521831057.898 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2018-03-23T18:50:57.898Z,1521831057.898 [Default:CheckIn](INFO): Running loop #11 2018-03-23T18:50:57.898Z,1521831057.898 [Default:CheckIn] Running Loop=11 2018-03-23T18:50:57.898Z,1521831057.898 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2018-03-23T18:50:57.898Z,1521831057.898 [Default:CheckIn:Read_GPS] Running Loop=1 2018-03-23T18:50:58.362Z,1521831058.362 [NAL9602](INFO): Powering up 2018-03-23T18:51:09.158Z,1521831069.158 [NAL9602](INFO): NAL9602 initialized 2018-03-23T18:51:41.162Z,1521831101.162 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2018-03-23T18:51:41.241Z,1521831101.241 [NAL9602](FAULT): received: +CSQ:0 OK04, 2, 0, 0, 0 OK 2018-03-23T18:51:41.241Z,1521831101.241 [NAL9602] Data Fault, FailCount= 4 2018-03-23T18:51:41.241Z,1521831101.241 [NAL9602](ERROR): Data Fault 2018-03-23T18:51:41.327Z,1521831101.327 [CBIT](ERROR): Data Fault in component: NAL9602 2018-03-23T18:51:41.558Z,1521831101.558 [NAL9602](INFO): Powering down 2018-03-23T18:51:42.441Z,1521831102.441 [CBIT](INFO): Clearing failed state for component NAL9602 2018-03-23T18:51:42.441Z,1521831102.441 [NAL9602] No Fault, FailCount= 4 2018-03-23T18:52:11.934Z,1521831131.934 [NAL9602](INFO): Powering up NAL9602 2018-03-23T18:52:23.134Z,1521831143.134 [NAL9602](INFO): NAL9602 initialized 2018-03-23T18:53:11.998Z,1521831191.998 [DeadReckonWithRespectToSeafloor](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-03-23T18:53:11.998Z,1521831191.998 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 20 2018-03-23T18:53:11.998Z,1521831191.998 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2018-03-23T18:53:12.023Z,1521831192.023 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2018-03-23T18:53:12.023Z,1521831192.023 [CBIT](FAULT): Software Fault in component: DeadReckonWithRespectToSeafloor 2018-03-23T18:56:03.169Z,1521831363.169 [Default:CheckIn:Read_GPS](INFO): Timed out from 2018-03-23T18:50:57.9Z 2018-03-23T18:56:03.169Z,1521831363.169 [Default:CheckIn:Read_GPS] Stopped 2018-03-23T18:56:03.169Z,1521831363.169 [Default:CheckIn:Read_Iridium] Running Loop=1 2018-03-23T18:56:13.092Z,1521831373.092 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2018-03-23T18:56:13.216Z,1521831373.216 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20180323T173617/Courier0032.lzma 2018-03-23T18:56:14.010Z,1521831374.010 [DataOverHttps](INFO): Moved sent file to Logs/20180323T173617/Courier0032.lzma.bak 2018-03-23T18:56:14.010Z,1521831374.010 [DataOverHttps](INFO): SBD MOMSN=8181651 2018-03-23T18:56:32.441Z,1521831392.441 [DataOverHttps](INFO): Sending 314 bytes from file Logs/20180323T173617/Express0033.lzma 2018-03-23T18:56:33.222Z,1521831393.222 [DataOverHttps](INFO): Moved sent file to Logs/20180323T173617/Express0033.lzma.bak 2018-03-23T18:56:33.222Z,1521831393.222 [DataOverHttps](INFO): SBD MOMSN=8181653 2018-03-23T18:56:34.036Z,1521831394.036 [Default:CheckIn:Read_Iridium] Stopped 2018-03-23T18:56:34.036Z,1521831394.036 [Default:CheckIn:C.Wait] Running Loop=1 2018-03-23T18:56:34.036Z,1521831394.036 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2018-03-23T18:56:43.374Z,1521831403.374 [NAL9602](INFO): Powering down 2018-03-23T18:57:41.577Z,1521831461.577 [CBIT](DEBUG): EFC running - data check-sum false 2018-03-23T19:01:34.278Z,1521831694.278 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2018-03-23T19:01:34.278Z,1521831694.278 [Default:CheckIn:C.Wait] Stopped 2018-03-23T19:01:34.278Z,1521831694.278 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2018-03-23T19:01:34.278Z,1521831694.278 [Default:CheckIn:D] Running Loop=1 2018-03-23T19:01:34.608Z,1521831694.608 [Default:CheckIn:D] Stopped 2018-03-23T19:01:34.608Z,1521831694.608 [Default:CheckIn:E] Running Loop=1 2018-03-23T19:01:35.011Z,1521831695.011 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 110.677197 min 2018-03-23T19:01:35.011Z,1521831695.011 [Default:CheckIn:E] Stopped 2018-03-23T19:01:35.011Z,1521831695.011 [Default:CheckIn](INFO): Completed Default:CheckIn 2018-03-23T19:01:35.011Z,1521831695.011 [Default:CheckIn] Stopped 2018-03-23T19:01:35.011Z,1521831695.011 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2018-03-23T19:01:35.012Z,1521831695.012 [Default:CheckIn](INFO): Running loop #12 2018-03-23T19:01:35.012Z,1521831695.012 [Default:CheckIn] Running Loop=12 2018-03-23T19:01:35.012Z,1521831695.012 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2018-03-23T19:01:35.012Z,1521831695.012 [Default:CheckIn:Read_GPS] Running Loop=1 2018-03-23T19:01:36.434Z,1521831696.434 [CommandLine](IMPORTANT): got command quit 2018-03-23T19:01:37.445Z,1521831697.445 [Supervisor](INFO): Stop Mission called by Supervisor::terminate 2018-03-23T19:01:37.449Z,1521831697.449 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2018-03-23T19:01:37.449Z,1521831697.449 [CommandLine ThreadHandler](INFO): Thread cancelled. 2018-03-23T19:01:37.513Z,1521831697.513 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2018-03-23T19:01:37.513Z,1521831697.513 [CommandLine ThreadHandler](INFO): Thread cancelled. 2018-03-23T19:01:37.514Z,1521831697.514 [CommandLine](INFO): Join timeout helper Thread ID is 1411 2018-03-23T19:01:37.532Z,1521831697.532 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2018-03-23T19:01:37.532Z,1521831697.532 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2018-03-23T19:01:37.550Z,1521831697.550 [NavChartDb](INFO): Join timeout helper Thread ID is 1412 2018-03-23T19:01:37.685Z,1521831697.685 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2018-03-23T19:01:37.685Z,1521831697.685 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2018-03-23T19:01:37.686Z,1521831697.686 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2018-03-23T19:01:37.686Z,1521831697.686 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2018-03-23T19:01:37.686Z,1521831697.686 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 1413 2018-03-23T19:01:37.929Z,1521831697.929 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2018-03-23T19:01:37.929Z,1521831697.929 [WetLabsBB2FL](INFO): Powering down 2018-03-23T19:01:37.930Z,1521831697.930 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2018-03-23T19:01:37.934Z,1521831697.934 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2018-03-23T19:01:37.934Z,1521831697.934 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2018-03-23T19:01:37.934Z,1521831697.934 [CTD_Seabird](INFO): Join timeout helper Thread ID is 1414 2018-03-23T19:01:38.265Z,1521831698.265 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2018-03-23T19:01:38.516Z,1521831698.516 [CTD_Seabird](INFO): Stopping potential previous instance(s) of CTD_Seabird LCM interface 2018-03-23T19:01:38.516Z,1521831698.516 [CTD_Seabird](INFO): Powering down 2018-03-23T19:01:38.517Z,1521831698.517 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2018-03-23T19:01:38.533Z,1521831698.533 [ComponentRegistry](INFO): Shutting down CTD_NeilBrown ThreadHandler 2018-03-23T19:01:38.533Z,1521831698.533 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled. 2018-03-23T19:01:38.534Z,1521831698.534 [CTD_NeilBrown](INFO): Join timeout helper Thread ID is 1416 2018-03-23T19:01:38.757Z,1521831698.757 [CTD_NeilBrown ThreadHandler](INFO): Uninitializing protected caller thread. 2018-03-23T19:01:38.757Z,1521831698.757 [CTD_NeilBrown](INFO): Powering down 2018-03-23T19:01:38.758Z,1521831698.758 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled. 2018-03-23T19:01:38.766Z,1521831698.766 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2018-03-23T19:01:38.766Z,1521831698.766 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2018-03-23T19:01:38.766Z,1521831698.766 [Radio_Surface](INFO): Join timeout helper Thread ID is 1417 2018-03-23T19:01:39.145Z,1521831699.145 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2018-03-23T19:01:39.145Z,1521831699.145 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2018-03-23T19:01:39.162Z,1521831699.162 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2018-03-23T19:01:39.162Z,1521831699.162 [logger ThreadHandler](INFO): Thread cancelled. 2018-03-23T19:01:39.163Z,1521831699.163 [logger](INFO): Join timeout helper Thread ID is 1418 2018-03-23T19:01:39.185Z,1521831699.185 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2018-03-23T19:01:39.185Z,1521831699.185 [logger ThreadHandler](INFO): Thread cancelled. 2018-03-23T19:01:39.198Z,1521831699.198 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2018-03-23T19:01:39.198Z,1521831699.198 [CommandLine ThreadHandler](INFO): Thread cancelled. 2018-03-23T19:01:39.198Z,1521831699.198 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2018-03-23T19:01:39.198Z,1521831699.198 [controlThread ThreadHandler](INFO): Thread cancelled. 2018-03-23T19:01:39.199Z,1521831699.199 [controlThread](INFO): Join timeout helper Thread ID is 1419 2018-03-23T19:01:42.142Z,1521831702.142 [NAL9602](INFO): Powering up 2018-03-23T19:01:42.239Z,1521831702.239 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2018-03-23T19:01:42.239Z,1521831702.239 [controlThread](DEBUG): Uninitializing ControlThread 2018-03-23T19:01:42.249Z,1521831702.249 [NAL9602](INFO): Powering down 2018-03-23T19:01:42.250Z,1521831702.250 [PNI_TCM](INFO): Powering down 2018-03-23T19:01:42.337Z,1521831702.337 [Aanderaa_O2](INFO): Powering down 2018-03-23T19:01:42.340Z,1521831702.340 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2018-03-23T19:01:42.341Z,1521831702.341 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2018-03-23T19:01:42.342Z,1521831702.342 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2018-03-23T19:01:42.343Z,1521831702.343 [MissionManager](INFO): Uninitializing Mission Default 2018-03-23T19:01:42.343Z,1521831702.343 [Default] Stopped 2018-03-23T19:01:42.343Z,1521831702.343 [Default](DEBUG): Aggregate::uninitialize Default 2018-03-23T19:01:42.343Z,1521831702.343 [Default:B.GoToSurface] Stopped 2018-03-23T19:01:42.343Z,1521831702.343 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2018-03-23T19:01:42.343Z,1521831702.343 [Default:CheckIn] Stopped 2018-03-23T19:01:42.343Z,1521831702.343 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2018-03-23T19:01:42.343Z,1521831702.343 [Default:CheckIn:Read_GPS] Stopped 2018-03-23T19:01:42.347Z,1521831702.347 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2018-03-23T19:01:42.347Z,1521831702.347 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2018-03-23T19:01:42.347Z,1521831702.347 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2018-03-23T19:01:42.347Z,1521831702.347 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2018-03-23T19:01:42.348Z,1521831702.348 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2018-03-23T19:01:42.348Z,1521831702.348 [BuoyancyServo](INFO): Powering down 2018-03-23T19:01:42.361Z,1521831702.361 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2018-03-23T19:01:42.361Z,1521831702.361 [ElevatorServo](INFO): Powering down 2018-03-23T19:01:42.363Z,1521831702.363 [MassServo](DEBUG): Uninitialize Mass Servo. 2018-03-23T19:01:42.363Z,1521831702.363 [MassServo](INFO): Powering down 2018-03-23T19:01:42.364Z,1521831702.364 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2018-03-23T19:01:42.364Z,1521831702.364 [RudderServo](INFO): Powering down 2018-03-23T19:01:42.365Z,1521831702.365 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2018-03-23T19:01:42.365Z,1521831702.365 [ThrusterServo](INFO): Powering down 2018-03-23T19:01:42.366Z,1521831702.366 [SBIT](DEBUG): Uninitialize SBIT Component. 2018-03-23T19:01:42.366Z,1521831702.366 [IBIT](DEBUG): Uninitialize IBIT Component. 2018-03-23T19:01:42.366Z,1521831702.366 [CBIT](DEBUG): Uninitialize CBIT Component. 2018-03-23T19:01:42.367Z,1521831702.367 [controlThread ThreadHandler](INFO): Thread cancelled. 2018-03-23T19:01:42.591Z,1521831702.591 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2018-03-23T19:01:42.666Z,1521831702.666 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2018-03-23T19:01:42.669Z,1521831702.669 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2018-03-23T19:01:42.682Z,1521831702.682 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled. 2018-03-23T19:01:42.738Z,1521831702.738 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2018-03-23T19:01:42.926Z,1521831702.926 [logger ThreadHandler](INFO): Thread cancelled.