Turn on suggestions
Auto-suggest helps you quickly narrow down your search results by suggesting possible matches as you type.
- Home
- Internet of Things (IoT)
- Azure IoT
- IoT Edge runtime not able to connect to the Azure IoT Hub
IoT Edge runtime not able to connect to the Azure IoT Hub
Discussion Options
- Subscribe to RSS Feed
- Mark Discussion as New
- Mark Discussion as Read
- Pin this Discussion for Current User
- Bookmark
- Subscribe
- Printer Friendly Page
- Mark as New
- Bookmark
- Subscribe
- Mute
- Subscribe to RSS Feed
- Permalink
- Report Inappropriate Content
May 09 2022 02:46 AM
Hi,
System: ARM32, Yocto build system
I have successfully compiled Azure Edge 1.2.6(https://github.com/Azure/meta-iotedge/pull/76) for my system. I have successfully installed moby-docker as well.
Below is the iotedge system status:
root@xxxxx-imx6ull:~# iotedge system status
System services:
aziot-edged Running
aziot-identityd Running
aziot-keyd Running
aziot-certd Running
aziot-tpmd Ready
Use 'iotedge system logs' to check for non-fatal errors.
Use 'iotedge check' to diagnose connectivity and configuration issues.
I can't see my device online. After doing further debugging, I found that I am not able to access the internet(not able to resolve the DNS) from the azure IoT edge agent container. Below are the logs for the 'iotedge check'
root@xxxxx-imx6ull:~# iotedge check
Configuration checks (aziot-identity-service)
---------------------------------------------
�√ keyd configuration is well-formed - OK
�√ certd configuration is well-formed - OK
�√ tpmd configuration is well-formed - OK
�√ identityd configuration is well-formed - OK
�√ daemon configurations up-to-date with config.toml - OK
�√ identityd config toml file specifies a valid hostname - OK
�‼ aziot-identity-service package is up-to-date - Warning
Installed aziot-identity-service package has version 1.2.4 but 1.2.6 is the latest stable version available.
Please see https://aka.ms/aziot-update-runtime for update instructions.
�√ host time is close to reference time - OK
�√ preloaded certificates are valid - OK
�√ keyd is running - OK
�√ certd is running - OK
�√ identityd is running - OK
�√ read all preloaded certificates from the Certificates Service - OK
�√ read all preloaded key pairs from the Keys Service - OK
�√ ensure all preloaded certificates match preloaded private keys with the same ID - OK
Connectivity checks (aziot-identity-service)
--------------------------------------------
�√ host can connect to and perform TLS handshake with iothub AMQP port - OK
�√ host can connect to and perform TLS handshake with iothub HTTPS / WebSockets port - OK
�√ host can connect to and perform TLS handshake with iothub MQTT port - OK
Configuration checks
--------------------
�√ aziot-edged configuration is well-formed - OK
�√ configuration up-to-date with config.toml - OK
�√ container engine is installed and functional - OK
�√ configuration has correct URIs for daemon mgmt endpoint - OK
�‼ aziot-edge package is up-to-date - Warning
Installed IoT Edge daemon has version 1.2.6 but 1.2.9 is the latest stable version available.
Please see https://aka.ms/iotedge-update-runtime for update instructions.
�√ container time is close to host time - OK
�√ DNS server - OK
�‼ production readiness: container engine - Warning
Device is not using a production-supported container engine (moby-engine).
Please see https://aka.ms/iotedge-prod-checklist-moby for details.
�‼ production readiness: logs policy - Warning
Container engine is not configured to rotate module logs which may cause it run out of disk space.
Please see https://aka.ms/iotedge-prod-checklist-logs for best practices.
You can ignore this warning if you are setting log policy per module in the Edge deployment.
�‼ production readiness: Edge Agent's storage directory is persisted on the host filesystem - Warning
The edgeAgent module is not configured to persist its /tmp/edgeAgent directory on the host filesystem.
Data might be lost if the module is deleted or updated.
Please see https://aka.ms/iotedge-storage-host for best practices.
�× production readiness: Edge Hub's storage directory is persisted on the host filesystem - Error
Could not check current state of edgeHub container
�√ Agent image is valid and can be pulled from upstream - OK
Connectivity checks
-------------------
�× container on the default network can connect to upstream AMQP port - Error
Container on the default network could not connect to ourIoTHub.azure-devices.net:5671
�× container on the default network can connect to upstream HTTPS / WebSockets port - Error
Container on the default network could not connect to ourIoTHub.azure-devices.net:443
�× container on the default network can connect to upstream MQTT port - Error
Container on the default network could not connect to ourIoTHub.azure-devices.net:8883
�× container on the IoT Edge module network can connect to upstream AMQP port - Error
Container on the azure-iot-edge network could not connect to ourIoTHub.azure-devices.net:5671
�× container on the IoT Edge module network can connect to upstream HTTPS / WebSockets port - Error
Container on the azure-iot-edge network could not connect to ourIoTHub.azure-devices.net:443
�× container on the IoT Edge module network can connect to upstream MQTT port - Error
Container on the azure-iot-edge network could not connect to ourIoTHub.azure-devices.net:8883
24 check(s) succeeded.
5 check(s) raised warnings. Re-run with --verbose for more details.
7 check(s) raised errors. Re-run with --verbose for more details.
Can you please help me to debug it further?
=========================================
Below are the docker daemon configurations
root@xxxxx-imx6ull:/# cat /etc/docker/daemon.json
{
"dns": ["8.8.8.8","8.8.4.4","0.0.0.0"],
"dns-opts": [],
"dns-search": []
}
Socket permissions
root@xxxxx-imx6ull:~# ls -all /var/run/iotedge/
total 0
drwxr-xr-x 2 root root 80 May 9 06:36 .
drwxr-xr-x 20 root root 740 May 9 06:36 ..
srw-rw-rw- 1 root iotedge 0 May 9 06:36 mgmt.sock
srw-rw-rw- 1 iotedge iotedge 0 May 9 06:36 workload.sock
root@xxxxx-imx6ull:~# ls -all /var/run/aziot/
total 0
drwxr-xr-x 2 root root 120 May 9 06:36 .
drwxr-xr-x 20 root root 740 May 9 06:36 ..
srw-rw---- 1 aziotcs aziotcs 0 May 9 06:36 certd.sock
srw-rw---- 1 aziotid aziotid 0 May 9 06:36 identityd.sock
srw-rw---- 1 aziotks aziotks 0 May 9 06:36 keyd.sock
srw-rw---- 1 aziottpm aziottpm 0 May 9 06:36 tpmd.sock
iotedge system logs
-- Journal begins at Mon 2022-05-09 06:34:04 UTC, ends at Mon 2022-05-09 06:49:46 UTC. --
May 09 06:34:20 xxxxx-imx6ull aziot-certd[207]: 2022-05-09T06:34:20Z [INFO] - Starting service...
May 09 06:34:20 xxxxx-imx6ull aziot-certd[207]: 2022-05-09T06:34:20Z [INFO] - Version - dev build
May 09 06:34:20 xxxxx-imx6ull aziot-keyd[209]: 2022-05-09T06:34:20Z [INFO] - Version - dev build
May 09 06:34:20 xxxxx-imx6ull aziot-keyd[209]: 2022-05-09T06:34:20Z [INFO] - Loaded libaziot-keys with version 0x02000000
May 09 06:34:20 xxxxx-imx6ull aziot-keyd[209]: 2022-05-09T06:34:20Z [INFO] - Starting server...
May 09 06:34:20 xxxxx-imx6ull aziot-tpmd[210]: 2022-05-09T06:34:20Z [INFO] - Starting service...
May 09 06:34:20 xxxxx-imx6ull aziot-tpmd[210]: 2022-05-09T06:34:20Z [INFO] - Version - dev build
May 09 06:34:21 xxxxx-imx6ull aziot-identityd[208]: 2022-05-09T06:34:20Z [INFO] - Provisioning starting. Reason: Startup
May 09 06:34:21 xxxxx-imx6ull aziot-certd[207]: 2022-05-09T06:34:20Z [INFO] - Starting server...
May 09 06:34:21 xxxxx-imx6ull aziot-tpmd[210]: 2022-05-09T06:34:21Z [ERR!] - service encountered an error
May 09 06:34:21 xxxxx-imx6ull aziot-tpmd[210]: 2022-05-09T06:34:21Z [ERR!] - caused by: internal error
May 09 06:34:21 xxxxx-imx6ull aziot-tpmd[210]: 2022-05-09T06:34:21Z [ERR!] - caused by: could not initialize TPM
May 09 06:34:21 xxxxx-imx6ull aziot-tpmd[210]: 2022-05-09T06:34:21Z [ERR!] - caused by: TPM API returned an invalid null response
May 09 06:34:21 xxxxx-imx6ull aziot-tpmd[210]: 2022-05-09T06:34:21Z [ERR!] - 0: <unknown>
May 09 06:34:21 xxxxx-imx6ull aziot-tpmd[210]: 1: <unknown>
May 09 06:34:21 xxxxx-imx6ull aziot-tpmd[210]: 2: <unknown>
May 09 06:34:21 xxxxx-imx6ull aziot-tpmd[210]: 3: <unknown>
May 09 06:34:21 xxxxx-imx6ull aziot-tpmd[210]: 4: <unknown>
May 09 06:34:21 xxxxx-imx6ull aziot-tpmd[210]: 5: <unknown>
May 09 06:34:21 xxxxx-imx6ull aziot-tpmd[210]: 6: <unknown>
May 09 06:34:21 xxxxx-imx6ull aziot-tpmd[210]: 7: <unknown>
May 09 06:34:21 xxxxx-imx6ull aziot-tpmd[210]: 8: <unknown>
May 09 06:34:21 xxxxx-imx6ull aziot-tpmd[210]: 9: <unknown>
May 09 06:34:21 xxxxx-imx6ull aziot-tpmd[210]: 10: <unknown>
May 09 06:34:21 xxxxx-imx6ull aziot-tpmd[210]: 11: <unknown>
May 09 06:34:21 xxxxx-imx6ull aziot-tpmd[210]: 12: <unknown>
May 09 06:34:21 xxxxx-imx6ull aziot-tpmd[210]: 13: __libc_start_main
May 09 06:34:21 xxxxx-imx6ull aziot-tpmd[210]: 2022-05-09T06:34:20Z [INFO] (/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/src/hsm_log.c:log_init:22) Initialized logging
May 09 06:34:21 xxxxx-imx6ull aziot-tpmd[210]: Error: Time:Mon May 9 06:34:20 2022 File:/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/deps/utpm/src/tpm_comm_linux.c Func:tpm_usermode_resmgr_connect Line:268 Failure: No user mode TRM found.
May 09 06:34:21 xxxxx-imx6ull aziot-tpmd[210]: Error: Time:Mon May 9 06:34:20 2022 File:/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/deps/utpm/src/tpm_comm_linux.c Func:tpm_comm_create Line:335 Failure: connecting to the TPM device
May 09 06:34:21 xxxxx-imx6ull aziot-tpmd[210]: Error: Time:Mon May 9 06:34:20 2022 File:/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/deps/utpm/src/tpm_codec.c Func:Initialize_TPM_Codec Line:258 creating tpm_comm object
May 09 06:34:21 xxxxx-imx6ull aziot-tpmd[210]: 2022-05-09T06:34:20Z [ERR!] (/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/src/hsm_client_tpm_device.c:initialize_tpm_device:278) Failure initializeing TPM Codec
May 09 06:34:21 xxxxx-imx6ull aziot-tpmd[210]: 2022-05-09T06:34:20Z [ERR!] (/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/src/hsm_client_tpm_device.c:hsm_client_tpm_create:311) Failure initializing tpm device.
May 09 06:34:22 xxxxx-imx6ull aziot-identityd[208]: 2022-05-09T06:34:21Z [INFO] - Updated device info for testdevid.
May 09 06:34:22 xxxxx-imx6ull aziot-identityd[208]: 2022-05-09T06:34:21Z [INFO] - Provisioning complete.
May 09 06:34:22 xxxxx-imx6ull aziot-identityd[208]: 2022-05-09T06:34:21Z [INFO] - Identity reconciliation started. Reason: Startup
May 09 06:34:22 xxxxx-imx6ull aziot-identityd[208]: 2022-05-09T06:34:21Z [DBUG] - [hyper::proto::h1::io] flushed 71 bytes
May 09 06:34:22 xxxxx-imx6ull aziot-keyd[209]: 2022-05-09T06:34:21Z [DBUG] - [hyper::proto::h1::io] parsed 1 headers
May 09 06:34:22 xxxxx-imx6ull aziot-keyd[209]: 2022-05-09T06:34:21Z [DBUG] - [hyper::proto::h1::conn] incoming body is empty
May 09 06:34:22 xxxxx-imx6ull aziot-keyd[209]: 2022-05-09T06:34:21Z [INFO] - <-- GET /key/device-id?api-version=2020-09-01 {"host": "keyd.sock"}
May 09 06:34:22 xxxxx-imx6ull aziot-identityd[208]: 2022-05-09T06:34:22Z [DBUG] - [hyper::proto::h1::io] parsed 3 headers
May 09 06:34:22 xxxxx-imx6ull aziot-identityd[208]: 2022-05-09T06:34:22Z [DBUG] - [hyper::proto::h1::conn] incoming body is content-length (240 bytes)
May 09 06:34:22 xxxxx-imx6ull aziot-identityd[208]: 2022-05-09T06:34:22Z [DBUG] - [hyper::proto::h1::conn] incoming body completed
May 09 06:34:22 xxxxx-imx6ull aziot-identityd[208]: 2022-05-09T06:34:22Z [DBUG] - [hyper::client::pool] pooling idle connection for ("http", keyd.sock)
May 09 06:34:22 xxxxx-imx6ull aziot-identityd[208]: 2022-05-09T06:34:22Z [DBUG] - [hyper::client::pool] reuse idle connection for ("http", keyd.sock)
May 09 06:34:22 xxxxx-imx6ull aziot-keyd[209]: 2022-05-09T06:34:22Z [INFO] - --> 200 {"content-type": "application/json"}
May 09 06:34:22 xxxxx-imx6ull aziot-keyd[209]: 2022-05-09T06:34:22Z [DBUG] - [hyper::proto::h1::io] flushed 349 bytes
May 09 06:34:22 xxxxx-imx6ull aziot-keyd[209]: 2022-05-09T06:34:22Z [DBUG] - [hyper::proto::h1::io] parsed 3 headers
May 09 06:34:22 xxxxx-imx6ull aziot-keyd[209]: 2022-05-09T06:34:22Z [DBUG] - [hyper::proto::h1::conn] incoming body is content-length (370 bytes)
May 09 06:34:22 xxxxx-imx6ull aziot-keyd[209]: 2022-05-09T06:34:22Z [INFO] - <-- POST /sign?api-version=2020-09-01 {"content-type": "application/json", "host": "keyd.sock", "content-length": "370"}
May 09 06:34:22 xxxxx-imx6ull aziot-keyd[209]: 2022-05-09T06:34:22Z [DBUG] - [hyper::proto::h1::conn] incoming body completed
May 09 06:34:22 xxxxx-imx6ull aziot-keyd[209]: 2022-05-09T06:34:22Z [INFO] - --> 200 {"content-type": "application/json"}
May 09 06:34:22 xxxxx-imx6ull aziot-keyd[209]: 2022-05-09T06:34:22Z [DBUG] - [hyper::proto::h1::io] flushed 168 bytes
May 09 06:34:23 xxxxx-imx6ull aziot-identityd[208]: 2022-05-09T06:34:22Z [DBUG] - [hyper::proto::h1::io] flushed 486 bytes
May 09 06:34:23 xxxxx-imx6ull aziot-identityd[208]: 2022-05-09T06:34:22Z [DBUG] - [hyper::proto::h1::io] parsed 3 headers
May 09 06:34:23 xxxxx-imx6ull aziot-identityd[208]: 2022-05-09T06:34:22Z [DBUG] - [hyper::proto::h1::conn] incoming body is content-length (60 bytes)
May 09 06:34:23 xxxxx-imx6ull aziot-identityd[208]: 2022-05-09T06:34:22Z [DBUG] - [hyper::proto::h1::conn] incoming body completed
May 09 06:34:23 xxxxx-imx6ull aziot-identityd[208]: 2022-05-09T06:34:22Z [DBUG] - [hyper::client::pool] pooling idle connection for ("http", keyd.sock)
May 09 06:34:23 xxxxx-imx6ull aziot-identityd[208]: 2022-05-09T06:34:22Z [DBUG] - [hyper::client::connect::dns] resolving host="ourIoTHub.azure-devices.net"
May 09 06:34:23 xxxxx-imx6ull aziot-identityd[208]: 2022-05-09T06:34:23Z [WARN] - Failed to communicate with IoT Hub (attempt 1 of 1): error trying to connect: dns error: failed to lookup address information: Temporary failure in name resolution
May 09 06:34:23 xxxxx-imx6ull aziot-identityd[208]: 2022-05-09T06:34:23Z [WARN] - Network not available for Identity reconciliation. Using offline backup from last run.
May 09 06:34:23 xxxxx-imx6ull aziot-identityd[208]: 2022-05-09T06:34:23Z [INFO] - Starting server...
May 09 06:34:21 xxxxx-imx6ull systemd[1]: aziot-tpmd.service: Main process exited, code=exited, status=1/FAILURE
May 09 06:34:21 xxxxx-imx6ull systemd[1]: aziot-tpmd.service: Failed with result 'exit-code'.
May 09 06:34:31 xxxxx-imx6ull aziot-tpmd[289]: 2022-05-09T06:34:31Z [INFO] - Starting service...
May 09 06:34:31 xxxxx-imx6ull aziot-tpmd[289]: 2022-05-09T06:34:31Z [INFO] - Version - dev build
May 09 06:34:31 xxxxx-imx6ull aziot-tpmd[289]: 2022-05-09T06:34:31Z [ERR!] - service encountered an error
May 09 06:34:31 xxxxx-imx6ull aziot-tpmd[289]: 2022-05-09T06:34:31Z [ERR!] - caused by: internal error
May 09 06:34:31 xxxxx-imx6ull aziot-tpmd[289]: 2022-05-09T06:34:31Z [ERR!] - caused by: could not initialize TPM
May 09 06:34:31 xxxxx-imx6ull aziot-tpmd[289]: 2022-05-09T06:34:31Z [ERR!] - caused by: TPM API returned an invalid null response
May 09 06:34:31 xxxxx-imx6ull aziot-tpmd[289]: 2022-05-09T06:34:31Z [ERR!] - 0: <unknown>
May 09 06:34:31 xxxxx-imx6ull aziot-tpmd[289]: 1: <unknown>
May 09 06:34:31 xxxxx-imx6ull aziot-tpmd[289]: 2: <unknown>
May 09 06:34:31 xxxxx-imx6ull aziot-tpmd[289]: 3: <unknown>
May 09 06:34:31 xxxxx-imx6ull aziot-tpmd[289]: 4: <unknown>
May 09 06:34:31 xxxxx-imx6ull aziot-tpmd[289]: 5: <unknown>
May 09 06:34:31 xxxxx-imx6ull aziot-tpmd[289]: 6: <unknown>
May 09 06:34:31 xxxxx-imx6ull aziot-tpmd[289]: 7: <unknown>
May 09 06:34:31 xxxxx-imx6ull aziot-tpmd[289]: 8: <unknown>
May 09 06:34:31 xxxxx-imx6ull aziot-tpmd[289]: 9: <unknown>
May 09 06:34:31 xxxxx-imx6ull aziot-tpmd[289]: 10: <unknown>
May 09 06:34:31 xxxxx-imx6ull aziot-tpmd[289]: 11: <unknown>
May 09 06:34:31 xxxxx-imx6ull aziot-tpmd[289]: 12: <unknown>
May 09 06:34:31 xxxxx-imx6ull aziot-tpmd[289]: 13: __libc_start_main
May 09 06:34:31 xxxxx-imx6ull aziot-tpmd[289]: 2022-05-09T06:34:31Z [INFO] (/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/src/hsm_log.c:log_init:22) Initialized logging
May 09 06:34:31 xxxxx-imx6ull aziot-tpmd[289]: Error: Time:Mon May 9 06:34:31 2022 File:/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/deps/utpm/src/tpm_comm_linux.c Func:tpm_usermode_resmgr_connect Line:268 Failure: No user mode TRM found.
May 09 06:34:31 xxxxx-imx6ull aziot-tpmd[289]: Error: Time:Mon May 9 06:34:31 2022 File:/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/deps/utpm/src/tpm_comm_linux.c Func:tpm_comm_create Line:335 Failure: connecting to the TPM device
May 09 06:34:31 xxxxx-imx6ull aziot-tpmd[289]: Error: Time:Mon May 9 06:34:31 2022 File:/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/deps/utpm/src/tpm_codec.c Func:Initialize_TPM_Codec Line:258 creating tpm_comm object
May 09 06:34:31 xxxxx-imx6ull aziot-tpmd[289]: 2022-05-09T06:34:31Z [ERR!] (/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/src/hsm_client_tpm_device.c:initialize_tpm_device:278) Failure initializeing TPM Codec
May 09 06:34:31 xxxxx-imx6ull aziot-tpmd[289]: 2022-05-09T06:34:31Z [ERR!] (/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/src/hsm_client_tpm_device.c:hsm_client_tpm_create:311) Failure initializing tpm device.
May 09 06:34:30 xxxxx-imx6ull systemd[1]: aziot-tpmd.service: Scheduled restart job, restart counter is at 1.
May 09 06:34:30 xxxxx-imx6ull systemd[1]: Stopped Azure IoT TPM Service.
May 09 06:34:39 xxxxx-imx6ull aziot-tpmd[333]: 2022-05-09T06:34:37Z [INFO] - Starting service...
May 09 06:34:39 xxxxx-imx6ull aziot-tpmd[333]: 2022-05-09T06:34:37Z [INFO] - Version - dev build
May 09 06:34:39 xxxxx-imx6ull aziot-tpmd[333]: 2022-05-09T06:34:38Z [ERR!] - service encountered an error
May 09 06:34:39 xxxxx-imx6ull aziot-tpmd[333]: 2022-05-09T06:34:38Z [ERR!] - caused by: internal error
May 09 06:34:39 xxxxx-imx6ull aziot-tpmd[333]: 2022-05-09T06:34:38Z [ERR!] - caused by: could not initialize TPM
May 09 06:34:39 xxxxx-imx6ull aziot-tpmd[333]: 2022-05-09T06:34:38Z [ERR!] - caused by: TPM API returned an invalid null response
May 09 06:34:39 xxxxx-imx6ull aziot-tpmd[333]: 2022-05-09T06:34:38Z [ERR!] - 0: <unknown>
May 09 06:34:39 xxxxx-imx6ull aziot-tpmd[333]: 1: <unknown>
May 09 06:34:39 xxxxx-imx6ull aziot-tpmd[333]: 2: <unknown>
May 09 06:34:39 xxxxx-imx6ull aziot-tpmd[333]: 3: <unknown>
May 09 06:34:39 xxxxx-imx6ull aziot-tpmd[333]: 4: <unknown>
May 09 06:34:39 xxxxx-imx6ull aziot-tpmd[333]: 5: <unknown>
May 09 06:34:39 xxxxx-imx6ull aziot-tpmd[333]: 6: <unknown>
May 09 06:34:39 xxxxx-imx6ull aziot-tpmd[333]: 7: <unknown>
May 09 06:34:39 xxxxx-imx6ull aziot-tpmd[333]: 8: <unknown>
May 09 06:34:39 xxxxx-imx6ull aziot-tpmd[333]: 9: <unknown>
May 09 06:34:39 xxxxx-imx6ull aziot-tpmd[333]: 10: <unknown>
May 09 06:34:39 xxxxx-imx6ull aziot-tpmd[333]: 11: <unknown>
May 09 06:34:39 xxxxx-imx6ull aziot-tpmd[333]: 12: <unknown>
May 09 06:34:39 xxxxx-imx6ull aziot-tpmd[333]: 13: __libc_start_main
May 09 06:34:39 xxxxx-imx6ull aziot-tpmd[333]: 2022-05-09T06:34:37Z [INFO] (/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/src/hsm_log.c:log_init:22) Initialized logging
May 09 06:34:39 xxxxx-imx6ull aziot-tpmd[333]: Error: Time:Mon May 9 06:34:38 2022 File:/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/deps/utpm/src/tpm_comm_linux.c Func:tpm_usermode_resmgr_connect Line:268 Failure: No user mode TRM found.
May 09 06:34:39 xxxxx-imx6ull aziot-tpmd[333]: Error: Time:Mon May 9 06:34:38 2022 File:/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/deps/utpm/src/tpm_comm_linux.c Func:tpm_comm_create Line:335 Failure: connecting to the TPM device
May 09 06:34:39 xxxxx-imx6ull aziot-tpmd[333]: Error: Time:Mon May 9 06:34:38 2022 File:/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/deps/utpm/src/tpm_codec.c Func:Initialize_TPM_Codec Line:258 creating tpm_comm object
May 09 06:34:39 xxxxx-imx6ull aziot-tpmd[333]: 2022-05-09T06:34:38Z [ERR!] (/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/src/hsm_client_tpm_device.c:initialize_tpm_device:278) Failure initializeing TPM Codec
May 09 06:34:39 xxxxx-imx6ull aziot-tpmd[333]: 2022-05-09T06:34:38Z [ERR!] (/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/src/hsm_client_tpm_device.c:hsm_client_tpm_create:311) Failure initializing tpm device.
May 09 06:34:30 xxxxx-imx6ull systemd[1]: Started Azure IoT TPM Service.
May 09 06:34:31 xxxxx-imx6ull systemd[1]: aziot-tpmd.service: Main process exited, code=exited, status=1/FAILURE
May 09 06:34:31 xxxxx-imx6ull systemd[1]: aziot-tpmd.service: Failed with result 'exit-code'.
May 09 06:34:36 xxxxx-imx6ull systemd[1]: aziot-tpmd.service: Scheduled restart job, restart counter is at 2.
May 09 06:34:36 xxxxx-imx6ull systemd[1]: Stopped Azure IoT TPM Service.
May 09 06:34:37 xxxxx-imx6ull systemd[1]: Started Azure IoT TPM Service.
May 09 06:34:38 xxxxx-imx6ull systemd[1]: aziot-tpmd.service: Main process exited, code=exited, status=1/FAILURE
May 09 06:34:38 xxxxx-imx6ull systemd[1]: aziot-tpmd.service: Failed with result 'exit-code'.
May 09 06:34:56 xxxxx-imx6ull aziot-tpmd[374]: 2022-05-09T06:34:52Z [INFO] - Starting service...
May 09 06:34:56 xxxxx-imx6ull aziot-tpmd[374]: 2022-05-09T06:34:52Z [INFO] - Version - dev build
May 09 06:34:56 xxxxx-imx6ull aziot-tpmd[374]: 2022-05-09T06:34:52Z [ERR!] - service encountered an error
May 09 06:34:56 xxxxx-imx6ull aziot-tpmd[374]: 2022-05-09T06:34:52Z [ERR!] - caused by: internal error
May 09 06:34:56 xxxxx-imx6ull aziot-tpmd[374]: 2022-05-09T06:34:52Z [ERR!] - caused by: could not initialize TPM
May 09 06:34:56 xxxxx-imx6ull aziot-tpmd[374]: 2022-05-09T06:34:52Z [ERR!] - caused by: TPM API returned an invalid null response
May 09 06:34:56 xxxxx-imx6ull aziot-tpmd[374]: 2022-05-09T06:34:52Z [ERR!] - 0: <unknown>
May 09 06:34:56 xxxxx-imx6ull aziot-tpmd[374]: 1: <unknown>
May 09 06:34:56 xxxxx-imx6ull aziot-tpmd[374]: 2: <unknown>
May 09 06:34:56 xxxxx-imx6ull aziot-tpmd[374]: 3: <unknown>
May 09 06:34:56 xxxxx-imx6ull aziot-tpmd[374]: 4: <unknown>
May 09 06:34:56 xxxxx-imx6ull aziot-tpmd[374]: 5: <unknown>
May 09 06:34:56 xxxxx-imx6ull aziot-tpmd[374]: 6: <unknown>
May 09 06:34:56 xxxxx-imx6ull aziot-tpmd[374]: 7: <unknown>
May 09 06:34:56 xxxxx-imx6ull aziot-tpmd[374]: 8: <unknown>
May 09 06:34:56 xxxxx-imx6ull aziot-tpmd[374]: 9: <unknown>
May 09 06:34:56 xxxxx-imx6ull aziot-tpmd[374]: 10: <unknown>
May 09 06:34:56 xxxxx-imx6ull aziot-tpmd[374]: 11: <unknown>
May 09 06:34:56 xxxxx-imx6ull aziot-tpmd[374]: 12: <unknown>
May 09 06:34:56 xxxxx-imx6ull aziot-tpmd[374]: 13: __libc_start_main
May 09 06:34:56 xxxxx-imx6ull aziot-tpmd[374]: 2022-05-09T06:34:52Z [INFO] (/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/src/hsm_log.c:log_init:22) Initialized logging
May 09 06:34:56 xxxxx-imx6ull aziot-tpmd[374]: Error: Time:Mon May 9 06:34:52 2022 File:/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/deps/utpm/src/tpm_comm_linux.c Func:tpm_usermode_resmgr_connect Line:268 Failure: No user mode TRM found.
May 09 06:34:56 xxxxx-imx6ull aziot-tpmd[374]: Error: Time:Mon May 9 06:34:52 2022 File:/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/deps/utpm/src/tpm_comm_linux.c Func:tpm_comm_create Line:335 Failure: connecting to the TPM device
May 09 06:34:56 xxxxx-imx6ull aziot-tpmd[374]: Error: Time:Mon May 9 06:34:52 2022 File:/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/deps/utpm/src/tpm_codec.c Func:Initialize_TPM_Codec Line:258 creating tpm_comm object
May 09 06:34:56 xxxxx-imx6ull aziot-tpmd[374]: 2022-05-09T06:34:52Z [ERR!] (/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/src/hsm_client_tpm_device.c:initialize_tpm_device:278) Failure initializeing TPM Codec
May 09 06:34:56 xxxxx-imx6ull aziot-tpmd[374]: 2022-05-09T06:34:52Z [ERR!] (/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/src/hsm_client_tpm_device.c:hsm_client_tpm_create:311) Failure initializing tpm device.
May 09 06:34:49 xxxxx-imx6ull systemd[1]: aziot-tpmd.service: Scheduled restart job, restart counter is at 3.
May 09 06:34:50 xxxxx-imx6ull systemd[1]: Stopped Azure IoT TPM Service.
May 09 06:34:58 xxxxx-imx6ull aziot-tpmd[398]: 2022-05-09T06:34:58Z [INFO] - Starting service...
May 09 06:34:58 xxxxx-imx6ull aziot-tpmd[398]: 2022-05-09T06:34:58Z [INFO] - Version - dev build
May 09 06:34:58 xxxxx-imx6ull aziot-tpmd[398]: 2022-05-09T06:34:58Z [ERR!] - service encountered an error
May 09 06:34:58 xxxxx-imx6ull aziot-tpmd[398]: 2022-05-09T06:34:58Z [ERR!] - caused by: internal error
May 09 06:34:58 xxxxx-imx6ull aziot-tpmd[398]: 2022-05-09T06:34:58Z [ERR!] - caused by: could not initialize TPM
May 09 06:34:58 xxxxx-imx6ull aziot-tpmd[398]: 2022-05-09T06:34:58Z [ERR!] - caused by: TPM API returned an invalid null response
May 09 06:34:58 xxxxx-imx6ull aziot-tpmd[398]: 2022-05-09T06:34:58Z [ERR!] - 0: <unknown>
May 09 06:34:58 xxxxx-imx6ull aziot-tpmd[398]: 1: <unknown>
May 09 06:34:58 xxxxx-imx6ull aziot-tpmd[398]: 2: <unknown>
May 09 06:34:58 xxxxx-imx6ull aziot-tpmd[398]: 3: <unknown>
May 09 06:34:58 xxxxx-imx6ull aziot-tpmd[398]: 4: <unknown>
May 09 06:34:58 xxxxx-imx6ull aziot-tpmd[398]: 5: <unknown>
May 09 06:34:58 xxxxx-imx6ull aziot-tpmd[398]: 6: <unknown>
May 09 06:34:58 xxxxx-imx6ull aziot-tpmd[398]: 7: <unknown>
May 09 06:34:58 xxxxx-imx6ull aziot-tpmd[398]: 8: <unknown>
May 09 06:34:58 xxxxx-imx6ull aziot-tpmd[398]: 9: <unknown>
May 09 06:34:58 xxxxx-imx6ull aziot-tpmd[398]: 10: <unknown>
May 09 06:34:58 xxxxx-imx6ull aziot-tpmd[398]: 11: <unknown>
May 09 06:34:58 xxxxx-imx6ull aziot-tpmd[398]: 12: <unknown>
May 09 06:34:58 xxxxx-imx6ull aziot-tpmd[398]: 13: __libc_start_main
May 09 06:34:58 xxxxx-imx6ull aziot-tpmd[398]: 2022-05-09T06:34:58Z [INFO] (/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/src/hsm_log.c:log_init:22) Initialized logging
May 09 06:34:58 xxxxx-imx6ull aziot-tpmd[398]: Error: Time:Mon May 9 06:34:58 2022 File:/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/deps/utpm/src/tpm_comm_linux.c Func:tpm_usermode_resmgr_connect Line:268 Failure: No user mode TRM found.
May 09 06:34:58 xxxxx-imx6ull aziot-tpmd[398]: Error: Time:Mon May 9 06:34:58 2022 File:/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/deps/utpm/src/tpm_comm_linux.c Func:tpm_comm_create Line:335 Failure: connecting to the TPM device
May 09 06:34:58 xxxxx-imx6ull aziot-tpmd[398]: Error: Time:Mon May 9 06:34:58 2022 File:/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/deps/utpm/src/tpm_codec.c Func:Initialize_TPM_Codec Line:258 creating tpm_comm object
May 09 06:34:58 xxxxx-imx6ull aziot-tpmd[398]: 2022-05-09T06:34:58Z [ERR!] (/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/src/hsm_client_tpm_device.c:initialize_tpm_device:278) Failure initializeing TPM Codec
May 09 06:34:58 xxxxx-imx6ull aziot-tpmd[398]: 2022-05-09T06:34:58Z [ERR!] (/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/src/hsm_client_tpm_device.c:hsm_client_tpm_create:311) Failure initializing tpm device.
May 09 06:34:51 xxxxx-imx6ull systemd[1]: Started Azure IoT TPM Service.
May 09 06:34:52 xxxxx-imx6ull systemd[1]: aziot-tpmd.service: Main process exited, code=exited, status=1/FAILURE
May 09 06:34:52 xxxxx-imx6ull systemd[1]: aziot-tpmd.service: Failed with result 'exit-code'.
May 09 06:34:57 xxxxx-imx6ull systemd[1]: aziot-tpmd.service: Scheduled restart job, restart counter is at 4.
May 09 06:34:57 xxxxx-imx6ull systemd[1]: Stopped Azure IoT TPM Service.
May 09 06:34:57 xxxxx-imx6ull systemd[1]: Started Azure IoT TPM Service.
May 09 06:34:58 xxxxx-imx6ull systemd[1]: aziot-tpmd.service: Main process exited, code=exited, status=1/FAILURE
May 09 06:34:58 xxxxx-imx6ull systemd[1]: aziot-tpmd.service: Failed with result 'exit-code'.
May 09 06:35:03 xxxxx-imx6ull systemd[1]: aziot-tpmd.service: Scheduled restart job, restart counter is at 5.
May 09 06:35:03 xxxxx-imx6ull systemd[1]: Stopped Azure IoT TPM Service.
May 09 06:35:03 xxxxx-imx6ull systemd[1]: Started Azure IoT TPM Service.
May 09 06:35:03 xxxxx-imx6ull aziot-tpmd[429]: 2022-05-09T06:35:03Z [INFO] - Starting service...
May 09 06:35:03 xxxxx-imx6ull aziot-tpmd[429]: 2022-05-09T06:35:03Z [INFO] - Version - dev build
May 09 06:35:04 xxxxx-imx6ull aziot-tpmd[429]: 2022-05-09T06:35:04Z [ERR!] - service encountered an error
May 09 06:35:04 xxxxx-imx6ull aziot-tpmd[429]: 2022-05-09T06:35:04Z [ERR!] - caused by: internal error
May 09 06:35:04 xxxxx-imx6ull aziot-tpmd[429]: 2022-05-09T06:35:04Z [ERR!] - caused by: could not initialize TPM
May 09 06:35:04 xxxxx-imx6ull aziot-tpmd[429]: 2022-05-09T06:35:04Z [ERR!] - caused by: TPM API returned an invalid null response
May 09 06:35:04 xxxxx-imx6ull aziot-tpmd[429]: 2022-05-09T06:35:04Z [ERR!] - 0: <unknown>
May 09 06:35:04 xxxxx-imx6ull aziot-tpmd[429]: 1: <unknown>
May 09 06:35:04 xxxxx-imx6ull aziot-tpmd[429]: 2: <unknown>
May 09 06:35:04 xxxxx-imx6ull aziot-tpmd[429]: 3: <unknown>
May 09 06:35:04 xxxxx-imx6ull aziot-tpmd[429]: 4: <unknown>
May 09 06:35:04 xxxxx-imx6ull aziot-tpmd[429]: 5: <unknown>
May 09 06:35:04 xxxxx-imx6ull aziot-tpmd[429]: 6: <unknown>
May 09 06:35:04 xxxxx-imx6ull aziot-tpmd[429]: 7: <unknown>
May 09 06:35:04 xxxxx-imx6ull aziot-tpmd[429]: 8: <unknown>
May 09 06:35:04 xxxxx-imx6ull aziot-tpmd[429]: 9: <unknown>
May 09 06:35:04 xxxxx-imx6ull aziot-tpmd[429]: 10: <unknown>
May 09 06:35:04 xxxxx-imx6ull aziot-tpmd[429]: 11: <unknown>
May 09 06:35:04 xxxxx-imx6ull aziot-tpmd[429]: 12: <unknown>
May 09 06:35:04 xxxxx-imx6ull aziot-tpmd[429]: 13: __libc_start_main
May 09 06:35:04 xxxxx-imx6ull aziot-tpmd[429]: 2022-05-09T06:35:03Z [INFO] (/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/src/hsm_log.c:log_init:22) Initialized logging
May 09 06:35:04 xxxxx-imx6ull aziot-tpmd[429]: Error: Time:Mon May 9 06:35:03 2022 File:/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/deps/utpm/src/tpm_comm_linux.c Func:tpm_usermode_resmgr_connect Line:268 Failure: No user mode TRM found.
May 09 06:35:04 xxxxx-imx6ull aziot-tpmd[429]: Error: Time:Mon May 9 06:35:03 2022 File:/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/deps/utpm/src/tpm_comm_linux.c Func:tpm_comm_create Line:335 Failure: connecting to the TPM device
May 09 06:35:04 xxxxx-imx6ull aziot-tpmd[429]: Error: Time:Mon May 9 06:35:03 2022 File:/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/deps/utpm/src/tpm_codec.c Func:Initialize_TPM_Codec Line:258 creating tpm_comm object
May 09 06:35:04 xxxxx-imx6ull aziot-tpmd[429]: 2022-05-09T06:35:03Z [ERR!] (/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/src/hsm_client_tpm_device.c:initialize_tpm_device:278) Failure initializeing TPM Codec
May 09 06:35:04 xxxxx-imx6ull aziot-tpmd[429]: 2022-05-09T06:35:03Z [ERR!] (/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/src/hsm_client_tpm_device.c:hsm_client_tpm_create:311) Failure initializing tpm device.
May 09 06:35:04 xxxxx-imx6ull systemd[1]: aziot-tpmd.service: Main process exited, code=exited, status=1/FAILURE
May 09 06:35:04 xxxxx-imx6ull systemd[1]: aziot-tpmd.service: Failed with result 'exit-code'.
May 09 06:35:09 xxxxx-imx6ull systemd[1]: aziot-tpmd.service: Scheduled restart job, restart counter is at 6.
May 09 06:35:09 xxxxx-imx6ull systemd[1]: Stopped Azure IoT TPM Service.
May 09 06:35:09 xxxxx-imx6ull systemd[1]: Started Azure IoT TPM Service.
May 09 06:35:09 xxxxx-imx6ull aziot-tpmd[518]: 2022-05-09T06:35:09Z [INFO] - Starting service...
May 09 06:35:09 xxxxx-imx6ull aziot-tpmd[518]: 2022-05-09T06:35:09Z [INFO] - Version - dev build
May 09 06:35:09 xxxxx-imx6ull aziot-tpmd[518]: 2022-05-09T06:35:09Z [ERR!] - service encountered an error
May 09 06:35:09 xxxxx-imx6ull aziot-tpmd[518]: 2022-05-09T06:35:09Z [ERR!] - caused by: internal error
May 09 06:35:09 xxxxx-imx6ull aziot-tpmd[518]: 2022-05-09T06:35:09Z [ERR!] - caused by: could not initialize TPM
May 09 06:35:09 xxxxx-imx6ull aziot-tpmd[518]: 2022-05-09T06:35:09Z [ERR!] - caused by: TPM API returned an invalid null response
May 09 06:35:09 xxxxx-imx6ull aziot-tpmd[518]: 2022-05-09T06:35:09Z [ERR!] - 0: <unknown>
May 09 06:35:09 xxxxx-imx6ull aziot-tpmd[518]: 1: <unknown>
May 09 06:35:09 xxxxx-imx6ull aziot-tpmd[518]: 2: <unknown>
May 09 06:35:09 xxxxx-imx6ull aziot-tpmd[518]: 3: <unknown>
May 09 06:35:09 xxxxx-imx6ull aziot-tpmd[518]: 4: <unknown>
May 09 06:35:09 xxxxx-imx6ull aziot-tpmd[518]: 5: <unknown>
May 09 06:35:09 xxxxx-imx6ull aziot-tpmd[518]: 6: <unknown>
May 09 06:35:09 xxxxx-imx6ull aziot-tpmd[518]: 7: <unknown>
May 09 06:35:09 xxxxx-imx6ull aziot-tpmd[518]: 8: <unknown>
May 09 06:35:09 xxxxx-imx6ull aziot-tpmd[518]: 9: <unknown>
May 09 06:35:09 xxxxx-imx6ull aziot-tpmd[518]: 10: <unknown>
May 09 06:35:09 xxxxx-imx6ull aziot-tpmd[518]: 11: <unknown>
May 09 06:35:09 xxxxx-imx6ull aziot-tpmd[518]: 12: <unknown>
May 09 06:35:09 xxxxx-imx6ull aziot-tpmd[518]: 13: __libc_start_main
May 09 06:35:09 xxxxx-imx6ull aziot-tpmd[518]: 2022-05-09T06:35:09Z [INFO] (/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/src/hsm_log.c:log_init:22) Initialized logging
May 09 06:35:09 xxxxx-imx6ull aziot-tpmd[518]: Error: Time:Mon May 9 06:35:09 2022 File:/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/deps/utpm/src/tpm_comm_linux.c Func:tpm_usermode_resmgr_connect Line:268 Failure: No user mode TRM found.
May 09 06:35:09 xxxxx-imx6ull aziot-tpmd[518]: Error: Time:Mon May 9 06:35:09 2022 File:/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/deps/utpm/src/tpm_comm_linux.c Func:tpm_comm_create Line:335 Failure: connecting to the TPM device
May 09 06:35:09 xxxxx-imx6ull aziot-tpmd[518]: Error: Time:Mon May 9 06:35:09 2022 File:/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/deps/utpm/src/tpm_codec.c Func:Initialize_TPM_Codec Line:258 creating tpm_comm object
May 09 06:35:09 xxxxx-imx6ull aziot-tpmd[518]: 2022-05-09T06:35:09Z [ERR!] (/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/src/hsm_client_tpm_device.c:initialize_tpm_device:278) Failure initializeing TPM Codec
May 09 06:35:09 xxxxx-imx6ull aziot-tpmd[518]: 2022-05-09T06:35:09Z [ERR!] (/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/src/hsm_client_tpm_device.c:hsm_client_tpm_create:311) Failure initializing tpm device.
May 09 06:35:09 xxxxx-imx6ull systemd[1]: aziot-tpmd.service: Main process exited, code=exited, status=1/FAILURE
May 09 06:35:09 xxxxx-imx6ull systemd[1]: aziot-tpmd.service: Failed with result 'exit-code'.
May 09 06:35:14 xxxxx-imx6ull systemd[1]: aziot-tpmd.service: Scheduled restart job, restart counter is at 7.
May 09 06:35:14 xxxxx-imx6ull systemd[1]: Stopped Azure IoT TPM Service.
May 09 06:35:14 xxxxx-imx6ull systemd[1]: Started Azure IoT TPM Service.
May 09 06:35:14 xxxxx-imx6ull aziot-tpmd[541]: 2022-05-09T06:35:14Z [INFO] - Starting service...
May 09 06:35:14 xxxxx-imx6ull aziot-tpmd[541]: 2022-05-09T06:35:14Z [INFO] - Version - dev build
May 09 06:35:14 xxxxx-imx6ull aziot-tpmd[541]: 2022-05-09T06:35:14Z [ERR!] - service encountered an error
May 09 06:35:14 xxxxx-imx6ull aziot-tpmd[541]: 2022-05-09T06:35:14Z [ERR!] - caused by: internal error
May 09 06:35:14 xxxxx-imx6ull aziot-tpmd[541]: 2022-05-09T06:35:14Z [ERR!] - caused by: could not initialize TPM
May 09 06:35:14 xxxxx-imx6ull aziot-tpmd[541]: 2022-05-09T06:35:14Z [ERR!] - caused by: TPM API returned an invalid null response
May 09 06:35:14 xxxxx-imx6ull aziot-tpmd[541]: 2022-05-09T06:35:14Z [ERR!] - 0: <unknown>
May 09 06:35:14 xxxxx-imx6ull aziot-tpmd[541]: 1: <unknown>
May 09 06:35:14 xxxxx-imx6ull aziot-tpmd[541]: 2: <unknown>
May 09 06:35:14 xxxxx-imx6ull aziot-tpmd[541]: 3: <unknown>
May 09 06:35:14 xxxxx-imx6ull aziot-tpmd[541]: 4: <unknown>
May 09 06:35:14 xxxxx-imx6ull aziot-tpmd[541]: 5: <unknown>
May 09 06:35:14 xxxxx-imx6ull aziot-tpmd[541]: 6: <unknown>
May 09 06:35:14 xxxxx-imx6ull aziot-tpmd[541]: 7: <unknown>
May 09 06:35:14 xxxxx-imx6ull aziot-tpmd[541]: 8: <unknown>
May 09 06:35:14 xxxxx-imx6ull aziot-tpmd[541]: 9: <unknown>
May 09 06:35:14 xxxxx-imx6ull aziot-tpmd[541]: 10: <unknown>
May 09 06:35:14 xxxxx-imx6ull aziot-tpmd[541]: 11: <unknown>
May 09 06:35:14 xxxxx-imx6ull aziot-tpmd[541]: 12: <unknown>
May 09 06:35:14 xxxxx-imx6ull aziot-tpmd[541]: 13: __libc_start_main
May 09 06:35:14 xxxxx-imx6ull aziot-tpmd[541]: 2022-05-09T06:35:14Z [INFO] (/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/src/hsm_log.c:log_init:22) Initialized logging
May 09 06:35:14 xxxxx-imx6ull aziot-tpmd[541]: Error: Time:Mon May 9 06:35:14 2022 File:/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/deps/utpm/src/tpm_comm_linux.c Func:tpm_usermode_resmgr_connect Line:268 Failure: No user mode TRM found.
May 09 06:35:14 xxxxx-imx6ull aziot-tpmd[541]: Error: Time:Mon May 9 06:35:14 2022 File:/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/deps/utpm/src/tpm_comm_linux.c Func:tpm_comm_create Line:335 Failure: connecting to the TPM device
May 09 06:35:14 xxxxx-imx6ull aziot-tpmd[541]: Error: Time:Mon May 9 06:35:14 2022 File:/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/deps/utpm/src/tpm_codec.c Func:Initialize_TPM_Codec Line:258 creating tpm_comm object
May 09 06:35:14 xxxxx-imx6ull aziot-tpmd[541]: 2022-05-09T06:35:14Z [ERR!] (/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/src/hsm_client_tpm_device.c:initialize_tpm_device:278) Failure initializeing TPM Codec
May 09 06:35:14 xxxxx-imx6ull aziot-tpmd[541]: 2022-05-09T06:35:14Z [ERR!] (/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/src/hsm_client_tpm_device.c:hsm_client_tpm_create:311) Failure initializing tpm device.
May 09 06:35:14 xxxxx-imx6ull systemd[1]: aziot-tpmd.service: Main process exited, code=exited, status=1/FAILURE
May 09 06:35:15 xxxxx-imx6ull systemd[1]: aziot-tpmd.service: Failed with result 'exit-code'.
May 09 06:35:20 xxxxx-imx6ull systemd[1]: aziot-tpmd.service: Scheduled restart job, restart counter is at 8.
May 09 06:35:20 xxxxx-imx6ull systemd[1]: Stopped Azure IoT TPM Service.
May 09 06:35:20 xxxxx-imx6ull systemd[1]: Started Azure IoT TPM Service.
May 09 06:35:20 xxxxx-imx6ull aziot-tpmd[572]: 2022-05-09T06:35:20Z [INFO] - Starting service...
May 09 06:35:20 xxxxx-imx6ull aziot-tpmd[572]: 2022-05-09T06:35:20Z [INFO] - Version - dev build
May 09 06:35:20 xxxxx-imx6ull aziot-tpmd[572]: 2022-05-09T06:35:20Z [ERR!] - service encountered an error
May 09 06:35:20 xxxxx-imx6ull aziot-tpmd[572]: 2022-05-09T06:35:20Z [ERR!] - caused by: internal error
May 09 06:35:20 xxxxx-imx6ull aziot-tpmd[572]: 2022-05-09T06:35:20Z [ERR!] - caused by: could not initialize TPM
May 09 06:35:20 xxxxx-imx6ull aziot-tpmd[572]: 2022-05-09T06:35:20Z [ERR!] - caused by: TPM API returned an invalid null response
May 09 06:35:20 xxxxx-imx6ull aziot-tpmd[572]: 2022-05-09T06:35:20Z [ERR!] - 0: <unknown>
May 09 06:35:20 xxxxx-imx6ull aziot-tpmd[572]: 1: <unknown>
May 09 06:35:20 xxxxx-imx6ull aziot-tpmd[572]: 2: <unknown>
May 09 06:35:20 xxxxx-imx6ull aziot-tpmd[572]: 3: <unknown>
May 09 06:35:20 xxxxx-imx6ull aziot-tpmd[572]: 4: <unknown>
May 09 06:35:20 xxxxx-imx6ull aziot-tpmd[572]: 5: <unknown>
May 09 06:35:20 xxxxx-imx6ull aziot-tpmd[572]: 6: <unknown>
May 09 06:35:20 xxxxx-imx6ull aziot-tpmd[572]: 7: <unknown>
May 09 06:35:20 xxxxx-imx6ull aziot-tpmd[572]: 8: <unknown>
May 09 06:35:20 xxxxx-imx6ull aziot-tpmd[572]: 9: <unknown>
May 09 06:35:20 xxxxx-imx6ull aziot-tpmd[572]: 10: <unknown>
May 09 06:35:20 xxxxx-imx6ull aziot-tpmd[572]: 11: <unknown>
May 09 06:35:20 xxxxx-imx6ull aziot-tpmd[572]: 12: <unknown>
May 09 06:35:20 xxxxx-imx6ull aziot-tpmd[572]: 13: __libc_start_main
May 09 06:35:20 xxxxx-imx6ull aziot-tpmd[572]: 2022-05-09T06:35:20Z [INFO] (/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/src/hsm_log.c:log_init:22) Initialized logging
May 09 06:35:20 xxxxx-imx6ull aziot-tpmd[572]: Error: Time:Mon May 9 06:35:20 2022 File:/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/deps/utpm/src/tpm_comm_linux.c Func:tpm_usermode_resmgr_connect Line:268 Failure: No user mode TRM found.
May 09 06:35:20 xxxxx-imx6ull aziot-tpmd[572]: Error: Time:Mon May 9 06:35:20 2022 File:/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/deps/utpm/src/tpm_comm_linux.c Func:tpm_comm_create Line:335 Failure: connecting to the TPM device
May 09 06:35:20 xxxxx-imx6ull aziot-tpmd[572]: Error: Time:Mon May 9 06:35:20 2022 File:/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/deps/utpm/src/tpm_codec.c Func:Initialize_TPM_Codec Line:258 creating tpm_comm object
May 09 06:35:20 xxxxx-imx6ull aziot-tpmd[572]: 2022-05-09T06:35:20Z [ERR!] (/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/src/hsm_client_tpm_device.c:initialize_tpm_device:278) Failure initializeing TPM Codec
May 09 06:35:20 xxxxx-imx6ull aziot-tpmd[572]: 2022-05-09T06:35:20Z [ERR!] (/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/src/hsm_client_tpm_device.c:hsm_client_tpm_create:311) Failure initializing tpm device.
May 09 06:35:20 xxxxx-imx6ull systemd[1]: aziot-tpmd.service: Main process exited, code=exited, status=1/FAILURE
May 09 06:35:20 xxxxx-imx6ull systemd[1]: aziot-tpmd.service: Failed with result 'exit-code'.
May 09 06:35:25 xxxxx-imx6ull systemd[1]: aziot-tpmd.service: Scheduled restart job, restart counter is at 9.
May 09 06:35:25 xxxxx-imx6ull systemd[1]: Stopped Azure IoT TPM Service.
May 09 06:35:25 xxxxx-imx6ull systemd[1]: Started Azure IoT TPM Service.
May 09 06:35:25 xxxxx-imx6ull aziot-tpmd[593]: 2022-05-09T06:35:25Z [INFO] - Starting service...
May 09 06:35:26 xxxxx-imx6ull aziot-tpmd[593]: 2022-05-09T06:35:26Z [INFO] - Version - dev build
May 09 06:35:26 xxxxx-imx6ull aziot-tpmd[593]: 2022-05-09T06:35:26Z [ERR!] - service encountered an error
May 09 06:35:26 xxxxx-imx6ull aziot-tpmd[593]: 2022-05-09T06:35:26Z [ERR!] - caused by: internal error
May 09 06:35:26 xxxxx-imx6ull aziot-tpmd[593]: 2022-05-09T06:35:26Z [ERR!] - caused by: could not initialize TPM
May 09 06:35:26 xxxxx-imx6ull aziot-tpmd[593]: 2022-05-09T06:35:26Z [ERR!] - caused by: TPM API returned an invalid null response
May 09 06:35:26 xxxxx-imx6ull aziot-tpmd[593]: 2022-05-09T06:35:26Z [ERR!] - 0: <unknown>
May 09 06:35:26 xxxxx-imx6ull aziot-tpmd[593]: 1: <unknown>
May 09 06:35:26 xxxxx-imx6ull aziot-tpmd[593]: 2: <unknown>
May 09 06:35:26 xxxxx-imx6ull aziot-tpmd[593]: 3: <unknown>
May 09 06:35:26 xxxxx-imx6ull aziot-tpmd[593]: 4: <unknown>
May 09 06:35:26 xxxxx-imx6ull aziot-tpmd[593]: 5: <unknown>
May 09 06:35:26 xxxxx-imx6ull aziot-tpmd[593]: 6: <unknown>
May 09 06:35:26 xxxxx-imx6ull aziot-tpmd[593]: 7: <unknown>
May 09 06:35:26 xxxxx-imx6ull aziot-tpmd[593]: 8: <unknown>
May 09 06:35:26 xxxxx-imx6ull aziot-tpmd[593]: 9: <unknown>
May 09 06:35:26 xxxxx-imx6ull aziot-tpmd[593]: 10: <unknown>
May 09 06:35:26 xxxxx-imx6ull aziot-tpmd[593]: 11: <unknown>
May 09 06:35:26 xxxxx-imx6ull aziot-tpmd[593]: 12: <unknown>
May 09 06:35:26 xxxxx-imx6ull aziot-tpmd[593]: 13: __libc_start_main
May 09 06:35:26 xxxxx-imx6ull aziot-tpmd[593]: 2022-05-09T06:35:25Z [INFO] (/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/src/hsm_log.c:log_init:22) Initialized logging
May 09 06:35:26 xxxxx-imx6ull aziot-tpmd[593]: Error: Time:Mon May 9 06:35:26 2022 File:/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/deps/utpm/src/tpm_comm_linux.c Func:tpm_usermode_resmgr_connect Line:268 Failure: No user mode TRM found.
May 09 06:35:26 xxxxx-imx6ull aziot-tpmd[593]: Error: Time:Mon May 9 06:35:26 2022 File:/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/deps/utpm/src/tpm_comm_linux.c Func:tpm_comm_create Line:335 Failure: connecting to the TPM device
May 09 06:35:26 xxxxx-imx6ull aziot-tpmd[593]: Error: Time:Mon May 9 06:35:26 2022 File:/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/deps/utpm/src/tpm_codec.c Func:Initialize_TPM_Codec Line:258 creating tpm_comm object
May 09 06:35:26 xxxxx-imx6ull aziot-tpmd[593]: 2022-05-09T06:35:26Z [ERR!] (/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/src/hsm_client_tpm_device.c:initialize_tpm_device:278) Failure initializeing TPM Codec
May 09 06:35:26 xxxxx-imx6ull aziot-tpmd[593]: 2022-05-09T06:35:26Z [ERR!] (/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/src/hsm_client_tpm_device.c:hsm_client_tpm_create:311) Failure initializing tpm device.
May 09 06:35:26 xxxxx-imx6ull systemd[1]: aziot-tpmd.service: Main process exited, code=exited, status=1/FAILURE
May 09 06:35:26 xxxxx-imx6ull systemd[1]: aziot-tpmd.service: Failed with result 'exit-code'.
May 09 06:35:31 xxxxx-imx6ull systemd[1]: aziot-tpmd.service: Scheduled restart job, restart counter is at 10.
May 09 06:35:31 xxxxx-imx6ull systemd[1]: Stopped Azure IoT TPM Service.
May 09 06:35:31 xxxxx-imx6ull systemd[1]: Started Azure IoT TPM Service.
May 09 06:35:31 xxxxx-imx6ull aziot-tpmd[620]: 2022-05-09T06:35:31Z [INFO] - Starting service...
May 09 06:35:31 xxxxx-imx6ull aziot-tpmd[620]: 2022-05-09T06:35:31Z [INFO] - Version - dev build
May 09 06:35:31 xxxxx-imx6ull aziot-tpmd[620]: 2022-05-09T06:35:31Z [ERR!] - service encountered an error
May 09 06:35:31 xxxxx-imx6ull aziot-tpmd[620]: 2022-05-09T06:35:31Z [ERR!] - caused by: internal error
May 09 06:35:31 xxxxx-imx6ull aziot-tpmd[620]: 2022-05-09T06:35:31Z [ERR!] - caused by: could not initialize TPM
May 09 06:35:31 xxxxx-imx6ull aziot-tpmd[620]: 2022-05-09T06:35:31Z [ERR!] - caused by: TPM API returned an invalid null response
May 09 06:35:31 xxxxx-imx6ull aziot-tpmd[620]: 2022-05-09T06:35:31Z [ERR!] - 0: <unknown>
May 09 06:35:31 xxxxx-imx6ull aziot-tpmd[620]: 1: <unknown>
May 09 06:35:31 xxxxx-imx6ull aziot-tpmd[620]: 2: <unknown>
May 09 06:35:31 xxxxx-imx6ull aziot-tpmd[620]: 3: <unknown>
May 09 06:35:31 xxxxx-imx6ull aziot-tpmd[620]: 4: <unknown>
May 09 06:35:31 xxxxx-imx6ull aziot-tpmd[620]: 5: <unknown>
May 09 06:35:31 xxxxx-imx6ull aziot-tpmd[620]: 6: <unknown>
May 09 06:35:31 xxxxx-imx6ull aziot-tpmd[620]: 7: <unknown>
May 09 06:35:31 xxxxx-imx6ull aziot-tpmd[620]: 8: <unknown>
May 09 06:35:31 xxxxx-imx6ull aziot-tpmd[620]: 9: <unknown>
May 09 06:35:31 xxxxx-imx6ull aziot-tpmd[620]: 10: <unknown>
May 09 06:35:31 xxxxx-imx6ull aziot-tpmd[620]: 11: <unknown>
May 09 06:35:31 xxxxx-imx6ull aziot-tpmd[620]: 12: <unknown>
May 09 06:35:31 xxxxx-imx6ull aziot-tpmd[620]: 13: __libc_start_main
May 09 06:35:31 xxxxx-imx6ull aziot-tpmd[620]: 2022-05-09T06:35:31Z [INFO] (/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/src/hsm_log.c:log_init:22) Initialized logging
May 09 06:35:31 xxxxx-imx6ull aziot-tpmd[620]: Error: Time:Mon May 9 06:35:31 2022 File:/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/deps/utpm/src/tpm_comm_linux.c Func:tpm_usermode_resmgr_connect Line:268 Failure: No user mode TRM found.
May 09 06:35:31 xxxxx-imx6ull aziot-tpmd[620]: Error: Time:Mon May 9 06:35:31 2022 File:/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/deps/utpm/src/tpm_comm_linux.c Func:tpm_comm_create Line:335 Failure: connecting to the TPM device
May 09 06:35:31 xxxxx-imx6ull aziot-tpmd[620]: Error: Time:Mon May 9 06:35:31 2022 File:/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/deps/utpm/src/tpm_codec.c Func:Initialize_TPM_Codec Line:258 creating tpm_comm object
May 09 06:35:31 xxxxx-imx6ull aziot-tpmd[620]: 2022-05-09T06:35:31Z [ERR!] (/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/src/hsm_client_tpm_device.c:initialize_tpm_device:278) Failure initializeing TPM Codec
May 09 06:35:31 xxxxx-imx6ull aziot-tpmd[620]: 2022-05-09T06:35:31Z [ERR!] (/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/src/hsm_client_tpm_device.c:hsm_client_tpm_create:311) Failure initializing tpm device.
May 09 06:35:31 xxxxx-imx6ull systemd[1]: aziot-tpmd.service: Main process exited, code=exited, status=1/FAILURE
May 09 06:35:31 xxxxx-imx6ull systemd[1]: aziot-tpmd.service: Failed with result 'exit-code'.
May 09 06:35:36 xxxxx-imx6ull systemd[1]: aziot-tpmd.service: Scheduled restart job, restart counter is at 11.
May 09 06:35:36 xxxxx-imx6ull systemd[1]: Stopped Azure IoT TPM Service.
May 09 06:35:36 xxxxx-imx6ull systemd[1]: Started Azure IoT TPM Service.
May 09 06:35:37 xxxxx-imx6ull aziot-tpmd[643]: 2022-05-09T06:35:37Z [INFO] - Starting service...
May 09 06:35:37 xxxxx-imx6ull aziot-tpmd[643]: 2022-05-09T06:35:37Z [INFO] - Version - dev build
May 09 06:35:37 xxxxx-imx6ull aziot-tpmd[643]: 2022-05-09T06:35:37Z [ERR!] - service encountered an error
May 09 06:35:37 xxxxx-imx6ull aziot-tpmd[643]: 2022-05-09T06:35:37Z [ERR!] - caused by: internal error
May 09 06:35:37 xxxxx-imx6ull aziot-tpmd[643]: 2022-05-09T06:35:37Z [ERR!] - caused by: could not initialize TPM
May 09 06:35:37 xxxxx-imx6ull aziot-tpmd[643]: 2022-05-09T06:35:37Z [ERR!] - caused by: TPM API returned an invalid null response
May 09 06:35:37 xxxxx-imx6ull aziot-tpmd[643]: 2022-05-09T06:35:37Z [ERR!] - 0: <unknown>
May 09 06:35:37 xxxxx-imx6ull aziot-tpmd[643]: 1: <unknown>
May 09 06:35:37 xxxxx-imx6ull aziot-tpmd[643]: 2: <unknown>
May 09 06:35:37 xxxxx-imx6ull aziot-tpmd[643]: 3: <unknown>
May 09 06:35:37 xxxxx-imx6ull aziot-tpmd[643]: 4: <unknown>
May 09 06:35:37 xxxxx-imx6ull aziot-tpmd[643]: 5: <unknown>
May 09 06:35:37 xxxxx-imx6ull aziot-tpmd[643]: 6: <unknown>
May 09 06:35:37 xxxxx-imx6ull aziot-tpmd[643]: 7: <unknown>
May 09 06:35:37 xxxxx-imx6ull aziot-tpmd[643]: 8: <unknown>
May 09 06:35:37 xxxxx-imx6ull aziot-tpmd[643]: 9: <unknown>
May 09 06:35:37 xxxxx-imx6ull aziot-tpmd[643]: 10: <unknown>
May 09 06:35:37 xxxxx-imx6ull aziot-tpmd[643]: 11: <unknown>
May 09 06:35:37 xxxxx-imx6ull aziot-tpmd[643]: 12: <unknown>
May 09 06:35:37 xxxxx-imx6ull aziot-tpmd[643]: 13: __libc_start_main
May 09 06:35:37 xxxxx-imx6ull aziot-tpmd[643]: 2022-05-09T06:35:37Z [INFO] (/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/src/hsm_log.c:log_init:22) Initialized logging
May 09 06:35:37 xxxxx-imx6ull aziot-tpmd[643]: Error: Time:Mon May 9 06:35:37 2022 File:/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/deps/utpm/src/tpm_comm_linux.c Func:tpm_usermode_resmgr_connect Line:268 Failure: No user mode TRM found.
May 09 06:35:37 xxxxx-imx6ull aziot-tpmd[643]: Error: Time:Mon May 9 06:35:37 2022 File:/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/deps/utpm/src/tpm_comm_linux.c Func:tpm_comm_create Line:335 Failure: connecting to the TPM device
May 09 06:35:37 xxxxx-imx6ull aziot-tpmd[643]: Error: Time:Mon May 9 06:35:37 2022 File:/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/deps/utpm/src/tpm_codec.c Func:Initialize_TPM_Codec Line:258 creating tpm_comm object
May 09 06:35:37 xxxxx-imx6ull aziot-tpmd[643]: 2022-05-09T06:35:37Z [ERR!] (/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/src/hsm_client_tpm_device.c:initialize_tpm_device:278) Failure initializeing TPM Codec
May 09 06:35:37 xxxxx-imx6ull aziot-tpmd[643]: 2022-05-09T06:35:37Z [ERR!] (/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/src/hsm_client_tpm_device.c:hsm_client_tpm_create:311) Failure initializing tpm device.
May 09 06:35:37 xxxxx-imx6ull systemd[1]: aziot-tpmd.service: Main process exited, code=exited, status=1/FAILURE
May 09 06:35:37 xxxxx-imx6ull systemd[1]: aziot-tpmd.service: Failed with result 'exit-code'.
May 09 06:35:42 xxxxx-imx6ull systemd[1]: aziot-tpmd.service: Scheduled restart job, restart counter is at 12.
May 09 06:35:42 xxxxx-imx6ull systemd[1]: Stopped Azure IoT TPM Service.
May 09 06:35:42 xxxxx-imx6ull systemd[1]: Started Azure IoT TPM Service.
May 09 06:35:42 xxxxx-imx6ull aziot-tpmd[674]: 2022-05-09T06:35:42Z [INFO] - Starting service...
May 09 06:35:42 xxxxx-imx6ull aziot-tpmd[674]: 2022-05-09T06:35:42Z [INFO] - Version - dev build
May 09 06:35:42 xxxxx-imx6ull aziot-tpmd[674]: 2022-05-09T06:35:42Z [ERR!] - service encountered an error
May 09 06:35:42 xxxxx-imx6ull aziot-tpmd[674]: 2022-05-09T06:35:42Z [ERR!] - caused by: internal error
May 09 06:35:42 xxxxx-imx6ull aziot-tpmd[674]: 2022-05-09T06:35:42Z [ERR!] - caused by: could not initialize TPM
May 09 06:35:42 xxxxx-imx6ull aziot-tpmd[674]: 2022-05-09T06:35:42Z [ERR!] - caused by: TPM API returned an invalid null response
May 09 06:35:42 xxxxx-imx6ull aziot-tpmd[674]: 2022-05-09T06:35:42Z [ERR!] - 0: <unknown>
May 09 06:35:42 xxxxx-imx6ull aziot-tpmd[674]: 1: <unknown>
May 09 06:35:42 xxxxx-imx6ull aziot-tpmd[674]: 2: <unknown>
May 09 06:35:42 xxxxx-imx6ull aziot-tpmd[674]: 3: <unknown>
May 09 06:35:42 xxxxx-imx6ull aziot-tpmd[674]: 4: <unknown>
May 09 06:35:42 xxxxx-imx6ull aziot-tpmd[674]: 5: <unknown>
May 09 06:35:42 xxxxx-imx6ull aziot-tpmd[674]: 6: <unknown>
May 09 06:35:42 xxxxx-imx6ull aziot-tpmd[674]: 7: <unknown>
May 09 06:35:42 xxxxx-imx6ull aziot-tpmd[674]: 8: <unknown>
May 09 06:35:42 xxxxx-imx6ull aziot-tpmd[674]: 9: <unknown>
May 09 06:35:42 xxxxx-imx6ull aziot-tpmd[674]: 10: <unknown>
May 09 06:35:42 xxxxx-imx6ull aziot-tpmd[674]: 11: <unknown>
May 09 06:35:42 xxxxx-imx6ull aziot-tpmd[674]: 12: <unknown>
May 09 06:35:42 xxxxx-imx6ull aziot-tpmd[674]: 13: __libc_start_main
May 09 06:35:42 xxxxx-imx6ull aziot-tpmd[674]: 2022-05-09T06:35:42Z [INFO] (/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/src/hsm_log.c:log_init:22) Initialized logging
May 09 06:35:42 xxxxx-imx6ull aziot-tpmd[674]: Error: Time:Mon May 9 06:35:42 2022 File:/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/deps/utpm/src/tpm_comm_linux.c Func:tpm_usermode_resmgr_connect Line:268 Failure: No user mode TRM found.
May 09 06:35:42 xxxxx-imx6ull aziot-tpmd[674]: Error: Time:Mon May 9 06:35:42 2022 File:/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/deps/utpm/src/tpm_comm_linux.c Func:tpm_comm_create Line:335 Failure: connecting to the TPM device
May 09 06:35:42 xxxxx-imx6ull aziot-tpmd[674]: Error: Time:Mon May 9 06:35:42 2022 File:/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/deps/utpm/src/tpm_codec.c Func:Initialize_TPM_Codec Line:258 creating tpm_comm object
May 09 06:35:42 xxxxx-imx6ull aziot-tpmd[674]: 2022-05-09T06:35:42Z [ERR!] (/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/src/hsm_client_tpm_device.c:initialize_tpm_device:278) Failure initializeing TPM Codec
May 09 06:35:42 xxxxx-imx6ull aziot-tpmd[674]: 2022-05-09T06:35:42Z [ERR!] (/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/src/hsm_client_tpm_device.c:hsm_client_tpm_create:311) Failure initializing tpm device.
May 09 06:35:42 xxxxx-imx6ull systemd[1]: aziot-tpmd.service: Main process exited, code=exited, status=1/FAILURE
May 09 06:35:42 xxxxx-imx6ull systemd[1]: aziot-tpmd.service: Failed with result 'exit-code'.
May 09 06:35:47 xxxxx-imx6ull systemd[1]: aziot-tpmd.service: Scheduled restart job, restart counter is at 13.
May 09 06:35:47 xxxxx-imx6ull systemd[1]: Stopped Azure IoT TPM Service.
May 09 06:35:48 xxxxx-imx6ull systemd[1]: Started Azure IoT TPM Service.
May 09 06:35:48 xxxxx-imx6ull aziot-tpmd[701]: 2022-05-09T06:35:48Z [INFO] - Starting service...
May 09 06:35:48 xxxxx-imx6ull aziot-tpmd[701]: 2022-05-09T06:35:48Z [INFO] - Version - dev build
May 09 06:35:48 xxxxx-imx6ull aziot-tpmd[701]: 2022-05-09T06:35:48Z [ERR!] - service encountered an error
May 09 06:35:48 xxxxx-imx6ull aziot-tpmd[701]: 2022-05-09T06:35:48Z [ERR!] - caused by: internal error
May 09 06:35:48 xxxxx-imx6ull aziot-tpmd[701]: 2022-05-09T06:35:48Z [ERR!] - caused by: could not initialize TPM
May 09 06:35:48 xxxxx-imx6ull aziot-tpmd[701]: 2022-05-09T06:35:48Z [ERR!] - caused by: TPM API returned an invalid null response
May 09 06:35:48 xxxxx-imx6ull aziot-tpmd[701]: 2022-05-09T06:35:48Z [ERR!] - 0: <unknown>
May 09 06:35:48 xxxxx-imx6ull aziot-tpmd[701]: 1: <unknown>
May 09 06:35:48 xxxxx-imx6ull aziot-tpmd[701]: 2: <unknown>
May 09 06:35:48 xxxxx-imx6ull aziot-tpmd[701]: 3: <unknown>
May 09 06:35:48 xxxxx-imx6ull aziot-tpmd[701]: 4: <unknown>
May 09 06:35:48 xxxxx-imx6ull aziot-tpmd[701]: 5: <unknown>
May 09 06:35:48 xxxxx-imx6ull aziot-tpmd[701]: 6: <unknown>
May 09 06:35:48 xxxxx-imx6ull aziot-tpmd[701]: 7: <unknown>
May 09 06:35:48 xxxxx-imx6ull aziot-tpmd[701]: 8: <unknown>
May 09 06:35:48 xxxxx-imx6ull aziot-tpmd[701]: 9: <unknown>
May 09 06:35:48 xxxxx-imx6ull aziot-tpmd[701]: 10: <unknown>
May 09 06:35:48 xxxxx-imx6ull aziot-tpmd[701]: 11: <unknown>
May 09 06:35:48 xxxxx-imx6ull aziot-tpmd[701]: 12: <unknown>
May 09 06:35:48 xxxxx-imx6ull aziot-tpmd[701]: 13: __libc_start_main
May 09 06:35:48 xxxxx-imx6ull aziot-tpmd[701]: 2022-05-09T06:35:48Z [INFO] (/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/src/hsm_log.c:log_init:22) Initialized logging
May 09 06:35:48 xxxxx-imx6ull aziot-tpmd[701]: Error: Time:Mon May 9 06:35:48 2022 File:/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/deps/utpm/src/tpm_comm_linux.c Func:tpm_usermode_resmgr_connect Line:268 Failure: No user mode TRM found.
May 09 06:35:48 xxxxx-imx6ull aziot-tpmd[701]: Error: Time:Mon May 9 06:35:48 2022 File:/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/deps/utpm/src/tpm_comm_linux.c Func:tpm_comm_create Line:335 Failure: connecting to the TPM device
May 09 06:35:48 xxxxx-imx6ull aziot-tpmd[701]: Error: Time:Mon May 9 06:35:48 2022 File:/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/deps/utpm/src/tpm_codec.c Func:Initialize_TPM_Codec Line:258 creating tpm_comm object
May 09 06:35:48 xxxxx-imx6ull aziot-tpmd[701]: 2022-05-09T06:35:48Z [ERR!] (/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/src/hsm_client_tpm_device.c:initialize_tpm_device:278) Failure initializeing TPM Codec
May 09 06:35:48 xxxxx-imx6ull aziot-tpmd[701]: 2022-05-09T06:35:48Z [ERR!] (/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/src/hsm_client_tpm_device.c:hsm_client_tpm_create:311) Failure initializing tpm device.
May 09 06:35:48 xxxxx-imx6ull systemd[1]: aziot-tpmd.service: Main process exited, code=exited, status=1/FAILURE
May 09 06:35:48 xxxxx-imx6ull systemd[1]: aziot-tpmd.service: Failed with result 'exit-code'.
May 09 06:35:53 xxxxx-imx6ull systemd[1]: aziot-tpmd.service: Scheduled restart job, restart counter is at 14.
May 09 06:35:53 xxxxx-imx6ull systemd[1]: Stopped Azure IoT TPM Service.
May 09 06:35:53 xxxxx-imx6ull systemd[1]: Started Azure IoT TPM Service.
May 09 06:35:53 xxxxx-imx6ull aziot-tpmd[730]: 2022-05-09T06:35:53Z [INFO] - Starting service...
May 09 06:35:54 xxxxx-imx6ull aziot-tpmd[730]: 2022-05-09T06:35:54Z [INFO] - Version - dev build
May 09 06:35:54 xxxxx-imx6ull aziot-tpmd[730]: 2022-05-09T06:35:54Z [ERR!] - service encountered an error
May 09 06:35:54 xxxxx-imx6ull aziot-tpmd[730]: 2022-05-09T06:35:54Z [ERR!] - caused by: internal error
May 09 06:35:54 xxxxx-imx6ull aziot-tpmd[730]: 2022-05-09T06:35:54Z [ERR!] - caused by: could not initialize TPM
May 09 06:35:54 xxxxx-imx6ull aziot-tpmd[730]: 2022-05-09T06:35:54Z [ERR!] - caused by: TPM API returned an invalid null response
May 09 06:35:54 xxxxx-imx6ull aziot-tpmd[730]: 2022-05-09T06:35:54Z [ERR!] - 0: <unknown>
May 09 06:35:54 xxxxx-imx6ull aziot-tpmd[730]: 1: <unknown>
May 09 06:35:54 xxxxx-imx6ull aziot-tpmd[730]: 2: <unknown>
May 09 06:35:54 xxxxx-imx6ull aziot-tpmd[730]: 3: <unknown>
May 09 06:35:54 xxxxx-imx6ull aziot-tpmd[730]: 4: <unknown>
May 09 06:35:54 xxxxx-imx6ull aziot-tpmd[730]: 5: <unknown>
May 09 06:35:54 xxxxx-imx6ull aziot-tpmd[730]: 6: <unknown>
May 09 06:35:54 xxxxx-imx6ull aziot-tpmd[730]: 7: <unknown>
May 09 06:35:54 xxxxx-imx6ull aziot-tpmd[730]: 8: <unknown>
May 09 06:35:54 xxxxx-imx6ull aziot-tpmd[730]: 9: <unknown>
May 09 06:35:54 xxxxx-imx6ull aziot-tpmd[730]: 10: <unknown>
May 09 06:35:54 xxxxx-imx6ull aziot-tpmd[730]: 11: <unknown>
May 09 06:35:54 xxxxx-imx6ull aziot-tpmd[730]: 12: <unknown>
May 09 06:35:54 xxxxx-imx6ull aziot-tpmd[730]: 13: __libc_start_main
May 09 06:35:54 xxxxx-imx6ull aziot-tpmd[730]: 2022-05-09T06:35:53Z [INFO] (/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/src/hsm_log.c:log_init:22) Initialized logging
May 09 06:35:54 xxxxx-imx6ull aziot-tpmd[730]: Error: Time:Mon May 9 06:35:54 2022 File:/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/deps/utpm/src/tpm_comm_linux.c Func:tpm_usermode_resmgr_connect Line:268 Failure: No user mode TRM found.
May 09 06:35:54 xxxxx-imx6ull aziot-tpmd[730]: Error: Time:Mon May 9 06:35:54 2022 File:/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/deps/utpm/src/tpm_comm_linux.c Func:tpm_comm_create Line:335 Failure: connecting to the TPM device
May 09 06:35:54 xxxxx-imx6ull aziot-tpmd[730]: Error: Time:Mon May 9 06:35:54 2022 File:/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/deps/utpm/src/tpm_codec.c Func:Initialize_TPM_Codec Line:258 creating tpm_comm object
May 09 06:35:54 xxxxx-imx6ull aziot-tpmd[730]: 2022-05-09T06:35:54Z [ERR!] (/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/src/hsm_client_tpm_device.c:initialize_tpm_device:278) Failure initializeing TPM Codec
May 09 06:35:54 xxxxx-imx6ull aziot-tpmd[730]: 2022-05-09T06:35:54Z [ERR!] (/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/src/hsm_client_tpm_device.c:hsm_client_tpm_create:311) Failure initializing tpm device.
May 09 06:35:54 xxxxx-imx6ull systemd[1]: aziot-tpmd.service: Main process exited, code=exited, status=1/FAILURE
May 09 06:35:54 xxxxx-imx6ull systemd[1]: aziot-tpmd.service: Failed with result 'exit-code'.
May 09 06:35:59 xxxxx-imx6ull systemd[1]: aziot-tpmd.service: Scheduled restart job, restart counter is at 15.
May 09 06:35:59 xxxxx-imx6ull systemd[1]: Stopped Azure IoT TPM Service.
May 09 06:35:59 xxxxx-imx6ull systemd[1]: Started Azure IoT TPM Service.
May 09 06:35:59 xxxxx-imx6ull aziot-tpmd[753]: 2022-05-09T06:35:59Z [INFO] - Starting service...
May 09 06:35:59 xxxxx-imx6ull aziot-tpmd[753]: 2022-05-09T06:35:59Z [INFO] - Version - dev build
May 09 06:35:59 xxxxx-imx6ull aziot-tpmd[753]: 2022-05-09T06:35:59Z [ERR!] - service encountered an error
May 09 06:35:59 xxxxx-imx6ull aziot-tpmd[753]: 2022-05-09T06:35:59Z [ERR!] - caused by: internal error
May 09 06:35:59 xxxxx-imx6ull aziot-tpmd[753]: 2022-05-09T06:35:59Z [ERR!] - caused by: could not initialize TPM
May 09 06:35:59 xxxxx-imx6ull aziot-tpmd[753]: 2022-05-09T06:35:59Z [ERR!] - caused by: TPM API returned an invalid null response
May 09 06:35:59 xxxxx-imx6ull aziot-tpmd[753]: 2022-05-09T06:35:59Z [ERR!] - 0: <unknown>
May 09 06:35:59 xxxxx-imx6ull aziot-tpmd[753]: 1: <unknown>
May 09 06:35:59 xxxxx-imx6ull aziot-tpmd[753]: 2: <unknown>
May 09 06:35:59 xxxxx-imx6ull aziot-tpmd[753]: 3: <unknown>
May 09 06:35:59 xxxxx-imx6ull aziot-tpmd[753]: 4: <unknown>
May 09 06:35:59 xxxxx-imx6ull aziot-tpmd[753]: 5: <unknown>
May 09 06:35:59 xxxxx-imx6ull aziot-tpmd[753]: 6: <unknown>
May 09 06:35:59 xxxxx-imx6ull aziot-tpmd[753]: 7: <unknown>
May 09 06:35:59 xxxxx-imx6ull aziot-tpmd[753]: 8: <unknown>
May 09 06:35:59 xxxxx-imx6ull aziot-tpmd[753]: 9: <unknown>
May 09 06:35:59 xxxxx-imx6ull aziot-tpmd[753]: 10: <unknown>
May 09 06:35:59 xxxxx-imx6ull aziot-tpmd[753]: 11: <unknown>
May 09 06:35:59 xxxxx-imx6ull aziot-tpmd[753]: 12: <unknown>
May 09 06:35:59 xxxxx-imx6ull aziot-tpmd[753]: 13: __libc_start_main
May 09 06:35:59 xxxxx-imx6ull aziot-tpmd[753]: 2022-05-09T06:35:59Z [INFO] (/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/src/hsm_log.c:log_init:22) Initialized logging
May 09 06:35:59 xxxxx-imx6ull aziot-tpmd[753]: Error: Time:Mon May 9 06:35:59 2022 File:/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/deps/utpm/src/tpm_comm_linux.c Func:tpm_usermode_resmgr_connect Line:268 Failure: No user mode TRM found.
May 09 06:35:59 xxxxx-imx6ull aziot-tpmd[753]: Error: Time:Mon May 9 06:35:59 2022 File:/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/deps/utpm/src/tpm_comm_linux.c Func:tpm_comm_create Line:335 Failure: connecting to the TPM device
May 09 06:35:59 xxxxx-imx6ull aziot-tpmd[753]: Error: Time:Mon May 9 06:35:59 2022 File:/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/deps/utpm/src/tpm_codec.c Func:Initialize_TPM_Codec Line:258 creating tpm_comm object
May 09 06:35:59 xxxxx-imx6ull aziot-tpmd[753]: 2022-05-09T06:35:59Z [ERR!] (/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/src/hsm_client_tpm_device.c:initialize_tpm_device:278) Failure initializeing TPM Codec
May 09 06:35:59 xxxxx-imx6ull aziot-tpmd[753]: 2022-05-09T06:35:59Z [ERR!] (/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/src/hsm_client_tpm_device.c:hsm_client_tpm_create:311) Failure initializing tpm device.
May 09 06:35:59 xxxxx-imx6ull systemd[1]: aziot-tpmd.service: Main process exited, code=exited, status=1/FAILURE
May 09 06:35:59 xxxxx-imx6ull systemd[1]: aziot-tpmd.service: Failed with result 'exit-code'.
May 09 06:36:04 xxxxx-imx6ull systemd[1]: aziot-tpmd.service: Scheduled restart job, restart counter is at 16.
May 09 06:36:04 xxxxx-imx6ull systemd[1]: Stopped Azure IoT TPM Service.
May 09 06:36:04 xxxxx-imx6ull systemd[1]: Started Azure IoT TPM Service.
May 09 06:36:05 xxxxx-imx6ull aziot-tpmd[781]: 2022-05-09T06:36:05Z [INFO] - Starting service...
May 09 06:36:05 xxxxx-imx6ull aziot-tpmd[781]: 2022-05-09T06:36:05Z [INFO] - Version - dev build
May 09 06:36:05 xxxxx-imx6ull aziot-tpmd[781]: 2022-05-09T06:36:05Z [ERR!] - service encountered an error
May 09 06:36:05 xxxxx-imx6ull aziot-tpmd[781]: 2022-05-09T06:36:05Z [ERR!] - caused by: internal error
May 09 06:36:05 xxxxx-imx6ull aziot-tpmd[781]: 2022-05-09T06:36:05Z [ERR!] - caused by: could not initialize TPM
May 09 06:36:05 xxxxx-imx6ull aziot-tpmd[781]: 2022-05-09T06:36:05Z [ERR!] - caused by: TPM API returned an invalid null response
May 09 06:36:05 xxxxx-imx6ull aziot-tpmd[781]: 2022-05-09T06:36:05Z [ERR!] - 0: <unknown>
May 09 06:36:05 xxxxx-imx6ull aziot-tpmd[781]: 1: <unknown>
May 09 06:36:05 xxxxx-imx6ull aziot-tpmd[781]: 2: <unknown>
May 09 06:36:05 xxxxx-imx6ull aziot-tpmd[781]: 3: <unknown>
May 09 06:36:05 xxxxx-imx6ull aziot-tpmd[781]: 4: <unknown>
May 09 06:36:05 xxxxx-imx6ull aziot-tpmd[781]: 5: <unknown>
May 09 06:36:05 xxxxx-imx6ull aziot-tpmd[781]: 6: <unknown>
May 09 06:36:05 xxxxx-imx6ull aziot-tpmd[781]: 7: <unknown>
May 09 06:36:05 xxxxx-imx6ull aziot-tpmd[781]: 8: <unknown>
May 09 06:36:05 xxxxx-imx6ull aziot-tpmd[781]: 9: <unknown>
May 09 06:36:05 xxxxx-imx6ull aziot-tpmd[781]: 10: <unknown>
May 09 06:36:05 xxxxx-imx6ull aziot-tpmd[781]: 11: <unknown>
May 09 06:36:05 xxxxx-imx6ull aziot-tpmd[781]: 12: <unknown>
May 09 06:36:05 xxxxx-imx6ull aziot-tpmd[781]: 13: __libc_start_main
May 09 06:36:05 xxxxx-imx6ull aziot-tpmd[781]: 2022-05-09T06:36:05Z [INFO] (/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/src/hsm_log.c:log_init:22) Initialized logging
May 09 06:36:05 xxxxx-imx6ull aziot-tpmd[781]: Error: Time:Mon May 9 06:36:05 2022 File:/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/deps/utpm/src/tpm_comm_linux.c Func:tpm_usermode_resmgr_connect Line:268 Failure: No user mode TRM found.
May 09 06:36:05 xxxxx-imx6ull aziot-tpmd[781]: Error: Time:Mon May 9 06:36:05 2022 File:/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/deps/utpm/src/tpm_comm_linux.c Func:tpm_comm_create Line:335 Failure: connecting to the TPM device
May 09 06:36:05 xxxxx-imx6ull aziot-tpmd[781]: Error: Time:Mon May 9 06:36:05 2022 File:/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/deps/utpm/src/tpm_codec.c Func:Initialize_TPM_Codec Line:258 creating tpm_comm object
May 09 06:36:05 xxxxx-imx6ull aziot-tpmd[781]: 2022-05-09T06:36:05Z [ERR!] (/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/src/hsm_client_tpm_device.c:initialize_tpm_device:278) Failure initializeing TPM Codec
May 09 06:36:05 xxxxx-imx6ull aziot-tpmd[781]: 2022-05-09T06:36:05Z [ERR!] (/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/src/hsm_client_tpm_device.c:hsm_client_tpm_create:311) Failure initializing tpm device.
May 09 06:36:05 xxxxx-imx6ull systemd[1]: aziot-tpmd.service: Main process exited, code=exited, status=1/FAILURE
May 09 06:36:05 xxxxx-imx6ull systemd[1]: aziot-tpmd.service: Failed with result 'exit-code'.
May 09 06:36:10 xxxxx-imx6ull systemd[1]: aziot-tpmd.service: Scheduled restart job, restart counter is at 17.
May 09 06:36:10 xxxxx-imx6ull systemd[1]: Stopped Azure IoT TPM Service.
May 09 06:36:10 xxxxx-imx6ull systemd[1]: Started Azure IoT TPM Service.
May 09 06:36:10 xxxxx-imx6ull aziot-tpmd[804]: 2022-05-09T06:36:10Z [INFO] - Starting service...
May 09 06:36:10 xxxxx-imx6ull aziot-tpmd[804]: 2022-05-09T06:36:10Z [INFO] - Version - dev build
May 09 06:36:10 xxxxx-imx6ull aziot-tpmd[804]: 2022-05-09T06:36:10Z [ERR!] - service encountered an error
May 09 06:36:10 xxxxx-imx6ull aziot-tpmd[804]: 2022-05-09T06:36:10Z [ERR!] - caused by: internal error
May 09 06:36:10 xxxxx-imx6ull aziot-tpmd[804]: 2022-05-09T06:36:10Z [ERR!] - caused by: could not initialize TPM
May 09 06:36:10 xxxxx-imx6ull aziot-tpmd[804]: 2022-05-09T06:36:10Z [ERR!] - caused by: TPM API returned an invalid null response
May 09 06:36:10 xxxxx-imx6ull aziot-tpmd[804]: 2022-05-09T06:36:10Z [ERR!] - 0: <unknown>
May 09 06:36:10 xxxxx-imx6ull aziot-tpmd[804]: 1: <unknown>
May 09 06:36:10 xxxxx-imx6ull aziot-tpmd[804]: 2: <unknown>
May 09 06:36:10 xxxxx-imx6ull aziot-tpmd[804]: 3: <unknown>
May 09 06:36:10 xxxxx-imx6ull aziot-tpmd[804]: 4: <unknown>
May 09 06:36:10 xxxxx-imx6ull aziot-tpmd[804]: 5: <unknown>
May 09 06:36:10 xxxxx-imx6ull aziot-tpmd[804]: 6: <unknown>
May 09 06:36:10 xxxxx-imx6ull aziot-tpmd[804]: 7: <unknown>
May 09 06:36:10 xxxxx-imx6ull aziot-tpmd[804]: 8: <unknown>
May 09 06:36:10 xxxxx-imx6ull aziot-tpmd[804]: 9: <unknown>
May 09 06:36:10 xxxxx-imx6ull aziot-tpmd[804]: 10: <unknown>
May 09 06:36:10 xxxxx-imx6ull aziot-tpmd[804]: 11: <unknown>
May 09 06:36:10 xxxxx-imx6ull aziot-tpmd[804]: 12: <unknown>
May 09 06:36:10 xxxxx-imx6ull aziot-tpmd[804]: 13: __libc_start_main
May 09 06:36:10 xxxxx-imx6ull aziot-tpmd[804]: 2022-05-09T06:36:10Z [INFO] (/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/src/hsm_log.c:log_init:22) Initialized logging
May 09 06:36:10 xxxxx-imx6ull aziot-tpmd[804]: Error: Time:Mon May 9 06:36:10 2022 File:/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/deps/utpm/src/tpm_comm_linux.c Func:tpm_usermode_resmgr_connect Line:268 Failure: No user mode TRM found.
May 09 06:36:10 xxxxx-imx6ull aziot-tpmd[804]: Error: Time:Mon May 9 06:36:10 2022 File:/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/deps/utpm/src/tpm_comm_linux.c Func:tpm_comm_create Line:335 Failure: connecting to the TPM device
May 09 06:36:10 xxxxx-imx6ull aziot-tpmd[804]: Error: Time:Mon May 9 06:36:10 2022 File:/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/deps/utpm/src/tpm_codec.c Func:Initialize_TPM_Codec Line:258 creating tpm_comm object
May 09 06:36:10 xxxxx-imx6ull aziot-tpmd[804]: 2022-05-09T06:36:10Z [ERR!] (/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/src/hsm_client_tpm_device.c:initialize_tpm_device:278) Failure initializeing TPM Codec
May 09 06:36:10 xxxxx-imx6ull aziot-tpmd[804]: 2022-05-09T06:36:10Z [ERR!] (/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/src/hsm_client_tpm_device.c:hsm_client_tpm_create:311) Failure initializing tpm device.
May 09 06:36:10 xxxxx-imx6ull systemd[1]: aziot-tpmd.service: Main process exited, code=exited, status=1/FAILURE
May 09 06:36:10 xxxxx-imx6ull systemd[1]: aziot-tpmd.service: Failed with result 'exit-code'.
May 09 06:36:15 xxxxx-imx6ull systemd[1]: aziot-tpmd.service: Scheduled restart job, restart counter is at 18.
May 09 06:36:15 xxxxx-imx6ull systemd[1]: Stopped Azure IoT TPM Service.
May 09 06:36:15 xxxxx-imx6ull systemd[1]: Started Azure IoT TPM Service.
May 09 06:36:15 xxxxx-imx6ull aziot-tpmd[834]: 2022-05-09T06:36:15Z [INFO] - Starting service...
May 09 06:36:15 xxxxx-imx6ull aziot-tpmd[834]: 2022-05-09T06:36:15Z [INFO] - Version - dev build
May 09 06:36:15 xxxxx-imx6ull aziot-tpmd[834]: 2022-05-09T06:36:15Z [ERR!] - service encountered an error
May 09 06:36:15 xxxxx-imx6ull aziot-tpmd[834]: 2022-05-09T06:36:15Z [ERR!] - caused by: internal error
May 09 06:36:15 xxxxx-imx6ull aziot-tpmd[834]: 2022-05-09T06:36:15Z [ERR!] - caused by: could not initialize TPM
May 09 06:36:15 xxxxx-imx6ull aziot-tpmd[834]: 2022-05-09T06:36:15Z [ERR!] - caused by: TPM API returned an invalid null response
May 09 06:36:15 xxxxx-imx6ull aziot-tpmd[834]: 2022-05-09T06:36:15Z [ERR!] - 0: <unknown>
May 09 06:36:15 xxxxx-imx6ull aziot-tpmd[834]: 1: <unknown>
May 09 06:36:15 xxxxx-imx6ull aziot-tpmd[834]: 2: <unknown>
May 09 06:36:15 xxxxx-imx6ull aziot-tpmd[834]: 3: <unknown>
May 09 06:36:15 xxxxx-imx6ull aziot-tpmd[834]: 4: <unknown>
May 09 06:36:15 xxxxx-imx6ull aziot-tpmd[834]: 5: <unknown>
May 09 06:36:15 xxxxx-imx6ull aziot-tpmd[834]: 6: <unknown>
May 09 06:36:15 xxxxx-imx6ull aziot-tpmd[834]: 7: <unknown>
May 09 06:36:15 xxxxx-imx6ull aziot-tpmd[834]: 8: <unknown>
May 09 06:36:15 xxxxx-imx6ull aziot-tpmd[834]: 9: <unknown>
May 09 06:36:15 xxxxx-imx6ull aziot-tpmd[834]: 10: <unknown>
May 09 06:36:15 xxxxx-imx6ull aziot-tpmd[834]: 11: <unknown>
May 09 06:36:15 xxxxx-imx6ull aziot-tpmd[834]: 12: <unknown>
May 09 06:36:15 xxxxx-imx6ull aziot-tpmd[834]: 13: __libc_start_main
May 09 06:36:15 xxxxx-imx6ull aziot-tpmd[834]: 2022-05-09T06:36:15Z [INFO] (/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/src/hsm_log.c:log_init:22) Initialized logging
May 09 06:36:15 xxxxx-imx6ull aziot-tpmd[834]: Error: Time:Mon May 9 06:36:15 2022 File:/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/deps/utpm/src/tpm_comm_linux.c Func:tpm_usermode_resmgr_connect Line:268 Failure: No user mode TRM found.
May 09 06:36:15 xxxxx-imx6ull aziot-tpmd[834]: Error: Time:Mon May 9 06:36:15 2022 File:/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/deps/utpm/src/tpm_comm_linux.c Func:tpm_comm_create Line:335 Failure: connecting to the TPM device
May 09 06:36:15 xxxxx-imx6ull aziot-tpmd[834]: Error: Time:Mon May 9 06:36:15 2022 File:/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/deps/utpm/src/tpm_codec.c Func:Initialize_TPM_Codec Line:258 creating tpm_comm object
May 09 06:36:15 xxxxx-imx6ull aziot-tpmd[834]: 2022-05-09T06:36:15Z [ERR!] (/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/src/hsm_client_tpm_device.c:initialize_tpm_device:278) Failure initializeing TPM Codec
May 09 06:36:15 xxxxx-imx6ull aziot-tpmd[834]: 2022-05-09T06:36:15Z [ERR!] (/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/src/hsm_client_tpm_device.c:hsm_client_tpm_create:311) Failure initializing tpm device.
May 09 06:36:16 xxxxx-imx6ull systemd[1]: aziot-tpmd.service: Main process exited, code=exited, status=1/FAILURE
May 09 06:36:16 xxxxx-imx6ull systemd[1]: aziot-tpmd.service: Failed with result 'exit-code'.
May 09 06:36:20 xxxxx-imx6ull aziot-keyd[209]: 2022-05-09T06:36:20Z [DBUG] - [config_common::watcher] Incoming file watcher event: Ok(NoticeWrite("/etc/aziot/keyd/config.d/00-super.toml"))
May 09 06:36:20 xxxxx-imx6ull aziot-certd[207]: 2022-05-09T06:36:20Z [DBUG] - [config_common::watcher] Incoming file watcher event: Ok(NoticeWrite("/etc/aziot/certd/config.d/00-super.toml"))
May 09 06:36:20 xxxxx-imx6ull aziot-identityd[208]: 2022-05-09T06:36:20Z [DBUG] - [config_common::watcher] Incoming file watcher event: Ok(NoticeWrite("/etc/aziot/identityd/config.d/00-super.toml"))
May 09 06:36:21 xxxxx-imx6ull systemd[1]: aziot-tpmd.service: Scheduled restart job, restart counter is at 19.
May 09 06:36:21 xxxxx-imx6ull systemd[1]: Stopped Azure IoT TPM Service.
May 09 06:36:21 xxxxx-imx6ull systemd[1]: Started Azure IoT TPM Service.
May 09 06:36:21 xxxxx-imx6ull aziot-tpmd[869]: 2022-05-09T06:36:21Z [INFO] - Starting service...
May 09 06:36:21 xxxxx-imx6ull aziot-tpmd[869]: 2022-05-09T06:36:21Z [INFO] - Version - dev build
May 09 06:36:21 xxxxx-imx6ull aziot-tpmd[869]: 2022-05-09T06:36:21Z [ERR!] - service encountered an error
May 09 06:36:21 xxxxx-imx6ull aziot-tpmd[869]: 2022-05-09T06:36:21Z [ERR!] - caused by: internal error
May 09 06:36:21 xxxxx-imx6ull aziot-tpmd[869]: 2022-05-09T06:36:21Z [ERR!] - caused by: could not initialize TPM
May 09 06:36:21 xxxxx-imx6ull aziot-tpmd[869]: 2022-05-09T06:36:21Z [ERR!] - caused by: TPM API returned an invalid null response
May 09 06:36:21 xxxxx-imx6ull aziot-tpmd[869]: 2022-05-09T06:36:21Z [ERR!] - 0: <unknown>
May 09 06:36:21 xxxxx-imx6ull aziot-tpmd[869]: 1: <unknown>
May 09 06:36:21 xxxxx-imx6ull aziot-tpmd[869]: 2: <unknown>
May 09 06:36:21 xxxxx-imx6ull aziot-tpmd[869]: 3: <unknown>
May 09 06:36:21 xxxxx-imx6ull aziot-tpmd[869]: 4: <unknown>
May 09 06:36:21 xxxxx-imx6ull aziot-tpmd[869]: 5: <unknown>
May 09 06:36:21 xxxxx-imx6ull aziot-tpmd[869]: 6: <unknown>
May 09 06:36:21 xxxxx-imx6ull aziot-tpmd[869]: 7: <unknown>
May 09 06:36:21 xxxxx-imx6ull aziot-tpmd[869]: 8: <unknown>
May 09 06:36:21 xxxxx-imx6ull aziot-tpmd[869]: 9: <unknown>
May 09 06:36:21 xxxxx-imx6ull aziot-tpmd[869]: 10: <unknown>
May 09 06:36:21 xxxxx-imx6ull aziot-tpmd[869]: 11: <unknown>
May 09 06:36:21 xxxxx-imx6ull aziot-tpmd[869]: 12: <unknown>
May 09 06:36:21 xxxxx-imx6ull aziot-tpmd[869]: 13: __libc_start_main
May 09 06:36:21 xxxxx-imx6ull aziot-tpmd[869]: 2022-05-09T06:36:21Z [INFO] (/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/src/hsm_log.c:log_init:22) Initialized logging
May 09 06:36:21 xxxxx-imx6ull aziot-tpmd[869]: Error: Time:Mon May 9 06:36:21 2022 File:/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/deps/utpm/src/tpm_comm_linux.c Func:tpm_usermode_resmgr_connect Line:268 Failure: No user mode TRM found.
May 09 06:36:21 xxxxx-imx6ull aziot-tpmd[869]: Error: Time:Mon May 9 06:36:21 2022 File:/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/deps/utpm/src/tpm_comm_linux.c Func:tpm_comm_create Line:335 Failure: connecting to the TPM device
May 09 06:36:21 xxxxx-imx6ull aziot-tpmd[869]: Error: Time:Mon May 9 06:36:21 2022 File:/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/deps/utpm/src/tpm_codec.c Func:Initialize_TPM_Codec Line:258 creating tpm_comm object
May 09 06:36:21 xxxxx-imx6ull aziot-tpmd[869]: 2022-05-09T06:36:21Z [ERR!] (/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/src/hsm_client_tpm_device.c:initialize_tpm_device:278) Failure initializeing TPM Codec
May 09 06:36:21 xxxxx-imx6ull aziot-tpmd[869]: 2022-05-09T06:36:21Z [ERR!] (/usr/src/debug/aziotd/1.2.4-r0/git/tpm/aziot-tpm-sys/azure-iot-hsm-c/src/hsm_client_tpm_device.c:hsm_client_tpm_create:311) Failure initializing tpm device.
May 09 06:36:21 xxxxx-imx6ull systemd[1]: Stopping Azure IoT Identity Service...
May 09 06:36:21 xxxxx-imx6ull aziot-keyd[209]: 2022-05-09T06:36:21Z [DBUG] - [hyper::proto::h1::conn] read eof
May 09 06:36:21 xxxxx-imx6ull systemd[1]: aziot-tpmd.service: Main process exited, code=exited, status=1/FAILURE
May 09 06:36:21 xxxxx-imx6ull systemd[1]: aziot-tpmd.service: Failed with result 'exit-code'.
May 09 06:36:21 xxxxx-imx6ull systemd[1]: aziot-identityd.service: Succeeded.
May 09 06:36:21 xxxxx-imx6ull systemd[1]: Stopped Azure IoT Identity Service.
May 09 06:36:22 xxxxx-imx6ull systemd[1]: Stopping Azure IoT Keys Service...
May 09 06:36:22 xxxxx-imx6ull systemd[1]: aziot-keyd.service: Succeeded.
May 09 06:36:22 xxxxx-imx6ull systemd[1]: Stopped Azure IoT Keys Service.
May 09 06:36:22 xxxxx-imx6ull systemd[1]: Stopping Azure IoT Certificates Service...
May 09 06:36:22 xxxxx-imx6ull systemd[1]: aziot-certd.service: Succeeded.
May 09 06:36:22 xxxxx-imx6ull systemd[1]: Stopped Azure IoT Certificates Service.
May 09 06:36:22 xxxxx-imx6ull systemd[1]: Stopped Azure IoT TPM Service.
May 09 06:36:54 xxxxx-imx6ull systemd[1]: Started Azure IoT Edge daemon.
May 09 06:36:54 xxxxx-imx6ull aziot-edged[1176]: 2022-05-09T06:36:54Z [INFO] - Starting Azure IoT Edge Module Runtime
May 09 06:36:54 xxxxx-imx6ull aziot-edged[1176]: 2022-05-09T06:36:54Z [INFO] - Version - 1.2.6
May 09 06:36:54 xxxxx-imx6ull aziot-edged[1176]: 2022-05-09T06:36:54Z [INFO] - Initializing the module runtime...
May 09 06:36:54 xxxxx-imx6ull aziot-edged[1176]: 2022-05-09T06:36:54Z [INFO] - Initializing module runtime...
May 09 06:36:54 xxxxx-imx6ull aziot-edged[1176]: 2022-05-09T06:36:54Z [INFO] - Using runtime network id azure-iot-edge
May 09 06:36:55 xxxxx-imx6ull systemd[1]: Stopping Azure IoT Edge daemon...
May 09 06:36:55 xxxxx-imx6ull systemd[1]: aziot-edged.service: Succeeded.
May 09 06:36:55 xxxxx-imx6ull systemd[1]: Stopped Azure IoT Edge daemon.
May 09 06:36:59 xxxxx-imx6ull systemd[1]: Started Azure IoT Edge daemon.
May 09 06:36:59 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:36:59Z [INFO] - Starting Azure IoT Edge Module Runtime
May 09 06:36:59 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:36:59Z [INFO] - Version - 1.2.6
May 09 06:36:59 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:36:59Z [INFO] - Initializing the module runtime...
May 09 06:36:59 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:36:59Z [INFO] - Initializing module runtime...
May 09 06:36:59 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:36:59Z [INFO] - Using runtime network id azure-iot-edge
May 09 06:36:59 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:36:59Z [INFO] - Successfully initialized module runtime
May 09 06:36:59 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:36:59Z [INFO] - Finished initializing the module runtime.
May 09 06:36:59 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:36:59Z [INFO] - Obtaining edge device provisioning data...
May 09 06:36:59 xxxxx-imx6ull systemd[1]: Started Azure IoT Identity Service.
May 09 06:37:00 xxxxx-imx6ull aziot-identityd[1221]: 2022-05-09T06:37:00Z [INFO] - Starting service...
May 09 06:37:00 xxxxx-imx6ull aziot-identityd[1221]: 2022-05-09T06:37:00Z [INFO] - Version - dev build
May 09 06:37:00 xxxxx-imx6ull aziot-identityd[1221]: 2022-05-09T06:37:00Z [INFO] - Provisioning starting. Reason: Startup
May 09 06:37:00 xxxxx-imx6ull aziot-identityd[1221]: 2022-05-09T06:37:00Z [INFO] - Updated device info for testdevid.
May 09 06:37:00 xxxxx-imx6ull aziot-identityd[1221]: 2022-05-09T06:37:00Z [INFO] - Provisioning complete.
May 09 06:37:00 xxxxx-imx6ull aziot-identityd[1221]: 2022-05-09T06:37:00Z [INFO] - Identity reconciliation started. Reason: Startup
May 09 06:37:00 xxxxx-imx6ull aziot-identityd[1221]: 2022-05-09T06:37:00Z [DBUG] - [hyper::proto::h1::io] flushed 71 bytes
May 09 06:37:00 xxxxx-imx6ull systemd[1]: Started Azure IoT Keys Service.
May 09 06:37:00 xxxxx-imx6ull aziot-keyd[1223]: 2022-05-09T06:37:00Z [INFO] - Starting service...
May 09 06:37:00 xxxxx-imx6ull aziot-keyd[1223]: 2022-05-09T06:37:00Z [INFO] - Version - dev build
May 09 06:37:00 xxxxx-imx6ull aziot-keyd[1223]: 2022-05-09T06:37:00Z [INFO] - Loaded libaziot-keys with version 0x02000000
May 09 06:37:00 xxxxx-imx6ull aziot-keyd[1223]: 2022-05-09T06:37:00Z [INFO] - Starting server...
May 09 06:37:00 xxxxx-imx6ull aziot-keyd[1223]: 2022-05-09T06:37:00Z [DBUG] - [hyper::proto::h1::io] parsed 1 headers
May 09 06:37:00 xxxxx-imx6ull aziot-keyd[1223]: 2022-05-09T06:37:00Z [DBUG] - [hyper::proto::h1::conn] incoming body is empty
May 09 06:37:00 xxxxx-imx6ull aziot-keyd[1223]: 2022-05-09T06:37:00Z [INFO] - <-- GET /key/device-id?api-version=2020-09-01 {"host": "keyd.sock"}
May 09 06:37:00 xxxxx-imx6ull aziot-keyd[1223]: 2022-05-09T06:37:00Z [INFO] - --> 200 {"content-type": "application/json"}
May 09 06:37:00 xxxxx-imx6ull aziot-identityd[1221]: 2022-05-09T06:37:00Z [DBUG] - [hyper::proto::h1::io] parsed 3 headers
May 09 06:37:00 xxxxx-imx6ull aziot-identityd[1221]: 2022-05-09T06:37:00Z [DBUG] - [hyper::proto::h1::conn] incoming body is content-length (240 bytes)
May 09 06:37:00 xxxxx-imx6ull aziot-identityd[1221]: 2022-05-09T06:37:00Z [DBUG] - [hyper::proto::h1::conn] incoming body completed
May 09 06:37:00 xxxxx-imx6ull aziot-identityd[1221]: 2022-05-09T06:37:00Z [DBUG] - [hyper::client::pool] pooling idle connection for ("http", keyd.sock)
May 09 06:37:00 xxxxx-imx6ull aziot-identityd[1221]: 2022-05-09T06:37:00Z [DBUG] - [hyper::client::pool] reuse idle connection for ("http", keyd.sock)
May 09 06:37:00 xxxxx-imx6ull aziot-identityd[1221]: 2022-05-09T06:37:00Z [DBUG] - [hyper::proto::h1::io] flushed 486 bytes
May 09 06:37:00 xxxxx-imx6ull aziot-keyd[1223]: 2022-05-09T06:37:00Z [DBUG] - [hyper::proto::h1::io] flushed 349 bytes
May 09 06:37:00 xxxxx-imx6ull aziot-keyd[1223]: 2022-05-09T06:37:00Z [DBUG] - [hyper::proto::h1::io] parsed 3 headers
May 09 06:37:00 xxxxx-imx6ull aziot-keyd[1223]: 2022-05-09T06:37:00Z [DBUG] - [hyper::proto::h1::conn] incoming body is content-length (370 bytes)
May 09 06:37:00 xxxxx-imx6ull aziot-keyd[1223]: 2022-05-09T06:37:00Z [INFO] - <-- POST /sign?api-version=2020-09-01 {"content-type": "application/json", "host": "keyd.sock", "content-length": "370"}
May 09 06:37:00 xxxxx-imx6ull aziot-keyd[1223]: 2022-05-09T06:37:00Z [DBUG] - [hyper::proto::h1::conn] incoming body completed
May 09 06:37:00 xxxxx-imx6ull aziot-keyd[1223]: 2022-05-09T06:37:00Z [INFO] - --> 200 {"content-type": "application/json"}
May 09 06:37:00 xxxxx-imx6ull aziot-keyd[1223]: 2022-05-09T06:37:00Z [DBUG] - [hyper::proto::h1::io] flushed 168 bytes
May 09 06:37:00 xxxxx-imx6ull aziot-identityd[1221]: 2022-05-09T06:37:00Z [DBUG] - [hyper::proto::h1::io] parsed 3 headers
May 09 06:37:00 xxxxx-imx6ull aziot-identityd[1221]: 2022-05-09T06:37:00Z [DBUG] - [hyper::proto::h1::conn] incoming body is content-length (60 bytes)
May 09 06:37:00 xxxxx-imx6ull aziot-identityd[1221]: 2022-05-09T06:37:00Z [DBUG] - [hyper::proto::h1::conn] incoming body completed
May 09 06:37:00 xxxxx-imx6ull aziot-identityd[1221]: 2022-05-09T06:37:00Z [DBUG] - [hyper::client::pool] pooling idle connection for ("http", keyd.sock)
May 09 06:37:00 xxxxx-imx6ull aziot-identityd[1221]: 2022-05-09T06:37:00Z [DBUG] - [hyper::client::connect::dns] resolving host="ourIoTHub.azure-devices.net"
May 09 06:37:00 xxxxx-imx6ull aziot-identityd[1221]: 2022-05-09T06:37:00Z [DBUG] - [hyper::client::connect::http] connecting to 20.43.121.64:443
May 09 06:37:00 xxxxx-imx6ull aziot-identityd[1221]: 2022-05-09T06:37:00Z [DBUG] - [hyper::client::connect::http] connected to 20.43.121.64:443
May 09 06:37:00 xxxxx-imx6ull aziot-identityd[1221]: 2022-05-09T06:37:00Z [DBUG] - [hyper::proto::h1::io] flushed 267 bytes
May 09 06:37:00 xxxxx-imx6ull aziot-identityd[1221]: 2022-05-09T06:37:00Z [DBUG] - [hyper::proto::h1::io] parsed 6 headers
May 09 06:37:00 xxxxx-imx6ull aziot-identityd[1221]: 2022-05-09T06:37:00Z [DBUG] - [hyper::proto::h1::conn] incoming body is content-length (975 bytes)
May 09 06:37:00 xxxxx-imx6ull aziot-identityd[1221]: 2022-05-09T06:37:00Z [DBUG] - [aziot_hub_client_async] IoTHub response status 200
May 09 06:37:00 xxxxx-imx6ull aziot-identityd[1221]: 2022-05-09T06:37:00Z [DBUG] - [aziot_hub_client_async] IoTHub response headers{"content-length": "975", "content-type": "application/json; charset=utf-8", "vary": "Origin", "server": "Microsoft-HTTPAPI/2.0", "x-ms-request-id": "653ab146-9ec6-408c-9304-99a4e57acd8d", "date": "Mon, 09 May 2022 06:36:59 GMT"}
May 09 06:37:00 xxxxx-imx6ull aziot-identityd[1221]: 2022-05-09T06:37:00Z [DBUG] - [hyper::proto::h1::conn] incoming body completed
May 09 06:37:00 xxxxx-imx6ull aziot-identityd[1221]: 2022-05-09T06:37:00Z [INFO] - Identity reconciliation complete.
May 09 06:37:00 xxxxx-imx6ull aziot-identityd[1221]: 2022-05-09T06:37:00Z [INFO] - Starting server...
May 09 06:37:00 xxxxx-imx6ull aziot-identityd[1221]: 2022-05-09T06:37:00Z [DBUG] - [hyper::proto::h1::io] parsed 3 headers
May 09 06:37:00 xxxxx-imx6ull aziot-identityd[1221]: 2022-05-09T06:37:00Z [DBUG] - [hyper::proto::h1::conn] incoming body is content-length (16 bytes)
May 09 06:37:00 xxxxx-imx6ull aziot-identityd[1221]: 2022-05-09T06:37:00Z [INFO] - <-- POST /identities/device?api-version=2020-09-01 {"content-type": "application/json", "host": "2f72756e2f617a696f742f6964656e74697479642e736f636b:0", "content-length": "16"}
May 09 06:37:00 xxxxx-imx6ull aziot-identityd[1221]: 2022-05-09T06:37:00Z [DBUG] - [hyper::proto::h1::conn] incoming body completed
May 09 06:37:00 xxxxx-imx6ull aziot-identityd[1221]: 2022-05-09T06:37:00Z [DBUG] - [hyper::client::pool] reuse idle connection for ("http", keyd.sock)
May 09 06:37:00 xxxxx-imx6ull aziot-keyd[1223]: 2022-05-09T06:37:00Z [DBUG] - [hyper::proto::h1::io] parsed 1 headers
May 09 06:37:00 xxxxx-imx6ull aziot-keyd[1223]: 2022-05-09T06:37:00Z [DBUG] - [hyper::proto::h1::conn] incoming body is empty
May 09 06:37:00 xxxxx-imx6ull aziot-keyd[1223]: 2022-05-09T06:37:00Z [INFO] - <-- GET /key/device-id?api-version=2020-09-01 {"host": "keyd.sock"}
May 09 06:37:00 xxxxx-imx6ull aziot-identityd[1221]: 2022-05-09T06:37:00Z [DBUG] - [hyper::proto::h1::io] flushed 71 bytes
May 09 06:37:00 xxxxx-imx6ull aziot-keyd[1223]: 2022-05-09T06:37:00Z [INFO] - --> 200 {"content-type": "application/json"}
May 09 06:37:00 xxxxx-imx6ull aziot-keyd[1223]: 2022-05-09T06:37:00Z [DBUG] - [hyper::proto::h1::io] flushed 349 bytes
May 09 06:37:00 xxxxx-imx6ull aziot-identityd[1221]: 2022-05-09T06:37:00Z [DBUG] - [hyper::proto::h1::io] parsed 3 headers
May 09 06:37:00 xxxxx-imx6ull aziot-identityd[1221]: 2022-05-09T06:37:00Z [DBUG] - [hyper::proto::h1::conn] incoming body is content-length (240 bytes)
May 09 06:37:00 xxxxx-imx6ull aziot-identityd[1221]: 2022-05-09T06:37:00Z [DBUG] - [hyper::proto::h1::conn] incoming body completed
May 09 06:37:00 xxxxx-imx6ull aziot-identityd[1221]: 2022-05-09T06:37:00Z [DBUG] - [hyper::client::pool] pooling idle connection for ("http", keyd.sock)
May 09 06:37:00 xxxxx-imx6ull aziot-identityd[1221]: 2022-05-09T06:37:00Z [INFO] - --> 200 {"content-type": "application/json"}
May 09 06:37:00 xxxxx-imx6ull aziot-identityd[1221]: 2022-05-09T06:37:00Z [DBUG] - [hyper::proto::h1::io] flushed 502 bytes
May 09 06:37:00 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:37:00Z [INFO] - Finished provisioning edge device.
May 09 06:37:00 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:37:00Z [INFO] - Stopping all modules...
May 09 06:37:00 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:37:00Z [INFO] - Stopping module edgeAgent...
May 09 06:37:00 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:37:00Z [WARN] - Could not stop module edgeAgent
May 09 06:37:00 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:37:00Z [WARN] - caused by: Target of operation already in this state
May 09 06:37:00 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:37:00Z [INFO] - Finished stopping modules.
May 09 06:37:00 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:37:00Z [INFO] - Detecting if device information has changed...
May 09 06:37:00 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:37:00Z [INFO] - Starting management API...
May 09 06:37:01 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:37:01Z [INFO] - Starting new listener for module edgeAgent
May 09 06:37:01 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:37:01Z [INFO] - Starting watchdog with 60 second frequency...
May 09 06:37:01 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:37:01Z [INFO] - Listening on fd://aziot-edged.mgmt.socket with 1 thread for management API.
May 09 06:37:01 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:37:01Z [INFO] - Checking edge runtime status
May 09 06:37:01 xxxxx-imx6ull systemd[1]: Started Azure IoT Certificates Service.
May 09 06:37:01 xxxxx-imx6ull aziot-certd[1236]: 2022-05-09T06:37:01Z [INFO] - Starting service...
May 09 06:37:01 xxxxx-imx6ull aziot-certd[1236]: 2022-05-09T06:37:01Z [INFO] - Version - dev build
May 09 06:37:01 xxxxx-imx6ull aziot-certd[1236]: 2022-05-09T06:37:01Z [INFO] - Starting server...
May 09 06:37:01 xxxxx-imx6ull aziot-certd[1236]: 2022-05-09T06:37:01Z [DBUG] - [hyper::proto::h1::io] parsed 1 headers
May 09 06:37:01 xxxxx-imx6ull aziot-certd[1236]: 2022-05-09T06:37:01Z [DBUG] - [hyper::proto::h1::conn] incoming body is empty
May 09 06:37:01 xxxxx-imx6ull aziot-certd[1236]: 2022-05-09T06:37:01Z [INFO] - <-- GET /certificates/aziot-edged-ca?api-version=2020-09-01 {"host": "2f72756e2f617a696f742f63657274642e736f636b:0"}
May 09 06:37:01 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:37:01Z [INFO] - Edge runtime status is failed, starting module now...
May 09 06:37:01 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:37:01Z [INFO] - Starting module edgeAgent...
May 09 06:37:01 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:37:01Z [INFO] - Starting new listener for module edgeAgent
May 09 06:37:01 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:37:01Z [INFO] - Listener edgeAgent already started, removing old listener
May 09 06:37:01 xxxxx-imx6ull aziot-certd[1236]: 2022-05-09T06:37:01Z [INFO] - --> 200 {"content-type": "application/json"}
May 09 06:37:01 xxxxx-imx6ull aziot-certd[1236]: 2022-05-09T06:37:01Z [DBUG] - [hyper::proto::h1::io] flushed 1242 bytes
May 09 06:37:01 xxxxx-imx6ull aziot-certd[1236]: 2022-05-09T06:37:01Z [DBUG] - [hyper::proto::h1::io] parsed 1 headers
May 09 06:37:01 xxxxx-imx6ull aziot-certd[1236]: 2022-05-09T06:37:01Z [DBUG] - [hyper::proto::h1::conn] incoming body is empty
May 09 06:37:01 xxxxx-imx6ull aziot-certd[1236]: 2022-05-09T06:37:01Z [INFO] - <-- GET /certificates/aziot-edged-ca?api-version=2020-09-01 {"host": "2f72756e2f617a696f742f63657274642e736f636b:0"}
May 09 06:37:01 xxxxx-imx6ull aziot-certd[1236]: 2022-05-09T06:37:01Z [INFO] - --> 200 {"content-type": "application/json"}
May 09 06:37:01 xxxxx-imx6ull aziot-certd[1236]: 2022-05-09T06:37:01Z [DBUG] - [hyper::proto::h1::io] flushed 1242 bytes
May 09 06:37:01 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:37:01Z [INFO] - Listening on fd://aziot-edged.workload.socket with 1 thread for workload API.
May 09 06:37:01 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:37:01Z [INFO] - Listening on unix:///var/lib/aziot/edged/mnt/edgeAgent.sock with 1 thread for workload API.
May 09 06:37:01 xxxxx-imx6ull aziot-certd[1236]: 2022-05-09T06:37:01Z [DBUG] - [hyper::proto::h1::io] parsed 1 headers
May 09 06:37:01 xxxxx-imx6ull aziot-certd[1236]: 2022-05-09T06:37:01Z [DBUG] - [hyper::proto::h1::conn] incoming body is empty
May 09 06:37:01 xxxxx-imx6ull aziot-certd[1236]: 2022-05-09T06:37:01Z [INFO] - <-- GET /certificates/aziot-edged-ca?api-version=2020-09-01 {"host": "2f72756e2f617a696f742f63657274642e736f636b:0"}
May 09 06:37:01 xxxxx-imx6ull aziot-certd[1236]: 2022-05-09T06:37:01Z [INFO] - --> 200 {"content-type": "application/json"}
May 09 06:37:01 xxxxx-imx6ull aziot-certd[1236]: 2022-05-09T06:37:01Z [DBUG] - [hyper::proto::h1::io] flushed 1242 bytes
May 09 06:37:01 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:37:01Z [INFO] - Listening on unix:///var/lib/aziot/edged/mnt/edgeAgent.sock with 1 thread for workload API.
May 09 06:37:15 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:37:15Z [INFO] - Successfully started module edgeAgent
May 09 06:37:35 xxxxx-imx6ull aziot-certd[1236]: 2022-05-09T06:37:35Z [DBUG] - [hyper::proto::h1::io] parsed 1 headers
May 09 06:37:35 xxxxx-imx6ull aziot-certd[1236]: 2022-05-09T06:37:35Z [DBUG] - [hyper::proto::h1::conn] incoming body is empty
May 09 06:37:35 xxxxx-imx6ull aziot-certd[1236]: 2022-05-09T06:37:35Z [INFO] - <-- GET /certificates/aziot-edged-trust-bundle?api-version=2020-09-01 {"host": "2f72756e2f617a696f742f63657274642e736f636b:0"}
May 09 06:37:35 xxxxx-imx6ull aziot-certd[1236]: 2022-05-09T06:37:35Z [INFO] - --> 200 {"content-type": "application/json"}
May 09 06:37:35 xxxxx-imx6ull aziot-certd[1236]: 2022-05-09T06:37:35Z [DBUG] - [hyper::proto::h1::io] flushed 1242 bytes
May 09 06:37:35 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:37:35Z [INFO] - [work] - - - [2022-05-09 06:37:35.811169826 UTC] "GET /trust-bundle?api-version=2019-01-30 HTTP/1.1" 200 OK 1140 "-" "-" auth_id(-)
May 09 06:37:44 xxxxx-imx6ull aziot-keyd[1223]: 2022-05-09T06:37:44Z [DBUG] - [hyper::proto::h1::conn] read eof
May 09 06:37:44 xxxxx-imx6ull aziot-certd[1236]: 2022-05-09T06:37:44Z [DBUG] - [hyper::proto::h1::conn] read eof
May 09 06:37:45 xxxxx-imx6ull aziot-identityd[1221]: 2022-05-09T06:37:45Z [DBUG] - [hyper::proto::h1::conn] read eof
May 09 06:37:45 xxxxx-imx6ull aziot-certd[1236]: 2022-05-09T06:37:45Z [DBUG] - [hyper::proto::h1::io] parsed 1 headers
May 09 06:37:45 xxxxx-imx6ull aziot-certd[1236]: 2022-05-09T06:37:45Z [DBUG] - [hyper::proto::h1::conn] incoming body is empty
May 09 06:37:45 xxxxx-imx6ull aziot-certd[1236]: 2022-05-09T06:37:45Z [INFO] - <-- GET /certificates/aziot-edged-trust-bundle?api-version=2020-09-01 {"host": "certd.sock"}
May 09 06:37:45 xxxxx-imx6ull aziot-certd[1236]: 2022-05-09T06:37:45Z [INFO] - --> 200 {"content-type": "application/json"}
May 09 06:37:45 xxxxx-imx6ull aziot-certd[1236]: 2022-05-09T06:37:45Z [DBUG] - [hyper::proto::h1::io] flushed 1242 bytes
May 09 06:37:45 xxxxx-imx6ull aziot-certd[1236]: 2022-05-09T06:37:45Z [DBUG] - [hyper::proto::h1::conn] read eof
May 09 06:37:45 xxxxx-imx6ull aziot-keyd[1223]: 2022-05-09T06:37:45Z [DBUG] - [hyper::proto::h1::io] parsed 1 headers
May 09 06:37:45 xxxxx-imx6ull aziot-keyd[1223]: 2022-05-09T06:37:45Z [DBUG] - [hyper::proto::h1::conn] incoming body is empty
May 09 06:37:45 xxxxx-imx6ull aziot-keyd[1223]: 2022-05-09T06:37:45Z [INFO] - <-- GET /keypair/device-id?api-version=2020-09-01 {"host": "keyd.sock"}
May 09 06:37:45 xxxxx-imx6ull aziot-keyd[1223]: 2022-05-09T06:37:45Z [ERR!] - error:0909006C:PEM routines:get_name:no start line:../openssl-1.1.1k/crypto/pem/pem_lib.c:745:Expecting: ANY PRIVATE KEY
May 09 06:37:45 xxxxx-imx6ull aziot-keyd[1223]: 2022-05-09T06:37:45Z [ERR!] - !!! internal error
May 09 06:37:45 xxxxx-imx6ull aziot-keyd[1223]: 2022-05-09T06:37:45Z [ERR!] - !!! caused by: could not load key pair
May 09 06:37:45 xxxxx-imx6ull aziot-keyd[1223]: 2022-05-09T06:37:45Z [ERR!] - !!! caused by: could not load key pair: AZIOT_KEYS_RC_ERR_EXTERNAL
May 09 06:37:45 xxxxx-imx6ull aziot-keyd[1223]: 2022-05-09T06:37:45Z [INFO] - --> 500 {"content-type": "application/json"}
May 09 06:37:45 xxxxx-imx6ull aziot-keyd[1223]: 2022-05-09T06:37:45Z [DBUG] - [hyper::proto::h1::io] flushed 155 bytes
May 09 06:37:45 xxxxx-imx6ull aziot-keyd[1223]: 2022-05-09T06:37:45Z [DBUG] - [hyper::proto::h1::conn] read eof
May 09 06:37:45 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:37:45Z [INFO] - Querying system info...
May 09 06:37:46 xxxxx-imx6ull aziot-edged[1579]: none
May 09 06:37:46 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:37:46Z [INFO] - Successfully queried system info
May 09 06:37:46 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:37:46Z [INFO] - [mgmt] - - - [2022-05-09 06:37:46.092148369 UTC] "GET /systeminfo?api-version=2020-07-07 HTTP/1.1" 200 OK 347 "-" "-" auth_id(-)
May 09 06:37:56 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:37:56Z [INFO] - Querying system info...
May 09 06:38:00 xxxxx-imx6ull aziot-edged[1672]: none
May 09 06:38:00 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:38:00Z [INFO] - Successfully queried system info
May 09 06:38:00 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:38:00Z [INFO] - [mgmt] - - - [2022-05-09 06:38:00.899822176 UTC] "GET /systeminfo?api-version=2020-07-07 HTTP/1.1" 200 OK 347 "-" "-" auth_id(-)
May 09 06:38:01 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:38:01Z [INFO] - Checking edge runtime status
May 09 06:38:01 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:38:01Z [INFO] - Edge runtime is running.
May 09 06:38:30 xxxxx-imx6ull aziot-identityd[1221]: 2022-05-09T06:38:30Z [DBUG] - [hyper::proto::h1::conn] read eof
May 09 06:38:31 xxxxx-imx6ull aziot-certd[1236]: 2022-05-09T06:38:31Z [DBUG] - [hyper::proto::h1::conn] read eof
May 09 06:38:32 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:38:32Z [INFO] - Querying system info...
May 09 06:38:33 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:38:33Z [INFO] - Querying system info...
May 09 06:38:35 xxxxx-imx6ull aziot-edged[1928]: none
May 09 06:38:35 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:38:35Z [INFO] - Successfully queried system info
May 09 06:38:35 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:38:35Z [INFO] - [mgmt] - - - [2022-05-09 06:38:35.816178895 UTC] "GET /systeminfo?api-version=2020-07-07 HTTP/1.1" 200 OK 347 "-" "-" auth_id(-)
May 09 06:38:36 xxxxx-imx6ull aziot-edged[1936]: none
May 09 06:38:36 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:38:36Z [INFO] - Successfully queried system info
May 09 06:38:36 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:38:36Z [INFO] - [mgmt] - - - [2022-05-09 06:38:36.851207443 UTC] "GET /systeminfo?api-version=2020-07-07 HTTP/1.1" 200 OK 347 "-" "-" auth_id(-)
May 09 06:38:40 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:38:40Z [INFO] - [mgmt] - - - [2022-05-09 06:38:40.803202462 UTC] "GET /modules?api-version=2020-07-07 HTTP/1.1" 200 OK 692 "-" "-" auth_id(-)
May 09 06:38:44 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:38:44Z [INFO] - Querying system resources...
May 09 06:38:47 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:38:47Z [INFO] - [mgmt] - - - [2022-05-09 06:38:47.178954890 UTC] "GET /systeminfo/resources?api-version=2020-07-07 HTTP/1.1" 200 OK 3203 "-" "-" auth_id(-)
May 09 06:38:52 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:38:52Z [INFO] - [mgmt] - - - [2022-05-09 06:38:52.466956638 UTC] "GET /modules?api-version=2020-07-07 HTTP/1.1" 200 OK 692 "-" "-" auth_id(-)
May 09 06:39:00 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:39:00Z [INFO] - Checking edge runtime status
May 09 06:39:00 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:39:00Z [INFO] - Edge runtime is running.
May 09 06:39:02 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:39:02Z [INFO] - [mgmt] - - - [2022-05-09 06:39:02.412896352 UTC] "GET /modules?api-version=2020-07-07 HTTP/1.1" 200 OK 692 "-" "-" auth_id(-)
May 09 06:39:12 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:39:12Z [INFO] - [mgmt] - - - [2022-05-09 06:39:12.489403137 UTC] "GET /modules?api-version=2020-07-07 HTTP/1.1" 200 OK 692 "-" "-" auth_id(-)
May 09 06:39:13 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:39:13Z [INFO] - Querying system info...
May 09 06:39:14 xxxxx-imx6ull aziot-edged[2208]: none
May 09 06:39:14 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:39:14Z [INFO] - Successfully queried system info
May 09 06:39:14 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:39:14Z [INFO] - [mgmt] - - - [2022-05-09 06:39:14.087476058 UTC] "GET /systeminfo?api-version=2020-07-07 HTTP/1.1" 200 OK 347 "-" "-" auth_id(-)
May 09 06:39:22 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:39:22Z [INFO] - [mgmt] - - - [2022-05-09 06:39:22.776492869 UTC] "GET /modules?api-version=2020-07-07 HTTP/1.1" 200 OK 692 "-" "-" auth_id(-)
May 09 06:39:32 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:39:32Z [INFO] - [mgmt] - - - [2022-05-09 06:39:32.911880810 UTC] "GET /modules?api-version=2020-07-07 HTTP/1.1" 200 OK 692 "-" "-" auth_id(-)
May 09 06:39:43 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:39:43Z [INFO] - [mgmt] - - - [2022-05-09 06:39:43.011086040 UTC] "GET /modules?api-version=2020-07-07 HTTP/1.1" 200 OK 692 "-" "-" auth_id(-)
May 09 06:39:45 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:39:45Z [INFO] - Querying system info...
May 09 06:39:46 xxxxx-imx6ull aziot-edged[2359]: none
May 09 06:39:46 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:39:46Z [INFO] - Successfully queried system info
May 09 06:39:46 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:39:46Z [INFO] - [mgmt] - - - [2022-05-09 06:39:46.209714783 UTC] "GET /systeminfo?api-version=2020-07-07 HTTP/1.1" 200 OK 347 "-" "-" auth_id(-)
May 09 06:39:50 xxxxx-imx6ull aziot-keyd[1223]: 2022-05-09T06:39:50Z [DBUG] - [hyper::proto::h1::conn] read eof
May 09 06:39:50 xxxxx-imx6ull aziot-certd[1236]: 2022-05-09T06:39:50Z [DBUG] - [hyper::proto::h1::conn] read eof
May 09 06:39:50 xxxxx-imx6ull aziot-identityd[1221]: 2022-05-09T06:39:50Z [DBUG] - [hyper::proto::h1::conn] read eof
May 09 06:39:50 xxxxx-imx6ull aziot-certd[1236]: 2022-05-09T06:39:50Z [DBUG] - [hyper::proto::h1::io] parsed 1 headers
May 09 06:39:50 xxxxx-imx6ull aziot-certd[1236]: 2022-05-09T06:39:50Z [DBUG] - [hyper::proto::h1::conn] incoming body is empty
May 09 06:39:50 xxxxx-imx6ull aziot-certd[1236]: 2022-05-09T06:39:50Z [INFO] - <-- GET /certificates/aziot-edged-trust-bundle?api-version=2020-09-01 {"host": "certd.sock"}
May 09 06:39:50 xxxxx-imx6ull aziot-certd[1236]: 2022-05-09T06:39:50Z [INFO] - --> 200 {"content-type": "application/json"}
May 09 06:39:50 xxxxx-imx6ull aziot-certd[1236]: 2022-05-09T06:39:50Z [DBUG] - [hyper::proto::h1::io] flushed 1242 bytes
May 09 06:39:50 xxxxx-imx6ull aziot-certd[1236]: 2022-05-09T06:39:50Z [DBUG] - [hyper::proto::h1::conn] read eof
May 09 06:39:50 xxxxx-imx6ull aziot-keyd[1223]: 2022-05-09T06:39:50Z [DBUG] - [hyper::proto::h1::io] parsed 1 headers
May 09 06:39:50 xxxxx-imx6ull aziot-keyd[1223]: 2022-05-09T06:39:50Z [DBUG] - [hyper::proto::h1::conn] incoming body is empty
May 09 06:39:50 xxxxx-imx6ull aziot-keyd[1223]: 2022-05-09T06:39:50Z [INFO] - <-- GET /keypair/device-id?api-version=2020-09-01 {"host": "keyd.sock"}
May 09 06:39:50 xxxxx-imx6ull aziot-keyd[1223]: 2022-05-09T06:39:50Z [ERR!] - error:0909006C:PEM routines:get_name:no start line:../openssl-1.1.1k/crypto/pem/pem_lib.c:745:Expecting: ANY PRIVATE KEY
May 09 06:39:50 xxxxx-imx6ull aziot-keyd[1223]: 2022-05-09T06:39:50Z [ERR!] - !!! internal error
May 09 06:39:50 xxxxx-imx6ull aziot-keyd[1223]: 2022-05-09T06:39:50Z [ERR!] - !!! caused by: could not load key pair
May 09 06:39:50 xxxxx-imx6ull aziot-keyd[1223]: 2022-05-09T06:39:50Z [ERR!] - !!! caused by: could not load key pair: AZIOT_KEYS_RC_ERR_EXTERNAL
May 09 06:39:50 xxxxx-imx6ull aziot-keyd[1223]: 2022-05-09T06:39:50Z [INFO] - --> 500 {"content-type": "application/json"}
May 09 06:39:50 xxxxx-imx6ull aziot-keyd[1223]: 2022-05-09T06:39:50Z [DBUG] - [hyper::proto::h1::io] flushed 155 bytes
May 09 06:39:50 xxxxx-imx6ull aziot-keyd[1223]: 2022-05-09T06:39:50Z [DBUG] - [hyper::proto::h1::conn] read eof
May 09 06:39:53 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:39:53Z [INFO] - [mgmt] - - - [2022-05-09 06:39:53.130218186 UTC] "GET /modules?api-version=2020-07-07 HTTP/1.1" 200 OK 692 "-" "-" auth_id(-)
May 09 06:40:00 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:40:00Z [INFO] - Checking edge runtime status
May 09 06:40:00 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:40:00Z [INFO] - Edge runtime is running.
May 09 06:40:01 xxxxx-imx6ull aziot-certd[1236]: 2022-05-09T06:40:01Z [DBUG] - [hyper::proto::h1::conn] read eof
May 09 06:40:01 xxxxx-imx6ull aziot-certd[1236]: 2022-05-09T06:40:01Z [DBUG] - [hyper::proto::h1::conn] read eof
May 09 06:40:03 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:40:03Z [INFO] - [mgmt] - - - [2022-05-09 06:40:03.281204581 UTC] "GET /modules?api-version=2020-07-07 HTTP/1.1" 200 OK 692 "-" "-" auth_id(-)
May 09 06:40:13 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:40:13Z [INFO] - [mgmt] - - - [2022-05-09 06:40:13.350285913 UTC] "GET /modules?api-version=2020-07-07 HTTP/1.1" 200 OK 692 "-" "-" auth_id(-)
May 09 06:40:14 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:40:14Z [INFO] - [mgmt] - - - [2022-05-09 06:40:14.205853838 UTC] "GET /modules/?api-version=2018-06-28 HTTP/1.1" 200 OK 692 "-" "-" auth_id(-)
May 09 06:40:24 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:40:24Z [INFO] - [mgmt] - - - [2022-05-09 06:40:24.040582518 UTC] "GET /modules?api-version=2020-07-07 HTTP/1.1" 200 OK 692 "-" "-" auth_id(-)
May 09 06:40:25 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:40:25Z [INFO] - Querying system info...
May 09 06:40:27 xxxxx-imx6ull aziot-edged[2662]: none
May 09 06:40:27 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:40:27Z [INFO] - Successfully queried system info
May 09 06:40:27 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:40:27Z [INFO] - [mgmt] - - - [2022-05-09 06:40:27.349309493 UTC] "GET /systeminfo?api-version=2020-07-07 HTTP/1.1" 200 OK 347 "-" "-" auth_id(-)
May 09 06:40:33 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:40:33Z [INFO] - [mgmt] - - - [2022-05-09 06:40:33.626815896 UTC] "GET /modules?api-version=2020-07-07 HTTP/1.1" 200 OK 692 "-" "-" auth_id(-)
May 09 06:40:43 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:40:43Z [INFO] - [mgmt] - - - [2022-05-09 06:40:43.897566832 UTC] "GET /modules?api-version=2020-07-07 HTTP/1.1" 200 OK 692 "-" "-" auth_id(-)
May 09 06:40:53 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:40:53Z [INFO] - [mgmt] - - - [2022-05-09 06:40:53.969927782 UTC] "GET /modules?api-version=2020-07-07 HTTP/1.1" 200 OK 692 "-" "-" auth_id(-)
May 09 06:40:59 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:40:59Z [INFO] - Querying system info...
May 09 06:41:00 xxxxx-imx6ull aziot-edged[2968]: none
May 09 06:41:00 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:41:00Z [INFO] - Successfully queried system info
May 09 06:41:00 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:41:00Z [INFO] - [mgmt] - - - [2022-05-09 06:41:00.409623086 UTC] "GET /systeminfo?api-version=2020-07-07 HTTP/1.1" 200 OK 347 "-" "-" auth_id(-)
May 09 06:41:00 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:41:00Z [INFO] - Checking edge runtime status
May 09 06:41:00 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:41:00Z [INFO] - Edge runtime is running.
May 09 06:41:04 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:41:04Z [INFO] - [mgmt] - - - [2022-05-09 06:41:04.230640405 UTC] "GET /modules?api-version=2020-07-07 HTTP/1.1" 200 OK 692 "-" "-" auth_id(-)
May 09 06:41:14 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:41:14Z [INFO] - [mgmt] - - - [2022-05-09 06:41:14.101820340 UTC] "GET /modules?api-version=2020-07-07 HTTP/1.1" 200 OK 692 "-" "-" auth_id(-)
May 09 06:41:24 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:41:24Z [INFO] - [mgmt] - - - [2022-05-09 06:41:24.192032768 UTC] "GET /modules?api-version=2020-07-07 HTTP/1.1" 200 OK 692 "-" "-" auth_id(-)
May 09 06:41:34 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:41:34Z [INFO] - [mgmt] - - - [2022-05-09 06:41:34.359096206 UTC] "GET /modules?api-version=2020-07-07 HTTP/1.1" 200 OK 692 "-" "-" auth_id(-)
May 09 06:41:44 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:41:44Z [INFO] - [mgmt] - - - [2022-05-09 06:41:44.256416913 UTC] "GET /modules?api-version=2020-07-07 HTTP/1.1" 200 OK 692 "-" "-" auth_id(-)
May 09 06:41:45 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:41:45Z [INFO] - Querying system info...
May 09 06:41:47 xxxxx-imx6ull aziot-edged[3298]: none
May 09 06:41:47 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:41:47Z [INFO] - Successfully queried system info
May 09 06:41:47 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:41:47Z [INFO] - [mgmt] - - - [2022-05-09 06:41:47.564757217 UTC] "GET /systeminfo?api-version=2020-07-07 HTTP/1.1" 200 OK 347 "-" "-" auth_id(-)
May 09 06:41:54 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:41:54Z [INFO] - [mgmt] - - - [2022-05-09 06:41:54.266310253 UTC] "GET /modules?api-version=2020-07-07 HTTP/1.1" 200 OK 692 "-" "-" auth_id(-)
May 09 06:42:00 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:42:00Z [INFO] - Checking edge runtime status
May 09 06:42:00 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:42:00Z [INFO] - Edge runtime is running.
May 09 06:42:04 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:42:04Z [INFO] - [mgmt] - - - [2022-05-09 06:42:04.410086323 UTC] "GET /modules?api-version=2020-07-07 HTTP/1.1" 200 OK 692 "-" "-" auth_id(-)
May 09 06:42:14 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:42:14Z [INFO] - [mgmt] - - - [2022-05-09 06:42:14.522823444 UTC] "GET /modules?api-version=2020-07-07 HTTP/1.1" 200 OK 692 "-" "-" auth_id(-)
May 09 06:42:19 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:42:19Z [INFO] - Querying system info...
May 09 06:42:21 xxxxx-imx6ull aziot-edged[3550]: none
May 09 06:42:21 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:42:21Z [INFO] - Successfully queried system info
May 09 06:42:21 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:42:21Z [INFO] - [mgmt] - - - [2022-05-09 06:42:21.659286308 UTC] "GET /systeminfo?api-version=2020-07-07 HTTP/1.1" 200 OK 347 "-" "-" auth_id(-)
May 09 06:42:24 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:42:24Z [INFO] - [mgmt] - - - [2022-05-09 06:42:24.540849202 UTC] "GET /modules?api-version=2020-07-07 HTTP/1.1" 200 OK 692 "-" "-" auth_id(-)
May 09 06:42:34 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:42:34Z [INFO] - [mgmt] - - - [2022-05-09 06:42:34.518500247 UTC] "GET /modules?api-version=2020-07-07 HTTP/1.1" 200 OK 692 "-" "-" auth_id(-)
May 09 06:42:44 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:42:44Z [INFO] - [mgmt] - - - [2022-05-09 06:42:44.589985055 UTC] "GET /modules?api-version=2020-07-07 HTTP/1.1" 200 OK 692 "-" "-" auth_id(-)
May 09 06:42:54 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:42:54Z [INFO] - [mgmt] - - - [2022-05-09 06:42:54.955023731 UTC] "GET /modules?api-version=2020-07-07 HTTP/1.1" 200 OK 692 "-" "-" auth_id(-)
May 09 06:43:00 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:43:00Z [INFO] - Checking edge runtime status
May 09 06:43:00 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:43:00Z [INFO] - Edge runtime is running.
May 09 06:43:04 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:43:04Z [INFO] - [mgmt] - - - [2022-05-09 06:43:04.863286782 UTC] "GET /modules?api-version=2020-07-07 HTTP/1.1" 200 OK 692 "-" "-" auth_id(-)
May 09 06:43:14 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:43:14Z [INFO] - [mgmt] - - - [2022-05-09 06:43:14.669686581 UTC] "GET /modules?api-version=2020-07-07 HTTP/1.1" 200 OK 692 "-" "-" auth_id(-)
May 09 06:43:24 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:43:24Z [INFO] - [mgmt] - - - [2022-05-09 06:43:24.749466614 UTC] "GET /modules?api-version=2020-07-07 HTTP/1.1" 200 OK 692 "-" "-" auth_id(-)
May 09 06:43:28 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:43:28Z [INFO] - Querying system info...
May 09 06:43:29 xxxxx-imx6ull aziot-edged[4024]: none
May 09 06:43:29 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:43:29Z [INFO] - Successfully queried system info
May 09 06:43:29 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:43:29Z [INFO] - [mgmt] - - - [2022-05-09 06:43:29.291802958 UTC] "GET /systeminfo?api-version=2020-07-07 HTTP/1.1" 200 OK 347 "-" "-" auth_id(-)
May 09 06:43:34 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:43:34Z [INFO] - [mgmt] - - - [2022-05-09 06:43:34.769288015 UTC] "GET /modules?api-version=2020-07-07 HTTP/1.1" 200 OK 692 "-" "-" auth_id(-)
May 09 06:43:44 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:43:44Z [INFO] - [mgmt] - - - [2022-05-09 06:43:44.937980387 UTC] "GET /modules?api-version=2020-07-07 HTTP/1.1" 200 OK 692 "-" "-" auth_id(-)
May 09 06:43:52 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:43:52Z [INFO] - Querying system resources...
May 09 06:43:54 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:43:54Z [INFO] - [mgmt] - - - [2022-05-09 06:43:54.060292426 UTC] "GET /systeminfo/resources?api-version=2020-07-07 HTTP/1.1" 200 OK 3209 "-" "-" auth_id(-)
May 09 06:43:55 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:43:55Z [INFO] - [mgmt] - - - [2022-05-09 06:43:55.000017854 UTC] "GET /modules?api-version=2020-07-07 HTTP/1.1" 200 OK 692 "-" "-" auth_id(-)
May 09 06:44:00 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:44:00Z [INFO] - Checking edge runtime status
May 09 06:44:00 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:44:00Z [INFO] - Querying system info...
May 09 06:44:01 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:44:01Z [INFO] - Edge runtime is running.
May 09 06:44:02 xxxxx-imx6ull aziot-edged[4257]: none
May 09 06:44:02 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:44:02Z [INFO] - Successfully queried system info
May 09 06:44:02 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:44:02Z [INFO] - [mgmt] - - - [2022-05-09 06:44:02.428216428 UTC] "GET /systeminfo?api-version=2020-07-07 HTTP/1.1" 200 OK 347 "-" "-" auth_id(-)
May 09 06:44:04 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:44:04Z [INFO] - [mgmt] - - - [2022-05-09 06:44:04.907095038 UTC] "GET /modules?api-version=2020-07-07 HTTP/1.1" 200 OK 692 "-" "-" auth_id(-)
May 09 06:44:14 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:44:14Z [INFO] - [mgmt] - - - [2022-05-09 06:44:14.906218641 UTC] "GET /modules?api-version=2020-07-07 HTTP/1.1" 200 OK 692 "-" "-" auth_id(-)
May 09 06:44:24 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:44:24Z [INFO] - [mgmt] - - - [2022-05-09 06:44:24.899026386 UTC] "GET /modules?api-version=2020-07-07 HTTP/1.1" 200 OK 692 "-" "-" auth_id(-)
May 09 06:44:34 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:44:34Z [INFO] - [mgmt] - - - [2022-05-09 06:44:34.888225885 UTC] "GET /modules?api-version=2020-07-07 HTTP/1.1" 200 OK 692 "-" "-" auth_id(-)
May 09 06:44:44 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:44:44Z [INFO] - [mgmt] - - - [2022-05-09 06:44:44.906210684 UTC] "GET /modules?api-version=2020-07-07 HTTP/1.1" 200 OK 692 "-" "-" auth_id(-)
May 09 06:44:54 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:44:54Z [INFO] - [mgmt] - - - [2022-05-09 06:44:54.926598425 UTC] "GET /modules?api-version=2020-07-07 HTTP/1.1" 200 OK 692 "-" "-" auth_id(-)
May 09 06:45:00 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:45:00Z [INFO] - Checking edge runtime status
May 09 06:45:00 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:45:00Z [INFO] - Edge runtime is running.
May 09 06:45:04 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:45:04Z [INFO] - [mgmt] - - - [2022-05-09 06:45:04.948250429 UTC] "GET /modules?api-version=2020-07-07 HTTP/1.1" 200 OK 692 "-" "-" auth_id(-)
May 09 06:45:14 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:45:14Z [INFO] - [mgmt] - - - [2022-05-09 06:45:14.953776849 UTC] "GET /modules?api-version=2020-07-07 HTTP/1.1" 200 OK 692 "-" "-" auth_id(-)
May 09 06:45:24 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:45:24Z [INFO] - [mgmt] - - - [2022-05-09 06:45:24.969045203 UTC] "GET /modules?api-version=2020-07-07 HTTP/1.1" 200 OK 692 "-" "-" auth_id(-)
May 09 06:45:34 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:45:34Z [INFO] - Querying system info...
May 09 06:45:35 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:45:35Z [INFO] - [mgmt] - - - [2022-05-09 06:45:35.057722823 UTC] "GET /modules?api-version=2020-07-07 HTTP/1.1" 200 OK 692 "-" "-" auth_id(-)
May 09 06:45:35 xxxxx-imx6ull aziot-edged[4763]: none
May 09 06:45:35 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:45:35Z [INFO] - Successfully queried system info
May 09 06:45:35 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:45:35Z [INFO] - [mgmt] - - - [2022-05-09 06:45:35.271644763 UTC] "GET /systeminfo?api-version=2020-07-07 HTTP/1.1" 200 OK 347 "-" "-" auth_id(-)
May 09 06:45:45 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:45:45Z [INFO] - [mgmt] - - - [2022-05-09 06:45:45.039729497 UTC] "GET /modules?api-version=2020-07-07 HTTP/1.1" 200 OK 692 "-" "-" auth_id(-)
May 09 06:45:55 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:45:55Z [INFO] - [mgmt] - - - [2022-05-09 06:45:55.040574909 UTC] "GET /modules?api-version=2020-07-07 HTTP/1.1" 200 OK 692 "-" "-" auth_id(-)
May 09 06:46:00 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:46:00Z [INFO] - Checking edge runtime status
May 09 06:46:00 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:46:00Z [INFO] - Edge runtime is running.
May 09 06:46:05 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:46:05Z [INFO] - [mgmt] - - - [2022-05-09 06:46:05.059077464 UTC] "GET /modules?api-version=2020-07-07 HTTP/1.1" 200 OK 692 "-" "-" auth_id(-)
May 09 06:46:06 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:46:06Z [INFO] - Querying system info...
May 09 06:46:07 xxxxx-imx6ull aziot-edged[4916]: none
May 09 06:46:07 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:46:07Z [INFO] - Successfully queried system info
May 09 06:46:07 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:46:07Z [INFO] - [mgmt] - - - [2022-05-09 06:46:07.039026494 UTC] "GET /systeminfo?api-version=2020-07-07 HTTP/1.1" 200 OK 347 "-" "-" auth_id(-)
May 09 06:46:15 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:46:15Z [INFO] - [mgmt] - - - [2022-05-09 06:46:15.053369183 UTC] "GET /modules?api-version=2020-07-07 HTTP/1.1" 200 OK 692 "-" "-" auth_id(-)
May 09 06:46:25 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:46:25Z [INFO] - [mgmt] - - - [2022-05-09 06:46:25.071450483 UTC] "GET /modules?api-version=2020-07-07 HTTP/1.1" 200 OK 692 "-" "-" auth_id(-)
May 09 06:46:35 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:46:35Z [INFO] - [mgmt] - - - [2022-05-09 06:46:35.087961350 UTC] "GET /modules?api-version=2020-07-07 HTTP/1.1" 200 OK 692 "-" "-" auth_id(-)
May 09 06:46:45 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:46:45Z [INFO] - [mgmt] - - - [2022-05-09 06:46:45.080818387 UTC] "GET /modules?api-version=2020-07-07 HTTP/1.1" 200 OK 692 "-" "-" auth_id(-)
May 09 06:46:55 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:46:55Z [INFO] - [mgmt] - - - [2022-05-09 06:46:55.109138336 UTC] "GET /modules?api-version=2020-07-07 HTTP/1.1" 200 OK 692 "-" "-" auth_id(-)
May 09 06:47:00 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:47:00Z [INFO] - Checking edge runtime status
May 09 06:47:00 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:47:00Z [INFO] - Edge runtime is running.
May 09 06:47:05 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:47:05Z [INFO] - [mgmt] - - - [2022-05-09 06:47:05.115756683 UTC] "GET /modules?api-version=2020-07-07 HTTP/1.1" 200 OK 692 "-" "-" auth_id(-)
May 09 06:47:15 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:47:15Z [INFO] - [mgmt] - - - [2022-05-09 06:47:15.132137216 UTC] "GET /modules?api-version=2020-07-07 HTTP/1.1" 200 OK 692 "-" "-" auth_id(-)
May 09 06:47:25 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:47:25Z [INFO] - [mgmt] - - - [2022-05-09 06:47:25.160556499 UTC] "GET /modules?api-version=2020-07-07 HTTP/1.1" 200 OK 692 "-" "-" auth_id(-)
May 09 06:47:35 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:47:35Z [INFO] - [mgmt] - - - [2022-05-09 06:47:35.236845782 UTC] "GET /modules?api-version=2020-07-07 HTTP/1.1" 200 OK 692 "-" "-" auth_id(-)
May 09 06:47:39 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:47:39Z [INFO] - Querying system info...
May 09 06:47:39 xxxxx-imx6ull aziot-edged[5367]: none
May 09 06:47:39 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:47:39Z [INFO] - Successfully queried system info
May 09 06:47:39 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:47:39Z [INFO] - [mgmt] - - - [2022-05-09 06:47:39.492088172 UTC] "GET /systeminfo?api-version=2020-07-07 HTTP/1.1" 200 OK 347 "-" "-" auth_id(-)
May 09 06:47:45 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:47:45Z [INFO] - [mgmt] - - - [2022-05-09 06:47:45.227384420 UTC] "GET /modules?api-version=2020-07-07 HTTP/1.1" 200 OK 692 "-" "-" auth_id(-)
May 09 06:47:55 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:47:55Z [INFO] - [mgmt] - - - [2022-05-09 06:47:55.217107299 UTC] "GET /modules?api-version=2020-07-07 HTTP/1.1" 200 OK 692 "-" "-" auth_id(-)
May 09 06:48:00 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:48:00Z [INFO] - Checking edge runtime status
May 09 06:48:00 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:48:00Z [INFO] - Edge runtime is running.
May 09 06:48:05 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:48:05Z [INFO] - [mgmt] - - - [2022-05-09 06:48:05.227870690 UTC] "GET /modules?api-version=2020-07-07 HTTP/1.1" 200 OK 692 "-" "-" auth_id(-)
May 09 06:48:10 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:48:10Z [INFO] - Querying system info...
May 09 06:48:11 xxxxx-imx6ull aziot-edged[5493]: none
May 09 06:48:11 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:48:11Z [INFO] - Successfully queried system info
May 09 06:48:11 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:48:11Z [INFO] - [mgmt] - - - [2022-05-09 06:48:11.036681579 UTC] "GET /systeminfo?api-version=2020-07-07 HTTP/1.1" 200 OK 347 "-" "-" auth_id(-)
May 09 06:48:15 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:48:15Z [INFO] - [mgmt] - - - [2022-05-09 06:48:15.276381308 UTC] "GET /modules?api-version=2020-07-07 HTTP/1.1" 200 OK 692 "-" "-" auth_id(-)
May 09 06:48:25 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:48:25Z [INFO] - [mgmt] - - - [2022-05-09 06:48:25.242973737 UTC] "GET /modules?api-version=2020-07-07 HTTP/1.1" 200 OK 692 "-" "-" auth_id(-)
May 09 06:48:35 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:48:35Z [INFO] - [mgmt] - - - [2022-05-09 06:48:35.248005902 UTC] "GET /modules?api-version=2020-07-07 HTTP/1.1" 200 OK 692 "-" "-" auth_id(-)
May 09 06:48:45 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:48:45Z [INFO] - [mgmt] - - - [2022-05-09 06:48:45.275826845 UTC] "GET /modules?api-version=2020-07-07 HTTP/1.1" 200 OK 692 "-" "-" auth_id(-)
May 09 06:48:54 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:48:54Z [INFO] - Querying system resources...
May 09 06:48:55 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:48:55Z [INFO] - [mgmt] - - - [2022-05-09 06:48:55.283596371 UTC] "GET /modules?api-version=2020-07-07 HTTP/1.1" 200 OK 692 "-" "-" auth_id(-)
May 09 06:48:55 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:48:55Z [INFO] - [mgmt] - - - [2022-05-09 06:48:55.809253647 UTC] "GET /systeminfo/resources?api-version=2020-07-07 HTTP/1.1" 200 OK 3217 "-" "-" auth_id(-)
May 09 06:49:00 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:49:00Z [INFO] - Checking edge runtime status
May 09 06:49:00 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:49:00Z [INFO] - Edge runtime is running.
May 09 06:49:05 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:49:05Z [INFO] - [mgmt] - - - [2022-05-09 06:49:05.286818183 UTC] "GET /modules?api-version=2020-07-07 HTTP/1.1" 200 OK 692 "-" "-" auth_id(-)
May 09 06:49:15 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:49:15Z [INFO] - [mgmt] - - - [2022-05-09 06:49:15.306459156 UTC] "GET /modules?api-version=2020-07-07 HTTP/1.1" 200 OK 692 "-" "-" auth_id(-)
May 09 06:49:25 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:49:25Z [INFO] - [mgmt] - - - [2022-05-09 06:49:25.316220171 UTC] "GET /modules?api-version=2020-07-07 HTTP/1.1" 200 OK 692 "-" "-" auth_id(-)
May 09 06:49:35 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:49:35Z [INFO] - [mgmt] - - - [2022-05-09 06:49:35.327580728 UTC] "GET /modules?api-version=2020-07-07 HTTP/1.1" 200 OK 692 "-" "-" auth_id(-)
May 09 06:49:42 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:49:42Z [INFO] - Querying system info...
May 09 06:49:43 xxxxx-imx6ull aziot-edged[5908]: none
May 09 06:49:43 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:49:43Z [INFO] - Successfully queried system info
May 09 06:49:43 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:49:43Z [INFO] - [mgmt] - - - [2022-05-09 06:49:43.135280233 UTC] "GET /systeminfo?api-version=2020-07-07 HTTP/1.1" 200 OK 347 "-" "-" auth_id(-)
May 09 06:49:45 xxxxx-imx6ull aziot-edged[1218]: 2022-05-09T06:49:45Z [INFO] - [mgmt] - - - [2022-05-09 06:49:45.358445482 UTC] "GET /modules?api-version=2020-07-07 HTTP/1.1" 200 OK 692 "-" "-" auth_id(-)
IoT Edge Agent container logs
2022-05-09 06:37:15 +00:00 Starting Edge Agent
2022-05-09 06:37:16 +00:00 Changing ownership of storage folder: /tmp/edgeAgent to root
2022-05-09 06:37:16 +00:00 Changing ownership of management socket: /var/run/iotedge/mgmt.sock
2022-05-09 06:37:19.085 +00:00 Edge Agent Main()
<6> 2022-05-09 06:37:26.390 +00:00 [INF] - Initializing Edge Agent.
<6> 2022-05-09 06:37:31.956 +00:00 [INF] - Version - 1.2.9.53764592 (4bbfdb99cf7afb16f23d6177865942cc22e197ce)
<6> 2022-05-09 06:37:31.978 +00:00 [INF] -
█████╗ ███████╗██╗ ██╗██████╗ ███████╗
██╔══██╗╚══███╔╝██║ ██║██╔══██╗██╔════╝
███████║ ███╔╝ ██║ ██║██████╔╝█████╗
██╔══██║ ███╔╝ ██║ ██║██╔══██╗██╔══╝
██║ ██║███████╗╚██████╔╝██║ ██║███████╗
╚═╝ ╚═╝╚══════╝ ╚═════╝ ╚═╝ ╚═╝╚══════╝
██╗ ██████╗ ████████╗ ███████╗██████╗ ██████╗ ███████╗
██║██╔═══██╗╚══██╔══╝ ██╔════╝██╔══██╗██╔════╝ ██╔════╝
██║██║ ██║ ██║ █████╗ ██║ ██║██║ ███╗█████╗
██║██║ ██║ ██║ ██╔══╝ ██║ ██║██║ ██║██╔══╝
██║╚██████╔╝ ██║ ███████╗██████╔╝╚██████╔╝███████╗
╚═╝ ╚═════╝ ╚═╝ ╚══════╝╚═════╝ ╚═════╝ ╚══════╝
<6> 2022-05-09 06:37:33.511 +00:00 [INF] - Experimental features configuration: {"Enabled":false,"DisableCloudSubscriptions":false}
<6> 2022-05-09 06:37:38.536 +00:00 [INF] - Installing certificates [CN=iotedged workload ca xxxxx-imx6ull:08/03/2022 09:37:30] to Root
<6> 2022-05-09 06:37:43.744 +00:00 [INF] - Starting metrics listener on Host: *, Port: 9600, Suffix: metrics
<6> 2022-05-09 06:37:44.488 +00:00 [INF] - Updating performance metrics every 05m:00s
<6> 2022-05-09 06:37:44.655 +00:00 [INF] - Started operation Get system resources
<6> 2022-05-09 06:37:44.703 +00:00 [INF] - Collecting metadata metrics
<6> 2022-05-09 06:37:48.241 +00:00 [INF] - Set metadata metrics: 1.2.9.53764592 (4bbfdb99cf7afb16f23d6177865942cc22e197ce), {"Enabled":false,"DisableCloudSubscriptions":false}, {"OperatingSystemType":"linux","Architecture":"armv7l","Version":"1.2.6","AdditionalProperties":{}}, True
<6> 2022-05-09 06:37:49.154 +00:00 [INF] - Started operation Checkpoint Availability
<6> 2022-05-09 06:37:49.397 +00:00 [INF] - Started operation refresh twin config
<6> 2022-05-09 06:37:51.253 +00:00 [INF] - Edge agent attempting to connect to IoT Hub via Amqp_Tcp_Only...
<6> 2022-05-09 06:38:13.433 +00:00 [INF] - Created persistent store at /tmp/edgeAgent
<6> 2022-05-09 06:38:15.990 +00:00 [INF] - Started operation Metrics Scrape
<6> 2022-05-09 06:38:16.016 +00:00 [INF] - Started operation Metrics Upload
Scraping frequency: 01:00:00
Upload Frequency: 1.00:00:00
<6> 2022-05-09 06:38:31.929 +00:00 [INF] - Edge agent attempting to connect to IoT Hub via Amqp_WebSocket_Only...
<6> 2022-05-09 06:38:37.373 +00:00 [INF] - Registering request handler UploadModuleLogs
<6> 2022-05-09 06:38:37.406 +00:00 [INF] - Registering request handler GetModuleLogs
<6> 2022-05-09 06:38:37.418 +00:00 [INF] - Registering request handler UploadSupportBundle
<6> 2022-05-09 06:38:37.426 +00:00 [INF] - Registering request handler RestartModule
<4> 2022-05-09 06:38:46.251 +00:00 [WRN] - Empty edge agent config was received. Attempting to read config from backup (/tmp/edgeAgent/backup.json) instead
<6> 2022-05-09 06:38:46.380 +00:00 [INF] - Edge agent config backup file does not exist - /tmp/edgeAgent/backup.json
<4> 2022-05-09 06:38:56.914 +00:00 [WRN] - Empty edge agent config was received. Attempting to read config from backup (/tmp/edgeAgent/backup.json) instead
<4> 2022-05-09 06:39:07.220 +00:00 [WRN] - Empty edge agent config was received. Attempting to read config from backup (/tmp/edgeAgent/backup.json) instead
<4> 2022-05-09 06:39:12.732 +00:00 [WRN] - Error creating a device-to-cloud connection
System.AggregateException: One or more errors occurred. (Transient network error occurred, please retry.) (Transient network error occurred, please retry.)
---> Microsoft.Azure.Devices.Client.Exceptions.IotHubCommunicationException: Transient network error occurred, please retry.
---> System.Net.Sockets.SocketException (11): Resource temporarily unavailable
at Microsoft.Azure.Devices.Client.Transport.AmqpIoT.AmqpIoTTransport.InitializeAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.Amqp.AmqpIoTConnector.OpenConnectionAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.Amqp.AmqpConnectionHolder.EnsureConnectionAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.Amqp.AmqpConnectionHolder.OpenSessionAsync(DeviceIdentity deviceIdentity, TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.AmqpIoT.AmqpUnit.EnsureSessionIsOpenAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.AmqpIoT.AmqpUnit.OpenAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.Amqp.AmqpTransportHandler.OpenAsync(CancellationToken cancellationToken)
at Microsoft.Azure.Devices.Client.Transport.ProtocolRoutingDelegatingHandler.OpenAsync(CancellationToken cancellationToken)
at Microsoft.Azure.Devices.Client.Transport.ErrorDelegatingHandler.<>c__DisplayClass27_0.<<ExecuteWithErrorHandlingAsync>b__0>d.MoveNext()
--- End of stack trace from previous location where exception was thrown ---
at Microsoft.Azure.Devices.Client.Transport.ErrorDelegatingHandler.ExecuteWithErrorHandlingAsync[T](Func`1 asyncOperation)
--- End of inner exception stack trace ---
at Microsoft.Azure.Devices.Client.Transport.ErrorDelegatingHandler.ExecuteWithErrorHandlingAsync[T](Func`1 asyncOperation)
at Microsoft.Azure.Devices.Client.Transport.RetryDelegatingHandler.<>c__DisplayClass38_0.<<OpenInternalAsync>b__0>d.MoveNext()
--- End of stack trace from previous location where exception was thrown ---
at Microsoft.Azure.Devices.Client.Transport.RetryDelegatingHandler.EnsureOpenedAsync(CancellationToken cancellationToken)
at Microsoft.Azure.Devices.Client.InternalClient.OpenAsync()
at Microsoft.Azure.Devices.Edge.Agent.IoTHub.ModuleClientProvider.CreateAndOpenSdkModuleClient(UpstreamProtocol upstreamProtocol, ConnectionStatusChangesHandler statusChangedHandler) in /mnt/vss/_work/1/s/edge-agent/src/Microsoft.Azure.Devices.Edge.Agent.IoTHub/ModuleClientProvider.cs:line 230
at Microsoft.Azure.Devices.Edge.Agent.IoTHub.ModuleClientProvider.<>c__DisplayClass20_1.<<CreateSdkModuleClient>b__2>d.MoveNext() in /mnt/vss/_work/1/s/edge-agent/src/Microsoft.Azure.Devices.Edge.Agent.IoTHub/ModuleClientProvider.cs:line 188
--- End of stack trace from previous location where exception was thrown ---
at Microsoft.Azure.Devices.Edge.Util.Fallback.ExecuteAsync[T](Func`1[] options)
--- End of inner exception stack trace ---
---> (Inner Exception #1) Microsoft.Azure.Devices.Client.Exceptions.IotHubCommunicationException: Transient network error occurred, please retry.
---> System.Net.WebSockets.WebSocketException (1978011664): Unable to connect to the remote server ---> System.Net.Http.HttpRequestException: Resource temporarily unavailable
---> System.Net.Sockets.SocketException (11): Resource temporarily unavailable
at System.Net.Http.ConnectHelper.ConnectAsync(String host, Int32 port, CancellationToken cancellationToken)
--- End of inner exception stack trace ---
at System.Net.Http.ConnectHelper.ConnectAsync(String host, Int32 port, CancellationToken cancellationToken)
at System.Net.Http.HttpConnectionPool.ConnectAsync(HttpRequestMessage request, Boolean allowHttp2, CancellationToken cancellationToken)
at System.Net.Http.HttpConnectionPool.CreateHttp11ConnectionAsync(HttpRequestMessage request, CancellationToken cancellationToken)
at System.Net.Http.HttpConnectionPool.GetHttpConnectionAsync(HttpRequestMessage request, CancellationToken cancellationToken)
at System.Net.Http.HttpConnectionPool.SendWithRetryAsync(HttpRequestMessage request, Boolean doRequestAuth, CancellationToken cancellationToken)
at System.Net.Http.RedirectHandler.SendAsync(HttpRequestMessage request, CancellationToken cancellationToken)
at System.Net.WebSockets.WebSocketHandle.ConnectAsyncCore(Uri uri, CancellationToken cancellationToken, ClientWebSocketOptions options)
at System.Net.WebSockets.WebSocketHandle.ConnectAsyncCore(Uri uri, CancellationToken cancellationToken, ClientWebSocketOptions options)
at System.Net.WebSockets.ClientWebSocket.ConnectAsyncCore(Uri uri, CancellationToken cancellationToken)
at Microsoft.Azure.Devices.Client.Transport.AmqpIoT.AmqpIoTTransport.CreateClientWebSocketAsync(Uri websocketUri, TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.AmqpIoT.AmqpIoTTransport.CreateClientWebSocketTransportAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.AmqpIoT.AmqpIoTTransport.InitializeAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.Amqp.AmqpIoTConnector.OpenConnectionAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.Amqp.AmqpConnectionHolder.EnsureConnectionAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.Amqp.AmqpConnectionHolder.OpenSessionAsync(DeviceIdentity deviceIdentity, TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.AmqpIoT.AmqpUnit.EnsureSessionIsOpenAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.AmqpIoT.AmqpUnit.OpenAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.Amqp.AmqpTransportHandler.OpenAsync(CancellationToken cancellationToken)
at Microsoft.Azure.Devices.Client.Transport.ProtocolRoutingDelegatingHandler.OpenAsync(CancellationToken cancellationToken)
at Microsoft.Azure.Devices.Client.Transport.ErrorDelegatingHandler.<>c__DisplayClass27_0.<<ExecuteWithErrorHandlingAsync>b__0>d.MoveNext()
--- End of stack trace from previous location where exception was thrown ---
at Microsoft.Azure.Devices.Client.Transport.ErrorDelegatingHandler.ExecuteWithErrorHandlingAsync[T](Func`1 asyncOperation)
--- End of inner exception stack trace ---
at Microsoft.Azure.Devices.Client.Transport.ErrorDelegatingHandler.ExecuteWithErrorHandlingAsync[T](Func`1 asyncOperation)
at Microsoft.Azure.Devices.Client.Transport.RetryDelegatingHandler.<>c__DisplayClass38_0.<<OpenInternalAsync>b__0>d.MoveNext()
--- End of stack trace from previous location where exception was thrown ---
at Microsoft.Azure.Devices.Client.Transport.RetryDelegatingHandler.EnsureOpenedAsync(CancellationToken cancellationToken)
at Microsoft.Azure.Devices.Client.InternalClient.OpenAsync()
at Microsoft.Azure.Devices.Edge.Agent.IoTHub.ModuleClientProvider.CreateAndOpenSdkModuleClient(UpstreamProtocol upstreamProtocol, ConnectionStatusChangesHandler statusChangedHandler) in /mnt/vss/_work/1/s/edge-agent/src/Microsoft.Azure.Devices.Edge.Agent.IoTHub/ModuleClientProvider.cs:line 230
at Microsoft.Azure.Devices.Edge.Agent.IoTHub.ModuleClientProvider.<>c__DisplayClass20_1.<<CreateSdkModuleClient>b__3>d.MoveNext() in /mnt/vss/_work/1/s/edge-agent/src/Microsoft.Azure.Devices.Edge.Agent.IoTHub/ModuleClientProvider.cs:line 194
--- End of stack trace from previous location where exception was thrown ---
at Microsoft.Azure.Devices.Edge.Util.Fallback.ExecuteAsync[T](Func`1[] options)<---
<6> 2022-05-09 06:39:13.615 +00:00 [INF] - Edge agent attempting to connect to IoT Hub via Amqp_Tcp_Only...
<4> 2022-05-09 06:39:17.480 +00:00 [WRN] - Empty edge agent config was received. Attempting to read config from backup (/tmp/edgeAgent/backup.json) instead
<4> 2022-05-09 06:39:27.732 +00:00 [WRN] - Empty edge agent config was received. Attempting to read config from backup (/tmp/edgeAgent/backup.json) instead
<4> 2022-05-09 06:39:37.827 +00:00 [WRN] - Empty edge agent config was received. Attempting to read config from backup (/tmp/edgeAgent/backup.json) instead
<6> 2022-05-09 06:39:45.166 +00:00 [INF] - Edge agent attempting to connect to IoT Hub via Amqp_WebSocket_Only...
<4> 2022-05-09 06:39:47.910 +00:00 [WRN] - Empty edge agent config was received. Attempting to read config from backup (/tmp/edgeAgent/backup.json) instead
<4> 2022-05-09 06:39:57.977 +00:00 [WRN] - Empty edge agent config was received. Attempting to read config from backup (/tmp/edgeAgent/backup.json) instead
<4> 2022-05-09 06:40:08.129 +00:00 [WRN] - Empty edge agent config was received. Attempting to read config from backup (/tmp/edgeAgent/backup.json) instead
<4> 2022-05-09 06:40:18.321 +00:00 [WRN] - Empty edge agent config was received. Attempting to read config from backup (/tmp/edgeAgent/backup.json) instead
<4> 2022-05-09 06:40:18.832 +00:00 [WRN] - Error creating a device-to-cloud connection
System.AggregateException: One or more errors occurred. (Transient network error occurred, please retry.) (Transient network error occurred, please retry.)
---> Microsoft.Azure.Devices.Client.Exceptions.IotHubCommunicationException: Transient network error occurred, please retry.
---> System.Net.Sockets.SocketException (11): Resource temporarily unavailable
at Microsoft.Azure.Devices.Client.Transport.AmqpIoT.AmqpIoTTransport.InitializeAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.Amqp.AmqpIoTConnector.OpenConnectionAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.Amqp.AmqpConnectionHolder.EnsureConnectionAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.Amqp.AmqpConnectionHolder.OpenSessionAsync(DeviceIdentity deviceIdentity, TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.AmqpIoT.AmqpUnit.EnsureSessionIsOpenAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.AmqpIoT.AmqpUnit.OpenAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.Amqp.AmqpTransportHandler.OpenAsync(CancellationToken cancellationToken)
at Microsoft.Azure.Devices.Client.Transport.ProtocolRoutingDelegatingHandler.OpenAsync(CancellationToken cancellationToken)
at Microsoft.Azure.Devices.Client.Transport.ErrorDelegatingHandler.<>c__DisplayClass27_0.<<ExecuteWithErrorHandlingAsync>b__0>d.MoveNext()
--- End of stack trace from previous location where exception was thrown ---
at Microsoft.Azure.Devices.Client.Transport.ErrorDelegatingHandler.ExecuteWithErrorHandlingAsync[T](Func`1 asyncOperation)
--- End of inner exception stack trace ---
at Microsoft.Azure.Devices.Client.Transport.ErrorDelegatingHandler.ExecuteWithErrorHandlingAsync[T](Func`1 asyncOperation)
at Microsoft.Azure.Devices.Client.Transport.RetryDelegatingHandler.<>c__DisplayClass38_0.<<OpenInternalAsync>b__0>d.MoveNext()
--- End of stack trace from previous location where exception was thrown ---
at Microsoft.Azure.Devices.Client.Transport.RetryDelegatingHandler.EnsureOpenedAsync(CancellationToken cancellationToken)
at Microsoft.Azure.Devices.Client.InternalClient.OpenAsync()
at Microsoft.Azure.Devices.Edge.Agent.IoTHub.ModuleClientProvider.CreateAndOpenSdkModuleClient(UpstreamProtocol upstreamProtocol, ConnectionStatusChangesHandler statusChangedHandler) in /mnt/vss/_work/1/s/edge-agent/src/Microsoft.Azure.Devices.Edge.Agent.IoTHub/ModuleClientProvider.cs:line 230
at Microsoft.Azure.Devices.Edge.Agent.IoTHub.ModuleClientProvider.<>c__DisplayClass20_1.<<CreateSdkModuleClient>b__2>d.MoveNext() in /mnt/vss/_work/1/s/edge-agent/src/Microsoft.Azure.Devices.Edge.Agent.IoTHub/ModuleClientProvider.cs:line 188
--- End of stack trace from previous location where exception was thrown ---
at Microsoft.Azure.Devices.Edge.Util.Fallback.ExecuteAsync[T](Func`1[] options)
--- End of inner exception stack trace ---
---> (Inner Exception #1) Microsoft.Azure.Devices.Client.Exceptions.IotHubCommunicationException: Transient network error occurred, please retry.
---> System.Net.WebSockets.WebSocketException (0x80004005): Unable to connect to the remote server
---> System.Net.Http.HttpRequestException: Resource temporarily unavailable
---> System.Net.Sockets.SocketException (11): Resource temporarily unavailable
at System.Net.Http.ConnectHelper.ConnectAsync(String host, Int32 port, CancellationToken cancellationToken)
--- End of inner exception stack trace ---
at System.Net.Http.ConnectHelper.ConnectAsync(String host, Int32 port, CancellationToken cancellationToken)
at System.Net.Http.HttpConnectionPool.ConnectAsync(HttpRequestMessage request, Boolean allowHttp2, CancellationToken cancellationToken)
at System.Net.Http.HttpConnectionPool.CreateHttp11ConnectionAsync(HttpRequestMessage request, CancellationToken cancellationToken)
at System.Net.Http.HttpConnectionPool.GetHttpConnectionAsync(HttpRequestMessage request, CancellationToken cancellationToken)
at System.Net.Http.HttpConnectionPool.SendWithRetryAsync(HttpRequestMessage request, Boolean doRequestAuth, CancellationToken cancellationToken)
at System.Net.Http.RedirectHandler.SendAsync(HttpRequestMessage request, CancellationToken cancellationToken)
at System.Net.WebSockets.WebSocketHandle.ConnectAsyncCore(Uri uri, CancellationToken cancellationToken, ClientWebSocketOptions options)
at System.Net.WebSockets.WebSocketHandle.ConnectAsyncCore(Uri uri, CancellationToken cancellationToken, ClientWebSocketOptions options)
at System.Net.WebSockets.ClientWebSocket.ConnectAsyncCore(Uri uri, CancellationToken cancellationToken)
at Microsoft.Azure.Devices.Client.Transport.AmqpIoT.AmqpIoTTransport.CreateClientWebSocketAsync(Uri websocketUri, TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.AmqpIoT.AmqpIoTTransport.CreateClientWebSocketTransportAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.AmqpIoT.AmqpIoTTransport.InitializeAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.Amqp.AmqpIoTConnector.OpenConnectionAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.Amqp.AmqpConnectionHolder.EnsureConnectionAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.Amqp.AmqpConnectionHolder.OpenSessionAsync(DeviceIdentity deviceIdentity, TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.AmqpIoT.AmqpUnit.EnsureSessionIsOpenAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.AmqpIoT.AmqpUnit.OpenAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.Amqp.AmqpTransportHandler.OpenAsync(CancellationToken cancellationToken)
at Microsoft.Azure.Devices.Client.Transport.ProtocolRoutingDelegatingHandler.OpenAsync(CancellationToken cancellationToken)
at Microsoft.Azure.Devices.Client.Transport.ErrorDelegatingHandler.<>c__DisplayClass27_0.<<ExecuteWithErrorHandlingAsync>b__0>d.MoveNext()
--- End of stack trace from previous location where exception was thrown ---
at Microsoft.Azure.Devices.Client.Transport.ErrorDelegatingHandler.ExecuteWithErrorHandlingAsync[T](Func`1 asyncOperation)
--- End of inner exception stack trace ---
at Microsoft.Azure.Devices.Client.Transport.ErrorDelegatingHandler.ExecuteWithErrorHandlingAsync[T](Func`1 asyncOperation)
at Microsoft.Azure.Devices.Client.Transport.RetryDelegatingHandler.<>c__DisplayClass38_0.<<OpenInternalAsync>b__0>d.MoveNext()
--- End of stack trace from previous location where exception was thrown ---
at Microsoft.Azure.Devices.Client.Transport.RetryDelegatingHandler.EnsureOpenedAsync(CancellationToken cancellationToken)
at Microsoft.Azure.Devices.Client.InternalClient.OpenAsync()
at Microsoft.Azure.Devices.Edge.Agent.IoTHub.ModuleClientProvider.CreateAndOpenSdkModuleClient(UpstreamProtocol upstreamProtocol, ConnectionStatusChangesHandler statusChangedHandler) in /mnt/vss/_work/1/s/edge-agent/src/Microsoft.Azure.Devices.Edge.Agent.IoTHub/ModuleClientProvider.cs:line 230
at Microsoft.Azure.Devices.Edge.Agent.IoTHub.ModuleClientProvider.<>c__DisplayClass20_1.<<CreateSdkModuleClient>b__3>d.MoveNext() in /mnt/vss/_work/1/s/edge-agent/src/Microsoft.Azure.Devices.Edge.Agent.IoTHub/ModuleClientProvider.cs:line 194
--- End of stack trace from previous location where exception was thrown ---
at Microsoft.Azure.Devices.Edge.Util.Fallback.ExecuteAsync[T](Func`1[] options)<---
<6> 2022-05-09 06:40:25.409 +00:00 [INF] - Edge agent attempting to connect to IoT Hub via Amqp_Tcp_Only...
<4> 2022-05-09 06:40:28.467 +00:00 [WRN] - Empty edge agent config was received. Attempting to read config from backup (/tmp/edgeAgent/backup.json) instead
<4> 2022-05-09 06:40:38.546 +00:00 [WRN] - Empty edge agent config was received. Attempting to read config from backup (/tmp/edgeAgent/backup.json) instead
<4> 2022-05-09 06:40:48.657 +00:00 [WRN] - Empty edge agent config was received. Attempting to read config from backup (/tmp/edgeAgent/backup.json) instead
<4> 2022-05-09 06:40:58.765 +00:00 [WRN] - Empty edge agent config was received. Attempting to read config from backup (/tmp/edgeAgent/backup.json) instead
<6> 2022-05-09 06:40:59.285 +00:00 [INF] - Edge agent attempting to connect to IoT Hub via Amqp_WebSocket_Only...
<4> 2022-05-09 06:41:08.877 +00:00 [WRN] - Empty edge agent config was received. Attempting to read config from backup (/tmp/edgeAgent/backup.json) instead
<4> 2022-05-09 06:41:18.985 +00:00 [WRN] - Empty edge agent config was received. Attempting to read config from backup (/tmp/edgeAgent/backup.json) instead
<4> 2022-05-09 06:41:29.042 +00:00 [WRN] - Empty edge agent config was received. Attempting to read config from backup (/tmp/edgeAgent/backup.json) instead
<4> 2022-05-09 06:41:32.303 +00:00 [WRN] - Error creating a device-to-cloud connection
System.AggregateException: One or more errors occurred. (Transient network error occurred, please retry.) (Transient network error occurred, please retry.)
---> Microsoft.Azure.Devices.Client.Exceptions.IotHubCommunicationException: Transient network error occurred, please retry.
---> System.Net.Sockets.SocketException (11): Resource temporarily unavailable
at Microsoft.Azure.Devices.Client.Transport.AmqpIoT.AmqpIoTTransport.InitializeAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.Amqp.AmqpIoTConnector.OpenConnectionAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.Amqp.AmqpConnectionHolder.EnsureConnectionAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.Amqp.AmqpConnectionHolder.OpenSessionAsync(DeviceIdentity deviceIdentity, TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.AmqpIoT.AmqpUnit.EnsureSessionIsOpenAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.AmqpIoT.AmqpUnit.OpenAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.Amqp.AmqpTransportHandler.OpenAsync(CancellationToken cancellationToken)
at Microsoft.Azure.Devices.Client.Transport.ProtocolRoutingDelegatingHandler.OpenAsync(CancellationToken cancellationToken)
at Microsoft.Azure.Devices.Client.Transport.ErrorDelegatingHandler.<>c__DisplayClass27_0.<<ExecuteWithErrorHandlingAsync>b__0>d.MoveNext()
--- End of stack trace from previous location where exception was thrown ---
at Microsoft.Azure.Devices.Client.Transport.ErrorDelegatingHandler.ExecuteWithErrorHandlingAsync[T](Func`1 asyncOperation)
--- End of inner exception stack trace ---
at Microsoft.Azure.Devices.Client.Transport.ErrorDelegatingHandler.ExecuteWithErrorHandlingAsync[T](Func`1 asyncOperation)
at Microsoft.Azure.Devices.Client.Transport.RetryDelegatingHandler.<>c__DisplayClass38_0.<<OpenInternalAsync>b__0>d.MoveNext()
--- End of stack trace from previous location where exception was thrown ---
at Microsoft.Azure.Devices.Client.Transport.RetryDelegatingHandler.EnsureOpenedAsync(CancellationToken cancellationToken)
at Microsoft.Azure.Devices.Client.InternalClient.OpenAsync()
at Microsoft.Azure.Devices.Edge.Agent.IoTHub.ModuleClientProvider.CreateAndOpenSdkModuleClient(UpstreamProtocol upstreamProtocol, ConnectionStatusChangesHandler statusChangedHandler) in /mnt/vss/_work/1/s/edge-agent/src/Microsoft.Azure.Devices.Edge.Agent.IoTHub/ModuleClientProvider.cs:line 230
at Microsoft.Azure.Devices.Edge.Agent.IoTHub.ModuleClientProvider.<>c__DisplayClass20_1.<<CreateSdkModuleClient>b__2>d.MoveNext() in /mnt/vss/_work/1/s/edge-agent/src/Microsoft.Azure.Devices.Edge.Agent.IoTHub/ModuleClientProvider.cs:line 188
--- End of stack trace from previous location where exception was thrown ---
at Microsoft.Azure.Devices.Edge.Util.Fallback.ExecuteAsync[T](Func`1[] options)
--- End of inner exception stack trace ---
---> (Inner Exception #1) Microsoft.Azure.Devices.Client.Exceptions.IotHubCommunicationException: Transient network error occurred, please retry.
---> System.Net.WebSockets.WebSocketException (0x80004005): Unable to connect to the remote server
---> System.Net.Http.HttpRequestException: Resource temporarily unavailable
---> System.Net.Sockets.SocketException (11): Resource temporarily unavailable
at System.Net.Http.ConnectHelper.ConnectAsync(String host, Int32 port, CancellationToken cancellationToken)
--- End of inner exception stack trace ---
at System.Net.Http.ConnectHelper.ConnectAsync(String host, Int32 port, CancellationToken cancellationToken)
at System.Net.Http.HttpConnectionPool.ConnectAsync(HttpRequestMessage request, Boolean allowHttp2, CancellationToken cancellationToken)
at System.Net.Http.HttpConnectionPool.CreateHttp11ConnectionAsync(HttpRequestMessage request, CancellationToken cancellationToken)
at System.Net.Http.HttpConnectionPool.GetHttpConnectionAsync(HttpRequestMessage request, CancellationToken cancellationToken)
at System.Net.Http.HttpConnectionPool.SendWithRetryAsync(HttpRequestMessage request, Boolean doRequestAuth, CancellationToken cancellationToken)
at System.Net.Http.RedirectHandler.SendAsync(HttpRequestMessage request, CancellationToken cancellationToken)
at System.Net.WebSockets.WebSocketHandle.ConnectAsyncCore(Uri uri, CancellationToken cancellationToken, ClientWebSocketOptions options)
at System.Net.WebSockets.WebSocketHandle.ConnectAsyncCore(Uri uri, CancellationToken cancellationToken, ClientWebSocketOptions options)
at System.Net.WebSockets.ClientWebSocket.ConnectAsyncCore(Uri uri, CancellationToken cancellationToken)
at Microsoft.Azure.Devices.Client.Transport.AmqpIoT.AmqpIoTTransport.CreateClientWebSocketAsync(Uri websocketUri, TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.AmqpIoT.AmqpIoTTransport.CreateClientWebSocketTransportAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.AmqpIoT.AmqpIoTTransport.InitializeAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.Amqp.AmqpIoTConnector.OpenConnectionAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.Amqp.AmqpConnectionHolder.EnsureConnectionAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.Amqp.AmqpConnectionHolder.OpenSessionAsync(DeviceIdentity deviceIdentity, TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.AmqpIoT.AmqpUnit.EnsureSessionIsOpenAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.AmqpIoT.AmqpUnit.OpenAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.Amqp.AmqpTransportHandler.OpenAsync(CancellationToken cancellationToken)
at Microsoft.Azure.Devices.Client.Transport.ProtocolRoutingDelegatingHandler.OpenAsync(CancellationToken cancellationToken)
at Microsoft.Azure.Devices.Client.Transport.ErrorDelegatingHandler.<>c__DisplayClass27_0.<<ExecuteWithErrorHandlingAsync>b__0>d.MoveNext()
--- End of stack trace from previous location where exception was thrown ---
at Microsoft.Azure.Devices.Client.Transport.ErrorDelegatingHandler.ExecuteWithErrorHandlingAsync[T](Func`1 asyncOperation)
--- End of inner exception stack trace ---
at Microsoft.Azure.Devices.Client.Transport.ErrorDelegatingHandler.ExecuteWithErrorHandlingAsync[T](Func`1 asyncOperation)
at Microsoft.Azure.Devices.Client.Transport.RetryDelegatingHandler.<>c__DisplayClass38_0.<<OpenInternalAsync>b__0>d.MoveNext()
--- End of stack trace from previous location where exception was thrown ---
at Microsoft.Azure.Devices.Client.Transport.RetryDelegatingHandler.EnsureOpenedAsync(CancellationToken cancellationToken)
at Microsoft.Azure.Devices.Client.InternalClient.OpenAsync()
at Microsoft.Azure.Devices.Edge.Agent.IoTHub.ModuleClientProvider.CreateAndOpenSdkModuleClient(UpstreamProtocol upstreamProtocol, ConnectionStatusChangesHandler statusChangedHandler) in /mnt/vss/_work/1/s/edge-agent/src/Microsoft.Azure.Devices.Edge.Agent.IoTHub/ModuleClientProvider.cs:line 230
at Microsoft.Azure.Devices.Edge.Agent.IoTHub.ModuleClientProvider.<>c__DisplayClass20_1.<<CreateSdkModuleClient>b__3>d.MoveNext() in /mnt/vss/_work/1/s/edge-agent/src/Microsoft.Azure.Devices.Edge.Agent.IoTHub/ModuleClientProvider.cs:line 194
--- End of stack trace from previous location where exception was thrown ---
at Microsoft.Azure.Devices.Edge.Util.Fallback.ExecuteAsync[T](Func`1[] options)<---
<4> 2022-05-09 06:41:39.079 +00:00 [WRN] - Empty edge agent config was received. Attempting to read config from backup (/tmp/edgeAgent/backup.json) instead
<6> 2022-05-09 06:41:45.686 +00:00 [INF] - Edge agent attempting to connect to IoT Hub via Amqp_Tcp_Only...
<4> 2022-05-09 06:41:49.180 +00:00 [WRN] - Empty edge agent config was received. Attempting to read config from backup (/tmp/edgeAgent/backup.json) instead
<4> 2022-05-09 06:41:59.221 +00:00 [WRN] - Empty edge agent config was received. Attempting to read config from backup (/tmp/edgeAgent/backup.json) instead
<4> 2022-05-09 06:42:09.267 +00:00 [WRN] - Empty edge agent config was received. Attempting to read config from backup (/tmp/edgeAgent/backup.json) instead
<4> 2022-05-09 06:42:19.295 +00:00 [WRN] - Empty edge agent config was received. Attempting to read config from backup (/tmp/edgeAgent/backup.json) instead
<6> 2022-05-09 06:42:19.431 +00:00 [INF] - Edge agent attempting to connect to IoT Hub via Amqp_WebSocket_Only...
<4> 2022-05-09 06:42:29.383 +00:00 [WRN] - Empty edge agent config was received. Attempting to read config from backup (/tmp/edgeAgent/backup.json) instead
<4> 2022-05-09 06:42:39.446 +00:00 [WRN] - Empty edge agent config was received. Attempting to read config from backup (/tmp/edgeAgent/backup.json) instead
<4> 2022-05-09 06:42:49.486 +00:00 [WRN] - Empty edge agent config was received. Attempting to read config from backup (/tmp/edgeAgent/backup.json) instead
<4> 2022-05-09 06:42:54.557 +00:00 [WRN] - Error creating a device-to-cloud connection
System.AggregateException: One or more errors occurred. (Transient network error occurred, please retry.) (Transient network error occurred, please retry.)
---> Microsoft.Azure.Devices.Client.Exceptions.IotHubCommunicationException: Transient network error occurred, please retry.
---> System.Net.Sockets.SocketException (11): Resource temporarily unavailable
at Microsoft.Azure.Devices.Client.Transport.AmqpIoT.AmqpIoTTransport.InitializeAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.Amqp.AmqpIoTConnector.OpenConnectionAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.Amqp.AmqpConnectionHolder.EnsureConnectionAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.Amqp.AmqpConnectionHolder.OpenSessionAsync(DeviceIdentity deviceIdentity, TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.AmqpIoT.AmqpUnit.EnsureSessionIsOpenAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.AmqpIoT.AmqpUnit.OpenAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.Amqp.AmqpTransportHandler.OpenAsync(CancellationToken cancellationToken)
at Microsoft.Azure.Devices.Client.Transport.ProtocolRoutingDelegatingHandler.OpenAsync(CancellationToken cancellationToken)
at Microsoft.Azure.Devices.Client.Transport.ErrorDelegatingHandler.<>c__DisplayClass27_0.<<ExecuteWithErrorHandlingAsync>b__0>d.MoveNext()
--- End of stack trace from previous location where exception was thrown ---
at Microsoft.Azure.Devices.Client.Transport.ErrorDelegatingHandler.ExecuteWithErrorHandlingAsync[T](Func`1 asyncOperation)
--- End of inner exception stack trace ---
at Microsoft.Azure.Devices.Client.Transport.ErrorDelegatingHandler.ExecuteWithErrorHandlingAsync[T](Func`1 asyncOperation)
at Microsoft.Azure.Devices.Client.Transport.RetryDelegatingHandler.<>c__DisplayClass38_0.<<OpenInternalAsync>b__0>d.MoveNext()
--- End of stack trace from previous location where exception was thrown ---
at Microsoft.Azure.Devices.Client.Transport.RetryDelegatingHandler.EnsureOpenedAsync(CancellationToken cancellationToken)
at Microsoft.Azure.Devices.Client.InternalClient.OpenAsync()
at Microsoft.Azure.Devices.Edge.Agent.IoTHub.ModuleClientProvider.CreateAndOpenSdkModuleClient(UpstreamProtocol upstreamProtocol, ConnectionStatusChangesHandler statusChangedHandler) in /mnt/vss/_work/1/s/edge-agent/src/Microsoft.Azure.Devices.Edge.Agent.IoTHub/ModuleClientProvider.cs:line 230
at Microsoft.Azure.Devices.Edge.Agent.IoTHub.ModuleClientProvider.<>c__DisplayClass20_1.<<CreateSdkModuleClient>b__2>d.MoveNext() in /mnt/vss/_work/1/s/edge-agent/src/Microsoft.Azure.Devices.Edge.Agent.IoTHub/ModuleClientProvider.cs:line 188
--- End of stack trace from previous location where exception was thrown ---
at Microsoft.Azure.Devices.Edge.Util.Fallback.ExecuteAsync[T](Func`1[] options)
--- End of inner exception stack trace ---
---> (Inner Exception #1) Microsoft.Azure.Devices.Client.Exceptions.IotHubCommunicationException: Transient network error occurred, please retry.
---> System.Net.WebSockets.WebSocketException (0x80004005): Unable to connect to the remote server
---> System.Net.Http.HttpRequestException: Resource temporarily unavailable
---> System.Net.Sockets.SocketException (11): Resource temporarily unavailable
at System.Net.Http.ConnectHelper.ConnectAsync(String host, Int32 port, CancellationToken cancellationToken)
--- End of inner exception stack trace ---
at System.Net.Http.ConnectHelper.ConnectAsync(String host, Int32 port, CancellationToken cancellationToken)
at System.Net.Http.HttpConnectionPool.ConnectAsync(HttpRequestMessage request, Boolean allowHttp2, CancellationToken cancellationToken)
at System.Net.Http.HttpConnectionPool.CreateHttp11ConnectionAsync(HttpRequestMessage request, CancellationToken cancellationToken)
at System.Net.Http.HttpConnectionPool.GetHttpConnectionAsync(HttpRequestMessage request, CancellationToken cancellationToken)
at System.Net.Http.HttpConnectionPool.SendWithRetryAsync(HttpRequestMessage request, Boolean doRequestAuth, CancellationToken cancellationToken)
at System.Net.Http.RedirectHandler.SendAsync(HttpRequestMessage request, CancellationToken cancellationToken)
at System.Net.WebSockets.WebSocketHandle.ConnectAsyncCore(Uri uri, CancellationToken cancellationToken, ClientWebSocketOptions options)
at System.Net.WebSockets.WebSocketHandle.ConnectAsyncCore(Uri uri, CancellationToken cancellationToken, ClientWebSocketOptions options)
at System.Net.WebSockets.ClientWebSocket.ConnectAsyncCore(Uri uri, CancellationToken cancellationToken)
at Microsoft.Azure.Devices.Client.Transport.AmqpIoT.AmqpIoTTransport.CreateClientWebSocketAsync(Uri websocketUri, TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.AmqpIoT.AmqpIoTTransport.CreateClientWebSocketTransportAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.AmqpIoT.AmqpIoTTransport.InitializeAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.Amqp.AmqpIoTConnector.OpenConnectionAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.Amqp.AmqpConnectionHolder.EnsureConnectionAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.Amqp.AmqpConnectionHolder.OpenSessionAsync(DeviceIdentity deviceIdentity, TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.AmqpIoT.AmqpUnit.EnsureSessionIsOpenAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.AmqpIoT.AmqpUnit.OpenAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.Amqp.AmqpTransportHandler.OpenAsync(CancellationToken cancellationToken)
at Microsoft.Azure.Devices.Client.Transport.ProtocolRoutingDelegatingHandler.OpenAsync(CancellationToken cancellationToken)
at Microsoft.Azure.Devices.Client.Transport.ErrorDelegatingHandler.<>c__DisplayClass27_0.<<ExecuteWithErrorHandlingAsync>b__0>d.MoveNext()
--- End of stack trace from previous location where exception was thrown ---
at Microsoft.Azure.Devices.Client.Transport.ErrorDelegatingHandler.ExecuteWithErrorHandlingAsync[T](Func`1 asyncOperation)
--- End of inner exception stack trace ---
at Microsoft.Azure.Devices.Client.Transport.ErrorDelegatingHandler.ExecuteWithErrorHandlingAsync[T](Func`1 asyncOperation)
at Microsoft.Azure.Devices.Client.Transport.RetryDelegatingHandler.<>c__DisplayClass38_0.<<OpenInternalAsync>b__0>d.MoveNext()
--- End of stack trace from previous location where exception was thrown ---
at Microsoft.Azure.Devices.Client.Transport.RetryDelegatingHandler.EnsureOpenedAsync(CancellationToken cancellationToken)
at Microsoft.Azure.Devices.Client.InternalClient.OpenAsync()
at Microsoft.Azure.Devices.Edge.Agent.IoTHub.ModuleClientProvider.CreateAndOpenSdkModuleClient(UpstreamProtocol upstreamProtocol, ConnectionStatusChangesHandler statusChangedHandler) in /mnt/vss/_work/1/s/edge-agent/src/Microsoft.Azure.Devices.Edge.Agent.IoTHub/ModuleClientProvider.cs:line 230
at Microsoft.Azure.Devices.Edge.Agent.IoTHub.ModuleClientProvider.<>c__DisplayClass20_1.<<CreateSdkModuleClient>b__3>d.MoveNext() in /mnt/vss/_work/1/s/edge-agent/src/Microsoft.Azure.Devices.Edge.Agent.IoTHub/ModuleClientProvider.cs:line 194
--- End of stack trace from previous location where exception was thrown ---
at Microsoft.Azure.Devices.Edge.Util.Fallback.ExecuteAsync[T](Func`1[] options)<---
<4> 2022-05-09 06:42:59.535 +00:00 [WRN] - Empty edge agent config was received. Attempting to read config from backup (/tmp/edgeAgent/backup.json) instead
<4> 2022-05-09 06:43:09.578 +00:00 [WRN] - Empty edge agent config was received. Attempting to read config from backup (/tmp/edgeAgent/backup.json) instead
<4> 2022-05-09 06:43:19.608 +00:00 [WRN] - Empty edge agent config was received. Attempting to read config from backup (/tmp/edgeAgent/backup.json) instead
<6> 2022-05-09 06:43:28.225 +00:00 [INF] - Edge agent attempting to connect to IoT Hub via Amqp_Tcp_Only...
<4> 2022-05-09 06:43:29.646 +00:00 [WRN] - Empty edge agent config was received. Attempting to read config from backup (/tmp/edgeAgent/backup.json) instead
<4> 2022-05-09 06:43:39.682 +00:00 [WRN] - Empty edge agent config was received. Attempting to read config from backup (/tmp/edgeAgent/backup.json) instead
<4> 2022-05-09 06:43:49.760 +00:00 [WRN] - Empty edge agent config was received. Attempting to read config from backup (/tmp/edgeAgent/backup.json) instead
<4> 2022-05-09 06:43:59.770 +00:00 [WRN] - Empty edge agent config was received. Attempting to read config from backup (/tmp/edgeAgent/backup.json) instead
<6> 2022-05-09 06:44:00.635 +00:00 [INF] - Edge agent attempting to connect to IoT Hub via Amqp_WebSocket_Only...
<4> 2022-05-09 06:44:09.784 +00:00 [WRN] - Empty edge agent config was received. Attempting to read config from backup (/tmp/edgeAgent/backup.json) instead
<4> 2022-05-09 06:44:19.817 +00:00 [WRN] - Empty edge agent config was received. Attempting to read config from backup (/tmp/edgeAgent/backup.json) instead
<4> 2022-05-09 06:44:29.840 +00:00 [WRN] - Empty edge agent config was received. Attempting to read config from backup (/tmp/edgeAgent/backup.json) instead
<4> 2022-05-09 06:44:34.505 +00:00 [WRN] - Error creating a device-to-cloud connection
System.AggregateException: One or more errors occurred. (Transient network error occurred, please retry.) (Transient network error occurred, please retry.)
---> Microsoft.Azure.Devices.Client.Exceptions.IotHubCommunicationException: Transient network error occurred, please retry.
---> System.Net.Sockets.SocketException (11): Resource temporarily unavailable
at Microsoft.Azure.Devices.Client.Transport.AmqpIoT.AmqpIoTTransport.InitializeAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.Amqp.AmqpIoTConnector.OpenConnectionAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.Amqp.AmqpConnectionHolder.EnsureConnectionAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.Amqp.AmqpConnectionHolder.OpenSessionAsync(DeviceIdentity deviceIdentity, TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.AmqpIoT.AmqpUnit.EnsureSessionIsOpenAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.AmqpIoT.AmqpUnit.OpenAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.Amqp.AmqpTransportHandler.OpenAsync(CancellationToken cancellationToken)
at Microsoft.Azure.Devices.Client.Transport.ProtocolRoutingDelegatingHandler.OpenAsync(CancellationToken cancellationToken)
at Microsoft.Azure.Devices.Client.Transport.ErrorDelegatingHandler.<>c__DisplayClass27_0.<<ExecuteWithErrorHandlingAsync>b__0>d.MoveNext()
--- End of stack trace from previous location where exception was thrown ---
at Microsoft.Azure.Devices.Client.Transport.ErrorDelegatingHandler.ExecuteWithErrorHandlingAsync[T](Func`1 asyncOperation)
--- End of inner exception stack trace ---
at Microsoft.Azure.Devices.Client.Transport.ErrorDelegatingHandler.ExecuteWithErrorHandlingAsync[T](Func`1 asyncOperation)
at Microsoft.Azure.Devices.Client.Transport.RetryDelegatingHandler.<>c__DisplayClass38_0.<<OpenInternalAsync>b__0>d.MoveNext()
--- End of stack trace from previous location where exception was thrown ---
at Microsoft.Azure.Devices.Client.Transport.RetryDelegatingHandler.EnsureOpenedAsync(CancellationToken cancellationToken)
at Microsoft.Azure.Devices.Client.InternalClient.OpenAsync()
at Microsoft.Azure.Devices.Edge.Agent.IoTHub.ModuleClientProvider.CreateAndOpenSdkModuleClient(UpstreamProtocol upstreamProtocol, ConnectionStatusChangesHandler statusChangedHandler) in /mnt/vss/_work/1/s/edge-agent/src/Microsoft.Azure.Devices.Edge.Agent.IoTHub/ModuleClientProvider.cs:line 230
at Microsoft.Azure.Devices.Edge.Agent.IoTHub.ModuleClientProvider.<>c__DisplayClass20_1.<<CreateSdkModuleClient>b__2>d.MoveNext() in /mnt/vss/_work/1/s/edge-agent/src/Microsoft.Azure.Devices.Edge.Agent.IoTHub/ModuleClientProvider.cs:line 188
--- End of stack trace from previous location where exception was thrown ---
at Microsoft.Azure.Devices.Edge.Util.Fallback.ExecuteAsync[T](Func`1[] options)
--- End of inner exception stack trace ---
---> (Inner Exception #1) Microsoft.Azure.Devices.Client.Exceptions.IotHubCommunicationException: Transient network error occurred, please retry.
---> System.Net.WebSockets.WebSocketException (0x80004005): Unable to connect to the remote server
---> System.Net.Http.HttpRequestException: Resource temporarily unavailable
---> System.Net.Sockets.SocketException (11): Resource temporarily unavailable
at System.Net.Http.ConnectHelper.ConnectAsync(String host, Int32 port, CancellationToken cancellationToken)
--- End of inner exception stack trace ---
at System.Net.Http.ConnectHelper.ConnectAsync(String host, Int32 port, CancellationToken cancellationToken)
at System.Net.Http.HttpConnectionPool.ConnectAsync(HttpRequestMessage request, Boolean allowHttp2, CancellationToken cancellationToken)
at System.Net.Http.HttpConnectionPool.CreateHttp11ConnectionAsync(HttpRequestMessage request, CancellationToken cancellationToken)
at System.Net.Http.HttpConnectionPool.GetHttpConnectionAsync(HttpRequestMessage request, CancellationToken cancellationToken)
at System.Net.Http.HttpConnectionPool.SendWithRetryAsync(HttpRequestMessage request, Boolean doRequestAuth, CancellationToken cancellationToken)
at System.Net.Http.RedirectHandler.SendAsync(HttpRequestMessage request, CancellationToken cancellationToken)
at System.Net.WebSockets.WebSocketHandle.ConnectAsyncCore(Uri uri, CancellationToken cancellationToken, ClientWebSocketOptions options)
at System.Net.WebSockets.WebSocketHandle.ConnectAsyncCore(Uri uri, CancellationToken cancellationToken, ClientWebSocketOptions options)
at System.Net.WebSockets.ClientWebSocket.ConnectAsyncCore(Uri uri, CancellationToken cancellationToken)
at Microsoft.Azure.Devices.Client.Transport.AmqpIoT.AmqpIoTTransport.CreateClientWebSocketAsync(Uri websocketUri, TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.AmqpIoT.AmqpIoTTransport.CreateClientWebSocketTransportAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.AmqpIoT.AmqpIoTTransport.InitializeAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.Amqp.AmqpIoTConnector.OpenConnectionAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.Amqp.AmqpConnectionHolder.EnsureConnectionAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.Amqp.AmqpConnectionHolder.OpenSessionAsync(DeviceIdentity deviceIdentity, TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.AmqpIoT.AmqpUnit.EnsureSessionIsOpenAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.AmqpIoT.AmqpUnit.OpenAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.Amqp.AmqpTransportHandler.OpenAsync(CancellationToken cancellationToken)
at Microsoft.Azure.Devices.Client.Transport.ProtocolRoutingDelegatingHandler.OpenAsync(CancellationToken cancellationToken)
at Microsoft.Azure.Devices.Client.Transport.ErrorDelegatingHandler.<>c__DisplayClass27_0.<<ExecuteWithErrorHandlingAsync>b__0>d.MoveNext()
--- End of stack trace from previous location where exception was thrown ---
at Microsoft.Azure.Devices.Client.Transport.ErrorDelegatingHandler.ExecuteWithErrorHandlingAsync[T](Func`1 asyncOperation)
--- End of inner exception stack trace ---
at Microsoft.Azure.Devices.Client.Transport.ErrorDelegatingHandler.ExecuteWithErrorHandlingAsync[T](Func`1 asyncOperation)
at Microsoft.Azure.Devices.Client.Transport.RetryDelegatingHandler.<>c__DisplayClass38_0.<<OpenInternalAsync>b__0>d.MoveNext()
--- End of stack trace from previous location where exception was thrown ---
at Microsoft.Azure.Devices.Client.Transport.RetryDelegatingHandler.EnsureOpenedAsync(CancellationToken cancellationToken)
at Microsoft.Azure.Devices.Client.InternalClient.OpenAsync()
at Microsoft.Azure.Devices.Edge.Agent.IoTHub.ModuleClientProvider.CreateAndOpenSdkModuleClient(UpstreamProtocol upstreamProtocol, ConnectionStatusChangesHandler statusChangedHandler) in /mnt/vss/_work/1/s/edge-agent/src/Microsoft.Azure.Devices.Edge.Agent.IoTHub/ModuleClientProvider.cs:line 230
at Microsoft.Azure.Devices.Edge.Agent.IoTHub.ModuleClientProvider.<>c__DisplayClass20_1.<<CreateSdkModuleClient>b__3>d.MoveNext() in /mnt/vss/_work/1/s/edge-agent/src/Microsoft.Azure.Devices.Edge.Agent.IoTHub/ModuleClientProvider.cs:line 194
--- End of stack trace from previous location where exception was thrown ---
at Microsoft.Azure.Devices.Edge.Util.Fallback.ExecuteAsync[T](Func`1[] options)<---
<4> 2022-05-09 06:44:39.842 +00:00 [WRN] - Empty edge agent config was received. Attempting to read config from backup (/tmp/edgeAgent/backup.json) instead
<4> 2022-05-09 06:44:49.856 +00:00 [WRN] - Empty edge agent config was received. Attempting to read config from backup (/tmp/edgeAgent/backup.json) instead
<4> 2022-05-09 06:44:59.879 +00:00 [WRN] - Empty edge agent config was received. Attempting to read config from backup (/tmp/edgeAgent/backup.json) instead
<4> 2022-05-09 06:45:09.895 +00:00 [WRN] - Empty edge agent config was received. Attempting to read config from backup (/tmp/edgeAgent/backup.json) instead
<4> 2022-05-09 06:45:19.906 +00:00 [WRN] - Empty edge agent config was received. Attempting to read config from backup (/tmp/edgeAgent/backup.json) instead
<4> 2022-05-09 06:45:29.917 +00:00 [WRN] - Empty edge agent config was received. Attempting to read config from backup (/tmp/edgeAgent/backup.json) instead
<6> 2022-05-09 06:45:34.774 +00:00 [INF] - Edge agent attempting to connect to IoT Hub via Amqp_Tcp_Only...
<4> 2022-05-09 06:45:39.936 +00:00 [WRN] - Empty edge agent config was received. Attempting to read config from backup (/tmp/edgeAgent/backup.json) instead
<4> 2022-05-09 06:45:49.966 +00:00 [WRN] - Empty edge agent config was received. Attempting to read config from backup (/tmp/edgeAgent/backup.json) instead
<4> 2022-05-09 06:45:59.985 +00:00 [WRN] - Empty edge agent config was received. Attempting to read config from backup (/tmp/edgeAgent/backup.json) instead
<6> 2022-05-09 06:46:06.385 +00:00 [INF] - Edge agent attempting to connect to IoT Hub via Amqp_WebSocket_Only...
<4> 2022-05-09 06:46:09.986 +00:00 [WRN] - Empty edge agent config was received. Attempting to read config from backup (/tmp/edgeAgent/backup.json) instead
<4> 2022-05-09 06:46:19.987 +00:00 [WRN] - Empty edge agent config was received. Attempting to read config from backup (/tmp/edgeAgent/backup.json) instead
<4> 2022-05-09 06:46:30.002 +00:00 [WRN] - Empty edge agent config was received. Attempting to read config from backup (/tmp/edgeAgent/backup.json) instead
<4> 2022-05-09 06:46:38.737 +00:00 [WRN] - Error creating a device-to-cloud connection
System.AggregateException: One or more errors occurred. (Transient network error occurred, please retry.) (Transient network error occurred, please retry.)
---> Microsoft.Azure.Devices.Client.Exceptions.IotHubCommunicationException: Transient network error occurred, please retry.
---> System.Net.Sockets.SocketException (11): Resource temporarily unavailable
at Microsoft.Azure.Devices.Client.Transport.AmqpIoT.AmqpIoTTransport.InitializeAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.Amqp.AmqpIoTConnector.OpenConnectionAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.Amqp.AmqpConnectionHolder.EnsureConnectionAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.Amqp.AmqpConnectionHolder.OpenSessionAsync(DeviceIdentity deviceIdentity, TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.AmqpIoT.AmqpUnit.EnsureSessionIsOpenAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.AmqpIoT.AmqpUnit.OpenAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.Amqp.AmqpTransportHandler.OpenAsync(CancellationToken cancellationToken)
at Microsoft.Azure.Devices.Client.Transport.ProtocolRoutingDelegatingHandler.OpenAsync(CancellationToken cancellationToken)
at Microsoft.Azure.Devices.Client.Transport.ErrorDelegatingHandler.<>c__DisplayClass27_0.<<ExecuteWithErrorHandlingAsync>b__0>d.MoveNext()
--- End of stack trace from previous location where exception was thrown ---
at Microsoft.Azure.Devices.Client.Transport.ErrorDelegatingHandler.ExecuteWithErrorHandlingAsync[T](Func`1 asyncOperation)
--- End of inner exception stack trace ---
at Microsoft.Azure.Devices.Client.Transport.ErrorDelegatingHandler.ExecuteWithErrorHandlingAsync[T](Func`1 asyncOperation)
at Microsoft.Azure.Devices.Client.Transport.RetryDelegatingHandler.<>c__DisplayClass38_0.<<OpenInternalAsync>b__0>d.MoveNext()
--- End of stack trace from previous location where exception was thrown ---
at Microsoft.Azure.Devices.Client.Transport.RetryDelegatingHandler.EnsureOpenedAsync(CancellationToken cancellationToken)
at Microsoft.Azure.Devices.Client.InternalClient.OpenAsync()
at Microsoft.Azure.Devices.Edge.Agent.IoTHub.ModuleClientProvider.CreateAndOpenSdkModuleClient(UpstreamProtocol upstreamProtocol, ConnectionStatusChangesHandler statusChangedHandler) in /mnt/vss/_work/1/s/edge-agent/src/Microsoft.Azure.Devices.Edge.Agent.IoTHub/ModuleClientProvider.cs:line 230
at Microsoft.Azure.Devices.Edge.Agent.IoTHub.ModuleClientProvider.<>c__DisplayClass20_1.<<CreateSdkModuleClient>b__2>d.MoveNext() in /mnt/vss/_work/1/s/edge-agent/src/Microsoft.Azure.Devices.Edge.Agent.IoTHub/ModuleClientProvider.cs:line 188
--- End of stack trace from previous location where exception was thrown ---
at Microsoft.Azure.Devices.Edge.Util.Fallback.ExecuteAsync[T](Func`1[] options)
--- End of inner exception stack trace ---
---> (Inner Exception #1) Microsoft.Azure.Devices.Client.Exceptions.IotHubCommunicationException: Transient network error occurred, please retry.
---> System.Net.WebSockets.WebSocketException (0x80004005): Unable to connect to the remote server
---> System.Net.Http.HttpRequestException: Resource temporarily unavailable
---> System.Net.Sockets.SocketException (11): Resource temporarily unavailable
at System.Net.Http.ConnectHelper.ConnectAsync(String host, Int32 port, CancellationToken cancellationToken)
--- End of inner exception stack trace ---
at System.Net.Http.ConnectHelper.ConnectAsync(String host, Int32 port, CancellationToken cancellationToken)
at System.Net.Http.HttpConnectionPool.ConnectAsync(HttpRequestMessage request, Boolean allowHttp2, CancellationToken cancellationToken)
at System.Net.Http.HttpConnectionPool.CreateHttp11ConnectionAsync(HttpRequestMessage request, CancellationToken cancellationToken)
at System.Net.Http.HttpConnectionPool.GetHttpConnectionAsync(HttpRequestMessage request, CancellationToken cancellationToken)
at System.Net.Http.HttpConnectionPool.SendWithRetryAsync(HttpRequestMessage request, Boolean doRequestAuth, CancellationToken cancellationToken)
at System.Net.Http.RedirectHandler.SendAsync(HttpRequestMessage request, CancellationToken cancellationToken)
at System.Net.WebSockets.WebSocketHandle.ConnectAsyncCore(Uri uri, CancellationToken cancellationToken, ClientWebSocketOptions options)
at System.Net.WebSockets.WebSocketHandle.ConnectAsyncCore(Uri uri, CancellationToken cancellationToken, ClientWebSocketOptions options)
at System.Net.WebSockets.ClientWebSocket.ConnectAsyncCore(Uri uri, CancellationToken cancellationToken)
at Microsoft.Azure.Devices.Client.Transport.AmqpIoT.AmqpIoTTransport.CreateClientWebSocketAsync(Uri websocketUri, TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.AmqpIoT.AmqpIoTTransport.CreateClientWebSocketTransportAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.AmqpIoT.AmqpIoTTransport.InitializeAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.Amqp.AmqpIoTConnector.OpenConnectionAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.Amqp.AmqpConnectionHolder.EnsureConnectionAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.Amqp.AmqpConnectionHolder.OpenSessionAsync(DeviceIdentity deviceIdentity, TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.AmqpIoT.AmqpUnit.EnsureSessionIsOpenAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.AmqpIoT.AmqpUnit.OpenAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.Amqp.AmqpTransportHandler.OpenAsync(CancellationToken cancellationToken)
at Microsoft.Azure.Devices.Client.Transport.ProtocolRoutingDelegatingHandler.OpenAsync(CancellationToken cancellationToken)
at Microsoft.Azure.Devices.Client.Transport.ErrorDelegatingHandler.<>c__DisplayClass27_0.<<ExecuteWithErrorHandlingAsync>b__0>d.MoveNext()
--- End of stack trace from previous location where exception was thrown ---
at Microsoft.Azure.Devices.Client.Transport.ErrorDelegatingHandler.ExecuteWithErrorHandlingAsync[T](Func`1 asyncOperation)
--- End of inner exception stack trace ---
at Microsoft.Azure.Devices.Client.Transport.ErrorDelegatingHandler.ExecuteWithErrorHandlingAsync[T](Func`1 asyncOperation)
at Microsoft.Azure.Devices.Client.Transport.RetryDelegatingHandler.<>c__DisplayClass38_0.<<OpenInternalAsync>b__0>d.MoveNext()
--- End of stack trace from previous location where exception was thrown ---
at Microsoft.Azure.Devices.Client.Transport.RetryDelegatingHandler.EnsureOpenedAsync(CancellationToken cancellationToken)
at Microsoft.Azure.Devices.Client.InternalClient.OpenAsync()
at Microsoft.Azure.Devices.Edge.Agent.IoTHub.ModuleClientProvider.CreateAndOpenSdkModuleClient(UpstreamProtocol upstreamProtocol, ConnectionStatusChangesHandler statusChangedHandler) in /mnt/vss/_work/1/s/edge-agent/src/Microsoft.Azure.Devices.Edge.Agent.IoTHub/ModuleClientProvider.cs:line 234
at Microsoft.Azure.Devices.Edge.Agent.IoTHub.ModuleClientProvider.<>c__DisplayClass20_1.<<CreateSdkModuleClient>b__3>d.MoveNext() in /mnt/vss/_work/1/s/edge-agent/src/Microsoft.Azure.Devices.Edge.Agent.IoTHub/ModuleClientProvider.cs:line 194
--- End of stack trace from previous location where exception was thrown ---
at Microsoft.Azure.Devices.Edge.Util.Fallback.ExecuteAsync[T](Func`1[] options)<---
<4> 2022-05-09 06:46:40.015 +00:00 [WRN] - Empty edge agent config was received. Attempting to read config from backup (/tmp/edgeAgent/backup.json) instead
<4> 2022-05-09 06:46:50.047 +00:00 [WRN] - Empty edge agent config was received. Attempting to read config from backup (/tmp/edgeAgent/backup.json) instead
<4> 2022-05-09 06:47:00.057 +00:00 [WRN] - Empty edge agent config was received. Attempting to read config from backup (/tmp/edgeAgent/backup.json) instead
<4> 2022-05-09 06:47:10.072 +00:00 [WRN] - Empty edge agent config was received. Attempting to read config from backup (/tmp/edgeAgent/backup.json) instead
<4> 2022-05-09 06:47:20.089 +00:00 [WRN] - Empty edge agent config was received. Attempting to read config from backup (/tmp/edgeAgent/backup.json) instead
<4> 2022-05-09 06:47:30.118 +00:00 [WRN] - Empty edge agent config was received. Attempting to read config from backup (/tmp/edgeAgent/backup.json) instead
<6> 2022-05-09 06:47:39.001 +00:00 [INF] - Edge agent attempting to connect to IoT Hub via Amqp_Tcp_Only...
<4> 2022-05-09 06:47:40.145 +00:00 [WRN] - Empty edge agent config was received. Attempting to read config from backup (/tmp/edgeAgent/backup.json) instead
<4> 2022-05-09 06:47:50.146 +00:00 [WRN] - Empty edge agent config was received. Attempting to read config from backup (/tmp/edgeAgent/backup.json) instead
<4> 2022-05-09 06:48:00.152 +00:00 [WRN] - Empty edge agent config was received. Attempting to read config from backup (/tmp/edgeAgent/backup.json) instead
<4> 2022-05-09 06:48:10.152 +00:00 [WRN] - Empty edge agent config was received. Attempting to read config from backup (/tmp/edgeAgent/backup.json) instead
<6> 2022-05-09 06:48:10.422 +00:00 [INF] - Edge agent attempting to connect to IoT Hub via Amqp_WebSocket_Only...
<4> 2022-05-09 06:48:20.164 +00:00 [WRN] - Empty edge agent config was received. Attempting to read config from backup (/tmp/edgeAgent/backup.json) instead
<4> 2022-05-09 06:48:30.175 +00:00 [WRN] - Empty edge agent config was received. Attempting to read config from backup (/tmp/edgeAgent/backup.json) instead
<4> 2022-05-09 06:48:40.198 +00:00 [WRN] - Empty edge agent config was received. Attempting to read config from backup (/tmp/edgeAgent/backup.json) instead
<4> 2022-05-09 06:48:42.526 +00:00 [WRN] - Error creating a device-to-cloud connection
System.AggregateException: One or more errors occurred. (Transient network error occurred, please retry.) (Transient network error occurred, please retry.)
---> Microsoft.Azure.Devices.Client.Exceptions.IotHubCommunicationException: Transient network error occurred, please retry.
---> System.Net.Sockets.SocketException (11): Resource temporarily unavailable
at Microsoft.Azure.Devices.Client.Transport.AmqpIoT.AmqpIoTTransport.InitializeAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.Amqp.AmqpIoTConnector.OpenConnectionAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.Amqp.AmqpConnectionHolder.EnsureConnectionAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.Amqp.AmqpConnectionHolder.OpenSessionAsync(DeviceIdentity deviceIdentity, TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.AmqpIoT.AmqpUnit.EnsureSessionIsOpenAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.AmqpIoT.AmqpUnit.OpenAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.Amqp.AmqpTransportHandler.OpenAsync(CancellationToken cancellationToken)
at Microsoft.Azure.Devices.Client.Transport.ProtocolRoutingDelegatingHandler.OpenAsync(CancellationToken cancellationToken)
at Microsoft.Azure.Devices.Client.Transport.ErrorDelegatingHandler.<>c__DisplayClass27_0.<<ExecuteWithErrorHandlingAsync>b__0>d.MoveNext()
--- End of stack trace from previous location where exception was thrown ---
at Microsoft.Azure.Devices.Client.Transport.ErrorDelegatingHandler.ExecuteWithErrorHandlingAsync[T](Func`1 asyncOperation)
--- End of inner exception stack trace ---
at Microsoft.Azure.Devices.Client.Transport.ErrorDelegatingHandler.ExecuteWithErrorHandlingAsync[T](Func`1 asyncOperation)
at Microsoft.Azure.Devices.Client.Transport.RetryDelegatingHandler.<>c__DisplayClass38_0.<<OpenInternalAsync>b__0>d.MoveNext()
--- End of stack trace from previous location where exception was thrown ---
at Microsoft.Azure.Devices.Client.Transport.RetryDelegatingHandler.EnsureOpenedAsync(CancellationToken cancellationToken)
at Microsoft.Azure.Devices.Client.InternalClient.OpenAsync()
at Microsoft.Azure.Devices.Edge.Agent.IoTHub.ModuleClientProvider.CreateAndOpenSdkModuleClient(UpstreamProtocol upstreamProtocol, ConnectionStatusChangesHandler statusChangedHandler) in /mnt/vss/_work/1/s/edge-agent/src/Microsoft.Azure.Devices.Edge.Agent.IoTHub/ModuleClientProvider.cs:line 234
at Microsoft.Azure.Devices.Edge.Agent.IoTHub.ModuleClientProvider.<>c__DisplayClass20_1.<<CreateSdkModuleClient>b__2>d.MoveNext() in /mnt/vss/_work/1/s/edge-agent/src/Microsoft.Azure.Devices.Edge.Agent.IoTHub/ModuleClientProvider.cs:line 188
--- End of stack trace from previous location where exception was thrown ---
at Microsoft.Azure.Devices.Edge.Util.Fallback.ExecuteAsync[T](Func`1[] options)
--- End of inner exception stack trace ---
---> (Inner Exception #1) Microsoft.Azure.Devices.Client.Exceptions.IotHubCommunicationException: Transient network error occurred, please retry.
---> System.Net.WebSockets.WebSocketException (0x80004005): Unable to connect to the remote server
---> System.Net.Http.HttpRequestException: Resource temporarily unavailable
---> System.Net.Sockets.SocketException (11): Resource temporarily unavailable
at System.Net.Http.ConnectHelper.ConnectAsync(String host, Int32 port, CancellationToken cancellationToken)
--- End of inner exception stack trace ---
at System.Net.Http.ConnectHelper.ConnectAsync(String host, Int32 port, CancellationToken cancellationToken)
at System.Net.Http.HttpConnectionPool.ConnectAsync(HttpRequestMessage request, Boolean allowHttp2, CancellationToken cancellationToken)
at System.Net.Http.HttpConnectionPool.CreateHttp11ConnectionAsync(HttpRequestMessage request, CancellationToken cancellationToken)
at System.Net.Http.HttpConnectionPool.GetHttpConnectionAsync(HttpRequestMessage request, CancellationToken cancellationToken)
at System.Net.Http.HttpConnectionPool.SendWithRetryAsync(HttpRequestMessage request, Boolean doRequestAuth, CancellationToken cancellationToken)
at System.Net.Http.RedirectHandler.SendAsync(HttpRequestMessage request, CancellationToken cancellationToken)
at System.Net.WebSockets.WebSocketHandle.ConnectAsyncCore(Uri uri, CancellationToken cancellationToken, ClientWebSocketOptions options)
at System.Net.WebSockets.WebSocketHandle.ConnectAsyncCore(Uri uri, CancellationToken cancellationToken, ClientWebSocketOptions options)
at System.Net.WebSockets.ClientWebSocket.ConnectAsyncCore(Uri uri, CancellationToken cancellationToken)
at Microsoft.Azure.Devices.Client.Transport.AmqpIoT.AmqpIoTTransport.CreateClientWebSocketAsync(Uri websocketUri, TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.AmqpIoT.AmqpIoTTransport.CreateClientWebSocketTransportAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.AmqpIoT.AmqpIoTTransport.InitializeAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.Amqp.AmqpIoTConnector.OpenConnectionAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.Amqp.AmqpConnectionHolder.EnsureConnectionAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.Amqp.AmqpConnectionHolder.OpenSessionAsync(DeviceIdentity deviceIdentity, TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.AmqpIoT.AmqpUnit.EnsureSessionIsOpenAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.AmqpIoT.AmqpUnit.OpenAsync(TimeSpan timeout)
at Microsoft.Azure.Devices.Client.Transport.Amqp.AmqpTransportHandler.OpenAsync(CancellationToken cancellationToken)
at Microsoft.Azure.Devices.Client.Transport.ProtocolRoutingDelegatingHandler.OpenAsync(CancellationToken cancellationToken)
at Microsoft.Azure.Devices.Client.Transport.ErrorDelegatingHandler.<>c__DisplayClass27_0.<<ExecuteWithErrorHandlingAsync>b__0>d.MoveNext()
--- End of stack trace from previous location where exception was thrown ---
at Microsoft.Azure.Devices.Client.Transport.ErrorDelegatingHandler.ExecuteWithErrorHandlingAsync[T](Func`1 asyncOperation)
--- End of inner exception stack trace ---
at Microsoft.Azure.Devices.Client.Transport.ErrorDelegatingHandler.ExecuteWithErrorHandlingAsync[T](Func`1 asyncOperation)
at Microsoft.Azure.Devices.Client.Transport.RetryDelegatingHandler.<>c__DisplayClass38_0.<<OpenInternalAsync>b__0>d.MoveNext()
--- End of stack trace from previous location where exception was thrown ---
at Microsoft.Azure.Devices.Client.Transport.RetryDelegatingHandler.EnsureOpenedAsync(CancellationToken cancellationToken)
at Microsoft.Azure.Devices.Client.InternalClient.OpenAsync()
at Microsoft.Azure.Devices.Edge.Agent.IoTHub.ModuleClientProvider.CreateAndOpenSdkModuleClient(UpstreamProtocol upstreamProtocol, ConnectionStatusChangesHandler statusChangedHandler) in /mnt/vss/_work/1/s/edge-agent/src/Microsoft.Azure.Devices.Edge.Agent.IoTHub/ModuleClientProvider.cs:line 234
at Microsoft.Azure.Devices.Edge.Agent.IoTHub.ModuleClientProvider.<>c__DisplayClass20_1.<<CreateSdkModuleClient>b__3>d.MoveNext() in /mnt/vss/_work/1/s/edge-agent/src/Microsoft.Azure.Devices.Edge.Agent.IoTHub/ModuleClientProvider.cs:line 194
--- End of stack trace from previous location where exception was thrown ---
at Microsoft.Azure.Devices.Edge.Util.Fallback.ExecuteAsync[T](Func`1[] options)<---
<4> 2022-05-09 06:48:50.203 +00:00 [WRN] - Empty edge agent config was received. Attempting to read config from backup (/tmp/edgeAgent/backup.json) instead
<4> 2022-05-09 06:49:00.227 +00:00 [WRN] - Empty edge agent config was received. Attempting to read config from backup (/tmp/edgeAgent/backup.json) instead
<4> 2022-05-09 06:49:10.241 +00:00 [WRN] - Empty edge agent config was received. Attempting to read config from backup (/tmp/edgeAgent/backup.json) instead
<4> 2022-05-09 06:49:20.254 +00:00 [WRN] - Empty edge agent config was received. Attempting to read config from backup (/tmp/edgeAgent/backup.json) instead
<4> 2022-05-09 06:49:30.266 +00:00 [WRN] - Empty edge agent config was received. Attempting to read config from backup (/tmp/edgeAgent/backup.json) instead
<4> 2022-05-09 06:49:40.277 +00:00 [WRN] - Empty edge agent config was received. Attempting to read config from backup (/tmp/edgeAgent/backup.json) instead
<6> 2022-05-09 06:49:42.702 +00:00 [INF] - Edge agent attempting to connect to IoT Hub via Amqp_Tcp_Only...
<4> 2022-05-09 06:49:50.305 +00:00 [WRN] - Empty edge agent config was received. Attempting to read config from backup (/tmp/edgeAgent/backup.json) instead
<4> 2022-05-09 06:50:00.321 +00:00 [WRN] - Empty edge agent config was received. Attempting to read config from backup (/tmp/edgeAgent/backup.json) instead
Labels:
- Labels:
-
IoT Edge
0 Replies