2021-01-27T00:11:26.925Z,1611706286.925 [CommandLine](IMPORTANT): got command restart logs 2021-01-27T00:12:13.878Z,1611706333.878 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](INFO): Done Waiting. 2021-01-27T00:12:13.878Z,1611706333.878 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Stopped 2021-01-27T00:12:13.878Z,1611706333.878 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-01-27T00:12:13.878Z,1611706333.878 [DefaultWithUndock:SurfaceDefault:CheckIn:D] Running Loop=1 2021-01-27T00:12:14.245Z,1611706334.245 [DefaultWithUndock:SurfaceDefault:CheckIn:D] Stopped 2021-01-27T00:12:14.245Z,1611706334.245 [DefaultWithUndock:SurfaceDefault:CheckIn:E] Running Loop=1 2021-01-27T00:12:14.629Z,1611706334.629 [DefaultWithUndock:SurfaceDefault:CheckIn:E](IMPORTANT): Default mission has been running for 15.143405 min 2021-01-27T00:12:14.629Z,1611706334.629 [DefaultWithUndock:SurfaceDefault:CheckIn:E] Stopped 2021-01-27T00:12:14.629Z,1611706334.629 [DefaultWithUndock:SurfaceDefault:CheckIn](INFO): Completed DefaultWithUndock:SurfaceDefault:CheckIn 2021-01-27T00:12:14.629Z,1611706334.629 [DefaultWithUndock:SurfaceDefault:CheckIn] Stopped 2021-01-27T00:12:14.629Z,1611706334.629 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::uninitialize DefaultWithUndock:SurfaceDefault:CheckIn 2021-01-27T00:12:14.629Z,1611706334.629 [DefaultWithUndock:SurfaceDefault:CheckIn](INFO): Running loop #3 2021-01-27T00:12:14.629Z,1611706334.629 [DefaultWithUndock:SurfaceDefault:CheckIn] Running Loop=3 2021-01-27T00:12:14.629Z,1611706334.629 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::initialize DefaultWithUndock:SurfaceDefault:CheckIn 2021-01-27T00:12:14.629Z,1611706334.629 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Running Loop=1 2021-01-27T00:12:16.635Z,1611706336.635 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,001216.00,A,4132.91072,N,07042.77161,W,0.564,185.78,270121,,,D*70 2021-01-27T00:12:16.638Z,1611706336.638 [NAL9602](INFO): GPS fix at 20210127T001216: (41.548512, -70.712860) 2021-01-27T00:12:16.649Z,1611706336.649 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Stopped 2021-01-27T00:12:16.649Z,1611706336.649 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Running Loop=1 2021-01-27T00:12:20.131Z,1611706340.131 [DataOverHttps](INFO): Sending 52 bytes from file Logs/20210126T202734/Courier0073.lzma 2021-01-27T00:12:21.134Z,1611706341.134 [DataOverHttps](INFO): Moved sent file to Logs/20210126T202734/Courier0073.lzma.bak 2021-01-27T00:12:21.134Z,1611706341.134 [DataOverHttps](INFO): SBD MOMSN=68165 2021-01-27T00:12:30.172Z,1611706350.172 [DataOverHttps](INFO): Sending 254 bytes from file Logs/20210127T001126/Courier0000.lzma 2021-01-27T00:12:31.174Z,1611706351.174 [DataOverHttps](INFO): Moved sent file to Logs/20210127T001126/Courier0000.lzma.bak 2021-01-27T00:12:31.174Z,1611706351.174 [DataOverHttps](INFO): SBD MOMSN=68167 2021-01-27T00:12:40.212Z,1611706360.212 [DataOverHttps](INFO): Sending 95 bytes from file Logs/20210126T202734/Express0074.lzma 2021-01-27T00:12:41.214Z,1611706361.214 [DataOverHttps](INFO): Moved sent file to Logs/20210126T202734/Express0074.lzma.bak 2021-01-27T00:12:41.214Z,1611706361.214 [DataOverHttps](INFO): SBD MOMSN=68171 2021-01-27T00:12:50.252Z,1611706370.252 [DataOverHttps](INFO): Sending 337 bytes from file Logs/20210127T001126/Express0001.lzma 2021-01-27T00:12:51.254Z,1611706371.254 [DataOverHttps](INFO): Moved sent file to Logs/20210127T001126/Express0001.lzma.bak 2021-01-27T00:12:51.254Z,1611706371.254 [DataOverHttps](INFO): SBD MOMSN=68173 2021-01-27T00:12:52.643Z,1611706372.643 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Stopped 2021-01-27T00:12:52.643Z,1611706372.643 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Running Loop=1 2021-01-27T00:12:52.643Z,1611706372.643 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-01-27T00:13:10.406Z,1611706390.406 [NAL9602](INFO): SBD MO Status=2, MOMSN=13067, MT Status=2, MTMSN=0 2021-01-27T00:13:10.406Z,1611706390.406 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-01-27T00:13:41.549Z,1611706421.549 [NAL9602](INFO): SBD MO Status=0, MOMSN=13067, MT Status=0, MTMSN=0 2021-01-27T00:13:41.549Z,1611706421.549 [NAL9602](INFO): No messages in MT queue 2021-01-27T00:14:06.554Z,1611706446.554 [DataOverHttps](IMPORTANT): SBD MTMSN=20210127T001406 2021-01-27T00:14:10.576Z,1611706450.576 [DataOverHttps](INFO): Received command:sched asap "load Transport/transit.xml;set transit.MissionTimeout 30 minute;set transit.Latitude 41.5548 degree;set transit.Longitude -70.7 degree;set transit.Depth 7 meter;set transit.Speed 1.5 meter_per_second;set transit.MaxDepth 9 meter" 2s0mw 1 2 2021-01-27T00:14:10.602Z,1611706450.602 [CommandLine](IMPORTANT): got command schedule asap "load Transport/transit.xml;set transit.MissionTimeout 30 minute;set transit.Latitude 41.5548 degree;set transit.Longitude -70.7 degree;set transit.Depth 7 meter;set transit.Speed 1.5 meter_per_second;set transit.MaxDepth 9 meter" 2s0mw 1 2.000000 2021-01-27T00:14:10.603Z,1611706450.603 [CommandLine](IMPORTANT): Scheduling command #1 of 2 with id=2s0mw 2021-01-27T00:14:10.604Z,1611706450.604 [CommandLine](IMPORTANT): Scheduled #8 (#1 of 2 with id='2s0mw'): "load Transport/transit.xml;set transit.MissionTimeout 30 minute;set transit.Latitude 41.5548 degree;set transit.Longitude -70.7 degree;set transit.Depth 7 meter;set transit.Speed 1.5 meter_per_second;set transit.MaxDepth 9 meter" ASAP 2021-01-27T00:14:11.573Z,1611706451.573 [DataOverHttps](IMPORTANT): SBD MTMSN=20210127T001411 2021-01-27T00:14:12.206Z,1611706452.206 [NAL9602](INFO): Not Powering down - fast GPS 2021-01-27T00:14:15.592Z,1611706455.592 [DataOverHttps](INFO): Received command:sched asap "set transit.MinOffshore 500 meter;set transit.MinAltitude 3 meter;run" 2s0mw 2 2 2021-01-27T00:14:15.633Z,1611706455.633 [CommandLine](IMPORTANT): got command schedule asap "set transit.MinOffshore 500 meter;set transit.MinAltitude 3 meter;run" 2s0mw 2 2.000000 2021-01-27T00:14:15.633Z,1611706455.633 [CommandLine](IMPORTANT): Scheduling command #2 of 2 with id=2s0mw 2021-01-27T00:14:15.634Z,1611706455.634 [CommandLine](IMPORTANT): Scheduled #9 (#2 of 2 with id='2s0mw'): "set transit.MinOffshore 500 meter;set transit.MinAltitude 3 meter;run" ASAP 2021-01-27T00:14:15.754Z,1611706455.754 [CommandLine](IMPORTANT): got command load ./Missions/Transport/transit.xml 2021-01-27T00:14:15.754Z,1611706455.754 [MissionManager](INFO): Loading Mission: ./Missions/Transport/transit.xml 2021-01-27T00:14:15.815Z,1611706455.815 [MissionManager](INFO): DefineArg transit.MissionTimeout = 60.000000 min 2021-01-27T00:14:15.818Z,1611706455.818 [MissionManager](INFO): DefineArg transit.NeedCommsTime = 30.000000 min 2021-01-27T00:14:15.821Z,1611706455.821 [MissionManager](INFO): DefineArg transit.Latitude = nan arcdeg 2021-01-27T00:14:15.852Z,1611706455.852 [MissionManager](INFO): DefineArg transit.Longitude = nan arcdeg 2021-01-27T00:14:15.855Z,1611706455.855 [MissionManager](INFO): DefineArg transit.Northings = 0.000000 m 2021-01-27T00:14:15.878Z,1611706455.878 [MissionManager](INFO): DefineArg transit.Eastings = 0.000000 m 2021-01-27T00:14:15.885Z,1611706455.885 [MissionManager](INFO): DefineArg transit.Depth = 10.000000 m 2021-01-27T00:14:15.905Z,1611706455.905 [MissionManager](INFO): DefineArg transit.Speed = 1.000000 m/s 2021-01-27T00:14:15.928Z,1611706455.928 [MissionManager](INFO): DefineArg transit.MaxDepth = 20.000000 m 2021-01-27T00:14:15.938Z,1611706455.938 [MissionManager](INFO): DefineArg transit.MinOffshore = 1.000000 km 2021-01-27T00:14:15.949Z,1611706455.949 [MissionManager](INFO): DefineArg transit.MinAltitude = 7.000000 m 2021-01-27T00:14:15.956Z,1611706455.956 [MissionManager](INFO): DefineArg transit.MassHold = 1 bool 2021-01-27T00:14:15.959Z,1611706455.959 [MissionManager](INFO): DefineArg transit.BuoyancyHold = 1 bool 2021-01-27T00:14:15.959Z,1611706455.959 [MissionManager](INFO): Inserting Stack: Missions/Insert/NeedComms.xml 2021-01-27T00:14:16.040Z,1611706456.040 [MissionManager](INFO): DefineArg transit:NeedComms.DiveInterval = 3.000000 h 2021-01-27T00:14:16.043Z,1611706456.043 [MissionManager](INFO): DefineArg transit:NeedComms.WaitForPitchUp = 10.000000 min 2021-01-27T00:14:16.050Z,1611706456.050 [MissionManager](INFO): DefineArg transit:NeedComms.SurfacePitch = 20.000000 arcdeg 2021-01-27T00:14:16.055Z,1611706456.055 [MissionManager](INFO): DefineArg transit:NeedComms.SurfaceDepthRate = nan m/s 2021-01-27T00:14:16.066Z,1611706456.066 [MissionManager](INFO): DefineArg transit:NeedComms.SurfaceSpeed = 1.000000 m/s 2021-01-27T00:14:16.070Z,1611706456.070 [MissionManager](INFO): DefineArg transit:NeedComms.GPSTimeout = 7.000000 min 2021-01-27T00:14:16.081Z,1611706456.081 [MissionManager](INFO): DefineArg transit:NeedComms.CommsTimeout = 30.000000 min 2021-01-27T00:14:16.096Z,1611706456.096 [transit:NeedComms:B.GoToSurface](DEBUG): Construct GoToSurface. 2021-01-27T00:14:16.126Z,1611706456.126 [MissionManager](INFO): Inserting Stack: Missions/Insert/StandardEnvelopes.xml 2021-01-27T00:14:16.151Z,1611706456.151 [MissionManager](INFO): DefineArg transit:StandardEnvelopes.MinAltitude = 5.000000 m 2021-01-27T00:14:16.163Z,1611706456.163 [MissionManager](INFO): DefineArg transit:StandardEnvelopes.MaxDepth = 200.000000 m 2021-01-27T00:14:16.166Z,1611706456.166 [MissionManager](INFO): DefineArg transit:StandardEnvelopes.MinOffshore = 2000.000000 m 2021-01-27T00:14:16.167Z,1611706456.167 [transit:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Construct AltitudeEnvelope. 2021-01-27T00:14:16.195Z,1611706456.195 [transit:StandardEnvelopes:B.DepthEnvelope](DEBUG): Construct DepthEnvelope. 2021-01-27T00:14:16.215Z,1611706456.215 [transit:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Construct OffshoreEnvelope. 2021-01-27T00:14:16.272Z,1611706456.272 [transit:BuoyancyHold.Buoyancy](DEBUG): Construct Buoyancy. 2021-01-27T00:14:16.284Z,1611706456.284 [transit:MassHold.Pitch](DEBUG): Construct. 2021-01-27T00:14:16.306Z,1611706456.306 [transit:Transit:A.Pitch](DEBUG): Construct. 2021-01-27T00:14:16.320Z,1611706456.320 [transit:Transit:B.SetSpeed](DEBUG): Construct. 2021-01-27T00:14:16.323Z,1611706456.323 [transit:Transit:Wpt1.Waypoint](DEBUG): Construct Waypoint. 2021-01-27T00:14:16.373Z,1611706456.373 [MissionManager](DEBUG): Vehicle transits to desired waypoint and can be commanded to use/hold mass or buoyancy. Maximum duration of mission 60 How often to surface for commumications 30 Latitude of waypoint to seek. If set to NaN, uses latitude at mission initialization. NaN Longitude of waypoint to seek. If set to NaN, uses longitude at mission initialization. NaN Northward distance of the waypoint to seek. If combined with Latitude and/or Longitude, this is an offset from the specified Latitude and/or Longitude. 0 Eastward distance of the waypoint to seek. If combined with Latitude and/or Longitude, this is an offset from the specified Latitude and/or Longitude. 0 Depth of flat and level flight during the mission. 10 Speed of vehicle (relative to water) during the mission. 1 Maximum depth for the entire mission. 20 Minimum distance offshore for the entire mission. 1 Minimum height above the sea floor for the entire mission. 7 Set to True in order to hold mass at default position, False to allow mass to run on its own. Set to True in order to hold buoyancy at neutral position, False to allow buoyancy to run on its own. 1 2021-01-27T00:14:16.373Z,1611706456.373 [CommandLine](IMPORTANT): Loaded ./Missions/Transport/transit.xml 2021-01-27T00:14:25.787Z,1611706465.787 [CommandLine](IMPORTANT): got command set transit.MissionTimeout 30.000000 minute 2021-01-27T00:14:25.788Z,1611706465.788 [CommandLine](IMPORTANT): got command set transit.Latitude 41.554798 degree 2021-01-27T00:14:25.788Z,1611706465.788 [CommandLine](IMPORTANT): got command set transit.Longitude -70.699997 degree 2021-01-27T00:14:25.789Z,1611706465.789 [CommandLine](IMPORTANT): got command set transit.Depth 7.000000 meter 2021-01-27T00:14:25.790Z,1611706465.790 [CommandLine](IMPORTANT): got command set transit.Speed 1.500000 meter_per_second 2021-01-27T00:14:25.791Z,1611706465.791 [CommandLine](IMPORTANT): got command set transit.MaxDepth 9.000000 meter 2021-01-27T00:14:29.365Z,1611706469.365 [CommandLine](IMPORTANT): got command set transit.MinOffshore 500.000000 meter 2021-01-27T00:14:29.365Z,1611706469.365 [CommandLine](IMPORTANT): got command set transit.MinAltitude 3.000000 meter 2021-01-27T00:14:29.366Z,1611706469.366 [CommandLine](IMPORTANT): got command run 2021-01-27T00:14:29.368Z,1611706469.368 [CommandLine](IMPORTANT): Running 2021-01-27T00:14:29.612Z,1611706469.612 [DefaultWithUndock] Stopped 2021-01-27T00:14:29.612Z,1611706469.612 [DefaultWithUndock](DEBUG): Aggregate::uninitialize DefaultWithUndock 2021-01-27T00:14:29.612Z,1611706469.612 [DefaultWithUndock:SurfaceDefault] Stopped 2021-01-27T00:14:29.612Z,1611706469.612 [DefaultWithUndock:SurfaceDefault](DEBUG): Aggregate::uninitialize DefaultWithUndock:SurfaceDefault 2021-01-27T00:14:29.612Z,1611706469.612 [DefaultWithUndock:SurfaceDefault:B.GoToSurface] Stopped 2021-01-27T00:14:29.612Z,1611706469.612 [DefaultWithUndock:SurfaceDefault:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2021-01-27T00:14:29.612Z,1611706469.612 [DefaultWithUndock:SurfaceDefault:CheckIn] Stopped 2021-01-27T00:14:29.612Z,1611706469.612 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::uninitialize DefaultWithUndock:SurfaceDefault:CheckIn 2021-01-27T00:14:29.613Z,1611706469.613 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Stopped 2021-01-27T00:14:29.613Z,1611706469.613 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-01-27T00:14:29.613Z,1611706469.613 [MissionManager](IMPORTANT): Started mission transit 2021-01-27T00:14:29.613Z,1611706469.613 [transit] Running Loop=1 2021-01-27T00:14:29.613Z,1611706469.613 [transit](DEBUG): Aggregate::initialize transit 2021-01-27T00:14:29.613Z,1611706469.613 [transit:StandardEnvelopes] Running Loop=1 2021-01-27T00:14:29.613Z,1611706469.613 [transit:StandardEnvelopes](DEBUG): Aggregate::initialize transit:StandardEnvelopes 2021-01-27T00:14:29.613Z,1611706469.613 [transit:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1 2021-01-27T00:14:29.614Z,1611706469.614 [transit:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Initialize AltitudeEnvelopeComponent. 2021-01-27T00:14:29.614Z,1611706469.614 [transit:StandardEnvelopes:B.DepthEnvelope] Running Loop=1 2021-01-27T00:14:29.614Z,1611706469.614 [transit:StandardEnvelopes:B.DepthEnvelope](DEBUG): Initialize DepthEnvelopeComponent. 2021-01-27T00:14:29.614Z,1611706469.614 [transit:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1 2021-01-27T00:14:29.614Z,1611706469.614 [transit:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Initialize OffshoreEnvelopeComponent. 2021-01-27T00:14:29.614Z,1611706469.614 [transit:BuoyancyHold.Buoyancy] Running Loop=1 2021-01-27T00:14:29.614Z,1611706469.614 [transit:BuoyancyHold.Buoyancy](DEBUG): Initialize Buoyancy Component. 2021-01-27T00:14:29.614Z,1611706469.614 [transit:MassHold.Pitch] Running Loop=1 2021-01-27T00:14:29.614Z,1611706469.614 [transit:MassHold.Pitch](DEBUG): Initialize. 2021-01-27T00:14:29.615Z,1611706469.615 [transit:B] Running Loop=1 2021-01-27T00:14:29.615Z,1611706469.615 [transit:MassHold.Pitch] Running Loop=1 2021-01-27T00:14:29.616Z,1611706469.616 [transit:BuoyancyHold.Buoyancy] Running Loop=1 2021-01-27T00:14:29.616Z,1611706469.616 [transit:StandardEnvelopes] Running Loop=1 2021-01-27T00:14:29.616Z,1611706469.616 [transit:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1 2021-01-27T00:14:29.616Z,1611706469.616 [transit:StandardEnvelopes:B.DepthEnvelope] Running Loop=1 2021-01-27T00:14:29.617Z,1611706469.617 [transit:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1 2021-01-27T00:14:29.617Z,1611706469.617 [transit:B] Stopped 2021-01-27T00:14:29.617Z,1611706469.617 [transit:C] Running Loop=1 2021-01-27T00:14:30.018Z,1611706470.018 [transit:C] Stopped 2021-01-27T00:14:30.018Z,1611706470.018 [transit:E] Running Loop=1 2021-01-27T00:14:30.401Z,1611706470.401 [transit:E] Stopped 2021-01-27T00:14:30.401Z,1611706470.401 [transit:F] Running Loop=1 2021-01-27T00:14:30.821Z,1611706470.821 [transit:F] Stopped 2021-01-27T00:14:30.821Z,1611706470.821 [transit:G] Running Loop=1 2021-01-27T00:14:31.216Z,1611706471.216 [transit:G] Stopped 2021-01-27T00:14:31.216Z,1611706471.216 [transit:Transit] Running Loop=1 2021-01-27T00:14:31.217Z,1611706471.217 [transit:Transit](DEBUG): Aggregate::initialize transit:Transit 2021-01-27T00:14:31.217Z,1611706471.217 [transit:Transit:A.Pitch] Running Loop=1 2021-01-27T00:14:31.217Z,1611706471.217 [transit:Transit:A.Pitch](DEBUG): Initialize. 2021-01-27T00:14:31.217Z,1611706471.217 [transit:Transit:B.SetSpeed] Running Loop=1 2021-01-27T00:14:31.217Z,1611706471.217 [transit:Transit:B.SetSpeed](DEBUG): Initialize. 2021-01-27T00:14:31.217Z,1611706471.217 [transit:Transit:Wpt1.Waypoint] Running Loop=1 2021-01-27T00:14:31.217Z,1611706471.217 [transit:Transit:Wpt1.Waypoint](DEBUG): Initialize WaypointComponent. 2021-01-27T00:14:31.613Z,1611706471.613 [transit:Transit:B.SetSpeed] Running Loop=1 2021-01-27T00:14:31.613Z,1611706471.613 [transit:Transit:A.Pitch] Running Loop=1 2021-01-27T00:14:38.188Z,1611706478.188 [ThrusterServo](FAULT): Overload Error 2021-01-27T00:14:38.188Z,1611706478.188 [ThrusterServo] Hardware Fault, FailCount= 1 2021-01-27T00:14:38.188Z,1611706478.188 [ThrusterServo](ERROR): Hardware Fault 2021-01-27T00:14:38.192Z,1611706478.192 [CBIT](ERROR): Hardware Fault in component: ThrusterServo 2021-01-27T00:14:38.621Z,1611706478.621 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2021-01-27T00:14:38.621Z,1611706478.621 [ThrusterServo](INFO): Powering down 2021-01-27T00:14:39.337Z,1611706479.337 [ThrusterServo](DEBUG): Initializing EZServoServo. 2021-01-27T00:14:39.462Z,1611706479.462 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2021-01-27T00:14:39.466Z,1611706479.466 [CBIT](INFO): Clearing failed state for component ThrusterServo 2021-01-27T00:14:39.466Z,1611706479.466 [ThrusterServo] No Fault, FailCount= 1 2021-01-27T00:14:48.312Z,1611706488.312 [ThrusterServo](FAULT): Overload Error 2021-01-27T00:14:48.312Z,1611706488.312 [ThrusterServo] Hardware Fault, FailCount= 2 2021-01-27T00:14:48.312Z,1611706488.312 [ThrusterServo](ERROR): Hardware Fault 2021-01-27T00:14:48.316Z,1611706488.316 [CBIT](ERROR): Hardware Fault in component: ThrusterServo 2021-01-27T00:14:48.661Z,1611706488.661 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2021-01-27T00:14:48.662Z,1611706488.662 [ThrusterServo](INFO): Powering down 2021-01-27T00:14:49.453Z,1611706489.453 [ThrusterServo](DEBUG): Initializing EZServoServo. 2021-01-27T00:14:49.573Z,1611706489.573 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2021-01-27T00:14:49.576Z,1611706489.576 [CBIT](INFO): Clearing failed state for component ThrusterServo 2021-01-27T00:14:49.577Z,1611706489.577 [ThrusterServo] No Fault, FailCount= 2 2021-01-27T00:14:58.876Z,1611706498.876 [ThrusterServo](FAULT): Overload Error 2021-01-27T00:14:58.876Z,1611706498.876 [ThrusterServo] Hardware Fault, FailCount= 3 2021-01-27T00:14:58.876Z,1611706498.876 [ThrusterServo](ERROR): Hardware Fault 2021-01-27T00:14:58.880Z,1611706498.880 [CBIT](ERROR): Hardware Fault in component: ThrusterServo 2021-01-27T00:14:59.193Z,1611706499.193 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2021-01-27T00:14:59.193Z,1611706499.193 [ThrusterServo](INFO): Powering down 2021-01-27T00:15:00.021Z,1611706500.021 [ThrusterServo](DEBUG): Initializing EZServoServo. 2021-01-27T00:15:00.141Z,1611706500.141 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2021-01-27T00:15:00.144Z,1611706500.144 [CBIT](INFO): Clearing failed state for component ThrusterServo 2021-01-27T00:15:00.145Z,1611706500.145 [ThrusterServo] No Fault, FailCount= 3 2021-01-27T00:15:08.936Z,1611706508.936 [ThrusterServo](FAULT): Overload Error 2021-01-27T00:15:08.936Z,1611706508.936 [ThrusterServo] Hardware Fault, FailCount= 4 2021-01-27T00:15:08.936Z,1611706508.936 [ThrusterServo](ERROR): Hardware Fault 2021-01-27T00:15:08.940Z,1611706508.940 [CBIT](ERROR): Hardware Fault in component: ThrusterServo 2021-01-27T00:15:09.369Z,1611706509.369 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2021-01-27T00:15:09.369Z,1611706509.369 [ThrusterServo](INFO): Powering down 2021-01-27T00:15:10.054Z,1611706510.054 [ThrusterServo](DEBUG): Initializing EZServoServo. 2021-01-27T00:15:10.173Z,1611706510.173 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2021-01-27T00:15:10.177Z,1611706510.177 [CBIT](INFO): Clearing failed state for component ThrusterServo 2021-01-27T00:15:10.177Z,1611706510.177 [ThrusterServo] No Fault, FailCount= 4 2021-01-27T00:15:19.008Z,1611706519.008 [ThrusterServo](FAULT): Overload Error 2021-01-27T00:15:19.008Z,1611706519.008 [ThrusterServo] Hardware Fault, FailCount= 5 2021-01-27T00:15:19.008Z,1611706519.008 [ThrusterServo](ERROR): Hardware Fault 2021-01-27T00:15:19.012Z,1611706519.012 [CBIT](ERROR): Hardware Fault in component: ThrusterServo 2021-01-27T00:15:19.012Z,1611706519.012 [CBIT](CRITICAL): Hardware Fault in component: ThrusterServo 2021-01-27T00:15:19.281Z,1611706519.281 [ElevatorOffsetCalculator](INFO): New estimator for commanded vars: speed 1.50 m/s, pitch 30.00 deg, mass-position 10.00 mm (7 active estimators). 2021-01-27T00:15:19.441Z,1611706519.441 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2021-01-27T00:15:19.441Z,1611706519.441 [ThrusterServo](INFO): Powering down 2021-01-27T00:15:19.443Z,1611706519.443 [CommandLine](FAULT): Scheduling is paused 2021-01-27T00:15:19.443Z,1611706519.443 [CBIT](INFO): Critical error at 20210127T001519 2021-01-27T00:15:19.444Z,1611706519.444 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2021-01-27T00:15:19.762Z,1611706519.762 [MissionManager](INFO): MissionManager is completed. 2021-01-27T00:15:19.762Z,1611706519.762 [MissionManager](INFO): Uninitializing Mission transit 2021-01-27T00:15:19.763Z,1611706519.763 [transit] Stopped 2021-01-27T00:15:19.763Z,1611706519.763 [transit](DEBUG): Aggregate::uninitialize transit 2021-01-27T00:15:19.763Z,1611706519.763 [transit:StandardEnvelopes] Stopped 2021-01-27T00:15:19.763Z,1611706519.763 [transit:StandardEnvelopes](DEBUG): Aggregate::uninitialize transit:StandardEnvelopes 2021-01-27T00:15:19.763Z,1611706519.763 [transit:StandardEnvelopes:A.AltitudeEnvelope] Stopped 2021-01-27T00:15:19.763Z,1611706519.763 [transit:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Uninitialize AltitudeEnvelopeComponent. 2021-01-27T00:15:19.763Z,1611706519.763 [transit:StandardEnvelopes:B.DepthEnvelope] Stopped 2021-01-27T00:15:19.763Z,1611706519.763 [transit:StandardEnvelopes:B.DepthEnvelope](DEBUG): Uninitialize. 2021-01-27T00:15:19.763Z,1611706519.763 [transit:StandardEnvelopes:C.OffshoreEnvelope] Stopped 2021-01-27T00:15:19.763Z,1611706519.763 [transit:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Uninitialize OffshoreEnvelopeComponent. 2021-01-27T00:15:19.763Z,1611706519.763 [transit:BuoyancyHold.Buoyancy] Stopped 2021-01-27T00:15:19.763Z,1611706519.763 [transit:BuoyancyHold.Buoyancy](DEBUG): Uninitialize Buoyancy Component. 2021-01-27T00:15:19.764Z,1611706519.764 [transit:MassHold.Pitch] Stopped 2021-01-27T00:15:19.764Z,1611706519.764 [transit:Transit] Stopped 2021-01-27T00:15:19.764Z,1611706519.764 [transit:Transit](DEBUG): Aggregate::uninitialize transit:Transit 2021-01-27T00:15:19.764Z,1611706519.764 [transit:Transit:A.Pitch] Stopped 2021-01-27T00:15:19.764Z,1611706519.764 [transit:Transit:B.SetSpeed] Stopped 2021-01-27T00:15:19.764Z,1611706519.764 [transit:Transit:B.SetSpeed](DEBUG): Uninitialize. 2021-01-27T00:15:19.764Z,1611706519.764 [transit:Transit:Wpt1.Waypoint] Stopped 2021-01-27T00:15:19.764Z,1611706519.764 [transit:Transit:Wpt1.Waypoint](DEBUG): Uninitialize WaypointComponent. 2021-01-27T00:15:20.100Z,1611706520.100 [MissionManager](IMPORTANT): Started mission DefaultWithUndock 2021-01-27T00:15:20.100Z,1611706520.100 [DefaultWithUndock] Running Loop=1 2021-01-27T00:15:20.100Z,1611706520.100 [DefaultWithUndock](DEBUG): Aggregate::initialize DefaultWithUndock 2021-01-27T00:15:20.101Z,1611706520.101 [DefaultWithUndock:A.Wait] Running Loop=1 2021-01-27T00:15:20.101Z,1611706520.101 [DefaultWithUndock:A.Wait](DEBUG): Initialize Wait Component. 2021-01-27T00:15:33.080Z,1611706533.080 [BuoyancyServo](FAULT): Overload Error 2021-01-27T00:15:33.080Z,1611706533.080 [BuoyancyServo] Hardware Fault, FailCount= 1 2021-01-27T00:15:33.080Z,1611706533.080 [BuoyancyServo](ERROR): Hardware Fault 2021-01-27T00:15:33.085Z,1611706533.085 [CBIT](ERROR): Hardware Fault in component: BuoyancyServo 2021-01-27T00:15:35.071Z,1611706535.071 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2021-01-27T00:15:35.071Z,1611706535.071 [BuoyancyServo](INFO): Powering down 2021-01-27T00:15:35.913Z,1611706535.913 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2021-01-27T00:15:35.913Z,1611706535.913 [BuoyancyServo] No Fault, FailCount= 1 2021-01-27T00:15:36.262Z,1611706536.262 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2021-01-27T00:15:36.262Z,1611706536.262 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2021-01-27T00:15:49.232Z,1611706549.232 [CBIT](INFO): Clearing failed state for component ThrusterServo 2021-01-27T00:15:49.233Z,1611706549.233 [ThrusterServo] No Fault, FailCount= 5 2021-01-27T00:15:49.625Z,1611706549.625 [ThrusterServo](DEBUG): Initializing EZServoServo. 2021-01-27T00:15:49.626Z,1611706549.626 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2021-01-27T00:15:50.392Z,1611706550.392 [DefaultWithUndock:A.Wait](INFO): Done Waiting. 2021-01-27T00:15:50.393Z,1611706550.393 [DefaultWithUndock:A.Wait] Stopped 2021-01-27T00:15:50.393Z,1611706550.393 [DefaultWithUndock:A.Wait](DEBUG): Uninitialize Wait Component. 2021-01-27T00:15:50.393Z,1611706550.393 [DefaultWithUndock:LeaveDock] Running Loop=1 2021-01-27T00:15:50.393Z,1611706550.393 [DefaultWithUndock:LeaveDock](DEBUG): Aggregate::initialize DefaultWithUndock:LeaveDock 2021-01-27T00:15:50.393Z,1611706550.393 [DefaultWithUndock:LeaveDock:A.] Running Loop=1 2021-01-27T00:15:50.393Z,1611706550.393 [DefaultWithUndock:LeaveDock:A.](INFO): Initializing TrackAcousticContact. 2021-01-27T00:15:50.393Z,1611706550.393 [DefaultWithUndock:LeaveDock:B.Undock] Running Loop=1 2021-01-27T00:15:50.393Z,1611706550.393 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Initialize. 2021-01-27T00:15:50.393Z,1611706550.393 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Initializing internal variables to default values. 2021-01-27T00:15:51.731Z,1611706551.731 [DefaultWithUndock:LeaveDock:B.Undock](INFO): Detaching from dock. 2021-01-27T00:15:51.972Z,1611706551.972 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.239399 2021-01-27T00:15:52.091Z,1611706552.091 [DefaultWithUndock:LeaveDock:B.Undock](INFO): Engaging thruster for 10.0 seconds (max) to disengage. 2021-01-27T00:15:52.935Z,1611706552.935 [DefaultWithUndock:LeaveDock:A.](INFO): *** querying acoustic contact *** 2021-01-27T00:15:53.647Z,1611706553.647 [Micromodem](INFO): Nmea out: $CCPGT,1,14500,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*76 2021-01-27T00:15:54.058Z,1611706554.058 [Micromodem](INFO): Nmea in: $SNPGT,1,14500,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*6B 2021-01-27T00:15:54.874Z,1611706554.874 [Micromodem](INFO): Nmea in: $SNTTA,0.366381,,,,001555.16*4A 2021-01-27T00:15:55.745Z,1611706555.745 [DefaultWithUndock:LeaveDock:B.Undock](INFO): Thruster off. 2021-01-27T00:15:56.128Z,1611706556.128 [DefaultWithUndock:LeaveDock:B.Undock](INFO): Detected possible detachment. Starting timer. 2021-01-27T00:15:58.107Z,1611706558.107 [DefaultWithUndock:LeaveDock:A.](INFO): *** querying acoustic contact *** 2021-01-27T00:15:58.898Z,1611706558.898 [Micromodem](INFO): Nmea out: $CCPGT,1,14500,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*76 2021-01-27T00:15:59.300Z,1611706559.300 [Micromodem](INFO): Nmea in: $SNPGT,1,14500,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*6B 2021-01-27T00:16:00.129Z,1611706560.129 [Micromodem](INFO): Nmea in: $SNTTA,0.366854,,,,001600.41*48 2021-01-27T00:16:03.022Z,1611706563.022 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003394 2021-01-27T00:16:03.368Z,1611706563.368 [DefaultWithUndock:LeaveDock:A.](INFO): *** querying acoustic contact *** 2021-01-27T00:16:04.154Z,1611706564.154 [Micromodem](INFO): Nmea out: $CCPGT,1,14500,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*76 2021-01-27T00:16:04.568Z,1611706564.568 [Micromodem](INFO): Nmea in: $SNPGT,1,14500,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*6B 2021-01-27T00:16:05.374Z,1611706565.374 [Micromodem](INFO): Nmea in: $SNTTA,0.367376,,,,001605.67*43 2021-01-27T00:16:08.607Z,1611706568.607 [DefaultWithUndock:LeaveDock:A.](INFO): *** querying acoustic contact *** 2021-01-27T00:16:09.398Z,1611706569.398 [Micromodem](INFO): Nmea out: $CCPGT,1,14500,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*76 2021-01-27T00:16:09.800Z,1611706569.800 [Micromodem](INFO): Nmea in: $SNPGT,1,14500,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*6B 2021-01-27T00:16:10.630Z,1611706570.630 [Micromodem](INFO): Nmea in: $SNTTA,0.367743,,,,001610.91*4C 2021-01-27T00:16:13.913Z,1611706573.913 [DefaultWithUndock:LeaveDock:A.](INFO): *** querying acoustic contact *** 2021-01-27T00:16:14.658Z,1611706574.658 [Micromodem](INFO): Nmea out: $CCPGT,1,14500,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*76 2021-01-27T00:16:15.056Z,1611706575.056 [Micromodem](INFO): Nmea in: $SNPGT,1,14500,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*6B 2021-01-27T00:16:15.894Z,1611706575.894 [Micromodem](INFO): Nmea in: $SNTTA,0.367978,,,,001616.17*42 2021-01-27T00:16:16.281Z,1611706576.281 [DefaultWithUndock:LeaveDock:B.Undock](INFO): Detached at range: 551.52 m. Transitioning DDM to standby. 2021-01-27T00:16:16.712Z,1611706576.712 [DefaultWithUndock:LeaveDock:A.](INFO): *** querying acoustic contact *** 2021-01-27T00:16:18.285Z,1611706578.285 [DUSBL_Hydroid](ERROR): No response from remote modem. 2021-01-27T00:16:19.135Z,1611706579.135 [DefaultWithUndock:LeaveDock:B.Undock](INFO): DDM at standby. 2021-01-27T00:16:19.553Z,1611706579.553 [DefaultWithUndock:LeaveDock:B.Undock](IMPORTANT): Undocking sequence complete. 2021-01-27T00:16:19.553Z,1611706579.553 [DefaultWithUndock:LeaveDock:B.Undock] Stopped 2021-01-27T00:16:19.553Z,1611706579.553 [DefaultWithUndock:LeaveDock:A.](INFO): *** querying acoustic contact *** 2021-01-27T00:16:19.554Z,1611706579.554 [DefaultWithUndock:LeaveDock](INFO): Completed DefaultWithUndock:LeaveDock 2021-01-27T00:16:19.554Z,1611706579.554 [DefaultWithUndock:LeaveDock] Stopped 2021-01-27T00:16:19.554Z,1611706579.554 [DefaultWithUndock:LeaveDock](DEBUG): Aggregate::uninitialize DefaultWithUndock:LeaveDock 2021-01-27T00:16:19.554Z,1611706579.554 [DefaultWithUndock:LeaveDock:A.] Stopped 2021-01-27T00:16:19.554Z,1611706579.554 [DefaultWithUndock:SurfaceDefault] Running Loop=1 2021-01-27T00:16:19.554Z,1611706579.554 [DefaultWithUndock:SurfaceDefault](DEBUG): Aggregate::initialize DefaultWithUndock:SurfaceDefault 2021-01-27T00:16:19.554Z,1611706579.554 [DefaultWithUndock:SurfaceDefault:HoldLatchOpen] Running Loop=1 2021-01-27T00:16:19.555Z,1611706579.555 [DefaultWithUndock:SurfaceDefault:HoldLatchOpen](DEBUG): Aggregate::initialize DefaultWithUndock:SurfaceDefault:HoldLatchOpen 2021-01-27T00:16:19.555Z,1611706579.555 [DefaultWithUndock:SurfaceDefault:HoldLatchOpen:A] Running Loop=1 2021-01-27T00:16:19.555Z,1611706579.555 [DefaultWithUndock:SurfaceDefault:HoldLatchOpen:B] Running Loop=1 2021-01-27T00:16:19.555Z,1611706579.555 [DefaultWithUndock:SurfaceDefault:B.GoToSurface] Running Loop=1 2021-01-27T00:16:19.555Z,1611706579.555 [DefaultWithUndock:SurfaceDefault:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2021-01-27T00:16:19.555Z,1611706579.555 [DefaultWithUndock:SurfaceDefault:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2021-01-27T00:16:19.555Z,1611706579.555 [DefaultWithUndock:SurfaceDefault:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2021-01-27T00:16:19.556Z,1611706579.556 [DefaultWithUndock:SurfaceDefault:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2021-01-27T00:16:19.556Z,1611706579.556 [DefaultWithUndock:SurfaceDefault:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2021-01-27T00:16:19.557Z,1611706579.557 [DefaultWithUndock:SurfaceDefault:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2021-01-27T00:16:19.889Z,1611706579.889 [DefaultWithUndock:SurfaceDefault:CheckIn] Running Loop=1 2021-01-27T00:16:19.889Z,1611706579.889 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::initialize DefaultWithUndock:SurfaceDefault:CheckIn 2021-01-27T00:16:19.889Z,1611706579.889 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Running Loop=1 2021-01-27T00:16:19.889Z,1611706579.889 [DefaultWithUndock:SurfaceDefault:HoldLatchOpen] Stopped 2021-01-27T00:16:19.889Z,1611706579.889 [DefaultWithUndock:SurfaceDefault:HoldLatchOpen](DEBUG): Aggregate::uninitialize DefaultWithUndock:SurfaceDefault:HoldLatchOpen 2021-01-27T00:16:19.889Z,1611706579.889 [DefaultWithUndock:SurfaceDefault:HoldLatchOpen:A] Stopped 2021-01-27T00:16:19.889Z,1611706579.889 [DefaultWithUndock:SurfaceDefault:HoldLatchOpen:B] Stopped 2021-01-27T00:16:21.896Z,1611706581.896 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,001621.00,A,4132.88230,N,07042.77560,W,0.719,196.04,270121,,,D*78 2021-01-27T00:16:21.898Z,1611706581.898 [NAL9602](INFO): GPS fix at 20210127T001621: (41.548038, -70.712927) 2021-01-27T00:16:21.919Z,1611706581.919 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Stopped 2021-01-27T00:16:21.919Z,1611706581.919 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Running Loop=1 2021-01-27T00:16:26.141Z,1611706586.141 [DataOverHttps](INFO): Sending 152 bytes from file Logs/20210127T001126/Courier0003.lzma 2021-01-27T00:16:27.141Z,1611706587.141 [DataOverHttps](INFO): Moved sent file to Logs/20210127T001126/Courier0003.lzma.bak 2021-01-27T00:16:27.142Z,1611706587.142 [DataOverHttps](INFO): SBD MOMSN=68181 2021-01-27T00:16:32.440Z,1611706592.440 [BuoyancyServo](FAULT): Overload Error 2021-01-27T00:16:32.440Z,1611706592.440 [BuoyancyServo] Hardware Fault, FailCount= 2 2021-01-27T00:16:32.440Z,1611706592.440 [BuoyancyServo](ERROR): Hardware Fault 2021-01-27T00:16:32.516Z,1611706592.516 [CBIT](ERROR): Hardware Fault in component: BuoyancyServo 2021-01-27T00:16:34.446Z,1611706594.446 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2021-01-27T00:16:34.446Z,1611706594.446 [BuoyancyServo](INFO): Powering down 2021-01-27T00:16:34.874Z,1611706594.874 [BuoyancyServo](FAULT): LCB fault: Current Limiter Activated. 2021-01-27T00:16:35.285Z,1611706595.285 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2021-01-27T00:16:35.285Z,1611706595.285 [BuoyancyServo] No Fault, FailCount= 2 2021-01-27T00:16:35.677Z,1611706595.677 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2021-01-27T00:16:35.692Z,1611706595.692 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2021-01-27T00:16:36.179Z,1611706596.179 [DataOverHttps](INFO): Sending 52 bytes from file Logs/20210127T001126/Courier0009.lzma 2021-01-27T00:16:37.181Z,1611706597.181 [DataOverHttps](INFO): Moved sent file to Logs/20210127T001126/Courier0009.lzma.bak 2021-01-27T00:16:37.182Z,1611706597.182 [DataOverHttps](INFO): SBD MOMSN=68185 2021-01-27T00:16:40.080Z,1611706600.080 [NAL9602](INFO): SBD MO Status=0, MOMSN=13068, MT Status=0, MTMSN=0 2021-01-27T00:16:40.080Z,1611706600.080 [NAL9602](INFO): No messages in MT queue 2021-01-27T00:16:46.221Z,1611706606.221 [DataOverHttps](INFO): Sending 854 bytes from file Logs/20210127T001126/Express0007.lzma 2021-01-27T00:16:47.222Z,1611706607.222 [DataOverHttps](INFO): Moved sent file to Logs/20210127T001126/Express0007.lzma.bak 2021-01-27T00:16:47.222Z,1611706607.222 [DataOverHttps](INFO): SBD MOMSN=68187 2021-01-27T00:16:56.259Z,1611706616.259 [DataOverHttps](INFO): Sending 61 bytes from file Logs/20210127T001126/Express0010.lzma 2021-01-27T00:16:57.261Z,1611706617.261 [DataOverHttps](INFO): Moved sent file to Logs/20210127T001126/Express0010.lzma.bak 2021-01-27T00:16:57.262Z,1611706617.262 [DataOverHttps](INFO): SBD MOMSN=68219 2021-01-27T00:16:58.685Z,1611706618.685 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Stopped 2021-01-27T00:16:58.686Z,1611706618.686 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Running Loop=1 2021-01-27T00:16:58.686Z,1611706618.686 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-01-27T00:16:59.548Z,1611706619.548 [BuoyancyServo](FAULT): Overload Error 2021-01-27T00:16:59.548Z,1611706619.548 [BuoyancyServo] Hardware Fault, FailCount= 3 2021-01-27T00:16:59.548Z,1611706619.548 [BuoyancyServo](ERROR): Hardware Fault 2021-01-27T00:16:59.589Z,1611706619.589 [CBIT](ERROR): Hardware Fault in component: BuoyancyServo 2021-01-27T00:17:01.543Z,1611706621.543 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2021-01-27T00:17:01.543Z,1611706621.543 [BuoyancyServo](INFO): Powering down 2021-01-27T00:17:02.323Z,1611706622.323 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2021-01-27T00:17:02.323Z,1611706622.323 [BuoyancyServo] No Fault, FailCount= 3 2021-01-27T00:17:02.752Z,1611706622.752 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2021-01-27T00:17:02.753Z,1611706622.753 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2021-01-27T00:17:10.774Z,1611706630.774 [NAL9602](INFO): Not Powering down - fast GPS 2021-01-27T00:17:20.148Z,1611706640.148 [BuoyancyServo](FAULT): Overload Error 2021-01-27T00:17:20.148Z,1611706640.148 [BuoyancyServo] Hardware Fault, FailCount= 4 2021-01-27T00:17:20.148Z,1611706640.148 [BuoyancyServo](ERROR): Hardware Fault 2021-01-27T00:17:20.189Z,1611706640.189 [CBIT](ERROR): Hardware Fault in component: BuoyancyServo 2021-01-27T00:17:22.130Z,1611706642.130 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2021-01-27T00:17:22.131Z,1611706642.131 [BuoyancyServo](INFO): Powering down 2021-01-27T00:17:22.964Z,1611706642.964 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2021-01-27T00:17:22.964Z,1611706642.964 [BuoyancyServo] No Fault, FailCount= 4 2021-01-27T00:17:23.317Z,1611706643.317 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2021-01-27T00:17:23.318Z,1611706643.318 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2021-01-27T00:17:39.948Z,1611706659.948 [BuoyancyServo](FAULT): Overload Error 2021-01-27T00:17:39.948Z,1611706659.948 [BuoyancyServo] Hardware Fault, FailCount= 5 2021-01-27T00:17:39.948Z,1611706659.948 [BuoyancyServo](ERROR): Hardware Fault 2021-01-27T00:17:39.989Z,1611706659.989 [CBIT](ERROR): Hardware Fault in component: BuoyancyServo 2021-01-27T00:17:41.931Z,1611706661.931 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2021-01-27T00:17:41.932Z,1611706661.932 [BuoyancyServo](INFO): Powering down 2021-01-27T00:17:42.778Z,1611706662.778 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2021-01-27T00:17:42.778Z,1611706662.778 [BuoyancyServo] No Fault, FailCount= 5 2021-01-27T00:17:43.142Z,1611706663.142 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2021-01-27T00:17:43.143Z,1611706663.143 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2021-01-27T00:17:58.936Z,1611706678.936 [BuoyancyServo](FAULT): Overload Error 2021-01-27T00:17:58.936Z,1611706678.936 [BuoyancyServo] Hardware Fault, FailCount= 6 2021-01-27T00:17:58.936Z,1611706678.936 [BuoyancyServo](ERROR): Hardware Fault 2021-01-27T00:17:58.977Z,1611706678.977 [CBIT](ERROR): Hardware Fault in component: BuoyancyServo 2021-01-27T00:18:00.908Z,1611706680.908 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2021-01-27T00:18:00.908Z,1611706680.908 [BuoyancyServo](INFO): Powering down 2021-01-27T00:18:01.752Z,1611706681.752 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2021-01-27T00:18:01.752Z,1611706681.752 [BuoyancyServo] No Fault, FailCount= 6 2021-01-27T00:18:02.111Z,1611706682.111 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2021-01-27T00:18:02.111Z,1611706682.111 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2021-01-27T00:21:22.534Z,1611706882.534 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2021-01-27T00:21:43.427Z,1611706903.427 [DataOverHttps](IMPORTANT): SBD MTMSN=20210127T002143 2021-01-27T00:21:47.444Z,1611706907.444 [DataOverHttps](INFO): Received command:sched asap "load Transport/transit.xml;set transit.MissionTimeout 30 minute;set transit.Latitude 41.5548 degree;set transit.Longitude -70.7 degree;set transit.Depth 7 meter;set transit.Speed 1.2 meter_per_second;set transit.MaxDepth 9 meter" 2s0zu 1 2 2021-01-27T00:21:47.482Z,1611706907.482 [CommandLine](IMPORTANT): got command schedule asap "load Transport/transit.xml;set transit.MissionTimeout 30 minute;set transit.Latitude 41.5548 degree;set transit.Longitude -70.7 degree;set transit.Depth 7 meter;set transit.Speed 1.2 meter_per_second;set transit.MaxDepth 9 meter" 2s0zu 1 2.000000 2021-01-27T00:21:47.482Z,1611706907.482 [CommandLine](IMPORTANT): Scheduling command #1 of 2 with id=2s0zu 2021-01-27T00:21:47.483Z,1611706907.483 [CommandLine](IMPORTANT): Scheduled #10 (#1 of 2 with id='2s0zu'): "load Transport/transit.xml;set transit.MissionTimeout 30 minute;set transit.Latitude 41.5548 degree;set transit.Longitude -70.7 degree;set transit.Depth 7 meter;set transit.Speed 1.2 meter_per_second;set transit.MaxDepth 9 meter" ASAP 2021-01-27T00:21:48.449Z,1611706908.449 [DataOverHttps](IMPORTANT): SBD MTMSN=20210127T002148 2021-01-27T00:21:52.468Z,1611706912.468 [DataOverHttps](INFO): Received command:sched asap "set transit.MinOffshore 500 meter;set transit.MinAltitude 3 meter;run" 2s0zu 2 2 2021-01-27T00:21:52.507Z,1611706912.507 [CommandLine](IMPORTANT): got command schedule asap "set transit.MinOffshore 500 meter;set transit.MinAltitude 3 meter;run" 2s0zu 2 2.000000 2021-01-27T00:21:52.517Z,1611706912.517 [CommandLine](IMPORTANT): Scheduling command #2 of 2 with id=2s0zu 2021-01-27T00:21:52.518Z,1611706912.518 [CommandLine](IMPORTANT): Scheduled #11 (#2 of 2 with id='2s0zu'): "set transit.MinOffshore 500 meter;set transit.MinAltitude 3 meter;run" ASAP 2021-01-27T00:21:52.623Z,1611706912.623 [CommandLine](IMPORTANT): got command load ./Missions/Transport/transit.xml 2021-01-27T00:21:52.624Z,1611706912.624 [MissionManager](INFO): Loading Mission: ./Missions/Transport/transit.xml 2021-01-27T00:21:52.686Z,1611706912.686 [MissionManager](INFO): DefineArg transit.MissionTimeout = 60.000000 min 2021-01-27T00:21:52.693Z,1611706912.693 [MissionManager](INFO): DefineArg transit.NeedCommsTime = 30.000000 min 2021-01-27T00:21:52.699Z,1611706912.699 [MissionManager](INFO): DefineArg transit.Latitude = nan arcdeg 2021-01-27T00:21:52.706Z,1611706912.706 [MissionManager](INFO): DefineArg transit.Longitude = nan arcdeg 2021-01-27T00:21:52.715Z,1611706912.715 [MissionManager](INFO): DefineArg transit.Northings = 0.000000 m 2021-01-27T00:21:52.722Z,1611706912.722 [MissionManager](INFO): DefineArg transit.Eastings = 0.000000 m 2021-01-27T00:21:52.727Z,1611706912.727 [MissionManager](INFO): DefineArg transit.Depth = 10.000000 m 2021-01-27T00:21:52.730Z,1611706912.730 [MissionManager](INFO): DefineArg transit.Speed = 1.000000 m/s 2021-01-27T00:21:52.752Z,1611706912.752 [MissionManager](INFO): DefineArg transit.MaxDepth = 20.000000 m 2021-01-27T00:21:52.754Z,1611706912.754 [MissionManager](INFO): DefineArg transit.MinOffshore = 1.000000 km 2021-01-27T00:21:52.795Z,1611706912.795 [RDI_PathfinderUp](ERROR): only read 2 of 4 data items 2021-01-27T00:21:52.797Z,1611706912.797 [MissionManager](INFO): DefineArg transit.MinAltitude = 7.000000 m 2021-01-27T00:21:52.799Z,1611706912.799 [MissionManager](INFO): DefineArg transit.MassHold = 1 bool 2021-01-27T00:21:52.813Z,1611706912.813 [MissionManager](INFO): DefineArg transit.BuoyancyHold = 1 bool 2021-01-27T00:21:52.813Z,1611706912.813 [MissionManager](INFO): Inserting Stack: Missions/Insert/NeedComms.xml 2021-01-27T00:21:52.959Z,1611706912.959 [MissionManager](INFO): DefineArg transit:NeedComms.DiveInterval = 3.000000 h 2021-01-27T00:21:52.961Z,1611706912.961 [MissionManager](INFO): DefineArg transit:NeedComms.WaitForPitchUp = 10.000000 min 2021-01-27T00:21:52.963Z,1611706912.963 [MissionManager](INFO): DefineArg transit:NeedComms.SurfacePitch = 20.000000 arcdeg 2021-01-27T00:21:52.975Z,1611706912.975 [MissionManager](INFO): DefineArg transit:NeedComms.SurfaceDepthRate = nan m/s 2021-01-27T00:21:52.985Z,1611706912.985 [MissionManager](INFO): DefineArg transit:NeedComms.SurfaceSpeed = 1.000000 m/s 2021-01-27T00:21:52.987Z,1611706912.987 [MissionManager](INFO): DefineArg transit:NeedComms.GPSTimeout = 7.000000 min 2021-01-27T00:21:52.989Z,1611706912.989 [MissionManager](INFO): DefineArg transit:NeedComms.CommsTimeout = 30.000000 min 2021-01-27T00:21:53.003Z,1611706913.003 [transit:NeedComms:B.GoToSurface](DEBUG): Construct GoToSurface. 2021-01-27T00:21:53.039Z,1611706913.039 [MissionManager](INFO): Inserting Stack: Missions/Insert/StandardEnvelopes.xml 2021-01-27T00:21:53.070Z,1611706913.070 [MissionManager](INFO): DefineArg transit:StandardEnvelopes.MinAltitude = 5.000000 m 2021-01-27T00:21:53.078Z,1611706913.078 [MissionManager](INFO): DefineArg transit:StandardEnvelopes.MaxDepth = 200.000000 m 2021-01-27T00:21:53.088Z,1611706913.088 [MissionManager](INFO): DefineArg transit:StandardEnvelopes.MinOffshore = 2000.000000 m 2021-01-27T00:21:53.089Z,1611706913.089 [transit:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Construct AltitudeEnvelope. 2021-01-27T00:21:53.103Z,1611706913.103 [transit:StandardEnvelopes:B.DepthEnvelope](DEBUG): Construct DepthEnvelope. 2021-01-27T00:21:53.122Z,1611706913.122 [transit:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Construct OffshoreEnvelope. 2021-01-27T00:21:53.137Z,1611706913.137 [transit:BuoyancyHold.Buoyancy](DEBUG): Construct Buoyancy. 2021-01-27T00:21:53.140Z,1611706913.140 [transit:MassHold.Pitch](DEBUG): Construct. 2021-01-27T00:21:53.146Z,1611706913.146 [transit:Transit:A.Pitch](DEBUG): Construct. 2021-01-27T00:21:53.150Z,1611706913.150 [transit:Transit:B.SetSpeed](DEBUG): Construct. 2021-01-27T00:21:53.152Z,1611706913.152 [transit:Transit:Wpt1.Waypoint](DEBUG): Construct Waypoint. 2021-01-27T00:21:53.202Z,1611706913.202 [MissionManager](DEBUG): Vehicle transits to desired waypoint and can be commanded to use/hold mass or buoyancy. Maximum duration of mission 60 How often to surface for commumications 30 Latitude of waypoint to seek. If set to NaN, uses latitude at mission initialization. NaN Longitude of waypoint to seek. If set to NaN, uses longitude at mission initialization. NaN Northward distance of the waypoint to seek. If combined with Latitude and/or Longitude, this is an offset from the specified Latitude and/or Longitude. 0 Eastward distance of the waypoint to seek. If combined with Latitude and/or Longitude, this is an offset from the specified Latitude and/or Longitude. 0 Depth of flat and level flight during the mission. 10 Speed of vehicle (relative to water) during the mission. 1 Maximum depth for the entire mission. 20 Minimum distance offshore for the entire mission. 1 Minimum height above the sea floor for the entire mission. 7 Set to True in order to hold mass at default position, False to allow mass to run on its own. Set to True in order to hold buoyancy at neutral position, False to allow buoyancy to run on its own. 1 2021-01-27T00:21:53.203Z,1611706913.203 [CommandLine](IMPORTANT): Loaded ./Missions/Transport/transit.xml 2021-01-27T00:21:59.263Z,1611706919.263 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](INFO): Done Waiting. 2021-01-27T00:21:59.263Z,1611706919.263 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Stopped 2021-01-27T00:21:59.263Z,1611706919.263 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-01-27T00:21:59.263Z,1611706919.263 [DefaultWithUndock:SurfaceDefault:CheckIn:D] Running Loop=1 2021-01-27T00:21:59.681Z,1611706919.681 [DefaultWithUndock:SurfaceDefault:CheckIn:D] Stopped 2021-01-27T00:21:59.681Z,1611706919.681 [DefaultWithUndock:SurfaceDefault:CheckIn:E] Running Loop=1 2021-01-27T00:22:00.113Z,1611706920.113 [DefaultWithUndock:SurfaceDefault:CheckIn:E](IMPORTANT): Default mission has been running for 6.659676 min 2021-01-27T00:22:00.113Z,1611706920.113 [DefaultWithUndock:SurfaceDefault:CheckIn:E] Stopped 2021-01-27T00:22:00.113Z,1611706920.113 [DefaultWithUndock:SurfaceDefault:CheckIn](INFO): Completed DefaultWithUndock:SurfaceDefault:CheckIn 2021-01-27T00:22:00.113Z,1611706920.113 [DefaultWithUndock:SurfaceDefault:CheckIn] Stopped 2021-01-27T00:22:00.113Z,1611706920.113 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::uninitialize DefaultWithUndock:SurfaceDefault:CheckIn 2021-01-27T00:22:00.113Z,1611706920.113 [DefaultWithUndock:SurfaceDefault:CheckIn](INFO): Running loop #2 2021-01-27T00:22:00.113Z,1611706920.113 [DefaultWithUndock:SurfaceDefault:CheckIn] Running Loop=2 2021-01-27T00:22:00.113Z,1611706920.113 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::initialize DefaultWithUndock:SurfaceDefault:CheckIn 2021-01-27T00:22:00.113Z,1611706920.113 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Running Loop=1 2021-01-27T00:22:02.072Z,1611706922.072 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,002202.00,A,4132.84285,N,07042.78823,W,0.447,173.66,270121,,,A*7B 2021-01-27T00:22:02.074Z,1611706922.074 [NAL9602](INFO): GPS fix at 20210127T002202: (41.547381, -70.713137) 2021-01-27T00:22:02.161Z,1611706922.161 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Stopped 2021-01-27T00:22:02.161Z,1611706922.161 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Running Loop=1 2021-01-27T00:22:02.233Z,1611706922.233 [CommandLine](IMPORTANT): got command set transit.MissionTimeout 30.000000 minute 2021-01-27T00:22:02.234Z,1611706922.234 [CommandLine](IMPORTANT): got command set transit.Latitude 41.554798 degree 2021-01-27T00:22:02.235Z,1611706922.235 [CommandLine](IMPORTANT): got command set transit.Longitude -70.699997 degree 2021-01-27T00:22:02.236Z,1611706922.236 [CommandLine](IMPORTANT): got command set transit.Depth 7.000000 meter 2021-01-27T00:22:02.237Z,1611706922.237 [CommandLine](IMPORTANT): got command set transit.Speed 1.200000 meter_per_second 2021-01-27T00:22:02.237Z,1611706922.237 [CommandLine](IMPORTANT): got command set transit.MaxDepth 9.000000 meter 2021-01-27T00:22:06.523Z,1611706926.523 [DataOverHttps](INFO): Sending 79 bytes from file Logs/20210127T001126/Courier0012.lzma 2021-01-27T00:22:06.875Z,1611706926.875 [CommandLine](IMPORTANT): got command set transit.MinOffshore 500.000000 meter 2021-01-27T00:22:06.876Z,1611706926.876 [CommandLine](IMPORTANT): got command set transit.MinAltitude 3.000000 meter 2021-01-27T00:22:06.877Z,1611706926.877 [CommandLine](IMPORTANT): got command run 2021-01-27T00:22:06.879Z,1611706926.879 [CommandLine](IMPORTANT): Running 2021-01-27T00:22:07.111Z,1611706927.111 [DefaultWithUndock] Stopped 2021-01-27T00:22:07.111Z,1611706927.111 [DefaultWithUndock](DEBUG): Aggregate::uninitialize DefaultWithUndock 2021-01-27T00:22:07.112Z,1611706927.112 [DefaultWithUndock:SurfaceDefault] Stopped 2021-01-27T00:22:07.112Z,1611706927.112 [DefaultWithUndock:SurfaceDefault](DEBUG): Aggregate::uninitialize DefaultWithUndock:SurfaceDefault 2021-01-27T00:22:07.112Z,1611706927.112 [DefaultWithUndock:SurfaceDefault:B.GoToSurface] Stopped 2021-01-27T00:22:07.112Z,1611706927.112 [DefaultWithUndock:SurfaceDefault:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2021-01-27T00:22:07.112Z,1611706927.112 [DefaultWithUndock:SurfaceDefault:CheckIn] Stopped 2021-01-27T00:22:07.112Z,1611706927.112 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::uninitialize DefaultWithUndock:SurfaceDefault:CheckIn 2021-01-27T00:22:07.112Z,1611706927.112 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Stopped 2021-01-27T00:22:07.112Z,1611706927.112 [MissionManager](IMPORTANT): Started mission transit 2021-01-27T00:22:07.113Z,1611706927.113 [transit] Running Loop=1 2021-01-27T00:22:07.113Z,1611706927.113 [transit](DEBUG): Aggregate::initialize transit 2021-01-27T00:22:07.113Z,1611706927.113 [transit:StandardEnvelopes] Running Loop=1 2021-01-27T00:22:07.113Z,1611706927.113 [transit:StandardEnvelopes](DEBUG): Aggregate::initialize transit:StandardEnvelopes 2021-01-27T00:22:07.113Z,1611706927.113 [transit:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1 2021-01-27T00:22:07.113Z,1611706927.113 [transit:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Initialize AltitudeEnvelopeComponent. 2021-01-27T00:22:07.113Z,1611706927.113 [transit:StandardEnvelopes:B.DepthEnvelope] Running Loop=1 2021-01-27T00:22:07.113Z,1611706927.113 [transit:StandardEnvelopes:B.DepthEnvelope](DEBUG): Initialize DepthEnvelopeComponent. 2021-01-27T00:22:07.114Z,1611706927.114 [transit:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1 2021-01-27T00:22:07.114Z,1611706927.114 [transit:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Initialize OffshoreEnvelopeComponent. 2021-01-27T00:22:07.114Z,1611706927.114 [transit:BuoyancyHold.Buoyancy] Running Loop=1 2021-01-27T00:22:07.114Z,1611706927.114 [transit:BuoyancyHold.Buoyancy](DEBUG): Initialize Buoyancy Component. 2021-01-27T00:22:07.114Z,1611706927.114 [transit:MassHold.Pitch] Running Loop=1 2021-01-27T00:22:07.114Z,1611706927.114 [transit:MassHold.Pitch](DEBUG): Initialize. 2021-01-27T00:22:07.114Z,1611706927.114 [transit:B] Running Loop=1 2021-01-27T00:22:07.115Z,1611706927.115 [transit:MassHold.Pitch] Running Loop=1 2021-01-27T00:22:07.115Z,1611706927.115 [transit:BuoyancyHold.Buoyancy] Running Loop=1 2021-01-27T00:22:07.115Z,1611706927.115 [transit:StandardEnvelopes] Running Loop=1 2021-01-27T00:22:07.115Z,1611706927.115 [transit:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1 2021-01-27T00:22:07.116Z,1611706927.116 [transit:StandardEnvelopes:B.DepthEnvelope] Running Loop=1 2021-01-27T00:22:07.116Z,1611706927.116 [transit:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1 2021-01-27T00:22:07.117Z,1611706927.117 [transit:B] Stopped 2021-01-27T00:22:07.117Z,1611706927.117 [transit:C] Running Loop=1 2021-01-27T00:22:07.525Z,1611706927.525 [DataOverHttps](INFO): Moved sent file to Logs/20210127T001126/Courier0012.lzma.bak 2021-01-27T00:22:07.526Z,1611706927.526 [DataOverHttps](INFO): SBD MOMSN=68226 2021-01-27T00:22:07.578Z,1611706927.578 [transit:C] Stopped 2021-01-27T00:22:07.578Z,1611706927.578 [transit:E] Running Loop=1 2021-01-27T00:22:07.915Z,1611706927.915 [transit:E] Stopped 2021-01-27T00:22:07.915Z,1611706927.915 [transit:F] Running Loop=1 2021-01-27T00:22:08.309Z,1611706928.309 [transit:F] Stopped 2021-01-27T00:22:08.310Z,1611706928.310 [transit:G] Running Loop=1 2021-01-27T00:22:08.783Z,1611706928.783 [transit:G] Stopped 2021-01-27T00:22:08.783Z,1611706928.783 [transit:Transit] Running Loop=1 2021-01-27T00:22:08.788Z,1611706928.788 [transit:Transit](DEBUG): Aggregate::initialize transit:Transit 2021-01-27T00:22:08.788Z,1611706928.788 [transit:Transit:A.Pitch] Running Loop=1 2021-01-27T00:22:08.788Z,1611706928.788 [transit:Transit:A.Pitch](DEBUG): Initialize. 2021-01-27T00:22:08.788Z,1611706928.788 [transit:Transit:B.SetSpeed] Running Loop=1 2021-01-27T00:22:08.788Z,1611706928.788 [transit:Transit:B.SetSpeed](DEBUG): Initialize. 2021-01-27T00:22:08.789Z,1611706928.789 [transit:Transit:Wpt1.Waypoint] Running Loop=1 2021-01-27T00:22:08.789Z,1611706928.789 [transit:Transit:Wpt1.Waypoint](DEBUG): Initialize WaypointComponent. 2021-01-27T00:22:09.113Z,1611706929.113 [transit:Transit:B.SetSpeed] Running Loop=1 2021-01-27T00:22:09.113Z,1611706929.113 [transit:Transit:A.Pitch] Running Loop=1 2021-01-27T00:22:17.593Z,1611706937.593 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2021-01-27T00:22:20.608Z,1611706940.608 [ThrusterServo](INFO): Failure count cleared after critical for ThrusterServo 2021-01-27T00:22:24.878Z,1611706944.878 [NAL9602](INFO): SBD MO Status=0, MOMSN=13069, MT Status=0, MTMSN=0 2021-01-27T00:22:24.878Z,1611706944.878 [NAL9602](INFO): No messages in MT queue 2021-01-27T00:22:37.830Z,1611706957.830 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-01-27T00:22:55.587Z,1611706975.587 [NAL9602](INFO): Not Powering down - fast GPS 2021-01-27T00:23:25.894Z,1611707005.894 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2021-01-27T00:25:23.047Z,1611707123.047 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2021-01-27T00:25:37.993Z,1611707137.993 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2021-01-27T00:25:47.751Z,1611707147.751 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2021-01-27T00:26:08.596Z,1611707168.596 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.259418 2021-01-27T00:26:38.772Z,1611707198.772 [Radio_Surface](INFO): Powering down 2021-01-27T00:26:44.757Z,1611707204.757 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2021-01-27T00:26:45.760Z,1611707205.760 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2021-01-27T00:35:06.060Z,1611707706.060 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2021-01-27T00:39:08.060Z,1611707948.060 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2021-01-27T00:42:08.637Z,1611708128.637 [RDI_PathfinderUp](ERROR): only read 2 of 4 data items 2021-01-27T00:42:13.901Z,1611708133.901 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2021-01-27T00:42:18.759Z,1611708138.759 [RDI_PathfinderUp](ERROR): only read 2 of 4 data items 2021-01-27T00:42:33.720Z,1611708153.720 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-01-27T00:42:48.634Z,1611708168.634 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for altitude 2021-01-27T00:44:53.869Z,1611708293.869 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2021-01-27T00:45:13.708Z,1611708313.708 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2021-01-27T00:45:29.030Z,1611708329.030 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2021-01-27T00:45:33.867Z,1611708333.867 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2021-01-27T00:45:43.978Z,1611708343.978 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2021-01-27T00:45:58.930Z,1611708358.930 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2021-01-27T00:46:09.016Z,1611708369.016 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude 2021-01-27T00:48:55.878Z,1611708535.878 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-01-27T00:52:02.139Z,1611708722.139 [transit:NeedComms] Running Loop=1 2021-01-27T00:52:02.139Z,1611708722.139 [transit:NeedComms](DEBUG): Aggregate::initialize transit:NeedComms 2021-01-27T00:52:02.139Z,1611708722.139 [transit:NeedComms:B.GoToSurface] Running Loop=1 2021-01-27T00:52:02.139Z,1611708722.139 [transit:NeedComms:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2021-01-27T00:52:02.140Z,1611708722.140 [transit:NeedComms:B.GoToSurface](INFO): Received depth rate setting nan m/s. 2021-01-27T00:52:02.140Z,1611708722.140 [transit:NeedComms:B.GoToSurface](INFO): Received pitch setting 19.999999 degrees. 2021-01-27T00:52:02.141Z,1611708722.141 [transit:NeedComms:B.GoToSurface](INFO): Received speed setting 1.000000 m/s. 2021-01-27T00:52:02.141Z,1611708722.141 [transit:NeedComms:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2021-01-27T00:52:02.141Z,1611708722.141 [transit:NeedComms:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2021-01-27T00:52:02.142Z,1611708722.142 [transit:NeedComms:A] Running Loop=1 2021-01-27T00:52:02.143Z,1611708722.143 [transit:NeedComms:A](INFO): last time_fix was: 1611706922.000000 second since 1970/01/01T00:00:00Z 2021-01-27T00:52:02.143Z,1611708722.143 [transit:NeedComms:A] Stopped 2021-01-27T00:52:07.366Z,1611708727.366 [transit](INFO): Timed out from 2021-01-27T00:22:07.1Z 2021-01-27T00:52:07.366Z,1611708727.366 [MissionManager](INFO): transit is completed. 2021-01-27T00:52:07.366Z,1611708727.366 [MissionManager](INFO): Uninitializing Mission transit 2021-01-27T00:52:07.367Z,1611708727.367 [transit] Stopped 2021-01-27T00:52:07.367Z,1611708727.367 [transit](DEBUG): Aggregate::uninitialize transit 2021-01-27T00:52:07.367Z,1611708727.367 [transit:NeedComms] Stopped 2021-01-27T00:52:07.367Z,1611708727.367 [transit:NeedComms](DEBUG): Aggregate::uninitialize transit:NeedComms 2021-01-27T00:52:07.367Z,1611708727.367 [transit:NeedComms:B.GoToSurface] Stopped 2021-01-27T00:52:07.367Z,1611708727.367 [transit:NeedComms:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2021-01-27T00:52:07.367Z,1611708727.367 [transit:StandardEnvelopes] Stopped 2021-01-27T00:52:07.367Z,1611708727.367 [transit:StandardEnvelopes](DEBUG): Aggregate::uninitialize transit:StandardEnvelopes 2021-01-27T00:52:07.367Z,1611708727.367 [transit:StandardEnvelopes:A.AltitudeEnvelope] Stopped 2021-01-27T00:52:07.367Z,1611708727.367 [transit:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Uninitialize AltitudeEnvelopeComponent. 2021-01-27T00:52:07.367Z,1611708727.367 [transit:StandardEnvelopes:B.DepthEnvelope] Stopped 2021-01-27T00:52:07.367Z,1611708727.367 [transit:StandardEnvelopes:B.DepthEnvelope](DEBUG): Uninitialize. 2021-01-27T00:52:07.368Z,1611708727.368 [transit:StandardEnvelopes:C.OffshoreEnvelope] Stopped 2021-01-27T00:52:07.368Z,1611708727.368 [transit:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Uninitialize OffshoreEnvelopeComponent. 2021-01-27T00:52:07.368Z,1611708727.368 [transit:BuoyancyHold.Buoyancy] Stopped 2021-01-27T00:52:07.368Z,1611708727.368 [transit:BuoyancyHold.Buoyancy](DEBUG): Uninitialize Buoyancy Component. 2021-01-27T00:52:07.368Z,1611708727.368 [transit:MassHold.Pitch] Stopped 2021-01-27T00:52:07.368Z,1611708727.368 [transit:Transit] Stopped 2021-01-27T00:52:07.368Z,1611708727.368 [transit:Transit](DEBUG): Aggregate::uninitialize transit:Transit 2021-01-27T00:52:07.368Z,1611708727.368 [transit:Transit:A.Pitch] Stopped 2021-01-27T00:52:07.368Z,1611708727.368 [transit:Transit:B.SetSpeed] Stopped 2021-01-27T00:52:07.368Z,1611708727.368 [transit:Transit:B.SetSpeed](DEBUG): Uninitialize. 2021-01-27T00:52:07.369Z,1611708727.369 [transit:Transit:Wpt1.Waypoint] Stopped 2021-01-27T00:52:07.369Z,1611708727.369 [transit:Transit:Wpt1.Waypoint](DEBUG): Uninitialize WaypointComponent. 2021-01-27T00:52:07.797Z,1611708727.797 [MissionManager](IMPORTANT): Started mission DefaultWithUndock 2021-01-27T00:52:07.797Z,1611708727.797 [DefaultWithUndock] Running Loop=1 2021-01-27T00:52:07.797Z,1611708727.797 [DefaultWithUndock](DEBUG): Aggregate::initialize DefaultWithUndock 2021-01-27T00:52:07.797Z,1611708727.797 [DefaultWithUndock:A.Wait] Running Loop=1 2021-01-27T00:52:07.797Z,1611708727.797 [DefaultWithUndock:A.Wait](DEBUG): Initialize Wait Component. 2021-01-27T00:52:38.086Z,1611708758.086 [DefaultWithUndock:A.Wait](INFO): Done Waiting. 2021-01-27T00:52:38.086Z,1611708758.086 [DefaultWithUndock:A.Wait] Stopped 2021-01-27T00:52:38.086Z,1611708758.086 [DefaultWithUndock:A.Wait](DEBUG): Uninitialize Wait Component. 2021-01-27T00:52:38.086Z,1611708758.086 [DefaultWithUndock:LeaveDock] Running Loop=1 2021-01-27T00:52:38.086Z,1611708758.086 [DefaultWithUndock:LeaveDock](DEBUG): Aggregate::initialize DefaultWithUndock:LeaveDock 2021-01-27T00:52:38.086Z,1611708758.086 [DefaultWithUndock:LeaveDock:A.] Running Loop=1 2021-01-27T00:52:38.086Z,1611708758.086 [DefaultWithUndock:LeaveDock:A.](INFO): Initializing TrackAcousticContact. 2021-01-27T00:52:38.087Z,1611708758.087 [DefaultWithUndock:LeaveDock:B.Undock] Running Loop=1 2021-01-27T00:52:38.087Z,1611708758.087 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Initialize. 2021-01-27T00:52:38.087Z,1611708758.087 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Initializing internal variables to default values. 2021-01-27T00:52:40.956Z,1611708760.956 [DefaultWithUndock:LeaveDock:A.](INFO): *** querying acoustic contact *** 2021-01-27T00:52:41.767Z,1611708761.767 [Micromodem](INFO): Nmea out: $CCPGT,1,14500,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*76 2021-01-27T00:52:41.882Z,1611708761.882 [DefaultWithUndock:LeaveDock:B.Undock](INFO): Detaching from dock. 2021-01-27T00:52:42.132Z,1611708762.132 [Micromodem](INFO): Nmea in: $SNPGT,1,14500,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*6B 2021-01-27T00:52:42.161Z,1611708762.161 [DefaultWithUndock:LeaveDock:B.Undock](INFO): Engaging thruster for 10.0 seconds (max) to disengage. 2021-01-27T00:52:42.941Z,1611708762.941 [Micromodem](INFO): Nmea in: $SNTTA,,,,,005243.27*5B 2021-01-27T00:52:44.187Z,1611708764.187 [DefaultWithUndock:LeaveDock:B.Undock](INFO): Thruster off. 2021-01-27T00:52:44.648Z,1611708764.648 [DefaultWithUndock:LeaveDock:B.Undock](INFO): Detected possible detachment. Starting timer. 2021-01-27T00:52:46.625Z,1611708766.625 [DefaultWithUndock:LeaveDock:A.](INFO): *** querying acoustic contact *** 2021-01-27T00:52:47.390Z,1611708767.390 [Micromodem](INFO): Nmea out: $CCPGT,1,14500,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*76 2021-01-27T00:52:47.792Z,1611708767.792 [Micromodem](INFO): Nmea in: $SNPGT,1,14500,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*6B 2021-01-27T00:52:48.626Z,1611708768.626 [Micromodem](INFO): Nmea in: $SNTTA,,,,,005248.90*5C 2021-01-27T00:52:52.249Z,1611708772.249 [DefaultWithUndock:LeaveDock:A.](INFO): *** querying acoustic contact *** 2021-01-27T00:52:53.050Z,1611708773.050 [Micromodem](INFO): Nmea out: $CCPGT,1,14500,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*76 2021-01-27T00:52:53.448Z,1611708773.448 [Micromodem](INFO): Nmea in: $SNPGT,1,14500,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*6B 2021-01-27T00:52:54.274Z,1611708774.274 [Micromodem](INFO): Nmea in: $SNTTA,,,,,005254.56*5B 2021-01-27T00:52:57.924Z,1611708777.924 [DefaultWithUndock:LeaveDock:A.](INFO): *** querying acoustic contact *** 2021-01-27T00:52:58.722Z,1611708778.722 [Micromodem](INFO): Nmea out: $CCPGT,1,14500,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*76 2021-01-27T00:52:59.105Z,1611708779.105 [Micromodem](INFO): Nmea in: $SNPGT,1,14500,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*6B 2021-01-27T00:52:59.913Z,1611708779.913 [Micromodem](INFO): Nmea in: $SNTTA,,,,,005300.23*59 2021-01-27T00:53:03.596Z,1611708783.596 [DefaultWithUndock:LeaveDock:A.](INFO): *** querying acoustic contact *** 2021-01-27T00:53:04.354Z,1611708784.354 [Micromodem](INFO): Nmea out: $CCPGT,1,14500,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*76 2021-01-27T00:53:04.768Z,1611708784.768 [Micromodem](INFO): Nmea in: $SNPGT,1,14500,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*6B 2021-01-27T00:53:04.817Z,1611708784.817 [DefaultWithUndock:LeaveDock:B.Undock](INFO): Detached at range: 826.92 m. Transitioning DDM to standby. 2021-01-27T00:53:05.598Z,1611708785.598 [Micromodem](INFO): Nmea in: $SNTTA,,,,,005305.86*53 2021-01-27T00:53:08.077Z,1611708788.077 [DefaultWithUndock:LeaveDock:B.Undock](INFO): DDM at standby. 2021-01-27T00:53:08.435Z,1611708788.435 [DefaultWithUndock:LeaveDock:B.Undock](IMPORTANT): Undocking sequence complete. 2021-01-27T00:53:08.435Z,1611708788.435 [DefaultWithUndock:LeaveDock:B.Undock] Stopped 2021-01-27T00:53:08.436Z,1611708788.436 [DefaultWithUndock:LeaveDock](INFO): Completed DefaultWithUndock:LeaveDock 2021-01-27T00:53:08.436Z,1611708788.436 [DefaultWithUndock:LeaveDock] Stopped 2021-01-27T00:53:08.436Z,1611708788.436 [DefaultWithUndock:LeaveDock](DEBUG): Aggregate::uninitialize DefaultWithUndock:LeaveDock 2021-01-27T00:53:08.436Z,1611708788.436 [DefaultWithUndock:LeaveDock:A.] Stopped 2021-01-27T00:53:08.436Z,1611708788.436 [DefaultWithUndock:SurfaceDefault] Running Loop=1 2021-01-27T00:53:08.436Z,1611708788.436 [DefaultWithUndock:SurfaceDefault](DEBUG): Aggregate::initialize DefaultWithUndock:SurfaceDefault 2021-01-27T00:53:08.436Z,1611708788.436 [DefaultWithUndock:SurfaceDefault:HoldLatchOpen] Running Loop=1 2021-01-27T00:53:08.436Z,1611708788.436 [DefaultWithUndock:SurfaceDefault:HoldLatchOpen](DEBUG): Aggregate::initialize DefaultWithUndock:SurfaceDefault:HoldLatchOpen 2021-01-27T00:53:08.437Z,1611708788.437 [DefaultWithUndock:SurfaceDefault:HoldLatchOpen:A] Running Loop=1 2021-01-27T00:53:08.437Z,1611708788.437 [DefaultWithUndock:SurfaceDefault:HoldLatchOpen:B] Running Loop=1 2021-01-27T00:53:08.437Z,1611708788.437 [DefaultWithUndock:SurfaceDefault:B.GoToSurface] Running Loop=1 2021-01-27T00:53:08.437Z,1611708788.437 [DefaultWithUndock:SurfaceDefault:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2021-01-27T00:53:08.437Z,1611708788.437 [DefaultWithUndock:SurfaceDefault:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2021-01-27T00:53:08.437Z,1611708788.437 [DefaultWithUndock:SurfaceDefault:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2021-01-27T00:53:08.438Z,1611708788.438 [DefaultWithUndock:SurfaceDefault:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2021-01-27T00:53:08.438Z,1611708788.438 [DefaultWithUndock:SurfaceDefault:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2021-01-27T00:53:08.438Z,1611708788.438 [DefaultWithUndock:SurfaceDefault:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2021-01-27T00:53:09.348Z,1611708789.348 [Radio_Surface](INFO): Powering up 2021-01-27T00:53:15.368Z,1611708795.368 [DataOverHttps](INFO): Radio surface powered ON. 2021-01-27T00:53:45.488Z,1611708825.488 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2021-01-27T00:54:20.628Z,1611708860.628 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2021-01-27T00:54:44.594Z,1611708884.594 [DefaultWithUndock:SurfaceDefault:B.GoToSurface](ERROR): Pitch down timeout. Pitch: -2.43 2021-01-27T00:54:55.768Z,1611708895.768 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2021-01-27T00:54:58.752Z,1611708898.752 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude 2021-01-27T00:55:30.916Z,1611708930.916 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2021-01-27T00:55:57.731Z,1611708957.731 [DefaultWithUndock:SurfaceDefault:CheckIn] Running Loop=1 2021-01-27T00:55:57.736Z,1611708957.736 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::initialize DefaultWithUndock:SurfaceDefault:CheckIn 2021-01-27T00:55:57.736Z,1611708957.736 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Running Loop=1 2021-01-27T00:55:57.736Z,1611708957.736 [DefaultWithUndock:SurfaceDefault:HoldLatchOpen] Stopped 2021-01-27T00:55:57.736Z,1611708957.736 [DefaultWithUndock:SurfaceDefault:HoldLatchOpen](DEBUG): Aggregate::uninitialize DefaultWithUndock:SurfaceDefault:HoldLatchOpen 2021-01-27T00:55:57.736Z,1611708957.736 [DefaultWithUndock:SurfaceDefault:HoldLatchOpen:A] Stopped 2021-01-27T00:55:57.736Z,1611708957.736 [DefaultWithUndock:SurfaceDefault:HoldLatchOpen:B] Stopped 2021-01-27T00:56:06.056Z,1611708966.056 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2021-01-27T00:56:32.799Z,1611708992.799 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2021-01-27T00:56:41.204Z,1611709001.204 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2021-01-27T00:56:50.245Z,1611709010.245 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003681 2021-01-27T00:56:52.180Z,1611709012.180 [NAL9602](INFO): SBD MO Status=0, MOMSN=13070, MT Status=0, MTMSN=0 2021-01-27T00:56:52.180Z,1611709012.180 [NAL9602](INFO): No messages in MT queue 2021-01-27T00:56:53.409Z,1611709013.409 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,005653.00,A,4133.31931,N,07041.99421,W,0.389,319.49,270121,,,A*73 2021-01-27T00:56:53.411Z,1611709013.411 [NAL9602](INFO): GPS fix at 20210127T005653: (41.555322, -70.699904) 2021-01-27T00:56:53.422Z,1611709013.422 [UniversalFixResidualReporter](INFO): Fix residual: 5.2 %DT, over the last 1375.9 m. Residual distance 71.3 m at bearing -156.9 degrees. Fix at (41.5553, -70.6999) with 1411.5 m made good. 2021-01-27T00:56:53.423Z,1611709013.423 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Stopped 2021-01-27T00:56:53.424Z,1611709013.424 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Running Loop=1 2021-01-27T00:56:57.283Z,1611709017.283 [DataOverHttps](INFO): Sending 55 bytes from file Logs/20210127T001126/Courier0015.lzma 2021-01-27T00:56:58.285Z,1611709018.285 [DataOverHttps](INFO): Moved sent file to Logs/20210127T001126/Courier0015.lzma.bak 2021-01-27T00:56:58.286Z,1611709018.286 [DataOverHttps](INFO): SBD MOMSN=68230 2021-01-27T00:57:07.324Z,1611709027.324 [DataOverHttps](INFO): Sending 203 bytes from file Logs/20210127T001126/Courier0018.lzma 2021-01-27T00:57:08.325Z,1611709028.325 [DataOverHttps](INFO): Moved sent file to Logs/20210127T001126/Courier0018.lzma.bak 2021-01-27T00:57:08.326Z,1611709028.326 [DataOverHttps](INFO): SBD MOMSN=68232 2021-01-27T00:57:17.365Z,1611709037.365 [DataOverHttps](INFO): Sending 613 bytes from file Logs/20210127T001126/Express0013.lzma 2021-01-27T00:57:18.366Z,1611709038.366 [DataOverHttps](INFO): Moved sent file to Logs/20210127T001126/Express0013.lzma.bak 2021-01-27T00:57:18.366Z,1611709038.366 [DataOverHttps](INFO): SBD MOMSN=68235 2021-01-27T00:57:26.115Z,1611709046.115 [NAL9602](INFO): Not Powering down - fast GPS 2021-01-27T00:57:27.403Z,1611709047.403 [DataOverHttps](INFO): Sending 70 bytes from file Logs/20210127T001126/Express0016.lzma 2021-01-27T00:57:28.406Z,1611709048.406 [DataOverHttps](INFO): Moved sent file to Logs/20210127T001126/Express0016.lzma.bak 2021-01-27T00:57:28.406Z,1611709048.406 [DataOverHttps](INFO): SBD MOMSN=68261 2021-01-27T00:57:37.444Z,1611709057.444 [DataOverHttps](INFO): Sending 305 bytes from file Logs/20210127T001126/Express0019.lzma 2021-01-27T00:57:38.450Z,1611709058.450 [DataOverHttps](INFO): Moved sent file to Logs/20210127T001126/Express0019.lzma.bak 2021-01-27T00:57:38.450Z,1611709058.450 [DataOverHttps](INFO): SBD MOMSN=68263 2021-01-27T00:57:39.900Z,1611709059.900 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Stopped 2021-01-27T00:57:39.901Z,1611709059.901 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Running Loop=1 2021-01-27T00:57:39.901Z,1611709059.901 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-01-27T01:00:40.182Z,1611709240.182 [DataOverHttps](IMPORTANT): SBD MTMSN=20210127T010039 2021-01-27T01:00:44.200Z,1611709244.200 [DataOverHttps](INFO): Received command:sched asap "load Transport/transit.xml;set transit.MissionTimeout 30 minute;set transit.Latitude 41.547 degree;set transit.Longitude -70.7105 degree;set transit.Depth 7 meter;set transit.Speed 1.35 meter_per_second;set transit.MaxDepth 9 meter" 2s2sp 1 2 2021-01-27T01:00:44.281Z,1611709244.281 [CommandLine](IMPORTANT): got command schedule asap "load Transport/transit.xml;set transit.MissionTimeout 30 minute;set transit.Latitude 41.547 degree;set transit.Longitude -70.7105 degree;set transit.Depth 7 meter;set transit.Speed 1.35 meter_per_second;set transit.MaxDepth 9 meter" 2s2sp 1 2.000000 2021-01-27T01:00:44.281Z,1611709244.281 [CommandLine](IMPORTANT): Scheduling command #1 of 2 with id=2s2sp 2021-01-27T01:00:44.282Z,1611709244.282 [CommandLine](IMPORTANT): Scheduled #12 (#1 of 2 with id='2s2sp'): "load Transport/transit.xml;set transit.MissionTimeout 30 minute;set transit.Latitude 41.547 degree;set transit.Longitude -70.7105 degree;set transit.Depth 7 meter;set transit.Speed 1.35 meter_per_second;set transit.MaxDepth 9 meter" ASAP 2021-01-27T01:00:45.201Z,1611709245.201 [DataOverHttps](IMPORTANT): SBD MTMSN=20210127T010044 2021-01-27T01:00:49.220Z,1611709249.220 [DataOverHttps](INFO): Received command:sched asap "set transit.MinOffshore 500 meter;set transit.MinAltitude 3 meter;run" 2s2sp 2 2 2021-01-27T01:00:49.229Z,1611709249.229 [CommandLine](IMPORTANT): got command schedule asap "set transit.MinOffshore 500 meter;set transit.MinAltitude 3 meter;run" 2s2sp 2 2.000000 2021-01-27T01:00:49.230Z,1611709249.230 [CommandLine](IMPORTANT): Scheduling command #2 of 2 with id=2s2sp 2021-01-27T01:00:49.231Z,1611709249.231 [CommandLine](IMPORTANT): Scheduled #13 (#2 of 2 with id='2s2sp'): "set transit.MinOffshore 500 meter;set transit.MinAltitude 3 meter;run" ASAP 2021-01-27T01:00:49.267Z,1611709249.267 [CommandLine](IMPORTANT): got command load ./Missions/Transport/transit.xml 2021-01-27T01:00:49.276Z,1611709249.276 [MissionManager](INFO): Loading Mission: ./Missions/Transport/transit.xml 2021-01-27T01:00:49.391Z,1611709249.391 [MissionManager](INFO): DefineArg transit.MissionTimeout = 60.000000 min 2021-01-27T01:00:49.395Z,1611709249.395 [MissionManager](INFO): DefineArg transit.NeedCommsTime = 30.000000 min 2021-01-27T01:00:49.428Z,1611709249.428 [MissionManager](INFO): DefineArg transit.Latitude = nan arcdeg 2021-01-27T01:00:49.431Z,1611709249.431 [MissionManager](INFO): DefineArg transit.Longitude = nan arcdeg 2021-01-27T01:00:49.437Z,1611709249.437 [MissionManager](INFO): DefineArg transit.Northings = 0.000000 m 2021-01-27T01:00:49.439Z,1611709249.439 [MissionManager](INFO): DefineArg transit.Eastings = 0.000000 m 2021-01-27T01:00:49.445Z,1611709249.445 [MissionManager](INFO): DefineArg transit.Depth = 10.000000 m 2021-01-27T01:00:49.447Z,1611709249.447 [MissionManager](INFO): DefineArg transit.Speed = 1.000000 m/s 2021-01-27T01:00:49.454Z,1611709249.454 [MissionManager](INFO): DefineArg transit.MaxDepth = 20.000000 m 2021-01-27T01:00:49.460Z,1611709249.460 [MissionManager](INFO): DefineArg transit.MinOffshore = 1.000000 km 2021-01-27T01:00:49.463Z,1611709249.463 [MissionManager](INFO): DefineArg transit.MinAltitude = 7.000000 m 2021-01-27T01:00:49.465Z,1611709249.465 [MissionManager](INFO): DefineArg transit.MassHold = 1 bool 2021-01-27T01:00:49.467Z,1611709249.467 [MissionManager](INFO): DefineArg transit.BuoyancyHold = 1 bool 2021-01-27T01:00:49.467Z,1611709249.467 [MissionManager](INFO): Inserting Stack: Missions/Insert/NeedComms.xml 2021-01-27T01:00:49.597Z,1611709249.597 [MissionManager](INFO): DefineArg transit:NeedComms.DiveInterval = 3.000000 h 2021-01-27T01:00:49.607Z,1611709249.607 [MissionManager](INFO): DefineArg transit:NeedComms.WaitForPitchUp = 10.000000 min 2021-01-27T01:00:49.610Z,1611709249.610 [MissionManager](INFO): DefineArg transit:NeedComms.SurfacePitch = 20.000000 arcdeg 2021-01-27T01:00:49.616Z,1611709249.616 [MissionManager](INFO): DefineArg transit:NeedComms.SurfaceDepthRate = nan m/s 2021-01-27T01:00:49.618Z,1611709249.618 [MissionManager](INFO): DefineArg transit:NeedComms.SurfaceSpeed = 1.000000 m/s 2021-01-27T01:00:49.625Z,1611709249.625 [MissionManager](INFO): DefineArg transit:NeedComms.GPSTimeout = 7.000000 min 2021-01-27T01:00:49.627Z,1611709249.627 [MissionManager](INFO): DefineArg transit:NeedComms.CommsTimeout = 30.000000 min 2021-01-27T01:00:49.643Z,1611709249.643 [transit:NeedComms:B.GoToSurface](DEBUG): Construct GoToSurface. 2021-01-27T01:00:49.686Z,1611709249.686 [MissionManager](INFO): Inserting Stack: Missions/Insert/StandardEnvelopes.xml 2021-01-27T01:00:49.727Z,1611709249.727 [MissionManager](INFO): DefineArg transit:StandardEnvelopes.MinAltitude = 5.000000 m 2021-01-27T01:00:49.758Z,1611709249.758 [MissionManager](INFO): DefineArg transit:StandardEnvelopes.MaxDepth = 200.000000 m 2021-01-27T01:00:49.760Z,1611709249.760 [MissionManager](INFO): DefineArg transit:StandardEnvelopes.MinOffshore = 2000.000000 m 2021-01-27T01:00:49.761Z,1611709249.761 [transit:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Construct AltitudeEnvelope. 2021-01-27T01:00:49.766Z,1611709249.766 [transit:StandardEnvelopes:B.DepthEnvelope](DEBUG): Construct DepthEnvelope. 2021-01-27T01:00:49.781Z,1611709249.781 [transit:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Construct OffshoreEnvelope. 2021-01-27T01:00:49.818Z,1611709249.818 [transit:BuoyancyHold.Buoyancy](DEBUG): Construct Buoyancy. 2021-01-27T01:00:49.837Z,1611709249.837 [transit:MassHold.Pitch](DEBUG): Construct. 2021-01-27T01:00:49.847Z,1611709249.847 [transit:Transit:A.Pitch](DEBUG): Construct. 2021-01-27T01:00:49.855Z,1611709249.855 [transit:Transit:B.SetSpeed](DEBUG): Construct. 2021-01-27T01:00:49.870Z,1611709249.870 [transit:Transit:Wpt1.Waypoint](DEBUG): Construct Waypoint. 2021-01-27T01:00:49.904Z,1611709249.904 [MissionManager](DEBUG): Vehicle transits to desired waypoint and can be commanded to use/hold mass or buoyancy. Maximum duration of mission 60 How often to surface for commumications 30 Latitude of waypoint to seek. If set to NaN, uses latitude at mission initialization. NaN Longitude of waypoint to seek. If set to NaN, uses longitude at mission initialization. NaN Northward distance of the waypoint to seek. If combined with Latitude and/or Longitude, this is an offset from the specified Latitude and/or Longitude. 0 Eastward distance of the waypoint to seek. If combined with Latitude and/or Longitude, this is an offset from the specified Latitude and/or Longitude. 0 Depth of flat and level flight during the mission. 10 Speed of vehicle (relative to water) during the mission. 1 Maximum depth for the entire mission. 20 Minimum distance offshore for the entire mission. 1 Minimum height above the sea floor for the entire mission. 7 Set to True in order to hold mass at default position, False to allow mass to run on its own. Set to True in order to hold buoyancy at neutral position, False to allow buoyancy to run on its own. 1 2021-01-27T01:00:49.908Z,1611709249.908 [CommandLine](IMPORTANT): Loaded ./Missions/Transport/transit.xml 2021-01-27T01:00:59.219Z,1611709259.219 [CommandLine](IMPORTANT): got command set transit.MissionTimeout 30.000000 minute 2021-01-27T01:00:59.220Z,1611709259.220 [CommandLine](IMPORTANT): got command set transit.Latitude 41.547001 degree 2021-01-27T01:00:59.220Z,1611709259.220 [CommandLine](IMPORTANT): got command set transit.Longitude -70.710503 degree 2021-01-27T01:00:59.221Z,1611709259.221 [CommandLine](IMPORTANT): got command set transit.Depth 7.000000 meter 2021-01-27T01:00:59.222Z,1611709259.222 [CommandLine](IMPORTANT): got command set transit.Speed 1.350000 meter_per_second 2021-01-27T01:00:59.222Z,1611709259.222 [CommandLine](IMPORTANT): got command set transit.MaxDepth 9.000000 meter 2021-01-27T01:01:02.940Z,1611709262.940 [CommandLine](IMPORTANT): got command set transit.MinOffshore 500.000000 meter 2021-01-27T01:01:02.940Z,1611709262.940 [CommandLine](IMPORTANT): got command set transit.MinAltitude 3.000000 meter 2021-01-27T01:01:02.941Z,1611709262.941 [CommandLine](IMPORTANT): got command run 2021-01-27T01:01:02.943Z,1611709262.943 [CommandLine](IMPORTANT): Running 2021-01-27T01:01:03.097Z,1611709263.097 [DefaultWithUndock] Stopped 2021-01-27T01:01:03.098Z,1611709263.098 [DefaultWithUndock](DEBUG): Aggregate::uninitialize DefaultWithUndock 2021-01-27T01:01:03.098Z,1611709263.098 [DefaultWithUndock:SurfaceDefault] Stopped 2021-01-27T01:01:03.098Z,1611709263.098 [DefaultWithUndock:SurfaceDefault](DEBUG): Aggregate::uninitialize DefaultWithUndock:SurfaceDefault 2021-01-27T01:01:03.098Z,1611709263.098 [DefaultWithUndock:SurfaceDefault:B.GoToSurface] Stopped 2021-01-27T01:01:03.098Z,1611709263.098 [DefaultWithUndock:SurfaceDefault:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2021-01-27T01:01:03.098Z,1611709263.098 [DefaultWithUndock:SurfaceDefault:CheckIn] Stopped 2021-01-27T01:01:03.098Z,1611709263.098 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::uninitialize DefaultWithUndock:SurfaceDefault:CheckIn 2021-01-27T01:01:03.098Z,1611709263.098 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Stopped 2021-01-27T01:01:03.098Z,1611709263.098 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-01-27T01:01:03.098Z,1611709263.098 [MissionManager](IMPORTANT): Started mission transit 2021-01-27T01:01:03.099Z,1611709263.099 [transit] Running Loop=1 2021-01-27T01:01:03.099Z,1611709263.099 [transit](DEBUG): Aggregate::initialize transit 2021-01-27T01:01:03.099Z,1611709263.099 [transit:StandardEnvelopes] Running Loop=1 2021-01-27T01:01:03.099Z,1611709263.099 [transit:StandardEnvelopes](DEBUG): Aggregate::initialize transit:StandardEnvelopes 2021-01-27T01:01:03.099Z,1611709263.099 [transit:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1 2021-01-27T01:01:03.099Z,1611709263.099 [transit:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Initialize AltitudeEnvelopeComponent. 2021-01-27T01:01:03.099Z,1611709263.099 [transit:StandardEnvelopes:B.DepthEnvelope] Running Loop=1 2021-01-27T01:01:03.099Z,1611709263.099 [transit:StandardEnvelopes:B.DepthEnvelope](DEBUG): Initialize DepthEnvelopeComponent. 2021-01-27T01:01:03.100Z,1611709263.100 [transit:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1 2021-01-27T01:01:03.100Z,1611709263.100 [transit:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Initialize OffshoreEnvelopeComponent. 2021-01-27T01:01:03.100Z,1611709263.100 [transit:BuoyancyHold.Buoyancy] Running Loop=1 2021-01-27T01:01:03.100Z,1611709263.100 [transit:BuoyancyHold.Buoyancy](DEBUG): Initialize Buoyancy Component. 2021-01-27T01:01:03.100Z,1611709263.100 [transit:MassHold.Pitch] Running Loop=1 2021-01-27T01:01:03.100Z,1611709263.100 [transit:MassHold.Pitch](DEBUG): Initialize. 2021-01-27T01:01:03.100Z,1611709263.100 [transit:B] Running Loop=1 2021-01-27T01:01:03.101Z,1611709263.101 [transit:MassHold.Pitch] Running Loop=1 2021-01-27T01:01:03.101Z,1611709263.101 [transit:BuoyancyHold.Buoyancy] Running Loop=1 2021-01-27T01:01:03.102Z,1611709263.102 [transit:StandardEnvelopes] Running Loop=1 2021-01-27T01:01:03.102Z,1611709263.102 [transit:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1 2021-01-27T01:01:03.102Z,1611709263.102 [transit:StandardEnvelopes:B.DepthEnvelope] Running Loop=1 2021-01-27T01:01:03.102Z,1611709263.102 [transit:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1 2021-01-27T01:01:03.103Z,1611709263.103 [transit:B] Stopped 2021-01-27T01:01:03.103Z,1611709263.103 [transit:C] Running Loop=1 2021-01-27T01:01:03.507Z,1611709263.507 [transit:C] Stopped 2021-01-27T01:01:03.507Z,1611709263.507 [transit:E] Running Loop=1 2021-01-27T01:01:03.929Z,1611709263.929 [transit:E] Stopped 2021-01-27T01:01:03.929Z,1611709263.929 [transit:F] Running Loop=1 2021-01-27T01:01:04.306Z,1611709264.306 [transit:F] Stopped 2021-01-27T01:01:04.306Z,1611709264.306 [transit:G] Running Loop=1 2021-01-27T01:01:04.759Z,1611709264.759 [transit:G] Stopped 2021-01-27T01:01:04.759Z,1611709264.759 [transit:Transit] Running Loop=1 2021-01-27T01:01:04.759Z,1611709264.759 [transit:Transit](DEBUG): Aggregate::initialize transit:Transit 2021-01-27T01:01:04.759Z,1611709264.759 [transit:Transit:A.Pitch] Running Loop=1 2021-01-27T01:01:04.759Z,1611709264.759 [transit:Transit:A.Pitch](DEBUG): Initialize. 2021-01-27T01:01:04.759Z,1611709264.759 [transit:Transit:B.SetSpeed] Running Loop=1 2021-01-27T01:01:04.760Z,1611709264.760 [transit:Transit:B.SetSpeed](DEBUG): Initialize. 2021-01-27T01:01:04.760Z,1611709264.760 [transit:Transit:Wpt1.Waypoint] Running Loop=1 2021-01-27T01:01:04.760Z,1611709264.760 [transit:Transit:Wpt1.Waypoint](DEBUG): Initialize WaypointComponent. 2021-01-27T01:01:05.117Z,1611709265.117 [transit:Transit:B.SetSpeed] Running Loop=1 2021-01-27T01:01:05.117Z,1611709265.117 [transit:Transit:A.Pitch] Running Loop=1 2021-01-27T01:01:12.880Z,1611709272.880 [ThrusterServo](FAULT): Overload Error 2021-01-27T01:01:12.880Z,1611709272.880 [ThrusterServo] Hardware Fault, FailCount= 1 2021-01-27T01:01:12.880Z,1611709272.880 [ThrusterServo](ERROR): Hardware Fault 2021-01-27T01:01:12.884Z,1611709272.884 [CBIT](ERROR): Hardware Fault in component: ThrusterServo 2021-01-27T01:01:13.249Z,1611709273.249 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2021-01-27T01:01:13.249Z,1611709273.249 [ThrusterServo](INFO): Powering down 2021-01-27T01:01:14.125Z,1611709274.125 [ThrusterServo](DEBUG): Initializing EZServoServo. 2021-01-27T01:01:14.245Z,1611709274.245 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2021-01-27T01:01:14.248Z,1611709274.248 [CBIT](INFO): Clearing failed state for component ThrusterServo 2021-01-27T01:01:14.249Z,1611709274.249 [ThrusterServo] No Fault, FailCount= 1 2021-01-27T01:01:23.192Z,1611709283.192 [ThrusterServo](FAULT): Overload Error 2021-01-27T01:01:23.192Z,1611709283.192 [ThrusterServo] Hardware Fault, FailCount= 2 2021-01-27T01:01:23.192Z,1611709283.192 [ThrusterServo](ERROR): Hardware Fault 2021-01-27T01:01:23.196Z,1611709283.196 [CBIT](ERROR): Hardware Fault in component: ThrusterServo 2021-01-27T01:01:23.624Z,1611709283.624 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2021-01-27T01:01:23.624Z,1611709283.624 [ThrusterServo](INFO): Powering down 2021-01-27T01:01:24.180Z,1611709284.180 [ThrusterServo](DEBUG): Initializing EZServoServo. 2021-01-27T01:01:24.301Z,1611709284.301 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2021-01-27T01:01:24.305Z,1611709284.305 [CBIT](INFO): Clearing failed state for component ThrusterServo 2021-01-27T01:01:24.305Z,1611709284.305 [ThrusterServo] No Fault, FailCount= 2 2021-01-27T01:01:32.772Z,1611709292.772 [ThrusterServo](FAULT): Overload Error 2021-01-27T01:01:32.772Z,1611709292.772 [ThrusterServo] Hardware Fault, FailCount= 3 2021-01-27T01:01:32.772Z,1611709292.772 [ThrusterServo](ERROR): Hardware Fault 2021-01-27T01:01:32.776Z,1611709292.776 [CBIT](ERROR): Hardware Fault in component: ThrusterServo 2021-01-27T01:01:33.193Z,1611709293.193 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2021-01-27T01:01:33.193Z,1611709293.193 [ThrusterServo](INFO): Powering down 2021-01-27T01:01:33.937Z,1611709293.937 [ThrusterServo](DEBUG): Initializing EZServoServo. 2021-01-27T01:01:34.057Z,1611709294.057 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2021-01-27T01:01:34.061Z,1611709294.061 [CBIT](INFO): Clearing failed state for component ThrusterServo 2021-01-27T01:01:34.061Z,1611709294.061 [ThrusterServo] No Fault, FailCount= 3 2021-01-27T01:01:42.848Z,1611709302.848 [ThrusterServo](FAULT): Overload Error 2021-01-27T01:01:42.848Z,1611709302.848 [ThrusterServo] Hardware Fault, FailCount= 4 2021-01-27T01:01:42.848Z,1611709302.848 [ThrusterServo](ERROR): Hardware Fault 2021-01-27T01:01:42.852Z,1611709302.852 [CBIT](ERROR): Hardware Fault in component: ThrusterServo 2021-01-27T01:01:43.245Z,1611709303.245 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2021-01-27T01:01:43.245Z,1611709303.245 [ThrusterServo](INFO): Powering down 2021-01-27T01:01:44.129Z,1611709304.129 [ThrusterServo](DEBUG): Initializing EZServoServo. 2021-01-27T01:01:44.249Z,1611709304.249 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2021-01-27T01:01:44.252Z,1611709304.252 [CBIT](INFO): Clearing failed state for component ThrusterServo 2021-01-27T01:01:44.253Z,1611709304.253 [ThrusterServo] No Fault, FailCount= 4 2021-01-27T01:01:53.000Z,1611709313.000 [ThrusterServo](FAULT): Overload Error 2021-01-27T01:01:53.000Z,1611709313.000 [ThrusterServo] Hardware Fault, FailCount= 5 2021-01-27T01:01:53.000Z,1611709313.000 [ThrusterServo](ERROR): Hardware Fault 2021-01-27T01:01:53.004Z,1611709313.004 [CBIT](ERROR): Hardware Fault in component: ThrusterServo 2021-01-27T01:01:53.004Z,1611709313.004 [CBIT](CRITICAL): Hardware Fault in component: ThrusterServo 2021-01-27T01:01:53.377Z,1611709313.377 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2021-01-27T01:01:53.377Z,1611709313.377 [ThrusterServo](INFO): Powering down 2021-01-27T01:01:53.379Z,1611709313.379 [CBIT](INFO): Critical error at 20210127T010153 2021-01-27T01:01:53.379Z,1611709313.379 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2021-01-27T01:01:53.606Z,1611709313.606 [MissionManager](INFO): MissionManager is completed. 2021-01-27T01:01:53.606Z,1611709313.606 [MissionManager](INFO): Uninitializing Mission transit 2021-01-27T01:01:53.606Z,1611709313.606 [transit] Stopped 2021-01-27T01:01:53.606Z,1611709313.606 [transit](DEBUG): Aggregate::uninitialize transit 2021-01-27T01:01:53.607Z,1611709313.607 [transit:StandardEnvelopes] Stopped 2021-01-27T01:01:53.607Z,1611709313.607 [transit:StandardEnvelopes](DEBUG): Aggregate::uninitialize transit:StandardEnvelopes 2021-01-27T01:01:53.607Z,1611709313.607 [transit:StandardEnvelopes:A.AltitudeEnvelope] Stopped 2021-01-27T01:01:53.607Z,1611709313.607 [transit:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Uninitialize AltitudeEnvelopeComponent. 2021-01-27T01:01:53.607Z,1611709313.607 [transit:StandardEnvelopes:B.DepthEnvelope] Stopped 2021-01-27T01:01:53.607Z,1611709313.607 [transit:StandardEnvelopes:B.DepthEnvelope](DEBUG): Uninitialize. 2021-01-27T01:01:53.607Z,1611709313.607 [transit:StandardEnvelopes:C.OffshoreEnvelope] Stopped 2021-01-27T01:01:53.607Z,1611709313.607 [transit:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Uninitialize OffshoreEnvelopeComponent. 2021-01-27T01:01:53.607Z,1611709313.607 [transit:BuoyancyHold.Buoyancy] Stopped 2021-01-27T01:01:53.607Z,1611709313.607 [transit:BuoyancyHold.Buoyancy](DEBUG): Uninitialize Buoyancy Component. 2021-01-27T01:01:53.607Z,1611709313.607 [transit:MassHold.Pitch] Stopped 2021-01-27T01:01:53.607Z,1611709313.607 [transit:Transit] Stopped 2021-01-27T01:01:53.607Z,1611709313.607 [transit:Transit](DEBUG): Aggregate::uninitialize transit:Transit 2021-01-27T01:01:53.624Z,1611709313.624 [transit:Transit:A.Pitch] Stopped 2021-01-27T01:01:53.624Z,1611709313.624 [transit:Transit:B.SetSpeed] Stopped 2021-01-27T01:01:53.624Z,1611709313.624 [transit:Transit:B.SetSpeed](DEBUG): Uninitialize. 2021-01-27T01:01:53.624Z,1611709313.624 [transit:Transit:Wpt1.Waypoint] Stopped 2021-01-27T01:01:53.624Z,1611709313.624 [transit:Transit:Wpt1.Waypoint](DEBUG): Uninitialize WaypointComponent. 2021-01-27T01:01:54.018Z,1611709314.018 [MissionManager](IMPORTANT): Started mission DefaultWithUndock 2021-01-27T01:01:54.019Z,1611709314.019 [DefaultWithUndock] Running Loop=1 2021-01-27T01:01:54.019Z,1611709314.019 [DefaultWithUndock](DEBUG): Aggregate::initialize DefaultWithUndock 2021-01-27T01:01:54.019Z,1611709314.019 [DefaultWithUndock:A.Wait] Running Loop=1 2021-01-27T01:01:54.019Z,1611709314.019 [DefaultWithUndock:A.Wait](DEBUG): Initialize Wait Component. 2021-01-27T01:02:06.972Z,1611709326.972 [BuoyancyServo](FAULT): Overload Error 2021-01-27T01:02:06.972Z,1611709326.972 [BuoyancyServo] Hardware Fault, FailCount= 1 2021-01-27T01:02:06.972Z,1611709326.972 [BuoyancyServo](ERROR): Hardware Fault 2021-01-27T01:02:07.012Z,1611709327.012 [CBIT](ERROR): Hardware Fault in component: BuoyancyServo 2021-01-27T01:02:08.953Z,1611709328.953 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2021-01-27T01:02:08.954Z,1611709328.954 [BuoyancyServo](INFO): Powering down 2021-01-27T01:02:09.348Z,1611709329.348 [BuoyancyServo](FAULT): LCB fault: Current Limiter Activated. 2021-01-27T01:02:09.786Z,1611709329.786 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2021-01-27T01:02:09.786Z,1611709329.786 [BuoyancyServo] No Fault, FailCount= 1 2021-01-27T01:02:10.152Z,1611709330.152 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2021-01-27T01:02:10.153Z,1611709330.153 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2021-01-27T01:02:23.143Z,1611709343.143 [CBIT](INFO): Clearing failed state for component ThrusterServo 2021-01-27T01:02:23.143Z,1611709343.143 [ThrusterServo] No Fault, FailCount= 5 2021-01-27T01:02:23.573Z,1611709343.573 [ThrusterServo](DEBUG): Initializing EZServoServo. 2021-01-27T01:02:23.574Z,1611709343.574 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2021-01-27T01:02:24.289Z,1611709344.289 [DefaultWithUndock:A.Wait](INFO): Done Waiting. 2021-01-27T01:02:24.289Z,1611709344.289 [DefaultWithUndock:A.Wait] Stopped 2021-01-27T01:02:24.289Z,1611709344.289 [DefaultWithUndock:A.Wait](DEBUG): Uninitialize Wait Component. 2021-01-27T01:02:24.290Z,1611709344.290 [DefaultWithUndock:LeaveDock] Running Loop=1 2021-01-27T01:02:24.290Z,1611709344.290 [DefaultWithUndock:LeaveDock](DEBUG): Aggregate::initialize DefaultWithUndock:LeaveDock 2021-01-27T01:02:24.290Z,1611709344.290 [DefaultWithUndock:LeaveDock:A.] Running Loop=1 2021-01-27T01:02:24.290Z,1611709344.290 [DefaultWithUndock:LeaveDock:A.](INFO): Initializing TrackAcousticContact. 2021-01-27T01:02:24.290Z,1611709344.290 [DefaultWithUndock:LeaveDock:B.Undock] Running Loop=1 2021-01-27T01:02:24.290Z,1611709344.290 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Initialize. 2021-01-27T01:02:24.290Z,1611709344.290 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Initializing internal variables to default values. 2021-01-27T01:02:25.663Z,1611709345.663 [DefaultWithUndock:LeaveDock:B.Undock](INFO): Detaching from dock. 2021-01-27T01:02:25.968Z,1611709345.968 [DefaultWithUndock:LeaveDock:B.Undock](INFO): Detected possible detachment. Starting timer. 2021-01-27T01:02:26.808Z,1611709346.808 [DefaultWithUndock:LeaveDock:A.](INFO): *** querying acoustic contact *** 2021-01-27T01:02:27.635Z,1611709347.635 [Micromodem](INFO): Nmea out: $CCPGT,1,14500,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*76 2021-01-27T01:02:28.028Z,1611709348.028 [Micromodem](INFO): Nmea in: $SNPGT,1,14500,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*6B 2021-01-27T01:02:28.813Z,1611709348.813 [Micromodem](INFO): Nmea in: $SNTTA,,,,,010229.14*53 2021-01-27T01:02:32.453Z,1611709352.453 [DefaultWithUndock:LeaveDock:A.](INFO): *** querying acoustic contact *** 2021-01-27T01:02:33.242Z,1611709353.242 [Micromodem](INFO): Nmea out: $CCPGT,1,14500,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*76 2021-01-27T01:02:33.653Z,1611709353.653 [Micromodem](INFO): Nmea in: $SNPGT,1,14500,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*6B 2021-01-27T01:02:34.470Z,1611709354.470 [Micromodem](INFO): Nmea in: $SNTTA,,,,,010234.75*58 2021-01-27T01:02:38.109Z,1611709358.109 [DefaultWithUndock:LeaveDock:A.](INFO): *** querying acoustic contact *** 2021-01-27T01:02:38.898Z,1611709358.898 [Micromodem](INFO): Nmea out: $CCPGT,1,14500,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*76 2021-01-27T01:02:39.304Z,1611709359.304 [Micromodem](INFO): Nmea in: $SNPGT,1,14500,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*6B 2021-01-27T01:02:39.751Z,1611709359.751 [RDI_PathfinderUp](ERROR): only read 2 of 4 data items 2021-01-27T01:02:40.122Z,1611709360.122 [Micromodem](INFO): Nmea in: $SNTTA,,,,,010240.40*5D 2021-01-27T01:02:43.860Z,1611709363.860 [DefaultWithUndock:LeaveDock:A.](INFO): *** querying acoustic contact *** 2021-01-27T01:02:44.574Z,1611709364.574 [Micromodem](INFO): Nmea out: $CCPGT,1,14500,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*76 2021-01-27T01:02:44.979Z,1611709364.979 [Micromodem](INFO): Nmea in: $SNPGT,1,14500,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*6B 2021-01-27T01:02:45.779Z,1611709365.779 [Micromodem](INFO): Nmea in: $SNTTA,,,,,010246.08*57 2021-01-27T01:02:46.201Z,1611709366.201 [DefaultWithUndock:LeaveDock:B.Undock](INFO): Detached at range: 821.52 m. Transitioning DDM to standby. 2021-01-27T01:02:49.074Z,1611709369.074 [DefaultWithUndock:LeaveDock:B.Undock](INFO): DDM at standby. 2021-01-27T01:02:49.428Z,1611709369.428 [DefaultWithUndock:LeaveDock:B.Undock](IMPORTANT): Undocking sequence complete. 2021-01-27T01:02:49.428Z,1611709369.428 [DefaultWithUndock:LeaveDock:B.Undock] Stopped 2021-01-27T01:02:49.429Z,1611709369.429 [DefaultWithUndock:LeaveDock:A.](INFO): *** querying acoustic contact *** 2021-01-27T01:02:49.429Z,1611709369.429 [DefaultWithUndock:LeaveDock](INFO): Completed DefaultWithUndock:LeaveDock 2021-01-27T01:02:49.429Z,1611709369.429 [DefaultWithUndock:LeaveDock] Stopped 2021-01-27T01:02:49.430Z,1611709369.430 [DefaultWithUndock:LeaveDock](DEBUG): Aggregate::uninitialize DefaultWithUndock:LeaveDock 2021-01-27T01:02:49.430Z,1611709369.430 [DefaultWithUndock:LeaveDock:A.] Stopped 2021-01-27T01:02:49.430Z,1611709369.430 [DefaultWithUndock:SurfaceDefault] Running Loop=1 2021-01-27T01:02:49.430Z,1611709369.430 [DefaultWithUndock:SurfaceDefault](DEBUG): Aggregate::initialize DefaultWithUndock:SurfaceDefault 2021-01-27T01:02:49.430Z,1611709369.430 [DefaultWithUndock:SurfaceDefault:HoldLatchOpen] Running Loop=1 2021-01-27T01:02:49.430Z,1611709369.430 [DefaultWithUndock:SurfaceDefault:HoldLatchOpen](DEBUG): Aggregate::initialize DefaultWithUndock:SurfaceDefault:HoldLatchOpen 2021-01-27T01:02:49.430Z,1611709369.430 [DefaultWithUndock:SurfaceDefault:HoldLatchOpen:A] Running Loop=1 2021-01-27T01:02:49.430Z,1611709369.430 [DefaultWithUndock:SurfaceDefault:HoldLatchOpen:B] Running Loop=1 2021-01-27T01:02:49.430Z,1611709369.430 [DefaultWithUndock:SurfaceDefault:B.GoToSurface] Running Loop=1 2021-01-27T01:02:49.430Z,1611709369.430 [DefaultWithUndock:SurfaceDefault:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2021-01-27T01:02:49.431Z,1611709369.431 [DefaultWithUndock:SurfaceDefault:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2021-01-27T01:02:49.431Z,1611709369.431 [DefaultWithUndock:SurfaceDefault:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2021-01-27T01:02:49.431Z,1611709369.431 [DefaultWithUndock:SurfaceDefault:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2021-01-27T01:02:49.436Z,1611709369.436 [DefaultWithUndock:SurfaceDefault:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2021-01-27T01:02:49.436Z,1611709369.436 [DefaultWithUndock:SurfaceDefault:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2021-01-27T01:02:49.806Z,1611709369.806 [DefaultWithUndock:SurfaceDefault:CheckIn] Running Loop=1 2021-01-27T01:02:49.807Z,1611709369.807 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::initialize DefaultWithUndock:SurfaceDefault:CheckIn 2021-01-27T01:02:49.807Z,1611709369.807 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Running Loop=1 2021-01-27T01:02:49.807Z,1611709369.807 [DefaultWithUndock:SurfaceDefault:HoldLatchOpen] Stopped 2021-01-27T01:02:49.807Z,1611709369.807 [DefaultWithUndock:SurfaceDefault:HoldLatchOpen](DEBUG): Aggregate::uninitialize DefaultWithUndock:SurfaceDefault:HoldLatchOpen 2021-01-27T01:02:49.807Z,1611709369.807 [DefaultWithUndock:SurfaceDefault:HoldLatchOpen:A] Stopped 2021-01-27T01:02:49.807Z,1611709369.807 [DefaultWithUndock:SurfaceDefault:HoldLatchOpen:B] Stopped 2021-01-27T01:02:51.796Z,1611709371.796 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,010251.00,A,4133.30986,N,07042.05792,W,0.525,295.28,270121,,,A*73 2021-01-27T01:02:51.798Z,1611709371.798 [NAL9602](INFO): GPS fix at 20210127T010251: (41.555164, -70.700965) 2021-01-27T01:02:51.848Z,1611709371.848 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Stopped 2021-01-27T01:02:51.848Z,1611709371.848 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Running Loop=1 2021-01-27T01:02:55.752Z,1611709375.752 [DataOverHttps](INFO): Sending 130 bytes from file Logs/20210127T001126/Courier0021.lzma 2021-01-27T01:02:56.750Z,1611709376.750 [DataOverHttps](INFO): Moved sent file to Logs/20210127T001126/Courier0021.lzma.bak 2021-01-27T01:02:56.750Z,1611709376.750 [DataOverHttps](INFO): SBD MOMSN=68275 2021-01-27T01:03:01.925Z,1611709381.925 [RDI_Pathfinder](ERROR): only read 0 of 4 data items 2021-01-27T01:03:02.348Z,1611709382.348 [BuoyancyServo](FAULT): Overload Error 2021-01-27T01:03:02.348Z,1611709382.348 [BuoyancyServo] Hardware Fault, FailCount= 2 2021-01-27T01:03:02.348Z,1611709382.348 [BuoyancyServo](ERROR): Hardware Fault 2021-01-27T01:03:02.416Z,1611709382.416 [CBIT](ERROR): Hardware Fault in component: BuoyancyServo 2021-01-27T01:03:04.335Z,1611709384.335 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2021-01-27T01:03:04.335Z,1611709384.335 [BuoyancyServo](INFO): Powering down 2021-01-27T01:03:04.775Z,1611709384.775 [BuoyancyServo](FAULT): LCB fault: Software Overcurrent. Current Limiter Activated. 2021-01-27T01:03:05.180Z,1611709385.180 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2021-01-27T01:03:05.180Z,1611709385.180 [BuoyancyServo] No Fault, FailCount= 2 2021-01-27T01:03:05.572Z,1611709385.572 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2021-01-27T01:03:05.573Z,1611709385.573 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2021-01-27T01:03:05.807Z,1611709385.807 [DataOverHttps](INFO): Sending 52 bytes from file Logs/20210127T001126/Courier0024.lzma 2021-01-27T01:03:06.810Z,1611709386.810 [DataOverHttps](INFO): Moved sent file to Logs/20210127T001126/Courier0024.lzma.bak 2021-01-27T01:03:06.811Z,1611709386.811 [DataOverHttps](INFO): SBD MOMSN=68279 2021-01-27T01:03:09.574Z,1611709389.574 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2021-01-27T01:03:11.607Z,1611709391.607 [NAL9602](INFO): SBD MO Status=0, MOMSN=13071, MT Status=0, MTMSN=0 2021-01-27T01:03:11.607Z,1611709391.607 [NAL9602](INFO): No messages in MT queue 2021-01-27T01:03:15.865Z,1611709395.865 [DataOverHttps](INFO): Sending 684 bytes from file Logs/20210127T001126/Express0022.lzma 2021-01-27T01:03:16.856Z,1611709396.856 [DataOverHttps](INFO): Moved sent file to Logs/20210127T001126/Express0022.lzma.bak 2021-01-27T01:03:16.856Z,1611709396.856 [DataOverHttps](INFO): SBD MOMSN=68281 2021-01-27T01:03:24.192Z,1611709404.192 [BuoyancyServo](FAULT): Overload Error 2021-01-27T01:03:24.192Z,1611709404.192 [BuoyancyServo] Hardware Fault, FailCount= 3 2021-01-27T01:03:24.192Z,1611709404.192 [BuoyancyServo](ERROR): Hardware Fault 2021-01-27T01:03:24.233Z,1611709404.233 [CBIT](ERROR): Hardware Fault in component: BuoyancyServo 2021-01-27T01:03:25.887Z,1611709405.887 [DataOverHttps](INFO): Sending 61 bytes from file Logs/20210127T001126/Express0025.lzma 2021-01-27T01:03:26.190Z,1611709406.190 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2021-01-27T01:03:26.190Z,1611709406.190 [BuoyancyServo](INFO): Powering down 2021-01-27T01:03:26.890Z,1611709406.890 [DataOverHttps](INFO): Moved sent file to Logs/20210127T001126/Express0025.lzma.bak 2021-01-27T01:03:26.890Z,1611709406.890 [DataOverHttps](INFO): SBD MOMSN=68314 2021-01-27T01:03:27.046Z,1611709407.046 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2021-01-27T01:03:27.046Z,1611709407.046 [BuoyancyServo] No Fault, FailCount= 3 2021-01-27T01:03:27.401Z,1611709407.401 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2021-01-27T01:03:27.408Z,1611709407.408 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2021-01-27T01:03:28.593Z,1611709408.593 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Stopped 2021-01-27T01:03:28.593Z,1611709408.593 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Running Loop=1 2021-01-27T01:03:28.593Z,1611709408.593 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-01-27T01:03:34.227Z,1611709414.227 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6. 2021-01-27T01:03:34.229Z,1611709414.229 [BPC1](INFO): Received data from all battery sticks. 2021-01-27T01:03:42.294Z,1611709422.294 [NAL9602](INFO): Not Powering down - fast GPS 2021-01-27T01:03:44.829Z,1611709424.829 [BuoyancyServo](FAULT): Overload Error 2021-01-27T01:03:44.829Z,1611709424.829 [BuoyancyServo] Hardware Fault, FailCount= 4 2021-01-27T01:03:44.830Z,1611709424.830 [BuoyancyServo](ERROR): Hardware Fault 2021-01-27T01:03:44.887Z,1611709424.887 [CBIT](ERROR): Hardware Fault in component: BuoyancyServo 2021-01-27T01:03:46.833Z,1611709426.833 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2021-01-27T01:03:46.833Z,1611709426.833 [BuoyancyServo](INFO): Powering down 2021-01-27T01:03:47.632Z,1611709427.632 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2021-01-27T01:03:47.632Z,1611709427.632 [BuoyancyServo] No Fault, FailCount= 4 2021-01-27T01:03:48.012Z,1611709428.012 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2021-01-27T01:03:48.020Z,1611709428.020 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2021-01-27T01:04:04.640Z,1611709444.640 [BuoyancyServo](FAULT): Overload Error 2021-01-27T01:04:04.640Z,1611709444.640 [BuoyancyServo] Hardware Fault, FailCount= 5 2021-01-27T01:04:04.640Z,1611709444.640 [BuoyancyServo](ERROR): Hardware Fault 2021-01-27T01:04:04.681Z,1611709444.681 [CBIT](ERROR): Hardware Fault in component: BuoyancyServo 2021-01-27T01:04:06.555Z,1611709446.555 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2021-01-27T01:04:06.556Z,1611709446.556 [BuoyancyServo](INFO): Powering down 2021-01-27T01:04:06.977Z,1611709446.977 [BuoyancyServo](FAULT): LCB fault: Software Overcurrent. Current Limiter Activated. 2021-01-27T01:04:07.378Z,1611709447.378 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2021-01-27T01:04:07.378Z,1611709447.378 [BuoyancyServo] No Fault, FailCount= 5 2021-01-27T01:04:07.798Z,1611709447.798 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2021-01-27T01:04:07.799Z,1611709447.799 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2021-01-27T01:05:18.342Z,1611709518.342 [DataOverHttps](IMPORTANT): SBD MTMSN=20210127T010518 2021-01-27T01:05:22.360Z,1611709522.360 [DataOverHttps](INFO): Received command:sched asap "load Transport/transit.xml;set transit.MissionTimeout 30 minute;set transit.Latitude 41.547 degree;set transit.Longitude -70.7105 degree;set transit.Depth 7 meter;set transit.Speed 1.3 meter_per_second;set transit.MaxDepth 9 meter" 2s305 1 2 2021-01-27T01:05:22.368Z,1611709522.368 [CommandLine](IMPORTANT): got command schedule asap "load Transport/transit.xml;set transit.MissionTimeout 30 minute;set transit.Latitude 41.547 degree;set transit.Longitude -70.7105 degree;set transit.Depth 7 meter;set transit.Speed 1.3 meter_per_second;set transit.MaxDepth 9 meter" 2s305 1 2.000000 2021-01-27T01:05:22.368Z,1611709522.368 [CommandLine](IMPORTANT): Scheduling command #1 of 2 with id=2s305 2021-01-27T01:05:22.369Z,1611709522.369 [CommandLine](IMPORTANT): Scheduled #14 (#1 of 2 with id='2s305'): "load Transport/transit.xml;set transit.MissionTimeout 30 minute;set transit.Latitude 41.547 degree;set transit.Longitude -70.7105 degree;set transit.Depth 7 meter;set transit.Speed 1.3 meter_per_second;set transit.MaxDepth 9 meter" ASAP 2021-01-27T01:05:23.361Z,1611709523.361 [DataOverHttps](IMPORTANT): SBD MTMSN=20210127T010523 2021-01-27T01:05:27.379Z,1611709527.379 [DataOverHttps](INFO): Received command:sched asap "set transit.MinOffshore 500 meter;set transit.MinAltitude 3 meter;run" 2s305 2 2 2021-01-27T01:05:27.469Z,1611709527.469 [CommandLine](IMPORTANT): got command schedule asap "set transit.MinOffshore 500 meter;set transit.MinAltitude 3 meter;run" 2s305 2 2.000000 2021-01-27T01:05:27.469Z,1611709527.469 [CommandLine](IMPORTANT): Scheduling command #2 of 2 with id=2s305 2021-01-27T01:05:27.470Z,1611709527.470 [CommandLine](IMPORTANT): Scheduled #15 (#2 of 2 with id='2s305'): "set transit.MinOffshore 500 meter;set transit.MinAltitude 3 meter;run" ASAP 2021-01-27T01:05:27.564Z,1611709527.564 [CommandLine](IMPORTANT): got command load ./Missions/Transport/transit.xml 2021-01-27T01:05:27.565Z,1611709527.565 [MissionManager](INFO): Loading Mission: ./Missions/Transport/transit.xml 2021-01-27T01:05:27.630Z,1611709527.630 [MissionManager](INFO): DefineArg transit.MissionTimeout = 60.000000 min 2021-01-27T01:05:27.633Z,1611709527.633 [MissionManager](INFO): DefineArg transit.NeedCommsTime = 30.000000 min 2021-01-27T01:05:27.635Z,1611709527.635 [MissionManager](INFO): DefineArg transit.Latitude = nan arcdeg 2021-01-27T01:05:27.637Z,1611709527.637 [MissionManager](INFO): DefineArg transit.Longitude = nan arcdeg 2021-01-27T01:05:27.639Z,1611709527.639 [MissionManager](INFO): DefineArg transit.Northings = 0.000000 m 2021-01-27T01:05:27.642Z,1611709527.642 [MissionManager](INFO): DefineArg transit.Eastings = 0.000000 m 2021-01-27T01:05:27.644Z,1611709527.644 [MissionManager](INFO): DefineArg transit.Depth = 10.000000 m 2021-01-27T01:05:27.646Z,1611709527.646 [MissionManager](INFO): DefineArg transit.Speed = 1.000000 m/s 2021-01-27T01:05:27.648Z,1611709527.648 [MissionManager](INFO): DefineArg transit.MaxDepth = 20.000000 m 2021-01-27T01:05:27.650Z,1611709527.650 [MissionManager](INFO): DefineArg transit.MinOffshore = 1.000000 km 2021-01-27T01:05:27.653Z,1611709527.653 [MissionManager](INFO): DefineArg transit.MinAltitude = 7.000000 m 2021-01-27T01:05:27.655Z,1611709527.655 [MissionManager](INFO): DefineArg transit.MassHold = 1 bool 2021-01-27T01:05:27.657Z,1611709527.657 [MissionManager](INFO): DefineArg transit.BuoyancyHold = 1 bool 2021-01-27T01:05:27.657Z,1611709527.657 [MissionManager](INFO): Inserting Stack: Missions/Insert/NeedComms.xml 2021-01-27T01:05:27.823Z,1611709527.823 [MissionManager](INFO): DefineArg transit:NeedComms.DiveInterval = 3.000000 h 2021-01-27T01:05:27.835Z,1611709527.835 [MissionManager](INFO): DefineArg transit:NeedComms.WaitForPitchUp = 10.000000 min 2021-01-27T01:05:27.846Z,1611709527.846 [MissionManager](INFO): DefineArg transit:NeedComms.SurfacePitch = 20.000000 arcdeg 2021-01-27T01:05:27.852Z,1611709527.852 [MissionManager](INFO): DefineArg transit:NeedComms.SurfaceDepthRate = nan m/s 2021-01-27T01:05:27.854Z,1611709527.854 [MissionManager](INFO): DefineArg transit:NeedComms.SurfaceSpeed = 1.000000 m/s 2021-01-27T01:05:27.857Z,1611709527.857 [MissionManager](INFO): DefineArg transit:NeedComms.GPSTimeout = 7.000000 min 2021-01-27T01:05:27.859Z,1611709527.859 [MissionManager](INFO): DefineArg transit:NeedComms.CommsTimeout = 30.000000 min 2021-01-27T01:05:27.874Z,1611709527.874 [transit:NeedComms:B.GoToSurface](DEBUG): Construct GoToSurface. 2021-01-27T01:05:27.901Z,1611709527.901 [MissionManager](INFO): Inserting Stack: Missions/Insert/StandardEnvelopes.xml 2021-01-27T01:05:27.936Z,1611709527.936 [MissionManager](INFO): DefineArg transit:StandardEnvelopes.MinAltitude = 5.000000 m 2021-01-27T01:05:27.938Z,1611709527.938 [MissionManager](INFO): DefineArg transit:StandardEnvelopes.MaxDepth = 200.000000 m 2021-01-27T01:05:27.941Z,1611709527.941 [MissionManager](INFO): DefineArg transit:StandardEnvelopes.MinOffshore = 2000.000000 m 2021-01-27T01:05:27.942Z,1611709527.942 [transit:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Construct AltitudeEnvelope. 2021-01-27T01:05:27.960Z,1611709527.960 [transit:StandardEnvelopes:B.DepthEnvelope](DEBUG): Construct DepthEnvelope. 2021-01-27T01:05:27.970Z,1611709527.970 [transit:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Construct OffshoreEnvelope. 2021-01-27T01:05:28.009Z,1611709528.009 [transit:BuoyancyHold.Buoyancy](DEBUG): Construct Buoyancy. 2021-01-27T01:05:28.016Z,1611709528.016 [transit:MassHold.Pitch](DEBUG): Construct. 2021-01-27T01:05:28.026Z,1611709528.026 [transit:Transit:A.Pitch](DEBUG): Construct. 2021-01-27T01:05:28.031Z,1611709528.031 [transit:Transit:B.SetSpeed](DEBUG): Construct. 2021-01-27T01:05:28.043Z,1611709528.043 [transit:Transit:Wpt1.Waypoint](DEBUG): Construct Waypoint. 2021-01-27T01:05:28.070Z,1611709528.070 [MissionManager](DEBUG): Vehicle transits to desired waypoint and can be commanded to use/hold mass or buoyancy. Maximum duration of mission 60 How often to surface for commumications 30 Latitude of waypoint to seek. If set to NaN, uses latitude at mission initialization. NaN Longitude of waypoint to seek. If set to NaN, uses longitude at mission initialization. NaN Northward distance of the waypoint to seek. If combined with Latitude and/or Longitude, this is an offset from the specified Latitude and/or Longitude. 0 Eastward distance of the waypoint to seek. If combined with Latitude and/or Longitude, this is an offset from the specified Latitude and/or Longitude. 0 Depth of flat and level flight during the mission. 10 Speed of vehicle (relative to water) during the mission. 1 Maximum depth for the entire mission. 20 Minimum distance offshore for the entire mission. 1 Minimum height above the sea floor for the entire mission. 7 Set to True in order to hold mass at default position, False to allow mass to run on its own. Set to True in order to hold buoyancy at neutral position, False to allow buoyancy to run on its own. 1 2021-01-27T01:05:28.071Z,1611709528.071 [CommandLine](IMPORTANT): Loaded ./Missions/Transport/transit.xml 2021-01-27T01:05:42.125Z,1611709542.125 [CommandLine](IMPORTANT): got command set transit.MissionTimeout 30.000000 minute 2021-01-27T01:05:42.126Z,1611709542.126 [CommandLine](IMPORTANT): got command set transit.Latitude 41.547001 degree 2021-01-27T01:05:42.127Z,1611709542.127 [CommandLine](IMPORTANT): got command set transit.Longitude -70.710503 degree 2021-01-27T01:05:42.132Z,1611709542.132 [CommandLine](IMPORTANT): got command set transit.Depth 7.000000 meter 2021-01-27T01:05:42.133Z,1611709542.133 [CommandLine](IMPORTANT): got command set transit.Speed 1.300000 meter_per_second 2021-01-27T01:05:42.134Z,1611709542.134 [CommandLine](IMPORTANT): got command set transit.MaxDepth 9.000000 meter 2021-01-27T01:05:48.803Z,1611709548.803 [CommandLine](IMPORTANT): got command set transit.MinOffshore 500.000000 meter 2021-01-27T01:05:48.815Z,1611709548.815 [CommandLine](IMPORTANT): got command set transit.MinAltitude 3.000000 meter 2021-01-27T01:05:48.815Z,1611709548.815 [CommandLine](IMPORTANT): got command run 2021-01-27T01:05:48.817Z,1611709548.817 [CommandLine](IMPORTANT): Running 2021-01-27T01:05:48.998Z,1611709548.998 [DefaultWithUndock] Stopped 2021-01-27T01:05:48.999Z,1611709548.999 [DefaultWithUndock](DEBUG): Aggregate::uninitialize DefaultWithUndock 2021-01-27T01:05:48.999Z,1611709548.999 [DefaultWithUndock:SurfaceDefault] Stopped 2021-01-27T01:05:48.999Z,1611709548.999 [DefaultWithUndock:SurfaceDefault](DEBUG): Aggregate::uninitialize DefaultWithUndock:SurfaceDefault 2021-01-27T01:05:48.999Z,1611709548.999 [DefaultWithUndock:SurfaceDefault:B.GoToSurface] Stopped 2021-01-27T01:05:48.999Z,1611709548.999 [DefaultWithUndock:SurfaceDefault:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2021-01-27T01:05:48.999Z,1611709548.999 [DefaultWithUndock:SurfaceDefault:CheckIn] Stopped 2021-01-27T01:05:48.999Z,1611709548.999 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::uninitialize DefaultWithUndock:SurfaceDefault:CheckIn 2021-01-27T01:05:48.999Z,1611709548.999 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Stopped 2021-01-27T01:05:48.999Z,1611709548.999 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-01-27T01:05:49.008Z,1611709549.008 [MissionManager](IMPORTANT): Started mission transit 2021-01-27T01:05:49.008Z,1611709549.008 [transit] Running Loop=1 2021-01-27T01:05:49.008Z,1611709549.008 [transit](DEBUG): Aggregate::initialize transit 2021-01-27T01:05:49.008Z,1611709549.008 [transit:StandardEnvelopes] Running Loop=1 2021-01-27T01:05:49.008Z,1611709549.008 [transit:StandardEnvelopes](DEBUG): Aggregate::initialize transit:StandardEnvelopes 2021-01-27T01:05:49.008Z,1611709549.008 [transit:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1 2021-01-27T01:05:49.009Z,1611709549.009 [transit:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Initialize AltitudeEnvelopeComponent. 2021-01-27T01:05:49.009Z,1611709549.009 [transit:StandardEnvelopes:B.DepthEnvelope] Running Loop=1 2021-01-27T01:05:49.009Z,1611709549.009 [transit:StandardEnvelopes:B.DepthEnvelope](DEBUG): Initialize DepthEnvelopeComponent. 2021-01-27T01:05:49.009Z,1611709549.009 [transit:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1 2021-01-27T01:05:49.009Z,1611709549.009 [transit:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Initialize OffshoreEnvelopeComponent. 2021-01-27T01:05:49.009Z,1611709549.009 [transit:BuoyancyHold.Buoyancy] Running Loop=1 2021-01-27T01:05:49.009Z,1611709549.009 [transit:BuoyancyHold.Buoyancy](DEBUG): Initialize Buoyancy Component. 2021-01-27T01:05:49.009Z,1611709549.009 [transit:MassHold.Pitch] Running Loop=1 2021-01-27T01:05:49.009Z,1611709549.009 [transit:MassHold.Pitch](DEBUG): Initialize. 2021-01-27T01:05:49.010Z,1611709549.010 [transit:B] Running Loop=1 2021-01-27T01:05:49.010Z,1611709549.010 [transit:MassHold.Pitch] Running Loop=1 2021-01-27T01:05:49.010Z,1611709549.010 [transit:BuoyancyHold.Buoyancy] Running Loop=1 2021-01-27T01:05:49.011Z,1611709549.011 [transit:StandardEnvelopes] Running Loop=1 2021-01-27T01:05:49.011Z,1611709549.011 [transit:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1 2021-01-27T01:05:49.011Z,1611709549.011 [transit:StandardEnvelopes:B.DepthEnvelope] Running Loop=1 2021-01-27T01:05:49.011Z,1611709549.011 [transit:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1 2021-01-27T01:05:49.020Z,1611709549.020 [transit:B] Stopped 2021-01-27T01:05:49.021Z,1611709549.021 [transit:C] Running Loop=1 2021-01-27T01:05:49.318Z,1611709549.318 [transit:C] Stopped 2021-01-27T01:05:49.318Z,1611709549.318 [transit:E] Running Loop=1 2021-01-27T01:05:49.784Z,1611709549.784 [transit:E] Stopped 2021-01-27T01:05:49.784Z,1611709549.784 [transit:F] Running Loop=1 2021-01-27T01:05:50.151Z,1611709550.151 [transit:F] Stopped 2021-01-27T01:05:50.151Z,1611709550.151 [transit:G] Running Loop=1 2021-01-27T01:05:50.518Z,1611709550.518 [transit:G] Stopped 2021-01-27T01:05:50.518Z,1611709550.518 [transit:Transit] Running Loop=1 2021-01-27T01:05:50.518Z,1611709550.518 [transit:Transit](DEBUG): Aggregate::initialize transit:Transit 2021-01-27T01:05:50.519Z,1611709550.519 [transit:Transit:A.Pitch] Running Loop=1 2021-01-27T01:05:50.519Z,1611709550.519 [transit:Transit:A.Pitch](DEBUG): Initialize. 2021-01-27T01:05:50.519Z,1611709550.519 [transit:Transit:B.SetSpeed] Running Loop=1 2021-01-27T01:05:50.519Z,1611709550.519 [transit:Transit:B.SetSpeed](DEBUG): Initialize. 2021-01-27T01:05:50.519Z,1611709550.519 [transit:Transit:Wpt1.Waypoint] Running Loop=1 2021-01-27T01:05:50.519Z,1611709550.519 [transit:Transit:Wpt1.Waypoint](DEBUG): Initialize WaypointComponent. 2021-01-27T01:05:50.965Z,1611709550.965 [transit:Transit:B.SetSpeed] Running Loop=1 2021-01-27T01:05:50.966Z,1611709550.966 [transit:Transit:A.Pitch] Running Loop=1 2021-01-27T01:06:01.564Z,1611709561.564 [ThrusterServo](FAULT): Overload Error 2021-01-27T01:06:01.564Z,1611709561.564 [ThrusterServo] Hardware Fault, FailCount= 1 2021-01-27T01:06:01.564Z,1611709561.564 [ThrusterServo](ERROR): Hardware Fault 2021-01-27T01:06:01.568Z,1611709561.568 [CBIT](ERROR): Hardware Fault in component: ThrusterServo 2021-01-27T01:06:01.969Z,1611709561.969 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2021-01-27T01:06:01.969Z,1611709561.969 [ThrusterServo](INFO): Powering down 2021-01-27T01:06:02.813Z,1611709562.813 [ThrusterServo](DEBUG): Initializing EZServoServo. 2021-01-27T01:06:02.944Z,1611709562.944 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2021-01-27T01:06:02.956Z,1611709562.956 [CBIT](INFO): Clearing failed state for component ThrusterServo 2021-01-27T01:06:02.956Z,1611709562.956 [ThrusterServo] No Fault, FailCount= 1 2021-01-27T01:06:05.064Z,1611709565.064 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude 2021-01-27T01:06:14.789Z,1611709574.789 [RDI_Pathfinder](ERROR): only read 1 of 4 data items 2021-01-27T01:06:15.685Z,1611709575.685 [ThrusterServo](FAULT): Overload Error 2021-01-27T01:06:15.685Z,1611709575.685 [ThrusterServo] Hardware Fault, FailCount= 2 2021-01-27T01:06:15.685Z,1611709575.685 [ThrusterServo](ERROR): Hardware Fault 2021-01-27T01:06:15.702Z,1611709575.702 [CBIT](ERROR): Hardware Fault in component: ThrusterServo 2021-01-27T01:06:16.169Z,1611709576.169 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2021-01-27T01:06:16.169Z,1611709576.169 [ThrusterServo](INFO): Powering down 2021-01-27T01:06:16.860Z,1611709576.860 [ThrusterServo](DEBUG): Initializing EZServoServo. 2021-01-27T01:06:16.981Z,1611709576.981 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2021-01-27T01:06:16.985Z,1611709576.985 [CBIT](INFO): Clearing failed state for component ThrusterServo 2021-01-27T01:06:16.985Z,1611709576.985 [ThrusterServo] No Fault, FailCount= 2 2021-01-27T01:06:19.999Z,1611709579.999 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2021-01-27T01:06:24.862Z,1611709584.862 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2021-01-27T01:06:25.444Z,1611709585.444 [ThrusterServo](FAULT): Overload Error 2021-01-27T01:06:25.444Z,1611709585.444 [ThrusterServo] Hardware Fault, FailCount= 3 2021-01-27T01:06:25.444Z,1611709585.444 [ThrusterServo](ERROR): Hardware Fault 2021-01-27T01:06:25.448Z,1611709585.448 [CBIT](ERROR): Hardware Fault in component: ThrusterServo 2021-01-27T01:06:25.762Z,1611709585.762 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2021-01-27T01:06:25.762Z,1611709585.762 [ThrusterServo](INFO): Powering down 2021-01-27T01:06:26.513Z,1611709586.513 [ThrusterServo](DEBUG): Initializing EZServoServo. 2021-01-27T01:06:26.633Z,1611709586.633 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2021-01-27T01:06:26.637Z,1611709586.637 [CBIT](INFO): Clearing failed state for component ThrusterServo 2021-01-27T01:06:26.637Z,1611709586.637 [ThrusterServo] No Fault, FailCount= 3 2021-01-27T01:06:29.740Z,1611709589.740 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2021-01-27T01:06:34.949Z,1611709594.949 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude 2021-01-27T01:06:35.481Z,1611709595.481 [ThrusterServo](FAULT): Overload Error 2021-01-27T01:06:35.481Z,1611709595.481 [ThrusterServo] Hardware Fault, FailCount= 4 2021-01-27T01:06:35.482Z,1611709595.482 [ThrusterServo](ERROR): Hardware Fault 2021-01-27T01:06:35.487Z,1611709595.487 [CBIT](ERROR): Hardware Fault in component: ThrusterServo 2021-01-27T01:06:35.925Z,1611709595.925 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2021-01-27T01:06:35.925Z,1611709595.925 [ThrusterServo](INFO): Powering down 2021-01-27T01:06:36.697Z,1611709596.697 [ThrusterServo](DEBUG): Initializing EZServoServo. 2021-01-27T01:06:36.836Z,1611709596.836 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2021-01-27T01:06:36.848Z,1611709596.848 [CBIT](INFO): Clearing failed state for component ThrusterServo 2021-01-27T01:06:36.848Z,1611709596.848 [ThrusterServo] No Fault, FailCount= 4 2021-01-27T01:06:45.072Z,1611709605.072 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2021-01-27T01:06:45.220Z,1611709605.220 [ThrusterServo](FAULT): Overload Error 2021-01-27T01:06:45.220Z,1611709605.220 [ThrusterServo] Hardware Fault, FailCount= 5 2021-01-27T01:06:45.220Z,1611709605.220 [ThrusterServo](ERROR): Hardware Fault 2021-01-27T01:06:45.224Z,1611709605.224 [CBIT](ERROR): Hardware Fault in component: ThrusterServo 2021-01-27T01:06:45.224Z,1611709605.224 [CBIT](CRITICAL): Hardware Fault in component: ThrusterServo 2021-01-27T01:06:45.542Z,1611709605.542 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2021-01-27T01:06:45.542Z,1611709605.542 [ThrusterServo](INFO): Powering down 2021-01-27T01:06:45.544Z,1611709605.544 [CBIT](INFO): Critical error at 20210127T010645 2021-01-27T01:06:45.544Z,1611709605.544 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2021-01-27T01:06:45.922Z,1611709605.922 [MissionManager](INFO): MissionManager is completed. 2021-01-27T01:06:45.922Z,1611709605.922 [MissionManager](INFO): Uninitializing Mission transit 2021-01-27T01:06:45.922Z,1611709605.922 [transit] Stopped 2021-01-27T01:06:45.922Z,1611709605.922 [transit](DEBUG): Aggregate::uninitialize transit 2021-01-27T01:06:45.923Z,1611709605.923 [transit:StandardEnvelopes] Stopped 2021-01-27T01:06:45.923Z,1611709605.923 [transit:StandardEnvelopes](DEBUG): Aggregate::uninitialize transit:StandardEnvelopes 2021-01-27T01:06:45.923Z,1611709605.923 [transit:StandardEnvelopes:A.AltitudeEnvelope] Stopped 2021-01-27T01:06:45.923Z,1611709605.923 [transit:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Uninitialize AltitudeEnvelopeComponent. 2021-01-27T01:06:45.923Z,1611709605.923 [transit:StandardEnvelopes:B.DepthEnvelope] Stopped 2021-01-27T01:06:45.923Z,1611709605.923 [transit:StandardEnvelopes:B.DepthEnvelope](DEBUG): Uninitialize. 2021-01-27T01:06:45.923Z,1611709605.923 [transit:StandardEnvelopes:C.OffshoreEnvelope] Stopped 2021-01-27T01:06:45.923Z,1611709605.923 [transit:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Uninitialize OffshoreEnvelopeComponent. 2021-01-27T01:06:45.923Z,1611709605.923 [transit:BuoyancyHold.Buoyancy] Stopped 2021-01-27T01:06:45.923Z,1611709605.923 [transit:BuoyancyHold.Buoyancy](DEBUG): Uninitialize Buoyancy Component. 2021-01-27T01:06:45.923Z,1611709605.923 [transit:MassHold.Pitch] Stopped 2021-01-27T01:06:45.923Z,1611709605.923 [transit:Transit] Stopped 2021-01-27T01:06:45.924Z,1611709605.924 [transit:Transit](DEBUG): Aggregate::uninitialize transit:Transit 2021-01-27T01:06:45.924Z,1611709605.924 [transit:Transit:A.Pitch] Stopped 2021-01-27T01:06:45.924Z,1611709605.924 [transit:Transit:B.SetSpeed] Stopped 2021-01-27T01:06:45.924Z,1611709605.924 [transit:Transit:B.SetSpeed](DEBUG): Uninitialize. 2021-01-27T01:06:45.924Z,1611709605.924 [transit:Transit:Wpt1.Waypoint] Stopped 2021-01-27T01:06:45.924Z,1611709605.924 [transit:Transit:Wpt1.Waypoint](DEBUG): Uninitialize WaypointComponent. 2021-01-27T01:06:46.284Z,1611709606.284 [MissionManager](IMPORTANT): Started mission DefaultWithUndock 2021-01-27T01:06:46.284Z,1611709606.284 [DefaultWithUndock] Running Loop=1 2021-01-27T01:06:46.284Z,1611709606.284 [DefaultWithUndock](DEBUG): Aggregate::initialize DefaultWithUndock 2021-01-27T01:06:46.285Z,1611709606.285 [DefaultWithUndock:A.Wait] Running Loop=1 2021-01-27T01:06:46.285Z,1611709606.285 [DefaultWithUndock:A.Wait](DEBUG): Initialize Wait Component. 2021-01-27T01:06:50.739Z,1611709610.739 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-01-27T01:06:59.240Z,1611709619.240 [BuoyancyServo](FAULT): Overload Error 2021-01-27T01:06:59.240Z,1611709619.240 [BuoyancyServo] Hardware Fault, FailCount= 6 2021-01-27T01:06:59.240Z,1611709619.240 [BuoyancyServo](ERROR): Hardware Fault 2021-01-27T01:06:59.284Z,1611709619.284 [CBIT](ERROR): Hardware Fault in component: BuoyancyServo 2021-01-27T01:07:01.245Z,1611709621.245 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2021-01-27T01:07:01.245Z,1611709621.245 [BuoyancyServo](INFO): Powering down 2021-01-27T01:07:02.048Z,1611709622.048 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2021-01-27T01:07:02.048Z,1611709622.048 [BuoyancyServo] No Fault, FailCount= 6 2021-01-27T01:07:02.438Z,1611709622.438 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2021-01-27T01:07:02.438Z,1611709622.438 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2021-01-27T01:07:15.404Z,1611709635.404 [CBIT](INFO): Clearing failed state for component ThrusterServo 2021-01-27T01:07:15.404Z,1611709635.404 [ThrusterServo] No Fault, FailCount= 5 2021-01-27T01:07:15.823Z,1611709635.823 [ThrusterServo](DEBUG): Initializing EZServoServo. 2021-01-27T01:07:15.825Z,1611709635.825 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2021-01-27T01:07:16.580Z,1611709636.580 [DefaultWithUndock:A.Wait](INFO): Done Waiting. 2021-01-27T01:07:16.581Z,1611709636.581 [DefaultWithUndock:A.Wait] Stopped 2021-01-27T01:07:16.581Z,1611709636.581 [DefaultWithUndock:A.Wait](DEBUG): Uninitialize Wait Component. 2021-01-27T01:07:16.581Z,1611709636.581 [DefaultWithUndock:LeaveDock] Running Loop=1 2021-01-27T01:07:16.581Z,1611709636.581 [DefaultWithUndock:LeaveDock](DEBUG): Aggregate::initialize DefaultWithUndock:LeaveDock 2021-01-27T01:07:16.581Z,1611709636.581 [DefaultWithUndock:LeaveDock:A.] Running Loop=1 2021-01-27T01:07:16.581Z,1611709636.581 [DefaultWithUndock:LeaveDock:A.](INFO): Initializing TrackAcousticContact. 2021-01-27T01:07:16.581Z,1611709636.581 [DefaultWithUndock:LeaveDock:B.Undock] Running Loop=1 2021-01-27T01:07:16.581Z,1611709636.581 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Initialize. 2021-01-27T01:07:16.581Z,1611709636.581 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Initializing internal variables to default values. 2021-01-27T01:07:19.433Z,1611709639.433 [DefaultWithUndock:LeaveDock:A.](INFO): *** querying acoustic contact *** 2021-01-27T01:07:20.251Z,1611709640.251 [Micromodem](INFO): Nmea out: $CCPGT,1,14500,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*76 2021-01-27T01:07:20.330Z,1611709640.330 [DefaultWithUndock:LeaveDock:B.Undock](INFO): Detaching from dock. 2021-01-27T01:07:20.624Z,1611709640.624 [Micromodem](INFO): Nmea in: $SNPGT,1,14500,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*6B 2021-01-27T01:07:20.691Z,1611709640.691 [DefaultWithUndock:LeaveDock:B.Undock](INFO): Detected possible detachment. Starting timer. 2021-01-27T01:07:21.456Z,1611709641.456 [Micromodem](INFO): Nmea in: $SNTTA,,,,,010721.76*5A 2021-01-27T01:07:22.257Z,1611709642.257 [DefaultWithUndock:LeaveDock:A.](INFO): *** querying acoustic contact *** 2021-01-27T01:07:23.857Z,1611709643.857 [DUSBL_Hydroid](ERROR): No response from remote modem. 2021-01-27T01:07:25.103Z,1611709645.103 [DefaultWithUndock:LeaveDock:A.](INFO): *** querying acoustic contact *** 2021-01-27T01:07:25.898Z,1611709645.898 [Micromodem](INFO): Nmea out: $CCPGT,1,14500,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*76 2021-01-27T01:07:26.284Z,1611709646.284 [Micromodem](INFO): Nmea in: $SNPGT,1,14500,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*6B 2021-01-27T01:07:27.102Z,1611709647.102 [Micromodem](INFO): Nmea in: $SNTTA,,,,,010727.40*59 2021-01-27T01:07:28.109Z,1611709648.109 [DefaultWithUndock:LeaveDock:A.](INFO): *** querying acoustic contact *** 2021-01-27T01:07:29.509Z,1611709649.509 [DUSBL_Hydroid](ERROR): No response from remote modem. 2021-01-27T01:07:30.779Z,1611709650.779 [DefaultWithUndock:LeaveDock:A.](INFO): *** querying acoustic contact *** 2021-01-27T01:07:31.551Z,1611709651.551 [Micromodem](INFO): Nmea out: $CCPGT,1,14500,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*76 2021-01-27T01:07:31.940Z,1611709651.940 [Micromodem](INFO): Nmea in: $SNPGT,1,14500,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*6B 2021-01-27T01:07:32.786Z,1611709652.786 [Micromodem](INFO): Nmea in: $SNTTA,,,,,010733.06*5E 2021-01-27T01:07:33.153Z,1611709653.153 [DUSBL_Hydroid](ERROR): unknown deviceResponse_: !U1,R,2F2,0001,E4 5,189,80,80,AC,FF 2021-01-27T01:07:33.607Z,1611709653.607 [DefaultWithUndock:LeaveDock:A.](INFO): *** querying acoustic contact *** 2021-01-27T01:07:36.397Z,1611709656.397 [DefaultWithUndock:LeaveDock:A.](INFO): *** querying acoustic contact *** 2021-01-27T01:07:38.917Z,1611709658.917 [DefaultWithUndock:LeaveDock:A.](INFO): *** querying acoustic contact *** 2021-01-27T01:07:39.627Z,1611709659.627 [Micromodem](INFO): Nmea out: $CCPGT,1,14500,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*76 2021-01-27T01:07:40.036Z,1611709660.036 [Micromodem](INFO): Nmea in: $SNPGT,1,14500,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*6B 2021-01-27T01:07:40.874Z,1611709660.874 [Micromodem](INFO): Nmea in: $SNTTA,,,,,010741.13*5F 2021-01-27T01:07:40.947Z,1611709660.947 [DefaultWithUndock:LeaveDock:B.Undock](INFO): Detached at range: 820.08 m. Transitioning DDM to standby. 2021-01-27T01:07:41.230Z,1611709661.230 [DUSBL_Hydroid](ERROR): unknown deviceResponse_: !U1,R,385,000,0E4 5,189,80,80,AC,FF 2021-01-27T01:07:41.672Z,1611709661.672 [DefaultWithUndock:LeaveDock:A.](INFO): *** querying acoustic contact *** 2021-01-27T01:07:43.735Z,1611709663.735 [DefaultWithUndock:LeaveDock:B.Undock](INFO): DDM at standby. 2021-01-27T01:07:44.123Z,1611709664.123 [DefaultWithUndock:LeaveDock:B.Undock](IMPORTANT): Undocking sequence complete. 2021-01-27T01:07:44.123Z,1611709664.123 [DefaultWithUndock:LeaveDock:B.Undock] Stopped 2021-01-27T01:07:44.123Z,1611709664.123 [DefaultWithUndock:LeaveDock](INFO): Completed DefaultWithUndock:LeaveDock 2021-01-27T01:07:44.123Z,1611709664.123 [DefaultWithUndock:LeaveDock] Stopped 2021-01-27T01:07:44.124Z,1611709664.124 [DefaultWithUndock:LeaveDock](DEBUG): Aggregate::uninitialize DefaultWithUndock:LeaveDock 2021-01-27T01:07:44.124Z,1611709664.124 [DefaultWithUndock:LeaveDock:A.] Stopped 2021-01-27T01:07:44.124Z,1611709664.124 [DefaultWithUndock:SurfaceDefault] Running Loop=1 2021-01-27T01:07:44.124Z,1611709664.124 [DefaultWithUndock:SurfaceDefault](DEBUG): Aggregate::initialize DefaultWithUndock:SurfaceDefault 2021-01-27T01:07:44.124Z,1611709664.124 [DefaultWithUndock:SurfaceDefault:HoldLatchOpen] Running Loop=1 2021-01-27T01:07:44.124Z,1611709664.124 [DefaultWithUndock:SurfaceDefault:HoldLatchOpen](DEBUG): Aggregate::initialize DefaultWithUndock:SurfaceDefault:HoldLatchOpen 2021-01-27T01:07:44.124Z,1611709664.124 [DefaultWithUndock:SurfaceDefault:HoldLatchOpen:A] Running Loop=1 2021-01-27T01:07:44.124Z,1611709664.124 [DefaultWithUndock:SurfaceDefault:HoldLatchOpen:B] Running Loop=1 2021-01-27T01:07:44.124Z,1611709664.124 [DefaultWithUndock:SurfaceDefault:B.GoToSurface] Running Loop=1 2021-01-27T01:07:44.125Z,1611709664.125 [DefaultWithUndock:SurfaceDefault:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2021-01-27T01:07:44.125Z,1611709664.125 [DefaultWithUndock:SurfaceDefault:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2021-01-27T01:07:44.125Z,1611709664.125 [DefaultWithUndock:SurfaceDefault:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2021-01-27T01:07:44.125Z,1611709664.125 [DefaultWithUndock:SurfaceDefault:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2021-01-27T01:07:44.126Z,1611709664.126 [DefaultWithUndock:SurfaceDefault:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2021-01-27T01:07:44.126Z,1611709664.126 [DefaultWithUndock:SurfaceDefault:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2021-01-27T01:07:44.473Z,1611709664.473 [DefaultWithUndock:SurfaceDefault:CheckIn] Running Loop=1 2021-01-27T01:07:44.474Z,1611709664.474 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::initialize DefaultWithUndock:SurfaceDefault:CheckIn 2021-01-27T01:07:44.474Z,1611709664.474 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Running Loop=1 2021-01-27T01:07:44.474Z,1611709664.474 [DefaultWithUndock:SurfaceDefault:HoldLatchOpen] Stopped 2021-01-27T01:07:44.474Z,1611709664.474 [DefaultWithUndock:SurfaceDefault:HoldLatchOpen](DEBUG): Aggregate::uninitialize DefaultWithUndock:SurfaceDefault:HoldLatchOpen 2021-01-27T01:07:44.474Z,1611709664.474 [DefaultWithUndock:SurfaceDefault:HoldLatchOpen:A] Stopped 2021-01-27T01:07:44.474Z,1611709664.474 [DefaultWithUndock:SurfaceDefault:HoldLatchOpen:B] Stopped 2021-01-27T01:07:46.460Z,1611709666.460 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,010746.00,A,4133.30039,N,07042.09473,W,0.583,276.96,270121,,,A*79 2021-01-27T01:07:46.462Z,1611709666.462 [NAL9602](INFO): GPS fix at 20210127T010746: (41.555006, -70.701579) 2021-01-27T01:07:46.483Z,1611709666.483 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Stopped 2021-01-27T01:07:46.483Z,1611709666.483 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Running Loop=1 2021-01-27T01:07:48.124Z,1611709668.124 [DataOverHttps](INFO): Sending 250 bytes from file Logs/20210127T001126/Courier0027.lzma 2021-01-27T01:07:49.118Z,1611709669.118 [DataOverHttps](INFO): Moved sent file to Logs/20210127T001126/Courier0027.lzma.bak 2021-01-27T01:07:49.118Z,1611709669.118 [DataOverHttps](INFO): SBD MOMSN=68319 2021-01-27T01:07:57.056Z,1611709677.056 [BuoyancyServo](FAULT): Overload Error 2021-01-27T01:07:57.056Z,1611709677.056 [BuoyancyServo] Hardware Fault, FailCount= 7 2021-01-27T01:07:57.056Z,1611709677.056 [BuoyancyServo](ERROR): Hardware Fault 2021-01-27T01:07:57.124Z,1611709677.124 [CBIT](ERROR): Hardware Fault in component: BuoyancyServo 2021-01-27T01:07:58.157Z,1611709678.157 [DataOverHttps](INFO): Sending 725 bytes from file Logs/20210127T001126/Express0028.lzma 2021-01-27T01:07:59.027Z,1611709679.027 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2021-01-27T01:07:59.027Z,1611709679.027 [BuoyancyServo](INFO): Powering down 2021-01-27T01:07:59.158Z,1611709679.158 [DataOverHttps](INFO): Moved sent file to Logs/20210127T001126/Express0028.lzma.bak 2021-01-27T01:07:59.158Z,1611709679.158 [DataOverHttps](INFO): SBD MOMSN=68323 2021-01-27T01:07:59.430Z,1611709679.430 [BuoyancyServo](FAULT): LCB fault: Current Limiter Activated. 2021-01-27T01:07:59.892Z,1611709679.892 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2021-01-27T01:07:59.892Z,1611709679.892 [BuoyancyServo] No Fault, FailCount= 7 2021-01-27T01:08:00.270Z,1611709680.270 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2021-01-27T01:08:00.276Z,1611709680.276 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2021-01-27T01:08:00.640Z,1611709680.640 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Stopped 2021-01-27T01:08:00.640Z,1611709680.640 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Running Loop=1 2021-01-27T01:08:00.640Z,1611709680.640 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-01-27T01:08:10.740Z,1611709690.740 [NAL9602](INFO): SBD MO Status=2, MOMSN=13072, MT Status=2, MTMSN=0 2021-01-27T01:08:10.740Z,1611709690.740 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-01-27T01:08:20.900Z,1611709700.900 [BuoyancyServo](FAULT): Overload Error 2021-01-27T01:08:20.900Z,1611709700.900 [BuoyancyServo] Hardware Fault, FailCount= 8 2021-01-27T01:08:20.900Z,1611709700.900 [BuoyancyServo](ERROR): Hardware Fault 2021-01-27T01:08:20.941Z,1611709700.941 [CBIT](ERROR): Hardware Fault in component: BuoyancyServo 2021-01-27T01:08:22.914Z,1611709702.914 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2021-01-27T01:08:22.914Z,1611709702.914 [BuoyancyServo](INFO): Powering down 2021-01-27T01:08:23.697Z,1611709703.697 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2021-01-27T01:08:23.698Z,1611709703.698 [BuoyancyServo] No Fault, FailCount= 8 2021-01-27T01:08:24.116Z,1611709704.116 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2021-01-27T01:08:24.124Z,1611709704.124 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2021-01-27T01:08:33.759Z,1611709713.759 [NAL9602](INFO): SBD MO Status=0, MOMSN=13072, MT Status=0, MTMSN=0 2021-01-27T01:08:33.759Z,1611709713.759 [NAL9602](INFO): No messages in MT queue 2021-01-27T01:08:33.790Z,1611709713.790 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-01-27T01:08:40.322Z,1611709720.322 [DataOverHttps](IMPORTANT): SBD MTMSN=20210127T010840 2021-01-27T01:08:44.340Z,1611709724.340 [DataOverHttps](INFO): Received command:sched asap "load Transport/transit.xml;set transit.MissionTimeout 30 minute;set transit.Latitude 41.547 degree;set transit.Longitude -70.7105 degree;set transit.Depth 7 meter;set transit.Speed 1.25 meter_per_second;set transit.MaxDepth 9 meter" 2s367 1 2 2021-01-27T01:08:44.393Z,1611709724.393 [CommandLine](IMPORTANT): got command schedule asap "load Transport/transit.xml;set transit.MissionTimeout 30 minute;set transit.Latitude 41.547 degree;set transit.Longitude -70.7105 degree;set transit.Depth 7 meter;set transit.Speed 1.25 meter_per_second;set transit.MaxDepth 9 meter" 2s367 1 2.000000 2021-01-27T01:08:44.393Z,1611709724.393 [CommandLine](IMPORTANT): Scheduling command #1 of 2 with id=2s367 2021-01-27T01:08:44.394Z,1611709724.394 [CommandLine](IMPORTANT): Scheduled #16 (#1 of 2 with id='2s367'): "load Transport/transit.xml;set transit.MissionTimeout 30 minute;set transit.Latitude 41.547 degree;set transit.Longitude -70.7105 degree;set transit.Depth 7 meter;set transit.Speed 1.25 meter_per_second;set transit.MaxDepth 9 meter" ASAP 2021-01-27T01:08:45.341Z,1611709725.341 [DataOverHttps](IMPORTANT): SBD MTMSN=20210127T010845 2021-01-27T01:08:45.525Z,1611709725.525 [BuoyancyServo](FAULT): Overload Error 2021-01-27T01:08:45.525Z,1611709725.525 [BuoyancyServo] Hardware Fault, FailCount= 9 2021-01-27T01:08:45.525Z,1611709725.525 [BuoyancyServo](ERROR): Hardware Fault 2021-01-27T01:08:45.569Z,1611709725.569 [CBIT](ERROR): Hardware Fault in component: BuoyancyServo 2021-01-27T01:08:47.507Z,1611709727.507 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2021-01-27T01:08:47.508Z,1611709727.508 [BuoyancyServo](INFO): Powering down 2021-01-27T01:08:47.986Z,1611709727.986 [BuoyancyServo](FAULT): LCB fault: Software Overcurrent. Current Limiter Activated. 2021-01-27T01:08:48.309Z,1611709728.309 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2021-01-27T01:08:48.309Z,1611709728.309 [BuoyancyServo] No Fault, FailCount= 9 2021-01-27T01:08:48.796Z,1611709728.796 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2021-01-27T01:08:48.804Z,1611709728.804 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2021-01-27T01:08:49.360Z,1611709729.360 [DataOverHttps](INFO): Received command:sched asap "set transit.MinOffshore 500 meter;set transit.MinAltitude 3 meter;run" 2s367 2 2 2021-01-27T01:08:49.397Z,1611709729.397 [CommandLine](IMPORTANT): got command schedule asap "set transit.MinOffshore 500 meter;set transit.MinAltitude 3 meter;run" 2s367 2 2.000000 2021-01-27T01:08:49.397Z,1611709729.397 [CommandLine](IMPORTANT): Scheduling command #2 of 2 with id=2s367 2021-01-27T01:08:49.398Z,1611709729.398 [CommandLine](IMPORTANT): Scheduled #17 (#2 of 2 with id='2s367'): "set transit.MinOffshore 500 meter;set transit.MinAltitude 3 meter;run" ASAP 2021-01-27T01:08:49.475Z,1611709729.475 [CommandLine](IMPORTANT): got command load ./Missions/Transport/transit.xml 2021-01-27T01:08:49.476Z,1611709729.476 [MissionManager](INFO): Loading Mission: ./Missions/Transport/transit.xml 2021-01-27T01:08:49.594Z,1611709729.594 [MissionManager](INFO): DefineArg transit.MissionTimeout = 60.000000 min 2021-01-27T01:08:49.597Z,1611709729.597 [MissionManager](INFO): DefineArg transit.NeedCommsTime = 30.000000 min 2021-01-27T01:08:49.599Z,1611709729.599 [MissionManager](INFO): DefineArg transit.Latitude = nan arcdeg 2021-01-27T01:08:49.601Z,1611709729.601 [MissionManager](INFO): DefineArg transit.Longitude = nan arcdeg 2021-01-27T01:08:49.603Z,1611709729.603 [MissionManager](INFO): DefineArg transit.Northings = 0.000000 m 2021-01-27T01:08:49.605Z,1611709729.605 [MissionManager](INFO): DefineArg transit.Eastings = 0.000000 m 2021-01-27T01:08:49.607Z,1611709729.607 [MissionManager](INFO): DefineArg transit.Depth = 10.000000 m 2021-01-27T01:08:49.610Z,1611709729.610 [MissionManager](INFO): DefineArg transit.Speed = 1.000000 m/s 2021-01-27T01:08:49.612Z,1611709729.612 [MissionManager](INFO): DefineArg transit.MaxDepth = 20.000000 m 2021-01-27T01:08:49.614Z,1611709729.614 [MissionManager](INFO): DefineArg transit.MinOffshore = 1.000000 km 2021-01-27T01:08:49.616Z,1611709729.616 [MissionManager](INFO): DefineArg transit.MinAltitude = 7.000000 m 2021-01-27T01:08:49.618Z,1611709729.618 [MissionManager](INFO): DefineArg transit.MassHold = 1 bool 2021-01-27T01:08:49.620Z,1611709729.620 [MissionManager](INFO): DefineArg transit.BuoyancyHold = 1 bool 2021-01-27T01:08:49.621Z,1611709729.621 [MissionManager](INFO): Inserting Stack: Missions/Insert/NeedComms.xml 2021-01-27T01:08:49.741Z,1611709729.741 [MissionManager](INFO): DefineArg transit:NeedComms.DiveInterval = 3.000000 h 2021-01-27T01:08:49.743Z,1611709729.743 [MissionManager](INFO): DefineArg transit:NeedComms.WaitForPitchUp = 10.000000 min 2021-01-27T01:08:49.750Z,1611709729.750 [MissionManager](INFO): DefineArg transit:NeedComms.SurfacePitch = 20.000000 arcdeg 2021-01-27T01:08:49.756Z,1611709729.756 [MissionManager](INFO): DefineArg transit:NeedComms.SurfaceDepthRate = nan m/s 2021-01-27T01:08:49.758Z,1611709729.758 [MissionManager](INFO): DefineArg transit:NeedComms.SurfaceSpeed = 1.000000 m/s 2021-01-27T01:08:49.761Z,1611709729.761 [MissionManager](INFO): DefineArg transit:NeedComms.GPSTimeout = 7.000000 min 2021-01-27T01:08:49.763Z,1611709729.763 [MissionManager](INFO): DefineArg transit:NeedComms.CommsTimeout = 30.000000 min 2021-01-27T01:08:49.783Z,1611709729.783 [transit:NeedComms:B.GoToSurface](DEBUG): Construct GoToSurface. 2021-01-27T01:08:49.847Z,1611709729.847 [MissionManager](INFO): Inserting Stack: Missions/Insert/StandardEnvelopes.xml 2021-01-27T01:08:49.959Z,1611709729.959 [MissionManager](INFO): DefineArg transit:StandardEnvelopes.MinAltitude = 5.000000 m 2021-01-27T01:08:49.973Z,1611709729.973 [MissionManager](INFO): DefineArg transit:StandardEnvelopes.MaxDepth = 200.000000 m 2021-01-27T01:08:49.975Z,1611709729.975 [MissionManager](INFO): DefineArg transit:StandardEnvelopes.MinOffshore = 2000.000000 m 2021-01-27T01:08:49.980Z,1611709729.980 [transit:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Construct AltitudeEnvelope. 2021-01-27T01:08:50.012Z,1611709730.012 [transit:StandardEnvelopes:B.DepthEnvelope](DEBUG): Construct DepthEnvelope. 2021-01-27T01:08:50.042Z,1611709730.042 [transit:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Construct OffshoreEnvelope. 2021-01-27T01:08:50.067Z,1611709730.067 [transit:BuoyancyHold.Buoyancy](DEBUG): Construct Buoyancy. 2021-01-27T01:08:50.070Z,1611709730.070 [transit:MassHold.Pitch](DEBUG): Construct. 2021-01-27T01:08:50.092Z,1611709730.092 [transit:Transit:A.Pitch](DEBUG): Construct. 2021-01-27T01:08:50.096Z,1611709730.096 [transit:Transit:B.SetSpeed](DEBUG): Construct. 2021-01-27T01:08:50.099Z,1611709730.099 [transit:Transit:Wpt1.Waypoint](DEBUG): Construct Waypoint. 2021-01-27T01:08:50.143Z,1611709730.143 [MissionManager](DEBUG): Vehicle transits to desired waypoint and can be commanded to use/hold mass or buoyancy. Maximum duration of mission 60 How often to surface for commumications 30 Latitude of waypoint to seek. If set to NaN, uses latitude at mission initialization. NaN Longitude of waypoint to seek. If set to NaN, uses longitude at mission initialization. NaN Northward distance of the waypoint to seek. If combined with Latitude and/or Longitude, this is an offset from the specified Latitude and/or Longitude. 0 Eastward distance of the waypoint to seek. If combined with Latitude and/or Longitude, this is an offset from the specified Latitude and/or Longitude. 0 Depth of flat and level flight during the mission. 10 Speed of vehicle (relative to water) during the mission. 1 Maximum depth for the entire mission. 20 Minimum distance offshore for the entire mission. 1 Minimum height above the sea floor for the entire mission. 7 Set to True in order to hold mass at default position, False to allow mass to run on its own. Set to True in order to hold buoyancy at neutral position, False to allow buoyancy to run on its own. 1 2021-01-27T01:08:50.144Z,1611709730.144 [CommandLine](IMPORTANT): Loaded ./Missions/Transport/transit.xml 2021-01-27T01:08:59.325Z,1611709739.325 [CommandLine](IMPORTANT): got command set transit.MissionTimeout 30.000000 minute 2021-01-27T01:08:59.326Z,1611709739.326 [CommandLine](IMPORTANT): got command set transit.Latitude 41.547001 degree 2021-01-27T01:08:59.327Z,1611709739.327 [CommandLine](IMPORTANT): got command set transit.Longitude -70.710503 degree 2021-01-27T01:08:59.328Z,1611709739.328 [CommandLine](IMPORTANT): got command set transit.Depth 7.000000 meter 2021-01-27T01:08:59.329Z,1611709739.329 [CommandLine](IMPORTANT): got command set transit.Speed 1.250000 meter_per_second 2021-01-27T01:08:59.329Z,1611709739.329 [CommandLine](IMPORTANT): got command set transit.MaxDepth 9.000000 meter 2021-01-27T01:09:03.138Z,1611709743.138 [CommandLine](IMPORTANT): got command set transit.MinOffshore 500.000000 meter 2021-01-27T01:09:03.138Z,1611709743.138 [CommandLine](IMPORTANT): got command set transit.MinAltitude 3.000000 meter 2021-01-27T01:09:03.139Z,1611709743.139 [CommandLine](IMPORTANT): got command run 2021-01-27T01:09:03.141Z,1611709743.141 [CommandLine](IMPORTANT): Running 2021-01-27T01:09:03.258Z,1611709743.258 [DefaultWithUndock] Stopped 2021-01-27T01:09:03.258Z,1611709743.258 [DefaultWithUndock](DEBUG): Aggregate::uninitialize DefaultWithUndock 2021-01-27T01:09:03.258Z,1611709743.258 [DefaultWithUndock:SurfaceDefault] Stopped 2021-01-27T01:09:03.258Z,1611709743.258 [DefaultWithUndock:SurfaceDefault](DEBUG): Aggregate::uninitialize DefaultWithUndock:SurfaceDefault 2021-01-27T01:09:03.258Z,1611709743.258 [DefaultWithUndock:SurfaceDefault:B.GoToSurface] Stopped 2021-01-27T01:09:03.258Z,1611709743.258 [DefaultWithUndock:SurfaceDefault:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2021-01-27T01:09:03.258Z,1611709743.258 [DefaultWithUndock:SurfaceDefault:CheckIn] Stopped 2021-01-27T01:09:03.259Z,1611709743.259 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::uninitialize DefaultWithUndock:SurfaceDefault:CheckIn 2021-01-27T01:09:03.259Z,1611709743.259 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Stopped 2021-01-27T01:09:03.259Z,1611709743.259 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-01-27T01:09:03.259Z,1611709743.259 [MissionManager](IMPORTANT): Started mission transit 2021-01-27T01:09:03.259Z,1611709743.259 [transit] Running Loop=1 2021-01-27T01:09:03.259Z,1611709743.259 [transit](DEBUG): Aggregate::initialize transit 2021-01-27T01:09:03.259Z,1611709743.259 [transit:StandardEnvelopes] Running Loop=1 2021-01-27T01:09:03.259Z,1611709743.259 [transit:StandardEnvelopes](DEBUG): Aggregate::initialize transit:StandardEnvelopes 2021-01-27T01:09:03.260Z,1611709743.260 [transit:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1 2021-01-27T01:09:03.260Z,1611709743.260 [transit:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Initialize AltitudeEnvelopeComponent. 2021-01-27T01:09:03.260Z,1611709743.260 [transit:StandardEnvelopes:B.DepthEnvelope] Running Loop=1 2021-01-27T01:09:03.260Z,1611709743.260 [transit:StandardEnvelopes:B.DepthEnvelope](DEBUG): Initialize DepthEnvelopeComponent. 2021-01-27T01:09:03.260Z,1611709743.260 [transit:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1 2021-01-27T01:09:03.260Z,1611709743.260 [transit:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Initialize OffshoreEnvelopeComponent. 2021-01-27T01:09:03.260Z,1611709743.260 [transit:BuoyancyHold.Buoyancy] Running Loop=1 2021-01-27T01:09:03.260Z,1611709743.260 [transit:BuoyancyHold.Buoyancy](DEBUG): Initialize Buoyancy Component. 2021-01-27T01:09:03.261Z,1611709743.261 [transit:MassHold.Pitch] Running Loop=1 2021-01-27T01:09:03.261Z,1611709743.261 [transit:MassHold.Pitch](DEBUG): Initialize. 2021-01-27T01:09:03.261Z,1611709743.261 [transit:B] Running Loop=1 2021-01-27T01:09:03.261Z,1611709743.261 [transit:MassHold.Pitch] Running Loop=1 2021-01-27T01:09:03.262Z,1611709743.262 [transit:BuoyancyHold.Buoyancy] Running Loop=1 2021-01-27T01:09:03.262Z,1611709743.262 [transit:StandardEnvelopes] Running Loop=1 2021-01-27T01:09:03.262Z,1611709743.262 [transit:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1 2021-01-27T01:09:03.262Z,1611709743.262 [transit:StandardEnvelopes:B.DepthEnvelope] Running Loop=1 2021-01-27T01:09:03.263Z,1611709743.263 [transit:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1 2021-01-27T01:09:03.263Z,1611709743.263 [transit:B] Stopped 2021-01-27T01:09:03.263Z,1611709743.263 [transit:C] Running Loop=1 2021-01-27T01:09:03.672Z,1611709743.672 [transit:C] Stopped 2021-01-27T01:09:03.672Z,1611709743.672 [transit:E] Running Loop=1 2021-01-27T01:09:04.086Z,1611709744.086 [transit:E] Stopped 2021-01-27T01:09:04.086Z,1611709744.086 [transit:F] Running Loop=1 2021-01-27T01:09:04.454Z,1611709744.454 [NAL9602](INFO): Not Powering down - fast GPS 2021-01-27T01:09:04.467Z,1611709744.467 [transit:F] Stopped 2021-01-27T01:09:04.467Z,1611709744.467 [transit:G] Running Loop=1 2021-01-27T01:09:04.926Z,1611709744.926 [transit:G] Stopped 2021-01-27T01:09:04.926Z,1611709744.926 [transit:Transit] Running Loop=1 2021-01-27T01:09:04.926Z,1611709744.926 [transit:Transit](DEBUG): Aggregate::initialize transit:Transit 2021-01-27T01:09:04.926Z,1611709744.926 [transit:Transit:A.Pitch] Running Loop=1 2021-01-27T01:09:04.926Z,1611709744.926 [transit:Transit:A.Pitch](DEBUG): Initialize. 2021-01-27T01:09:04.926Z,1611709744.926 [transit:Transit:B.SetSpeed] Running Loop=1 2021-01-27T01:09:04.927Z,1611709744.927 [transit:Transit:B.SetSpeed](DEBUG): Initialize. 2021-01-27T01:09:04.927Z,1611709744.927 [transit:Transit:Wpt1.Waypoint] Running Loop=1 2021-01-27T01:09:04.927Z,1611709744.927 [transit:Transit:Wpt1.Waypoint](DEBUG): Initialize WaypointComponent. 2021-01-27T01:09:05.285Z,1611709745.285 [transit:Transit:B.SetSpeed] Running Loop=1 2021-01-27T01:09:05.285Z,1611709745.285 [transit:Transit:A.Pitch] Running Loop=1 2021-01-27T01:09:16.721Z,1611709756.721 [ThrusterServo](INFO): Failure count cleared after critical for ThrusterServo 2021-01-27T01:09:31.129Z,1611709771.129 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2021-01-27T01:09:38.000Z,1611709778.000 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2021-01-27T01:09:50.123Z,1611709790.123 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2021-01-27T01:10:25.757Z,1611709825.757 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.252411 2021-01-27T01:10:56.592Z,1611709856.592 [Radio_Surface](INFO): Powering down 2021-01-27T01:11:01.900Z,1611709861.900 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2021-01-27T01:11:02.917Z,1611709862.917 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2021-01-27T01:20:30.864Z,1611710430.864 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2021-01-27T01:22:05.822Z,1611710525.822 [RDI_PathfinderUp](ERROR): only read 2 of 4 data items 2021-01-27T01:22:10.679Z,1611710530.679 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-01-27T01:22:15.929Z,1611710535.929 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2021-01-27T01:22:50.764Z,1611710570.764 [RDI_PathfinderUp](ERROR): DVL uart error: serial timeout 2021-01-27T01:22:50.764Z,1611710570.764 [RDI_PathfinderUp] Communications Fault, FailCount= 1 2021-01-27T01:22:50.764Z,1611710570.764 [RDI_PathfinderUp](ERROR): Communications Fault 2021-01-27T01:22:50.832Z,1611710570.832 [CBIT](ERROR): Communications Fault in component: RDI_PathfinderUp 2021-01-27T01:22:51.144Z,1611710571.144 [RDI_PathfinderUp](INFO): Powering down 2021-01-27T01:22:51.924Z,1611710571.924 [CBIT](INFO): Clearing failed state for component RDI_PathfinderUp 2021-01-27T01:22:51.924Z,1611710571.924 [RDI_PathfinderUp] No Fault, FailCount= 1 2021-01-27T01:24:51.058Z,1611710691.058 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2021-01-27T01:25:05.991Z,1611710705.991 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2021-01-27T01:28:09.421Z,1611710889.421 [transit:Transit:Wpt1.Waypoint](IMPORTANT): Reached Waypoint: 41.547003,-70.710503 2021-01-27T01:28:09.421Z,1611710889.421 [transit:Transit:Wpt1.Waypoint] Stopped 2021-01-27T01:28:09.421Z,1611710889.421 [transit:Transit:Wpt1.Waypoint](DEBUG): Uninitialize WaypointComponent. 2021-01-27T01:28:09.421Z,1611710889.421 [transit:Transit:PhoneHome] Running Loop=1 2021-01-27T01:28:09.421Z,1611710889.421 [transit:Transit:PhoneHome](DEBUG): Aggregate::initialize transit:Transit:PhoneHome 2021-01-27T01:28:09.832Z,1611710889.832 [transit:NeedComms] Running Loop=1 2021-01-27T01:28:09.832Z,1611710889.832 [transit:NeedComms](DEBUG): Aggregate::initialize transit:NeedComms 2021-01-27T01:28:09.832Z,1611710889.832 [transit:NeedComms:B.GoToSurface] Running Loop=1 2021-01-27T01:28:09.832Z,1611710889.832 [transit:NeedComms:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2021-01-27T01:28:09.832Z,1611710889.832 [transit:NeedComms:B.GoToSurface](INFO): Received depth rate setting nan m/s. 2021-01-27T01:28:09.833Z,1611710889.833 [transit:NeedComms:B.GoToSurface](INFO): Received pitch setting 19.999999 degrees. 2021-01-27T01:28:09.833Z,1611710889.833 [transit:NeedComms:B.GoToSurface](INFO): Received speed setting 1.000000 m/s. 2021-01-27T01:28:09.833Z,1611710889.833 [transit:NeedComms:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2021-01-27T01:28:09.834Z,1611710889.834 [transit:NeedComms:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2021-01-27T01:28:09.834Z,1611710889.834 [transit:NeedComms:A] Running Loop=1 2021-01-27T01:28:09.835Z,1611710889.835 [transit:NeedComms:A](INFO): last time_fix was: 1611709666.000000 second since 1970/01/01T00:00:00Z 2021-01-27T01:28:09.836Z,1611710889.836 [transit:NeedComms:A] Stopped 2021-01-27T01:28:57.524Z,1611710937.524 [transit:NeedComms:C] Running Loop=1 2021-01-27T01:28:57.920Z,1611710937.920 [transit:NeedComms:C](DEBUG): Initialize ReadDataComponent to sense time_fix 2021-01-27T01:28:58.112Z,1611710938.112 [Radio_Surface](INFO): Powering up 2021-01-27T01:29:03.416Z,1611710943.416 [DataOverHttps](INFO): Radio surface powered ON. 2021-01-27T01:29:11.300Z,1611710951.300 [BuoyancyServo](FAULT): Overload Error 2021-01-27T01:29:11.300Z,1611710951.300 [BuoyancyServo] Hardware Fault, FailCount= 1 2021-01-27T01:29:11.300Z,1611710951.300 [BuoyancyServo](ERROR): Hardware Fault 2021-01-27T01:29:11.341Z,1611710951.341 [CBIT](ERROR): Hardware Fault in component: BuoyancyServo 2021-01-27T01:29:13.255Z,1611710953.255 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2021-01-27T01:29:13.255Z,1611710953.255 [BuoyancyServo](INFO): Powering down 2021-01-27T01:29:14.085Z,1611710954.085 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2021-01-27T01:29:14.085Z,1611710954.085 [BuoyancyServo] No Fault, FailCount= 1 2021-01-27T01:29:14.506Z,1611710954.506 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2021-01-27T01:29:14.512Z,1611710954.512 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2021-01-27T01:29:24.546Z,1611710964.546 [NAL9602](INFO): SBD MO Status=2, MOMSN=13073, MT Status=2, MTMSN=0 2021-01-27T01:29:24.547Z,1611710964.547 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-01-27T01:29:33.536Z,1611710973.536 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2021-01-27T01:30:03.737Z,1611711003.737 [NAL9602](INFO): SBD MO Status=0, MOMSN=13073, MT Status=0, MTMSN=0 2021-01-27T01:30:03.737Z,1611711003.737 [NAL9602](INFO): No messages in MT queue 2021-01-27T01:30:04.232Z,1611711004.232 [BuoyancyServo](FAULT): Overload Error 2021-01-27T01:30:04.232Z,1611711004.232 [BuoyancyServo] Hardware Fault, FailCount= 2 2021-01-27T01:30:04.232Z,1611711004.232 [BuoyancyServo](ERROR): Hardware Fault 2021-01-27T01:30:04.272Z,1611711004.272 [CBIT](ERROR): Hardware Fault in component: BuoyancyServo 2021-01-27T01:30:04.960Z,1611711004.960 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,013004.00,A,4132.76355,N,07042.68682,W,1.419,195.19,270121,,,A*70 2021-01-27T01:30:04.962Z,1611711004.962 [NAL9602](INFO): GPS fix at 20210127T013004: (41.546059, -70.711447) 2021-01-27T01:30:04.984Z,1611711004.984 [UniversalFixResidualReporter](INFO): Fix residual: 4.6 %DT, over the last 1274.0 m. Residual distance 59.1 m at bearing 60.0 degrees. Fix at (41.5461, -70.7114) with 1290.0 m made good. 2021-01-27T01:30:04.987Z,1611711004.987 [transit:NeedComms:C] Stopped 2021-01-27T01:30:04.987Z,1611711004.987 [transit:NeedComms:D] Running Loop=1 2021-01-27T01:30:05.403Z,1611711005.403 [transit:NeedComms:D](DEBUG): Initialize ReadDataComponent to sense platform_communications 2021-01-27T01:30:06.218Z,1611711006.218 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2021-01-27T01:30:06.218Z,1611711006.218 [BuoyancyServo](INFO): Powering down 2021-01-27T01:30:06.586Z,1611711006.586 [BuoyancyServo](FAULT): LCB fault: Software Overcurrent. Current Limiter Activated. 2021-01-27T01:30:07.009Z,1611711007.009 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2021-01-27T01:30:07.009Z,1611711007.009 [BuoyancyServo] No Fault, FailCount= 2 2021-01-27T01:30:07.541Z,1611711007.541 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2021-01-27T01:30:07.548Z,1611711007.548 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2021-01-27T01:30:08.682Z,1611711008.682 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2021-01-27T01:30:25.668Z,1611711025.668 [NAL9602](INFO): SBD MO Status=1, MOMSN=13074, MT Status=0, MTMSN=0 2021-01-27T01:30:25.728Z,1611711025.728 [NAL9602](INFO): Sent 78 bytes from file Logs/20210127T001126/Courier0030.lzma 2021-01-27T01:30:25.728Z,1611711025.728 [NAL9602](INFO): Packets left to send: 0 2021-01-27T01:30:35.556Z,1611711035.556 [BuoyancyServo](FAULT): Overload Error 2021-01-27T01:30:35.556Z,1611711035.556 [BuoyancyServo] Hardware Fault, FailCount= 3 2021-01-27T01:30:35.556Z,1611711035.556 [BuoyancyServo](ERROR): Hardware Fault 2021-01-27T01:30:35.597Z,1611711035.597 [CBIT](ERROR): Hardware Fault in component: BuoyancyServo 2021-01-27T01:30:37.531Z,1611711037.531 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2021-01-27T01:30:37.531Z,1611711037.531 [BuoyancyServo](INFO): Powering down 2021-01-27T01:30:37.992Z,1611711037.992 [BuoyancyServo](FAULT): LCB fault: Software Overcurrent. Current Limiter Activated. 2021-01-27T01:30:38.358Z,1611711038.358 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2021-01-27T01:30:38.358Z,1611711038.358 [BuoyancyServo] No Fault, FailCount= 3 2021-01-27T01:30:38.766Z,1611711038.766 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2021-01-27T01:30:38.767Z,1611711038.767 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2021-01-27T01:30:40.748Z,1611711040.748 [NAL9602](INFO): SBD MO Status=2, MOMSN=13075, MT Status=2, MTMSN=0 2021-01-27T01:30:40.748Z,1611711040.748 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-01-27T01:30:43.824Z,1611711043.824 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2021-01-27T01:31:03.016Z,1611711063.016 [BuoyancyServo](FAULT): Overload Error 2021-01-27T01:31:03.016Z,1611711063.016 [BuoyancyServo] Hardware Fault, FailCount= 4 2021-01-27T01:31:03.016Z,1611711063.016 [BuoyancyServo](ERROR): Hardware Fault 2021-01-27T01:31:03.057Z,1611711063.057 [CBIT](ERROR): Hardware Fault in component: BuoyancyServo 2021-01-27T01:31:05.147Z,1611711065.147 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2021-01-27T01:31:05.147Z,1611711065.147 [BuoyancyServo](INFO): Powering down 2021-01-27T01:31:05.817Z,1611711065.817 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2021-01-27T01:31:05.817Z,1611711065.817 [BuoyancyServo] No Fault, FailCount= 4 2021-01-27T01:31:06.270Z,1611711066.270 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2021-01-27T01:31:06.276Z,1611711066.276 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2021-01-27T01:31:18.972Z,1611711078.972 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2021-01-27T01:31:24.852Z,1611711084.852 [BuoyancyServo](FAULT): Overload Error 2021-01-27T01:31:24.852Z,1611711084.852 [BuoyancyServo] Hardware Fault, FailCount= 5 2021-01-27T01:31:24.852Z,1611711084.852 [BuoyancyServo](ERROR): Hardware Fault 2021-01-27T01:31:24.857Z,1611711084.857 [CBIT](ERROR): Hardware Fault in component: BuoyancyServo 2021-01-27T01:31:26.943Z,1611711086.943 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2021-01-27T01:31:26.943Z,1611711086.943 [BuoyancyServo](INFO): Powering down 2021-01-27T01:31:27.633Z,1611711087.633 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2021-01-27T01:31:27.633Z,1611711087.633 [BuoyancyServo] No Fault, FailCount= 5 2021-01-27T01:31:28.223Z,1611711088.223 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2021-01-27T01:31:28.224Z,1611711088.224 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2021-01-27T01:31:54.113Z,1611711114.113 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2021-01-27T01:32:05.661Z,1611711125.661 [NAL9602](INFO): SBD MO Status=1, MOMSN=13075, MT Status=0, MTMSN=0 2021-01-27T01:32:05.724Z,1611711125.724 [NAL9602](INFO): Sent 184 bytes from file Logs/20210127T001126/Express0032.lzma 2021-01-27T01:32:05.724Z,1611711125.724 [NAL9602](INFO): Packets left to send: 4 2021-01-27T01:32:21.910Z,1611711141.910 [NAL9602](INFO): SBD MO Status=2, MOMSN=13076, MT Status=2, MTMSN=0 2021-01-27T01:32:21.911Z,1611711141.911 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-01-27T01:32:23.233Z,1611711143.233 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003556 2021-01-27T01:32:27.247Z,1611711147.247 [DataOverHttps](INFO): Sending 51 bytes from file Logs/20210127T001126/Courier0036.lzma 2021-01-27T01:32:28.250Z,1611711148.250 [DataOverHttps](INFO): Moved sent file to Logs/20210127T001126/Courier0036.lzma.bak 2021-01-27T01:32:28.250Z,1611711148.250 [DataOverHttps](INFO): SBD MOMSN=68368 2021-01-27T01:32:37.302Z,1611711157.302 [DataOverHttps](INFO): Sending 759 bytes from file Logs/20210127T001126/Express0032.lzma 2021-01-27T01:32:38.305Z,1611711158.305 [DataOverHttps](INFO): Moved sent file to Logs/20210127T001126/Express0032.lzma.bak 2021-01-27T01:32:38.306Z,1611711158.306 [DataOverHttps](INFO): SBD MOMSN=68371 2021-01-27T01:32:47.344Z,1611711167.344 [DataOverHttps](INFO): Sending 157 bytes from file Logs/20210127T001126/Express0037.lzma 2021-01-27T01:32:48.342Z,1611711168.342 [DataOverHttps](INFO): Moved sent file to Logs/20210127T001126/Express0037.lzma.bak 2021-01-27T01:32:48.342Z,1611711168.342 [DataOverHttps](INFO): SBD MOMSN=68402 2021-01-27T01:32:49.825Z,1611711169.825 [transit:NeedComms:D] Stopped 2021-01-27T01:32:49.825Z,1611711169.825 [transit:NeedComms:E] Running Loop=1 2021-01-27T01:32:50.203Z,1611711170.203 [transit:NeedComms:E](DEBUG): Initialize ReadDataComponent to sense time_fix 2021-01-27T01:32:51.808Z,1611711171.808 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,013251.00,A,4132.73389,N,07042.70803,W,0.564,190.64,270121,,,D*78 2021-01-27T01:32:51.810Z,1611711171.810 [NAL9602](INFO): GPS fix at 20210127T013251: (41.545565, -70.711800) 2021-01-27T01:32:51.854Z,1611711171.854 [transit:NeedComms:E] Stopped 2021-01-27T01:32:51.855Z,1611711171.855 [transit:NeedComms](INFO): Completed transit:NeedComms 2021-01-27T01:32:51.855Z,1611711171.855 [transit:NeedComms] Stopped 2021-01-27T01:32:51.855Z,1611711171.855 [transit:NeedComms](DEBUG): Aggregate::uninitialize transit:NeedComms 2021-01-27T01:32:51.855Z,1611711171.855 [transit:NeedComms:B.GoToSurface] Stopped 2021-01-27T01:32:51.855Z,1611711171.855 [transit:NeedComms:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2021-01-27T01:32:52.265Z,1611711172.265 [transit:Transit:PhoneHome](INFO): Completed transit:Transit:PhoneHome 2021-01-27T01:32:52.265Z,1611711172.265 [transit:Transit:PhoneHome] Stopped 2021-01-27T01:32:52.265Z,1611711172.265 [transit:Transit:PhoneHome](DEBUG): Aggregate::uninitialize transit:Transit:PhoneHome 2021-01-27T01:32:52.266Z,1611711172.266 [transit:Transit](INFO): Completed transit:Transit 2021-01-27T01:32:52.266Z,1611711172.266 [transit:Transit] Stopped 2021-01-27T01:32:52.266Z,1611711172.266 [transit:Transit](DEBUG): Aggregate::uninitialize transit:Transit 2021-01-27T01:32:52.266Z,1611711172.266 [transit:Transit:A.Pitch] Stopped 2021-01-27T01:32:52.266Z,1611711172.266 [transit:Transit:B.SetSpeed] Stopped 2021-01-27T01:32:52.266Z,1611711172.266 [transit:Transit:B.SetSpeed](DEBUG): Uninitialize. 2021-01-27T01:32:52.268Z,1611711172.268 [transit](INFO): Completed transit 2021-01-27T01:32:52.268Z,1611711172.268 [MissionManager](INFO): transit is completed. 2021-01-27T01:32:52.268Z,1611711172.268 [MissionManager](INFO): Uninitializing Mission transit 2021-01-27T01:32:52.268Z,1611711172.268 [transit] Stopped 2021-01-27T01:32:52.269Z,1611711172.269 [transit](DEBUG): Aggregate::uninitialize transit 2021-01-27T01:32:52.269Z,1611711172.269 [transit:StandardEnvelopes] Stopped 2021-01-27T01:32:52.269Z,1611711172.269 [transit:StandardEnvelopes](DEBUG): Aggregate::uninitialize transit:StandardEnvelopes 2021-01-27T01:32:52.269Z,1611711172.269 [transit:StandardEnvelopes:A.AltitudeEnvelope] Stopped 2021-01-27T01:32:52.269Z,1611711172.269 [transit:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Uninitialize AltitudeEnvelopeComponent. 2021-01-27T01:32:52.269Z,1611711172.269 [transit:StandardEnvelopes:B.DepthEnvelope] Stopped 2021-01-27T01:32:52.269Z,1611711172.269 [transit:StandardEnvelopes:B.DepthEnvelope](DEBUG): Uninitialize. 2021-01-27T01:32:52.269Z,1611711172.269 [transit:StandardEnvelopes:C.OffshoreEnvelope] Stopped 2021-01-27T01:32:52.269Z,1611711172.269 [transit:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Uninitialize OffshoreEnvelopeComponent. 2021-01-27T01:32:52.269Z,1611711172.269 [transit:BuoyancyHold.Buoyancy] Stopped 2021-01-27T01:32:52.269Z,1611711172.269 [transit:BuoyancyHold.Buoyancy](DEBUG): Uninitialize Buoyancy Component. 2021-01-27T01:32:52.269Z,1611711172.269 [transit:MassHold.Pitch] Stopped 2021-01-27T01:32:52.629Z,1611711172.629 [ElevatorOffsetCalculator](INFO): Removing expired estimator for commanded vars: speed 1.00 m/s, pitch -15.00 deg, mass-position 15.00 mm. 2021-01-27T01:32:52.630Z,1611711172.630 [ElevatorOffsetCalculator](INFO): Removing expired estimator for commanded vars: speed 1.00 m/s, pitch 15.00 deg, mass-position 15.00 mm. 2021-01-27T01:32:52.634Z,1611711172.634 [MissionManager](IMPORTANT): Started mission DefaultWithUndock 2021-01-27T01:32:52.634Z,1611711172.634 [DefaultWithUndock] Running Loop=1 2021-01-27T01:32:52.634Z,1611711172.634 [DefaultWithUndock](DEBUG): Aggregate::initialize DefaultWithUndock 2021-01-27T01:32:52.634Z,1611711172.634 [DefaultWithUndock:A.Wait] Running Loop=1 2021-01-27T01:32:52.634Z,1611711172.634 [DefaultWithUndock:A.Wait](DEBUG): Initialize Wait Component. 2021-01-27T01:33:23.107Z,1611711203.107 [DefaultWithUndock:A.Wait](INFO): Done Waiting. 2021-01-27T01:33:23.107Z,1611711203.107 [DefaultWithUndock:A.Wait] Stopped 2021-01-27T01:33:23.140Z,1611711203.140 [DefaultWithUndock:A.Wait](DEBUG): Uninitialize Wait Component. 2021-01-27T01:33:23.140Z,1611711203.140 [DefaultWithUndock:LeaveDock] Running Loop=1 2021-01-27T01:33:23.140Z,1611711203.140 [DefaultWithUndock:LeaveDock](DEBUG): Aggregate::initialize DefaultWithUndock:LeaveDock 2021-01-27T01:33:23.140Z,1611711203.140 [DefaultWithUndock:LeaveDock:A.] Running Loop=1 2021-01-27T01:33:23.141Z,1611711203.141 [DefaultWithUndock:LeaveDock:A.](INFO): Initializing TrackAcousticContact. 2021-01-27T01:33:23.141Z,1611711203.141 [DefaultWithUndock:LeaveDock:B.Undock] Running Loop=1 2021-01-27T01:33:23.141Z,1611711203.141 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Initialize. 2021-01-27T01:33:23.141Z,1611711203.141 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Initializing internal variables to default values. 2021-01-27T01:33:23.729Z,1611711203.729 [NAL9602](INFO): Not Powering down - fast GPS 2021-01-27T01:33:25.802Z,1611711205.802 [DefaultWithUndock:LeaveDock:A.](INFO): *** querying acoustic contact *** 2021-01-27T01:33:26.606Z,1611711206.606 [Micromodem](INFO): Nmea out: $CCPGT,1,14500,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*76 2021-01-27T01:33:26.651Z,1611711206.651 [DefaultWithUndock:LeaveDock:B.Undock](INFO): Detaching from dock. 2021-01-27T01:33:26.984Z,1611711206.984 [Micromodem](INFO): Nmea in: $SNPGT,1,14500,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*6B 2021-01-27T01:33:27.043Z,1611711207.043 [DefaultWithUndock:LeaveDock:B.Undock](INFO): Detected possible detachment. Starting timer. 2021-01-27T01:33:27.793Z,1611711207.793 [Micromodem](INFO): Nmea in: $SNTTA,,,,,013328.11*55 2021-01-27T01:33:31.455Z,1611711211.455 [DefaultWithUndock:LeaveDock:A.](INFO): *** querying acoustic contact *** 2021-01-27T01:33:32.230Z,1611711212.230 [Micromodem](INFO): Nmea out: $CCPGT,1,14500,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*76 2021-01-27T01:33:32.636Z,1611711212.636 [Micromodem](INFO): Nmea in: $SNPGT,1,14500,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*6B 2021-01-27T01:33:33.462Z,1611711213.462 [Micromodem](INFO): Nmea in: $SNTTA,,,,,013333.73*5B 2021-01-27T01:33:37.089Z,1611711217.089 [DefaultWithUndock:LeaveDock:A.](INFO): *** querying acoustic contact *** 2021-01-27T01:33:37.887Z,1611711217.887 [Micromodem](INFO): Nmea out: $CCPGT,1,14500,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*76 2021-01-27T01:33:38.321Z,1611711218.321 [Micromodem](INFO): Nmea in: $SNPGT,1,14500,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*6B 2021-01-27T01:33:39.118Z,1611711219.118 [Micromodem](INFO): Nmea in: $SNTTA,,,,,013339.39*5F 2021-01-27T01:33:39.935Z,1611711219.935 [DefaultWithUndock:LeaveDock:A.](INFO): *** querying acoustic contact *** 2021-01-27T01:33:41.169Z,1611711221.169 [DUSBL_Hydroid](ERROR): No response from remote modem. 2021-01-27T01:33:42.801Z,1611711222.801 [DefaultWithUndock:LeaveDock:A.](INFO): *** querying acoustic contact *** 2021-01-27T01:33:43.543Z,1611711223.543 [Micromodem](INFO): Nmea out: $CCPGT,1,14500,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*76 2021-01-27T01:33:43.952Z,1611711223.952 [Micromodem](INFO): Nmea in: $SNPGT,1,14500,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*6B 2021-01-27T01:33:44.786Z,1611711224.786 [Micromodem](INFO): Nmea in: $SNTTA,,,,,013345.04*5A 2021-01-27T01:33:45.181Z,1611711225.181 [DUSBL_Hydroid](ERROR): unknown deviceResponse_: !U1,R,317,P 0,0363A,189,80,80,58,FF 2021-01-27T01:33:45.581Z,1611711225.581 [DefaultWithUndock:LeaveDock:A.](INFO): *** querying acoustic contact *** 2021-01-27T01:33:47.251Z,1611711227.251 [DefaultWithUndock:LeaveDock:B.Undock](INFO): Detached at range: 795.42 m. Transitioning DDM to standby. 2021-01-27T01:33:48.415Z,1611711228.415 [DefaultWithUndock:LeaveDock:A.](INFO): *** querying acoustic contact *** 2021-01-27T01:33:50.058Z,1611711230.058 [DefaultWithUndock:LeaveDock:B.Undock](INFO): DDM at standby. 2021-01-27T01:33:50.428Z,1611711230.428 [DefaultWithUndock:LeaveDock:B.Undock](IMPORTANT): Undocking sequence complete. 2021-01-27T01:33:50.428Z,1611711230.428 [DefaultWithUndock:LeaveDock:B.Undock] Stopped 2021-01-27T01:33:50.428Z,1611711230.428 [DefaultWithUndock:LeaveDock](INFO): Completed DefaultWithUndock:LeaveDock 2021-01-27T01:33:50.429Z,1611711230.429 [DefaultWithUndock:LeaveDock] Stopped 2021-01-27T01:33:50.429Z,1611711230.429 [DefaultWithUndock:LeaveDock](DEBUG): Aggregate::uninitialize DefaultWithUndock:LeaveDock 2021-01-27T01:33:50.429Z,1611711230.429 [DefaultWithUndock:LeaveDock:A.] Stopped 2021-01-27T01:33:50.429Z,1611711230.429 [DefaultWithUndock:SurfaceDefault] Running Loop=1 2021-01-27T01:33:50.429Z,1611711230.429 [DefaultWithUndock:SurfaceDefault](DEBUG): Aggregate::initialize DefaultWithUndock:SurfaceDefault 2021-01-27T01:33:50.429Z,1611711230.429 [DefaultWithUndock:SurfaceDefault:HoldLatchOpen] Running Loop=1 2021-01-27T01:33:50.429Z,1611711230.429 [DefaultWithUndock:SurfaceDefault:HoldLatchOpen](DEBUG): Aggregate::initialize DefaultWithUndock:SurfaceDefault:HoldLatchOpen 2021-01-27T01:33:50.429Z,1611711230.429 [DefaultWithUndock:SurfaceDefault:HoldLatchOpen:A] Running Loop=1 2021-01-27T01:33:50.429Z,1611711230.429 [DefaultWithUndock:SurfaceDefault:HoldLatchOpen:B] Running Loop=1 2021-01-27T01:33:50.429Z,1611711230.429 [DefaultWithUndock:SurfaceDefault:B.GoToSurface] Running Loop=1 2021-01-27T01:33:50.429Z,1611711230.429 [DefaultWithUndock:SurfaceDefault:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2021-01-27T01:33:50.430Z,1611711230.430 [DefaultWithUndock:SurfaceDefault:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2021-01-27T01:33:50.430Z,1611711230.430 [DefaultWithUndock:SurfaceDefault:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2021-01-27T01:33:50.430Z,1611711230.430 [DefaultWithUndock:SurfaceDefault:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2021-01-27T01:33:50.431Z,1611711230.431 [DefaultWithUndock:SurfaceDefault:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2021-01-27T01:33:50.431Z,1611711230.431 [DefaultWithUndock:SurfaceDefault:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2021-01-27T01:33:50.928Z,1611711230.928 [DefaultWithUndock:SurfaceDefault:CheckIn] Running Loop=1 2021-01-27T01:33:50.928Z,1611711230.928 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::initialize DefaultWithUndock:SurfaceDefault:CheckIn 2021-01-27T01:33:50.928Z,1611711230.928 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Running Loop=1 2021-01-27T01:33:50.928Z,1611711230.928 [DefaultWithUndock:SurfaceDefault:HoldLatchOpen] Stopped 2021-01-27T01:33:50.928Z,1611711230.928 [DefaultWithUndock:SurfaceDefault:HoldLatchOpen](DEBUG): Aggregate::uninitialize DefaultWithUndock:SurfaceDefault:HoldLatchOpen 2021-01-27T01:33:50.928Z,1611711230.928 [DefaultWithUndock:SurfaceDefault:HoldLatchOpen:A] Stopped 2021-01-27T01:33:50.928Z,1611711230.928 [DefaultWithUndock:SurfaceDefault:HoldLatchOpen:B] Stopped 2021-01-27T01:33:52.806Z,1611711232.806 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,013352.00,A,4132.72331,N,07042.71509,W,0.583,221.33,270121,,,D*7C 2021-01-27T01:33:52.808Z,1611711232.808 [NAL9602](INFO): GPS fix at 20210127T013352: (41.545389, -70.711918) 2021-01-27T01:33:52.854Z,1611711232.854 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Stopped 2021-01-27T01:33:52.855Z,1611711232.855 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Running Loop=1 2021-01-27T01:33:56.462Z,1611711236.462 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-01-27T01:33:56.643Z,1611711236.643 [DataOverHttps](INFO): Sending 78 bytes from file Logs/20210127T001126/Courier0039.lzma 2021-01-27T01:33:57.646Z,1611711237.646 [DataOverHttps](INFO): Moved sent file to Logs/20210127T001126/Courier0039.lzma.bak 2021-01-27T01:33:57.646Z,1611711237.646 [DataOverHttps](INFO): SBD MOMSN=68409 2021-01-27T01:34:03.400Z,1611711243.400 [BuoyancyServo](FAULT): Overload Error 2021-01-27T01:34:03.400Z,1611711243.400 [BuoyancyServo] Hardware Fault, FailCount= 1 2021-01-27T01:34:03.400Z,1611711243.400 [BuoyancyServo](ERROR): Hardware Fault 2021-01-27T01:34:03.468Z,1611711243.468 [CBIT](ERROR): Hardware Fault in component: BuoyancyServo 2021-01-27T01:34:05.355Z,1611711245.355 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2021-01-27T01:34:05.355Z,1611711245.355 [BuoyancyServo](INFO): Powering down 2021-01-27T01:34:05.814Z,1611711245.814 [BuoyancyServo](FAULT): LCB fault: Software Overcurrent. 2021-01-27T01:34:06.228Z,1611711246.228 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2021-01-27T01:34:06.228Z,1611711246.228 [BuoyancyServo] No Fault, FailCount= 1 2021-01-27T01:34:06.561Z,1611711246.561 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2021-01-27T01:34:06.562Z,1611711246.562 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2021-01-27T01:34:06.694Z,1611711246.694 [DataOverHttps](INFO): Sending 143 bytes from file Logs/20210127T001126/Express0040.lzma 2021-01-27T01:34:07.690Z,1611711247.690 [DataOverHttps](INFO): Moved sent file to Logs/20210127T001126/Express0040.lzma.bak 2021-01-27T01:34:07.691Z,1611711247.691 [DataOverHttps](INFO): SBD MOMSN=68412 2021-01-27T01:34:08.996Z,1611711248.996 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Stopped 2021-01-27T01:34:08.996Z,1611711248.996 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Running Loop=1 2021-01-27T01:34:08.997Z,1611711248.997 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-01-27T01:34:17.059Z,1611711257.059 [NAL9602](INFO): SBD MO Status=1, MOMSN=13076, MT Status=0, MTMSN=0 2021-01-27T01:34:17.059Z,1611711257.059 [NAL9602](INFO): No messages in MT queue 2021-01-27T01:34:25.600Z,1611711265.600 [BuoyancyServo](FAULT): Overload Error 2021-01-27T01:34:25.600Z,1611711265.600 [BuoyancyServo] Hardware Fault, FailCount= 2 2021-01-27T01:34:25.600Z,1611711265.600 [BuoyancyServo](ERROR): Hardware Fault 2021-01-27T01:34:25.600Z,1611711265.600 [BuoyancyServo](FAULT): Buoyancy initialization uart error:no error 2021-01-27T01:34:25.600Z,1611711265.600 [BuoyancyServo] Communications Fault, FailCount= 2 2021-01-27T01:34:25.600Z,1611711265.600 [BuoyancyServo](ERROR): Communications Fault 2021-01-27T01:34:25.605Z,1611711265.605 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2021-01-27T01:34:26.346Z,1611711266.346 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-01-27T01:34:27.590Z,1611711267.590 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2021-01-27T01:34:27.590Z,1611711267.590 [BuoyancyServo](INFO): Powering down 2021-01-27T01:34:28.400Z,1611711268.400 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2021-01-27T01:34:28.400Z,1611711268.400 [BuoyancyServo] No Fault, FailCount= 2 2021-01-27T01:34:28.800Z,1611711268.800 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2021-01-27T01:34:28.801Z,1611711268.801 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2021-01-27T01:34:47.754Z,1611711287.754 [NAL9602](INFO): Not Powering down - fast GPS 2021-01-27T01:34:47.849Z,1611711287.849 [DataOverHttps](IMPORTANT): SBD MTMSN=20210127T013447 2021-01-27T01:34:51.867Z,1611711291.867 [DataOverHttps](INFO): Received command:restart logs