makai Path

trajectory

20240920T042724 [CommandExec]:got command schedule resume

20240920T042724 [CommandExec]:Scheduling is resumed

20240920T042724 [CommandExec]:got command restart logs

20240920T043349 [Default:CheckIn:E]:Default mission has been running for 13.636565 min

20240920T043416 [CommandExec]:got command schedule 20240920T050000 "load Science/circle_sample.xml;set CircleSample.MissionTimeout 4 h;set CircleSample.AcousticTrackingTimeout 0.5 h;set CircleSample.NeedCommsMissionStart 0 bool;set CircleSample.AcousticTargetDepth 0 m" 4flrv 1 4.000000

20240920T043416 [CommandExec]:Scheduling command #1 of 4 with id=4flrv

20240920T043416 [CommandExec]:Scheduled #1 (#1 of 4 with id='4flrv'): "load Science/circle_sample.xml;set CircleSample.MissionTimeout 4 h;set CircleSample.AcousticTrackingTimeout 0.5 h;set CircleSample.NeedCommsMissionStart 0 bool;set CircleSample.AcousticTargetDepth 0 m", AT TIME: 2024-09-20T05:00:00Z

20240920T043443 [NAL9602]:Failed to initiate SBD session. Error code: 2

20240920T043531 [CommandExec]:got command schedule 20240920T050000 "set CircleSample.SendSampleResultToWG 1 bool;set CircleSample.WaitBeforeFiring 0 min;set CircleSample.MaxWaitMustFire 120 min;set CircleSample.DepthCircle 150 m;set CircleSample.CircleYoYoMinDepth 10 m" 4flrv 2 4.000000

20240920T043531 [CommandExec]:Scheduling command #2 of 4 with id=4flrv

20240920T043531 [CommandExec]:Scheduled #2 (#2 of 4 with id='4flrv'): "set CircleSample.SendSampleResultToWG 1 bool;set CircleSample.WaitBeforeFiring 0 min;set CircleSample.MaxWaitMustFire 120 min;set CircleSample.DepthCircle 150 m;set CircleSample.CircleYoYoMinDepth 10 m", AT TIME: 2024-09-20T05:00:00Z

20240920T043539 [CommandExec]:got command schedule 20240920T050000 "set CircleSample.NumberOfStartingFixesToIgnore 1 count;set CircleSample:NeedComms.CommsTimeout 15 min;run" 4flrv 4 4.000000

20240920T043539 [CommandExec]:Scheduling command #4 of 4 with id=4flrv

20240920T043539 [CommandExec]:Scheduled #3 (#4 of 4 with id='4flrv'): "set CircleSample.NumberOfStartingFixesToIgnore 1 count;set CircleSample:NeedComms.CommsTimeout 15 min;run", AT TIME: 2024-09-20T05:00:00Z

20240920T043556 [CommandExec]:got command schedule 20240920T050000 "set CircleSample.CircleYoYoMaxDepth 280 m;set CircleSample.MaxDepth 290 m;set CircleSample.CenterLatitude 36.712468 degree;set CircleSample.CenterLongitude -122.1869 degree;set CircleSample.TrackingUpdatePeriod 65 s" 4flrv 3 4.000000

20240920T043556 [CommandExec]:Scheduled #3 (#4 of 4 with id='4flrv'): "set CircleSample.NumberOfStartingFixesToIgnore 1 count;set CircleSample:NeedComms.CommsTimeout 15 min;run", AT TIME: 2024-09-20T05:00:00Z

20240920T044214 [Default:CheckIn:E]:Default mission has been running for 22.052547 min

20240920T044246 [CommandExec]:got command load ./Missions/Transport/keepstation.tl

20240920T044248 [CommandExec]:Loaded ./Missions/Transport/keepstation.tl id=keepstation

20240920T044253 [CommandExec]:got command set keepstation.NeedCommsTime 10 minute

20240920T044253 [CommandExec]:got command set keepstation.Latitude 36.712468 degree

20240920T044253 [CommandExec]:got command set keepstation.Longitude -122.1869 degree

20240920T044253 [CommandExec]:got command run

20240920T044253 [CommandExec]:Running

20240920T044253 [MissionManager]:Started mission keepstation

20240920T044255 [keepstation:StandardEnvelopes:A.AltitudeEnvelope]:Altitude Measurement is not Active.

20240920T044409 [keepstation:TransitToStation:Wpt1.Waypoint]:Navigating to waypoint: 36.712467,-122.186897

20240920T044722 [keepstation:TransitToStation:Wpt1.Waypoint]:Reached waypoint: 36.712467,-122.186897

20240920T050000 [CommandExec]:got command load ./Missions/Science/circle_sample.xml

20240920T050005 [MissionManager]:Slate does not contain CTD_NeilBrown.bin_mean_sea_water_temperature

20240920T050005 [MissionManager]:Slate does not contain celsius

20240920T050010 [CommandExec]:Loaded ./Missions/Science/circle_sample.xml id=CircleSample

20240920T050011 [MissionManager]:Started mission Default

20240920T050024 [CommandExec]:got command set CircleSample.MissionTimeout 4 hour

20240920T050024 [CommandExec]:got command set CircleSample.AcousticTrackingTimeout 0.5 hour

20240920T050024 [CommandExec]:got command set CircleSample.NeedCommsMissionStart 0 bool

20240920T050024 [CommandExec]:got command set CircleSample.AcousticTargetDepth 0 meter

20240920T050039 [CommandExec]:got command set CircleSample.SendSampleResultToWG 1 bool

20240920T050039 [CommandExec]:got command set CircleSample.WaitBeforeFiring 0 minute

20240920T050039 [CommandExec]:got command set CircleSample.MaxWaitMustFire 120 minute

20240920T050039 [CommandExec]:got command set CircleSample.DepthCircle 150 meter

20240920T050039 [CommandExec]:got command set CircleSample.CircleYoYoMinDepth 10 meter

20240920T050047 [NAL9602]:Failed to initiate SBD session. Error code: 2

20240920T050053 [CommandExec]:got command set CircleSample.CircleYoYoMaxDepth 280 meter

20240920T050053 [CommandExec]:got command set CircleSample.MaxDepth 290 meter

20240920T050053 [CommandExec]:got command set CircleSample.CenterLatitude 36.712468 degree

20240920T050053 [CommandExec]:got command set CircleSample.CenterLongitude -122.1869 degree

