Multipass can't start VMs on Fedora 36

According to multipass tracker snaps still can’t get IPs, even if the IPs are needed for local purpose.

Trying to run Debian 11 image with multipass fails.

$ multipass launch --name debian11 -vvvv https://cloud.debian.org/images/cloud/bullseye/latest/debian-11-generic-amd64.qcow2
...
[2022-05-12T20:25:37.264] [debug] [qemu-system-x86_64] [206109] started: qemu-system-x86_64 --enable-kvm -cpu host -nic tap,ifname=tap-ea0f558e917,script=no,downscript=no,model=virtio-net-pci,mac=52:54:00:cb:74:67 -device virtio-scsi-pci,id=scsi0 -drive file=/var/snap/multipass/common/data/multipassd/vault/instances/debian11/debian-11-generic-amd64.qcow2,if=none,format=qcow2,discard=unmap,id=hda -device scsi-hd,drive=hda,bus=scsi0.0 -smp 1 -m 1024M -qmp stdio -chardev null,id=char0 -serial chardev:char0 -nographic -cdrom /var/snap/multipass/common/data/multipassd/vault/instances/debian11/cloud-init-config.iso
[2022-05-12T20:25:37.264] [info] [debian11] process started                     
launch failed: The following errors occurred:                                   
debian11: timed out waiting for response            

The full log.

