0s autopkgtest [12:16:16]: starting date and time: 2025-10-26 12:16:16+0000 0s autopkgtest [12:16:16]: git checkout: 4b346b80 nova: make wait_reboot return success even when a no-op 0s autopkgtest [12:16:16]: host juju-7f2275-prod-proposed-migration-environment-20; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.7_apnz2w/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:python3-defaults --apt-upgrade django-cas-server --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=python3-defaults/3.13.7-2 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-20@bos03-arm64-2.secgroup --name adt-resolute-arm64-django-cas-server-20251026-121616-juju-7f2275-prod-proposed-migration-environment-20-9b0d8e75-e346-4bda-a018-2d116c2046d2 --image adt/ubuntu-resolute-arm64-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-20 --net-id=net_prod-proposed-migration -e TERM=linux --mirror=http://ftpmaster.internal/ubuntu/ 3s Creating nova instance adt-resolute-arm64-django-cas-server-20251026-121616-juju-7f2275-prod-proposed-migration-environment-20-9b0d8e75-e346-4bda-a018-2d116c2046d2 from image adt/ubuntu-resolute-arm64-server-20251026.img (UUID fa7cbcb5-9100-4899-a7ce-c330a9621a0a)... 60s autopkgtest [12:17:16]: testbed dpkg architecture: arm64 60s autopkgtest [12:17:16]: testbed apt version: 3.1.8ubuntu1 61s autopkgtest [12:17:17]: @@@@@@@@@@@@@@@@@@@@ test bed setup 61s autopkgtest [12:17:17]: testbed release detected to be: None 61s autopkgtest [12:17:17]: updating testbed package index (apt update) 62s Get:1 http://ftpmaster.internal/ubuntu resolute-proposed InRelease [87.8 kB] 62s Hit:2 http://ftpmaster.internal/ubuntu resolute InRelease 62s Hit:3 http://ftpmaster.internal/ubuntu resolute-updates InRelease 62s Hit:4 http://ftpmaster.internal/ubuntu resolute-security InRelease 62s Get:5 http://ftpmaster.internal/ubuntu resolute-proposed/universe Sources [422 kB] 63s Get:6 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse Sources [16.5 kB] 63s Get:7 http://ftpmaster.internal/ubuntu resolute-proposed/restricted Sources [5028 B] 63s Get:8 http://ftpmaster.internal/ubuntu resolute-proposed/main Sources [61.7 kB] 63s Get:9 http://ftpmaster.internal/ubuntu resolute-proposed/main arm64 Packages [149 kB] 63s Get:10 http://ftpmaster.internal/ubuntu resolute-proposed/main arm64 c-n-f Metadata [3312 B] 63s Get:11 http://ftpmaster.internal/ubuntu resolute-proposed/restricted arm64 Packages [44.3 kB] 63s Get:12 http://ftpmaster.internal/ubuntu resolute-proposed/restricted arm64 c-n-f Metadata [324 B] 63s Get:13 http://ftpmaster.internal/ubuntu resolute-proposed/universe arm64 Packages [295 kB] 63s Get:14 http://ftpmaster.internal/ubuntu resolute-proposed/universe arm64 c-n-f Metadata [8284 B] 63s Get:15 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse arm64 Packages [5840 B] 63s Get:16 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse arm64 c-n-f Metadata [376 B] 64s Fetched 1100 kB in 1s (914 kB/s) 65s Reading package lists... 66s Hit:1 http://ftpmaster.internal/ubuntu resolute-proposed InRelease 66s Hit:2 http://ftpmaster.internal/ubuntu resolute InRelease 66s Hit:3 http://ftpmaster.internal/ubuntu resolute-updates InRelease 66s Hit:4 http://ftpmaster.internal/ubuntu resolute-security InRelease 67s Reading package lists... 67s Reading package lists... 67s Building dependency tree... 67s Reading state information... 67s Calculating upgrade... 68s The following packages will be upgraded: 68s libpython3-stdlib python3 python3-minimal 68s 3 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 68s Need to get 62.4 kB of archives. 68s After this operation, 0 B of additional disk space will be used. 68s Get:1 http://ftpmaster.internal/ubuntu resolute-proposed/main arm64 python3-minimal arm64 3.13.7-2 [27.8 kB] 68s Get:2 http://ftpmaster.internal/ubuntu resolute-proposed/main arm64 python3 arm64 3.13.7-2 [23.9 kB] 68s Get:3 http://ftpmaster.internal/ubuntu resolute-proposed/main arm64 libpython3-stdlib arm64 3.13.7-2 [10.6 kB] 68s dpkg-preconfigure: unable to re-open stdin: No such file or directory 69s Fetched 62.4 kB in 0s (211 kB/s) 69s (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 ... 83380 files and directories currently installed.) 69s Preparing to unpack .../python3-minimal_3.13.7-2_arm64.deb ... 69s Unpacking python3-minimal (3.13.7-2) over (3.13.7-1) ... 69s Setting up python3-minimal (3.13.7-2) ... 69s (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 ... 83380 files and directories currently installed.) 69s Preparing to unpack .../python3_3.13.7-2_arm64.deb ... 69s running python pre-rtupdate hooks for python3.13... 69s Unpacking python3 (3.13.7-2) over (3.13.7-1) ... 70s Preparing to unpack .../libpython3-stdlib_3.13.7-2_arm64.deb ... 70s Unpacking libpython3-stdlib:arm64 (3.13.7-2) over (3.13.7-1) ... 70s Setting up libpython3-stdlib:arm64 (3.13.7-2) ... 70s Setting up python3 (3.13.7-2) ... 70s running python rtupdate hooks for python3.13... 70s running python post-rtupdate hooks for python3.13... 70s Processing triggers for man-db (2.13.1-1) ... 71s autopkgtest [12:17:27]: upgrading testbed (apt dist-upgrade and autopurge) 71s Reading package lists... 71s Building dependency tree... 71s Reading state information... 72s Calculating upgrade... 72s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 72s Reading package lists... 72s Building dependency tree... 72s Reading state information... 73s Solving dependencies... 73s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 76s autopkgtest [12:17:32]: testbed running kernel: Linux 6.17.0-5-generic #5-Ubuntu SMP PREEMPT_DYNAMIC Mon Sep 22 09:50:31 UTC 2025 76s autopkgtest [12:17:32]: @@@@@@@@@@@@@@@@@@@@ apt-source django-cas-server 79s Get:1 http://ftpmaster.internal/ubuntu resolute/universe django-cas-server 2.1.0-3 (dsc) [2597 B] 79s Get:2 http://ftpmaster.internal/ubuntu resolute/universe django-cas-server 2.1.0-3 (tar) [138 kB] 79s Get:3 http://ftpmaster.internal/ubuntu resolute/universe django-cas-server 2.1.0-3 (diff) [10.2 kB] 79s gpgv: Signature made Sat Dec 14 20:43:18 2024 UTC 79s gpgv: using RSA key 8F6DE104377F3B11E741748731F3144544A1741A 79s gpgv: issuer "tchet@debian.org" 79s gpgv: Can't check signature: No public key 79s dpkg-source: warning: cannot verify inline signature for ./django-cas-server_2.1.0-3.dsc: no acceptable signature found 79s autopkgtest [12:17:35]: testing package django-cas-server version 2.1.0-3 80s autopkgtest [12:17:36]: build not needed 83s autopkgtest [12:17:39]: test run-test-suite.sh: preparing testbed 83s Reading package lists... 83s Building dependency tree... 83s Reading state information... 83s Solving dependencies... 84s The following NEW packages will be installed: 84s fonts-font-awesome fonts-lato libjs-jquery libjs-sphinxdoc libjs-underscore 84s libpython3.14-minimal libpython3.14-stdlib libxslt1.1 python3-all 84s python3-asgiref python3-django python3-django-cas-server 84s python3-django-cas-server-doc python3-iniconfig python3-legacy-cgi 84s python3-lxml python3-packaging python3-pluggy python3-pytest 84s python3-pytest-django python3-requests-futures python3-sqlparse python3.14 84s python3.14-minimal sphinx-rtd-theme-common 84s 0 upgraded, 25 newly installed, 0 to remove and 0 not upgraded. 84s Need to get 17.5 MB of archives. 84s After this operation, 83.9 MB of additional disk space will be used. 84s Get:1 http://ftpmaster.internal/ubuntu resolute/main arm64 fonts-lato all 2.015-1 [2781 kB] 85s Get:2 http://ftpmaster.internal/ubuntu resolute/main arm64 libpython3.14-minimal arm64 3.14.0-4 [903 kB] 85s Get:3 http://ftpmaster.internal/ubuntu resolute/main arm64 python3.14-minimal arm64 3.14.0-4 [2543 kB] 85s Get:4 http://ftpmaster.internal/ubuntu resolute/main arm64 fonts-font-awesome all 5.0.10+really4.7.0~dfsg-4.1 [516 kB] 85s Get:5 http://ftpmaster.internal/ubuntu resolute/main arm64 libjs-jquery all 3.6.1+dfsg+~3.5.14-1 [328 kB] 85s Get:6 http://ftpmaster.internal/ubuntu resolute/main arm64 libjs-underscore all 1.13.4~dfsg+~1.11.4-3 [118 kB] 85s Get:7 http://ftpmaster.internal/ubuntu resolute/main arm64 libjs-sphinxdoc all 8.2.3-1ubuntu2 [28.0 kB] 85s Get:8 http://ftpmaster.internal/ubuntu resolute/main arm64 libpython3.14-stdlib arm64 3.14.0-4 [2349 kB] 85s Get:9 http://ftpmaster.internal/ubuntu resolute/main arm64 libxslt1.1 arm64 1.1.43-0.1 [171 kB] 85s Get:10 http://ftpmaster.internal/ubuntu resolute/main arm64 python3.14 arm64 3.14.0-4 [805 kB] 85s Get:11 http://ftpmaster.internal/ubuntu resolute-proposed/main arm64 python3-all arm64 3.13.7-2 [890 B] 85s Get:12 http://ftpmaster.internal/ubuntu resolute/main arm64 python3-asgiref all 3.9.1-2 [24.9 kB] 85s Get:13 http://ftpmaster.internal/ubuntu resolute/main arm64 python3-sqlparse all 0.5.3-1 [32.9 kB] 85s Get:14 http://ftpmaster.internal/ubuntu resolute/main arm64 python3-django all 3:5.2.4-1ubuntu2 [3036 kB] 85s Get:15 http://ftpmaster.internal/ubuntu resolute/main arm64 python3-legacy-cgi all 2.6.3-1 [16.8 kB] 85s Get:16 http://ftpmaster.internal/ubuntu resolute/main arm64 python3-lxml arm64 6.0.1-1build1 [2149 kB] 85s Get:17 http://ftpmaster.internal/ubuntu resolute/universe arm64 python3-requests-futures all 1.0.2-1 [12.0 kB] 85s Get:18 http://ftpmaster.internal/ubuntu resolute/universe arm64 python3-django-cas-server all 2.1.0-3 [111 kB] 85s Get:19 http://ftpmaster.internal/ubuntu resolute/main arm64 sphinx-rtd-theme-common all 3.0.2+dfsg-3 [1013 kB] 85s Get:20 http://ftpmaster.internal/ubuntu resolute/universe arm64 python3-django-cas-server-doc all 2.1.0-3 [178 kB] 85s Get:21 http://ftpmaster.internal/ubuntu resolute/universe arm64 python3-iniconfig all 1.1.1-2 [6024 B] 85s Get:22 http://ftpmaster.internal/ubuntu resolute/main arm64 python3-packaging all 25.0-1 [52.8 kB] 85s Get:23 http://ftpmaster.internal/ubuntu resolute/universe arm64 python3-pluggy all 1.6.0-1 [21.0 kB] 85s Get:24 http://ftpmaster.internal/ubuntu resolute/universe arm64 python3-pytest all 8.3.5-2 [252 kB] 85s Get:25 http://ftpmaster.internal/ubuntu resolute/universe arm64 python3-pytest-django all 4.11.1-2 [21.8 kB] 86s Fetched 17.5 MB in 2s (11.2 MB/s) 86s Selecting previously unselected package fonts-lato. 86s (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 ... 83380 files and directories currently installed.) 86s Preparing to unpack .../00-fonts-lato_2.015-1_all.deb ... 86s Unpacking fonts-lato (2.015-1) ... 86s Selecting previously unselected package libpython3.14-minimal:arm64. 86s Preparing to unpack .../01-libpython3.14-minimal_3.14.0-4_arm64.deb ... 86s Unpacking libpython3.14-minimal:arm64 (3.14.0-4) ... 86s Selecting previously unselected package python3.14-minimal. 86s Preparing to unpack .../02-python3.14-minimal_3.14.0-4_arm64.deb ... 86s Unpacking python3.14-minimal (3.14.0-4) ... 86s Selecting previously unselected package fonts-font-awesome. 86s Preparing to unpack .../03-fonts-font-awesome_5.0.10+really4.7.0~dfsg-4.1_all.deb ... 86s Unpacking fonts-font-awesome (5.0.10+really4.7.0~dfsg-4.1) ... 86s Selecting previously unselected package libjs-jquery. 86s Preparing to unpack .../04-libjs-jquery_3.6.1+dfsg+~3.5.14-1_all.deb ... 86s Unpacking libjs-jquery (3.6.1+dfsg+~3.5.14-1) ... 86s Selecting previously unselected package libjs-underscore. 86s Preparing to unpack .../05-libjs-underscore_1.13.4~dfsg+~1.11.4-3_all.deb ... 86s Unpacking libjs-underscore (1.13.4~dfsg+~1.11.4-3) ... 86s Selecting previously unselected package libjs-sphinxdoc. 86s Preparing to unpack .../06-libjs-sphinxdoc_8.2.3-1ubuntu2_all.deb ... 86s Unpacking libjs-sphinxdoc (8.2.3-1ubuntu2) ... 86s Selecting previously unselected package libpython3.14-stdlib:arm64. 86s Preparing to unpack .../07-libpython3.14-stdlib_3.14.0-4_arm64.deb ... 86s Unpacking libpython3.14-stdlib:arm64 (3.14.0-4) ... 87s Selecting previously unselected package libxslt1.1:arm64. 87s Preparing to unpack .../08-libxslt1.1_1.1.43-0.1_arm64.deb ... 87s Unpacking libxslt1.1:arm64 (1.1.43-0.1) ... 87s Selecting previously unselected package python3.14. 87s Preparing to unpack .../09-python3.14_3.14.0-4_arm64.deb ... 87s Unpacking python3.14 (3.14.0-4) ... 87s Selecting previously unselected package python3-all. 87s Preparing to unpack .../10-python3-all_3.13.7-2_arm64.deb ... 87s Unpacking python3-all (3.13.7-2) ... 87s Selecting previously unselected package python3-asgiref. 87s Preparing to unpack .../11-python3-asgiref_3.9.1-2_all.deb ... 87s Unpacking python3-asgiref (3.9.1-2) ... 87s Selecting previously unselected package python3-sqlparse. 87s Preparing to unpack .../12-python3-sqlparse_0.5.3-1_all.deb ... 87s Unpacking python3-sqlparse (0.5.3-1) ... 87s Selecting previously unselected package python3-django. 87s Preparing to unpack .../13-python3-django_3%3a5.2.4-1ubuntu2_all.deb ... 87s Unpacking python3-django (3:5.2.4-1ubuntu2) ... 87s Selecting previously unselected package python3-legacy-cgi. 87s Preparing to unpack .../14-python3-legacy-cgi_2.6.3-1_all.deb ... 87s Unpacking python3-legacy-cgi (2.6.3-1) ... 87s Selecting previously unselected package python3-lxml:arm64. 87s Preparing to unpack .../15-python3-lxml_6.0.1-1build1_arm64.deb ... 87s Unpacking python3-lxml:arm64 (6.0.1-1build1) ... 87s Selecting previously unselected package python3-requests-futures. 87s Preparing to unpack .../16-python3-requests-futures_1.0.2-1_all.deb ... 87s Unpacking python3-requests-futures (1.0.2-1) ... 87s Selecting previously unselected package python3-django-cas-server. 87s Preparing to unpack .../17-python3-django-cas-server_2.1.0-3_all.deb ... 87s Unpacking python3-django-cas-server (2.1.0-3) ... 87s Selecting previously unselected package sphinx-rtd-theme-common. 87s Preparing to unpack .../18-sphinx-rtd-theme-common_3.0.2+dfsg-3_all.deb ... 87s Unpacking sphinx-rtd-theme-common (3.0.2+dfsg-3) ... 88s Selecting previously unselected package python3-django-cas-server-doc. 88s Preparing to unpack .../19-python3-django-cas-server-doc_2.1.0-3_all.deb ... 88s Unpacking python3-django-cas-server-doc (2.1.0-3) ... 88s Selecting previously unselected package python3-iniconfig. 88s Preparing to unpack .../20-python3-iniconfig_1.1.1-2_all.deb ... 88s Unpacking python3-iniconfig (1.1.1-2) ... 88s Selecting previously unselected package python3-packaging. 88s Preparing to unpack .../21-python3-packaging_25.0-1_all.deb ... 88s Unpacking python3-packaging (25.0-1) ... 88s Selecting previously unselected package python3-pluggy. 88s Preparing to unpack .../22-python3-pluggy_1.6.0-1_all.deb ... 88s Unpacking python3-pluggy (1.6.0-1) ... 88s Selecting previously unselected package python3-pytest. 88s Preparing to unpack .../23-python3-pytest_8.3.5-2_all.deb ... 88s Unpacking python3-pytest (8.3.5-2) ... 88s Selecting previously unselected package python3-pytest-django. 88s Preparing to unpack .../24-python3-pytest-django_4.11.1-2_all.deb ... 88s Unpacking python3-pytest-django (4.11.1-2) ... 88s Setting up python3-iniconfig (1.1.1-2) ... 88s Setting up fonts-lato (2.015-1) ... 88s Setting up libpython3.14-minimal:arm64 (3.14.0-4) ... 88s Setting up python3-packaging (25.0-1) ... 88s Setting up python3-sqlparse (0.5.3-1) ... 89s Setting up python3-pluggy (1.6.0-1) ... 89s Setting up python3-legacy-cgi (2.6.3-1) ... 89s Setting up libxslt1.1:arm64 (1.1.43-0.1) ... 89s Setting up python3-requests-futures (1.0.2-1) ... 89s Setting up libjs-jquery (3.6.1+dfsg+~3.5.14-1) ... 89s Setting up fonts-font-awesome (5.0.10+really4.7.0~dfsg-4.1) ... 89s Setting up sphinx-rtd-theme-common (3.0.2+dfsg-3) ... 89s Setting up python3.14-minimal (3.14.0-4) ... 90s Setting up python3-asgiref (3.9.1-2) ... 91s Setting up libjs-underscore (1.13.4~dfsg+~1.11.4-3) ... 91s Setting up python3-django (3:5.2.4-1ubuntu2) ... 93s Setting up libpython3.14-stdlib:arm64 (3.14.0-4) ... 93s Setting up python3-pytest (8.3.5-2) ... 94s Setting up python3-pytest-django (4.11.1-2) ... 94s Setting up libjs-sphinxdoc (8.2.3-1ubuntu2) ... 94s Setting up python3-lxml:arm64 (6.0.1-1build1) ... 95s Setting up python3.14 (3.14.0-4) ... 96s Setting up python3-django-cas-server (2.1.0-3) ... 96s Setting up python3-all (3.13.7-2) ... 96s Setting up python3-django-cas-server-doc (2.1.0-3) ... 96s Processing triggers for systemd (257.9-0ubuntu2) ... 96s Processing triggers for man-db (2.13.1-1) ... 97s Processing triggers for libc-bin (2.42-0ubuntu3) ... 98s autopkgtest [12:17:54]: test run-test-suite.sh: [----------------------- 98s 98s *************************** 98s *** Testing with python3.14 98s *************************** 98s 98s Content of current working folder: 98s 98s total 20 98s drwxr-xr-x 3 ubuntu ubuntu 4096 Oct 26 12:17 . 98s drwxrwxrwx 5 root root 4096 Oct 26 12:17 .. 98s drwxrwxr-x 9 ubuntu ubuntu 4096 Oct 26 12:17 cas_server 98s -rw-rw-r-- 1 ubuntu ubuntu 140 Aug 18 2024 pytest.ini 98s -rw-rw-r-- 1 ubuntu ubuntu 152 Aug 18 2024 setup.cfg 98s Running tests... 98s 99s ============================= test session starts ============================== 99s platform linux -- Python 3.14.0, pytest-8.3.5, pluggy-1.6.0 -- /usr/bin/python3.14 99s cachedir: .pytest_cache 99s django: version: 5.2.4, settings: cas_server.tests.settings (from ini) 99s rootdir: /tmp/autopkgtest.qOLrS9/autopkgtest_tmp 99s configfile: pytest.ini 99s testpaths: cas_server/tests/ 99s plugins: typeguard-4.4.2, django-4.11.1 99s collecting ... collected 128 items 99s 99s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_auth_federate_errors Creating test database for alias 'default'... 100s 2025-10-26 12:17:56,478 WARNING Identity provider suffix exemple.fr not found 100s 2025-10-26 12:17:56,494 INFO Got an invalid ticket ST-i2tG0ZQF2k3D7G5VMeHWF7oozOTf7pKjfRyEZnVTaZBcngwCKFOYqtr2aQp7U from http://127.0.0.1:8080 for service http://testserver/federate/example.com. Retrying authentication 100s 2025-10-26 12:17:56,499 INFO Got an invalid ticket ST-qSXJthyeTDuXN3OuFL7VD8JvUEFyoe27zn6uTUdG8AyuTa2CH1sfmOZ3lioaP from http://127.0.0.1:8080 for service http://testserver/federate/example.com. Retrying authentication 100s PASSED 100s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_auth_federate_false 2025-10-26 12:17:56,539 WARNING CAS_FEDERATE is False, set it to True to use federation 100s 2025-10-26 12:17:56,540 WARNING CAS_FEDERATE is False, set it to True to use federation 100s PASSED 100s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_auth_federate_slo 2025-10-26 12:17:56,560 INFO Trying to authenticate http://127.0.0.1:8080 again 100s 2025-10-26 12:17:56,567 INFO Got a valid ticket for dédé from http://127.0.0.1:8080 100s 2025-10-26 12:17:56,583 INFO User dédé@example.com successfully authenticated 100s 2025-10-26 12:17:56,598 INFO Service ticket created for service https://www.example.com by user dédé@example.com. 100s 2025-10-26 12:17:56,611 INFO Trying to authenticate http://127.0.0.1:8081 again 100s 2025-10-26 12:17:56,619 INFO Got a valid ticket for dédé from http://127.0.0.1:8081 100s 2025-10-26 12:17:56,632 INFO User dédé@example.org successfully authenticated 100s 2025-10-26 12:17:56,643 INFO Service ticket created for service https://www.example.com by user dédé@example.org. 100s 2025-10-26 12:17:56,656 INFO Trying to authenticate http://127.0.0.1:8082 again 100s 2025-10-26 12:17:56,663 INFO Got a valid ticket for dédé from http://127.0.0.1:8082 100s 2025-10-26 12:17:56,676 INFO User dédé@example.net successfully authenticated 100s 2025-10-26 12:17:56,687 INFO Service ticket created for service https://www.example.com by user dédé@example.net. 100s 2025-10-26 12:17:56,700 INFO Trying to authenticate http://127.0.0.1:8083 again 100s 2025-10-26 12:17:56,708 INFO Got a valid ticket for dédé from http://127.0.0.1:8083 100s 2025-10-26 12:17:56,721 INFO User dédé@example.test successfully authenticated 100s 2025-10-26 12:17:56,732 INFO Service ticket created for service https://www.example.com by user dédé@example.test. 100s 2025-10-26 12:17:56,777 INFO Got an SLO requests for ticket dédé@example.net, logging out user ST-Y8ZT3ArYvbes2TlMCOPWz9uBZ8pXkKQ2LExbtE1qhg6bMdSVDxRMMNLG7uOUM 100s 2025-10-26 12:17:56,807 INFO Got an SLO requests for ticket dédé@example.test, logging out user ST-ZV8i7prTrmbKIiPZMECym2oBBb8f1KQNGGVRX4xVldkQBZcICklYVuwpNLC1R 100s PASSED 100s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_default_settings PASSED 100s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_federate_logout 2025-10-26 12:17:56,847 INFO Trying to authenticate http://127.0.0.1:8080 again 100s 2025-10-26 12:17:56,854 INFO Got a valid ticket for dédé from http://127.0.0.1:8080 100s 2025-10-26 12:17:56,866 INFO User dédé@example.com successfully authenticated 100s 2025-10-26 12:17:56,878 INFO Service ticket created for service https://www.example.com by user dédé@example.com. 100s 2025-10-26 12:17:56,892 INFO Trying to authenticate http://127.0.0.1:8081 again 100s 2025-10-26 12:17:56,898 INFO Got a valid ticket for dédé from http://127.0.0.1:8081 100s 2025-10-26 12:17:56,910 INFO User dédé@example.org successfully authenticated 100s 2025-10-26 12:17:56,922 INFO Service ticket created for service https://www.example.com by user dédé@example.org. 100s 2025-10-26 12:17:56,936 INFO Trying to authenticate http://127.0.0.1:8082 again 100s 2025-10-26 12:17:56,942 INFO Got a valid ticket for dédé from http://127.0.0.1:8082 100s 2025-10-26 12:17:56,954 INFO User dédé@example.net successfully authenticated 100s 2025-10-26 12:17:56,965 INFO Service ticket created for service https://www.example.com by user dédé@example.net. 101s 2025-10-26 12:17:56,977 INFO Trying to authenticate http://127.0.0.1:8083 again 101s 2025-10-26 12:17:56,985 INFO Got a valid ticket for dédé from http://127.0.0.1:8083 101s 2025-10-26 12:17:56,997 INFO User dédé@example.test successfully authenticated 101s 2025-10-26 12:17:57,008 INFO Service ticket created for service https://www.example.com by user dédé@example.test. 101s 2025-10-26 12:17:57,009 INFO logout requested 101s 2025-10-26 12:17:57,012 INFO Logging out user dédé@example.com. 101s 2025-10-26 12:17:57,016 INFO User dédé@example.com logged out 101s 2025-10-26 12:17:57,027 INFO logout requested 101s 2025-10-26 12:17:57,030 INFO logout requested 101s 2025-10-26 12:17:57,032 INFO Logging out user dédé@example.org. 101s 2025-10-26 12:17:57,037 INFO User dédé@example.org logged out 101s 2025-10-26 12:17:57,049 INFO logout requested 101s 2025-10-26 12:17:57,052 INFO logout requested 101s 2025-10-26 12:17:57,054 INFO Logging out user dédé@example.net. 101s 2025-10-26 12:17:57,059 INFO User dédé@example.net logged out 101s 2025-10-26 12:17:57,069 INFO logout requested 101s 2025-10-26 12:17:57,072 INFO logout requested 101s 2025-10-26 12:17:57,075 INFO Logging out user dédé@example.test. 101s 2025-10-26 12:17:57,080 INFO User dédé@example.test logged out 101s 2025-10-26 12:17:57,090 INFO logout requested 101s 2025-10-26 12:17:57,106 INFO Trying to authenticate http://127.0.0.1:8080 again 101s 2025-10-26 12:17:57,113 INFO Got a valid ticket for dédé from http://127.0.0.1:8080 101s 2025-10-26 12:17:57,124 INFO User dédé@example.com successfully authenticated 101s 2025-10-26 12:17:57,135 INFO Service ticket created for service https://www.example.com by user dédé@example.com. 101s 2025-10-26 12:17:57,148 INFO Trying to authenticate http://127.0.0.1:8081 again 101s 2025-10-26 12:17:57,155 INFO Got a valid ticket for dédé from http://127.0.0.1:8081 101s 2025-10-26 12:17:57,166 INFO User dédé@example.org successfully authenticated 101s 2025-10-26 12:17:57,177 INFO Service ticket created for service https://www.example.com by user dédé@example.org. 101s 2025-10-26 12:17:57,190 INFO Trying to authenticate http://127.0.0.1:8082 again 101s 2025-10-26 12:17:57,197 INFO Got a valid ticket for dédé from http://127.0.0.1:8082 101s 2025-10-26 12:17:57,208 INFO User dédé@example.net successfully authenticated 101s 2025-10-26 12:17:57,219 INFO Service ticket created for service https://www.example.com by user dédé@example.net. 101s 2025-10-26 12:17:57,233 INFO Trying to authenticate http://127.0.0.1:8083 again 101s 2025-10-26 12:17:57,240 INFO Got a valid ticket for dédé from http://127.0.0.1:8083 101s 2025-10-26 12:17:57,251 INFO User dédé@example.test successfully authenticated 101s 2025-10-26 12:17:57,262 INFO Service ticket created for service https://www.example.com by user dédé@example.test. 101s 2025-10-26 12:17:57,265 INFO logout requested 101s 2025-10-26 12:17:57,266 INFO Logging out user dédé. 101s 2025-10-26 12:17:57,267 INFO User dédé logged out 101s 2025-10-26 12:17:57,279 INFO logout requested 101s 2025-10-26 12:17:57,281 INFO Logging out user dédé. 101s 2025-10-26 12:17:57,282 INFO User dédé logged out 101s 2025-10-26 12:17:57,294 INFO logout requested 101s 2025-10-26 12:17:57,295 INFO Logging out user dédé. 101s 2025-10-26 12:17:57,296 INFO User dédé logged out 101s 2025-10-26 12:17:57,309 INFO logout requested 101s 2025-10-26 12:17:57,310 INFO Logging out user dédé. 101s 2025-10-26 12:17:57,311 INFO User dédé logged out 101s PASSED 101s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_forget_provider 2025-10-26 12:17:57,340 INFO Trying to authenticate http://127.0.0.1:8080 again 101s 2025-10-26 12:17:57,347 INFO Got a valid ticket for dédé from http://127.0.0.1:8080 101s 2025-10-26 12:17:57,358 INFO User dédé@example.com successfully authenticated 101s 2025-10-26 12:17:57,370 INFO Service ticket created for service https://www.example.com by user dédé@example.com. 101s 2025-10-26 12:17:57,386 INFO Trying to authenticate http://127.0.0.1:8081 again 101s 2025-10-26 12:17:57,392 INFO Got a valid ticket for dédé from http://127.0.0.1:8081 101s 2025-10-26 12:17:57,404 INFO User dédé@example.org successfully authenticated 101s 2025-10-26 12:17:57,415 INFO Service ticket created for service https://www.example.com by user dédé@example.org. 101s 2025-10-26 12:17:57,430 INFO Trying to authenticate http://127.0.0.1:8082 again 101s 2025-10-26 12:17:57,436 INFO Got a valid ticket for dédé from http://127.0.0.1:8082 101s 2025-10-26 12:17:57,448 INFO User dédé@example.net successfully authenticated 101s 2025-10-26 12:17:57,459 INFO Service ticket created for service https://www.example.com by user dédé@example.net. 101s 2025-10-26 12:17:57,474 INFO Trying to authenticate http://127.0.0.1:8083 again 101s 2025-10-26 12:17:57,481 INFO Got a valid ticket for dédé from http://127.0.0.1:8083 101s 2025-10-26 12:17:57,492 INFO User dédé@example.test successfully authenticated 101s 2025-10-26 12:17:57,504 INFO Service ticket created for service https://www.example.com by user dédé@example.test. 101s 2025-10-26 12:17:57,505 INFO logout requested 101s 2025-10-26 12:17:57,508 INFO Logging out user dédé@example.com. 101s 2025-10-26 12:17:57,513 INFO User dédé@example.com logged out 101s 2025-10-26 12:17:57,514 INFO logout requested 101s 2025-10-26 12:17:57,516 INFO Logging out user dédé@example.org. 101s 2025-10-26 12:17:57,522 INFO User dédé@example.org logged out 101s 2025-10-26 12:17:57,523 INFO logout requested 101s 2025-10-26 12:17:57,525 INFO Logging out user dédé@example.net. 101s 2025-10-26 12:17:57,530 INFO User dédé@example.net logged out 101s 2025-10-26 12:17:57,531 INFO logout requested 101s 2025-10-26 12:17:57,533 INFO Logging out user dédé@example.test. 101s 2025-10-26 12:17:57,538 INFO User dédé@example.test logged out 101s PASSED 101s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_login_bad_ticket 2025-10-26 12:17:57,556 WARNING A login attempt failed 101s PASSED 101s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_login_get_provider PASSED 101s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_login_post_provider 2025-10-26 12:17:57,596 INFO Trying to authenticate http://127.0.0.1:8080 again 101s 2025-10-26 12:17:57,603 INFO Got a valid ticket for dédé from http://127.0.0.1:8080 101s 2025-10-26 12:17:57,614 INFO User dédé@example.com successfully authenticated 101s 2025-10-26 12:17:57,626 INFO Service ticket created for service https://www.example.com by user dédé@example.com. 101s 2025-10-26 12:17:57,640 INFO Trying to authenticate http://127.0.0.1:8081 again 101s 2025-10-26 12:17:57,647 INFO Got a valid ticket for dédé from http://127.0.0.1:8081 101s 2025-10-26 12:17:57,659 INFO User dédé@example.org successfully authenticated 101s 2025-10-26 12:17:57,670 INFO Service ticket created for service https://www.example.com by user dédé@example.org. 101s 2025-10-26 12:17:57,683 INFO Trying to authenticate http://127.0.0.1:8082 again 101s 2025-10-26 12:17:57,691 INFO Got a valid ticket for dédé from http://127.0.0.1:8082 101s 2025-10-26 12:17:57,703 INFO User dédé@example.net successfully authenticated 101s 2025-10-26 12:17:57,714 INFO Service ticket created for service https://www.example.com by user dédé@example.net. 101s 2025-10-26 12:17:57,727 INFO Trying to authenticate http://127.0.0.1:8083 again 101s 2025-10-26 12:17:57,734 INFO Got a valid ticket for dédé from http://127.0.0.1:8083 101s 2025-10-26 12:17:57,747 INFO User dédé@example.test successfully authenticated 101s 2025-10-26 12:17:57,758 INFO Service ticket created for service https://www.example.com by user dédé@example.test. 101s PASSED 101s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_login_twice 2025-10-26 12:17:57,777 INFO Trying to authenticate http://127.0.0.1:8080 again 101s 2025-10-26 12:17:57,783 INFO Got a valid ticket for dédé from http://127.0.0.1:8080 101s 2025-10-26 12:17:57,797 INFO User dédé@example.com successfully authenticated 101s 2025-10-26 12:17:57,808 INFO Service ticket created for service https://www.example.com by user dédé@example.com. 101s 2025-10-26 12:17:57,820 INFO Trying to authenticate http://127.0.0.1:8081 again 101s 2025-10-26 12:17:57,827 INFO Got a valid ticket for dédé from http://127.0.0.1:8081 101s 2025-10-26 12:17:57,838 INFO User dédé@example.org successfully authenticated 101s 2025-10-26 12:17:57,850 INFO Service ticket created for service https://www.example.com by user dédé@example.org. 101s 2025-10-26 12:17:57,863 INFO Trying to authenticate http://127.0.0.1:8082 again 101s 2025-10-26 12:17:57,870 INFO Got a valid ticket for dédé from http://127.0.0.1:8082 101s 2025-10-26 12:17:57,881 INFO User dédé@example.net successfully authenticated 101s 2025-10-26 12:17:57,893 INFO Service ticket created for service https://www.example.com by user dédé@example.net. 101s 2025-10-26 12:17:57,908 INFO Trying to authenticate http://127.0.0.1:8083 again 101s 2025-10-26 12:17:57,915 INFO Got a valid ticket for dédé from http://127.0.0.1:8083 101s 2025-10-26 12:17:57,926 INFO User dédé@example.test successfully authenticated 101s 2025-10-26 12:17:57,937 INFO Service ticket created for service https://www.example.com by user dédé@example.test. 101s 2025-10-26 12:17:57,954 INFO Trying to authenticate http://127.0.0.1:8080 again 101s 2025-10-26 12:17:57,960 INFO Got a valid ticket for dédé from http://127.0.0.1:8080 102s 2025-10-26 12:17:57,971 INFO User dédé@example.com successfully authenticated 102s 2025-10-26 12:17:57,982 INFO Service ticket created for service https://www.example.com by user dédé@example.com. 102s 2025-10-26 12:17:57,998 INFO Trying to authenticate http://127.0.0.1:8081 again 102s 2025-10-26 12:17:58,005 INFO Got a valid ticket for dédé from http://127.0.0.1:8081 102s 2025-10-26 12:17:58,017 INFO User dédé@example.org successfully authenticated 102s 2025-10-26 12:17:58,028 INFO Service ticket created for service https://www.example.com by user dédé@example.org. 102s 2025-10-26 12:17:58,040 INFO Trying to authenticate http://127.0.0.1:8082 again 102s 2025-10-26 12:17:58,046 INFO Got a valid ticket for dédé from http://127.0.0.1:8082 102s 2025-10-26 12:17:58,062 INFO User dédé@example.net successfully authenticated 102s 2025-10-26 12:17:58,074 INFO Service ticket created for service https://www.example.com by user dédé@example.net. 102s 2025-10-26 12:17:58,086 INFO Trying to authenticate http://127.0.0.1:8083 again 102s 2025-10-26 12:17:58,094 INFO Got a valid ticket for dédé from http://127.0.0.1:8083 102s 2025-10-26 12:17:58,109 INFO User dédé@example.test successfully authenticated 102s 2025-10-26 12:17:58,119 INFO Service ticket created for service https://www.example.com by user dédé@example.test. 102s 2025-10-26 12:17:58,122 WARNING User already authenticated, dropping federated authentication request 102s 2025-10-26 12:17:58,123 WARNING User already authenticated, dropping federated authentication request 102s 2025-10-26 12:17:58,124 WARNING User already authenticated, dropping federated authentication request 102s 2025-10-26 12:17:58,126 WARNING User already authenticated, dropping federated authentication request 102s PASSED 102s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_remember_provider 2025-10-26 12:17:58,144 INFO Trying to authenticate http://127.0.0.1:8080 again 102s 2025-10-26 12:17:58,151 INFO Got a valid ticket for dédé from http://127.0.0.1:8080 102s 2025-10-26 12:17:58,166 INFO User dédé@example.com successfully authenticated 102s 2025-10-26 12:17:58,177 INFO Service ticket created for service https://www.example.com by user dédé@example.com. 102s 2025-10-26 12:17:58,189 INFO Trying to authenticate http://127.0.0.1:8081 again 102s 2025-10-26 12:17:58,196 INFO Got a valid ticket for dédé from http://127.0.0.1:8081 102s 2025-10-26 12:17:58,215 INFO User dédé@example.org successfully authenticated 102s 2025-10-26 12:17:58,226 INFO Service ticket created for service https://www.example.com by user dédé@example.org. 102s 2025-10-26 12:17:58,239 INFO Trying to authenticate http://127.0.0.1:8082 again 102s 2025-10-26 12:17:58,246 INFO Got a valid ticket for dédé from http://127.0.0.1:8082 102s 2025-10-26 12:17:58,258 INFO User dédé@example.net successfully authenticated 102s 2025-10-26 12:17:58,293 INFO Service ticket created for service https://www.example.com by user dédé@example.net. 102s 2025-10-26 12:17:58,306 INFO Trying to authenticate http://127.0.0.1:8083 again 102s 2025-10-26 12:17:58,314 INFO Got a valid ticket for dédé from http://127.0.0.1:8083 102s 2025-10-26 12:17:58,325 INFO User dédé@example.test successfully authenticated 102s 2025-10-26 12:17:58,338 INFO Service ticket created for service https://www.example.com by user dédé@example.test. 102s 2025-10-26 12:17:58,339 INFO logout requested 102s 2025-10-26 12:17:58,341 INFO Logging out user dédé@example.com. 102s 2025-10-26 12:17:58,347 INFO User dédé@example.com logged out 102s 2025-10-26 12:17:58,351 INFO logout requested 102s 2025-10-26 12:17:58,353 INFO Logging out user dédé@example.org. 102s 2025-10-26 12:17:58,358 INFO User dédé@example.org logged out 102s 2025-10-26 12:17:58,362 INFO logout requested 102s 2025-10-26 12:17:58,364 INFO Logging out user dédé@example.net. 102s 2025-10-26 12:17:58,369 INFO User dédé@example.net logged out 102s 2025-10-26 12:17:58,373 INFO logout requested 102s 2025-10-26 12:17:58,375 INFO Logging out user dédé@example.test. 102s 2025-10-26 12:17:58,380 INFO User dédé@example.test logged out 102s PASSED 102s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_renew 2025-10-26 12:17:58,400 INFO Trying to authenticate http://127.0.0.1:8080 again 102s 2025-10-26 12:17:58,407 INFO Got a valid ticket for dédé from http://127.0.0.1:8080 102s 2025-10-26 12:17:58,419 INFO User dédé@example.com successfully authenticated 102s 2025-10-26 12:17:58,430 INFO Service ticket created for service https://www.example.com by user dédé@example.com. 102s 2025-10-26 12:17:58,443 INFO Trying to authenticate http://127.0.0.1:8081 again 102s 2025-10-26 12:17:58,449 INFO Got a valid ticket for dédé from http://127.0.0.1:8081 102s 2025-10-26 12:17:58,462 INFO User dédé@example.org successfully authenticated 102s 2025-10-26 12:17:58,473 INFO Service ticket created for service https://www.example.com by user dédé@example.org. 102s 2025-10-26 12:17:58,486 INFO Trying to authenticate http://127.0.0.1:8082 again 102s 2025-10-26 12:17:58,493 INFO Got a valid ticket for dédé from http://127.0.0.1:8082 102s 2025-10-26 12:17:58,506 INFO User dédé@example.net successfully authenticated 102s 2025-10-26 12:17:58,518 INFO Service ticket created for service https://www.example.com by user dédé@example.net. 102s 2025-10-26 12:17:58,532 INFO Trying to authenticate http://127.0.0.1:8083 again 102s 2025-10-26 12:17:58,540 INFO Got a valid ticket for dédé from http://127.0.0.1:8083 102s 2025-10-26 12:17:58,552 INFO User dédé@example.test successfully authenticated 102s 2025-10-26 12:17:58,565 INFO Service ticket created for service https://www.example.com by user dédé@example.test. 102s 2025-10-26 12:17:58,571 INFO Trying to authenticate http://127.0.0.1:8080 again 102s 2025-10-26 12:17:58,577 INFO Got a valid ticket for dédé from http://127.0.0.1:8080 102s 2025-10-26 12:17:58,590 INFO User dédé@example.com successfully authenticated 102s 2025-10-26 12:17:58,595 INFO Service ticket created for service https://www.example.com by user dédé@example.com. 102s 2025-10-26 12:17:58,602 INFO Trying to authenticate http://127.0.0.1:8081 again 102s 2025-10-26 12:17:58,609 INFO Got a valid ticket for dédé from http://127.0.0.1:8081 102s 2025-10-26 12:17:58,621 INFO User dédé@example.org successfully authenticated 102s 2025-10-26 12:17:58,626 INFO Service ticket created for service https://www.example.com by user dédé@example.org. 102s 2025-10-26 12:17:58,634 INFO Trying to authenticate http://127.0.0.1:8082 again 102s 2025-10-26 12:17:58,640 INFO Got a valid ticket for dédé from http://127.0.0.1:8082 102s 2025-10-26 12:17:58,653 INFO User dédé@example.net successfully authenticated 102s 2025-10-26 12:17:58,658 INFO Service ticket created for service https://www.example.com by user dédé@example.net. 102s 2025-10-26 12:17:58,665 INFO Trying to authenticate http://127.0.0.1:8083 again 102s 2025-10-26 12:17:58,672 INFO Got a valid ticket for dédé from http://127.0.0.1:8083 102s 2025-10-26 12:17:58,684 INFO User dédé@example.test successfully authenticated 102s 2025-10-26 12:17:58,690 INFO Service ticket created for service https://www.example.com by user dédé@example.test. 102s PASSED 102s cas_server/tests/test_models.py::FederatedUserTestCase::test_clean_old_entries PASSED 102s cas_server/tests/test_models.py::FederatedUserTestCase::test_json_attributes PASSED 102s cas_server/tests/test_models.py::FederateSLOTestCase::test_clean_deleted_sessions PASSED 102s cas_server/tests/test_models.py::UserAttributesTestCase::test_clean_old_entries 2025-10-26 12:17:58,742 INFO User test successfully authenticated 102s PASSED 102s cas_server/tests/test_models.py::UserTestCase::test_cached_attributs 2025-10-26 12:17:58,764 INFO User test successfully authenticated 102s PASSED 102s cas_server/tests/test_models.py::UserTestCase::test_clean_deleted_sessions 2025-10-26 12:17:58,781 INFO User test successfully authenticated 102s 2025-10-26 12:17:58,795 INFO User test successfully authenticated 102s 2025-10-26 12:17:58,807 INFO Sending SLO requests to service http://127.0.0.1:45678 for user test 102s 2025-10-26 12:17:58,811 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')) 102s PASSED 102s cas_server/tests/test_models.py::UserTestCase::test_clean_old_entries 2025-10-26 12:17:58,825 INFO User test successfully authenticated 102s PASSED 102s cas_server/tests/test_models.py::UserTestCase::test_clean_old_entries_tgt_expired 2025-10-26 12:17:58,845 INFO User test successfully authenticated 102s PASSED 102s cas_server/tests/test_models.py::TicketTestCase::test_clean_old_service_ticket 2025-10-26 12:17:58,869 INFO User test successfully authenticated 102s 2025-10-26 12:17:58,883 INFO Sending SLO requests to service http://127.0.0.1:35489 for user test 102s 2025-10-26 12:17:58,887 WARNING Error durring SLO ('Connection aborted.', RemoteDisconnected('Remote end closed connection without response')) 102s ConnectionError(ProtocolError('Connection aborted.', RemoteDisconnected('Remote end closed connection without response'))) 102s PASSED 102s cas_server/tests/test_models.py::TicketTestCase::test_json_attributes 2025-10-26 12:17:58,902 INFO User test successfully authenticated 102s PASSED 102s cas_server/tests/test_models.py::NewVersionWarningTestCase::test_send_mails PASSED 102s cas_server/tests/test_models.py::NewVersionWarningTestCase::test_send_mails_disabled PASSED 102s cas_server/tests/test_models.py::NewVersionWarningTestCase::test_send_mails_no_admins PASSED 102s cas_server/tests/test_models.py::NewVersionWarningTestCase::test_send_mails_same_version PASSED 102s cas_server/tests/test_templatetags.py::TemplateTagsTestCase::test_is_checkbox PASSED 102s cas_server/tests/test_templatetags.py::TemplateTagsTestCase::test_is_hidden PASSED 102s cas_server/tests/test_utils.py::CheckPasswordCase::test_bad_method PASSED 102s cas_server/tests/test_utils.py::CheckPasswordCase::test_crypt PASSED 102s cas_server/tests/test_utils.py::CheckPasswordCase::test_hex PASSED 102s cas_server/tests/test_utils.py::CheckPasswordCase::test_ldap_password_fail PASSED 102s cas_server/tests/test_utils.py::CheckPasswordCase::test_ldap_password_valid PASSED 102s cas_server/tests/test_utils.py::CheckPasswordCase::test_plain PASSED 102s cas_server/tests/test_utils.py::CheckPasswordCase::test_plain_unicode PASSED 102s cas_server/tests/test_utils.py::CheckPasswordCase::test_setup PASSED 102s cas_server/tests/test_utils.py::UtilsTestCase::test_crypt_salt_is_valid PASSED 102s cas_server/tests/test_utils.py::UtilsTestCase::test_dictfetchall PASSED 102s cas_server/tests/test_utils.py::UtilsTestCase::test_get_current_url PASSED 102s cas_server/tests/test_utils.py::UtilsTestCase::test_get_tuple PASSED 102s cas_server/tests/test_utils.py::UtilsTestCase::test_import_attr PASSED 103s cas_server/tests/test_utils.py::UtilsTestCase::test_last_version PASSED 103s cas_server/tests/test_utils.py::UtilsTestCase::test_regexpr_validator PASSED 103s cas_server/tests/test_utils.py::UtilsTestCase::test_update_url PASSED 103s cas_server/tests/test_view.py::LoginTestCase::test_ajax_get_ticket_fail 2025-10-26 12:17:59,769 INFO User test successfully authenticated 103s 2025-10-26 12:17:59,776 WARNING Service https://www.example.org not allowed. 103s PASSED 103s cas_server/tests/test_view.py::LoginTestCase::test_ajax_get_ticket_success 2025-10-26 12:17:59,791 INFO User test successfully authenticated 103s 2025-10-26 12:17:59,800 INFO Service ticket created for service https://www.example.com by user test. 103s 2025-10-26 12:17:59,814 INFO User test successfully authenticated 103s PASSED 103s cas_server/tests/test_view.py::LoginTestCase::test_ajax_get_ticket_success_alt 2025-10-26 12:17:59,823 INFO Service ticket created for service https://www.example.com by user test. 103s PASSED 103s cas_server/tests/test_view.py::LoginTestCase::test_ajax_get_ticket_warn 2025-10-26 12:17:59,837 INFO User test successfully authenticated 103s PASSED 103s cas_server/tests/test_view.py::LoginTestCase::test_ajax_logged 2025-10-26 12:17:59,859 INFO User test successfully authenticated 103s PASSED 103s cas_server/tests/test_view.py::LoginTestCase::test_ajax_logged_user_deleted 2025-10-26 12:17:59,880 INFO User test successfully authenticated 103s 2025-10-26 12:17:59,888 WARNING User test seems authenticated but is not found in the database. 103s 2025-10-26 12:17:59,888 INFO Logging out user test. 103s 2025-10-26 12:17:59,889 INFO User test logged out 103s PASSED 103s cas_server/tests/test_view.py::LoginTestCase::test_ajax_login_required PASSED 103s cas_server/tests/test_view.py::LoginTestCase::test_gateway 2025-10-26 12:17:59,911 INFO User test successfully authenticated 103s 2025-10-26 12:17:59,918 WARNING Username test not allowed on service restrict_user_fail 103s PASSED 103s cas_server/tests/test_view.py::LoginTestCase::test_login_post_missing_params 2025-10-26 12:17:59,935 WARNING A login attempt failed 103s 2025-10-26 12:17:59,953 WARNING A login attempt failed 103s 2025-10-26 12:17:59,970 WARNING A login attempt failed 104s PASSED 104s cas_server/tests/test_view.py::LoginTestCase::test_login_view_post_badlt 2025-10-26 12:17:59,993 WARNING Received an invalid login ticket 104s PASSED 104s cas_server/tests/test_view.py::LoginTestCase::test_login_view_post_badpass_good_lt 2025-10-26 12:18:00,014 WARNING A login attempt failed 104s PASSED 104s cas_server/tests/test_view.py::LoginTestCase::test_login_view_post_goodpass_goodlt 2025-10-26 12:18:00,038 INFO User test successfully authenticated 104s PASSED 104s cas_server/tests/test_view.py::LoginTestCase::test_login_view_post_goodpass_goodlt_warn 2025-10-26 12:18:00,057 INFO User test successfully authenticated 104s PASSED 105s cas_server/tests/test_view.py::LoginTestCase::test_lt_max PASSED 105s cas_server/tests/test_view.py::LoginTestCase::test_messages_info_box_bad_messages PASSED 105s cas_server/tests/test_view.py::LoginTestCase::test_messages_info_box_disabled PASSED 105s cas_server/tests/test_view.py::LoginTestCase::test_messages_info_box_enabled PASSED 105s cas_server/tests/test_view.py::LoginTestCase::test_new_version_available_badpypi PASSED 105s cas_server/tests/test_view.py::LoginTestCase::test_new_version_available_disabled PASSED 105s cas_server/tests/test_view.py::LoginTestCase::test_new_version_available_ok PASSED 105s cas_server/tests/test_view.py::LoginTestCase::test_renew 2025-10-26 12:18:01,202 INFO User test successfully authenticated 105s 2025-10-26 12:18:01,221 INFO User test successfully authenticated 105s 2025-10-26 12:18:01,226 INFO Service ticket created for service https://www.example.com by user test. 105s PASSED 105s cas_server/tests/test_view.py::LoginTestCase::test_renew_message_disabled 2025-10-26 12:18:01,244 INFO User test successfully authenticated 105s 2025-10-26 12:18:01,257 INFO User test successfully authenticated 105s 2025-10-26 12:18:01,264 INFO Service ticket created for service https://www.example.com by user test. 105s PASSED 105s cas_server/tests/test_view.py::LoginTestCase::test_service_filter 2025-10-26 12:18:01,283 INFO User test successfully authenticated 105s 2025-10-26 12:18:01,290 WARNING User constraint failed for test, service filter_fail: ^admin$ do not match right None. 105s 2025-10-26 12:18:01,295 WARNING User constraint failed for test, service filter_fail_alt: ^toto$ do not match nom Nymous. 105s 2025-10-26 12:18:01,301 INFO Service ticket created for service https://filter_success.example.com by user test. 105s PASSED 105s cas_server/tests/test_view.py::LoginTestCase::test_service_restrict_user 2025-10-26 12:18:01,315 INFO User test successfully authenticated 105s 2025-10-26 12:18:01,326 WARNING Username test not allowed on service restrict_user_fail 105s 2025-10-26 12:18:01,333 INFO Service ticket created for service https://restrict_user_success.example.com by user test. 105s PASSED 105s cas_server/tests/test_view.py::LoginTestCase::test_service_user_field 2025-10-26 12:18:01,347 INFO User test successfully authenticated 105s 2025-10-26 12:18:01,354 WARNING Cannot use uid a loggin for user test on service field_needed_fail because it is absent 105s 2025-10-26 12:18:01,360 INFO Service ticket created for service https://field_needed_success.example.com by user test. 105s PASSED 105s cas_server/tests/test_view.py::LoginTestCase::test_service_user_field_evaluate_to_false 2025-10-26 12:18:01,375 INFO User test successfully authenticated 105s 2025-10-26 12:18:01,381 WARNING Cannot use alias a loggin for user test on service field_needed_success because it is absent 105s PASSED 105s cas_server/tests/test_view.py::LoginTestCase::test_user_logged_not_in_db 2025-10-26 12:18:01,400 INFO User test successfully authenticated 105s 2025-10-26 12:18:01,408 WARNING User test seems authenticated but is not found in the database. 105s 2025-10-26 12:18:01,408 INFO Logging out user test. 105s 2025-10-26 12:18:01,409 INFO User test logged out 105s PASSED 105s cas_server/tests/test_view.py::LoginTestCase::test_view_login_get_allowed_service PASSED 105s cas_server/tests/test_view.py::LoginTestCase::test_view_login_get_allowed_service_no_message PASSED 105s cas_server/tests/test_view.py::LoginTestCase::test_view_login_get_auth_allowed_service 2025-10-26 12:18:01,452 INFO User test successfully authenticated 105s 2025-10-26 12:18:01,461 INFO Service ticket created for service https://www.example.com/é by user test. 105s PASSED 105s cas_server/tests/test_view.py::LoginTestCase::test_view_login_get_auth_allowed_service_non_ascii 2025-10-26 12:18:01,477 INFO User test successfully authenticated 105s 2025-10-26 12:18:01,486 INFO Service ticket created for service https://www.example.com by user test. 105s PASSED 105s cas_server/tests/test_view.py::LoginTestCase::test_view_login_get_auth_allowed_service_warn 2025-10-26 12:18:01,502 INFO User test successfully authenticated 105s 2025-10-26 12:18:01,518 WARNING Received a login attempt for an already-active user 105s 2025-10-26 12:18:01,522 INFO Service ticket created for service https://www.example.com by user test. 105s PASSED 105s cas_server/tests/test_view.py::LoginTestCase::test_view_login_get_auth_denied_service 2025-10-26 12:18:01,538 INFO User test successfully authenticated 105s 2025-10-26 12:18:01,544 WARNING Service https://www.example.org not allowed. 105s PASSED 105s cas_server/tests/test_view.py::LoginTestCase::test_view_login_get_denied_service 2025-10-26 12:18:01,552 WARNING Service https://www.example.net not allowed. 105s PASSED 105s cas_server/tests/test_view.py::LoginTestCase::test_view_login_get_denied_service_no_message 2025-10-26 12:18:01,573 WARNING Service https://www.example.net not allowed. 105s PASSED 105s cas_server/tests/test_view.py::LogoutTestCase::test_ajax_logout 2025-10-26 12:18:01,590 INFO User test successfully authenticated 105s 2025-10-26 12:18:01,595 INFO logout requested 105s 2025-10-26 12:18:01,596 INFO Logging out user test. 105s 2025-10-26 12:18:01,600 INFO User test logged out 105s PASSED 105s cas_server/tests/test_view.py::LogoutTestCase::test_ajax_logout_all_session 2025-10-26 12:18:01,634 INFO User test successfully authenticated 105s 2025-10-26 12:18:01,646 INFO User test successfully authenticated 105s 2025-10-26 12:18:01,657 INFO User test successfully authenticated 105s 2025-10-26 12:18:01,671 INFO User test successfully authenticated 105s 2025-10-26 12:18:01,682 INFO User test successfully authenticated 105s 2025-10-26 12:18:01,694 INFO User test successfully authenticated 105s 2025-10-26 12:18:01,706 INFO User test successfully authenticated 105s 2025-10-26 12:18:01,711 INFO logout requested 105s 2025-10-26 12:18:01,712 INFO Logging out user test from all sessions. 105s 2025-10-26 12:18:01,736 INFO User test logged out 105s PASSED 105s cas_server/tests/test_view.py::LogoutTestCase::test_ajax_redirect_after_logout 2025-10-26 12:18:01,747 INFO User test successfully authenticated 105s 2025-10-26 12:18:01,752 INFO logout requested 105s 2025-10-26 12:18:01,753 INFO Logging out user test. 105s 2025-10-26 12:18:01,757 INFO User test logged out 105s PASSED 105s cas_server/tests/test_view.py::LogoutTestCase::test_logout 2025-10-26 12:18:01,762 INFO logout requested 105s PASSED 105s cas_server/tests/test_view.py::LogoutTestCase::test_logout_from_all_session 2025-10-26 12:18:01,777 INFO User test successfully authenticated 105s 2025-10-26 12:18:01,789 INFO User test successfully authenticated 105s 2025-10-26 12:18:01,794 INFO logout requested 105s 2025-10-26 12:18:01,795 INFO Logging out user test from all sessions. 105s 2025-10-26 12:18:01,802 INFO User test logged out 105s PASSED 105s cas_server/tests/test_view.py::LogoutTestCase::test_logout_slo 2025-10-26 12:18:01,816 INFO User test successfully authenticated 105s 2025-10-26 12:18:01,825 INFO Service ticket created for service http://127.0.0.1:45981 by user test. 105s 2025-10-26 12:18:01,831 INFO Validate: Service ticket ST-0nP3K6gTGZP9cyxJP6Rjwnsag5f0ZMrbSVnd3Xpog1LpWBFBxifQh4Bp74KPc validated, user test authenticated on service http://127.0.0.1:45981 105s 2025-10-26 12:18:01,833 INFO logout requested 105s 2025-10-26 12:18:01,833 INFO Logging out user test. 105s 2025-10-26 12:18:01,838 INFO Sending SLO requests to service http://127.0.0.1:45981 for user test 105s 2025-10-26 12:18:01,842 WARNING Error during SLO for user test: ('Connection aborted.', RemoteDisconnected('Remote end closed connection without response')) 105s 2025-10-26 12:18:01,844 INFO User test logged out 105s 2025-10-26 12:18:01,856 INFO User test successfully authenticated 105s 2025-10-26 12:18:01,864 INFO Service ticket created for service http://127.0.0.1:45678 by user test. 105s 2025-10-26 12:18:01,869 INFO Validate: Service ticket ST-QFINNSYe5dW66YvrcQg7MgxjRFenQFsFhxMEqRqLMCBM1SJxT5DGlda91ZFan validated, user test authenticated on service http://127.0.0.1:45678 105s 2025-10-26 12:18:01,870 INFO logout requested 105s 2025-10-26 12:18:01,871 INFO Logging out user test. 105s 2025-10-26 12:18:01,874 INFO Sending SLO requests to service http://127.0.0.1:45678 for user test 105s 2025-10-26 12:18:01,879 WARNING Error during SLO for user test: ('Connection aborted.', RemoteDisconnected('Remote end closed connection without response')) 105s 2025-10-26 12:18:01,881 INFO User test logged out 105s 2025-10-26 12:18:01,893 INFO User test successfully authenticated 105s 2025-10-26 12:18:01,902 INFO Service ticket created for service http://127.0.0.1:45678 by user test. 105s 2025-10-26 12:18:01,906 INFO Validate: Service ticket ST-1lL2WFGMf0v3DTCuAk8udKC6EZGtOFXWPlpUAChxQ4q8aKhhfcF8AlxnKPh79 validated, user test authenticated on service http://127.0.0.1:45678 105s 2025-10-26 12:18:01,908 INFO logout requested 105s 2025-10-26 12:18:01,908 INFO Logging out user test. 105s 2025-10-26 12:18:01,912 INFO Sending SLO requests to service http://127.0.0.1:45678 for user test 105s 2025-10-26 12:18:01,915 WARNING Error during SLO for user test: HTTPConnectionPool(host='127.0.0.1', port=42543): Max retries exceeded with url: / (Caused by NewConnectionError(': Failed to establish a new connection: [Errno 111] Connection refused')) 105s 2025-10-26 12:18:01,917 INFO User test logged out 105s PASSED 105s cas_server/tests/test_view.py::LogoutTestCase::test_logout_view 2025-10-26 12:18:01,930 INFO User test successfully authenticated 105s 2025-10-26 12:18:01,945 INFO User test successfully authenticated 105s 2025-10-26 12:18:01,953 INFO logout requested 105s 2025-10-26 12:18:01,954 INFO Logging out user test. 105s 2025-10-26 12:18:01,958 INFO User test logged out 106s PASSED 106s cas_server/tests/test_view.py::LogoutTestCase::test_logout_view_service 2025-10-26 12:18:01,979 INFO User test successfully authenticated 106s 2025-10-26 12:18:01,984 INFO logout requested 106s 2025-10-26 12:18:01,986 INFO Logging out user test. 106s 2025-10-26 12:18:01,990 INFO User test logged out 106s PASSED 106s cas_server/tests/test_view.py::LogoutTestCase::test_logout_view_url 2025-10-26 12:18:02,008 INFO User test successfully authenticated 106s 2025-10-26 12:18:02,013 INFO logout requested 106s 2025-10-26 12:18:02,014 INFO Logging out user test. 106s 2025-10-26 12:18:02,018 INFO User test logged out 106s PASSED 106s cas_server/tests/test_view.py::LogoutTestCase::test_redirect_after_logout 2025-10-26 12:18:02,036 INFO User test successfully authenticated 106s 2025-10-26 12:18:02,041 INFO logout requested 106s 2025-10-26 12:18:02,042 INFO Logging out user test. 106s 2025-10-26 12:18:02,046 INFO User test logged out 106s PASSED 106s cas_server/tests/test_view.py::LogoutTestCase::test_redirect_after_logout_to_service 2025-10-26 12:18:02,058 INFO User test successfully authenticated 106s 2025-10-26 12:18:02,062 INFO logout requested 106s 2025-10-26 12:18:02,063 INFO Logging out user test. 106s 2025-10-26 12:18:02,067 INFO User test logged out 106s 2025-10-26 12:18:02,074 INFO logout requested 106s PASSED 106s cas_server/tests/test_view.py::AuthTestCase::test_auth_view_badpass PASSED 106s cas_server/tests/test_view.py::AuthTestCase::test_auth_view_badsecret PASSED 106s cas_server/tests/test_view.py::AuthTestCase::test_auth_view_badservice 2025-10-26 12:18:02,097 WARNING Service https://www.example.org not allowed. 106s PASSED 106s cas_server/tests/test_view.py::AuthTestCase::test_auth_view_badsettings PASSED 106s cas_server/tests/test_view.py::AuthTestCase::test_auth_view_goodpass PASSED 106s cas_server/tests/test_view.py::AuthTestCase::test_auth_view_goodpass_logged 2025-10-26 12:18:02,117 INFO User test successfully authenticated 106s PASSED 106s cas_server/tests/test_view.py::AuthTestCase::test_auth_view_missing_parameter PASSED 106s cas_server/tests/test_view.py::ValidateTestCase::test_validate_missing_parameter 2025-10-26 12:18:02,143 INFO User test successfully authenticated 106s 2025-10-26 12:18:02,152 INFO Service ticket created for service https://www.example.com by user test. 106s 2025-10-26 12:18:02,155 WARNING Validate: service or ticket missing 106s 2025-10-26 12:18:02,156 WARNING Validate: service or ticket missing 106s PASSED 106s cas_server/tests/test_view.py::ValidateTestCase::test_validate_service_renew 2025-10-26 12:18:02,168 INFO User test successfully authenticated 106s 2025-10-26 12:18:02,173 INFO Service ticket created for service https://www.example.com by user test. 106s 2025-10-26 12:18:02,178 INFO Validate: Service ticket ST-Bvce8y8qToR3JrcYhSl2cQcLJH1Gti0MdLqhjCcSuWPBPXRbmxGsBtNqgCYZj validated, user test authenticated on service https://www.example.com 106s 2025-10-26 12:18:02,187 INFO User test successfully authenticated 106s 2025-10-26 12:18:02,192 INFO Service ticket created for service https://www.example.com by user test. 106s 2025-10-26 12:18:02,196 INFO Validate: Service ticket ST-oN28RDzQQqlnkCceT3NXpUl1dw9uC5tSpAWWgPMUQSD6Riog322TZhevNIrU9 validated, user test authenticated on service https://www.example.com 106s 2025-10-26 12:18:02,201 INFO Service ticket created for service https://www.example.com by user test. 106s 2025-10-26 12:18:02,203 WARNING Validate: Service ticket ST-R4Sy4EAuRLy8zGwxbJOupC47H9ts8OWjoQUoENoTrmvAYGEZ80kxcYqioI6q4 not found or already validated, auth to https://www.example.com failed 106s PASSED 106s cas_server/tests/test_view.py::ValidateTestCase::test_validate_user_field_ok 2025-10-26 12:18:02,216 INFO User test successfully authenticated 106s 2025-10-26 12:18:02,225 INFO Service ticket created for service https://user_field.example.com by user test. 106s 2025-10-26 12:18:02,229 INFO Validate: Service ticket ST-augAUcedIZZjjhznEpsao0IHfepxsfmsEldiUHEFnWl6spBFITWTrSpx4FSCC validated, user test authenticated on service https://user_field.example.com 106s 2025-10-26 12:18:02,238 INFO User test successfully authenticated 106s 2025-10-26 12:18:02,247 INFO Service ticket created for service https://user_field_alt.example.com by user test. 106s 2025-10-26 12:18:02,252 INFO Validate: Service ticket ST-hsDNyWukTljNBxra0Hy5f7kqYke17Okg6PYg1GvDvqyWlq0MYKH5Mc2QcSqCg validated, user test authenticated on service https://user_field_alt.example.com 106s PASSED 106s cas_server/tests/test_view.py::ValidateTestCase::test_validate_view_badservice 2025-10-26 12:18:02,264 INFO User test successfully authenticated 106s 2025-10-26 12:18:02,274 INFO Service ticket created for service https://www.example.com by user test. 106s 2025-10-26 12:18:02,277 WARNING Validate: Service ticket ST-yFfWJCl4OND7pEdLXHB1nQFOORyYEyGLGfGT4PkaUfzt44kwkas15jhFnWOfT not found or already validated, auth to https://www.example.org failed 106s PASSED 106s cas_server/tests/test_view.py::ValidateTestCase::test_validate_view_badticket 2025-10-26 12:18:02,289 INFO User test successfully authenticated 106s 2025-10-26 12:18:02,297 INFO Service ticket created for service https://www.example.com by user test. 106s 2025-10-26 12:18:02,301 WARNING Validate: Service ticket ST-RANDOM not found or already validated, auth to https://www.example.com failed 106s PASSED 106s cas_server/tests/test_view.py::ValidateTestCase::test_validate_view_ok 2025-10-26 12:18:02,311 INFO User test successfully authenticated 106s 2025-10-26 12:18:02,320 INFO Service ticket created for service https://www.example.com by user test. 106s 2025-10-26 12:18:02,325 INFO Validate: Service ticket ST-mMx6rTlnfIfxXuBtyL4V0dHx5fikniAg7x8O5flAvPTmPT7J33VzuEdf8sAwf validated, user test authenticated on service https://www.example.com 106s PASSED 106s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_missing_parameter 2025-10-26 12:18:02,339 INFO User test successfully authenticated 106s 2025-10-26 12:18:02,348 INFO Service ticket created for service http://127.0.0.1:45678 by user test. 106s 2025-10-26 12:18:02,351 WARNING ValidateService: missing ticket or service 106s 2025-10-26 12:18:02,353 WARNING ValidateService: missing ticket or service 106s PASSED 106s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_proxy 2025-10-26 12:18:02,367 INFO User test successfully authenticated 106s 2025-10-26 12:18:02,378 INFO Service ticket created for service http://127.0.0.1:45231 by user test. 106s 2025-10-26 12:18:02,386 INFO ValidateService: ticket ST-uNgpIWeZR5XVjSjg4LkQJaPYFrAFg3PBFCt4D0lFruGMlIE2fF3Rh6bDnjCFY validated for user test on service http://127.0.0.1:45231. Proxy Granting Ticket transmited to http://127.0.0.1:45231. 106s 2025-10-26 12:18:02,393 INFO Proxy ticket created for user test on service http://127.0.0.1:45678. 106s 2025-10-26 12:18:02,398 INFO ValidateService: ticket PT-iNZi5XrXrOb2qyd65TN2Mw6JMhSagappbX1poJIxBN9QnwXfRhyFrLH9igp3w validated for user test on service http://127.0.0.1:45678. 106s 2025-10-26 12:18:02,408 INFO User test successfully authenticated 106s 2025-10-26 12:18:02,417 INFO Service ticket created for service http://127.0.0.1:44095 by user test. 106s 2025-10-26 12:18:02,425 INFO ValidateService: ticket ST-jSHsQtZ4hFLp0autueAPqn9ADxhBzN7Umqf4Gp9hebEDqccmdiY9pmEJEFv2Q validated for user test on service http://127.0.0.1:44095. Proxy Granting Ticket transmited to http://127.0.0.1:44095. 106s 2025-10-26 12:18:02,431 INFO Proxy ticket created for user test on service http://127.0.0.1:45678. 106s 2025-10-26 12:18:02,433 WARNING ValidateService: validation error: INVALID_TICKET PT-57vWfHW0H3dVArsAY139aNlEbem9qJTEJHs5nP3D2aSe1huvD2keKFhfcnchL 106s PASSED 106s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_replace_attributes 2025-10-26 12:18:02,447 INFO User test successfully authenticated 106s 2025-10-26 12:18:02,456 INFO Service ticket created for service https://replace_attribute.example.com by user test. 106s 2025-10-26 12:18:02,460 INFO ValidateService: ticket ST-eeZyPkILFi6jYahloFPIOqjSBcyUrcvpyHPyjbCKbiBJlQSZrAJyuvqkxYo8L validated for user test on service https://replace_attribute.example.com. 106s 2025-10-26 12:18:02,469 INFO User test successfully authenticated 106s 2025-10-26 12:18:02,477 INFO Service ticket created for service https://replace_attribute_list.example.com by user test. 106s 2025-10-26 12:18:02,482 INFO ValidateService: ticket ST-oL33JR28dnAnR0KxMyFGihFtxn6qdfZnwTde8lOKIDxeJREhQ3kT1Y918nKuM validated for user test on service https://replace_attribute_list.example.com. 106s PASSED 106s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_service_pgturl_404 2025-10-26 12:18:02,497 INFO User test successfully authenticated 106s 2025-10-26 12:18:02,505 INFO Service ticket created for service http://127.0.0.1:43149 by user test. 106s 2025-10-26 12:18:02,514 INFO ValidateService: ticket ST-40SgiYSq5uA10JDLiZsDxLgMiBrr7y4WsGyLESw5BNtxKSi6SgUMjpCNX4yTK validated for user test on service http://127.0.0.1:43149. Proxy Granting Ticket transmited to http://127.0.0.1:43149. 106s PASSED 106s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_service_pgturl_bad_proxy_callback 2025-10-26 12:18:02,529 INFO User test successfully authenticated 106s 2025-10-26 12:18:02,538 INFO Service ticket created for service http://127.0.0.1:45678 by user test. 106s 2025-10-26 12:18:02,543 WARNING ValidateService: validation error: INVALID_PROXY_CALLBACK callback url not allowed by configuration 106s 2025-10-26 12:18:02,552 INFO User test successfully authenticated 106s 2025-10-26 12:18:02,561 INFO Service ticket created for service http://127.0.0.1:45678 by user test. 106s 2025-10-26 12:18:02,566 WARNING Service https://www.example.org not allowed. 106s 2025-10-26 12:18:02,566 WARNING ValidateService: validation error: INVALID_PROXY_CALLBACK callback url not allowed by configuration 106s PASSED 106s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_service_pgturl_sslerror 2025-10-26 12:18:02,579 INFO User test successfully authenticated 106s 2025-10-26 12:18:02,588 INFO Service ticket created for service https://127.0.0.1:39197 by user test. 106s 2025-10-26 12:18:02,596 WARNING ValidateService: validation error: INVALID_PROXY_CALLBACK : HTTPSConnectionPool(host='127.0.0.1', port=39197): Max retries exceeded with url: /?pgtId=PGT-wfEPgVAfmMUbFnvR3kZBfPLwj8SIjFI2qcplrWoPOVMzJ19jOoDDdHzpSdWI&pgtIou=PGTIOU-fxECpSXFMt30MhcLqsrHC5rCQQf7OyfsmN8FLhWJkoADhquhvVrZbohH6 (Caused by SSLError(SSLError(1, '[SSL: RECORD_LAYER_FAILURE] record layer failure (_ssl.c:1077)'))) 106s PASSED 106s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_service_renew 2025-10-26 12:18:02,611 INFO User test successfully authenticated 106s 2025-10-26 12:18:02,616 INFO Service ticket created for service http://127.0.0.1:45678 by user test. 106s 2025-10-26 12:18:02,621 INFO ValidateService: ticket ST-HH7rwSmFgJ58Bsl7Z8SOzuAT4ULWIKyP3fcUk24lx6BGyOoWa98MTZ6H6Vkbq validated for user test on service http://127.0.0.1:45678. 106s 2025-10-26 12:18:02,630 INFO User test successfully authenticated 106s 2025-10-26 12:18:02,635 INFO Service ticket created for service http://127.0.0.1:45678 by user test. 106s 2025-10-26 12:18:02,639 INFO ValidateService: ticket ST-FHmr89uBBSuH8tiTRLT7TPiUxME1Xvjtru3mGeem7ECmlEZDOsNcKYqL5PlA1 validated for user test on service http://127.0.0.1:45678. 106s 2025-10-26 12:18:02,645 INFO Service ticket created for service http://127.0.0.1:45678 by user test. 106s 2025-10-26 12:18:02,647 WARNING ValidateService: validation error: INVALID_TICKET ticket not found 106s PASSED 106s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_service_view_badservice 2025-10-26 12:18:02,661 INFO User test successfully authenticated 106s 2025-10-26 12:18:02,670 INFO Service ticket created for service http://127.0.0.1:45678 by user test. 106s 2025-10-26 12:18:02,673 WARNING ValidateService: validation error: INVALID_SERVICE https://www.example.org 106s PASSED 106s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_service_view_badticket_badprefix 2025-10-26 12:18:02,687 INFO User test successfully authenticated 106s 2025-10-26 12:18:02,695 INFO Service ticket created for service http://127.0.0.1:45678 by user test. 106s 2025-10-26 12:18:02,698 WARNING ValidateService: validation error: INVALID_TICKET RANDOM 106s PASSED 106s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_service_view_badticket_goodprefix 2025-10-26 12:18:02,727 INFO User test successfully authenticated 106s 2025-10-26 12:18:02,736 INFO Service ticket created for service http://127.0.0.1:45678 by user test. 106s 2025-10-26 12:18:02,740 WARNING ValidateService: validation error: INVALID_TICKET ticket not found 106s PASSED 106s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_service_view_ok 2025-10-26 12:18:02,753 INFO User test successfully authenticated 106s 2025-10-26 12:18:02,761 INFO Service ticket created for service http://127.0.0.1:45678 by user test. 106s 2025-10-26 12:18:02,766 INFO ValidateService: ticket ST-S9d3k7vhjpxppya275AEuZDaAn9DC7Lh7CQOoMmPnPgOutt1GmcC4Q170vrKj validated for user test on service http://127.0.0.1:45678. 106s PASSED 106s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_service_view_ok_one_attribute 2025-10-26 12:18:02,780 INFO User test successfully authenticated 106s 2025-10-26 12:18:02,789 INFO Service ticket created for service https://one_attribute.example.com by user test. 106s 2025-10-26 12:18:02,794 INFO ValidateService: ticket ST-gU63idbsCrnT8eHpJY2qi5QYwQ6aUzjmU5qfEN8YN7XBhOM0lcZWvjGEJISz1 validated for user test on service https://one_attribute.example.com. 106s PASSED 106s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_service_view_ok_pgturl 2025-10-26 12:18:02,808 INFO User test successfully authenticated 106s 2025-10-26 12:18:02,817 INFO Service ticket created for service http://127.0.0.1:44673 by user test. 106s 2025-10-26 12:18:02,825 INFO ValidateService: ticket ST-mWhQwdzGW6qRDT1RTF24v9nZSeYAfgU5FPY1iLZDmsUbVD7HObnkBsdN589mh validated for user test on service http://127.0.0.1:44673. Proxy Granting Ticket transmited to http://127.0.0.1:44673. 106s PASSED 106s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_user_field_ok 2025-10-26 12:18:02,838 INFO User test successfully authenticated 106s 2025-10-26 12:18:02,848 INFO Service ticket created for service https://user_field.example.com by user test. 106s 2025-10-26 12:18:02,853 INFO ValidateService: ticket ST-8Tn8L8h1hnyqpRkuNJG0KztOswOhclcybkFUziGhzRfKG8hZ7B9WCF8pecG2y validated for user test on service https://user_field.example.com. 106s 2025-10-26 12:18:02,862 INFO User test successfully authenticated 106s 2025-10-26 12:18:02,871 INFO Service ticket created for service https://user_field_alt.example.com by user test. 106s 2025-10-26 12:18:02,875 INFO ValidateService: ticket ST-7NTwWooqer99Jx5B3VZ8Eo1rCelFCXB6mr5KKOrUVE7rN1Adi83DhUbYPWFql validated for user test on service https://user_field_alt.example.com. 106s PASSED 106s cas_server/tests/test_view.py::ProxyTestCase::test_proxy_missing_parameter 2025-10-26 12:18:02,892 INFO User test successfully authenticated 106s 2025-10-26 12:18:02,903 INFO Service ticket created for service http://127.0.0.1:38657 by user test. 106s 2025-10-26 12:18:02,911 INFO ValidateService: ticket ST-W7BnYUJUmQL4XuXIexnsv0E7MSJ7GS5n4AV2DZihc1xShpSw6OgmDdolA3VPc validated for user test on service http://127.0.0.1:38657. Proxy Granting Ticket transmited to http://127.0.0.1:38657. 106s 2025-10-26 12:18:02,912 WARNING Proxy: validation error: INVALID_REQUEST you must specify and pgt and targetService 106s 2025-10-26 12:18:02,914 WARNING Proxy: validation error: INVALID_REQUEST you must specify and pgt and targetService 106s PASSED 106s cas_server/tests/test_view.py::ProxyTestCase::test_proxy_unauthorized_user 2025-10-26 12:18:02,929 INFO User test successfully authenticated 106s 2025-10-26 12:18:02,938 INFO Service ticket created for service http://127.0.0.1:43037 by user test. 106s 2025-10-26 12:18:02,946 INFO ValidateService: ticket ST-Xe39LZ7ylUHnQBUkwOtDLi5JcGFZOtk2MY43SMEJbqbQEDyxA1mvZohbntOpq validated for user test on service http://127.0.0.1:43037. Proxy Granting Ticket transmited to http://127.0.0.1:43037. 106s 2025-10-26 12:18:02,950 WARNING Username test not allowed on service restrict_user_fail 106s 2025-10-26 12:18:02,951 WARNING Proxy: validation error: UNAUTHORIZED_USER User test not allowed on https://restrict_user_fail.example.com 106s 2025-10-26 12:18:02,954 WARNING User constraint failed for test, service filter_fail: ^admin$ do not match right None. 106s 2025-10-26 12:18:02,954 WARNING Proxy: validation error: UNAUTHORIZED_USER User test not allowed on https://filter_fail.example.com 106s 2025-10-26 12:18:02,958 WARNING Cannot use uid a loggin for user test on service field_needed_fail because it is absent 106s 2025-10-26 12:18:02,958 WARNING Proxy: validation error: UNAUTHORIZED_USER User test not allowed on https://field_needed_fail.example.com 106s PASSED 107s cas_server/tests/test_view.py::ProxyTestCase::test_validate_proxy_bad_pgt 2025-10-26 12:18:02,974 INFO User test successfully authenticated 107s 2025-10-26 12:18:02,983 INFO Service ticket created for service http://127.0.0.1:35629 by user test. 107s 2025-10-26 12:18:02,991 INFO ValidateService: ticket ST-MFQRKs4VOdNn72XkTBJdCxuL4YxSYL9Hbzqw793kPo6Xgh1souQRoDXLr7DBb validated for user test on service http://127.0.0.1:35629. Proxy Granting Ticket transmited to http://127.0.0.1:35629. 107s 2025-10-26 12:18:02,994 WARNING Proxy: validation error: INVALID_TICKET PGT PGT-RANDOM not found 107s PASSED 107s cas_server/tests/test_view.py::ProxyTestCase::test_validate_proxy_bad_service 2025-10-26 12:18:03,009 INFO User test successfully authenticated 107s 2025-10-26 12:18:03,018 INFO Service ticket created for service http://127.0.0.1:39987 by user test. 107s 2025-10-26 12:18:03,027 INFO ValidateService: ticket ST-Y9yFJEPrsmZmXnXe2FuJMaU5dufw1M5atjX4XN3Pj1oit4jkO64nVTw6Vw7ck validated for user test on service http://127.0.0.1:39987. Proxy Granting Ticket transmited to http://127.0.0.1:39987. 107s 2025-10-26 12:18:03,029 WARNING Service https://www.example.org not allowed. 107s 2025-10-26 12:18:03,029 WARNING Proxy: validation error: UNAUTHORIZED_SERVICE https://www.example.org 107s 2025-10-26 12:18:03,032 WARNING Proxy: validation error: UNAUTHORIZED_SERVICE the service http://127.0.0.1:39987 does not allow proxy tickets 107s PASSED 107s cas_server/tests/test_view.py::ProxyTestCase::test_validate_proxy_ok 2025-10-26 12:18:03,047 INFO User test successfully authenticated 107s 2025-10-26 12:18:03,057 INFO Service ticket created for service http://127.0.0.1:33745 by user test. 107s 2025-10-26 12:18:03,065 INFO ValidateService: ticket ST-yN6PBkSaT2ry7evPxYGGxFCC7GGx1E1IexR22iqVSS7KP4v6BYEkFAhLkjRn6 validated for user test on service http://127.0.0.1:33745. Proxy Granting Ticket transmited to http://127.0.0.1:33745. 107s 2025-10-26 12:18:03,071 INFO Proxy ticket created for user test on service https://www.example.com. 107s 2025-10-26 12:18:03,075 INFO ValidateService: ticket PT-v9aU7yOcjoUNfg8cFvBzIWFYplUNbPpbYSeDURW53KAS5U31N24MRD7S1LeuG validated for user test on service https://www.example.com. 107s PASSED 107s cas_server/tests/test_view.py::SamlValidateTestCase::test_saml_bad_target 2025-10-26 12:18:03,092 INFO User test successfully authenticated 107s 2025-10-26 12:18:03,101 INFO Service ticket created for service https://www.example.com by user test. 107s 2025-10-26 12:18:03,105 WARNING SamlValidate: validation error: AuthnFailed TARGET https://www.example.org does not match ticket service 107s PASSED 107s cas_server/tests/test_view.py::SamlValidateTestCase::test_saml_bad_ticket 2025-10-26 12:18:03,113 WARNING SamlValidate: validation error: AuthnFailed ticket ST-NULtMSxLnWq2JlMNt8ox4kEMxUdsbnMt7cspuPG7MeBtfB68KaQGRYlHJRl66 not found 107s 2025-10-26 12:18:03,115 WARNING SamlValidate: validation error: AuthnFailed ticket PT-jXs57ZdE6ynXSLvPnKJNvczFfpTbRvJJ2lwxNbegl0DARjPb8ziPoilLPcD7M not found 107s PASSED 107s cas_server/tests/test_view.py::SamlValidateTestCase::test_saml_bad_ticket_prefix 2025-10-26 12:18:03,122 WARNING SamlValidate: validation error: AuthnFailed ticket RANDOM-NOT-BEGINING-WITH-ST-OR-ST should begin with PT- or ST- 107s PASSED 107s cas_server/tests/test_view.py::SamlValidateTestCase::test_saml_bad_xml 2025-10-26 12:18:03,128 WARNING SamlValidate: validation error: VersionMismatch 107s PASSED 107s cas_server/tests/test_view.py::SamlValidateTestCase::test_saml_ok 2025-10-26 12:18:03,142 INFO User test successfully authenticated 107s 2025-10-26 12:18:03,151 INFO Service ticket created for service https://www.example.com by user test. 107s 2025-10-26 12:18:03,163 INFO User test successfully authenticated 107s 2025-10-26 12:18:03,172 INFO Service ticket created for service http://127.0.0.1:36583 by user test. 107s 2025-10-26 12:18:03,180 INFO ValidateService: ticket ST-RoOqbrWyIiWs8xUgObjj5uGKzMlxiSRi9POBnwIeFqjy60hpjXr4MjuXJKLM5 validated for user test on service http://127.0.0.1:36583. Proxy Granting Ticket transmited to http://127.0.0.1:36583. 107s 2025-10-26 12:18:03,186 INFO Proxy ticket created for user test on service https://www.example.com. 107s 2025-10-26 12:18:03,191 INFO SamlValidate: ticket ST-Rq3N5tIml2p7r0s0jshqy9Uw8wm5VyC5T7pDHVn76TTsS2SYjDw3VGc4A7QAz validated for user test on service https://www.example.com. 107s 2025-10-26 12:18:03,195 INFO SamlValidate: ticket PT-HV8RkDm3LNYkJSn7bXOXoY7jUMoJd0pEIN6g09mcYMII8adoiPZPuhRhSfFwH validated for user test on service https://www.example.com. 107s PASSED 107s cas_server/tests/test_view.py::SamlValidateTestCase::test_saml_ok_user_field 2025-10-26 12:18:03,209 INFO User test successfully authenticated 107s 2025-10-26 12:18:03,220 INFO Service ticket created for service https://field_needed_success.example.com by user test. 107s 2025-10-26 12:18:03,225 INFO SamlValidate: ticket ST-knWORZRPXUhkz5O5loTslQa8QfhzAALlf5bUeHlW1p87WbK10OeaVJ7u5nD1R validated for user test on service https://field_needed_success.example.com. 107s 2025-10-26 12:18:03,235 INFO User test successfully authenticated 107s 2025-10-26 12:18:03,244 INFO Service ticket created for service https://field_needed_success_alt.example.com by user test. 107s 2025-10-26 12:18:03,249 INFO SamlValidate: ticket ST-rLKZ024uzaNaZhvqLTUsjCKm6B3A70JgOqvYpuebGPrLnCnwyD3DwoRH7bbiJ validated for user test on service https://field_needed_success_alt.example.com. 107s PASSEDDestroying test database for alias 'default'... 107s 107s 107s =============================== warnings summary =============================== 107s cas_server/tests/test_federate.py: 8 warnings 107s cas_server/tests/test_view.py: 3 warnings 107s /tmp/autopkgtest.qOLrS9/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). 107s datetime.utcnow() + timedelta(seconds=max_age), 107s 107s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_login_post_provider 107s /usr/lib/python3.14/unittest/case.py:725: DeprecationWarning: It is deprecated to return a value that is not None from a test case (> returned 'list') 107s return self.run(*args, **kwds) 107s 107s -- Docs: https://docs.pytest.org/en/stable/how-to/capture-warnings.html 107s ======================= 128 passed, 12 warnings in 7.63s ======================= 107s 107s *************************** 107s *** Testing with python3.13 107s *************************** 107s 107s Content of current working folder: 107s 107s total 20 107s drwxr-xr-x 3 ubuntu ubuntu 4096 Oct 26 12:18 . 107s drwxrwxrwx 5 root root 4096 Oct 26 12:17 .. 107s drwxrwxr-x 10 ubuntu ubuntu 4096 Oct 26 12:17 cas_server 107s -rw-rw-r-- 1 ubuntu ubuntu 140 Aug 18 2024 pytest.ini 107s -rw-rw-r-- 1 ubuntu ubuntu 152 Aug 18 2024 setup.cfg 107s Running tests... 107s 108s ============================= test session starts ============================== 108s platform linux -- Python 3.13.9, pytest-8.3.5, pluggy-1.6.0 -- /usr/bin/python3.13 108s cachedir: .pytest_cache 108s django: version: 5.2.4, settings: cas_server.tests.settings (from ini) 108s rootdir: /tmp/autopkgtest.qOLrS9/autopkgtest_tmp 108s configfile: pytest.ini 108s testpaths: cas_server/tests/ 108s plugins: typeguard-4.4.2, django-4.11.1 108s collecting ... collected 128 items 108s 108s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_auth_federate_errors Creating test database for alias 'default'... 109s 2025-10-26 12:18:05,014 WARNING Identity provider suffix exemple.fr not found 109s 2025-10-26 12:18:05,030 INFO Got an invalid ticket ST-Fu69XMaMs7lXaTj6moug5WTcGKSKubNzDV4QTUSKDUwePMqdRya7OJXAb3wEx from http://127.0.0.1:8080 for service http://testserver/federate/example.com. Retrying authentication 109s 2025-10-26 12:18:05,036 INFO Got an invalid ticket ST-ufrWukEmHq6anfm2lvIemqHsVnWa5aNbCEryQlECBHY4wbTh6wkEuSJhnsFDF from http://127.0.0.1:8080 for service http://testserver/federate/example.com. Retrying authentication 109s PASSED 109s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_auth_federate_false 2025-10-26 12:18:05,076 WARNING CAS_FEDERATE is False, set it to True to use federation 109s 2025-10-26 12:18:05,077 WARNING CAS_FEDERATE is False, set it to True to use federation 109s PASSED 109s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_auth_federate_slo 2025-10-26 12:18:05,097 INFO Trying to authenticate http://127.0.0.1:8080 again 109s 2025-10-26 12:18:05,104 INFO Got a valid ticket for dédé from http://127.0.0.1:8080 109s 2025-10-26 12:18:05,122 INFO User dédé@example.com successfully authenticated 109s 2025-10-26 12:18:05,136 INFO Service ticket created for service https://www.example.com by user dédé@example.com. 109s 2025-10-26 12:18:05,150 INFO Trying to authenticate http://127.0.0.1:8081 again 109s 2025-10-26 12:18:05,157 INFO Got a valid ticket for dédé from http://127.0.0.1:8081 109s 2025-10-26 12:18:05,169 INFO User dédé@example.org successfully authenticated 109s 2025-10-26 12:18:05,181 INFO Service ticket created for service https://www.example.com by user dédé@example.org. 109s 2025-10-26 12:18:05,194 INFO Trying to authenticate http://127.0.0.1:8082 again 109s 2025-10-26 12:18:05,201 INFO Got a valid ticket for dédé from http://127.0.0.1:8082 109s 2025-10-26 12:18:05,213 INFO User dédé@example.net successfully authenticated 109s 2025-10-26 12:18:05,223 INFO Service ticket created for service https://www.example.com by user dédé@example.net. 109s 2025-10-26 12:18:05,237 INFO Trying to authenticate http://127.0.0.1:8083 again 109s 2025-10-26 12:18:05,244 INFO Got a valid ticket for dédé from http://127.0.0.1:8083 109s 2025-10-26 12:18:05,256 INFO User dédé@example.test successfully authenticated 109s 2025-10-26 12:18:05,267 INFO Service ticket created for service https://www.example.com by user dédé@example.test. 109s 2025-10-26 12:18:05,309 INFO Got an SLO requests for ticket dédé@example.net, logging out user ST-METmmQNhmJECjxhsp8ss8ZT8rFemiG59NH4B8v1teWTq4yghmsnAHSE9GUDui 109s 2025-10-26 12:18:05,338 INFO Got an SLO requests for ticket dédé@example.test, logging out user ST-Z0kGa3TszvBCPgqOw3ORz41SvXxrlgfJn2MuUozIvctIEoudD1nM8cIRi59XE 109s PASSED 109s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_default_settings PASSED 109s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_federate_logout 2025-10-26 12:18:05,386 INFO Trying to authenticate http://127.0.0.1:8080 again 109s 2025-10-26 12:18:05,393 INFO Got a valid ticket for dédé from http://127.0.0.1:8080 109s 2025-10-26 12:18:05,405 INFO User dédé@example.com successfully authenticated 109s 2025-10-26 12:18:05,415 INFO Service ticket created for service https://www.example.com by user dédé@example.com. 109s 2025-10-26 12:18:05,429 INFO Trying to authenticate http://127.0.0.1:8081 again 109s 2025-10-26 12:18:05,435 INFO Got a valid ticket for dédé from http://127.0.0.1:8081 109s 2025-10-26 12:18:05,447 INFO User dédé@example.org successfully authenticated 109s 2025-10-26 12:18:05,458 INFO Service ticket created for service https://www.example.com by user dédé@example.org. 109s 2025-10-26 12:18:05,472 INFO Trying to authenticate http://127.0.0.1:8082 again 109s 2025-10-26 12:18:05,479 INFO Got a valid ticket for dédé from http://127.0.0.1:8082 109s 2025-10-26 12:18:05,491 INFO User dédé@example.net successfully authenticated 109s 2025-10-26 12:18:05,502 INFO Service ticket created for service https://www.example.com by user dédé@example.net. 109s 2025-10-26 12:18:05,515 INFO Trying to authenticate http://127.0.0.1:8083 again 109s 2025-10-26 12:18:05,522 INFO Got a valid ticket for dédé from http://127.0.0.1:8083 109s 2025-10-26 12:18:05,534 INFO User dédé@example.test successfully authenticated 109s 2025-10-26 12:18:05,545 INFO Service ticket created for service https://www.example.com by user dédé@example.test. 109s 2025-10-26 12:18:05,547 INFO logout requested 109s 2025-10-26 12:18:05,549 INFO Logging out user dédé@example.com. 109s 2025-10-26 12:18:05,554 INFO User dédé@example.com logged out 109s 2025-10-26 12:18:05,565 INFO logout requested 109s 2025-10-26 12:18:05,569 INFO logout requested 109s 2025-10-26 12:18:05,572 INFO Logging out user dédé@example.org. 109s 2025-10-26 12:18:05,577 INFO User dédé@example.org logged out 109s 2025-10-26 12:18:05,589 INFO logout requested 109s 2025-10-26 12:18:05,592 INFO logout requested 109s 2025-10-26 12:18:05,594 INFO Logging out user dédé@example.net. 109s 2025-10-26 12:18:05,599 INFO User dédé@example.net logged out 109s 2025-10-26 12:18:05,610 INFO logout requested 109s 2025-10-26 12:18:05,614 INFO logout requested 109s 2025-10-26 12:18:05,616 INFO Logging out user dédé@example.test. 109s 2025-10-26 12:18:05,621 INFO User dédé@example.test logged out 109s 2025-10-26 12:18:05,633 INFO logout requested 109s 2025-10-26 12:18:05,647 INFO Trying to authenticate http://127.0.0.1:8080 again 109s 2025-10-26 12:18:05,654 INFO Got a valid ticket for dédé from http://127.0.0.1:8080 109s 2025-10-26 12:18:05,667 INFO User dédé@example.com successfully authenticated 109s 2025-10-26 12:18:05,679 INFO Service ticket created for service https://www.example.com by user dédé@example.com. 109s 2025-10-26 12:18:05,692 INFO Trying to authenticate http://127.0.0.1:8081 again 109s 2025-10-26 12:18:05,699 INFO Got a valid ticket for dédé from http://127.0.0.1:8081 109s 2025-10-26 12:18:05,712 INFO User dédé@example.org successfully authenticated 109s 2025-10-26 12:18:05,723 INFO Service ticket created for service https://www.example.com by user dédé@example.org. 109s 2025-10-26 12:18:05,736 INFO Trying to authenticate http://127.0.0.1:8082 again 109s 2025-10-26 12:18:05,743 INFO Got a valid ticket for dédé from http://127.0.0.1:8082 109s 2025-10-26 12:18:05,756 INFO User dédé@example.net successfully authenticated 109s 2025-10-26 12:18:05,768 INFO Service ticket created for service https://www.example.com by user dédé@example.net. 109s 2025-10-26 12:18:05,781 INFO Trying to authenticate http://127.0.0.1:8083 again 109s 2025-10-26 12:18:05,788 INFO Got a valid ticket for dédé from http://127.0.0.1:8083 109s 2025-10-26 12:18:05,801 INFO User dédé@example.test successfully authenticated 109s 2025-10-26 12:18:05,812 INFO Service ticket created for service https://www.example.com by user dédé@example.test. 109s 2025-10-26 12:18:05,815 INFO logout requested 109s 2025-10-26 12:18:05,816 INFO Logging out user dédé. 109s 2025-10-26 12:18:05,817 INFO User dédé logged out 109s 2025-10-26 12:18:05,829 INFO logout requested 109s 2025-10-26 12:18:05,830 INFO Logging out user dédé. 109s 2025-10-26 12:18:05,832 INFO User dédé logged out 109s 2025-10-26 12:18:05,844 INFO logout requested 109s 2025-10-26 12:18:05,845 INFO Logging out user dédé. 109s 2025-10-26 12:18:05,847 INFO User dédé logged out 109s 2025-10-26 12:18:05,859 INFO logout requested 109s 2025-10-26 12:18:05,860 INFO Logging out user dédé. 109s 2025-10-26 12:18:05,861 INFO User dédé logged out 109s PASSED 109s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_forget_provider 2025-10-26 12:18:05,893 INFO Trying to authenticate http://127.0.0.1:8080 again 109s 2025-10-26 12:18:05,899 INFO Got a valid ticket for dédé from http://127.0.0.1:8080 109s 2025-10-26 12:18:05,912 INFO User dédé@example.com successfully authenticated 109s 2025-10-26 12:18:05,923 INFO Service ticket created for service https://www.example.com by user dédé@example.com. 109s 2025-10-26 12:18:05,942 INFO Trying to authenticate http://127.0.0.1:8081 again 109s 2025-10-26 12:18:05,949 INFO Got a valid ticket for dédé from http://127.0.0.1:8081 109s 2025-10-26 12:18:05,961 INFO User dédé@example.org successfully authenticated 110s 2025-10-26 12:18:05,972 INFO Service ticket created for service https://www.example.com by user dédé@example.org. 110s 2025-10-26 12:18:06,067 INFO Trying to authenticate http://127.0.0.1:8082 again 110s 2025-10-26 12:18:06,076 INFO Got a valid ticket for dédé from http://127.0.0.1:8082 110s 2025-10-26 12:18:06,090 INFO User dédé@example.net successfully authenticated 110s 2025-10-26 12:18:06,102 INFO Service ticket created for service https://www.example.com by user dédé@example.net. 110s 2025-10-26 12:18:06,119 INFO Trying to authenticate http://127.0.0.1:8083 again 110s 2025-10-26 12:18:06,126 INFO Got a valid ticket for dédé from http://127.0.0.1:8083 110s 2025-10-26 12:18:06,139 INFO User dédé@example.test successfully authenticated 110s 2025-10-26 12:18:06,151 INFO Service ticket created for service https://www.example.com by user dédé@example.test. 110s 2025-10-26 12:18:06,153 INFO logout requested 110s 2025-10-26 12:18:06,156 INFO Logging out user dédé@example.com. 110s 2025-10-26 12:18:06,162 INFO User dédé@example.com logged out 110s 2025-10-26 12:18:06,163 INFO logout requested 110s 2025-10-26 12:18:06,165 INFO Logging out user dédé@example.org. 110s 2025-10-26 12:18:06,171 INFO User dédé@example.org logged out 110s 2025-10-26 12:18:06,172 INFO logout requested 110s 2025-10-26 12:18:06,174 INFO Logging out user dédé@example.net. 110s 2025-10-26 12:18:06,180 INFO User dédé@example.net logged out 110s 2025-10-26 12:18:06,181 INFO logout requested 110s 2025-10-26 12:18:06,183 INFO Logging out user dédé@example.test. 110s 2025-10-26 12:18:06,189 INFO User dédé@example.test logged out 110s PASSED 110s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_login_bad_ticket 2025-10-26 12:18:06,208 WARNING A login attempt failed 110s PASSED 110s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_login_get_provider PASSED 110s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_login_post_provider 2025-10-26 12:18:06,253 INFO Trying to authenticate http://127.0.0.1:8080 again 110s 2025-10-26 12:18:06,260 INFO Got a valid ticket for dédé from http://127.0.0.1:8080 110s 2025-10-26 12:18:06,274 INFO User dédé@example.com successfully authenticated 110s 2025-10-26 12:18:06,286 INFO Service ticket created for service https://www.example.com by user dédé@example.com. 110s 2025-10-26 12:18:06,300 INFO Trying to authenticate http://127.0.0.1:8081 again 110s 2025-10-26 12:18:06,307 INFO Got a valid ticket for dédé from http://127.0.0.1:8081 110s 2025-10-26 12:18:06,320 INFO User dédé@example.org successfully authenticated 110s 2025-10-26 12:18:06,332 INFO Service ticket created for service https://www.example.com by user dédé@example.org. 110s 2025-10-26 12:18:06,345 INFO Trying to authenticate http://127.0.0.1:8082 again 110s 2025-10-26 12:18:06,352 INFO Got a valid ticket for dédé from http://127.0.0.1:8082 110s 2025-10-26 12:18:06,365 INFO User dédé@example.net successfully authenticated 110s 2025-10-26 12:18:06,377 INFO Service ticket created for service https://www.example.com by user dédé@example.net. 110s 2025-10-26 12:18:06,390 INFO Trying to authenticate http://127.0.0.1:8083 again 110s 2025-10-26 12:18:06,398 INFO Got a valid ticket for dédé from http://127.0.0.1:8083 110s 2025-10-26 12:18:06,412 INFO User dédé@example.test successfully authenticated 110s 2025-10-26 12:18:06,424 INFO Service ticket created for service https://www.example.com by user dédé@example.test. 110s PASSED 110s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_login_twice 2025-10-26 12:18:06,446 INFO Trying to authenticate http://127.0.0.1:8080 again 110s 2025-10-26 12:18:06,453 INFO Got a valid ticket for dédé from http://127.0.0.1:8080 110s 2025-10-26 12:18:06,467 INFO User dédé@example.com successfully authenticated 110s 2025-10-26 12:18:06,479 INFO Service ticket created for service https://www.example.com by user dédé@example.com. 110s 2025-10-26 12:18:06,493 INFO Trying to authenticate http://127.0.0.1:8081 again 110s 2025-10-26 12:18:06,500 INFO Got a valid ticket for dédé from http://127.0.0.1:8081 110s 2025-10-26 12:18:06,514 INFO User dédé@example.org successfully authenticated 110s 2025-10-26 12:18:06,526 INFO Service ticket created for service https://www.example.com by user dédé@example.org. 110s 2025-10-26 12:18:06,539 INFO Trying to authenticate http://127.0.0.1:8082 again 110s 2025-10-26 12:18:06,546 INFO Got a valid ticket for dédé from http://127.0.0.1:8082 110s 2025-10-26 12:18:06,560 INFO User dédé@example.net successfully authenticated 110s 2025-10-26 12:18:06,573 INFO Service ticket created for service https://www.example.com by user dédé@example.net. 110s 2025-10-26 12:18:06,586 INFO Trying to authenticate http://127.0.0.1:8083 again 110s 2025-10-26 12:18:06,594 INFO Got a valid ticket for dédé from http://127.0.0.1:8083 110s 2025-10-26 12:18:06,608 INFO User dédé@example.test successfully authenticated 110s 2025-10-26 12:18:06,619 INFO Service ticket created for service https://www.example.com by user dédé@example.test. 110s 2025-10-26 12:18:06,633 INFO Trying to authenticate http://127.0.0.1:8080 again 110s 2025-10-26 12:18:06,640 INFO Got a valid ticket for dédé from http://127.0.0.1:8080 110s 2025-10-26 12:18:06,658 INFO User dédé@example.com successfully authenticated 110s 2025-10-26 12:18:06,670 INFO Service ticket created for service https://www.example.com by user dédé@example.com. 110s 2025-10-26 12:18:06,683 INFO Trying to authenticate http://127.0.0.1:8081 again 110s 2025-10-26 12:18:06,691 INFO Got a valid ticket for dédé from http://127.0.0.1:8081 110s 2025-10-26 12:18:06,705 INFO User dédé@example.org successfully authenticated 110s 2025-10-26 12:18:06,717 INFO Service ticket created for service https://www.example.com by user dédé@example.org. 110s 2025-10-26 12:18:06,731 INFO Trying to authenticate http://127.0.0.1:8082 again 110s 2025-10-26 12:18:06,738 INFO Got a valid ticket for dédé from http://127.0.0.1:8082 110s 2025-10-26 12:18:06,751 INFO User dédé@example.net successfully authenticated 110s 2025-10-26 12:18:06,764 INFO Service ticket created for service https://www.example.com by user dédé@example.net. 110s 2025-10-26 12:18:06,778 INFO Trying to authenticate http://127.0.0.1:8083 again 110s 2025-10-26 12:18:06,786 INFO Got a valid ticket for dédé from http://127.0.0.1:8083 110s 2025-10-26 12:18:06,800 INFO User dédé@example.test successfully authenticated 110s 2025-10-26 12:18:06,813 INFO Service ticket created for service https://www.example.com by user dédé@example.test. 110s 2025-10-26 12:18:06,816 WARNING User already authenticated, dropping federated authentication request 110s 2025-10-26 12:18:06,818 WARNING User already authenticated, dropping federated authentication request 110s 2025-10-26 12:18:06,820 WARNING User already authenticated, dropping federated authentication request 110s 2025-10-26 12:18:06,822 WARNING User already authenticated, dropping federated authentication request 110s PASSED 110s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_remember_provider 2025-10-26 12:18:06,843 INFO Trying to authenticate http://127.0.0.1:8080 again 110s 2025-10-26 12:18:06,850 INFO Got a valid ticket for dédé from http://127.0.0.1:8080 110s 2025-10-26 12:18:06,864 INFO User dédé@example.com successfully authenticated 110s 2025-10-26 12:18:06,876 INFO Service ticket created for service https://www.example.com by user dédé@example.com. 110s 2025-10-26 12:18:06,889 INFO Trying to authenticate http://127.0.0.1:8081 again 110s 2025-10-26 12:18:06,896 INFO Got a valid ticket for dédé from http://127.0.0.1:8081 110s 2025-10-26 12:18:06,910 INFO User dédé@example.org successfully authenticated 110s 2025-10-26 12:18:06,922 INFO Service ticket created for service https://www.example.com by user dédé@example.org. 110s 2025-10-26 12:18:06,936 INFO Trying to authenticate http://127.0.0.1:8082 again 110s 2025-10-26 12:18:06,943 INFO Got a valid ticket for dédé from http://127.0.0.1:8082 110s 2025-10-26 12:18:06,957 INFO User dédé@example.net successfully authenticated 110s 2025-10-26 12:18:06,968 INFO Service ticket created for service https://www.example.com by user dédé@example.net. 111s 2025-10-26 12:18:06,982 INFO Trying to authenticate http://127.0.0.1:8083 again 111s 2025-10-26 12:18:06,989 INFO Got a valid ticket for dédé from http://127.0.0.1:8083 111s 2025-10-26 12:18:07,003 INFO User dédé@example.test successfully authenticated 111s 2025-10-26 12:18:07,015 INFO Service ticket created for service https://www.example.com by user dédé@example.test. 111s 2025-10-26 12:18:07,016 INFO logout requested 111s 2025-10-26 12:18:07,019 INFO Logging out user dédé@example.com. 111s 2025-10-26 12:18:07,025 INFO User dédé@example.com logged out 111s 2025-10-26 12:18:07,030 INFO logout requested 111s 2025-10-26 12:18:07,032 INFO Logging out user dédé@example.org. 111s 2025-10-26 12:18:07,037 INFO User dédé@example.org logged out 111s 2025-10-26 12:18:07,041 INFO logout requested 111s 2025-10-26 12:18:07,044 INFO Logging out user dédé@example.net. 111s 2025-10-26 12:18:07,049 INFO User dédé@example.net logged out 111s 2025-10-26 12:18:07,053 INFO logout requested 111s 2025-10-26 12:18:07,055 INFO Logging out user dédé@example.test. 111s 2025-10-26 12:18:07,060 INFO User dédé@example.test logged out 111s PASSED 111s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_renew 2025-10-26 12:18:07,083 INFO Trying to authenticate http://127.0.0.1:8080 again 111s 2025-10-26 12:18:07,090 INFO Got a valid ticket for dédé from http://127.0.0.1:8080 111s 2025-10-26 12:18:07,104 INFO User dédé@example.com successfully authenticated 111s 2025-10-26 12:18:07,116 INFO Service ticket created for service https://www.example.com by user dédé@example.com. 111s 2025-10-26 12:18:07,131 INFO Trying to authenticate http://127.0.0.1:8081 again 111s 2025-10-26 12:18:07,138 INFO Got a valid ticket for dédé from http://127.0.0.1:8081 111s 2025-10-26 12:18:07,151 INFO User dédé@example.org successfully authenticated 111s 2025-10-26 12:18:07,162 INFO Service ticket created for service https://www.example.com by user dédé@example.org. 111s 2025-10-26 12:18:07,177 INFO Trying to authenticate http://127.0.0.1:8082 again 111s 2025-10-26 12:18:07,184 INFO Got a valid ticket for dédé from http://127.0.0.1:8082 111s 2025-10-26 12:18:07,197 INFO User dédé@example.net successfully authenticated 111s 2025-10-26 12:18:07,209 INFO Service ticket created for service https://www.example.com by user dédé@example.net. 111s 2025-10-26 12:18:07,222 INFO Trying to authenticate http://127.0.0.1:8083 again 111s 2025-10-26 12:18:07,229 INFO Got a valid ticket for dédé from http://127.0.0.1:8083 111s 2025-10-26 12:18:07,242 INFO User dédé@example.test successfully authenticated 111s 2025-10-26 12:18:07,253 INFO Service ticket created for service https://www.example.com by user dédé@example.test. 111s 2025-10-26 12:18:07,259 INFO Trying to authenticate http://127.0.0.1:8080 again 111s 2025-10-26 12:18:07,266 INFO Got a valid ticket for dédé from http://127.0.0.1:8080 111s 2025-10-26 12:18:07,285 INFO User dédé@example.com successfully authenticated 111s 2025-10-26 12:18:07,290 INFO Service ticket created for service https://www.example.com by user dédé@example.com. 111s 2025-10-26 12:18:07,298 INFO Trying to authenticate http://127.0.0.1:8081 again 111s 2025-10-26 12:18:07,305 INFO Got a valid ticket for dédé from http://127.0.0.1:8081 111s 2025-10-26 12:18:07,318 INFO User dédé@example.org successfully authenticated 111s 2025-10-26 12:18:07,323 INFO Service ticket created for service https://www.example.com by user dédé@example.org. 111s 2025-10-26 12:18:07,331 INFO Trying to authenticate http://127.0.0.1:8082 again 111s 2025-10-26 12:18:07,338 INFO Got a valid ticket for dédé from http://127.0.0.1:8082 111s 2025-10-26 12:18:07,352 INFO User dédé@example.net successfully authenticated 111s 2025-10-26 12:18:07,358 INFO Service ticket created for service https://www.example.com by user dédé@example.net. 111s 2025-10-26 12:18:07,366 INFO Trying to authenticate http://127.0.0.1:8083 again 111s 2025-10-26 12:18:07,374 INFO Got a valid ticket for dédé from http://127.0.0.1:8083 111s 2025-10-26 12:18:07,387 INFO User dédé@example.test successfully authenticated 111s 2025-10-26 12:18:07,393 INFO Service ticket created for service https://www.example.com by user dédé@example.test. 111s PASSED 111s cas_server/tests/test_models.py::FederatedUserTestCase::test_clean_old_entries PASSED 111s cas_server/tests/test_models.py::FederatedUserTestCase::test_json_attributes PASSED 111s cas_server/tests/test_models.py::FederateSLOTestCase::test_clean_deleted_sessions PASSED 111s cas_server/tests/test_models.py::UserAttributesTestCase::test_clean_old_entries 2025-10-26 12:18:07,451 INFO User test successfully authenticated 111s PASSED 111s cas_server/tests/test_models.py::UserTestCase::test_cached_attributs 2025-10-26 12:18:07,474 INFO User test successfully authenticated 111s PASSED 111s cas_server/tests/test_models.py::UserTestCase::test_clean_deleted_sessions 2025-10-26 12:18:07,493 INFO User test successfully authenticated 111s 2025-10-26 12:18:07,507 INFO User test successfully authenticated 111s 2025-10-26 12:18:07,520 INFO Sending SLO requests to service http://127.0.0.1:45678 for user test 111s 2025-10-26 12:18:07,525 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')) 111s PASSED 111s cas_server/tests/test_models.py::UserTestCase::test_clean_old_entries 2025-10-26 12:18:07,541 INFO User test successfully authenticated 111s PASSED 111s cas_server/tests/test_models.py::UserTestCase::test_clean_old_entries_tgt_expired 2025-10-26 12:18:07,562 INFO User test successfully authenticated 111s PASSED 111s cas_server/tests/test_models.py::TicketTestCase::test_clean_old_service_ticket 2025-10-26 12:18:07,587 INFO User test successfully authenticated 111s 2025-10-26 12:18:07,603 INFO Sending SLO requests to service http://127.0.0.1:36321 for user test 111s 2025-10-26 12:18:07,607 WARNING Error durring SLO ('Connection aborted.', RemoteDisconnected('Remote end closed connection without response')) 111s ConnectionError(ProtocolError('Connection aborted.', RemoteDisconnected('Remote end closed connection without response'))) 111s PASSED 111s cas_server/tests/test_models.py::TicketTestCase::test_json_attributes 2025-10-26 12:18:07,631 INFO User test successfully authenticated 111s PASSED 111s cas_server/tests/test_models.py::NewVersionWarningTestCase::test_send_mails PASSED 111s cas_server/tests/test_models.py::NewVersionWarningTestCase::test_send_mails_disabled PASSED 111s cas_server/tests/test_models.py::NewVersionWarningTestCase::test_send_mails_no_admins PASSED 111s cas_server/tests/test_models.py::NewVersionWarningTestCase::test_send_mails_same_version PASSED 111s cas_server/tests/test_templatetags.py::TemplateTagsTestCase::test_is_checkbox PASSED 111s cas_server/tests/test_templatetags.py::TemplateTagsTestCase::test_is_hidden PASSED 111s cas_server/tests/test_utils.py::CheckPasswordCase::test_bad_method PASSED 111s cas_server/tests/test_utils.py::CheckPasswordCase::test_crypt PASSED 111s cas_server/tests/test_utils.py::CheckPasswordCase::test_hex PASSED 111s cas_server/tests/test_utils.py::CheckPasswordCase::test_ldap_password_fail PASSED 111s cas_server/tests/test_utils.py::CheckPasswordCase::test_ldap_password_valid PASSED 111s cas_server/tests/test_utils.py::CheckPasswordCase::test_plain PASSED 111s cas_server/tests/test_utils.py::CheckPasswordCase::test_plain_unicode PASSED 111s cas_server/tests/test_utils.py::CheckPasswordCase::test_setup PASSED 111s cas_server/tests/test_utils.py::UtilsTestCase::test_crypt_salt_is_valid PASSED 111s cas_server/tests/test_utils.py::UtilsTestCase::test_dictfetchall PASSED 111s cas_server/tests/test_utils.py::UtilsTestCase::test_get_current_url PASSED 111s cas_server/tests/test_utils.py::UtilsTestCase::test_get_tuple PASSED 111s cas_server/tests/test_utils.py::UtilsTestCase::test_import_attr PASSED 112s cas_server/tests/test_utils.py::UtilsTestCase::test_last_version PASSED 112s cas_server/tests/test_utils.py::UtilsTestCase::test_regexpr_validator PASSED 112s cas_server/tests/test_utils.py::UtilsTestCase::test_update_url PASSED 112s cas_server/tests/test_view.py::LoginTestCase::test_ajax_get_ticket_fail 2025-10-26 12:18:08,471 INFO User test successfully authenticated 112s 2025-10-26 12:18:08,477 WARNING Service https://www.example.org not allowed. 112s PASSED 112s cas_server/tests/test_view.py::LoginTestCase::test_ajax_get_ticket_success 2025-10-26 12:18:08,491 INFO User test successfully authenticated 112s 2025-10-26 12:18:08,499 INFO Service ticket created for service https://www.example.com by user test. 112s PASSED 112s cas_server/tests/test_view.py::LoginTestCase::test_ajax_get_ticket_success_alt 2025-10-26 12:18:08,513 INFO User test successfully authenticated 112s 2025-10-26 12:18:08,521 INFO Service ticket created for service https://www.example.com by user test. 112s PASSED 112s cas_server/tests/test_view.py::LoginTestCase::test_ajax_get_ticket_warn 2025-10-26 12:18:08,535 INFO User test successfully authenticated 112s PASSED 112s cas_server/tests/test_view.py::LoginTestCase::test_ajax_logged 2025-10-26 12:18:08,559 INFO User test successfully authenticated 112s PASSED 112s cas_server/tests/test_view.py::LoginTestCase::test_ajax_logged_user_deleted 2025-10-26 12:18:08,580 INFO User test successfully authenticated 112s 2025-10-26 12:18:08,588 WARNING User test seems authenticated but is not found in the database. 112s 2025-10-26 12:18:08,588 INFO Logging out user test. 112s 2025-10-26 12:18:08,590 INFO User test logged out 112s PASSED 112s cas_server/tests/test_view.py::LoginTestCase::test_ajax_login_required PASSED 112s cas_server/tests/test_view.py::LoginTestCase::test_gateway 2025-10-26 12:18:08,613 INFO User test successfully authenticated 112s 2025-10-26 12:18:08,620 WARNING Username test not allowed on service restrict_user_fail 112s PASSED 112s cas_server/tests/test_view.py::LoginTestCase::test_login_post_missing_params 2025-10-26 12:18:08,638 WARNING A login attempt failed 112s 2025-10-26 12:18:08,658 WARNING A login attempt failed 112s 2025-10-26 12:18:08,675 WARNING A login attempt failed 112s PASSED 112s cas_server/tests/test_view.py::LoginTestCase::test_login_view_post_badlt 2025-10-26 12:18:08,702 WARNING Received an invalid login ticket 112s PASSED 112s cas_server/tests/test_view.py::LoginTestCase::test_login_view_post_badpass_good_lt 2025-10-26 12:18:08,724 WARNING A login attempt failed 112s PASSED 112s cas_server/tests/test_view.py::LoginTestCase::test_login_view_post_goodpass_goodlt 2025-10-26 12:18:08,747 INFO User test successfully authenticated 112s PASSED 112s cas_server/tests/test_view.py::LoginTestCase::test_login_view_post_goodpass_goodlt_warn 2025-10-26 12:18:08,768 INFO User test successfully authenticated 112s PASSED 113s cas_server/tests/test_view.py::LoginTestCase::test_lt_max PASSED 113s cas_server/tests/test_view.py::LoginTestCase::test_messages_info_box_bad_messages PASSED 113s cas_server/tests/test_view.py::LoginTestCase::test_messages_info_box_disabled PASSED 113s cas_server/tests/test_view.py::LoginTestCase::test_messages_info_box_enabled PASSED 113s cas_server/tests/test_view.py::LoginTestCase::test_new_version_available_badpypi PASSED 113s cas_server/tests/test_view.py::LoginTestCase::test_new_version_available_disabled PASSED 113s cas_server/tests/test_view.py::LoginTestCase::test_new_version_available_ok PASSED 113s cas_server/tests/test_view.py::LoginTestCase::test_renew 2025-10-26 12:18:09,925 INFO User test successfully authenticated 113s 2025-10-26 12:18:09,939 INFO User test successfully authenticated 113s 2025-10-26 12:18:09,944 INFO Service ticket created for service https://www.example.com by user test. 113s PASSED 113s cas_server/tests/test_view.py::LoginTestCase::test_renew_message_disabled 2025-10-26 12:18:09,961 INFO User test successfully authenticated 114s 2025-10-26 12:18:09,974 INFO User test successfully authenticated 114s 2025-10-26 12:18:09,979 INFO Service ticket created for service https://www.example.com by user test. 114s PASSED 114s cas_server/tests/test_view.py::LoginTestCase::test_service_filter 2025-10-26 12:18:09,994 INFO User test successfully authenticated 114s 2025-10-26 12:18:10,003 WARNING User constraint failed for test, service filter_fail: ^admin$ do not match right None. 114s 2025-10-26 12:18:10,007 WARNING User constraint failed for test, service filter_fail_alt: ^toto$ do not match nom Nymous. 114s 2025-10-26 12:18:10,014 INFO Service ticket created for service https://filter_success.example.com by user test. 114s PASSED 114s cas_server/tests/test_view.py::LoginTestCase::test_service_restrict_user 2025-10-26 12:18:10,028 INFO User test successfully authenticated 114s 2025-10-26 12:18:10,035 WARNING Username test not allowed on service restrict_user_fail 114s 2025-10-26 12:18:10,042 INFO Service ticket created for service https://restrict_user_success.example.com by user test. 114s PASSED 114s cas_server/tests/test_view.py::LoginTestCase::test_service_user_field 2025-10-26 12:18:10,058 INFO User test successfully authenticated 114s 2025-10-26 12:18:10,065 WARNING Cannot use uid a loggin for user test on service field_needed_fail because it is absent 114s 2025-10-26 12:18:10,072 INFO Service ticket created for service https://field_needed_success.example.com by user test. 114s PASSED 114s cas_server/tests/test_view.py::LoginTestCase::test_service_user_field_evaluate_to_false 2025-10-26 12:18:10,087 INFO User test successfully authenticated 114s 2025-10-26 12:18:10,093 WARNING Cannot use alias a loggin for user test on service field_needed_success because it is absent 114s PASSED 114s cas_server/tests/test_view.py::LoginTestCase::test_user_logged_not_in_db 2025-10-26 12:18:10,110 INFO User test successfully authenticated 114s 2025-10-26 12:18:10,119 WARNING User test seems authenticated but is not found in the database. 114s 2025-10-26 12:18:10,119 INFO Logging out user test. 114s 2025-10-26 12:18:10,120 INFO User test logged out 114s PASSED 114s cas_server/tests/test_view.py::LoginTestCase::test_view_login_get_allowed_service PASSED 114s cas_server/tests/test_view.py::LoginTestCase::test_view_login_get_allowed_service_no_message PASSED 114s cas_server/tests/test_view.py::LoginTestCase::test_view_login_get_auth_allowed_service 2025-10-26 12:18:10,162 INFO User test successfully authenticated 114s 2025-10-26 12:18:10,171 INFO Service ticket created for service https://www.example.com/é by user test. 114s PASSED 114s cas_server/tests/test_view.py::LoginTestCase::test_view_login_get_auth_allowed_service_non_ascii 2025-10-26 12:18:10,187 INFO User test successfully authenticated 114s 2025-10-26 12:18:10,196 INFO Service ticket created for service https://www.example.com by user test. 114s PASSED 114s cas_server/tests/test_view.py::LoginTestCase::test_view_login_get_auth_allowed_service_warn 2025-10-26 12:18:10,214 INFO User test successfully authenticated 114s 2025-10-26 12:18:10,228 WARNING Received a login attempt for an already-active user 114s 2025-10-26 12:18:10,232 INFO Service ticket created for service https://www.example.com by user test. 114s PASSED 114s cas_server/tests/test_view.py::LoginTestCase::test_view_login_get_auth_denied_service 2025-10-26 12:18:10,248 INFO User test successfully authenticated 114s 2025-10-26 12:18:10,255 WARNING Service https://www.example.org not allowed. 114s PASSED 114s cas_server/tests/test_view.py::LoginTestCase::test_view_login_get_denied_service 2025-10-26 12:18:10,265 WARNING Service https://www.example.net not allowed. 114s PASSED 114s cas_server/tests/test_view.py::LoginTestCase::test_view_login_get_denied_service_no_message 2025-10-26 12:18:10,278 WARNING Service https://www.example.net not allowed. 114s PASSED 114s cas_server/tests/test_view.py::LogoutTestCase::test_ajax_logout 2025-10-26 12:18:10,297 INFO User test successfully authenticated 114s 2025-10-26 12:18:10,303 INFO logout requested 114s 2025-10-26 12:18:10,304 INFO Logging out user test. 114s 2025-10-26 12:18:10,309 INFO User test logged out 114s PASSED 114s cas_server/tests/test_view.py::LogoutTestCase::test_ajax_logout_all_session 2025-10-26 12:18:10,322 INFO User test successfully authenticated 114s 2025-10-26 12:18:10,334 INFO User test successfully authenticated 114s 2025-10-26 12:18:10,348 INFO User test successfully authenticated 114s 2025-10-26 12:18:10,360 INFO User test successfully authenticated 114s 2025-10-26 12:18:10,373 INFO User test successfully authenticated 114s 2025-10-26 12:18:10,379 INFO logout requested 114s 2025-10-26 12:18:10,380 INFO Logging out user test from all sessions. 114s 2025-10-26 12:18:10,398 INFO User test logged out 114s PASSED 114s cas_server/tests/test_view.py::LogoutTestCase::test_ajax_redirect_after_logout 2025-10-26 12:18:10,411 INFO User test successfully authenticated 114s 2025-10-26 12:18:10,416 INFO logout requested 114s 2025-10-26 12:18:10,417 INFO Logging out user test. 114s 2025-10-26 12:18:10,425 INFO User test logged out 114s PASSED 114s cas_server/tests/test_view.py::LogoutTestCase::test_logout 2025-10-26 12:18:10,430 INFO logout requested 114s PASSED 114s cas_server/tests/test_view.py::LogoutTestCase::test_logout_from_all_session 2025-10-26 12:18:10,446 INFO User test successfully authenticated 114s 2025-10-26 12:18:10,458 INFO User test successfully authenticated 114s 2025-10-26 12:18:10,463 INFO logout requested 114s 2025-10-26 12:18:10,464 INFO Logging out user test from all sessions. 114s 2025-10-26 12:18:10,472 INFO User test logged out 114s PASSED 114s cas_server/tests/test_view.py::LogoutTestCase::test_logout_slo 2025-10-26 12:18:10,486 INFO User test successfully authenticated 114s 2025-10-26 12:18:10,496 INFO Service ticket created for service http://127.0.0.1:35759 by user test. 114s 2025-10-26 12:18:10,502 INFO Validate: Service ticket ST-wHzA360qd0Kyn7ErUm1nUaUjtekLiRk8DgdsJ0X6TsEG9zaSYljZ5C3jtLETj validated, user test authenticated on service http://127.0.0.1:35759 114s 2025-10-26 12:18:10,504 INFO logout requested 114s 2025-10-26 12:18:10,505 INFO Logging out user test. 114s 2025-10-26 12:18:10,508 INFO Sending SLO requests to service http://127.0.0.1:35759 for user test 114s 2025-10-26 12:18:10,513 WARNING Error during SLO for user test: ('Connection aborted.', RemoteDisconnected('Remote end closed connection without response')) 114s 2025-10-26 12:18:10,515 INFO User test logged out 114s 2025-10-26 12:18:10,526 INFO User test successfully authenticated 114s 2025-10-26 12:18:10,535 INFO Service ticket created for service http://127.0.0.1:45678 by user test. 114s 2025-10-26 12:18:10,540 INFO Validate: Service ticket ST-gye11OUejgKnNCX4MxKIWh4tSmycjD7MB3yjzYax1k8r3HNJahN68Qt0dVjld validated, user test authenticated on service http://127.0.0.1:45678 114s 2025-10-26 12:18:10,542 INFO logout requested 114s 2025-10-26 12:18:10,544 INFO Logging out user test. 114s 2025-10-26 12:18:10,548 INFO Sending SLO requests to service http://127.0.0.1:45678 for user test 114s 2025-10-26 12:18:10,553 WARNING Error during SLO for user test: ('Connection aborted.', RemoteDisconnected('Remote end closed connection without response')) 114s 2025-10-26 12:18:10,555 INFO User test logged out 114s 2025-10-26 12:18:10,565 INFO User test successfully authenticated 114s 2025-10-26 12:18:10,575 INFO Service ticket created for service http://127.0.0.1:45678 by user test. 114s 2025-10-26 12:18:10,579 INFO Validate: Service ticket ST-0EjQTNg2ASVi3eVvsdyL37J9UBYABQffJN6kvdiaeJ1MY2pG8W2M8ZvlrVVUz validated, user test authenticated on service http://127.0.0.1:45678 114s 2025-10-26 12:18:10,582 INFO logout requested 114s 2025-10-26 12:18:10,583 INFO Logging out user test. 114s 2025-10-26 12:18:10,586 INFO Sending SLO requests to service http://127.0.0.1:45678 for user test 114s 2025-10-26 12:18:10,590 WARNING Error during SLO for user test: HTTPConnectionPool(host='127.0.0.1', port=43851): Max retries exceeded with url: / (Caused by NewConnectionError(': Failed to establish a new connection: [Errno 111] Connection refused')) 114s 2025-10-26 12:18:10,592 INFO User test logged out 114s PASSED 114s cas_server/tests/test_view.py::LogoutTestCase::test_logout_view 2025-10-26 12:18:10,607 INFO User test successfully authenticated 114s 2025-10-26 12:18:10,621 INFO User test successfully authenticated 114s 2025-10-26 12:18:10,630 INFO logout requested 114s 2025-10-26 12:18:10,631 INFO Logging out user test. 114s 2025-10-26 12:18:10,636 INFO User test logged out 114s PASSED 114s cas_server/tests/test_view.py::LogoutTestCase::test_logout_view_service 2025-10-26 12:18:10,658 INFO User test successfully authenticated 114s 2025-10-26 12:18:10,663 INFO logout requested 114s 2025-10-26 12:18:10,665 INFO Logging out user test. 114s 2025-10-26 12:18:10,670 INFO User test logged out 114s PASSED 114s cas_server/tests/test_view.py::LogoutTestCase::test_logout_view_url 2025-10-26 12:18:10,689 INFO User test successfully authenticated 114s 2025-10-26 12:18:10,694 INFO logout requested 114s 2025-10-26 12:18:10,696 INFO Logging out user test. 114s 2025-10-26 12:18:10,700 INFO User test logged out 114s PASSED 114s cas_server/tests/test_view.py::LogoutTestCase::test_redirect_after_logout 2025-10-26 12:18:10,719 INFO User test successfully authenticated 114s 2025-10-26 12:18:10,724 INFO logout requested 114s 2025-10-26 12:18:10,726 INFO Logging out user test. 114s 2025-10-26 12:18:10,735 INFO User test logged out 114s PASSED 114s cas_server/tests/test_view.py::LogoutTestCase::test_redirect_after_logout_to_service 2025-10-26 12:18:10,749 INFO User test successfully authenticated 114s 2025-10-26 12:18:10,754 INFO logout requested 114s 2025-10-26 12:18:10,755 INFO Logging out user test. 114s 2025-10-26 12:18:10,759 INFO User test logged out 114s 2025-10-26 12:18:10,767 INFO logout requested 114s PASSED 114s cas_server/tests/test_view.py::AuthTestCase::test_auth_view_badpass PASSED 114s cas_server/tests/test_view.py::AuthTestCase::test_auth_view_badsecret PASSED 114s cas_server/tests/test_view.py::AuthTestCase::test_auth_view_badservice 2025-10-26 12:18:10,792 WARNING Service https://www.example.org not allowed. 114s PASSED 114s cas_server/tests/test_view.py::AuthTestCase::test_auth_view_badsettings PASSED 114s cas_server/tests/test_view.py::AuthTestCase::test_auth_view_goodpass PASSED 114s cas_server/tests/test_view.py::AuthTestCase::test_auth_view_goodpass_logged 2025-10-26 12:18:10,816 INFO User test successfully authenticated 114s PASSED 114s cas_server/tests/test_view.py::AuthTestCase::test_auth_view_missing_parameter PASSED 114s cas_server/tests/test_view.py::ValidateTestCase::test_validate_missing_parameter 2025-10-26 12:18:10,842 INFO User test successfully authenticated 114s 2025-10-26 12:18:10,852 INFO Service ticket created for service https://www.example.com by user test. 114s 2025-10-26 12:18:10,855 WARNING Validate: service or ticket missing 114s 2025-10-26 12:18:10,856 WARNING Validate: service or ticket missing 114s PASSED 114s cas_server/tests/test_view.py::ValidateTestCase::test_validate_service_renew 2025-10-26 12:18:10,869 INFO User test successfully authenticated 114s 2025-10-26 12:18:10,874 INFO Service ticket created for service https://www.example.com by user test. 114s 2025-10-26 12:18:10,879 INFO Validate: Service ticket ST-C8OxYbIAtokG5BqFy6qH24SMMbTgElEeyVRK1tbdYj8lgEeLW4qjB6p6DaBdt validated, user test authenticated on service https://www.example.com 114s 2025-10-26 12:18:10,889 INFO User test successfully authenticated 114s 2025-10-26 12:18:10,894 INFO Service ticket created for service https://www.example.com by user test. 114s 2025-10-26 12:18:10,898 INFO Validate: Service ticket ST-omxl9TcVs8O6FpoJ8jZDzh9jEkburFevKX9aMwGCBJRtkjAgBbxJVgs29cbQf validated, user test authenticated on service https://www.example.com 114s 2025-10-26 12:18:10,904 INFO Service ticket created for service https://www.example.com by user test. 114s 2025-10-26 12:18:10,906 WARNING Validate: Service ticket ST-2ddZokCxiiKl6P0za00EghGBo7tvsEyJoQsTUmr89SgtNzleCYxjew7onCU3I not found or already validated, auth to https://www.example.com failed 114s PASSED 114s cas_server/tests/test_view.py::ValidateTestCase::test_validate_user_field_ok 2025-10-26 12:18:10,920 INFO User test successfully authenticated 114s 2025-10-26 12:18:10,932 INFO Service ticket created for service https://user_field.example.com by user test. 114s 2025-10-26 12:18:10,936 INFO Validate: Service ticket ST-tGwHELnjXDhjXCVCYp8lSQYZOIwklmEGijo61iYaSA3KAZZfFuHIAxweP0jVN validated, user test authenticated on service https://user_field.example.com 114s 2025-10-26 12:18:10,946 INFO User test successfully authenticated 114s 2025-10-26 12:18:10,955 INFO Service ticket created for service https://user_field_alt.example.com by user test. 114s 2025-10-26 12:18:10,960 INFO Validate: Service ticket ST-tobglErRo8Vx6D3txX6XLZhNMpI5uaNsALNikaLL7ed7fRU5DObHcjdoAk3To validated, user test authenticated on service https://user_field_alt.example.com 114s PASSED 115s cas_server/tests/test_view.py::ValidateTestCase::test_validate_view_badservice 2025-10-26 12:18:10,974 INFO User test successfully authenticated 115s 2025-10-26 12:18:10,984 INFO Service ticket created for service https://www.example.com by user test. 115s 2025-10-26 12:18:10,988 WARNING Validate: Service ticket ST-KgwVMWNcwuWBRpqPNYpebfiyGh2yPeV09mhuZmHbjferjQ5SB13YqWsWNjuJB not found or already validated, auth to https://www.example.org failed 115s PASSED 115s cas_server/tests/test_view.py::ValidateTestCase::test_validate_view_badticket 2025-10-26 12:18:11,001 INFO User test successfully authenticated 115s PASSED 115s cas_server/tests/test_view.py::ValidateTestCase::test_validate_view_ok 2025-10-26 12:18:11,010 INFO Service ticket created for service https://www.example.com by user test. 115s 2025-10-26 12:18:11,014 WARNING Validate: Service ticket ST-RANDOM not found or already validated, auth to https://www.example.com failed 115s 2025-10-26 12:18:11,027 INFO User test successfully authenticated 115s 2025-10-26 12:18:11,036 INFO Service ticket created for service https://www.example.com by user test. 115s PASSED 115s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_missing_parameter 2025-10-26 12:18:11,041 INFO Validate: Service ticket ST-NsjjzkOX2HxmUbec33LpzlBjRrnOZaqHqaWnEhamiOuDi8xKjnkrnnxMZ6tcb validated, user test authenticated on service https://www.example.com 115s 2025-10-26 12:18:11,056 INFO User test successfully authenticated 115s PASSED 115s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_proxy 2025-10-26 12:18:11,065 INFO Service ticket created for service http://127.0.0.1:45678 by user test. 115s 2025-10-26 12:18:11,068 WARNING ValidateService: missing ticket or service 115s 2025-10-26 12:18:11,070 WARNING ValidateService: missing ticket or service 115s 2025-10-26 12:18:11,087 INFO User test successfully authenticated 115s 2025-10-26 12:18:11,096 INFO Service ticket created for service http://127.0.0.1:33427 by user test. 115s 2025-10-26 12:18:11,106 INFO ValidateService: ticket ST-oEGS6M8LNiNlo9MrPSnQGdSbjUV6dFeQpErXatWEu5BzWAU4yetV1xHC2kNjI validated for user test on service http://127.0.0.1:33427. Proxy Granting Ticket transmited to http://127.0.0.1:33427. 115s 2025-10-26 12:18:11,114 INFO Proxy ticket created for user test on service http://127.0.0.1:45678. 115s 2025-10-26 12:18:11,120 INFO ValidateService: ticket PT-n4j3Ter1H938XAAIvxawJyALTOsKF5O4KNfPlqOddt93hgRgdVBHbOHaKfzSK validated for user test on service http://127.0.0.1:45678. 115s 2025-10-26 12:18:11,131 INFO User test successfully authenticated 115s 2025-10-26 12:18:11,140 INFO Service ticket created for service http://127.0.0.1:43435 by user test. 115s 2025-10-26 12:18:11,149 INFO ValidateService: ticket ST-1MqApSYpy4RitA1FcIdHqLJblrwXIgEOzNenkQroQ7RoLt8Mb6UBsCZz1LLvl validated for user test on service http://127.0.0.1:43435. Proxy Granting Ticket transmited to http://127.0.0.1:43435. 115s 2025-10-26 12:18:11,155 INFO Proxy ticket created for user test on service http://127.0.0.1:45678. 115s 2025-10-26 12:18:11,157 WARNING ValidateService: validation error: INVALID_TICKET PT-UcRHR0JCVyZOkfPP1TnTDNBBgi7CwJExCogjE7F7u1IzHE6PbNM0vSg3Eyqrc 115s PASSED 115s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_replace_attributes 2025-10-26 12:18:11,172 INFO User test successfully authenticated 115s 2025-10-26 12:18:11,182 INFO Service ticket created for service https://replace_attribute.example.com by user test. 115s 2025-10-26 12:18:11,187 INFO ValidateService: ticket ST-4nv8mje32Hj0gl9lUWyfxmpKczS5wAUxqYtLEZDfkcAi3Y5TaZNAXu61UzpuM validated for user test on service https://replace_attribute.example.com. 115s 2025-10-26 12:18:11,200 INFO User test successfully authenticated 115s 2025-10-26 12:18:11,209 INFO Service ticket created for service https://replace_attribute_list.example.com by user test. 115s 2025-10-26 12:18:11,213 INFO ValidateService: ticket ST-uC0dPNDMZewdIbNZuWXjmJX6uDItg8ozXLn7YHRTEwBrkDkDTVQTAlcCxUNZz validated for user test on service https://replace_attribute_list.example.com. 115s PASSED 115s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_service_pgturl_404 2025-10-26 12:18:11,228 INFO User test successfully authenticated 115s 2025-10-26 12:18:11,237 INFO Service ticket created for service http://127.0.0.1:43107 by user test. 115s 2025-10-26 12:18:11,248 INFO ValidateService: ticket ST-7gHz7tQZ1PGTKW3Gv3KUeVwCd46o6L4k51i5oFJrxJu72FeEsMbhr2Sgn1RPV validated for user test on service http://127.0.0.1:43107. Proxy Granting Ticket transmited to http://127.0.0.1:43107. 115s PASSED 115s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_service_pgturl_bad_proxy_callback 2025-10-26 12:18:11,262 INFO User test successfully authenticated 115s 2025-10-26 12:18:11,271 INFO Service ticket created for service http://127.0.0.1:45678 by user test. 115s 2025-10-26 12:18:11,276 WARNING ValidateService: validation error: INVALID_PROXY_CALLBACK callback url not allowed by configuration 115s 2025-10-26 12:18:11,285 INFO User test successfully authenticated 115s 2025-10-26 12:18:11,294 INFO Service ticket created for service http://127.0.0.1:45678 by user test. 115s PASSED 115s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_service_pgturl_sslerror 2025-10-26 12:18:11,300 WARNING Service https://www.example.org not allowed. 115s 2025-10-26 12:18:11,300 WARNING ValidateService: validation error: INVALID_PROXY_CALLBACK callback url not allowed by configuration 115s 2025-10-26 12:18:11,314 INFO User test successfully authenticated 115s 2025-10-26 12:18:11,323 INFO Service ticket created for service https://127.0.0.1:33343 by user test. 115s 2025-10-26 12:18:11,330 WARNING ValidateService: validation error: INVALID_PROXY_CALLBACK : HTTPSConnectionPool(host='127.0.0.1', port=33343): Max retries exceeded with url: /?pgtId=PGT-zvAFP2aXcKJJOWQJtbXhDTeSPIfHdPUsvWszW7Vhl0k3aDCsv0bPQev3K8RX&pgtIou=PGTIOU-qxKSAjbOCVvhs0cg2NylFHBt0sCPZpI7eDR6Tef7inEP0LEKabSw7xTD9 (Caused by SSLError(SSLError(1, '[SSL: RECORD_LAYER_FAILURE] record layer failure (_ssl.c:1033)'))) 115s PASSED 115s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_service_renew 2025-10-26 12:18:11,348 INFO User test successfully authenticated 115s 2025-10-26 12:18:11,353 INFO Service ticket created for service http://127.0.0.1:45678 by user test. 115s 2025-10-26 12:18:11,357 INFO ValidateService: ticket ST-A85gTGczUwfNjapVehosdBa1xW49hSV7q9w4f19AKqg1kRIx8Ox5XhD9qZS1b validated for user test on service http://127.0.0.1:45678. 115s 2025-10-26 12:18:11,366 INFO User test successfully authenticated 115s 2025-10-26 12:18:11,371 INFO Service ticket created for service http://127.0.0.1:45678 by user test. 115s 2025-10-26 12:18:11,375 INFO ValidateService: ticket ST-XHAvmbKNCURe3IDExrmWXtQekV3gjFsfJfayjijXDGuZd1d2WUTvnOHfnPyGU validated for user test on service http://127.0.0.1:45678. 115s 2025-10-26 12:18:11,381 INFO Service ticket created for service http://127.0.0.1:45678 by user test. 115s 2025-10-26 12:18:11,383 WARNING ValidateService: validation error: INVALID_TICKET ticket not found 115s PASSED 115s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_service_view_badservice 2025-10-26 12:18:11,398 INFO User test successfully authenticated 115s 2025-10-26 12:18:11,406 INFO Service ticket created for service http://127.0.0.1:45678 by user test. 115s 2025-10-26 12:18:11,410 WARNING ValidateService: validation error: INVALID_SERVICE https://www.example.org 115s PASSED 115s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_service_view_badticket_badprefix 2025-10-26 12:18:11,423 INFO User test successfully authenticated 115s 2025-10-26 12:18:11,431 INFO Service ticket created for service http://127.0.0.1:45678 by user test. 115s 2025-10-26 12:18:11,434 WARNING ValidateService: validation error: INVALID_TICKET RANDOM 115s PASSED 115s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_service_view_badticket_goodprefix 2025-10-26 12:18:11,448 INFO User test successfully authenticated 115s 2025-10-26 12:18:11,456 INFO Service ticket created for service http://127.0.0.1:45678 by user test. 115s 2025-10-26 12:18:11,460 WARNING ValidateService: validation error: INVALID_TICKET ticket not found 115s PASSED 115s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_service_view_ok 2025-10-26 12:18:11,473 INFO User test successfully authenticated 115s 2025-10-26 12:18:11,482 INFO Service ticket created for service http://127.0.0.1:45678 by user test. 115s 2025-10-26 12:18:11,487 INFO ValidateService: ticket ST-L2guhiVM80xkDa06ShRqqDheLlb85u85GekOaYSDjId9huwikJV5p42T0i8lc validated for user test on service http://127.0.0.1:45678. 115s PASSED 115s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_service_view_ok_one_attribute 2025-10-26 12:18:11,501 INFO User test successfully authenticated 115s 2025-10-26 12:18:11,510 INFO Service ticket created for service https://one_attribute.example.com by user test. 115s 2025-10-26 12:18:11,515 INFO ValidateService: ticket ST-l09t6HnWOSWzy28BTKd5rtYyq10dJNVWL4jNYvWmYCboMmbsbq4hxVeBHnIS0 validated for user test on service https://one_attribute.example.com. 115s PASSED 115s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_service_view_ok_pgturl 2025-10-26 12:18:11,528 INFO User test successfully authenticated 115s 2025-10-26 12:18:11,538 INFO Service ticket created for service http://127.0.0.1:43403 by user test. 115s 2025-10-26 12:18:11,546 INFO ValidateService: ticket ST-qfE02SoE7atOKBLxhoc8wNuo7gpZrLAB37lLvnYoLGq6egmRL5yHRAA2Hwue5 validated for user test on service http://127.0.0.1:43403. Proxy Granting Ticket transmited to http://127.0.0.1:43403. 115s PASSED 115s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_user_field_ok 2025-10-26 12:18:11,560 INFO User test successfully authenticated 115s 2025-10-26 12:18:11,569 INFO Service ticket created for service https://user_field.example.com by user test. 115s 2025-10-26 12:18:11,574 INFO ValidateService: ticket ST-YQxX4s2VyfpZjTRlqlXovfW1uMfq4kmzeYv1YT8kVousduMVCkrY4YiHGZJyp validated for user test on service https://user_field.example.com. 115s 2025-10-26 12:18:11,583 INFO User test successfully authenticated 115s 2025-10-26 12:18:11,593 INFO Service ticket created for service https://user_field_alt.example.com by user test. 115s 2025-10-26 12:18:11,598 INFO ValidateService: ticket ST-GPZbmYqvqrFo4u0MRTG1eOgkQ2ZZe35cIdsWL9xP6BDvwqIVZliCiawgdH85b validated for user test on service https://user_field_alt.example.com. 115s PASSED 115s cas_server/tests/test_view.py::ProxyTestCase::test_proxy_missing_parameter 2025-10-26 12:18:11,614 INFO User test successfully authenticated 115s 2025-10-26 12:18:11,623 INFO Service ticket created for service http://127.0.0.1:42967 by user test. 115s 2025-10-26 12:18:11,631 INFO ValidateService: ticket ST-6NB2FJip7qF5DrQo5BLH87O9P8t4KMDSBaEcEGIOh3Pt2Bm4AmdDC8ytpwznc validated for user test on service http://127.0.0.1:42967. Proxy Granting Ticket transmited to http://127.0.0.1:42967. 115s 2025-10-26 12:18:11,633 WARNING Proxy: validation error: INVALID_REQUEST you must specify and pgt and targetService 115s 2025-10-26 12:18:11,634 WARNING Proxy: validation error: INVALID_REQUEST you must specify and pgt and targetService 115s PASSED 115s cas_server/tests/test_view.py::ProxyTestCase::test_proxy_unauthorized_user 2025-10-26 12:18:11,650 INFO User test successfully authenticated 115s 2025-10-26 12:18:11,663 INFO Service ticket created for service http://127.0.0.1:32989 by user test. 115s 2025-10-26 12:18:11,673 INFO ValidateService: ticket ST-j1mmhtN5lficHRWHB3GvBzJUMIKvi8WKsl06fdPVOTiAduHUSVAAu8RTEVVxg validated for user test on service http://127.0.0.1:32989. Proxy Granting Ticket transmited to http://127.0.0.1:32989. 115s 2025-10-26 12:18:11,677 WARNING Username test not allowed on service restrict_user_fail 115s 2025-10-26 12:18:11,678 WARNING Proxy: validation error: UNAUTHORIZED_USER User test not allowed on https://restrict_user_fail.example.com 115s 2025-10-26 12:18:11,682 WARNING User constraint failed for test, service filter_fail: ^admin$ do not match right None. 115s 2025-10-26 12:18:11,683 WARNING Proxy: validation error: UNAUTHORIZED_USER User test not allowed on https://filter_fail.example.com 115s 2025-10-26 12:18:11,686 WARNING Cannot use uid a loggin for user test on service field_needed_fail because it is absent 115s 2025-10-26 12:18:11,687 WARNING Proxy: validation error: UNAUTHORIZED_USER User test not allowed on https://field_needed_fail.example.com 115s PASSED 115s cas_server/tests/test_view.py::ProxyTestCase::test_validate_proxy_bad_pgt 2025-10-26 12:18:11,704 INFO User test successfully authenticated 115s 2025-10-26 12:18:11,715 INFO Service ticket created for service http://127.0.0.1:37145 by user test. 115s 2025-10-26 12:18:11,724 INFO ValidateService: ticket ST-7XUOv00zkTH5y8hnOPiVUJQ2Yl1zNprqPctSKJOfk6FtrCkxusFVIEMhyH5Ad validated for user test on service http://127.0.0.1:37145. Proxy Granting Ticket transmited to http://127.0.0.1:37145. 115s 2025-10-26 12:18:11,727 WARNING Proxy: validation error: INVALID_TICKET PGT PGT-RANDOM not found 115s PASSED 115s cas_server/tests/test_view.py::ProxyTestCase::test_validate_proxy_bad_service 2025-10-26 12:18:11,743 INFO User test successfully authenticated 115s 2025-10-26 12:18:11,753 INFO Service ticket created for service http://127.0.0.1:33777 by user test. 115s 2025-10-26 12:18:11,762 INFO ValidateService: ticket ST-6DJ3bqoYphdjNaAbD5EVvtRxyMiBK2LmINu6xtV4XbzOsXlmwrCguOuhTS0yG validated for user test on service http://127.0.0.1:33777. Proxy Granting Ticket transmited to http://127.0.0.1:33777. 115s 2025-10-26 12:18:11,765 WARNING Service https://www.example.org not allowed. 115s 2025-10-26 12:18:11,765 WARNING Proxy: validation error: UNAUTHORIZED_SERVICE https://www.example.org 115s 2025-10-26 12:18:11,768 WARNING Proxy: validation error: UNAUTHORIZED_SERVICE the service http://127.0.0.1:33777 does not allow proxy tickets 115s PASSED 115s cas_server/tests/test_view.py::ProxyTestCase::test_validate_proxy_ok 2025-10-26 12:18:11,787 INFO User test successfully authenticated 115s 2025-10-26 12:18:11,797 INFO Service ticket created for service http://127.0.0.1:33149 by user test. 115s 2025-10-26 12:18:11,805 INFO ValidateService: ticket ST-El3K3THNYywJjR3t2jwGOvcthjHD6Ln1MVLDFbOIu411NdTNOAWKDoviBB9K9 validated for user test on service http://127.0.0.1:33149. Proxy Granting Ticket transmited to http://127.0.0.1:33149. 115s 2025-10-26 12:18:11,813 INFO Proxy ticket created for user test on service https://www.example.com. 115s 2025-10-26 12:18:11,818 INFO ValidateService: ticket PT-YfvYsBcNilsLbcdnFl3gLjsxuFFJ8ElagKAH9hkwuysXWYU86kihe49khKDC4 validated for user test on service https://www.example.com. 115s PASSED 115s cas_server/tests/test_view.py::SamlValidateTestCase::test_saml_bad_target 2025-10-26 12:18:11,837 INFO User test successfully authenticated 115s 2025-10-26 12:18:11,846 INFO Service ticket created for service https://www.example.com by user test. 115s PASSED 115s cas_server/tests/test_view.py::SamlValidateTestCase::test_saml_bad_ticket 2025-10-26 12:18:11,851 WARNING SamlValidate: validation error: AuthnFailed TARGET https://www.example.org does not match ticket service 115s 2025-10-26 12:18:11,859 WARNING SamlValidate: validation error: AuthnFailed ticket ST-ogCof1oFjKqkkrbkzxUJXJZHt0fPvSrysC77m8IMl7KOfMD239QAJBpwW2EO5 not found 115s 2025-10-26 12:18:11,862 WARNING SamlValidate: validation error: AuthnFailed ticket PT-9cVERumsrlvEqqbkwAQuKwhAFR3XNo2U8T3qA5ICaU8TCSLSKakACWtfegyOF not found 115s PASSED 115s cas_server/tests/test_view.py::SamlValidateTestCase::test_saml_bad_ticket_prefix 2025-10-26 12:18:11,869 WARNING SamlValidate: validation error: AuthnFailed ticket RANDOM-NOT-BEGINING-WITH-ST-OR-ST should begin with PT- or ST- 115s PASSED 115s cas_server/tests/test_view.py::SamlValidateTestCase::test_saml_bad_xml 2025-10-26 12:18:11,877 WARNING SamlValidate: validation error: VersionMismatch 115s PASSED 115s cas_server/tests/test_view.py::SamlValidateTestCase::test_saml_ok 2025-10-26 12:18:11,892 INFO User test successfully authenticated 115s 2025-10-26 12:18:11,902 INFO Service ticket created for service https://www.example.com by user test. 115s 2025-10-26 12:18:11,914 INFO User test successfully authenticated 115s 2025-10-26 12:18:11,923 INFO Service ticket created for service http://127.0.0.1:45831 by user test. 115s 2025-10-26 12:18:11,932 INFO ValidateService: ticket ST-16rJFWfk5kuGB3ZqvzW7BmpDOs7JfQNFRy32TOLfbHx5nJOcyJKwwaiJkJBzq validated for user test on service http://127.0.0.1:45831. Proxy Granting Ticket transmited to http://127.0.0.1:45831. 115s 2025-10-26 12:18:11,938 INFO Proxy ticket created for user test on service https://www.example.com. 115s 2025-10-26 12:18:11,942 INFO SamlValidate: ticket ST-WuPK9NFxwripvRLRmmYL8B2d9txhpnKdrDB5Pp1XBP9R95TLlO2pKfPJfjGMR validated for user test on service https://www.example.com. 115s 2025-10-26 12:18:11,946 INFO SamlValidate: ticket PT-zt6u0Yge0HKF3xd5hxuGJazlpaGZLQIWWtJCTPLUIYh8uJXcNEFAz3CozDVRQ validated for user test on service https://www.example.com. 115s PASSED 115s cas_server/tests/test_view.py::SamlValidateTestCase::test_saml_ok_user_field 2025-10-26 12:18:11,962 INFO User test successfully authenticated 116s 2025-10-26 12:18:11,971 INFO Service ticket created for service https://field_needed_success.example.com by user test. 116s 2025-10-26 12:18:11,976 INFO SamlValidate: ticket ST-VMGbRTdMVtNomO9WHWRoWnZ4mXgng6VmI4odeVCKpeMW3pscre0kecZVEVf2C validated for user test on service https://field_needed_success.example.com. 116s 2025-10-26 12:18:11,985 INFO User test successfully authenticated 116s 2025-10-26 12:18:11,994 INFO Service ticket created for service https://field_needed_success_alt.example.com by user test. 116s 2025-10-26 12:18:11,999 INFO SamlValidate: ticket ST-FEeYITox4pEQWCA4NYQSt9WJAuGfttpCvg00uYZSf1gej2TQHRA2TmbFeIqSP validated for user test on service https://field_needed_success_alt.example.com. 116s PASSEDDestroying test database for alias 'default'... 116s 116s 116s =============================== warnings summary =============================== 116s cas_server/tests/test_federate.py: 8 warnings 116s cas_server/tests/test_view.py: 3 warnings 116s /tmp/autopkgtest.qOLrS9/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). 116s datetime.utcnow() + timedelta(seconds=max_age), 116s 116s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_login_post_provider 116s /usr/lib/python3.13/unittest/case.py:707: DeprecationWarning: It is deprecated to return a value that is not None from a test case (>) 116s return self.run(*args, **kwds) 116s 116s -- Docs: https://docs.pytest.org/en/stable/how-to/capture-warnings.html 116s ======================= 128 passed, 12 warnings in 7.73s ======================= 116s 116s autopkgtest [12:18:12]: test run-test-suite.sh: -----------------------] 117s autopkgtest [12:18:13]: test run-test-suite.sh: - - - - - - - - - - results - - - - - - - - - - 117s run-test-suite.sh PASS 117s autopkgtest [12:18:13]: @@@@@@@@@@@@@@@@@@@@ summary 117s run-test-suite.sh PASS