20240920T050053 [CommandExec]:got command set CircleSample.TrackingUpdatePeriod 65 second

20240920T050101 [CommandExec]:got command set CircleSample.NumberOfStartingFixesToIgnore 1 count

20240920T050101 [CommandExec]:got command set CircleSample:NeedComms.CommsTimeout 15 minute

20240920T050101 [CommandExec]:got command run

20240920T050101 [CommandExec]:Running

20240920T050101 [MissionManager]:Started mission CircleSample

20240920T050101 [CircleSample:AbortDrift:B.AbortDrift]:Acoustic timeout set to: 0.50 hours.

20240920T050103 [CircleSample:L.AltitudeEnvelope]:Altitude Measurement is not Active.

20240920T050103 [CircleSample:StandardEnvelopes:A.AltitudeEnvelope]:Altitude Measurement is not Active.

20240920T050103 [CircleSample:MissionStartNoComms:A]:Mission start no comms.

20240920T050105 [CircleSample:CircleAndSample:B]:Circle around location 36.712467 arcdeg , -122.186897 arcdeg , at radius = 20.000000 m and depth = 150.000000 m .

20240920T050105 [CTD_Seabird]:Failed to parse device response: #

20240920T050107 [CircleSample:SetSampleOptions:E]:Set CartridgeType (if ESP), SettleDuration to -1.000000 count , 5.000000 min .

20240920T050848 [DATMMP]:Timeout waiting for range request10.082657

20240920T050848 [DATMMP]:Timeout waiting for range request10.334622

20240920T050848 [DATMMP]:Timeout waiting for range request10.586592

20240920T050850 [DATMMP]:5:Command error: timeout

20240920T051106 time since start or last firing(= 10.033087 min ) is longer than MaxWaitFirstSample (= 10.000000 min ) for the 1st sample, or longer than MaxWaitMustFire (= 120.000000 min ) for non-1st samples. Firing sample No. 1.000000 count

20240920T051707 [CircleSample:SampleAtDepth:sample:SampleWrapper:B]:At 150.070419 m , settling for 5.000000 min

20240920T051941 [DATMMP]:5:Command error: timeout

20240920T051953 [BPC1]:BPC1A: No match for serial number 1717 in BPC1A's battery stick inventory (sticks 1-31 in onboard configuration file).

20240920T052151 [DATMMP]:5:Command error: timeout

20240920T052209 [ESPComponent]:Setting regex for ESP Log summary: 'Selecting

20240920T052220 [ESPComponent]:Starting PPPD with command:/sbin/pppd xonxoff asyncmap A0000 /dev/ttyTX1 linkname esp noauth local lock 115200 10.89.5.2:10.89.5.3 persist maxfail 0 holdoff 10 lcp-echo-interval 60 lcp-echo-failure 3 proxyarp ktune deflate 12 ms-dns 8.8.8.8

20240920T052220 [ESPComponent]:Waiting for ESP to connect (timeout=150.0000)

20240920T052311 [ESPComponent]:ESP has connected as client

