0s autopkgtest [17:30:40]: starting date and time: 2025-06-13 17:30:40+0000 0s autopkgtest [17:30:40]: git checkout: 9986aa8c Merge branch 'skia/fix_network_interface' into 'ubuntu/production' 0s autopkgtest [17:30:40]: host juju-7f2275-prod-proposed-migration-environment-20; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.mo3f_a0w/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:nginx --apt-upgrade libnginx-mod-http-echo --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=nginx/1.24.0-2ubuntu7.4 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest-cpu2-ram4-disk20-ppc64el --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-20@sto01-ppc64el-4.secgroup --name adt-noble-ppc64el-libnginx-mod-http-echo-20250613-173040-juju-7f2275-prod-proposed-migration-environment-20-4cedc531-dee3-490a-915f-2ac87418f5ff --image adt/ubuntu-noble-ppc64el-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-20 --net-id=net_prod-autopkgtest-workers-ppc64el -e TERM=linux --mirror=http://ftpmaster.internal/ubuntu/ 110s autopkgtest [17:32:30]: testbed dpkg architecture: ppc64el 110s autopkgtest [17:32:30]: testbed apt version: 2.8.3 110s autopkgtest [17:32:30]: @@@@@@@@@@@@@@@@@@@@ test bed setup 110s autopkgtest [17:32:30]: testbed release detected to be: None 111s autopkgtest [17:32:31]: updating testbed package index (apt update) 111s Get:1 http://ftpmaster.internal/ubuntu noble-proposed InRelease [265 kB] 111s Hit:2 http://ftpmaster.internal/ubuntu noble InRelease 111s Hit:3 http://ftpmaster.internal/ubuntu noble-updates InRelease 111s Hit:4 http://ftpmaster.internal/ubuntu noble-security InRelease 111s Get:5 http://ftpmaster.internal/ubuntu noble-proposed/restricted Sources [34.4 kB] 112s Get:6 http://ftpmaster.internal/ubuntu noble-proposed/universe Sources [68.7 kB] 112s Get:7 http://ftpmaster.internal/ubuntu noble-proposed/main Sources [72.6 kB] 112s Get:8 http://ftpmaster.internal/ubuntu noble-proposed/main ppc64el Packages [103 kB] 112s Get:9 http://ftpmaster.internal/ubuntu noble-proposed/main ppc64el c-n-f Metadata [2224 B] 112s Get:10 http://ftpmaster.internal/ubuntu noble-proposed/restricted ppc64el Packages [1888 B] 112s Get:11 http://ftpmaster.internal/ubuntu noble-proposed/restricted ppc64el c-n-f Metadata [116 B] 112s Get:12 http://ftpmaster.internal/ubuntu noble-proposed/universe ppc64el Packages [430 kB] 112s Get:13 http://ftpmaster.internal/ubuntu noble-proposed/universe ppc64el c-n-f Metadata [6116 B] 112s Get:14 http://ftpmaster.internal/ubuntu noble-proposed/multiverse ppc64el c-n-f Metadata [116 B] 116s Fetched 985 kB in 1s (1455 kB/s) 117s Reading package lists... 118s autopkgtest [17:32:38]: upgrading testbed (apt dist-upgrade and autopurge) 118s Reading package lists... 118s Building dependency tree... 118s Reading state information... 118s Calculating upgrade...Starting pkgProblemResolver with broken count: 0 118s Starting 2 pkgProblemResolver with broken count: 0 118s Done 119s Entering ResolveByKeep 119s 119s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 119s Reading package lists... 119s Building dependency tree... 119s Reading state information... 119s Starting pkgProblemResolver with broken count: 0 119s Starting 2 pkgProblemResolver with broken count: 0 119s Done 120s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 121s autopkgtest [17:32:41]: testbed running kernel: Linux 6.8.0-60-generic #63-Ubuntu SMP Tue Apr 15 19:06:00 UTC 2025 122s autopkgtest [17:32:42]: @@@@@@@@@@@@@@@@@@@@ apt-source libnginx-mod-http-echo 123s Get:1 http://ftpmaster.internal/ubuntu noble/universe libnginx-mod-http-echo 1:0.63-6build2 (dsc) [2184 B] 123s Get:2 http://ftpmaster.internal/ubuntu noble/universe libnginx-mod-http-echo 1:0.63-6build2 (tar) [53.4 kB] 123s Get:3 http://ftpmaster.internal/ubuntu noble/universe libnginx-mod-http-echo 1:0.63-6build2 (diff) [3956 B] 123s gpgv: Signature made Wed Apr 17 12:25:00 2024 UTC 123s gpgv: using RSA key 8AFD08D3D1B817B2DF8982F501AC4B4083590A98 123s gpgv: Can't check signature: No public key 123s dpkg-source: warning: cannot verify inline signature for ./libnginx-mod-http-echo_0.63-6build2.dsc: no acceptable signature found 123s autopkgtest [17:32:43]: testing package libnginx-mod-http-echo version 1:0.63-6build2 123s autopkgtest [17:32:43]: build not needed 124s autopkgtest [17:32:44]: test generic: preparing testbed 124s Reading package lists... 124s Building dependency tree... 124s Reading state information... 124s Starting pkgProblemResolver with broken count: 0 124s Starting 2 pkgProblemResolver with broken count: 0 124s Done 124s The following NEW packages will be installed: 124s libnginx-mod-http-echo libnginx-mod-http-geoip2 124s libnginx-mod-http-image-filter libnginx-mod-http-xslt-filter 124s libnginx-mod-mail libnginx-mod-stream libnginx-mod-stream-geoip2 libxslt1.1 124s nginx nginx-common nginx-core 125s 0 upgraded, 11 newly installed, 0 to remove and 0 not upgraded. 125s Need to get 1201 kB of archives. 125s After this operation, 3879 kB of additional disk space will be used. 125s Get:1 http://ftpmaster.internal/ubuntu noble-proposed/main ppc64el nginx-common all 1.24.0-2ubuntu7.4 [43.4 kB] 125s Get:2 http://ftpmaster.internal/ubuntu noble-proposed/main ppc64el nginx ppc64el 1.24.0-2ubuntu7.4 [699 kB] 125s Get:3 http://ftpmaster.internal/ubuntu noble/universe ppc64el libnginx-mod-http-echo ppc64el 1:0.63-6build2 [23.9 kB] 125s Get:4 http://ftpmaster.internal/ubuntu noble-proposed/main ppc64el libnginx-mod-stream ppc64el 1.24.0-2ubuntu7.4 [101 kB] 125s Get:5 http://ftpmaster.internal/ubuntu noble/main ppc64el libnginx-mod-http-geoip2 ppc64el 1:3.4-5build2 [10.7 kB] 125s Get:6 http://ftpmaster.internal/ubuntu noble-proposed/main ppc64el libnginx-mod-http-image-filter ppc64el 1.24.0-2ubuntu7.4 [26.6 kB] 125s Get:7 http://ftpmaster.internal/ubuntu noble-updates/main ppc64el libxslt1.1 ppc64el 1.1.39-0exp1ubuntu0.24.04.2 [190 kB] 125s Get:8 http://ftpmaster.internal/ubuntu noble-proposed/main ppc64el libnginx-mod-http-xslt-filter ppc64el 1.24.0-2ubuntu7.4 [25.2 kB] 125s Get:9 http://ftpmaster.internal/ubuntu noble-proposed/main ppc64el libnginx-mod-mail ppc64el 1.24.0-2ubuntu7.4 [65.4 kB] 125s Get:10 http://ftpmaster.internal/ubuntu noble/main ppc64el libnginx-mod-stream-geoip2 ppc64el 1:3.4-5build2 [10.3 kB] 125s Get:11 http://ftpmaster.internal/ubuntu noble-proposed/main ppc64el nginx-core all 1.24.0-2ubuntu7.4 [4692 B] 125s Preconfiguring packages ... 125s Fetched 1201 kB in 0s (3846 kB/s) 125s Selecting previously unselected package nginx-common. 126s (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 ... 72925 files and directories currently installed.) 126s Preparing to unpack .../00-nginx-common_1.24.0-2ubuntu7.4_all.deb ... 126s Unpacking nginx-common (1.24.0-2ubuntu7.4) ... 126s Selecting previously unselected package nginx. 126s Preparing to unpack .../01-nginx_1.24.0-2ubuntu7.4_ppc64el.deb ... 126s Unpacking nginx (1.24.0-2ubuntu7.4) ... 126s Selecting previously unselected package libnginx-mod-http-echo. 126s Preparing to unpack .../02-libnginx-mod-http-echo_1%3a0.63-6build2_ppc64el.deb ... 126s Unpacking libnginx-mod-http-echo (1:0.63-6build2) ... 126s Selecting previously unselected package libnginx-mod-stream. 126s Preparing to unpack .../03-libnginx-mod-stream_1.24.0-2ubuntu7.4_ppc64el.deb ... 126s Unpacking libnginx-mod-stream (1.24.0-2ubuntu7.4) ... 126s Selecting previously unselected package libnginx-mod-http-geoip2. 126s Preparing to unpack .../04-libnginx-mod-http-geoip2_1%3a3.4-5build2_ppc64el.deb ... 126s Unpacking libnginx-mod-http-geoip2 (1:3.4-5build2) ... 126s Selecting previously unselected package libnginx-mod-http-image-filter. 126s Preparing to unpack .../05-libnginx-mod-http-image-filter_1.24.0-2ubuntu7.4_ppc64el.deb ... 126s Unpacking libnginx-mod-http-image-filter (1.24.0-2ubuntu7.4) ... 126s Selecting previously unselected package libxslt1.1:ppc64el. 126s Preparing to unpack .../06-libxslt1.1_1.1.39-0exp1ubuntu0.24.04.2_ppc64el.deb ... 126s Unpacking libxslt1.1:ppc64el (1.1.39-0exp1ubuntu0.24.04.2) ... 126s Selecting previously unselected package libnginx-mod-http-xslt-filter. 126s Preparing to unpack .../07-libnginx-mod-http-xslt-filter_1.24.0-2ubuntu7.4_ppc64el.deb ... 126s Unpacking libnginx-mod-http-xslt-filter (1.24.0-2ubuntu7.4) ... 126s Selecting previously unselected package libnginx-mod-mail. 126s Preparing to unpack .../08-libnginx-mod-mail_1.24.0-2ubuntu7.4_ppc64el.deb ... 126s Unpacking libnginx-mod-mail (1.24.0-2ubuntu7.4) ... 126s Selecting previously unselected package libnginx-mod-stream-geoip2. 126s Preparing to unpack .../09-libnginx-mod-stream-geoip2_1%3a3.4-5build2_ppc64el.deb ... 126s Unpacking libnginx-mod-stream-geoip2 (1:3.4-5build2) ... 126s Selecting previously unselected package nginx-core. 126s Preparing to unpack .../10-nginx-core_1.24.0-2ubuntu7.4_all.deb ... 126s Unpacking nginx-core (1.24.0-2ubuntu7.4) ... 126s Setting up nginx-common (1.24.0-2ubuntu7.4) ... 126s Created symlink /etc/systemd/system/multi-user.target.wants/nginx.service → /usr/lib/systemd/system/nginx.service. 127s Setting up libxslt1.1:ppc64el (1.1.39-0exp1ubuntu0.24.04.2) ... 127s Setting up nginx (1.24.0-2ubuntu7.4) ... 128s * Upgrading binary nginx  [ OK ] 128s Setting up libnginx-mod-http-image-filter (1.24.0-2ubuntu7.4) ... 128s Setting up libnginx-mod-stream (1.24.0-2ubuntu7.4) ... 128s Setting up libnginx-mod-http-xslt-filter (1.24.0-2ubuntu7.4) ... 128s Setting up libnginx-mod-http-echo (1:0.63-6build2) ... 128s Setting up libnginx-mod-http-geoip2 (1:3.4-5build2) ... 128s Setting up libnginx-mod-stream-geoip2 (1:3.4-5build2) ... 128s Setting up libnginx-mod-mail (1.24.0-2ubuntu7.4) ... 128s Setting up nginx-core (1.24.0-2ubuntu7.4) ... 128s Processing triggers for ufw (0.36.2-6) ... 128s Processing triggers for man-db (2.12.0-4build2) ... 128s Processing triggers for libc-bin (2.39-0ubuntu8.4) ... 128s Processing triggers for nginx (1.24.0-2ubuntu7.4) ... 128s Triggering nginx reload ... 129s autopkgtest [17:32:49]: test generic: [----------------------- 129s curl after installation: http status=response_code: 503, ... FAILED 129s nginx reload ... OK 134s curl after reload: http status=response_code: 503, ... FAILED 135s nginx restart ... OK 140s curl after restart: http status=response_code: 503, ... FAILED 140s === journalctl === 140s Jun 13 17:32:46 autopkgtest systemd[1]: Starting nginx.service - A high performance web server and a reverse proxy server... 140s ░░ Subject: A start job for unit nginx.service has begun execution 140s ░░ Defined-By: systemd 140s ░░ Support: http://www.ubuntu.com/support 140s ░░ 140s ░░ A start job for unit nginx.service has begun execution. 140s ░░ 140s ░░ The job identifier is 904. 140s Jun 13 17:32:46 autopkgtest systemd[1]: Started nginx.service - A high performance web server and a reverse proxy server. 140s ░░ Subject: A start job for unit nginx.service has finished successfully 140s ░░ Defined-By: systemd 140s ░░ Support: http://www.ubuntu.com/support 140s ░░ 140s ░░ A start job for unit nginx.service has finished successfully. 140s ░░ 140s ░░ The job identifier is 904. 140s Jun 13 17:32:48 autopkgtest systemd[1]: Reloading nginx.service - A high performance web server and a reverse proxy server... 140s ░░ Subject: A reload job for unit nginx.service has begun execution 140s ░░ Defined-By: systemd 140s ░░ Support: http://www.ubuntu.com/support 140s ░░ 140s ░░ A reload job for unit nginx.service has begun execution. 140s ░░ 140s ░░ The job identifier is 984. 140s Jun 13 17:32:48 autopkgtest nginx[2244]: 2025/06/13 17:32:48 [notice] 2244#2244: signal process started 140s Jun 13 17:32:48 autopkgtest systemd[1]: Reloaded nginx.service - A high performance web server and a reverse proxy server. 140s ░░ Subject: A reload job for unit nginx.service has finished 140s ░░ Defined-By: systemd 140s ░░ Support: http://www.ubuntu.com/support 140s ░░ 140s ░░ A reload job for unit nginx.service has finished. 140s ░░ 140s ░░ The job identifier is 984 and the job result is done. 140s Jun 13 17:32:49 autopkgtest systemd[1]: Reloading nginx.service - A high performance web server and a reverse proxy server... 140s ░░ Subject: A reload job for unit nginx.service has begun execution 140s ░░ Defined-By: systemd 140s ░░ Support: http://www.ubuntu.com/support 140s ░░ 140s ░░ A reload job for unit nginx.service has begun execution. 140s ░░ 140s ░░ The job identifier is 985. 140s Jun 13 17:32:49 autopkgtest nginx[2330]: 2025/06/13 17:32:49 [notice] 2330#2330: signal process started 140s Jun 13 17:32:49 autopkgtest systemd[1]: Reloaded nginx.service - A high performance web server and a reverse proxy server. 140s ░░ Subject: A reload job for unit nginx.service has finished 140s ░░ Defined-By: systemd 140s ░░ Support: http://www.ubuntu.com/support 140s ░░ 140s ░░ A reload job for unit nginx.service has finished. 140s ░░ 140s ░░ The job identifier is 985 and the job result is done. 140s Jun 13 17:32:54 autopkgtest systemd[1]: Stopping nginx.service - A high performance web server and a reverse proxy server... 140s ░░ Subject: A stop job for unit nginx.service has begun execution 140s ░░ Defined-By: systemd 140s ░░ Support: http://www.ubuntu.com/support 140s ░░ 140s ░░ A stop job for unit nginx.service has begun execution. 140s ░░ 140s ░░ The job identifier is 986. 140s Jun 13 17:32:54 autopkgtest systemd[1]: nginx.service: Deactivated successfully. 140s ░░ Subject: Unit succeeded 140s ░░ Defined-By: systemd 140s ░░ Support: http://www.ubuntu.com/support 140s ░░ 140s ░░ The unit nginx.service has successfully entered the 'dead' state. 140s Jun 13 17:32:54 autopkgtest systemd[1]: Stopped nginx.service - A high performance web server and a reverse proxy server. 140s ░░ Subject: A stop job for unit nginx.service has finished 140s ░░ Defined-By: systemd 140s ░░ Support: http://www.ubuntu.com/support 140s ░░ 140s ░░ A stop job for unit nginx.service has finished. 140s ░░ 140s ░░ The job identifier is 986 and the job result is done. 140s Jun 13 17:32:54 autopkgtest systemd[1]: Starting nginx.service - A high performance web server and a reverse proxy server... 140s ░░ Subject: A start job for unit nginx.service has begun execution 140s ░░ Defined-By: systemd 140s ░░ Support: http://www.ubuntu.com/support 140s ░░ 140s ░░ A start job for unit nginx.service has begun execution. 140s ░░ 140s ░░ The job identifier is 986. 140s Jun 13 17:32:54 autopkgtest systemd[1]: Started nginx.service - A high performance web server and a reverse proxy server. 140s ░░ Subject: A start job for unit nginx.service has finished successfully 140s ░░ Defined-By: systemd 140s ░░ Support: http://www.ubuntu.com/support 140s ░░ 140s ░░ A start job for unit nginx.service has finished successfully. 140s ░░ 140s ░░ The job identifier is 986. 140s === error.log === 140s 2025/06/13 17:32:46 [notice] 2150#2150: using inherited sockets from "5;6;" 140s autopkgtest [17:33:00]: test generic: -----------------------] 140s generic FAIL non-zero exit status 1 140s autopkgtest [17:33:00]: test generic: - - - - - - - - - - results - - - - - - - - - - 141s autopkgtest [17:33:01]: test helloworld: preparing testbed 141s Reading package lists... 141s Building dependency tree... 141s Reading state information... 141s Starting pkgProblemResolver with broken count: 0 141s Starting 2 pkgProblemResolver with broken count: 0 141s Done 141s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 142s autopkgtest [17:33:02]: test helloworld: [----------------------- 142s nginx: the configuration file /etc/nginx/nginx.conf syntax is ok 142s nginx: configuration file /etc/nginx/nginx.conf test is successful 142s % Total % Received % Xferd Average Speed Time Time Time Current 142s Dload Upload Total Spent Left Speed 142s 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0 0 3627 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0 142s curl: (22) The requested URL returned error: 503 142s autopkgtest [17:33:02]: test helloworld: -----------------------] 143s autopkgtest [17:33:03]: test helloworld: - - - - - - - - - - results - - - - - - - - - - 143s helloworld FAIL non-zero exit status 22 143s autopkgtest [17:33:03]: @@@@@@@@@@@@@@@@@@@@ summary 143s generic FAIL non-zero exit status 1 143s helloworld FAIL non-zero exit status 22 147s nova [W] Using flock in prodstack7-ppc64el 147s flock: timeout while waiting to get lock 147s Creating nova instance adt-noble-ppc64el-libnginx-mod-http-echo-20250613-173040-juju-7f2275-prod-proposed-migration-environment-20-4cedc531-dee3-490a-915f-2ac87418f5ff from image adt/ubuntu-noble-ppc64el-server-20250613.img (UUID cfbe7026-2f3a-4ff6-9b46-985b8faeb49b)... 147s nova [W] Timed out waiting for 71718299-a2d9-4761-a9cd-3d25fccf9898 to get deleted.