Azure / Azure/iot-identity-service

aziot-identityd 1.5.0 fails to start

Open
#613 2 comments 0 reactions 0 assignees View on GitHub
Dominant language
Rust
Stars
38
Forks
54
Avg merge
5d 13h
Merged PRs (30d)
1

Description

Hi. We have recently tried to use the IoT Edge 1.5 version, but we have been unable to use it. At least aziot-identityd does not start. Installing 1.4 version to clean Ubuntu 22 LTS works, but doing the same for 1.5 fails to start.

## Expected Behavior
aziot-identityd starts after installation

## Current Behavior
aziot-identityd fails to start:

```

touko 23 21:25:17 user-VirtualBox systemd[1]: Stopped Azure IoT Identity Service.
touko 23 21:25:17 user-VirtualBox systemd[1]: Started Azure IoT Identity Service.
touko 23 21:25:17 user-VirtualBox aziot-identityd[9643]: 2024-05-23T18:25:17Z [INFO] - Starting service...
touko 23 21:25:17 user-VirtualBox aziot-identityd[9643]: 2024-05-23T18:25:17Z [INFO] - Version - 1.5.0
touko 23 21:25:17 user-VirtualBox aziot-identityd[9643]: 2024-05-23T18:25:17Z [INFO] - Loaded openssl'd Default provider
touko 23 21:25:17 user-VirtualBox aziot-identityd[9643]: 2024-05-23T18:25:17Z [INFO] - Provisioning starting. Reason: Startup
touko 23 21:25:17 user-VirtualBox aziot-identityd[9643]: 2024-05-23T18:25:17Z [INFO] - Updated device info for temporary-test-device.
touko 23 21:25:17 user-VirtualBox aziot-identityd[9643]: 2024-05-23T18:25:17Z [INFO] - Provisioning complete.
touko 23 21:25:17 user-VirtualBox aziot-identityd[9643]: 2024-05-23T18:25:17Z [INFO] - Identity reconciliation started. Reason: Startup
touko 23 21:25:18 user-VirtualBox aziot-identityd[9643]: 2024-05-23T18:25:18Z [INFO] - Could not reconcile Identities with current device data. Reprovisioning.
touko 23 21:25:18 user-VirtualBox aziot-identityd[9643]: 2024-05-23T18:25:18Z [INFO] - Updated device info for temporary-test-device.
touko 23 21:25:18 user-VirtualBox aziot-identityd[9643]: 2024-05-23T18:25:18Z [ERR!] - Failed to provision with IoT Hub, and no valid device backup was found: Hub client error
touko 23 21:25:18 user-VirtualBox aziot-identityd[9643]: 2024-05-23T18:25:18Z [ERR!] - service encountered an error
touko 23 21:25:18 user-VirtualBox aziot-identityd[9643]: 2024-05-23T18:25:18Z [ERR!] - caused by: Hub client error
touko 23 21:25:18 user-VirtualBox aziot-identityd[9643]: 2024-05-23T18:25:18Z [ERR!] - caused by: ErrorCode:IotHubUnauthorizedAccess;Unauthorized
touko 23 21:25:18 user-VirtualBox aziot-identityd[9643]: 2024-05-23T18:25:18Z [ERR!] - 0:
touko 23 21:25:18 user-VirtualBox aziot-identityd[9643]: 1:
touko 23 21:25:18 user-VirtualBox aziot-identityd[9643]: 2:
touko 23 21:25:18 user-VirtualBox aziot-identityd[9643]: 3:
touko 23 21:25:18 user-VirtualBox aziot-identityd[9643]: 4:
touko 23 21:25:18 user-VirtualBox aziot-identityd[9643]: 5:
touko 23 21:25:18 user-VirtualBox aziot-identityd[9643]: 6:
touko 23 21:25:18 user-VirtualBox aziot-identityd[9643]: 7:
touko 23 21:25:18 user-VirtualBox aziot-identityd[9643]: 8:
touko 23 21:25:18 user-VirtualBox aziot-identityd[9643]: 9: __libc_start_call_main
touko 23 21:25:18 user-VirtualBox aziot-identityd[9643]: at ./csu/../sysdeps/nptl/libc_start_call_main.h:58:16
touko 23 21:25:18 user-VirtualBox aziot-identityd[9643]: 10: __libc_start_main_impl
touko 23 21:25:18 user-VirtualBox aziot-identityd[9643]: at ./csu/../csu/libc-start.c:392:3
touko 23 21:25:18 user-VirtualBox aziot-identityd[9643]: 11:
touko 23 21:25:18 user-VirtualBox systemd[1]: aziot-identityd.service: Main process exited, code=exited, status=1/FAILURE
touko 23 21:25:18 user-VirtualBox systemd[1]: aziot-identityd.service: Failed with result 'exit-code'.

```