20240920T052312 [ESPComponent]:[sample #1] Setting cartridge argument to -1

20240920T052312 [ESPComponent]:[sample #1] ESP sampling sequence starting. Sampling state: S_WAITING_INITIAL_PROMPT

20240920T052312 sampling at 149.520172 m in 9.270014 degC water with 0.070720 ug/l chlorophyll fluorescence.

20240920T052313 [ESPComponent]:[sample #1] ESP sampling state: S_PREPARING_SHOW_LOG

20240920T052313 [ESPComponent]:[sample #1] ESP sampling state: S_PREPARING_SHOW_STATUS

20240920T052315 [ESPComponent]:[sample #1] ESP sampling state: S_LOADING_CARTRIDGE

20240920T052346 [ESPComponent]:[sample #1] ESP sampling state: S_WAITING_FOR_PRIMING (@58,aRNAl_bac)

20240920T052349 [ESPComponent]:[sample #1] ESP sampling state: S_PRIMING (@100.0)

20240920T052349 [ESPComponent]:Filtering timeoutMinutes=94.169998 issuedCmd_=Cmd.startFiltering

20240920T052350 [ESPComponent]:[sample #1] ESP sampling state: S_WAITING_FOR_FILTERING (@100.0)

20240920T052645 [ESPComponent]:[sample #1] ESP sampling state: S_FILTERING (@0.0)

20240920T052646 [ESPComponent]:[sample #1] ESP sampling state: S_WAITING_FOR_PAUSED (@0.0)

20240920T054151 [CTD_Seabird]:Failed to parse device response: 10,1658.00#

20240920T061442 [CTD_Seabird]:Failed to parse device response: 41,1651.95#

20240920T061451 [ESPComponent]:[sample #1] ESP sampling state: S_PAUSED (@1000.0)

20240920T061452 [ESPComponent]:[sample #1] ESP sampling state: S_PROCESSING (@1000.0)

20240920T061454 [ESPComponent]:Processing timeoutMinutes=30.000000 issuedCmd_=Cmd.startProcessing

20240920T061454 [ESPComponent]:[sample #1] ESP sampling state: S_WAITING_FOR_PROCESSED (@58,aRNAl_bac)

20240920T061629 [ESPComponent]:[sample #1] ESP sampling state: S_STOPPING (@58,aRNAl_bac)

20240920T061637 [ESPComponent]:Syncing ESP logs with command: rsync -azPq -e 'ssh -o StrictHostKeyChecking=no' --timeout=60 esp@esp:'/var/log/esp/real /var/log/esp/real.out /var/log/esp/real.slot /var/log/esp/*.spr*' /LRAUV/ESPlogs &

20240920T061637 [ESPComponent]:[sample #1] ESP sampling state: S_STOPPED

20240920T062137 [ESPComponent]:[sample #1] ESP sampling sequence completed normally.

20240920T062138 [ESPComponent]:[sample #1] ESP log summary report (2 messages):#@22:23:25.02 Selecting Cartridge 58#@23:14:50.10 Sampled 1000.0ml#

20240920T062140 [CircleSample:SendSampleInfo:SampleInfo:C]:CntSamples = 1.000000 count

20240920T062140 [CircleSample:SendSampleInfo:SampleInfo:D]:data element is not active.

20240920T062141 [CircleSample:SendSampleInfo:SampleInfo:F]:data element is not active.

20240920T062141 [CircleSample:SendSampleInfo:SampleInfo:G]:Universal:depth = 149.764160 m

20240920T062147 [CircleSample:SetSampleOptions:E]:Set CartridgeType (if ESP), SettleDuration to -1.000000 count , 1.000000 min .

20240920T062149 [ElevatorServo]:Overload Error

20240920T062149 [ElevatorServo]:Hardware Fault

20240920T062149 [CBIT]:Hardware Fault in component: ElevatorServo

20240920T062222 [DATMMP]:Ack receipt timeout failure.

20240920T062223 [DATMMP]:10:Error talking to DAT device_busy

20240920T062233 [DATMMP]:Buffer send receipt timeout failure.

20240920T062316 [DATMMP]:Ack receipt timeout failure.

20240920T062920 [CTD_Seabird]:Failed to parse device response: .32#

20240920T064757 [CTD_Seabird]:Failed to parse device response: 26,1562.84#

20240920T070825 [ThrusterHE]:Could not get status:serial timeout

20240920T071109 time since start or last firing(= 120.030998 min ) is longer than MaxWaitFirstSample (= 10.000000 min ) for the 1st sample, or longer than MaxWaitMustFire (= 120.000000 min ) for non-1st samples. Firing sample No. 2.000000 count

20240920T071649 [CircleSample:SampleAtDepth:sample:SampleWrapper:B]:At 150.273239 m , settling for 1.000000 min

20240920T071801 [ESPComponent]:Starting PPPD with command:/sbin/pppd xonxoff asyncmap A0000 /dev/ttyTX1 linkname esp noauth local lock 115200 10.89.5.2:10.89.5.3 persist maxfail 0 holdoff 10 lcp-echo-interval 60 lcp-echo-failure 3 proxyarp ktune deflate 12 ms-dns 8.8.8.8

20240920T071801 [ESPComponent]:Waiting for ESP to connect (timeout=150.0000)

20240920T071849 [ESPComponent]:ESP has connected as client

20240920T071850 [ESPComponent]:[sample #2] Setting cartridge argument to -1

20240920T071850 [ESPComponent]:[sample #2] ESP sampling sequence starting. Sampling state: S_WAITING_INITIAL_PROMPT

20240920T071850 sampling at 150.618973 m in 9.363367 degC water with 0.071760 ug/l chlorophyll fluorescence.

20240920T071851 [ESPComponent]:[sample #2] ESP sampling state: S_PREPARING_SHOW_LOG

20240920T071851 [ESPComponent]:[sample #2] ESP sampling state: S_PREPARING_SHOW_STATUS

20240920T071853 [ESPComponent]:[sample #2] ESP sampling state: S_LOADING_CARTRIDGE

20240920T071924 [ESPComponent]:[sample #2] ESP sampling state: S_WAITING_FOR_PRIMING (@57,aRNAl_bac)

20240920T071927 [ESPComponent]:[sample #2] ESP sampling state: S_PRIMING (@100.0)

20240920T071927 [ESPComponent]:Filtering timeoutMinutes=94.169998 issuedCmd_=Cmd.startFiltering

20240920T071927 [ESPComponent]:[sample #2] ESP sampling state: S_WAITING_FOR_FILTERING (@100.0)

20240920T072224 [ESPComponent]:[sample #2] ESP sampling state: S_FILTERING (@0.0)

20240920T072224 [ESPComponent]:[sample #2] ESP sampling state: S_WAITING_FOR_PAUSED (@0.0)

20240920T072510 [CTD_Seabird]:Failed to parse device response: 7,3.65669,1683.28#

20240920T073506 [RudderServo]:getPosition uart error serial timeout

20240920T073506 [RudderServo]:Rudder uart error - getPosition..serial timeout

20240920T073506 [RudderServo]:Communications Fault

20240920T073506 [CBIT]:Communications Fault in component: RudderServo

20240920T074639 [CTD_Seabird]:Failed to parse device response: .6,1674.05#

20240920T074645 [ThrusterHE]:getSpeed error serial timeout

20240920T074645 [ThrusterHE]:Thruster uart error: serial timeout

20240920T074645 [ThrusterHE]:Communications Fault

20240920T074645 [CBIT]:Communications Fault in component: ThrusterHE

20240920T081009 [ESPComponent]:[sample #2] ESP sampling state: S_PAUSED (@1000.0)

20240920T081010 [ESPComponent]:[sample #2] ESP sampling state: S_PROCESSING (@1000.0)

20240920T081012 [ESPComponent]:Processing timeoutMinutes=30.000000 issuedCmd_=Cmd.startProcessing

20240920T081012 [ESPComponent]:[sample #2] ESP sampling state: S_WAITING_FOR_PROCESSED (@57,aRNAl_bac)

20240920T081147 [ESPComponent]:[sample #2] ESP sampling state: S_STOPPING (@57,aRNAl_bac)

20240920T081155 [ESPComponent]:Syncing ESP logs with command: rsync -azPq -e 'ssh -o StrictHostKeyChecking=no' --timeout=60 esp@esp:'/var/log/esp/real /var/log/esp/real.out /var/log/esp/real.slot /var/log/esp/*.spr*' /LRAUV/ESPlogs &

20240920T081155 [ESPComponent]:[sample #2] ESP sampling state: S_STOPPED

20240920T081655 [ESPComponent]:[sample #2] ESP sampling sequence completed normally.

20240920T081655 [ESPComponent]:[sample #2] ESP log summary report (2 messages):#@00:19:03.14 Selecting Cartridge 57#@01:10:08.30 Sampled 1000.0ml#

20240920T081658 [CircleSample:SendSampleInfo:SampleInfo:C]:CntSamples = 2.000000 count

20240920T081658 [CircleSample:SendSampleInfo:SampleInfo:D]:data element is not active.

20240920T081659 [CircleSample:SendSampleInfo:SampleInfo:F]:data element is not active.

20240920T081659 [CircleSample:SendSampleInfo:SampleInfo:G]:Universal:depth = 150.771957 m

20240920T081703 [MissionManager]:Started mission Default

20240920T081740 [DATMMP]:Ack receipt timeout failure.

20240920T082208 [NAL9602]:GPS failed to acquire within timeout.

20240920T082209 [CBIT]:Data Fault in component: NAL9602

20240920T082209 [NAL9602]:LCB fault: LCB Watchdog Reset. Current Limiter Activated.

20240920T082210 [ElevatorServo]:Overload Error

20240920T082210 [ElevatorServo]:Hardware Fault

20240920T082210 [CBIT]:Hardware Fault in component: ElevatorServo

20240920T082309 [CommandExec]:got command schedule "load Transport/keepstation.tl;set keepstation.NeedCommsTime 10 min;set keepstation.Latitude 36.712468 degree;set keepstation.Longitude -122.1869 degree;run"

20240920T082309 [CommandExec]:Scheduled #5: "load Transport/keepstation.tl;set keepstation.NeedCommsTime 10 min;set keepstation.Latitude 36.712468 degree;set keepstation.Longitude -122.1869 degree;run", AFTER MISSION

20240920T082309 [CommandExec]:got command load ./Missions/Transport/keepstation.tl

20240920T082311 [CommandExec]:Loaded ./Missions/Transport/keepstation.tl id=keepstation

20240920T082318 [CommandExec]:got command set keepstation.NeedCommsTime 10 minute

20240920T082318 [CommandExec]:got command set keepstation.Latitude 36.712468 degree

20240920T082318 [CommandExec]:got command set keepstation.Longitude -122.1869 degree

20240920T082318 [CommandExec]:got command run

20240920T082318 [CommandExec]:Running

20240920T082318 [MissionManager]:Started mission keepstation

20240920T082320 [keepstation:StandardEnvelopes:A.AltitudeEnvelope]:Altitude Measurement is not Active.

20240920T082853 [NAL9602]:Failed to initiate SBD session. Error code: 2

20240920T083828 [keepstation:TransitToStation:Wpt1.Waypoint]:Navigating to waypoint: 36.712467,-122.186897

20240920T085732 [keepstation:TransitToStation:Wpt1.Waypoint]:Reached waypoint: 36.712467,-122.186897

20240920T090242 [CBIT]:Beginning ground fault scan

20240920T110800 [CommandExec]:got command stop

20240920T110800 [CommandExec]:Scheduling is paused

20240920T110800 [MissionManager]:Started mission Default

20240920T111012 [NAL9602]:Inadequate Iridium signal strength reported: 0

20240920T111112 [CommandExec]:got command schedule resume

20240920T111112 [CommandExec]:Scheduling is resumed

20240920T111132 [CommandExec]:got command configSet NAL9602.fastGPSFix 0 bool persist

20240920T111132 [CommandExec]:got command configSet Express none DATMMP.acoustic_contact_range persist

20240920T111716 [Default:CheckIn:E]:Default mission has been running for 9.260454 min

20240920T111749 [CommandExec]:got command schedule 20240920T120000 "load Science/circle_sample.xml;set CircleSample.NumSamplers 55 count;set CircleSample.MissionTimeout 120 h;set CircleSample.AcousticTrackingTimeout 0.5 h;set CircleSample.NeedCommsMissionStart 0 bool" 4g4me 1 4.000000

20240920T111749 [CommandExec]:Scheduling command #1 of 4 with id=4g4me

20240920T111749 [CommandExec]:Scheduled #6 (#1 of 4 with id='4g4me'): "load Science/circle_sample.xml;set CircleSample.NumSamplers 55 count;set CircleSample.MissionTimeout 120 h;set CircleSample.AcousticTrackingTimeout 0.5 h;set CircleSample.NeedCommsMissionStart 0 bool", AT TIME: 2024-09-20T12:00:00Z

20240920T111807 [CommandExec]:got command schedule 20240920T120000 "set CircleSample.AcousticTargetDepth 0 m;set CircleSample.SendSampleResultToWG 1 bool;set CircleSample.WaitBeforeFiring 0 min;set CircleSample.MaxWaitMustFire 120 min;set CircleSample.DepthCircle 150 m" 4g4me 2 4.000000

20240920T111807 [CommandExec]:Scheduling command #2 of 4 with id=4g4me

20240920T111807 [CommandExec]:Scheduled #7 (#2 of 4 with id='4g4me'): "set CircleSample.AcousticTargetDepth 0 m;set CircleSample.SendSampleResultToWG 1 bool;set CircleSample.WaitBeforeFiring 0 min;set CircleSample.MaxWaitMustFire 120 min;set CircleSample.DepthCircle 150 m", AT TIME: 2024-09-20T12:00:00Z

20240920T111821 [CommandExec]:got command schedule 20240920T120000 "set CircleSample.CircleYoYoMinDepth 10 m;set CircleSample.CircleYoYoMaxDepth 280 m;set CircleSample.MaxDepth 290 m;set CircleSample.CenterLatitude 36.712468 degree;set CircleSample.CenterLongitude -122.1869 degree" 4g4me 3 4.000000

20240920T111821 [CommandExec]:Scheduling command #3 of 4 with id=4g4me

20240920T111821 [CommandExec]:Scheduled #8 (#3 of 4 with id='4g4me'): "set CircleSample.CircleYoYoMinDepth 10 m;set CircleSample.CircleYoYoMaxDepth 280 m;set CircleSample.MaxDepth 290 m;set CircleSample.CenterLatitude 36.712468 degree;set CircleSample.CenterLongitude -122.1869 degree", AT TIME: 2024-09-20T12:00:00Z

20240920T111835 [CommandExec]:got command schedule 20240920T120000 "set CircleSample.IntervalRestartLogs 12 h;set CircleSample.TrackingUpdatePeriod 65 s;set CircleSample.NumberOfStartingFixesToIgnore 1 count;set CircleSample:NeedComms.CommsTimeout 15 min;run" 4g4me 4 4.000000

20240920T111835 [CommandExec]:Scheduled #9 (#4 of 4 with id='4g4me'): "set CircleSample.IntervalRestartLogs 12 h;set CircleSample.TrackingUpdatePeriod 65 s;set CircleSample.NumberOfStartingFixesToIgnore 1 count;set CircleSample:NeedComms.CommsTimeout 15 min;run", AT TIME: 2024-09-20T12:00:00Z

20240920T120000 [CommandExec]:got command load ./Missions/Science/circle_sample.xml

20240920T120003 [MissionManager]:Slate does not contain CTD_NeilBrown.bin_mean_sea_water_temperature

20240920T120003 [MissionManager]:Slate does not contain celsius

20240920T120007 [CommandExec]:Loaded ./Missions/Science/circle_sample.xml id=CircleSample

20240920T120018 [CommandExec]:got command set CircleSample.NumSamplers 55 count

20240920T120018 [CommandExec]:got command set CircleSample.MissionTimeout 120 hour

20240920T120018 [CommandExec]:got command set CircleSample.AcousticTrackingTimeout 0.5 hour

20240920T120018 [CommandExec]:got command set CircleSample.NeedCommsMissionStart 0 bool

20240920T120033 [CommandExec]:got command set CircleSample.AcousticTargetDepth 0 meter

20240920T120033 [CommandExec]:got command set CircleSample.SendSampleResultToWG 1 bool

20240920T120033 [CommandExec]:got command set CircleSample.WaitBeforeFiring 0 minute

20240920T120033 [CommandExec]:got command set CircleSample.MaxWaitMustFire 120 minute

20240920T120033 [CommandExec]:got command set CircleSample.DepthCircle 150 meter

20240920T120046 [CommandExec]:got command set CircleSample.CircleYoYoMinDepth 10 meter

20240920T120046 [CommandExec]:got command set CircleSample.CircleYoYoMaxDepth 280 meter

20240920T120046 [CommandExec]:got command set CircleSample.MaxDepth 290 meter

20240920T120046 [CommandExec]:got command set CircleSample.CenterLatitude 36.712468 degree

20240920T120046 [CommandExec]:got command set CircleSample.CenterLongitude -122.1869 degree

20240920T120100 [CommandExec]:got command set CircleSample.IntervalRestartLogs 12 hour

20240920T120100 [CommandExec]:got command set CircleSample.TrackingUpdatePeriod 65 second

20240920T120100 [CommandExec]:got command set CircleSample.NumberOfStartingFixesToIgnore 1 count

20240920T120100 [CommandExec]:got command set CircleSample:NeedComms.CommsTimeout 15 minute

20240920T120100 [MissionManager]:Started mission CircleSample

20240920T120100 [CircleSample:AbortDrift:B.AbortDrift]:Acoustic timeout set to: 0.50 hours.

20240920T120101 [CircleSample:L.AltitudeEnvelope]:Altitude Measurement is not Active.

20240920T120101 [CircleSample:StandardEnvelopes:A.AltitudeEnvelope]:Altitude Measurement is not Active.

20240920T120102 [CircleSample:MissionStartNoComms:A]:Mission start no comms.

20240920T120103 [CircleSample:CircleAndSample:B]:Circle around location 36.712467 arcdeg , -122.186897 arcdeg , at radius = 20.000000 m and depth = 150.000000 m .

20240920T120103 [CTD_Seabird]:Failed to parse device response: #

20240920T120105 [CircleSample:SetSampleOptions:E]:Set CartridgeType (if ESP), SettleDuration to -1.000000 count , 5.000000 min .

20240920T121104 time since start or last firing(= 10.027973 min ) is longer than MaxWaitFirstSample (= 10.000000 min ) for the 1st sample, or longer than MaxWaitMustFire (= 120.000000 min ) for non-1st samples. Firing sample No. 1.000000 count

20240920T121127 [CircleSample:SampleAtDepth:sample:SampleWrapper:B]:At 149.807144 m , settling for 5.000000 min

20240920T121639 [ESPComponent]:Starting PPPD with command:/sbin/pppd xonxoff asyncmap A0000 /dev/ttyTX1 linkname esp noauth local lock 115200 10.89.5.2:10.89.5.3 persist maxfail 0 holdoff 10 lcp-echo-interval 60 lcp-echo-failure 3 proxyarp ktune deflate 12 ms-dns 8.8.8.8

20240920T121640 [ESPComponent]:Waiting for ESP to connect (timeout=150.0000)

20240920T121731 [ESPComponent]:ESP has connected as client

20240920T121732 [ESPComponent]:[sample #3] Setting cartridge argument to -1

20240920T121732 [ESPComponent]:[sample #3] ESP sampling sequence starting. Sampling state: S_WAITING_INITIAL_PROMPT

20240920T121732 sampling at 149.650208 m in 9.299982 degC water with 0.073840 ug/l chlorophyll fluorescence.

20240920T121733 [ESPComponent]:[sample #3] ESP sampling state: S_PREPARING_SHOW_LOG

20240920T121733 [ESPComponent]:[sample #3] ESP sampling state: S_PREPARING_SHOW_STATUS

20240920T121735 [ESPComponent]:[sample #3] ESP sampling state: S_LOADING_CARTRIDGE

20240920T121807 [ESPComponent]:[sample #3] ESP sampling state: S_WAITING_FOR_PRIMING (@56,aRNAl_bac)

20240920T121810 [ESPComponent]:[sample #3] ESP sampling state: S_PRIMING (@100.0)

20240920T121810 [ESPComponent]:Filtering timeoutMinutes=94.169998 issuedCmd_=Cmd.startFiltering

20240920T121810 [ESPComponent]:[sample #3] ESP sampling state: S_WAITING_FOR_FILTERING (@100.0)

20240920T122103 [ESPComponent]:[sample #3] ESP sampling state: S_FILTERING (@0.0)

20240920T122104 [ESPComponent]:[sample #3] ESP sampling state: S_WAITING_FOR_PAUSED (@0.0)

20240920T125330 [CTD_Seabird]:Failed to parse device response: 150.27,53#

20240920T130739 [ESPComponent]:[sample #3] ESP sampling state: S_PAUSED (@1000.0)

20240920T130740 [ESPComponent]:[sample #3] ESP sampling state: S_PROCESSING (@1000.0)

20240920T130742 [ESPComponent]:Processing timeoutMinutes=30.000000 issuedCmd_=Cmd.startProcessing

20240920T130742 [ESPComponent]:[sample #3] ESP sampling state: S_WAITING_FOR_PROCESSED (@56,aRNAl_bac)

20240920T130917 [ESPComponent]:[sample #3] ESP sampling state: S_STOPPING (@56,aRNAl_bac)

20240920T130925 [ESPComponent]:Syncing ESP logs with command: rsync -azPq -e 'ssh -o StrictHostKeyChecking=no' --timeout=60 esp@esp:'/var/log/esp/real /var/log/esp/real.out /var/log/esp/real.slot /var/log/esp/*.spr*' /LRAUV/ESPlogs &

20240920T130925 [ESPComponent]:[sample #3] ESP sampling state: S_STOPPED

20240920T131425 [ESPComponent]:[sample #3] ESP sampling sequence completed normally.

20240920T131425 [ESPComponent]:[sample #3] ESP log summary report (2 messages):#@05:17:45.65 Selecting Cartridge 56#@06:07:38.40 Sampled 1000.0ml#

20240920T131428 [CircleSample:SendSampleInfo:SampleInfo:C]:CntSamples = 1.000000 count

20240920T131428 [CircleSample:SendSampleInfo:SampleInfo:D]:data element is not active.

20240920T131429 [CircleSample:SendSampleInfo:SampleInfo:F]:data element is not active.

20240920T131429 [CircleSample:SendSampleInfo:SampleInfo:G]:Universal:depth = 150.425186 m

20240920T131436 [BPC1]:BPC1A: No match for serial number 1717 in BPC1A's battery stick inventory (sticks 1-31 in onboard configuration file).

20240920T141926 [CTD_Seabird]:Failed to parse device response: 151.49,9.180.85#

20240920T142127 [ESPComponent]:In state S_WAITING_FOR_FILTERING got exception while awaiting completion of cmd='Cmd.startFiltering' exception=<>. Elapsed time since command issued: 242.8124

20240920T142128 [ESPComponent]:[sample #4] ESP sampling state: S_STOPPING (@0.0)

20240920T142636 [ESPComponent]:[sample #4] ESP sampling sequence terminated with error: In state S_WAITING_FOR_FILTERING got exception while awaiting completion of cmd='Cmd.startFiltering' exception=<>. Elapsed time since command issued: 242.8124

20240920T142636 [ESPComponent]:Communications Fault

20240920T142636 [CommandExec]:Scheduling is paused

20240920T142636 [CBIT]:Communications Fault in component: ESPComponent

20240920T142636 [ESPComponent]:[sample #4] ESP log summary report (10 messages):#@07:17:03.92 Selecting Cartridge 55#@07:20:28.97 Cartridge::Sampler::Leaky in FILTERING -- Isolated cartridge pressure fell by 36% to 147.4psia#@07:20:28.98 Retry #1 of 2#@07:20:29.04 Cmd::SpareCartridge in FILTERING -- 4 spares remaining#@07:20:29.11 Selecting Cartridge 54#@07:20:58.94 Cartridge::Sampler::Leaky in FILTERING -- Isolated cartridge pressure fell by 36% to 148.3psia#@07:20:58.96 Retry #2 of 2#@07:20:59.01 Cmd::SpareCartridge in FILTERING -- 3 spares remaining#@07:20:59.07 Selecting Cartridge 53#@07:21:19.69 Cartridge::Sampler::Leaky in FILTERING -- Isolated cartridge pressure fell by 41% to 134.2psia#

20240920T143146 [ElevatorServo]:Overload Error

20240920T143146 [ElevatorServo]:Hardware Fault

20240920T143146 [CBIT]:Hardware Fault in component: ElevatorServo

20240920T143151 [BuoyancyServo]:getPosition uart error serial timeout

20240920T143151 [BuoyancyServo]:Buoyancy getPosition uart error.serial timeout

20240920T143151 [BuoyancyServo]:Communications Fault

20240920T143151 [CBIT]:Communications Fault in component: BuoyancyServo

20240920T145746 [CommandExec]:got command load ./Missions/Transport/keepstation.tl

20240920T145747 [CommandExec]:Loaded ./Missions/Transport/keepstation.tl id=keepstation

20240920T145754 [CommandExec]:got command set keepstation.NeedCommsTime 10 minute

20240920T145754 [CommandExec]:got command set keepstation.Latitude 36.712468 degree

20240920T145754 [CommandExec]:got command set keepstation.Longitude -122.1869 degree

20240920T145754 [MissionManager]:Started mission keepstation

20240920T145755 [keepstation:StandardEnvelopes:A.AltitudeEnvelope]:Altitude Measurement is not Active.

20240920T145849 [CommandExec]:got command schedule resume

20240920T145849 [CommandExec]:Scheduling is resumed

20240920T150209 [keepstation:TransitToStation:Wpt1.Waypoint]:Navigating to waypoint: 36.712467,-122.186897

20240920T150253 [CBIT]:Beginning ground fault scan

20240920T151335 [keepstation:TransitToStation:Wpt1.Waypoint]:Reached waypoint: 36.712467,-122.186897

20240920T151542 [CommandExec]:got command ! onESPclient preston -- ‘spare:5’

20240920T152929 [BPC1]:BPC1B: No match for serial number 1717 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).

20240920T153057 [CommandExec]:got command stop

20240920T153057 [CommandExec]:Scheduling is paused

20240920T153140 [CommandExec]:got command ! onESPclient preston -- 'spare:5'

20240920T153845 [CommandExec]:got command schedule 20240920T160000 "set CircleSample.IntervalRestartLogs 12 h;set CircleSample.TrackingUpdatePeriod 65 s;set CircleSample.NumberOfStartingFixesToIgnore 1 count;set CircleSample:NeedComms.CommsTimeout 15 min;run" 4gglz 4 4.000000

20240920T153845 [CommandExec]:Scheduling command #4 of 4 with id=4gglz

20240920T153845 [CommandExec]:Scheduled #10 (#4 of 4 with id='4gglz'): "set CircleSample.IntervalRestartLogs 12 h;set CircleSample.TrackingUpdatePeriod 65 s;set CircleSample.NumberOfStartingFixesToIgnore 1 count;set CircleSample:NeedComms.CommsTimeout 15 min;run", AT TIME: 2024-09-20T16:00:00Z

20240920T161931 [NAL9602]:Inadequate Iridium signal strength reported: 0

20240920T161933 [NAL9602]:Inadequate Iridium signal strength reported: 0

20240920T163426 [CommandExec]:got command schedule asap "load Science/circle_sample.xml;set CircleSample.NumSamplers 1 count;set CircleSample.MissionTimeout 120 h;set CircleSample.AcousticTrackingTimeout 0.5 h;set CircleSample.NeedCommsMissionStart 0 bool" 4gjc7 1 4.000000

20240920T163426 [CommandExec]:Scheduling command #1 of 4 with id=4gjc7

20240920T163426 [CommandExec]:Scheduled #11 (#1 of 4 with id='4gjc7'): "load Science/circle_sample.xml;set CircleSample.NumSamplers 1 count;set CircleSample.MissionTimeout 120 h;set CircleSample.AcousticTrackingTimeout 0.5 h;set CircleSample.NeedCommsMissionStart 0 bool", ASAP

20240920T163456 [CommandExec]:got command schedule asap "set CircleSample.AcousticTargetDepth 0 m;set CircleSample.SendSampleResultToWG 1 bool;set CircleSample.WaitBeforeFiring 0 min;set CircleSample.MaxWaitMustFire 120 min;set CircleSample.DepthCircle 150 m" 4gjc7 2 4.000000

20240920T163456 [CommandExec]:Scheduling command #2 of 4 with id=4gjc7

20240920T163456 [CommandExec]:Scheduled #12 (#2 of 4 with id='4gjc7'): "set CircleSample.AcousticTargetDepth 0 m;set CircleSample.SendSampleResultToWG 1 bool;set CircleSample.WaitBeforeFiring 0 min;set CircleSample.MaxWaitMustFire 120 min;set CircleSample.DepthCircle 150 m", ASAP

20240920T163528 [CommandExec]:got command schedule asap "set CircleSample.CircleYoYoMinDepth 10 m;set CircleSample.CircleYoYoMaxDepth 280 m;set CircleSample.MaxDepth 290 m;set CircleSample.CenterLatitude 36.712468 degree;set CircleSample.CenterLongitude -122.1869 degree" 4gjc7 3 4.000000

20240920T163528 [CommandExec]:Scheduling command #3 of 4 with id=4gjc7

20240920T163528 [CommandExec]:Scheduled #13 (#3 of 4 with id='4gjc7'): "set CircleSample.CircleYoYoMinDepth 10 m;set CircleSample.CircleYoYoMaxDepth 280 m;set CircleSample.MaxDepth 290 m;set CircleSample.CenterLatitude 36.712468 degree;set CircleSample.CenterLongitude -122.1869 degree", ASAP

20240920T163611 [CommandExec]:got command schedule asap "set CircleSample.IntervalRestartLogs 12 h;set CircleSample.TrackingUpdatePeriod 65 s;set CircleSample.NumberOfStartingFixesToIgnore 1 count;set CircleSample:NeedComms.CommsTimeout 15 min;run" 4gjc7 4 4.000000

20240920T163611 [CommandExec]:Scheduled #14 (#4 of 4 with id='4gjc7'): "set CircleSample.IntervalRestartLogs 12 h;set CircleSample.TrackingUpdatePeriod 65 s;set CircleSample.NumberOfStartingFixesToIgnore 1 count;set CircleSample:NeedComms.CommsTimeout 15 min;run", ASAP

20240920T163611 [CommandExec]:got command load ./Missions/Science/circle_sample.xml

20240920T163615 [MissionManager]:Slate does not contain CTD_NeilBrown.bin_mean_sea_water_temperature

20240920T163615 [MissionManager]:Slate does not contain celsius

20240920T163619 [CommandExec]:Loaded ./Missions/Science/circle_sample.xml id=CircleSample

20240920T163631 [CommandExec]:got command set CircleSample.NumSamplers 1 count

20240920T163631 [CommandExec]:got command set CircleSample.MissionTimeout 120 hour

20240920T163631 [CommandExec]:got command set CircleSample.AcousticTrackingTimeout 0.5 hour

20240920T163631 [CommandExec]:got command set CircleSample.NeedCommsMissionStart 0 bool

20240920T163646 [CommandExec]:got command set CircleSample.AcousticTargetDepth 0 meter

20240920T163646 [CommandExec]:got command set CircleSample.SendSampleResultToWG 1 bool

20240920T163646 [CommandExec]:got command set CircleSample.WaitBeforeFiring 0 minute

20240920T163646 [CommandExec]:got command set CircleSample.MaxWaitMustFire 120 minute

20240920T163646 [CommandExec]:got command set CircleSample.DepthCircle 150 meter

20240920T163700 [CommandExec]:got command set CircleSample.CircleYoYoMinDepth 10 meter

20240920T163700 [CommandExec]:got command set CircleSample.CircleYoYoMaxDepth 280 meter

20240920T163700 [CommandExec]:got command set CircleSample.MaxDepth 290 meter

20240920T163700 [CommandExec]:got command set CircleSample.CenterLatitude 36.712468 degree

20240920T163700 [CommandExec]:got command set CircleSample.CenterLongitude -122.1869 degree

20240920T163714 [CommandExec]:got command set CircleSample.IntervalRestartLogs 12 hour

20240920T163714 [CommandExec]:got command set CircleSample.TrackingUpdatePeriod 65 second

20240920T163714 [CommandExec]:got command set CircleSample.NumberOfStartingFixesToIgnore 1 count

20240920T163714 [CommandExec]:got command set CircleSample:NeedComms.CommsTimeout 15 minute

20240920T163714 [MissionManager]:Started mission CircleSample

20240920T163714 [CircleSample:AbortDrift:B.AbortDrift]:Acoustic timeout set to: 0.50 hours.

20240920T163715 [CircleSample:L.AltitudeEnvelope]:Altitude Measurement is not Active.

20240920T163715 [CircleSample:StandardEnvelopes:A.AltitudeEnvelope]:Altitude Measurement is not Active.

20240920T163716 [CircleSample:MissionStartNoComms:A]:Mission start no comms.

20240920T163717 [CircleSample:CircleAndSample:B]:Circle around location 36.712467 arcdeg , -122.186897 arcdeg , at radius = 20.000000 m and depth = 150.000000 m .

20240920T163718 [CTD_Seabird]:Failed to parse device response: #

20240920T165640 [CTD_Seabird]:Failed to parse device response: .65#

20240920T170546 [CTD_Seabird]:Failed to parse device response: .13#

20240920T172324 [ThrusterHE]:Could not get status:serial timeout

20240920T174243 [ThrusterHE]:getSpeed error serial timeout

20240920T174243 [ThrusterHE]:Thruster uart error: serial timeout

20240920T174243 [ThrusterHE]:Communications Fault

20240920T174243 [CBIT]:Communications Fault in component: ThrusterHE

20240920T175310 [DATMMP]:10:Error talking to DAT device_busy

20240920T175320 [DATMMP]:Buffer send receipt timeout failure.

20240920T180341 [NAL9602]:MT Queue status failed to be acquired within timeout. Will not retry this session.

20240920T180734 [CommandExec]:got command schedule asap "load Science/circle_sample.xml;set CircleSample.NumSamplers 52 count;set CircleSample.MissionTimeout 110 h;set CircleSample.AcousticTrackingTimeout 0.5 h;set CircleSample.NeedCommsMissionStart 0 bool" 4gnnc 1 4.000000

20240920T180734 [CommandExec]:Scheduling command #1 of 4 with id=4gnnc

20240920T180734 [CommandExec]:Scheduled #15 (#1 of 4 with id='4gnnc'): "load Science/circle_sample.xml;set CircleSample.NumSamplers 52 count;set CircleSample.MissionTimeout 110 h;set CircleSample.AcousticTrackingTimeout 0.5 h;set CircleSample.NeedCommsMissionStart 0 bool", ASAP

20240920T180809 [CommandExec]:got command schedule asap "set CircleSample.AcousticTargetDepth 0 m;set CircleSample.SendSampleResultToWG 1 bool;set CircleSample.WaitBeforeFiring 0 min;set CircleSample.MaxWaitMustFire 120 min;set CircleSample.DepthCircle 150 m" 4gnnc 2 4.000000

20240920T180809 [CommandExec]:Scheduling command #2 of 4 with id=4gnnc

20240920T180809 [CommandExec]:Scheduled #16 (#2 of 4 with id='4gnnc'): "set CircleSample.AcousticTargetDepth 0 m;set CircleSample.SendSampleResultToWG 1 bool;set CircleSample.WaitBeforeFiring 0 min;set CircleSample.MaxWaitMustFire 120 min;set CircleSample.DepthCircle 150 m", ASAP

20240920T180832 [CommandExec]:got command schedule asap "set CircleSample.CircleYoYoMinDepth 10 m;set CircleSample.CircleYoYoMaxDepth 280 m;set CircleSample.MaxDepth 290 m;set CircleSample.CenterLatitude 36.712468 degree;set CircleSample.CenterLongitude -122.1869 degree" 4gnnc 3 4.000000

20240920T180832 [CommandExec]:Scheduling command #3 of 4 with id=4gnnc

20240920T180832 [CommandExec]:Scheduled #17 (#3 of 4 with id='4gnnc'): "set CircleSample.CircleYoYoMinDepth 10 m;set CircleSample.CircleYoYoMaxDepth 280 m;set CircleSample.MaxDepth 290 m;set CircleSample.CenterLatitude 36.712468 degree;set CircleSample.CenterLongitude -122.1869 degree", ASAP

20240920T180857 [CommandExec]:got command schedule asap "set CircleSample.Settle1 1 min;set CircleSample.IntervalRestartLogs 12 h;set CircleSample.TrackingUpdatePeriod 65 s;set CircleSample.NumberOfStartingFixesToIgnore 1 count;set CircleSample:NeedComms.CommsTimeout 15 min;run" 4gnnc 4 4.000000

20240920T180857 [CommandExec]:Scheduled #18 (#4 of 4 with id='4gnnc'): "set CircleSample.Settle1 1 min;set CircleSample.IntervalRestartLogs 12 h;set CircleSample.TrackingUpdatePeriod 65 s;set CircleSample.NumberOfStartingFixesToIgnore 1 count;set CircleSample:NeedComms.CommsTimeout 15 min;run", ASAP

20240920T180916 [CommandExec]:got command set CircleSample.NumSamplers 52 count

20240920T180959 [CommandExec]:got command set CircleSample.Settle1 1 minute

20240920T180959 [CommandExec]:got command set CircleSample.IntervalRestartLogs 12 hour

20240920T181006 [NAL9602]:GPS failed to acquire within timeout.

20240920T181006 [CBIT]:Data Fault in component: NAL9602

20240920T183556 [ThrusterHE]:Could not get status:serial timeout

20240920T184241 [CTD_Seabird]:Failed to parse device response: 151.01,9.398.86#

20240920T185746 [CTD_Seabird]:Failed to parse device response: 150.48,9.388.72#

20240920T203029 [ThrusterHE]:getSpeed error serial timeout

20240920T203029 [ThrusterHE]:Thruster uart error: serial timeout

20240920T203029 [ThrusterHE]:Communications Fault

20240920T203029 [CBIT]:Communications Fault in component: ThrusterHE

20240920T204621 [CTD_Seabird]:Failed to parse device response: 5,3.67391,1741.42#

20240920T210304 [CBIT]:Beginning ground fault scan

20240920T211104 [RudderServo]:getPosition uart error serial timeout

20240920T211104 [RudderServo]:Rudder uart error - getPosition..serial timeout

20240920T211104 [RudderServo]:Communications Fault

20240920T211105 [CBIT]:Communications Fault in component: RudderServo

20240920T212159 [DATMMP]:10:Error talking to DAT device_busy

20240920T212209 [DATMMP]:Buffer send receipt timeout failure.

20240920T223703 [CTD_Seabird]:Failed to parse device response: 1,3.67001,1757.53#

20240920T225040 [CTD_Seabird]:Failed to parse device response: 151.08,9.5301,#

20240920T232234 [BPC1]:BPC1B: No match for serial number 1717 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).

20240920T234206 [CTD_Seabird]:Failed to parse device response: 1#

20240921T002809 [BPC1]:BPC1B: No match for serial number 1717 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).

20240921T012001 [ESPComponent]:LCB 1 fault: LCB Watchdog Reset. Current Limiter Activated.

20240921T012001 [ESPComponent]:Hardware Fault

20240921T012002 [CBIT]:Hardware Fault in component: ESPComponent

20240921T015422 [CTD_Seabird]:Failed to parse device response: 168.54,7#

20240921T024121 [CTD_Seabird]:Failed to parse device response: 151.12.72#

20240921T045639 [CTD_Seabird]:Failed to parse device response: 40#

20240921T052329 [ESPComponent]:[sample #11] ESP log summary report (6 messages):#@21:25:01.86 Selecting Cartridge 46#@21:28:19.34 Cartridge::Sampler::Leaky in FILTERING -- Isolated cartridge pressure fell by 38% to 143.3psia#@21:28:19.35 Retry #1 of 2#@21:28:19.40 Cmd::SpareCartridge in FILTERING -- 2 spares remaining#@21:28:19.46 Selecting Cartridge 45#@22:16:41.94 Sampled 1000.0ml#

20240921T060959 [CircleSample:CycleLogs:A:B]:Restarting logs.