May 12 19:59:26 blackred systemd[1]: Started snap.multipass.hook.install.097d1668-0433-4a4f-8523-02e0e0f5073c.scope.
May 12 19:59:27 blackred systemd[1]: snap.multipass.hook.install.097d1668-0433-4a4f-8523-02e0e0f5073c.scope: Deactivated successfully.
May 12 19:59:27 blackred systemd[1]: Started snap.multipass.multipassd.service - Service for snap application multipass.multipassd.
May 12 19:59:28 blackred systemd[1]: Started snap.multipass.hook.configure.e745dc7a-c973-4c1c-b9a1-9fb286aaf20c.scope.
May 12 19:59:28 blackred systemd[1]: snap.multipass.hook.configure.e745dc7a-c973-4c1c-b9a1-9fb286aaf20c.scope: Deactivated successfully.
May 12 19:59:28 blackred multipassd[193165]: Unable to determine subnet for the mpqemubr0 subnet
May 12 19:59:29 blackred multipassd[193165]: Using AppArmor support
May 12 19:59:29 blackred multipassd[193165]: Failed to enable AppArmor: AppArmor is not enabled
May 12 19:59:29 blackred multipassd[193165]: Starting dnsmasq
May 12 19:59:29 blackred multipassd[193165]: [193281] started: dnsmasq --keep-in-foreground --strict-order --bind-interfaces --pid-file --domain=multipass --local=/multipass/ --except-interface=lo --interface=mpqemubr0 --listen-address=10.76.185.1 --dhcp-no-override --dhcp-authoritative --dhcp-leasefile=/var/snap/multipass/common/data/multipassd/network/dnsmasq.leases --dhcp-hostsfile=/var/snap/multipass/common/data/multipassd/network/dnsmasq.hosts --dhcp-range 10.76.185.2,10.76.185.254,infinite --conf-file=/var/snap/multipass/common/data/multipassd/network/dnsmasq-rSozCN.conf
May 12 19:59:29 blackred dnsmasq[193281]: started, version 2.80 cachesize 150
May 12 19:59:29 blackred dnsmasq[193281]: compile time options: IPv6 GNU-getopt DBus i18n IDN DHCP DHCPv6 no-Lua TFTP conntrack ipset auth nettlehash DNSSEC loop-detect inotify dumpfile
May 12 19:59:29 blackred dnsmasq-dhcp[193281]: DHCP, IP range 10.76.185.2 -- 10.76.185.254, lease time infinite
May 12 19:59:29 blackred dnsmasq-dhcp[193281]: DHCP, sockets bound exclusively to interface mpqemubr0
May 12 19:59:29 blackred dnsmasq[193281]: using local addresses only for domain multipass
May 12 19:59:29 blackred dnsmasq[193281]: reading /etc/resolv.conf
May 12 19:59:29 blackred dnsmasq[193281]: using local addresses only for domain multipass
May 12 19:59:29 blackred dnsmasq[193281]: using nameserver 127.0.0.53#53
May 12 19:59:29 blackred dnsmasq[193281]: read /etc/hosts - 2 addresses
May 12 19:59:29 blackred dnsmasq-dhcp[193281]: read /var/snap/multipass/common/data/multipassd/network/dnsmasq.hosts
May 12 19:59:29 blackred multipassd[193165]: Cannot parse kernel version '5.17.5-300.fc36.x86_64'
May 12 19:59:29 blackred multipassd[193165]: Using iptables-legacy for firewall rules.
May 12 19:59:29 blackred multipassd[193165]: [193283] started: iptables-legacy --wait -t filter --list-rules
May 12 19:59:29 blackred multipassd[193165]: [193287] started: iptables-legacy --wait -t nat --list-rules
May 12 19:59:29 blackred multipassd[193165]: [193288] started: iptables-legacy --wait -t mangle --list-rules
May 12 19:59:29 blackred multipassd[193165]: [193289] started: iptables-legacy --wait -t raw --list-rules
May 12 19:59:29 blackred multipassd[193165]: [193290] started: iptables-legacy --wait -t filter --insert INPUT --in-interface mpqemubr0 --protocol udp --dport 67 --jump ACCEPT --match comment --comment generated for Multipass network mpqemubr0
May 12 19:59:29 blackred multipassd[193165]: [193294] started: iptables-legacy --wait -t filter --insert INPUT --in-interface mpqemubr0 --protocol udp --dport 53 --jump ACCEPT --match comment --comment generated for Multipass network mpqemubr0
May 12 19:59:29 blackred multipassd[193165]: [193295] started: iptables-legacy --wait -t filter --insert INPUT --in-interface mpqemubr0 --protocol tcp --dport 53 --jump ACCEPT --match comment --comment generated for Multipass network mpqemubr0
May 12 19:59:29 blackred multipassd[193165]: [193297] started: iptables-legacy --wait -t filter --insert OUTPUT --out-interface mpqemubr0 --protocol udp --sport 67 --jump ACCEPT --match comment --comment generated for Multipass network mpqemubr0
May 12 19:59:29 blackred multipassd[193165]: [193300] started: iptables-legacy --wait -t filter --insert OUTPUT --out-interface mpqemubr0 --protocol udp --sport 53 --jump ACCEPT --match comment --comment generated for Multipass network mpqemubr0
May 12 19:59:29 blackred multipassd[193165]: [193303] started: iptables-legacy --wait -t filter --insert OUTPUT --out-interface mpqemubr0 --protocol tcp --sport 53 --jump ACCEPT --match comment --comment generated for Multipass network mpqemubr0
May 12 19:59:29 blackred multipassd[193165]: [193305] started: iptables-legacy --wait -t mangle --insert POSTROUTING --out-interface mpqemubr0 --protocol udp --dport 68 --jump CHECKSUM --checksum-fill --match comment --comment generated for Multipass network mpqemubr0
May 12 19:59:29 blackred multipassd[193165]: [193308] started: iptables-legacy --wait -t nat --insert POSTROUTING --source 10.76.185.0/24 --destination 224.0.0.0/24 --jump RETURN --match comment --comment generated for Multipass network mpqemubr0
May 12 19:59:29 blackred multipassd[193165]: [193309] started: iptables-legacy --wait -t nat --insert POSTROUTING --source 10.76.185.0/24 --destination 255.255.255.255/32 --jump RETURN --match comment --comment generated for Multipass network mpqemubr0
May 12 19:59:29 blackred multipassd[193165]: [193310] started: iptables-legacy --wait -t nat --insert POSTROUTING --source 10.76.185.0/24 ! --destination 10.76.185.0/24 --protocol tcp --jump MASQUERADE --to-ports 1024-65535 --match comment --comment generated for Multipass network mpqemubr0
May 12 19:59:29 blackred multipassd[193165]: [193312] started: iptables-legacy --wait -t nat --insert POSTROUTING --source 10.76.185.0/24 ! --destination 10.76.185.0/24 --protocol udp --jump MASQUERADE --to-ports 1024-65535 --match comment --comment generated for Multipass network mpqemubr0
May 12 19:59:29 blackred multipassd[193165]: [193313] started: iptables-legacy --wait -t nat --insert POSTROUTING --source 10.76.185.0/24 ! --destination 10.76.185.0/24 --jump MASQUERADE --match comment --comment generated for Multipass network mpqemubr0
May 12 19:59:29 blackred multipassd[193165]: [193314] started: iptables-legacy --wait -t filter --insert FORWARD --destination 10.76.185.0/24 --out-interface mpqemubr0 --match conntrack --ctstate RELATED,ESTABLISHED --jump ACCEPT --match comment --comment generated for Multipass network mpqemubr0
May 12 19:59:29 blackred multipassd[193165]: [193316] started: iptables-legacy --wait -t filter --insert FORWARD --source 10.76.185.0/24 --in-interface mpqemubr0 --jump ACCEPT --match comment --comment generated for Multipass network mpqemubr0
May 12 19:59:29 blackred multipassd[193165]: [193317] started: iptables-legacy --wait -t filter --insert FORWARD --in-interface mpqemubr0 --out-interface mpqemubr0 --jump ACCEPT --match comment --comment generated for Multipass network mpqemubr0
May 12 19:59:29 blackred multipassd[193165]: [193318] started: iptables-legacy --wait -t filter --append FORWARD --in-interface mpqemubr0 --jump REJECT --reject-with icmp-port-unreachable --match comment --comment generated for Multipass network mpqemubr0
May 12 19:59:29 blackred multipassd[193165]: [193320] started: iptables-legacy --wait -t filter --append FORWARD --out-interface mpqemubr0 --jump REJECT --reject-with icmp-port-unreachable --match comment --comment generated for Multipass network mpqemubr0
May 12 19:59:45 blackred multipassd[193165]: gRPC listening on unix:/var/snap/multipass/common/multipass_socket
May 12 19:59:45 blackred multipassd[193165]: QIODevice::write (QFile, "/var/snap/multipass/common/cache/multipassd/vault/multipassd-image-records.json"): device not open
May 12 19:59:45 blackred multipassd[193165]: Starting Multipass 1.9.0
May 12 19:59:45 blackred multipassd[193165]: Daemon arguments: /snap/multipass/6920/bin/multipassd --verbosity debug --logger platform
May 12 20:17:09 blackred multipassd[193165]: [203563] started: qemu-system-x86_64 --version
May 12 20:17:51 blackred multipassd[193165]: [203839] started: qemu-system-x86_64 --version
May 12 20:18:01 blackred multipassd[193165]: Cannot retrieve headers for https://cloud.debian.org/images/cloud/bullseye/latest/debian-11-generic-amd64.qcow2: Network timeout
May 12 20:18:24 blackred multipassd[193165]: [204011] started: qemu-system-x86_64 --version
May 12 20:18:34 blackred multipassd[193165]: Cannot retrieve headers for https://cloud.debian.org/images/cloud/bullseye/latest/debian-11-generic-amd64.qcow2: Network timeout
May 12 20:18:59 blackred multipassd[193165]: [204300] started: qemu-system-x86_64 --version
May 12 20:19:09 blackred multipassd[193165]: Cannot retrieve headers for https://cloud.debian.org/images/cloud/bullseye/latest/debian-11-generic-amd64.qcow2: Network timeout
May 12 20:19:36 blackred multipassd[193165]: [204500] started: qemu-system-x86_64 --version
May 12 20:19:47 blackred multipassd[193165]: Cannot retrieve headers for https://cloud.debian.org/images/cloud/bullseye/latest/debian-11-generic-amd64.qcow2: Network timeout
May 12 20:20:21 blackred multipassd[193165]: [204694] started: qemu-system-x86_64 --version
May 12 20:20:31 blackred multipassd[193165]: Cannot retrieve headers for https://cloud.debian.org/images/cloud/bullseye/latest/debian-11-generic-amd64.qcow2: Network timeout
May 12 20:20:41 blackred multipassd[193165]: [204802] started: qemu-system-x86_64 --version
May 12 20:20:51 blackred multipassd[193165]: Cannot retrieve headers for https://cloud.debian.org/images/cloud/bullseye/latest/debian-11-generic-amd64.qcow2: Network timeout
May 12 20:23:41 blackred multipassd[193165]: [205317] started: qemu-system-x86_64 --version
May 12 20:25:35 blackred multipassd[193165]: [206051] started: qemu-img info --output=json /var/snap/multipass/common/cache/multipassd/vault/images/debian-11-generic-amd64-20220503/debian-11-generic-amd64.qcow2
May 12 20:25:36 blackred multipassd[193165]: [206060] started: qemu-img info /var/snap/multipass/common/cache/multipassd/vault/images/debian-11-generic-amd64-20220503/debian-11-generic-amd64.qcow2
May 12 20:25:36 blackred multipassd[193165]: [206065] started: qemu-img resize /var/snap/multipass/common/data/multipassd/vault/instances/debian11/debian-11-generic-amd64.qcow2 5368709120
May 12 20:25:36 blackred multipassd[193165]: [206070] started: qemu-img snapshot -l /var/snap/multipass/common/data/multipassd/vault/instances/debian11/debian-11-generic-amd64.qcow2
May 12 20:25:36 blackred multipassd[193165]: process working dir '/snap/multipass/6920/qemu'
May 12 20:25:36 blackred multipassd[193165]: process program 'qemu-system-x86_64'
May 12 20:25:36 blackred multipassd[193165]: process arguments '--enable-kvm, -cpu, host, -nic, tap,ifname=tap-ea0f558e917,script=no,downscript=no,model=virtio-net-pci,mac=52:54:00:cb:74:67, -device, virtio-scsi-pci,id=scsi0, -drive, file=/var/snap/multipass/common/data/multipassd/vault/instances/debian11/debian-11-generic-amd64.qcow2,if=none,format=qcow2,discard=unmap,id=hda, -device, scsi-hd,drive=hda,bus=scsi0.0, -smp, 1, -m, 1024M, -qmp, stdio, -chardev, null,id=char0, -serial, chardev:char0, -nographic, -cdrom, /var/snap/multipass/common/data/multipassd/vault/instances/debian11/cloud-init-config.iso'
May 12 20:25:36 blackred multipassd[193165]: [206092] started: qemu-system-x86_64 -nographic -dump-vmstate /tmp/multipassd.MspNRp
May 12 20:25:37 blackred multipassd[193165]: process state changed to Starting
May 12 20:25:37 blackred multipassd[193165]: process state changed to Running
May 12 20:25:37 blackred multipassd[193165]: [206109] started: qemu-system-x86_64 --enable-kvm -cpu host -nic tap,ifname=tap-ea0f558e917,script=no,downscript=no,model=virtio-net-pci,mac=52:54:00:cb:74:67 -device virtio-scsi-pci,id=scsi0 -drive file=/var/snap/multipass/common/data/multipassd/vault/instances/debian11/debian-11-generic-amd64.qcow2,if=none,format=qcow2,discard=unmap,id=hda -device scsi-hd,drive=hda,bus=scsi0.0 -smp 1 -m 1024M -qmp stdio -chardev null,id=char0 -serial chardev:char0 -nographic -cdrom /var/snap/multipass/common/data/multipassd/vault/instances/debian11/cloud-init-config.iso
May 12 20:25:37 blackred multipassd[193165]: process started
May 12 20:25:37 blackred multipassd[193165]: Waiting for SSH to be up
May 12 20:25:37 blackred multipassd[193165]: QMP: {"QMP": {"version": {"qemu": {"micro": 1, "minor": 2, "major": 4}, "package": "Debian 1:4.2-3ubuntu6.21"}, "capabilities": ["oob"]}}
May 12 20:25:37 blackred multipassd[193165]: QMP: {"return": {}}
May 12 20:25:47 blackred multipassd[193165]: QMP: {"timestamp": {"seconds": 1652376347, "microseconds": 443127}, "event": "NIC_RX_FILTER_CHANGED", "data": {"path": "/machine/unattached/device[22]/virtio-backend"}}
May 12 20:31:02 blackred multipassd[193165]: Cannot fetch image information: Unable to find an image matching hash "af7dc04797e908e753ebb8801fac37f770d0f7288857ae5916339657ecdda56a"
May 12 20:31:26 blackred multipassd[193165]: [207377] started: qemu-system-x86_64 --version

The github issue mentions temporarily disabling firewalld. Have you tried it by any chance?

Working on system with firewall turned off doesn’t seem like a good idea to me, so I can hardly consider this to be a solution.

Yeah I get that. Perhaps someone has to implement the necessary dbus integration with firewalld. As usual, there’s more than one way of doing things.

1 Like

Or someone needs to enable slower user mode networking in multipass through SLIRP when firewall integration is not available.