Skip to content

flaky test: docker install on macOS 14 (arm64) #317

Description

@crazy-max

Similar to docker/setup-docker-action#53 (comment), no virt on macOS arm 😢.

https://github.com/docker/actions-toolkit/actions/runs/8828949944/job/24238960153?pr=316#step:6:332

/opt/homebrew/bin/limactl start --name=docker-actions-toolkit --cpus 4 --memory 8
  time="2024-04-25T07:55:11Z" level=warning msg="provisioning scripts should not reference the LIMA_CIDATA variables"
  time="2024-04-25T07:55:11Z" level=info msg="Using the existing instance \"docker-actions-toolkit\""
  time="2024-04-25T07:55:11Z" level=warning msg="provisioning scripts should not reference the LIMA_CIDATA variables"
  time="2024-04-25T07:55:11Z" level=warning msg="provisioning scripts should not reference the LIMA_CIDATA variables"
  time="2024-04-25T07:55:11Z" level=info msg="Starting the instance \"docker-actions-toolkit\" with VM driver \"qemu\""
  time="2024-04-25T07:55:11Z" level=info msg="QEMU binary \"/opt/homebrew/bin/qemu-system-aarch64\" seems properly signed with the \"com.apple.security.hypervisor\" entitlement"
  time="2024-04-25T07:55:11Z" level=warning msg="provisioning scripts should not reference the LIMA_CIDATA variables"
  time="2024-04-25T07:55:11Z" level=info msg="Attempting to download the image" arch=aarch64 digest= location="https://cloud.debian.org/images/cloud/bookworm/20231013-1532/debian-12-genericcloud-arm64-20231013-1532.qcow2"
  Downloading the image (debian-12-genericcloud-arm64-20231013-1532.qcow2)
  
  92.37 MiB / 247.62 MiB (37.30%) ? p/s
  220.27 MiB / 247.62 MiB (88.95%) 25.58 MiB/s
  247.62 MiB / 247.62 MiB (100.00%) 40.82 MiB/stime="2024-04-25T07:55:24Z" level=info msg="Downloaded the image from \"[https://cloud.debian.org/images/cloud/bookworm/20231013-1532/debian-12-genericcloud-arm64-20231013-1532.qcow2\](https://cloud.debian.org/images/cloud/bookworm/20231013-1532/debian-12-genericcloud-arm64-20231013-1532.qcow2/)""
  time="2024-04-25T07:55:24Z" level=warning msg="[hostagent] provisioning scripts should not reference the LIMA_CIDATA variables"
  time="2024-04-25T07:55:24Z" level=warning msg="[hostagent] provisioning scripts should not reference the LIMA_CIDATA variables"
  time="2024-04-25T07:55:24Z" level=warning msg="[hostagent] provisioning scripts should not reference the LIMA_CIDATA variables"
  time="2024-04-25T07:55:24Z" level=info msg="[hostagent] hostagent socket created at /Users/runner/.lima/docker-actions-toolkit/ha.sock"
  time="2024-04-25T07:55:24Z" level=info msg="[hostagent] Using system firmware (\"/opt/homebrew/share/qemu/edk2-aarch64-code.fd\")"
  time="2024-04-25T07:55:24Z" level=info msg="[hostagent] Starting QEMU (hint: to watch the boot progress, see \"/Users/runner/.lima/docker-actions-toolkit/serial*.log\")"
  time="2024-04-25T07:55:24Z" level=info msg="SSH Local Port: 49215"
  time="2024-04-25T07:55:24Z" level=info msg="[hostagent] Waiting for the essential requirement 1 of 4: \"ssh\""
  time="2024-04-25T07:55:24Z" level=info msg="[hostagent] Driver stopped due to error: \"signal: abort trap\""
  time="2024-04-25T07:55:24Z" level=info msg="[hostagent] Shutting down the host agent"
  time="2024-04-25T07:55:24Z" level=warning msg="[hostagent] failed to exit SSH master" error="failed to execute `ssh -O exit -p 49215 127.0.0.1`, out=\"Control socket connect(/Users/runner/.lima/docker-actions-toolkit/ssh.sock): No such file or directory\\r\\n\": exit status 255"
  time="2024-04-25T07:55:24Z" level=info msg="[hostagent] Shutting down QEMU with ACPI"
  time="2024-04-25T07:55:24Z" level=warning msg="[hostagent] failed to open the QMP socket \"/Users/runner/.lima/docker-actions-toolkit/qmp.sock\", forcibly killing QEMU" error="dial unix /Users/runner/.lima/docker-actions-toolkit/qmp.sock: connect: connection refused"
  time="2024-04-25T07:55:24Z" level=info msg="[hostagent] QEMU has already exited"
  time="2024-04-25T07:55:24Z" level=fatal msg="exiting, status={Running:false Degraded:false Exiting:true Errors:[] SSHLocalPort:0} (hint: see \"/Users/runner/.lima/docker-actions-toolkit/ha.stderr.log\")"
