Azure / iotedge

The IoT Edge OSS project
MIT License
1.45k stars 457 forks source link

IOT Edge service failed to start #1276

Closed akhtar927 closed 5 years ago

akhtar927 commented 5 years ago

Docker status: running i am using Raspberry pi 3b+ (stretch) My Iot Edge service failed to start giving me this error.

â iotedge.service - Azure IoT Edge daemon
   Loaded: loaded (/lib/systemd/system/iotedge.service; enabled; vendor preset: enabled)
   Active: inactive (dead) (Result: exit-code) since Thu 2019-05-30 17:42:19 IST; 13min ago
     Docs: man:iotedged(8)
  Process: 5135 ExecStart=/usr/bin/iotedged -c /etc/iotedge/config.yaml (code=exited, status=
 Main PID: 5135 (code=exited, status=1/FAILURE)
      CPU: 254ms

May 30 17:42:18 raspberrypi systemd[1]: iotedge.service: Failed with result 'exit-code'.
May 30 17:42:19 raspberrypi systemd[1]: iotedge.service: Service hold-off time over, scheduli
May 30 17:42:19 raspberrypi systemd[1]: Stopped Azure IoT Edge daemon.
May 30 17:42:19 raspberrypi systemd[1]: Dependency failed for Azure IoT Edge daemon.
May 30 17:42:19 raspberrypi systemd[1]: iotedge.service: Job iotedge.service/start failed wit

but then i regenerated the key and modified the config file and restarted my Iot Edge service became active.

But when i ran sudo journalctl -u iotedge --no-pager --no-full gives this error

May 30 17:42:18 raspberrypi iotedged[5135]: 2019-05-30T12:12:18Z [INFO] - Using config fâ¦yaml
May 30 17:42:18 raspberrypi iotedged[5135]: 2019-05-30T12:12:18Z [INFO] - Starting Azureâ¦emon
May 30 17:42:18 raspberrypi iotedged[5135]: 2019-05-30T12:12:18Z [INFO] - Version - 1.0.â¦9f3)
May 30 17:42:18 raspberrypi iotedged[5135]: 2019-05-30T12:12:18Z [INFO] - Using runtime â¦edge
May 30 17:42:18 raspberrypi iotedged[5135]: 2019-05-30T12:12:18Z [INFO] - Initializing tâ¦e...
May 30 17:42:18 raspberrypi iotedged[5135]: 2019-05-30T12:12:18Z [INFO] - Initializing mâ¦e...
May 30 17:42:18 raspberrypi iotedged[5135]: 2019-05-30T12:12:18Z [INFO] - Successfully iâ¦time
May 30 17:42:18 raspberrypi iotedged[5135]: 2019-05-30T12:12:18Z [INFO] - Finished initiâ¦ime.
May 30 17:42:18 raspberrypi iotedged[5135]: 2019-05-30T12:12:18Z [INFO] - Configuring /vâ¦ory.
May 30 17:42:18 raspberrypi iotedged[5135]: 2019-05-30T12:12:18Z [INFO] - Configuring ceâ¦s...
May 30 17:42:18 raspberrypi iotedged[5135]: 2019-05-30T12:12:18Z [INFO] - Transparent gaâ¦e...
May 30 17:42:18 raspberrypi iotedged[5135]: 2019-05-30T12:12:18Z [INFO] - Finished confiâ¦tes.
May 30 17:42:18 raspberrypi iotedged[5135]: 2019-05-30T12:12:18Z [INFO] - Initializing hsm...
May 30 17:42:18 raspberrypi iotedged[5135]: 2019-05-30T12:12:18Z [INFO] - Finished initiâ¦hsm.
May 30 17:42:18 raspberrypi iotedged[5135]: 2019-05-30T12:12:18Z [INFO] - Detecting if câ¦d...
May 30 17:42:18 raspberrypi iotedged[5135]: 2019-05-30T12:12:18Z [INFO] - No change to câ¦ted.
May 30 17:42:18 raspberrypi iotedged[5135]: 2019-05-30T12:12:18Z [INFO] - Obtaining workâ¦ded.
May 30 17:42:18 raspberrypi iotedged[5135]: 2019-05-30T12:12:18Z [INFO] - Provisioning eâ¦e...
May 30 17:42:18 raspberrypi iotedged[5135]: 2019-05-30T12:12:18Z [INFO] - Manually proviâ¦net"
May 30 17:42:18 raspberrypi iotedged[5135]: 2019-05-30T12:12:18Z [INFO] - Finished proviâ¦ice.
May 30 17:42:18 raspberrypi iotedged[5135]: 2019-05-30T12:12:18Z [INFO] - Starting managâ¦I...
May 30 17:42:18 raspberrypi iotedged[5135]: 2019-05-30T12:12:18Z [INFO] - Starting worklâ¦I...
May 30 17:42:18 raspberrypi iotedged[5135]: 2019-05-30T12:12:18Z [INFO] - Starting watchâ¦y...
May 30 17:42:18 raspberrypi iotedged[5135]: 2019-05-30T12:12:18Z [INFO] - Listening on uâ¦API.
May 30 17:42:18 raspberrypi systemd[1]: iotedge.service: Main process exited, code=exitâ¦ILURE
May 30 17:42:18 raspberrypi systemd[1]: iotedge.service: Unit entered failed state.
May 30 17:42:18 raspberrypi systemd[1]: iotedge.service: Failed with result 'exit-code'.
May 30 17:42:19 raspberrypi systemd[1]: iotedge.service: Service hold-off time over, scâ¦tart.
May 30 17:42:19 raspberrypi systemd[1]: Stopped Azure IoT Edge daemon.
May 30 17:42:19 raspberrypi systemd[1]: Dependency failed for Azure IoT Edge daemon.
May 30 17:42:19 raspberrypi systemd[1]: iotedge.service: Job iotedge.service/start failâ¦ncy'