## Steps to Reproduce
Install Azure IoT Edge 1.5 on clean Ubuntu 22 LTS using the instructions from https://learn.microsoft.com/en-gb/azure/iot-edge/how-to-provision-single-device-linux-symmetric?view=iotedge-1.5&tabs=azure-portal%2Cubuntu

## Context (Environment)

### Output of `iotedge check`

Click here

```

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 - OK
√ 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 - Error
could not load cert with ID "aziot-edged-trust-bundle"

Caused by:
parameter "id" has an invalid value
caused by: not found
√ read all preloaded key pairs from the Keys Service - OK
√ check all EST server URLs utilize HTTPS - 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 - Error
SocketError - SocketErrorCode (TimedOut) : Operation timed out
One or more errors occurred. (Got bad response: )
√ aziot-edge package is up-to-date - OK
√ container time is close to host time - OK
‼ DNS server - Warning
Container engine is not configured with DNS server setting, which may impact connectivity to IoT Hub.
Please see https://aka.ms/iotedge-prod-checklist-dns for best practices.
You can ignore this warning if you are setting DNS server per module in the Edge deployment.
‼ 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 - Error
Could not check current state of edgeAgent container
× 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
√ proxy settings are consistent in aziot-edged, aziot-identityd, moby daemon and config.toml - OK

Connectivity checks
-------------------
√ container on the default network can connect to upstream AMQP port - OK
√ container on the default network can connect to upstream HTTPS / WebSockets port - OK
× 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 liazeuwedgedevflex.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 liazeuwedgedevflex.azure-devices.net:443
27 check(s) succeeded.
2 check(s) raised warnings. Re-run with --verbose for more details.
6 check(s) raised errors. Re-run with --verbose for more details.
2 check(s) were skipped due to errors from other checks. Re-run with --verbose for more details.

```

### Output of `iotedge system status`

Click here

```

System services:
aziot-edged Running
aziot-identityd Down - activating
aziot-keyd Running
aziot-certd Running
aziot-tpmd Ready

aziot-identityd is in a bad state because:
aziot-identityd.service: Down - activating : Printing the last 10 log lines.
touko 23 21:36:19 user-VirtualBox aziot-identityd[11035]: 6:
touko 23 21:36:19 user-VirtualBox aziot-identityd[11035]: 7:
touko 23 21:36:19 user-VirtualBox aziot-identityd[11035]: 8:
touko 23 21:36:19 user-VirtualBox aziot-identityd[11035]: 9: __libc_start_call_main
touko 23 21:36:19 user-VirtualBox aziot-identityd[11035]: at ./csu/../sysdeps/nptl/libc_start_call_main.h:58:16
touko 23 21:36:19 user-VirtualBox aziot-identityd[11035]: 10: __libc_start_main_impl
touko 23 21:36:19 user-VirtualBox aziot-identityd[11035]: at ./csu/../csu/libc-start.c:392:3
touko 23 21:36:19 user-VirtualBox aziot-identityd[11035]: 11:
touko 23 21:36:19 user-VirtualBox systemd[1]: aziot-identityd.service: Main process exited, code=exited, status=1/FAILURE
touko 23 21:36:19 user-VirtualBox systemd[1]: aziot-identityd.service: Failed with result 'exit-code'.

```

### Device Information
* Host OS: Ubuntu 22.04
* Architecture: amd64
* Container OS: Linux containers

