0s autopkgtest [00:18:29]: starting date and time: 2024-06-08 00:18:29+0000
  0s autopkgtest [00:18:29]: git checkout: 433ed4cb Merge branch 'skia/nova_flock' into 'ubuntu/5.34+prod'
  0s autopkgtest [00:18:29]: host juju-7f2275-prod-proposed-migration-environment-3; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.o82a_tz0/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:pytest,src:astropy --apt-upgrade django-cas-server --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 '--env=ADT_TEST_TRIGGERS=pytest/8.2.2-1ubuntu1 astropy/6.0.1-4' -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-3@lcy02-13.secgroup --name adt-oracular-amd64-django-cas-server-20240608-001828-juju-7f2275-prod-proposed-migration-environment-3-2ba3e9b0-feae-4b4f-9b93-934855f2abb8 --image adt/ubuntu-oracular-amd64-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-3 --net-id=net_prod-proposed-migration -e TERM=linux -e ''"'"'http_proxy=http://squid.internal:3128'"'"'' -e ''"'"'https_proxy=http://squid.internal:3128'"'"'' -e ''"'"'no_proxy=127.0.0.1,127.0.1.1,login.ubuntu.com,localhost,localdomain,novalocal,internal,archive.ubuntu.com,ports.ubuntu.com,security.ubuntu.com,ddebs.ubuntu.com,changelogs.ubuntu.com,keyserver.ubuntu.com,launchpadlibrarian.net,launchpadcontent.net,launchpad.net,10.24.0.0/24,keystone.ps5.canonical.com,objectstorage.prodstack5.canonical.com'"'"'' --mirror=http://ftpmaster.internal/ubuntu/
