0s autopkgtest [00:40:45]: starting date and time: 2024-06-08 00:40:45+0000 0s autopkgtest [00:40:45]: git checkout: 433ed4cb Merge branch 'skia/nova_flock' into 'ubuntu/5.34+prod' 0s autopkgtest [00:40:45]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.qfdtk1ho/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:pytest,src:astropy --apt-upgrade django-cas-server --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 '--env=ADT_TEST_TRIGGERS=pytest/8.2.2-1ubuntu1 astropy/6.0.1-4' -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@bos02-ppc64el-3.secgroup --name adt-oracular-ppc64el-django-cas-server-20240608-004044-juju-7f2275-prod-proposed-migration-environment-2-2e5f4c61-b0ce-43da-a10b-5d61195966e7 --image adt/ubuntu-oracular-ppc64el-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://ftpmaster.internal/ubuntu/ 137s autopkgtest [00:43:02]: testbed dpkg architecture: ppc64el 137s autopkgtest [00:43:02]: testbed apt version: 2.9.3 137s autopkgtest [00:43:02]: @@@@@@@@@@@@@@@@@@@@ test bed setup 138s Get:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease [110 kB] 138s Get:2 http://ftpmaster.internal/ubuntu oracular-proposed/main Sources [44.3 kB] 138s Get:3 http://ftpmaster.internal/ubuntu oracular-proposed/restricted Sources [7972 B] 138s Get:4 http://ftpmaster.internal/ubuntu oracular-proposed/universe Sources [339 kB] 139s Get:5 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse Sources [2852 B] 139s Get:6 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el Packages [53.6 kB] 139s Get:7 http://ftpmaster.internal/ubuntu oracular-proposed/restricted ppc64el Packages [1860 B] 139s Get:8 http://ftpmaster.internal/ubuntu oracular-proposed/universe ppc64el Packages [289 kB] 139s Get:9 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse ppc64el Packages [1768 B] 139s Fetched 850 kB in 1s (1075 kB/s) 139s Reading package lists... 141s Reading package lists... 141s Building dependency tree... 141s Reading state information... 142s Calculating upgrade... 142s The following packages will be upgraded: 142s debianutils libheif-plugin-aomdec libheif-plugin-aomenc 142s libheif-plugin-libde265 libheif1 libnetplan1 netplan-generator netplan.io 142s python3-netplan 142s 9 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 142s Need to get 731 kB of archives. 142s After this operation, 5120 B of additional disk space will be used. 142s Get:1 http://ftpmaster.internal/ubuntu oracular/main ppc64el debianutils ppc64el 5.18 [90.5 kB] 142s Get:2 http://ftpmaster.internal/ubuntu oracular/main ppc64el netplan-generator ppc64el 1.0-3ubuntu1 [59.3 kB] 142s Get:3 http://ftpmaster.internal/ubuntu oracular/main ppc64el python3-netplan ppc64el 1.0-3ubuntu1 [21.8 kB] 142s Get:4 http://ftpmaster.internal/ubuntu oracular/main ppc64el netplan.io ppc64el 1.0-3ubuntu1 [66.6 kB] 142s Get:5 http://ftpmaster.internal/ubuntu oracular/main ppc64el libnetplan1 ppc64el 1.0-3ubuntu1 [138 kB] 142s Get:6 http://ftpmaster.internal/ubuntu oracular/main ppc64el libheif-plugin-aomdec ppc64el 1.17.6-3 [10.2 kB] 142s Get:7 http://ftpmaster.internal/ubuntu oracular/main ppc64el libheif-plugin-aomenc ppc64el 1.17.6-3 [16.6 kB] 142s Get:8 http://ftpmaster.internal/ubuntu oracular/main ppc64el libheif1 ppc64el 1.17.6-3 [320 kB] 142s Get:9 http://ftpmaster.internal/ubuntu oracular/main ppc64el libheif-plugin-libde265 ppc64el 1.17.6-3 [8484 B] 142s Fetched 731 kB in 1s (1336 kB/s) 143s (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 ... 72602 files and directories currently installed.) 143s Preparing to unpack .../debianutils_5.18_ppc64el.deb ... 143s Unpacking debianutils (5.18) over (5.17build1) ... 143s Setting up debianutils (5.18) ... 143s (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 ... 72602 files and directories currently installed.) 143s Preparing to unpack .../0-netplan-generator_1.0-3ubuntu1_ppc64el.deb ... 143s Adding 'diversion of /lib/systemd/system-generators/netplan to /lib/systemd/system-generators/netplan.usr-is-merged by netplan-generator' 143s Unpacking netplan-generator (1.0-3ubuntu1) over (1.0-2ubuntu1) ... 143s Preparing to unpack .../1-python3-netplan_1.0-3ubuntu1_ppc64el.deb ... 143s Unpacking python3-netplan (1.0-3ubuntu1) over (1.0-2ubuntu1) ... 143s Preparing to unpack .../2-netplan.io_1.0-3ubuntu1_ppc64el.deb ... 143s Unpacking netplan.io (1.0-3ubuntu1) over (1.0-2ubuntu1) ... 143s Preparing to unpack .../3-libnetplan1_1.0-3ubuntu1_ppc64el.deb ... 143s Unpacking libnetplan1:ppc64el (1.0-3ubuntu1) over (1.0-2ubuntu1) ... 143s Preparing to unpack .../4-libheif-plugin-aomdec_1.17.6-3_ppc64el.deb ... 143s Unpacking libheif-plugin-aomdec:ppc64el (1.17.6-3) over (1.17.6-1ubuntu4) ... 143s Preparing to unpack .../5-libheif-plugin-aomenc_1.17.6-3_ppc64el.deb ... 143s Unpacking libheif-plugin-aomenc:ppc64el (1.17.6-3) over (1.17.6-1ubuntu4) ... 143s Preparing to unpack .../6-libheif1_1.17.6-3_ppc64el.deb ... 143s Unpacking libheif1:ppc64el (1.17.6-3) over (1.17.6-1ubuntu4) ... 143s Preparing to unpack .../7-libheif-plugin-libde265_1.17.6-3_ppc64el.deb ... 143s Unpacking libheif-plugin-libde265:ppc64el (1.17.6-3) over (1.17.6-1ubuntu4) ... 143s Setting up libnetplan1:ppc64el (1.0-3ubuntu1) ... 143s Setting up python3-netplan (1.0-3ubuntu1) ... 143s Setting up netplan-generator (1.0-3ubuntu1) ... 143s Removing 'diversion of /lib/systemd/system-generators/netplan to /lib/systemd/system-generators/netplan.usr-is-merged by netplan-generator' 143s Setting up netplan.io (1.0-3ubuntu1) ... 143s Setting up libheif-plugin-aomdec:ppc64el (1.17.6-3) ... 143s Setting up libheif-plugin-libde265:ppc64el (1.17.6-3) ... 143s Setting up libheif1:ppc64el (1.17.6-3) ... 143s Setting up libheif-plugin-aomenc:ppc64el (1.17.6-3) ... 143s Processing triggers for libc-bin (2.39-0ubuntu8.1) ... 143s Processing triggers for man-db (2.12.1-1) ... 144s Processing triggers for dbus (1.14.10-4ubuntu4) ... 145s Reading package lists... 145s Building dependency tree... 145s Reading state information... 145s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 145s Hit:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease 145s Hit:2 http://ftpmaster.internal/ubuntu oracular InRelease 146s Hit:3 http://ftpmaster.internal/ubuntu oracular-updates InRelease 146s Hit:4 http://ftpmaster.internal/ubuntu oracular-security InRelease 147s Reading package lists... 147s Reading package lists... 147s Building dependency tree... 147s Reading state information... 147s Calculating upgrade... 147s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 147s Reading package lists... 147s Building dependency tree... 147s Reading state information... 148s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 150s autopkgtest [00:43:15]: testbed running kernel: Linux 6.8.0-31-generic #31-Ubuntu SMP Sat Apr 20 00:05:55 UTC 2024 151s autopkgtest [00:43:16]: @@@@@@@@@@@@@@@@@@@@ apt-source django-cas-server 153s Get:1 http://ftpmaster.internal/ubuntu oracular/universe django-cas-server 2.0.0-2 (dsc) [2588 B] 153s Get:2 http://ftpmaster.internal/ubuntu oracular/universe django-cas-server 2.0.0-2 (tar) [169 kB] 153s Get:3 http://ftpmaster.internal/ubuntu oracular/universe django-cas-server 2.0.0-2 (diff) [6480 B] 153s gpgv: Signature made Sat Dec 3 08:42:02 2022 UTC 153s gpgv: using RSA key B70DFC6F134FECFC011E62AA83016014251D1DB0 153s gpgv: Can't check signature: No public key 153s dpkg-source: warning: cannot verify inline signature for ./django-cas-server_2.0.0-2.dsc: no acceptable signature found 153s autopkgtest [00:43:18]: testing package django-cas-server version 2.0.0-2 153s autopkgtest [00:43:18]: build not needed 154s autopkgtest [00:43:19]: test run-test-suite.sh: preparing testbed 155s Reading package lists... 155s Building dependency tree... 155s Reading state information... 155s Starting pkgProblemResolver with broken count: 0 155s Starting 2 pkgProblemResolver with broken count: 0 155s Done 155s The following additional packages will be installed: 155s fonts-font-awesome fonts-lato libjs-jquery libjs-sphinxdoc libjs-underscore 155s libxslt1.1 python3-all python3-asgiref python3-django 155s python3-django-cas-server python3-django-cas-server-doc python3-iniconfig 155s python3-lxml python3-mock python3-packaging python3-pluggy python3-pytest 155s python3-pytest-django python3-requests-futures python3-sqlparse 155s sphinx-rtd-theme-common 155s Suggested packages: 155s bpython3 geoip-database-contrib gettext ipython3 libgdal20 155s libsqlite3-mod-spatialite python-django-doc python3-bcrypt python3-flup 155s python3-memcache python3-mysqldb python3-pil python3-psycopg2 155s python3-selenium python3-sqlite python-lxml-doc python-mock-doc 155s python-sqlparse-doc 155s Recommended packages: 155s javascript-common python3-tz python3-bs4 python3-cssselect python3-html5lib 155s The following NEW packages will be installed: 155s autopkgtest-satdep fonts-font-awesome fonts-lato libjs-jquery 155s libjs-sphinxdoc libjs-underscore libxslt1.1 python3-all python3-asgiref 155s python3-django python3-django-cas-server python3-django-cas-server-doc 155s python3-iniconfig python3-lxml python3-mock python3-packaging python3-pluggy 155s python3-pytest python3-pytest-django python3-requests-futures 155s python3-sqlparse sphinx-rtd-theme-common 155s 0 upgraded, 22 newly installed, 0 to remove and 0 not upgraded. 155s Need to get 10.0 MB/10.0 MB of archives. 155s After this operation, 52.6 MB of additional disk space will be used. 155s Get:1 /tmp/autopkgtest.Lm6AWl/1-autopkgtest-satdep.deb autopkgtest-satdep ppc64el 0 [748 B] 156s Get:2 http://ftpmaster.internal/ubuntu oracular/main ppc64el fonts-lato all 2.015-1 [2781 kB] 156s Get:3 http://ftpmaster.internal/ubuntu oracular/main ppc64el fonts-font-awesome all 5.0.10+really4.7.0~dfsg-4.1 [516 kB] 156s Get:4 http://ftpmaster.internal/ubuntu oracular/main ppc64el libjs-jquery all 3.6.1+dfsg+~3.5.14-1 [328 kB] 156s Get:5 http://ftpmaster.internal/ubuntu oracular/main ppc64el libjs-underscore all 1.13.4~dfsg+~1.11.4-3 [118 kB] 156s Get:6 http://ftpmaster.internal/ubuntu oracular/main ppc64el libjs-sphinxdoc all 7.2.6-8 [150 kB] 156s Get:7 http://ftpmaster.internal/ubuntu oracular/main ppc64el libxslt1.1 ppc64el 1.1.39-0exp1build1 [192 kB] 156s Get:8 http://ftpmaster.internal/ubuntu oracular/main ppc64el python3-all ppc64el 3.12.3-0ubuntu1 [888 B] 156s Get:9 http://ftpmaster.internal/ubuntu oracular/main ppc64el python3-asgiref all 3.8.1-1 [24.8 kB] 156s Get:10 http://ftpmaster.internal/ubuntu oracular/main ppc64el python3-sqlparse all 0.5.0-1 [32.4 kB] 156s Get:11 http://ftpmaster.internal/ubuntu oracular/main ppc64el python3-django all 3:4.2.13-1 [2919 kB] 156s Get:12 http://ftpmaster.internal/ubuntu oracular/main ppc64el python3-lxml ppc64el 5.2.1-1 [1250 kB] 156s Get:13 http://ftpmaster.internal/ubuntu oracular/universe ppc64el python3-requests-futures all 1.0.1-1 [11.7 kB] 156s Get:14 http://ftpmaster.internal/ubuntu oracular/universe ppc64el python3-django-cas-server all 2.0.0-2 [111 kB] 156s Get:15 http://ftpmaster.internal/ubuntu oracular/main ppc64el sphinx-rtd-theme-common all 2.0.0+dfsg-1 [1012 kB] 156s Get:16 http://ftpmaster.internal/ubuntu oracular/universe ppc64el python3-django-cas-server-doc all 2.0.0-2 [159 kB] 156s Get:17 http://ftpmaster.internal/ubuntu oracular/universe ppc64el python3-iniconfig all 1.1.1-2 [6024 B] 156s Get:18 http://ftpmaster.internal/ubuntu oracular/main ppc64el python3-packaging all 24.0-1 [41.1 kB] 156s Get:19 http://ftpmaster.internal/ubuntu oracular/universe ppc64el python3-pluggy all 1.5.0-1 [21.0 kB] 156s Get:20 http://ftpmaster.internal/ubuntu oracular-proposed/universe ppc64el python3-pytest all 8.2.2-1ubuntu1 [250 kB] 156s Get:21 http://ftpmaster.internal/ubuntu oracular/universe ppc64el python3-pytest-django all 4.5.2-3 [18.5 kB] 156s Get:22 http://ftpmaster.internal/ubuntu oracular/universe ppc64el python3-mock all 5.1.0-1 [64.1 kB] 157s Fetched 10.0 MB in 1s (10.7 MB/s) 157s Selecting previously unselected package fonts-lato. 157s (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 ... 72602 files and directories currently installed.) 157s Preparing to unpack .../00-fonts-lato_2.015-1_all.deb ... 157s Unpacking fonts-lato (2.015-1) ... 157s Selecting previously unselected package fonts-font-awesome. 157s Preparing to unpack .../01-fonts-font-awesome_5.0.10+really4.7.0~dfsg-4.1_all.deb ... 157s Unpacking fonts-font-awesome (5.0.10+really4.7.0~dfsg-4.1) ... 157s Selecting previously unselected package libjs-jquery. 157s Preparing to unpack .../02-libjs-jquery_3.6.1+dfsg+~3.5.14-1_all.deb ... 157s Unpacking libjs-jquery (3.6.1+dfsg+~3.5.14-1) ... 157s Selecting previously unselected package libjs-underscore. 157s Preparing to unpack .../03-libjs-underscore_1.13.4~dfsg+~1.11.4-3_all.deb ... 157s Unpacking libjs-underscore (1.13.4~dfsg+~1.11.4-3) ... 157s Selecting previously unselected package libjs-sphinxdoc. 157s Preparing to unpack .../04-libjs-sphinxdoc_7.2.6-8_all.deb ... 157s Unpacking libjs-sphinxdoc (7.2.6-8) ... 157s Selecting previously unselected package libxslt1.1:ppc64el. 157s Preparing to unpack .../05-libxslt1.1_1.1.39-0exp1build1_ppc64el.deb ... 157s Unpacking libxslt1.1:ppc64el (1.1.39-0exp1build1) ... 157s Selecting previously unselected package python3-all. 157s Preparing to unpack .../06-python3-all_3.12.3-0ubuntu1_ppc64el.deb ... 157s Unpacking python3-all (3.12.3-0ubuntu1) ... 157s Selecting previously unselected package python3-asgiref. 157s Preparing to unpack .../07-python3-asgiref_3.8.1-1_all.deb ... 157s Unpacking python3-asgiref (3.8.1-1) ... 157s Selecting previously unselected package python3-sqlparse. 157s Preparing to unpack .../08-python3-sqlparse_0.5.0-1_all.deb ... 157s Unpacking python3-sqlparse (0.5.0-1) ... 157s Selecting previously unselected package python3-django. 157s Preparing to unpack .../09-python3-django_3%3a4.2.13-1_all.deb ... 157s Unpacking python3-django (3:4.2.13-1) ... 158s Selecting previously unselected package python3-lxml:ppc64el. 158s Preparing to unpack .../10-python3-lxml_5.2.1-1_ppc64el.deb ... 158s Unpacking python3-lxml:ppc64el (5.2.1-1) ... 158s Selecting previously unselected package python3-requests-futures. 158s Preparing to unpack .../11-python3-requests-futures_1.0.1-1_all.deb ... 158s Unpacking python3-requests-futures (1.0.1-1) ... 158s Selecting previously unselected package python3-django-cas-server. 158s Preparing to unpack .../12-python3-django-cas-server_2.0.0-2_all.deb ... 158s Unpacking python3-django-cas-server (2.0.0-2) ... 158s Selecting previously unselected package sphinx-rtd-theme-common. 158s Preparing to unpack .../13-sphinx-rtd-theme-common_2.0.0+dfsg-1_all.deb ... 158s Unpacking sphinx-rtd-theme-common (2.0.0+dfsg-1) ... 158s Selecting previously unselected package python3-django-cas-server-doc. 158s Preparing to unpack .../14-python3-django-cas-server-doc_2.0.0-2_all.deb ... 158s Unpacking python3-django-cas-server-doc (2.0.0-2) ... 158s Selecting previously unselected package python3-iniconfig. 158s Preparing to unpack .../15-python3-iniconfig_1.1.1-2_all.deb ... 158s Unpacking python3-iniconfig (1.1.1-2) ... 158s Selecting previously unselected package python3-packaging. 158s Preparing to unpack .../16-python3-packaging_24.0-1_all.deb ... 158s Unpacking python3-packaging (24.0-1) ... 158s Selecting previously unselected package python3-pluggy. 158s Preparing to unpack .../17-python3-pluggy_1.5.0-1_all.deb ... 158s Unpacking python3-pluggy (1.5.0-1) ... 158s Selecting previously unselected package python3-pytest. 158s Preparing to unpack .../18-python3-pytest_8.2.2-1ubuntu1_all.deb ... 158s Unpacking python3-pytest (8.2.2-1ubuntu1) ... 159s Selecting previously unselected package python3-pytest-django. 159s Preparing to unpack .../19-python3-pytest-django_4.5.2-3_all.deb ... 159s Unpacking python3-pytest-django (4.5.2-3) ... 159s Selecting previously unselected package python3-mock. 159s Preparing to unpack .../20-python3-mock_5.1.0-1_all.deb ... 159s Unpacking python3-mock (5.1.0-1) ... 159s Selecting previously unselected package autopkgtest-satdep. 159s Preparing to unpack .../21-1-autopkgtest-satdep.deb ... 159s Unpacking autopkgtest-satdep (0) ... 159s Setting up python3-iniconfig (1.1.1-2) ... 159s Setting up fonts-lato (2.015-1) ... 159s Setting up python3-all (3.12.3-0ubuntu1) ... 159s Setting up python3-mock (5.1.0-1) ... 159s Setting up python3-packaging (24.0-1) ... 159s Setting up python3-sqlparse (0.5.0-1) ... 160s Setting up python3-pluggy (1.5.0-1) ... 160s Setting up libxslt1.1:ppc64el (1.1.39-0exp1build1) ... 160s Setting up python3-requests-futures (1.0.1-1) ... 160s Setting up libjs-jquery (3.6.1+dfsg+~3.5.14-1) ... 160s Setting up fonts-font-awesome (5.0.10+really4.7.0~dfsg-4.1) ... 160s Setting up sphinx-rtd-theme-common (2.0.0+dfsg-1) ... 160s Setting up python3-asgiref (3.8.1-1) ... 160s Setting up libjs-underscore (1.13.4~dfsg+~1.11.4-3) ... 160s Setting up python3-django (3:4.2.13-1) ... 162s Setting up python3-pytest (8.2.2-1ubuntu1) ... 162s Setting up python3-pytest-django (4.5.2-3) ... 162s Setting up libjs-sphinxdoc (7.2.6-8) ... 162s Setting up python3-lxml:ppc64el (5.2.1-1) ... 163s Setting up python3-django-cas-server (2.0.0-2) ... 163s Setting up python3-django-cas-server-doc (2.0.0-2) ... 163s Setting up autopkgtest-satdep (0) ... 163s Processing triggers for man-db (2.12.1-1) ... 163s Processing triggers for libc-bin (2.39-0ubuntu8.1) ... 167s (Reading database ... 79409 files and directories currently installed.) 167s Removing autopkgtest-satdep (0) ... 168s autopkgtest [00:43:33]: test run-test-suite.sh: [----------------------- 168s 168s *************************** 168s *** Testing with python3.12 168s *************************** 168s 168s Content of current working folder: 168s 168s total 20 168s drwxr-xr-x 3 ubuntu ubuntu 4096 Jun 8 00:43 . 168s drwxrwxrwt 5 root root 4096 Jun 8 00:43 .. 168s drwxrwxr-x 9 ubuntu ubuntu 4096 Oct 17 2022 cas_server 168s -rw-rw-r-- 1 ubuntu ubuntu 140 Oct 17 2022 pytest.ini 168s -rw-rw-r-- 1 ubuntu ubuntu 152 Oct 17 2022 setup.cfg 168s Running tests... 168s 168s ============================= test session starts ============================== 168s platform linux -- Python 3.12.3, pytest-8.2.2, pluggy-1.5.0 -- /usr/bin/python3.12 168s cachedir: .pytest_cache 168s django: settings: cas_server.tests.settings (from ini) 168s rootdir: /tmp/autopkgtest.Lm6AWl/autopkgtest_tmp 168s configfile: pytest.ini 168s testpaths: cas_server/tests/ 168s plugins: django-4.5.2 169s collecting ... collected 128 items 169s 169s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_auth_federate_errors Creating test database for alias 'default'... 169s 2024-06-08 00:43:34,966 WARNING Identity provider suffix exemple.fr not found 170s 2024-06-08 00:43:35,040 INFO Got an invalid ticket ST-37vdrk4OSrMjtZrFIDPap8wVz4wsLg6swmwlOVWkDjyfMKGn2a9SEY1O8SDTz from http://127.0.0.1:8080 for service http://testserver/federate/example.com. Retrying authentication 170s 2024-06-08 00:43:35,045 INFO Got an invalid ticket ST-4pUAqBptBr7DDTpW9tcIMl4pYltbI6MjXWS5uB2Q3STR6IOlxurCBR5pAs9hQ from http://127.0.0.1:8080 for service http://testserver/federate/example.com. Retrying authentication 170s PASSED 170s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_auth_federate_false 2024-06-08 00:43:35,089 WARNING CAS_FEDERATE is False, set it to True to use federation 170s 2024-06-08 00:43:35,090 WARNING CAS_FEDERATE is False, set it to True to use federation 170s PASSED 170s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_auth_federate_slo 2024-06-08 00:43:35,112 INFO Trying to authenticate http://127.0.0.1:8080 again 170s 2024-06-08 00:43:35,118 INFO Got a valid ticket for dédé from http://127.0.0.1:8080 170s 2024-06-08 00:43:35,138 INFO User dédé@example.com successfully authenticated 170s 2024-06-08 00:43:35,153 INFO Service ticket created for service https://www.example.com by user dédé@example.com. 170s 2024-06-08 00:43:35,168 INFO Trying to authenticate http://127.0.0.1:8081 again 170s 2024-06-08 00:43:35,175 INFO Got a valid ticket for dédé from http://127.0.0.1:8081 170s 2024-06-08 00:43:35,188 INFO User dédé@example.org successfully authenticated 170s 2024-06-08 00:43:35,201 INFO Service ticket created for service https://www.example.com by user dédé@example.org. 170s 2024-06-08 00:43:35,218 INFO Trying to authenticate http://127.0.0.1:8082 again 170s 2024-06-08 00:43:35,228 INFO Got a valid ticket for dédé from http://127.0.0.1:8082 170s 2024-06-08 00:43:35,241 INFO User dédé@example.net successfully authenticated 170s 2024-06-08 00:43:35,253 INFO Service ticket created for service https://www.example.com by user dédé@example.net. 170s 2024-06-08 00:43:35,268 INFO Trying to authenticate http://127.0.0.1:8083 again 170s 2024-06-08 00:43:35,277 INFO Got a valid ticket for dédé from http://127.0.0.1:8083 170s 2024-06-08 00:43:35,292 INFO User dédé@example.test successfully authenticated 170s 2024-06-08 00:43:35,304 INFO Service ticket created for service https://www.example.com by user dédé@example.test. 170s 2024-06-08 00:43:35,349 INFO Got an SLO requests for ticket dédé@example.net, logging out user ST-w1YoaXTR7TIILwmFb0bJiWLnJI2iFH34QMqIRcV1OzbAjZsxB7e2BRawG0M8f 170s 2024-06-08 00:43:35,383 INFO Got an SLO requests for ticket dédé@example.test, logging out user ST-jUNcaSPadnccJaecl1c0HRLEEOD4cex2QFDNQBhAH47rSAKlb1CmovJTZKg9e 170s PASSED 170s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_default_settings PASSED 170s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_federate_logout 2024-06-08 00:43:35,429 INFO Trying to authenticate http://127.0.0.1:8080 again 170s 2024-06-08 00:43:35,436 INFO Got a valid ticket for dédé from http://127.0.0.1:8080 170s 2024-06-08 00:43:35,449 INFO User dédé@example.com successfully authenticated 170s 2024-06-08 00:43:35,462 INFO Service ticket created for service https://www.example.com by user dédé@example.com. 170s 2024-06-08 00:43:35,478 INFO Trying to authenticate http://127.0.0.1:8081 again 170s 2024-06-08 00:43:35,484 INFO Got a valid ticket for dédé from http://127.0.0.1:8081 170s 2024-06-08 00:43:35,498 INFO User dédé@example.org successfully authenticated 170s 2024-06-08 00:43:35,513 INFO Service ticket created for service https://www.example.com by user dédé@example.org. 170s 2024-06-08 00:43:35,529 INFO Trying to authenticate http://127.0.0.1:8082 again 170s 2024-06-08 00:43:35,536 INFO Got a valid ticket for dédé from http://127.0.0.1:8082 170s 2024-06-08 00:43:35,550 INFO User dédé@example.net successfully authenticated 170s 2024-06-08 00:43:35,563 INFO Service ticket created for service https://www.example.com by user dédé@example.net. 170s 2024-06-08 00:43:35,581 INFO Trying to authenticate http://127.0.0.1:8083 again 170s 2024-06-08 00:43:35,588 INFO Got a valid ticket for dédé from http://127.0.0.1:8083 170s 2024-06-08 00:43:35,602 INFO User dédé@example.test successfully authenticated 170s 2024-06-08 00:43:35,614 INFO Service ticket created for service https://www.example.com by user dédé@example.test. 170s 2024-06-08 00:43:35,616 INFO logout requested 170s 2024-06-08 00:43:35,618 INFO Logging out user dédé@example.com. 170s 2024-06-08 00:43:35,624 INFO User dédé@example.com logged out 170s 2024-06-08 00:43:35,636 INFO logout requested 170s 2024-06-08 00:43:35,640 INFO logout requested 170s 2024-06-08 00:43:35,643 INFO Logging out user dédé@example.org. 170s 2024-06-08 00:43:35,649 INFO User dédé@example.org logged out 170s 2024-06-08 00:43:35,666 INFO logout requested 170s 2024-06-08 00:43:35,670 INFO logout requested 170s 2024-06-08 00:43:35,672 INFO Logging out user dédé@example.net. 170s 2024-06-08 00:43:35,678 INFO User dédé@example.net logged out 170s 2024-06-08 00:43:35,691 INFO logout requested 170s 2024-06-08 00:43:35,695 INFO logout requested 170s 2024-06-08 00:43:35,700 INFO Logging out user dédé@example.test. 170s 2024-06-08 00:43:35,707 INFO User dédé@example.test logged out 170s 2024-06-08 00:43:35,721 INFO logout requested 170s 2024-06-08 00:43:35,737 INFO Trying to authenticate http://127.0.0.1:8080 again 170s 2024-06-08 00:43:35,743 INFO Got a valid ticket for dédé from http://127.0.0.1:8080 170s 2024-06-08 00:43:35,757 INFO User dédé@example.com successfully authenticated 170s 2024-06-08 00:43:35,769 INFO Service ticket created for service https://www.example.com by user dédé@example.com. 170s 2024-06-08 00:43:35,785 INFO Trying to authenticate http://127.0.0.1:8081 again 170s 2024-06-08 00:43:35,792 INFO Got a valid ticket for dédé from http://127.0.0.1:8081 170s 2024-06-08 00:43:35,805 INFO User dédé@example.org successfully authenticated 170s 2024-06-08 00:43:35,817 INFO Service ticket created for service https://www.example.com by user dédé@example.org. 170s 2024-06-08 00:43:35,832 INFO Trying to authenticate http://127.0.0.1:8082 again 170s 2024-06-08 00:43:35,838 INFO Got a valid ticket for dédé from http://127.0.0.1:8082 170s 2024-06-08 00:43:35,852 INFO User dédé@example.net successfully authenticated 170s 2024-06-08 00:43:35,864 INFO Service ticket created for service https://www.example.com by user dédé@example.net. 170s 2024-06-08 00:43:35,878 INFO Trying to authenticate http://127.0.0.1:8083 again 170s 2024-06-08 00:43:35,885 INFO Got a valid ticket for dédé from http://127.0.0.1:8083 170s 2024-06-08 00:43:35,898 INFO User dédé@example.test successfully authenticated 170s 2024-06-08 00:43:35,913 INFO Service ticket created for service https://www.example.com by user dédé@example.test. 170s 2024-06-08 00:43:35,916 INFO logout requested 170s 2024-06-08 00:43:35,917 INFO Logging out user dédé. 170s 2024-06-08 00:43:35,919 INFO User dédé logged out 170s 2024-06-08 00:43:35,933 INFO logout requested 170s 2024-06-08 00:43:35,934 INFO Logging out user dédé. 170s 2024-06-08 00:43:35,935 INFO User dédé logged out 170s 2024-06-08 00:43:35,950 INFO logout requested 170s 2024-06-08 00:43:35,951 INFO Logging out user dédé. 170s 2024-06-08 00:43:35,952 INFO User dédé logged out 170s 2024-06-08 00:43:35,966 INFO logout requested 170s 2024-06-08 00:43:35,967 INFO Logging out user dédé. 170s 2024-06-08 00:43:35,969 INFO User dédé logged out 171s PASSED 171s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_forget_provider 2024-06-08 00:43:36,002 INFO Trying to authenticate http://127.0.0.1:8080 again 171s 2024-06-08 00:43:36,007 INFO Got a valid ticket for dédé from http://127.0.0.1:8080 171s 2024-06-08 00:43:36,021 INFO User dédé@example.com successfully authenticated 171s 2024-06-08 00:43:36,034 INFO Service ticket created for service https://www.example.com by user dédé@example.com. 171s 2024-06-08 00:43:36,049 INFO Trying to authenticate http://127.0.0.1:8081 again 171s 2024-06-08 00:43:36,055 INFO Got a valid ticket for dédé from http://127.0.0.1:8081 171s 2024-06-08 00:43:36,070 INFO User dédé@example.org successfully authenticated 171s 2024-06-08 00:43:36,083 INFO Service ticket created for service https://www.example.com by user dédé@example.org. 171s 2024-06-08 00:43:36,099 INFO Trying to authenticate http://127.0.0.1:8082 again 171s 2024-06-08 00:43:36,105 INFO Got a valid ticket for dédé from http://127.0.0.1:8082 171s 2024-06-08 00:43:36,121 INFO User dédé@example.net successfully authenticated 171s 2024-06-08 00:43:36,134 INFO Service ticket created for service https://www.example.com by user dédé@example.net. 171s 2024-06-08 00:43:36,150 INFO Trying to authenticate http://127.0.0.1:8083 again 171s 2024-06-08 00:43:36,156 INFO Got a valid ticket for dédé from http://127.0.0.1:8083 171s 2024-06-08 00:43:36,171 INFO User dédé@example.test successfully authenticated 171s 2024-06-08 00:43:36,183 INFO Service ticket created for service https://www.example.com by user dédé@example.test. 171s 2024-06-08 00:43:36,185 INFO logout requested 171s 2024-06-08 00:43:36,188 INFO Logging out user dédé@example.com. 171s 2024-06-08 00:43:36,195 INFO User dédé@example.com logged out 171s 2024-06-08 00:43:36,196 INFO logout requested 171s 2024-06-08 00:43:36,199 INFO Logging out user dédé@example.org. 171s 2024-06-08 00:43:36,206 INFO User dédé@example.org logged out 171s 2024-06-08 00:43:36,207 INFO logout requested 171s 2024-06-08 00:43:36,210 INFO Logging out user dédé@example.net. 171s 2024-06-08 00:43:36,216 INFO User dédé@example.net logged out 171s 2024-06-08 00:43:36,217 INFO logout requested 171s 2024-06-08 00:43:36,220 INFO Logging out user dédé@example.test. 171s 2024-06-08 00:43:36,226 INFO User dédé@example.test logged out 171s PASSED 171s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_login_bad_ticket 2024-06-08 00:43:36,247 WARNING A login attempt failed 171s PASSED 171s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_login_get_provider PASSED 171s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_login_post_provider 2024-06-08 00:43:36,297 INFO Trying to authenticate http://127.0.0.1:8080 again 171s 2024-06-08 00:43:36,302 INFO Got a valid ticket for dédé from http://127.0.0.1:8080 171s 2024-06-08 00:43:36,316 INFO User dédé@example.com successfully authenticated 171s 2024-06-08 00:43:36,330 INFO Service ticket created for service https://www.example.com by user dédé@example.com. 171s 2024-06-08 00:43:36,346 INFO Trying to authenticate http://127.0.0.1:8081 again 171s 2024-06-08 00:43:36,352 INFO Got a valid ticket for dédé from http://127.0.0.1:8081 171s 2024-06-08 00:43:36,367 INFO User dédé@example.org successfully authenticated 171s 2024-06-08 00:43:36,381 INFO Service ticket created for service https://www.example.com by user dédé@example.org. 171s 2024-06-08 00:43:36,400 INFO Trying to authenticate http://127.0.0.1:8082 again 171s 2024-06-08 00:43:36,406 INFO Got a valid ticket for dédé from http://127.0.0.1:8082 171s 2024-06-08 00:43:36,421 INFO User dédé@example.net successfully authenticated 171s 2024-06-08 00:43:36,434 INFO Service ticket created for service https://www.example.com by user dédé@example.net. 171s 2024-06-08 00:43:36,450 INFO Trying to authenticate http://127.0.0.1:8083 again 171s 2024-06-08 00:43:36,457 INFO Got a valid ticket for dédé from http://127.0.0.1:8083 171s 2024-06-08 00:43:36,471 INFO User dédé@example.test successfully authenticated 171s 2024-06-08 00:43:36,485 INFO Service ticket created for service https://www.example.com by user dédé@example.test. 171s PASSED 171s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_login_twice 2024-06-08 00:43:36,512 INFO Trying to authenticate http://127.0.0.1:8080 again 171s 2024-06-08 00:43:36,518 INFO Got a valid ticket for dédé from http://127.0.0.1:8080 171s 2024-06-08 00:43:36,532 INFO User dédé@example.com successfully authenticated 171s 2024-06-08 00:43:36,545 INFO Service ticket created for service https://www.example.com by user dédé@example.com. 171s 2024-06-08 00:43:36,560 INFO Trying to authenticate http://127.0.0.1:8081 again 171s 2024-06-08 00:43:36,566 INFO Got a valid ticket for dédé from http://127.0.0.1:8081 171s 2024-06-08 00:43:36,579 INFO User dédé@example.org successfully authenticated 171s 2024-06-08 00:43:36,593 INFO Service ticket created for service https://www.example.com by user dédé@example.org. 171s 2024-06-08 00:43:36,611 INFO Trying to authenticate http://127.0.0.1:8082 again 171s 2024-06-08 00:43:36,619 INFO Got a valid ticket for dédé from http://127.0.0.1:8082 171s 2024-06-08 00:43:36,633 INFO User dédé@example.net successfully authenticated 171s 2024-06-08 00:43:36,646 INFO Service ticket created for service https://www.example.com by user dédé@example.net. 171s 2024-06-08 00:43:36,662 INFO Trying to authenticate http://127.0.0.1:8083 again 171s 2024-06-08 00:43:36,668 INFO Got a valid ticket for dédé from http://127.0.0.1:8083 171s 2024-06-08 00:43:36,682 INFO User dédé@example.test successfully authenticated 171s 2024-06-08 00:43:36,695 INFO Service ticket created for service https://www.example.com by user dédé@example.test. 171s 2024-06-08 00:43:36,711 INFO Trying to authenticate http://127.0.0.1:8080 again 171s 2024-06-08 00:43:36,717 INFO Got a valid ticket for dédé from http://127.0.0.1:8080 171s 2024-06-08 00:43:36,731 INFO User dédé@example.com successfully authenticated 171s 2024-06-08 00:43:36,745 INFO Service ticket created for service https://www.example.com by user dédé@example.com. 171s 2024-06-08 00:43:36,764 INFO Trying to authenticate http://127.0.0.1:8081 again 171s 2024-06-08 00:43:36,771 INFO Got a valid ticket for dédé from http://127.0.0.1:8081 171s 2024-06-08 00:43:36,787 INFO User dédé@example.org successfully authenticated 171s 2024-06-08 00:43:36,800 INFO Service ticket created for service https://www.example.com by user dédé@example.org. 171s 2024-06-08 00:43:36,817 INFO Trying to authenticate http://127.0.0.1:8082 again 171s 2024-06-08 00:43:36,824 INFO Got a valid ticket for dédé from http://127.0.0.1:8082 171s 2024-06-08 00:43:36,840 INFO User dédé@example.net successfully authenticated 171s 2024-06-08 00:43:36,855 INFO Service ticket created for service https://www.example.com by user dédé@example.net. 171s 2024-06-08 00:43:36,925 INFO Trying to authenticate http://127.0.0.1:8083 again 171s 2024-06-08 00:43:36,932 INFO Got a valid ticket for dédé from http://127.0.0.1:8083 171s 2024-06-08 00:43:36,946 INFO User dédé@example.test successfully authenticated 171s 2024-06-08 00:43:36,958 INFO Service ticket created for service https://www.example.com by user dédé@example.test. 171s 2024-06-08 00:43:36,960 WARNING User already authenticated, dropping federated authentication request 171s 2024-06-08 00:43:36,961 WARNING User already authenticated, dropping federated authentication request 171s 2024-06-08 00:43:36,963 WARNING User already authenticated, dropping federated authentication request 171s 2024-06-08 00:43:36,964 WARNING User already authenticated, dropping federated authentication request 171s PASSED 172s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_remember_provider 2024-06-08 00:43:36,985 INFO Trying to authenticate http://127.0.0.1:8080 again 172s 2024-06-08 00:43:36,991 INFO Got a valid ticket for dédé from http://127.0.0.1:8080 172s 2024-06-08 00:43:37,004 INFO User dédé@example.com successfully authenticated 172s 2024-06-08 00:43:37,016 INFO Service ticket created for service https://www.example.com by user dédé@example.com. 172s 2024-06-08 00:43:37,031 INFO Trying to authenticate http://127.0.0.1:8081 again 172s 2024-06-08 00:43:37,037 INFO Got a valid ticket for dédé from http://127.0.0.1:8081 172s 2024-06-08 00:43:37,050 INFO User dédé@example.org successfully authenticated 172s 2024-06-08 00:43:37,062 INFO Service ticket created for service https://www.example.com by user dédé@example.org. 172s 2024-06-08 00:43:37,078 INFO Trying to authenticate http://127.0.0.1:8082 again 172s 2024-06-08 00:43:37,085 INFO Got a valid ticket for dédé from http://127.0.0.1:8082 172s 2024-06-08 00:43:37,099 INFO User dédé@example.net successfully authenticated 172s 2024-06-08 00:43:37,112 INFO Service ticket created for service https://www.example.com by user dédé@example.net. 172s 2024-06-08 00:43:37,131 INFO Trying to authenticate http://127.0.0.1:8083 again 172s 2024-06-08 00:43:37,138 INFO Got a valid ticket for dédé from http://127.0.0.1:8083 172s 2024-06-08 00:43:37,152 INFO User dédé@example.test successfully authenticated 172s 2024-06-08 00:43:37,165 INFO Service ticket created for service https://www.example.com by user dédé@example.test. 172s 2024-06-08 00:43:37,167 INFO logout requested 172s 2024-06-08 00:43:37,170 INFO Logging out user dédé@example.com. 172s 2024-06-08 00:43:37,176 INFO User dédé@example.com logged out 172s 2024-06-08 00:43:37,180 INFO logout requested 172s 2024-06-08 00:43:37,183 INFO Logging out user dédé@example.org. 172s 2024-06-08 00:43:37,188 INFO User dédé@example.org logged out 172s 2024-06-08 00:43:37,192 INFO logout requested 172s 2024-06-08 00:43:37,194 INFO Logging out user dédé@example.net. 172s 2024-06-08 00:43:37,201 INFO User dédé@example.net logged out 172s 2024-06-08 00:43:37,205 INFO logout requested 172s 2024-06-08 00:43:37,207 INFO Logging out user dédé@example.test. 172s 2024-06-08 00:43:37,213 INFO User dédé@example.test logged out 172s PASSED 172s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_renew 2024-06-08 00:43:37,238 INFO Trying to authenticate http://127.0.0.1:8080 again 172s 2024-06-08 00:43:37,244 INFO Got a valid ticket for dédé from http://127.0.0.1:8080 172s 2024-06-08 00:43:37,257 INFO User dédé@example.com successfully authenticated 172s 2024-06-08 00:43:37,270 INFO Service ticket created for service https://www.example.com by user dédé@example.com. 172s 2024-06-08 00:43:37,285 INFO Trying to authenticate http://127.0.0.1:8081 again 172s 2024-06-08 00:43:37,291 INFO Got a valid ticket for dédé from http://127.0.0.1:8081 172s 2024-06-08 00:43:37,304 INFO User dédé@example.org successfully authenticated 172s 2024-06-08 00:43:37,316 INFO Service ticket created for service https://www.example.com by user dédé@example.org. 172s 2024-06-08 00:43:37,331 INFO Trying to authenticate http://127.0.0.1:8082 again 172s 2024-06-08 00:43:37,337 INFO Got a valid ticket for dédé from http://127.0.0.1:8082 172s 2024-06-08 00:43:37,350 INFO User dédé@example.net successfully authenticated 172s 2024-06-08 00:43:37,362 INFO Service ticket created for service https://www.example.com by user dédé@example.net. 172s 2024-06-08 00:43:37,379 INFO Trying to authenticate http://127.0.0.1:8083 again 172s 2024-06-08 00:43:37,386 INFO Got a valid ticket for dédé from http://127.0.0.1:8083 172s 2024-06-08 00:43:37,398 INFO User dédé@example.test successfully authenticated 172s 2024-06-08 00:43:37,410 INFO Service ticket created for service https://www.example.com by user dédé@example.test. 172s 2024-06-08 00:43:37,417 INFO Trying to authenticate http://127.0.0.1:8080 again 172s 2024-06-08 00:43:37,422 INFO Got a valid ticket for dédé from http://127.0.0.1:8080 172s 2024-06-08 00:43:37,436 INFO User dédé@example.com successfully authenticated 172s 2024-06-08 00:43:37,442 INFO Service ticket created for service https://www.example.com by user dédé@example.com. 172s 2024-06-08 00:43:37,450 INFO Trying to authenticate http://127.0.0.1:8081 again 172s 2024-06-08 00:43:37,456 INFO Got a valid ticket for dédé from http://127.0.0.1:8081 172s 2024-06-08 00:43:37,470 INFO User dédé@example.org successfully authenticated 172s 2024-06-08 00:43:37,477 INFO Service ticket created for service https://www.example.com by user dédé@example.org. 172s 2024-06-08 00:43:37,484 INFO Trying to authenticate http://127.0.0.1:8082 again 172s 2024-06-08 00:43:37,491 INFO Got a valid ticket for dédé from http://127.0.0.1:8082 172s 2024-06-08 00:43:37,505 INFO User dédé@example.net successfully authenticated 172s 2024-06-08 00:43:37,512 INFO Service ticket created for service https://www.example.com by user dédé@example.net. 172s 2024-06-08 00:43:37,519 INFO Trying to authenticate http://127.0.0.1:8083 again 172s 2024-06-08 00:43:37,526 INFO Got a valid ticket for dédé from http://127.0.0.1:8083 172s 2024-06-08 00:43:37,540 INFO User dédé@example.test successfully authenticated 172s PASSED 172s cas_server/tests/test_models.py::FederatedUserTestCase::test_clean_old_entries 2024-06-08 00:43:37,547 INFO Service ticket created for service https://www.example.com by user dédé@example.test. 172s PASSED 172s cas_server/tests/test_models.py::FederatedUserTestCase::test_json_attributes PASSED 172s cas_server/tests/test_models.py::FederateSLOTestCase::test_clean_deleted_sessions PASSED 172s cas_server/tests/test_models.py::UserAttributesTestCase::test_clean_old_entries 2024-06-08 00:43:37,606 INFO User test successfully authenticated 172s PASSED 172s cas_server/tests/test_models.py::UserTestCase::test_cached_attributs 2024-06-08 00:43:37,633 INFO User test successfully authenticated 172s PASSED 172s cas_server/tests/test_models.py::UserTestCase::test_clean_deleted_sessions 2024-06-08 00:43:37,652 INFO User test successfully authenticated 172s 2024-06-08 00:43:37,666 INFO User test successfully authenticated 172s 2024-06-08 00:43:37,680 INFO Sending SLO requests to service http://127.0.0.1:45678 for user test 172s 2024-06-08 00:43:37,685 WARNING Error during SLO for user test: HTTPConnectionPool(host='127.0.0.1', port=45678): Max retries exceeded with url: / (Caused by NewConnectionError(': Failed to establish a new connection: [Errno 111] Connection refused')) 172s PASSED 172s cas_server/tests/test_models.py::UserTestCase::test_clean_old_entries 2024-06-08 00:43:37,703 INFO User test successfully authenticated 172s PASSED 172s cas_server/tests/test_models.py::UserTestCase::test_clean_old_entries_tgt_expired 2024-06-08 00:43:37,726 INFO User test successfully authenticated 172s PASSED 172s cas_server/tests/test_models.py::TicketTestCase::test_clean_old_service_ticket 2024-06-08 00:43:37,754 INFO User test successfully authenticated 172s 2024-06-08 00:43:37,769 INFO Sending SLO requests to service http://127.0.0.1:46411 for user test 172s PASSED2024-06-08 00:43:37,773 WARNING Error durring SLO ('Connection aborted.', RemoteDisconnected('Remote end closed connection without response')) 172s ConnectionError(ProtocolError('Connection aborted.', RemoteDisconnected('Remote end closed connection without response'))) 172s 172s cas_server/tests/test_models.py::TicketTestCase::test_json_attributes 2024-06-08 00:43:37,791 INFO User test successfully authenticated 172s PASSED 172s cas_server/tests/test_models.py::NewVersionWarningTestCase::test_send_mails PASSED 172s cas_server/tests/test_models.py::NewVersionWarningTestCase::test_send_mails_disabled PASSED 172s cas_server/tests/test_models.py::NewVersionWarningTestCase::test_send_mails_no_admins PASSED 172s cas_server/tests/test_models.py::NewVersionWarningTestCase::test_send_mails_same_version PASSED 172s cas_server/tests/test_templatetags.py::TemplateTagsTestCase::test_is_checkbox PASSED 172s cas_server/tests/test_templatetags.py::TemplateTagsTestCase::test_is_hidden PASSED 172s cas_server/tests/test_utils.py::CheckPasswordCase::test_bad_method PASSED 172s cas_server/tests/test_utils.py::CheckPasswordCase::test_crypt PASSED 172s cas_server/tests/test_utils.py::CheckPasswordCase::test_hex PASSED 172s cas_server/tests/test_utils.py::CheckPasswordCase::test_ldap_password_fail PASSED 172s cas_server/tests/test_utils.py::CheckPasswordCase::test_ldap_password_valid PASSED 172s cas_server/tests/test_utils.py::CheckPasswordCase::test_plain PASSED 172s cas_server/tests/test_utils.py::CheckPasswordCase::test_plain_unicode PASSED 172s cas_server/tests/test_utils.py::CheckPasswordCase::test_setup PASSED 172s cas_server/tests/test_utils.py::UtilsTestCase::test_crypt_salt_is_valid PASSED 172s cas_server/tests/test_utils.py::UtilsTestCase::test_dictfetchall PASSED 172s cas_server/tests/test_utils.py::UtilsTestCase::test_get_current_url PASSED 172s cas_server/tests/test_utils.py::UtilsTestCase::test_get_tuple PASSED 172s cas_server/tests/test_utils.py::UtilsTestCase::test_import_attr PASSED 173s cas_server/tests/test_utils.py::UtilsTestCase::test_last_version PASSED 173s cas_server/tests/test_utils.py::UtilsTestCase::test_regexpr_validator PASSED 173s cas_server/tests/test_utils.py::UtilsTestCase::test_update_url PASSED 173s cas_server/tests/test_view.py::LoginTestCase::test_ajax_get_ticket_fail 2024-06-08 00:43:38,883 INFO User test successfully authenticated 173s 2024-06-08 00:43:38,893 WARNING Service https://www.example.org not allowed. 173s PASSED 173s cas_server/tests/test_view.py::LoginTestCase::test_ajax_get_ticket_success 2024-06-08 00:43:38,914 INFO User test successfully authenticated 173s PASSED 173s cas_server/tests/test_view.py::LoginTestCase::test_ajax_get_ticket_success_alt 2024-06-08 00:43:38,924 INFO Service ticket created for service https://www.example.com by user test. 173s 2024-06-08 00:43:38,942 INFO User test successfully authenticated 173s 2024-06-08 00:43:38,951 INFO Service ticket created for service https://www.example.com by user test. 173s PASSED 173s cas_server/tests/test_view.py::LoginTestCase::test_ajax_get_ticket_warn 2024-06-08 00:43:38,968 INFO User test successfully authenticated 174s PASSED 174s cas_server/tests/test_view.py::LoginTestCase::test_ajax_logged 2024-06-08 00:43:38,993 INFO User test successfully authenticated 174s PASSED 174s cas_server/tests/test_view.py::LoginTestCase::test_ajax_logged_user_deleted 2024-06-08 00:43:39,016 INFO User test successfully authenticated 174s 2024-06-08 00:43:39,024 WARNING User test seems authenticated but is not found in the database. 174s 2024-06-08 00:43:39,025 INFO Logging out user test. 174s 2024-06-08 00:43:39,026 INFO User test logged out 174s PASSED 174s cas_server/tests/test_view.py::LoginTestCase::test_ajax_login_required PASSED 174s cas_server/tests/test_view.py::LoginTestCase::test_gateway 2024-06-08 00:43:39,053 INFO User test successfully authenticated 174s 2024-06-08 00:43:39,061 WARNING Username test not allowed on service restrict_user_fail 174s PASSED 174s cas_server/tests/test_view.py::LoginTestCase::test_login_post_missing_params 2024-06-08 00:43:39,082 WARNING A login attempt failed 174s 2024-06-08 00:43:39,102 WARNING A login attempt failed 174s 2024-06-08 00:43:39,124 WARNING A login attempt failed 174s PASSED 174s cas_server/tests/test_view.py::LoginTestCase::test_login_view_post_badlt 2024-06-08 00:43:39,151 WARNING Received an invalid login ticket 174s PASSED 174s cas_server/tests/test_view.py::LoginTestCase::test_login_view_post_badpass_good_lt 2024-06-08 00:43:39,175 WARNING A login attempt failed 174s PASSED 174s cas_server/tests/test_view.py::LoginTestCase::test_login_view_post_goodpass_goodlt 2024-06-08 00:43:39,201 INFO User test successfully authenticated 174s PASSED 174s cas_server/tests/test_view.py::LoginTestCase::test_login_view_post_goodpass_goodlt_warn 2024-06-08 00:43:39,224 INFO User test successfully authenticated 174s PASSED 175s cas_server/tests/test_view.py::LoginTestCase::test_lt_max PASSED 175s cas_server/tests/test_view.py::LoginTestCase::test_messages_info_box_bad_messages PASSED 175s cas_server/tests/test_view.py::LoginTestCase::test_messages_info_box_disabled PASSED 175s cas_server/tests/test_view.py::LoginTestCase::test_messages_info_box_enabled PASSED 175s cas_server/tests/test_view.py::LoginTestCase::test_new_version_available_badpypi PASSED 175s cas_server/tests/test_view.py::LoginTestCase::test_new_version_available_disabled PASSED 175s cas_server/tests/test_view.py::LoginTestCase::test_new_version_available_ok PASSED 175s cas_server/tests/test_view.py::LoginTestCase::test_renew 2024-06-08 00:43:40,559 INFO User test successfully authenticated 175s 2024-06-08 00:43:40,576 INFO User test successfully authenticated 175s 2024-06-08 00:43:40,581 INFO Service ticket created for service https://www.example.com by user test. 175s PASSED 175s cas_server/tests/test_view.py::LoginTestCase::test_renew_message_disabled 2024-06-08 00:43:40,599 INFO User test successfully authenticated 175s 2024-06-08 00:43:40,614 INFO User test successfully authenticated 175s 2024-06-08 00:43:40,619 INFO Service ticket created for service https://www.example.com by user test. 175s PASSED 175s cas_server/tests/test_view.py::LoginTestCase::test_service_filter 2024-06-08 00:43:40,637 INFO User test successfully authenticated 175s 2024-06-08 00:43:40,644 WARNING User constraint failed for test, service filter_fail: ^admin$ do not match right None. 175s 2024-06-08 00:43:40,649 WARNING User constraint failed for test, service filter_fail_alt: ^toto$ do not match nom Nymous. 175s 2024-06-08 00:43:40,656 INFO Service ticket created for service https://filter_success.example.com by user test. 175s PASSED 175s cas_server/tests/test_view.py::LoginTestCase::test_service_restrict_user 2024-06-08 00:43:40,675 INFO User test successfully authenticated 175s 2024-06-08 00:43:40,682 WARNING Username test not allowed on service restrict_user_fail 175s 2024-06-08 00:43:40,691 INFO Service ticket created for service https://restrict_user_success.example.com by user test. 175s PASSED 175s cas_server/tests/test_view.py::LoginTestCase::test_service_user_field 2024-06-08 00:43:40,711 INFO User test successfully authenticated 175s 2024-06-08 00:43:40,719 WARNING Cannot use uid a loggin for user test on service field_needed_fail because it is absent 175s 2024-06-08 00:43:40,727 INFO Service ticket created for service https://field_needed_success.example.com by user test. 175s PASSED 175s cas_server/tests/test_view.py::LoginTestCase::test_service_user_field_evaluate_to_false 2024-06-08 00:43:40,746 INFO User test successfully authenticated 175s 2024-06-08 00:43:40,753 WARNING Cannot use alias a loggin for user test on service field_needed_success because it is absent 175s PASSED 175s cas_server/tests/test_view.py::LoginTestCase::test_user_logged_not_in_db 2024-06-08 00:43:40,771 INFO User test successfully authenticated 175s 2024-06-08 00:43:40,780 WARNING User test seems authenticated but is not found in the database. 175s 2024-06-08 00:43:40,780 INFO Logging out user test. 175s PASSED 175s cas_server/tests/test_view.py::LoginTestCase::test_view_login_get_allowed_service 2024-06-08 00:43:40,781 INFO User test logged out 175s PASSED 175s cas_server/tests/test_view.py::LoginTestCase::test_view_login_get_allowed_service_no_message PASSED 175s cas_server/tests/test_view.py::LoginTestCase::test_view_login_get_auth_allowed_service 2024-06-08 00:43:40,833 INFO User test successfully authenticated 175s 2024-06-08 00:43:40,843 INFO Service ticket created for service https://www.example.com/é by user test. 175s PASSED 175s cas_server/tests/test_view.py::LoginTestCase::test_view_login_get_auth_allowed_service_non_ascii 2024-06-08 00:43:40,864 INFO User test successfully authenticated 175s 2024-06-08 00:43:40,874 INFO Service ticket created for service https://www.example.com by user test. 175s PASSED 175s cas_server/tests/test_view.py::LoginTestCase::test_view_login_get_auth_allowed_service_warn 2024-06-08 00:43:40,895 INFO User test successfully authenticated 175s 2024-06-08 00:43:40,911 WARNING Received a login attempt for an already-active user 175s 2024-06-08 00:43:40,915 INFO Service ticket created for service https://www.example.com by user test. 175s PASSED 175s cas_server/tests/test_view.py::LoginTestCase::test_view_login_get_auth_denied_service 2024-06-08 00:43:40,935 INFO User test successfully authenticated 175s 2024-06-08 00:43:40,943 WARNING Service https://www.example.org not allowed. 175s PASSED 175s cas_server/tests/test_view.py::LoginTestCase::test_view_login_get_denied_service 2024-06-08 00:43:40,953 WARNING Service https://www.example.net not allowed. 175s PASSED 175s cas_server/tests/test_view.py::LoginTestCase::test_view_login_get_denied_service_no_message 2024-06-08 00:43:40,969 WARNING Service https://www.example.net not allowed. 176s PASSED 176s cas_server/tests/test_view.py::LogoutTestCase::test_ajax_logout 2024-06-08 00:43:40,993 INFO User test successfully authenticated 176s 2024-06-08 00:43:40,998 INFO logout requested 176s 2024-06-08 00:43:40,999 INFO Logging out user test. 176s 2024-06-08 00:43:41,004 INFO User test logged out 176s PASSED 176s cas_server/tests/test_view.py::LogoutTestCase::test_ajax_logout_all_session 2024-06-08 00:43:41,019 INFO User test successfully authenticated 176s 2024-06-08 00:43:41,034 INFO User test successfully authenticated 176s 2024-06-08 00:43:41,051 INFO User test successfully authenticated 176s 2024-06-08 00:43:41,067 INFO User test successfully authenticated 176s 2024-06-08 00:43:41,084 INFO User test successfully authenticated 176s 2024-06-08 00:43:41,100 INFO User test successfully authenticated 176s 2024-06-08 00:43:41,114 INFO User test successfully authenticated 176s 2024-06-08 00:43:41,128 INFO User test successfully authenticated 176s 2024-06-08 00:43:41,143 INFO User test successfully authenticated 176s 2024-06-08 00:43:41,148 INFO logout requested 176s 2024-06-08 00:43:41,149 INFO Logging out user test from all sessions. 176s 2024-06-08 00:43:41,193 INFO User test logged out 176s PASSED 176s cas_server/tests/test_view.py::LogoutTestCase::test_ajax_redirect_after_logout 2024-06-08 00:43:41,209 INFO User test successfully authenticated 176s PASSED 176s cas_server/tests/test_view.py::LogoutTestCase::test_logout 2024-06-08 00:43:41,215 INFO logout requested 176s 2024-06-08 00:43:41,216 INFO Logging out user test. 176s 2024-06-08 00:43:41,221 INFO User test logged out 176s 2024-06-08 00:43:41,225 INFO logout requested 176s PASSED 176s cas_server/tests/test_view.py::LogoutTestCase::test_logout_from_all_session 2024-06-08 00:43:41,240 INFO User test successfully authenticated 176s 2024-06-08 00:43:41,254 INFO User test successfully authenticated 176s 2024-06-08 00:43:41,258 INFO logout requested 176s 2024-06-08 00:43:41,259 INFO Logging out user test from all sessions. 176s 2024-06-08 00:43:41,270 INFO User test logged out 176s PASSED 176s cas_server/tests/test_view.py::LogoutTestCase::test_logout_slo 2024-06-08 00:43:41,288 INFO User test successfully authenticated 176s 2024-06-08 00:43:41,298 INFO Service ticket created for service http://127.0.0.1:38937 by user test. 176s 2024-06-08 00:43:41,303 INFO Validate: Service ticket ST-8e6r0d8nBbqACkrmGsl8M02gW3dqQ5OA1Ei94TYZot9aeWnPNxqiYwtKGqNVB validated, user test authenticated on service http://127.0.0.1:38937 176s 2024-06-08 00:43:41,304 INFO logout requested 176s 2024-06-08 00:43:41,305 INFO Logging out user test. 176s 2024-06-08 00:43:41,310 INFO Sending SLO requests to service http://127.0.0.1:38937 for user test 176s 2024-06-08 00:43:41,314 WARNING Error during SLO for user test: ('Connection aborted.', RemoteDisconnected('Remote end closed connection without response')) 176s 2024-06-08 00:43:41,316 INFO User test logged out 176s 2024-06-08 00:43:41,329 INFO User test successfully authenticated 176s 2024-06-08 00:43:41,338 INFO Service ticket created for service http://127.0.0.1:45678 by user test. 176s 2024-06-08 00:43:41,342 INFO Validate: Service ticket ST-kd8Q3KjZP20YGefa2V1jKs4mPSzQKD9QDHVFgyiKwQMyGdEgzCJmVyR5vO1sO validated, user test authenticated on service http://127.0.0.1:45678 176s 2024-06-08 00:43:41,344 INFO logout requested 176s 2024-06-08 00:43:41,345 INFO Logging out user test. 176s 2024-06-08 00:43:41,349 INFO Sending SLO requests to service http://127.0.0.1:45678 for user test 176s 2024-06-08 00:43:41,353 WARNING Error during SLO for user test: ('Connection aborted.', RemoteDisconnected('Remote end closed connection without response')) 176s 2024-06-08 00:43:41,355 INFO User test logged out 176s 2024-06-08 00:43:41,368 INFO User test successfully authenticated 176s 2024-06-08 00:43:41,377 INFO Service ticket created for service http://127.0.0.1:45678 by user test. 176s 2024-06-08 00:43:41,381 INFO Validate: Service ticket ST-uNTHOKLAFyaNscwcqEXanUfq8hVpZeQ48v9PXa3Lu4lywdf9glq8XCBErHnGW validated, user test authenticated on service http://127.0.0.1:45678 176s 2024-06-08 00:43:41,383 INFO logout requested 176s 2024-06-08 00:43:41,384 INFO Logging out user test. 176s 2024-06-08 00:43:41,388 INFO Sending SLO requests to service http://127.0.0.1:45678 for user test 176s 2024-06-08 00:43:41,391 WARNING Error during SLO for user test: HTTPConnectionPool(host='127.0.0.1', port=35269): Max retries exceeded with url: / (Caused by NewConnectionError(': Failed to establish a new connection: [Errno 111] Connection refused')) 176s 2024-06-08 00:43:41,393 INFO User test logged out 176s PASSED 176s cas_server/tests/test_view.py::LogoutTestCase::test_logout_view 2024-06-08 00:43:41,410 INFO User test successfully authenticated 176s 2024-06-08 00:43:41,425 INFO User test successfully authenticated 176s 2024-06-08 00:43:41,435 INFO logout requested 176s 2024-06-08 00:43:41,436 INFO Logging out user test. 176s 2024-06-08 00:43:41,442 INFO User test logged out 176s PASSED 176s cas_server/tests/test_view.py::LogoutTestCase::test_logout_view_service 2024-06-08 00:43:41,471 INFO User test successfully authenticated 176s 2024-06-08 00:43:41,479 INFO logout requested 176s 2024-06-08 00:43:41,480 INFO Logging out user test. 176s 2024-06-08 00:43:41,486 INFO User test logged out 176s PASSED 176s cas_server/tests/test_view.py::LogoutTestCase::test_logout_view_url 2024-06-08 00:43:41,511 INFO User test successfully authenticated 176s 2024-06-08 00:43:41,517 INFO logout requested 176s 2024-06-08 00:43:41,518 INFO Logging out user test. 176s 2024-06-08 00:43:41,524 INFO User test logged out 176s PASSED 176s cas_server/tests/test_view.py::LogoutTestCase::test_redirect_after_logout 2024-06-08 00:43:41,550 INFO User test successfully authenticated 176s 2024-06-08 00:43:41,554 INFO logout requested 176s 2024-06-08 00:43:41,555 INFO Logging out user test. 176s 2024-06-08 00:43:41,560 INFO User test logged out 176s PASSED 176s cas_server/tests/test_view.py::LogoutTestCase::test_redirect_after_logout_to_service 2024-06-08 00:43:41,575 INFO User test successfully authenticated 176s 2024-06-08 00:43:41,579 INFO logout requested 176s 2024-06-08 00:43:41,580 INFO Logging out user test. 176s 2024-06-08 00:43:41,585 INFO User test logged out 176s 2024-06-08 00:43:41,593 INFO logout requested 176s PASSED 176s cas_server/tests/test_view.py::AuthTestCase::test_auth_view_badpass PASSED 176s cas_server/tests/test_view.py::AuthTestCase::test_auth_view_badsecret PASSED 176s cas_server/tests/test_view.py::AuthTestCase::test_auth_view_badservice 2024-06-08 00:43:41,617 WARNING Service https://www.example.org not allowed. 176s PASSED 176s cas_server/tests/test_view.py::AuthTestCase::test_auth_view_badsettings PASSED 176s cas_server/tests/test_view.py::AuthTestCase::test_auth_view_goodpass PASSED 176s cas_server/tests/test_view.py::AuthTestCase::test_auth_view_goodpass_logged 2024-06-08 00:43:41,641 INFO User test successfully authenticated 176s PASSED 176s cas_server/tests/test_view.py::AuthTestCase::test_auth_view_missing_parameter PASSED 176s cas_server/tests/test_view.py::ValidateTestCase::test_validate_missing_parameter 2024-06-08 00:43:41,668 INFO User test successfully authenticated 176s 2024-06-08 00:43:41,677 INFO Service ticket created for service https://www.example.com by user test. 176s 2024-06-08 00:43:41,680 WARNING Validate: service or ticket missing 176s 2024-06-08 00:43:41,681 WARNING Validate: service or ticket missing 176s PASSED 176s cas_server/tests/test_view.py::ValidateTestCase::test_validate_service_renew 2024-06-08 00:43:41,694 INFO User test successfully authenticated 176s 2024-06-08 00:43:41,699 INFO Service ticket created for service https://www.example.com by user test. 176s 2024-06-08 00:43:41,703 INFO Validate: Service ticket ST-5C6gcyrH6lPk75GABJHe5UCZikz2WF4iGV6XB1UmP00RJTiwxvre7dtqMVuUv validated, user test authenticated on service https://www.example.com 176s 2024-06-08 00:43:41,714 INFO User test successfully authenticated 176s 2024-06-08 00:43:41,719 INFO Service ticket created for service https://www.example.com by user test. 176s 2024-06-08 00:43:41,723 INFO Validate: Service ticket ST-cxXmeJdyuCEul3ZMHpGemQzEfRRyLY9rVm6m62VVpNavrbUtrE2D9j6r9KUfS validated, user test authenticated on service https://www.example.com 176s 2024-06-08 00:43:41,728 INFO Service ticket created for service https://www.example.com by user test. 176s 2024-06-08 00:43:41,731 WARNING Validate: Service ticket ST-nmn4U7Ynm4l0IvhNjW1UIwCR5XZoFCPLZHtuB2jEEyGpMaHAoC1wBGozMkfYt not found or already validated, auth to https://www.example.com failed 176s PASSED 176s cas_server/tests/test_view.py::ValidateTestCase::test_validate_user_field_ok 2024-06-08 00:43:41,744 INFO User test successfully authenticated 176s 2024-06-08 00:43:41,753 INFO Service ticket created for service https://user_field.example.com by user test. 176s 2024-06-08 00:43:41,757 INFO Validate: Service ticket ST-W3VB7MEdVaUuZMI53NZ529dB3fL3U2wM2Vay2YxJZb3nZSvFk1MnYTHMHj72D validated, user test authenticated on service https://user_field.example.com 176s 2024-06-08 00:43:41,767 INFO User test successfully authenticated 176s 2024-06-08 00:43:41,776 INFO Service ticket created for service https://user_field_alt.example.com by user test. 176s 2024-06-08 00:43:41,780 INFO Validate: Service ticket ST-GPrg158xXAKXCXsLRrmy7LOZcTh3aRGaJrPBQf8SArrGWsvptCcltFcBLzbev validated, user test authenticated on service https://user_field_alt.example.com 176s PASSED 176s cas_server/tests/test_view.py::ValidateTestCase::test_validate_view_badservice 2024-06-08 00:43:41,795 INFO User test successfully authenticated 176s 2024-06-08 00:43:41,805 INFO Service ticket created for service https://www.example.com by user test. 176s 2024-06-08 00:43:41,808 WARNING Validate: Service ticket ST-1q6bKCoOTPG6B6xf8x80GCskz3GIcJX5KlFev4FzOzfCsEcNhXXhkDMnyCgu3 not found or already validated, auth to https://www.example.org failed 176s PASSED 176s cas_server/tests/test_view.py::ValidateTestCase::test_validate_view_badticket 2024-06-08 00:43:41,823 INFO User test successfully authenticated 176s 2024-06-08 00:43:41,832 INFO Service ticket created for service https://www.example.com by user test. 176s 2024-06-08 00:43:41,836 WARNING Validate: Service ticket ST-RANDOM not found or already validated, auth to https://www.example.com failed 176s PASSED 176s cas_server/tests/test_view.py::ValidateTestCase::test_validate_view_ok 2024-06-08 00:43:41,850 INFO User test successfully authenticated 176s 2024-06-08 00:43:41,858 INFO Service ticket created for service https://www.example.com by user test. 176s 2024-06-08 00:43:41,863 INFO Validate: Service ticket ST-SgylpFJqHDMxZhCfeZWSBzBX0A4kcDQ1Yjf2FvuCXRENSzG7IzTHnS8jJc2k6 validated, user test authenticated on service https://www.example.com 176s PASSED 176s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_missing_parameter 2024-06-08 00:43:41,879 INFO User test successfully authenticated 176s 2024-06-08 00:43:41,888 INFO Service ticket created for service http://127.0.0.1:45678 by user test. 176s 2024-06-08 00:43:41,891 WARNING ValidateService: missing ticket or service 176s 2024-06-08 00:43:41,892 WARNING ValidateService: missing ticket or service 176s PASSED 176s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_proxy 2024-06-08 00:43:41,908 INFO User test successfully authenticated 176s 2024-06-08 00:43:41,917 INFO Service ticket created for service http://127.0.0.1:42865 by user test. 176s 2024-06-08 00:43:41,926 INFO ValidateService: ticket ST-V7Zx33XA15JOUchBp8GFsTEWTQusLgSP8yKwwBnFVavMFd7YsZwyYw6giSPiA validated for user test on service http://127.0.0.1:42865. Proxy Granting Ticket transmited to http://127.0.0.1:42865. 176s 2024-06-08 00:43:41,933 INFO Proxy ticket created for user test on service http://127.0.0.1:45678. 176s 2024-06-08 00:43:41,938 INFO ValidateService: ticket PT-qGpX3pfk5QTNSBw92ogqbOY1asLiVLSpn07OV65dD8dpQyj4Zdd9Rj8oJrL2c validated for user test on service http://127.0.0.1:45678. 176s 2024-06-08 00:43:41,949 INFO User test successfully authenticated 176s 2024-06-08 00:43:41,958 INFO Service ticket created for service http://127.0.0.1:36399 by user test. 176s 2024-06-08 00:43:41,965 INFO ValidateService: ticket ST-xRCKpXleRulp2EglMoQ0l7SMh66ElFYuIiNPwCg2Bnr6Y8zhMeB6RgF5miOL9 validated for user test on service http://127.0.0.1:36399. Proxy Granting Ticket transmited to http://127.0.0.1:36399. 177s 2024-06-08 00:43:41,971 INFO Proxy ticket created for user test on service http://127.0.0.1:45678. 177s 2024-06-08 00:43:41,973 WARNING ValidateService: validation error: INVALID_TICKET PT-OYaJGZ6SqEEQTtFYUlcn38MgGnGBWvV7oUMMZ4YbhA658g8IHVZ7ae3M1uul6 177s PASSED 177s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_replace_attributes 2024-06-08 00:43:41,988 INFO User test successfully authenticated 177s 2024-06-08 00:43:41,997 INFO Service ticket created for service https://replace_attribute.example.com by user test. 177s 2024-06-08 00:43:42,001 INFO ValidateService: ticket ST-t4T1MpcZ8vTBAj6nuIxHWW4YP0Pje7DT7fz62wk73GfPs5e9H0QD06RtVVKgn validated for user test on service https://replace_attribute.example.com. 177s 2024-06-08 00:43:42,012 INFO User test successfully authenticated 177s 2024-06-08 00:43:42,020 INFO Service ticket created for service https://replace_attribute_list.example.com by user test. 177s PASSED2024-06-08 00:43:42,025 INFO ValidateService: ticket ST-OfPt46O39AqgTvrFPoafqlgiK60nNqyUsmIL0enHyK6AMmILqt3pHcP5fJmpi validated for user test on service https://replace_attribute_list.example.com. 177s 177s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_service_pgturl_404 2024-06-08 00:43:42,041 INFO User test successfully authenticated 177s 2024-06-08 00:43:42,049 INFO Service ticket created for service http://127.0.0.1:45207 by user test. 177s 2024-06-08 00:43:42,057 INFO ValidateService: ticket ST-VYlXduPvy0aVtGBtWNHBTM7Ju68efAfJJyUbJiDv83VROrTmJu6h52ATeS9u5 validated for user test on service http://127.0.0.1:45207. Proxy Granting Ticket transmited to http://127.0.0.1:45207. 177s PASSED 177s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_service_pgturl_bad_proxy_callback 2024-06-08 00:43:42,073 INFO User test successfully authenticated 177s 2024-06-08 00:43:42,082 INFO Service ticket created for service http://127.0.0.1:45678 by user test. 177s 2024-06-08 00:43:42,087 WARNING ValidateService: validation error: INVALID_PROXY_CALLBACK callback url not allowed by configuration 177s 2024-06-08 00:43:42,137 INFO User test successfully authenticated 177s 2024-06-08 00:43:42,146 INFO Service ticket created for service http://127.0.0.1:45678 by user test. 177s 2024-06-08 00:43:42,151 WARNING Service https://www.example.org not allowed. 177s 2024-06-08 00:43:42,151 WARNING ValidateService: validation error: INVALID_PROXY_CALLBACK callback url not allowed by configuration 177s PASSED 177s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_service_pgturl_sslerror 2024-06-08 00:43:42,166 INFO User test successfully authenticated 177s 2024-06-08 00:43:42,175 INFO Service ticket created for service https://127.0.0.1:38257 by user test. 177s 2024-06-08 00:43:42,240 WARNING ValidateService: validation error: INVALID_PROXY_CALLBACK : HTTPSConnectionPool(host='127.0.0.1', port=38257): Max retries exceeded with url: /?pgtId=PGT-OiEdyN3Zqv1AL03KarsUjtGV88OwyVGCNtof60YVjTcOnUHomGckXvP64w1i&pgtIou=PGTIOU-UuATiGw1UGA6tnHImEpmJB2c54ZK0oSDCEh2IQIpCL45nliaUGa2HN6KC (Caused by SSLError(SSLError(1, '[SSL: WRONG_VERSION_NUMBER] wrong version number (_ssl.c:1000)'))) 177s PASSED 177s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_service_renew 2024-06-08 00:43:42,258 INFO User test successfully authenticated 177s 2024-06-08 00:43:42,263 INFO Service ticket created for service http://127.0.0.1:45678 by user test. 177s 2024-06-08 00:43:42,268 INFO ValidateService: ticket ST-HkvY8DahEm96q9lPdnksXjTn1JoVFO1Sn8vcQSXPlvrvKxSYoBJlFslF5qZfa validated for user test on service http://127.0.0.1:45678. 177s 2024-06-08 00:43:42,280 INFO User test successfully authenticated 177s 2024-06-08 00:43:42,285 INFO Service ticket created for service http://127.0.0.1:45678 by user test. 177s 2024-06-08 00:43:42,290 INFO ValidateService: ticket ST-n8AtGdMDFE3Svw8wcEvDAzYaYcnyW1zVqzu4ccstv1S9ibCCuQNb4BVM4hJj9 validated for user test on service http://127.0.0.1:45678. 177s 2024-06-08 00:43:42,296 INFO Service ticket created for service http://127.0.0.1:45678 by user test. 177s 2024-06-08 00:43:42,299 WARNING ValidateService: validation error: INVALID_TICKET ticket not found 177s PASSED 177s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_service_view_badservice 2024-06-08 00:43:42,315 INFO User test successfully authenticated 177s 2024-06-08 00:43:42,324 INFO Service ticket created for service http://127.0.0.1:45678 by user test. 177s 2024-06-08 00:43:42,328 WARNING ValidateService: validation error: INVALID_SERVICE https://www.example.org 177s PASSED 177s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_service_view_badticket_badprefix 2024-06-08 00:43:42,344 INFO User test successfully authenticated 177s 2024-06-08 00:43:42,353 INFO Service ticket created for service http://127.0.0.1:45678 by user test. 177s 2024-06-08 00:43:42,356 WARNING ValidateService: validation error: INVALID_TICKET RANDOM 177s PASSED 177s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_service_view_badticket_goodprefix 2024-06-08 00:43:42,372 INFO User test successfully authenticated 177s 2024-06-08 00:43:42,382 INFO Service ticket created for service http://127.0.0.1:45678 by user test. 177s 2024-06-08 00:43:42,385 WARNING ValidateService: validation error: INVALID_TICKET ticket not found 177s PASSED 177s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_service_view_ok 2024-06-08 00:43:42,400 INFO User test successfully authenticated 177s 2024-06-08 00:43:42,408 INFO Service ticket created for service http://127.0.0.1:45678 by user test. 177s 2024-06-08 00:43:42,414 INFO ValidateService: ticket ST-wrnzKLIHGBCXii7deFIZOYZx2uJ1ZFbwG73Jc6Po5HYqIO8NNCzo8bDRrpJC7 validated for user test on service http://127.0.0.1:45678. 177s PASSED 177s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_service_view_ok_one_attribute 2024-06-08 00:43:42,429 INFO User test successfully authenticated 177s 2024-06-08 00:43:42,437 INFO Service ticket created for service https://one_attribute.example.com by user test. 177s 2024-06-08 00:43:42,442 INFO ValidateService: ticket ST-E9VWmO9QsFhBWzB3XfshmtCNoqeHUnpVMzzIzuJdYZQT6XvPPZD1r160mKhRD validated for user test on service https://one_attribute.example.com. 177s PASSED 177s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_service_view_ok_pgturl 2024-06-08 00:43:42,457 INFO User test successfully authenticated 177s 2024-06-08 00:43:42,466 INFO Service ticket created for service http://127.0.0.1:43651 by user test. 177s 2024-06-08 00:43:42,473 INFO ValidateService: ticket ST-cxeF3tsPVJXw7BhVtL4ilhG9pQQsdr3Dd2EFJG4GnUPy1iAcBMH2ttY1uXUgf validated for user test on service http://127.0.0.1:43651. Proxy Granting Ticket transmited to http://127.0.0.1:43651. 177s PASSED 177s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_user_field_ok 2024-06-08 00:43:42,488 INFO User test successfully authenticated 177s 2024-06-08 00:43:42,497 INFO Service ticket created for service https://user_field.example.com by user test. 177s 2024-06-08 00:43:42,502 INFO ValidateService: ticket ST-WX4GqH7fsjNKgpjiVb70aFIgZHFf4YbUAEzd6DCoyhWKGezRLnOngq4vgXUE7 validated for user test on service https://user_field.example.com. 177s 2024-06-08 00:43:42,512 INFO User test successfully authenticated 177s 2024-06-08 00:43:42,520 INFO Service ticket created for service https://user_field_alt.example.com by user test. 177s 2024-06-08 00:43:42,525 INFO ValidateService: ticket ST-9Tnbq9ZGRYkgB6kCEGDhCz9RE9Iu8CEFCGsNvm0kNsfnjOMUXZra9K2f2bfBw validated for user test on service https://user_field_alt.example.com. 177s PASSED 177s cas_server/tests/test_view.py::ProxyTestCase::test_proxy_missing_parameter 2024-06-08 00:43:42,542 INFO User test successfully authenticated 177s 2024-06-08 00:43:42,551 INFO Service ticket created for service http://127.0.0.1:44001 by user test. 177s 2024-06-08 00:43:42,559 INFO ValidateService: ticket ST-JO6yW4AzpzDulfK8OqYsac116xWzmzZIdmZygRVSI0QFl4y7N8gwfbwIbceEl validated for user test on service http://127.0.0.1:44001. Proxy Granting Ticket transmited to http://127.0.0.1:44001. 177s 2024-06-08 00:43:42,561 WARNING Proxy: validation error: INVALID_REQUEST you must specify and pgt and targetService 177s 2024-06-08 00:43:42,562 WARNING Proxy: validation error: INVALID_REQUEST you must specify and pgt and targetService 177s PASSED 177s cas_server/tests/test_view.py::ProxyTestCase::test_proxy_unauthorized_user 2024-06-08 00:43:42,578 INFO User test successfully authenticated 177s 2024-06-08 00:43:42,586 INFO Service ticket created for service http://127.0.0.1:43949 by user test. 177s 2024-06-08 00:43:42,594 INFO ValidateService: ticket ST-C4XPcXNWGtqhRI0HrhhjouUOhfyw6g8vnQw6fHDwQO0GpXPguzjZmYfqkO8iA validated for user test on service http://127.0.0.1:43949. Proxy Granting Ticket transmited to http://127.0.0.1:43949. 177s 2024-06-08 00:43:42,598 WARNING Username test not allowed on service restrict_user_fail 177s 2024-06-08 00:43:42,598 WARNING Proxy: validation error: UNAUTHORIZED_USER User test not allowed on https://restrict_user_fail.example.com 177s 2024-06-08 00:43:42,602 WARNING User constraint failed for test, service filter_fail: ^admin$ do not match right None. 177s 2024-06-08 00:43:42,602 WARNING Proxy: validation error: UNAUTHORIZED_USER User test not allowed on https://filter_fail.example.com 177s 2024-06-08 00:43:42,605 WARNING Cannot use uid a loggin for user test on service field_needed_fail because it is absent 177s 2024-06-08 00:43:42,605 WARNING Proxy: validation error: UNAUTHORIZED_USER User test not allowed on https://field_needed_fail.example.com 177s PASSED 177s cas_server/tests/test_view.py::ProxyTestCase::test_validate_proxy_bad_pgt 2024-06-08 00:43:42,621 INFO User test successfully authenticated 177s 2024-06-08 00:43:42,630 INFO Service ticket created for service http://127.0.0.1:42127 by user test. 177s 2024-06-08 00:43:42,639 INFO ValidateService: ticket ST-vKci0gTvmG4h0XgLkYIEwZIzfsDyPw4gGLlHblZ8SXiKruPUlNFoprnegOTTg validated for user test on service http://127.0.0.1:42127. Proxy Granting Ticket transmited to http://127.0.0.1:42127. 177s PASSED2024-06-08 00:43:42,642 WARNING Proxy: validation error: INVALID_TICKET PGT PGT-RANDOM not found 177s 177s cas_server/tests/test_view.py::ProxyTestCase::test_validate_proxy_bad_service 2024-06-08 00:43:42,658 INFO User test successfully authenticated 177s 2024-06-08 00:43:42,667 INFO Service ticket created for service http://127.0.0.1:46195 by user test. 177s 2024-06-08 00:43:42,674 INFO ValidateService: ticket ST-GtA6apQfewxFqJQvRbv9LgFYRIE1ii6f5OF0YK87WaAnYH6sBTy5dYkLuoLQG validated for user test on service http://127.0.0.1:46195. Proxy Granting Ticket transmited to http://127.0.0.1:46195. 177s 2024-06-08 00:43:42,677 WARNING Service https://www.example.org not allowed. 177s 2024-06-08 00:43:42,677 WARNING Proxy: validation error: UNAUTHORIZED_SERVICE https://www.example.org 177s 2024-06-08 00:43:42,679 WARNING Proxy: validation error: UNAUTHORIZED_SERVICE the service http://127.0.0.1:46195 does not allow proxy tickets 177s PASSED 177s cas_server/tests/test_view.py::ProxyTestCase::test_validate_proxy_ok 2024-06-08 00:43:42,696 INFO User test successfully authenticated 177s 2024-06-08 00:43:42,704 INFO Service ticket created for service http://127.0.0.1:35733 by user test. 177s 2024-06-08 00:43:42,712 INFO ValidateService: ticket ST-py4M48NBvDC0B2kSAuZeNi6HYcSun2VU7b8wWkNjcd28hYkMcRT4Otf8HP1e2 validated for user test on service http://127.0.0.1:35733. Proxy Granting Ticket transmited to http://127.0.0.1:35733. 177s 2024-06-08 00:43:42,719 INFO Proxy ticket created for user test on service https://www.example.com. 177s 2024-06-08 00:43:42,723 INFO ValidateService: ticket PT-uFLP7TkuyS7c4nMYvgTP2qABUiV8MhBbKR8VOyPwtaQviZ1ea6ZIdkkBQ6n53 validated for user test on service https://www.example.com. 177s PASSED 177s cas_server/tests/test_view.py::SamlValidateTestCase::test_saml_bad_target 2024-06-08 00:43:42,740 INFO User test successfully authenticated 177s 2024-06-08 00:43:42,749 INFO Service ticket created for service https://www.example.com by user test. 177s 2024-06-08 00:43:42,753 WARNING SamlValidate: validation error: AuthnFailed TARGET https://www.example.org does not match ticket service 177s PASSED 177s cas_server/tests/test_view.py::SamlValidateTestCase::test_saml_bad_ticket 2024-06-08 00:43:42,761 WARNING SamlValidate: validation error: AuthnFailed ticket ST-W8YgpoeerBPu1X9NeqLIs72ABoZarNb7tIIOrJ78SrBdODlfjvPG10NK1ZOLu not found 177s 2024-06-08 00:43:42,763 WARNING SamlValidate: validation error: AuthnFailed ticket PT-q5INIOvuKYbrhI76b7fFztXggCYdUNDuMPdqfVzl3nOIElnkiSfijhyrWWUcn not found 177s PASSED 177s cas_server/tests/test_view.py::SamlValidateTestCase::test_saml_bad_ticket_prefix 2024-06-08 00:43:42,770 WARNING SamlValidate: validation error: AuthnFailed ticket RANDOM-NOT-BEGINING-WITH-ST-OR-ST should begin with PT- or ST- 177s PASSED 177s cas_server/tests/test_view.py::SamlValidateTestCase::test_saml_bad_xml 2024-06-08 00:43:42,776 WARNING SamlValidate: validation error: VersionMismatch 177s PASSED 177s cas_server/tests/test_view.py::SamlValidateTestCase::test_saml_ok 2024-06-08 00:43:42,792 INFO User test successfully authenticated 177s 2024-06-08 00:43:42,801 INFO Service ticket created for service https://www.example.com by user test. 177s 2024-06-08 00:43:42,813 INFO User test successfully authenticated 177s 2024-06-08 00:43:42,822 INFO Service ticket created for service http://127.0.0.1:44281 by user test. 177s 2024-06-08 00:43:42,829 INFO ValidateService: ticket ST-rXWZyKjOQPwkvjaxSusRLcuiYxfs2R5NZZpCohkaH00axymY0ubqwuYbdlOEQ validated for user test on service http://127.0.0.1:44281. Proxy Granting Ticket transmited to http://127.0.0.1:44281. 177s 2024-06-08 00:43:42,836 INFO Proxy ticket created for user test on service https://www.example.com. 177s 2024-06-08 00:43:42,840 INFO SamlValidate: ticket ST-zQfqlh7vaPQBjQT4d2CMueklfWdnjd89nSrFsbafGy3IR4Yn58ULMZj1CbICa validated for user test on service https://www.example.com. 177s 2024-06-08 00:43:42,844 INFO SamlValidate: ticket PT-SEfetaOcpw6OeHc0BO3naQdxEffvs4lGX40JoveyOYE9gE4UqCgzkrkWjYeWc validated for user test on service https://www.example.com. 177s PASSED 177s cas_server/tests/test_view.py::SamlValidateTestCase::test_saml_ok_user_field 2024-06-08 00:43:42,860 INFO User test successfully authenticated 177s 2024-06-08 00:43:42,868 INFO Service ticket created for service https://field_needed_success.example.com by user test. 177s 2024-06-08 00:43:42,873 INFO SamlValidate: ticket ST-x1ovkaID8wPzrBU5v4GkckSmPOhy0TqQRrM2PXIITll5EV8yfHdNkhHivckho validated for user test on service https://field_needed_success.example.com. 177s 2024-06-08 00:43:42,884 INFO User test successfully authenticated 177s 2024-06-08 00:43:42,893 INFO Service ticket created for service https://field_needed_success_alt.example.com by user test. 177s 2024-06-08 00:43:42,898 INFO SamlValidate: ticket ST-TblLR0UvdkgJjitoLpK6fu4ayoOmImi3Qtbq30vyhUuhxl2W4RhCtXAs63gQQ validated for user test on service https://field_needed_success_alt.example.com. 177s PASSEDDestroying test database for alias 'default'... 177s 177s 177s =============================== warnings summary =============================== 177s cas_server/utils.py:33 177s /tmp/autopkgtest.Lm6AWl/autopkgtest_tmp/cas_server/utils.py:33: DeprecationWarning: 'crypt' is deprecated and slated for removal in Python 3.13 177s import crypt 177s 177s cas_server/tests/utils.py:20 177s /tmp/autopkgtest.Lm6AWl/autopkgtest_tmp/cas_server/tests/utils.py:20: DeprecationWarning: 'cgi' is deprecated and slated for removal in Python 3.13 177s import cgi 177s 177s cas_server/tests/test_federate.py: 8 warnings 177s cas_server/tests/test_view.py: 3 warnings 177s /tmp/autopkgtest.Lm6AWl/autopkgtest_tmp/cas_server/utils.py:208: DeprecationWarning: datetime.datetime.utcnow() is deprecated and scheduled for removal in a future version. Use timezone-aware objects to represent datetimes in UTC: datetime.datetime.now(datetime.UTC). 177s datetime.utcnow() + timedelta(seconds=max_age), 177s 177s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_login_post_provider 177s /usr/lib/python3.12/unittest/case.py:690: DeprecationWarning: It is deprecated to return a value that is not None from a test case (>) 177s return self.run(*args, **kwds) 177s 177s -- Docs: https://docs.pytest.org/en/stable/how-to/capture-warnings.html 177s ======================= 128 passed, 14 warnings in 8.94s ======================= 178s 178s autopkgtest [00:43:43]: test run-test-suite.sh: -----------------------] 178s run-test-suite.sh PASS 178s autopkgtest [00:43:43]: test run-test-suite.sh: - - - - - - - - - - results - - - - - - - - - - 179s autopkgtest [00:43:44]: @@@@@@@@@@@@@@@@@@@@ summary 179s run-test-suite.sh PASS 189s nova [W] Using flock in scalingstack-bos02-ppc64el 189s Creating nova instance adt-oracular-ppc64el-django-cas-server-20240608-004044-juju-7f2275-prod-proposed-migration-environment-2-2e5f4c61-b0ce-43da-a10b-5d61195966e7 from image adt/ubuntu-oracular-ppc64el-server-20240607.img (UUID 2e7ff4dd-25ad-4882-8618-1243d2d4ac8e)...