tethys Path

trajectory

20180816T200444 [MissionManager]:Started mission Default

20180816T200601 [CommandLine]:got command schedule asap "load Maintenance/sample.xml;set sample.MissionTimeout 4 hour;set sample.Depth 2 meter;set sample.NumberOfSamples 3 count;set sample.WaitBeforeSample 3 second;set sample:SampleAtDepth.TargetDepth 2 meter" 32t4h 1 2.000000

20180816T200601 [CommandLine]:Scheduling command #1 of 2 with id=32t4h

20180816T200601 [CommandLine]:Scheduled #1 (#1 of 2 with id='32t4h'): "load Maintenance/sample.xml;set sample.MissionTimeout 4 hour;set sample.Depth 2 meter;set sample.NumberOfSamples 3 count;set sample.WaitBeforeSample 3 second;set sample:SampleAtDepth.TargetDepth 2 meter" ASAP

20180816T200607 [CommandLine]:got command schedule asap "set sample:SampleAtDepth.SettleTime 3 second;run " 32t4h 2 2.000000

20180816T200607 [CommandLine]:Scheduling command #2 of 2 with id=32t4h

20180816T200607 [CommandLine]:Scheduled #2 (#2 of 2 with id='32t4h'): "set sample:SampleAtDepth.SettleTime 3 second;run " ASAP

20180816T200607 [CommandLine]:got command load ./Missions/Maintenance/sample.xml

20180816T200607 [CommandLine]:Loaded ./Missions/Maintenance/sample.xml

20180816T200616 [CommandLine]:got command set sample.MissionTimeout 4.000000 hour

20180816T200616 [CommandLine]:got command set sample.Depth 2.000000 meter

20180816T200616 [CommandLine]:got command set sample.NumberOfSamples 3.000000 count

20180816T200616 [CommandLine]:got command set sample.WaitBeforeSample 3.000000 second

20180816T200616 [CommandLine]:got command set sample:SampleAtDepth.TargetDepth 2.000000 meter

20180816T200618 [CommandLine]:got command set sample:SampleAtDepth.SettleTime 3.000000 second

20180816T200618 [CommandLine]:got command run

20180816T200618 [CommandLine]:Running

20180816T200618 [MissionManager]:Started mission sample

20180816T200626 [CommandLine]:got command maintain sensor Depth_Keller.depth 2.000000 meter

20180816T200632 [ESPComponent]:Setting regex for ESP Log summary: 'Selecting Cartridge|Sampled|Error|Fail|Retry|Cmd::|Sampler::'

20180816T200632 [ESPComponent]:Powered ESP with command: ! echo 1 > /dev/loadA6

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

20180816T200632 [CommandLine]:got command ! echo 1 > /dev/loadA6

20180816T200633 [ESPComponent]:Waiting for ESP to connect (timeout=150.0000)

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

20180816T200717 [ESPComponent]:ESP has connected as client