### Runtime Versions
* aziot-edged: iotedge 1.5.0
* Edge Agent: 1.5
* Edge Hub: 1.5
* Moby: 26.1.3-1

## Logs

aziot-edged logs

```

touko 23 21:06:50 user-VirtualBox systemd[1]: Started Azure IoT Edge daemon.
touko 23 21:06:50 user-VirtualBox aziot-edged[6290]: 2024-05-23T18:06:50Z [INFO] - Starting Azure IoT Edge Daemon
touko 23 21:06:50 user-VirtualBox aziot-edged[6290]: 2024-05-23T18:06:50Z [INFO] - Version - 1.5.0
touko 23 21:06:50 user-VirtualBox aziot-edged[6290]: 2024-05-23T18:06:50Z [INFO] - Obtaining Edge device provisioning data...
touko 23 21:06:55 user-VirtualBox aziot-edged[6290]: 2024-05-23T18:06:55Z [WARN] - Failed to send HTTP request (attempt 1 of 2): connection error: Connection reset by peer (os error 104)
touko 23 21:07:01 user-VirtualBox aziot-edged[6290]: 2024-05-23T18:07:01Z [WARN] - Failed to send HTTP request (attempt 2 of 2): connection error: Connection reset by peer (os error 104)
touko 23 21:07:01 user-VirtualBox aziot-edged[6290]: 2024-05-23T18:07:01Z [WARN] - Failed to obtain device identity: connection error: Connection reset by peer (os error 104)
touko 23 21:07:01 user-VirtualBox aziot-edged[6290]: 2024-05-23T18:07:01Z [INFO] - Requesting device reprovision
touko 23 21:07:01 user-VirtualBox aziot-edged[6290]: 2024-05-23T18:07:01Z [WARN] - Failed to send HTTP request (attempt 1 of 2): error trying to connect: Permission denied (os error 13)
touko 23 21:07:07 user-VirtualBox aziot-edged[6290]: 2024-05-23T18:07:07Z [WARN] - Failed to send HTTP request (attempt 2 of 2): connection error: Connection reset by peer (os error 104)
touko 23 21:07:07 user-VirtualBox aziot-edged[6290]: 2024-05-23T18:07:07Z [WARN] - Failed to reprovision: connection error: Connection reset by peer (os error 104)
touko 23 21:07:12 user-VirtualBox aziot-edged[6290]: 2024-05-23T18:07:12Z [INFO] - Obtaining Edge device provisioning data...
touko 23 21:07:12 user-VirtualBox aziot-edged[6290]: 2024-05-23T18:07:12Z [WARN] - Failed to send HTTP request (attempt 1 of 2): connection error: Connection reset by peer (os error 104)
touko 23 21:07:18 user-VirtualBox aziot-edged[6290]: 2024-05-23T18:07:18Z [WARN] - Failed to send HTTP request (attempt 2 of 2): connection error: Connection reset by peer (os error 104)
touko 23 21:07:18 user-VirtualBox aziot-edged[6290]: 2024-05-23T18:07:18Z [WARN] - Failed to obtain device identity: connection error: Connection reset by peer (os error 104)
touko 23 21:07:18 user-VirtualBox aziot-edged[6290]: 2024-05-23T18:07:18Z [INFO] - Requesting device reprovision
touko 23 21:07:18 user-VirtualBox aziot-edged[6290]: 2024-05-23T18:07:18Z [WARN] - Failed to clear provisioning cache before reprovision: No such file or directory (os error 2)
touko 23 21:07:18 user-VirtualBox aziot-edged[6290]: 2024-05-23T18:07:18Z [WARN] - Failed to send HTTP request (attempt 1 of 2): error trying to connect: Permission denied (os error 13)
touko 23 21:07:24 user-VirtualBox aziot-edged[6290]: 2024-05-23T18:07:24Z [WARN] - Failed to send HTTP request (attempt 2 of 2): connection error: Connection reset by peer (os error 104)
touko 23 21:07:24 user-VirtualBox aziot-edged[6290]: 2024-05-23T18:07:24Z [WARN] - Failed to reprovision: connection error: Connection reset by peer (os error 104)
touko 23 21:07:29 user-VirtualBox aziot-edged[6290]: 2024-05-23T18:07:29Z [INFO] - Obtaining Edge device provisioning data...
touko 23 21:07:30 user-VirtualBox aziot-edged[6290]: 2024-05-23T18:07:30Z [WARN] - Failed to send HTTP request (attempt 1 of 2): connection error: Connection reset by peer (os error 104)
touko 23 21:07:35 user-VirtualBox aziot-edged[6290]: 2024-05-23T18:07:35Z [WARN] - Failed to send HTTP request (attempt 2 of 2): connection error: Connection reset by peer (os error 104)
touko 23 21:07:35 user-VirtualBox aziot-edged[6290]: 2024-05-23T18:07:35Z [WARN] - Failed to obtain device identity: connection error: Connection reset by peer (os error 104)
touko 23 21:07:35 user-VirtualBox aziot-edged[6290]: 2024-05-23T18:07:35Z [INFO] - Requesting device reprovision
touko 23 21:07:35 user-VirtualBox aziot-edged[6290]: 2024-05-23T18:07:35Z [WARN] - Failed to clear provisioning cache before reprovision: No such file or directory (os error 2)
touko 23 21:07:35 user-VirtualBox aziot-edged[6290]: 2024-05-23T18:07:35Z [WARN] - Failed to send HTTP request (attempt 1 of 2): error trying to connect: Permission denied (os error 13)
touko 23 21:07:41 user-VirtualBox aziot-edged[6290]: 2024-05-23T18:07:41Z [WARN] - Failed to send HTTP request (attempt 2 of 2): connection error: Connection reset by peer (os error 104)
touko 23 21:07:41 user-VirtualBox aziot-edged[6290]: 2024-05-23T18:07:41Z [WARN] - Failed to reprovision: connection error: Connection reset by peer (os error 104)
touko 23 21:07:46 user-VirtualBox aziot-edged[6290]: 2024-05-23T18:07:46Z [INFO] - Obtaining Edge device provisioning data...
touko 23 21:07:47 user-VirtualBox aziot-edged[6290]: 2024-05-23T18:07:47Z [WARN] - Failed to send HTTP request (attempt 1 of 2): connection error: Connection reset by peer (os error 104)
touko 23 21:07:53 user-VirtualBox aziot-edged[6290]: 2024-05-23T18:07:53Z [WARN] - Failed to send HTTP request (attempt 2 of 2): connection error: Connection reset by peer (os error 104)
touko 23 21:07:53 user-VirtualBox aziot-edged[6290]: 2024-05-23T18:07:53Z [WARN] - Failed to obtain device identity: connection error: Connection reset by peer (os error 104)
touko 23 21:07:53 user-VirtualBox aziot-edged[6290]: 2024-05-23T18:07:53Z [INFO] - Requesting device reprovision
touko 23 21:07:53 user-VirtualBox aziot-edged[6290]: 2024-05-23T18:07:53Z [WARN] - Failed to clear provisioning cache before reprovision: No such file or directory (os error 2)
touko 23 21:07:53 user-VirtualBox aziot-edged[6290]: 2024-05-23T18:07:53Z [WARN] - Failed to send HTTP request (attempt 1 of 2): error trying to connect: Connection refused (os error 111)
touko 23 21:07:58 user-VirtualBox aziot-edged[6290]: 2024-05-23T18:07:58Z [WARN] - Failed to send HTTP request (attempt 2 of 2): connection error: Connection reset by peer (os error 104)
touko 23 21:07:58 user-VirtualBox aziot-edged[6290]: 2024-05-23T18:07:58Z [WARN] - Failed to reprovision: connection error: Connection reset by peer (os error 104)
touko 23 21:08:04 user-VirtualBox aziot-edged[6290]: 2024-05-23T18:08:04Z [INFO] - Obtaining Edge device provisioning data...
touko 23 21:08:04 user-VirtualBox aziot-edged[6290]: 2024-05-23T18:08:04Z [WARN] - Failed to send HTTP request (attempt 1 of 2): connection error: Connection reset by peer (os error 104)
touko 23 21:08:10 user-VirtualBox aziot-edged[6290]: 2024-05-23T18:08:10Z [WARN] - Failed to send HTTP request (attempt 2 of 2): connection error: Connection reset by peer (os error 104)
touko 23 21:08:10 user-VirtualBox aziot-edged[6290]: 2024-05-23T18:08:10Z [WARN] - Failed to obtain device identity: connection error: Connection reset by peer (os error 104)
touko 23 21:08:10 user-VirtualBox aziot-edged[6290]: 2024-05-23T18:08:10Z [INFO] - Requesting device reprovision
touko 23 21:08:10 user-VirtualBox aziot-edged[6290]: 2024-05-23T18:08:10Z [WARN] - Failed to clear provisioning cache before reprovision: No such file or directory (os error 2)
touko 23 21:08:10 user-VirtualBox aziot-edged[6290]: 2024-05-23T18:08:10Z [WARN] - Failed to send HTTP request (attempt 1 of 2): error trying to connect: Connection refused (os error 111)
touko 23 21:08:16 user-VirtualBox aziot-edged[6290]: 2024-05-23T18:08:16Z [WARN] - Failed to send HTTP request (attempt 2 of 2): connection error: Connection reset by peer (os error 104)
touko 23 21:08:16 user-VirtualBox aziot-edged[6290]: 2024-05-23T18:08:16Z [WARN] - Failed to reprovision: connection error: Connection reset by peer (os error 104)
touko 23 21:08:21 user-VirtualBox aziot-edged[6290]: 2024-05-23T18:08:21Z [INFO] - Obtaining Edge device provisioning data...
touko 23 21:08:21 user-VirtualBox aziot-edged[6290]: 2024-05-23T18:08:21Z [WARN] - Failed to send HTTP request (attempt 1 of 2): connection error: Connection reset by peer (os error 104)
touko 23 21:08:27 user-VirtualBox aziot-edged[6290]: 2024-05-23T18:08:27Z [WARN] - Failed to send HTTP request (attempt 2 of 2): connection error: Connection reset by peer (os error 104)
touko 23 21:08:27 user-VirtualBox aziot-edged[6290]: 2024-05-23T18:08:27Z [WARN] - Failed to obtain device identity: connection error: Connection reset by peer (os error 104)
touko 23 21:08:27 user-VirtualBox aziot-edged[6290]: 2024-05-23T18:08:27Z [INFO] - Requesting device reprovision
touko 23 21:08:27 user-VirtualBox aziot-edged[6290]: 2024-05-23T18:08:27Z [WARN] - Failed to clear provisioning cache before reprovision: No such file or directory (os error 2)
touko 23 21:08:27 user-VirtualBox aziot-edged[6290]: 2024-05-23T18:08:27Z [WARN] - Failed to send HTTP request (attempt 1 of 2): error trying to connect: Permission denied (os error 13)
touko 23 21:08:33 user-VirtualBox aziot-edged[6290]: 2024-05-23T18:08:33Z [WARN] - Failed to send HTTP request (attempt 2 of 2): connection error: Connection reset by peer (os error 104)
touko 23 21:08:33 user-VirtualBox aziot-edged[6290]: 2024-05-23T18:08:33Z [WARN] - Failed to reprovision: connection error: Connection reset by peer (os error 104)
touko 23 21:08:38 user-VirtualBox aziot-edged[6290]: 2024-05-23T18:08:38Z [INFO] - Obtaining Edge device provisioning data...
touko 23 21:08:39 user-VirtualBox aziot-edged[6290]: 2024-05-23T18:08:39Z [WARN] - Failed to send HTTP request (attempt 1 of 2): connection error: Connection reset by peer (os error 104)
touko 23 21:08:45 user-VirtualBox aziot-edged[6290]: 2024-05-23T18:08:45Z [WARN] - Failed to send HTTP request (attempt 2 of 2): connection error: Connection reset by peer (os error 104)
touko 23 21:08:45 user-VirtualBox aziot-edged[6290]: 2024-05-23T18:08:45Z [WARN] - Failed to obtain device identity: connection error: Connection reset by peer (os error 104)
touko 23 21:08:45 user-VirtualBox aziot-edged[6290]: 2024-05-23T18:08:45Z [INFO] - Requesting device reprovision
touko 23 21:08:45 user-VirtualBox aziot-edged[6290]: 2024-05-23T18:08:45Z [WARN] - Failed to clear provisioning cache before reprovision: No such file or directory (os error 2)
touko 23 21:08:45 user-VirtualBox aziot-edged[6290]: 2024-05-23T18:08:45Z [WARN] - Failed to send HTTP request (attempt 1 of 2): error trying to connect: Connection refused (os error 111)
touko 23 21:08:51 user-VirtualBox aziot-edged[6290]: 2024-05-23T18:08:51Z [WARN] - Failed to send HTTP request (attempt 2 of 2): connection error: Connection reset by peer (os error 104)
touko 23 21:08:51 user-VirtualBox aziot-edged[6290]: 2024-05-23T18:08:51Z [WARN] - Failed to reprovision: connection error: Connection reset by peer (os error 104)
touko 23 21:08:56 user-VirtualBox aziot-edged[6290]: 2024-05-23T18:08:56Z [INFO] - Obtaining Edge device provisioning data...

```

