0s autopkgtest [21:57:58]: starting date and time: 2025-10-21 21:57:58+0000 0s autopkgtest [21:57:58]: git checkout: 4b346b80 nova: make wait_reboot return success even when a no-op 0s autopkgtest [21:57:58]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.f3rg3sv1/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:pytest,src:python-pluggy --apt-upgrade django-cas-server --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 '--env=ADT_TEST_TRIGGERS=pytest/8.4.2-1 python-pluggy/1.6.0-1' -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest-ppc64el --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@bos03-ppc64el-6.secgroup --name adt-resolute-ppc64el-django-cas-server-20251021-215758-juju-7f2275-prod-proposed-migration-environment-2-550cf66f-967d-4fd8-90c6-f86cc426791d --image adt/ubuntu-resolute-ppc64el-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-2 --net-id=net_prod-proposed-migration-ppc64el -e TERM=linux --mirror=http://ftpmaster.internal/ubuntu/ 4s Creating nova instance adt-resolute-ppc64el-django-cas-server-20251021-215758-juju-7f2275-prod-proposed-migration-environment-2-550cf66f-967d-4fd8-90c6-f86cc426791d from image adt/ubuntu-resolute-ppc64el-server-20251021.img (UUID c177abc7-cbc1-4b1f-967f-196ea722a402)... 52s autopkgtest [21:58:50]: testbed dpkg architecture: ppc64el 53s autopkgtest [21:58:51]: testbed apt version: 3.1.8ubuntu1 53s autopkgtest [21:58:51]: @@@@@@@@@@@@@@@@@@@@ test bed setup 53s autopkgtest [21:58:51]: testbed release detected to be: None 54s autopkgtest [21:58:52]: updating testbed package index (apt update) 54s Get:1 http://ftpmaster.internal/ubuntu resolute-proposed InRelease [83.3 kB] 55s Hit:2 http://ftpmaster.internal/ubuntu resolute InRelease 55s Hit:3 http://ftpmaster.internal/ubuntu resolute-updates InRelease 55s Hit:4 http://ftpmaster.internal/ubuntu resolute-security InRelease 55s Get:5 http://ftpmaster.internal/ubuntu resolute-proposed/main Sources [62.2 kB] 55s Get:6 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse Sources [15.0 kB] 55s Get:7 http://ftpmaster.internal/ubuntu resolute-proposed/restricted Sources [5028 B] 55s Get:8 http://ftpmaster.internal/ubuntu resolute-proposed/universe Sources [627 kB] 55s Get:9 http://ftpmaster.internal/ubuntu resolute-proposed/main ppc64el Packages [119 kB] 55s Get:10 http://ftpmaster.internal/ubuntu resolute-proposed/restricted ppc64el Packages [940 B] 55s Get:11 http://ftpmaster.internal/ubuntu resolute-proposed/universe ppc64el Packages [427 kB] 55s Get:12 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse ppc64el Packages [4596 B] 55s Fetched 1344 kB in 1s (1118 kB/s) 56s Reading package lists... 57s Failed to check for VM: Permission denied 57s Hit:1 http://ftpmaster.internal/ubuntu resolute-proposed InRelease 57s Hit:2 http://ftpmaster.internal/ubuntu resolute InRelease 57s Hit:3 http://ftpmaster.internal/ubuntu resolute-updates InRelease 57s Hit:4 http://ftpmaster.internal/ubuntu resolute-security InRelease 58s Reading package lists... 58s Reading package lists... 58s Building dependency tree... 58s Reading state information... 58s Calculating upgrade... 58s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 58s autopkgtest [21:58:56]: upgrading testbed (apt dist-upgrade and autopurge) 59s Reading package lists... 59s Building dependency tree... 59s Reading state information... 59s Calculating upgrade... 59s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 59s Reading package lists... 59s Building dependency tree... 59s Reading state information... 59s Solving dependencies... 59s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 62s autopkgtest [21:59:00]: testbed running kernel: Linux 6.17.0-5-generic #5-Ubuntu SMP PREEMPT_DYNAMIC Mon Sep 22 10:02:41 UTC 2025 62s autopkgtest [21:59:00]: @@@@@@@@@@@@@@@@@@@@ apt-source django-cas-server 65s Get:1 http://ftpmaster.internal/ubuntu resolute/universe django-cas-server 2.1.0-3 (dsc) [2597 B] 65s Get:2 http://ftpmaster.internal/ubuntu resolute/universe django-cas-server 2.1.0-3 (tar) [138 kB] 65s Get:3 http://ftpmaster.internal/ubuntu resolute/universe django-cas-server 2.1.0-3 (diff) [10.2 kB] 65s gpgv: Signature made Sat Dec 14 20:43:18 2024 UTC 65s gpgv: using RSA key 8F6DE104377F3B11E741748731F3144544A1741A 65s gpgv: issuer "tchet@debian.org" 65s gpgv: Can't check signature: No public key 65s dpkg-source: warning: cannot verify inline signature for ./django-cas-server_2.1.0-3.dsc: no acceptable signature found 65s autopkgtest [21:59:03]: testing package django-cas-server version 2.1.0-3 66s autopkgtest [21:59:04]: build not needed 67s autopkgtest [21:59:05]: test run-test-suite.sh: preparing testbed 67s Reading package lists... 67s Building dependency tree... 67s Reading state information... 67s Solving dependencies... 67s The following NEW packages will be installed: 67s fonts-font-awesome fonts-lato libjs-jquery libjs-sphinxdoc libjs-underscore 67s libxslt1.1 python3-all python3-asgiref python3-django 67s python3-django-cas-server python3-django-cas-server-doc python3-iniconfig 67s python3-legacy-cgi python3-lxml python3-packaging python3-pluggy 67s python3-pytest python3-pytest-django python3-requests-futures 67s python3-sqlparse sphinx-rtd-theme-common 67s 0 upgraded, 21 newly installed, 0 to remove and 0 not upgraded. 67s Need to get 10.4 MB of archives. 67s After this operation, 55.3 MB of additional disk space will be used. 67s Get:1 http://ftpmaster.internal/ubuntu resolute/main ppc64el fonts-lato all 2.015-1 [2781 kB] 68s Get:2 http://ftpmaster.internal/ubuntu resolute/main ppc64el fonts-font-awesome all 5.0.10+really4.7.0~dfsg-4.1 [516 kB] 68s Get:3 http://ftpmaster.internal/ubuntu resolute/main ppc64el libjs-jquery all 3.6.1+dfsg+~3.5.14-1 [328 kB] 68s Get:4 http://ftpmaster.internal/ubuntu resolute/main ppc64el libjs-underscore all 1.13.4~dfsg+~1.11.4-3 [118 kB] 69s Get:5 http://ftpmaster.internal/ubuntu resolute/main ppc64el libjs-sphinxdoc all 8.2.3-1ubuntu2 [28.0 kB] 69s Get:6 http://ftpmaster.internal/ubuntu resolute/main ppc64el libxslt1.1 ppc64el 1.1.43-0.1 [189 kB] 69s Get:7 http://ftpmaster.internal/ubuntu resolute/main ppc64el python3-all ppc64el 3.13.7-1 [884 B] 69s Get:8 http://ftpmaster.internal/ubuntu resolute/main ppc64el python3-asgiref all 3.9.1-2 [24.9 kB] 69s Get:9 http://ftpmaster.internal/ubuntu resolute/main ppc64el python3-sqlparse all 0.5.3-1 [32.9 kB] 69s Get:10 http://ftpmaster.internal/ubuntu resolute/main ppc64el python3-django all 3:5.2.4-1ubuntu2 [3036 kB] 69s Get:11 http://ftpmaster.internal/ubuntu resolute/main ppc64el python3-legacy-cgi all 2.6.3-1 [16.8 kB] 69s Get:12 http://ftpmaster.internal/ubuntu resolute/main ppc64el python3-lxml ppc64el 6.0.1-1 [1616 kB] 69s Get:13 http://ftpmaster.internal/ubuntu resolute/universe ppc64el python3-requests-futures all 1.0.2-1 [12.0 kB] 69s Get:14 http://ftpmaster.internal/ubuntu resolute/universe ppc64el python3-django-cas-server all 2.1.0-3 [111 kB] 69s Get:15 http://ftpmaster.internal/ubuntu resolute/main ppc64el sphinx-rtd-theme-common all 3.0.2+dfsg-3 [1013 kB] 69s Get:16 http://ftpmaster.internal/ubuntu resolute/universe ppc64el python3-django-cas-server-doc all 2.1.0-3 [178 kB] 69s Get:17 http://ftpmaster.internal/ubuntu resolute/universe ppc64el python3-iniconfig all 1.1.1-2 [6024 B] 69s Get:18 http://ftpmaster.internal/ubuntu resolute/main ppc64el python3-packaging all 25.0-1 [52.8 kB] 69s Get:19 http://ftpmaster.internal/ubuntu resolute/universe ppc64el python3-pluggy all 1.6.0-1 [21.0 kB] 69s Get:20 http://ftpmaster.internal/ubuntu resolute-proposed/universe ppc64el python3-pytest all 8.4.2-1 [268 kB] 69s Get:21 http://ftpmaster.internal/ubuntu resolute/universe ppc64el python3-pytest-django all 4.5.2-3 [18.5 kB] 70s Fetched 10.4 MB in 2s (4557 kB/s) 70s Selecting previously unselected package fonts-lato. 70s (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 ... 76480 files and directories currently installed.) 70s Preparing to unpack .../00-fonts-lato_2.015-1_all.deb ... 70s Unpacking fonts-lato (2.015-1) ... 71s Selecting previously unselected package fonts-font-awesome. 71s Preparing to unpack .../01-fonts-font-awesome_5.0.10+really4.7.0~dfsg-4.1_all.deb ... 71s Unpacking fonts-font-awesome (5.0.10+really4.7.0~dfsg-4.1) ... 71s Selecting previously unselected package libjs-jquery. 71s Preparing to unpack .../02-libjs-jquery_3.6.1+dfsg+~3.5.14-1_all.deb ... 71s Unpacking libjs-jquery (3.6.1+dfsg+~3.5.14-1) ... 71s Selecting previously unselected package libjs-underscore. 71s Preparing to unpack .../03-libjs-underscore_1.13.4~dfsg+~1.11.4-3_all.deb ... 71s Unpacking libjs-underscore (1.13.4~dfsg+~1.11.4-3) ... 71s Selecting previously unselected package libjs-sphinxdoc. 71s Preparing to unpack .../04-libjs-sphinxdoc_8.2.3-1ubuntu2_all.deb ... 71s Unpacking libjs-sphinxdoc (8.2.3-1ubuntu2) ... 71s Selecting previously unselected package libxslt1.1:ppc64el. 71s Preparing to unpack .../05-libxslt1.1_1.1.43-0.1_ppc64el.deb ... 71s Unpacking libxslt1.1:ppc64el (1.1.43-0.1) ... 71s Selecting previously unselected package python3-all. 71s Preparing to unpack .../06-python3-all_3.13.7-1_ppc64el.deb ... 71s Unpacking python3-all (3.13.7-1) ... 71s Selecting previously unselected package python3-asgiref. 71s Preparing to unpack .../07-python3-asgiref_3.9.1-2_all.deb ... 71s Unpacking python3-asgiref (3.9.1-2) ... 71s Selecting previously unselected package python3-sqlparse. 71s Preparing to unpack .../08-python3-sqlparse_0.5.3-1_all.deb ... 71s Unpacking python3-sqlparse (0.5.3-1) ... 71s Selecting previously unselected package python3-django. 71s Preparing to unpack .../09-python3-django_3%3a5.2.4-1ubuntu2_all.deb ... 71s Unpacking python3-django (3:5.2.4-1ubuntu2) ... 71s Selecting previously unselected package python3-legacy-cgi. 71s Preparing to unpack .../10-python3-legacy-cgi_2.6.3-1_all.deb ... 71s Unpacking python3-legacy-cgi (2.6.3-1) ... 71s Selecting previously unselected package python3-lxml:ppc64el. 71s Preparing to unpack .../11-python3-lxml_6.0.1-1_ppc64el.deb ... 71s Unpacking python3-lxml:ppc64el (6.0.1-1) ... 71s Selecting previously unselected package python3-requests-futures. 71s Preparing to unpack .../12-python3-requests-futures_1.0.2-1_all.deb ... 71s Unpacking python3-requests-futures (1.0.2-1) ... 71s Selecting previously unselected package python3-django-cas-server. 71s Preparing to unpack .../13-python3-django-cas-server_2.1.0-3_all.deb ... 71s Unpacking python3-django-cas-server (2.1.0-3) ... 72s Selecting previously unselected package sphinx-rtd-theme-common. 72s Preparing to unpack .../14-sphinx-rtd-theme-common_3.0.2+dfsg-3_all.deb ... 72s Unpacking sphinx-rtd-theme-common (3.0.2+dfsg-3) ... 72s Selecting previously unselected package python3-django-cas-server-doc. 72s Preparing to unpack .../15-python3-django-cas-server-doc_2.1.0-3_all.deb ... 72s Unpacking python3-django-cas-server-doc (2.1.0-3) ... 72s Selecting previously unselected package python3-iniconfig. 72s Preparing to unpack .../16-python3-iniconfig_1.1.1-2_all.deb ... 72s Unpacking python3-iniconfig (1.1.1-2) ... 72s Selecting previously unselected package python3-packaging. 72s Preparing to unpack .../17-python3-packaging_25.0-1_all.deb ... 72s Unpacking python3-packaging (25.0-1) ... 72s Selecting previously unselected package python3-pluggy. 72s Preparing to unpack .../18-python3-pluggy_1.6.0-1_all.deb ... 72s Unpacking python3-pluggy (1.6.0-1) ... 72s Selecting previously unselected package python3-pytest. 72s Preparing to unpack .../19-python3-pytest_8.4.2-1_all.deb ... 72s Unpacking python3-pytest (8.4.2-1) ... 72s Selecting previously unselected package python3-pytest-django. 72s Preparing to unpack .../20-python3-pytest-django_4.5.2-3_all.deb ... 72s Unpacking python3-pytest-django (4.5.2-3) ... 72s Setting up python3-iniconfig (1.1.1-2) ... 72s Setting up fonts-lato (2.015-1) ... 72s Setting up python3-all (3.13.7-1) ... 72s Setting up python3-packaging (25.0-1) ... 72s Setting up python3-sqlparse (0.5.3-1) ... 72s Setting up python3-pluggy (1.6.0-1) ... 72s Setting up python3-legacy-cgi (2.6.3-1) ... 72s Setting up libxslt1.1:ppc64el (1.1.43-0.1) ... 72s Setting up python3-requests-futures (1.0.2-1) ... 72s Setting up libjs-jquery (3.6.1+dfsg+~3.5.14-1) ... 72s Setting up fonts-font-awesome (5.0.10+really4.7.0~dfsg-4.1) ... 72s Setting up sphinx-rtd-theme-common (3.0.2+dfsg-3) ... 72s Setting up python3-asgiref (3.9.1-2) ... 72s Setting up libjs-underscore (1.13.4~dfsg+~1.11.4-3) ... 72s Setting up python3-django (3:5.2.4-1ubuntu2) ... 74s Setting up python3-pytest (8.4.2-1) ... 74s Setting up python3-pytest-django (4.5.2-3) ... 74s Setting up libjs-sphinxdoc (8.2.3-1ubuntu2) ... 74s Setting up python3-lxml:ppc64el (6.0.1-1) ... 74s Setting up python3-django-cas-server (2.1.0-3) ... 74s Setting up python3-django-cas-server-doc (2.1.0-3) ... 74s Processing triggers for man-db (2.13.1-1) ... 76s Processing triggers for libc-bin (2.42-0ubuntu3) ... 77s autopkgtest [21:59:15]: test run-test-suite.sh: [----------------------- 78s 78s *************************** 78s *** Testing with python3.13 78s *************************** 78s 78s Content of current working folder: 78s 78s total 20 78s drwxr-xr-x 3 ubuntu ubuntu 4096 Oct 21 21:59 . 78s drwxrwxrwx 5 root root 4096 Oct 21 21:59 .. 78s drwxrwxr-x 9 ubuntu ubuntu 4096 Oct 21 21:59 cas_server 78s -rw-rw-r-- 1 ubuntu ubuntu 140 Aug 18 2024 pytest.ini 78s -rw-rw-r-- 1 ubuntu ubuntu 152 Aug 18 2024 setup.cfg 78s Running tests... 78s 78s ============================= test session starts ============================== 78s platform linux -- Python 3.13.9, pytest-8.4.2, pluggy-1.6.0 -- /usr/bin/python3.13 78s cachedir: .pytest_cache 78s django: settings: cas_server.tests.settings (from ini) 78s rootdir: /tmp/autopkgtest.9ue7Sp/autopkgtest_tmp 78s configfile: pytest.ini 78s testpaths: cas_server/tests/ 78s plugins: django-4.5.2, typeguard-4.4.2 79s collecting ... Creating test database for alias 'default'... 79s collected 128 items 79s 79s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_auth_federate_errors 2025-10-21 21:59:17,689 WARNING Identity provider suffix exemple.fr not found 79s 2025-10-21 21:59:17,706 INFO Got an invalid ticket ST-kjRDgPHblr4Prl50tPnpaZDelLctUvFSbmd85fv2uBHTVzhLsfNJEVP0c038s from http://127.0.0.1:8080 for service http://testserver/federate/example.com. Retrying authentication 79s 2025-10-21 21:59:17,710 INFO Got an invalid ticket ST-22uTWZuxWOniyXCNhTcLKmDnkfwH2unsm9dwfG0No76iZPspKSGJrMhgTmJ9p from http://127.0.0.1:8080 for service http://testserver/federate/example.com. Retrying authentication 79s PASSED 79s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_auth_federate_false 2025-10-21 21:59:17,743 WARNING CAS_FEDERATE is False, set it to True to use federation 79s PASSED 79s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_auth_federate_slo 2025-10-21 21:59:17,744 WARNING CAS_FEDERATE is False, set it to True to use federation 79s 2025-10-21 21:59:17,760 INFO Trying to authenticate http://127.0.0.1:8080 again 79s 2025-10-21 21:59:17,765 INFO Got a valid ticket for dédé from http://127.0.0.1:8080 79s 2025-10-21 21:59:17,781 INFO User dédé@example.com successfully authenticated 79s 2025-10-21 21:59:17,792 INFO Service ticket created for service https://www.example.com by user dédé@example.com. 79s 2025-10-21 21:59:17,803 INFO Trying to authenticate http://127.0.0.1:8081 again 79s 2025-10-21 21:59:17,810 INFO Got a valid ticket for dédé from http://127.0.0.1:8081 79s 2025-10-21 21:59:17,820 INFO User dédé@example.org successfully authenticated 79s 2025-10-21 21:59:17,830 INFO Service ticket created for service https://www.example.com by user dédé@example.org. 79s 2025-10-21 21:59:17,840 INFO Trying to authenticate http://127.0.0.1:8082 again 79s 2025-10-21 21:59:17,846 INFO Got a valid ticket for dédé from http://127.0.0.1:8082 79s 2025-10-21 21:59:17,857 INFO User dédé@example.net successfully authenticated 79s 2025-10-21 21:59:17,866 INFO Service ticket created for service https://www.example.com by user dédé@example.net. 79s 2025-10-21 21:59:17,876 INFO Trying to authenticate http://127.0.0.1:8083 again 79s 2025-10-21 21:59:17,888 INFO Got a valid ticket for dédé from http://127.0.0.1:8083 79s 2025-10-21 21:59:17,898 INFO User dédé@example.test successfully authenticated 79s 2025-10-21 21:59:17,907 INFO Service ticket created for service https://www.example.com by user dédé@example.test. 79s 2025-10-21 21:59:17,942 INFO Got an SLO requests for ticket dédé@example.net, logging out user ST-Qpdy1InZ8jAGJiIGsnBH4t44svj8V4kU1n7nIdUirlszMgJjmrXaHU3qj3wHX 79s 2025-10-21 21:59:17,965 INFO Got an SLO requests for ticket dédé@example.test, logging out user ST-8XdvswbanJnD3aAO6bVLq9xl2U6MIRZnv0h9Lrokp89q6otCElPLT80o5we0v 80s PASSED 80s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_default_settings PASSED 80s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_federate_logout 2025-10-21 21:59:17,999 INFO Trying to authenticate http://127.0.0.1:8080 again 80s 2025-10-21 21:59:18,004 INFO Got a valid ticket for dédé from http://127.0.0.1:8080 80s 2025-10-21 21:59:18,015 INFO User dédé@example.com successfully authenticated 80s 2025-10-21 21:59:18,025 INFO Service ticket created for service https://www.example.com by user dédé@example.com. 80s 2025-10-21 21:59:18,035 INFO Trying to authenticate http://127.0.0.1:8081 again 80s 2025-10-21 21:59:18,041 INFO Got a valid ticket for dédé from http://127.0.0.1:8081 80s 2025-10-21 21:59:18,051 INFO User dédé@example.org successfully authenticated 80s 2025-10-21 21:59:18,061 INFO Service ticket created for service https://www.example.com by user dédé@example.org. 80s 2025-10-21 21:59:18,071 INFO Trying to authenticate http://127.0.0.1:8082 again 80s 2025-10-21 21:59:18,078 INFO Got a valid ticket for dédé from http://127.0.0.1:8082 80s 2025-10-21 21:59:18,088 INFO User dédé@example.net successfully authenticated 80s 2025-10-21 21:59:18,098 INFO Service ticket created for service https://www.example.com by user dédé@example.net. 80s 2025-10-21 21:59:18,108 INFO Trying to authenticate http://127.0.0.1:8083 again 80s 2025-10-21 21:59:18,114 INFO Got a valid ticket for dédé from http://127.0.0.1:8083 80s 2025-10-21 21:59:18,126 INFO User dédé@example.test successfully authenticated 80s 2025-10-21 21:59:18,135 INFO Service ticket created for service https://www.example.com by user dédé@example.test. 80s 2025-10-21 21:59:18,136 INFO logout requested 80s 2025-10-21 21:59:18,138 INFO Logging out user dédé@example.com. 80s 2025-10-21 21:59:18,142 INFO User dédé@example.com logged out 80s 2025-10-21 21:59:18,151 INFO logout requested 80s 2025-10-21 21:59:18,154 INFO logout requested 80s 2025-10-21 21:59:18,156 INFO Logging out user dédé@example.org. 80s 2025-10-21 21:59:18,160 INFO User dédé@example.org logged out 80s 2025-10-21 21:59:18,169 INFO logout requested 80s 2025-10-21 21:59:18,172 INFO logout requested 80s 2025-10-21 21:59:18,174 INFO Logging out user dédé@example.net. 80s 2025-10-21 21:59:18,178 INFO User dédé@example.net logged out 80s 2025-10-21 21:59:18,187 INFO logout requested 80s 2025-10-21 21:59:18,189 INFO logout requested 80s 2025-10-21 21:59:18,191 INFO Logging out user dédé@example.test. 80s 2025-10-21 21:59:18,196 INFO User dédé@example.test logged out 80s 2025-10-21 21:59:18,204 INFO logout requested 80s 2025-10-21 21:59:18,217 INFO Trying to authenticate http://127.0.0.1:8080 again 80s 2025-10-21 21:59:18,224 INFO Got a valid ticket for dédé from http://127.0.0.1:8080 80s 2025-10-21 21:59:18,234 INFO User dédé@example.com successfully authenticated 80s 2025-10-21 21:59:18,243 INFO Service ticket created for service https://www.example.com by user dédé@example.com. 80s 2025-10-21 21:59:18,255 INFO Trying to authenticate http://127.0.0.1:8081 again 80s 2025-10-21 21:59:18,261 INFO Got a valid ticket for dédé from http://127.0.0.1:8081 80s 2025-10-21 21:59:18,272 INFO User dédé@example.org successfully authenticated 80s 2025-10-21 21:59:18,281 INFO Service ticket created for service https://www.example.com by user dédé@example.org. 80s 2025-10-21 21:59:18,315 INFO Trying to authenticate http://127.0.0.1:8082 again 80s 2025-10-21 21:59:18,322 INFO Got a valid ticket for dédé from http://127.0.0.1:8082 80s 2025-10-21 21:59:18,331 INFO User dédé@example.net successfully authenticated 80s 2025-10-21 21:59:18,340 INFO Service ticket created for service https://www.example.com by user dédé@example.net. 80s 2025-10-21 21:59:18,351 INFO Trying to authenticate http://127.0.0.1:8083 again 80s 2025-10-21 21:59:18,358 INFO Got a valid ticket for dédé from http://127.0.0.1:8083 80s 2025-10-21 21:59:18,367 INFO User dédé@example.test successfully authenticated 80s 2025-10-21 21:59:18,377 INFO Service ticket created for service https://www.example.com by user dédé@example.test. 80s 2025-10-21 21:59:18,379 INFO logout requested 80s 2025-10-21 21:59:18,380 INFO Logging out user dédé. 80s 2025-10-21 21:59:18,381 INFO User dédé logged out 80s 2025-10-21 21:59:18,390 INFO logout requested 80s 2025-10-21 21:59:18,391 INFO Logging out user dédé. 80s 2025-10-21 21:59:18,392 INFO User dédé logged out 80s 2025-10-21 21:59:18,402 INFO logout requested 80s 2025-10-21 21:59:18,403 INFO Logging out user dédé. 80s 2025-10-21 21:59:18,404 INFO User dédé logged out 80s 2025-10-21 21:59:18,414 INFO logout requested 80s 2025-10-21 21:59:18,415 INFO Logging out user dédé. 80s 2025-10-21 21:59:18,416 INFO User dédé logged out 80s PASSED 80s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_forget_provider 2025-10-21 21:59:18,440 INFO Trying to authenticate http://127.0.0.1:8080 again 80s 2025-10-21 21:59:18,446 INFO Got a valid ticket for dédé from http://127.0.0.1:8080 80s 2025-10-21 21:59:18,457 INFO User dédé@example.com successfully authenticated 80s 2025-10-21 21:59:18,466 INFO Service ticket created for service https://www.example.com by user dédé@example.com. 80s 2025-10-21 21:59:18,477 INFO Trying to authenticate http://127.0.0.1:8081 again 80s 2025-10-21 21:59:18,483 INFO Got a valid ticket for dédé from http://127.0.0.1:8081 80s 2025-10-21 21:59:18,493 INFO User dédé@example.org successfully authenticated 80s 2025-10-21 21:59:18,502 INFO Service ticket created for service https://www.example.com by user dédé@example.org. 80s 2025-10-21 21:59:18,513 INFO Trying to authenticate http://127.0.0.1:8082 again 80s 2025-10-21 21:59:18,520 INFO Got a valid ticket for dédé from http://127.0.0.1:8082 80s 2025-10-21 21:59:18,530 INFO User dédé@example.net successfully authenticated 80s 2025-10-21 21:59:18,539 INFO Service ticket created for service https://www.example.com by user dédé@example.net. 80s 2025-10-21 21:59:18,550 INFO Trying to authenticate http://127.0.0.1:8083 again 80s 2025-10-21 21:59:18,554 INFO Got a valid ticket for dédé from http://127.0.0.1:8083 80s 2025-10-21 21:59:18,564 INFO User dédé@example.test successfully authenticated 80s 2025-10-21 21:59:18,573 INFO Service ticket created for service https://www.example.com by user dédé@example.test. 80s 2025-10-21 21:59:18,574 INFO logout requested 80s 2025-10-21 21:59:18,576 INFO Logging out user dédé@example.com. 80s 2025-10-21 21:59:18,581 INFO User dédé@example.com logged out 80s 2025-10-21 21:59:18,581 INFO logout requested 80s 2025-10-21 21:59:18,583 INFO Logging out user dédé@example.org. 80s 2025-10-21 21:59:18,588 INFO User dédé@example.org logged out 80s 2025-10-21 21:59:18,588 INFO logout requested 80s 2025-10-21 21:59:18,590 INFO Logging out user dédé@example.net. 80s 2025-10-21 21:59:18,594 INFO User dédé@example.net logged out 80s 2025-10-21 21:59:18,595 INFO logout requested 80s 2025-10-21 21:59:18,597 INFO Logging out user dédé@example.test. 80s PASSED2025-10-21 21:59:18,601 INFO User dédé@example.test logged out 80s 80s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_login_bad_ticket 2025-10-21 21:59:18,616 WARNING A login attempt failed 80s PASSED 80s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_login_get_provider PASSED 80s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_login_post_provider 2025-10-21 21:59:18,650 INFO Trying to authenticate http://127.0.0.1:8080 again 80s 2025-10-21 21:59:18,660 INFO Got a valid ticket for dédé from http://127.0.0.1:8080 80s 2025-10-21 21:59:18,670 INFO User dédé@example.com successfully authenticated 80s 2025-10-21 21:59:18,679 INFO Service ticket created for service https://www.example.com by user dédé@example.com. 80s 2025-10-21 21:59:18,691 INFO Trying to authenticate http://127.0.0.1:8081 again 80s 2025-10-21 21:59:18,698 INFO Got a valid ticket for dédé from http://127.0.0.1:8081 80s 2025-10-21 21:59:18,708 INFO User dédé@example.org successfully authenticated 80s 2025-10-21 21:59:18,718 INFO Service ticket created for service https://www.example.com by user dédé@example.org. 80s 2025-10-21 21:59:18,730 INFO Trying to authenticate http://127.0.0.1:8082 again 80s 2025-10-21 21:59:18,735 INFO Got a valid ticket for dédé from http://127.0.0.1:8082 80s 2025-10-21 21:59:18,746 INFO User dédé@example.net successfully authenticated 80s 2025-10-21 21:59:18,756 INFO Service ticket created for service https://www.example.com by user dédé@example.net. 80s 2025-10-21 21:59:18,769 INFO Trying to authenticate http://127.0.0.1:8083 again 80s 2025-10-21 21:59:18,775 INFO Got a valid ticket for dédé from http://127.0.0.1:8083 80s 2025-10-21 21:59:18,786 INFO User dédé@example.test successfully authenticated 80s PASSED2025-10-21 21:59:18,795 INFO Service ticket created for service https://www.example.com by user dédé@example.test. 80s 80s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_login_twice 2025-10-21 21:59:18,814 INFO Trying to authenticate http://127.0.0.1:8080 again 80s 2025-10-21 21:59:18,820 INFO Got a valid ticket for dédé from http://127.0.0.1:8080 80s 2025-10-21 21:59:18,830 INFO User dédé@example.com successfully authenticated 80s 2025-10-21 21:59:18,839 INFO Service ticket created for service https://www.example.com by user dédé@example.com. 80s 2025-10-21 21:59:18,850 INFO Trying to authenticate http://127.0.0.1:8081 again 80s 2025-10-21 21:59:18,854 INFO Got a valid ticket for dédé from http://127.0.0.1:8081 80s 2025-10-21 21:59:18,864 INFO User dédé@example.org successfully authenticated 80s 2025-10-21 21:59:18,873 INFO Service ticket created for service https://www.example.com by user dédé@example.org. 80s 2025-10-21 21:59:18,885 INFO Trying to authenticate http://127.0.0.1:8082 again 80s 2025-10-21 21:59:18,890 INFO Got a valid ticket for dédé from http://127.0.0.1:8082 80s 2025-10-21 21:59:18,900 INFO User dédé@example.net successfully authenticated 80s 2025-10-21 21:59:18,910 INFO Service ticket created for service https://www.example.com by user dédé@example.net. 80s 2025-10-21 21:59:18,921 INFO Trying to authenticate http://127.0.0.1:8083 again 80s 2025-10-21 21:59:18,928 INFO Got a valid ticket for dédé from http://127.0.0.1:8083 80s 2025-10-21 21:59:18,938 INFO User dédé@example.test successfully authenticated 80s 2025-10-21 21:59:18,947 INFO Service ticket created for service https://www.example.com by user dédé@example.test. 80s 2025-10-21 21:59:18,959 INFO Trying to authenticate http://127.0.0.1:8080 again 80s 2025-10-21 21:59:18,966 INFO Got a valid ticket for dédé from http://127.0.0.1:8080 81s 2025-10-21 21:59:18,976 INFO User dédé@example.com successfully authenticated 81s 2025-10-21 21:59:18,986 INFO Service ticket created for service https://www.example.com by user dédé@example.com. 81s 2025-10-21 21:59:18,997 INFO Trying to authenticate http://127.0.0.1:8081 again 81s 2025-10-21 21:59:19,004 INFO Got a valid ticket for dédé from http://127.0.0.1:8081 81s 2025-10-21 21:59:19,014 INFO User dédé@example.org successfully authenticated 81s 2025-10-21 21:59:19,024 INFO Service ticket created for service https://www.example.com by user dédé@example.org. 81s 2025-10-21 21:59:19,034 INFO Trying to authenticate http://127.0.0.1:8082 again 81s 2025-10-21 21:59:19,041 INFO Got a valid ticket for dédé from http://127.0.0.1:8082 81s 2025-10-21 21:59:19,051 INFO User dédé@example.net successfully authenticated 81s 2025-10-21 21:59:19,060 INFO Service ticket created for service https://www.example.com by user dédé@example.net. 81s 2025-10-21 21:59:19,071 INFO Trying to authenticate http://127.0.0.1:8083 again 81s 2025-10-21 21:59:19,078 INFO Got a valid ticket for dédé from http://127.0.0.1:8083 81s 2025-10-21 21:59:19,088 INFO User dédé@example.test successfully authenticated 81s 2025-10-21 21:59:19,097 INFO Service ticket created for service https://www.example.com by user dédé@example.test. 81s 2025-10-21 21:59:19,098 WARNING User already authenticated, dropping federated authentication request 81s 2025-10-21 21:59:19,100 WARNING User already authenticated, dropping federated authentication request 81s 2025-10-21 21:59:19,101 WARNING User already authenticated, dropping federated authentication request 81s PASSED 81s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_remember_provider 2025-10-21 21:59:19,102 WARNING User already authenticated, dropping federated authentication request 81s 2025-10-21 21:59:19,117 INFO Trying to authenticate http://127.0.0.1:8080 again 81s 2025-10-21 21:59:19,123 INFO Got a valid ticket for dédé from http://127.0.0.1:8080 81s 2025-10-21 21:59:19,133 INFO User dédé@example.com successfully authenticated 81s 2025-10-21 21:59:19,142 INFO Service ticket created for service https://www.example.com by user dédé@example.com. 81s 2025-10-21 21:59:19,153 INFO Trying to authenticate http://127.0.0.1:8081 again 81s 2025-10-21 21:59:19,159 INFO Got a valid ticket for dédé from http://127.0.0.1:8081 81s 2025-10-21 21:59:19,170 INFO User dédé@example.org successfully authenticated 81s 2025-10-21 21:59:19,179 INFO Service ticket created for service https://www.example.com by user dédé@example.org. 81s 2025-10-21 21:59:19,190 INFO Trying to authenticate http://127.0.0.1:8082 again 81s 2025-10-21 21:59:19,199 INFO Got a valid ticket for dédé from http://127.0.0.1:8082 81s 2025-10-21 21:59:19,209 INFO User dédé@example.net successfully authenticated 81s 2025-10-21 21:59:19,219 INFO Service ticket created for service https://www.example.com by user dédé@example.net. 81s 2025-10-21 21:59:19,232 INFO Trying to authenticate http://127.0.0.1:8083 again 81s 2025-10-21 21:59:19,237 INFO Got a valid ticket for dédé from http://127.0.0.1:8083 81s 2025-10-21 21:59:19,247 INFO User dédé@example.test successfully authenticated 81s 2025-10-21 21:59:19,257 INFO Service ticket created for service https://www.example.com by user dédé@example.test. 81s 2025-10-21 21:59:19,258 INFO logout requested 81s 2025-10-21 21:59:19,259 INFO Logging out user dédé@example.com. 81s 2025-10-21 21:59:19,264 INFO User dédé@example.com logged out 81s 2025-10-21 21:59:19,267 INFO logout requested 81s 2025-10-21 21:59:19,269 INFO Logging out user dédé@example.org. 81s 2025-10-21 21:59:19,273 INFO User dédé@example.org logged out 81s 2025-10-21 21:59:19,276 INFO logout requested 81s 2025-10-21 21:59:19,277 INFO Logging out user dédé@example.net. 81s 2025-10-21 21:59:19,282 INFO User dédé@example.net logged out 81s 2025-10-21 21:59:19,284 INFO logout requested 81s 2025-10-21 21:59:19,286 INFO Logging out user dédé@example.test. 81s 2025-10-21 21:59:19,291 INFO User dédé@example.test logged out 81s PASSED 81s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_renew 2025-10-21 21:59:19,308 INFO Trying to authenticate http://127.0.0.1:8080 again 81s 2025-10-21 21:59:19,314 INFO Got a valid ticket for dédé from http://127.0.0.1:8080 81s 2025-10-21 21:59:19,324 INFO User dédé@example.com successfully authenticated 81s 2025-10-21 21:59:19,334 INFO Service ticket created for service https://www.example.com by user dédé@example.com. 81s 2025-10-21 21:59:19,344 INFO Trying to authenticate http://127.0.0.1:8081 again 81s 2025-10-21 21:59:19,351 INFO Got a valid ticket for dédé from http://127.0.0.1:8081 81s 2025-10-21 21:59:19,361 INFO User dédé@example.org successfully authenticated 81s 2025-10-21 21:59:19,371 INFO Service ticket created for service https://www.example.com by user dédé@example.org. 81s 2025-10-21 21:59:19,382 INFO Trying to authenticate http://127.0.0.1:8082 again 81s 2025-10-21 21:59:19,387 INFO Got a valid ticket for dédé from http://127.0.0.1:8082 81s 2025-10-21 21:59:19,398 INFO User dédé@example.net successfully authenticated 81s 2025-10-21 21:59:19,408 INFO Service ticket created for service https://www.example.com by user dédé@example.net. 81s 2025-10-21 21:59:19,418 INFO Trying to authenticate http://127.0.0.1:8083 again 81s 2025-10-21 21:59:19,424 INFO Got a valid ticket for dédé from http://127.0.0.1:8083 81s 2025-10-21 21:59:19,434 INFO User dédé@example.test successfully authenticated 81s 2025-10-21 21:59:19,444 INFO Service ticket created for service https://www.example.com by user dédé@example.test. 81s 2025-10-21 21:59:19,448 INFO Trying to authenticate http://127.0.0.1:8080 again 81s 2025-10-21 21:59:19,455 INFO Got a valid ticket for dédé from http://127.0.0.1:8080 81s 2025-10-21 21:59:19,466 INFO User dédé@example.com successfully authenticated 81s 2025-10-21 21:59:19,470 INFO Service ticket created for service https://www.example.com by user dédé@example.com. 81s 2025-10-21 21:59:19,476 INFO Trying to authenticate http://127.0.0.1:8081 again 81s 2025-10-21 21:59:19,481 INFO Got a valid ticket for dédé from http://127.0.0.1:8081 81s 2025-10-21 21:59:19,492 INFO User dédé@example.org successfully authenticated 81s 2025-10-21 21:59:19,497 INFO Service ticket created for service https://www.example.com by user dédé@example.org. 81s 2025-10-21 21:59:19,502 INFO Trying to authenticate http://127.0.0.1:8082 again 81s 2025-10-21 21:59:19,507 INFO Got a valid ticket for dédé from http://127.0.0.1:8082 81s 2025-10-21 21:59:19,518 INFO User dédé@example.net successfully authenticated 81s 2025-10-21 21:59:19,523 INFO Service ticket created for service https://www.example.com by user dédé@example.net. 81s 2025-10-21 21:59:19,528 INFO Trying to authenticate http://127.0.0.1:8083 again 81s 2025-10-21 21:59:19,533 INFO Got a valid ticket for dédé from http://127.0.0.1:8083 81s 2025-10-21 21:59:19,545 INFO User dédé@example.test successfully authenticated 81s 2025-10-21 21:59:19,550 INFO Service ticket created for service https://www.example.com by user dédé@example.test. 81s PASSED 81s cas_server/tests/test_models.py::FederatedUserTestCase::test_clean_old_entries PASSED 81s cas_server/tests/test_models.py::FederatedUserTestCase::test_json_attributes PASSED 81s cas_server/tests/test_models.py::FederateSLOTestCase::test_clean_deleted_sessions PASSED 81s cas_server/tests/test_models.py::UserAttributesTestCase::test_clean_old_entries 2025-10-21 21:59:19,593 INFO User test successfully authenticated 81s PASSED 81s cas_server/tests/test_models.py::UserTestCase::test_cached_attributs 2025-10-21 21:59:19,610 INFO User test successfully authenticated 81s PASSED 81s cas_server/tests/test_models.py::UserTestCase::test_clean_deleted_sessions 2025-10-21 21:59:19,624 INFO User test successfully authenticated 81s 2025-10-21 21:59:19,635 INFO User test successfully authenticated 81s 2025-10-21 21:59:19,645 INFO Sending SLO requests to service http://127.0.0.1:45678 for user test 81s 2025-10-21 21:59:19,651 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')) 81s PASSED 81s cas_server/tests/test_models.py::UserTestCase::test_clean_old_entries 2025-10-21 21:59:19,663 INFO User test successfully authenticated 81s PASSED 81s cas_server/tests/test_models.py::UserTestCase::test_clean_old_entries_tgt_expired 2025-10-21 21:59:19,679 INFO User test successfully authenticated 81s PASSED 81s cas_server/tests/test_models.py::TicketTestCase::test_clean_old_service_ticket 2025-10-21 21:59:19,700 INFO User test successfully authenticated 81s 2025-10-21 21:59:19,714 INFO Sending SLO requests to service http://127.0.0.1:39923 for user test 81s PASSED 81s cas_server/tests/test_models.py::TicketTestCase::test_json_attributes 2025-10-21 21:59:19,716 WARNING Error durring SLO ('Connection aborted.', RemoteDisconnected('Remote end closed connection without response')) 81s ConnectionError(ProtocolError('Connection aborted.', RemoteDisconnected('Remote end closed connection without response'))) 81s 2025-10-21 21:59:19,728 INFO User test successfully authenticated 81s PASSED 81s cas_server/tests/test_models.py::NewVersionWarningTestCase::test_send_mails PASSED 81s cas_server/tests/test_models.py::NewVersionWarningTestCase::test_send_mails_disabled PASSED 81s cas_server/tests/test_models.py::NewVersionWarningTestCase::test_send_mails_no_admins PASSED 81s cas_server/tests/test_models.py::NewVersionWarningTestCase::test_send_mails_same_version PASSED 81s cas_server/tests/test_templatetags.py::TemplateTagsTestCase::test_is_checkbox PASSED 81s cas_server/tests/test_templatetags.py::TemplateTagsTestCase::test_is_hidden PASSED 81s cas_server/tests/test_utils.py::CheckPasswordCase::test_bad_method PASSED 81s cas_server/tests/test_utils.py::CheckPasswordCase::test_crypt PASSED 81s cas_server/tests/test_utils.py::CheckPasswordCase::test_hex PASSED 81s cas_server/tests/test_utils.py::CheckPasswordCase::test_ldap_password_fail PASSED 81s cas_server/tests/test_utils.py::CheckPasswordCase::test_ldap_password_valid PASSED 81s cas_server/tests/test_utils.py::CheckPasswordCase::test_plain PASSED 81s cas_server/tests/test_utils.py::CheckPasswordCase::test_plain_unicode PASSED 81s cas_server/tests/test_utils.py::CheckPasswordCase::test_setup PASSED 81s cas_server/tests/test_utils.py::UtilsTestCase::test_crypt_salt_is_valid PASSED 81s cas_server/tests/test_utils.py::UtilsTestCase::test_dictfetchall PASSED 81s cas_server/tests/test_utils.py::UtilsTestCase::test_get_current_url PASSED 81s cas_server/tests/test_utils.py::UtilsTestCase::test_get_tuple PASSED 81s cas_server/tests/test_utils.py::UtilsTestCase::test_import_attr PASSED 82s cas_server/tests/test_utils.py::UtilsTestCase::test_last_version PASSED 82s cas_server/tests/test_utils.py::UtilsTestCase::test_regexpr_validator PASSED 82s cas_server/tests/test_utils.py::UtilsTestCase::test_update_url PASSED 82s cas_server/tests/test_view.py::LoginTestCase::test_ajax_get_ticket_fail 2025-10-21 21:59:20,769 INFO User test successfully authenticated 82s PASSED2025-10-21 21:59:20,774 WARNING Service https://www.example.org not allowed. 82s 82s cas_server/tests/test_view.py::LoginTestCase::test_ajax_get_ticket_success 2025-10-21 21:59:20,787 INFO User test successfully authenticated 82s PASSED 82s cas_server/tests/test_view.py::LoginTestCase::test_ajax_get_ticket_success_alt 2025-10-21 21:59:20,794 INFO Service ticket created for service https://www.example.com by user test. 82s PASSED 82s cas_server/tests/test_view.py::LoginTestCase::test_ajax_get_ticket_warn 2025-10-21 21:59:20,806 INFO User test successfully authenticated 82s 2025-10-21 21:59:20,813 INFO Service ticket created for service https://www.example.com by user test. 82s 2025-10-21 21:59:20,825 INFO User test successfully authenticated 82s PASSED 82s cas_server/tests/test_view.py::LoginTestCase::test_ajax_logged 2025-10-21 21:59:20,843 INFO User test successfully authenticated 82s PASSED 82s cas_server/tests/test_view.py::LoginTestCase::test_ajax_logged_user_deleted 2025-10-21 21:59:20,859 INFO User test successfully authenticated 82s 2025-10-21 21:59:20,865 WARNING User test seems authenticated but is not found in the database. 82s 2025-10-21 21:59:20,865 INFO Logging out user test. 82s 2025-10-21 21:59:20,866 INFO User test logged out 82s PASSED 82s cas_server/tests/test_view.py::LoginTestCase::test_ajax_login_required PASSED 82s cas_server/tests/test_view.py::LoginTestCase::test_gateway 2025-10-21 21:59:20,884 INFO User test successfully authenticated 82s 2025-10-21 21:59:20,889 WARNING Username test not allowed on service restrict_user_fail 82s PASSED 82s cas_server/tests/test_view.py::LoginTestCase::test_login_post_missing_params 2025-10-21 21:59:20,905 WARNING A login attempt failed 82s 2025-10-21 21:59:20,919 WARNING A login attempt failed 82s 2025-10-21 21:59:20,933 WARNING A login attempt failed 82s PASSED 82s cas_server/tests/test_view.py::LoginTestCase::test_login_view_post_badlt 2025-10-21 21:59:20,951 WARNING Received an invalid login ticket 82s PASSED 83s cas_server/tests/test_view.py::LoginTestCase::test_login_view_post_badpass_good_lt 2025-10-21 21:59:20,969 WARNING A login attempt failed 83s PASSED 83s cas_server/tests/test_view.py::LoginTestCase::test_login_view_post_goodpass_goodlt 2025-10-21 21:59:20,987 INFO User test successfully authenticated 83s PASSED 83s cas_server/tests/test_view.py::LoginTestCase::test_login_view_post_goodpass_goodlt_warn PASSED 83s cas_server/tests/test_view.py::LoginTestCase::test_lt_max 2025-10-21 21:59:21,003 INFO User test successfully authenticated 83s PASSED 83s cas_server/tests/test_view.py::LoginTestCase::test_messages_info_box_bad_messages PASSED 83s cas_server/tests/test_view.py::LoginTestCase::test_messages_info_box_disabled PASSED 83s cas_server/tests/test_view.py::LoginTestCase::test_messages_info_box_enabled PASSED 83s cas_server/tests/test_view.py::LoginTestCase::test_new_version_available_badpypi PASSED 83s cas_server/tests/test_view.py::LoginTestCase::test_new_version_available_disabled PASSED 83s cas_server/tests/test_view.py::LoginTestCase::test_new_version_available_ok PASSED 83s cas_server/tests/test_view.py::LoginTestCase::test_renew 2025-10-21 21:59:21,958 INFO User test successfully authenticated 84s 2025-10-21 21:59:21,969 INFO User test successfully authenticated 84s 2025-10-21 21:59:21,973 INFO Service ticket created for service https://www.example.com by user test. 84s PASSED 84s cas_server/tests/test_view.py::LoginTestCase::test_renew_message_disabled 2025-10-21 21:59:21,986 INFO User test successfully authenticated 84s 2025-10-21 21:59:21,997 INFO User test successfully authenticated 84s 2025-10-21 21:59:22,001 INFO Service ticket created for service https://www.example.com by user test. 84s PASSED 84s cas_server/tests/test_view.py::LoginTestCase::test_service_filter 2025-10-21 21:59:22,013 INFO User test successfully authenticated 84s 2025-10-21 21:59:22,018 WARNING User constraint failed for test, service filter_fail: ^admin$ do not match right None. 84s 2025-10-21 21:59:22,022 WARNING User constraint failed for test, service filter_fail_alt: ^toto$ do not match nom Nymous. 84s PASSED 84s cas_server/tests/test_view.py::LoginTestCase::test_service_restrict_user 2025-10-21 21:59:22,027 INFO Service ticket created for service https://filter_success.example.com by user test. 84s 2025-10-21 21:59:22,040 INFO User test successfully authenticated 84s 2025-10-21 21:59:22,045 WARNING Username test not allowed on service restrict_user_fail 84s PASSED2025-10-21 21:59:22,050 INFO Service ticket created for service https://restrict_user_success.example.com by user test. 84s 84s cas_server/tests/test_view.py::LoginTestCase::test_service_user_field 2025-10-21 21:59:22,062 INFO User test successfully authenticated 84s 2025-10-21 21:59:22,067 WARNING Cannot use uid a loggin for user test on service field_needed_fail because it is absent 84s PASSED 84s cas_server/tests/test_view.py::LoginTestCase::test_service_user_field_evaluate_to_false 2025-10-21 21:59:22,072 INFO Service ticket created for service https://field_needed_success.example.com by user test. 84s 2025-10-21 21:59:22,085 INFO User test successfully authenticated 84s 2025-10-21 21:59:22,090 WARNING Cannot use alias a loggin for user test on service field_needed_success because it is absent 84s PASSED 84s cas_server/tests/test_view.py::LoginTestCase::test_user_logged_not_in_db 2025-10-21 21:59:22,103 INFO User test successfully authenticated 84s PASSED 84s cas_server/tests/test_view.py::LoginTestCase::test_view_login_get_allowed_service 2025-10-21 21:59:22,109 WARNING User test seems authenticated but is not found in the database. 84s 2025-10-21 21:59:22,109 INFO Logging out user test. 84s 2025-10-21 21:59:22,110 INFO User test logged out 84s PASSED 84s cas_server/tests/test_view.py::LoginTestCase::test_view_login_get_allowed_service_no_message PASSED 84s cas_server/tests/test_view.py::LoginTestCase::test_view_login_get_auth_allowed_service 2025-10-21 21:59:22,143 INFO User test successfully authenticated 84s 2025-10-21 21:59:22,150 INFO Service ticket created for service https://www.example.com/é by user test. 84s PASSED 84s cas_server/tests/test_view.py::LoginTestCase::test_view_login_get_auth_allowed_service_non_ascii 2025-10-21 21:59:22,164 INFO User test successfully authenticated 84s 2025-10-21 21:59:22,170 INFO Service ticket created for service https://www.example.com by user test. 84s PASSED 84s cas_server/tests/test_view.py::LoginTestCase::test_view_login_get_auth_allowed_service_warn 2025-10-21 21:59:22,184 INFO User test successfully authenticated 84s 2025-10-21 21:59:22,194 WARNING Received a login attempt for an already-active user 84s 2025-10-21 21:59:22,197 INFO Service ticket created for service https://www.example.com by user test. 84s PASSED 84s cas_server/tests/test_view.py::LoginTestCase::test_view_login_get_auth_denied_service 2025-10-21 21:59:22,211 INFO User test successfully authenticated 84s 2025-10-21 21:59:22,216 WARNING Service https://www.example.org not allowed. 84s PASSED 84s cas_server/tests/test_view.py::LoginTestCase::test_view_login_get_denied_service 2025-10-21 21:59:22,222 WARNING Service https://www.example.net not allowed. 84s PASSED 84s cas_server/tests/test_view.py::LoginTestCase::test_view_login_get_denied_service_no_message 2025-10-21 21:59:22,233 WARNING Service https://www.example.net not allowed. 84s PASSED 84s cas_server/tests/test_view.py::LogoutTestCase::test_ajax_logout 2025-10-21 21:59:22,248 INFO User test successfully authenticated 84s 2025-10-21 21:59:22,251 INFO logout requested 84s 2025-10-21 21:59:22,252 INFO Logging out user test. 84s PASSED2025-10-21 21:59:22,256 INFO User test logged out 84s 84s cas_server/tests/test_view.py::LogoutTestCase::test_ajax_logout_all_session 2025-10-21 21:59:22,266 INFO User test successfully authenticated 84s 2025-10-21 21:59:22,276 INFO User test successfully authenticated 84s 2025-10-21 21:59:22,287 INFO User test successfully authenticated 84s 2025-10-21 21:59:22,297 INFO User test successfully authenticated 84s 2025-10-21 21:59:22,307 INFO User test successfully authenticated 84s 2025-10-21 21:59:22,317 INFO User test successfully authenticated 84s 2025-10-21 21:59:22,321 INFO logout requested 84s 2025-10-21 21:59:22,322 INFO Logging out user test from all sessions. 84s PASSED 84s cas_server/tests/test_view.py::LogoutTestCase::test_ajax_redirect_after_logout 2025-10-21 21:59:22,343 INFO User test logged out 84s 2025-10-21 21:59:22,352 INFO User test successfully authenticated 84s 2025-10-21 21:59:22,356 INFO logout requested 84s 2025-10-21 21:59:22,356 INFO Logging out user test. 84s 2025-10-21 21:59:22,360 INFO User test logged out 84s PASSED 84s cas_server/tests/test_view.py::LogoutTestCase::test_logout PASSED 84s cas_server/tests/test_view.py::LogoutTestCase::test_logout_from_all_session 2025-10-21 21:59:22,363 INFO logout requested 84s 2025-10-21 21:59:22,374 INFO User test successfully authenticated 84s 2025-10-21 21:59:22,385 INFO User test successfully authenticated 84s 2025-10-21 21:59:22,389 INFO logout requested 84s 2025-10-21 21:59:22,389 INFO Logging out user test from all sessions. 84s 2025-10-21 21:59:22,397 INFO User test logged out 84s PASSED 84s cas_server/tests/test_view.py::LogoutTestCase::test_logout_slo 2025-10-21 21:59:22,409 INFO User test successfully authenticated 84s 2025-10-21 21:59:22,417 INFO Service ticket created for service http://127.0.0.1:44483 by user test. 84s 2025-10-21 21:59:22,420 INFO Validate: Service ticket ST-XkFAvyKC1yzPJqZbRFxD96BmZQGv1I4l9yHEMbTdiKMGhYCnrlzCBoiSMBsip validated, user test authenticated on service http://127.0.0.1:44483 84s 2025-10-21 21:59:22,422 INFO logout requested 84s 2025-10-21 21:59:22,422 INFO Logging out user test. 84s 2025-10-21 21:59:22,425 INFO Sending SLO requests to service http://127.0.0.1:44483 for user test 84s 2025-10-21 21:59:22,428 WARNING Error during SLO for user test: ('Connection aborted.', RemoteDisconnected('Remote end closed connection without response')) 84s 2025-10-21 21:59:22,429 INFO User test logged out 84s 2025-10-21 21:59:22,439 INFO User test successfully authenticated 84s 2025-10-21 21:59:22,445 INFO Service ticket created for service http://127.0.0.1:45678 by user test. 84s 2025-10-21 21:59:22,449 INFO Validate: Service ticket ST-FIZw4PPH5J0kK1Jc3kgTQvQOERKGAQ2A6zcy2Uh2q2yQuxvSP8pve3Kraw3xN validated, user test authenticated on service http://127.0.0.1:45678 84s 2025-10-21 21:59:22,450 INFO logout requested 84s 2025-10-21 21:59:22,451 INFO Logging out user test. 84s 2025-10-21 21:59:22,453 INFO Sending SLO requests to service http://127.0.0.1:45678 for user test 84s 2025-10-21 21:59:22,457 WARNING Error during SLO for user test: ('Connection aborted.', RemoteDisconnected('Remote end closed connection without response')) 84s 2025-10-21 21:59:22,458 INFO User test logged out 84s 2025-10-21 21:59:22,466 INFO User test successfully authenticated 84s 2025-10-21 21:59:22,473 INFO Service ticket created for service http://127.0.0.1:45678 by user test. 84s 2025-10-21 21:59:22,476 INFO Validate: Service ticket ST-d6sJ4p0oVr9l4Ey1UUs1nS6pvsE1gBXjf4eg7tsvzpBTLHHU0ayOH5Td9sgfY validated, user test authenticated on service http://127.0.0.1:45678 84s 2025-10-21 21:59:22,478 INFO logout requested 84s 2025-10-21 21:59:22,478 INFO Logging out user test. 84s 2025-10-21 21:59:22,481 INFO Sending SLO requests to service http://127.0.0.1:45678 for user test 84s PASSED 84s cas_server/tests/test_view.py::LogoutTestCase::test_logout_view 2025-10-21 21:59:22,483 WARNING Error during SLO for user test: HTTPConnectionPool(host='127.0.0.1', port=38243): Max retries exceeded with url: / (Caused by NewConnectionError(': Failed to establish a new connection: [Errno 111] Connection refused')) 84s 2025-10-21 21:59:22,484 INFO User test logged out 84s 2025-10-21 21:59:22,495 INFO User test successfully authenticated 84s 2025-10-21 21:59:22,505 INFO User test successfully authenticated 84s 2025-10-21 21:59:22,512 INFO logout requested 84s 2025-10-21 21:59:22,513 INFO Logging out user test. 84s 2025-10-21 21:59:22,517 INFO User test logged out 84s PASSED 84s cas_server/tests/test_view.py::LogoutTestCase::test_logout_view_service 2025-10-21 21:59:22,535 INFO User test successfully authenticated 84s 2025-10-21 21:59:22,538 INFO logout requested 84s 2025-10-21 21:59:22,539 INFO Logging out user test. 84s 2025-10-21 21:59:22,543 INFO User test logged out 84s PASSED 84s cas_server/tests/test_view.py::LogoutTestCase::test_logout_view_url 2025-10-21 21:59:22,558 INFO User test successfully authenticated 84s 2025-10-21 21:59:22,562 INFO logout requested 84s 2025-10-21 21:59:22,562 INFO Logging out user test. 84s 2025-10-21 21:59:22,566 INFO User test logged out 84s PASSED 84s cas_server/tests/test_view.py::LogoutTestCase::test_redirect_after_logout 2025-10-21 21:59:22,581 INFO User test successfully authenticated 84s 2025-10-21 21:59:22,585 INFO logout requested 84s 2025-10-21 21:59:22,585 INFO Logging out user test. 84s 2025-10-21 21:59:22,589 INFO User test logged out 84s PASSED 84s cas_server/tests/test_view.py::LogoutTestCase::test_redirect_after_logout_to_service 2025-10-21 21:59:22,600 INFO User test successfully authenticated 84s 2025-10-21 21:59:22,604 INFO logout requested 84s 2025-10-21 21:59:22,604 INFO Logging out user test. 84s 2025-10-21 21:59:22,608 INFO User test logged out 84s 2025-10-21 21:59:22,615 INFO logout requested 84s PASSED 84s cas_server/tests/test_view.py::AuthTestCase::test_auth_view_badpass PASSED 84s cas_server/tests/test_view.py::AuthTestCase::test_auth_view_badsecret PASSED 84s cas_server/tests/test_view.py::AuthTestCase::test_auth_view_badservice 2025-10-21 21:59:22,633 WARNING Service https://www.example.org not allowed. 84s PASSED 84s cas_server/tests/test_view.py::AuthTestCase::test_auth_view_badsettings PASSED 84s cas_server/tests/test_view.py::AuthTestCase::test_auth_view_goodpass PASSED 84s cas_server/tests/test_view.py::AuthTestCase::test_auth_view_goodpass_logged 2025-10-21 21:59:22,651 INFO User test successfully authenticated 84s PASSED 84s cas_server/tests/test_view.py::AuthTestCase::test_auth_view_missing_parameter PASSED 84s cas_server/tests/test_view.py::ValidateTestCase::test_validate_missing_parameter 2025-10-21 21:59:22,672 INFO User test successfully authenticated 84s 2025-10-21 21:59:22,679 INFO Service ticket created for service https://www.example.com by user test. 84s 2025-10-21 21:59:22,681 WARNING Validate: service or ticket missing 84s 2025-10-21 21:59:22,681 WARNING Validate: service or ticket missing 84s PASSED 84s cas_server/tests/test_view.py::ValidateTestCase::test_validate_service_renew 2025-10-21 21:59:22,691 INFO User test successfully authenticated 84s 2025-10-21 21:59:22,695 INFO Service ticket created for service https://www.example.com by user test. 84s 2025-10-21 21:59:22,698 INFO Validate: Service ticket ST-khoKzDK5i5oPYrFIuHDKFwmQjYN2Lf8Fyxk8Kr9Ut6m29aVQJqufwUhKfDTwi validated, user test authenticated on service https://www.example.com 84s 2025-10-21 21:59:22,707 INFO User test successfully authenticated 84s 2025-10-21 21:59:22,711 INFO Service ticket created for service https://www.example.com by user test. 84s 2025-10-21 21:59:22,714 INFO Validate: Service ticket ST-7Q1ry03zVubv55fMfSWuPmlwnIOZP9XwGBHJEZ1NilZuSSjJmKFjQyzgv6cup validated, user test authenticated on service https://www.example.com 84s 2025-10-21 21:59:22,718 INFO Service ticket created for service https://www.example.com by user test. 84s PASSED 84s cas_server/tests/test_view.py::ValidateTestCase::test_validate_user_field_ok 2025-10-21 21:59:22,720 WARNING Validate: Service ticket ST-FHkB8ScK2beFG2J4nDupCM6sip1nZV0fAAdoQGXx0AsZFPs9Z5ZbizP4Hi8Ai not found or already validated, auth to https://www.example.com failed 84s 2025-10-21 21:59:22,730 INFO User test successfully authenticated 84s 2025-10-21 21:59:22,737 INFO Service ticket created for service https://user_field.example.com by user test. 84s 2025-10-21 21:59:22,740 INFO Validate: Service ticket ST-5RcupdyGEQUvYULy0BPNFvJv21uatpAGmpmaDnaq0mc1ZZnP3P5Y6RjJgFSw0 validated, user test authenticated on service https://user_field.example.com 84s 2025-10-21 21:59:22,748 INFO User test successfully authenticated 84s 2025-10-21 21:59:22,755 INFO Service ticket created for service https://user_field_alt.example.com by user test. 84s 2025-10-21 21:59:22,758 INFO Validate: Service ticket ST-JjTqtOx5osly0kbNb76pk7VUv9CfninNjlFJE9iew6xeBKij3cyF2WLxCsPmO validated, user test authenticated on service https://user_field_alt.example.com 84s PASSED 84s cas_server/tests/test_view.py::ValidateTestCase::test_validate_view_badservice 2025-10-21 21:59:22,768 INFO User test successfully authenticated 84s 2025-10-21 21:59:22,775 INFO Service ticket created for service https://www.example.com by user test. 84s 2025-10-21 21:59:22,778 WARNING Validate: Service ticket ST-nnY9AJHV5AeLaUDEontNFdG986mYBrrndLZfhf4B48ls4GK3aAD5PEVDxjfOb not found or already validated, auth to https://www.example.org failed 84s PASSED 84s cas_server/tests/test_view.py::ValidateTestCase::test_validate_view_badticket 2025-10-21 21:59:22,787 INFO User test successfully authenticated 84s 2025-10-21 21:59:22,794 INFO Service ticket created for service https://www.example.com by user test. 84s PASSED 84s cas_server/tests/test_view.py::ValidateTestCase::test_validate_view_ok 2025-10-21 21:59:22,797 WARNING Validate: Service ticket ST-RANDOM not found or already validated, auth to https://www.example.com failed 84s 2025-10-21 21:59:22,806 INFO User test successfully authenticated 84s 2025-10-21 21:59:22,814 INFO Service ticket created for service https://www.example.com by user test. 84s 2025-10-21 21:59:22,817 INFO Validate: Service ticket ST-WhJqP4AGK31qLOgnwuSBu8SuxJJs9CqFAVa4ygY1IhPoFfgkV1X4rfrP0UqYT validated, user test authenticated on service https://www.example.com 84s PASSED 84s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_missing_parameter 2025-10-21 21:59:22,830 INFO User test successfully authenticated 84s 2025-10-21 21:59:22,837 INFO Service ticket created for service http://127.0.0.1:45678 by user test. 84s 2025-10-21 21:59:22,839 WARNING ValidateService: missing ticket or service 84s 2025-10-21 21:59:22,840 WARNING ValidateService: missing ticket or service 84s PASSED 84s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_proxy 2025-10-21 21:59:22,854 INFO User test successfully authenticated 84s 2025-10-21 21:59:22,860 INFO Service ticket created for service http://127.0.0.1:36587 by user test. 84s 2025-10-21 21:59:22,868 INFO ValidateService: ticket ST-D3Rzu9yn8AvMfJrHwCbtPr6MiaJz27frI5snnDpw20DUbvSdgBIB2A0Oj2VcE validated for user test on service http://127.0.0.1:36587. Proxy Granting Ticket transmited to http://127.0.0.1:36587. 84s 2025-10-21 21:59:22,873 INFO Proxy ticket created for user test on service http://127.0.0.1:45678. 84s 2025-10-21 21:59:22,877 INFO ValidateService: ticket PT-2QuIXpIklid25brtxsJo1fHauHMuEbFgmcsAV1iIPwFSNqExjUaEIRFm05ja2 validated for user test on service http://127.0.0.1:45678. 84s 2025-10-21 21:59:22,886 INFO User test successfully authenticated 84s 2025-10-21 21:59:22,894 INFO Service ticket created for service http://127.0.0.1:41713 by user test. 84s 2025-10-21 21:59:22,900 INFO ValidateService: ticket ST-pZKz4Hd76CzZVVu97K5chUTN7m8c07016NKTgWOq2M0W7zL5uWHhxNrHv8LtN validated for user test on service http://127.0.0.1:41713. Proxy Granting Ticket transmited to http://127.0.0.1:41713. 84s PASSED 84s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_replace_attributes 2025-10-21 21:59:22,905 INFO Proxy ticket created for user test on service http://127.0.0.1:45678. 84s 2025-10-21 21:59:22,906 WARNING ValidateService: validation error: INVALID_TICKET PT-9eSx6GCNc7Asq9JVoNAQrCgGBR9H8yAeBZebEHE7FVrIF6qxjZjK81jNhBkzE 84s 2025-10-21 21:59:22,918 INFO User test successfully authenticated 84s 2025-10-21 21:59:22,925 INFO Service ticket created for service https://replace_attribute.example.com by user test. 84s 2025-10-21 21:59:22,929 INFO ValidateService: ticket ST-XF8vnJ4KXGn3dPpeiExAzM2kRgtiJQgifmp30fbcynxnSrhIbAbvalsbauGA8 validated for user test on service https://replace_attribute.example.com. 84s 2025-10-21 21:59:22,937 INFO User test successfully authenticated 84s PASSED 84s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_service_pgturl_404 2025-10-21 21:59:22,944 INFO Service ticket created for service https://replace_attribute_list.example.com by user test. 84s 2025-10-21 21:59:22,948 INFO ValidateService: ticket ST-7Azqh4zWyGeZeiECYhNP51mhHTiq9jd6cl23htNPMZejmNWnX750mVdqwemmY validated for user test on service https://replace_attribute_list.example.com. 84s 2025-10-21 21:59:22,960 INFO User test successfully authenticated 85s 2025-10-21 21:59:22,967 INFO Service ticket created for service http://127.0.0.1:39065 by user test. 85s 2025-10-21 21:59:22,974 INFO ValidateService: ticket ST-uRq9BhsvLdy62psXtqt31IXe5g6jWOCJmlZTG3AfJlyHVXCksIygxQ9RDTTUa validated for user test on service http://127.0.0.1:39065. Proxy Granting Ticket transmited to http://127.0.0.1:39065. 85s PASSED 85s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_service_pgturl_bad_proxy_callback 2025-10-21 21:59:22,988 INFO User test successfully authenticated 85s 2025-10-21 21:59:22,995 INFO Service ticket created for service http://127.0.0.1:45678 by user test. 85s 2025-10-21 21:59:22,999 WARNING ValidateService: validation error: INVALID_PROXY_CALLBACK callback url not allowed by configuration 85s 2025-10-21 21:59:23,006 INFO User test successfully authenticated 85s 2025-10-21 21:59:23,013 INFO Service ticket created for service http://127.0.0.1:45678 by user test. 85s PASSED 85s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_service_pgturl_sslerror 2025-10-21 21:59:23,017 WARNING Service https://www.example.org not allowed. 85s 2025-10-21 21:59:23,017 WARNING ValidateService: validation error: INVALID_PROXY_CALLBACK callback url not allowed by configuration 85s 2025-10-21 21:59:23,031 INFO User test successfully authenticated 85s 2025-10-21 21:59:23,038 INFO Service ticket created for service https://127.0.0.1:35277 by user test. 85s 2025-10-21 21:59:23,044 WARNING ValidateService: validation error: INVALID_PROXY_CALLBACK : HTTPSConnectionPool(host='127.0.0.1', port=35277): Max retries exceeded with url: /?pgtId=PGT-mdAQDB37EDHrqHA1EhzUGHNh9uglOWmMI9qCKNplGu4GZE8Md1vGcLoxEDIJ&pgtIou=PGTIOU-7kJkxWl2p4ikuogrOp5Ujej0B1K5OkNw8qb8PRH0ELPt540QtD2BzEUjz (Caused by SSLError(SSLError(1, '[SSL: RECORD_LAYER_FAILURE] record layer failure (_ssl.c:1033)'))) 85s PASSED 85s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_service_renew 2025-10-21 21:59:23,056 INFO User test successfully authenticated 85s 2025-10-21 21:59:23,060 INFO Service ticket created for service http://127.0.0.1:45678 by user test. 85s 2025-10-21 21:59:23,064 INFO ValidateService: ticket ST-hL6oYG7GdfczFZzS6UyZFw2EJXkTetVACYyEoxOxKHC03Eh2dcuk2iKBR3UrT validated for user test on service http://127.0.0.1:45678. 85s 2025-10-21 21:59:23,072 INFO User test successfully authenticated 85s 2025-10-21 21:59:23,076 INFO Service ticket created for service http://127.0.0.1:45678 by user test. 85s 2025-10-21 21:59:23,079 INFO ValidateService: ticket ST-sMTaQm6MyEtNa6phvuFPzROqWFhdvm6UysFzR6SMWZvsKm0SSJBM7xdS4k3oI validated for user test on service http://127.0.0.1:45678. 85s 2025-10-21 21:59:23,084 INFO Service ticket created for service http://127.0.0.1:45678 by user test. 85s 2025-10-21 21:59:23,086 WARNING ValidateService: validation error: INVALID_TICKET ticket not found 85s PASSED 85s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_service_view_badservice 2025-10-21 21:59:23,097 INFO User test successfully authenticated 85s 2025-10-21 21:59:23,104 INFO Service ticket created for service http://127.0.0.1:45678 by user test. 85s PASSED 85s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_service_view_badticket_badprefix 2025-10-21 21:59:23,107 WARNING ValidateService: validation error: INVALID_SERVICE https://www.example.org 85s 2025-10-21 21:59:23,118 INFO User test successfully authenticated 85s 2025-10-21 21:59:23,125 INFO Service ticket created for service http://127.0.0.1:45678 by user test. 85s PASSED 85s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_service_view_badticket_goodprefix 2025-10-21 21:59:23,127 WARNING ValidateService: validation error: INVALID_TICKET RANDOM 85s 2025-10-21 21:59:23,138 INFO User test successfully authenticated 85s PASSED 85s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_service_view_ok 2025-10-21 21:59:23,145 INFO Service ticket created for service http://127.0.0.1:45678 by user test. 85s 2025-10-21 21:59:23,148 WARNING ValidateService: validation error: INVALID_TICKET ticket not found 85s 2025-10-21 21:59:23,159 INFO User test successfully authenticated 85s 2025-10-21 21:59:23,166 INFO Service ticket created for service http://127.0.0.1:45678 by user test. 85s PASSED 85s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_service_view_ok_one_attribute 2025-10-21 21:59:23,169 INFO ValidateService: ticket ST-Z4EnzahSnzKTMW6xEXr5YkeASDFv5YiJdR7JUQP9w1iKbdF62JoGwx5zYsnBu validated for user test on service http://127.0.0.1:45678. 85s 2025-10-21 21:59:23,181 INFO User test successfully authenticated 85s 2025-10-21 21:59:23,188 INFO Service ticket created for service https://one_attribute.example.com by user test. 85s 2025-10-21 21:59:23,192 INFO ValidateService: ticket ST-4zJNrlbFO12YH3QqKzkNIdcCliw1muil40drc9CMg6yDsiZPXegJGCYBu8xDm validated for user test on service https://one_attribute.example.com. 85s PASSED 85s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_service_view_ok_pgturl 2025-10-21 21:59:23,205 INFO User test successfully authenticated 85s 2025-10-21 21:59:23,212 INFO Service ticket created for service http://127.0.0.1:41375 by user test. 85s 2025-10-21 21:59:23,218 INFO ValidateService: ticket ST-JAHuzC8VwRpXAMVU8V4Ze4cZUPQ2X0jNmEyd0CCo22ywUWfDYmkV2jrtrqydH validated for user test on service http://127.0.0.1:41375. Proxy Granting Ticket transmited to http://127.0.0.1:41375. 85s PASSED 85s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_user_field_ok 2025-10-21 21:59:23,231 INFO User test successfully authenticated 85s 2025-10-21 21:59:23,238 INFO Service ticket created for service https://user_field.example.com by user test. 85s 2025-10-21 21:59:23,241 INFO ValidateService: ticket ST-HFkXs0mRGpIJV2PnDVeUBG2SFzTPzvES0GKRCGX3KxN4o2yrw7jM0Wr1VU381 validated for user test on service https://user_field.example.com. 85s 2025-10-21 21:59:23,249 INFO User test successfully authenticated 85s 2025-10-21 21:59:23,256 INFO Service ticket created for service https://user_field_alt.example.com by user test. 85s PASSED 85s cas_server/tests/test_view.py::ProxyTestCase::test_proxy_missing_parameter 2025-10-21 21:59:23,259 INFO ValidateService: ticket ST-bd84WZ2JJpLWdiHHTzulI44oyQkJiDagvbsL8Yy7kZ0qlyje8pE1x0qmHoC87 validated for user test on service https://user_field_alt.example.com. 85s 2025-10-21 21:59:23,275 INFO User test successfully authenticated 85s 2025-10-21 21:59:23,281 INFO Service ticket created for service http://127.0.0.1:40573 by user test. 85s 2025-10-21 21:59:23,288 INFO ValidateService: ticket ST-pmY1iFv0sm92rYQl1LF1mRKIw7PonjL6Nh9Rs8ZaoBctYUnWfr5SDcgqFpWwK validated for user test on service http://127.0.0.1:40573. Proxy Granting Ticket transmited to http://127.0.0.1:40573. 85s PASSED 85s cas_server/tests/test_view.py::ProxyTestCase::test_proxy_unauthorized_user 2025-10-21 21:59:23,289 WARNING Proxy: validation error: INVALID_REQUEST you must specify and pgt and targetService 85s 2025-10-21 21:59:23,290 WARNING Proxy: validation error: INVALID_REQUEST you must specify and pgt and targetService 85s 2025-10-21 21:59:23,303 INFO User test successfully authenticated 85s 2025-10-21 21:59:23,312 INFO Service ticket created for service http://127.0.0.1:42159 by user test. 85s 2025-10-21 21:59:23,319 INFO ValidateService: ticket ST-POkVypuESVVMfUFSLeQ6ceKepE1E3y6gjw3bUiFOnTzIswYV5NzGDMIo1lTYV validated for user test on service http://127.0.0.1:42159. Proxy Granting Ticket transmited to http://127.0.0.1:42159. 85s 2025-10-21 21:59:23,322 WARNING Username test not allowed on service restrict_user_fail 85s 2025-10-21 21:59:23,322 WARNING Proxy: validation error: UNAUTHORIZED_USER User test not allowed on https://restrict_user_fail.example.com 85s 2025-10-21 21:59:23,324 WARNING User constraint failed for test, service filter_fail: ^admin$ do not match right None. 85s 2025-10-21 21:59:23,325 WARNING Proxy: validation error: UNAUTHORIZED_USER User test not allowed on https://filter_fail.example.com 85s PASSED 85s cas_server/tests/test_view.py::ProxyTestCase::test_validate_proxy_bad_pgt 2025-10-21 21:59:23,327 WARNING Cannot use uid a loggin for user test on service field_needed_fail because it is absent 85s 2025-10-21 21:59:23,327 WARNING Proxy: validation error: UNAUTHORIZED_USER User test not allowed on https://field_needed_fail.example.com 85s 2025-10-21 21:59:23,341 INFO User test successfully authenticated 85s 2025-10-21 21:59:23,348 INFO Service ticket created for service http://127.0.0.1:43727 by user test. 85s 2025-10-21 21:59:23,355 INFO ValidateService: ticket ST-ur4q3ni7doqCOuKtEjhyh6DsKgciDBOoMXmSK1vg59W9siqAqp4S0gQvnxtdp validated for user test on service http://127.0.0.1:43727. Proxy Granting Ticket transmited to http://127.0.0.1:43727. 85s 2025-10-21 21:59:23,357 WARNING Proxy: validation error: INVALID_TICKET PGT PGT-RANDOM not found 85s PASSED 85s cas_server/tests/test_view.py::ProxyTestCase::test_validate_proxy_bad_service 2025-10-21 21:59:23,370 INFO User test successfully authenticated 85s 2025-10-21 21:59:23,377 INFO Service ticket created for service http://127.0.0.1:32997 by user test. 85s 2025-10-21 21:59:23,383 INFO ValidateService: ticket ST-nowuvUUAQgJVcb5FWmHvFOvnQqRtXA4iLmBVSRk3lBdMgRBrVQjbMx0fW2ilp validated for user test on service http://127.0.0.1:32997. Proxy Granting Ticket transmited to http://127.0.0.1:32997. 85s 2025-10-21 21:59:23,385 WARNING Service https://www.example.org not allowed. 85s 2025-10-21 21:59:23,385 WARNING Proxy: validation error: UNAUTHORIZED_SERVICE https://www.example.org 85s 2025-10-21 21:59:23,387 WARNING Proxy: validation error: UNAUTHORIZED_SERVICE the service http://127.0.0.1:32997 does not allow proxy tickets 85s PASSED 85s cas_server/tests/test_view.py::ProxyTestCase::test_validate_proxy_ok 2025-10-21 21:59:23,400 INFO User test successfully authenticated 85s 2025-10-21 21:59:23,407 INFO Service ticket created for service http://127.0.0.1:46593 by user test. 85s 2025-10-21 21:59:23,414 INFO ValidateService: ticket ST-C9zF5XiE62ZvzvG0BdrPdi22cpdujLwQt05iolJLYFTbThviYbZBBI9TLn3Z8 validated for user test on service http://127.0.0.1:46593. Proxy Granting Ticket transmited to http://127.0.0.1:46593. 85s 2025-10-21 21:59:23,419 INFO Proxy ticket created for user test on service https://www.example.com. 85s 2025-10-21 21:59:23,422 INFO ValidateService: ticket PT-GK17oHc0IW2Gb5t1UrnrgiZIgW33EOjRV7ex4FQhvslYiN0suU0MdJ1bEm8iM validated for user test on service https://www.example.com. 85s PASSED 85s cas_server/tests/test_view.py::SamlValidateTestCase::test_saml_bad_target 2025-10-21 21:59:23,436 INFO User test successfully authenticated 85s 2025-10-21 21:59:23,443 INFO Service ticket created for service https://www.example.com by user test. 85s 2025-10-21 21:59:23,447 WARNING SamlValidate: validation error: AuthnFailed TARGET https://www.example.org does not match ticket service 85s PASSED 85s cas_server/tests/test_view.py::SamlValidateTestCase::test_saml_bad_ticket 2025-10-21 21:59:23,453 WARNING SamlValidate: validation error: AuthnFailed ticket ST-fO4ck9mzRz62Xic4yBk8wXQUnBOG2SPaoZUSlzczOydlfcnGdZ8i6GidypPw6 not found 85s 2025-10-21 21:59:23,455 WARNING SamlValidate: validation error: AuthnFailed ticket PT-dzqG7T58Fjbxy1YRU8vYqRVxg6CFJmO6JrnbJj3PhRtuGfUwXqnBeKCnNPzXc not found 85s PASSED 85s cas_server/tests/test_view.py::SamlValidateTestCase::test_saml_bad_ticket_prefix PASSED 85s cas_server/tests/test_view.py::SamlValidateTestCase::test_saml_bad_xml 2025-10-21 21:59:23,460 WARNING SamlValidate: validation error: AuthnFailed ticket RANDOM-NOT-BEGINING-WITH-ST-OR-ST should begin with PT- or ST- 85s PASSED 85s cas_server/tests/test_view.py::SamlValidateTestCase::test_saml_ok 2025-10-21 21:59:23,465 WARNING SamlValidate: validation error: VersionMismatch 85s 2025-10-21 21:59:23,478 INFO User test successfully authenticated 85s 2025-10-21 21:59:23,484 INFO Service ticket created for service https://www.example.com by user test. 85s 2025-10-21 21:59:23,495 INFO User test successfully authenticated 85s 2025-10-21 21:59:23,501 INFO Service ticket created for service http://127.0.0.1:42883 by user test. 85s 2025-10-21 21:59:23,508 INFO ValidateService: ticket ST-iLX3ON66vRFJ29mBdzJrUHSYMhUegVphjAl4BHAHwU2XWZSLhSKPNdyMxy7WM validated for user test on service http://127.0.0.1:42883. Proxy Granting Ticket transmited to http://127.0.0.1:42883. 85s 2025-10-21 21:59:23,513 INFO Proxy ticket created for user test on service https://www.example.com. 85s 2025-10-21 21:59:23,516 INFO SamlValidate: ticket ST-QFocIg7coi2lXc7QNAbsGN8K3papqQv1XSV1JIsdsDvrhzaDDJ00paJXTj0Ip validated for user test on service https://www.example.com. 85s 2025-10-21 21:59:23,519 INFO SamlValidate: ticket PT-0PmqWbbjbr18aggSiNx7YZqrnnQc4KigdI7ot45vHaJbCEqjIQzlvk9fhnzOZ validated for user test on service https://www.example.com. 85s PASSED 85s cas_server/tests/test_view.py::SamlValidateTestCase::test_saml_ok_user_field 2025-10-21 21:59:23,533 INFO User test successfully authenticated 85s 2025-10-21 21:59:23,539 INFO Service ticket created for service https://field_needed_success.example.com by user test. 85s 2025-10-21 21:59:23,543 INFO SamlValidate: ticket ST-Fjs4p6RFnaPgzz4uSSzNdAIDUS2LrEgH7a2z07CKTfZ4wEZBKomTmiZC1Ar67 validated for user test on service https://field_needed_success.example.com. 85s 2025-10-21 21:59:23,551 INFO User test successfully authenticated 85s 2025-10-21 21:59:23,557 INFO Service ticket created for service https://field_needed_success_alt.example.com by user test. 85s 2025-10-21 21:59:23,561 INFO SamlValidate: ticket ST-xviLdpbxswV7OrMcJCeDMQYulMtAQgoYUfsI3YnMWDfzDQxKQLtJDsE8rYKIE validated for user test on service https://field_needed_success_alt.example.com. 85s Destroying test database for alias 'default'... 85s PASSED 85s 85s =============================== warnings summary =============================== 85s cas_server/tests/test_federate.py: 8 warnings 85s cas_server/tests/test_view.py: 3 warnings 85s /tmp/autopkgtest.9ue7Sp/autopkgtest_tmp/cas_server/utils.py:211: 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). 85s datetime.utcnow() + timedelta(seconds=max_age), 85s 85s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_login_post_provider 85s /usr/lib/python3.13/unittest/case.py:707: DeprecationWarning: It is deprecated to return a value that is not None from a test case (>) 85s return self.run(*args, **kwds) 85s 85s -- Docs: https://docs.pytest.org/en/stable/how-to/capture-warnings.html 85s ======================= 128 passed, 12 warnings in 6.61s ======================= 85s 86s autopkgtest [21:59:24]: test run-test-suite.sh: -----------------------] 86s autopkgtest [21:59:24]: test run-test-suite.sh: - - - - - - - - - - results - - - - - - - - - - 86s run-test-suite.sh PASS 87s autopkgtest [21:59:25]: @@@@@@@@@@@@@@@@@@@@ summary 87s run-test-suite.sh PASS