Routing on IOT Edge
Hi, I have a problem that I have been dealing with for quite some time. Trying to put a "where" in a routing for AZIOT edge hub. have tested this which works. FROM /messages/* WHERE $connectionModuleId = 'noded' INTO BrokeredEndpoint("/modules/testjob/inputs/edgehub") . But what I want to do is a "where" against appProperties. I have tried every conceivable "syntax" for this?? Inserts an example message. { "message": { "systemProperties": { "contentType": "application/json", "contentEncoding": "UTF-8", "iothub-message-source": "deviceMessages", "iothub-enqueuedtime": "2017-05-08T18:55:31.8514657Z" }, "appProperties": { "processingPath": "{cold | warm | hot}", "verbose": "{true, false}", "severity": 1-5, "testDevice": "{true | false}" }, "body": "{\"Weather\":{\"Temperature\":50}}" } } Thanks for any help I can get. Can't find any documentation for this?
IoT Edge certificate renewal
Hi all, We are currently implementing an IoT Edge on a lot of Devices which will be at remote locations. We have cleared out that IoT Edge can use up to 3 certificates: Certificate to perform the TLS communication with IoT Hub Device certificates for internal use with modules, leave devices, etc. DPS (Optional is you use certificates) We are currently looking for a solution for point 1 and 2. 1. We understand that this can be solved with keeping IoT Edge up-to-date, but how do perform this is these devices are Remote and we have a lot of them? I know this will not happen that often that this certificate will expire but still it can, so we want to be prepared. 2. Device certificates should also be renewed from time to time. How can you also orchestrated form IoT Hub? We currently where thinking of building a module, but when the device comes online again after some time and in the main time, the certificate has expired, than the module is not able to talk to IoT Hub. Or do you just install a device certificate a installation which will have an expiration date longer then the expected device lifetime? Thanks for the help and insights on this topic. Kr, Steven
IoT Edge runtime not able to connect to the Azure IoT Hub
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) insteadIntroducing Live Video Analytics from Azure Media Services - Now in preview
Azure Media Services is pleased to announce the public preview of a new platform capability called “Live Video Analytics” or in short LVA. LVA provides a platform for you to build hybrid applications with video analytics capabilities. The platform offers the capability of capturing, recording, and analyzing live video and publishing the results (which could be video and/or video analytics) to Azure services in the cloud and/or the edge.