118s autopkgtest [00:20:27]: testbed dpkg architecture: amd64
118s autopkgtest [00:20:27]: testbed apt version: 2.9.3
118s autopkgtest [00:20:27]: @@@@@@@@@@@@@@@@@@@@ test bed setup
119s Get:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease [110 kB]
119s Get:2 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse Sources [2852 B]
119s Get:3 http://ftpmaster.internal/ubuntu oracular-proposed/main Sources [44.3 kB]
119s Get:4 http://ftpmaster.internal/ubuntu oracular-proposed/universe Sources [339 kB]
119s Get:5 http://ftpmaster.internal/ubuntu oracular-proposed/restricted Sources [7972 B]
119s Get:6 http://ftpmaster.internal/ubuntu oracular-proposed/main amd64 Packages [65.6 kB]
119s Get:7 http://ftpmaster.internal/ubuntu oracular-proposed/main i386 Packages [37.8 kB]
119s Get:8 http://ftpmaster.internal/ubuntu oracular-proposed/restricted i386 Packages [9340 B]
119s Get:9 http://ftpmaster.internal/ubuntu oracular-proposed/restricted amd64 Packages [27.4 kB]
119s Get:10 http://ftpmaster.internal/ubuntu oracular-proposed/universe i386 Packages [124 kB]
119s Get:11 http://ftpmaster.internal/ubuntu oracular-proposed/universe amd64 Packages [300 kB]
119s Get:12 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse amd64 Packages [9280 B]
119s Get:13 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse i386 Packages [3368 B]
119s Fetched 1081 kB in 0s (3628 kB/s)
119s Reading package lists...
121s Reading package lists...
121s Building dependency tree...
121s Reading state information...
122s Calculating upgrade...
122s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
122s Reading package lists...
122s Building dependency tree...
122s Reading state information...
123s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
123s Hit:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease
123s Hit:2 http://ftpmaster.internal/ubuntu oracular InRelease
123s Hit:3 http://ftpmaster.internal/ubuntu oracular-updates InRelease
123s Hit:4 http://ftpmaster.internal/ubuntu oracular-security InRelease
124s Reading package lists...
125s Reading package lists...
125s Building dependency tree...
125s Reading state information...
125s Calculating upgrade...
126s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
126s Reading package lists...
126s Building dependency tree...
126s Reading state information...
126s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
127s autopkgtest [00:20:36]: testbed running kernel: Linux 6.8.0-31-generic #31-Ubuntu SMP PREEMPT_DYNAMIC Sat Apr 20 00:40:06 UTC 2024
127s autopkgtest [00:20:36]: @@@@@@@@@@@@@@@@@@@@ apt-source django-cas-server
129s Get:1 http://ftpmaster.internal/ubuntu oracular/universe django-cas-server 2.0.0-2 (dsc) [2588 B]
129s Get:2 http://ftpmaster.internal/ubuntu oracular/universe django-cas-server 2.0.0-2 (tar) [169 kB]
129s Get:3 http://ftpmaster.internal/ubuntu oracular/universe django-cas-server 2.0.0-2 (diff) [6480 B]
129s gpgv: Signature made Sat Dec  3 08:42:02 2022 UTC
129s gpgv:                using RSA key B70DFC6F134FECFC011E62AA83016014251D1DB0
129s gpgv: Can't check signature: No public key
129s dpkg-source: warning: cannot verify inline signature for ./django-cas-server_2.0.0-2.dsc: no acceptable signature found
129s autopkgtest [00:20:38]: testing package django-cas-server version 2.0.0-2
129s autopkgtest [00:20:38]: build not needed
129s autopkgtest [00:20:38]: test run-test-suite.sh: preparing testbed
129s Reading package lists...
130s Building dependency tree...
130s Reading state information...
130s Starting pkgProblemResolver with broken count: 0
130s Starting 2 pkgProblemResolver with broken count: 0
130s Done
131s The following additional packages will be installed:
131s   fonts-font-awesome fonts-lato libjs-jquery libjs-sphinxdoc libjs-underscore
131s   libxslt1.1 python3-all python3-asgiref python3-django
131s   python3-django-cas-server python3-django-cas-server-doc python3-iniconfig
131s   python3-lxml python3-mock python3-packaging python3-pluggy python3-pytest
131s   python3-pytest-django python3-requests-futures python3-sqlparse
131s   sphinx-rtd-theme-common
131s Suggested packages:
131s   bpython3 geoip-database-contrib gettext ipython3 libgdal20
131s   libsqlite3-mod-spatialite python-django-doc python3-bcrypt python3-flup
131s   python3-memcache python3-mysqldb python3-pil python3-psycopg2
131s   python3-selenium python3-sqlite python-lxml-doc python-mock-doc
131s   python-sqlparse-doc
131s Recommended packages:
131s   javascript-common python3-bs4 python3-cssselect python3-html5lib
131s The following NEW packages will be installed:
131s   autopkgtest-satdep fonts-font-awesome fonts-lato libjs-jquery
131s   libjs-sphinxdoc libjs-underscore libxslt1.1 python3-all python3-asgiref
131s   python3-django python3-django-cas-server python3-django-cas-server-doc
131s   python3-iniconfig python3-lxml python3-mock python3-packaging python3-pluggy
131s   python3-pytest python3-pytest-django python3-requests-futures
131s   python3-sqlparse sphinx-rtd-theme-common
131s 0 upgraded, 22 newly installed, 0 to remove and 0 not upgraded.
131s Need to get 9974 kB/9975 kB of archives.
131s After this operation, 51.7 MB of additional disk space will be used.
131s Get:1 /tmp/autopkgtest.NSrMwe/1-autopkgtest-satdep.deb autopkgtest-satdep amd64 0 [748 B]
131s Get:2 http://ftpmaster.internal/ubuntu oracular/main amd64 fonts-lato all 2.015-1 [2781 kB]
131s Get:3 http://ftpmaster.internal/ubuntu oracular/main amd64 fonts-font-awesome all 5.0.10+really4.7.0~dfsg-4.1 [516 kB]
131s Get:4 http://ftpmaster.internal/ubuntu oracular/main amd64 libjs-jquery all 3.6.1+dfsg+~3.5.14-1 [328 kB]
131s Get:5 http://ftpmaster.internal/ubuntu oracular/main amd64 libjs-underscore all 1.13.4~dfsg+~1.11.4-3 [118 kB]
131s Get:6 http://ftpmaster.internal/ubuntu oracular/main amd64 libjs-sphinxdoc all 7.2.6-8 [150 kB]
131s Get:7 http://ftpmaster.internal/ubuntu oracular/main amd64 libxslt1.1 amd64 1.1.39-0exp1build1 [167 kB]
131s Get:8 http://ftpmaster.internal/ubuntu oracular/main amd64 python3-all amd64 3.12.3-0ubuntu1 [888 B]
131s Get:9 http://ftpmaster.internal/ubuntu oracular/main amd64 python3-asgiref all 3.8.1-1 [24.8 kB]
131s Get:10 http://ftpmaster.internal/ubuntu oracular/main amd64 python3-sqlparse all 0.5.0-1 [32.4 kB]
131s Get:11 http://ftpmaster.internal/ubuntu oracular/main amd64 python3-django all 3:4.2.13-1 [2919 kB]
131s Get:12 http://ftpmaster.internal/ubuntu oracular/main amd64 python3-lxml amd64 5.2.1-1 [1243 kB]
131s Get:13 http://ftpmaster.internal/ubuntu oracular/universe amd64 python3-requests-futures all 1.0.1-1 [11.7 kB]
131s Get:14 http://ftpmaster.internal/ubuntu oracular/universe amd64 python3-django-cas-server all 2.0.0-2 [111 kB]
131s Get:15 http://ftpmaster.internal/ubuntu oracular/main amd64 sphinx-rtd-theme-common all 2.0.0+dfsg-1 [1012 kB]
131s Get:16 http://ftpmaster.internal/ubuntu oracular/universe amd64 python3-django-cas-server-doc all 2.0.0-2 [159 kB]
131s Get:17 http://ftpmaster.internal/ubuntu oracular/universe amd64 python3-iniconfig all 1.1.1-2 [6024 B]
131s Get:18 http://ftpmaster.internal/ubuntu oracular/main amd64 python3-packaging all 24.0-1 [41.1 kB]
131s Get:19 http://ftpmaster.internal/ubuntu oracular/universe amd64 python3-pluggy all 1.5.0-1 [21.0 kB]
131s Get:20 http://ftpmaster.internal/ubuntu oracular-proposed/universe amd64 python3-pytest all 8.2.2-1ubuntu1 [250 kB]
131s Get:21 http://ftpmaster.internal/ubuntu oracular/universe amd64 python3-pytest-django all 4.5.2-3 [18.5 kB]
131s Get:22 http://ftpmaster.internal/ubuntu oracular/universe amd64 python3-mock all 5.1.0-1 [64.1 kB]
132s Fetched 9974 kB in 0s (48.5 MB/s)
132s Selecting previously unselected package fonts-lato.
132s (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 ... 74365 files and directories currently installed.)
132s Preparing to unpack .../00-fonts-lato_2.015-1_all.deb ...
132s Unpacking fonts-lato (2.015-1) ...
132s Selecting previously unselected package fonts-font-awesome.
132s Preparing to unpack .../01-fonts-font-awesome_5.0.10+really4.7.0~dfsg-4.1_all.deb ...
132s Unpacking fonts-font-awesome (5.0.10+really4.7.0~dfsg-4.1) ...
132s Selecting previously unselected package libjs-jquery.
132s Preparing to unpack .../02-libjs-jquery_3.6.1+dfsg+~3.5.14-1_all.deb ...
133s Unpacking libjs-jquery (3.6.1+dfsg+~3.5.14-1) ...
133s Selecting previously unselected package libjs-underscore.
133s Preparing to unpack .../03-libjs-underscore_1.13.4~dfsg+~1.11.4-3_all.deb ...
133s Unpacking libjs-underscore (1.13.4~dfsg+~1.11.4-3) ...
133s Selecting previously unselected package libjs-sphinxdoc.
133s Preparing to unpack .../04-libjs-sphinxdoc_7.2.6-8_all.deb ...
133s Unpacking libjs-sphinxdoc (7.2.6-8) ...
133s Selecting previously unselected package libxslt1.1:amd64.
133s Preparing to unpack .../05-libxslt1.1_1.1.39-0exp1build1_amd64.deb ...
133s Unpacking libxslt1.1:amd64 (1.1.39-0exp1build1) ...
133s Selecting previously unselected package python3-all.
133s Preparing to unpack .../06-python3-all_3.12.3-0ubuntu1_amd64.deb ...
133s Unpacking python3-all (3.12.3-0ubuntu1) ...
133s Selecting previously unselected package python3-asgiref.
133s Preparing to unpack .../07-python3-asgiref_3.8.1-1_all.deb ...
133s Unpacking python3-asgiref (3.8.1-1) ...
133s Selecting previously unselected package python3-sqlparse.
133s Preparing to unpack .../08-python3-sqlparse_0.5.0-1_all.deb ...
133s Unpacking python3-sqlparse (0.5.0-1) ...
133s Selecting previously unselected package python3-django.
133s Preparing to unpack .../09-python3-django_3%3a4.2.13-1_all.deb ...
133s Unpacking python3-django (3:4.2.13-1) ...
134s Selecting previously unselected package python3-lxml:amd64.
134s Preparing to unpack .../10-python3-lxml_5.2.1-1_amd64.deb ...
134s Unpacking python3-lxml:amd64 (5.2.1-1) ...
134s Selecting previously unselected package python3-requests-futures.
134s Preparing to unpack .../11-python3-requests-futures_1.0.1-1_all.deb ...
134s Unpacking python3-requests-futures (1.0.1-1) ...
134s Selecting previously unselected package python3-django-cas-server.
134s Preparing to unpack .../12-python3-django-cas-server_2.0.0-2_all.deb ...
134s Unpacking python3-django-cas-server (2.0.0-2) ...
134s Selecting previously unselected package sphinx-rtd-theme-common.
134s Preparing to unpack .../13-sphinx-rtd-theme-common_2.0.0+dfsg-1_all.deb ...
134s Unpacking sphinx-rtd-theme-common (2.0.0+dfsg-1) ...
134s Selecting previously unselected package python3-django-cas-server-doc.
134s Preparing to unpack .../14-python3-django-cas-server-doc_2.0.0-2_all.deb ...
134s Unpacking python3-django-cas-server-doc (2.0.0-2) ...
134s Selecting previously unselected package python3-iniconfig.
134s Preparing to unpack .../15-python3-iniconfig_1.1.1-2_all.deb ...
134s Unpacking python3-iniconfig (1.1.1-2) ...
134s Selecting previously unselected package python3-packaging.
134s Preparing to unpack .../16-python3-packaging_24.0-1_all.deb ...
134s Unpacking python3-packaging (24.0-1) ...
134s Selecting previously unselected package python3-pluggy.
134s Preparing to unpack .../17-python3-pluggy_1.5.0-1_all.deb ...
134s Unpacking python3-pluggy (1.5.0-1) ...
134s Selecting previously unselected package python3-pytest.
134s Preparing to unpack .../18-python3-pytest_8.2.2-1ubuntu1_all.deb ...
134s Unpacking python3-pytest (8.2.2-1ubuntu1) ...
134s Selecting previously unselected package python3-pytest-django.
134s Preparing to unpack .../19-python3-pytest-django_4.5.2-3_all.deb ...
134s Unpacking python3-pytest-django (4.5.2-3) ...
134s Selecting previously unselected package python3-mock.
134s Preparing to unpack .../20-python3-mock_5.1.0-1_all.deb ...
134s Unpacking python3-mock (5.1.0-1) ...
134s Selecting previously unselected package autopkgtest-satdep.
134s Preparing to unpack .../21-1-autopkgtest-satdep.deb ...
134s Unpacking autopkgtest-satdep (0) ...
134s Setting up python3-iniconfig (1.1.1-2) ...
134s Setting up fonts-lato (2.015-1) ...
134s Setting up python3-all (3.12.3-0ubuntu1) ...
134s Setting up python3-mock (5.1.0-1) ...
135s Setting up python3-packaging (24.0-1) ...
135s Setting up python3-sqlparse (0.5.0-1) ...
135s Setting up python3-pluggy (1.5.0-1) ...
135s Setting up libxslt1.1:amd64 (1.1.39-0exp1build1) ...
135s Setting up python3-requests-futures (1.0.1-1) ...
135s Setting up libjs-jquery (3.6.1+dfsg+~3.5.14-1) ...
135s Setting up fonts-font-awesome (5.0.10+really4.7.0~dfsg-4.1) ...
135s Setting up sphinx-rtd-theme-common (2.0.0+dfsg-1) ...
135s Setting up python3-asgiref (3.8.1-1) ...
135s Setting up libjs-underscore (1.13.4~dfsg+~1.11.4-3) ...
135s Setting up python3-django (3:4.2.13-1) ...
137s Setting up python3-pytest (8.2.2-1ubuntu1) ...
137s Setting up python3-pytest-django (4.5.2-3) ...
137s Setting up libjs-sphinxdoc (7.2.6-8) ...
137s Setting up python3-lxml:amd64 (5.2.1-1) ...
138s Setting up python3-django-cas-server (2.0.0-2) ...
138s Setting up python3-django-cas-server-doc (2.0.0-2) ...
138s Setting up autopkgtest-satdep (0) ...
138s Processing triggers for man-db (2.12.1-1) ...
138s Processing triggers for libc-bin (2.39-0ubuntu8.1) ...
142s (Reading database ... 81172 files and directories currently installed.)
142s Removing autopkgtest-satdep (0) ...
143s autopkgtest [00:20:52]: test run-test-suite.sh: [-----------------------
143s 
143s ***************************
143s *** Testing with python3.12
143s ***************************
143s 
143s Content of current working folder:
143s 
143s total 20
143s drwxr-xr-x 3 ubuntu ubuntu 4096 Jun  8 00:20 .
143s drwxrwxrwt 5 root   root   4096 Jun  8 00:20 ..
143s drwxrwxr-x 9 ubuntu ubuntu 4096 Oct 17  2022 cas_server
143s -rw-rw-r-- 1 ubuntu ubuntu  140 Oct 17  2022 pytest.ini
143s -rw-rw-r-- 1 ubuntu ubuntu  152 Oct 17  2022 setup.cfg
143s Running tests...
143s 
144s ============================= test session starts ==============================
144s platform linux -- Python 3.12.3, pytest-8.2.2, pluggy-1.5.0 -- /usr/bin/python3.12
144s cachedir: .pytest_cache
144s django: settings: cas_server.tests.settings (from ini)
144s rootdir: /tmp/autopkgtest.NSrMwe/autopkgtest_tmp
144s configfile: pytest.ini
144s testpaths: cas_server/tests/
144s plugins: django-4.5.2
144s collecting ... collected 128 items
144s 
144s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_auth_federate_errors Creating test database for alias 'default'...
145s 2024-06-08 00:20:54,253 WARNING Identity provider suffix exemple.fr not found
145s 2024-06-08 00:20:54,294 INFO Got an invalid ticket ST-89NPFNXImgTBbEW98meXcZCXi6Hwb8ALIkMAflkvHS8jx5pUXLnLD62M80s10 from http://127.0.0.1:8080 for service http://testserver/federate/example.com. Retrying authentication
145s 2024-06-08 00:20:54,298 INFO Got an invalid ticket ST-Ai8AuExRbZ9gij4okJNNhfgs7zHmfwjMfzVgi2UcYwLh5n0PxEio5AoYl4ZZI from http://127.0.0.1:8080 for service http://testserver/federate/example.com. Retrying authentication
145s PASSED
145s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_auth_federate_false 2024-06-08 00:20:54,334 WARNING CAS_FEDERATE is False, set it to True to use federation
145s 2024-06-08 00:20:54,335 WARNING CAS_FEDERATE is False, set it to True to use federation
145s PASSED
145s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_auth_federate_slo 2024-06-08 00:20:54,352 INFO Trying to authenticate http://127.0.0.1:8080 again
145s 2024-06-08 00:20:54,358 INFO Got a valid ticket for dédé from http://127.0.0.1:8080
145s 2024-06-08 00:20:54,373 INFO User dédé@example.com successfully authenticated
145s 2024-06-08 00:20:54,386 INFO Service ticket created for service https://www.example.com by user dédé@example.com.
145s 2024-06-08 00:20:54,398 INFO Trying to authenticate http://127.0.0.1:8081 again
145s 2024-06-08 00:20:54,405 INFO Got a valid ticket for dédé from http://127.0.0.1:8081
145s 2024-06-08 00:20:54,417 INFO User dédé@example.org successfully authenticated
145s 2024-06-08 00:20:54,427 INFO Service ticket created for service https://www.example.com by user dédé@example.org.
145s 2024-06-08 00:20:54,441 INFO Trying to authenticate http://127.0.0.1:8082 again
145s 2024-06-08 00:20:54,447 INFO Got a valid ticket for dédé from http://127.0.0.1:8082
145s 2024-06-08 00:20:54,458 INFO User dédé@example.net successfully authenticated
145s 2024-06-08 00:20:54,468 INFO Service ticket created for service https://www.example.com by user dédé@example.net.
145s 2024-06-08 00:20:54,480 INFO Trying to authenticate http://127.0.0.1:8083 again
145s 2024-06-08 00:20:54,489 INFO Got a valid ticket for dédé from http://127.0.0.1:8083
145s 2024-06-08 00:20:54,505 INFO User dédé@example.test successfully authenticated
145s 2024-06-08 00:20:54,516 INFO Service ticket created for service https://www.example.com by user dédé@example.test.
145s 2024-06-08 00:20:54,564 INFO Got an SLO requests for ticket dédé@example.net, logging out user ST-ysRhIR3jqJp4G8XRfUK4JqH7X2Y5qTpvLE1qjZD4PJ18TB1SSCJ9akSKIqXXj
145s 2024-06-08 00:20:54,592 INFO Got an SLO requests for ticket dédé@example.test, logging out user ST-yg50FV0P0HUNDlxGvC4DDI0F923YOYZ7KGUVcJ4KUFEx3OdJK08ByIJpTH4Ee
145s PASSED
145s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_default_settings PASSED
145s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_federate_logout 2024-06-08 00:20:54,634 INFO Trying to authenticate http://127.0.0.1:8080 again
145s 2024-06-08 00:20:54,640 INFO Got a valid ticket for dédé from http://127.0.0.1:8080
145s 2024-06-08 00:20:54,657 INFO User dédé@example.com successfully authenticated
145s 2024-06-08 00:20:54,670 INFO Service ticket created for service https://www.example.com by user dédé@example.com.
145s 2024-06-08 00:20:54,685 INFO Trying to authenticate http://127.0.0.1:8081 again
145s 2024-06-08 00:20:54,691 INFO Got a valid ticket for dédé from http://127.0.0.1:8081
145s 2024-06-08 00:20:54,704 INFO User dédé@example.org successfully authenticated
145s 2024-06-08 00:20:54,715 INFO Service ticket created for service https://www.example.com by user dédé@example.org.
145s 2024-06-08 00:20:54,728 INFO Trying to authenticate http://127.0.0.1:8082 again
145s 2024-06-08 00:20:54,734 INFO Got a valid ticket for dédé from http://127.0.0.1:8082
145s 2024-06-08 00:20:54,746 INFO User dédé@example.net successfully authenticated
145s 2024-06-08 00:20:54,756 INFO Service ticket created for service https://www.example.com by user dédé@example.net.
145s 2024-06-08 00:20:54,768 INFO Trying to authenticate http://127.0.0.1:8083 again
145s 2024-06-08 00:20:54,774 INFO Got a valid ticket for dédé from http://127.0.0.1:8083
145s 2024-06-08 00:20:54,785 INFO User dédé@example.test successfully authenticated
145s 2024-06-08 00:20:54,795 INFO Service ticket created for service https://www.example.com by user dédé@example.test.
145s 2024-06-08 00:20:54,797 INFO logout requested
145s 2024-06-08 00:20:54,799 INFO Logging out user dédé@example.com.
145s 2024-06-08 00:20:54,803 INFO User dédé@example.com logged out
145s 2024-06-08 00:20:54,813 INFO logout requested
145s 2024-06-08 00:20:54,817 INFO logout requested
145s 2024-06-08 00:20:54,819 INFO Logging out user dédé@example.org.
145s 2024-06-08 00:20:54,823 INFO User dédé@example.org logged out
145s 2024-06-08 00:20:54,833 INFO logout requested
145s 2024-06-08 00:20:54,836 INFO logout requested
145s 2024-06-08 00:20:54,838 INFO Logging out user dédé@example.net.
145s 2024-06-08 00:20:54,843 INFO User dédé@example.net logged out
145s 2024-06-08 00:20:54,854 INFO logout requested
145s 2024-06-08 00:20:54,857 INFO logout requested
145s 2024-06-08 00:20:54,859 INFO Logging out user dédé@example.test.
145s 2024-06-08 00:20:54,864 INFO User dédé@example.test logged out
145s 2024-06-08 00:20:54,875 INFO logout requested
145s 2024-06-08 00:20:54,890 INFO Trying to authenticate http://127.0.0.1:8080 again
145s 2024-06-08 00:20:54,896 INFO Got a valid ticket for dédé from http://127.0.0.1:8080
145s 2024-06-08 00:20:54,908 INFO User dédé@example.com successfully authenticated
145s 2024-06-08 00:20:54,918 INFO Service ticket created for service https://www.example.com by user dédé@example.com.
145s 2024-06-08 00:20:54,930 INFO Trying to authenticate http://127.0.0.1:8081 again
145s 2024-06-08 00:20:54,936 INFO Got a valid ticket for dédé from http://127.0.0.1:8081
145s 2024-06-08 00:20:54,948 INFO User dédé@example.org successfully authenticated
145s 2024-06-08 00:20:54,958 INFO Service ticket created for service https://www.example.com by user dédé@example.org.
145s 2024-06-08 00:20:54,971 INFO Trying to authenticate http://127.0.0.1:8082 again
145s 2024-06-08 00:20:54,977 INFO Got a valid ticket for dédé from http://127.0.0.1:8082
145s 2024-06-08 00:20:54,989 INFO User dédé@example.net successfully authenticated
145s 2024-06-08 00:20:54,999 INFO Service ticket created for service https://www.example.com by user dédé@example.net.
146s 2024-06-08 00:20:55,011 INFO Trying to authenticate http://127.0.0.1:8083 again
146s 2024-06-08 00:20:55,018 INFO Got a valid ticket for dédé from http://127.0.0.1:8083
146s 2024-06-08 00:20:55,032 INFO User dédé@example.test successfully authenticated
146s 2024-06-08 00:20:55,042 INFO Service ticket created for service https://www.example.com by user dédé@example.test.
146s 2024-06-08 00:20:55,045 INFO logout requested
146s 2024-06-08 00:20:55,046 INFO Logging out user dédé.
146s 2024-06-08 00:20:55,047 INFO User dédé logged out
146s 2024-06-08 00:20:55,059 INFO logout requested
146s 2024-06-08 00:20:55,060 INFO Logging out user dédé.
146s 2024-06-08 00:20:55,061 INFO User dédé logged out
146s 2024-06-08 00:20:55,073 INFO logout requested
146s 2024-06-08 00:20:55,074 INFO Logging out user dédé.
146s 2024-06-08 00:20:55,075 INFO User dédé logged out
146s 2024-06-08 00:20:55,087 INFO logout requested
146s 2024-06-08 00:20:55,088 INFO Logging out user dédé.
146s 2024-06-08 00:20:55,089 INFO User dédé logged out
146s PASSED
146s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_forget_provider 2024-06-08 00:20:55,118 INFO Trying to authenticate http://127.0.0.1:8080 again
146s 2024-06-08 00:20:55,123 INFO Got a valid ticket for dédé from http://127.0.0.1:8080
146s 2024-06-08 00:20:55,135 INFO User dédé@example.com successfully authenticated
146s 2024-06-08 00:20:55,146 INFO Service ticket created for service https://www.example.com by user dédé@example.com.
146s 2024-06-08 00:20:55,159 INFO Trying to authenticate http://127.0.0.1:8081 again
146s 2024-06-08 00:20:55,164 INFO Got a valid ticket for dédé from http://127.0.0.1:8081
146s 2024-06-08 00:20:55,176 INFO User dédé@example.org successfully authenticated
146s 2024-06-08 00:20:55,187 INFO Service ticket created for service https://www.example.com by user dédé@example.org.
146s 2024-06-08 00:20:55,201 INFO Trying to authenticate http://127.0.0.1:8082 again
146s 2024-06-08 00:20:55,208 INFO Got a valid ticket for dédé from http://127.0.0.1:8082
146s 2024-06-08 00:20:55,220 INFO User dédé@example.net successfully authenticated
146s 2024-06-08 00:20:55,232 INFO Service ticket created for service https://www.example.com by user dédé@example.net.
146s 2024-06-08 00:20:55,246 INFO Trying to authenticate http://127.0.0.1:8083 again
146s 2024-06-08 00:20:55,252 INFO Got a valid ticket for dédé from http://127.0.0.1:8083
146s 2024-06-08 00:20:55,264 INFO User dédé@example.test successfully authenticated
146s 2024-06-08 00:20:55,274 INFO Service ticket created for service https://www.example.com by user dédé@example.test.
146s 2024-06-08 00:20:55,276 INFO logout requested
146s 2024-06-08 00:20:55,278 INFO Logging out user dédé@example.com.
146s 2024-06-08 00:20:55,283 INFO User dédé@example.com logged out
146s 2024-06-08 00:20:55,284 INFO logout requested
146s 2024-06-08 00:20:55,286 INFO Logging out user dédé@example.org.
146s 2024-06-08 00:20:55,291 INFO User dédé@example.org logged out
146s 2024-06-08 00:20:55,292 INFO logout requested
146s 2024-06-08 00:20:55,293 INFO Logging out user dédé@example.net.
146s 2024-06-08 00:20:55,298 INFO User dédé@example.net logged out
146s 2024-06-08 00:20:55,299 INFO logout requested
146s 2024-06-08 00:20:55,301 INFO Logging out user dédé@example.test.
146s 2024-06-08 00:20:55,306 INFO User dédé@example.test logged out
146s PASSED
146s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_login_bad_ticket 2024-06-08 00:20:55,322 WARNING A login attempt failed
146s PASSED
146s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_login_get_provider PASSED
146s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_login_post_provider 2024-06-08 00:20:55,362 INFO Trying to authenticate http://127.0.0.1:8080 again
146s 2024-06-08 00:20:55,366 INFO Got a valid ticket for dédé from http://127.0.0.1:8080
146s 2024-06-08 00:20:55,377 INFO User dédé@example.com successfully authenticated
146s 2024-06-08 00:20:55,388 INFO Service ticket created for service https://www.example.com by user dédé@example.com.
146s 2024-06-08 00:20:55,401 INFO Trying to authenticate http://127.0.0.1:8081 again
146s 2024-06-08 00:20:55,406 INFO Got a valid ticket for dédé from http://127.0.0.1:8081
146s 2024-06-08 00:20:55,419 INFO User dédé@example.org successfully authenticated
146s 2024-06-08 00:20:55,429 INFO Service ticket created for service https://www.example.com by user dédé@example.org.
146s 2024-06-08 00:20:55,442 INFO Trying to authenticate http://127.0.0.1:8082 again
146s 2024-06-08 00:20:55,447 INFO Got a valid ticket for dédé from http://127.0.0.1:8082
146s 2024-06-08 00:20:55,458 INFO User dédé@example.net successfully authenticated
146s 2024-06-08 00:20:55,469 INFO Service ticket created for service https://www.example.com by user dédé@example.net.
146s 2024-06-08 00:20:55,482 INFO Trying to authenticate http://127.0.0.1:8083 again
146s 2024-06-08 00:20:55,487 INFO Got a valid ticket for dédé from http://127.0.0.1:8083
146s 2024-06-08 00:20:55,498 INFO User dédé@example.test successfully authenticated
146s 2024-06-08 00:20:55,508 INFO Service ticket created for service https://www.example.com by user dédé@example.test.
146s PASSED
146s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_login_twice 2024-06-08 00:20:55,528 INFO Trying to authenticate http://127.0.0.1:8080 again
146s 2024-06-08 00:20:55,532 INFO Got a valid ticket for dédé from http://127.0.0.1:8080
146s 2024-06-08 00:20:55,545 INFO User dédé@example.com successfully authenticated
146s 2024-06-08 00:20:55,555 INFO Service ticket created for service https://www.example.com by user dédé@example.com.
146s 2024-06-08 00:20:55,567 INFO Trying to authenticate http://127.0.0.1:8081 again
146s 2024-06-08 00:20:55,572 INFO Got a valid ticket for dédé from http://127.0.0.1:8081
146s 2024-06-08 00:20:55,583 INFO User dédé@example.org successfully authenticated
146s 2024-06-08 00:20:55,592 INFO Service ticket created for service https://www.example.com by user dédé@example.org.
146s 2024-06-08 00:20:55,608 INFO Trying to authenticate http://127.0.0.1:8082 again
146s 2024-06-08 00:20:55,614 INFO Got a valid ticket for dédé from http://127.0.0.1:8082
146s 2024-06-08 00:20:55,626 INFO User dédé@example.net successfully authenticated
146s 2024-06-08 00:20:55,638 INFO Service ticket created for service https://www.example.com by user dédé@example.net.
146s 2024-06-08 00:20:55,652 INFO Trying to authenticate http://127.0.0.1:8083 again
146s 2024-06-08 00:20:55,657 INFO Got a valid ticket for dédé from http://127.0.0.1:8083
146s 2024-06-08 00:20:55,669 INFO User dédé@example.test successfully authenticated
146s 2024-06-08 00:20:55,679 INFO Service ticket created for service https://www.example.com by user dédé@example.test.
146s 2024-06-08 00:20:55,691 INFO Trying to authenticate http://127.0.0.1:8080 again
146s 2024-06-08 00:20:55,696 INFO Got a valid ticket for dédé from http://127.0.0.1:8080
146s 2024-06-08 00:20:55,707 INFO User dédé@example.com successfully authenticated
146s 2024-06-08 00:20:55,718 INFO Service ticket created for service https://www.example.com by user dédé@example.com.
146s 2024-06-08 00:20:55,730 INFO Trying to authenticate http://127.0.0.1:8081 again
146s 2024-06-08 00:20:55,736 INFO Got a valid ticket for dédé from http://127.0.0.1:8081
146s 2024-06-08 00:20:55,748 INFO User dédé@example.org successfully authenticated
146s 2024-06-08 00:20:55,758 INFO Service ticket created for service https://www.example.com by user dédé@example.org.
146s 2024-06-08 00:20:55,772 INFO Trying to authenticate http://127.0.0.1:8082 again
146s 2024-06-08 00:20:55,778 INFO Got a valid ticket for dédé from http://127.0.0.1:8082
146s 2024-06-08 00:20:55,791 INFO User dédé@example.net successfully authenticated
146s 2024-06-08 00:20:55,845 INFO Service ticket created for service https://www.example.com by user dédé@example.net.
146s 2024-06-08 00:20:55,857 INFO Trying to authenticate http://127.0.0.1:8083 again
146s 2024-06-08 00:20:55,863 INFO Got a valid ticket for dédé from http://127.0.0.1:8083
146s 2024-06-08 00:20:55,875 INFO User dédé@example.test successfully authenticated
146s 2024-06-08 00:20:55,885 INFO Service ticket created for service https://www.example.com by user dédé@example.test.
146s 2024-06-08 00:20:55,887 WARNING User already authenticated, dropping federated authentication request
146s 2024-06-08 00:20:55,888 WARNING User already authenticated, dropping federated authentication request
146s 2024-06-08 00:20:55,889 WARNING User already authenticated, dropping federated authentication request
146s 2024-06-08 00:20:55,890 WARNING User already authenticated, dropping federated authentication request
146s PASSED
146s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_remember_provider 2024-06-08 00:20:55,908 INFO Trying to authenticate http://127.0.0.1:8080 again
146s 2024-06-08 00:20:55,914 INFO Got a valid ticket for dédé from http://127.0.0.1:8080
146s 2024-06-08 00:20:55,926 INFO User dédé@example.com successfully authenticated
146s 2024-06-08 00:20:55,936 INFO Service ticket created for service https://www.example.com by user dédé@example.com.
146s 2024-06-08 00:20:55,949 INFO Trying to authenticate http://127.0.0.1:8081 again
146s 2024-06-08 00:20:55,956 INFO Got a valid ticket for dédé from http://127.0.0.1:8081
146s 2024-06-08 00:20:55,968 INFO User dédé@example.org successfully authenticated
146s 2024-06-08 00:20:55,979 INFO Service ticket created for service https://www.example.com by user dédé@example.org.
146s 2024-06-08 00:20:55,992 INFO Trying to authenticate http://127.0.0.1:8082 again
146s 2024-06-08 00:20:55,998 INFO Got a valid ticket for dédé from http://127.0.0.1:8082
147s 2024-06-08 00:20:56,013 INFO User dédé@example.net successfully authenticated
147s 2024-06-08 00:20:56,024 INFO Service ticket created for service https://www.example.com by user dédé@example.net.
147s 2024-06-08 00:20:56,038 INFO Trying to authenticate http://127.0.0.1:8083 again
147s 2024-06-08 00:20:56,044 INFO Got a valid ticket for dédé from http://127.0.0.1:8083
147s 2024-06-08 00:20:56,057 INFO User dédé@example.test successfully authenticated
147s 2024-06-08 00:20:56,068 INFO Service ticket created for service https://www.example.com by user dédé@example.test.
147s 2024-06-08 00:20:56,070 INFO logout requested
147s 2024-06-08 00:20:56,072 INFO Logging out user dédé@example.com.
147s 2024-06-08 00:20:56,077 INFO User dédé@example.com logged out
147s 2024-06-08 00:20:56,081 INFO logout requested
147s 2024-06-08 00:20:56,083 INFO Logging out user dédé@example.org.
147s 2024-06-08 00:20:56,088 INFO User dédé@example.org logged out
147s 2024-06-08 00:20:56,092 INFO logout requested
147s 2024-06-08 00:20:56,094 INFO Logging out user dédé@example.net.
147s 2024-06-08 00:20:56,099 INFO User dédé@example.net logged out
147s 2024-06-08 00:20:56,103 INFO logout requested
147s 2024-06-08 00:20:56,105 INFO Logging out user dédé@example.test.
147s 2024-06-08 00:20:56,110 INFO User dédé@example.test logged out
147s PASSED
147s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_renew 2024-06-08 00:20:56,130 INFO Trying to authenticate http://127.0.0.1:8080 again
147s 2024-06-08 00:20:56,136 INFO Got a valid ticket for dédé from http://127.0.0.1:8080
147s 2024-06-08 00:20:56,147 INFO User dédé@example.com successfully authenticated
147s 2024-06-08 00:20:56,158 INFO Service ticket created for service https://www.example.com by user dédé@example.com.
147s 2024-06-08 00:20:56,171 INFO Trying to authenticate http://127.0.0.1:8081 again
147s 2024-06-08 00:20:56,177 INFO Got a valid ticket for dédé from http://127.0.0.1:8081
147s 2024-06-08 00:20:56,193 INFO User dédé@example.org successfully authenticated
147s 2024-06-08 00:20:56,206 INFO Service ticket created for service https://www.example.com by user dédé@example.org.
147s 2024-06-08 00:20:56,220 INFO Trying to authenticate http://127.0.0.1:8082 again
147s 2024-06-08 00:20:56,226 INFO Got a valid ticket for dédé from http://127.0.0.1:8082
147s 2024-06-08 00:20:56,239 INFO User dédé@example.net successfully authenticated
147s 2024-06-08 00:20:56,249 INFO Service ticket created for service https://www.example.com by user dédé@example.net.
147s 2024-06-08 00:20:56,263 INFO Trying to authenticate http://127.0.0.1:8083 again
147s 2024-06-08 00:20:56,270 INFO Got a valid ticket for dédé from http://127.0.0.1:8083
147s 2024-06-08 00:20:56,282 INFO User dédé@example.test successfully authenticated
147s 2024-06-08 00:20:56,292 INFO Service ticket created for service https://www.example.com by user dédé@example.test.
147s 2024-06-08 00:20:56,298 INFO Trying to authenticate http://127.0.0.1:8080 again
147s 2024-06-08 00:20:56,304 INFO Got a valid ticket for dédé from http://127.0.0.1:8080
147s 2024-06-08 00:20:56,317 INFO User dédé@example.com successfully authenticated
147s 2024-06-08 00:20:56,322 INFO Service ticket created for service https://www.example.com by user dédé@example.com.
147s 2024-06-08 00:20:56,330 INFO Trying to authenticate http://127.0.0.1:8081 again
147s 2024-06-08 00:20:56,337 INFO Got a valid ticket for dédé from http://127.0.0.1:8081
147s 2024-06-08 00:20:56,351 INFO User dédé@example.org successfully authenticated
147s 2024-06-08 00:20:56,357 INFO Service ticket created for service https://www.example.com by user dédé@example.org.
147s 2024-06-08 00:20:56,364 INFO Trying to authenticate http://127.0.0.1:8082 again
147s 2024-06-08 00:20:56,371 INFO Got a valid ticket for dédé from http://127.0.0.1:8082
147s 2024-06-08 00:20:56,384 INFO User dédé@example.net successfully authenticated
147s 2024-06-08 00:20:56,391 INFO Service ticket created for service https://www.example.com by user dédé@example.net.
147s 2024-06-08 00:20:56,398 INFO Trying to authenticate http://127.0.0.1:8083 again
147s 2024-06-08 00:20:56,405 INFO Got a valid ticket for dédé from http://127.0.0.1:8083
147s 2024-06-08 00:20:56,417 INFO User dédé@example.test successfully authenticated
147s 2024-06-08 00:20:56,422 INFO Service ticket created for service https://www.example.com by user dédé@example.test.
147s PASSED
147s cas_server/tests/test_models.py::FederatedUserTestCase::test_clean_old_entries PASSED
147s cas_server/tests/test_models.py::FederatedUserTestCase::test_json_attributes PASSED
147s cas_server/tests/test_models.py::FederateSLOTestCase::test_clean_deleted_sessions PASSED
147s cas_server/tests/test_models.py::UserAttributesTestCase::test_clean_old_entries 2024-06-08 00:20:56,476 INFO User test successfully authenticated
147s PASSED
147s cas_server/tests/test_models.py::UserTestCase::test_cached_attributs 2024-06-08 00:20:56,497 INFO User test successfully authenticated
147s PASSED
147s cas_server/tests/test_models.py::UserTestCase::test_clean_deleted_sessions 2024-06-08 00:20:56,513 INFO User test successfully authenticated
147s 2024-06-08 00:20:56,525 INFO User test successfully authenticated
147s 2024-06-08 00:20:56,536 INFO Sending SLO requests to service http://127.0.0.1:45678 for user test
147s 2024-06-08 00:20:56,541 WARNING Error during SLO for user test: HTTPConnectionPool(host='127.0.0.1', port=45678): Max retries exceeded with url: / (Caused by NewConnectionError('<urllib3.connection.HTTPConnection object at 0x70d24e96c1d0>: Failed to establish a new connection: [Errno 111] Connection refused'))
147s PASSED
147s cas_server/tests/test_models.py::UserTestCase::test_clean_old_entries 2024-06-08 00:20:56,556 INFO User test successfully authenticated
147s PASSED
147s cas_server/tests/test_models.py::UserTestCase::test_clean_old_entries_tgt_expired 2024-06-08 00:20:56,577 INFO User test successfully authenticated
147s PASSED
147s cas_server/tests/test_models.py::TicketTestCase::test_clean_old_service_ticket 2024-06-08 00:20:56,601 INFO User test successfully authenticated
147s 2024-06-08 00:20:56,614 INFO Sending SLO requests to service http://127.0.0.1:38759 for user test
147s 2024-06-08 00:20:56,618 WARNING Error durring SLO ('Connection aborted.', RemoteDisconnected('Remote end closed connection without response'))
147s ConnectionError(ProtocolError('Connection aborted.', RemoteDisconnected('Remote end closed connection without response')))
147s PASSED
147s cas_server/tests/test_models.py::TicketTestCase::test_json_attributes 2024-06-08 00:20:56,632 INFO User test successfully authenticated
147s PASSED
147s cas_server/tests/test_models.py::NewVersionWarningTestCase::test_send_mails PASSED
147s cas_server/tests/test_models.py::NewVersionWarningTestCase::test_send_mails_disabled PASSED
147s cas_server/tests/test_models.py::NewVersionWarningTestCase::test_send_mails_no_admins PASSED
147s cas_server/tests/test_models.py::NewVersionWarningTestCase::test_send_mails_same_version PASSED
147s cas_server/tests/test_templatetags.py::TemplateTagsTestCase::test_is_checkbox PASSED
147s cas_server/tests/test_templatetags.py::TemplateTagsTestCase::test_is_hidden PASSED
147s cas_server/tests/test_utils.py::CheckPasswordCase::test_bad_method PASSED
147s cas_server/tests/test_utils.py::CheckPasswordCase::test_crypt PASSED
147s cas_server/tests/test_utils.py::CheckPasswordCase::test_hex PASSED
147s cas_server/tests/test_utils.py::CheckPasswordCase::test_ldap_password_fail PASSED
147s cas_server/tests/test_utils.py::CheckPasswordCase::test_ldap_password_valid PASSED
147s cas_server/tests/test_utils.py::CheckPasswordCase::test_plain PASSED
147s cas_server/tests/test_utils.py::CheckPasswordCase::test_plain_unicode PASSED
147s cas_server/tests/test_utils.py::CheckPasswordCase::test_setup PASSED
147s cas_server/tests/test_utils.py::UtilsTestCase::test_crypt_salt_is_valid PASSED
147s cas_server/tests/test_utils.py::UtilsTestCase::test_dictfetchall PASSED
147s cas_server/tests/test_utils.py::UtilsTestCase::test_get_current_url PASSED
147s cas_server/tests/test_utils.py::UtilsTestCase::test_get_tuple PASSED
147s cas_server/tests/test_utils.py::UtilsTestCase::test_import_attr PASSED
147s cas_server/tests/test_utils.py::UtilsTestCase::test_last_version PASSED
147s cas_server/tests/test_utils.py::UtilsTestCase::test_regexpr_validator PASSED
147s cas_server/tests/test_utils.py::UtilsTestCase::test_update_url PASSED
148s cas_server/tests/test_view.py::LoginTestCase::test_ajax_get_ticket_fail 2024-06-08 00:20:57,005 INFO User test successfully authenticated
148s 2024-06-08 00:20:57,011 WARNING Service https://www.example.org not allowed.
148s PASSED
148s cas_server/tests/test_view.py::LoginTestCase::test_ajax_get_ticket_success 2024-06-08 00:20:57,025 INFO User test successfully authenticated
148s 2024-06-08 00:20:57,033 INFO Service ticket created for service https://www.example.com by user test.
148s PASSED
148s cas_server/tests/test_view.py::LoginTestCase::test_ajax_get_ticket_success_alt 2024-06-08 00:20:57,047 INFO User test successfully authenticated
148s 2024-06-08 00:20:57,055 INFO Service ticket created for service https://www.example.com by user test.
148s PASSED
148s cas_server/tests/test_view.py::LoginTestCase::test_ajax_get_ticket_warn 2024-06-08 00:20:57,070 INFO User test successfully authenticated
148s PASSED
148s cas_server/tests/test_view.py::LoginTestCase::test_ajax_logged PASSED
148s cas_server/tests/test_view.py::LoginTestCase::test_ajax_logged_user_deleted 2024-06-08 00:20:57,097 INFO User test successfully authenticated
148s 2024-06-08 00:20:57,123 INFO User test successfully authenticated
148s 2024-06-08 00:20:57,132 WARNING User test seems authenticated but is not found in the database.
148s 2024-06-08 00:20:57,133 INFO Logging out user test.
148s 2024-06-08 00:20:57,134 INFO User test logged out
148s PASSED
148s cas_server/tests/test_view.py::LoginTestCase::test_ajax_login_required PASSED
148s cas_server/tests/test_view.py::LoginTestCase::test_gateway 2024-06-08 00:20:57,160 INFO User test successfully authenticated
148s 2024-06-08 00:20:57,169 WARNING Username test not allowed on service restrict_user_fail
148s PASSED
148s cas_server/tests/test_view.py::LoginTestCase::test_login_post_missing_params 2024-06-08 00:20:57,190 WARNING A login attempt failed
148s 2024-06-08 00:20:57,211 WARNING A login attempt failed
148s 2024-06-08 00:20:57,228 WARNING A login attempt failed
148s PASSED
148s cas_server/tests/test_view.py::LoginTestCase::test_login_view_post_badlt 2024-06-08 00:20:57,249 WARNING Received an invalid login ticket
148s PASSED
148s cas_server/tests/test_view.py::LoginTestCase::test_login_view_post_badpass_good_lt 2024-06-08 00:20:57,269 WARNING A login attempt failed
148s PASSED
148s cas_server/tests/test_view.py::LoginTestCase::test_login_view_post_goodpass_goodlt 2024-06-08 00:20:57,290 INFO User test successfully authenticated
148s PASSED
148s cas_server/tests/test_view.py::LoginTestCase::test_login_view_post_goodpass_goodlt_warn 2024-06-08 00:20:57,308 INFO User test successfully authenticated
148s PASSED
149s cas_server/tests/test_view.py::LoginTestCase::test_lt_max PASSED
149s cas_server/tests/test_view.py::LoginTestCase::test_messages_info_box_bad_messages PASSED
149s cas_server/tests/test_view.py::LoginTestCase::test_messages_info_box_disabled PASSED
149s cas_server/tests/test_view.py::LoginTestCase::test_messages_info_box_enabled PASSED
149s cas_server/tests/test_view.py::LoginTestCase::test_new_version_available_badpypi PASSED
149s cas_server/tests/test_view.py::LoginTestCase::test_new_version_available_disabled PASSED
149s cas_server/tests/test_view.py::LoginTestCase::test_new_version_available_ok PASSED
149s cas_server/tests/test_view.py::LoginTestCase::test_renew 2024-06-08 00:20:58,408 INFO User test successfully authenticated
149s 2024-06-08 00:20:58,421 INFO User test successfully authenticated
149s 2024-06-08 00:20:58,425 INFO Service ticket created for service https://www.example.com by user test.
149s PASSED
149s cas_server/tests/test_view.py::LoginTestCase::test_renew_message_disabled 2024-06-08 00:20:58,440 INFO User test successfully authenticated
149s 2024-06-08 00:20:58,452 INFO User test successfully authenticated
149s 2024-06-08 00:20:58,456 INFO Service ticket created for service https://www.example.com by user test.
149s PASSED
149s cas_server/tests/test_view.py::LoginTestCase::test_service_filter 2024-06-08 00:20:58,471 INFO User test successfully authenticated
149s 2024-06-08 00:20:58,477 WARNING User constraint failed for test, service filter_fail: ^admin$ do not match right None.
149s 2024-06-08 00:20:58,481 WARNING User constraint failed for test, service filter_fail_alt: ^toto$ do not match nom Nymous.
149s 2024-06-08 00:20:58,488 INFO Service ticket created for service https://filter_success.example.com by user test.
149s PASSED
149s cas_server/tests/test_view.py::LoginTestCase::test_service_restrict_user 2024-06-08 00:20:58,502 INFO User test successfully authenticated
149s 2024-06-08 00:20:58,508 WARNING Username test not allowed on service restrict_user_fail
149s 2024-06-08 00:20:58,514 INFO Service ticket created for service https://restrict_user_success.example.com by user test.
149s PASSED
149s cas_server/tests/test_view.py::LoginTestCase::test_service_user_field 2024-06-08 00:20:58,529 INFO User test successfully authenticated
149s 2024-06-08 00:20:58,535 WARNING Cannot use uid a loggin for user test on service field_needed_fail because it is absent
149s PASSED
149s cas_server/tests/test_view.py::LoginTestCase::test_service_user_field_evaluate_to_false 2024-06-08 00:20:58,541 INFO Service ticket created for service https://field_needed_success.example.com by user test.
149s 2024-06-08 00:20:58,555 INFO User test successfully authenticated
149s 2024-06-08 00:20:58,563 WARNING Cannot use alias a loggin for user test on service field_needed_success because it is absent
149s PASSED
149s cas_server/tests/test_view.py::LoginTestCase::test_user_logged_not_in_db 2024-06-08 00:20:58,581 INFO User test successfully authenticated
149s 2024-06-08 00:20:58,589 WARNING User test seems authenticated but is not found in the database.
149s 2024-06-08 00:20:58,590 INFO Logging out user test.
149s 2024-06-08 00:20:58,591 INFO User test logged out
149s PASSED
149s cas_server/tests/test_view.py::LoginTestCase::test_view_login_get_allowed_service PASSED
149s cas_server/tests/test_view.py::LoginTestCase::test_view_login_get_allowed_service_no_message PASSED
149s cas_server/tests/test_view.py::LoginTestCase::test_view_login_get_auth_allowed_service 2024-06-08 00:20:58,635 INFO User test successfully authenticated
149s 2024-06-08 00:20:58,643 INFO Service ticket created for service https://www.example.com/é by user test.
149s PASSED
149s cas_server/tests/test_view.py::LoginTestCase::test_view_login_get_auth_allowed_service_non_ascii 2024-06-08 00:20:58,660 INFO User test successfully authenticated
149s 2024-06-08 00:20:58,667 INFO Service ticket created for service https://www.example.com by user test.
149s PASSED
149s cas_server/tests/test_view.py::LoginTestCase::test_view_login_get_auth_allowed_service_warn 2024-06-08 00:20:58,682 INFO User test successfully authenticated
149s 2024-06-08 00:20:58,693 WARNING Received a login attempt for an already-active user
149s 2024-06-08 00:20:58,696 INFO Service ticket created for service https://www.example.com by user test.
149s PASSED
149s cas_server/tests/test_view.py::LoginTestCase::test_view_login_get_auth_denied_service 2024-06-08 00:20:58,712 INFO User test successfully authenticated
149s 2024-06-08 00:20:58,718 WARNING Service https://www.example.org not allowed.
149s PASSED
149s cas_server/tests/test_view.py::LoginTestCase::test_view_login_get_denied_service 2024-06-08 00:20:58,725 WARNING Service https://www.example.net not allowed.
149s PASSED
149s cas_server/tests/test_view.py::LoginTestCase::test_view_login_get_denied_service_no_message 2024-06-08 00:20:58,737 WARNING Service https://www.example.net not allowed.
149s PASSED
149s cas_server/tests/test_view.py::LogoutTestCase::test_ajax_logout 2024-06-08 00:20:58,753 INFO User test successfully authenticated
149s 2024-06-08 00:20:58,757 INFO logout requested
149s 2024-06-08 00:20:58,758 INFO Logging out user test.
149s PASSED
149s cas_server/tests/test_view.py::LogoutTestCase::test_ajax_logout_all_session 2024-06-08 00:20:58,763 INFO User test logged out
149s 2024-06-08 00:20:58,774 INFO User test successfully authenticated
149s 2024-06-08 00:20:58,785 INFO User test successfully authenticated
149s 2024-06-08 00:20:58,797 INFO User test successfully authenticated
149s 2024-06-08 00:20:58,809 INFO User test successfully authenticated
149s 2024-06-08 00:20:58,820 INFO User test successfully authenticated
149s 2024-06-08 00:20:58,824 INFO logout requested
149s 2024-06-08 00:20:58,824 INFO Logging out user test from all sessions.
149s 2024-06-08 00:20:58,843 INFO User test logged out
149s PASSED
149s cas_server/tests/test_view.py::LogoutTestCase::test_ajax_redirect_after_logout 2024-06-08 00:20:58,853 INFO User test successfully authenticated
149s 2024-06-08 00:20:58,857 INFO logout requested
149s 2024-06-08 00:20:58,858 INFO Logging out user test.
149s 2024-06-08 00:20:58,862 INFO User test logged out
149s PASSED
149s cas_server/tests/test_view.py::LogoutTestCase::test_logout 2024-06-08 00:20:58,865 INFO logout requested
149s PASSED
149s cas_server/tests/test_view.py::LogoutTestCase::test_logout_from_all_session 2024-06-08 00:20:58,878 INFO User test successfully authenticated
149s 2024-06-08 00:20:58,890 INFO User test successfully authenticated
149s 2024-06-08 00:20:58,893 INFO logout requested
149s 2024-06-08 00:20:58,894 INFO Logging out user test from all sessions.
149s 2024-06-08 00:20:58,902 INFO User test logged out
149s PASSED
149s cas_server/tests/test_view.py::LogoutTestCase::test_logout_slo 2024-06-08 00:20:58,915 INFO User test successfully authenticated
149s 2024-06-08 00:20:58,924 INFO Service ticket created for service http://127.0.0.1:35185 by user test.
149s 2024-06-08 00:20:58,928 INFO Validate: Service ticket ST-GIIfIhqBq31XFiEYajmD78PRIk1BfBondaDnjqdZXZVEN9VcidLRXb7XkxAf0 validated, user test authenticated on service http://127.0.0.1:35185
149s 2024-06-08 00:20:58,929 INFO logout requested
149s 2024-06-08 00:20:58,930 INFO Logging out user test.
149s 2024-06-08 00:20:58,933 INFO Sending SLO requests to service http://127.0.0.1:35185 for user test
149s 2024-06-08 00:20:58,937 WARNING Error during SLO for user test: ('Connection aborted.', RemoteDisconnected('Remote end closed connection without response'))
149s 2024-06-08 00:20:58,939 INFO User test logged out
149s 2024-06-08 00:20:58,950 INFO User test successfully authenticated
149s 2024-06-08 00:20:58,958 INFO Service ticket created for service http://127.0.0.1:45678 by user test.
149s 2024-06-08 00:20:58,961 INFO Validate: Service ticket ST-BhjVcNtl2fkDvxTCsSwd194JYqBfhlzza4oIvMQHjA4AfhE54HbAWgEHpT2QQ validated, user test authenticated on service http://127.0.0.1:45678
149s 2024-06-08 00:20:58,963 INFO logout requested
149s 2024-06-08 00:20:58,963 INFO Logging out user test.
149s 2024-06-08 00:20:58,966 INFO Sending SLO requests to service http://127.0.0.1:45678 for user test
149s 2024-06-08 00:20:58,969 WARNING Error during SLO for user test: ('Connection aborted.', RemoteDisconnected('Remote end closed connection without response'))
149s 2024-06-08 00:20:58,972 INFO User test logged out
149s 2024-06-08 00:20:58,982 INFO User test successfully authenticated
149s 2024-06-08 00:20:58,989 INFO Service ticket created for service http://127.0.0.1:45678 by user test.
149s 2024-06-08 00:20:58,993 INFO Validate: Service ticket ST-lXJDxxZFmqPKxm8vznkzbLKtc8EkJXkGNJWuqKevLYfGxg7iJfVXRB0xKGSnP validated, user test authenticated on service http://127.0.0.1:45678
149s 2024-06-08 00:20:58,994 INFO logout requested
149s 2024-06-08 00:20:58,995 INFO Logging out user test.
149s 2024-06-08 00:20:58,998 INFO Sending SLO requests to service http://127.0.0.1:45678 for user test
149s 2024-06-08 00:20:59,001 WARNING Error during SLO for user test: HTTPConnectionPool(host='127.0.0.1', port=33391): Max retries exceeded with url: / (Caused by NewConnectionError('<urllib3.connection.HTTPConnection object at 0x70d24e6d3f80>: Failed to establish a new connection: [Errno 111] Connection refused'))
150s 2024-06-08 00:20:59,003 INFO User test logged out
150s PASSED
150s cas_server/tests/test_view.py::LogoutTestCase::test_logout_view 2024-06-08 00:20:59,015 INFO User test successfully authenticated
150s 2024-06-08 00:20:59,027 INFO User test successfully authenticated
150s 2024-06-08 00:20:59,033 INFO logout requested
150s 2024-06-08 00:20:59,034 INFO Logging out user test.
150s 2024-06-08 00:20:59,038 INFO User test logged out
150s PASSED
150s cas_server/tests/test_view.py::LogoutTestCase::test_logout_view_service 2024-06-08 00:20:59,057 INFO User test successfully authenticated
150s 2024-06-08 00:20:59,061 INFO logout requested
150s 2024-06-08 00:20:59,062 INFO Logging out user test.
150s 2024-06-08 00:20:59,067 INFO User test logged out
150s PASSED
150s cas_server/tests/test_view.py::LogoutTestCase::test_logout_view_url 2024-06-08 00:20:59,083 INFO User test successfully authenticated
150s 2024-06-08 00:20:59,087 INFO logout requested
150s 2024-06-08 00:20:59,088 INFO Logging out user test.
150s 2024-06-08 00:20:59,092 INFO User test logged out
150s PASSED
150s cas_server/tests/test_view.py::LogoutTestCase::test_redirect_after_logout 2024-06-08 00:20:59,109 INFO User test successfully authenticated
150s 2024-06-08 00:20:59,113 INFO logout requested
150s 2024-06-08 00:20:59,113 INFO Logging out user test.
150s 2024-06-08 00:20:59,118 INFO User test logged out
150s PASSED
150s cas_server/tests/test_view.py::LogoutTestCase::test_redirect_after_logout_to_service 2024-06-08 00:20:59,130 INFO User test successfully authenticated
150s 2024-06-08 00:20:59,134 INFO logout requested
150s 2024-06-08 00:20:59,134 INFO Logging out user test.
150s 2024-06-08 00:20:59,139 INFO User test logged out
150s 2024-06-08 00:20:59,149 INFO logout requested
150s PASSED
150s cas_server/tests/test_view.py::AuthTestCase::test_auth_view_badpass PASSED
150s cas_server/tests/test_view.py::AuthTestCase::test_auth_view_badsecret PASSED
150s cas_server/tests/test_view.py::AuthTestCase::test_auth_view_badservice 2024-06-08 00:20:59,169 WARNING Service https://www.example.org not allowed.
150s PASSED
150s cas_server/tests/test_view.py::AuthTestCase::test_auth_view_badsettings PASSED
150s cas_server/tests/test_view.py::AuthTestCase::test_auth_view_goodpass PASSED
150s cas_server/tests/test_view.py::AuthTestCase::test_auth_view_goodpass_logged 2024-06-08 00:20:59,189 INFO User test successfully authenticated
150s PASSED
150s cas_server/tests/test_view.py::AuthTestCase::test_auth_view_missing_parameter PASSED
150s cas_server/tests/test_view.py::ValidateTestCase::test_validate_missing_parameter 2024-06-08 00:20:59,211 INFO User test successfully authenticated
150s 2024-06-08 00:20:59,220 INFO Service ticket created for service https://www.example.com by user test.
150s 2024-06-08 00:20:59,222 WARNING Validate: service or ticket missing
150s 2024-06-08 00:20:59,223 WARNING Validate: service or ticket missing
150s PASSED
150s cas_server/tests/test_view.py::ValidateTestCase::test_validate_service_renew 2024-06-08 00:20:59,236 INFO User test successfully authenticated
150s 2024-06-08 00:20:59,240 INFO Service ticket created for service https://www.example.com by user test.
150s 2024-06-08 00:20:59,244 INFO Validate: Service ticket ST-w5gLYEQ9FBnl1SdDWWZk6f0o8TblkCoBhOrCotJrR0PxQwYEtghv5KawSxtWL validated, user test authenticated on service https://www.example.com
150s 2024-06-08 00:20:59,253 INFO User test successfully authenticated
150s 2024-06-08 00:20:59,258 INFO Service ticket created for service https://www.example.com by user test.
150s 2024-06-08 00:20:59,261 INFO Validate: Service ticket ST-owA5c3gphlcp5cJ99kb4lek2uNpILgvwX8SSL0IYoSQYt8p9gMT62ehOlFajk validated, user test authenticated on service https://www.example.com
150s 2024-06-08 00:20:59,266 INFO Service ticket created for service https://www.example.com by user test.
150s 2024-06-08 00:20:59,268 WARNING Validate: Service ticket ST-vvSQCLn1PaALQXYaPsHxVcEmi1vbLOao6Uh1uMMtoIxSHqvYMeA5be1SP7XHW not found or already validated, auth to https://www.example.com failed
150s PASSED
150s cas_server/tests/test_view.py::ValidateTestCase::test_validate_user_field_ok 2024-06-08 00:20:59,281 INFO User test successfully authenticated
150s 2024-06-08 00:20:59,289 INFO Service ticket created for service https://user_field.example.com by user test.
150s 2024-06-08 00:20:59,293 INFO Validate: Service ticket ST-4DE6qcku7H3SZYcTCFHUi8UpNyrpRrxJym3g0lsCSEiFP5IA1Rjlmto3Uudqp validated, user test authenticated on service https://user_field.example.com
150s 2024-06-08 00:20:59,302 INFO User test successfully authenticated
150s 2024-06-08 00:20:59,310 INFO Service ticket created for service https://user_field_alt.example.com by user test.
150s 2024-06-08 00:20:59,314 INFO Validate: Service ticket ST-B8vp7dm3rJZFkyG8BKQXTSPUm6rt9RuvmGMDOs4jDqwy5SREuJRGnXS7hboW4 validated, user test authenticated on service https://user_field_alt.example.com
150s PASSED
150s cas_server/tests/test_view.py::ValidateTestCase::test_validate_view_badservice 2024-06-08 00:20:59,327 INFO User test successfully authenticated
150s 2024-06-08 00:20:59,335 INFO Service ticket created for service https://www.example.com by user test.
150s PASSED
150s cas_server/tests/test_view.py::ValidateTestCase::test_validate_view_badticket 2024-06-08 00:20:59,338 WARNING Validate: Service ticket ST-Pmf7fC1MBEaFCiet9ii8fGbQX8hCD2TqB4hV3gLAZXT9rHEE6M1jJ8YwcvFP4 not found or already validated, auth to https://www.example.org failed
150s 2024-06-08 00:20:59,350 INFO User test successfully authenticated
150s 2024-06-08 00:20:59,358 INFO Service ticket created for service https://www.example.com by user test.
150s 2024-06-08 00:20:59,361 WARNING Validate: Service ticket ST-RANDOM not found or already validated, auth to https://www.example.com failed
150s PASSED
150s cas_server/tests/test_view.py::ValidateTestCase::test_validate_view_ok 2024-06-08 00:20:59,373 INFO User test successfully authenticated
150s 2024-06-08 00:20:59,381 INFO Service ticket created for service https://www.example.com by user test.
150s 2024-06-08 00:20:59,384 INFO Validate: Service ticket ST-sejstoKODxRqmbu26HFYmEHB4Ai8jqp68LHFhtoRndvesJ5PaARMxZ4cnEqQz validated, user test authenticated on service https://www.example.com
150s PASSED
150s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_missing_parameter 2024-06-08 00:20:59,398 INFO User test successfully authenticated
150s 2024-06-08 00:20:59,407 INFO Service ticket created for service http://127.0.0.1:45678 by user test.
150s 2024-06-08 00:20:59,410 WARNING ValidateService: missing ticket or service
150s 2024-06-08 00:20:59,411 WARNING ValidateService: missing ticket or service
150s PASSED
150s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_proxy 2024-06-08 00:20:59,426 INFO User test successfully authenticated
150s 2024-06-08 00:20:59,433 INFO Service ticket created for service http://127.0.0.1:39465 by user test.
150s 2024-06-08 00:20:59,440 INFO ValidateService: ticket ST-Kn89xQjppaOFzS0Kp8DO2bdOYO2fRqtiQWPdVgUZErbsOZ0HRWPzSX49lLBNu validated for user test on service http://127.0.0.1:39465. Proxy Granting Ticket transmited to http://127.0.0.1:39465.
150s 2024-06-08 00:20:59,446 INFO Proxy ticket created for user test on service http://127.0.0.1:45678.
150s 2024-06-08 00:20:59,451 INFO ValidateService: ticket PT-DnjijpWdTEvULjU4wVWBeQxH3Y7MHjzy6vzuWmzxn5SOjovDI6SiV9nJY399V validated for user test on service http://127.0.0.1:45678.
150s 2024-06-08 00:20:59,462 INFO User test successfully authenticated
150s 2024-06-08 00:20:59,469 INFO Service ticket created for service http://127.0.0.1:35601 by user test.
150s 2024-06-08 00:20:59,475 INFO ValidateService: ticket ST-Yj7o255UmPVqJlzZiW3QzP06TWtCXKFWBNcAWj4kFVqRMhCJx6EShY06js9Ke validated for user test on service http://127.0.0.1:35601. Proxy Granting Ticket transmited to http://127.0.0.1:35601.
150s 2024-06-08 00:20:59,480 INFO Proxy ticket created for user test on service http://127.0.0.1:45678.
150s 2024-06-08 00:20:59,482 WARNING ValidateService: validation error: INVALID_TICKET PT-vXQciFm98dFkh5vOsiWf19EQZR8HPoX7znhjU09aFKT5UWCuqk4wxxvOZScgr
150s PASSED
150s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_replace_attributes 2024-06-08 00:20:59,494 INFO User test successfully authenticated
150s 2024-06-08 00:20:59,502 INFO Service ticket created for service https://replace_attribute.example.com by user test.
150s 2024-06-08 00:20:59,506 INFO ValidateService: ticket ST-Immjoey19tF0R7K7INqWm9QmOnglXQJvcm1laXNMnNWRZfWJNcYgE0XZ1SPOd validated for user test on service https://replace_attribute.example.com.
150s 2024-06-08 00:20:59,515 INFO User test successfully authenticated
150s 2024-06-08 00:20:59,523 INFO Service ticket created for service https://replace_attribute_list.example.com by user test.
150s 2024-06-08 00:20:59,527 INFO ValidateService: ticket ST-ZLAYpSt3kQpoJkTVBsSmA4azfLikuYjawrXemuxhiBoDkmqom894g0kR9xjrM validated for user test on service https://replace_attribute_list.example.com.
150s PASSED
150s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_service_pgturl_404 2024-06-08 00:20:59,541 INFO User test successfully authenticated
150s 2024-06-08 00:20:59,548 INFO Service ticket created for service http://127.0.0.1:44593 by user test.
150s 2024-06-08 00:20:59,555 INFO ValidateService: ticket ST-KwL9ltZju77Y6AiawB8X5DN3ArNDtlX3tibE2VXHMRPHe4rDBB2YzvI4zBvE7 validated for user test on service http://127.0.0.1:44593. Proxy Granting Ticket transmited to http://127.0.0.1:44593.
150s PASSED
150s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_service_pgturl_bad_proxy_callback 2024-06-08 00:20:59,569 INFO User test successfully authenticated
150s 2024-06-08 00:20:59,576 INFO Service ticket created for service http://127.0.0.1:45678 by user test.
150s 2024-06-08 00:20:59,580 WARNING ValidateService: validation error: INVALID_PROXY_CALLBACK callback url not allowed by configuration
150s 2024-06-08 00:20:59,589 INFO User test successfully authenticated
150s 2024-06-08 00:20:59,597 INFO Service ticket created for service http://127.0.0.1:45678 by user test.
150s 2024-06-08 00:20:59,601 WARNING Service https://www.example.org not allowed.
150s 2024-06-08 00:20:59,601 WARNING ValidateService: validation error: INVALID_PROXY_CALLBACK callback url not allowed by configuration
150s PASSED
150s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_service_pgturl_sslerror 2024-06-08 00:20:59,616 INFO User test successfully authenticated
150s 2024-06-08 00:20:59,624 INFO Service ticket created for service https://127.0.0.1:35985 by user test.
150s 2024-06-08 00:20:59,665 WARNING ValidateService: validation error: INVALID_PROXY_CALLBACK <class 'urllib3.exceptions.MaxRetryError'>: HTTPSConnectionPool(host='127.0.0.1', port=35985): Max retries exceeded with url: /?pgtId=PGT-YS7PZcx9DysXboMX0apAX8ymFGWZr5Ww5gBhx9FKrT9STVpHUaeHso7Wi2Yr&pgtIou=PGTIOU-6usXOyq4khW8t1QTsMkP8aV2t6wFatVDTGNl70bZB3QyfqeHWdsAiKPff (Caused by SSLError(SSLError(1, '[SSL: WRONG_VERSION_NUMBER] wrong version number (_ssl.c:1000)')))
150s PASSED
150s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_service_renew 2024-06-08 00:20:59,678 INFO User test successfully authenticated
150s 2024-06-08 00:20:59,682 INFO Service ticket created for service http://127.0.0.1:45678 by user test.
150s 2024-06-08 00:20:59,686 INFO ValidateService: ticket ST-oncJwiAEUk4ViSkPKa2Ik3GmsvVtvbUbz0adKf0RzXGf2AIVPMDtjd4v94MxL validated for user test on service http://127.0.0.1:45678.
150s 2024-06-08 00:20:59,695 INFO User test successfully authenticated
150s 2024-06-08 00:20:59,700 INFO Service ticket created for service http://127.0.0.1:45678 by user test.
150s 2024-06-08 00:20:59,704 INFO ValidateService: ticket ST-GKOna2im3Myie8ZixXbGJm8ZyJ901ohurY7f6Io8lY6QoK9vMFls20EDfyGmJ validated for user test on service http://127.0.0.1:45678.
150s 2024-06-08 00:20:59,709 INFO Service ticket created for service http://127.0.0.1:45678 by user test.
150s PASSED
150s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_service_view_badservice 2024-06-08 00:20:59,711 WARNING ValidateService: validation error: INVALID_TICKET ticket not found
150s 2024-06-08 00:20:59,724 INFO User test successfully authenticated
150s 2024-06-08 00:20:59,732 INFO Service ticket created for service http://127.0.0.1:45678 by user test.
150s 2024-06-08 00:20:59,736 WARNING ValidateService: validation error: INVALID_SERVICE https://www.example.org
150s PASSED
150s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_service_view_badticket_badprefix 2024-06-08 00:20:59,753 INFO User test successfully authenticated
150s 2024-06-08 00:20:59,764 INFO Service ticket created for service http://127.0.0.1:45678 by user test.
150s 2024-06-08 00:20:59,767 WARNING ValidateService: validation error: INVALID_TICKET RANDOM
150s PASSED
150s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_service_view_badticket_goodprefix 2024-06-08 00:20:59,785 INFO User test successfully authenticated
150s 2024-06-08 00:20:59,795 INFO Service ticket created for service http://127.0.0.1:45678 by user test.
150s 2024-06-08 00:20:59,799 WARNING ValidateService: validation error: INVALID_TICKET ticket not found
150s PASSED
150s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_service_view_ok 2024-06-08 00:20:59,816 INFO User test successfully authenticated
150s 2024-06-08 00:20:59,827 INFO Service ticket created for service http://127.0.0.1:45678 by user test.
150s 2024-06-08 00:20:59,832 INFO ValidateService: ticket ST-6gaRJ5W6xCMs1178ZSIiLe4EnGEe5m3QsO1G2nWLfWhhDkZxMDTvEz3CmGBOA validated for user test on service http://127.0.0.1:45678.
150s PASSED
150s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_service_view_ok_one_attribute 2024-06-08 00:20:59,845 INFO User test successfully authenticated
150s 2024-06-08 00:20:59,853 INFO Service ticket created for service https://one_attribute.example.com by user test.
150s 2024-06-08 00:20:59,857 INFO ValidateService: ticket ST-ZOelKHJSo8PRLqFFEieJhz3ZDF1SoeS3YAujhdqShhDMxRpIfEDcM0rJF9QC5 validated for user test on service https://one_attribute.example.com.
150s PASSED
150s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_service_view_ok_pgturl 2024-06-08 00:20:59,870 INFO User test successfully authenticated
150s 2024-06-08 00:20:59,879 INFO Service ticket created for service http://127.0.0.1:38473 by user test.
150s 2024-06-08 00:20:59,886 INFO ValidateService: ticket ST-j4sccnoLGZdZeO696sfLuTgVlHJybV5YrWxL8nBukx6UAEi14QLoj3rMMUCD3 validated for user test on service http://127.0.0.1:38473. Proxy Granting Ticket transmited to http://127.0.0.1:38473.
150s PASSED
150s cas_server/tests/test_view.py::ValidateServiceTestCase::test_validate_user_field_ok 2024-06-08 00:20:59,943 INFO User test successfully authenticated
150s 2024-06-08 00:20:59,950 INFO Service ticket created for service https://user_field.example.com by user test.
150s 2024-06-08 00:20:59,955 INFO ValidateService: ticket ST-jDlkBFI0EXp8E7VJk2pFFS5dcEDR0aKMgtOiDfldrbnhjt7tL2knNKrg6UEGG validated for user test on service https://user_field.example.com.
150s 2024-06-08 00:20:59,963 INFO User test successfully authenticated
150s 2024-06-08 00:20:59,971 INFO Service ticket created for service https://user_field_alt.example.com by user test.
150s 2024-06-08 00:20:59,975 INFO ValidateService: ticket ST-BPjnEyvy0ZEWGw5XmDatQCP5Byvjd9YjFabmMKJGtyMjedTFnHcNbBrbquU6G validated for user test on service https://user_field_alt.example.com.
150s PASSED
150s cas_server/tests/test_view.py::ProxyTestCase::test_proxy_missing_parameter 2024-06-08 00:20:59,991 INFO User test successfully authenticated
150s 2024-06-08 00:20:59,998 INFO Service ticket created for service http://127.0.0.1:36365 by user test.
151s 2024-06-08 00:21:00,005 INFO ValidateService: ticket ST-2a3fvr7E6HvzLe53vWzRz0zGu0fQ9sjUvXdnTd8RpHhGezuVsYNCvIxvD5zEY validated for user test on service http://127.0.0.1:36365. Proxy Granting Ticket transmited to http://127.0.0.1:36365.
151s 2024-06-08 00:21:00,007 WARNING Proxy: validation error: INVALID_REQUEST you must specify and pgt and targetService
151s 2024-06-08 00:21:00,008 WARNING Proxy: validation error: INVALID_REQUEST you must specify and pgt and targetService
151s PASSED
151s cas_server/tests/test_view.py::ProxyTestCase::test_proxy_unauthorized_user 2024-06-08 00:21:00,022 INFO User test successfully authenticated
151s 2024-06-08 00:21:00,029 INFO Service ticket created for service http://127.0.0.1:33095 by user test.
151s 2024-06-08 00:21:00,036 INFO ValidateService: ticket ST-V02vFR9Zws6DJ73TL06lzoXKfmM9XrlpHc2kcNYYTZytiu1VBoJBTiLl55Pfm validated for user test on service http://127.0.0.1:33095. Proxy Granting Ticket transmited to http://127.0.0.1:33095.
151s 2024-06-08 00:21:00,041 WARNING Username test not allowed on service restrict_user_fail
151s 2024-06-08 00:21:00,041 WARNING Proxy: validation error: UNAUTHORIZED_USER User test not allowed on https://restrict_user_fail.example.com
151s 2024-06-08 00:21:00,045 WARNING User constraint failed for test, service filter_fail: ^admin$ do not match right None.
151s 2024-06-08 00:21:00,045 WARNING Proxy: validation error: UNAUTHORIZED_USER User test not allowed on https://filter_fail.example.com
151s 2024-06-08 00:21:00,049 WARNING Cannot use uid a loggin for user test on service field_needed_fail because it is absent
151s 2024-06-08 00:21:00,049 WARNING Proxy: validation error: UNAUTHORIZED_USER User test not allowed on https://field_needed_fail.example.com
151s PASSED
151s cas_server/tests/test_view.py::ProxyTestCase::test_validate_proxy_bad_pgt 2024-06-08 00:21:00,068 INFO User test successfully authenticated
151s 2024-06-08 00:21:00,077 INFO Service ticket created for service http://127.0.0.1:33641 by user test.
151s 2024-06-08 00:21:00,084 INFO ValidateService: ticket ST-xEiveafA8LHGcwNkWmOu2dhBWOaxISjMD1sOD9eTivaAhsn0P8mmuKyvtlWvC validated for user test on service http://127.0.0.1:33641. Proxy Granting Ticket transmited to http://127.0.0.1:33641.
151s 2024-06-08 00:21:00,086 WARNING Proxy: validation error: INVALID_TICKET PGT PGT-RANDOM not found
151s PASSED
151s cas_server/tests/test_view.py::ProxyTestCase::test_validate_proxy_bad_service 2024-06-08 00:21:00,100 INFO User test successfully authenticated
151s 2024-06-08 00:21:00,108 INFO Service ticket created for service http://127.0.0.1:45547 by user test.
151s 2024-06-08 00:21:00,114 INFO ValidateService: ticket ST-HhQFRMTjBdIzVIIPj7f21c7IuQFynaWY0R7QazC3hPzjtkA8GNThlt8IJddIC validated for user test on service http://127.0.0.1:45547. Proxy Granting Ticket transmited to http://127.0.0.1:45547.
151s 2024-06-08 00:21:00,116 WARNING Service https://www.example.org not allowed.
151s 2024-06-08 00:21:00,116 WARNING Proxy: validation error: UNAUTHORIZED_SERVICE https://www.example.org
151s 2024-06-08 00:21:00,118 WARNING Proxy: validation error: UNAUTHORIZED_SERVICE the service http://127.0.0.1:45547 does not allow proxy tickets
151s PASSED
151s cas_server/tests/test_view.py::ProxyTestCase::test_validate_proxy_ok 2024-06-08 00:21:00,133 INFO User test successfully authenticated
151s 2024-06-08 00:21:00,140 INFO Service ticket created for service http://127.0.0.1:33857 by user test.
151s 2024-06-08 00:21:00,147 INFO ValidateService: ticket ST-xOz5hzN4g3QQo62CQalnaW9XNZ64oXEBdt1heljE9DX92fO0G1mnasgmlV8zG validated for user test on service http://127.0.0.1:33857. Proxy Granting Ticket transmited to http://127.0.0.1:33857.
151s 2024-06-08 00:21:00,153 INFO Proxy ticket created for user test on service https://www.example.com.
151s 2024-06-08 00:21:00,157 INFO ValidateService: ticket PT-Q0uN2WI2Bhc19GAptdd7362NmkhC40D2GB0QIQQr1P28rabK12N2CnjwQtDFj validated for user test on service https://www.example.com.
151s PASSED
151s cas_server/tests/test_view.py::SamlValidateTestCase::test_saml_bad_target 2024-06-08 00:21:00,172 INFO User test successfully authenticated
151s 2024-06-08 00:21:00,179 INFO Service ticket created for service https://www.example.com by user test.
151s 2024-06-08 00:21:00,183 WARNING SamlValidate: validation error: AuthnFailed TARGET https://www.example.org does not match ticket service
151s PASSED
151s cas_server/tests/test_view.py::SamlValidateTestCase::test_saml_bad_ticket 2024-06-08 00:21:00,191 WARNING SamlValidate: validation error: AuthnFailed ticket ST-HjOjqFHAFezED3PPH1SfMioJuv1kzrRNrrqJ6hk6M7FuIQKdkvjBCiXNmk1Bv not found
151s 2024-06-08 00:21:00,193 WARNING SamlValidate: validation error: AuthnFailed ticket PT-ShHVQK6q5hhAevyhuRXr26H08qgZa9D9KXJeEbyttSe95jDoeny3oFWScqvn2 not found
151s PASSED
151s cas_server/tests/test_view.py::SamlValidateTestCase::test_saml_bad_ticket_prefix 2024-06-08 00:21:00,199 WARNING SamlValidate: validation error: AuthnFailed ticket RANDOM-NOT-BEGINING-WITH-ST-OR-ST should begin with PT- or ST-
151s PASSED
151s cas_server/tests/test_view.py::SamlValidateTestCase::test_saml_bad_xml PASSED
151s cas_server/tests/test_view.py::SamlValidateTestCase::test_saml_ok 2024-06-08 00:21:00,204 WARNING SamlValidate: validation error: VersionMismatch 
151s 2024-06-08 00:21:00,218 INFO User test successfully authenticated
151s 2024-06-08 00:21:00,225 INFO Service ticket created for service https://www.example.com by user test.
151s 2024-06-08 00:21:00,236 INFO User test successfully authenticated
151s 2024-06-08 00:21:00,244 INFO Service ticket created for service http://127.0.0.1:38169 by user test.
151s 2024-06-08 00:21:00,251 INFO ValidateService: ticket ST-aOlIOFZWaVcksDbkJCsoiHmI7sQKS6Rmnu6t1sunOVEonj1Yg3I7XxVjqI3jc validated for user test on service http://127.0.0.1:38169. Proxy Granting Ticket transmited to http://127.0.0.1:38169.
151s 2024-06-08 00:21:00,257 INFO Proxy ticket created for user test on service https://www.example.com.
151s 2024-06-08 00:21:00,261 INFO SamlValidate: ticket ST-iuosqc7cxn4VLqgT6PZ9kDj4LenG5iarZWnuU1NUY65kb8ntoKFeGbtcz4Arw validated for user test on service https://www.example.com.
151s 2024-06-08 00:21:00,264 INFO SamlValidate: ticket PT-emNmG2md0bE8GNyeNwMlEjz7gHT9VXWc3I4WyU81EJR82awYCRZCgWTuiQBtL validated for user test on service https://www.example.com.
151s PASSED
151s cas_server/tests/test_view.py::SamlValidateTestCase::test_saml_ok_user_field 2024-06-08 00:21:00,278 INFO User test successfully authenticated
151s 2024-06-08 00:21:00,285 INFO Service ticket created for service https://field_needed_success.example.com by user test.
151s 2024-06-08 00:21:00,291 INFO SamlValidate: ticket ST-rAsi18ASnbLUiQZQjrpTeLcPh77SItIPWuwHgNUJUTfj8ChxHBdGZDlFnDXFU validated for user test on service https://field_needed_success.example.com.
151s 2024-06-08 00:21:00,301 INFO User test successfully authenticated
151s 2024-06-08 00:21:00,311 INFO Service ticket created for service https://field_needed_success_alt.example.com by user test.
151s 2024-06-08 00:21:00,315 INFO SamlValidate: ticket ST-Lti3Hwqm2SqjcZbiqy7ACdJNmobYTztQlGanXNUoL4X26YOeIUw8DVcqFtbqU validated for user test on service https://field_needed_success_alt.example.com.
151s PASSEDDestroying test database for alias 'default'...
151s 
151s 
151s =============================== warnings summary ===============================
151s cas_server/utils.py:33
151s   /tmp/autopkgtest.NSrMwe/autopkgtest_tmp/cas_server/utils.py:33: DeprecationWarning: 'crypt' is deprecated and slated for removal in Python 3.13
151s     import crypt
151s 
151s cas_server/tests/utils.py:20
151s   /tmp/autopkgtest.NSrMwe/autopkgtest_tmp/cas_server/tests/utils.py:20: DeprecationWarning: 'cgi' is deprecated and slated for removal in Python 3.13
151s     import cgi
151s 
151s cas_server/tests/test_federate.py: 8 warnings
151s cas_server/tests/test_view.py: 3 warnings
151s   /tmp/autopkgtest.NSrMwe/autopkgtest_tmp/cas_server/utils.py:208: DeprecationWarning: datetime.datetime.utcnow() is deprecated and scheduled for removal in a future version. Use timezone-aware objects to represent datetimes in UTC: datetime.datetime.now(datetime.UTC).
151s     datetime.utcnow() + timedelta(seconds=max_age),
151s 
151s cas_server/tests/test_federate.py::FederateAuthLoginLogoutTestCase::test_login_post_provider
151s   /usr/lib/python3.12/unittest/case.py:690: DeprecationWarning: It is deprecated to return a value that is not None from a test case (<bound method FederateAuthLoginLogoutTestCase.test_login_post_provider of <cas_server.tests.test_federate.FederateAuthLoginLogoutTestCase testMethod=test_login_post_provider>>)
151s     return self.run(*args, **kwds)
151s 
151s -- Docs: https://docs.pytest.org/en/stable/how-to/capture-warnings.html
151s ======================= 128 passed, 14 warnings in 7.07s =======================
151s 
151s autopkgtest [00:21:00]: test run-test-suite.sh: -----------------------]
152s autopkgtest [00:21:01]: test run-test-suite.sh:  - - - - - - - - - - results - - - - - - - - - -
152s run-test-suite.sh    PASS
152s autopkgtest [00:21:01]: @@@@@@@@@@@@@@@@@@@@ summary
152s run-test-suite.sh    PASS
168s nova [W] Skipping flock for amd64
168s Creating nova instance adt-oracular-amd64-django-cas-server-20240608-001828-juju-7f2275-prod-proposed-migration-environment-3-2ba3e9b0-feae-4b4f-9b93-934855f2abb8 from image adt/ubuntu-oracular-amd64-server-20240607.img (UUID d996b44c-1e10-4875-aeab-5b4c434d75a2)...