### /Users/runner/.lima/docker-actions-toolkit/ha.stderr.log:
{"level":"warning","msg":"provisioning scripts should not reference the LIMA_CIDATA variables","time":"2024-04-25T07:55:24Z"}
{"level":"warning","msg":"provisioning scripts should not reference the LIMA_CIDATA variables","time":"2024-04-25T07:55:24Z"}
{"level":"warning","msg":"provisioning scripts should not reference the LIMA_CIDATA variables","time":"2024-04-25T07:55:24Z"}
{"level":"debug","msg":"executing [ssh-keygen -t ed25519 -q -N  -f /Users/runner/.lima/_config/user]","time":"2024-04-25T07:55:24Z"}
{"level":"debug","msg":"Creating iso file /Users/runner/.lima/docker-actions-toolkit/cidata.iso","time":"2024-04-25T07:55:24Z"}
{"level":"debug","msg":"Using /var/folders/3m/p59k4qdj0f17st0gn2cmj3640000gn/T/diskfs_iso3971499752 as workspace","time":"2024-04-25T07:55:24Z"}
{"level":"debug","msg":"Failed to detect CPU features. Assuming that AES acceleration is available on this Apple silicon.","time":"2024-04-25T07:55:24Z"}
{"level":"debug","msg":"OpenSSH version 9.6.1 detected","time":"2024-04-25T07:55:24Z"}
{"level":"debug","msg":"AES accelerator seems available, prioritizing aes128-gcm@openssh.com and aes256-gcm@openssh.com","time":"2024-04-25T07:55:24Z"}
{"level":"info","msg":"hostagent socket created at /Users/runner/.lima/docker-actions-toolkit/ha.sock","time":"2024-04-25T07:55:24Z"}
{"level":"debug","msg":"Start udp DNS listening on: 127.0.0.1:52205","time":"2024-04-25T07:55:24Z"}
{"level":"debug","msg":"Start tcp DNS listening on: 127.0.0.1:49216","time":"2024-04-25T07:55:24Z"}
{"level":"debug","msg":"QEMU version 8.2.2 detected","time":"2024-04-25T07:55:24Z"}
{"level":"debug","msg":"firmware candidates = [/Users/runner/.local/share/qemu/edk2-aarch64-code.fd /opt/homebrew/share/qemu/edk2-aarch64-code.fd /usr/share/AAVMF/AAVMF_CODE.fd /usr/share/qemu-efi-aarch64/QEMU_EFI.fd]","time":"2024-04-25T07:55:24Z"}
{"level":"info","msg":"Using system firmware (\"/opt/homebrew/share/qemu/edk2-aarch64-code.fd\")","time":"2024-04-25T07:55:24Z"}
{"level":"info","msg":"Starting QEMU (hint: to watch the boot progress, see \"/Users/runner/.lima/docker-actions-toolkit/serial*.log\")","time":"2024-04-25T07:55:24Z"}
{"level":"debug","msg":"qCmd.Args: [/opt/homebrew/bin/qemu-system-aarch64 -m 8192 -cpu host -machine virt,accel=hvf -smp 4,sockets=1,cores=4,threads=1 -drive if=pflash,format=raw,readonly=on,file=/opt/homebrew/share/qemu/edk2-aarch64-code.fd -boot order=c,splash-time=0,menu=on -drive file=/Users/runner/.lima/docker-actions-toolkit/diffdisk,if=virtio,discard=on -drive id=cdrom0,if=none,format=raw,readonly=on,file=/Users/runner/.lima/docker-actions-toolkit/cidata.iso -device virtio-scsi-pci,id=scsi0 -device scsi-cd,bus=scsi0.0,drive=cdrom0 -netdev user,id=net0,net=192.168.5.0/24,dhcpstart=192.168.5.15,hostfwd=tcp:127.0.0.1:49215-:22 -device virtio-net-pci,netdev=net0,mac=52:55:55:35:03:b3 -device virtio-rng-pci -audiodev none,id=default -device ich9-intel-hda -device hda-output,audiodev=default -display none -device virtio-gpu -device virtio-keyboard-pci -device virtio-mouse-pci -device qemu-xhci,id=usb-bus -parallel none -chardev socket,id=char-serial,path=/Users/runner/.lima/docker-actions-toolkit/serial.sock,server=on,wait=off,logfile=/Users/runner/.lima/docker-actions-toolkit/serial.log -serial chardev:char-serial -chardev socket,id=char-serial-pci,path=/Users/runner/.lima/docker-actions-toolkit/serialp.sock,server=on,wait=off,logfile=/Users/runner/.lima/docker-actions-toolkit/serialp.log -device pci-serial,chardev=char-serial-pci -chardev socket,id=char-serial-virtio,path=/Users/runner/.lima/docker-actions-toolkit/serialv.sock,server=on,wait=off,logfile=/Users/runner/.lima/docker-actions-toolkit/serialv.log -device virtio-serial-pci,id=virtio-serial0,max_ports=1 -device virtconsole,chardev=char-serial-virtio,id=console0 -chardev socket,id=char-qmp,path=/Users/runner/.lima/docker-actions-toolkit/qmp.sock,server=on,wait=off -qmp chardev:char-qmp -chardev socket,path=/Users/runner/.lima/docker-actions-toolkit/ga.sock,server=on,wait=off,id=qga0 -device virtio-serial -device virtserialport,chardev=qga0,name=io.lima-vm.guest_agent.0 -name lima-docker-actions-toolkit -pidfile /Users/runner/.lima/docker-actions-toolkit/qemu.pid]","time":"2024-04-25T07:55:24Z"}
{"level":"info","msg":"Waiting for the essential requirement 1 of 4: \"ssh\"","time":"2024-04-25T07:55:24Z"}
{"level":"debug","msg":"executing script \"ssh\"","time":"2024-04-25T07:55:24Z"}
{"level":"debug","msg":"executing ssh for script \"ssh\": /usr/bin/ssh [ssh -F /dev/null -o IdentityFile=\"/Users/runner/.lima/_config/user\" -o StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -o NoHostAuthenticationForLocalhost=yes -o GSSAPIAuthentication=no -o PreferredAuthentications=publickey -o Compression=no -o BatchMode=yes -o IdentitiesOnly=yes -o Ciphers=\"^aes128-gcm@openssh.com,aes256-gcm@openssh.com\" -o User=runner -o ControlMaster=auto -o ControlPath=\"/Users/runner/.lima/docker-actions-toolkit/ssh.sock\" -o ControlPersist=yes -p 49215 127.0.0.1 -- /bin/bash]","time":"2024-04-25T07:55:24Z"}
{"level":"debug","msg":"stdout=\"\", stderr=\"ssh: connect to host 127.0.0.1 port 49215: Connection refused\\r\\n\", err=failed to execute script \"ssh\": stdout=\"\", stderr=\"ssh: connect to host 127.0.0.1 port 49215: Connection refused\\r\\n\": exit status 255","time":"2024-04-25T07:55:24Z"}
{"level":"debug","msg":"qemu[stderr]: qemu-system-aarch64: Error: HV_UNSUPPORTED","time":"2024-04-25T07:55:24Z"}
{"level":"info","msg":"Driver stopped due to error: \"signal: abort trap\"","time":"2024-04-25T07:55:24Z"}
{"level":"info","msg":"Shutting down the host agent","time":"2024-04-25T07:55:24Z"}
{"level":"debug","msg":"shutting down the SSH master","time":"2024-04-25T07:55:24Z"}
{"level":"debug","msg":"executing ssh for exiting the master: /usr/bin/ssh [ssh -F /dev/null -o IdentityFile=\"/Users/runner/.lima/_config/user\" -o StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -o NoHostAuthenticationForLocalhost=yes -o GSSAPIAuthentication=no -o PreferredAuthentications=publickey -o Compression=no -o BatchMode=yes -o IdentitiesOnly=yes -o Ciphers=\"^aes128-gcm@openssh.com,aes256-gcm@openssh.com\" -o User=runner -o ControlMaster=auto -o ControlPath=\"/Users/runner/.lima/docker-actions-toolkit/ssh.sock\" -o ControlPersist=yes -O exit -p 49215 127.0.0.1]","time":"2024-04-25T07:55:24Z"}
{"error":"failed to execute `ssh -O exit -p 49215 127.0.0.1`, out=\"Control socket connect(/Users/runner/.lima/docker-actions-toolkit/ssh.sock): No such file or directory\\r\\n\": exit status 255","level":"warning","msg":"failed to exit SSH master","time":"2024-04-25T07:55:24Z"}
{"level":"info","msg":"Shutting down QEMU with ACPI","time":"2024-04-25T07:55:24Z"}
{"error":"dial unix /Users/runner/.lima/docker-actions-toolkit/qmp.sock: connect: connection refused","level":"warning","msg":"failed to open the QMP socket \"/Users/runner/.lima/docker-actions-toolkit/qmp.sock\", forcibly killing QEMU","time":"2024-04-25T07:55:24Z"}
{"level":"info","msg":"QEMU has already exited","time":"2024-04-25T07:55:24Z"}
### /Users/runner/.lima/docker-actions-toolkit/ha.stdout.log:
{"time":"2024-04-25T07:55:24.722092Z","status":{"sshLocalPort":49215}}
{"time":"2024-04-25T07:55:24.779903Z","status":{"exiting":true}}

Activity

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment

Metadata

Metadata

Assignees

No one assigned

    Type

    No type

    Projects

    No projects

      Milestone

      No milestone

      Relationships

      None yet

      Development

      No branches or pull requests

      Issue actions