aziot-identityd logs

```

touko 23 21:42:04 user-VirtualBox systemd[1]: aziot-identityd.service: Scheduled restart job, restart counter is at 369.
touko 23 21:42:04 user-VirtualBox systemd[1]: Stopped Azure IoT Identity Service.
touko 23 21:42:04 user-VirtualBox systemd[1]: Started Azure IoT Identity Service.
touko 23 21:42:05 user-VirtualBox aziot-identityd[12091]: 2024-05-23T18:42:05Z [INFO] - Starting service...
touko 23 21:42:05 user-VirtualBox aziot-identityd[12091]: 2024-05-23T18:42:05Z [INFO] - Version - 1.5.0
touko 23 21:42:05 user-VirtualBox aziot-identityd[12091]: 2024-05-23T18:42:05Z [INFO] - Loaded openssl'd Default provider
touko 23 21:42:05 user-VirtualBox aziot-identityd[12091]: 2024-05-23T18:42:05Z [INFO] - Provisioning starting. Reason: Startup
touko 23 21:42:05 user-VirtualBox aziot-identityd[12091]: 2024-05-23T18:42:05Z [INFO] - Updated device info for temporary-test-device.
touko 23 21:42:05 user-VirtualBox aziot-identityd[12091]: 2024-05-23T18:42:05Z [INFO] - Provisioning complete.
touko 23 21:42:05 user-VirtualBox aziot-identityd[12091]: 2024-05-23T18:42:05Z [INFO] - Identity reconciliation started. Reason: Startup
touko 23 21:42:05 user-VirtualBox aziot-identityd[12091]: 2024-05-23T18:42:05Z [INFO] - Could not reconcile Identities with current device data. Reprovisioning.
touko 23 21:42:05 user-VirtualBox aziot-identityd[12091]: 2024-05-23T18:42:05Z [INFO] - Updated device info for temporary-test-device.
touko 23 21:42:05 user-VirtualBox aziot-identityd[12091]: 2024-05-23T18:42:05Z [ERR!] - Failed to provision with IoT Hub, and no valid device backup was found: Hub client error
touko 23 21:42:05 user-VirtualBox aziot-identityd[12091]: 2024-05-23T18:42:05Z [ERR!] - service encountered an error
touko 23 21:42:05 user-VirtualBox aziot-identityd[12091]: 2024-05-23T18:42:05Z [ERR!] - caused by: Hub client error
touko 23 21:42:05 user-VirtualBox aziot-identityd[12091]: 2024-05-23T18:42:05Z [ERR!] - caused by: ErrorCode:IotHubUnauthorizedAccess;Unauthorized
touko 23 21:42:05 user-VirtualBox aziot-identityd[12091]: 2024-05-23T18:42:05Z [ERR!] - 0:
touko 23 21:42:05 user-VirtualBox aziot-identityd[12091]: 1:
touko 23 21:42:05 user-VirtualBox aziot-identityd[12091]: 2:
touko 23 21:42:05 user-VirtualBox aziot-identityd[12091]: 3:
touko 23 21:42:05 user-VirtualBox aziot-identityd[12091]: 4:
touko 23 21:42:05 user-VirtualBox aziot-identityd[12091]: 5:
touko 23 21:42:05 user-VirtualBox aziot-identityd[12091]: 6:
touko 23 21:42:05 user-VirtualBox aziot-identityd[12091]: 7:
touko 23 21:42:05 user-VirtualBox aziot-identityd[12091]: 8:
touko 23 21:42:05 user-VirtualBox aziot-identityd[12091]: 9: __libc_start_call_main
touko 23 21:42:05 user-VirtualBox aziot-identityd[12091]: at ./csu/../sysdeps/nptl/libc_start_call_main.h:58:16
touko 23 21:42:05 user-VirtualBox aziot-identityd[12091]: 10: __libc_start_main_impl
touko 23 21:42:05 user-VirtualBox aziot-identityd[12091]: at ./csu/../csu/libc-start.c:392:3
touko 23 21:42:05 user-VirtualBox aziot-identityd[12091]: 11:
touko 23 21:42:05 user-VirtualBox systemd[1]: aziot-identityd.service: Main process exited, code=exited, status=1/FAILURE
touko 23 21:42:05 user-VirtualBox systemd[1]: aziot-identityd.service: Failed with result 'exit-code'.

```