20180816T200718 [ESPComponent]:[sample #1] ESP sampling sequence starting. Sampling state: S_WAITING_INITIAL_PROMPT

20180816T200718 [sample:SampleAtDepth:SampleWrapper:SampleESP:B]:ESP sampling at 2.000000 m in nan degC water with nan ug/l chlorophyll fluorescence.

20180816T200719 [ESPComponent]:[sample #1] ESP sampling state: S_PREPARING_SHOW_LOG

20180816T200720 [ESPComponent]:[sample #1] ESP sampling state: S_PREPARING_SHOW_STATUS

20180816T200720 [DeadReckonUsingMultipleVelocitySources]:Will not write estimated position: latitudeAccuracy_ = 0.000000, longitudeAccuracy_ = 0.000000, depthAccuracy_ = nan

20180816T200720 [DeadReckonUsingMultipleVelocitySources]:Software Fault

20180816T200720 [DeadReckonUsingSpeedCalculator]:Will not write estimated position: latitudeAccuracy_ = 0.000000, longitudeAccuracy_ = 0.000000, depthAccuracy_ = nan

20180816T200720 [DeadReckonUsingSpeedCalculator]:Software Fault

20180816T200720 [CBIT]:Software Fault in component: DeadReckonUsingMultipleVelocitySources

20180816T200720 [CBIT]:Software Fault in component: DeadReckonUsingSpeedCalculator

20180816T200721 [ESPComponent]:[sample #1] ESP sampling state: S_LOADING_CARTRIDGE

20180816T200754 [ESPComponent]:[sample #1] ESP sampling state: S_FILTERING

20180816T200757 [ESPComponent]:[sample #1] ESP sampling state: S_WAITING_FOR_PAUSED

20180816T201020 [DeadReckonUsingMultipleVelocitySources]:Will not write estimated position: latitudeAccuracy_ = 0.000000, longitudeAccuracy_ = 0.000000, depthAccuracy_ = nan

20180816T201020 [DeadReckonUsingMultipleVelocitySources]:Software Fault

20180816T201020 [DeadReckonUsingSpeedCalculator]:Will not write estimated position: latitudeAccuracy_ = 0.000000, longitudeAccuracy_ = 0.000000, depthAccuracy_ = nan

20180816T201020 [DeadReckonUsingSpeedCalculator]:Software Fault

20180816T201021 [CBIT]:Software Fault in component: DeadReckonUsingMultipleVelocitySources

20180816T201021 [CBIT]:Software Fault in component: DeadReckonUsingSpeedCalculator

20180816T201321 [DeadReckonUsingMultipleVelocitySources]:Will not write estimated position: latitudeAccuracy_ = 0.000000, longitudeAccuracy_ = 0.000000, depthAccuracy_ = nan

20180816T201321 [DeadReckonUsingMultipleVelocitySources]:Software Fault

20180816T201321 [DeadReckonUsingSpeedCalculator]:Will not write estimated position: latitudeAccuracy_ = 0.000000, longitudeAccuracy_ = 0.000000, depthAccuracy_ = nan

20180816T201321 [DeadReckonUsingSpeedCalculator]:Software Fault

20180816T201321 [CBIT]:Software Fault in component: DeadReckonUsingMultipleVelocitySources

20180816T201321 [CBIT]:Software Fault in component: DeadReckonUsingSpeedCalculator

20180816T202825 [CommandLine]:got command show stack

20180816T202825 [CommandLine]:Behavior Stack:#

20180816T202825 [sample]:Priority 0: sample:A.Pitch

20180816T202825 [sample]:Priority 1: sample:B.SetSpeed

20180816T202825 [sample:SampleAtDepth]:Priority 2: sample:SampleAtDepth:B.Pitch

20180816T202825 [sample:SampleAtDepth:SampleWrapper:SampleESP]:Priority 3: sample:SampleAtDepth:SampleWrapper:SampleESP:WaitForESP

20180816T204743 [ESPComponent]:[sample #1] ESP sampling state: S_PROCESSING

20180816T204746 [ESPComponent]:[sample #1] ESP sampling state: S_WAITING_FOR_PROCESSED

20180816T205909 [ESPComponent]:[sample #1] ESP sampling state: S_STOPPING

20180816T205935 [ESPComponent]:[sample #1] ESP sampling sequence completed normally.

20180816T205935 [ESPComponent]:[sample #1] ESP log summary report (2 messages):#@13:07:28.70 Selecting Cartridge 59#@13:47:34.41 Sampled 1000.0ml#

20180816T205942 [CommandLine]:got command ! echo 1 > /dev/loadA6

20180816T205942 [ESPComponent]:Powered ESP with command: ! echo 1 > /dev/loadA6

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

20180816T205942 [ESPComponent]:Waiting for ESP to connect (timeout=150.0000)

20180816T210028 [ESPComponent]:ESP has connected as client

20180816T210029 [ESPComponent]:[sample #2] ESP sampling sequence starting. Sampling state: S_WAITING_INITIAL_PROMPT

20180816T210030 [sample:SampleAtDepth:SampleWrapper:SampleESP:B]:ESP sampling at 2.000000 m in nan degC water with nan ug/l chlorophyll fluorescence.

20180816T210030 [ESPComponent]:[sample #2] ESP sampling state: S_PREPARING_SHOW_LOG

20180816T210030 [ESPComponent]:[sample #2] ESP sampling state: S_PREPARING_SHOW_STATUS

20180816T210032 [ESPComponent]:[sample #2] ESP sampling state: S_LOADING_CARTRIDGE

20180816T210105 [ESPComponent]:[sample #2] ESP sampling state: S_FILTERING

20180816T210108 [ESPComponent]:[sample #2] ESP sampling state: S_WAITING_FOR_PAUSED

20180816T211332 [RDI_Pathfinder]:only read 3 of 5 data items

20180816T211852 [RDI_Pathfinder]:only read 0 of 1 data item for BIT error

20180816T212722 [RDI_Pathfinder]:only read 3 of 5 data items

20180816T212752 [RDI_Pathfinder]:only read 4 of 5 data items

20180816T212800 [ESPComponent]:[sample #2] ESP sampling state: S_PROCESSING

20180816T212802 [ESPComponent]:[sample #2] ESP sampling state: S_WAITING_FOR_PROCESSED

20180816T213926 [ESPComponent]:[sample #2] ESP sampling state: S_STOPPING

20180816T213952 [ESPComponent]:[sample #2] ESP sampling sequence completed normally.

20180816T213952 [ESPComponent]:[sample #2] ESP log summary report (2 messages):#@14:00:39.84 Selecting Cartridge 58#@14:27:51.24 Sampled 1000.1ml#

20180816T213959 [ESPComponent]:Powered ESP with command: ! echo 1 > /dev/loadA6

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

20180816T213959 [CommandLine]:got command ! echo 1 > /dev/loadA6

20180816T214000 [ESPComponent]:Waiting for ESP to connect (timeout=150.0000)

20180816T214044 [ESPComponent]:ESP has connected as client

20180816T214045 [ESPComponent]:[sample #3] ESP sampling sequence starting. Sampling state: S_WAITING_INITIAL_PROMPT

20180816T214045 [sample:SampleAtDepth:SampleWrapper:SampleESP:B]:ESP sampling at 2.000000 m in nan degC water with nan ug/l chlorophyll fluorescence.

20180816T214046 [ESPComponent]:[sample #3] ESP sampling state: S_PREPARING_SHOW_LOG

20180816T214046 [ESPComponent]:[sample #3] ESP sampling state: S_PREPARING_SHOW_STATUS

20180816T214048 [ESPComponent]:[sample #3] ESP sampling state: S_LOADING_CARTRIDGE

20180816T214121 [ESPComponent]:[sample #3] ESP sampling state: S_FILTERING

20180816T214123 [ESPComponent]:[sample #3] ESP sampling state: S_WAITING_FOR_PAUSED

20180816T215801 [CommandLine]:got command show stack

20180816T215801 [CommandLine]:Behavior Stack:#

20180816T215801 [sample]:Priority 0: sample:A.Pitch

20180816T215801 [sample]:Priority 1: sample:B.SetSpeed

20180816T215801 [sample:SampleAtDepth]:Priority 2: sample:SampleAtDepth:B.Pitch

20180816T215801 [sample:SampleAtDepth:SampleWrapper:SampleESP]:Priority 3: sample:SampleAtDepth:SampleWrapper:SampleESP:WaitForESP

20180816T220200 [CommandLine]:got command show stack

20180816T220200 [CommandLine]:Behavior Stack:#

20180816T220200 [sample]:Priority 0: sample:A.Pitch

20180816T220200 [sample]:Priority 1: sample:B.SetSpeed

20180816T220200 [sample:SampleAtDepth]:Priority 2: sample:SampleAtDepth:B.Pitch

20180816T220200 [sample:SampleAtDepth:SampleWrapper:SampleESP]:Priority 3: sample:SampleAtDepth:SampleWrapper:SampleESP:WaitForESP

20180816T220858 [RDI_Pathfinder]:Failed to parse:##

20180816T220945 [CommandLine]:got command failComponent

20180816T220945 [CommandLine]:Failed components:

20180816T220945 [CommandLine]:No failed Components.

20180816T221901 [ESPComponent]:[sample #3] ESP sampling state: S_PROCESSING

20180816T221904 [ESPComponent]:[sample #3] ESP sampling state: S_WAITING_FOR_PROCESSED

20180816T223027 [ESPComponent]:[sample #3] ESP sampling state: S_STOPPING

20180816T223053 [ESPComponent]:[sample #3] ESP sampling sequence completed normally.

20180816T223053 [ESPComponent]:[sample #3] ESP log summary report (2 messages):#@14:40:55.89 Selecting Cartridge 57#@15:18:52.46 Sampled 1000.1ml#

20180816T223054 [MissionManager]:Started mission Default

20180816T223247 [RDI_Pathfinder]:only read 0 of 1 data item for altitude

20180816T223554 [VerticalControl]:Failure to ascend, stopping mission after 300.081543 seconds, depthRate=0.068760 m/s, pitch=88.996925 deg.

20180816T223554 [CommandLine]:Scheduling is paused

20180816T223923 [RDI_Pathfinder]:only read 0 of 1 data item for BIT error

20180816T224054 [VerticalControl]:Failure to ascend, dropping drop weight after 300.004974 seconds, depthRate=0.068760 m/s, pitch=88.992439 deg.

20180816T224734 [Default:B.GoToSurface]:Surfacing timeout. Returning calc satisfied.

20180816T224746 [NAL9602]:GPS failed to acquire within timeout.

20180816T224746 [CBIT]:Data Fault in component: NAL9602

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

20180816T225835 [Default:CheckIn:E]:Default mission has been running for 27.678569 min

20180816T225850 [NAL9602]:GPS failed to acquire within timeout.

20180816T225850 [CBIT]:Data Fault in component: NAL9602

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

20180816T230708 [RDI_Pathfinder]:only read 0 of 1 data item for BIT error

20180816T230858 [Default:CheckIn:E]:Default mission has been running for 38.066296 min

20180816T230942 [NAL9602]:Failed to receive proper response when querying signal strength for MT queue check.

20180816T230942 [CBIT]:Data Fault in component: NAL9602

20180816T231024 [NAL9602]:GPS failed to acquire within timeout.

20180816T231150 [RDI_Pathfinder]:only read 0 of 1 data item for altitude

20180816T231150 [RDI_Pathfinder]:Failed to parse:#:BD, 0.000#

20180816T231953 [Default:CheckIn:E]:Default mission has been running for 48.978585 min

20180816T232037 [NAL9602]:Failed to receive proper response when querying signal strength for MT queue check.