0s autopkgtest [20:02:59]: starting date and time: 2024-07-18 20:02:59+0000 0s autopkgtest [20:02:59]: git checkout: fd3bed09 nova: allow more retries for quota issues 0s autopkgtest [20:02:59]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.qpjzjly4/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:python-uvicorn --apt-upgrade python-uvicorn --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=python-uvicorn/0.30.1-1 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@bos01-s390x-6.secgroup --name adt-oracular-s390x-python-uvicorn-20240718-200256-juju-7f2275-prod-proposed-migration-environment-2-f87aa781-3cd1-4e06-979c-fee7f6433d96 --image adt/ubuntu-oracular-s390x-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-2 --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,keyserver.ubuntu.com,launchpadlibrarian.net,launchpadcontent.net,launchpad.net,10.24.0.0/24,keystone.ps5.canonical.com,objectstorage.prodstack5.canonical.com'"'"'' --mirror=http://us.ports.ubuntu.com/ubuntu-ports/ 112s autopkgtest [20:04:51]: testbed dpkg architecture: s390x 112s autopkgtest [20:04:51]: testbed apt version: 2.9.6 112s autopkgtest [20:04:51]: @@@@@@@@@@@@@@@@@@@@ test bed setup 115s Get:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease [126 kB] 115s Get:2 http://ftpmaster.internal/ubuntu oracular-proposed/main Sources [45.5 kB] 115s Get:3 http://ftpmaster.internal/ubuntu oracular-proposed/universe Sources [353 kB] 115s Get:4 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse Sources [2576 B] 115s Get:5 http://ftpmaster.internal/ubuntu oracular-proposed/restricted Sources [8548 B] 115s Get:6 http://ftpmaster.internal/ubuntu oracular-proposed/main s390x Packages [67.7 kB] 115s Get:7 http://ftpmaster.internal/ubuntu oracular-proposed/main s390x c-n-f Metadata [2112 B] 115s Get:8 http://ftpmaster.internal/ubuntu oracular-proposed/restricted s390x Packages [1368 B] 115s Get:9 http://ftpmaster.internal/ubuntu oracular-proposed/restricted s390x c-n-f Metadata [120 B] 115s Get:10 http://ftpmaster.internal/ubuntu oracular-proposed/universe s390x Packages [329 kB] 115s Get:11 http://ftpmaster.internal/ubuntu oracular-proposed/universe s390x c-n-f Metadata [8372 B] 115s Get:12 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse s390x Packages [1448 B] 115s Get:13 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse s390x c-n-f Metadata [120 B] 116s Fetched 946 kB in 1s (1294 kB/s) 116s Reading package lists... 121s Reading package lists... 121s Building dependency tree... 121s Reading state information... 122s Calculating upgrade... 122s The following packages will be upgraded: 122s cpio krb5-locales libgssapi-krb5-2 libk5crypto3 libkrb5-3 libkrb5support0 122s s390-tools s390-tools-data s390-tools-signed 122s 9 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 122s Need to get 3953 kB of archives. 122s After this operation, 77.8 kB disk space will be freed. 122s Get:1 http://ftpmaster.internal/ubuntu oracular/main s390x krb5-locales all 1.21.3-3 [14.3 kB] 122s Get:2 http://ftpmaster.internal/ubuntu oracular/main s390x libgssapi-krb5-2 s390x 1.21.3-3 [146 kB] 122s Get:3 http://ftpmaster.internal/ubuntu oracular/main s390x libkrb5-3 s390x 1.21.3-3 [352 kB] 122s Get:4 http://ftpmaster.internal/ubuntu oracular/main s390x libkrb5support0 s390x 1.21.3-3 [34.8 kB] 122s Get:5 http://ftpmaster.internal/ubuntu oracular/main s390x libk5crypto3 s390x 1.21.3-3 [89.5 kB] 122s Get:6 http://ftpmaster.internal/ubuntu oracular/main s390x cpio s390x 2.15+dfsg-1ubuntu3 [87.9 kB] 122s Get:7 http://ftpmaster.internal/ubuntu oracular/main s390x s390-tools-data all 2.33.1-0ubuntu4 [18.9 kB] 122s Get:8 http://ftpmaster.internal/ubuntu oracular/main s390x s390-tools s390x 2.33.1-0ubuntu4 [3198 kB] 123s Get:9 http://ftpmaster.internal/ubuntu oracular/main s390x s390-tools-signed all 2.33.1-0ubuntu4 [12.3 kB] 123s Fetched 3953 kB in 1s (5110 kB/s) 123s (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 ... 54720 files and directories currently installed.) 123s Preparing to unpack .../0-krb5-locales_1.21.3-3_all.deb ... 123s Unpacking krb5-locales (1.21.3-3) over (1.20.1-6ubuntu2) ... 123s Preparing to unpack .../1-libgssapi-krb5-2_1.21.3-3_s390x.deb ... 123s Unpacking libgssapi-krb5-2:s390x (1.21.3-3) over (1.20.1-6ubuntu2) ... 123s Preparing to unpack .../2-libkrb5-3_1.21.3-3_s390x.deb ... 123s Unpacking libkrb5-3:s390x (1.21.3-3) over (1.20.1-6ubuntu2) ... 123s Preparing to unpack .../3-libkrb5support0_1.21.3-3_s390x.deb ... 123s Unpacking libkrb5support0:s390x (1.21.3-3) over (1.20.1-6ubuntu2) ... 123s Preparing to unpack .../4-libk5crypto3_1.21.3-3_s390x.deb ... 123s Unpacking libk5crypto3:s390x (1.21.3-3) over (1.20.1-6ubuntu2) ... 123s Preparing to unpack .../5-cpio_2.15+dfsg-1ubuntu3_s390x.deb ... 123s Unpacking cpio (2.15+dfsg-1ubuntu3) over (2.15+dfsg-1ubuntu2) ... 123s Preparing to unpack .../6-s390-tools-data_2.33.1-0ubuntu4_all.deb ... 123s Unpacking s390-tools-data (2.33.1-0ubuntu4) over (2.33.1-0ubuntu3) ... 123s Preparing to unpack .../7-s390-tools_2.33.1-0ubuntu4_s390x.deb ... 123s Unpacking s390-tools (2.33.1-0ubuntu4) over (2.33.1-0ubuntu3) ... 123s Preparing to unpack .../8-s390-tools-signed_2.33.1-0ubuntu4_all.deb ... 123s Unpacking s390-tools-signed (2.33.1-0ubuntu4) over (2.33.1-0ubuntu3) ... 123s Setting up cpio (2.15+dfsg-1ubuntu3) ... 123s Setting up krb5-locales (1.21.3-3) ... 123s Setting up libkrb5support0:s390x (1.21.3-3) ... 123s Setting up s390-tools-signed (2.33.1-0ubuntu4) ... 123s Setting up libk5crypto3:s390x (1.21.3-3) ... 123s Setting up libkrb5-3:s390x (1.21.3-3) ... 123s Setting up s390-tools-data (2.33.1-0ubuntu4) ... 123s Setting up libgssapi-krb5-2:s390x (1.21.3-3) ... 123s Setting up s390-tools (2.33.1-0ubuntu4) ... 124s Processing triggers for libc-bin (2.39-0ubuntu9) ... 124s Processing triggers for man-db (2.12.1-2) ... 125s Processing triggers for initramfs-tools (0.142ubuntu30) ... 125s update-initramfs: Generating /boot/initrd.img-6.8.0-31-generic 125s W: No lz4 in /usr/bin:/sbin:/bin, using gzip 129s Using config file '/etc/zipl.conf' 129s Building bootmap in '/boot' 129s Adding IPL section 'ubuntu' (default) 129s Preparing boot device for LD-IPL: vda (0000). 129s Done. 129s Reading package lists... 129s Building dependency tree... 129s Reading state information... 130s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 130s Hit:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease 130s Hit:2 http://ftpmaster.internal/ubuntu oracular InRelease 130s Hit:3 http://ftpmaster.internal/ubuntu oracular-updates InRelease 130s Hit:4 http://ftpmaster.internal/ubuntu oracular-security InRelease 131s Reading package lists... 131s Reading package lists... 131s Building dependency tree... 131s Reading state information... 131s Calculating upgrade... 132s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 132s Reading package lists... 132s Building dependency tree... 132s Reading state information... 132s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 132s autopkgtest [20:05:11]: rebooting testbed after setup commands that affected boot 166s autopkgtest-virt-ssh: WARNING: ssh connection failed. Retrying in 3 seconds... 174s autopkgtest [20:05:53]: testbed running kernel: Linux 6.8.0-31-generic #31-Ubuntu SMP Sat Apr 20 00:14:26 UTC 2024 177s autopkgtest [20:05:56]: @@@@@@@@@@@@@@@@@@@@ apt-source python-uvicorn 181s Get:1 http://ftpmaster.internal/ubuntu oracular-proposed/universe python-uvicorn 0.30.1-1 (dsc) [2337 B] 181s Get:2 http://ftpmaster.internal/ubuntu oracular-proposed/universe python-uvicorn 0.30.1-1 (tar) [723 kB] 181s Get:3 http://ftpmaster.internal/ubuntu oracular-proposed/universe python-uvicorn 0.30.1-1 (diff) [7360 B] 181s gpgv: Signature made Thu Jul 18 08:04:21 2024 UTC 181s gpgv: using RSA key A954A54575BCED49240A725CFFD3C88B997DD16A 181s gpgv: Can't check signature: No public key 181s dpkg-source: warning: cannot verify inline signature for ./python-uvicorn_0.30.1-1.dsc: no acceptable signature found 181s autopkgtest [20:06:00]: testing package python-uvicorn version 0.30.1-1 182s autopkgtest [20:06:01]: build not needed 185s autopkgtest [20:06:04]: test unittests: preparing testbed 187s Reading package lists... 187s Building dependency tree... 187s Reading state information... 187s Starting pkgProblemResolver with broken count: 0 187s Starting 2 pkgProblemResolver with broken count: 0 187s Done 188s The following additional packages will be installed: 188s autoconf automake autopoint autotools-dev build-essential cpp cpp-13 188s cpp-13-s390x-linux-gnu cpp-s390x-linux-gnu debhelper debugedit dh-autoreconf 188s dh-python dh-strip-nondeterminism dwz fonts-font-awesome fonts-lato g++ 188s g++-13 g++-13-s390x-linux-gnu g++-s390x-linux-gnu gcc gcc-13 gcc-13-base 188s gcc-13-s390x-linux-gnu gcc-s390x-linux-gnu gettext ghp-import help2man 188s intltool-debian javascript-common libarchive-zip-perl libasan8 libatomic1 188s libcc1-0 libdebhelper-perl libfile-stripnondeterminism-perl libgcc-13-dev 188s libgomp1 libhttp-parser2.9 libisl23 libitm1 libjs-bootstrap4 188s libjs-highlight.js libjs-jquery libjs-lunr libjs-modernizr libjs-popper.js 188s libjs-sphinxdoc libjs-underscore libmpc3 libstdc++-13-dev libtool libubsan1 188s m4 mkdocs po-debconf pybuild-plugin-pyproject python-uvicorn-doc 188s python3-a2wsgi python3-all python3-anyio python3-async-generator 188s python3-build python3-click python3-colorama python3-dateutil python3-dotenv 188s python3-h11 python3-hatchling python3-httpcore python3-httptools 188s python3-httpx python3-iniconfig python3-installer python3-joblib 188s python3-livereload python3-lunr python3-markdown python3-mergedeep 188s python3-nltk python3-packaging python3-pathspec python3-platformdirs 188s python3-pluggy python3-pymdownx python3-pyproject-hooks python3-pytest 188s python3-pytest-asyncio python3-pytest-mock python3-pyyaml-env-tag 188s python3-regex python3-sniffio python3-toml python3-tornado python3-tqdm 188s python3-trove-classifiers python3-trustme python3-uvicorn python3-uvloop 188s python3-watchdog python3-watchfiles python3-websockets python3-wheel 188s python3-wsproto sphinx-rtd-theme-common uvicorn 188s Suggested packages: 188s autoconf-archive gnu-standards autoconf-doc cpp-doc gcc-13-locales 188s cpp-13-doc dh-make flit gcc-13-doc gcc-multilib manpages-dev flex bison gdb 188s gcc-doc gdb-s390x-linux-gnu gettext-doc libasprintf-dev libgettextpo-dev 188s apache2 | lighttpd | httpd libjs-es5-shim libstdc++-13-doc libtool-doc 188s gfortran | fortran95-compiler gcj-jdk m4-doc mkdocs-doc nodejs 188s libmail-box-perl python3-pip python3-venv python-build-doc 188s python-installer-doc coffeescript node-less node-uglify 188s python-livereload-doc python3-django python3-flask python3-slimmer 188s python-lunr-doc python-markdown-doc python-pytest-mock-doc python3-pycurl 188s python-tornado-doc python3-twisted 188s Recommended packages: 188s libarchive-cpio-perl node-jquery libltdl-dev libmail-sendmail-perl 188s python3-numpy python3-simplejson python3-psutil python3-pyinotify prover9 188s python3-tk 188s The following NEW packages will be installed: 188s autoconf automake autopkgtest-satdep autopoint autotools-dev build-essential 188s cpp cpp-13 cpp-13-s390x-linux-gnu cpp-s390x-linux-gnu debhelper debugedit 188s dh-autoreconf dh-python dh-strip-nondeterminism dwz fonts-font-awesome 188s fonts-lato g++ g++-13 g++-13-s390x-linux-gnu g++-s390x-linux-gnu gcc gcc-13 188s gcc-13-base gcc-13-s390x-linux-gnu gcc-s390x-linux-gnu gettext ghp-import 188s help2man intltool-debian javascript-common libarchive-zip-perl libasan8 188s libatomic1 libcc1-0 libdebhelper-perl libfile-stripnondeterminism-perl 188s libgcc-13-dev libgomp1 libhttp-parser2.9 libisl23 libitm1 libjs-bootstrap4 188s libjs-highlight.js libjs-jquery libjs-lunr libjs-modernizr libjs-popper.js 188s libjs-sphinxdoc libjs-underscore libmpc3 libstdc++-13-dev libtool libubsan1 188s m4 mkdocs po-debconf pybuild-plugin-pyproject python-uvicorn-doc 188s python3-a2wsgi python3-all python3-anyio python3-async-generator 188s python3-build python3-click python3-colorama python3-dateutil python3-dotenv 188s python3-h11 python3-hatchling python3-httpcore python3-httptools 188s python3-httpx python3-iniconfig python3-installer python3-joblib 188s python3-livereload python3-lunr python3-markdown python3-mergedeep 188s python3-nltk python3-packaging python3-pathspec python3-platformdirs 188s python3-pluggy python3-pymdownx python3-pyproject-hooks python3-pytest 188s python3-pytest-asyncio python3-pytest-mock python3-pyyaml-env-tag 188s python3-regex python3-sniffio python3-toml python3-tornado python3-tqdm 188s python3-trove-classifiers python3-trustme python3-uvicorn python3-uvloop 188s python3-watchdog python3-watchfiles python3-websockets python3-wheel 188s python3-wsproto sphinx-rtd-theme-common uvicorn 188s 0 upgraded, 108 newly installed, 0 to remove and 0 not upgraded. 188s Need to get 63.7 MB/63.7 MB of archives. 188s After this operation, 208 MB of additional disk space will be used. 188s Get:1 /tmp/autopkgtest.3NsjGX/1-autopkgtest-satdep.deb autopkgtest-satdep s390x 0 [916 B] 188s Get:2 http://ftpmaster.internal/ubuntu oracular/main s390x fonts-lato all 2.015-1 [2781 kB] 189s Get:3 http://ftpmaster.internal/ubuntu oracular/main s390x m4 s390x 1.4.19-4build1 [256 kB] 189s Get:4 http://ftpmaster.internal/ubuntu oracular/main s390x autoconf all 2.71-3 [339 kB] 189s Get:5 http://ftpmaster.internal/ubuntu oracular/main s390x autotools-dev all 20220109.1 [44.9 kB] 189s Get:6 http://ftpmaster.internal/ubuntu oracular/main s390x automake all 1:1.16.5-1.3ubuntu1 [558 kB] 189s Get:7 http://ftpmaster.internal/ubuntu oracular/main s390x autopoint all 0.22.5-1 [616 kB] 189s Get:8 http://ftpmaster.internal/ubuntu oracular/main s390x gcc-13-base s390x 13.3.0-3ubuntu1 [50.8 kB] 189s Get:9 http://ftpmaster.internal/ubuntu oracular/main s390x libisl23 s390x 0.26-3build1 [713 kB] 189s Get:10 http://ftpmaster.internal/ubuntu oracular/main s390x libmpc3 s390x 1.3.1-1build1 [58.4 kB] 189s Get:11 http://ftpmaster.internal/ubuntu oracular/main s390x cpp-13-s390x-linux-gnu s390x 13.3.0-3ubuntu1 [8777 kB] 190s Get:12 http://ftpmaster.internal/ubuntu oracular/main s390x cpp-13 s390x 13.3.0-3ubuntu1 [1026 B] 190s Get:13 http://ftpmaster.internal/ubuntu oracular/main s390x cpp-s390x-linux-gnu s390x 4:13.3.0-2ubuntu2 [5388 B] 190s Get:14 http://ftpmaster.internal/ubuntu oracular/main s390x cpp s390x 4:13.3.0-2ubuntu2 [22.4 kB] 190s Get:15 http://ftpmaster.internal/ubuntu oracular/main s390x libcc1-0 s390x 14.1.0-4ubuntu2 [50.6 kB] 190s Get:16 http://ftpmaster.internal/ubuntu oracular/main s390x libgomp1 s390x 14.1.0-4ubuntu2 [150 kB] 190s Get:17 http://ftpmaster.internal/ubuntu oracular/main s390x libitm1 s390x 14.1.0-4ubuntu2 [30.9 kB] 190s Get:18 http://ftpmaster.internal/ubuntu oracular/main s390x libatomic1 s390x 14.1.0-4ubuntu2 [9428 B] 190s Get:19 http://ftpmaster.internal/ubuntu oracular/main s390x libasan8 s390x 14.1.0-4ubuntu2 [2965 kB] 190s Get:20 http://ftpmaster.internal/ubuntu oracular/main s390x libubsan1 s390x 14.1.0-4ubuntu2 [1184 kB] 190s Get:21 http://ftpmaster.internal/ubuntu oracular/main s390x libgcc-13-dev s390x 13.3.0-3ubuntu1 [997 kB] 190s Get:22 http://ftpmaster.internal/ubuntu oracular/main s390x gcc-13-s390x-linux-gnu s390x 13.3.0-3ubuntu1 [17.1 MB] 191s Get:23 http://ftpmaster.internal/ubuntu oracular/main s390x gcc-13 s390x 13.3.0-3ubuntu1 [482 kB] 191s Get:24 http://ftpmaster.internal/ubuntu oracular/main s390x gcc-s390x-linux-gnu s390x 4:13.3.0-2ubuntu2 [1204 B] 191s Get:25 http://ftpmaster.internal/ubuntu oracular/main s390x gcc s390x 4:13.3.0-2ubuntu2 [5014 B] 191s Get:26 http://ftpmaster.internal/ubuntu oracular/main s390x libstdc++-13-dev s390x 13.3.0-3ubuntu1 [2525 kB] 191s Get:27 http://ftpmaster.internal/ubuntu oracular/main s390x g++-13-s390x-linux-gnu s390x 13.3.0-3ubuntu1 [10.2 MB] 192s Get:28 http://ftpmaster.internal/ubuntu oracular/main s390x g++-13 s390x 13.3.0-3ubuntu1 [16.0 kB] 192s Get:29 http://ftpmaster.internal/ubuntu oracular/main s390x g++-s390x-linux-gnu s390x 4:13.3.0-2ubuntu2 [956 B] 192s Get:30 http://ftpmaster.internal/ubuntu oracular/main s390x g++ s390x 4:13.3.0-2ubuntu2 [1080 B] 192s Get:31 http://ftpmaster.internal/ubuntu oracular/main s390x build-essential s390x 12.10ubuntu1 [4930 B] 192s Get:32 http://ftpmaster.internal/ubuntu oracular/main s390x libdebhelper-perl all 13.16ubuntu2 [92.9 kB] 192s Get:33 http://ftpmaster.internal/ubuntu oracular/main s390x libtool all 2.4.7-7build1 [166 kB] 192s Get:34 http://ftpmaster.internal/ubuntu oracular/main s390x dh-autoreconf all 20 [16.1 kB] 192s Get:35 http://ftpmaster.internal/ubuntu oracular/main s390x libarchive-zip-perl all 1.68-1 [90.2 kB] 192s Get:36 http://ftpmaster.internal/ubuntu oracular/main s390x libfile-stripnondeterminism-perl all 1.14.0-1 [20.1 kB] 192s Get:37 http://ftpmaster.internal/ubuntu oracular/main s390x dh-strip-nondeterminism all 1.14.0-1 [5058 B] 192s Get:38 http://ftpmaster.internal/ubuntu oracular/main s390x debugedit s390x 1:5.0-6 [49.9 kB] 192s Get:39 http://ftpmaster.internal/ubuntu oracular/main s390x dwz s390x 0.15-1build6 [122 kB] 192s Get:40 http://ftpmaster.internal/ubuntu oracular/main s390x gettext s390x 0.22.5-1 [989 kB] 192s Get:41 http://ftpmaster.internal/ubuntu oracular/main s390x intltool-debian all 0.35.0+20060710.6 [23.2 kB] 192s Get:42 http://ftpmaster.internal/ubuntu oracular/main s390x po-debconf all 1.0.21+nmu1 [233 kB] 192s Get:43 http://ftpmaster.internal/ubuntu oracular/main s390x debhelper all 13.16ubuntu2 [869 kB] 192s Get:44 http://ftpmaster.internal/ubuntu oracular/universe s390x dh-python all 6.20240603 [112 kB] 192s Get:45 http://ftpmaster.internal/ubuntu oracular/main s390x fonts-font-awesome all 5.0.10+really4.7.0~dfsg-4.1 [516 kB] 192s Get:46 http://ftpmaster.internal/ubuntu oracular/main s390x python3-dateutil all 2.9.0-2 [80.3 kB] 192s Get:47 http://ftpmaster.internal/ubuntu oracular/universe s390x ghp-import all 2.1.0-3 [12.4 kB] 192s Get:48 http://ftpmaster.internal/ubuntu oracular/universe s390x help2man s390x 1.49.3 [201 kB] 192s Get:49 http://ftpmaster.internal/ubuntu oracular/main s390x javascript-common all 11+nmu1 [5936 B] 192s Get:50 http://ftpmaster.internal/ubuntu oracular/main s390x libhttp-parser2.9 s390x 2.9.4-6build1 [24.7 kB] 192s Get:51 http://ftpmaster.internal/ubuntu oracular/universe s390x libjs-popper.js all 1.16.1+ds-6 [54.1 kB] 192s Get:52 http://ftpmaster.internal/ubuntu oracular/universe s390x libjs-bootstrap4 all 4.6.1+dfsg1-4 [537 kB] 192s Get:53 http://ftpmaster.internal/ubuntu oracular/universe s390x libjs-highlight.js all 9.18.5+dfsg1-2 [385 kB] 192s Get:54 http://ftpmaster.internal/ubuntu oracular/main s390x libjs-jquery all 3.6.1+dfsg+~3.5.14-1 [328 kB] 192s Get:55 http://ftpmaster.internal/ubuntu oracular/universe s390x libjs-lunr all 2.3.9~dfsg-2 [66.8 kB] 192s Get:56 http://ftpmaster.internal/ubuntu oracular/main s390x libjs-underscore all 1.13.4~dfsg+~1.11.4-3 [118 kB] 192s Get:57 http://ftpmaster.internal/ubuntu oracular/main s390x libjs-sphinxdoc all 7.3.7-3 [154 kB] 192s Get:58 http://ftpmaster.internal/ubuntu oracular/universe s390x libjs-modernizr all 3.13.0-0.1 [101 kB] 192s Get:59 http://ftpmaster.internal/ubuntu oracular/main s390x python3-tornado s390x 6.4.1-1 [298 kB] 192s Get:60 http://ftpmaster.internal/ubuntu oracular/universe s390x python3-livereload all 2.6.3-2 [24.7 kB] 192s Get:61 http://ftpmaster.internal/ubuntu oracular/main s390x python3-colorama all 0.4.6-4 [32.1 kB] 192s Get:62 http://ftpmaster.internal/ubuntu oracular/main s390x python3-click all 8.1.7-1 [79.1 kB] 192s Get:63 http://ftpmaster.internal/ubuntu oracular/universe s390x python3-joblib all 1.3.2-2 [208 kB] 192s Get:64 http://ftpmaster.internal/ubuntu oracular/universe s390x python3-regex s390x 0.1.20221031-2build1 [298 kB] 192s Get:65 http://ftpmaster.internal/ubuntu oracular/universe s390x python3-tqdm all 4.66.4-1 [91.3 kB] 192s Get:66 http://ftpmaster.internal/ubuntu oracular/universe s390x python3-nltk all 3.8.1-1 [1002 kB] 192s Get:67 http://ftpmaster.internal/ubuntu oracular/universe s390x python3-lunr all 0.7.0-1 [26.8 kB] 192s Get:68 http://ftpmaster.internal/ubuntu oracular/main s390x sphinx-rtd-theme-common all 2.0.0+dfsg-2 [1012 kB] 192s Get:69 http://ftpmaster.internal/ubuntu oracular/main s390x python3-markdown all 3.6-1 [73.4 kB] 192s Get:70 http://ftpmaster.internal/ubuntu oracular/universe s390x python3-mergedeep all 1.3.4-3 [6560 B] 192s Get:71 http://ftpmaster.internal/ubuntu oracular/main s390x python3-packaging all 24.1-1 [41.4 kB] 192s Get:72 http://ftpmaster.internal/ubuntu oracular/universe s390x python3-pathspec all 0.12.1-1 [24.5 kB] 192s Get:73 http://ftpmaster.internal/ubuntu oracular/main s390x python3-platformdirs all 4.2.1-1 [16.3 kB] 192s Get:74 http://ftpmaster.internal/ubuntu oracular/universe s390x python3-pyyaml-env-tag all 0.1-3 [5268 B] 192s Get:75 http://ftpmaster.internal/ubuntu oracular/universe s390x python3-watchdog all 3.0.0-1 [121 kB] 192s Get:76 http://ftpmaster.internal/ubuntu oracular/universe s390x mkdocs all 1.5.3+dfsg-1 [2256 kB] 192s Get:77 http://ftpmaster.internal/ubuntu oracular/universe s390x python3-pyproject-hooks all 1.1.0-2 [9916 B] 192s Get:78 http://ftpmaster.internal/ubuntu oracular/universe s390x python3-toml all 0.10.2-1 [16.5 kB] 192s Get:79 http://ftpmaster.internal/ubuntu oracular/universe s390x python3-wheel all 0.43.0-1 [53.5 kB] 192s Get:80 http://ftpmaster.internal/ubuntu oracular/universe s390x python3-build all 1.2.1-1 [29.7 kB] 192s Get:81 http://ftpmaster.internal/ubuntu oracular/universe s390x python3-installer all 0.7.0+dfsg1-3 [17.4 kB] 193s Get:82 http://ftpmaster.internal/ubuntu oracular/universe s390x pybuild-plugin-pyproject all 6.20240603 [1732 B] 193s Get:83 http://ftpmaster.internal/ubuntu oracular-proposed/universe s390x python-uvicorn-doc all 0.30.1-1 [656 kB] 193s Get:84 http://ftpmaster.internal/ubuntu oracular/universe s390x python3-a2wsgi all 1.10.6-1 [13.0 kB] 193s Get:85 http://ftpmaster.internal/ubuntu oracular/main s390x python3-all s390x 3.12.3-0ubuntu1 [890 B] 193s Get:86 http://ftpmaster.internal/ubuntu oracular/universe s390x python3-sniffio all 1.3.1-1 [7262 B] 193s Get:87 http://ftpmaster.internal/ubuntu oracular/universe s390x python3-anyio all 4.3.0-1 [56.6 kB] 193s Get:88 http://ftpmaster.internal/ubuntu oracular/universe s390x python3-async-generator all 1.10-4 [17.5 kB] 193s Get:89 http://ftpmaster.internal/ubuntu oracular/universe s390x python3-dotenv all 1.0.1-1 [22.3 kB] 193s Get:90 http://ftpmaster.internal/ubuntu oracular/universe s390x python3-h11 all 0.14.0-1 [51.1 kB] 193s Get:91 http://ftpmaster.internal/ubuntu oracular/universe s390x python3-pluggy all 1.5.0-1 [21.0 kB] 193s Get:92 http://ftpmaster.internal/ubuntu oracular/universe s390x python3-trove-classifiers all 2024.4.10-1 [10.6 kB] 193s Get:93 http://ftpmaster.internal/ubuntu oracular/universe s390x python3-hatchling all 1.25.0-1 [54.8 kB] 193s Get:94 http://ftpmaster.internal/ubuntu oracular/universe s390x python3-httpcore all 1.0.4-1 [38.8 kB] 193s Get:95 http://ftpmaster.internal/ubuntu oracular/universe s390x python3-httptools s390x 0.1.1-3build3 [45.7 kB] 193s Get:96 http://ftpmaster.internal/ubuntu oracular/universe s390x python3-httpx all 0.26.0-2 [61.3 kB] 193s Get:97 http://ftpmaster.internal/ubuntu oracular/universe s390x python3-iniconfig all 1.1.1-2 [6024 B] 193s Get:98 http://ftpmaster.internal/ubuntu oracular/universe s390x python3-pymdownx all 10.8.1-1 [150 kB] 193s Get:99 http://ftpmaster.internal/ubuntu oracular/universe s390x python3-pytest all 7.4.4-1 [305 kB] 193s Get:100 http://ftpmaster.internal/ubuntu oracular/universe s390x python3-pytest-asyncio all 0.20.3-1.3 [10.7 kB] 193s Get:101 http://ftpmaster.internal/ubuntu oracular/universe s390x python3-pytest-mock all 3.14.0-1 [11.6 kB] 193s Get:102 http://ftpmaster.internal/ubuntu oracular/universe s390x python3-trustme all 1.1.0-1 [12.0 kB] 193s Get:103 http://ftpmaster.internal/ubuntu oracular/universe s390x python3-wsproto all 1.2.0-1 [23.6 kB] 193s Get:104 http://ftpmaster.internal/ubuntu oracular/universe s390x python3-uvloop s390x 0.19.0+ds1-2.1 [594 kB] 193s Get:105 http://ftpmaster.internal/ubuntu oracular-proposed/universe s390x python3-uvicorn all 0.30.1-1 [41.2 kB] 193s Get:106 http://ftpmaster.internal/ubuntu oracular/universe s390x python3-watchfiles s390x 0.21.0-4 [365 kB] 193s Get:107 http://ftpmaster.internal/ubuntu oracular/universe s390x python3-websockets all 10.4-1 [64.0 kB] 193s Get:108 http://ftpmaster.internal/ubuntu oracular-proposed/universe s390x uvicorn all 0.30.1-1 [4754 B] 194s Fetched 63.7 MB in 6s (11.5 MB/s) 194s Selecting previously unselected package fonts-lato. 194s (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 ... 54720 files and directories currently installed.) 194s Preparing to unpack .../000-fonts-lato_2.015-1_all.deb ... 194s Unpacking fonts-lato (2.015-1) ... 194s Selecting previously unselected package m4. 194s Preparing to unpack .../001-m4_1.4.19-4build1_s390x.deb ... 194s Unpacking m4 (1.4.19-4build1) ... 194s Selecting previously unselected package autoconf. 194s Preparing to unpack .../002-autoconf_2.71-3_all.deb ... 194s Unpacking autoconf (2.71-3) ... 194s Selecting previously unselected package autotools-dev. 194s Preparing to unpack .../003-autotools-dev_20220109.1_all.deb ... 194s Unpacking autotools-dev (20220109.1) ... 194s Selecting previously unselected package automake. 194s Preparing to unpack .../004-automake_1%3a1.16.5-1.3ubuntu1_all.deb ... 194s Unpacking automake (1:1.16.5-1.3ubuntu1) ... 194s Selecting previously unselected package autopoint. 194s Preparing to unpack .../005-autopoint_0.22.5-1_all.deb ... 194s Unpacking autopoint (0.22.5-1) ... 194s Selecting previously unselected package gcc-13-base:s390x. 194s Preparing to unpack .../006-gcc-13-base_13.3.0-3ubuntu1_s390x.deb ... 194s Unpacking gcc-13-base:s390x (13.3.0-3ubuntu1) ... 194s Selecting previously unselected package libisl23:s390x. 194s Preparing to unpack .../007-libisl23_0.26-3build1_s390x.deb ... 194s Unpacking libisl23:s390x (0.26-3build1) ... 194s Selecting previously unselected package libmpc3:s390x. 194s Preparing to unpack .../008-libmpc3_1.3.1-1build1_s390x.deb ... 194s Unpacking libmpc3:s390x (1.3.1-1build1) ... 194s Selecting previously unselected package cpp-13-s390x-linux-gnu. 194s Preparing to unpack .../009-cpp-13-s390x-linux-gnu_13.3.0-3ubuntu1_s390x.deb ... 194s Unpacking cpp-13-s390x-linux-gnu (13.3.0-3ubuntu1) ... 195s Selecting previously unselected package cpp-13. 195s Preparing to unpack .../010-cpp-13_13.3.0-3ubuntu1_s390x.deb ... 195s Unpacking cpp-13 (13.3.0-3ubuntu1) ... 195s Selecting previously unselected package cpp-s390x-linux-gnu. 195s Preparing to unpack .../011-cpp-s390x-linux-gnu_4%3a13.3.0-2ubuntu2_s390x.deb ... 195s Unpacking cpp-s390x-linux-gnu (4:13.3.0-2ubuntu2) ... 195s Selecting previously unselected package cpp. 195s Preparing to unpack .../012-cpp_4%3a13.3.0-2ubuntu2_s390x.deb ... 195s Unpacking cpp (4:13.3.0-2ubuntu2) ... 195s Selecting previously unselected package libcc1-0:s390x. 195s Preparing to unpack .../013-libcc1-0_14.1.0-4ubuntu2_s390x.deb ... 195s Unpacking libcc1-0:s390x (14.1.0-4ubuntu2) ... 195s Selecting previously unselected package libgomp1:s390x. 195s Preparing to unpack .../014-libgomp1_14.1.0-4ubuntu2_s390x.deb ... 195s Unpacking libgomp1:s390x (14.1.0-4ubuntu2) ... 195s Selecting previously unselected package libitm1:s390x. 195s Preparing to unpack .../015-libitm1_14.1.0-4ubuntu2_s390x.deb ... 195s Unpacking libitm1:s390x (14.1.0-4ubuntu2) ... 195s Selecting previously unselected package libatomic1:s390x. 195s Preparing to unpack .../016-libatomic1_14.1.0-4ubuntu2_s390x.deb ... 195s Unpacking libatomic1:s390x (14.1.0-4ubuntu2) ... 195s Selecting previously unselected package libasan8:s390x. 195s Preparing to unpack .../017-libasan8_14.1.0-4ubuntu2_s390x.deb ... 195s Unpacking libasan8:s390x (14.1.0-4ubuntu2) ... 195s Selecting previously unselected package libubsan1:s390x. 195s Preparing to unpack .../018-libubsan1_14.1.0-4ubuntu2_s390x.deb ... 195s Unpacking libubsan1:s390x (14.1.0-4ubuntu2) ... 195s Selecting previously unselected package libgcc-13-dev:s390x. 195s Preparing to unpack .../019-libgcc-13-dev_13.3.0-3ubuntu1_s390x.deb ... 195s Unpacking libgcc-13-dev:s390x (13.3.0-3ubuntu1) ... 195s Selecting previously unselected package gcc-13-s390x-linux-gnu. 195s Preparing to unpack .../020-gcc-13-s390x-linux-gnu_13.3.0-3ubuntu1_s390x.deb ... 195s Unpacking gcc-13-s390x-linux-gnu (13.3.0-3ubuntu1) ... 195s Selecting previously unselected package gcc-13. 195s Preparing to unpack .../021-gcc-13_13.3.0-3ubuntu1_s390x.deb ... 195s Unpacking gcc-13 (13.3.0-3ubuntu1) ... 195s Selecting previously unselected package gcc-s390x-linux-gnu. 195s Preparing to unpack .../022-gcc-s390x-linux-gnu_4%3a13.3.0-2ubuntu2_s390x.deb ... 195s Unpacking gcc-s390x-linux-gnu (4:13.3.0-2ubuntu2) ... 195s Selecting previously unselected package gcc. 195s Preparing to unpack .../023-gcc_4%3a13.3.0-2ubuntu2_s390x.deb ... 195s Unpacking gcc (4:13.3.0-2ubuntu2) ... 195s Selecting previously unselected package libstdc++-13-dev:s390x. 195s Preparing to unpack .../024-libstdc++-13-dev_13.3.0-3ubuntu1_s390x.deb ... 195s Unpacking libstdc++-13-dev:s390x (13.3.0-3ubuntu1) ... 196s Selecting previously unselected package g++-13-s390x-linux-gnu. 196s Preparing to unpack .../025-g++-13-s390x-linux-gnu_13.3.0-3ubuntu1_s390x.deb ... 196s Unpacking g++-13-s390x-linux-gnu (13.3.0-3ubuntu1) ... 196s Selecting previously unselected package g++-13. 196s Preparing to unpack .../026-g++-13_13.3.0-3ubuntu1_s390x.deb ... 196s Unpacking g++-13 (13.3.0-3ubuntu1) ... 196s Selecting previously unselected package g++-s390x-linux-gnu. 196s Preparing to unpack .../027-g++-s390x-linux-gnu_4%3a13.3.0-2ubuntu2_s390x.deb ... 196s Unpacking g++-s390x-linux-gnu (4:13.3.0-2ubuntu2) ... 196s Selecting previously unselected package g++. 196s Preparing to unpack .../028-g++_4%3a13.3.0-2ubuntu2_s390x.deb ... 196s Unpacking g++ (4:13.3.0-2ubuntu2) ... 196s Selecting previously unselected package build-essential. 196s Preparing to unpack .../029-build-essential_12.10ubuntu1_s390x.deb ... 196s Unpacking build-essential (12.10ubuntu1) ... 196s Selecting previously unselected package libdebhelper-perl. 196s Preparing to unpack .../030-libdebhelper-perl_13.16ubuntu2_all.deb ... 196s Unpacking libdebhelper-perl (13.16ubuntu2) ... 196s Selecting previously unselected package libtool. 196s Preparing to unpack .../031-libtool_2.4.7-7build1_all.deb ... 196s Unpacking libtool (2.4.7-7build1) ... 196s Selecting previously unselected package dh-autoreconf. 196s Preparing to unpack .../032-dh-autoreconf_20_all.deb ... 196s Unpacking dh-autoreconf (20) ... 196s Selecting previously unselected package libarchive-zip-perl. 196s Preparing to unpack .../033-libarchive-zip-perl_1.68-1_all.deb ... 196s Unpacking libarchive-zip-perl (1.68-1) ... 196s Selecting previously unselected package libfile-stripnondeterminism-perl. 196s Preparing to unpack .../034-libfile-stripnondeterminism-perl_1.14.0-1_all.deb ... 196s Unpacking libfile-stripnondeterminism-perl (1.14.0-1) ... 196s Selecting previously unselected package dh-strip-nondeterminism. 196s Preparing to unpack .../035-dh-strip-nondeterminism_1.14.0-1_all.deb ... 196s Unpacking dh-strip-nondeterminism (1.14.0-1) ... 196s Selecting previously unselected package debugedit. 196s Preparing to unpack .../036-debugedit_1%3a5.0-6_s390x.deb ... 196s Unpacking debugedit (1:5.0-6) ... 196s Selecting previously unselected package dwz. 196s Preparing to unpack .../037-dwz_0.15-1build6_s390x.deb ... 196s Unpacking dwz (0.15-1build6) ... 196s Selecting previously unselected package gettext. 196s Preparing to unpack .../038-gettext_0.22.5-1_s390x.deb ... 196s Unpacking gettext (0.22.5-1) ... 196s Selecting previously unselected package intltool-debian. 196s Preparing to unpack .../039-intltool-debian_0.35.0+20060710.6_all.deb ... 196s Unpacking intltool-debian (0.35.0+20060710.6) ... 196s Selecting previously unselected package po-debconf. 196s Preparing to unpack .../040-po-debconf_1.0.21+nmu1_all.deb ... 196s Unpacking po-debconf (1.0.21+nmu1) ... 196s Selecting previously unselected package debhelper. 197s Preparing to unpack .../041-debhelper_13.16ubuntu2_all.deb ... 197s Unpacking debhelper (13.16ubuntu2) ... 197s Selecting previously unselected package dh-python. 197s Preparing to unpack .../042-dh-python_6.20240603_all.deb ... 197s Unpacking dh-python (6.20240603) ... 197s Selecting previously unselected package fonts-font-awesome. 197s Preparing to unpack .../043-fonts-font-awesome_5.0.10+really4.7.0~dfsg-4.1_all.deb ... 197s Unpacking fonts-font-awesome (5.0.10+really4.7.0~dfsg-4.1) ... 197s Selecting previously unselected package python3-dateutil. 197s Preparing to unpack .../044-python3-dateutil_2.9.0-2_all.deb ... 197s Unpacking python3-dateutil (2.9.0-2) ... 197s Selecting previously unselected package ghp-import. 197s Preparing to unpack .../045-ghp-import_2.1.0-3_all.deb ... 197s Unpacking ghp-import (2.1.0-3) ... 197s Selecting previously unselected package help2man. 197s Preparing to unpack .../046-help2man_1.49.3_s390x.deb ... 197s Unpacking help2man (1.49.3) ... 197s Selecting previously unselected package javascript-common. 197s Preparing to unpack .../047-javascript-common_11+nmu1_all.deb ... 197s Unpacking javascript-common (11+nmu1) ... 197s Selecting previously unselected package libhttp-parser2.9:s390x. 197s Preparing to unpack .../048-libhttp-parser2.9_2.9.4-6build1_s390x.deb ... 197s Unpacking libhttp-parser2.9:s390x (2.9.4-6build1) ... 197s Selecting previously unselected package libjs-popper.js. 197s Preparing to unpack .../049-libjs-popper.js_1.16.1+ds-6_all.deb ... 197s Unpacking libjs-popper.js (1.16.1+ds-6) ... 197s Selecting previously unselected package libjs-bootstrap4. 197s Preparing to unpack .../050-libjs-bootstrap4_4.6.1+dfsg1-4_all.deb ... 197s Unpacking libjs-bootstrap4 (4.6.1+dfsg1-4) ... 197s Selecting previously unselected package libjs-highlight.js. 197s Preparing to unpack .../051-libjs-highlight.js_9.18.5+dfsg1-2_all.deb ... 197s Unpacking libjs-highlight.js (9.18.5+dfsg1-2) ... 197s Selecting previously unselected package libjs-jquery. 197s Preparing to unpack .../052-libjs-jquery_3.6.1+dfsg+~3.5.14-1_all.deb ... 197s Unpacking libjs-jquery (3.6.1+dfsg+~3.5.14-1) ... 197s Selecting previously unselected package libjs-lunr. 197s Preparing to unpack .../053-libjs-lunr_2.3.9~dfsg-2_all.deb ... 197s Unpacking libjs-lunr (2.3.9~dfsg-2) ... 197s Selecting previously unselected package libjs-underscore. 197s Preparing to unpack .../054-libjs-underscore_1.13.4~dfsg+~1.11.4-3_all.deb ... 197s Unpacking libjs-underscore (1.13.4~dfsg+~1.11.4-3) ... 197s Selecting previously unselected package libjs-sphinxdoc. 197s Preparing to unpack .../055-libjs-sphinxdoc_7.3.7-3_all.deb ... 197s Unpacking libjs-sphinxdoc (7.3.7-3) ... 197s Selecting previously unselected package libjs-modernizr. 197s Preparing to unpack .../056-libjs-modernizr_3.13.0-0.1_all.deb ... 197s Unpacking libjs-modernizr (3.13.0-0.1) ... 197s Selecting previously unselected package python3-tornado. 197s Preparing to unpack .../057-python3-tornado_6.4.1-1_s390x.deb ... 197s Unpacking python3-tornado (6.4.1-1) ... 197s Selecting previously unselected package python3-livereload. 197s Preparing to unpack .../058-python3-livereload_2.6.3-2_all.deb ... 197s Unpacking python3-livereload (2.6.3-2) ... 197s Selecting previously unselected package python3-colorama. 197s Preparing to unpack .../059-python3-colorama_0.4.6-4_all.deb ... 197s Unpacking python3-colorama (0.4.6-4) ... 197s Selecting previously unselected package python3-click. 197s Preparing to unpack .../060-python3-click_8.1.7-1_all.deb ... 197s Unpacking python3-click (8.1.7-1) ... 197s Selecting previously unselected package python3-joblib. 197s Preparing to unpack .../061-python3-joblib_1.3.2-2_all.deb ... 197s Unpacking python3-joblib (1.3.2-2) ... 197s Selecting previously unselected package python3-regex. 197s Preparing to unpack .../062-python3-regex_0.1.20221031-2build1_s390x.deb ... 197s Unpacking python3-regex (0.1.20221031-2build1) ... 197s Selecting previously unselected package python3-tqdm. 197s Preparing to unpack .../063-python3-tqdm_4.66.4-1_all.deb ... 197s Unpacking python3-tqdm (4.66.4-1) ... 197s Selecting previously unselected package python3-nltk. 197s Preparing to unpack .../064-python3-nltk_3.8.1-1_all.deb ... 197s Unpacking python3-nltk (3.8.1-1) ... 197s Selecting previously unselected package python3-lunr. 197s Preparing to unpack .../065-python3-lunr_0.7.0-1_all.deb ... 197s Unpacking python3-lunr (0.7.0-1) ... 197s Selecting previously unselected package sphinx-rtd-theme-common. 197s Preparing to unpack .../066-sphinx-rtd-theme-common_2.0.0+dfsg-2_all.deb ... 197s Unpacking sphinx-rtd-theme-common (2.0.0+dfsg-2) ... 197s Selecting previously unselected package python3-markdown. 197s Preparing to unpack .../067-python3-markdown_3.6-1_all.deb ... 197s Unpacking python3-markdown (3.6-1) ... 197s Selecting previously unselected package python3-mergedeep. 197s Preparing to unpack .../068-python3-mergedeep_1.3.4-3_all.deb ... 197s Unpacking python3-mergedeep (1.3.4-3) ... 197s Selecting previously unselected package python3-packaging. 197s Preparing to unpack .../069-python3-packaging_24.1-1_all.deb ... 197s Unpacking python3-packaging (24.1-1) ... 197s Selecting previously unselected package python3-pathspec. 197s Preparing to unpack .../070-python3-pathspec_0.12.1-1_all.deb ... 197s Unpacking python3-pathspec (0.12.1-1) ... 197s Selecting previously unselected package python3-platformdirs. 197s Preparing to unpack .../071-python3-platformdirs_4.2.1-1_all.deb ... 197s Unpacking python3-platformdirs (4.2.1-1) ... 197s Selecting previously unselected package python3-pyyaml-env-tag. 197s Preparing to unpack .../072-python3-pyyaml-env-tag_0.1-3_all.deb ... 197s Unpacking python3-pyyaml-env-tag (0.1-3) ... 197s Selecting previously unselected package python3-watchdog. 197s Preparing to unpack .../073-python3-watchdog_3.0.0-1_all.deb ... 197s Unpacking python3-watchdog (3.0.0-1) ... 198s Selecting previously unselected package mkdocs. 198s Preparing to unpack .../074-mkdocs_1.5.3+dfsg-1_all.deb ... 198s Unpacking mkdocs (1.5.3+dfsg-1) ... 198s Selecting previously unselected package python3-pyproject-hooks. 198s Preparing to unpack .../075-python3-pyproject-hooks_1.1.0-2_all.deb ... 198s Unpacking python3-pyproject-hooks (1.1.0-2) ... 198s Selecting previously unselected package python3-toml. 198s Preparing to unpack .../076-python3-toml_0.10.2-1_all.deb ... 198s Unpacking python3-toml (0.10.2-1) ... 198s Selecting previously unselected package python3-wheel. 198s Preparing to unpack .../077-python3-wheel_0.43.0-1_all.deb ... 198s Unpacking python3-wheel (0.43.0-1) ... 198s Selecting previously unselected package python3-build. 198s Preparing to unpack .../078-python3-build_1.2.1-1_all.deb ... 198s Unpacking python3-build (1.2.1-1) ... 198s Selecting previously unselected package python3-installer. 198s Preparing to unpack .../079-python3-installer_0.7.0+dfsg1-3_all.deb ... 198s Unpacking python3-installer (0.7.0+dfsg1-3) ... 198s Selecting previously unselected package pybuild-plugin-pyproject. 198s Preparing to unpack .../080-pybuild-plugin-pyproject_6.20240603_all.deb ... 198s Unpacking pybuild-plugin-pyproject (6.20240603) ... 198s Selecting previously unselected package python-uvicorn-doc. 198s Preparing to unpack .../081-python-uvicorn-doc_0.30.1-1_all.deb ... 198s Unpacking python-uvicorn-doc (0.30.1-1) ... 198s Selecting previously unselected package python3-a2wsgi. 198s Preparing to unpack .../082-python3-a2wsgi_1.10.6-1_all.deb ... 198s Unpacking python3-a2wsgi (1.10.6-1) ... 198s Selecting previously unselected package python3-all. 198s Preparing to unpack .../083-python3-all_3.12.3-0ubuntu1_s390x.deb ... 198s Unpacking python3-all (3.12.3-0ubuntu1) ... 198s Selecting previously unselected package python3-sniffio. 198s Preparing to unpack .../084-python3-sniffio_1.3.1-1_all.deb ... 198s Unpacking python3-sniffio (1.3.1-1) ... 198s Selecting previously unselected package python3-anyio. 198s Preparing to unpack .../085-python3-anyio_4.3.0-1_all.deb ... 198s Unpacking python3-anyio (4.3.0-1) ... 198s Selecting previously unselected package python3-async-generator. 198s Preparing to unpack .../086-python3-async-generator_1.10-4_all.deb ... 198s Unpacking python3-async-generator (1.10-4) ... 198s Selecting previously unselected package python3-dotenv. 198s Preparing to unpack .../087-python3-dotenv_1.0.1-1_all.deb ... 198s Unpacking python3-dotenv (1.0.1-1) ... 198s Selecting previously unselected package python3-h11. 198s Preparing to unpack .../088-python3-h11_0.14.0-1_all.deb ... 198s Unpacking python3-h11 (0.14.0-1) ... 198s Selecting previously unselected package python3-pluggy. 198s Preparing to unpack .../089-python3-pluggy_1.5.0-1_all.deb ... 198s Unpacking python3-pluggy (1.5.0-1) ... 198s Selecting previously unselected package python3-trove-classifiers. 198s Preparing to unpack .../090-python3-trove-classifiers_2024.4.10-1_all.deb ... 198s Unpacking python3-trove-classifiers (2024.4.10-1) ... 198s Selecting previously unselected package python3-hatchling. 198s Preparing to unpack .../091-python3-hatchling_1.25.0-1_all.deb ... 198s Unpacking python3-hatchling (1.25.0-1) ... 198s Selecting previously unselected package python3-httpcore. 198s Preparing to unpack .../092-python3-httpcore_1.0.4-1_all.deb ... 198s Unpacking python3-httpcore (1.0.4-1) ... 198s Selecting previously unselected package python3-httptools. 198s Preparing to unpack .../093-python3-httptools_0.1.1-3build3_s390x.deb ... 198s Unpacking python3-httptools (0.1.1-3build3) ... 198s Selecting previously unselected package python3-httpx. 198s Preparing to unpack .../094-python3-httpx_0.26.0-2_all.deb ... 198s Unpacking python3-httpx (0.26.0-2) ... 198s Selecting previously unselected package python3-iniconfig. 198s Preparing to unpack .../095-python3-iniconfig_1.1.1-2_all.deb ... 198s Unpacking python3-iniconfig (1.1.1-2) ... 198s Selecting previously unselected package python3-pymdownx. 198s Preparing to unpack .../096-python3-pymdownx_10.8.1-1_all.deb ... 198s Unpacking python3-pymdownx (10.8.1-1) ... 198s Selecting previously unselected package python3-pytest. 198s Preparing to unpack .../097-python3-pytest_7.4.4-1_all.deb ... 198s Unpacking python3-pytest (7.4.4-1) ... 198s Selecting previously unselected package python3-pytest-asyncio. 198s Preparing to unpack .../098-python3-pytest-asyncio_0.20.3-1.3_all.deb ... 198s Unpacking python3-pytest-asyncio (0.20.3-1.3) ... 198s Selecting previously unselected package python3-pytest-mock. 198s Preparing to unpack .../099-python3-pytest-mock_3.14.0-1_all.deb ... 198s Unpacking python3-pytest-mock (3.14.0-1) ... 198s Selecting previously unselected package python3-trustme. 198s Preparing to unpack .../100-python3-trustme_1.1.0-1_all.deb ... 198s Unpacking python3-trustme (1.1.0-1) ... 198s Selecting previously unselected package python3-wsproto. 198s Preparing to unpack .../101-python3-wsproto_1.2.0-1_all.deb ... 198s Unpacking python3-wsproto (1.2.0-1) ... 198s Selecting previously unselected package python3-uvloop. 198s Preparing to unpack .../102-python3-uvloop_0.19.0+ds1-2.1_s390x.deb ... 198s Unpacking python3-uvloop (0.19.0+ds1-2.1) ... 198s Selecting previously unselected package python3-uvicorn. 198s Preparing to unpack .../103-python3-uvicorn_0.30.1-1_all.deb ... 198s Unpacking python3-uvicorn (0.30.1-1) ... 199s Selecting previously unselected package python3-watchfiles. 199s Preparing to unpack .../104-python3-watchfiles_0.21.0-4_s390x.deb ... 199s Unpacking python3-watchfiles (0.21.0-4) ... 199s Selecting previously unselected package python3-websockets. 199s Preparing to unpack .../105-python3-websockets_10.4-1_all.deb ... 199s Unpacking python3-websockets (10.4-1) ... 199s Selecting previously unselected package uvicorn. 199s Preparing to unpack .../106-uvicorn_0.30.1-1_all.deb ... 199s Unpacking uvicorn (0.30.1-1) ... 199s Selecting previously unselected package autopkgtest-satdep. 199s Preparing to unpack .../107-1-autopkgtest-satdep.deb ... 199s Unpacking autopkgtest-satdep (0) ... 199s Setting up python3-dotenv (1.0.1-1) ... 199s Setting up dh-python (6.20240603) ... 199s Setting up javascript-common (11+nmu1) ... 199s Setting up python3-iniconfig (1.1.1-2) ... 199s Setting up python3-sniffio (1.3.1-1) ... 199s Setting up python3-tornado (6.4.1-1) ... 200s Setting up fonts-lato (2.015-1) ... 200s Setting up python3-async-generator (1.10-4) ... 200s Setting up python3-anyio (4.3.0-1) ... 200s Setting up python3-joblib (1.3.2-2) ... 201s Setting up libjs-popper.js (1.16.1+ds-6) ... 201s Setting up python3-colorama (0.4.6-4) ... 201s Setting up libarchive-zip-perl (1.68-1) ... 201s Setting up libjs-lunr (2.3.9~dfsg-2) ... 201s Setting up libdebhelper-perl (13.16ubuntu2) ... 201s Setting up python3-tqdm (4.66.4-1) ... 201s Setting up m4 (1.4.19-4build1) ... 201s Setting up python3-watchfiles (0.21.0-4) ... 202s Setting up python3-all (3.12.3-0ubuntu1) ... 202s Setting up python3-trustme (1.1.0-1) ... 202s Setting up libgomp1:s390x (14.1.0-4ubuntu2) ... 202s Setting up python3-click (8.1.7-1) ... 202s Setting up libjs-modernizr (3.13.0-0.1) ... 202s Setting up python3-wheel (0.43.0-1) ... 202s Setting up python3-platformdirs (4.2.1-1) ... 202s Setting up python3-pyyaml-env-tag (0.1-3) ... 203s Setting up help2man (1.49.3) ... 203s Setting up python3-a2wsgi (1.10.6-1) ... 203s Setting up autotools-dev (20220109.1) ... 203s Setting up python3-packaging (24.1-1) ... 203s Setting up gcc-13-base:s390x (13.3.0-3ubuntu1) ... 203s Setting up python3-pyproject-hooks (1.1.0-2) ... 203s Setting up libmpc3:s390x (1.3.1-1build1) ... 203s Setting up libatomic1:s390x (14.1.0-4ubuntu2) ... 203s Setting up python3-markdown (3.6-1) ... 203s Setting up python3-h11 (0.14.0-1) ... 204s Setting up autopoint (0.22.5-1) ... 204s Setting up python3-mergedeep (1.3.4-3) ... 204s Setting up python3-regex (0.1.20221031-2build1) ... 204s Setting up python3-toml (0.10.2-1) ... 204s Setting up python3-uvloop (0.19.0+ds1-2.1) ... 204s Setting up python3-installer (0.7.0+dfsg1-3) ... 204s Setting up autoconf (2.71-3) ... 204s Setting up python3-pluggy (1.5.0-1) ... 204s Setting up libubsan1:s390x (14.1.0-4ubuntu2) ... 204s Setting up dwz (0.15-1build6) ... 204s Setting up libjs-highlight.js (9.18.5+dfsg1-2) ... 204s Setting up python3-trove-classifiers (2024.4.10-1) ... 205s Setting up python3-livereload (2.6.3-2) ... 205s Setting up libasan8:s390x (14.1.0-4ubuntu2) ... 205s Setting up debugedit (1:5.0-6) ... 205s Setting up python3-dateutil (2.9.0-2) ... 205s Setting up libjs-bootstrap4 (4.6.1+dfsg1-4) ... 205s Setting up libjs-jquery (3.6.1+dfsg+~3.5.14-1) ... 205s Setting up libisl23:s390x (0.26-3build1) ... 205s Setting up python3-build (1.2.1-1) ... 205s Setting up python3-pathspec (0.12.1-1) ... 205s Setting up python3-nltk (3.8.1-1) ... 207s Setting up fonts-font-awesome (5.0.10+really4.7.0~dfsg-4.1) ... 207s Setting up sphinx-rtd-theme-common (2.0.0+dfsg-2) ... 207s Setting up libcc1-0:s390x (14.1.0-4ubuntu2) ... 207s Setting up libitm1:s390x (14.1.0-4ubuntu2) ... 207s Setting up libhttp-parser2.9:s390x (2.9.4-6build1) ... 207s Setting up libjs-underscore (1.13.4~dfsg+~1.11.4-3) ... 207s Setting up python3-lunr (0.7.0-1) ... 207s Setting up python3-websockets (10.4-1) ... 207s Setting up automake (1:1.16.5-1.3ubuntu1) ... 207s update-alternatives: using /usr/bin/automake-1.16 to provide /usr/bin/automake (automake) in auto mode 207s Setting up libfile-stripnondeterminism-perl (1.14.0-1) ... 207s Setting up python3-httpcore (1.0.4-1) ... 207s Setting up gettext (0.22.5-1) ... 207s Setting up python3-wsproto (1.2.0-1) ... 207s Setting up pybuild-plugin-pyproject (6.20240603) ... 207s Setting up python3-pytest (7.4.4-1) ... 208s Setting up python3-pymdownx (10.8.1-1) ... 208s Setting up intltool-debian (0.35.0+20060710.6) ... 208s Setting up cpp-13-s390x-linux-gnu (13.3.0-3ubuntu1) ... 208s Setting up python3-httpx (0.26.0-2) ... 209s Setting up libjs-sphinxdoc (7.3.7-3) ... 209s Setting up python3-pytest-asyncio (0.20.3-1.3) ... 209s Setting up dh-strip-nondeterminism (1.14.0-1) ... 209s Setting up ghp-import (2.1.0-3) ... 209s Setting up python3-pytest-mock (3.14.0-1) ... 209s Setting up libgcc-13-dev:s390x (13.3.0-3ubuntu1) ... 209s Setting up python3-httptools (0.1.1-3build3) ... 209s Setting up python3-hatchling (1.25.0-1) ... 209s Setting up libstdc++-13-dev:s390x (13.3.0-3ubuntu1) ... 209s Setting up python3-uvicorn (0.30.1-1) ... 210s Setting up cpp-13 (13.3.0-3ubuntu1) ... 210s Setting up cpp-s390x-linux-gnu (4:13.3.0-2ubuntu2) ... 210s Setting up python3-watchdog (3.0.0-1) ... 210s Setting up po-debconf (1.0.21+nmu1) ... 210s Setting up gcc-13-s390x-linux-gnu (13.3.0-3ubuntu1) ... 210s Setting up gcc-s390x-linux-gnu (4:13.3.0-2ubuntu2) ... 210s Setting up g++-13-s390x-linux-gnu (13.3.0-3ubuntu1) ... 210s Setting up gcc-13 (13.3.0-3ubuntu1) ... 210s Setting up cpp (4:13.3.0-2ubuntu2) ... 210s Setting up mkdocs (1.5.3+dfsg-1) ... 210s Setting up g++-13 (13.3.0-3ubuntu1) ... 210s Setting up uvicorn (0.30.1-1) ... 210s Setting up libtool (2.4.7-7build1) ... 210s Setting up g++-s390x-linux-gnu (4:13.3.0-2ubuntu2) ... 210s Setting up gcc (4:13.3.0-2ubuntu2) ... 210s Setting up dh-autoreconf (20) ... 210s Setting up g++ (4:13.3.0-2ubuntu2) ... 210s update-alternatives: using /usr/bin/g++ to provide /usr/bin/c++ (c++) in auto mode 210s Setting up python-uvicorn-doc (0.30.1-1) ... 210s Setting up build-essential (12.10ubuntu1) ... 210s Setting up debhelper (13.16ubuntu2) ... 210s Setting up autopkgtest-satdep (0) ... 210s Processing triggers for man-db (2.12.1-2) ... 211s Processing triggers for install-info (7.1-3build2) ... 211s Processing triggers for libc-bin (2.39-0ubuntu9) ... 216s (Reading database ... 60108 files and directories currently installed.) 216s Removing autopkgtest-satdep (0) ... 217s autopkgtest [20:06:36]: test unittests: [----------------------- 217s === python3.12 === 217s ============================= test session starts ============================== 217s platform linux -- Python 3.12.4, pytest-7.4.4, pluggy-1.5.0 -- /usr/bin/python3.12 217s cachedir: .pytest_cache 217s rootdir: /tmp/autopkgtest.3NsjGX/autopkgtest_tmp 217s plugins: anyio-4.3.0, mock-3.14.0, asyncio-0.20.3 217s asyncio: mode=Mode.STRICT 218s collecting ... collected 401 items / 26 deselected / 375 selected 218s 218s tests/test_auto_detection.py::test_loop_auto PASSED 218s tests/test_auto_detection.py::test_http_auto PASSED 218s tests/test_cli.py::test_cli_print_version PASSED 218s tests/test_cli.py::test_cli_headers PASSED 218s tests/test_cli.py::test_cli_call_server_run PASSED 218s tests/test_cli.py::test_cli_call_change_reload_run PASSED 218s tests/test_cli.py::test_cli_call_multiprocess_run PASSED 218s tests/test_cli.py::test_cli_uds[True] PASSED 218s tests/test_cli.py::test_cli_uds[False] PASSED 218s tests/test_cli.py::test_cli_incomplete_app_parameter PASSED 218s tests/test_cli.py::test_cli_event_size PASSED 218s tests/test_cli.py::test_env_variables[h11] PASSED 218s tests/test_cli.py::test_env_variables[httptools] PASSED 218s tests/test_cli.py::test_ignore_environment_variable_when_set_on_cli PASSED 218s tests/test_cli.py::test_app_dir PASSED 218s tests/test_cli.py::test_set_app_via_environment_variable PASSED 218s tests/test_config.py::test_config_should_reload_is_set[asgi_app-False] PASSED 218s tests/test_config.py::test_config_should_reload_is_set[tests.test_config:asgi_app-True] INFO: Will watch for changes in these directories: ['/tmp/autopkgtest.3NsjGX/autopkgtest_tmp'] 218s PASSED 218s tests/test_config.py::test_should_warn_on_invalid_reload_configuration WARNING: Current configuration will not reload as not all conditions are met, please refer to documentation. 218s WARNING: Current configuration will not reload as not all conditions are met, please refer to documentation. 218s PASSED 218s tests/test_config.py::test_reload_dir_is_set INFO: Will watch for changes in these directories: ['/tmp/pytest-of-ubuntu/pytest-0/reload_directory0/app'] 218s INFO: Will watch for changes in these directories: ['/tmp/pytest-of-ubuntu/pytest-0/reload_directory0/app'] 218s PASSED 218s tests/test_config.py::test_non_existant_reload_dir_is_not_set WARNING: Provided reload directories ['reload'] did not contain valid directories, watching current working directory. 218s INFO: Will watch for changes in these directories: ['/tmp/pytest-of-ubuntu/pytest-0/reload_directory0'] 218s PASSED 218s tests/test_config.py::test_reload_subdir_removal INFO: Will watch for changes in these directories: ['/tmp/pytest-of-ubuntu/pytest-0/reload_directory0'] 218s PASSED 218s tests/test_config.py::test_reload_included_dir_is_added_to_reload_dirs INFO: Will watch for changes in these directories: ['/tmp/pytest-of-ubuntu/pytest-0/reload_directory0/app', '/tmp/pytest-of-ubuntu/pytest-0/reload_directory0/ext'] 218s PASSED 218s tests/test_config.py::test_reload_dir_subdirectories_are_removed INFO: Will watch for changes in these directories: ['/tmp/pytest-of-ubuntu/pytest-0/reload_directory0/app', '/tmp/pytest-of-ubuntu/pytest-0/reload_directory0/ext'] 218s PASSED 218s tests/test_config.py::test_reload_excluded_subdirectories_are_removed INFO: Will watch for changes in these directories: ['/tmp/pytest-of-ubuntu/pytest-0/reload_directory0'] 218s PASSED 218s tests/test_config.py::test_reload_includes_exclude_dir_patterns_are_matched INFO: Will watch for changes in these directories: ['/tmp/pytest-of-ubuntu/pytest-0/reload_directory0/app_first/src', '/tmp/pytest-of-ubuntu/pytest-0/reload_directory0/app_second/src'] 218s PASSED 218s tests/test_config.py::test_wsgi_app PASSED 218s tests/test_config.py::test_proxy_headers PASSED 218s tests/test_config.py::test_app_unimportable_module PASSED 218s tests/test_config.py::test_app_unimportable_other ERROR: Error loading ASGI app. Attribute "app" not found in module "tests.test_config". 218s PASSED 218s tests/test_config.py::test_app_factory WARNING: ASGI app factory detected. Using it, but please consider setting the --factory flag explicitly. 218s ERROR: Error loading ASGI app factory: asgi_app() missing 3 required positional arguments: 'scope', 'receive', and 'send' 218s PASSED 218s tests/test_config.py::test_concrete_http_class PASSED 218s tests/test_config.py::test_socket_bind INFO: Uvicorn running on http://127.0.0.1:8000 (Press CTRL+C to quit) 218s PASSED 218s tests/test_config.py::test_ssl_config PASSED 218s tests/test_config.py::test_ssl_config_combined PASSED 218s tests/test_config.py::test_asgi_version[asgi_app-3.0] PASSED 218s tests/test_config.py::test_asgi_version[asgi2_app-2.0] PASSED 218s tests/test_config.py::test_log_config_default[use_colors_not_provided] PASSED 218s tests/test_config.py::test_log_config_default[use_colors_invalid_value] PASSED 218s tests/test_config.py::test_log_config_default[use_colors_enabled] PASSED 218s tests/test_config.py::test_log_config_default[use_colors_disabled] PASSED 218s tests/test_config.py::test_log_config_json PASSED 218s tests/test_config.py::test_log_config_yaml[log_config.yml] PASSED 218s tests/test_config.py::test_log_config_yaml[log_config.yaml] PASSED 218s tests/test_config.py::test_log_config_file[log_config.ini] PASSED 218s tests/test_config.py::test_log_config_file[config_file1] PASSED 218s tests/test_config.py::test_log_config_file[config_file2] PASSED 218s tests/test_config.py::test_env_file[0-127.0.0.1] INFO: Loading environment from '/tmp/pytest-of-ubuntu/pytest-0/test_env_file_0_127_0_0_1_0/.env' 218s PASSED 218s tests/test_config.py::test_env_file[0-127.0.0.2] INFO: Loading environment from '/tmp/pytest-of-ubuntu/pytest-0/test_env_file_0_127_0_0_2_0/.env' 218s PASSED 218s tests/test_config.py::test_env_file[1-127.0.0.1] INFO: Loading environment from '/tmp/pytest-of-ubuntu/pytest-0/test_env_file_1_127_0_0_1_0/.env' 218s PASSED 218s tests/test_config.py::test_env_file[1-127.0.0.2] INFO: Loading environment from '/tmp/pytest-of-ubuntu/pytest-0/test_env_file_1_127_0_0_2_0/.env' 218s PASSED 218s tests/test_config.py::test_config_access_log[access log enabled should have single handler] PASSED 218s tests/test_config.py::test_config_access_log[access log disabled shouldn't have handlers] PASSED 218s tests/test_config.py::test_config_log_level[5] PASSED 218s tests/test_config.py::test_config_log_level[10] PASSED 218s tests/test_config.py::test_config_log_level[20] PASSED 218s tests/test_config.py::test_config_log_level[30] PASSED 218s tests/test_config.py::test_config_log_level[40] PASSED 218s tests/test_config.py::test_config_log_level[50] PASSED 218s tests/test_config.py::test_config_log_effective_level[0-None] PASSED 218s tests/test_config.py::test_config_log_effective_level[0-0] PASSED 218s tests/test_config.py::test_config_log_effective_level[0-5] PASSED 218s tests/test_config.py::test_config_log_effective_level[0-10] PASSED 218s tests/test_config.py::test_config_log_effective_level[0-20] PASSED 218s tests/test_config.py::test_config_log_effective_level[0-30] PASSED 218s tests/test_config.py::test_config_log_effective_level[0-40] PASSED 218s tests/test_config.py::test_config_log_effective_level[0-50] PASSED 218s tests/test_config.py::test_config_log_effective_level[5-None] PASSED 218s tests/test_config.py::test_config_log_effective_level[5-0] PASSED 218s tests/test_config.py::test_config_log_effective_level[5-5] PASSED 218s tests/test_config.py::test_config_log_effective_level[5-10] PASSED 218s tests/test_config.py::test_config_log_effective_level[5-20] PASSED 218s tests/test_config.py::test_config_log_effective_level[5-30] PASSED 218s tests/test_config.py::test_config_log_effective_level[5-40] PASSED 218s tests/test_config.py::test_config_log_effective_level[5-50] PASSED 218s tests/test_config.py::test_config_log_effective_level[10-None] PASSED 218s tests/test_config.py::test_config_log_effective_level[10-0] PASSED 218s tests/test_config.py::test_config_log_effective_level[10-5] PASSED 218s tests/test_config.py::test_config_log_effective_level[10-10] PASSED 218s tests/test_config.py::test_config_log_effective_level[10-20] PASSED 218s tests/test_config.py::test_config_log_effective_level[10-30] PASSED 218s tests/test_config.py::test_config_log_effective_level[10-40] PASSED 218s tests/test_config.py::test_config_log_effective_level[10-50] PASSED 218s tests/test_config.py::test_config_log_effective_level[20-None] PASSED 218s tests/test_config.py::test_config_log_effective_level[20-0] PASSED 218s tests/test_config.py::test_config_log_effective_level[20-5] PASSED 218s tests/test_config.py::test_config_log_effective_level[20-10] PASSED 218s tests/test_config.py::test_config_log_effective_level[20-20] PASSED 218s tests/test_config.py::test_config_log_effective_level[20-30] PASSED 218s tests/test_config.py::test_config_log_effective_level[20-40] PASSED 218s tests/test_config.py::test_config_log_effective_level[20-50] PASSED 218s tests/test_config.py::test_config_log_effective_level[30-None] PASSED 218s tests/test_config.py::test_config_log_effective_level[30-0] PASSED 218s tests/test_config.py::test_config_log_effective_level[30-5] PASSED 218s tests/test_config.py::test_config_log_effective_level[30-10] PASSED 218s tests/test_config.py::test_config_log_effective_level[30-20] PASSED 218s tests/test_config.py::test_config_log_effective_level[30-30] PASSED 218s tests/test_config.py::test_config_log_effective_level[30-40] PASSED 218s tests/test_config.py::test_config_log_effective_level[30-50] PASSED 218s tests/test_config.py::test_config_log_effective_level[40-None] PASSED 218s tests/test_config.py::test_config_log_effective_level[40-0] PASSED 218s tests/test_config.py::test_config_log_effective_level[40-5] PASSED 218s tests/test_config.py::test_config_log_effective_level[40-10] PASSED 218s tests/test_config.py::test_config_log_effective_level[40-20] PASSED 218s tests/test_config.py::test_config_log_effective_level[40-30] PASSED 218s tests/test_config.py::test_config_log_effective_level[40-40] PASSED 218s tests/test_config.py::test_config_log_effective_level[40-50] PASSED 218s tests/test_config.py::test_config_log_effective_level[50-None] PASSED 218s tests/test_config.py::test_config_log_effective_level[50-0] PASSED 218s tests/test_config.py::test_config_log_effective_level[50-5] PASSED 218s tests/test_config.py::test_config_log_effective_level[50-10] PASSED 218s tests/test_config.py::test_config_log_effective_level[50-20] PASSED 218s tests/test_config.py::test_config_log_effective_level[50-30] PASSED 218s tests/test_config.py::test_config_log_effective_level[50-40] PASSED 218s tests/test_config.py::test_config_log_effective_level[50-50] PASSED 218s tests/test_config.py::test_ws_max_size PASSED 218s tests/test_config.py::test_ws_max_queue PASSED 218s tests/test_config.py::test_bind_unix_socket_works_with_reload_or_workers[--reload=True --workers=1] INFO: Uvicorn running on unix socket /tmp/pytest-of-ubuntu/pytest-0/p-j88wn7t1-5198cba4e6fe9481556184fc90a4ef02/my.sock (Press CTRL+C to quit) 218s PASSED 218s tests/test_config.py::test_bind_unix_socket_works_with_reload_or_workers[--reload=False --workers=2] INFO: Uvicorn running on unix socket /tmp/pytest-of-ubuntu/pytest-0/p-pr2p8rkb-5198cba4e6fe9481556184fc90a4ef02/my.sock (Press CTRL+C to quit) 218s PASSED 218s tests/test_config.py::test_bind_fd_works_with_reload_or_workers[--reload=True --workers=1] INFO: Uvicorn running on socket (Press CTRL+C to quit) 218s PASSED 218s tests/test_config.py::test_bind_fd_works_with_reload_or_workers[--reload=False --workers=2] INFO: Uvicorn running on socket (Press CTRL+C to quit) 218s PASSED 218s tests/test_config.py::test_config_use_subprocess[--reload=True --workers=1] PASSED 218s tests/test_config.py::test_config_use_subprocess[--reload=False --workers=2] PASSED 218s tests/test_config.py::test_config_use_subprocess[--reload=False --workers=1] PASSED 218s tests/test_config.py::test_warn_when_using_reload_and_workers WARNING: "workers" flag is ignored when reloading is enabled. 218s PASSED 218s tests/test_lifespan.py::test_lifespan_on INFO: Waiting for application startup. 218s INFO: Application startup complete. 218s INFO: Waiting for application shutdown. 218s INFO: Application shutdown complete. 218s PASSED 218s tests/test_lifespan.py::test_lifespan_off PASSED 218s tests/test_lifespan.py::test_lifespan_auto INFO: Waiting for application startup. 218s INFO: Application startup complete. 218s INFO: Waiting for application shutdown. 218s INFO: Application shutdown complete. 218s PASSED 218s tests/test_lifespan.py::test_lifespan_auto_with_error INFO: Waiting for application startup. 218s INFO: ASGI 'lifespan' protocol appears unsupported. 218s INFO: Application startup complete. 218s PASSED 218s tests/test_lifespan.py::test_lifespan_on_with_error INFO: Waiting for application startup. 218s ERROR: Exception in 'lifespan' protocol 218s Traceback (most recent call last): 218s File "/usr/lib/python3/dist-packages/uvicorn/lifespan/on.py", line 86, in main 218s await app(scope, self.receive, self.send) 218s File "/usr/lib/python3/dist-packages/uvicorn/middleware/proxy_headers.py", line 70, in __call__ 218s return await self.app(scope, receive, send) 218s ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 218s File "/tmp/autopkgtest.3NsjGX/autopkgtest_tmp/tests/test_lifespan.py", line 113, in app 218s raise RuntimeError() 218s RuntimeError 218s ERROR: Application startup failed. Exiting. 218s PASSED 218s tests/test_lifespan.py::test_lifespan_with_failed_startup[True-auto] INFO: Waiting for application startup. 218s ERROR: the lifespan event failed 218s ERROR: Application startup failed. Exiting. 218s PASSED 218s tests/test_lifespan.py::test_lifespan_with_failed_startup[True-on] INFO: Waiting for application startup. 218s ERROR: the lifespan event failed 218s ERROR: Application startup failed. Exiting. 218s PASSED 218s tests/test_lifespan.py::test_lifespan_with_failed_startup[False-auto] INFO: Waiting for application startup. 218s ERROR: the lifespan event failed 218s ERROR: Application startup failed. Exiting. 218s INFO: Waiting for application shutdown. 218s INFO: Application shutdown complete. 218s PASSED 218s tests/test_lifespan.py::test_lifespan_with_failed_startup[False-on] INFO: Waiting for application startup. 218s ERROR: the lifespan event failed 218s ERROR: Application startup failed. Exiting. 218s INFO: Waiting for application shutdown. 218s INFO: Application shutdown complete. 218s PASSED 218s tests/test_lifespan.py::test_lifespan_scope_asgi3app INFO: Waiting for application startup. 218s INFO: Application startup complete. 218s INFO: Waiting for application shutdown. 218s INFO: Application shutdown complete. 218s PASSED 218s tests/test_lifespan.py::test_lifespan_scope_asgi2app INFO: Waiting for application startup. 218s INFO: Application startup complete. 218s INFO: Waiting for application shutdown. 218s INFO: Application shutdown complete. 218s PASSED 218s tests/test_lifespan.py::test_lifespan_with_failed_shutdown[True-auto] INFO: Waiting for application startup. 218s INFO: Application startup complete. 218s INFO: Waiting for application shutdown. 218s ERROR: the lifespan event failed 218s ERROR: Application shutdown failed. Exiting. 218s PASSED 218s tests/test_lifespan.py::test_lifespan_with_failed_shutdown[True-on] INFO: Waiting for application startup. 218s INFO: Application startup complete. 218s INFO: Waiting for application shutdown. 218s ERROR: the lifespan event failed 218s ERROR: Application shutdown failed. Exiting. 218s PASSED 218s tests/test_lifespan.py::test_lifespan_with_failed_shutdown[False-auto] INFO: Waiting for application startup. 218s INFO: Application startup complete. 218s INFO: Waiting for application shutdown. 218s ERROR: the lifespan event failed 218s ERROR: Application shutdown failed. Exiting. 218s PASSED 218s tests/test_lifespan.py::test_lifespan_with_failed_shutdown[False-on] INFO: Waiting for application startup. 218s INFO: Application startup complete. 218s INFO: Waiting for application shutdown. 218s ERROR: the lifespan event failed 218s ERROR: Application shutdown failed. Exiting. 218s PASSED 218s tests/test_lifespan.py::test_lifespan_state INFO: Waiting for application startup. 218s INFO: Application startup complete. 218s INFO: Waiting for application shutdown. 218s INFO: Application shutdown complete. 218s PASSED 218s tests/test_main.py::test_exit_on_create_server_with_invalid_host INFO: Started server process [2904] 218s INFO: Waiting for application startup. 218s INFO: ASGI 'lifespan' protocol appears unsupported. 218s INFO: Application startup complete. 218s ERROR: [Errno -3] Temporary failure in name resolution 218s PASSED 218s tests/test_server.py::test_server_interrupt[capture_signal_sync-15] INFO: Started server process [2904] 218s INFO: Waiting for application startup. 218s INFO: Application startup complete. 218s INFO: Uvicorn running on http://127.0.0.1:8000 (Press CTRL+C to quit) 218s INFO: Shutting down 218s INFO: Waiting for application shutdown. 218s INFO: Application shutdown complete. 218s INFO: Finished server process [2904] 218s PASSED 218s tests/test_server.py::test_server_interrupt[capture_signal_sync-2] INFO: Started server process [2904] 218s INFO: Waiting for application startup. 218s INFO: Application startup complete. 218s INFO: Uvicorn running on http://127.0.0.1:8000 (Press CTRL+C to quit) 218s INFO: Shutting down 218s INFO: Waiting for application shutdown. 218s INFO: Application shutdown complete. 218s INFO: Finished server process [2904] 218s PASSED 218s tests/test_server.py::test_server_interrupt[capture_signal_async-15] INFO: Started server process [2904] 218s INFO: Waiting for application startup. 218s INFO: Application startup complete. 218s INFO: Uvicorn running on http://127.0.0.1:8000 (Press CTRL+C to quit) 218s INFO: Shutting down 219s INFO: Waiting for application shutdown. 219s INFO: Application shutdown complete. 219s INFO: Finished server process [2904] 219s PASSED 219s tests/test_server.py::test_server_interrupt[capture_signal_async-2] INFO: Started server process [2904] 219s INFO: Waiting for application startup. 219s INFO: Application startup complete. 219s INFO: Uvicorn running on http://127.0.0.1:8000 (Press CTRL+C to quit) 219s INFO: Shutting down 219s INFO: Waiting for application shutdown. 219s INFO: Application shutdown complete. 219s INFO: Finished server process [2904] 219s PASSED 219s tests/test_subprocess.py::test_get_subprocess PASSED 219s tests/test_subprocess.py::test_subprocess_started PASSED 219s tests/importer/test_importer.py::test_invalid_format PASSED 219s tests/importer/test_importer.py::test_invalid_module PASSED 219s tests/importer/test_importer.py::test_invalid_attr PASSED 219s tests/importer/test_importer.py::test_internal_import_error PASSED 219s tests/importer/test_importer.py::test_valid_import PASSED 219s tests/importer/test_importer.py::test_no_import_needed PASSED 219s tests/importer/test_importer.py::test_circular_import_error PASSED 219s tests/middleware/test_logging.py::test_access_logging[True] INFO: Started server process [2904] 219s INFO: Waiting for application startup. 219s INFO: ASGI 'lifespan' protocol appears unsupported. 219s INFO: Application startup complete. 219s INFO: Uvicorn running on http://127.0.0.1:38407 (Press CTRL+C to quit) 219s INFO: 127.0.0.1:53090 - "GET / HTTP/1.1" 204 No Content 219s INFO: Shutting down 219s PASSED 219s tests/middleware/test_logging.py::test_access_logging[False] INFO: Started server process [2904] 219s INFO: Waiting for application startup. 219s INFO: ASGI 'lifespan' protocol appears unsupported. 219s INFO: Application startup complete. 219s INFO: Uvicorn running on http://127.0.0.1:37103 (Press CTRL+C to quit) 219s INFO: 127.0.0.1:36532 - "GET / HTTP/1.1" 204 No Content 219s INFO: Shutting down 219s PASSED 219s tests/middleware/test_logging.py::test_access_logging[None] INFO: Started server process [2904] 219s INFO: Waiting for application startup. 219s INFO: ASGI 'lifespan' protocol appears unsupported. 219s INFO: Application startup complete. 219s INFO: Uvicorn running on http://127.0.0.1:33067 (Press CTRL+C to quit) 219s INFO: 127.0.0.1:57382 - "GET / HTTP/1.1" 204 No Content 219s INFO: Shutting down 220s PASSED 220s tests/middleware/test_logging.py::test_default_logging[True] INFO: Started server process [2904] 220s INFO: Waiting for application startup. 220s INFO: ASGI 'lifespan' protocol appears unsupported. 220s INFO: Application startup complete. 220s INFO: Uvicorn running on http://127.0.0.1:36007 (Press CTRL+C to quit) 220s INFO: 127.0.0.1:53762 - "GET / HTTP/1.1" 204 No Content 220s INFO: Shutting down 220s PASSED 220s tests/middleware/test_logging.py::test_default_logging[False] INFO: Started server process [2904] 220s INFO: Waiting for application startup. 220s INFO: ASGI 'lifespan' protocol appears unsupported. 220s INFO: Application startup complete. 220s INFO: Uvicorn running on http://127.0.0.1:54521 (Press CTRL+C to quit) 220s INFO: 127.0.0.1:50856 - "GET / HTTP/1.1" 204 No Content 220s INFO: Shutting down 220s PASSED 220s tests/middleware/test_logging.py::test_unknown_status_code INFO: Started server process [2904] 220s INFO: Waiting for application startup. 220s INFO: ASGI 'lifespan' protocol appears unsupported. 220s INFO: Application startup complete. 220s INFO: Uvicorn running on http://127.0.0.1:38333 (Press CTRL+C to quit) 220s INFO: 127.0.0.1:43688 - "GET / HTTP/1.1" 599 220s INFO: Shutting down 220s PASSED 220s tests/middleware/test_logging.py::test_server_start_with_port_zero INFO: Started server process [2904] 220s INFO: Waiting for application startup. 220s INFO: ASGI 'lifespan' protocol appears unsupported. 220s INFO: Application startup complete. 220s INFO: Uvicorn running on http://127.0.0.1:34607 (Press CTRL+C to quit) 220s INFO: Shutting down 221s PASSED 221s tests/middleware/test_message_logger.py::test_message_logger PASSED 221s tests/middleware/test_message_logger.py::test_message_logger_exc PASSED 221s tests/middleware/test_proxy_headers.py::test_proxy_headers_trusted_hosts[*-Remote: https://1.2.3.4:0] PASSED 221s tests/middleware/test_proxy_headers.py::test_proxy_headers_trusted_hosts[127.0.0.1-Remote: https://1.2.3.4:0] PASSED 221s tests/middleware/test_proxy_headers.py::test_proxy_headers_trusted_hosts[trusted_hosts2-Remote: https://1.2.3.4:0] PASSED 221s tests/middleware/test_proxy_headers.py::test_proxy_headers_trusted_hosts[trusted_hosts3-Remote: https://1.2.3.4:0] PASSED 221s tests/middleware/test_proxy_headers.py::test_proxy_headers_trusted_hosts[127.0.0.1, 10.0.0.1-Remote: https://1.2.3.4:0] PASSED 221s tests/middleware/test_proxy_headers.py::test_proxy_headers_trusted_hosts[192.168.0.1-Remote: http://127.0.0.1:123] PASSED 221s tests/middleware/test_proxy_headers.py::test_proxy_headers_multiple_proxies[*-Remote: https://1.2.3.4:0] PASSED 221s tests/middleware/test_proxy_headers.py::test_proxy_headers_multiple_proxies[trusted_hosts1-Remote: https://1.2.3.4:0] PASSED 221s tests/middleware/test_proxy_headers.py::test_proxy_headers_multiple_proxies[trusted_hosts2-Remote: https://1.2.3.4:0] PASSED 221s tests/middleware/test_proxy_headers.py::test_proxy_headers_multiple_proxies[trusted_hosts3-Remote: https://10.0.2.1:0] PASSED 221s tests/middleware/test_proxy_headers.py::test_proxy_headers_invalid_x_forwarded_for PASSED 221s tests/middleware/test_proxy_headers.py::test_proxy_headers_websocket_x_forwarded_proto[wsproto-httptools-http-ws://1.2.3.4:0] INFO: Started server process [2904] 221s INFO: Uvicorn running on http://127.0.0.1:55973 (Press CTRL+C to quit) 221s INFO: ('1.2.3.4', 0) - "WebSocket /" [accepted] 221s INFO: Shutting down 221s PASSED 221s tests/middleware/test_proxy_headers.py::test_proxy_headers_websocket_x_forwarded_proto[wsproto-httptools-https-wss://1.2.3.4:0] INFO: Started server process [2904] 221s INFO: Uvicorn running on http://127.0.0.1:38131 (Press CTRL+C to quit) 221s INFO: ('1.2.3.4', 0) - "WebSocket /" [accepted] 221s INFO: Shutting down 221s PASSED 221s tests/middleware/test_proxy_headers.py::test_proxy_headers_websocket_x_forwarded_proto[wsproto-httptools-ws-ws://1.2.3.4:0] INFO: Started server process [2904] 221s INFO: Uvicorn running on http://127.0.0.1:35467 (Press CTRL+C to quit) 221s INFO: ('1.2.3.4', 0) - "WebSocket /" [accepted] 221s INFO: Shutting down 221s PASSED 221s tests/middleware/test_proxy_headers.py::test_proxy_headers_websocket_x_forwarded_proto[wsproto-httptools-wss-wss://1.2.3.4:0] INFO: Started server process [2904] 221s INFO: Uvicorn running on http://127.0.0.1:44803 (Press CTRL+C to quit) 221s INFO: ('1.2.3.4', 0) - "WebSocket /" [accepted] 221s INFO: Shutting down 221s PASSED 221s tests/middleware/test_proxy_headers.py::test_proxy_headers_websocket_x_forwarded_proto[wsproto-h11-http-ws://1.2.3.4:0] INFO: Started server process [2904] 221s INFO: Uvicorn running on http://127.0.0.1:36369 (Press CTRL+C to quit) 222s INFO: ('1.2.3.4', 0) - "WebSocket /" [accepted] 222s INFO: Shutting down 222s PASSED 222s tests/middleware/test_proxy_headers.py::test_proxy_headers_websocket_x_forwarded_proto[wsproto-h11-https-wss://1.2.3.4:0] INFO: Started server process [2904] 222s INFO: Uvicorn running on http://127.0.0.1:53463 (Press CTRL+C to quit) 222s INFO: ('1.2.3.4', 0) - "WebSocket /" [accepted] 222s INFO: Shutting down 222s PASSED 222s tests/middleware/test_proxy_headers.py::test_proxy_headers_websocket_x_forwarded_proto[wsproto-h11-ws-ws://1.2.3.4:0] INFO: Started server process [2904] 222s INFO: Uvicorn running on http://127.0.0.1:60839 (Press CTRL+C to quit) 222s INFO: ('1.2.3.4', 0) - "WebSocket /" [accepted] 222s INFO: Shutting down 222s PASSED 222s tests/middleware/test_proxy_headers.py::test_proxy_headers_websocket_x_forwarded_proto[wsproto-h11-wss-wss://1.2.3.4:0] INFO: Started server process [2904] 222s INFO: Uvicorn running on http://127.0.0.1:49439 (Press CTRL+C to quit) 222s INFO: ('1.2.3.4', 0) - "WebSocket /" [accepted] 222s INFO: Shutting down 222s PASSED 222s tests/middleware/test_proxy_headers.py::test_proxy_headers_websocket_x_forwarded_proto[websockets-httptools-http-ws://1.2.3.4:0] INFO: Started server process [2904] 222s INFO: Uvicorn running on http://127.0.0.1:54055 (Press CTRL+C to quit) 222s INFO: ('1.2.3.4', 0) - "WebSocket /" [accepted] 222s INFO: connection open 222s INFO: Shutting down 222s INFO: connection closed 223s PASSED 223s tests/middleware/test_proxy_headers.py::test_proxy_headers_websocket_x_forwarded_proto[websockets-httptools-https-wss://1.2.3.4:0] INFO: Started server process [2904] 223s INFO: Uvicorn running on http://127.0.0.1:42967 (Press CTRL+C to quit) 223s INFO: ('1.2.3.4', 0) - "WebSocket /" [accepted] 223s INFO: connection open 223s INFO: Shutting down 223s INFO: connection closed 223s PASSED 223s tests/middleware/test_proxy_headers.py::test_proxy_headers_websocket_x_forwarded_proto[websockets-httptools-ws-ws://1.2.3.4:0] INFO: Started server process [2904] 223s INFO: Uvicorn running on http://127.0.0.1:41879 (Press CTRL+C to quit) 223s INFO: ('1.2.3.4', 0) - "WebSocket /" [accepted] 223s INFO: connection open 223s INFO: Shutting down 223s INFO: connection closed 223s PASSED 223s tests/middleware/test_proxy_headers.py::test_proxy_headers_websocket_x_forwarded_proto[websockets-httptools-wss-wss://1.2.3.4:0] INFO: Started server process [2904] 223s INFO: Uvicorn running on http://127.0.0.1:36837 (Press CTRL+C to quit) 223s INFO: ('1.2.3.4', 0) - "WebSocket /" [accepted] 223s INFO: connection open 223s INFO: Shutting down 223s INFO: connection closed 223s PASSED 223s tests/middleware/test_proxy_headers.py::test_proxy_headers_websocket_x_forwarded_proto[websockets-h11-http-ws://1.2.3.4:0] INFO: Started server process [2904] 223s INFO: Uvicorn running on http://127.0.0.1:48449 (Press CTRL+C to quit) 223s INFO: ('1.2.3.4', 0) - "WebSocket /" [accepted] 223s INFO: connection open 223s INFO: Shutting down 223s INFO: connection closed 223s PASSED 223s tests/middleware/test_proxy_headers.py::test_proxy_headers_websocket_x_forwarded_proto[websockets-h11-https-wss://1.2.3.4:0] INFO: Started server process [2904] 223s INFO: Uvicorn running on http://127.0.0.1:52195 (Press CTRL+C to quit) 223s INFO: ('1.2.3.4', 0) - "WebSocket /" [accepted] 223s INFO: connection open 223s INFO: Shutting down 223s INFO: connection closed 224s PASSED 224s tests/middleware/test_proxy_headers.py::test_proxy_headers_websocket_x_forwarded_proto[websockets-h11-ws-ws://1.2.3.4:0] INFO: Started server process [2904] 224s INFO: Uvicorn running on http://127.0.0.1:47359 (Press CTRL+C to quit) 224s INFO: ('1.2.3.4', 0) - "WebSocket /" [accepted] 224s INFO: connection open 224s INFO: Shutting down 224s INFO: connection closed 224s PASSED 224s tests/middleware/test_proxy_headers.py::test_proxy_headers_websocket_x_forwarded_proto[websockets-h11-wss-wss://1.2.3.4:0] INFO: Started server process [2904] 224s INFO: Uvicorn running on http://127.0.0.1:55803 (Press CTRL+C to quit) 224s INFO: ('1.2.3.4', 0) - "WebSocket /" [accepted] 224s INFO: connection open 224s INFO: Shutting down 224s INFO: connection closed 224s PASSED 224s tests/middleware/test_wsgi.py::test_wsgi_get[_WSGIMiddleware] PASSED 224s tests/middleware/test_wsgi.py::test_wsgi_get[WSGIMiddleware] PASSED 224s tests/middleware/test_wsgi.py::test_wsgi_post[_WSGIMiddleware] PASSED 224s tests/middleware/test_wsgi.py::test_wsgi_post[WSGIMiddleware] PASSED 224s tests/middleware/test_wsgi.py::test_wsgi_put_more_body[_WSGIMiddleware] PASSED 224s tests/middleware/test_wsgi.py::test_wsgi_put_more_body[WSGIMiddleware] PASSED 224s tests/middleware/test_wsgi.py::test_wsgi_exception[_WSGIMiddleware] PASSED 224s tests/middleware/test_wsgi.py::test_wsgi_exception[WSGIMiddleware] PASSED 224s tests/middleware/test_wsgi.py::test_wsgi_exc_info[_WSGIMiddleware] PASSED 224s tests/middleware/test_wsgi.py::test_wsgi_exc_info[WSGIMiddleware] PASSED 224s tests/middleware/test_wsgi.py::test_build_environ_encoding PASSED 224s tests/protocols/test_http.py::test_get_request[httptools] INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 200 OK 224s PASSED 224s tests/protocols/test_http.py::test_get_request[h11] INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 200 OK 224s PASSED 224s tests/protocols/test_http.py::test_header_value_allowed_characters[httptools-allow_ascii_letter] INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 200 OK 224s PASSED 224s tests/protocols/test_http.py::test_header_value_allowed_characters[httptools-allow_tab] INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 200 OK 224s PASSED 224s tests/protocols/test_http.py::test_header_value_allowed_characters[httptools-allow_space] INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 200 OK 224s PASSED 224s tests/protocols/test_http.py::test_header_value_allowed_characters[httptools-allow_non_ascii_char] INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 200 OK 224s PASSED 224s tests/protocols/test_http.py::test_header_value_allowed_characters[h11-allow_ascii_letter] INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 200 OK 224s PASSED 224s tests/protocols/test_http.py::test_header_value_allowed_characters[h11-allow_tab] INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 200 OK 224s PASSED 224s tests/protocols/test_http.py::test_header_value_allowed_characters[h11-allow_space] INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 200 OK 224s PASSED 224s tests/protocols/test_http.py::test_header_value_allowed_characters[h11-allow_non_ascii_char] INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 200 OK 224s PASSED 224s tests/protocols/test_http.py::test_request_logging[httptools-/] INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 200 OK 224s INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 200 224s PASSED 224s tests/protocols/test_http.py::test_request_logging[httptools-/?foo] INFO: 127.0.0.1:8001 - "GET /?foo HTTP/1.1" 200 OK 224s INFO: 127.0.0.1:8001 - "GET /?foo HTTP/1.1" 200 224s PASSED 224s tests/protocols/test_http.py::test_request_logging[httptools-/?foo=bar] INFO: 127.0.0.1:8001 - "GET /?foo=bar HTTP/1.1" 200 OK 224s INFO: 127.0.0.1:8001 - "GET /?foo=bar HTTP/1.1" 200 224s PASSED 224s tests/protocols/test_http.py::test_request_logging[httptools-/?foo=bar&baz=1] INFO: 127.0.0.1:8001 - "GET /?foo=bar&baz=1 HTTP/1.1" 200 OK 224s INFO: 127.0.0.1:8001 - "GET /?foo=bar&baz=1 HTTP/1.1" 200 224s PASSED 224s tests/protocols/test_http.py::test_request_logging[h11-/] INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 200 OK 224s INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 200 224s PASSED 224s tests/protocols/test_http.py::test_request_logging[h11-/?foo] INFO: 127.0.0.1:8001 - "GET /?foo HTTP/1.1" 200 OK 224s INFO: 127.0.0.1:8001 - "GET /?foo HTTP/1.1" 200 224s PASSED 224s tests/protocols/test_http.py::test_request_logging[h11-/?foo=bar] INFO: 127.0.0.1:8001 - "GET /?foo=bar HTTP/1.1" 200 OK 224s INFO: 127.0.0.1:8001 - "GET /?foo=bar HTTP/1.1" 200 224s PASSED 224s tests/protocols/test_http.py::test_request_logging[h11-/?foo=bar&baz=1] INFO: 127.0.0.1:8001 - "GET /?foo=bar&baz=1 HTTP/1.1" 200 OK 224s INFO: 127.0.0.1:8001 - "GET /?foo=bar&baz=1 HTTP/1.1" 200 224s PASSED 224s tests/protocols/test_http.py::test_head_request[httptools] INFO: 127.0.0.1:8001 - "HEAD / HTTP/1.1" 200 OK 224s PASSED 224s tests/protocols/test_http.py::test_head_request[h11] INFO: 127.0.0.1:8001 - "HEAD / HTTP/1.1" 200 OK 224s PASSED 224s tests/protocols/test_http.py::test_post_request[httptools] INFO: 127.0.0.1:8001 - "POST / HTTP/1.1" 200 OK 224s PASSED 224s tests/protocols/test_http.py::test_post_request[h11] INFO: 127.0.0.1:8001 - "POST / HTTP/1.1" 200 OK 224s PASSED 224s tests/protocols/test_http.py::test_keepalive[httptools] INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 204 No Content 224s PASSED 224s tests/protocols/test_http.py::test_keepalive[h11] INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 204 No Content 224s PASSED 224s tests/protocols/test_http.py::test_keepalive_timeout[httptools] INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 204 No Content 224s PASSED 224s tests/protocols/test_http.py::test_keepalive_timeout[h11] INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 204 No Content 224s PASSED 224s tests/protocols/test_http.py::test_keepalive_timeout_with_pipelined_requests[httptools] INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 200 OK 224s INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 200 OK 224s PASSED 224s tests/protocols/test_http.py::test_keepalive_timeout_with_pipelined_requests[h11] INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 200 OK 224s INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 200 OK 224s PASSED 224s tests/protocols/test_http.py::test_close[httptools] INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 204 No Content 224s PASSED 224s tests/protocols/test_http.py::test_close[h11] INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 204 No Content 224s PASSED 224s tests/protocols/test_http.py::test_chunked_encoding[httptools] INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 200 OK 224s PASSED 224s tests/protocols/test_http.py::test_chunked_encoding[h11] INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 200 OK 224s PASSED 224s tests/protocols/test_http.py::test_chunked_encoding_empty_body[httptools] INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 200 OK 224s PASSED 224s tests/protocols/test_http.py::test_chunked_encoding_empty_body[h11] INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 200 OK 224s PASSED 224s tests/protocols/test_http.py::test_chunked_encoding_head_request[httptools] INFO: 127.0.0.1:8001 - "HEAD / HTTP/1.1" 200 OK 224s PASSED 224s tests/protocols/test_http.py::test_chunked_encoding_head_request[h11] INFO: 127.0.0.1:8001 - "HEAD / HTTP/1.1" 200 OK 224s PASSED 224s tests/protocols/test_http.py::test_pipelined_requests[httptools] INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 200 OK 224s INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 200 OK 224s INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 200 OK 224s PASSED 224s tests/protocols/test_http.py::test_pipelined_requests[h11] INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 200 OK 224s INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 200 OK 224s INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 200 OK 224s PASSED 224s tests/protocols/test_http.py::test_undersized_request[httptools] INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 200 OK 224s ERROR: Exception in ASGI application 224s Traceback (most recent call last): 224s File "/usr/lib/python3/dist-packages/uvicorn/protocols/http/httptools_impl.py", line 399, in run_asgi 224s result = await app( # type: ignore[func-returns-value] 224s ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 224s File "/usr/lib/python3/dist-packages/uvicorn/middleware/proxy_headers.py", line 70, in __call__ 224s return await self.app(scope, receive, send) 224s ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 224s File "/tmp/autopkgtest.3NsjGX/autopkgtest_tmp/tests/response.py", line 21, in __call__ 224s await send({"type": prefix + "http.response.body", "body": self.body}) 224s File "/usr/lib/python3/dist-packages/uvicorn/protocols/http/httptools_impl.py", line 534, in send 224s raise RuntimeError("Response content shorter than Content-Length") 224s RuntimeError: Response content shorter than Content-Length 224s PASSED 224s tests/protocols/test_http.py::test_undersized_request[h11] INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 200 OK 224s ERROR: Exception in ASGI application 224s Traceback (most recent call last): 224s File "/usr/lib/python3/dist-packages/uvicorn/protocols/http/h11_impl.py", line 396, in run_asgi 224s result = await app( # type: ignore[func-returns-value] 224s ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 224s File "/usr/lib/python3/dist-packages/uvicorn/middleware/proxy_headers.py", line 70, in __call__ 224s return await self.app(scope, receive, send) 224s ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 224s File "/tmp/autopkgtest.3NsjGX/autopkgtest_tmp/tests/response.py", line 21, in __call__ 224s await send({"type": prefix + "http.response.body", "body": self.body}) 224s File "/usr/lib/python3/dist-packages/uvicorn/protocols/http/h11_impl.py", line 500, in send 224s output = self.conn.send(event=h11.EndOfMessage()) 224s ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 224s File "/usr/lib/python3/dist-packages/h11/_connection.py", line 512, in send 224s data_list = self.send_with_data_passthrough(event) 224s ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 224s File "/usr/lib/python3/dist-packages/h11/_connection.py", line 545, in send_with_data_passthrough 224s writer(event, data_list.append) 224s File "/usr/lib/python3/dist-packages/h11/_writers.py", line 67, in __call__ 224s self.send_eom(event.headers, write) 224s File "/usr/lib/python3/dist-packages/h11/_writers.py", line 96, in send_eom 224s raise LocalProtocolError("Too little data for declared Content-Length") 224s h11._util.LocalProtocolError: Too little data for declared Content-Length 224s PASSED 224s tests/protocols/test_http.py::test_oversized_request[httptools] INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 200 OK 224s ERROR: Exception in ASGI application 224s Traceback (most recent call last): 224s File "/usr/lib/python3/dist-packages/uvicorn/protocols/http/httptools_impl.py", line 399, in run_asgi 224s result = await app( # type: ignore[func-returns-value] 224s ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 224s File "/usr/lib/python3/dist-packages/uvicorn/middleware/proxy_headers.py", line 70, in __call__ 224s return await self.app(scope, receive, send) 224s ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 224s File "/tmp/autopkgtest.3NsjGX/autopkgtest_tmp/tests/response.py", line 21, in __call__ 224s await send({"type": prefix + "http.response.body", "body": self.body}) 224s File "/usr/lib/python3/dist-packages/uvicorn/protocols/http/httptools_impl.py", line 526, in send 224s raise RuntimeError("Response content longer than Content-Length") 224s RuntimeError: Response content longer than Content-Length 224s PASSED 224s tests/protocols/test_http.py::test_oversized_request[h11] INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 200 OK 224s ERROR: Exception in ASGI application 224s Traceback (most recent call last): 224s File "/usr/lib/python3/dist-packages/uvicorn/protocols/http/h11_impl.py", line 396, in run_asgi 224s result = await app( # type: ignore[func-returns-value] 224s ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 224s File "/usr/lib/python3/dist-packages/uvicorn/middleware/proxy_headers.py", line 70, in __call__ 224s return await self.app(scope, receive, send) 224s ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 224s File "/tmp/autopkgtest.3NsjGX/autopkgtest_tmp/tests/response.py", line 21, in __call__ 224s await send({"type": prefix + "http.response.body", "body": self.body}) 224s File "/usr/lib/python3/dist-packages/uvicorn/protocols/http/h11_impl.py", line 493, in send 224s output = self.conn.send(event=h11.Data(data=data)) 224s ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 224s File "/usr/lib/python3/dist-packages/h11/_connection.py", line 512, in send 224s data_list = self.send_with_data_passthrough(event) 224s ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 224s File "/usr/lib/python3/dist-packages/h11/_connection.py", line 545, in send_with_data_passthrough 224s writer(event, data_list.append) 224s File "/usr/lib/python3/dist-packages/h11/_writers.py", line 65, in __call__ 224s self.send_data(event.data, write) 224s File "/usr/lib/python3/dist-packages/h11/_writers.py", line 91, in send_data 224s raise LocalProtocolError("Too much data for declared Content-Length") 224s h11._util.LocalProtocolError: Too much data for declared Content-Length 224s PASSED 224s tests/protocols/test_http.py::test_large_post_request[httptools] INFO: 127.0.0.1:8001 - "POST / HTTP/1.1" 200 OK 224s PASSED 224s tests/protocols/test_http.py::test_large_post_request[h11] INFO: 127.0.0.1:8001 - "POST / HTTP/1.1" 200 OK 224s PASSED 224s tests/protocols/test_http.py::test_invalid_http[httptools] WARNING: Invalid HTTP request received. 224s PASSED 224s tests/protocols/test_http.py::test_invalid_http[h11] WARNING: Invalid HTTP request received. 224s PASSED 224s tests/protocols/test_http.py::test_app_exception[httptools] ERROR: Exception in ASGI application 224s Traceback (most recent call last): 224s File "/usr/lib/python3/dist-packages/uvicorn/protocols/http/httptools_impl.py", line 399, in run_asgi 224s result = await app( # type: ignore[func-returns-value] 224s ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 224s File "/usr/lib/python3/dist-packages/uvicorn/middleware/proxy_headers.py", line 70, in __call__ 224s return await self.app(scope, receive, send) 224s ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 224s File "/tmp/autopkgtest.3NsjGX/autopkgtest_tmp/tests/protocols/test_http.py", line 471, in app 224s raise Exception() 224s Exception 224s INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 500 Internal Server Error 224s PASSED 224s tests/protocols/test_http.py::test_app_exception[h11] ERROR: Exception in ASGI application 224s Traceback (most recent call last): 224s File "/usr/lib/python3/dist-packages/uvicorn/protocols/http/h11_impl.py", line 396, in run_asgi 224s result = await app( # type: ignore[func-returns-value] 224s ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 224s File "/usr/lib/python3/dist-packages/uvicorn/middleware/proxy_headers.py", line 70, in __call__ 224s return await self.app(scope, receive, send) 224s ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 224s File "/tmp/autopkgtest.3NsjGX/autopkgtest_tmp/tests/protocols/test_http.py", line 471, in app 224s raise Exception() 224s Exception 224s INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 500 Internal Server Error 224s PASSED 224s tests/protocols/test_http.py::test_exception_during_response[httptools] INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 200 OK 224s ERROR: Exception in ASGI application 224s Traceback (most recent call last): 224s File "/usr/lib/python3/dist-packages/uvicorn/protocols/http/httptools_impl.py", line 399, in run_asgi 224s result = await app( # type: ignore[func-returns-value] 224s ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 224s File "/usr/lib/python3/dist-packages/uvicorn/middleware/proxy_headers.py", line 70, in __call__ 224s return await self.app(scope, receive, send) 224s ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 224s File "/tmp/autopkgtest.3NsjGX/autopkgtest_tmp/tests/protocols/test_http.py", line 484, in app 224s raise Exception() 224s Exception 224s PASSED 224s tests/protocols/test_http.py::test_exception_during_response[h11] INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 200 OK 224s ERROR: Exception in ASGI application 224s Traceback (most recent call last): 224s File "/usr/lib/python3/dist-packages/uvicorn/protocols/http/h11_impl.py", line 396, in run_asgi 224s result = await app( # type: ignore[func-returns-value] 224s ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 224s File "/usr/lib/python3/dist-packages/uvicorn/middleware/proxy_headers.py", line 70, in __call__ 224s return await self.app(scope, receive, send) 224s ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 224s File "/tmp/autopkgtest.3NsjGX/autopkgtest_tmp/tests/protocols/test_http.py", line 484, in app 224s raise Exception() 224s Exception 224s PASSED 224s tests/protocols/test_http.py::test_no_response_returned[httptools] ERROR: ASGI callable returned without starting response. 224s INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 500 Internal Server Error 224s PASSED 224s tests/protocols/test_http.py::test_no_response_returned[h11] ERROR: ASGI callable returned without starting response. 224s INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 500 Internal Server Error 224s PASSED 224s tests/protocols/test_http.py::test_partial_response_returned[httptools] INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 200 OK 224s ERROR: ASGI callable returned without completing response. 224s PASSED 224s tests/protocols/test_http.py::test_partial_response_returned[h11] INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 200 OK 224s ERROR: ASGI callable returned without completing response. 224s PASSED 224s tests/protocols/test_http.py::test_response_header_splitting[httptools] INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 200 OK 224s ERROR: Exception in ASGI application 224s Traceback (most recent call last): 224s File "/usr/lib/python3/dist-packages/uvicorn/protocols/http/httptools_impl.py", line 399, in run_asgi 224s result = await app( # type: ignore[func-returns-value] 224s ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 224s File "/usr/lib/python3/dist-packages/uvicorn/middleware/proxy_headers.py", line 70, in __call__ 224s return await self.app(scope, receive, send) 224s ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 224s File "/tmp/autopkgtest.3NsjGX/autopkgtest_tmp/tests/response.py", line 14, in __call__ 224s await send( 224s File "/usr/lib/python3/dist-packages/uvicorn/protocols/http/httptools_impl.py", line 482, in send 224s raise RuntimeError("Invalid HTTP header value.") 224s RuntimeError: Invalid HTTP header value. 224s PASSED 224s tests/protocols/test_http.py::test_response_header_splitting[h11] INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 200 OK 224s ERROR: Exception in ASGI application 224s Traceback (most recent call last): 224s File "/usr/lib/python3/dist-packages/uvicorn/protocols/http/h11_impl.py", line 396, in run_asgi 224s result = await app( # type: ignore[func-returns-value] 224s ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 224s File "/usr/lib/python3/dist-packages/uvicorn/middleware/proxy_headers.py", line 70, in __call__ 224s return await self.app(scope, receive, send) 224s ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 224s File "/tmp/autopkgtest.3NsjGX/autopkgtest_tmp/tests/response.py", line 14, in __call__ 224s await send( 224s File "/usr/lib/python3/dist-packages/uvicorn/protocols/http/h11_impl.py", line 477, in send 224s response = h11.Response(status_code=status, headers=headers, reason=reason) 224s ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 224s File "/usr/lib/python3/dist-packages/h11/_events.py", line 151, in __init__ 224s self, "headers", normalize_and_validate(headers, _parsed=_parsed) 224s ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 224s File "/usr/lib/python3/dist-packages/h11/_headers.py", line 164, in normalize_and_validate 224s validate(_field_value_re, value, "Illegal header value {!r}", value) 224s File "/usr/lib/python3/dist-packages/h11/_util.py", line 91, in validate 224s raise LocalProtocolError(msg) 224s h11._util.LocalProtocolError: Illegal header value b'value\r\nCookie: smuggled=value' 224s PASSED 224s tests/protocols/test_http.py::test_duplicate_start_message[httptools] INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 200 OK 224s ERROR: Exception in ASGI application 224s Traceback (most recent call last): 224s File "/usr/lib/python3/dist-packages/uvicorn/protocols/http/httptools_impl.py", line 399, in run_asgi 224s result = await app( # type: ignore[func-returns-value] 224s ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 224s File "/usr/lib/python3/dist-packages/uvicorn/middleware/proxy_headers.py", line 70, in __call__ 224s return await self.app(scope, receive, send) 224s ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 224s File "/tmp/autopkgtest.3NsjGX/autopkgtest_tmp/tests/protocols/test_http.py", line 528, in app 224s await send({"type": "http.response.start", "status": 200}) 224s File "/usr/lib/python3/dist-packages/uvicorn/protocols/http/httptools_impl.py", line 507, in send 224s raise RuntimeError(msg % message_type) 224s RuntimeError: Expected ASGI message 'http.response.body', but got 'http.response.start'. 224s PASSED 224s tests/protocols/test_http.py::test_duplicate_start_message[h11] INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 200 OK 224s ERROR: Exception in ASGI application 224s Traceback (most recent call last): 224s File "/usr/lib/python3/dist-packages/uvicorn/protocols/http/h11_impl.py", line 396, in run_asgi 224s result = await app( # type: ignore[func-returns-value] 224s ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 224s File "/usr/lib/python3/dist-packages/uvicorn/middleware/proxy_headers.py", line 70, in __call__ 224s return await self.app(scope, receive, send) 224s ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 224s File "/tmp/autopkgtest.3NsjGX/autopkgtest_tmp/tests/protocols/test_http.py", line 528, in app 224s await send({"type": "http.response.start", "status": 200}) 224s File "/usr/lib/python3/dist-packages/uvicorn/protocols/http/h11_impl.py", line 485, in send 224s raise RuntimeError(msg % message_type) 224s RuntimeError: Expected ASGI message 'http.response.body', but got 'http.response.start'. 224s PASSED 224s tests/protocols/test_http.py::test_missing_start_message[httptools] ERROR: Exception in ASGI application 224s Traceback (most recent call last): 224s File "/usr/lib/python3/dist-packages/uvicorn/protocols/http/httptools_impl.py", line 399, in run_asgi 224s result = await app( # type: ignore[func-returns-value] 224s ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 224s File "/usr/lib/python3/dist-packages/uvicorn/middleware/proxy_headers.py", line 70, in __call__ 224s return await self.app(scope, receive, send) 224s ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 224s File "/tmp/autopkgtest.3NsjGX/autopkgtest_tmp/tests/protocols/test_http.py", line 539, in app 224s await send({"type": "http.response.body", "body": b""}) 224s File "/usr/lib/python3/dist-packages/uvicorn/protocols/http/httptools_impl.py", line 453, in send 224s raise RuntimeError(msg % message_type) 224s RuntimeError: Expected ASGI message 'http.response.start', but got 'http.response.body'. 224s INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 500 Internal Server Error 224s PASSED 224s tests/protocols/test_http.py::test_missing_start_message[h11] ERROR: Exception in ASGI application 224s Traceback (most recent call last): 224s File "/usr/lib/python3/dist-packages/uvicorn/protocols/http/h11_impl.py", line 396, in run_asgi 224s result = await app( # type: ignore[func-returns-value] 224s ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 224s File "/usr/lib/python3/dist-packages/uvicorn/middleware/proxy_headers.py", line 70, in __call__ 224s return await self.app(scope, receive, send) 224s ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 224s File "/tmp/autopkgtest.3NsjGX/autopkgtest_tmp/tests/protocols/test_http.py", line 539, in app 224s await send({"type": "http.response.body", "body": b""}) 224s File "/usr/lib/python3/dist-packages/uvicorn/protocols/http/h11_impl.py", line 453, in send 224s raise RuntimeError(msg % message_type) 224s RuntimeError: Expected ASGI message 'http.response.start', but got 'http.response.body'. 224s INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 500 Internal Server Error 224s PASSED 224s tests/protocols/test_http.py::test_message_after_body_complete[httptools] INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 200 OK 224s ERROR: Exception in ASGI application 224s Traceback (most recent call last): 224s File "/usr/lib/python3/dist-packages/uvicorn/protocols/http/httptools_impl.py", line 399, in run_asgi 224s result = await app( # type: ignore[func-returns-value] 224s ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 224s File "/usr/lib/python3/dist-packages/uvicorn/middleware/proxy_headers.py", line 70, in __call__ 224s return await self.app(scope, receive, send) 224s ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 224s File "/tmp/autopkgtest.3NsjGX/autopkgtest_tmp/tests/protocols/test_http.py", line 552, in app 224s await send({"type": "http.response.body", "body": b""}) 224s File "/usr/lib/python3/dist-packages/uvicorn/protocols/http/httptools_impl.py", line 544, in send 224s raise RuntimeError(msg % message_type) 224s RuntimeError: Unexpected ASGI message 'http.response.body' sent, after response already completed. 224s PASSED 224s tests/protocols/test_http.py::test_message_after_body_complete[h11] INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 200 OK 224s ERROR: Exception in ASGI application 224s Traceback (most recent call last): 224s File "/usr/lib/python3/dist-packages/uvicorn/protocols/http/h11_impl.py", line 396, in run_asgi 224s result = await app( # type: ignore[func-returns-value] 224s ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 224s File "/usr/lib/python3/dist-packages/uvicorn/middleware/proxy_headers.py", line 70, in __call__ 224s return await self.app(scope, receive, send) 224s ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 224s File "/tmp/autopkgtest.3NsjGX/autopkgtest_tmp/tests/protocols/test_http.py", line 552, in app 224s await send({"type": "http.response.body", "body": b""}) 224s File "/usr/lib/python3/dist-packages/uvicorn/protocols/http/h11_impl.py", line 506, in send 224s raise RuntimeError(msg % message_type) 224s RuntimeError: Unexpected ASGI message 'http.response.body' sent, after response already completed. 224s PASSED 224s tests/protocols/test_http.py::test_value_returned[httptools] INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 200 OK 224s ERROR: ASGI callable should return None, but returned '123'. 224s PASSED 224s tests/protocols/test_http.py::test_value_returned[h11] INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 200 OK 224s ERROR: ASGI callable should return None, but returned '123'. 224s PASSED 224s tests/protocols/test_http.py::test_early_disconnect[httptools] PASSED 224s tests/protocols/test_http.py::test_early_disconnect[h11] PASSED 224s tests/protocols/test_http.py::test_early_response[httptools] INFO: 127.0.0.1:8001 - "POST / HTTP/1.1" 200 OK 224s PASSED 224s tests/protocols/test_http.py::test_early_response[h11] INFO: 127.0.0.1:8001 - "POST / HTTP/1.1" 200 OK 224s PASSED 224s tests/protocols/test_http.py::test_read_after_response[httptools] INFO: 127.0.0.1:8001 - "POST / HTTP/1.1" 200 OK 224s PASSED 224s tests/protocols/test_http.py::test_read_after_response[h11] INFO: 127.0.0.1:8001 - "POST / HTTP/1.1" 200 OK 224s PASSED 224s tests/protocols/test_http.py::test_http10_request[httptools] INFO: 127.0.0.1:8001 - "GET / HTTP/1.0" 200 OK 224s PASSED 224s tests/protocols/test_http.py::test_http10_request[h11] INFO: 127.0.0.1:8001 - "GET / HTTP/1.0" 200 OK 224s PASSED 224s tests/protocols/test_http.py::test_root_path[httptools] INFO: 127.0.0.1:8001 - "GET /app/ HTTP/1.1" 200 OK 224s PASSED 224s tests/protocols/test_http.py::test_root_path[h11] INFO: 127.0.0.1:8001 - "GET /app/ HTTP/1.1" 200 OK 224s PASSED 224s tests/protocols/test_http.py::test_raw_path[httptools] INFO: 127.0.0.1:8001 - "GET /app/one/two HTTP/1.1" 200 OK 224s PASSED 224s tests/protocols/test_http.py::test_raw_path[h11] INFO: 127.0.0.1:8001 - "GET /app/one/two HTTP/1.1" 200 OK 224s PASSED 224s tests/protocols/test_http.py::test_max_concurrency[httptools] WARNING: Exceeded concurrency limit. 224s INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 503 Service Unavailable 224s PASSED 224s tests/protocols/test_http.py::test_max_concurrency[h11] WARNING: Exceeded concurrency limit. 224s INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 503 Service Unavailable 224s PASSED 224s tests/protocols/test_http.py::test_shutdown_during_request[httptools] INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 204 No Content 224s PASSED 224s tests/protocols/test_http.py::test_shutdown_during_request[h11] INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 204 No Content 224s PASSED 224s tests/protocols/test_http.py::test_shutdown_during_idle[httptools] PASSED 224s tests/protocols/test_http.py::test_shutdown_during_idle[h11] PASSED 224s tests/protocols/test_http.py::test_100_continue_sent_when_body_consumed[httptools] INFO: 127.0.0.1:8001 - "POST / HTTP/1.1" 200 OK 224s PASSED 224s tests/protocols/test_http.py::test_100_continue_sent_when_body_consumed[h11] INFO: 127.0.0.1:8001 - "POST / HTTP/1.1" 200 OK 224s PASSED 224s tests/protocols/test_http.py::test_100_continue_not_sent_when_body_not_consumed[httptools] INFO: 127.0.0.1:8001 - "POST / HTTP/1.1" 204 No Content 224s PASSED 224s tests/protocols/test_http.py::test_100_continue_not_sent_when_body_not_consumed[h11] INFO: 127.0.0.1:8001 - "POST / HTTP/1.1" 204 No Content 224s PASSED 225s tests/protocols/test_http.py::test_supported_upgrade_request[httptools] PASSED 225s tests/protocols/test_http.py::test_supported_upgrade_request[h11] PASSED 225s tests/protocols/test_http.py::test_unsupported_ws_upgrade_request[httptools] INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 200 OK 225s PASSED 225s tests/protocols/test_http.py::test_unsupported_ws_upgrade_request[h11] INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 200 OK 225s PASSED 225s tests/protocols/test_http.py::test_unsupported_ws_upgrade_request_warn_on_auto[httptools] WARNING: Unsupported upgrade request. 225s WARNING: No supported WebSocket library detected. Please use "pip install 'uvicorn[standard]'", or install 'websockets' or 'wsproto' manually. 225s WARNING: Unsupported upgrade request. 225s WARNING: No supported WebSocket library detected. Please use "pip install 'uvicorn[standard]'", or install 'websockets' or 'wsproto' manually. 225s WARNING: Unsupported upgrade request. 225s WARNING: No supported WebSocket library detected. Please use "pip install 'uvicorn[standard]'", or install 'websockets' or 'wsproto' manually. 225s INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 200 OK 225s PASSED 225s tests/protocols/test_http.py::test_unsupported_ws_upgrade_request_warn_on_auto[h11] WARNING: Unsupported upgrade request. 225s WARNING: No supported WebSocket library detected. Please use "pip install 'uvicorn[standard]'", or install 'websockets' or 'wsproto' manually. 225s INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 200 OK 225s PASSED 225s tests/protocols/test_http.py::test_http2_upgrade_request[httptools-wsproto] INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 200 OK 225s PASSED 225s tests/protocols/test_http.py::test_http2_upgrade_request[httptools-websockets] INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 200 OK 225s PASSED 225s tests/protocols/test_http.py::test_http2_upgrade_request[h11-wsproto] INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 200 OK 225s PASSED 225s tests/protocols/test_http.py::test_http2_upgrade_request[h11-websockets] INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 200 OK 225s PASSED 225s tests/protocols/test_http.py::test_scopes[httptools-asgi3app-expected_scopes0] ERROR: ASGI callable returned without starting response. 225s INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 500 Internal Server Error 225s PASSED 225s tests/protocols/test_http.py::test_scopes[httptools-asgi2app-expected_scopes1] ERROR: ASGI callable returned without starting response. 225s INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 500 Internal Server Error 225s PASSED 225s tests/protocols/test_http.py::test_scopes[h11-asgi3app-expected_scopes0] ERROR: ASGI callable returned without starting response. 225s INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 500 Internal Server Error 225s PASSED 225s tests/protocols/test_http.py::test_scopes[h11-asgi2app-expected_scopes1] ERROR: ASGI callable returned without starting response. 225s INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 500 Internal Server Error 225s PASSED 225s tests/protocols/test_http.py::test_invalid_http_request[httptools-invalid-method] WARNING: Invalid HTTP request received. 225s PASSED 225s tests/protocols/test_http.py::test_invalid_http_request[httptools-invalid-path] WARNING: Invalid HTTP request received. 225s PASSED 225s tests/protocols/test_http.py::test_invalid_http_request[httptools-invalid-http-version] WARNING: Invalid HTTP request received. 225s PASSED 225s tests/protocols/test_http.py::test_invalid_http_request[h11-invalid-method] WARNING: Invalid HTTP request received. 225s PASSED 225s tests/protocols/test_http.py::test_invalid_http_request[h11-invalid-path] WARNING: Invalid HTTP request received. 225s PASSED 225s tests/protocols/test_http.py::test_invalid_http_request[h11-invalid-http-version] WARNING: Invalid HTTP request received. 225s PASSED 225s tests/protocols/test_http.py::test_fragmentation INFO: Started server process [2904] 225s INFO: Waiting for application startup. 225s INFO: ASGI 'lifespan' protocol appears unsupported. 225s INFO: Application startup complete. 225s INFO: Uvicorn running on http://127.0.0.1:56459 (Press CTRL+C to quit) 226s INFO: 127.0.0.1:57584 - "GET /?param=qqqqqqqqqq HTTP/1.1" 200 OK 226s INFO: Shutting down 226s INFO: Finished server process [2904] 226s PASSED 226s tests/protocols/test_http.py::test_huge_headers_h11protocol_failure WARNING: Invalid HTTP request received. 226s PASSED 226s tests/protocols/test_http.py::test_huge_headers_httptools_will_pass INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 200 OK 226s PASSED 226s tests/protocols/test_http.py::test_huge_headers_h11protocol_failure_with_setting WARNING: Invalid HTTP request received. 226s PASSED 226s tests/protocols/test_http.py::test_huge_headers_httptools INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 200 OK 226s PASSED 226s tests/protocols/test_http.py::test_huge_headers_h11_max_incomplete INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 200 OK 226s WARNING: Invalid HTTP request received. 226s PASSED 226s tests/protocols/test_http.py::test_return_close_header[httptools] INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 200 OK 226s PASSED 226s tests/protocols/test_http.py::test_return_close_header[h11] INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 200 OK 226s PASSED 226s tests/protocols/test_http.py::test_iterator_headers[httptools] INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 200 OK 226s PASSED 226s tests/protocols/test_http.py::test_iterator_headers[h11] INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 200 OK 226s PASSED 226s tests/protocols/test_http.py::test_lifespan_state[httptools] INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 200 OK 226s INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 200 OK 226s PASSED 226s tests/protocols/test_http.py::test_lifespan_state[h11] INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 200 OK 226s INFO: 127.0.0.1:8001 - "GET / HTTP/1.1" 200 OK 226s PASSED 226s tests/protocols/test_utils.py::test_get_local_addr_with_socket PASSED 226s tests/protocols/test_utils.py::test_get_remote_addr_with_socket PASSED 226s tests/protocols/test_utils.py::test_get_local_addr PASSED 226s tests/protocols/test_utils.py::test_get_remote_addr PASSED 226s tests/protocols/test_utils.py::test_get_client_addr[ip:port client] PASSED 226s tests/protocols/test_utils.py::test_get_client_addr[None client] PASSED 226s tests/supervisors/test_multiprocess.py::test_process_ping_pong PASSED 226s tests/supervisors/test_multiprocess.py::test_process_ping_pong_timeout PASSED 226s tests/supervisors/test_multiprocess.py::test_multiprocess_run INFO: Started parent process [2904] 226s PASSED 226s tests/supervisors/test_multiprocess.py::test_multiprocess_health_check INFO: Started parent process [2904] 227s INFO: Received SIGINT, exiting. 227s INFO: Terminated child process [3128] 227s INFO: Terminated child process [3130] 227s INFO: Waiting for child process [3128] 227s INFO: Waiting for child process [3130] 227s INFO: Stopping parent process [2904] 227s INFO: Waiting for child process [3129] 227s INFO: Child process [3129] died 228s INFO: Waiting for child process [3131] 228s INFO: Received SIGINT, exiting. 228s INFO: Terminated child process [3131] 228s INFO: Terminated child process [3134] 228s INFO: Waiting for child process [3131] 228s INFO: Waiting for child process [3134] 228s INFO: Waiting for child process [3134] 228s PASSED 228s tests/supervisors/test_multiprocess.py::test_multiprocess_sigterm INFO: Stopping parent process [2904] 228s INFO: Started parent process [2904] 229s INFO: Waiting for child process [3137] 229s INFO: Received SIGTERM, exiting. 229s INFO: Terminated child process [3137] 229s INFO: Terminated child process [3138] 229s INFO: Waiting for child process [3137] 229s INFO: Waiting for child process [3138] 229s INFO: Waiting for child process [3138] 229s PASSED 229s tests/supervisors/test_multiprocess.py::test_multiprocess_sigbreak SKIPPEDINFO: Stopping parent process [2904] 229s 229s tests/supervisors/test_multiprocess.py::test_multiprocess_sighup INFO: Started parent process [2904] 230s INFO: Received SIGHUP, restarting processes. 230s INFO: Terminated child process [3142] 230s INFO: Waiting for child process [3142] 230s INFO: Terminated child process [3143] 230s INFO: Waiting for child process [3143] 231s INFO: Waiting for child process [3146] 232s INFO: Received SIGINT, exiting. 232s INFO: Terminated child process [3146] 232s INFO: Terminated child process [3147] 232s INFO: Waiting for child process [3146] 232s INFO: Waiting for child process [3147] 232s INFO: Waiting for child process [3147] 232s PASSED 232s tests/supervisors/test_multiprocess.py::test_multiprocess_sigttin INFO: Stopping parent process [2904] 232s INFO: Started parent process [2904] 232s INFO: Received SIGTTIN, increasing the number of processes. 233s INFO: Waiting for child process [3151] 233s INFO: Received SIGINT, exiting. 233s INFO: Terminated child process [3151] 233s INFO: Terminated child process [3152] 233s INFO: Terminated child process [3155] 233s INFO: Waiting for child process [3151] 233s INFO: Waiting for child process [3152] 233s INFO: Waiting for child process [3155] 233s INFO: Stopping parent process [2904] 233s INFO: Waiting for child process [3152] 233s INFO: Waiting for child process [3155] 233s PASSED 233s tests/supervisors/test_multiprocess.py::test_multiprocess_sigttou INFO: Started parent process [2904] 233s INFO: Received SIGTTOU, decreasing number of processes. 233s INFO: Terminated child process [3159] 233s INFO: Waiting for child process [3159] 234s INFO: Received SIGTTOU, decreasing number of processes. 234s INFO: Already reached one process, cannot decrease the number of processes anymore. 235s INFO: Waiting for child process [3158] 235s INFO: Received SIGINT, exiting. 235s INFO: Terminated child process [3158] 235s INFO: Waiting for child process [3158] 235s INFO: Stopping parent process [2904] 235s PASSED 235s tests/supervisors/test_reload.py::TestBaseReload::test_reloader_should_initialize[StatReload] INFO: Will watch for changes in these directories: ['/tmp/pytest-of-ubuntu/pytest-0/reload_directory1'] 235s INFO: Started reloader process [2904] using StatReload 235s INFO: Stopping reloader process [2904] 235s PASSED 235s tests/supervisors/test_reload.py::TestBaseReload::test_reloader_should_initialize[None] SKIPPED 235s tests/supervisors/test_reload.py::TestBaseReload::test_reloader_should_initialize[WatchFilesReload] INFO: Will watch for changes in these directories: ['/tmp/pytest-of-ubuntu/pytest-0/reload_directory1'] 235s INFO: Started reloader process [2904] using WatchFiles 235s INFO: Stopping reloader process [2904] 235s PASSED 235s tests/supervisors/test_reload.py::TestBaseReload::test_reload_when_python_file_is_changed[StatReload] INFO: Will watch for changes in these directories: ['/tmp/pytest-of-ubuntu/pytest-0/reload_directory1'] 235s INFO: Started reloader process [2904] using StatReload 235s INFO: Stopping reloader process [2904] 235s PASSED 235s tests/supervisors/test_reload.py::TestBaseReload::test_reload_when_python_file_is_changed[None] SKIPPED 235s tests/supervisors/test_reload.py::TestBaseReload::test_reload_when_python_file_is_changed[WatchFilesReload] INFO: Will watch for changes in these directories: ['/tmp/pytest-of-ubuntu/pytest-0/reload_directory1'] 235s INFO: Started reloader process [2904] using WatchFiles 235s INFO: Stopping reloader process [2904] 235s PASSED 235s tests/supervisors/test_reload.py::TestBaseReload::test_should_reload_when_python_file_in_subdir_is_changed[StatReload] INFO: Will watch for changes in these directories: ['/tmp/pytest-of-ubuntu/pytest-0/reload_directory1'] 235s INFO: Started reloader process [2904] using StatReload 235s INFO: Stopping reloader process [2904] 235s PASSED 235s tests/supervisors/test_reload.py::TestBaseReload::test_should_reload_when_python_file_in_subdir_is_changed[None] SKIPPED 235s tests/supervisors/test_reload.py::TestBaseReload::test_should_reload_when_python_file_in_subdir_is_changed[WatchFilesReload] INFO: Will watch for changes in these directories: ['/tmp/pytest-of-ubuntu/pytest-0/reload_directory1'] 235s INFO: Started reloader process [2904] using WatchFiles 236s INFO: Stopping reloader process [2904] 236s PASSED 236s tests/supervisors/test_reload.py::TestBaseReload::test_should_not_reload_when_python_file_in_excluded_subdir_is_changed[WatchFilesReload] INFO: Will watch for changes in these directories: ['/tmp/pytest-of-ubuntu/pytest-0/reload_directory1'] 236s INFO: Started reloader process [2904] using WatchFiles 236s INFO: Stopping reloader process [2904] 236s PASSED 236s tests/supervisors/test_reload.py::TestBaseReload::test_should_not_reload_when_python_file_in_excluded_subdir_is_changed[None] SKIPPED 236s tests/supervisors/test_reload.py::TestBaseReload::test_reload_when_pattern_matched_file_is_changed[StatReload-False] INFO: Will watch for changes in these directories: ['/tmp/pytest-of-ubuntu/pytest-0/reload_directory1'] 236s WARNING: --reload-include and --reload-exclude have no effect unless watchfiles is installed. 236s INFO: Started reloader process [2904] using StatReload 236s INFO: Stopping reloader process [2904] 236s PASSED 236s tests/supervisors/test_reload.py::TestBaseReload::test_reload_when_pattern_matched_file_is_changed[WatchFilesReload-True] INFO: Will watch for changes in these directories: ['/tmp/pytest-of-ubuntu/pytest-0/reload_directory1'] 236s INFO: Started reloader process [2904] using WatchFiles 236s INFO: Stopping reloader process [2904] 236s PASSED 236s tests/supervisors/test_reload.py::TestBaseReload::test_should_not_reload_when_exclude_pattern_match_file_is_changed[WatchFilesReload] INFO: Will watch for changes in these directories: ['/tmp/pytest-of-ubuntu/pytest-0/reload_directory1/.dotted_dir', '/tmp/pytest-of-ubuntu/pytest-0/reload_directory1/app', '/tmp/pytest-of-ubuntu/pytest-0/reload_directory1/app_first', '/tmp/pytest-of-ubuntu/pytest-0/reload_directory1/app_second', '/tmp/pytest-of-ubuntu/pytest-0/reload_directory1/app_third', '/tmp/pytest-of-ubuntu/pytest-0/reload_directory1/ext'] 236s INFO: Started reloader process [2904] using WatchFiles 237s INFO: Stopping reloader process [2904] 237s PASSED 237s tests/supervisors/test_reload.py::TestBaseReload::test_should_not_reload_when_exclude_pattern_match_file_is_changed[None] SKIPPED 237s tests/supervisors/test_reload.py::TestBaseReload::test_should_not_reload_when_dot_file_is_changed[StatReload] INFO: Will watch for changes in these directories: ['/tmp/pytest-of-ubuntu/pytest-0/reload_directory1'] 237s INFO: Started reloader process [2904] using StatReload 237s INFO: Stopping reloader process [2904] 237s PASSED 237s tests/supervisors/test_reload.py::TestBaseReload::test_should_not_reload_when_dot_file_is_changed[None] SKIPPED 237s tests/supervisors/test_reload.py::TestBaseReload::test_should_not_reload_when_dot_file_is_changed[WatchFilesReload] INFO: Will watch for changes in these directories: ['/tmp/pytest-of-ubuntu/pytest-0/reload_directory1'] 237s INFO: Started reloader process [2904] using WatchFiles 237s INFO: Stopping reloader process [2904] 237s PASSED 237s tests/supervisors/test_reload.py::TestBaseReload::test_should_reload_when_directories_have_same_prefix[StatReload] INFO: Will watch for changes in these directories: ['/tmp/pytest-of-ubuntu/pytest-0/reload_directory1/app', '/tmp/pytest-of-ubuntu/pytest-0/reload_directory1/app_first'] 237s INFO: Started reloader process [2904] using StatReload 237s INFO: Stopping reloader process [2904] 237s PASSED 237s tests/supervisors/test_reload.py::TestBaseReload::test_should_reload_when_directories_have_same_prefix[None] SKIPPED 237s tests/supervisors/test_reload.py::TestBaseReload::test_should_reload_when_directories_have_same_prefix[WatchFilesReload] INFO: Will watch for changes in these directories: ['/tmp/pytest-of-ubuntu/pytest-0/reload_directory1/app', '/tmp/pytest-of-ubuntu/pytest-0/reload_directory1/app_first'] 237s INFO: Started reloader process [2904] using WatchFiles 238s INFO: Stopping reloader process [2904] 238s PASSED 238s tests/supervisors/test_reload.py::TestBaseReload::test_should_not_reload_when_only_subdirectory_is_watched[StatReload] INFO: Will watch for changes in these directories: ['/tmp/pytest-of-ubuntu/pytest-0/reload_directory1/app'] 238s INFO: Started reloader process [2904] using StatReload 238s INFO: Stopping reloader process [2904] 238s PASSED 238s tests/supervisors/test_reload.py::TestBaseReload::test_should_not_reload_when_only_subdirectory_is_watched[None] SKIPPED 238s tests/supervisors/test_reload.py::TestBaseReload::test_should_not_reload_when_only_subdirectory_is_watched[WatchFilesReload] INFO: Will watch for changes in these directories: ['/tmp/pytest-of-ubuntu/pytest-0/reload_directory1/app'] 238s INFO: Started reloader process [2904] using WatchFiles 238s INFO: Stopping reloader process [2904] 238s PASSED 238s tests/supervisors/test_reload.py::TestBaseReload::test_override_defaults[WatchFilesReload] INFO: Will watch for changes in these directories: ['/tmp/pytest-of-ubuntu/pytest-0/reload_directory1'] 238s INFO: Started reloader process [2904] using WatchFiles 239s INFO: Stopping reloader process [2904] 239s PASSED 239s tests/supervisors/test_reload.py::TestBaseReload::test_override_defaults[None] SKIPPED 239s tests/supervisors/test_reload.py::TestBaseReload::test_explicit_paths[WatchFilesReload] INFO: Will watch for changes in these directories: ['/tmp/pytest-of-ubuntu/pytest-0/reload_directory1'] 239s INFO: Started reloader process [2904] using WatchFiles 240s INFO: Stopping reloader process [2904] 240s PASSED 240s tests/supervisors/test_reload.py::TestBaseReload::test_explicit_paths[None] SKIPPED 240s tests/supervisors/test_reload.py::TestBaseReload::test_watchfiles_no_changes[WatchFilesReload] INFO: Will watch for changes in these directories: ['/tmp/pytest-of-ubuntu/pytest-0/reload_directory1'] 240s INFO: Started reloader process [2904] using WatchFiles 240s INFO: Stopping reloader process [2904] 240s PASSED 240s tests/supervisors/test_reload.py::TestBaseReload::test_should_detect_new_reload_dirs[None] SKIPPED 240s tests/supervisors/test_reload.py::test_should_watch_one_dir_cwd INFO: Will watch for changes in these directories: ['/tmp/pytest-of-ubuntu/pytest-0/reload_directory1/app', '/tmp/pytest-of-ubuntu/pytest-0/reload_directory1/app_first'] 240s PASSED 240s tests/supervisors/test_reload.py::test_should_watch_separate_dirs_outside_cwd INFO: Will watch for changes in these directories: ['/tmp/pytest-of-ubuntu/pytest-0/reload_directory1/app', '/tmp/pytest-of-ubuntu/pytest-0/reload_directory1/app_first'] 240s PASSED 240s tests/supervisors/test_reload.py::test_display_path_relative PASSED 240s tests/supervisors/test_reload.py::test_display_path_non_relative PASSED 240s tests/supervisors/test_reload.py::test_base_reloader_run INFO: Will watch for changes in these directories: ['/tmp/autopkgtest.3NsjGX/autopkgtest_tmp'] 240s WARNING: None detected changes in '/tmp/pytest-of-ubuntu/pytest-0/test_base_reloader_run0/foobar.py'. Reloading... 240s PASSED 240s tests/supervisors/test_reload.py::test_base_reloader_should_exit INFO: Will watch for changes in these directories: ['/tmp/autopkgtest.3NsjGX/autopkgtest_tmp'] 240s PASSED 240s tests/supervisors/test_reload.py::test_base_reloader_closes_sockets_on_shutdown INFO: Will watch for changes in these directories: ['/tmp/autopkgtest.3NsjGX/autopkgtest_tmp'] 240s INFO: Started reloader process [2904] using None 240s INFO: Stopping reloader process [2904] 240s PASSED 240s tests/supervisors/test_signal.py::test_sigint_finish_req INFO: Started server process [2904] 240s INFO: Waiting for application startup. 240s INFO: ASGI 'lifespan' protocol appears unsupported. 240s INFO: Application startup complete. 240s INFO: Uvicorn running on http://127.0.0.1:42555 (Press CTRL+C to quit) 240s INFO: 127.0.0.1:47846 - "GET / HTTP/1.1" 200 OK 240s INFO: Shutting down 240s INFO: Shutting down 240s INFO: Finished server process [2904] 240s PASSED 240s tests/supervisors/test_signal.py::test_sigint_abort_req INFO: Started server process [2904] 240s INFO: Waiting for application startup. 240s INFO: ASGI 'lifespan' protocol appears unsupported. 240s INFO: Application startup complete. 240s INFO: Uvicorn running on http://127.0.0.1:43593 (Press CTRL+C to quit) 241s INFO: 127.0.0.1:58660 - "GET / HTTP/1.1" 200 OK 241s INFO: Shutting down 241s INFO: Waiting for connections to close. (CTRL+C to force quit) 242s ERROR: Cancel 1 running task(s), timeout graceful shutdown exceeded 242s INFO: Finished server process [2904] 242s ERROR: Exception in ASGI application 242s Traceback (most recent call last): 242s File "/usr/lib/python3/dist-packages/uvicorn/protocols/http/httptools_impl.py", line 399, in run_asgi 242s result = await app( # type: ignore[func-returns-value] 242s ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 242s File "/usr/lib/python3/dist-packages/uvicorn/middleware/proxy_headers.py", line 70, in __call__ 242s return await self.app(scope, receive, send) 242s ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 242s File "/tmp/autopkgtest.3NsjGX/autopkgtest_tmp/tests/supervisors/test_signal.py", line 62, in forever_app 242s await server_event.wait() 242s File "/usr/lib/python3.12/asyncio/locks.py", line 212, in wait 242s await fut 242s asyncio.exceptions.CancelledError: Task cancelled, timeout graceful shutdown exceeded 242s INFO: Shutting down 242s PASSED 242s tests/supervisors/test_signal.py::test_sigint_deny_request_after_triggered INFO: Started server process [2904] 242s INFO: Waiting for application startup. 242s INFO: ASGI 'lifespan' protocol appears unsupported. 242s INFO: Application startup complete. 242s INFO: Uvicorn running on http://127.0.0.1:50009 (Press CTRL+C to quit) 242s INFO: Shutting down 242s INFO: Finished server process [2904] 242s INFO: Shutting down 242s PASSED 242s 242s =============================== warnings summary =============================== 242s tests/middleware/test_wsgi.py::test_wsgi_get[_WSGIMiddleware] 242s tests/middleware/test_wsgi.py::test_wsgi_post[_WSGIMiddleware] 242s tests/middleware/test_wsgi.py::test_wsgi_put_more_body[_WSGIMiddleware] 242s tests/middleware/test_wsgi.py::test_wsgi_exception[_WSGIMiddleware] 242s tests/middleware/test_wsgi.py::test_wsgi_exc_info[_WSGIMiddleware] 242s /usr/lib/python3/dist-packages/uvicorn/middleware/wsgi.py:84: DeprecationWarning: Uvicorn's native WSGI implementation is deprecated, you should switch to a2wsgi (`pip install a2wsgi`). 242s warnings.warn( 242s 242s -- Docs: https://docs.pytest.org/en/stable/how-to/capture-warnings.html 242s ========= 363 passed, 12 skipped, 26 deselected, 5 warnings in 25.20s ========== 243s autopkgtest [20:07:02]: test unittests: -----------------------] 243s autopkgtest [20:07:02]: test unittests: - - - - - - - - - - results - - - - - - - - - - 243s unittests PASS 244s autopkgtest [20:07:03]: test autodep8-python3: preparing testbed 563s autopkgtest [20:12:22]: testbed dpkg architecture: s390x 563s autopkgtest [20:12:22]: testbed apt version: 2.9.6 563s autopkgtest [20:12:22]: @@@@@@@@@@@@@@@@@@@@ test bed setup 564s Get:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease [126 kB] 565s Get:2 http://ftpmaster.internal/ubuntu oracular-proposed/restricted Sources [8548 B] 565s Get:3 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse Sources [2576 B] 565s Get:4 http://ftpmaster.internal/ubuntu oracular-proposed/main Sources [45.5 kB] 565s Get:5 http://ftpmaster.internal/ubuntu oracular-proposed/universe Sources [353 kB] 565s Get:6 http://ftpmaster.internal/ubuntu oracular-proposed/main s390x Packages [67.7 kB] 565s Get:7 http://ftpmaster.internal/ubuntu oracular-proposed/main s390x c-n-f Metadata [2112 B] 565s Get:8 http://ftpmaster.internal/ubuntu oracular-proposed/restricted s390x Packages [1368 B] 565s Get:9 http://ftpmaster.internal/ubuntu oracular-proposed/restricted s390x c-n-f Metadata [120 B] 565s Get:10 http://ftpmaster.internal/ubuntu oracular-proposed/universe s390x Packages [329 kB] 566s Get:11 http://ftpmaster.internal/ubuntu oracular-proposed/universe s390x c-n-f Metadata [8372 B] 566s Get:12 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse s390x Packages [1448 B] 566s Get:13 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse s390x c-n-f Metadata [120 B] 566s Fetched 946 kB in 2s (602 kB/s) 566s Reading package lists... 568s Reading package lists... 569s Building dependency tree... 569s Reading state information... 569s Calculating upgrade... 569s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 569s Reading package lists... 569s Building dependency tree... 569s Reading state information... 569s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 570s Hit:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease 570s Get:2 http://ftpmaster.internal/ubuntu oracular InRelease [121 kB] 570s Hit:3 http://ftpmaster.internal/ubuntu oracular-updates InRelease 570s Hit:4 http://ftpmaster.internal/ubuntu oracular-security InRelease 570s Get:5 http://ftpmaster.internal/ubuntu oracular/multiverse Sources [301 kB] 570s Get:6 http://ftpmaster.internal/ubuntu oracular/main Sources [1380 kB] 570s Get:7 http://ftpmaster.internal/ubuntu oracular/universe Sources [20.2 MB] 573s Get:8 http://ftpmaster.internal/ubuntu oracular/main s390x Packages [1348 kB] 573s Get:9 http://ftpmaster.internal/ubuntu oracular/universe s390x Packages [14.8 MB] 575s Get:10 http://ftpmaster.internal/ubuntu oracular/multiverse s390x Packages [167 kB] 578s Fetched 38.3 MB in 8s (4872 kB/s) 578s Reading package lists... 579s Reading package lists... 579s Building dependency tree... 579s Reading state information... 579s Calculating upgrade... 579s The following packages will be upgraded: 579s cpio krb5-locales libgssapi-krb5-2 libk5crypto3 libkrb5-3 libkrb5support0 579s s390-tools s390-tools-data s390-tools-signed 579s 9 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 579s Need to get 3953 kB of archives. 579s After this operation, 77.8 kB disk space will be freed. 579s Get:1 http://ftpmaster.internal/ubuntu oracular/main s390x krb5-locales all 1.21.3-3 [14.3 kB] 579s Get:2 http://ftpmaster.internal/ubuntu oracular/main s390x libgssapi-krb5-2 s390x 1.21.3-3 [146 kB] 580s Get:3 http://ftpmaster.internal/ubuntu oracular/main s390x libkrb5-3 s390x 1.21.3-3 [352 kB] 580s Get:4 http://ftpmaster.internal/ubuntu oracular/main s390x libkrb5support0 s390x 1.21.3-3 [34.8 kB] 580s Get:5 http://ftpmaster.internal/ubuntu oracular/main s390x libk5crypto3 s390x 1.21.3-3 [89.5 kB] 580s Get:6 http://ftpmaster.internal/ubuntu oracular/main s390x cpio s390x 2.15+dfsg-1ubuntu3 [87.9 kB] 580s Get:7 http://ftpmaster.internal/ubuntu oracular/main s390x s390-tools-data all 2.33.1-0ubuntu4 [18.9 kB] 580s Get:8 http://ftpmaster.internal/ubuntu oracular/main s390x s390-tools s390x 2.33.1-0ubuntu4 [3198 kB] 580s Get:9 http://ftpmaster.internal/ubuntu oracular/main s390x s390-tools-signed all 2.33.1-0ubuntu4 [12.3 kB] 580s Fetched 3953 kB in 1s (3560 kB/s) 581s (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 ... 54720 files and directories currently installed.) 581s Preparing to unpack .../0-krb5-locales_1.21.3-3_all.deb ... 581s Unpacking krb5-locales (1.21.3-3) over (1.20.1-6ubuntu2) ... 581s Preparing to unpack .../1-libgssapi-krb5-2_1.21.3-3_s390x.deb ... 581s Unpacking libgssapi-krb5-2:s390x (1.21.3-3) over (1.20.1-6ubuntu2) ... 581s Preparing to unpack .../2-libkrb5-3_1.21.3-3_s390x.deb ... 581s Unpacking libkrb5-3:s390x (1.21.3-3) over (1.20.1-6ubuntu2) ... 581s Preparing to unpack .../3-libkrb5support0_1.21.3-3_s390x.deb ... 581s Unpacking libkrb5support0:s390x (1.21.3-3) over (1.20.1-6ubuntu2) ... 581s Preparing to unpack .../4-libk5crypto3_1.21.3-3_s390x.deb ... 581s Unpacking libk5crypto3:s390x (1.21.3-3) over (1.20.1-6ubuntu2) ... 581s Preparing to unpack .../5-cpio_2.15+dfsg-1ubuntu3_s390x.deb ... 581s Unpacking cpio (2.15+dfsg-1ubuntu3) over (2.15+dfsg-1ubuntu2) ... 581s Preparing to unpack .../6-s390-tools-data_2.33.1-0ubuntu4_all.deb ... 581s Unpacking s390-tools-data (2.33.1-0ubuntu4) over (2.33.1-0ubuntu3) ... 581s Preparing to unpack .../7-s390-tools_2.33.1-0ubuntu4_s390x.deb ... 581s Unpacking s390-tools (2.33.1-0ubuntu4) over (2.33.1-0ubuntu3) ... 581s Preparing to unpack .../8-s390-tools-signed_2.33.1-0ubuntu4_all.deb ... 581s Unpacking s390-tools-signed (2.33.1-0ubuntu4) over (2.33.1-0ubuntu3) ... 581s Setting up cpio (2.15+dfsg-1ubuntu3) ... 581s Setting up krb5-locales (1.21.3-3) ... 581s Setting up libkrb5support0:s390x (1.21.3-3) ... 581s Setting up s390-tools-signed (2.33.1-0ubuntu4) ... 581s Setting up libk5crypto3:s390x (1.21.3-3) ... 581s Setting up libkrb5-3:s390x (1.21.3-3) ... 581s Setting up s390-tools-data (2.33.1-0ubuntu4) ... 581s Setting up libgssapi-krb5-2:s390x (1.21.3-3) ... 581s Setting up s390-tools (2.33.1-0ubuntu4) ... 582s Processing triggers for libc-bin (2.39-0ubuntu9) ... 582s Processing triggers for man-db (2.12.1-2) ... 583s Processing triggers for initramfs-tools (0.142ubuntu30) ... 583s update-initramfs: Generating /boot/initrd.img-6.8.0-31-generic 583s W: No lz4 in /usr/bin:/sbin:/bin, using gzip 587s Using config file '/etc/zipl.conf' 587s Building bootmap in '/boot' 587s Adding IPL section 'ubuntu' (default) 587s Preparing boot device for LD-IPL: vda (0000). 587s Done. 587s Reading package lists... 587s Building dependency tree... 587s Reading state information... 588s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 588s autopkgtest [20:12:47]: rebooting testbed after setup commands that affected boot 592s autopkgtest-virt-ssh: WARNING: ssh connection failed. Retrying in 3 seconds... 622s Reading package lists... 622s Building dependency tree... 622s Reading state information... 622s Starting pkgProblemResolver with broken count: 0 622s Starting 2 pkgProblemResolver with broken count: 0 622s Done 623s The following additional packages will be installed: 623s python3-all python3-click python3-colorama python3-h11 python3-uvicorn 623s python3-uvloop python3-wsproto 623s Suggested packages: 623s python-uvicorn-doc 623s The following NEW packages will be installed: 623s autopkgtest-satdep python3-all python3-click python3-colorama python3-h11 623s python3-uvicorn python3-uvloop python3-wsproto 623s 0 upgraded, 8 newly installed, 0 to remove and 0 not upgraded. 623s Need to get 822 kB/823 kB of archives. 623s After this operation, 3090 kB of additional disk space will be used. 623s Get:1 /tmp/autopkgtest.3NsjGX/2-autopkgtest-satdep.deb autopkgtest-satdep s390x 0 [716 B] 623s Get:2 http://ftpmaster.internal/ubuntu oracular/main s390x python3-all s390x 3.12.3-0ubuntu1 [890 B] 623s Get:3 http://ftpmaster.internal/ubuntu oracular/main s390x python3-colorama all 0.4.6-4 [32.1 kB] 623s Get:4 http://ftpmaster.internal/ubuntu oracular/main s390x python3-click all 8.1.7-1 [79.1 kB] 623s Get:5 http://ftpmaster.internal/ubuntu oracular/universe s390x python3-h11 all 0.14.0-1 [51.1 kB] 623s Get:6 http://ftpmaster.internal/ubuntu oracular/universe s390x python3-wsproto all 1.2.0-1 [23.6 kB] 623s Get:7 http://ftpmaster.internal/ubuntu oracular/universe s390x python3-uvloop s390x 0.19.0+ds1-2.1 [594 kB] 623s Get:8 http://ftpmaster.internal/ubuntu oracular-proposed/universe s390x python3-uvicorn all 0.30.1-1 [41.2 kB] 624s Fetched 822 kB in 1s (1280 kB/s) 624s Selecting previously unselected package python3-all. 624s (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 ... 54720 files and directories currently installed.) 624s Preparing to unpack .../0-python3-all_3.12.3-0ubuntu1_s390x.deb ... 624s Unpacking python3-all (3.12.3-0ubuntu1) ... 624s Selecting previously unselected package python3-colorama. 624s Preparing to unpack .../1-python3-colorama_0.4.6-4_all.deb ... 624s Unpacking python3-colorama (0.4.6-4) ... 624s Selecting previously unselected package python3-click. 624s Preparing to unpack .../2-python3-click_8.1.7-1_all.deb ... 624s Unpacking python3-click (8.1.7-1) ... 624s Selecting previously unselected package python3-h11. 624s Preparing to unpack .../3-python3-h11_0.14.0-1_all.deb ... 624s Unpacking python3-h11 (0.14.0-1) ... 624s Selecting previously unselected package python3-wsproto. 624s Preparing to unpack .../4-python3-wsproto_1.2.0-1_all.deb ... 624s Unpacking python3-wsproto (1.2.0-1) ... 624s Selecting previously unselected package python3-uvloop. 624s Preparing to unpack .../5-python3-uvloop_0.19.0+ds1-2.1_s390x.deb ... 624s Unpacking python3-uvloop (0.19.0+ds1-2.1) ... 624s Selecting previously unselected package python3-uvicorn. 624s Preparing to unpack .../6-python3-uvicorn_0.30.1-1_all.deb ... 624s Unpacking python3-uvicorn (0.30.1-1) ... 624s Selecting previously unselected package autopkgtest-satdep. 624s Preparing to unpack .../7-2-autopkgtest-satdep.deb ... 624s Unpacking autopkgtest-satdep (0) ... 624s Setting up python3-colorama (0.4.6-4) ... 624s Setting up python3-all (3.12.3-0ubuntu1) ... 624s Setting up python3-click (8.1.7-1) ... 624s Setting up python3-h11 (0.14.0-1) ... 625s Setting up python3-uvloop (0.19.0+ds1-2.1) ... 625s Setting up python3-wsproto (1.2.0-1) ... 625s Setting up python3-uvicorn (0.30.1-1) ... 625s Setting up autopkgtest-satdep (0) ... 627s (Reading database ... 54923 files and directories currently installed.) 627s Removing autopkgtest-satdep (0) ... 629s autopkgtest [20:13:28]: test autodep8-python3: set -e ; for py in $(py3versions -r 2>/dev/null) ; do cd "$AUTOPKGTEST_TMP" ; echo "Testing with $py:" ; $py -c "import uvicorn; print(uvicorn)" ; done 629s autopkgtest [20:13:28]: test autodep8-python3: [----------------------- 629s Testing with python3.12: 629s 630s autopkgtest [20:13:29]: test autodep8-python3: -----------------------] 630s autopkgtest [20:13:29]: test autodep8-python3: - - - - - - - - - - results - - - - - - - - - - 630s autodep8-python3 PASS (superficial) 630s autopkgtest [20:13:29]: @@@@@@@@@@@@@@@@@@@@ summary 630s unittests PASS 630s autodep8-python3 PASS (superficial) 645s nova [W] Using flock in scalingstack-bos01-s390x 645s Creating nova instance adt-oracular-s390x-python-uvicorn-20240718-200256-juju-7f2275-prod-proposed-migration-environment-2-f87aa781-3cd1-4e06-979c-fee7f6433d96 from image adt/ubuntu-oracular-s390x-server-20240718.img (UUID cb3a8fb6-d5e0-455a-be21-bd0339c4916d)... 645s nova [W] Using flock in scalingstack-bos01-s390x 645s Creating nova instance adt-oracular-s390x-python-uvicorn-20240718-200256-juju-7f2275-prod-proposed-migration-environment-2-f87aa781-3cd1-4e06-979c-fee7f6433d96 from image adt/ubuntu-oracular-s390x-server-20240718.img (UUID cb3a8fb6-d5e0-455a-be21-bd0339c4916d)...