0s autopkgtest [11:04:06]: starting date and time: 2024-03-22 11:04:06+0000 0s autopkgtest [11:04:06]: git checkout: 4a1cd702 l/adt_testbed: don't blame the testbed for unsolvable build deps 0s autopkgtest [11:04:06]: host juju-7f2275-prod-proposed-migration-environment-3; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.3aq2rqi4/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --setup-commands /home/ubuntu/autopkgtest/setup-commands/setup-testbed --apt-pocket=proposed=src:sphinx --apt-upgrade django-cas-server --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=sphinx/7.2.6-6 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-3@bos02-ppc64el-16.secgroup --name adt-noble-ppc64el-django-cas-server-20240322-110406-juju-7f2275-prod-proposed-migration-environment-3 --image adt/ubuntu-noble-ppc64el-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-3 --net-id=net_prod-proposed-migration -e TERM=linux -e ''"'"'http_proxy=http://squid.internal:3128'"'"'' -e ''"'"'https_proxy=http://squid.internal:3128'"'"'' -e ''"'"'no_proxy=127.0.0.1,127.0.1.1,login.ubuntu.com,localhost,localdomain,novalocal,internal,archive.ubuntu.com,ports.ubuntu.com,security.ubuntu.com,ddebs.ubuntu.com,changelogs.ubuntu.com,launchpadlibrarian.net,launchpadcontent.net,launchpad.net,10.24.0.0/24,keystone.ps5.canonical.com,objectstorage.prodstack5.canonical.com'"'"'' --mirror=http://ftpmaster.internal/ubuntu/ 343s autopkgtest [11:09:49]: testbed dpkg architecture: ppc64el 343s autopkgtest [11:09:49]: testbed apt version: 2.7.12 343s autopkgtest [11:09:49]: @@@@@@@@@@@@@@@@@@@@ test bed setup 344s Get:1 http://ftpmaster.internal/ubuntu noble-proposed InRelease [117 kB] 344s Get:2 http://ftpmaster.internal/ubuntu noble-proposed/universe Sources [3760 kB] 345s Get:3 http://ftpmaster.internal/ubuntu noble-proposed/main Sources [496 kB] 345s Get:4 http://ftpmaster.internal/ubuntu noble-proposed/multiverse Sources [54.0 kB] 345s Get:5 http://ftpmaster.internal/ubuntu noble-proposed/restricted Sources [6540 B] 345s Get:6 http://ftpmaster.internal/ubuntu noble-proposed/main ppc64el Packages [671 kB] 346s Get:7 http://ftpmaster.internal/ubuntu noble-proposed/main ppc64el c-n-f Metadata [3116 B] 346s Get:8 http://ftpmaster.internal/ubuntu noble-proposed/restricted ppc64el Packages [1372 B] 346s Get:9 http://ftpmaster.internal/ubuntu noble-proposed/restricted ppc64el c-n-f Metadata [116 B] 346s Get:10 http://ftpmaster.internal/ubuntu noble-proposed/universe ppc64el Packages [4092 kB] 346s Get:11 http://ftpmaster.internal/ubuntu noble-proposed/universe ppc64el c-n-f Metadata [8652 B] 346s Get:12 http://ftpmaster.internal/ubuntu noble-proposed/multiverse ppc64el Packages [58.3 kB] 346s Get:13 http://ftpmaster.internal/ubuntu noble-proposed/multiverse ppc64el c-n-f Metadata [116 B] 350s Fetched 9269 kB in 4s (2644 kB/s) 350s Reading package lists... 353s Reading package lists... 353s Building dependency tree... 353s Reading state information... 353s Calculating upgrade... 353s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 353s Reading package lists... 354s Building dependency tree... 354s Reading state information... 354s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 355s sh: Attempting to set up Debian/Ubuntu apt sources automatically 355s sh: Distribution appears to be Ubuntu 355s Reading package lists... 356s Building dependency tree... 356s Reading state information... 356s eatmydata is already the newest version (131-1). 356s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 356s Reading package lists... 356s Building dependency tree... 356s Reading state information... 356s dbus is already the newest version (1.14.10-4ubuntu1). 356s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 356s Reading package lists... 356s Building dependency tree... 356s Reading state information... 357s rng-tools-debian is already the newest version (2.4). 357s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 357s Reading package lists... 357s Building dependency tree... 357s Reading state information... 357s The following packages will be REMOVED: 357s cloud-init* python3-configobj* python3-debconf* 357s 0 upgraded, 0 newly installed, 3 to remove and 0 not upgraded. 357s After this operation, 3256 kB disk space will be freed. 357s (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 ... 70156 files and directories currently installed.) 357s Removing cloud-init (24.1.2-0ubuntu1) ... 358s Removing python3-configobj (5.0.8-3) ... 358s Removing python3-debconf (1.5.86) ... 358s Processing triggers for man-db (2.12.0-3) ... 359s (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 ... 69767 files and directories currently installed.) 359s Purging configuration files for cloud-init (24.1.2-0ubuntu1) ... 360s dpkg: warning: while removing cloud-init, directory '/etc/cloud/cloud.cfg.d' not empty so not removed 360s Processing triggers for rsyslog (8.2312.0-3ubuntu3) ... 360s invoke-rc.d: policy-rc.d denied execution of try-restart. 360s Reading package lists... 360s Building dependency tree... 360s Reading state information... 361s linux-generic is already the newest version (6.8.0-11.11+1). 361s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 361s Hit:1 http://ftpmaster.internal/ubuntu noble InRelease 361s Hit:2 http://ftpmaster.internal/ubuntu noble-updates InRelease 361s Hit:3 http://ftpmaster.internal/ubuntu noble-security InRelease 364s Reading package lists... 364s Reading package lists... 365s Building dependency tree... 365s Reading state information... 365s Calculating upgrade... 365s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 365s Reading package lists... 365s Building dependency tree... 365s Reading state information... 365s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 366s autopkgtest [11:10:12]: rebooting testbed after setup commands that affected boot 533s autopkgtest [11:12:59]: testbed running kernel: Linux 6.8.0-11-generic #11-Ubuntu SMP Wed Feb 14 00:33:03 UTC 2024 537s autopkgtest [11:13:03]: @@@@@@@@@@@@@@@@@@@@ apt-source django-cas-server 540s Get:1 http://ftpmaster.internal/ubuntu noble/universe django-cas-server 2.0.0-2 (dsc) [2588 B] 540s Get:2 http://ftpmaster.internal/ubuntu noble/universe django-cas-server 2.0.0-2 (tar) [169 kB] 540s Get:3 http://ftpmaster.internal/ubuntu noble/universe django-cas-server 2.0.0-2 (diff) [6480 B] 540s gpgv: Signature made Sat Dec 3 08:42:02 2022 UTC 540s gpgv: using RSA key B70DFC6F134FECFC011E62AA83016014251D1DB0 540s gpgv: Can't check signature: No public key 540s dpkg-source: warning: cannot verify inline signature for ./django-cas-server_2.0.0-2.dsc: no acceptable signature found 541s autopkgtest [11:13:07]: testing package django-cas-server version 2.0.0-2 541s autopkgtest [11:13:07]: build not needed 542s autopkgtest [11:13:08]: test run-test-suite.sh: preparing testbed 543s Reading package lists... 543s Building dependency tree... 543s Reading state information... 544s Starting pkgProblemResolver with broken count: 0 544s Starting 2 pkgProblemResolver with broken count: 0 544s Done 544s The following additional packages will be installed: 544s fonts-font-awesome fonts-lato libjs-jquery libjs-sphinxdoc libjs-underscore 544s libxslt1.1 python3-all python3-asgiref python3-django 544s python3-django-cas-server python3-django-cas-server-doc python3-iniconfig 544s python3-lxml python3-mock python3-packaging python3-pluggy python3-pytest 544s python3-pytest-django python3-requests-futures python3-sqlparse 544s sphinx-rtd-theme-common 544s Suggested packages: 544s bpython3 geoip-database-contrib gettext ipython3 libgdal20 544s libsqlite3-mod-spatialite python-django-doc python3-bcrypt python3-flup 544s python3-memcache python3-mysqldb python3-pil python3-psycopg2 544s python3-selenium python3-sqlite python-lxml-doc python-mock-doc 544s python-sqlparse-doc 544s Recommended packages: 544s javascript-common python3-bs4 python3-cssselect python3-html5lib 544s The following NEW packages will be installed: 544s autopkgtest-satdep fonts-font-awesome fonts-lato libjs-jquery 544s libjs-sphinxdoc libjs-underscore libxslt1.1 python3-all python3-asgiref 544s python3-django python3-django-cas-server python3-django-cas-server-doc 544s python3-iniconfig python3-lxml python3-mock python3-packaging python3-pluggy 544s python3-pytest python3-pytest-django python3-requests-futures 544s python3-sqlparse sphinx-rtd-theme-common 544s 0 upgraded, 22 newly installed, 0 to remove and 0 not upgraded. 544s Need to get 12.2 MB/12.2 MB of archives. 544s After this operation, 57.1 MB of additional disk space will be used. 544s Get:1 /tmp/autopkgtest.qShEHf/1-autopkgtest-satdep.deb autopkgtest-satdep ppc64el 0 [748 B] 544s Get:2 http://ftpmaster.internal/ubuntu noble/main ppc64el fonts-lato all 2.015-1 [2781 kB] 545s Get:3 http://ftpmaster.internal/ubuntu noble/main ppc64el fonts-font-awesome all 5.0.10+really4.7.0~dfsg-4.1 [516 kB] 545s Get:4 http://ftpmaster.internal/ubuntu noble/main ppc64el libjs-jquery all 3.6.1+dfsg+~3.5.14-1 [328 kB] 545s Get:5 http://ftpmaster.internal/ubuntu noble/main ppc64el libjs-underscore all 1.13.4~dfsg+~1.11.4-3 [118 kB] 545s Get:6 http://ftpmaster.internal/ubuntu noble/main ppc64el libjs-sphinxdoc all 7.2.6-4 [149 kB] 545s Get:7 http://ftpmaster.internal/ubuntu noble/main ppc64el libxslt1.1 ppc64el 1.1.35-1 [185 kB] 545s Get:8 http://ftpmaster.internal/ubuntu noble/main ppc64el python3-all ppc64el 3.12.1-0ubuntu2 [904 B] 545s Get:9 http://ftpmaster.internal/ubuntu noble/main ppc64el python3-asgiref all 3.7.2-1 [24.8 kB] 545s Get:10 http://ftpmaster.internal/ubuntu noble/main ppc64el python3-sqlparse all 0.4.4-1 [31.5 kB] 545s Get:11 http://ftpmaster.internal/ubuntu noble/main ppc64el python3-django all 3:4.2.9-1 [4102 kB] 545s Get:12 http://ftpmaster.internal/ubuntu noble/main ppc64el python3-lxml ppc64el 5.1.0-1 [2191 kB] 546s Get:13 http://ftpmaster.internal/ubuntu noble/universe ppc64el python3-requests-futures all 1.0.1-1 [11.7 kB] 546s Get:14 http://ftpmaster.internal/ubuntu noble/universe ppc64el python3-django-cas-server all 2.0.0-2 [111 kB] 546s Get:15 http://ftpmaster.internal/ubuntu noble/main ppc64el sphinx-rtd-theme-common all 2.0.0+dfsg-1 [1012 kB] 546s Get:16 http://ftpmaster.internal/ubuntu noble/universe ppc64el python3-django-cas-server-doc all 2.0.0-2 [159 kB] 546s Get:17 http://ftpmaster.internal/ubuntu noble/universe ppc64el python3-iniconfig all 1.1.1-2 [6024 B] 546s Get:18 http://ftpmaster.internal/ubuntu noble/main ppc64el python3-packaging all 23.2-1 [40.6 kB] 546s Get:19 http://ftpmaster.internal/ubuntu noble/universe ppc64el python3-pluggy all 1.4.0-1 [20.4 kB] 546s Get:20 http://ftpmaster.internal/ubuntu noble/universe ppc64el python3-pytest all 7.4.4-1 [305 kB] 546s Get:21 http://ftpmaster.internal/ubuntu noble/universe ppc64el python3-pytest-django all 4.5.2-3 [18.5 kB] 546s Get:22 http://ftpmaster.internal/ubuntu noble/universe ppc64el python3-mock all 5.1.0-1 [64.1 kB] 546s Fetched 12.2 MB in 2s (6843 kB/s) 546s Selecting previously unselected package fonts-lato. 546s (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 ... 69712 files and directories currently installed.) 546s Preparing to unpack .../00-fonts-lato_2.015-1_all.deb ... 546s Unpacking fonts-lato (2.015-1) ... 547s Selecting previously unselected package fonts-font-awesome. 547s Preparing to unpack .../01-fonts-font-awesome_5.0.10+really4.7.0~dfsg-4.1_all.deb ... 547s Unpacking fonts-font-awesome (5.0.10+really4.7.0~dfsg-4.1) ... 547s Selecting previously unselected package libjs-jquery. 547s Preparing to unpack .../02-libjs-jquery_3.6.1+dfsg+~3.5.14-1_all.deb ... 547s Unpacking libjs-jquery (3.6.1+dfsg+~3.5.14-1) ... 547s Selecting previously unselected package libjs-underscore. 547s Preparing to unpack .../03-libjs-underscore_1.13.4~dfsg+~1.11.4-3_all.deb ... 547s Unpacking libjs-underscore (1.13.4~dfsg+~1.11.4-3) ... 547s Selecting previously unselected package libjs-sphinxdoc. 547s Preparing to unpack .../04-libjs-sphinxdoc_7.2.6-4_all.deb ... 547s Unpacking libjs-sphinxdoc (7.2.6-4) ... 547s Selecting previously unselected package libxslt1.1:ppc64el. 547s Preparing to unpack .../05-libxslt1.1_1.1.35-1_ppc64el.deb ... 547s Unpacking libxslt1.1:ppc64el (1.1.35-1) ... 547s Selecting previously unselected package python3-all. 547s Preparing to unpack .../06-python3-all_3.12.1-0ubuntu2_ppc64el.deb ... 547s Unpacking python3-all (3.12.1-0ubuntu2) ... 547s Selecting previously unselected package python3-asgiref. 547s Preparing to unpack .../07-python3-asgiref_3.7.2-1_all.deb ... 547s Unpacking python3-asgiref (3.7.2-1) ... 547s Selecting previously unselected package python3-sqlparse. 547s Preparing to unpack .../08-python3-sqlparse_0.4.4-1_all.deb ... 547s Unpacking python3-sqlparse (0.4.4-1) ... 547s Selecting previously unselected package python3-django. 547s Preparing to unpack .../09-python3-django_3%3a4.2.9-1_all.deb ... 547s Unpacking python3-django (3:4.2.9-1) ... 548s Selecting previously unselected package python3-lxml:ppc64el. 548s Preparing to unpack .../10-python3-lxml_5.1.0-1_ppc64el.deb ... 548s Unpacking python3-lxml:ppc64el (5.1.0-1) ... 548s Selecting previously unselected package python3-requests-futures. 548s Preparing to unpack .../11-python3-requests-futures_1.0.1-1_all.deb ... 548s Unpacking python3-requests-futures (1.0.1-1) ... 548s Selecting previously unselected package python3-django-cas-server. 548s Preparing to unpack .../12-python3-django-cas-server_2.0.0-2_all.deb ... 548s Unpacking python3-django-cas-server (2.0.0-2) ... 548s Selecting previously unselected package sphinx-rtd-theme-common. 548s Preparing to unpack .../13-sphinx-rtd-theme-common_2.0.0+dfsg-1_all.deb ... 548s Unpacking sphinx-rtd-theme-common (2.0.0+dfsg-1) ... 548s Selecting previously unselected package python3-django-cas-server-doc. 548s Preparing to unpack .../14-python3-django-cas-server-doc_2.0.0-2_all.deb ... 548s Unpacking python3-django-cas-server-doc (2.0.0-2) ... 548s Selecting previously unselected package python3-iniconfig. 548s Preparing to unpack .../15-python3-iniconfig_1.1.1-2_all.deb ... 548s Unpacking python3-iniconfig (1.1.1-2) ... 548s Selecting previously unselected package python3-packaging. 548s Preparing to unpack .../16-python3-packaging_23.2-1_all.deb ... 548s Unpacking python3-packaging (23.2-1) ... 548s Selecting previously unselected package python3-pluggy. 548s Preparing to unpack .../17-python3-pluggy_1.4.0-1_all.deb ... 548s Unpacking python3-pluggy (1.4.0-1) ... 548s Selecting previously unselected package python3-pytest. 548s Preparing to unpack .../18-python3-pytest_7.4.4-1_all.deb ... 548s Unpacking python3-pytest (7.4.4-1) ... 548s Selecting previously unselected package python3-pytest-django. 548s Preparing to unpack .../19-python3-pytest-django_4.5.2-3_all.deb ... 548s Unpacking python3-pytest-django (4.5.2-3) ... 548s Selecting previously unselected package python3-mock. 548s Preparing to unpack .../20-python3-mock_5.1.0-1_all.deb ... 548s Unpacking python3-mock (5.1.0-1) ... 548s Selecting previously unselected package autopkgtest-satdep. 548s Preparing to unpack .../21-1-autopkgtest-satdep.deb ... 548s Unpacking autopkgtest-satdep (0) ... 548s Setting up python3-iniconfig (1.1.1-2) ... 548s Setting up fonts-lato (2.015-1) ... 548s Setting up python3-all (3.12.1-0ubuntu2) ... 548s Setting up python3-mock (5.1.0-1) ... 549s Setting up python3-packaging (23.2-1) ... 549s Setting up python3-sqlparse (0.4.4-1) ... 549s Setting up python3-pluggy (1.4.0-1) ... 549s Setting up libxslt1.1:ppc64el (1.1.35-1) ... 549s Setting up python3-requests-futures (1.0.1-1) ... 549s Setting up libjs-jquery (3.6.1+dfsg+~3.5.14-1) ... 549s Setting up fonts-font-awesome (5.0.10+really4.7.0~dfsg-4.1) ... 549s Setting up sphinx-rtd-theme-common (2.0.0+dfsg-1) ... 549s Setting up python3-asgiref (3.7.2-1) ... 550s Setting up libjs-underscore (1.13.4~dfsg+~1.11.4-3) ... 550s Setting up python3-django (3:4.2.9-1) ... 551s Setting up python3-pytest (7.4.4-1) ... 551s Setting up python3-pytest-django (4.5.2-3) ... 552s Setting up libjs-sphinxdoc (7.2.6-4) ... 552s Setting up python3-lxml:ppc64el (5.1.0-1) ... 552s Setting up python3-django-cas-server (2.0.0-2) ... 552s Setting up python3-django-cas-server-doc (2.0.0-2) ... 552s Setting up autopkgtest-satdep (0) ... 552s Processing triggers for man-db (2.12.0-3) ... 553s Processing triggers for libc-bin (2.39-0ubuntu2) ... 556s (Reading database ... 76530 files and directories currently installed.) 556s Removing autopkgtest-satdep (0) ... 557s autopkgtest [11:13:23]: test run-test-suite.sh: [----------------------- 557s 557s *************************** 557s *** Testing with python3.12 557s *************************** 557s 557s Content of current working folder: 557s 557s total 20 557s drwxr-xr-x 3 ubuntu ubuntu 4096 Mar 22 11:13 . 557s drwxrwxrwt 5 root root 4096 Mar 22 11:13 .. 557s drwxrwxr-x 9 ubuntu ubuntu 4096 Oct 17 2022 cas_server 557s -rw-rw-r-- 1 ubuntu ubuntu 140 Oct 17 2022 pytest.ini 557s -rw-rw-r-- 1 ubuntu ubuntu 152 Oct 17 2022 setup.cfg 557s Running tests... 557s 558s ============================= test session starts ============================== 558s platform linux -- Python 3.12.2, pytest-7.4.4, pluggy-1.4.0 -- /usr/bin/python3.12 558s cachedir: .pytest_cache 558s django: settings: cas_server.tests.settings (from ini) 558s rootdir: /tmp/autopkgtest.qShEHf/autopkgtest_tmp 558s configfile: pytest.ini 558s testpaths: cas_server/tests/ 558s plugins: django-4.5.2 558s collecting ... collected 128 items 558s 558s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_auth_federate_errors Creating test database for alias 'default'... 559s 2024-03-22 11:13:25,867 WARNING Identity provider suffix exemple.fr not found 559s 2024-03-22 11:13:25,939 INFO Got an invalid ticket ST-glaFq2PI7xp2Y6hlkTUeyj0wfVq7KeTcpTpjsvK4z4iHtLu4l52hDrcsHOFTs from http://127.0.0.1:8080 for service http://testserver/federate/example.com. Retrying authentication 559s 2024-03-22 11:13:25,943 INFO Got an invalid ticket ST-GWjhrb99MfOwV58szMagmQyeyxKxw77t2nvZZUjFjsPLX7bR99CONHND24yTW from http://127.0.0.1:8080 for service http://testserver/federate/example.com. Retrying authentication 559s PASSED 559s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_auth_federate_false 2024-03-22 11:13:25,984 WARNING CAS_FEDERATE is False, set it to True to use federation 559s 2024-03-22 11:13:25,985 WARNING CAS_FEDERATE is False, set it to True to use federation 559s PASSED 559s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_auth_federate_slo 2024-03-22 11:13:26,005 INFO Trying to authenticate http://127.0.0.1:8080 again 559s 2024-03-22 11:13:26,011 INFO Got a valid ticket for dédé from http://127.0.0.1:8080 559s 2024-03-22 11:13:26,029 INFO User dédé@example.com successfully authenticated 559s 2024-03-22 11:13:26,044 INFO Service ticket created for service https://www.example.com by user dédé@example.com. 559s 2024-03-22 11:13:26,058 INFO Trying to authenticate http://127.0.0.1:8081 again 559s 2024-03-22 11:13:26,064 INFO Got a valid ticket for dédé from http://127.0.0.1:8081 559s 2024-03-22 11:13:26,078 INFO User dédé@example.org successfully authenticated 559s 2024-03-22 11:13:26,090 INFO Service ticket created for service https://www.example.com by user dédé@example.org. 559s 2024-03-22 11:13:26,107 INFO Trying to authenticate http://127.0.0.1:8082 again 559s 2024-03-22 11:13:26,116 INFO Got a valid ticket for dédé from http://127.0.0.1:8082 559s 2024-03-22 11:13:26,136 INFO User dédé@example.net successfully authenticated 559s 2024-03-22 11:13:26,150 INFO Service ticket created for service https://www.example.com by user dédé@example.net. 559s 2024-03-22 11:13:26,165 INFO Trying to authenticate http://127.0.0.1:8083 again 559s 2024-03-22 11:13:26,172 INFO Got a valid ticket for dédé from http://127.0.0.1:8083 559s 2024-03-22 11:13:26,184 INFO User dédé@example.test successfully authenticated 559s 2024-03-22 11:13:26,198 INFO Service ticket created for service https://www.example.com by user dédé@example.test. 559s 2024-03-22 11:13:25,640 INFO Got an SLO requests for ticket dédé@example.net, logging out user ST-9wPdc6bOUbMui4JfiMkDkm86BkWe74z9vKNHFvk1XcnjlqtRjEvkMqTXpsEAW 559s 2024-03-22 11:13:25,668 INFO Got an SLO requests for ticket dédé@example.test, logging out user ST-poSWbIR78bJIYG3efujSp1LxIJe8snxtWp5X4sDfTdOw6zqSyLqumwTJ83ECW 559s PASSED 559s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_default_settings PASSED 559s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_federate_logout 2024-03-22 11:13:25,709 INFO Trying to authenticate http://127.0.0.1:8080 again 559s 2024-03-22 11:13:25,714 INFO Got a valid ticket for dédé from http://127.0.0.1:8080 559s 2024-03-22 11:13:25,726 INFO User dédé@example.com successfully authenticated 559s 2024-03-22 11:13:25,737 INFO Service ticket created for service https://www.example.com by user dédé@example.com. 559s 2024-03-22 11:13:25,751 INFO Trying to authenticate http://127.0.0.1:8081 again 559s 2024-03-22 11:13:25,756 INFO Got a valid ticket for dédé from http://127.0.0.1:8081 559s 2024-03-22 11:13:25,768 INFO User dédé@example.org successfully authenticated 559s 2024-03-22 11:13:25,779 INFO Service ticket created for service https://www.example.com by user dédé@example.org. 559s 2024-03-22 11:13:25,792 INFO Trying to authenticate http://127.0.0.1:8082 again 559s 2024-03-22 11:13:25,797 INFO Got a valid ticket for dédé from http://127.0.0.1:8082 559s 2024-03-22 11:13:25,812 INFO User dédé@example.net successfully authenticated 559s 2024-03-22 11:13:25,823 INFO Service ticket created for service https://www.example.com by user dédé@example.net. 559s 2024-03-22 11:13:25,836 INFO Trying to authenticate http://127.0.0.1:8083 again 559s 2024-03-22 11:13:25,846 INFO Got a valid ticket for dédé from http://127.0.0.1:8083 559s 2024-03-22 11:13:25,858 INFO User dédé@example.test successfully authenticated 559s 2024-03-22 11:13:25,869 INFO Service ticket created for service https://www.example.com by user dédé@example.test. 559s 2024-03-22 11:13:25,871 INFO logout requested 559s 2024-03-22 11:13:25,873 INFO Logging out user dédé@example.com. 559s 2024-03-22 11:13:25,878 INFO User dédé@example.com logged out 559s 2024-03-22 11:13:25,889 INFO logout requested 559s 2024-03-22 11:13:25,893 INFO logout requested 559s 2024-03-22 11:13:25,895 INFO Logging out user dédé@example.org. 559s 2024-03-22 11:13:25,900 INFO User dédé@example.org logged out 559s 2024-03-22 11:13:25,911 INFO logout requested 559s 2024-03-22 11:13:25,914 INFO logout requested 559s 2024-03-22 11:13:25,917 INFO Logging out user dédé@example.net. 559s 2024-03-22 11:13:25,922 INFO User dédé@example.net logged out 559s 2024-03-22 11:13:25,933 INFO logout requested 559s 2024-03-22 11:13:25,936 INFO logout requested 559s 2024-03-22 11:13:25,938 INFO Logging out user dédé@example.test. 559s 2024-03-22 11:13:25,944 INFO User dédé@example.test logged out 559s 2024-03-22 11:13:25,956 INFO logout requested 560s 2024-03-22 11:13:25,972 INFO Trying to authenticate http://127.0.0.1:8080 again 560s 2024-03-22 11:13:25,977 INFO Got a valid ticket for dédé from http://127.0.0.1:8080 560s 2024-03-22 11:13:25,989 INFO User dédé@example.com successfully authenticated 560s 2024-03-22 11:13:26,000 INFO Service ticket created for service https://www.example.com by user dédé@example.com. 560s 2024-03-22 11:13:26,014 INFO Trying to authenticate http://127.0.0.1:8081 again 560s 2024-03-22 11:13:26,020 INFO Got a valid ticket for dédé from http://127.0.0.1:8081 560s 2024-03-22 11:13:26,032 INFO User dédé@example.org successfully authenticated 560s 2024-03-22 11:13:26,043 INFO Service ticket created for service https://www.example.com by user dédé@example.org. 560s 2024-03-22 11:13:26,057 INFO Trying to authenticate http://127.0.0.1:8082 again 560s 2024-03-22 11:13:26,063 INFO Got a valid ticket for dédé from http://127.0.0.1:8082 560s 2024-03-22 11:13:26,075 INFO User dédé@example.net successfully authenticated 560s 2024-03-22 11:13:26,086 INFO Service ticket created for service https://www.example.com by user dédé@example.net. 560s 2024-03-22 11:13:26,100 INFO Trying to authenticate http://127.0.0.1:8083 again 560s 2024-03-22 11:13:26,106 INFO Got a valid ticket for dédé from http://127.0.0.1:8083 560s 2024-03-22 11:13:26,118 INFO User dédé@example.test successfully authenticated 560s 2024-03-22 11:13:26,129 INFO Service ticket created for service https://www.example.com by user dédé@example.test. 560s 2024-03-22 11:13:26,132 INFO logout requested 560s 2024-03-22 11:13:26,133 INFO Logging out user dédé. 560s 2024-03-22 11:13:26,134 INFO User dédé logged out 560s 2024-03-22 11:13:26,147 INFO logout requested 560s 2024-03-22 11:13:26,148 INFO Logging out user dédé. 560s 2024-03-22 11:13:26,149 INFO User dédé logged out 560s 2024-03-22 11:13:26,161 INFO logout requested 560s 2024-03-22 11:13:26,162 INFO Logging out user dédé. 560s 2024-03-22 11:13:26,164 INFO User dédé logged out 560s 2024-03-22 11:13:26,176 INFO logout requested 560s 2024-03-22 11:13:26,177 INFO Logging out user dédé. 560s 2024-03-22 11:13:26,178 INFO User dédé logged out 560s PASSED 560s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_forget_provider 2024-03-22 11:13:26,208 INFO Trying to authenticate http://127.0.0.1:8080 again 560s 2024-03-22 11:13:26,212 INFO Got a valid ticket for dédé from http://127.0.0.1:8080 560s 2024-03-22 11:13:26,225 INFO User dédé@example.com successfully authenticated 560s 2024-03-22 11:13:26,237 INFO Service ticket created for service https://www.example.com by user dédé@example.com. 560s 2024-03-22 11:13:26,251 INFO Trying to authenticate http://127.0.0.1:8081 again 560s 2024-03-22 11:13:26,257 INFO Got a valid ticket for dédé from http://127.0.0.1:8081 560s 2024-03-22 11:13:26,270 INFO User dédé@example.org successfully authenticated 560s 2024-03-22 11:13:26,281 INFO Service ticket created for service https://www.example.com by user dédé@example.org. 560s 2024-03-22 11:13:26,295 INFO Trying to authenticate http://127.0.0.1:8082 again 560s 2024-03-22 11:13:26,300 INFO Got a valid ticket for dédé from http://127.0.0.1:8082 560s 2024-03-22 11:13:26,312 INFO User dédé@example.net successfully authenticated 560s 2024-03-22 11:13:26,324 INFO Service ticket created for service https://www.example.com by user dédé@example.net. 560s 2024-03-22 11:13:26,339 INFO Trying to authenticate http://127.0.0.1:8083 again 560s 2024-03-22 11:13:26,345 INFO Got a valid ticket for dédé from http://127.0.0.1:8083 560s 2024-03-22 11:13:26,357 INFO User dédé@example.test successfully authenticated 560s 2024-03-22 11:13:26,369 INFO Service ticket created for service https://www.example.com by user dédé@example.test. 560s 2024-03-22 11:13:26,370 INFO logout requested 560s 2024-03-22 11:13:26,372 INFO Logging out user dédé@example.com. 560s 2024-03-22 11:13:26,378 INFO User dédé@example.com logged out 560s 2024-03-22 11:13:26,379 INFO logout requested 560s 2024-03-22 11:13:26,382 INFO Logging out user dédé@example.org. 560s 2024-03-22 11:13:26,387 INFO User dédé@example.org logged out 560s 2024-03-22 11:13:26,388 INFO logout requested 560s 2024-03-22 11:13:26,390 INFO Logging out user dédé@example.net. 560s 2024-03-22 11:13:26,395 INFO User dédé@example.net logged out 560s 2024-03-22 11:13:26,396 INFO logout requested 560s 2024-03-22 11:13:26,399 INFO Logging out user dédé@example.test. 560s 2024-03-22 11:13:26,404 INFO User dédé@example.test logged out 560s PASSED 560s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_login_bad_ticket 2024-03-22 11:13:26,423 WARNING A login attempt failed 560s PASSED 560s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_login_get_provider PASSED 560s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_login_post_provider 2024-03-22 11:13:26,465 INFO Trying to authenticate http://127.0.0.1:8080 again 560s 2024-03-22 11:13:26,470 INFO Got a valid ticket for dédé from http://127.0.0.1:8080 560s 2024-03-22 11:13:26,483 INFO User dédé@example.com successfully authenticated 560s 2024-03-22 11:13:26,494 INFO Service ticket created for service https://www.example.com by user dédé@example.com. 560s 2024-03-22 11:13:26,508 INFO Trying to authenticate http://127.0.0.1:8081 again 560s 2024-03-22 11:13:26,513 INFO Got a valid ticket for dédé from http://127.0.0.1:8081 560s 2024-03-22 11:13:26,525 INFO User dédé@example.org successfully authenticated 560s 2024-03-22 11:13:26,536 INFO Service ticket created for service https://www.example.com by user dédé@example.org. 560s 2024-03-22 11:13:26,552 INFO Trying to authenticate http://127.0.0.1:8082 again 560s 2024-03-22 11:13:26,557 INFO Got a valid ticket for dédé from http://127.0.0.1:8082 560s 2024-03-22 11:13:26,570 INFO User dédé@example.net successfully authenticated 560s 2024-03-22 11:13:26,581 INFO Service ticket created for service https://www.example.com by user dédé@example.net. 560s 2024-03-22 11:13:26,594 INFO Trying to authenticate http://127.0.0.1:8083 again 560s 2024-03-22 11:13:26,599 INFO Got a valid ticket for dédé from http://127.0.0.1:8083 560s 2024-03-22 11:13:26,612 INFO User dédé@example.test successfully authenticated 560s 2024-03-22 11:13:26,623 INFO Service ticket created for service https://www.example.com by user dédé@example.test. 560s PASSED 560s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_login_twice 2024-03-22 11:13:26,644 INFO Trying to authenticate http://127.0.0.1:8080 again 560s 2024-03-22 11:13:26,649 INFO Got a valid ticket for dédé from http://127.0.0.1:8080 560s 2024-03-22 11:13:26,660 INFO User dédé@example.com successfully authenticated 560s 2024-03-22 11:13:26,671 INFO Service ticket created for service https://www.example.com by user dédé@example.com. 560s 2024-03-22 11:13:26,685 INFO Trying to authenticate http://127.0.0.1:8081 again 560s 2024-03-22 11:13:26,690 INFO Got a valid ticket for dédé from http://127.0.0.1:8081 561s 2024-03-22 11:13:26,702 INFO User dédé@example.org successfully authenticated 561s PASSED 561s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_remember_provider PASSED 561s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_renew PASSED 561s cas_server/tests/test_models.py::FederatedUserTestCase::test_clean_old_entries 2024-03-22 11:13:26,713 INFO Service ticket created for service https://www.example.com by user dédé@example.org. 561s 2024-03-22 11:13:26,726 INFO Trying to authenticate http://127.0.0.1:8082 again 561s 2024-03-22 11:13:26,733 INFO Got a valid ticket for dédé from http://127.0.0.1:8082 561s 2024-03-22 11:13:26,745 INFO User dédé@example.net successfully authenticated 561s 2024-03-22 11:13:26,756 INFO Service ticket created for service https://www.example.com by user dédé@example.net. 561s 2024-03-22 11:13:26,769 INFO Trying to authenticate http://127.0.0.1:8083 again 561s 2024-03-22 11:13:26,774 INFO Got a valid ticket for dédé from http://127.0.0.1:8083 561s 2024-03-22 11:13:26,786 INFO User dédé@example.test successfully authenticated 561s 2024-03-22 11:13:26,797 INFO Service ticket created for service https://www.example.com by user dédé@example.test. 561s 2024-03-22 11:13:26,811 INFO Trying to authenticate http://127.0.0.1:8080 again 561s 2024-03-22 11:13:26,816 INFO Got a valid ticket for dédé from http://127.0.0.1:8080 561s 2024-03-22 11:13:26,829 INFO User dédé@example.com successfully authenticated 561s 2024-03-22 11:13:26,841 INFO Service ticket created for service https://www.example.com by user dédé@example.com. 561s 2024-03-22 11:13:26,854 INFO Trying to authenticate http://127.0.0.1:8081 again 561s 2024-03-22 11:13:26,860 INFO Got a valid ticket for dédé from http://127.0.0.1:8081 561s 2024-03-22 11:13:26,872 INFO User dédé@example.org successfully authenticated 561s 2024-03-22 11:13:26,884 INFO Service ticket created for service https://www.example.com by user dédé@example.org. 561s 2024-03-22 11:13:26,899 INFO Trying to authenticate http://127.0.0.1:8082 again 561s 2024-03-22 11:13:26,904 INFO Got a valid ticket for dédé from http://127.0.0.1:8082 561s 2024-03-22 11:13:26,917 INFO User dédé@example.net successfully authenticated 561s 2024-03-22 11:13:26,930 INFO Service ticket created for service https://www.example.com by user dédé@example.net. 561s 2024-03-22 11:13:26,973 INFO Trying to authenticate http://127.0.0.1:8083 again 561s 2024-03-22 11:13:26,979 INFO Got a valid ticket for dédé from http://127.0.0.1:8083 561s 2024-03-22 11:13:26,991 INFO User dédé@example.test successfully authenticated 561s 2024-03-22 11:13:27,003 INFO Service ticket created for service https://www.example.com by user dédé@example.test. 561s 2024-03-22 11:13:27,005 WARNING User already authenticated, dropping federated authentication request 561s 2024-03-22 11:13:27,007 WARNING User already authenticated, dropping federated authentication request 561s 2024-03-22 11:13:27,008 WARNING User already authenticated, dropping federated authentication request 561s 2024-03-22 11:13:27,009 WARNING User already authenticated, dropping federated authentication request 561s 2024-03-22 11:13:27,030 INFO Trying to authenticate http://127.0.0.1:8080 again 561s 2024-03-22 11:13:27,035 INFO Got a valid ticket for dédé from http://127.0.0.1:8080 561s 2024-03-22 11:13:27,048 INFO User dédé@example.com successfully authenticated 561s 2024-03-22 11:13:27,060 INFO Service ticket created for service https://www.example.com by user dédé@example.com. 561s 2024-03-22 11:13:27,074 INFO Trying to authenticate http://127.0.0.1:8081 again 561s 2024-03-22 11:13:27,079 INFO Got a valid ticket for dédé from http://127.0.0.1:8081 561s 2024-03-22 11:13:27,092 INFO User dédé@example.org successfully authenticated 561s 2024-03-22 11:13:27,103 INFO Service ticket created for service https://www.example.com by user dédé@example.org. 561s 2024-03-22 11:13:27,118 INFO Trying to authenticate http://127.0.0.1:8082 again 561s 2024-03-22 11:13:27,123 INFO Got a valid ticket for dédé from http://127.0.0.1:8082 561s 2024-03-22 11:13:27,137 INFO User dédé@example.net successfully authenticated 561s 2024-03-22 11:13:27,149 INFO Service ticket created for service https://www.example.com by user dédé@example.net. 561s 2024-03-22 11:13:27,164 INFO Trying to authenticate http://127.0.0.1:8083 again 561s 2024-03-22 11:13:27,169 INFO Got a valid ticket for dédé from http://127.0.0.1:8083 561s 2024-03-22 11:13:27,182 INFO User dédé@example.test successfully authenticated 561s 2024-03-22 11:13:27,194 INFO Service ticket created for service https://www.example.com by user dédé@example.test. 561s 2024-03-22 11:13:27,195 INFO logout requested 561s 2024-03-22 11:13:27,198 INFO Logging out user dédé@example.com. 561s 2024-03-22 11:13:27,204 INFO User dédé@example.com logged out 561s 2024-03-22 11:13:27,208 INFO logout requested 561s 2024-03-22 11:13:27,210 INFO Logging out user dédé@example.org. 561s 2024-03-22 11:13:27,215 INFO User dédé@example.org logged out 561s 2024-03-22 11:13:27,219 INFO logout requested 561s 2024-03-22 11:13:27,221 INFO Logging out user dédé@example.net. 561s 2024-03-22 11:13:27,227 INFO User dédé@example.net logged out 561s 2024-03-22 11:13:27,231 INFO logout requested 561s 2024-03-22 11:13:27,233 INFO Logging out user dédé@example.test. 561s 2024-03-22 11:13:27,239 INFO User dédé@example.test logged out 561s 2024-03-22 11:13:27,261 INFO Trying to authenticate http://127.0.0.1:8080 again 561s 2024-03-22 11:13:27,266 INFO Got a valid ticket for dédé from http://127.0.0.1:8080 561s 2024-03-22 11:13:27,278 INFO User dédé@example.com successfully authenticated 561s 2024-03-22 11:13:27,289 INFO Service ticket created for service https://www.example.com by user dédé@example.com. 561s 2024-03-22 11:13:27,303 INFO Trying to authenticate http://127.0.0.1:8081 again 561s 2024-03-22 11:13:27,308 INFO Got a valid ticket for dédé from http://127.0.0.1:8081 561s 2024-03-22 11:13:27,320 INFO User dédé@example.org successfully authenticated 561s 2024-03-22 11:13:27,332 INFO Service ticket created for service https://www.example.com by user dédé@example.org. 561s 2024-03-22 11:13:27,346 INFO Trying to authenticate http://127.0.0.1:8082 again 561s 2024-03-22 11:13:27,352 INFO Got a valid ticket for dédé from http://127.0.0.1:8082 561s 2024-03-22 11:13:27,365 INFO User dédé@example.net successfully authenticated 561s 2024-03-22 11:13:27,377 INFO Service ticket created for service https://www.example.com by user dédé@example.net. 561s 2024-03-22 11:13:27,392 INFO Trying to authenticate http://127.0.0.1:8083 again 561s 2024-03-22 11:13:27,398 INFO Got a valid ticket for dédé from http://127.0.0.1:8083 561s 2024-03-22 11:13:27,411 INFO User dédé@example.test successfully authenticated 561s 2024-03-22 11:13:27,424 INFO Service ticket created for service https://www.example.com by user dédé@example.test. 561s 2024-03-22 11:13:27,432 INFO Trying to authenticate http://127.0.0.1:8080 again 561s 2024-03-22 11:13:27,437 INFO Got a valid ticket for dédé from http://127.0.0.1:8080 561s 2024-03-22 11:13:27,453 INFO User dédé@example.com successfully authenticated 561s 2024-03-22 11:13:27,460 INFO Service ticket created for service https://www.example.com by user dédé@example.com. 561s 2024-03-22 11:13:27,474 INFO Trying to authenticate http://127.0.0.1:8081 again 561s 2024-03-22 11:13:27,481 INFO Got a valid ticket for dédé from http://127.0.0.1:8081 561s 2024-03-22 11:13:27,495 INFO User dédé@example.org successfully authenticated 561s 2024-03-22 11:13:27,502 INFO Service ticket created for service https://www.example.com by user dédé@example.org. 561s 2024-03-22 11:13:27,509 INFO Trying to authenticate http://127.0.0.1:8082 again 561s 2024-03-22 11:13:27,515 INFO Got a valid ticket for dédé from http://127.0.0.1:8082 561s 2024-03-22 11:13:27,530 INFO User dédé@example.net successfully authenticated 561s 2024-03-22 11:13:27,537 INFO Service ticket created for service https://www.example.com by user dédé@example.net. 561s 2024-03-22 11:13:27,544 INFO Trying to authenticate http://127.0.0.1:8083 again 561s 2024-03-22 11:13:27,550 INFO Got a valid ticket for dédé from http://127.0.0.1:8083 561s 2024-03-22 11:13:27,565 INFO User dédé@example.test successfully authenticated 561s 2024-03-22 11:13:27,571 INFO Service ticket created for service https://www.example.com by user dédé@example.test. 561s PASSED 561s cas_server/tests/test_models.py::FederatedUserTestCase::test_json_attributes PASSED 561s cas_server/tests/test_models.py::FederateSLOTestCase::test_clean_deleted_sessions PASSED 561s cas_server/tests/test_models.py::UserAttributesTestCase::test_clean_old_entries 2024-03-22 11:13:27,635 INFO User test successfully authenticated 561s PASSED 561s cas_server/tests/test_models.py::UserTestCase::test_cached_attributs 2024-03-22 11:13:27,659 INFO User test successfully authenticated 561s PASSED 561s cas_server/tests/test_models.py::UserTestCase::test_clean_deleted_sessions 2024-03-22 11:13:27,678 INFO User test successfully authenticated 561s 2024-03-22 11:13:27,691 INFO User test successfully authenticated 561s 2024-03-22 11:13:27,705 INFO Sending SLO requests to service http://127.0.0.1:45678 for user test 561s 2024-03-22 11:13:27,710 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')) 561s PASSED 561s cas_server/tests/test_models.py::UserTestCase::test_clean_old_entries 2024-03-22 11:13:27,726 INFO User test successfully authenticated 561s PASSED 561s cas_server/tests/test_models.py::UserTestCase::test_clean_old_entries_tgt_expired 2024-03-22 11:13:27,748 INFO User test successfully authenticated 561s PASSED 561s cas_server/tests/test_models.py::TicketTestCase::test_clean_old_service_ticket 2024-03-22 11:13:27,775 INFO User test successfully authenticated 561s 2024-03-22 11:13:27,790 INFO Sending SLO requests to service http://127.0.0.1:34857 for user test 561s 2024-03-22 11:13:27,794 WARNING Error durring SLO ('Connection aborted.', RemoteDisconnected('Remote end closed connection without response')) 561s ConnectionError(ProtocolError('Connection aborted.', RemoteDisconnected('Remote end closed connection without response'))) 561s PASSED 561s cas_server/tests/test_models.py::TicketTestCase::test_json_attributes 2024-03-22 11:13:27,810 INFO User test successfully authenticated 561s PASSED 561s cas_server/tests/test_models.py::NewVersionWarningTestCase::test_send_mails PASSED 561s cas_server/tests/test_models.py::NewVersionWarningTestCase::test_send_mails_disabled PASSED 561s cas_server/tests/test_models.py::NewVersionWarningTestCase::test_send_mails_no_admins PASSED 561s cas_server/tests/test_models.py::NewVersionWarningTestCase::test_send_mails_same_version PASSED 561s cas_server/tests/test_templatetags.py::TemplateTagsTestCase::test_is_checkbox PASSED 561s cas_server/tests/test_templatetags.py::TemplateTagsTestCase::test_is_hidden PASSED 561s cas_server/tests/test_utils.py::CheckPasswordCase::test_bad_method PASSED 561s cas_server/tests/test_utils.py::CheckPasswordCase::test_crypt PASSED 561s cas_server/tests/test_utils.py::CheckPasswordCase::test_hex PASSED 561s cas_server/tests/test_utils.py::CheckPasswordCase::test_ldap_password_fail PASSED 561s cas_server/tests/test_utils.py::CheckPasswordCase::test_ldap_password_valid PASSED 561s cas_server/tests/test_utils.py::CheckPasswordCase::test_plain PASSED 561s cas_server/tests/test_utils.py::CheckPasswordCase::test_plain_unicode PASSED 561s cas_server/tests/test_utils.py::CheckPasswordCase::test_setup PASSED 561s cas_server/tests/test_utils.py::UtilsTestCase::test_crypt_salt_is_valid PASSED 561s cas_server/tests/test_utils.py::UtilsTestCase::test_dictfetchall PASSED 561s cas_server/tests/test_utils.py::UtilsTestCase::test_get_current_url PASSED 561s cas_server/tests/test_utils.py::UtilsTestCase::test_get_tuple PASSED 561s cas_server/tests/test_utils.py::UtilsTestCase::test_import_attr PASSED 562s cas_server/tests/test_utils.py::UtilsTestCase::test_last_version PASSED 562s cas_server/tests/test_utils.py::UtilsTestCase::test_regexpr_validator PASSED 562s cas_server/tests/test_utils.py::UtilsTestCase::test_update_url PASSED 563s cas_server/tests/test_view.py::LoginTestCase::test_ajax_get_ticket_fail 2024-03-22 11:13:28,984 INFO User test successfully authenticated 563s 2024-03-22 11:13:28,995 WARNING Service https://www.example.org not allowed. 563s PASSED 563s cas_server/tests/test_view.py::LoginTestCase::test_ajax_get_ticket_success 2024-03-22 11:13:29,015 INFO User test successfully authenticated 563s 2024-03-22 11:13:29,027 INFO Service ticket created for service https://www.example.com by user test. 563s PASSED 563s cas_server/tests/test_view.py::LoginTestCase::test_ajax_get_ticket_success_alt 2024-03-22 11:13:29,045 INFO User test successfully authenticated 563s 2024-03-22 11:13:29,056 INFO Service ticket created for service https://www.example.com by user test. 563s PASSED 563s cas_server/tests/test_view.py::LoginTestCase::test_ajax_get_ticket_warn 2024-03-22 11:13:29,076 INFO User test successfully authenticated 563s PASSED 563s cas_server/tests/test_view.py::LoginTestCase::test_ajax_logged 2024-03-22 11:13:29,103 INFO User test successfully authenticated 563s PASSED 563s cas_server/tests/test_view.py::LoginTestCase::test_ajax_logged_user_deleted 2024-03-22 11:13:29,130 INFO User test successfully authenticated 563s 2024-03-22 11:13:29,145 WARNING User test seems authenticated but is not found in the database. 563s 2024-03-22 11:13:29,145 INFO Logging out user test. 563s 2024-03-22 11:13:29,146 INFO User test logged out 563s PASSED 563s cas_server/tests/test_view.py::LoginTestCase::test_ajax_login_required PASSED 563s cas_server/tests/test_view.py::LoginTestCase::test_gateway 2024-03-22 11:13:29,178 INFO User test successfully authenticated 563s 2024-03-22 11:13:29,185 WARNING Username test not allowed on service restrict_user_fail 563s PASSED 563s cas_server/tests/test_view.py::LoginTestCase::test_login_post_missing_params 2024-03-22 11:13:29,207 WARNING A login attempt failed 563s 2024-03-22 11:13:29,233 WARNING A login attempt failed 563s 2024-03-22 11:13:29,252 WARNING A login attempt failed 563s PASSED 563s cas_server/tests/test_view.py::LoginTestCase::test_login_view_post_badlt 2024-03-22 11:13:29,277 WARNING Received an invalid login ticket 563s PASSED 563s cas_server/tests/test_view.py::LoginTestCase::test_login_view_post_badpass_good_lt 2024-03-22 11:13:29,300 WARNING A login attempt failed 563s PASSED 563s cas_server/tests/test_view.py::LoginTestCase::test_login_view_post_goodpass_goodlt 2024-03-22 11:13:29,326 INFO User test successfully authenticated 563s PASSED 563s cas_server/tests/test_view.py::LoginTestCase::test_login_view_post_goodpass_goodlt_warn 2024-03-22 11:13:29,349 INFO User test successfully authenticated 563s PASSED 564s cas_server/tests/test_view.py::LoginTestCase::test_lt_max PASSED 564s cas_server/tests/test_view.py::LoginTestCase::test_messages_info_box_bad_messages PASSED 564s cas_server/tests/test_view.py::LoginTestCase::test_messages_info_box_disabled PASSED 564s cas_server/tests/test_view.py::LoginTestCase::test_messages_info_box_enabled PASSED 564s cas_server/tests/test_view.py::LoginTestCase::test_new_version_available_badpypi PASSED 564s cas_server/tests/test_view.py::LoginTestCase::test_new_version_available_disabled PASSED 564s cas_server/tests/test_view.py::LoginTestCase::test_new_version_available_ok PASSED 564s cas_server/tests/test_view.py::LoginTestCase::test_renew 2024-03-22 11:13:30,665 INFO User test successfully authenticated 564s 2024-03-22 11:13:30,680 INFO User test successfully authenticated 564s 2024-03-22 11:13:30,685 INFO Service ticket created for service https://www.example.com by user test. 564s PASSED 564s cas_server/tests/test_view.py::LoginTestCase::test_renew_message_disabled 2024-03-22 11:13:30,702 INFO User test successfully authenticated 564s 2024-03-22 11:13:30,717 INFO User test successfully authenticated 564s 2024-03-22 11:13:30,721 INFO Service ticket created for service https://www.example.com by user test. 564s PASSED 564s cas_server/tests/test_view.py::LoginTestCase::test_service_filter 2024-03-22 11:13:30,739 INFO User test successfully authenticated 564s 2024-03-22 11:13:30,746 WARNING User constraint failed for test, service filter_fail: ^admin$ do not match right None. 564s 2024-03-22 11:13:30,751 WARNING User constraint failed for test, service filter_fail_alt: ^toto$ do not match nom Nymous. 564s 2024-03-22 11:13:30,758 INFO Service ticket created for service https://filter_success.example.com by user test. 564s PASSED 564s cas_server/tests/test_view.py::LoginTestCase::test_service_restrict_user 2024-03-22 11:13:30,774 INFO User test successfully authenticated 564s 2024-03-22 11:13:30,781 WARNING Username test not allowed on service restrict_user_fail 564s 2024-03-22 11:13:30,788 INFO Service ticket created for service https://restrict_user_success.example.com by user test. 564s PASSED 564s cas_server/tests/test_view.py::LoginTestCase::test_service_user_field 2024-03-22 11:13:30,804 INFO User test successfully authenticated 564s 2024-03-22 11:13:30,811 WARNING Cannot use uid a loggin for user test on service field_needed_fail because it is absent 564s 2024-03-22 11:13:30,818 INFO Service ticket created for service https://field_needed_success.example.com by user test. 564s PASSED 564s cas_server/tests/test_view.py::LoginTestCase::test_service_user_field_evaluate_to_false 2024-03-22 11:13:30,835 INFO User test successfully authenticated 564s 2024-03-22 11:13:30,841 WARNING Cannot use alias a loggin for user test on service field_needed_success because it is absent 564s PASSED 564s cas_server/tests/test_view.py::LoginTestCase::test_user_logged_not_in_db 2024-03-22 11:13:30,858 INFO User test successfully authenticated 564s 2024-03-22 11:13:30,866 WARNING User test seems authenticated but is not found in the database. 564s 2024-03-22 11:13:30,866 INFO Logging out user test. 564s 2024-03-22 11:13:30,868 INFO User test logged out 564s PASSED 564s cas_server/tests/test_view.py::LoginTestCase::test_view_login_get_allowed_service PASSED 564s cas_server/tests/test_view.py::LoginTestCase::test_view_login_get_allowed_service_no_message PASSED 564s cas_server/tests/test_view.py::LoginTestCase::test_view_login_get_auth_allowed_service 2024-03-22 11:13:30,911 INFO User test successfully authenticated 564s 2024-03-22 11:13:30,920 INFO Service ticket created for service https://www.example.com/é by user test. 564s PASSED 564s cas_server/tests/test_view.py::LoginTestCase::test_view_login_get_auth_allowed_service_non_ascii 2024-03-22 11:13:30,939 INFO User test successfully authenticated 564s 2024-03-22 11:13:30,947 INFO Service ticket created for service https://www.example.com by user test. 564s PASSED 564s cas_server/tests/test_view.py::LoginTestCase::test_view_login_get_auth_allowed_service_warn 2024-03-22 11:13:30,967 INFO User test successfully authenticated 565s 2024-03-22 11:13:30,981 WARNING Received a login attempt for an already-active user 565s 2024-03-22 11:13:30,985 INFO Service ticket created for service https://www.example.com by user test. 565s PASSED 565s cas_server/tests/test_view.py::LoginTestCase::test_view_login_get_auth_denied_service 2024-03-22 11:13:31,004 INFO User test successfully authenticated 565s 2024-03-22 11:13:31,010 WARNING Service https://www.example.org not allowed. 565s PASSED 565s cas_server/tests/test_view.py::LoginTestCase::test_view_login_get_denied_service 2024-03-22 11:13:31,019 WARNING Service https://www.example.net not allowed. 565s PASSED 565s cas_server/tests/test_view.py::LoginTestCase::test_view_login_get_denied_service_no_message 2024-03-22 11:13:31,033 WARNING Service https://www.example.net not allowed. 565s PASSED 565s cas_server/tests/test_view.py::LogoutTestCase::test_ajax_logout 2024-03-22 11:13:31,054 INFO User test successfully authenticated 565s 2024-03-22 11:13:31,058 INFO logout requested 565s 2024-03-22 11:13:31,059 INFO Logging out user test. 565s 2024-03-22 11:13:31,065 INFO User test logged out 565s PASSED 565s cas_server/tests/test_view.py::LogoutTestCase::test_ajax_logout_all_session 2024-03-22 11:13:31,078 INFO User test successfully authenticated 565s 2024-03-22 11:13:31,092 INFO User test successfully authenticated 565s 2024-03-22 11:13:31,105 INFO User test successfully authenticated 565s 2024-03-22 11:13:31,118 INFO User test successfully authenticated 565s 2024-03-22 11:13:31,132 INFO User test successfully authenticated 565s 2024-03-22 11:13:31,147 INFO User test successfully authenticated 565s 2024-03-22 11:13:31,151 INFO logout requested 565s 2024-03-22 11:13:31,152 INFO Logging out user test from all sessions. 565s 2024-03-22 11:13:31,179 INFO User test logged out 565s PASSED 565s cas_server/tests/test_view.py::LogoutTestCase::test_ajax_redirect_after_logout 2024-03-22 11:13:31,192 INFO User test successfully authenticated 565s 2024-03-22 11:13:31,197 INFO logout requested 565s 2024-03-22 11:13:31,198 INFO Logging out user test. 565s 2024-03-22 11:13:31,203 INFO User test logged out 565s PASSED 565s cas_server/tests/test_view.py::LogoutTestCase::test_logout 2024-03-22 11:13:31,207 INFO logout requested 565s PASSED 565s cas_server/tests/test_view.py::LogoutTestCase::test_logout_from_all_session 2024-03-22 11:13:31,222 INFO User test successfully authenticated 565s 2024-03-22 11:13:31,236 INFO User test successfully authenticated 565s 2024-03-22 11:13:31,241 INFO logout requested 565s 2024-03-22 11:13:31,242 INFO Logging out user test from all sessions. 565s 2024-03-22 11:13:31,252 INFO User test logged out 565s PASSED 565s cas_server/tests/test_view.py::LogoutTestCase::test_logout_slo 2024-03-22 11:13:31,269 INFO User test successfully authenticated 565s 2024-03-22 11:13:31,278 INFO Service ticket created for service http://127.0.0.1:39621 by user test. 565s 2024-03-22 11:13:31,283 INFO Validate: Service ticket ST-Rr4SkiUJYJUikJgEUZZcFwa3GvPINayYYQ2wxYZubkJEWLyJfiJW2MnNKTbxB validated, user test authenticated on service http://127.0.0.1:39621 565s 2024-03-22 11:13:31,284 INFO logout requested 565s 2024-03-22 11:13:31,285 INFO Logging out user test. 565s 2024-03-22 11:13:31,289 INFO Sending SLO requests to service http://127.0.0.1:39621 for user test 565s 2024-03-22 11:13:31,292 WARNING Error during SLO for user test: ('Connection aborted.', RemoteDisconnected('Remote end closed connection without response')) 565s 2024-03-22 11:13:31,294 INFO User test logged out 565s 2024-03-22 11:13:31,306 INFO User test successfully authenticated 565s 2024-03-22 11:13:31,315 INFO Service ticket created for service http://127.0.0.1:45678 by user test. 565s 2024-03-22 11:13:31,320 INFO Validate: Service ticket ST-CkOnU6wnBYgWt4BqXwHpx1u1J73RKgoxxlXdThvIBVoBGqCZghH8wtajeecUX validated, user test authenticated on service http://127.0.0.1:45678 565s 2024-03-22 11:13:31,322 INFO logout requested 565s 2024-03-22 11:13:31,322 INFO Logging out user test. 565s 2024-03-22 11:13:31,326 INFO Sending SLO requests to service http://127.0.0.1:45678 for user test 565s 2024-03-22 11:13:31,329 WARNING Error during SLO for user test: ('Connection aborted.', RemoteDisconnected('Remote end closed connection without response')) 565s 2024-03-22 11:13:31,331 INFO User test logged out 565s 2024-03-22 11:13:31,343 INFO User test successfully authenticated 565s 2024-03-22 11:13:31,351 INFO Service ticket created for service http://127.0.0.1:45678 by user test. 565s 2024-03-22 11:13:31,356 INFO Validate: Service ticket ST-AggZS9MQCUFDYaDEQaKPUyra2ICHinuv3W6NCQMn9AEhTNPdRrUlGqYfEe7e2 validated, user test authenticated on service http://127.0.0.1:45678 565s 2024-03-22 11:13:31,358 INFO logout requested 565s 2024-03-22 11:13:31,359 INFO Logging out user test. 565s 2024-03-22 11:13:31,362 INFO Sending SLO requests to service http://127.0.0.1:45678 for user test 565s 2024-03-22 11:13:31,365 WARNING Error during SLO for user test: HTTPConnectionPool(host='127.0.0.1', port=38667): Max retries exceeded with url: / (Caused by NewConnectionError(': Failed to establish a new connection: [Errno 111] Connection refused')) 565s 2024-03-22 11:13:31,367 INFO User test logged out 565s PASSED 565s cas_server/tests/test_view.py::LogoutTestCase::test_logout_view 2024-03-22 11:13:31,384 INFO User test successfully authenticated 565s 2024-03-22 11:13:31,398 INFO User test successfully authenticated 565s 2024-03-22 11:13:31,407 INFO logout requested 565s 2024-03-22 11:13:31,408 INFO Logging out user test. 565s 2024-03-22 11:13:31,414 INFO User test logged out 565s PASSED 565s cas_server/tests/test_view.py::LogoutTestCase::test_logout_view_service 2024-03-22 11:13:31,439 INFO User test successfully authenticated 565s 2024-03-22 11:13:31,443 INFO logout requested 565s 2024-03-22 11:13:31,444 INFO Logging out user test. 565s 2024-03-22 11:13:31,449 INFO User test logged out 565s PASSED 565s cas_server/tests/test_view.py::LogoutTestCase::test_logout_view_url 2024-03-22 11:13:31,470 INFO User test successfully authenticated 565s 2024-03-22 11:13:31,475 INFO logout requested 565s 2024-03-22 11:13:31,476 INFO Logging out user test. 565s 2024-03-22 11:13:31,481 INFO User test logged out 565s PASSED 565s cas_server/tests/test_view.py::LogoutTestCase::test_redirect_after_logout 2024-03-22 11:13:31,503 INFO User test successfully authenticated 565s 2024-03-22 11:13:31,508 INFO logout requested 565s 2024-03-22 11:13:31,509 INFO Logging out user test. 565s 2024-03-22 11:13:31,514 INFO User test logged out 565s PASSED 565s cas_server/tests/test_view.py::LogoutTestCase::test_redirect_after_logout_to_service 2024-03-22 11:13:31,529 INFO User test successfully authenticated 565s 2024-03-22 11:13:31,534 INFO logout requested 565s 2024-03-22 11:13:31,534 INFO Logging out user test. 565s 2024-03-22 11:13:31,540 INFO User test logged out 565s 2024-03-22 11:13:31,548 INFO logout requested 565s PASSED 565s cas_server/tests/test_view.py::AuthTestCase::test_auth_view_badpass PASSED 565s cas_server/tests/test_view.py::AuthTestCase::test_auth_view_badsecret PASSED 565s cas_server/tests/test_view.py::AuthTestCase::test_auth_view_badservice 2024-03-22 11:13:31,573 WARNING Service https://www.example.org not allowed. 565s PASSED 565s cas_server/tests/test_view.py::AuthTestCase::test_auth_view_badsettings PASSED 565s cas_server/tests/test_view.py::AuthTestCase::test_auth_view_goodpass PASSED 565s cas_server/tests/test_view.py::AuthTestCase::test_auth_view_goodpass_logged 2024-03-22 11:13:31,598 INFO User test successfully authenticated 565s PASSED 565s cas_server/tests/test_view.py::AuthTestCase::test_auth_view_missing_parameter PASSED 565s cas_server/tests/test_view.py::ValidateTestCase::test_validate_missing_parameter 2024-03-22 11:13:31,627 INFO User test successfully authenticated 565s 2024-03-22 11:13:31,636 INFO Service ticket created for service https://www.example.com by user test. 565s 2024-03-22 11:13:31,639 WARNING Validate: service or ticket missing 565s 2024-03-22 11:13:31,640 WARNING Validate: service or ticket missing 565s PASSED 565s cas_server/tests/test_view.py::ValidateTestCase::test_validate_service_renew 2024-03-22 11:13:31,654 INFO User test successfully authenticated 565s 2024-03-22 11:13:31,659 INFO Service ticket created for service https://www.example.com by user test. 565s 2024-03-22 11:13:31,664 INFO Validate: Service ticket ST-mnETdV7aoJOP1vTX85GcsCJpl9bAK0DXU0eo92a1eEyMLnTZ6kVFwxjvxdQaG validated, user test authenticated on service https://www.example.com 565s 2024-03-22 11:13:31,675 INFO User test successfully authenticated 565s 2024-03-22 11:13:31,680 INFO Service ticket created for service https://www.example.com by user test. 565s 2024-03-22 11:13:31,684 INFO Validate: Service ticket ST-Cru8UzVFNTuSLlWev1ZvhBBiMp8xKJWsWEQmHCVnUpd6IxEEbWu45BdS661Oa validated, user test authenticated on service https://www.example.com 565s 2024-03-22 11:13:31,690 INFO Service ticket created for service https://www.example.com by user test. 565s 2024-03-22 11:13:31,693 WARNING Validate: Service ticket ST-PVMbo4wkBo9miQZ4ngddL0diOqOkgZTrnaV2sI6zWMCXDn3B2SLTIHnj164SG not found or already validated, auth to https://www.example.com failed 565s PASSED 565s cas_server/tests/test_view.py::ValidateTestCase::test_validate_user_field_ok 2024-03-22 11:13:31,706 INFO User test successfully authenticated 565s 2024-03-22 11:13:31,715 INFO Service ticket created for service https://user_field.example.com by user test. 565s 2024-03-22 11:13:31,720 INFO Validate: Service ticket ST-BNl8Jpp22VYxX9PkkY8lJhsgSXMsl4p6rxD41FpFH4RrRsZIzput1488FQhQj validated, user test authenticated on service https://user_field.example.com 565s 2024-03-22 11:13:31,730 INFO User test successfully authenticated 565s 2024-03-22 11:13:31,740 INFO Service ticket created for service https://user_field_alt.example.com by user test. 565s 2024-03-22 11:13:31,745 INFO Validate: Service ticket ST-kpk6joAvscVcg51ug6RUQjPj5Ey1T2mhoJqJUzONvs6w4BA2gFVcP6T4wVNh0 validated, user test authenticated on service https://user_field_alt.example.com 565s PASSED 565s cas_server/tests/test_view.py::ValidateTestCase::test_validate_view_badservice 2024-03-22 11:13:31,759 INFO User test successfully authenticated 565s 2024-03-22 11:13:31,768 INFO Service ticket created for service https://www.example.com by user test. 565s 2024-03-22 11:13:31,772 WARNING Validate: Service ticket ST-YUd46WHoEEbi3XWiWqDVj6JhHLTtfRy7OC1p14fD7xPe61qX8sgDP8KxXgSXM not found or already validated, auth to https://www.example.org failed 565s PASSED 565s cas_server/tests/test_view.py::ValidateTestCase::test_validate_view_badticket 2024-03-22 11:13:31,786 INFO User test successfully authenticated 565s 2024-03-22 11:13:31,795 INFO Service ticket created for service https://www.example.com by user test. 565s 2024-03-22 11:13:31,798 WARNING Validate: Service ticket ST-RANDOM not found or already validated, auth to https://www.example.com failed 565s PASSED 565s cas_server/tests/test_view.py::ValidateTestCase::test_validate_view_ok 2024-03-22 11:13:31,840 INFO User test successfully authenticated 565s 2024-03-22 11:13:31,848 INFO Service ticket created for service https://www.example.com by user test. 565s 2024-03-22 11:13:31,852 INFO Validate: Service ticket ST-SCe7G6wDIOiMgCIzYNvzp6GLcg10GuhTKGd2kJ0azKS5vB7S8n2NFgQaKPRwN validated, user test authenticated on service https://www.example.com 565s PASSED 565s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_missing_parameter 2024-03-22 11:13:31,868 INFO User test successfully authenticated 565s 2024-03-22 11:13:31,876 INFO Service ticket created for service http://127.0.0.1:45678 by user test. 565s 2024-03-22 11:13:31,878 WARNING ValidateService: missing ticket or service 565s 2024-03-22 11:13:31,880 WARNING ValidateService: missing ticket or service 565s PASSED 565s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_proxy 2024-03-22 11:13:31,895 INFO User test successfully authenticated 565s 2024-03-22 11:13:31,903 INFO Service ticket created for service http://127.0.0.1:42505 by user test. 565s 2024-03-22 11:13:31,910 INFO ValidateService: ticket ST-sEvN86xcLmVyyWk8ACBst7og5ZvhU0xSeiZCdpSrAdm6tCwLWgH0zw4RqllpH validated for user test on service http://127.0.0.1:42505. Proxy Granting Ticket transmited to http://127.0.0.1:42505. 565s 2024-03-22 11:13:31,917 INFO Proxy ticket created for user test on service http://127.0.0.1:45678. 565s 2024-03-22 11:13:31,921 INFO ValidateService: ticket PT-mPR0WzR65ez8xJb9Szti6Taa2PDA6CEYZ2oN1xFWRT3UNNAsYmRv2OM0Zy5nY validated for user test on service http://127.0.0.1:45678. 565s 2024-03-22 11:13:31,932 INFO User test successfully authenticated 565s 2024-03-22 11:13:31,940 INFO Service ticket created for service http://127.0.0.1:44887 by user test. 565s 2024-03-22 11:13:31,948 INFO ValidateService: ticket ST-nEHyRpZGSoqlMQ1317YIwBFPReyepGVeeQrrtASHeG8vKia3ZnvAP3wm78VSp validated for user test on service http://127.0.0.1:44887. Proxy Granting Ticket transmited to http://127.0.0.1:44887. 565s 2024-03-22 11:13:31,953 INFO Proxy ticket created for user test on service http://127.0.0.1:45678. 565s 2024-03-22 11:13:31,955 WARNING ValidateService: validation error: INVALID_TICKET PT-VxwckfQdd3hShFaJsnePvP5XjUteqkpdZDiF7jBtPCpwNhajoIm6eOEz0qg4l 565s PASSED 566s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_replace_attributes 2024-03-22 11:13:31,969 INFO User test successfully authenticated 566s 2024-03-22 11:13:31,978 INFO Service ticket created for service https://replace_attribute.example.com by user test. 566s 2024-03-22 11:13:31,983 INFO ValidateService: ticket ST-aRB8XDcC7pIiWYLWKLsnFIydnCxBVsKcgGj6kbFNBGIWHcGt0kpLlOkV2PIKm validated for user test on service https://replace_attribute.example.com. 566s 2024-03-22 11:13:31,992 INFO User test successfully authenticated 566s 2024-03-22 11:13:32,000 INFO Service ticket created for service https://replace_attribute_list.example.com by user test. 566s 2024-03-22 11:13:32,005 INFO ValidateService: ticket ST-tWlHvkt5TNVx7JyE9jVxUpY3UPJOMWVOcLRwyo2Ooc9fFbT7SrcKdM7rBFe2x validated for user test on service https://replace_attribute_list.example.com. 566s PASSED 566s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_service_pgturl_404 2024-03-22 11:13:32,020 INFO User test successfully authenticated 566s 2024-03-22 11:13:32,028 INFO Service ticket created for service http://127.0.0.1:38309 by user test. 566s 2024-03-22 11:13:32,036 INFO ValidateService: ticket ST-4moluk8LH6451URfCp2GgJGu4OncD2R7FxqY0H1lfDYQKQf7lgW5mxlqSNH75 validated for user test on service http://127.0.0.1:38309. Proxy Granting Ticket transmited to http://127.0.0.1:38309. 566s PASSED 566s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_service_pgturl_bad_proxy_callback 2024-03-22 11:13:32,051 INFO User test successfully authenticated 566s 2024-03-22 11:13:32,059 INFO Service ticket created for service http://127.0.0.1:45678 by user test. 566s 2024-03-22 11:13:32,064 WARNING ValidateService: validation error: INVALID_PROXY_CALLBACK callback url not allowed by configuration 566s 2024-03-22 11:13:32,073 INFO User test successfully authenticated 566s 2024-03-22 11:13:32,081 INFO Service ticket created for service http://127.0.0.1:45678 by user test. 566s 2024-03-22 11:13:32,086 WARNING Service https://www.example.org not allowed. 566s 2024-03-22 11:13:32,086 WARNING ValidateService: validation error: INVALID_PROXY_CALLBACK callback url not allowed by configuration 566s PASSED 566s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_service_pgturl_sslerror 2024-03-22 11:13:32,100 INFO User test successfully authenticated 566s 2024-03-22 11:13:32,108 INFO Service ticket created for service https://127.0.0.1:37637 by user test. 566s 2024-03-22 11:13:32,172 WARNING ValidateService: validation error: INVALID_PROXY_CALLBACK : HTTPSConnectionPool(host='127.0.0.1', port=37637): Max retries exceeded with url: /?pgtId=PGT-pwJDgF86F5lpIa96f8XrXoANTzx4Cjkibf6iHS3AbKeNEZ2kYctcIrdVdRen&pgtIou=PGTIOU-BRFHqMW4dZSQ3maK8A6Zx1s3SIPNUMhrPXLMQLhYYte65jxe8T7cFcPM9 (Caused by SSLError(SSLError(1, '[SSL: WRONG_VERSION_NUMBER] wrong version number (_ssl.c:1000)'))) 566s PASSED 566s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_service_renew PASSED 566s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_service_view_badservice PASSED 566s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_service_view_badticket_badprefix PASSED 566s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_service_view_badticket_goodprefix PASSED 566s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_service_view_ok 2024-03-22 11:13:32,188 INFO User test successfully authenticated 566s 2024-03-22 11:13:32,195 INFO Service ticket created for service http://127.0.0.1:45678 by user test. 566s 2024-03-22 11:13:32,199 INFO ValidateService: ticket ST-ZxjOIXVhz3ThHtbXYlsNSKumL0hkWFFfdC3pKT7OBlP7ViUYgWmOoXv0afzPc validated for user test on service http://127.0.0.1:45678. 566s 2024-03-22 11:13:32,209 INFO User test successfully authenticated 566s 2024-03-22 11:13:32,214 INFO Service ticket created for service http://127.0.0.1:45678 by user test. 566s 2024-03-22 11:13:32,218 INFO ValidateService: ticket ST-fyXf7GUyyLISCBKfcw93YHaZbhIK0irNR7PRrTgApEunZZlEIw3g6j6uMMrSW validated for user test on service http://127.0.0.1:45678. 566s 2024-03-22 11:13:32,223 INFO Service ticket created for service http://127.0.0.1:45678 by user test. 566s 2024-03-22 11:13:32,225 WARNING ValidateService: validation error: INVALID_TICKET ticket not found 566s 2024-03-22 11:13:32,239 INFO User test successfully authenticated 566s 2024-03-22 11:13:32,247 INFO Service ticket created for service http://127.0.0.1:45678 by user test. 566s 2024-03-22 11:13:32,251 WARNING ValidateService: validation error: INVALID_SERVICE https://www.example.org 566s 2024-03-22 11:13:32,267 INFO User test successfully authenticated 566s 2024-03-22 11:13:32,276 INFO Service ticket created for service http://127.0.0.1:45678 by user test. 566s 2024-03-22 11:13:32,279 WARNING ValidateService: validation error: INVALID_TICKET RANDOM 566s 2024-03-22 11:13:32,293 INFO User test successfully authenticated 566s 2024-03-22 11:13:32,301 INFO Service ticket created for service http://127.0.0.1:45678 by user test. 566s 2024-03-22 11:13:32,304 WARNING ValidateService: validation error: INVALID_TICKET ticket not found 566s 2024-03-22 11:13:32,318 INFO User test successfully authenticated 566s 2024-03-22 11:13:32,327 INFO Service ticket created for service http://127.0.0.1:45678 by user test. 566s 2024-03-22 11:13:32,331 INFO ValidateService: ticket ST-wb0iTPnrXfW1bP2qwk2BXkaUBMnfJ2xnVHVE4WKJbvQV3i0OrpQKOiliQ3t4i validated for user test on service http://127.0.0.1:45678. 566s PASSED 566s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_service_view_ok_one_attribute 2024-03-22 11:13:32,346 INFO User test successfully authenticated 566s 2024-03-22 11:13:32,354 INFO Service ticket created for service https://one_attribute.example.com by user test. 566s 2024-03-22 11:13:32,359 INFO ValidateService: ticket ST-YrDIE02O9kQ9NPvMc8ZNhAYfU05EAzV3QaqmyzcrvEA1lMomltK0ieVnrgvtP validated for user test on service https://one_attribute.example.com. 566s PASSED 566s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_service_view_ok_pgturl 2024-03-22 11:13:32,373 INFO User test successfully authenticated 566s 2024-03-22 11:13:32,382 INFO Service ticket created for service http://127.0.0.1:33491 by user test. 566s 2024-03-22 11:13:32,389 INFO ValidateService: ticket ST-mo8wHGS0j7FVuHHWegV5GSwoRWOipWj5Kf8rPDZQKm8bJfobg3APCMYUeBuvk validated for user test on service http://127.0.0.1:33491. Proxy Granting Ticket transmited to http://127.0.0.1:33491. 566s PASSED 566s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_user_field_ok 2024-03-22 11:13:32,403 INFO User test successfully authenticated 566s 2024-03-22 11:13:32,411 INFO Service ticket created for service https://user_field.example.com by user test. 566s 2024-03-22 11:13:32,416 INFO ValidateService: ticket ST-Y2kKXuooJ8HVkUwWOaivJANtmw1MyiXzal53ghlgntUcF9qin5z67NpKnWq7K validated for user test on service https://user_field.example.com. 566s 2024-03-22 11:13:32,425 INFO User test successfully authenticated 566s 2024-03-22 11:13:32,434 INFO Service ticket created for service https://user_field_alt.example.com by user test. 566s 2024-03-22 11:13:32,438 INFO ValidateService: ticket ST-c7SABwlhA8bz63aSGVfisuA57ZWfcRbZeMj91jeYKIFGhhDrd7oJodT5y5r9C validated for user test on service https://user_field_alt.example.com. 566s PASSED 566s cas_server/tests/test_view.py::ProxyTestCase::test_proxy_missing_parameter 2024-03-22 11:13:32,457 INFO User test successfully authenticated 566s 2024-03-22 11:13:32,466 INFO Service ticket created for service http://127.0.0.1:40145 by user test. 566s 2024-03-22 11:13:32,474 INFO ValidateService: ticket ST-NISyZmhD1cVzT5VIhG2PFPyPvnsO47lzaQMhXpKbCELDGDfMfWD1GHXlgLbdH validated for user test on service http://127.0.0.1:40145. Proxy Granting Ticket transmited to http://127.0.0.1:40145. 566s 2024-03-22 11:13:32,476 WARNING Proxy: validation error: INVALID_REQUEST you must specify and pgt and targetService 566s 2024-03-22 11:13:32,478 WARNING Proxy: validation error: INVALID_REQUEST you must specify and pgt and targetService 566s PASSED 566s cas_server/tests/test_view.py::ProxyTestCase::test_proxy_unauthorized_user 2024-03-22 11:13:32,495 INFO User test successfully authenticated 566s 2024-03-22 11:13:32,503 INFO Service ticket created for service http://127.0.0.1:37151 by user test. 566s 2024-03-22 11:13:32,510 INFO ValidateService: ticket ST-XaXKmrKXnWc5VSN9neR077rymuV0Yn0gqJQ9WRvfVGnQow6BVI3ViPaTGMFxa validated for user test on service http://127.0.0.1:37151. Proxy Granting Ticket transmited to http://127.0.0.1:37151. 566s 2024-03-22 11:13:32,514 WARNING Username test not allowed on service restrict_user_fail 566s 2024-03-22 11:13:32,514 WARNING Proxy: validation error: UNAUTHORIZED_USER User test not allowed on https://restrict_user_fail.example.com 566s 2024-03-22 11:13:32,518 WARNING User constraint failed for test, service filter_fail: ^admin$ do not match right None. 566s 2024-03-22 11:13:32,518 WARNING Proxy: validation error: UNAUTHORIZED_USER User test not allowed on https://filter_fail.example.com 566s 2024-03-22 11:13:32,521 WARNING Cannot use uid a loggin for user test on service field_needed_fail because it is absent 566s 2024-03-22 11:13:32,521 WARNING Proxy: validation error: UNAUTHORIZED_USER User test not allowed on https://field_needed_fail.example.com 566s PASSED 566s cas_server/tests/test_view.py::ProxyTestCase::test_validate_proxy_bad_pgt 2024-03-22 11:13:32,537 INFO User test successfully authenticated 566s 2024-03-22 11:13:32,546 INFO Service ticket created for service http://127.0.0.1:34323 by user test. 566s 2024-03-22 11:13:32,553 INFO ValidateService: ticket ST-VI9q4mWChxODrkzs02DodWU31QEuqRVtnWd3SeT2oMwgtUFqfZZURrcPUOPjb validated for user test on service http://127.0.0.1:34323. Proxy Granting Ticket transmited to http://127.0.0.1:34323. 566s 2024-03-22 11:13:32,556 WARNING Proxy: validation error: INVALID_TICKET PGT PGT-RANDOM not found 566s PASSED 566s cas_server/tests/test_view.py::ProxyTestCase::test_validate_proxy_bad_service 2024-03-22 11:13:32,572 INFO User test successfully authenticated 566s 2024-03-22 11:13:32,581 INFO Service ticket created for service http://127.0.0.1:38471 by user test. 566s 2024-03-22 11:13:32,588 INFO ValidateService: ticket ST-hHVXYmJ474RhemMgM3yxbpOglY8vGV6kDeO0CcXtraLxd8iMRSCw4w2hCuHtJ validated for user test on service http://127.0.0.1:38471. Proxy Granting Ticket transmited to http://127.0.0.1:38471. 566s 2024-03-22 11:13:32,590 WARNING Service https://www.example.org not allowed. 566s 2024-03-22 11:13:32,590 WARNING Proxy: validation error: UNAUTHORIZED_SERVICE https://www.example.org 566s 2024-03-22 11:13:32,593 WARNING Proxy: validation error: UNAUTHORIZED_SERVICE the service http://127.0.0.1:38471 does not allow proxy tickets 566s PASSED 566s cas_server/tests/test_view.py::ProxyTestCase::test_validate_proxy_ok 2024-03-22 11:13:32,609 INFO User test successfully authenticated 566s 2024-03-22 11:13:32,618 INFO Service ticket created for service http://127.0.0.1:39527 by user test. 566s 2024-03-22 11:13:32,625 INFO ValidateService: ticket ST-QmFPlmVsR8jHSRGMwetMKqCHhaGYhFn35n7eQfDnM1aZ3zAwMnqigrmgfrhJV validated for user test on service http://127.0.0.1:39527. Proxy Granting Ticket transmited to http://127.0.0.1:39527. 566s 2024-03-22 11:13:32,631 INFO Proxy ticket created for user test on service https://www.example.com. 566s 2024-03-22 11:13:32,635 INFO ValidateService: ticket PT-um8QyfuzBbqO4qAjZUTkP6ugKB9DhMlMaNMIrbVmxXb0TUsDTOvRoFBoimc7V validated for user test on service https://www.example.com. 566s PASSED 566s cas_server/tests/test_view.py::SamlValidateTestCase::test_saml_bad_target 2024-03-22 11:13:32,652 INFO User test successfully authenticated 566s 2024-03-22 11:13:32,661 INFO Service ticket created for service https://www.example.com by user test. 566s 2024-03-22 11:13:32,665 WARNING SamlValidate: validation error: AuthnFailed TARGET https://www.example.org does not match ticket service 566s PASSED 566s cas_server/tests/test_view.py::SamlValidateTestCase::test_saml_bad_ticket 2024-03-22 11:13:32,673 WARNING SamlValidate: validation error: AuthnFailed ticket ST-lORWgz09MVbt0nqQHFbU6Tf3GU0CwHXe3HsdJn51oTMPDCo5eNgDR69WOxGpv not found 566s 2024-03-22 11:13:32,675 WARNING SamlValidate: validation error: AuthnFailed ticket PT-IXFQLufuHgi80fHIfGIah4DdbuvJzWnhukqOXWM5ex4WrekEDolRohA39FsTZ not found 566s PASSED 566s cas_server/tests/test_view.py::SamlValidateTestCase::test_saml_bad_ticket_prefix 2024-03-22 11:13:32,681 WARNING SamlValidate: validation error: AuthnFailed ticket RANDOM-NOT-BEGINING-WITH-ST-OR-ST should begin with PT- or ST- 566s PASSED 566s cas_server/tests/test_view.py::SamlValidateTestCase::test_saml_bad_xml 2024-03-22 11:13:32,688 WARNING SamlValidate: validation error: VersionMismatch 566s PASSED 566s cas_server/tests/test_view.py::SamlValidateTestCase::test_saml_ok 2024-03-22 11:13:32,705 INFO User test successfully authenticated 566s 2024-03-22 11:13:32,714 INFO Service ticket created for service https://www.example.com by user test. 566s 2024-03-22 11:13:32,727 INFO User test successfully authenticated 566s 2024-03-22 11:13:32,735 INFO Service ticket created for service http://127.0.0.1:46683 by user test. 566s 2024-03-22 11:13:32,742 INFO ValidateService: ticket ST-F5L6G4nF0IZYtv2c0Qls2hQ0AMBoNNN6VXHG0Mbtx6pj72WLNFjzwdTbgRuWA validated for user test on service http://127.0.0.1:46683. Proxy Granting Ticket transmited to http://127.0.0.1:46683. 566s 2024-03-22 11:13:32,748 INFO Proxy ticket created for user test on service https://www.example.com. 566s 2024-03-22 11:13:32,752 INFO SamlValidate: ticket ST-ONxoTRIvmwqFyZnElIrXuAGd5xzmWOFOhzobDnMKIc9SQg68WA46d7fBC2fLK validated for user test on service https://www.example.com. 566s 2024-03-22 11:13:32,756 INFO SamlValidate: ticket PT-XqFEZ3qmJLCedYwUgxrZxXJJvVIFTxVpS8gtakxLEvwDa6Z9wkinm3RrvBnr1 validated for user test on service https://www.example.com. 566s PASSED 566s cas_server/tests/test_view.py::SamlValidateTestCase::test_saml_ok_user_field 2024-03-22 11:13:32,771 INFO User test successfully authenticated 566s 2024-03-22 11:13:32,781 INFO Service ticket created for service https://field_needed_success.example.com by user test. 566s 2024-03-22 11:13:32,786 INFO SamlValidate: ticket ST-mIm58mHUCWDbRQZsFKb46kVCEAaeYFZDXfJ2OPWhqmk40r45TGeWAkkacgQyR validated for user test on service https://field_needed_success.example.com. 566s 2024-03-22 11:13:32,796 INFO User test successfully authenticated 566s 2024-03-22 11:13:32,805 INFO Service ticket created for service https://field_needed_success_alt.example.com by user test. 566s 2024-03-22 11:13:32,810 INFO SamlValidate: ticket ST-DECHGPdK4LSousGVIoV4oVtWKA5wyzqxo4WZUziaEAq5mhoXHQS0EkOAp8q5x validated for user test on service https://field_needed_success_alt.example.com. 566s Destroying test database for alias 'default'... 566s PASSED 566s 566s =============================== warnings summary =============================== 566s cas_server/utils.py:33 566s /tmp/autopkgtest.qShEHf/autopkgtest_tmp/cas_server/utils.py:33: DeprecationWarning: 'crypt' is deprecated and slated for removal in Python 3.13 566s import crypt 566s 566s cas_server/tests/utils.py:20 566s /tmp/autopkgtest.qShEHf/autopkgtest_tmp/cas_server/tests/utils.py:20: DeprecationWarning: 'cgi' is deprecated and slated for removal in Python 3.13 566s import cgi 566s 566s cas_server/tests/test_federate.py: 8 warnings 566s cas_server/tests/test_view.py: 3 warnings 566s /tmp/autopkgtest.qShEHf/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). 566s datetime.utcnow() + timedelta(seconds=max_age), 566s 566s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_login_post_provider 566s /usr/lib/python3.12/unittest/case.py:690: DeprecationWarning: It is deprecated to return a value that is not None from a test case (>) 566s return self.run(*args, **kwds) 566s 566s -- Docs: https://docs.pytest.org/en/stable/how-to/capture-warnings.html 566s ======================= 128 passed, 14 warnings in 7.86s ======================= 566s 567s autopkgtest [11:13:33]: test run-test-suite.sh: -----------------------] 567s autopkgtest [11:13:33]: test run-test-suite.sh: - - - - - - - - - - results - - - - - - - - - - 567s run-test-suite.sh PASS 568s autopkgtest [11:13:34]: @@@@@@@@@@@@@@@@@@@@ summary 568s run-test-suite.sh PASS 649s Creating nova instance adt-noble-ppc64el-django-cas-server-20240322-110406-juju-7f2275-prod-proposed-migration-environment-3 from image adt/ubuntu-noble-ppc64el-server-20240322.img (UUID 8499323f-6fcd-4f77-8a53-77410adea6d3)...