0s autopkgtest [09:27:28]: starting date and time: 2025-04-14 09:27:28+0000
  0s autopkgtest [09:27:28]: git checkout: 9986aa8c Merge branch 'skia/fix_network_interface' into 'ubuntu/production'
  0s autopkgtest [09:27:28]: host juju-7f2275-prod-proposed-migration-environment-23; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.m7m8l323/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:podman-compose --apt-upgrade podman-compose --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=podman-compose/1.2.0-2 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest-cpu2-ram4-disk20-s390x --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-23@sto01-s390x-3.secgroup --name adt-plucky-s390x-podman-compose-20250414-092728-juju-7f2275-prod-proposed-migration-environment-23-7b6aaedf-13cd-4943-8b14-f7d21419f6f9 --image adt/ubuntu-plucky-s390x-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-23 --net-id=net_prod-autopkgtest-workers-s390x -e TERM=linux --mirror=http://ftpmaster.internal/ubuntu/
108s autopkgtest [09:29:16]: testbed dpkg architecture: s390x
109s autopkgtest [09:29:17]: testbed apt version: 3.0.0
109s autopkgtest [09:29:17]: @@@@@@@@@@@@@@@@@@@@ test bed setup
109s autopkgtest [09:29:17]: testbed release detected to be: None
111s autopkgtest [09:29:19]: updating testbed package index (apt update)
111s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [265 kB]
112s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease
112s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease
112s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease
112s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [5192 B]
112s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [9948 B]
112s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [204 kB]
112s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x Packages [3452 B]
112s Get:9 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x c-n-f Metadata [288 B]
112s Get:10 http://ftpmaster.internal/ubuntu plucky-proposed/restricted s390x c-n-f Metadata [116 B]
112s Get:11 http://ftpmaster.internal/ubuntu plucky-proposed/universe s390x Packages [119 kB]
112s Get:12 http://ftpmaster.internal/ubuntu plucky-proposed/universe s390x c-n-f Metadata [7952 B]
112s Get:13 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse s390x Packages [1460 B]
112s Get:14 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse s390x c-n-f Metadata [172 B]
118s Fetched 616 kB in 1s (848 kB/s)
122s Reading package lists...
123s autopkgtest [09:29:31]: upgrading testbed (apt dist-upgrade and autopurge)
123s Reading package lists...
123s Building dependency tree...
123s Reading state information...
124s Calculating upgrade...Starting pkgProblemResolver with broken count: 0
124s Starting 2 pkgProblemResolver with broken count: 0
124s Done
124s Entering ResolveByKeep
125s 
125s Calculating upgrade...
126s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
126s Reading package lists...
126s Building dependency tree...
126s Reading state information...
126s Starting pkgProblemResolver with broken count: 0
127s Starting 2 pkgProblemResolver with broken count: 0
127s Done
127s Solving dependencies...
127s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
130s autopkgtest [09:29:38]: testbed running kernel: Linux 6.14.0-15-generic #15-Ubuntu SMP Sun Apr  6 13:39:00 UTC 2025
130s autopkgtest [09:29:38]: @@@@@@@@@@@@@@@@@@@@ apt-source podman-compose
131s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed/universe podman-compose 1.2.0-2 (dsc) [2206 B]
131s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/universe podman-compose 1.2.0-2 (tar) [84.7 kB]
131s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/universe podman-compose 1.2.0-2 (diff) [4248 B]
131s gpgv: Signature made Tue Aug 20 14:06:40 2024 UTC
131s gpgv:                using RSA key 439884E6862A429C290DF63B033C4CA276024834
131s gpgv:                issuer "athoscribeiro@gmail.com"
131s gpgv: Can't check signature: No public key
131s dpkg-source: warning: cannot verify inline signature for ./podman-compose_1.2.0-2.dsc: no acceptable signature found
131s autopkgtest [09:29:39]: testing package podman-compose version 1.2.0-2
131s autopkgtest [09:29:39]: build not needed
132s autopkgtest [09:29:40]: test build.sh: preparing testbed
132s Reading package lists...
132s Building dependency tree...
132s Reading state information...
133s Starting pkgProblemResolver with broken count: 0
133s Starting 2 pkgProblemResolver with broken count: 0
133s Done
133s The following NEW packages will be installed:
133s   conmon containernetworking-plugins crun golang-github-containers-common
133s   golang-github-containers-image libslirp0 libsubid5 libyajl2 netavark podman
133s   podman-compose python3-dotenv slirp4netns uidmap
134s 0 upgraded, 14 newly installed, 0 to remove and 0 not upgraded.
134s Need to get 38.0 MB of archives.
134s After this operation, 171 MB of additional disk space will be used.
134s Get:1 http://ftpmaster.internal/ubuntu plucky/universe s390x conmon s390x 2.1.12-4 [38.0 kB]
134s Get:2 http://ftpmaster.internal/ubuntu plucky/universe s390x containernetworking-plugins s390x 1.1.1+ds1-3build1 [6697 kB]
134s Get:3 http://ftpmaster.internal/ubuntu plucky/main s390x libyajl2 s390x 2.1.0-5build1 [22.2 kB]
134s Get:4 http://ftpmaster.internal/ubuntu plucky/universe s390x crun s390x 1.20-1syncable1 [461 kB]
134s Get:5 http://ftpmaster.internal/ubuntu plucky/universe s390x netavark s390x 1.12.1-9 [5614 kB]
134s Get:6 http://ftpmaster.internal/ubuntu plucky/universe s390x golang-github-containers-image all 5.34.2-1 [34.6 kB]
134s Get:7 http://ftpmaster.internal/ubuntu plucky/universe s390x golang-github-containers-common all 0.62.2+ds1-2 [44.5 kB]
134s Get:8 http://ftpmaster.internal/ubuntu plucky/main s390x libslirp0 s390x 4.8.0-1ubuntu1 [66.3 kB]
134s Get:9 http://ftpmaster.internal/ubuntu plucky/main s390x libsubid5 s390x 1:4.16.0-7ubuntu1 [26.8 kB]
134s Get:10 http://ftpmaster.internal/ubuntu plucky/universe s390x podman s390x 5.4.1+ds1-1 [24.8 MB]
135s Get:11 http://ftpmaster.internal/ubuntu plucky/universe s390x python3-dotenv all 1.0.1-1 [22.3 kB]
135s Get:12 http://ftpmaster.internal/ubuntu plucky-proposed/universe s390x podman-compose all 1.2.0-2 [46.4 kB]
135s Get:13 http://ftpmaster.internal/ubuntu plucky/universe s390x slirp4netns s390x 1.2.1-1build2 [36.2 kB]
135s Get:14 http://ftpmaster.internal/ubuntu plucky/main s390x uidmap s390x 1:4.16.0-7ubuntu1 [38.2 kB]
135s Fetched 38.0 MB in 2s (25.3 MB/s)
135s Selecting previously unselected package conmon.
135s (Reading database ... 
(Reading database ... 5%
(Reading database ... 10%
(Reading database ... 15%
(Reading database ... 20%
(Reading database ... 25%
(Reading database ... 30%
(Reading database ... 35%
(Reading database ... 40%
(Reading database ... 45%
(Reading database ... 50%
(Reading database ... 55%
(Reading database ... 60%
(Reading database ... 65%
(Reading database ... 70%
(Reading database ... 75%
(Reading database ... 80%
(Reading database ... 85%
(Reading database ... 90%
(Reading database ... 95%
(Reading database ... 100%
(Reading database ... 81472 files and directories currently installed.)
135s Preparing to unpack .../00-conmon_2.1.12-4_s390x.deb ...
135s Unpacking conmon (2.1.12-4) ...
135s Selecting previously unselected package containernetworking-plugins.
135s Preparing to unpack .../01-containernetworking-plugins_1.1.1+ds1-3build1_s390x.deb ...
135s Unpacking containernetworking-plugins (1.1.1+ds1-3build1) ...
136s Selecting previously unselected package libyajl2:s390x.
136s Preparing to unpack .../02-libyajl2_2.1.0-5build1_s390x.deb ...
136s Unpacking libyajl2:s390x (2.1.0-5build1) ...
136s Selecting previously unselected package crun.
136s Preparing to unpack .../03-crun_1.20-1syncable1_s390x.deb ...
136s Unpacking crun (1.20-1syncable1) ...
136s Selecting previously unselected package netavark.
136s Preparing to unpack .../04-netavark_1.12.1-9_s390x.deb ...
136s Unpacking netavark (1.12.1-9) ...
136s Selecting previously unselected package golang-github-containers-image.
136s Preparing to unpack .../05-golang-github-containers-image_5.34.2-1_all.deb ...
136s Unpacking golang-github-containers-image (5.34.2-1) ...
136s Selecting previously unselected package golang-github-containers-common.
136s Preparing to unpack .../06-golang-github-containers-common_0.62.2+ds1-2_all.deb ...
136s Unpacking golang-github-containers-common (0.62.2+ds1-2) ...
136s Selecting previously unselected package libslirp0:s390x.
136s Preparing to unpack .../07-libslirp0_4.8.0-1ubuntu1_s390x.deb ...
136s Unpacking libslirp0:s390x (4.8.0-1ubuntu1) ...
136s Selecting previously unselected package libsubid5:s390x.
136s Preparing to unpack .../08-libsubid5_1%3a4.16.0-7ubuntu1_s390x.deb ...
136s Unpacking libsubid5:s390x (1:4.16.0-7ubuntu1) ...
136s Selecting previously unselected package podman.
136s Preparing to unpack .../09-podman_5.4.1+ds1-1_s390x.deb ...
136s Unpacking podman (5.4.1+ds1-1) ...
138s Selecting previously unselected package python3-dotenv.
138s Preparing to unpack .../10-python3-dotenv_1.0.1-1_all.deb ...
138s Unpacking python3-dotenv (1.0.1-1) ...
138s Selecting previously unselected package podman-compose.
138s Preparing to unpack .../11-podman-compose_1.2.0-2_all.deb ...
138s Unpacking podman-compose (1.2.0-2) ...
138s Selecting previously unselected package slirp4netns.
138s Preparing to unpack .../12-slirp4netns_1.2.1-1build2_s390x.deb ...
138s Unpacking slirp4netns (1.2.1-1build2) ...
138s Selecting previously unselected package uidmap.
138s Preparing to unpack .../13-uidmap_1%3a4.16.0-7ubuntu1_s390x.deb ...
138s Unpacking uidmap (1:4.16.0-7ubuntu1) ...
138s Setting up python3-dotenv (1.0.1-1) ...
138s Setting up libyajl2:s390x (2.1.0-5build1) ...
138s Setting up podman-compose (1.2.0-2) ...
138s Setting up libsubid5:s390x (1:4.16.0-7ubuntu1) ...
138s Setting up golang-github-containers-image (5.34.2-1) ...
138s Setting up conmon (2.1.12-4) ...
138s Setting up containernetworking-plugins (1.1.1+ds1-3build1) ...
138s Setting up netavark (1.12.1-9) ...
138s Created symlink '/etc/systemd/system/default.target.wants/netavark-dhcp-proxy.service' → '/usr/lib/systemd/system/netavark-dhcp-proxy.service'.

139s Created symlink '/etc/systemd/system/sockets.target.wants/netavark-dhcp-proxy.socket' → '/usr/lib/systemd/system/netavark-dhcp-proxy.socket'.

139s Created symlink '/etc/systemd/system/firewalld.service.wants/netavark-firewalld-reload.service' → '/usr/lib/systemd/system/netavark-firewalld-reload.service'.

139s Unit /usr/lib/systemd/system/netavark-firewalld-reload.service is added as a dependency to a non-existent unit firewalld.service.

139s Setting up libslirp0:s390x (4.8.0-1ubuntu1) ...
139s Setting up golang-github-containers-common (0.62.2+ds1-2) ...
139s Setting up slirp4netns (1.2.1-1build2) ...
139s Setting up crun (1.20-1syncable1) ...
139s Setting up uidmap (1:4.16.0-7ubuntu1) ...
139s Setting up podman (5.4.1+ds1-1) ...
140s Processing triggers for libc-bin (2.41-6ubuntu1) ...
140s Processing triggers for man-db (2.13.0-1) ...
143s autopkgtest [09:29:51]: test build.sh: [-----------------------
143s STEP 1/8: FROM busybox
143s Resolved "busybox" as an alias (/etc/containers/registries.conf.d/shortnames.conf)
143s Trying to pull docker.io/library/busybox:latest...
143s STEP 1/8: FROM busybox
143s STEP 1/3: FROM busybox
143s Resolved "busybox" as an alias (/etc/containers/registries.conf.d/shortnames.conf)
143s Trying to pull docker.io/library/busybox:latest...
143s Resolved "busybox" as an alias (/etc/containers/registries.conf.d/shortnames.conf)
143s Trying to pull docker.io/library/busybox:latest...
145s Getting image source signatures
145s Copying blob sha256:3a771a545ce43b48793668c03014c1416fcd95adb4c2310b25b4d5dc47b71922
145s Getting image source signatures
145s Copying blob sha256:3a771a545ce43b48793668c03014c1416fcd95adb4c2310b25b4d5dc47b71922
145s Getting image source signatures
145s Copying blob sha256:3a771a545ce43b48793668c03014c1416fcd95adb4c2310b25b4d5dc47b71922
146s Copying config sha256:b26cc99e16b22c3823de3da1c0954265eafcf4f8bc6fc2bd43b0259d3e24360b
146s Writing manifest to image destination
146s Copying config sha256:b26cc99e16b22c3823de3da1c0954265eafcf4f8bc6fc2bd43b0259d3e24360b
146s Writing manifest to image destination
146s STEP 2/8: ARG buildno=1
146s STEP 2/8: ARG buildno=1
146s Copying config sha256:b26cc99e16b22c3823de3da1c0954265eafcf4f8bc6fc2bd43b0259d3e24360b
146s Writing manifest to image destination
146s --> e62cdd9f9689
146s --> df837f9951bf
146s STEP 2/3: RUN mkdir -p /var/www/html/ && date -Iseconds > /var/www/html/index.txt
146s STEP 3/8: ARG httpd_port=80
146s STEP 3/8: ARG httpd_port=80
147s --> cc9aeacb169e
147s --> 7908a3d99d48
147s STEP 4/8: ARG other_variable=not_set
147s STEP 4/8: ARG other_variable=not_set
147s time="2025-04-14T09:32:09Z" level=warning msg="pkg/bind: error detaching \"/var/tmp/buildah2517376113/mnt/rootfs\": no such file or directory"
147s time="2025-04-14T09:32:09Z" level=warning msg="pkg/bind: error removing \"/var/tmp/buildah2517376113/mnt/rootfs\": no such file or directory"
147s time="2025-04-14T09:32:09Z" level=warning msg="pkg/bind: error detaching \"/var/tmp/buildah2517376113/mnt\": no such file or directory"
147s time="2025-04-14T09:32:09Z" level=warning msg="pkg/bind: error removing \"/var/tmp/buildah2517376113/mnt\": no such file or directory"
147s time="2025-04-14T09:32:09Z" level=error msg="no such file or directory"
147s error running container: did not get container start message from parent: EOF
147s Error: building at STEP "RUN mkdir -p /var/www/html/ && date -Iseconds > /var/www/html/index.txt": setup network: could not find pasta, the network namespace can't be configured: exec: "pasta": executable file not found in $PATH
147s --> 55a0411ffbb1
147s --> 3c01c8d571db
147s STEP 5/8: ENV httpd_port ${httpd_port}
147s STEP 5/8: ENV httpd_port ${httpd_port}
147s --> db20d428e826
147s --> 1894c9575d53
147s STEP 6/8: ENV other_variable ${other_variable}
147s STEP 6/8: ENV other_variable ${other_variable}
147s --> f6abf522b995
147s --> c63f67952d4f
147s STEP 7/8: RUN mkdir -p /var/www/html/ &&     echo "ALT buildno=$buildno port=$httpd_port `date -Iseconds`" > /var/www/html/index.txt
147s STEP 7/8: RUN mkdir -p /var/www/html/ &&     echo "ALT buildno=$buildno port=$httpd_port `date -Iseconds`" > /var/www/html/index.txt
149s error running container: did not get container start message from parent: EOF
149s Error: building at STEP "RUN mkdir -p /var/www/html/ &&     echo "ALT buildno=$buildno port=$httpd_port `date -Iseconds`" > /var/www/html/index.txt": setup network: could not find pasta, the network namespace can't be configured: exec: "pasta": executable file not found in $PATH
149s error running container: did not get container start message from parent: EOF
149s Error: building at STEP "RUN mkdir -p /var/www/html/ &&     echo "ALT buildno=$buildno port=$httpd_port `date -Iseconds`" > /var/www/html/index.txt": setup network: could not find pasta, the network namespace can't be configured: exec: "pasta": executable file not found in $PATH
149s autopkgtest [09:29:57]: test build.sh: -----------------------]
150s build.sh             FAIL non-zero exit status 125
150s autopkgtest [09:29:58]: test build.sh:  - - - - - - - - - - results - - - - - - - - - -
150s autopkgtest [09:29:58]: @@@@@@@@@@@@@@@@@@@@ summary
150s build.sh             FAIL non-zero exit status 125
166s nova [W] Using flock in prodstack7-s390x
166s flock: timeout while waiting to get lock
166s Creating nova instance adt-plucky-s390x-podman-compose-20250414-092728-juju-7f2275-prod-proposed-migration-environment-23-7b6aaedf-13cd-4943-8b14-f7d21419f6f9 from image adt/ubuntu-plucky-s390x-server-20250413.img (UUID 0f91ffef-5635-4915-8647-23d7a5fffc22)...
166s nova [W] Timed out waiting for aed202e1-2f30-4a69-8588-b62bbaf3e3b1 to get deleted.