0s autopkgtest [07:31:31]: starting date and time: 2024-03-24 07:31:31+0000
0s autopkgtest [07:31:31]: git checkout: 4a1cd702 l/adt_testbed: don't blame the testbed for unsolvable build deps
0s autopkgtest [07:31:31]: host juju-7f2275-prod-proposed-migration-environment-3; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.j6e1m9mh/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --setup-commands /home/ubuntu/autopkgtest/setup-commands/setup-testbed --apt-pocket=proposed=src:curl,src:gnutls28,src:libpsl,src:nettle,src:openssl,src:orthanc-python --apt-upgrade gssproxy --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 '--env=ADT_TEST_TRIGGERS=curl/8.5.0-2ubuntu8 gnutls28/3.8.3-1.1ubuntu2 libpsl/0.21.2-1.1 nettle/3.9.1-2.2 openssl/3.0.13-0ubuntu2 orthanc-python/4.1+ds-2build3' -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-3@lcy02-90.secgroup --name adt-noble-amd64-gssproxy-20240324-073131-juju-7f2275-prod-proposed-migration-environment-3 --image adt/ubuntu-noble-amd64-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-3 --net-id=net_prod-proposed-migration -e TERM=linux -e ''"'"'http_proxy=http://squid.internal:3128'"'"'' -e ''"'"'https_proxy=http://squid.internal:3128'"'"'' -e ''"'"'no_proxy=127.0.0.1,127.0.1.1,login.ubuntu.com,localhost,localdomain,novalocal,internal,archive.ubuntu.com,ports.ubuntu.com,security.ubuntu.com,ddebs.ubuntu.com,changelogs.ubuntu.com,launchpadlibrarian.net,launchpadcontent.net,launchpad.net,10.24.0.0/24,keystone.ps5.canonical.com,objectstorage.prodstack5.canonical.com'"'"'' --mirror=http://ftpmaster.internal/ubuntu/
883s autopkgtest [07:46:14]: testbed dpkg architecture: amd64
883s autopkgtest [07:46:14]: testbed apt version: 2.7.12
883s autopkgtest [07:46:14]: @@@@@@@@@@@@@@@@@@@@ test bed setup
883s Get:1 http://ftpmaster.internal/ubuntu noble-proposed InRelease [117 kB]
883s Get:2 http://ftpmaster.internal/ubuntu noble-proposed/multiverse Sources [56.9 kB]
883s Get:3 http://ftpmaster.internal/ubuntu noble-proposed/main Sources [494 kB]
883s Get:4 http://ftpmaster.internal/ubuntu noble-proposed/restricted Sources [6540 B]
883s Get:5 http://ftpmaster.internal/ubuntu noble-proposed/universe Sources [4004 kB]
883s Get:6 http://ftpmaster.internal/ubuntu noble-proposed/main amd64 Packages [724 kB]
883s Get:7 http://ftpmaster.internal/ubuntu noble-proposed/main i386 Packages [486 kB]
883s Get:8 http://ftpmaster.internal/ubuntu noble-proposed/main amd64 c-n-f Metadata [3508 B]
883s Get:9 http://ftpmaster.internal/ubuntu noble-proposed/restricted i386 Packages [6700 B]
883s Get:10 http://ftpmaster.internal/ubuntu noble-proposed/restricted amd64 Packages [30.5 kB]
883s Get:11 http://ftpmaster.internal/ubuntu noble-proposed/restricted amd64 c-n-f Metadata [116 B]
883s Get:12 http://ftpmaster.internal/ubuntu noble-proposed/universe i386 Packages [1301 kB]
883s Get:13 http://ftpmaster.internal/ubuntu noble-proposed/universe amd64 Packages [4449 kB]
883s Get:14 http://ftpmaster.internal/ubuntu noble-proposed/universe amd64 c-n-f Metadata [9396 B]
883s Get:15 http://ftpmaster.internal/ubuntu noble-proposed/multiverse i386 Packages [27.1 kB]
883s Get:16 http://ftpmaster.internal/ubuntu noble-proposed/multiverse amd64 Packages [96.1 kB]
883s Get:17 http://ftpmaster.internal/ubuntu noble-proposed/multiverse amd64 c-n-f Metadata [196 B]
886s Fetched 11.8 MB in 1s (8500 kB/s)
887s Reading package lists...
888s Reading package lists...
888s Building dependency tree...
888s Reading state information...
889s Calculating upgrade...
889s The following packages will be REMOVED:
889s libssl3
889s The following NEW packages will be installed:
889s libssl3t64
889s The following packages have been kept back:
889s curl
889s The following packages will be upgraded:
889s libc-bin libc6 locales openssl
889s 4 upgraded, 1 newly installed, 1 to remove and 1 not upgraded.
889s Need to get 11.1 MB of archives.
889s After this operation, 140 kB of additional disk space will be used.
889s Get:1 http://ftpmaster.internal/ubuntu noble/main amd64 libc6 amd64 2.39-0ubuntu6 [3262 kB]
889s Get:2 http://ftpmaster.internal/ubuntu noble/main amd64 libc-bin amd64 2.39-0ubuntu6 [682 kB]
889s Get:3 http://ftpmaster.internal/ubuntu noble-proposed/main amd64 openssl amd64 3.0.13-0ubuntu2 [1002 kB]
889s Get:4 http://ftpmaster.internal/ubuntu noble-proposed/main amd64 libssl3t64 amd64 3.0.13-0ubuntu2 [1936 kB]
889s Get:5 http://ftpmaster.internal/ubuntu noble/main amd64 locales all 2.39-0ubuntu6 [4232 kB]
889s Preconfiguring packages ...
890s Fetched 11.1 MB in 0s (101 MB/s)
890s (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 ... 71864 files and directories currently installed.)
890s Preparing to unpack .../libc6_2.39-0ubuntu6_amd64.deb ...
890s Unpacking libc6:amd64 (2.39-0ubuntu6) over (2.39-0ubuntu2) ...
890s Setting up libc6:amd64 (2.39-0ubuntu6) ...
891s (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 ... 71864 files and directories currently installed.)
891s Preparing to unpack .../libc-bin_2.39-0ubuntu6_amd64.deb ...
891s Unpacking libc-bin (2.39-0ubuntu6) over (2.39-0ubuntu2) ...
891s Setting up libc-bin (2.39-0ubuntu6) ...
891s (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 ... 71864 files and directories currently installed.)
891s Preparing to unpack .../openssl_3.0.13-0ubuntu2_amd64.deb ...
891s Unpacking openssl (3.0.13-0ubuntu2) over (3.0.10-1ubuntu4) ...
891s dpkg: libssl3:amd64: dependency problems, but removing anyway as you requested:
891s wget depends on libssl3 (>= 3.0.0).
891s tnftp depends on libssl3 (>= 3.0.0).
891s tcpdump depends on libssl3 (>= 3.0.0).
891s systemd-resolved depends on libssl3 (>= 3.0.0).
891s systemd depends on libssl3 (>= 3.0.0).
891s sudo depends on libssl3 (>= 3.0.0).
891s sbsigntool depends on libssl3 (>= 3.0.0).
891s rsync depends on libssl3 (>= 3.0.0).
891s python3-cryptography depends on libssl3 (>= 3.0.0).
891s openssh-server depends on libssl3 (>= 3.0.10).
891s openssh-client depends on libssl3 (>= 3.0.10).
891s mokutil depends on libssl3 (>= 3.0.0).
891s linux-headers-6.8.0-11-generic depends on libssl3 (>= 3.0.0).
891s libtss2-esys-3.0.2-0:amd64 depends on libssl3 (>= 3.0.0).
891s libsystemd-shared:amd64 depends on libssl3 (>= 3.0.0).
891s libssh-4:amd64 depends on libssl3 (>= 3.0.0).
891s libsasl2-modules:amd64 depends on libssl3 (>= 3.0.0).
891s libsasl2-2:amd64 depends on libssl3 (>= 3.0.0).
891s libpython3.12-minimal:amd64 depends on libssl3 (>= 3.0.0).
891s libpython3.11-minimal:amd64 depends on libssl3 (>= 3.0.0).
891s libnvme1 depends on libssl3 (>= 3.0.0).
891s libkrb5-3:amd64 depends on libssl3 (>= 3.0.0).
891s libkmod2:amd64 depends on libssl3 (>= 3.0.0).
891s libfido2-1:amd64 depends on libssl3 (>= 3.0.0).
891s libcurl4:amd64 depends on libssl3 (>= 3.0.0).
891s libcryptsetup12:amd64 depends on libssl3 (>= 3.0.0).
891s kmod depends on libssl3 (>= 3.0.0).
891s dhcpcd-base depends on libssl3 (>= 3.0.0).
891s coreutils depends on libssl3 (>= 3.0.0).
891s bind9-libs:amd64 depends on libssl3 (>= 3.0.0).
891s
891s (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 ... 71864 files and directories currently installed.)
891s Removing libssl3:amd64 (3.0.10-1ubuntu4) ...
891s Selecting previously unselected package libssl3t64:amd64.
891s (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 ... 71853 files and directories currently installed.)
891s Preparing to unpack .../libssl3t64_3.0.13-0ubuntu2_amd64.deb ...
891s Unpacking libssl3t64:amd64 (3.0.13-0ubuntu2) ...
891s Setting up libssl3t64:amd64 (3.0.13-0ubuntu2) ...
891s (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 ... 71866 files and directories currently installed.)
891s Preparing to unpack .../locales_2.39-0ubuntu6_all.deb ...
891s Unpacking locales (2.39-0ubuntu6) over (2.39-0ubuntu2) ...
891s Setting up locales (2.39-0ubuntu6) ...
892s Generating locales (this might take a while)...
893s en_US.UTF-8... done
893s Generation complete.
893s Setting up openssl (3.0.13-0ubuntu2) ...
893s Processing triggers for man-db (2.12.0-3) ...
895s Processing triggers for libc-bin (2.39-0ubuntu6) ...
895s Reading package lists...
895s Building dependency tree...
895s Reading state information...
895s 0 upgraded, 0 newly installed, 0 to remove and 1 not upgraded.
896s sh: Attempting to set up Debian/Ubuntu apt sources automatically
896s sh: Distribution appears to be Ubuntu
897s Reading package lists...
897s Building dependency tree...
897s Reading state information...
897s eatmydata is already the newest version (131-1).
897s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
897s Reading package lists...
898s Building dependency tree...
898s Reading state information...
898s dbus is already the newest version (1.14.10-4ubuntu1).
898s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
898s Reading package lists...
898s Building dependency tree...
898s Reading state information...
898s rng-tools-debian is already the newest version (2.4).
898s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
898s Reading package lists...
899s Building dependency tree...
899s Reading state information...
899s The following packages will be REMOVED:
899s cloud-init* python3-configobj* python3-debconf*
899s 0 upgraded, 0 newly installed, 3 to remove and 0 not upgraded.
899s After this operation, 3256 kB disk space will be freed.
899s (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 ... 71866 files and directories currently installed.)
899s Removing cloud-init (24.1.2-0ubuntu1) ...
900s Removing python3-configobj (5.0.8-3) ...
900s Removing python3-debconf (1.5.86) ...
900s Processing triggers for man-db (2.12.0-3) ...
900s (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 ... 71477 files and directories currently installed.)
900s Purging configuration files for cloud-init (24.1.2-0ubuntu1) ...
901s dpkg: warning: while removing cloud-init, directory '/etc/cloud/cloud.cfg.d' not empty so not removed
901s Processing triggers for rsyslog (8.2312.0-3ubuntu3) ...
901s invoke-rc.d: policy-rc.d denied execution of try-restart.
901s Reading package lists...
901s Building dependency tree...
901s Reading state information...
901s linux-generic is already the newest version (6.8.0-11.11+1).
901s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
902s Hit:1 http://ftpmaster.internal/ubuntu noble InRelease
902s Hit:2 http://ftpmaster.internal/ubuntu noble-updates InRelease
902s Hit:3 http://ftpmaster.internal/ubuntu noble-security InRelease
904s Reading package lists...
904s Reading package lists...
904s Building dependency tree...
904s Reading state information...
904s Calculating upgrade...
904s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
904s Reading package lists...
904s Building dependency tree...
904s Reading state information...
905s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
905s autopkgtest [07:46:36]: rebooting testbed after setup commands that affected boot
923s autopkgtest [07:46:54]: testbed running kernel: Linux 6.8.0-11-generic #11-Ubuntu SMP PREEMPT_DYNAMIC Wed Feb 14 00:29:05 UTC 2024
923s autopkgtest [07:46:54]: @@@@@@@@@@@@@@@@@@@@ apt-source gssproxy
924s Get:1 http://ftpmaster.internal/ubuntu noble/universe gssproxy 0.9.2-2 (dsc) [1699 B]
924s Get:2 http://ftpmaster.internal/ubuntu noble/universe gssproxy 0.9.2-2 (tar) [190 kB]
924s Get:3 http://ftpmaster.internal/ubuntu noble/universe gssproxy 0.9.2-2 (diff) [6864 B]
924s gpgv: Signature made Fri Jan 12 10:48:47 2024 UTC
924s gpgv: using EDDSA key A3CC9C870B9D310ABAD4CF2F51722B08FE4745A2
924s gpgv: issuer "simon@josefsson.org"
924s gpgv: Can't check signature: No public key
924s dpkg-source: warning: cannot verify inline signature for ./gssproxy_0.9.2-2.dsc: no acceptable signature found
924s autopkgtest [07:46:55]: testing package gssproxy version 0.9.2-2
925s autopkgtest [07:46:56]: build not needed
925s autopkgtest [07:46:56]: test gssproxy-apache: preparing testbed
929s Reading package lists...
930s Building dependency tree...
930s Reading state information...
930s Starting pkgProblemResolver with broken count: 0
930s Starting 2 pkgProblemResolver with broken count: 0
930s Done
931s The following additional packages will be installed:
931s apache2 apache2-bin apache2-data apache2-utils gssproxy krb5-admin-server
931s krb5-config krb5-kdc krb5-user libapache2-mod-auth-gssapi libapr1
931s libaprutil1 libaprutil1-dbd-sqlite3 libaprutil1-ldap libbasicobjects0
931s libcollection4 libevent-2.1-7 libgssrpc4 libini-config5 libkadm5clnt-mit12
931s libkadm5srv-mit12 libkdb5-10 liblua5.4-0 libpath-utils1 libref-array1
931s libverto-libevent1 libverto1
931s Suggested packages:
931s apache2-doc apache2-suexec-pristine | apache2-suexec-custom www-browser
931s krb5-kdc-ldap krb5-kpropd krb5-k5tls krb5-doc
931s Recommended packages:
931s ssl-cert
931s The following NEW packages will be installed:
931s apache2 apache2-bin apache2-data apache2-utils autopkgtest-satdep gssproxy
931s krb5-admin-server krb5-config krb5-kdc krb5-user libapache2-mod-auth-gssapi
931s libapr1 libaprutil1 libaprutil1-dbd-sqlite3 libaprutil1-ldap
931s libbasicobjects0 libcollection4 libevent-2.1-7 libgssrpc4 libini-config5
931s libkadm5clnt-mit12 libkadm5srv-mit12 libkdb5-10 liblua5.4-0 libpath-utils1
931s libref-array1 libverto-libevent1 libverto1
931s 0 upgraded, 28 newly installed, 0 to remove and 0 not upgraded.
931s Need to get 3098 kB/3098 kB of archives.
931s After this operation, 11.4 MB of additional disk space will be used.
931s Get:1 /tmp/autopkgtest.7dOYWm/1-autopkgtest-satdep.deb autopkgtest-satdep amd64 0 [752 B]
931s Get:2 http://ftpmaster.internal/ubuntu noble/main amd64 libapr1 amd64 1.7.2-3 [107 kB]
931s Get:3 http://ftpmaster.internal/ubuntu noble/main amd64 libaprutil1 amd64 1.6.3-1ubuntu1 [91.6 kB]
931s Get:4 http://ftpmaster.internal/ubuntu noble/main amd64 libaprutil1-dbd-sqlite3 amd64 1.6.3-1ubuntu1 [11.3 kB]
931s Get:5 http://ftpmaster.internal/ubuntu noble/main amd64 libaprutil1-ldap amd64 1.6.3-1ubuntu1 [9172 B]
931s Get:6 http://ftpmaster.internal/ubuntu noble/main amd64 liblua5.4-0 amd64 5.4.6-3 [166 kB]
931s Get:7 http://ftpmaster.internal/ubuntu noble/main amd64 apache2-bin amd64 2.4.58-1ubuntu2 [1328 kB]
931s Get:8 http://ftpmaster.internal/ubuntu noble/main amd64 apache2-data all 2.4.58-1ubuntu2 [163 kB]
931s Get:9 http://ftpmaster.internal/ubuntu noble/main amd64 apache2-utils amd64 2.4.58-1ubuntu2 [95.7 kB]
931s Get:10 http://ftpmaster.internal/ubuntu noble/main amd64 apache2 amd64 2.4.58-1ubuntu2 [90.2 kB]
931s Get:11 http://ftpmaster.internal/ubuntu noble/main amd64 krb5-config all 2.7 [22.0 kB]
931s Get:12 http://ftpmaster.internal/ubuntu noble/main amd64 libgssrpc4 amd64 1.20.1-5build1 [57.0 kB]
931s Get:13 http://ftpmaster.internal/ubuntu noble/main amd64 libkadm5clnt-mit12 amd64 1.20.1-5build1 [40.2 kB]
931s Get:14 http://ftpmaster.internal/ubuntu noble/main amd64 libkdb5-10 amd64 1.20.1-5build1 [39.9 kB]
931s Get:15 http://ftpmaster.internal/ubuntu noble/main amd64 libkadm5srv-mit12 amd64 1.20.1-5build1 [53.2 kB]
931s Get:16 http://ftpmaster.internal/ubuntu noble/universe amd64 krb5-user amd64 1.20.1-5build1 [109 kB]
931s Get:17 http://ftpmaster.internal/ubuntu noble/main amd64 libevent-2.1-7 amd64 2.1.12-stable-9 [144 kB]
931s Get:18 http://ftpmaster.internal/ubuntu noble/main amd64 libverto1 amd64 0.3.1-1ubuntu5 [10.4 kB]
931s Get:19 http://ftpmaster.internal/ubuntu noble/main amd64 libverto-libevent1 amd64 0.3.1-1ubuntu5 [5962 B]
931s Get:20 http://ftpmaster.internal/ubuntu noble/universe amd64 krb5-kdc amd64 1.20.1-5build1 [180 kB]
931s Get:21 http://ftpmaster.internal/ubuntu noble/universe amd64 krb5-admin-server amd64 1.20.1-5build1 [96.5 kB]
931s Get:22 http://ftpmaster.internal/ubuntu noble/main amd64 libbasicobjects0 amd64 0.6.2-2 [5562 B]
931s Get:23 http://ftpmaster.internal/ubuntu noble/main amd64 libcollection4 amd64 0.6.2-2 [22.9 kB]
931s Get:24 http://ftpmaster.internal/ubuntu noble/main amd64 libpath-utils1 amd64 0.6.2-2 [8590 B]
931s Get:25 http://ftpmaster.internal/ubuntu noble/main amd64 libref-array1 amd64 0.6.2-2 [7114 B]
931s Get:26 http://ftpmaster.internal/ubuntu noble/main amd64 libini-config5 amd64 0.6.2-2 [43.3 kB]
931s Get:27 http://ftpmaster.internal/ubuntu noble/universe amd64 gssproxy amd64 0.9.2-2 [125 kB]
931s Get:28 http://ftpmaster.internal/ubuntu noble/universe amd64 libapache2-mod-auth-gssapi amd64 1.6.4-3 [64.5 kB]
931s Preconfiguring packages ...
932s Fetched 3098 kB in 0s (29.1 MB/s)
932s Selecting previously unselected package libapr1:amd64.
932s (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 ... 71422 files and directories currently installed.)
932s Preparing to unpack .../00-libapr1_1.7.2-3_amd64.deb ...
932s Unpacking libapr1:amd64 (1.7.2-3) ...
932s Selecting previously unselected package libaprutil1:amd64.
932s Preparing to unpack .../01-libaprutil1_1.6.3-1ubuntu1_amd64.deb ...
932s Unpacking libaprutil1:amd64 (1.6.3-1ubuntu1) ...
932s Selecting previously unselected package libaprutil1-dbd-sqlite3:amd64.
932s Preparing to unpack .../02-libaprutil1-dbd-sqlite3_1.6.3-1ubuntu1_amd64.deb ...
932s Unpacking libaprutil1-dbd-sqlite3:amd64 (1.6.3-1ubuntu1) ...
932s Selecting previously unselected package libaprutil1-ldap:amd64.
932s Preparing to unpack .../03-libaprutil1-ldap_1.6.3-1ubuntu1_amd64.deb ...
932s Unpacking libaprutil1-ldap:amd64 (1.6.3-1ubuntu1) ...
932s Selecting previously unselected package liblua5.4-0:amd64.
932s Preparing to unpack .../04-liblua5.4-0_5.4.6-3_amd64.deb ...
932s Unpacking liblua5.4-0:amd64 (5.4.6-3) ...
932s Selecting previously unselected package apache2-bin.
932s Preparing to unpack .../05-apache2-bin_2.4.58-1ubuntu2_amd64.deb ...
932s Unpacking apache2-bin (2.4.58-1ubuntu2) ...
932s Selecting previously unselected package apache2-data.
932s Preparing to unpack .../06-apache2-data_2.4.58-1ubuntu2_all.deb ...
932s Unpacking apache2-data (2.4.58-1ubuntu2) ...
932s Selecting previously unselected package apache2-utils.
932s Preparing to unpack .../07-apache2-utils_2.4.58-1ubuntu2_amd64.deb ...
932s Unpacking apache2-utils (2.4.58-1ubuntu2) ...
932s Selecting previously unselected package apache2.
932s Preparing to unpack .../08-apache2_2.4.58-1ubuntu2_amd64.deb ...
932s Unpacking apache2 (2.4.58-1ubuntu2) ...
932s Selecting previously unselected package krb5-config.
932s Preparing to unpack .../09-krb5-config_2.7_all.deb ...
932s Unpacking krb5-config (2.7) ...
932s Selecting previously unselected package libgssrpc4:amd64.
932s Preparing to unpack .../10-libgssrpc4_1.20.1-5build1_amd64.deb ...
932s Unpacking libgssrpc4:amd64 (1.20.1-5build1) ...
932s Selecting previously unselected package libkadm5clnt-mit12:amd64.
932s Preparing to unpack .../11-libkadm5clnt-mit12_1.20.1-5build1_amd64.deb ...
932s Unpacking libkadm5clnt-mit12:amd64 (1.20.1-5build1) ...
932s Selecting previously unselected package libkdb5-10:amd64.
932s Preparing to unpack .../12-libkdb5-10_1.20.1-5build1_amd64.deb ...
932s Unpacking libkdb5-10:amd64 (1.20.1-5build1) ...
932s Selecting previously unselected package libkadm5srv-mit12:amd64.
932s Preparing to unpack .../13-libkadm5srv-mit12_1.20.1-5build1_amd64.deb ...
932s Unpacking libkadm5srv-mit12:amd64 (1.20.1-5build1) ...
932s Selecting previously unselected package krb5-user.
932s Preparing to unpack .../14-krb5-user_1.20.1-5build1_amd64.deb ...
932s Unpacking krb5-user (1.20.1-5build1) ...
932s Selecting previously unselected package libevent-2.1-7:amd64.
932s Preparing to unpack .../15-libevent-2.1-7_2.1.12-stable-9_amd64.deb ...
932s Unpacking libevent-2.1-7:amd64 (2.1.12-stable-9) ...
932s Selecting previously unselected package libverto1:amd64.
932s Preparing to unpack .../16-libverto1_0.3.1-1ubuntu5_amd64.deb ...
932s Unpacking libverto1:amd64 (0.3.1-1ubuntu5) ...
932s Selecting previously unselected package libverto-libevent1:amd64.
932s Preparing to unpack .../17-libverto-libevent1_0.3.1-1ubuntu5_amd64.deb ...
932s Unpacking libverto-libevent1:amd64 (0.3.1-1ubuntu5) ...
932s Selecting previously unselected package krb5-kdc.
932s Preparing to unpack .../18-krb5-kdc_1.20.1-5build1_amd64.deb ...
932s Unpacking krb5-kdc (1.20.1-5build1) ...
932s Selecting previously unselected package krb5-admin-server.
932s Preparing to unpack .../19-krb5-admin-server_1.20.1-5build1_amd64.deb ...
932s Unpacking krb5-admin-server (1.20.1-5build1) ...
932s Selecting previously unselected package libbasicobjects0:amd64.
932s Preparing to unpack .../20-libbasicobjects0_0.6.2-2_amd64.deb ...
932s Unpacking libbasicobjects0:amd64 (0.6.2-2) ...
932s Selecting previously unselected package libcollection4:amd64.
932s Preparing to unpack .../21-libcollection4_0.6.2-2_amd64.deb ...
932s Unpacking libcollection4:amd64 (0.6.2-2) ...
932s Selecting previously unselected package libpath-utils1:amd64.
932s Preparing to unpack .../22-libpath-utils1_0.6.2-2_amd64.deb ...
932s Unpacking libpath-utils1:amd64 (0.6.2-2) ...
932s Selecting previously unselected package libref-array1:amd64.
932s Preparing to unpack .../23-libref-array1_0.6.2-2_amd64.deb ...
932s Unpacking libref-array1:amd64 (0.6.2-2) ...
932s Selecting previously unselected package libini-config5:amd64.
933s Preparing to unpack .../24-libini-config5_0.6.2-2_amd64.deb ...
933s Unpacking libini-config5:amd64 (0.6.2-2) ...
933s Selecting previously unselected package gssproxy.
933s Preparing to unpack .../25-gssproxy_0.9.2-2_amd64.deb ...
933s Unpacking gssproxy (0.9.2-2) ...
933s Selecting previously unselected package libapache2-mod-auth-gssapi.
933s Preparing to unpack .../26-libapache2-mod-auth-gssapi_1.6.4-3_amd64.deb ...
933s Unpacking libapache2-mod-auth-gssapi (1.6.4-3) ...
933s Selecting previously unselected package autopkgtest-satdep.
933s Preparing to unpack .../27-1-autopkgtest-satdep.deb ...
933s Unpacking autopkgtest-satdep (0) ...
933s Setting up libpath-utils1:amd64 (0.6.2-2) ...
933s Setting up libbasicobjects0:amd64 (0.6.2-2) ...
933s Setting up libapr1:amd64 (1.7.2-3) ...
933s Setting up libgssrpc4:amd64 (1.20.1-5build1) ...
933s Setting up krb5-config (2.7) ...
933s Setting up libevent-2.1-7:amd64 (2.1.12-stable-9) ...
933s Setting up libcollection4:amd64 (0.6.2-2) ...
933s Setting up liblua5.4-0:amd64 (5.4.6-3) ...
933s Setting up libref-array1:amd64 (0.6.2-2) ...
933s Setting up apache2-data (2.4.58-1ubuntu2) ...
933s Setting up libkadm5clnt-mit12:amd64 (1.20.1-5build1) ...
933s Setting up libaprutil1:amd64 (1.6.3-1ubuntu1) ...
933s Setting up libkdb5-10:amd64 (1.20.1-5build1) ...
933s Setting up libini-config5:amd64 (0.6.2-2) ...
933s Setting up libaprutil1-ldap:amd64 (1.6.3-1ubuntu1) ...
933s Setting up libaprutil1-dbd-sqlite3:amd64 (1.6.3-1ubuntu1) ...
933s Setting up libkadm5srv-mit12:amd64 (1.20.1-5build1) ...
933s Setting up apache2-utils (2.4.58-1ubuntu2) ...
933s Setting up apache2-bin (2.4.58-1ubuntu2) ...
933s Setting up krb5-user (1.20.1-5build1) ...
933s update-alternatives: using /usr/bin/kinit.mit to provide /usr/bin/kinit (kinit) in auto mode
933s update-alternatives: using /usr/bin/klist.mit to provide /usr/bin/klist (klist) in auto mode
933s update-alternatives: using /usr/bin/kswitch.mit to provide /usr/bin/kswitch (kswitch) in auto mode
933s update-alternatives: using /usr/bin/ksu.mit to provide /usr/bin/ksu (ksu) in auto mode
933s update-alternatives: using /usr/bin/kpasswd.mit to provide /usr/bin/kpasswd (kpasswd) in auto mode
933s update-alternatives: using /usr/bin/kdestroy.mit to provide /usr/bin/kdestroy (kdestroy) in auto mode
933s update-alternatives: using /usr/bin/kadmin.mit to provide /usr/bin/kadmin (kadmin) in auto mode
933s update-alternatives: using /usr/bin/ktutil.mit to provide /usr/bin/ktutil (ktutil) in auto mode
933s Setting up libapache2-mod-auth-gssapi (1.6.4-3) ...
933s Package apache2 is not configured yet. Will defer actions by package libapache2-mod-auth-gssapi.
933s Setting up apache2 (2.4.58-1ubuntu2) ...
933s Enabling module mpm_event.
933s Enabling module authz_core.
933s Enabling module authz_host.
933s Enabling module authn_core.
933s Enabling module auth_basic.
933s Enabling module access_compat.
933s Enabling module authn_file.
933s Enabling module authz_user.
933s Enabling module alias.
933s Enabling module dir.
933s Enabling module autoindex.
933s Enabling module env.
933s Enabling module mime.
933s Enabling module negotiation.
933s Enabling module setenvif.
934s Enabling module filter.
934s Enabling module deflate.
934s Enabling module status.
934s Enabling module reqtimeout.
934s Enabling conf charset.
934s Enabling conf localized-error-pages.
934s Enabling conf other-vhosts-access-log.
934s Enabling conf security.
934s Enabling conf serve-cgi-bin.
934s Enabling site 000-default.
934s info: Executing deferred 'a2enmod auth_gssapi' for package libapache2-mod-auth-gssapi
934s Enabling module auth_gssapi.
935s Created symlink /etc/systemd/system/multi-user.target.wants/apache2.service → /usr/lib/systemd/system/apache2.service.
935s Created symlink /etc/systemd/system/multi-user.target.wants/apache-htcacheclean.service → /usr/lib/systemd/system/apache-htcacheclean.service.
936s Setting up libverto-libevent1:amd64 (0.3.1-1ubuntu5) ...
936s Setting up libverto1:amd64 (0.3.1-1ubuntu5) ...
936s Setting up gssproxy (0.9.2-2) ...
936s Created symlink /etc/systemd/user/sockets.target.wants/gssuserproxy.socket → /usr/lib/systemd/user/gssuserproxy.socket.
936s Created symlink /etc/systemd/system/multi-user.target.wants/gssproxy.service → /usr/lib/systemd/system/gssproxy.service.
937s Setting up krb5-kdc (1.20.1-5build1) ...
937s Created symlink /etc/systemd/system/multi-user.target.wants/krb5-kdc.service → /usr/lib/systemd/system/krb5-kdc.service.
938s Could not execute systemctl: at /usr/bin/deb-systemd-invoke line 148.
938s Setting up krb5-admin-server (1.20.1-5build1) ...
938s Created symlink /etc/systemd/system/multi-user.target.wants/krb5-admin-server.service → /usr/lib/systemd/system/krb5-admin-server.service.
939s Setting up autopkgtest-satdep (0) ...
939s Processing triggers for libc-bin (2.39-0ubuntu6) ...
939s Processing triggers for ufw (0.36.2-5) ...
939s Processing triggers for man-db (2.12.0-3) ...
942s (Reading database ... 72330 files and directories currently installed.)
942s Removing autopkgtest-satdep (0) ...
942s autopkgtest [07:47:13]: test gssproxy-apache: [-----------------------
942s /usr/bin/ss
942s /usr/bin/id
942s /usr/bin/hostname
942s /usr/bin/dpkg
942s + command -v ss
942s + command -v id
942s + command -v hostname
942s + command -v dpkg
942s + dpkg -V krb5-kdc
942s + dpkg -V krb5-admin-server
942s + dpkg -V apache2
942s + dpkg -V libapache2-mod-auth-gssapi
942s + dpkg -V gssproxy
942s + dpkg -V curl
942s + service apache2 stop
943s + service krb5-kdc stop
944s /usr/bin/systemctl
944s + command -v systemctl
944s + service gssproxy stop
944s + export PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/games:/usr/local/games:/snap/bin:/sbin:/usr/sbin
944s + trap+ tail --pid=2339 -F /var/log/syslog
944s
944s set +e;
944s kdestroy
944s service apache2 stop
944s service krb5-kdc stop
944s for f in /tmp/out-*;
944s do echo ----- BEGIN FILE $f -----
944s cat $f
944s done
944s tail -v /var/log/apache2/error.log /var/log/apache2/access.log
944s mv /etc/krb5kdc/kdc.conf-gssproxysave /etc/krb5kdc/kdc.conf
944s mv /etc/krb5.conf-gssproxysave /etc/krb5.conf
944s mv /etc/gssproxy/gssproxy.conf-gssproxysave /etc/gssproxy/gssproxy.conf
944s rm /etc/gssproxy/80-gssproxy-autopkgtest.conf /etc/apache2/conf-enabled/gssproxy-autopkgtest.conf /etc/systemd/system/apache2.service.d/gssproxy-autopkgtest.conf /var/www/html/gssproxy-autopkgtest/foo /var/lib/krb5kdc/gssproxy-principal* /var/lib/krb5kdc/gssproxy-stash /etc/gssproxy/httpd.keytab
944s test -d /etc/systemd/system/apache2.service.d && rmdir /etc/systemd/system/apache2.service.d
944s rmdir /var/www/html/gssproxy-autopkgtest
944s 0 INT QUIT ABRT PIPE TERM
944s + id -un
944s + my_user=root
944s + hostname -f
944s + 2024-03-24T07:47:10.184435+00:00 adt-noble-amd64-gssproxy-20240324-073131-juju-7f2275-prod-propo (kadmind)[2201]: krb5-admin-server.service: Referenced but unset environment variable evaluates to an empty string: DAEMON_ARGS
944s 2024-03-24T07:47:10.187400+00:00 adt-noble-amd64-gssproxy-20240324-073131-juju-7f2275-prod-propo kadmind[2201]: kadmind: Cannot open DB2 database '/var/lib/krb5kdc/principal': No such file or directory while initializing, aborting
944s 2024-03-24T07:47:10.188245+00:00 adt-noble-amd64-gssproxy-20240324-073131-juju-7f2275-prod-propo systemd[1]: krb5-admin-server.service: Main process exited, code=exited, status=1/FAILURE
944s 2024-03-24T07:47:10.188292+00:00 adt-noble-amd64-gssproxy-20240324-073131-juju-7f2275-prod-propo systemd[1]: krb5-admin-server.service: Failed with result 'exit-code'.
944s 2024-03-24T07:47:14.330830+00:00 adt-noble-amd64-gssproxy-20240324-073131-juju-7f2275-prod-propo systemd[1]: Stopping apache2.service - The Apache HTTP Server...
944s 2024-03-24T07:47:14.369342+00:00 adt-noble-amd64-gssproxy-20240324-073131-juju-7f2275-prod-propo systemd[1]: apache2.service: Deactivated successfully.
944s 2024-03-24T07:47:14.369535+00:00 adt-noble-amd64-gssproxy-20240324-073131-juju-7f2275-prod-propo systemd[1]: Stopped apache2.service - The Apache HTTP Server.
944s 2024-03-24T07:47:15.569530+00:00 adt-noble-amd64-gssproxy-20240324-073131-juju-7f2275-prod-propo systemd[1]: Stopping gssproxy.service - GSSAPI Proxy Daemon...
944s 2024-03-24T07:47:15.572078+00:00 adt-noble-amd64-gssproxy-20240324-073131-juju-7f2275-prod-propo systemd[1]: gssproxy.service: Deactivated successfully.
944s 2024-03-24T07:47:15.572256+00:00 adt-noble-amd64-gssproxy-20240324-073131-juju-7f2275-prod-propo systemd[1]: Stopped gssproxy.service - GSSAPI Proxy Daemon.
944s my_hostname=adt-noble-amd64-gssproxy-20240324-073131-juju-7f2275-prod-propo.openstack.prodstack5.lan
944s + hostname -d
944s + my_domainname=openstack.prodstack5.lan
944s + test -f /etc/krb5kdc/kdc.conf-gssproxysave
944s + cp /etc/krb5kdc/kdc.conf /etc/krb5kdc/kdc.conf-gssproxysave
944s + cat
944s + test -f /etc/krb5.conf-gssproxysave
944s + cp /etc/krb5.conf /etc/krb5.conf-gssproxysave
944s + cat
944s + kdb5_util -P foo create -s
944s Initializing database '/var/lib/krb5kdc/gssproxy-principal' for realm 'GSSPROXY.EXAMPLE.ORG',
944s master key name 'K/M@GSSPROXY.EXAMPLE.ORG'
944s + kadmin.local addprinc -randkey HTTP/adt-noble-amd64-gssproxy-20240324-073131-juju-7f2275-prod-propo.openstack.prodstack5.lan
944s + kadmin.local addprinc -pw bar root
944s + kadmin.local ktadd -k /etc/gssproxy/httpd.keytab HTTP/adt-noble-amd64-gssproxy-20240324-073131-juju-7f2275-prod-propo.openstack.prodstack5.lan
944s Entry for principal HTTP/adt-noble-amd64-gssproxy-20240324-073131-juju-7f2275-prod-propo.openstack.prodstack5.lan with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/etc/gssproxy/httpd.keytab.
944s Entry for principal HTTP/adt-noble-amd64-gssproxy-20240324-073131-juju-7f2275-prod-propo.openstack.prodstack5.lan with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/etc/gssproxy/httpd.keytab.
944s + service krb5-kdc start
945s 2024-03-24T07:47:16.246780+00:00 adt-noble-amd64-gssproxy-20240324-073131-juju-7f2275-prod-propo systemd[1]: Starting krb5-kdc.service - Kerberos 5 Key Distribution Center...
945s 2024-03-24T07:47:16.270098+00:00 adt-noble-amd64-gssproxy-20240324-073131-juju-7f2275-prod-propo (krb5kdc)[2389]: krb5-kdc.service: Referenced but unset environment variable evaluates to an empty string: DAEMON_ARGS
945s + i=0
945s + ss -na
945s + + grep 0.0.0.0:176432024-03-24T07:47:16.278434+00:00 adt-noble-amd64-gssproxy-20240324-073131-juju-7f2275-prod-propo systemd[1]: Started krb5-kdc.service - Kerberos 5 Key Distribution Center.
945s grep LISTEN
945s
945s tcp LISTEN 0 5 0.0.0.0:17643 0.0.0.0:*
945s + kdestroy
945s kdestroy: No credentials cache found while destroying cache
945s + echo bar
945s + kinit root
945s Password for root@GSSPROXY.EXAMPLE.ORG:
945s + test -f /etc/gssproxy/gssproxy.conf-gssproxysave
945s + cp /etc/gssproxy/gssproxy.conf /etc/gssproxy/gssproxy.conf-gssproxysave
945s + cat
945s + cat
945s + command -v systemctl
945s + cat
945s + KRB5RCACHEDIR=/var/lib/gssproxy/rcache /usr/sbin/gssproxy -i --debug-level=2
945s /usr/bin/systemctl
945s + command -v systemctl
945s + mkdir -p /etc/systemd/system/apache2.service.d
945s /usr/bin/systemctl
945s + cat
945s + systemctl daemon-reload
945s 2024-03-24T07:47:16.822296+00:00 adt-noble-amd64-gssproxy-20240324-073131-juju-7f2275-prod-propo systemd[1]: Reloading requested from client PID 2416 ('systemctl') (unit session-1.scope)...
945s 2024-03-24T07:47:16.822381+00:00 adt-noble-amd64-gssproxy-20240324-073131-juju-7f2275-prod-propo systemd[1]: Reloading...
946s 2024-03-24T07:47:17.043547+00:00 adt-noble-amd64-gssproxy-20240324-073131-juju-7f2275-prod-propo systemd[1]: Reloading finished in 222 ms.
946s + service apache2 start
946s 2024-03-24T07:47:17.714658+00:00 adt-noble-amd64-gssproxy-20240324-073131-juju-7f2275-prod-propo systemd[1]: Starting apache2.service - The Apache HTTP Server...
946s 2024-03-24T07:47:17.738866+00:00 adt-noble-amd64-gssproxy-20240324-073131-juju-7f2275-prod-propo systemd[1]: Started apache2.service - The Apache HTTP Server.
946s + mkdir -p /var/www/html/gssproxy-autopkgtest
946s + echo Ossifrage
946s + curl --verbose --negotiate -u : http://adt-noble-amd64-gssproxy-20240324-073131-juju-7f2275-prod-propo.openstack.prodstack5.lan/gssproxy-autopkgtest/foo
946s + grep Ossifrage /tmp/out-curl-out
946s + set +e
946s + kdestroy
946s + service apache2 stop
947s 2024-03-24T07:47:18.398761+00:00 adt-noble-amd64-gssproxy-20240324-073131-juju-7f2275-prod-propo systemd[1]: Stopping apache2.service - The Apache HTTP Server...
947s 2024-03-24T07:47:18.439442+00:00 adt-noble-amd64-gssproxy-20240324-073131-juju-7f2275-prod-propo systemd[1]: apache2.service: Deactivated successfully.
947s 2024-03-24T07:47:18.439801+00:00 adt-noble-amd64-gssproxy-20240324-073131-juju-7f2275-prod-propo systemd[1]: Stopped apache2.service - The Apache HTTP Server.
947s + service krb5-kdc stop
948s 2024-03-24T07:47:19.034490+00:00 adt-noble-amd64-gssproxy-20240324-073131-juju-7f2275-prod-propo systemd[1]: Stopping krb5-kdc.service - Kerberos 5 Key Distribution Center...
948s 2024-03-24T07:47:19.034877+00:00 adt-noble-amd64-gssproxy-20240324-073131-juju-7f2275-prod-propo systemd[1]: krb5-kdc.service: Deactivated successfully.
948s 2024-03-24T07:47:19.035095+00:00 adt-noble-amd64-gssproxy-20240324-073131-juju-7f2275-prod-propo systemd[1]: Stopped krb5-kdc.service - Kerberos 5 Key Distribution Center.
948s ----- BEGIN FILE /tmp/out-curl-err -----
948s + echo ----- BEGIN FILE /tmp/out-curl-err -----
948s + cat /tmp/out-curl-err
948s * Uses proxy env variable no_proxy == '127.0.0.1,127.0.1.1,login.ubuntu.com,localhost,localdomain,novalocal,internal,archive.ubuntu.com,ports.ubuntu.com,security.ubuntu.com,ddebs.ubuntu.com,changelogs.ubuntu.com,launchpadlibrarian.net,launchpadcontent.net,launchpad.net,10.24.0.0/24,keystone.ps5.canonical.com,objectstorage.prodstack5.canonical.com'
948s * Uses proxy env variable http_proxy == 'http://squid.internal:3128'
948s % Total % Received % Xferd Average Speed Time Time Time Current
948s Dload Upload Total Spent Left Speed
948s
0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0* Host squid.internal:3128 was resolved.
948s * IPv6: (none)
948s * IPv4: 185.125.188.86, 185.125.188.85
948s * Trying 185.125.188.86:3128...
948s * Connected to squid.internal (185.125.188.86) port 3128
948s * Server auth using Negotiate with user ''
948s > GET http://adt-noble-amd64-gssproxy-20240324-073131-juju-7f2275-prod-propo.openstack.prodstack5.lan/gssproxy-autopkgtest/foo HTTP/1.1
948s > Host: adt-noble-amd64-gssproxy-20240324-073131-juju-7f2275-prod-propo.openstack.prodstack5.lan
948s > Authorization: Negotiate YIIDXQYGKwYBBQUCoIIDUTCCA02gDTALBgkqhkiG9xIBAgKiggM6BIIDNmCCAzIGCSqGSIb3EgECAgEAboIDITCCAx2gAwIBBaEDAgEOogcDBQAgAAAAo4ICLWGCAikwggIloAMCAQWhFhsUR1NTUFJPWFkuRVhBTVBMRS5PUkeiazBpoAMCAQOhYjBgGwRIVFRQG1hhZHQtbm9ibGUtYW1kNjQtZ3NzcHJveHktMjAyNDAzMjQtMDczMTMxLWp1anUtN2YyMjc1LXByb2QtcHJvcG8ub3BlbnN0YWNrLnByb2RzdGFjazUubGFuo4IBlzCCAZOgAwIBEqEDAgECooIBhQSCAYGVIzI/sqoO9xCyHo0+O5jgSTpg4q1aWINu9r18PysqH3ezKEhY3vYMPekJXV+YyiSb3Qmd3WA5j/LnMHyKbSzi10SEt5X4Ma1JeotAeyUjQ3UWOOck5KziLlA/Lyqiqbdc56O7eNYAiLN+bt95xGmAMOq/1+BkYOYNJLmLWEeMmxdbYzIf6v0MmcoFtzCUXI32iySupWQJwzLivFzDib2QUPZ74OAzUS9buoHXoDJh3zJMEPZXJKh0m3zQK53+B/Y6BA1kwQxZrj+Rq3RX4T5RWOzX/r67j8i1lGoS3W/3U/MXuly/kze+K+1/lQ/8ObElqUtyriTvq+KCHg+NMIE7LPLfBqDqKCwIda07FKE9Me0r0KK07l5uwLVUeddA3snwrTsNRmPgi0Sw9cbujunt/Nwqttk6K5i8NLUsfuuvsKQyWBq0tCUGHYRmGjwxWnidFXSLcOr0eJaEUkBHZLQB1L0WrRgH67SLLLGvPQ9XEcNfx66KCPyWeu6P7sbTNOCvpIHWMIHToAMCARKigcsEgcjVmxJrOufljHHrxIhdnwdSbxQY+oIVAnAzjqvuJA20nkCv774OAK093zydjmtoXyartuEIDtyT8VGa63b3LrY+YfY54oQZ6Md/KD2kbgCig45XB14DktoD49l6WhsTiEhFPDBRAH6Z7L4Z2FL7RawJ+LLPMtkeol+J+cNi559nOMJuPoMiKQ0kkAjOkPv3FWTJ/jPFAygjspXV2grhf24NWOcPOVshtmMIya4Aoz1XIKUZIlGhvucJpmpbX5QH3424iN4yTg6wpA==
948s > User-Agent: curl/8.5.0
948s > Accept: */*
948s > Proxy-Connection: Keep-Alive
948s >
948s < HTTP/1.1 503 Service Unavailable
948s < Server: squid/4.10
948s < Mime-Version: 1.0
948s < Date: Sun, 24 Mar 2024 07:47:17 GMT
948s < Content-Type: text/html;charset=utf-8
948s < Content-Length: 5364
948s < X-Squid-Error: ERR_DNS_FAIL 0
948s < Vary: Accept-Language
948s < Content-Language: en
948s < X-Cache: MISS from juju-3536d5-prod-internal-proxy-2
948s < X-Cache-Lookup: MISS from juju-3536d5-prod-internal-proxy-2:3128
948s < Via: 1.1 juju-3536d5-prod-internal-proxy-2 (squid/4.10)
948s < Connection: keep-alive
948s <
948s { [5364 bytes data]
948s
100 5364 100 5364 0 0 274k 0 --:--:-- --:--:-- --:--:-- 291k
948s * Connection #0 to host squid.internal left intact
948s ----- BEGIN FILE /tmp/out-curl-out -----
948s + echo ----- BEGIN FILE /tmp/out-curl-out -----
948s + cat /tmp/out-curl-out
948s
948s
948s
948s
948s ERROR: The requested URL could not be retrieved
948s
948s
948s
948s
ERROR
948s The requested URL could not be retrieved
948s
948s
948s
948s
948s
The following error was encountered while trying to retrieve the URL: http://adt-noble-amd64-gssproxy-20240324-073131-juju-7f2275-prod-propo.openstack.prodstack5.lan/gssproxy-autopkgtest/foo
948s
948s
948s Unable to determine IP address from host name adt-noble-amd64-gssproxy-20240324-073131-juju-7f2275-prod-propo.openstack.prodstack5.lan
948s
948s
948s
The DNS server returned:
948s
948s Name Error: The domain name does not exist.
948s
948s
948s
This means that the cache was not able to resolve the hostname presented in the URL. Check if the address is correct.
948s
948s
Your cache administrator is webmaster.
948s
948s
948s
948s
948s
948s
948s ----- BEGIN FILE /tmp/out-gssproxy-err -----
948s + echo ----- BEGIN FILE /tmp/out-gssproxy-err -----
948s + cat /tmp/out-gssproxy-err
948s [2024/03/24 07:47:16]: Debug Level changed to 2
948s [2024/03/24 07:47:16]: Debug Level changed to 2
948s [2024/03/24 07:47:16]: Keytab /etc/krb5.keytab has no content (-1765328203)
948s [2024/03/24 07:47:16]: Service: nfs-server, Enckey: [ephemeral], Enctype: 18
948s [2024/03/24 07:47:16]: Service: HTTP, Keytab: /etc/gssproxy/httpd.keytab, Enctype: 18
948s [2024/03/24 07:47:16]: Kernel doesn't support GSS-Proxy (can't open /proc/net/rpc/use-gss-proxy: 2 (No such file or directory))
948s [2024/03/24 07:47:16]: Initialization complete.
948s [2024/03/24 07:47:17]: Client [2024/03/24 07:47:17]: (/usr/sbin/apache2) [2024/03/24 07:47:17]: connected (fd = 11)[2024/03/24 07:47:17]: (pid = 2461) (uid = 0) (gid = 0)[2024/03/24 07:47:17]:
948s [2024/03/24 07:47:17]: Total received bytes: 56
948s [2024/03/24 07:47:17]: Idle for: 1711266437 seconds
948s [CID 11][2024/03/24 07:47:17]: No matching service found
948s [2024/03/24 07:47:17]: Client [2024/03/24 07:47:17]: (/usr/sbin/apache2) [2024/03/24 07:47:17]: connected (fd = 11)[2024/03/24 07:47:17]: (pid = 2461) (uid = 0) (gid = 0)[2024/03/24 07:47:17]:
948s [2024/03/24 07:47:17]: Total received bytes: 60
948s [2024/03/24 07:47:17]: Idle for: 0 seconds
948s [CID 11][2024/03/24 07:47:17]: No matching service found
948s [2024/03/24 07:47:17]: Total received bytes: 112
948s [2024/03/24 07:47:17]: Idle for: 0 seconds
948s [2024/03/24 07:47:17]: Client [2024/03/24 07:47:17]: (/usr/sbin/apache2) [2024/03/24 07:47:17]: connected (fd = 11)[2024/03/24 07:47:17]: (pid = 2461) (uid = 0) (gid = 0)[2024/03/24 07:47:17]:
948s [2024/03/24 07:47:17]: Total received bytes: 168
948s [2024/03/24 07:47:17]: Idle for: 0 seconds
948s [CID 11][2024/03/24 07:47:17]: No matching service found
948s [2024/03/24 07:47:17]: Client [2024/03/24 07:47:17]: (/usr/sbin/apache2) [2024/03/24 07:47:17]: connected (fd = 11)[2024/03/24 07:47:17]: (pid = 2461) (uid = 0) (gid = 0)[2024/03/24 07:47:17]:
948s [2024/03/24 07:47:17]: Total received bytes: 172
948s [2024/03/24 07:47:17]: Idle for: 0 seconds
948s [2024/03/24 07:47:17]: Total received bytes: 224
948s [2024/03/24 07:47:17]: Idle for: 0 seconds
948s [CID 11][2024/03/24 07:47:17]: No matching service found
948s [2024/03/24 07:47:17]: Client [2024/03/24 07:47:17]: (/usr/sbin/apache2) [2024/03/24 07:47:17]: connected (fd = 11)[2024/03/24 07:47:17]: (pid = 2461) (uid = 0) (gid = 0)[2024/03/24 07:47:17]:
948s [2024/03/24 07:47:17]: Total received bytes: 280
948s [2024/03/24 07:47:17]: Idle for: 0 seconds
948s [CID 11][2024/03/24 07:47:17]: No matching service found
948s [2024/03/24 07:47:17]: Client [2024/03/24 07:47:17]: (/usr/sbin/apache2) [2024/03/24 07:47:17]: connected (fd = 11)[2024/03/24 07:47:17]: (pid = 2461) (uid = 0) (gid = 0)[2024/03/24 07:47:17]:
948s [CID 11][2024/03/24 07:47:17]: No matching service found
948s [2024/03/24 07:47:17]: Total received bytes: 336
948s [2024/03/24 07:47:17]: Idle for: 0 seconds
948s [2024/03/24 07:47:17]: Client [2024/03/24 07:47:17]: (/usr/sbin/apache2) [2024/03/24 07:47:17]: connected (fd = 11)[2024/03/24 07:47:17]: (pid = 2461) (uid = 0) (gid = 0)[2024/03/24 07:47:17]:
948s [2024/03/24 07:47:17]: Total received bytes: 392
948s [2024/03/24 07:47:17]: Idle for: 0 seconds
948s [CID 11][2024/03/24 07:47:17]: No matching service found
948s [2024/03/24 07:47:17]: Client [2024/03/24 07:47:17]: (/usr/sbin/apache2) [2024/03/24 07:47:17]: connected (fd = 11)[2024/03/24 07:47:17]: (pid = 2461) (uid = 0) (gid = 0)[2024/03/24 07:47:17]:
948s [2024/03/24 07:47:17]: Total received bytes: 448
948s [2024/03/24 07:47:17]: Idle for: 0 seconds
948s [CID 11][2024/03/24 07:47:17]: No matching service found
948s [2024/03/24 07:47:17]: Client [2024/03/24 07:47:17]: (/usr/sbin/apache2) [2024/03/24 07:47:17]: connected (fd = 11)[2024/03/24 07:47:17]: (pid = 2461) (uid = 0) (gid = 0)[2024/03/24 07:47:17]:
948s [2024/03/24 07:47:17]: Total received bytes: 452
948s [2024/03/24 07:47:17]: Idle for: 0 seconds
948s [CID 11][2024/03/24 07:47:17]: No matching service found
948s [2024/03/24 07:47:17]: Total received bytes: 504
948s [2024/03/24 07:47:17]: Idle for: 0 seconds
948s [2024/03/24 07:47:18]: Client [2024/03/24 07:47:18]: (/usr/sbin/apache2) [2024/03/24 07:47:18]: connected (fd = 11)[2024/03/24 07:47:18]: (pid = 2533) (uid = 0) (gid = 0)[2024/03/24 07:47:18]:
948s [2024/03/24 07:47:18]: Total received bytes: 508
948s [2024/03/24 07:47:18]: Idle for: 1 seconds
948s [2024/03/24 07:47:18]: Total received bytes: 560
948s [2024/03/24 07:47:18]: Idle for: 0 seconds
948s [CID 11][2024/03/24 07:47:18]: No matching service found
948s [2024/03/24 07:47:18]: Client [2024/03/24 07:47:18]: (/usr/sbin/apache2) [2024/03/24 07:47:18]: connected (fd = 11)[2024/03/24 07:47:18]: (pid = 2533) (uid = 0) (gid = 0)[2024/03/24 07:47:18]:
948s [2024/03/24 07:47:18]: Total received bytes: 564
948s [2024/03/24 07:47:18]: Idle for: 0 seconds
948s [2024/03/24 07:47:18]: Total received bytes: 616
948s [2024/03/24 07:47:18]: Idle for: 0 seconds
948s [CID 11][2024/03/24 07:47:18]: No matching service found
948s [2024/03/24 07:47:18]: Client [2024/03/24 07:47:18]: (/usr/sbin/apache2) [2024/03/24 07:47:18]: connected (fd = 11)[2024/03/24 07:47:18]: (pid = 2533) (uid = 0) (gid = 0)[2024/03/24 07:47:18]:
948s [2024/03/24 07:47:18]: Total received bytes: 620
948s [2024/03/24 07:47:18]: Idle for: 0 seconds
948s [CID 11][2024/03/24 07:47:18]: No matching service found
948s [2024/03/24 07:47:18]: Total received bytes: 672
948s [2024/03/24 07:47:18]: Idle for: 0 seconds
948s [2024/03/24 07:47:18]: Client [2024/03/24 07:47:18]: (/usr/sbin/apache2) [2024/03/24 07:47:18]: connected (fd = 11)[2024/03/24 07:47:18]: (pid = 2533) (uid = 0) (gid = 0)[2024/03/24 07:47:18]:
948s [2024/03/24 07:47:18]: Total received bytes: 676
948s [2024/03/24 07:47:18]: Idle for: 0 seconds
948s [2024/03/24 07:47:18]: Total received bytes: 728
948s [2024/03/24 07:47:18]: Idle for: 0 seconds
948s [CID 11][2024/03/24 07:47:18]: No matching service found
948s [2024/03/24 07:47:18]: Client [2024/03/24 07:47:18]: (/usr/sbin/apache2) [2024/03/24 07:47:18]: connected (fd = 11)[2024/03/24 07:47:18]: (pid = 2533) (uid = 0) (gid = 0)[2024/03/24 07:47:18]:
948s [2024/03/24 07:47:18]: Total received bytes: 732
948s [2024/03/24 07:47:18]: Idle for: 0 seconds
948s [2024/03/24 07:47:18]: Total received bytes: 784
948s [2024/03/24 07:47:18]: Idle for: 0 seconds
948s [CID 11][2024/03/24 07:47:18]: No matching service found
948s ----- BEGIN FILE /tmp/out-gssproxy-out -----
948s + echo ----- BEGIN FILE /tmp/out-gssproxy-out -----
948s + cat /tmp/out-gssproxy-out
948s + tail -v /var/log/apache2/error.log /var/log/apache2/access.log
948s ==> /var/log/apache2/error.log <==
948s [Sun Mar 24 07:47:06.462650 2024] [mpm_event:notice] [pid 1803:tid 131590381602688] AH00489: Apache/2.4.58 (Ubuntu) mod_auth_gssapi/1.6.4 configured -- resuming normal operations
948s [Sun Mar 24 07:47:06.462767 2024] [core:notice] [pid 1803:tid 131590381602688] AH00094: Command line: '/usr/sbin/apache2'
948s [Sun Mar 24 07:47:14.344669 2024] [mpm_event:notice] [pid 1803:tid 131590381602688] AH00492: caught SIGWINCH, shutting down gracefully
948s [Sun Mar 24 07:47:17.741299 2024] [mpm_event:notice] [pid 2462:tid 137572574631808] AH00489: Apache/2.4.58 (Ubuntu) mod_auth_gssapi/1.6.4 configured -- resuming normal operations
948s [Sun Mar 24 07:47:17.741403 2024] [core:notice] [pid 2462:tid 137572574631808] AH00094: Command line: '/usr/sbin/apache2'
948s [Sun Mar 24 07:47:18.414624 2024] [mpm_event:notice] [pid 2462:tid 137572574631808] AH00492: caught SIGWINCH, shutting down gracefully
948s
948s ==> /var/log/apache2/access.log <==
948s + mv /etc/krb5kdc/kdc.conf-gssproxysave /etc/krb5kdc/kdc.conf
948s + mv /etc/krb5.conf-gssproxysave /etc/krb5.conf
948s + mv /etc/gssproxy/gssproxy.conf-gssproxysave /etc/gssproxy/gssproxy.conf
948s + rm /etc/gssproxy/80-gssproxy-autopkgtest.conf /etc/apache2/conf-enabled/gssproxy-autopkgtest.conf /etc/systemd/system/apache2.service.d/gssproxy-autopkgtest.conf /var/www/html/gssproxy-autopkgtest/foo /var/lib/krb5kdc/gssproxy-principal /var/lib/krb5kdc/gssproxy-principal.kadm5 /var/lib/krb5kdc/gssproxy-principal.kadm5.lock /var/lib/krb5kdc/gssproxy-principal.ok /var/lib/krb5kdc/gssproxy-stash /etc/gssproxy/httpd.keytab
948s rm: cannot remove '/var/lib/krb5kdc/gssproxy-stash': No such file or directory
948s + test -d /etc/systemd/system/apache2.service.d
948s + rmdir /etc/systemd/system/apache2.service.d
948s + rmdir /var/www/html/gssproxy-autopkgtest
948s /tmp/autopkgtest.7dOYWm/wrapper.sh: Killing leaked background processes: 2371
948s PID TTY STAT TIME COMMAND
948s 2371 ? S 0:00 tail --pid=2339 -F /var/log/syslog
948s autopkgtest [07:47:19]: test gssproxy-apache: -----------------------]
948s autopkgtest [07:47:19]: test gssproxy-apache: - - - - - - - - - - results - - - - - - - - - -
948s gssproxy-apache FAIL non-zero exit status 1
948s autopkgtest [07:47:19]: @@@@@@@@@@@@@@@@@@@@ summary
948s gssproxy-apache FAIL non-zero exit status 1
960s Creating nova instance adt-noble-amd64-gssproxy-20240324-073131-juju-7f2275-prod-proposed-migration-environment-3 from image adt/ubuntu-noble-amd64-server-20240323.img (UUID 5df8a563-0957-4fdd-8453-862df650aaf8)...