2023-05-12T19:24:14.280Z,1683919454.280 [CommandExec](IMPORTANT): got command restart logs 2023-05-12T19:24:32.070Z,1683919472.070 [DataOverHttps](INFO): Sending 109 bytes from file Logs/20230512T184208/Express0008.lzma 2023-05-12T19:24:33.073Z,1683919473.073 [DataOverHttps](INFO): Moved sent file to Logs/20230512T184208/Express0008.lzma.bak 2023-05-12T19:24:33.073Z,1683919473.073 [DataOverHttps](INFO): SBD MOMSN=18300521 2023-05-12T19:24:34.596Z,1683919474.596 [NAL9602](INFO): Not Powering down - fast GPS 2023-05-12T19:24:49.582Z,1683919489.582 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230512T191723/Courier0007.lzma 2023-05-12T19:24:50.569Z,1683919490.569 [DataOverHttps](INFO): Moved sent file to Logs/20230512T191723/Courier0007.lzma.bak 2023-05-12T19:24:50.569Z,1683919490.569 [DataOverHttps](INFO): SBD MOMSN=18300559 2023-05-12T19:24:58.838Z,1683919498.838 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6. 2023-05-12T19:24:58.841Z,1683919498.841 [BPC1](INFO): Received data from all battery sticks. 2023-05-12T19:25:06.901Z,1683919506.901 [DataOverHttps](INFO): Sending 1055 bytes from file Logs/20230512T191723/Express0001.lzma 2023-05-12T19:25:07.897Z,1683919507.897 [DataOverHttps](INFO): Moved sent file to Logs/20230512T191723/Express0001.lzma.bak 2023-05-12T19:25:07.897Z,1683919507.897 [DataOverHttps](INFO): SBD MOMSN=18300561 2023-05-12T19:25:23.960Z,1683919523.960 [DataOverHttps](INFO): Sending 636 bytes from file Logs/20230512T191723/Express0005.lzma 2023-05-12T19:25:24.961Z,1683919524.961 [DataOverHttps](INFO): Moved sent file to Logs/20230512T191723/Express0005.lzma.bak 2023-05-12T19:25:24.961Z,1683919524.961 [DataOverHttps](INFO): SBD MOMSN=18300586 2023-05-12T19:25:35.916Z,1683919535.916 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:25:35.916Z,1683919535.916 [DATMMP](INFO): doppler rx: x0 2023-05-12T19:25:35.917Z,1683919535.917 [DATMMP](INFO): Received message type: doppler 2023-05-12T19:25:35.917Z,1683919535.917 [DATMMP](INFO): Handled 2023-05-12T19:25:36.168Z,1683919536.168 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:25:36.169Z,1683919536.169 [DATMMP](INFO): timestamp rx: x1 x13 x19 x22 xA8A 2023-05-12T19:25:36.169Z,1683919536.169 [DATMMP](INFO): Rx dataTimestamp_ set to:1683919560.364544 2023-05-12T19:25:36.170Z,1683919536.170 [DATMMP](INFO): Rx ping set to:1683919536.168871 2023-05-12T19:25:36.170Z,1683919536.170 [DATMMP](INFO): Received message type: timestamp 2023-05-12T19:25:36.170Z,1683919536.170 [DATMMP](INFO): Handled 2023-05-12T19:25:36.433Z,1683919536.433 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:25:36.435Z,1683919536.435 [DATMMP](INFO): nav_stat rx: x0 x1 x1 2023-05-12T19:25:36.435Z,1683919536.435 [DATMMP](INFO): Received message type: nav_stat 2023-05-12T19:25:36.436Z,1683919536.436 [DATMMP](INFO): Handled 2023-05-12T19:25:36.684Z,1683919536.684 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:25:36.685Z,1683919536.685 [DATMMP](INFO): directional_debug rx: x174 xF1 x21 x1BA x2A60 x4471 x6C82 x67E3 2023-05-12T19:25:36.686Z,1683919536.686 [DATMMP](INFO): Received message type: directional_debug 2023-05-12T19:25:36.686Z,1683919536.686 [DATMMP](INFO): Handled 2023-05-12T19:25:36.936Z,1683919536.936 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:25:36.937Z,1683919536.937 [DATMMP](INFO): directional rx: x194 xE2 x468 xFF0F xB1A xFF0E x0 x6B3 x3 x1 x27B5966 x-43569E0 2023-05-12T19:25:36.939Z,1683919536.939 [DATMMP](INFO): Received message type: directional 2023-05-12T19:25:36.939Z,1683919536.939 [DATMMP](INFO): Handled 2023-05-12T19:25:37.188Z,1683919537.188 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:25:37.189Z,1683919537.189 [DATMMP](INFO): remote_header rx: x0 x62 x1 xA1 x1 xA xC x0 2023-05-12T19:25:37.189Z,1683919537.189 [DATMMP](INFO): DATA Src=12, Dst=10 2023-05-12T19:25:37.190Z,1683919537.190 [DATMMP](INFO): Received message type: remote_header 2023-05-12T19:25:37.190Z,1683919537.190 [DATMMP](INFO): Handled 2023-05-12T19:25:37.440Z,1683919537.440 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:25:37.442Z,1683919537.442 [DATMMP](INFO): acstats rx: xC x0 x0 x2D0 x23 x78 xAD xAC xD xFFFF x0 x22 x0 x0 2023-05-12T19:25:37.442Z,1683919537.442 [DATMMP](INFO): Received message type: acstats 2023-05-12T19:25:37.442Z,1683919537.442 [DATMMP](INFO): Handled 2023-05-12T19:25:37.692Z,1683919537.692 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:25:37.693Z,1683919537.693 [DATMMP](INFO): timestamp rx: x0 x13 x19 x23 x2216 2023-05-12T19:25:37.693Z,1683919537.693 [DATMMP](INFO): Received message type: timestamp 2023-05-12T19:25:37.693Z,1683919537.693 [DATMMP](INFO): Handled 2023-05-12T19:25:41.330Z,1683919541.330 [DataOverHttps](INFO): Sending 62 bytes from file Logs/20230512T191723/Express0008.lzma 2023-05-12T19:25:42.333Z,1683919542.333 [DataOverHttps](INFO): Moved sent file to Logs/20230512T191723/Express0008.lzma.bak 2023-05-12T19:25:42.333Z,1683919542.333 [DataOverHttps](INFO): SBD MOMSN=18300606 2023-05-12T19:25:51.312Z,1683919551.312 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:25:51.312Z,1683919551.312 [DATMMP](INFO): doppler rx: x0 2023-05-12T19:25:51.313Z,1683919551.313 [DATMMP](INFO): Received message type: doppler 2023-05-12T19:25:51.313Z,1683919551.313 [DATMMP](INFO): Handled 2023-05-12T19:25:51.565Z,1683919551.565 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:25:51.568Z,1683919551.568 [DATMMP](INFO): timestamp rx: x1 x13 x19 x31 x1A2A 2023-05-12T19:25:51.569Z,1683919551.569 [DATMMP](INFO): Rx dataTimestamp_ set to:1683919550.430080 2023-05-12T19:25:51.570Z,1683919551.570 [DATMMP](INFO): Rx ping set to:1683919551.568118 2023-05-12T19:25:51.571Z,1683919551.571 [DATMMP](INFO): Received message type: timestamp 2023-05-12T19:25:51.571Z,1683919551.571 [DATMMP](INFO): Handled 2023-05-12T19:25:52.068Z,1683919552.068 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:25:52.069Z,1683919552.069 [DATMMP](INFO): nav_stat rx: x0 x1 x1 2023-05-12T19:25:52.069Z,1683919552.069 [DATMMP](INFO): Received message type: nav_stat 2023-05-12T19:25:52.069Z,1683919552.069 [DATMMP](INFO): Handled 2023-05-12T19:25:52.320Z,1683919552.320 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:25:52.321Z,1683919552.321 [DATMMP](INFO): directional_debug rx: x188 x109 x21 x1D2 x31F0 x41F1 x6932 x7663 2023-05-12T19:25:52.322Z,1683919552.322 [DATMMP](INFO): Received message type: directional_debug 2023-05-12T19:25:52.322Z,1683919552.322 [DATMMP](INFO): Handled 2023-05-12T19:25:52.572Z,1683919552.572 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:25:52.574Z,1683919552.574 [DATMMP](INFO): directional rx: x1AA xF6 x454 xFEF7 xB04 xFEF6 x0 x6B2 x3 x0 x27B5966 x-43569E0 2023-05-12T19:25:52.576Z,1683919552.576 [DATMMP](INFO): Received message type: directional 2023-05-12T19:25:52.576Z,1683919552.576 [DATMMP](INFO): Handled 2023-05-12T19:25:52.824Z,1683919552.824 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:25:52.825Z,1683919552.825 [DATMMP](INFO): remote_header rx: x0 x62 x1 xA1 x1 xA xC x0 2023-05-12T19:25:52.826Z,1683919552.826 [DATMMP](INFO): DATA Src=12, Dst=10 2023-05-12T19:25:52.826Z,1683919552.826 [DATMMP](INFO): Received message type: remote_header 2023-05-12T19:25:52.826Z,1683919552.826 [DATMMP](INFO): Handled 2023-05-12T19:25:53.076Z,1683919553.076 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:25:53.078Z,1683919553.078 [DATMMP](INFO): acstats rx: xC x0 x0 x2D0 x23 x7D xAE xA9 xD xFFFF x0 x22 x0 x0 2023-05-12T19:25:53.078Z,1683919553.078 [DATMMP](INFO): Received message type: acstats 2023-05-12T19:25:53.078Z,1683919553.078 [DATMMP](INFO): Handled 2023-05-12T19:25:53.328Z,1683919553.328 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:25:53.329Z,1683919553.329 [DATMMP](INFO): timestamp rx: x0 x13 x19 x33 xAA6 2023-05-12T19:25:53.329Z,1683919553.329 [DATMMP](INFO): Received message type: timestamp 2023-05-12T19:25:53.329Z,1683919553.329 [DATMMP](INFO): Handled 2023-05-12T19:26:06.696Z,1683919566.696 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:26:06.697Z,1683919566.697 [DATMMP](INFO): doppler rx: x0 2023-05-12T19:26:06.697Z,1683919566.697 [DATMMP](INFO): Received message type: doppler 2023-05-12T19:26:06.697Z,1683919566.697 [DATMMP](INFO): Handled 2023-05-12T19:26:06.948Z,1683919566.948 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:26:06.949Z,1683919566.949 [DATMMP](INFO): timestamp rx: x1 x13 x1A x5 x2B9 2023-05-12T19:26:06.950Z,1683919566.950 [DATMMP](INFO): Rx dataTimestamp_ set to:1683919571.845824 2023-05-12T19:26:06.950Z,1683919566.950 [DATMMP](INFO): Rx ping set to:1683919566.949105 2023-05-12T19:26:06.950Z,1683919566.950 [DATMMP](INFO): Received message type: timestamp 2023-05-12T19:26:06.950Z,1683919566.950 [DATMMP](INFO): Handled 2023-05-12T19:26:07.452Z,1683919567.452 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:26:07.453Z,1683919567.453 [DATMMP](INFO): nav_stat rx: x0 x1 x1 2023-05-12T19:26:07.453Z,1683919567.453 [DATMMP](INFO): Received message type: nav_stat 2023-05-12T19:26:07.453Z,1683919567.453 [DATMMP](INFO): Handled 2023-05-12T19:26:07.704Z,1683919567.704 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:26:07.705Z,1683919567.705 [DATMMP](INFO): directional_debug rx: x191 xFC x20 x1DF x2A30 x42F1 x6A32 x7FE3 2023-05-12T19:26:07.706Z,1683919567.706 [DATMMP](INFO): Received message type: directional_debug 2023-05-12T19:26:07.706Z,1683919567.706 [DATMMP](INFO): Handled 2023-05-12T19:26:07.956Z,1683919567.956 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:26:07.958Z,1683919567.958 [DATMMP](INFO): directional rx: x1B4 xEC x44B xFF04 xAFA xFF03 x0 x6B0 x1 x1 x27B5966 x-43569E0 2023-05-12T19:26:07.959Z,1683919567.959 [DATMMP](INFO): Received message type: directional 2023-05-12T19:26:07.960Z,1683919567.960 [DATMMP](INFO): Handled 2023-05-12T19:26:08.208Z,1683919568.208 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:26:08.209Z,1683919568.209 [DATMMP](INFO): remote_header rx: x0 x62 x1 xA1 x1 xA xC x0 2023-05-12T19:26:08.209Z,1683919568.209 [DATMMP](INFO): DATA Src=12, Dst=10 2023-05-12T19:26:08.210Z,1683919568.210 [DATMMP](INFO): Received message type: remote_header 2023-05-12T19:26:08.210Z,1683919568.210 [DATMMP](INFO): Handled 2023-05-12T19:26:08.460Z,1683919568.460 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:26:08.462Z,1683919568.462 [DATMMP](INFO): acstats rx: xC x0 x0 x2D0 x22 x78 xAF xB0 xD xFFFF x0 x24 x0 x0 2023-05-12T19:26:08.462Z,1683919568.462 [DATMMP](INFO): Received message type: acstats 2023-05-12T19:26:08.462Z,1683919568.462 [DATMMP](INFO): Handled 2023-05-12T19:26:08.716Z,1683919568.716 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:26:08.717Z,1683919568.717 [DATMMP](INFO): timestamp rx: x0 x13 x1A x6 x1A45 2023-05-12T19:26:08.717Z,1683919568.717 [DATMMP](INFO): Received message type: timestamp 2023-05-12T19:26:08.717Z,1683919568.717 [DATMMP](INFO): Handled 2023-05-12T19:26:21.852Z,1683919581.852 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:26:21.852Z,1683919581.852 [DATMMP](INFO): doppler rx: x0 2023-05-12T19:26:21.853Z,1683919581.853 [DATMMP](INFO): Received message type: doppler 2023-05-12T19:26:21.853Z,1683919581.853 [DATMMP](INFO): Handled 2023-05-12T19:26:22.104Z,1683919582.104 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:26:22.105Z,1683919582.105 [DATMMP](INFO): timestamp rx: x1 x13 x1A x14 x887 2023-05-12T19:26:22.105Z,1683919582.105 [DATMMP](INFO): Rx dataTimestamp_ set to:1683919601.333824 2023-05-12T19:26:22.106Z,1683919582.106 [DATMMP](INFO): Rx ping set to:1683919582.104753 2023-05-12T19:26:22.106Z,1683919582.106 [DATMMP](INFO): Received message type: timestamp 2023-05-12T19:26:22.106Z,1683919582.106 [DATMMP](INFO): Handled 2023-05-12T19:26:22.356Z,1683919582.356 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:26:22.357Z,1683919582.357 [DATMMP](INFO): remote_header rx: xF x4 x5 x22 x0 xA xC x0 2023-05-12T19:26:22.358Z,1683919582.358 [DATMMP](INFO): DATA Src=12, Dst=10 2023-05-12T19:26:22.358Z,1683919582.358 [DATMMP](INFO): Received message type: remote_header 2023-05-12T19:26:22.358Z,1683919582.358 [DATMMP](INFO): Handled 2023-05-12T19:26:22.860Z,1683919582.860 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:26:22.860Z,1683919582.860 [DATMMP](INFO): nav_stat rx: x0 x1 x1 2023-05-12T19:26:22.861Z,1683919582.861 [DATMMP](INFO): Received message type: nav_stat 2023-05-12T19:26:22.861Z,1683919582.861 [DATMMP](INFO): Handled 2023-05-12T19:26:23.112Z,1683919583.112 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:26:23.113Z,1683919583.113 [DATMMP](INFO): directional_debug rx: x1B6 xC6 x20 x161 x36B0 x4291 x6FF2 x7FF3 2023-05-12T19:26:23.114Z,1683919583.114 [DATMMP](INFO): Received message type: directional_debug 2023-05-12T19:26:23.114Z,1683919583.114 [DATMMP](INFO): Handled 2023-05-12T19:26:23.364Z,1683919583.364 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:26:23.365Z,1683919583.365 [DATMMP](INFO): directional rx: x1E2 xC1 x426 xFF3A xAD6 xFF38 x0 x6AF xFFFF x2 x27B5966 x-43569E0 2023-05-12T19:26:23.367Z,1683919583.367 [DATMMP](INFO): Received message type: directional 2023-05-12T19:26:23.367Z,1683919583.367 [DATMMP](INFO): Handled 2023-05-12T19:26:23.616Z,1683919583.616 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:26:23.618Z,1683919583.618 [DATMMP](INFO): acstats rx: xC x5 x0 x2D0 x23 x7A xAE xB6 xD xFFFF x91 x22 xB x0 2023-05-12T19:26:23.619Z,1683919583.619 [DATMMP](INFO): Received message type: acstats 2023-05-12T19:26:23.619Z,1683919583.619 [DATMMP](INFO): Handled 2023-05-12T19:26:23.868Z,1683919583.868 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:26:23.869Z,1683919583.869 [DATMMP](INFO): data_rx rx: xC x0 x0 x22 2023-05-12T19:26:23.869Z,1683919583.869 [DATMMP](INFO): Check CRC 2023-05-12T19:26:23.869Z,1683919583.869 [DATMMP](INFO): data rx parseDataResponse 34 2023-05-12T19:26:23.869Z,1683919583.869 [DATMMP](INFO): Got DATA: len 34 2023-05-12T19:26:23.870Z,1683919583.870 [DATMMP](INFO): Received command: set _.pressure 0.742417 atmosphere 2023-05-12T19:26:23.870Z,1683919583.870 [DATMMP](INFO): #Outgoing data=1 2023-05-12T19:26:23.870Z,1683919583.870 [DATMMP](INFO): Sending ack 2023-05-12T19:26:23.870Z,1683919583.870 [DATMMP](INFO): Received message type: data_rx 2023-05-12T19:26:23.870Z,1683919583.870 [DATMMP](INFO): Handled 2023-05-12T19:26:23.870Z,1683919583.870 [DATMMP](INFO): *** SENDING_FILL_BUFFER *** 2023-05-12T19:26:23.871Z,1683919583.871 [DATMMP](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_NAV_DATA 2023-05-12T19:26:24.115Z,1683919584.115 [Default:CheckIn:Read_Iridium] Stopped 2023-05-12T19:26:24.115Z,1683919584.115 [Default:CheckIn:C.Wait] Running Loop=1 2023-05-12T19:26:24.120Z,1683919584.120 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:26:24.120Z,1683919584.120 [DATMMP](INFO): doppler rx: x0 2023-05-12T19:26:24.121Z,1683919584.121 [DATMMP](INFO): Received message type: doppler 2023-05-12T19:26:24.121Z,1683919584.121 [DATMMP](INFO): Handled 2023-05-12T19:26:24.121Z,1683919584.121 [DATMMP](INFO): *** SENDING_NAV_DATA *** 2023-05-12T19:26:24.121Z,1683919584.121 [DATMMP](DEBUG): In sendingNavData, set commsState_ = SENDING_TRANSMIT 2023-05-12T19:26:24.121Z,1683919584.121 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-05-12T19:26:24.372Z,1683919584.372 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:26:24.373Z,1683919584.373 [DATMMP](INFO): timestamp rx: x1 x13 x1A x15 x235E 2023-05-12T19:26:24.374Z,1683919584.374 [DATMMP](INFO): Rx dataTimestamp_ set to:1683919605.438272 2023-05-12T19:26:24.374Z,1683919584.374 [DATMMP](INFO): Rx ping set to:1683919584.373054 2023-05-12T19:26:24.374Z,1683919584.374 [DATMMP](INFO): Received message type: timestamp 2023-05-12T19:26:24.374Z,1683919584.374 [DATMMP](INFO): Handled 2023-05-12T19:26:24.374Z,1683919584.374 [DATMMP](INFO): *** SENDING_TRANSMIT *** 2023-05-12T19:26:24.375Z,1683919584.375 [DATMMP](INFO): Tx to 12 len 4 xid 21 2023-05-12T19:26:24.378Z,1683919584.378 [DATMMP](INFO): In sendingTransmit, set commsState_ = SENDING_TRANSMIT_VERIFY 2023-05-12T19:26:24.378Z,1683919584.378 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-05-12T19:26:24.624Z,1683919584.624 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:26:24.625Z,1683919584.625 [DATMMP](INFO): nav_stat rx: x0 x1 x1 2023-05-12T19:26:24.625Z,1683919584.625 [DATMMP](INFO): Received message type: nav_stat 2023-05-12T19:26:24.625Z,1683919584.625 [DATMMP](INFO): Handled 2023-05-12T19:26:24.625Z,1683919584.625 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-05-12T19:26:24.876Z,1683919584.876 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:26:24.877Z,1683919584.877 [DATMMP](INFO): directional_debug rx: x1A6 xCE x22 x193 x3670 x41A1 x6FA2 x5643 2023-05-12T19:26:24.878Z,1683919584.878 [DATMMP](INFO): Received message type: directional_debug 2023-05-12T19:26:24.878Z,1683919584.878 [DATMMP](INFO): Handled 2023-05-12T19:26:24.878Z,1683919584.878 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-05-12T19:26:25.128Z,1683919585.128 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:26:25.129Z,1683919585.129 [DATMMP](INFO): directional rx: x1D0 xC8 x436 xFF32 xAE5 xFF31 x0 x6AF xFFFF x1 x27B5966 x-43569E0 2023-05-12T19:26:25.131Z,1683919585.131 [DATMMP](INFO): Received message type: directional 2023-05-12T19:26:25.131Z,1683919585.131 [DATMMP](INFO): Handled 2023-05-12T19:26:25.132Z,1683919585.132 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-05-12T19:26:25.380Z,1683919585.380 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:26:25.381Z,1683919585.381 [DATMMP](INFO): remote_header rx: x0 x62 x1 xA1 x1 xA xC x0 2023-05-12T19:26:25.381Z,1683919585.381 [DATMMP](INFO): DATA Src=12, Dst=10 2023-05-12T19:26:25.382Z,1683919585.382 [DATMMP](INFO): Received message type: remote_header 2023-05-12T19:26:25.382Z,1683919585.382 [DATMMP](INFO): Handled 2023-05-12T19:26:25.382Z,1683919585.382 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-05-12T19:26:25.632Z,1683919585.632 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:26:25.634Z,1683919585.634 [DATMMP](INFO): acstats rx: xC x0 x0 x2D0 x23 x7E xB0 xA9 xD xFFFF x0 x23 x0 x0 2023-05-12T19:26:25.634Z,1683919585.634 [DATMMP](INFO): Received message type: acstats 2023-05-12T19:26:25.634Z,1683919585.634 [DATMMP](INFO): Handled 2023-05-12T19:26:25.634Z,1683919585.634 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-05-12T19:26:25.852Z,1683919585.852 [CommandExec](IMPORTANT): got command set _.pressure 0.742417 atmosphere 2023-05-12T19:26:25.884Z,1683919585.884 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:26:25.885Z,1683919585.885 [DATMMP](INFO): timestamp rx: x0 x13 x1A x17 x13DB 2023-05-12T19:26:25.885Z,1683919585.885 [DATMMP](INFO): Received message type: timestamp 2023-05-12T19:26:25.885Z,1683919585.885 [DATMMP](INFO): Handled 2023-05-12T19:26:25.885Z,1683919585.885 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-05-12T19:26:26.136Z,1683919586.136 [DATMMP](INFO): GSXN notify for xid: 21 2023-05-12T19:26:26.137Z,1683919586.137 [DATMMP](INFO): cmd_result rx: x1 x7 x0 x1 2023-05-12T19:26:26.137Z,1683919586.137 [DATMMP](DEBUG): In rxCmdResult, sent ack so set commsState_ = SENDING_VERIFIED 2023-05-12T19:26:26.137Z,1683919586.137 [DATMMP](DEBUG): Command complete send 2023-05-12T19:26:26.137Z,1683919586.137 [DATMMP](ERROR): 1:COMPLETE 2023-05-12T19:26:26.137Z,1683919586.137 [DATMMP](INFO): Received message type: cmd_result 2023-05-12T19:26:26.138Z,1683919586.138 [DATMMP](INFO): Handled 2023-05-12T19:26:26.138Z,1683919586.138 [DATMMP](INFO): *** SENDING_VERIFIED *** 2023-05-12T19:26:26.138Z,1683919586.138 [DATMMP](DEBUG): In sendingVerified, data done so set commsState_ = SENDING_FILL_BUFFER 2023-05-12T19:26:26.388Z,1683919586.388 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:26:26.389Z,1683919586.389 [DATMMP](INFO): timestamp rx: x0 x13 x1A x17 xEAA 2023-05-12T19:26:26.389Z,1683919586.389 [DATMMP](INFO): Received message type: timestamp 2023-05-12T19:26:26.389Z,1683919586.389 [DATMMP](INFO): Handled 2023-05-12T19:26:31.428Z,1683919591.428 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:26:31.429Z,1683919591.429 [DATMMP](INFO): doppler rx: x0 2023-05-12T19:26:31.429Z,1683919591.429 [DATMMP](INFO): Received message type: doppler 2023-05-12T19:26:31.429Z,1683919591.429 [DATMMP](INFO): Handled 2023-05-12T19:26:31.680Z,1683919591.680 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:26:31.681Z,1683919591.681 [DATMMP](INFO): timestamp rx: x1 x13 x1A x1D x1FF6 2023-05-12T19:26:31.681Z,1683919591.681 [DATMMP](INFO): Rx dataTimestamp_ set to:1683919604.946176 2023-05-12T19:26:31.682Z,1683919591.682 [DATMMP](INFO): Rx ping set to:1683919591.680810 2023-05-12T19:26:31.682Z,1683919591.682 [DATMMP](INFO): Received message type: timestamp 2023-05-12T19:26:31.682Z,1683919591.682 [DATMMP](INFO): Handled 2023-05-12T19:26:31.932Z,1683919591.932 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:26:31.933Z,1683919591.933 [DATMMP](INFO): remote_header rx: xF x4 x5 x23 x0 xA xC x0 2023-05-12T19:26:31.934Z,1683919591.934 [DATMMP](INFO): DATA Src=12, Dst=10 2023-05-12T19:26:31.934Z,1683919591.934 [DATMMP](INFO): Received message type: remote_header 2023-05-12T19:26:31.934Z,1683919591.934 [DATMMP](INFO): Handled 2023-05-12T19:26:32.437Z,1683919592.437 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:26:32.439Z,1683919592.439 [DATMMP](INFO): nav_stat rx: x0 x1 x1 2023-05-12T19:26:32.440Z,1683919592.440 [DATMMP](INFO): Received message type: nav_stat 2023-05-12T19:26:32.440Z,1683919592.440 [DATMMP](INFO): Handled 2023-05-12T19:26:32.688Z,1683919592.688 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:26:32.689Z,1683919592.689 [DATMMP](INFO): directional_debug rx: x193 x109 x22 x1DA x3170 x3F61 x68A2 x7963 2023-05-12T19:26:32.690Z,1683919592.690 [DATMMP](INFO): Received message type: directional_debug 2023-05-12T19:26:32.690Z,1683919592.690 [DATMMP](INFO): Handled 2023-05-12T19:26:32.940Z,1683919592.940 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:26:32.942Z,1683919592.942 [DATMMP](INFO): directional rx: x1B5 xF6 x449 xFEF7 xAF7 xFEF6 x0 x6AE x1 x1 x27B5966 x-43569E0 2023-05-12T19:26:32.944Z,1683919592.944 [DATMMP](INFO): Received message type: directional 2023-05-12T19:26:32.944Z,1683919592.944 [DATMMP](INFO): Handled 2023-05-12T19:26:33.192Z,1683919593.192 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:26:33.194Z,1683919593.194 [DATMMP](INFO): acstats rx: xC x5 x0 x2D0 x23 x7D xA9 xB0 xD xFFFF xA5 x1E xB x0 2023-05-12T19:26:33.194Z,1683919593.194 [DATMMP](INFO): Received message type: acstats 2023-05-12T19:26:33.194Z,1683919593.194 [DATMMP](INFO): Handled 2023-05-12T19:26:33.444Z,1683919593.444 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:26:33.445Z,1683919593.445 [DATMMP](INFO): data_rx rx: xC x0 x0 x23 2023-05-12T19:26:33.445Z,1683919593.445 [DATMMP](INFO): Check CRC 2023-05-12T19:26:33.445Z,1683919593.445 [DATMMP](INFO): data rx parseDataResponse 35 2023-05-12T19:26:33.445Z,1683919593.445 [DATMMP](INFO): Got DATA: len 35 2023-05-12T19:26:33.445Z,1683919593.445 [DATMMP](INFO): Received command: set _.temperature 24.219263 celsius 2023-05-12T19:26:33.446Z,1683919593.446 [DATMMP](INFO): #Outgoing data=1 2023-05-12T19:26:33.446Z,1683919593.446 [DATMMP](INFO): Sending ack 2023-05-12T19:26:33.446Z,1683919593.446 [DATMMP](INFO): Received message type: data_rx 2023-05-12T19:26:33.446Z,1683919593.446 [DATMMP](INFO): Handled 2023-05-12T19:26:33.446Z,1683919593.446 [DATMMP](INFO): *** SENDING_FILL_BUFFER *** 2023-05-12T19:26:33.447Z,1683919593.447 [DATMMP](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_NAV_DATA 2023-05-12T19:26:33.696Z,1683919593.696 [DATMMP](INFO): *** SENDING_NAV_DATA *** 2023-05-12T19:26:33.696Z,1683919593.696 [DATMMP](DEBUG): In sendingNavData, set commsState_ = SENDING_TRANSMIT 2023-05-12T19:26:33.948Z,1683919593.948 [DATMMP](INFO): *** SENDING_TRANSMIT *** 2023-05-12T19:26:33.948Z,1683919593.948 [DATMMP](INFO): Tx to 12 len 4 xid 22 2023-05-12T19:26:33.949Z,1683919593.949 [DATMMP](INFO): In sendingTransmit, set commsState_ = SENDING_TRANSMIT_VERIFY 2023-05-12T19:26:33.949Z,1683919593.949 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-05-12T19:26:34.200Z,1683919594.200 [DATMMP](INFO): GSXN notify for xid: 22 2023-05-12T19:26:34.201Z,1683919594.201 [DATMMP](INFO): cmd_result rx: x1 x7 x0 x1 2023-05-12T19:26:34.201Z,1683919594.201 [DATMMP](DEBUG): In rxCmdResult, sent ack so set commsState_ = SENDING_VERIFIED 2023-05-12T19:26:34.201Z,1683919594.201 [DATMMP](DEBUG): Command complete send 2023-05-12T19:26:34.201Z,1683919594.201 [DATMMP](ERROR): 1:COMPLETE 2023-05-12T19:26:34.201Z,1683919594.201 [DATMMP](INFO): Received message type: cmd_result 2023-05-12T19:26:34.201Z,1683919594.201 [DATMMP](INFO): Handled 2023-05-12T19:26:34.452Z,1683919594.452 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:26:34.453Z,1683919594.453 [DATMMP](INFO): timestamp rx: x0 x13 x1A x20 x261B 2023-05-12T19:26:34.453Z,1683919594.453 [DATMMP](INFO): Received message type: timestamp 2023-05-12T19:26:34.453Z,1683919594.453 [DATMMP](INFO): Handled 2023-05-12T19:26:34.453Z,1683919594.453 [DATMMP](INFO): *** SENDING_VERIFIED *** 2023-05-12T19:26:34.453Z,1683919594.453 [DATMMP](DEBUG): In sendingVerified, data done so set commsState_ = SENDING_FILL_BUFFER 2023-05-12T19:26:36.012Z,1683919596.012 [CommandExec](IMPORTANT): got command set _.temperature 24.219263 celsius 2023-05-12T19:26:37.476Z,1683919597.476 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:26:37.476Z,1683919597.476 [DATMMP](INFO): doppler rx: x0 2023-05-12T19:26:37.477Z,1683919597.477 [DATMMP](INFO): Received message type: doppler 2023-05-12T19:26:37.477Z,1683919597.477 [DATMMP](INFO): Handled 2023-05-12T19:26:37.728Z,1683919597.728 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:26:37.729Z,1683919597.729 [DATMMP](INFO): timestamp rx: x1 x13 x1A x23 x2002 2023-05-12T19:26:37.729Z,1683919597.729 [DATMMP](INFO): Rx dataTimestamp_ set to:1683919611.020480 2023-05-12T19:26:37.730Z,1683919597.730 [DATMMP](INFO): Rx ping set to:1683919597.728858 2023-05-12T19:26:37.730Z,1683919597.730 [DATMMP](INFO): Received message type: timestamp 2023-05-12T19:26:37.730Z,1683919597.730 [DATMMP](INFO): Handled 2023-05-12T19:26:37.981Z,1683919597.981 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:26:37.983Z,1683919597.983 [DATMMP](INFO): nav_stat rx: x0 x1 x1 2023-05-12T19:26:37.984Z,1683919597.984 [DATMMP](INFO): Received message type: nav_stat 2023-05-12T19:26:37.984Z,1683919597.984 [DATMMP](INFO): Handled 2023-05-12T19:26:38.232Z,1683919598.232 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:26:38.233Z,1683919598.233 [DATMMP](INFO): directional_debug rx: x1C9 xDA x20 x15E x3660 x4281 x6F82 x7FC3 2023-05-12T19:26:38.234Z,1683919598.234 [DATMMP](INFO): Received message type: directional_debug 2023-05-12T19:26:38.234Z,1683919598.234 [DATMMP](INFO): Handled 2023-05-12T19:26:38.484Z,1683919598.484 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:26:38.485Z,1683919598.485 [DATMMP](INFO): directional rx: x1F6 xCF x413 xFF26 xAC1 xFF25 x0 x6AE x1 x1 x27B5966 x-43569E0 2023-05-12T19:26:38.487Z,1683919598.487 [DATMMP](INFO): Received message type: directional 2023-05-12T19:26:38.487Z,1683919598.487 [DATMMP](INFO): Handled 2023-05-12T19:26:38.737Z,1683919598.737 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:26:38.738Z,1683919598.738 [DATMMP](INFO): remote_header rx: x0 x62 x1 xA1 x1 xA xC x0 2023-05-12T19:26:38.739Z,1683919598.739 [DATMMP](INFO): DATA Src=12, Dst=10 2023-05-12T19:26:38.747Z,1683919598.747 [DATMMP](INFO): Received message type: remote_header 2023-05-12T19:26:38.747Z,1683919598.747 [DATMMP](INFO): Handled 2023-05-12T19:26:38.988Z,1683919598.988 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:26:38.990Z,1683919598.990 [DATMMP](INFO): acstats rx: xC x0 x0 x2D0 x22 x7B xAD xAD xD xFFFF x0 x22 x0 x0 2023-05-12T19:26:38.990Z,1683919598.990 [DATMMP](INFO): Received message type: acstats 2023-05-12T19:26:38.990Z,1683919598.990 [DATMMP](INFO): Handled 2023-05-12T19:26:39.240Z,1683919599.240 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:26:39.241Z,1683919599.241 [DATMMP](INFO): timestamp rx: x0 x13 x1A x25 x107E 2023-05-12T19:26:39.241Z,1683919599.241 [DATMMP](INFO): Received message type: timestamp 2023-05-12T19:26:39.241Z,1683919599.241 [DATMMP](INFO): Handled 2023-05-12T19:26:49.577Z,1683919609.577 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:26:49.579Z,1683919609.579 [DATMMP](INFO): doppler rx: x0 2023-05-12T19:26:49.580Z,1683919609.580 [DATMMP](INFO): Received message type: doppler 2023-05-12T19:26:49.580Z,1683919609.580 [DATMMP](INFO): Handled 2023-05-12T19:26:49.828Z,1683919609.828 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:26:49.829Z,1683919609.829 [DATMMP](INFO): timestamp rx: x1 x13 x1A x2F x25D0 2023-05-12T19:26:49.829Z,1683919609.829 [DATMMP](INFO): Rx dataTimestamp_ set to:1683919637.557056 2023-05-12T19:26:49.830Z,1683919609.830 [DATMMP](INFO): Rx ping set to:1683919609.828793 2023-05-12T19:26:49.830Z,1683919609.830 [DATMMP](INFO): Received message type: timestamp 2023-05-12T19:26:49.830Z,1683919609.830 [DATMMP](INFO): Handled 2023-05-12T19:26:50.080Z,1683919610.080 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:26:50.081Z,1683919610.081 [DATMMP](INFO): remote_header rx: xF x4 x5 x20 x0 xA xC x0 2023-05-12T19:26:50.081Z,1683919610.081 [DATMMP](INFO): DATA Src=12, Dst=10 2023-05-12T19:26:50.082Z,1683919610.082 [DATMMP](INFO): Received message type: remote_header 2023-05-12T19:26:50.082Z,1683919610.082 [DATMMP](INFO): Handled 2023-05-12T19:26:50.584Z,1683919610.584 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:26:50.584Z,1683919610.584 [DATMMP](INFO): nav_stat rx: x0 x1 x1 2023-05-12T19:26:50.585Z,1683919610.585 [DATMMP](INFO): Received message type: nav_stat 2023-05-12T19:26:50.585Z,1683919610.585 [DATMMP](INFO): Handled 2023-05-12T19:26:50.836Z,1683919610.836 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:26:50.837Z,1683919610.837 [DATMMP](INFO): directional_debug rx: x17C x108 x21 x1F2 x3180 x41B1 x6C52 x7FF3 2023-05-12T19:26:50.838Z,1683919610.838 [DATMMP](INFO): Received message type: directional_debug 2023-05-12T19:26:50.838Z,1683919610.838 [DATMMP](INFO): Handled 2023-05-12T19:26:51.088Z,1683919611.088 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:26:51.089Z,1683919611.089 [DATMMP](INFO): directional rx: x19B xF5 x460 xFEF8 xB0D xFEF8 x0 x6AD x1 x0 x27B5966 x-43569E0 2023-05-12T19:26:51.091Z,1683919611.091 [DATMMP](INFO): Received message type: directional 2023-05-12T19:26:51.091Z,1683919611.091 [DATMMP](INFO): Handled 2023-05-12T19:26:51.340Z,1683919611.340 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:26:51.342Z,1683919611.342 [DATMMP](INFO): acstats rx: xC x5 x0 x2D0 x23 x79 xB3 xC0 xD xFFFF xA9 x22 xB x0 2023-05-12T19:26:51.342Z,1683919611.342 [DATMMP](INFO): Received message type: acstats 2023-05-12T19:26:51.342Z,1683919611.342 [DATMMP](INFO): Handled 2023-05-12T19:26:51.593Z,1683919611.593 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:26:51.595Z,1683919611.595 [DATMMP](INFO): data_rx rx: xC x0 x0 x20 2023-05-12T19:26:51.595Z,1683919611.595 [DATMMP](INFO): Check CRC 2023-05-12T19:26:51.596Z,1683919611.596 [DATMMP](INFO): data rx parseDataResponse 32 2023-05-12T19:26:51.596Z,1683919611.596 [DATMMP](INFO): Got DATA: len 32 2023-05-12T19:26:51.596Z,1683919611.596 [DATMMP](INFO): Received command: set _.humidity 12.892199 percent 2023-05-12T19:26:51.596Z,1683919611.596 [DATMMP](INFO): #Outgoing data=1 2023-05-12T19:26:51.596Z,1683919611.596 [DATMMP](INFO): Sending ack 2023-05-12T19:26:51.597Z,1683919611.597 [DATMMP](INFO): Received message type: data_rx 2023-05-12T19:26:51.597Z,1683919611.597 [DATMMP](INFO): Handled 2023-05-12T19:26:51.843Z,1683919611.843 [DATMMP](INFO): *** SENDING_FILL_BUFFER *** 2023-05-12T19:26:51.844Z,1683919611.844 [DATMMP](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_NAV_DATA 2023-05-12T19:26:52.096Z,1683919612.096 [DATMMP](INFO): *** SENDING_NAV_DATA *** 2023-05-12T19:26:52.096Z,1683919612.096 [DATMMP](DEBUG): In sendingNavData, set commsState_ = SENDING_TRANSMIT 2023-05-12T19:26:52.348Z,1683919612.348 [DATMMP](INFO): *** SENDING_TRANSMIT *** 2023-05-12T19:26:52.348Z,1683919612.348 [DATMMP](INFO): Tx to 12 len 4 xid 23 2023-05-12T19:26:52.349Z,1683919612.349 [DATMMP](INFO): In sendingTransmit, set commsState_ = SENDING_TRANSMIT_VERIFY 2023-05-12T19:26:52.349Z,1683919612.349 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-05-12T19:26:52.578Z,1683919612.578 [CommandExec](IMPORTANT): got command set _.humidity 12.892199 percent 2023-05-12T19:26:52.603Z,1683919612.603 [DATMMP](INFO): GSXN notify for xid: 23 2023-05-12T19:26:52.604Z,1683919612.604 [DATMMP](INFO): cmd_result rx: x1 x7 x0 x1 2023-05-12T19:26:52.604Z,1683919612.604 [DATMMP](DEBUG): In rxCmdResult, sent ack so set commsState_ = SENDING_VERIFIED 2023-05-12T19:26:52.605Z,1683919612.605 [DATMMP](DEBUG): Command complete send 2023-05-12T19:26:52.605Z,1683919612.605 [DATMMP](ERROR): 1:COMPLETE 2023-05-12T19:26:52.605Z,1683919612.605 [DATMMP](INFO): Received message type: cmd_result 2023-05-12T19:26:52.605Z,1683919612.605 [DATMMP](INFO): Handled 2023-05-12T19:26:52.605Z,1683919612.605 [DATMMP](INFO): *** SENDING_VERIFIED *** 2023-05-12T19:26:52.605Z,1683919612.605 [DATMMP](DEBUG): In sendingVerified, data done so set commsState_ = SENDING_FILL_BUFFER 2023-05-12T19:26:52.856Z,1683919612.856 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:26:52.856Z,1683919612.856 [DATMMP](INFO): doppler rx: x0 2023-05-12T19:26:52.857Z,1683919612.857 [DATMMP](INFO): Received message type: doppler 2023-05-12T19:26:52.857Z,1683919612.857 [DATMMP](INFO): Handled 2023-05-12T19:26:53.108Z,1683919613.108 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:26:53.109Z,1683919613.109 [DATMMP](INFO): timestamp rx: x0 x13 x1A x33 xEA8 2023-05-12T19:26:53.109Z,1683919613.109 [DATMMP](INFO): Received message type: timestamp 2023-05-12T19:26:53.109Z,1683919613.109 [DATMMP](INFO): Handled 2023-05-12T19:26:53.360Z,1683919613.360 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:26:53.361Z,1683919613.361 [DATMMP](INFO): nav_stat rx: x0 x1 x1 2023-05-12T19:26:53.361Z,1683919613.361 [DATMMP](INFO): Received message type: nav_stat 2023-05-12T19:26:53.361Z,1683919613.361 [DATMMP](INFO): Handled 2023-05-12T19:26:53.612Z,1683919613.612 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:26:53.613Z,1683919613.613 [DATMMP](INFO): directional_debug rx: x1A3 xD1 x21 x193 x35F0 x41B1 x6FC2 x7FF3 2023-05-12T19:26:53.614Z,1683919613.614 [DATMMP](INFO): Received message type: directional_debug 2023-05-12T19:26:53.614Z,1683919613.614 [DATMMP](INFO): Handled 2023-05-12T19:26:53.864Z,1683919613.864 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:26:53.866Z,1683919613.866 [DATMMP](INFO): directional rx: x1CD xCA x439 xFF2F xAE6 xFF2F x0 x6AE x2 x0 x27B5966 x-43569E0 2023-05-12T19:26:53.868Z,1683919613.868 [DATMMP](INFO): Received message type: directional 2023-05-12T19:26:53.868Z,1683919613.868 [DATMMP](INFO): Handled 2023-05-12T19:26:54.116Z,1683919614.116 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:26:54.117Z,1683919614.117 [DATMMP](INFO): timestamp rx: x1 x13 x1A x32 x23E9 2023-05-12T19:26:54.117Z,1683919614.117 [DATMMP](INFO): Rx dataTimestamp_ set to:1683919635.813056 2023-05-12T19:26:54.118Z,1683919614.118 [DATMMP](INFO): Rx ping set to:1683919614.116830 2023-05-12T19:26:54.118Z,1683919614.118 [DATMMP](INFO): Received message type: timestamp 2023-05-12T19:26:54.118Z,1683919614.118 [DATMMP](INFO): Handled 2023-05-12T19:26:54.372Z,1683919614.372 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:26:54.373Z,1683919614.373 [DATMMP](INFO): remote_header rx: x0 x62 x1 xA1 x1 xA xC x0 2023-05-12T19:26:54.373Z,1683919614.373 [DATMMP](INFO): DATA Src=12, Dst=10 2023-05-12T19:26:54.374Z,1683919614.374 [DATMMP](INFO): Received message type: remote_header 2023-05-12T19:26:54.374Z,1683919614.374 [DATMMP](INFO): Handled 2023-05-12T19:26:54.624Z,1683919614.624 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:26:54.626Z,1683919614.626 [DATMMP](INFO): acstats rx: xC x0 x0 x1A2 x22 x78 xAD xAC xD xFFFF x0 x2B x0 x0 2023-05-12T19:26:54.626Z,1683919614.626 [DATMMP](INFO): Received message type: acstats 2023-05-12T19:26:54.626Z,1683919614.626 [DATMMP](INFO): Handled 2023-05-12T19:26:54.876Z,1683919614.876 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:26:54.877Z,1683919614.877 [DATMMP](INFO): timestamp rx: x0 x13 x1A x34 x1465 2023-05-12T19:26:54.877Z,1683919614.877 [DATMMP](INFO): Received message type: timestamp 2023-05-12T19:26:54.877Z,1683919614.877 [DATMMP](INFO): Handled 2023-05-12T19:27:08.004Z,1683919628.004 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:27:08.005Z,1683919628.005 [DATMMP](INFO): doppler rx: x0 2023-05-12T19:27:08.005Z,1683919628.005 [DATMMP](INFO): Received message type: doppler 2023-05-12T19:27:08.005Z,1683919628.005 [DATMMP](INFO): Handled 2023-05-12T19:27:08.256Z,1683919628.256 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:27:08.257Z,1683919628.257 [DATMMP](INFO): timestamp rx: x1 x13 x1B x6 xC77 2023-05-12T19:27:08.257Z,1683919628.257 [DATMMP](INFO): Rx dataTimestamp_ set to:1683919657.169984 2023-05-12T19:27:08.258Z,1683919628.258 [DATMMP](INFO): Rx ping set to:1683919628.256790 2023-05-12T19:27:08.258Z,1683919628.258 [DATMMP](INFO): Received message type: timestamp 2023-05-12T19:27:08.258Z,1683919628.258 [DATMMP](INFO): Handled 2023-05-12T19:27:08.508Z,1683919628.508 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:27:08.509Z,1683919628.509 [DATMMP](INFO): nav_stat rx: x0 x1 x1 2023-05-12T19:27:08.509Z,1683919628.509 [DATMMP](INFO): Received message type: nav_stat 2023-05-12T19:27:08.509Z,1683919628.509 [DATMMP](INFO): Handled 2023-05-12T19:27:08.760Z,1683919628.760 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:27:08.761Z,1683919628.761 [DATMMP](INFO): directional_debug rx: x188 xF2 x22 x1B5 x26F0 x3121 x52F2 x55F3 2023-05-12T19:27:08.763Z,1683919628.763 [DATMMP](INFO): Received message type: directional_debug 2023-05-12T19:27:08.763Z,1683919628.763 [DATMMP](INFO): Handled 2023-05-12T19:27:09.012Z,1683919629.012 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:27:09.013Z,1683919629.013 [DATMMP](INFO): directional rx: x1AB xE4 x454 xFF0E xB03 xFF0C x0 x6B0 x2 x1 x27B5966 x-43569E0 2023-05-12T19:27:09.017Z,1683919629.017 [DATMMP](INFO): Received message type: directional 2023-05-12T19:27:09.017Z,1683919629.017 [DATMMP](INFO): Handled 2023-05-12T19:27:09.264Z,1683919629.264 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:27:09.265Z,1683919629.265 [DATMMP](INFO): remote_header rx: x0 x62 x1 xA1 x1 xA xC x0 2023-05-12T19:27:09.266Z,1683919629.266 [DATMMP](INFO): DATA Src=12, Dst=10 2023-05-12T19:27:09.266Z,1683919629.266 [DATMMP](INFO): Received message type: remote_header 2023-05-12T19:27:09.266Z,1683919629.266 [DATMMP](INFO): Handled 2023-05-12T19:27:09.516Z,1683919629.516 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:27:09.518Z,1683919629.518 [DATMMP](INFO): acstats rx: xC x0 x0 x2D0 x23 x81 xAF xA9 xD xFFFF x0 x23 x0 x0 2023-05-12T19:27:09.518Z,1683919629.518 [DATMMP](INFO): Received message type: acstats 2023-05-12T19:27:09.518Z,1683919629.518 [DATMMP](INFO): Handled 2023-05-12T19:27:09.768Z,1683919629.768 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:27:09.769Z,1683919629.769 [DATMMP](INFO): timestamp rx: x0 x13 x1B x7 x2403 2023-05-12T19:27:09.769Z,1683919629.769 [DATMMP](INFO): Received message type: timestamp 2023-05-12T19:27:09.769Z,1683919629.769 [DATMMP](INFO): Handled 2023-05-12T19:27:23.400Z,1683919643.400 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:27:23.400Z,1683919643.400 [DATMMP](INFO): doppler rx: xFFFF 2023-05-12T19:27:23.400Z,1683919643.400 [DATMMP](INFO): Received message type: doppler 2023-05-12T19:27:23.401Z,1683919643.401 [DATMMP](INFO): Handled 2023-05-12T19:27:23.652Z,1683919643.652 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:27:23.653Z,1683919643.653 [DATMMP](INFO): timestamp rx: x1 x13 x1B x15 x1A22 2023-05-12T19:27:23.654Z,1683919643.654 [DATMMP](INFO): Rx dataTimestamp_ set to:1683919642.348160 2023-05-12T19:27:23.654Z,1683919643.654 [DATMMP](INFO): Rx ping set to:1683919643.653194 2023-05-12T19:27:23.654Z,1683919643.654 [DATMMP](INFO): Received message type: timestamp 2023-05-12T19:27:23.654Z,1683919643.654 [DATMMP](INFO): Handled 2023-05-12T19:27:23.904Z,1683919643.904 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:27:23.905Z,1683919643.905 [DATMMP](INFO): nav_stat rx: x0 x1 x1 2023-05-12T19:27:23.905Z,1683919643.905 [DATMMP](INFO): Received message type: nav_stat 2023-05-12T19:27:23.905Z,1683919643.905 [DATMMP](INFO): Handled 2023-05-12T19:27:24.156Z,1683919644.156 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:27:24.157Z,1683919644.157 [DATMMP](INFO): directional_debug rx: x19C x102 x20 x1CE x2A10 x4261 x6AF2 x7ED3 2023-05-12T19:27:24.158Z,1683919644.158 [DATMMP](INFO): Received message type: directional_debug 2023-05-12T19:27:24.158Z,1683919644.158 [DATMMP](INFO): Handled 2023-05-12T19:27:24.408Z,1683919644.408 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:27:24.409Z,1683919644.409 [DATMMP](INFO): directional rx: x1C0 xF0 x440 xFEFE xAF0 xFEFD x0 x6B1 x2 x1 x27B5966 x-43569E0 2023-05-12T19:27:24.411Z,1683919644.411 [DATMMP](INFO): Received message type: directional 2023-05-12T19:27:24.411Z,1683919644.411 [DATMMP](INFO): Handled 2023-05-12T19:27:24.660Z,1683919644.660 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:27:24.661Z,1683919644.661 [DATMMP](INFO): remote_header rx: x0 x62 x1 xA1 x1 xA xC x0 2023-05-12T19:27:24.661Z,1683919644.661 [DATMMP](INFO): DATA Src=12, Dst=10 2023-05-12T19:27:24.662Z,1683919644.662 [DATMMP](INFO): Received message type: remote_header 2023-05-12T19:27:24.662Z,1683919644.662 [DATMMP](INFO): Handled 2023-05-12T19:27:24.912Z,1683919644.912 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:27:24.914Z,1683919644.914 [DATMMP](INFO): acstats rx: xC x0 xFFFF x2D0 x23 x7A xAF xAF xD xFFFF x0 x24 x0 x0 2023-05-12T19:27:24.914Z,1683919644.914 [DATMMP](INFO): Received message type: acstats 2023-05-12T19:27:24.914Z,1683919644.914 [DATMMP](INFO): Handled 2023-05-12T19:27:25.164Z,1683919645.164 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:27:25.165Z,1683919645.165 [DATMMP](INFO): timestamp rx: x0 x13 x1B x17 xA9E 2023-05-12T19:27:25.165Z,1683919645.165 [DATMMP](INFO): Received message type: timestamp 2023-05-12T19:27:25.165Z,1683919645.165 [DATMMP](INFO): Handled 2023-05-12T19:27:34.488Z,1683919654.488 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:27:34.488Z,1683919654.488 [DATMMP](INFO): doppler rx: x0 2023-05-12T19:27:34.489Z,1683919654.489 [DATMMP](INFO): Received message type: doppler 2023-05-12T19:27:34.489Z,1683919654.489 [DATMMP](INFO): Handled 2023-05-12T19:27:34.740Z,1683919654.740 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:27:34.741Z,1683919654.741 [DATMMP](INFO): timestamp rx: x1 x13 x1B x20 x1FF2 2023-05-12T19:27:34.741Z,1683919654.741 [DATMMP](INFO): Rx dataTimestamp_ set to:1683919667.905216 2023-05-12T19:27:34.742Z,1683919654.742 [DATMMP](INFO): Rx ping set to:1683919654.740700 2023-05-12T19:27:34.742Z,1683919654.742 [DATMMP](INFO): Received message type: timestamp 2023-05-12T19:27:34.742Z,1683919654.742 [DATMMP](INFO): Handled 2023-05-12T19:27:34.992Z,1683919654.992 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:27:34.993Z,1683919654.993 [DATMMP](INFO): remote_header rx: xF x4 x5 x22 x0 xA xC x0 2023-05-12T19:27:34.993Z,1683919654.993 [DATMMP](INFO): DATA Src=12, Dst=10 2023-05-12T19:27:34.994Z,1683919654.994 [DATMMP](INFO): Received message type: remote_header 2023-05-12T19:27:34.994Z,1683919654.994 [DATMMP](INFO): Handled 2023-05-12T19:27:35.496Z,1683919655.496 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:27:35.497Z,1683919655.497 [DATMMP](INFO): nav_stat rx: x0 x1 x1 2023-05-12T19:27:35.497Z,1683919655.497 [DATMMP](INFO): Received message type: nav_stat 2023-05-12T19:27:35.497Z,1683919655.497 [DATMMP](INFO): Handled 2023-05-12T19:27:35.748Z,1683919655.748 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:27:35.749Z,1683919655.749 [DATMMP](INFO): directional_debug rx: x191 xF6 x20 x1B8 x2A90 x41B1 x6AB2 x7FF3 2023-05-12T19:27:35.750Z,1683919655.750 [DATMMP](INFO): Received message type: directional_debug 2023-05-12T19:27:35.750Z,1683919655.750 [DATMMP](INFO): Handled 2023-05-12T19:27:35.000Z,1683919656.000 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:27:36.002Z,1683919656.002 [DATMMP](INFO): directional rx: x1B5 xE8 x44B xFF0A xAFC xFF08 x0 x6B3 x3 x1 x27B5966 x-43569E0 2023-05-12T19:27:36.004Z,1683919656.004 [DATMMP](INFO): Received message type: directional 2023-05-12T19:27:36.004Z,1683919656.004 [DATMMP](INFO): Handled 2023-05-12T19:27:36.252Z,1683919656.252 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:27:36.254Z,1683919656.254 [DATMMP](INFO): acstats rx: xC x5 x0 x1C3 x22 x77 xC0 xB5 xD xFFFF xA7 x22 xB x0 2023-05-12T19:27:36.254Z,1683919656.254 [DATMMP](INFO): Received message type: acstats 2023-05-12T19:27:36.254Z,1683919656.254 [DATMMP](INFO): Handled 2023-05-12T19:27:36.504Z,1683919656.504 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:27:36.505Z,1683919656.505 [DATMMP](INFO): data_rx rx: xC x0 x0 x22 2023-05-12T19:27:36.505Z,1683919656.505 [DATMMP](INFO): Check CRC 2023-05-12T19:27:36.505Z,1683919656.505 [DATMMP](INFO): data rx parseDataResponse 34 2023-05-12T19:27:36.506Z,1683919656.506 [DATMMP](INFO): Got DATA: len 34 2023-05-12T19:27:36.506Z,1683919656.506 [DATMMP](INFO): Received command: set _.pressure 0.744443 atmosphere 2023-05-12T19:27:36.506Z,1683919656.506 [DATMMP](INFO): #Outgoing data=1 2023-05-12T19:27:36.506Z,1683919656.506 [DATMMP](INFO): Sending ack 2023-05-12T19:27:36.507Z,1683919656.507 [DATMMP](INFO): Received message type: data_rx 2023-05-12T19:27:36.507Z,1683919656.507 [DATMMP](INFO): Handled 2023-05-12T19:27:36.507Z,1683919656.507 [DATMMP](INFO): *** SENDING_FILL_BUFFER *** 2023-05-12T19:27:36.507Z,1683919656.507 [DATMMP](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_NAV_DATA 2023-05-12T19:27:36.755Z,1683919656.755 [DATMMP](INFO): *** SENDING_NAV_DATA *** 2023-05-12T19:27:36.756Z,1683919656.756 [DATMMP](DEBUG): In sendingNavData, set commsState_ = SENDING_TRANSMIT 2023-05-12T19:27:37.008Z,1683919657.008 [DATMMP](INFO): *** SENDING_TRANSMIT *** 2023-05-12T19:27:37.008Z,1683919657.008 [DATMMP](INFO): Tx to 12 len 4 xid 24 2023-05-12T19:27:37.009Z,1683919657.009 [DATMMP](INFO): In sendingTransmit, set commsState_ = SENDING_TRANSMIT_VERIFY 2023-05-12T19:27:37.009Z,1683919657.009 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-05-12T19:27:37.260Z,1683919657.260 [DATMMP](INFO): GSXN notify for xid: 24 2023-05-12T19:27:37.261Z,1683919657.261 [DATMMP](INFO): cmd_result rx: x1 x7 x0 x1 2023-05-12T19:27:37.261Z,1683919657.261 [DATMMP](DEBUG): In rxCmdResult, sent ack so set commsState_ = SENDING_VERIFIED 2023-05-12T19:27:37.261Z,1683919657.261 [DATMMP](DEBUG): Command complete send 2023-05-12T19:27:37.261Z,1683919657.261 [DATMMP](ERROR): 1:COMPLETE 2023-05-12T19:27:37.261Z,1683919657.261 [DATMMP](INFO): Received message type: cmd_result 2023-05-12T19:27:37.261Z,1683919657.261 [DATMMP](INFO): Handled 2023-05-12T19:27:37.262Z,1683919657.262 [DATMMP](INFO): *** SENDING_VERIFIED *** 2023-05-12T19:27:37.262Z,1683919657.262 [DATMMP](DEBUG): In sendingVerified, data done so set commsState_ = SENDING_FILL_BUFFER 2023-05-12T19:27:37.504Z,1683919657.504 [CommandExec](IMPORTANT): got command set _.pressure 0.744443 atmosphere 2023-05-12T19:27:37.513Z,1683919657.513 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:27:37.514Z,1683919657.514 [DATMMP](INFO): timestamp rx: x0 x13 x1B x24 xFC 2023-05-12T19:27:37.514Z,1683919657.514 [DATMMP](INFO): Received message type: timestamp 2023-05-12T19:27:37.514Z,1683919657.514 [DATMMP](INFO): Handled 2023-05-12T19:27:41.796Z,1683919661.796 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:27:41.796Z,1683919661.796 [DATMMP](INFO): doppler rx: x0 2023-05-12T19:27:41.797Z,1683919661.797 [DATMMP](INFO): Received message type: doppler 2023-05-12T19:27:41.797Z,1683919661.797 [DATMMP](INFO): Handled 2023-05-12T19:27:42.048Z,1683919662.048 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:27:42.049Z,1683919662.049 [DATMMP](INFO): timestamp rx: x1 x13 x1B x28 x68D 2023-05-12T19:27:42.049Z,1683919662.049 [DATMMP](INFO): Rx dataTimestamp_ set to:1683919676.395264 2023-05-12T19:27:42.050Z,1683919662.050 [DATMMP](INFO): Rx ping set to:1683919662.048825 2023-05-12T19:27:42.050Z,1683919662.050 [DATMMP](INFO): Received message type: timestamp 2023-05-12T19:27:42.050Z,1683919662.050 [DATMMP](INFO): Handled 2023-05-12T19:27:42.300Z,1683919662.300 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:27:42.301Z,1683919662.301 [DATMMP](INFO): remote_header rx: xF x4 x5 x23 x0 xA xC x0 2023-05-12T19:27:42.301Z,1683919662.301 [DATMMP](INFO): DATA Src=12, Dst=10 2023-05-12T19:27:42.302Z,1683919662.302 [DATMMP](INFO): Received message type: remote_header 2023-05-12T19:27:42.302Z,1683919662.302 [DATMMP](INFO): Handled 2023-05-12T19:27:42.804Z,1683919662.804 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:27:42.805Z,1683919662.805 [DATMMP](INFO): nav_stat rx: x0 x1 x1 2023-05-12T19:27:42.805Z,1683919662.805 [DATMMP](INFO): Received message type: nav_stat 2023-05-12T19:27:42.805Z,1683919662.805 [DATMMP](INFO): Handled 2023-05-12T19:27:43.056Z,1683919663.056 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:27:43.057Z,1683919663.057 [DATMMP](INFO): directional_debug rx: x18B xF2 x21 x1B5 x29E0 x3F31 x6652 x55F3 2023-05-12T19:27:43.058Z,1683919663.058 [DATMMP](INFO): Received message type: directional_debug 2023-05-12T19:27:43.058Z,1683919663.058 [DATMMP](INFO): Handled 2023-05-12T19:27:43.308Z,1683919663.308 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:27:43.309Z,1683919663.309 [DATMMP](INFO): directional rx: x1AE xE4 x451 xFF0E xB01 xFF0D x0 x6B2 x4 x0 x27B5966 x-43569E0 2023-05-12T19:27:43.311Z,1683919663.311 [DATMMP](INFO): Received message type: directional 2023-05-12T19:27:43.311Z,1683919663.311 [DATMMP](INFO): Handled 2023-05-12T19:27:43.561Z,1683919663.561 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:27:43.566Z,1683919663.566 [DATMMP](INFO): acstats rx: xC x5 x0 x2D0 x23 x7B xC5 xC4 xD xFFFF xA3 x1D xB x0 2023-05-12T19:27:43.567Z,1683919663.567 [DATMMP](INFO): Received message type: acstats 2023-05-12T19:27:43.582Z,1683919663.582 [DATMMP](INFO): Handled 2023-05-12T19:27:43.812Z,1683919663.812 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:27:43.813Z,1683919663.813 [DATMMP](INFO): data_rx rx: xC x0 x0 x23 2023-05-12T19:27:43.813Z,1683919663.813 [DATMMP](INFO): Check CRC 2023-05-12T19:27:43.813Z,1683919663.813 [DATMMP](INFO): data rx parseDataResponse 35 2023-05-12T19:27:43.813Z,1683919663.813 [DATMMP](INFO): Got DATA: len 35 2023-05-12T19:27:43.813Z,1683919663.813 [DATMMP](INFO): Received command: set _.temperature 24.219263 celsius 2023-05-12T19:27:43.814Z,1683919663.814 [DATMMP](INFO): #Outgoing data=1 2023-05-12T19:27:43.814Z,1683919663.814 [DATMMP](INFO): Sending ack 2023-05-12T19:27:43.814Z,1683919663.814 [DATMMP](INFO): Received message type: data_rx 2023-05-12T19:27:43.814Z,1683919663.814 [DATMMP](INFO): Handled 2023-05-12T19:27:43.814Z,1683919663.814 [DATMMP](INFO): *** SENDING_FILL_BUFFER *** 2023-05-12T19:27:43.814Z,1683919663.814 [DATMMP](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_NAV_DATA 2023-05-12T19:27:44.063Z,1683919664.063 [DATMMP](INFO): *** SENDING_NAV_DATA *** 2023-05-12T19:27:44.064Z,1683919664.064 [DATMMP](DEBUG): In sendingNavData, set commsState_ = SENDING_TRANSMIT 2023-05-12T19:27:44.316Z,1683919664.316 [DATMMP](INFO): *** SENDING_TRANSMIT *** 2023-05-12T19:27:44.316Z,1683919664.316 [DATMMP](INFO): Tx to 12 len 4 xid 25 2023-05-12T19:27:44.317Z,1683919664.317 [DATMMP](INFO): In sendingTransmit, set commsState_ = SENDING_TRANSMIT_VERIFY 2023-05-12T19:27:44.317Z,1683919664.317 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-05-12T19:27:44.568Z,1683919664.568 [DATMMP](INFO): GSXN notify for xid: 25 2023-05-12T19:27:44.569Z,1683919664.569 [DATMMP](INFO): cmd_result rx: x1 x7 x0 x1 2023-05-12T19:27:44.569Z,1683919664.569 [DATMMP](DEBUG): In rxCmdResult, sent ack so set commsState_ = SENDING_VERIFIED 2023-05-12T19:27:44.569Z,1683919664.569 [DATMMP](DEBUG): Command complete send 2023-05-12T19:27:44.569Z,1683919664.569 [DATMMP](ERROR): 1:COMPLETE 2023-05-12T19:27:44.569Z,1683919664.569 [DATMMP](INFO): Received message type: cmd_result 2023-05-12T19:27:44.569Z,1683919664.569 [DATMMP](INFO): Handled 2023-05-12T19:27:44.570Z,1683919664.570 [DATMMP](INFO): *** SENDING_VERIFIED *** 2023-05-12T19:27:44.570Z,1683919664.570 [DATMMP](DEBUG): In sendingVerified, data done so set commsState_ = SENDING_FILL_BUFFER 2023-05-12T19:27:44.820Z,1683919664.820 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:27:44.821Z,1683919664.821 [DATMMP](INFO): timestamp rx: x0 x13 x1B x2B xCB3 2023-05-12T19:27:44.821Z,1683919664.821 [DATMMP](INFO): Received message type: timestamp 2023-05-12T19:27:44.821Z,1683919664.821 [DATMMP](INFO): Handled 2023-05-12T19:27:45.146Z,1683919665.146 [CommandExec](IMPORTANT): got command set _.temperature 24.219263 celsius 2023-05-12T19:27:49.105Z,1683919669.105 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:27:49.105Z,1683919669.105 [DATMMP](INFO): doppler rx: x0 2023-05-12T19:27:49.105Z,1683919669.105 [DATMMP](INFO): Received message type: doppler 2023-05-12T19:27:49.106Z,1683919669.106 [DATMMP](INFO): Handled 2023-05-12T19:27:49.356Z,1683919669.356 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:27:49.357Z,1683919669.357 [DATMMP](INFO): timestamp rx: x1 x13 x1B x2F x1244 2023-05-12T19:27:49.358Z,1683919669.358 [DATMMP](INFO): Rx dataTimestamp_ set to:1683919712.696320 2023-05-12T19:27:49.358Z,1683919669.358 [DATMMP](INFO): Rx ping set to:1683919669.357054 2023-05-12T19:27:49.358Z,1683919669.358 [DATMMP](INFO): Received message type: timestamp 2023-05-12T19:27:49.358Z,1683919669.358 [DATMMP](INFO): Handled 2023-05-12T19:27:49.608Z,1683919669.608 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:27:49.609Z,1683919669.609 [DATMMP](INFO): remote_header rx: xF x4 x5 x20 x0 xA xC x0 2023-05-12T19:27:49.610Z,1683919669.610 [DATMMP](INFO): DATA Src=12, Dst=10 2023-05-12T19:27:49.610Z,1683919669.610 [DATMMP](INFO): Received message type: remote_header 2023-05-12T19:27:49.610Z,1683919669.610 [DATMMP](INFO): Handled 2023-05-12T19:27:50.129Z,1683919670.129 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:27:50.131Z,1683919670.131 [DATMMP](INFO): nav_stat rx: x0 x1 x1 2023-05-12T19:27:50.131Z,1683919670.131 [DATMMP](INFO): Received message type: nav_stat 2023-05-12T19:27:50.132Z,1683919670.132 [DATMMP](INFO): Handled 2023-05-12T19:27:50.364Z,1683919670.364 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:27:50.365Z,1683919670.365 [DATMMP](INFO): directional_debug rx: x19F x106 x20 x1D3 x2A80 x40E1 x6F52 x7FF3 2023-05-12T19:27:50.366Z,1683919670.366 [DATMMP](INFO): Received message type: directional_debug 2023-05-12T19:27:50.366Z,1683919670.366 [DATMMP](INFO): Handled 2023-05-12T19:27:50.616Z,1683919670.616 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:27:50.617Z,1683919670.617 [DATMMP](INFO): directional rx: x1C3 xF4 x43D xFEFA xAEC xFEF8 x0 x6B1 x5 x1 x27B5966 x-43569E0 2023-05-12T19:27:50.619Z,1683919670.619 [DATMMP](INFO): Received message type: directional 2023-05-12T19:27:50.619Z,1683919670.619 [DATMMP](INFO): Handled 2023-05-12T19:27:50.870Z,1683919670.870 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:27:50.874Z,1683919670.874 [DATMMP](INFO): acstats rx: xC x5 x0 x2D0 x23 x7B xB6 xB1 xD xFFFF xAA x1F xB x0 2023-05-12T19:27:50.874Z,1683919670.874 [DATMMP](INFO): Received message type: acstats 2023-05-12T19:27:50.874Z,1683919670.874 [DATMMP](INFO): Handled 2023-05-12T19:27:51.120Z,1683919671.120 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:27:51.121Z,1683919671.121 [DATMMP](INFO): data_rx rx: xC x0 x0 x20 2023-05-12T19:27:51.121Z,1683919671.121 [DATMMP](INFO): Check CRC 2023-05-12T19:27:51.121Z,1683919671.121 [DATMMP](INFO): data rx parseDataResponse 32 2023-05-12T19:27:51.121Z,1683919671.121 [DATMMP](INFO): Got DATA: len 32 2023-05-12T19:27:51.122Z,1683919671.122 [DATMMP](INFO): Received command: set _.humidity 12.892199 percent 2023-05-12T19:27:51.122Z,1683919671.122 [DATMMP](INFO): #Outgoing data=1 2023-05-12T19:27:51.122Z,1683919671.122 [DATMMP](INFO): Sending ack 2023-05-12T19:27:51.122Z,1683919671.122 [DATMMP](INFO): Received message type: data_rx 2023-05-12T19:27:51.122Z,1683919671.122 [DATMMP](INFO): Handled 2023-05-12T19:27:51.122Z,1683919671.122 [DATMMP](INFO): *** SENDING_FILL_BUFFER *** 2023-05-12T19:27:51.123Z,1683919671.123 [DATMMP](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_NAV_DATA 2023-05-12T19:27:51.371Z,1683919671.371 [DATMMP](INFO): *** SENDING_NAV_DATA *** 2023-05-12T19:27:51.372Z,1683919671.372 [DATMMP](DEBUG): In sendingNavData, set commsState_ = SENDING_TRANSMIT 2023-05-12T19:27:51.624Z,1683919671.624 [DATMMP](INFO): *** SENDING_TRANSMIT *** 2023-05-12T19:27:51.624Z,1683919671.624 [DATMMP](INFO): Tx to 12 len 4 xid 26 2023-05-12T19:27:51.625Z,1683919671.625 [DATMMP](INFO): In sendingTransmit, set commsState_ = SENDING_TRANSMIT_VERIFY 2023-05-12T19:27:51.625Z,1683919671.625 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-05-12T19:27:51.876Z,1683919671.876 [DATMMP](INFO): GSXN notify for xid: 26 2023-05-12T19:27:51.876Z,1683919671.876 [DATMMP](INFO): cmd_result rx: x1 x7 x0 x1 2023-05-12T19:27:51.877Z,1683919671.877 [DATMMP](DEBUG): In rxCmdResult, sent ack so set commsState_ = SENDING_VERIFIED 2023-05-12T19:27:51.877Z,1683919671.877 [DATMMP](DEBUG): Command complete send 2023-05-12T19:27:51.877Z,1683919671.877 [DATMMP](ERROR): 1:COMPLETE 2023-05-12T19:27:51.877Z,1683919671.877 [DATMMP](INFO): Received message type: cmd_result 2023-05-12T19:27:51.877Z,1683919671.877 [DATMMP](INFO): Handled 2023-05-12T19:27:51.877Z,1683919671.877 [DATMMP](INFO): *** SENDING_VERIFIED *** 2023-05-12T19:27:51.878Z,1683919671.878 [DATMMP](DEBUG): In sendingVerified, data done so set commsState_ = SENDING_FILL_BUFFER 2023-05-12T19:27:52.128Z,1683919672.128 [DATMMP](INFO): GSXN notify for xid: 0 2023-05-12T19:27:52.129Z,1683919672.129 [DATMMP](INFO): timestamp rx: x0 x13 x1B x32 x186B 2023-05-12T19:27:52.129Z,1683919672.129 [DATMMP](INFO): Received message type: timestamp 2023-05-12T19:27:52.129Z,1683919672.129 [DATMMP](INFO): Handled 2023-05-12T19:27:52.303Z,1683919672.303 [CommandExec](IMPORTANT): got command set _.humidity 12.892199 percent 2023-05-12T19:29:32.566Z,1683919772.566 [CommandExec](IMPORTANT): got command set NAL9602.time_fix 1683919672 second 2023-05-12T19:31:24.707Z,1683919884.707 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-05-12T19:31:24.715Z,1683919884.715 [Default:CheckIn:C.Wait] Stopped 2023-05-12T19:31:24.715Z,1683919884.715 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-05-12T19:31:24.715Z,1683919884.715 [Default:CheckIn:D] Running Loop=1 2023-05-12T19:31:25.113Z,1683919885.113 [Default:CheckIn:D] Stopped 2023-05-12T19:31:25.113Z,1683919885.113 [Default:CheckIn:E] Running Loop=1 2023-05-12T19:31:25.482Z,1683919885.482 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 11.077989 min 2023-05-12T19:31:25.482Z,1683919885.482 [Default:CheckIn:E] Stopped 2023-05-12T19:31:25.482Z,1683919885.482 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-05-12T19:31:25.482Z,1683919885.482 [Default:CheckIn] Stopped 2023-05-12T19:31:25.483Z,1683919885.483 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-05-12T19:31:25.483Z,1683919885.483 [Default:CheckIn](INFO): Running loop #2 2023-05-12T19:31:25.495Z,1683919885.495 [Default:CheckIn] Running Loop=2 2023-05-12T19:31:25.495Z,1683919885.495 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-05-12T19:31:25.495Z,1683919885.495 [Default:CheckIn:Read_GPS] Running Loop=1 2023-05-12T19:31:27.080Z,1683919887.080 [CommandExec](IMPORTANT): got command failComponent 2023-05-12T19:31:27.080Z,1683919887.080 [CommandExec](IMPORTANT): Failed components: 2023-05-12T19:31:27.080Z,1683919887.080 [CommandExec](IMPORTANT): No failed Components. 2023-05-12T19:31:27.081Z,1683919887.081 [NAL9602](FAULT): GPS failed to acquire within timeout. 2023-05-12T19:31:27.081Z,1683919887.081 [NAL9602] Data Fault, FailCount= 1 2023-05-12T19:31:27.082Z,1683919887.082 [NAL9602](ERROR): Data Fault 2023-05-12T19:31:27.184Z,1683919887.184 [CBIT](ERROR): Data Fault in component: NAL9602 2023-05-12T19:31:27.484Z,1683919887.484 [NAL9602](INFO): Powering down 2023-05-12T19:31:28.390Z,1683919888.390 [CBIT](INFO): Clearing failed state for component NAL9602 2023-05-12T19:31:28.390Z,1683919888.390 [NAL9602] No Fault, FailCount= 1 2023-05-12T19:31:57.788Z,1683919917.788 [NAL9602](INFO): Powering up NAL9602 2023-05-12T19:32:08.700Z,1683919928.700 [NAL9602](INFO): NAL9602 initialized 2023-05-12T19:36:25.697Z,1683920185.697 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-05-12T19:31:25.5Z 2023-05-12T19:36:25.697Z,1683920185.697 [Default:CheckIn:Read_GPS] Stopped 2023-05-12T19:36:25.697Z,1683920185.697 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-05-12T19:36:33.031Z,1683920193.031 [DataOverHttps](INFO): Sending 246 bytes from file Logs/20230512T192414/Courier0000.lzma 2023-05-12T19:36:34.033Z,1683920194.033 [DataOverHttps](INFO): Moved sent file to Logs/20230512T192414/Courier0000.lzma.bak 2023-05-12T19:36:34.033Z,1683920194.033 [DataOverHttps](INFO): SBD MOMSN=18300679 2023-05-12T19:36:50.047Z,1683920210.047 [DataOverHttps](INFO): Sending 607 bytes from file Logs/20230512T192414/Express0001.lzma 2023-05-12T19:36:51.049Z,1683920211.049 [DataOverHttps](INFO): Moved sent file to Logs/20230512T192414/Express0001.lzma.bak 2023-05-12T19:36:51.049Z,1683920211.049 [DataOverHttps](INFO): SBD MOMSN=18300684 2023-05-12T19:37:12.104Z,1683920232.104 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2023-05-12T19:37:42.804Z,1683920262.804 [NAL9602](INFO): Not Powering down - fast GPS 2023-05-12T19:42:26.799Z,1683920546.799 [CommandExec](IMPORTANT): got command get Vehicle.id 2023-05-12T19:42:26.804Z,1683920546.804 [CommandExec](IMPORTANT): Vehicle.id 10 enum 2023-05-12T19:43:10.969Z,1683920590.969 [CommandExec](IMPORTANT): got command get depth 2023-05-12T19:43:10.969Z,1683920590.969 [CommandExec](IMPORTANT): depth 0.800000 m