daq icon indicating copy to clipboard operation
daq copied to clipboard

UDMI discovery message - fails to reconnect after token expiry

Open noursaidi opened this issue 4 years ago • 0 comments

While running the ATA, after about 25 minutes, the UDMI discovery publisher stops publishing. Looks like a JWT refresh issue.

The cloud logs show a disconnect due to token expiry:

jsonPayload: {
disconnectType: "SERVER"
eventType: "DISCONNECT"
protocol: "MQTT"
resourceName: "projects/daq1-273309/locations/us-central1/registries/UDMS-AUDITOR/devices/2746576174755753"
serviceName: "cloudiot.googleapis.com"
status: {
code: 16
description: "UNAUTHENTICATED"
message: "SERVER: The authorization token expired."
}
}

The daqrun logs show the device trying to reconnect unsuccessfully

on_connect Connection Refused: bad user name or password.
on_disconnect 5: The connection was refused.
Waiting for 1.908 before reconnecting.
publish /devices/daq/events/audit
Aug 11 21:03:01 report   INFO    Copying reports to local/site/mac_addrs/54e019d356d4/report.*
Aug 11 21:03:01 host     INFO    Finalized with reports ['report_path.md', 'report_path.pdf', 'report_path.json', 'trigger_path']
Aug 11 21:03:01 runner   INFO    Target device 54e019d356d4 finalize: [] (target set not active)
.......
Aug 11 21:03:01 host     INFO    Target device 54e01980e5d0 state: Waiting for activation -> Baseline tests
Aug 11 21:03:01 udmi     INFO    Sending udmi discovery message for device 54:e0:19:d3:54:94
Waiting for 2.983 before reconnecting.
publish /devices/daq/events/discovery
...
Aug 11 21:03:12 udmi     INFO    Sending udmi discovery message for device 54:e0:19:80:e5:d0
Waiting for 4.082 before reconnecting.
publish /devices/daq/events/discovery
...
Aug 11 21:03:22 udmi     INFO    Sending udmi discovery message for device 54:e0:19:d3:56:d4
Waiting for 8.163 before reconnecting.
publish /devices/daq/events/discovery
...
Aug 11 21:03:36 udmi     INFO    Sending udmi discovery message for device 54:e0:19:d3:54:94
Waiting for 16.197 before reconnecting.
publish /devices/daq/events/discovery
....
Aug 11 21:05:50 udmi     INFO    Sending udmi discovery message for device 54:e0:19:d3:56:d4
Exceeded maximum backoff time. Giving up.
publish /devices/daq/events/discovery
Aug 11 21:06:00 udmi     INFO    Sending udmi discovery message for device 54:e0:19:d3:54:94
on_connect Connection Refused: bad user name or password.
on_disconnect 5: The connection was refused.
Waiting for 1.045 before reconnecting.
publish /devices/daq/events/discovery
...

noursaidi avatar Aug 12 '21 08:08 noursaidi