and when i run this again sudo systemctl status iotedge it gives the same error. Help Please.

Originally posted by @akhtar927 in https://github.com/Azure/iotedge/issues/940#issuecomment-497312713

myagley commented 5 years ago

Due to a quirk in how systemd/journald attach log lines to services, sometimes the last few log lines are missing when a process exits. To be able to see the last few lines you can run this instead:

sudo journalctl --no-pager

This should capture the remaining log lines.

akhtar927 commented 5 years ago
May 31 11:54:13 raspberrypi dockerd[3016]: time="2019-05-31T11:54:13.581932597+05:30" level=warning msg="Your kernel does not support cgroup cfs period"
May 31 11:54:13 raspberrypi dockerd[3016]: time="2019-05-31T11:54:13.582090766+05:30" level=warning msg="Your kernel does not support cgroup cfs quotas"
May 31 11:54:13 raspberrypi dockerd[3016]: time="2019-05-31T11:54:13.582188554+05:30" level=warning msg="Your kernel does not support cgroup rt period"
May 31 11:54:13 raspberrypi dockerd[3016]: time="2019-05-31T11:54:13.582281653+05:30" level=warning msg="Your kernel does not support cgroup rt runtime"
May 31 11:54:13 raspberrypi dockerd[3016]: time="2019-05-31T11:54:13.582377461+05:30" level=warning msg="mountpoint for pids not found"
May 31 11:54:13 raspberrypi dockerd[3016]: time="2019-05-31T11:54:13.583724768+05:30" level=info msg="Loading containers: start."
May 31 11:54:14 raspberrypi dockerd[3016]: time="2019-05-31T11:54:14.954639780+05:30" level=info msg="Default bridge (docker0) is assigned with an IP address 172.17.0.0/16. Daemon option --bip can be used to set a preferred IP address"
May 31 11:54:15 raspberrypi dockerd[3016]: time="2019-05-31T11:54:15.405379742+05:30" level=info msg="Loading containers: done."
May 31 11:54:15 raspberrypi dockerd[3016]: time="2019-05-31T11:54:15.902297518+05:30" level=info msg="Docker daemon" commit=dbe4a30 graphdriver(s)=overlay2 version=3.0.5
May 31 11:54:15 raspberrypi dockerd[3016]: time="2019-05-31T11:54:15.902711227+05:30" level=info msg="Daemon has completed initialization"
May 31 11:54:16 raspberrypi dockerd[3016]: time="2019-05-31T11:54:16.014643729+05:30" level=info msg="API listen on /var/run/docker.sock"
May 31 11:54:16 raspberrypi systemd[1]: Started Docker Application Container Engine.
May 31 11:54:16 raspberrypi sudo[2953]: pam_unix(sudo:session): session closed for user root
May 31 12:02:02 raspberrypi sudo[3259]:       pi : TTY=pts/0 ; PWD=/run/iotedge ; USER=root ; COMMAND=/usr/bin/curl -L https://aka.ms/moby-cli-armhf-latest -o moby_cli.deb
May 31 12:02:02 raspberrypi sudo[3259]: pam_unix(sudo:session): session opened for user root by pi(uid=0)
May 31 12:02:11 raspberrypi sudo[3259]: pam_unix(sudo:session): session closed for user root
May 31 12:02:11 raspberrypi sudo[3272]:       pi : TTY=pts/0 ; PWD=/run/iotedge ; USER=root ; COMMAND=/usr/bin/dpkg -i ./moby_cli.deb
May 31 12:02:11 raspberrypi sudo[3272]: pam_unix(sudo:session): session opened for user root by pi(uid=0)
May 31 12:02:21 raspberrypi sudo[3272]: pam_unix(sudo:session): session closed for user root
May 31 12:02:23 raspberrypi sudo[3305]:       pi : TTY=pts/0 ; PWD=/run/iotedge ; USER=root ; COMMAND=/usr/bin/apt-get install -f
May 31 12:02:23 raspberrypi sudo[3305]: pam_unix(sudo:session): session opened for user root by pi(uid=0)
May 31 12:02:28 raspberrypi sudo[3305]: pam_unix(sudo:session): session closed for user root
May 31 12:03:24 raspberrypi sudo[3323]:       pi : TTY=pts/0 ; PWD=/run/iotedge ; USER=root ; COMMAND=/usr/bin/curl -L https://aka.ms/libiothsm-std-linux-armhf-latest -o libiothsm-std.deb
May 31 12:03:24 raspberrypi sudo[3323]: pam_unix(sudo:session): session opened for user root by pi(uid=0)
May 31 12:03:30 raspberrypi sudo[3323]: pam_unix(sudo:session): session closed for user root
May 31 12:03:30 raspberrypi sudo[3334]:       pi : TTY=pts/0 ; PWD=/run/iotedge ; USER=root ; COMMAND=/usr/bin/dpkg -i ./libiothsm-std.deb
May 31 12:03:30 raspberrypi sudo[3334]: pam_unix(sudo:session): session opened for user root by pi(uid=0)
May 31 12:03:32 raspberrypi sudo[3334]: pam_unix(sudo:session): session closed for user root
May 31 12:09:01 raspberrypi CRON[3406]: pam_unix(cron:session): session opened for user root by (uid=0)
May 31 12:09:01 raspberrypi CRON[3410]: (root) CMD (  [ -x /usr/lib/php/sessionclean ] && if [ ! -d /run/systemd/system ]; then /usr/lib/php/sessionclean; fi)
May 31 12:09:01 raspberrypi CRON[3406]: pam_unix(cron:session): session closed for user root
May 31 12:09:03 raspberrypi sudo[3414]:       pi : TTY=pts/0 ; PWD=/run/iotedge ; USER=root ; COMMAND=/usr/bin/curl -L https://aka.ms/iotedged-linux-armhf-latest -o iotedge.deb
May 31 12:09:03 raspberrypi sudo[3414]: pam_unix(sudo:session): session opened for user root by pi(uid=0)
May 31 12:09:12 raspberrypi sudo[3414]: pam_unix(sudo:session): session closed for user root
May 31 12:09:12 raspberrypi sudo[3427]:       pi : TTY=pts/0 ; PWD=/run/iotedge ; USER=root ; COMMAND=/usr/bin/dpkg -i ./iotedge.deb
May 31 12:09:12 raspberrypi sudo[3427]: pam_unix(sudo:session): session opened for user root by pi(uid=0)
May 31 12:09:19 raspberrypi systemd[1]: Starting Clean php session files...
May 31 12:09:19 raspberrypi systemd[1]: Reloading.
May 31 12:09:20 raspberrypi systemd[1]: apt-daily-upgrade.timer: Adding 23min 31.567352s random time.
May 31 12:09:20 raspberrypi systemd[1]: apt-daily.timer: Adding 7h 53min 5.434073s random time.
May 31 12:09:20 raspberrypi systemd[1]: Started Clean php session files.
May 31 12:09:21 raspberrypi systemd[1]: Reloading.
May 31 12:09:21 raspberrypi systemd[1]: apt-daily-upgrade.timer: Adding 59min 10.186021s random time.
May 31 12:09:21 raspberrypi systemd[1]: apt-daily.timer: Adding 5h 34min 50.029202s random time.
May 31 12:09:23 raspberrypi systemd[1]: Reloading.
May 31 12:09:23 raspberrypi systemd[1]: apt-daily-upgrade.timer: Adding 57.031260s random time.
May 31 12:09:23 raspberrypi systemd[1]: apt-daily.timer: Adding 3h 59min 4.030876s random time.
May 31 12:09:27 raspberrypi systemd[1]: Reloading.
May 31 12:09:28 raspberrypi systemd[1]: apt-daily-upgrade.timer: Adding 22min 18.375119s random time.
May 31 12:09:28 raspberrypi systemd[1]: apt-daily.timer: Adding 7min 40.334161s random time.
May 31 12:09:28 raspberrypi systemd[1]: Reloading.
May 31 12:09:28 raspberrypi systemd[1]: apt-daily.timer: Adding 7h 24min 5.824482s random time.
May 31 12:09:28 raspberrypi systemd[1]: apt-daily-upgrade.timer: Adding 24min 30.106989s random time.
May 31 12:09:28 raspberrypi systemd[1]: Starting Azure IoT Edge daemon management socket.
May 31 12:09:28 raspberrypi systemd[1]: Starting Azure IoT Edge daemon workload socket.
May 31 12:09:28 raspberrypi systemd[1]: Listening on Azure IoT Edge daemon management socket.
May 31 12:09:28 raspberrypi systemd[1]: Listening on Azure IoT Edge daemon workload socket.
May 31 12:09:28 raspberrypi systemd[1]: Started Azure IoT Edge daemon.
May 31 12:09:28 raspberrypi iotedged[3600]: 2019-05-31T06:39:28Z [INFO] - Using config file: /etc/iotedge/config.yaml
May 31 12:09:28 raspberrypi iotedged[3600]: 2019-05-31T06:39:28Z [INFO] - Starting Azure IoT Edge Security Daemon
May 31 12:09:28 raspberrypi iotedged[3600]: 2019-05-31T06:39:28Z [INFO] - Version - 1.0.7.1 (f7c51d92be8336bc6be042e1f1f2505ba01679f3)
May 31 12:09:28 raspberrypi iotedged[3600]: 2019-05-31T06:39:28Z [ERR!] - The daemon could not start up successfully: Edge device information is required.
May 31 12:09:28 raspberrypi iotedged[3600]: Please update the config.yaml and provide the IoTHub connection information.
May 31 12:09:28 raspberrypi iotedged[3600]: See https://aka.ms/iot-edge-configure-linux for more details.
May 31 12:09:28 raspberrypi systemd[1]: iotedge.service: Main process exited, code=exited, status=1/FAILURE
May 31 12:09:28 raspberrypi systemd[1]: iotedge.service: Unit entered failed state.
May 31 12:09:28 raspberrypi systemd[1]: iotedge.service: Failed with result 'exit-code'.
May 31 12:09:29 raspberrypi systemd[1]: Reloading.
May 31 12:09:29 raspberrypi systemd[1]: apt-daily.timer: Adding 6h 57min 48.996279s random time.
May 31 12:09:29 raspberrypi systemd[1]: apt-daily-upgrade.timer: Adding 6min 24.168283s random time.
May 31 12:09:29 raspberrypi systemd[1]: iotedge.service: Service hold-off time over, scheduling restart.
May 31 12:09:29 raspberrypi systemd[1]: Stopped Azure IoT Edge daemon.
May 31 12:09:29 raspberrypi systemd[1]: Closed Azure IoT Edge daemon management socket.
May 31 12:09:29 raspberrypi systemd[1]: Stopping Azure IoT Edge daemon management socket.
May 31 12:09:29 raspberrypi systemd[1]: Starting Azure IoT Edge daemon management socket.
May 31 12:09:29 raspberrypi systemd[1]: Closed Azure IoT Edge daemon workload socket.
May 31 12:09:29 raspberrypi systemd[1]: Stopping Azure IoT Edge daemon workload socket.
May 31 12:09:29 raspberrypi systemd[1]: Starting Azure IoT Edge daemon workload socket.
May 31 12:09:29 raspberrypi systemd[1]: Listening on Azure IoT Edge daemon management socket.
May 31 12:09:29 raspberrypi systemd[1]: Listening on Azure IoT Edge daemon workload socket.
May 31 12:09:29 raspberrypi systemd[1]: Started Azure IoT Edge daemon.
May 31 12:09:29 raspberrypi iotedged[3618]: 2019-05-31T06:39:29Z [INFO] - Using config file: /etc/iotedge/config.yaml
May 31 12:09:29 raspberrypi iotedged[3618]: 2019-05-31T06:39:29Z [INFO] - Starting Azure IoT Edge Security Daemon
May 31 12:09:29 raspberrypi iotedged[3618]: 2019-05-31T06:39:29Z [INFO] - Version - 1.0.7.1 (f7c51d92be8336bc6be042e1f1f2505ba01679f3)
May 31 12:09:29 raspberrypi iotedged[3618]: 2019-05-31T06:39:29Z [ERR!] - The daemon could not start up successfully: Edge device information is required.
May 31 12:09:29 raspberrypi iotedged[3618]: Please update the config.yaml and provide the IoTHub connection information.
May 31 12:09:29 raspberrypi iotedged[3618]: See https://aka.ms/iot-edge-configure-linux for more details.
May 31 12:09:29 raspberrypi systemd[1]: iotedge.service: Main process exited, code=exited, status=1/FAILURE
May 31 12:09:29 raspberrypi systemd[1]: iotedge.service: Unit entered failed state.
May 31 12:09:29 raspberrypi systemd[1]: iotedge.service: Failed with result 'exit-code'.
May 31 12:09:30 raspberrypi systemd[1]: iotedge.service: Service hold-off time over, scheduling restart.
May 31 12:09:30 raspberrypi systemd[1]: Stopped Azure IoT Edge daemon.
May 31 12:09:30 raspberrypi systemd[1]: Closed Azure IoT Edge daemon workload socket.
May 31 12:09:30 raspberrypi systemd[1]: Stopping Azure IoT Edge daemon workload socket.
May 31 12:09:30 raspberrypi systemd[1]: Starting Azure IoT Edge daemon workload socket.
May 31 12:09:30 raspberrypi systemd[1]: Closed Azure IoT Edge daemon management socket.
May 31 12:09:30 raspberrypi systemd[1]: Stopping Azure IoT Edge daemon management socket.
May 31 12:09:30 raspberrypi systemd[1]: Starting Azure IoT Edge daemon management socket.
May 31 12:09:30 raspberrypi systemd[1]: Listening on Azure IoT Edge daemon workload socket.
May 31 12:09:30 raspberrypi systemd[1]: Listening on Azure IoT Edge daemon management socket.
May 31 12:09:30 raspberrypi systemd[1]: Started Azure IoT Edge daemon.
May 31 12:09:30 raspberrypi iotedged[3633]: 2019-05-31T06:39:30Z [INFO] - Using config file: /etc/iotedge/config.yaml
May 31 12:09:30 raspberrypi iotedged[3633]: 2019-05-31T06:39:30Z [INFO] - Starting Azure IoT Edge Security Daemon
May 31 12:09:30 raspberrypi iotedged[3633]: 2019-05-31T06:39:30Z [INFO] - Version - 1.0.7.1 (f7c51d92be8336bc6be042e1f1f2505ba01679f3)
May 31 12:09:30 raspberrypi iotedged[3633]: 2019-05-31T06:39:30Z [ERR!] - The daemon could not start up successfully: Edge device information is required.
May 31 12:09:30 raspberrypi iotedged[3633]: Please update the config.yaml and provide the IoTHub connection information.
May 31 12:09:30 raspberrypi iotedged[3633]: See https://aka.ms/iot-edge-configure-linux for more details.
May 31 12:09:30 raspberrypi systemd[1]: iotedge.service: Main process exited, code=exited, status=1/FAILURE
May 31 12:09:30 raspberrypi systemd[1]: iotedge.service: Unit entered failed state.
May 31 12:09:30 raspberrypi systemd[1]: iotedge.service: Failed with result 'exit-code'.
May 31 12:09:30 raspberrypi systemd[1]: iotedge.service: Service hold-off time over, scheduling restart.
May 31 12:09:30 raspberrypi systemd[1]: Stopped Azure IoT Edge daemon.
May 31 12:09:30 raspberrypi systemd[1]: Closed Azure IoT Edge daemon workload socket.
May 31 12:09:30 raspberrypi systemd[1]: Stopping Azure IoT Edge daemon workload socket.
May 31 12:09:30 raspberrypi systemd[1]: Starting Azure IoT Edge daemon workload socket.
May 31 12:09:30 raspberrypi systemd[1]: Closed Azure IoT Edge daemon management socket.
May 31 12:09:30 raspberrypi systemd[1]: Stopping Azure IoT Edge daemon management socket.
May 31 12:09:30 raspberrypi systemd[1]: Starting Azure IoT Edge daemon management socket.
May 31 12:09:30 raspberrypi systemd[1]: Listening on Azure IoT Edge daemon workload socket.
May 31 12:09:30 raspberrypi systemd[1]: Listening on Azure IoT Edge daemon management socket.
May 31 12:09:30 raspberrypi systemd[1]: Started Azure IoT Edge daemon.
May 31 12:09:30 raspberrypi iotedged[3689]: 2019-05-31T06:39:30Z [INFO] - Using config file: /etc/iotedge/config.yaml
May 31 12:09:30 raspberrypi iotedged[3689]: 2019-05-31T06:39:30Z [INFO] - Starting Azure IoT Edge Security Daemon
May 31 12:09:30 raspberrypi iotedged[3689]: 2019-05-31T06:39:30Z [INFO] - Version - 1.0.7.1 (f7c51d92be8336bc6be042e1f1f2505ba01679f3)
May 31 12:09:30 raspberrypi iotedged[3689]: 2019-05-31T06:39:30Z [ERR!] - The daemon could not start up successfully: Edge device information is required.
May 31 12:09:30 raspberrypi iotedged[3689]: Please update the config.yaml and provide the IoTHub connection information.
May 31 12:09:30 raspberrypi iotedged[3689]: See https://aka.ms/iot-edge-configure-linux for more details.
May 31 12:09:30 raspberrypi systemd[1]: iotedge.service: Main process exited, code=exited, status=1/FAILURE
May 31 12:09:30 raspberrypi systemd[1]: iotedge.service: Unit entered failed state.
May 31 12:09:30 raspberrypi systemd[1]: iotedge.service: Failed with result 'exit-code'.
May 31 12:09:30 raspberrypi systemd[1]: iotedge.service: Service hold-off time over, scheduling restart.
May 31 12:09:30 raspberrypi systemd[1]: Stopped Azure IoT Edge daemon.
May 31 12:09:30 raspberrypi systemd[1]: Closed Azure IoT Edge daemon workload socket.
May 31 12:09:30 raspberrypi systemd[1]: Stopping Azure IoT Edge daemon workload socket.
May 31 12:09:30 raspberrypi systemd[1]: Starting Azure IoT Edge daemon workload socket.
May 31 12:09:30 raspberrypi systemd[1]: Closed Azure IoT Edge daemon management socket.
May 31 12:09:30 raspberrypi systemd[1]: Stopping Azure IoT Edge daemon management socket.
May 31 12:09:30 raspberrypi systemd[1]: Starting Azure IoT Edge daemon management socket.
May 31 12:09:30 raspberrypi systemd[1]: Listening on Azure IoT Edge daemon workload socket.
May 31 12:09:30 raspberrypi systemd[1]: Listening on Azure IoT Edge daemon management socket.
May 31 12:09:30 raspberrypi systemd[1]: Started Azure IoT Edge daemon.
May 31 12:09:30 raspberrypi iotedged[3756]: 2019-05-31T06:39:30Z [INFO] - Using config file: /etc/iotedge/config.yaml
May 31 12:09:30 raspberrypi iotedged[3756]: 2019-05-31T06:39:30Z [INFO] - Starting Azure IoT Edge Security Daemon
May 31 12:09:30 raspberrypi iotedged[3756]: 2019-05-31T06:39:30Z [INFO] - Version - 1.0.7.1 (f7c51d92be8336bc6be042e1f1f2505ba01679f3)
May 31 12:09:30 raspberrypi iotedged[3756]: 2019-05-31T06:39:30Z [ERR!] - The daemon could not start up successfully: Edge device information is required.
May 31 12:09:30 raspberrypi iotedged[3756]: Please update the config.yaml and provide the IoTHub connection information.
May 31 12:09:30 raspberrypi iotedged[3756]: See https://aka.ms/iot-edge-configure-linux for more details.
May 31 12:09:30 raspberrypi systemd[1]: iotedge.service: Main process exited, code=exited, status=1/FAILURE
May 31 12:09:30 raspberrypi systemd[1]: iotedge.service: Unit entered failed state.
May 31 12:09:30 raspberrypi systemd[1]: iotedge.service: Failed with result 'exit-code'.
May 31 12:09:30 raspberrypi systemd[1]: iotedge.service: Service hold-off time over, scheduling restart.
May 31 12:09:30 raspberrypi systemd[1]: Stopped Azure IoT Edge daemon.
May 31 12:09:30 raspberrypi systemd[1]: Closed Azure IoT Edge daemon management socket.
May 31 12:09:30 raspberrypi systemd[1]: Stopping Azure IoT Edge daemon management socket.
May 31 12:09:30 raspberrypi systemd[1]: Starting Azure IoT Edge daemon management socket.
May 31 12:09:30 raspberrypi systemd[1]: Closed Azure IoT Edge daemon workload socket.
May 31 12:09:30 raspberrypi systemd[1]: Stopping Azure IoT Edge daemon workload socket.
May 31 12:09:30 raspberrypi systemd[1]: Starting Azure IoT Edge daemon workload socket.
May 31 12:09:30 raspberrypi systemd[1]: Listening on Azure IoT Edge daemon management socket.
May 31 12:09:30 raspberrypi systemd[1]: Listening on Azure IoT Edge daemon workload socket.
May 31 12:09:30 raspberrypi systemd[1]: Started Azure IoT Edge daemon.
May 31 12:09:30 raspberrypi iotedged[3773]: 2019-05-31T06:39:30Z [INFO] - Using config file: /etc/iotedge/config.yaml
May 31 12:09:30 raspberrypi iotedged[3773]: 2019-05-31T06:39:30Z [INFO] - Starting Azure IoT Edge Security Daemon
May 31 12:09:30 raspberrypi iotedged[3773]: 2019-05-31T06:39:30Z [INFO] - Version - 1.0.7.1 (f7c51d92be8336bc6be042e1f1f2505ba01679f3)
May 31 12:09:30 raspberrypi iotedged[3773]: 2019-05-31T06:39:30Z [ERR!] - The daemon could not start up successfully: Edge device information is required.
May 31 12:09:30 raspberrypi iotedged[3773]: Please update the config.yaml and provide the IoTHub connection information.
May 31 12:09:30 raspberrypi iotedged[3773]: See https://aka.ms/iot-edge-configure-linux for more details.
May 31 12:09:30 raspberrypi systemd[1]: iotedge.service: Main process exited, code=exited, status=1/FAILURE
May 31 12:09:30 raspberrypi systemd[1]: iotedge.service: Unit entered failed state.
May 31 12:09:30 raspberrypi systemd[1]: iotedge.service: Failed with result 'exit-code'.
May 31 12:09:31 raspberrypi systemd[1]: iotedge.service: Service hold-off time over, scheduling restart.
May 31 12:09:31 raspberrypi systemd[1]: Stopped Azure IoT Edge daemon.
May 31 12:09:31 raspberrypi systemd[1]: Closed Azure IoT Edge daemon workload socket.
May 31 12:09:31 raspberrypi systemd[1]: Stopping Azure IoT Edge daemon workload socket.
May 31 12:09:31 raspberrypi systemd[1]: iotedge.socket: Start request repeated too quickly.
May 31 12:09:31 raspberrypi systemd[1]: Failed to listen on Azure IoT Edge daemon workload socket.
May 31 12:09:31 raspberrypi systemd[1]: Dependency failed for Azure IoT Edge daemon.
May 31 12:09:31 raspberrypi systemd[1]: iotedge.service: Job iotedge.service/start failed with result 'dependency'.
May 31 12:09:31 raspberrypi systemd[1]: iotedge.socket: Unit entered failed state.
May 31 12:09:31 raspberrypi systemd[1]: Closed Azure IoT Edge daemon management socket.
May 31 12:09:31 raspberrypi systemd[1]: Stopping Azure IoT Edge daemon management socket.
May 31 12:09:31 raspberrypi systemd[1]: iotedge.mgmt.socket: Start request repeated too quickly.
May 31 12:09:31 raspberrypi systemd[1]: Failed to listen on Azure IoT Edge daemon management socket.
May 31 12:09:31 raspberrypi systemd[1]: iotedge.mgmt.socket: Unit entered failed state.
May 31 12:09:31 raspberrypi sudo[3427]: pam_unix(sudo:session): session closed for user root
May 31 12:10:01 raspberrypi sudo[3793]:       pi : TTY=pts/0 ; PWD=/run/iotedge ; USER=root ; COMMAND=/usr/bin/apt-get install -f
May 31 12:10:01 raspberrypi sudo[3793]: pam_unix(sudo:session): session opened for user root by pi(uid=0)
May 31 12:10:07 raspberrypi sudo[3793]: pam_unix(sudo:session): session closed for user root
May 31 12:10:25 raspberrypi sudo[3806]:       pi : TTY=pts/0 ; PWD=/run/iotedge ; USER=root ; COMMAND=/bin/nano /etc/iotedge/config.yaml
May 31 12:10:25 raspberrypi sudo[3806]: pam_unix(sudo:session): session opened for user root by pi(uid=0)
May 31 12:11:41 raspberrypi sudo[3806]: pam_unix(sudo:session): session closed for user root
May 31 12:12:06 raspberrypi sudo[3840]:       pi : TTY=pts/0 ; PWD=/run/iotedge ; USER=root ; COMMAND=/bin/systemctl restart iotedge
May 31 12:12:06 raspberrypi sudo[3840]: pam_unix(sudo:session): session opened for user root by pi(uid=0)
May 31 12:12:06 raspberrypi systemd[1]: Starting Azure IoT Edge daemon workload socket.
May 31 12:12:06 raspberrypi systemd[1]: Starting Azure IoT Edge daemon management socket.
May 31 12:12:06 raspberrypi systemd[1]: Listening on Azure IoT Edge daemon workload socket.
May 31 12:12:06 raspberrypi systemd[1]: Listening on Azure IoT Edge daemon management socket.
May 31 12:12:06 raspberrypi systemd[1]: Started Azure IoT Edge daemon.
May 31 12:12:06 raspberrypi sudo[3840]: pam_unix(sudo:session): session closed for user root
May 31 12:12:06 raspberrypi iotedged[3848]: 2019-05-31T06:42:06Z [INFO] - Using config file: /etc/iotedge/config.yaml
May 31 12:12:06 raspberrypi iotedged[3848]: 2019-05-31T06:42:06Z [INFO] - Starting Azure IoT Edge Security Daemon
May 31 12:12:06 raspberrypi iotedged[3848]: 2019-05-31T06:42:06Z [INFO] - Version - 1.0.7.1 (f7c51d92be8336bc6be042e1f1f2505ba01679f3)
May 31 12:12:06 raspberrypi iotedged[3848]: 2019-05-31T06:42:06Z [INFO] - Using runtime network id azure-iot-edge
May 31 12:12:06 raspberrypi iotedged[3848]: 2019-05-31T06:42:06Z [INFO] - Initializing the module runtime...
May 31 12:12:06 raspberrypi iotedged[3848]: 2019-05-31T06:42:06Z [INFO] - Initializing module runtime...
May 31 12:12:07 raspberrypi iotedged[3848]: 2019-05-31T06:42:07Z [INFO] - Successfully initialized module runtime
May 31 12:12:07 raspberrypi iotedged[3848]: 2019-05-31T06:42:07Z [INFO] - Finished initializing the module runtime.
May 31 12:12:07 raspberrypi iotedged[3848]: 2019-05-31T06:42:07Z [INFO] - Configuring /var/lib/iotedge as the home directory.
May 31 12:12:07 raspberrypi iotedged[3848]: 2019-05-31T06:42:07Z [INFO] - Configuring certificates...
May 31 12:12:07 raspberrypi iotedged[3848]: 2019-05-31T06:42:07Z [INFO] - Transparent gateway certificates not found, operating in quick start mode...
May 31 12:12:07 raspberrypi iotedged[3848]: 2019-05-31T06:42:07Z [INFO] - Finished configuring certificates.
May 31 12:12:07 raspberrypi iotedged[3848]: 2019-05-31T06:42:07Z [INFO] - Initializing hsm...
May 31 12:12:07 raspberrypi iotedged[3848]: 2019-05-31T06:42:07Z [INFO] - Finished initializing hsm.
May 31 12:12:07 raspberrypi iotedged[3848]: 2019-05-31T06:42:07Z [INFO] - Detecting if configuration file has changed...
May 31 12:12:07 raspberrypi iotedged[3848]: 2019-05-31T06:42:07Z [INFO] - Change to configuration file detected.
May 31 12:12:07 raspberrypi iotedged[3848]: 2019-05-31T06:42:07Z [INFO] - Removing all modules...
May 31 12:12:07 raspberrypi iotedged[3848]: 2019-05-31T06:42:07Z [INFO] - Finished removing modules.
May 31 12:12:16 raspberrypi iotedged[3848]: 2019-05-31T06:42:16Z [INFO] - Provisioning edge device...
May 31 12:12:16 raspberrypi iotedged[3848]: 2019-05-31T06:42:16Z [INFO] - Manually provisioning device "raspi3b" in hub "supplychain-test.azure-devices.net"
May 31 12:12:16 raspberrypi iotedged[3848]: 2019-05-31T06:42:16Z [INFO] - Finished provisioning edge device.
May 31 12:12:16 raspberrypi iotedged[3848]: 2019-05-31T06:42:16Z [INFO] - Starting management API...
May 31 12:12:16 raspberrypi iotedged[3848]: 2019-05-31T06:42:16Z [INFO] - Starting workload API...
May 31 12:12:16 raspberrypi iotedged[3848]: 2019-05-31T06:42:16Z [INFO] - Starting watchdog with 60 second frequency...
May 31 12:12:16 raspberrypi iotedged[3848]: 2019-05-31T06:42:16Z [INFO] - Listening on fd://iotedge.mgmt.socket/ with 1 thread for management API.
May 31 12:12:16 raspberrypi iotedged[3848]: 2019-05-31T06:42:16Z [INFO] - Listening on fd://iotedge.socket/ with 1 thread for workload API.
May 31 12:12:16 raspberrypi iotedged[3848]: 2019-05-31T06:42:16Z [INFO] - Checking edge runtime status
May 31 12:12:16 raspberrypi iotedged[3848]: 2019-05-31T06:42:16Z [INFO] - Creating and starting edge runtime module edgeAgent
May 31 12:12:18 raspberrypi iotedged[3848]: 2019-05-31T06:42:18Z [INFO] - Updating identity for module $edgeAgent
May 31 12:12:18 raspberrypi iotedged[3848]: 2019-05-31T06:42:18Z [INFO] - Pulling image mcr.microsoft.com/azureiotedge-agent:1.0...
May 31 12:12:22 raspberrypi rngd[351]: stats: bits received from HRNG source: 80064
May 31 12:12:22 raspberrypi rngd[351]: stats: bits sent to kernel pool: 34336
May 31 12:12:22 raspberrypi rngd[351]: stats: entropy added to kernel pool: 34336
May 31 12:12:22 raspberrypi rngd[351]: stats: FIPS 140-2 successes: 4
May 31 12:12:22 raspberrypi rngd[351]: stats: FIPS 140-2 failures: 0
May 31 12:12:22 raspberrypi rngd[351]: stats: FIPS 140-2(2001-10-10) Monobit: 0
May 31 12:12:22 raspberrypi rngd[351]: stats: FIPS 140-2(2001-10-10) Poker: 0
May 31 12:12:22 raspberrypi rngd[351]: stats: FIPS 140-2(2001-10-10) Runs: 0
May 31 12:12:22 raspberrypi rngd[351]: stats: FIPS 140-2(2001-10-10) Long run: 0
May 31 12:12:22 raspberrypi rngd[351]: stats: FIPS 140-2(2001-10-10) Continuous run: 0
May 31 12:12:22 raspberrypi rngd[351]: stats: HRNG source speed: (min=364.886; avg=602.979; max=813.362)Kibits/s
May 31 12:12:22 raspberrypi rngd[351]: stats: FIPS tests speed: (min=1.203; avg=3.123; max=7.064)Mibits/s
May 31 12:12:22 raspberrypi rngd[351]: stats: Lowest ready-buffers level: 2
May 31 12:12:22 raspberrypi rngd[351]: stats: Entropy starvations: 0
May 31 12:12:22 raspberrypi rngd[351]: stats: Time spent starving for entropy: (min=0; avg=0.000; max=0)us
May 31 12:14:33 raspberrypi sudo[3943]:       pi : TTY=pts/0 ; PWD=/run/iotedge ; USER=root ; COMMAND=/bin/journalctl --no-pager
May 31 12:14:33 raspberrypi sudo[3943]: pam_unix(sudo:session): session opened for user root by pi(uid=0)
damonbarry commented 5 years ago

From the most recent logs, it looks like edge failed to start because the connection string wasn't set in config.yaml. But then you added the connection string to the config, the daemon started and was pulling the Edge Agent image for the first time (mcr.microsoft.com/azureiotedge-agent:1.0), which can take a really long time on Raspberry Pi--several minutes.

So it looks like it's working now...is that what you're seeing?

ancaantochi commented 5 years ago

Closing because it looks like the issue was solved, please reopen if you still have this issue.