aziot-certd logs

```

touko 23 21:17:56 user-VirtualBox systemd[1]: Stopped Azure IoT Certificates Service.
touko 23 21:34:09 user-VirtualBox systemd[1]: Started Azure IoT Certificates Service.
touko 23 21:34:09 user-VirtualBox aziot-certd[10331]: 2024-05-23T18:34:09Z [INFO] - Starting service...
touko 23 21:34:09 user-VirtualBox aziot-certd[10331]: 2024-05-23T18:34:09Z [INFO] - Version - 1.5.0
touko 23 21:34:09 user-VirtualBox aziot-certd[10331]: 2024-05-23T18:34:09Z [INFO] - Starting server...
touko 23 21:34:09 user-VirtualBox aziot-certd[10331]: 2024-05-23T18:34:09Z [INFO] - <-- GET /certificates/aziot-edged-trust-bundle?api-version=2020-09-01 {"host": "certd.sock"}
touko 23 21:34:09 user-VirtualBox aziot-certd[10331]: 2024-05-23T18:34:09Z [INFO] - !!! parameter "id" has an invalid value
touko 23 21:34:09 user-VirtualBox aziot-certd[10331]: 2024-05-23T18:34:09Z [INFO] - !!! caused by: not found
touko 23 21:34:09 user-VirtualBox aziot-certd[10331]: 2024-05-23T18:34:09Z [INFO] - --> 400 {"content-type": "application/json"}
touko 23 21:41:27 user-VirtualBox aziot-certd[10331]: 2024-05-23T18:41:27Z [INFO] - <-- GET /certificates/aziot-edged-trust-bundle?api-version=2020-09-01 {"host": "certd.sock"}
touko 23 21:41:27 user-VirtualBox aziot-certd[10331]: 2024-05-23T18:41:27Z [INFO] - !!! parameter "id" has an invalid value
touko 23 21:41:27 user-VirtualBox aziot-certd[10331]: 2024-05-23T18:41:27Z [INFO] - !!! caused by: not found
touko 23 21:41:27 user-VirtualBox aziot-certd[10331]: 2024-05-23T18:41:27Z [INFO] - --> 400 {"content-type": "application/json"}

```

Contributor guide

Open the contributing guide

Research direction

Start by comparing the Azure IoT Edge 1.4 and 1.5 installation results on clean Ubuntu 22.04, then inspect the aziot-identityd systemd logs and the reported IoT Hub Unauthorized error. Done means aziot-identityd starts successfully after following the linked provisioning instructions.

Written by the indexing model from the issue text.

Assessment

Tech stack
rust
Domain
authentication
Issue type
Bug
Difficulty
4/5
Estimated time
3-5 days
Activity status
Stale
Clarity
Needs clarification
Newbie friendliness
25/100

Get new issues in your inbox

A short digest of beginner-friendly GitHub issues.