0s autopkgtest [14:45:21]: starting date and time: 2025-06-19 14:45:21+0000
  0s autopkgtest [14:45:21]: git checkout: 9986aa8c Merge branch 'skia/fix_network_interface' into 'ubuntu/production'
  0s autopkgtest [14:45:21]: host juju-7f2275-prod-proposed-migration-environment-21; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.dj5h1_pf/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:requests --apt-upgrade python-stubserver --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=requests/2.32.3+dfsg-5ubuntu2 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest-cpu2-ram4-disk20-ppc64el --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-21@sto01-ppc64el-21.secgroup --name adt-questing-ppc64el-python-stubserver-20250619-144521-juju-7f2275-prod-proposed-migration-environment-21-5c3f9310-0829-4143-bea1-a147da177fbe --image adt/ubuntu-questing-ppc64el-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-21 --net-id=net_prod-autopkgtest-workers-ppc64el -e TERM=linux --mirror=http://ftpmaster.internal/ubuntu/
 67s autopkgtest [14:46:28]: testbed dpkg architecture: ppc64el
 67s autopkgtest [14:46:28]: testbed apt version: 3.1.2
 67s autopkgtest [14:46:28]: @@@@@@@@@@@@@@@@@@@@ test bed setup
 67s autopkgtest [14:46:28]: testbed release detected to be: None
 68s autopkgtest [14:46:29]: updating testbed package index (apt update)
 68s Get:1 http://ftpmaster.internal/ubuntu questing-proposed InRelease [249 kB]
 68s Hit:2 http://ftpmaster.internal/ubuntu questing InRelease
 68s Hit:3 http://ftpmaster.internal/ubuntu questing-updates InRelease
 68s Hit:4 http://ftpmaster.internal/ubuntu questing-security InRelease
 68s Get:5 http://ftpmaster.internal/ubuntu questing-proposed/multiverse Sources [17.4 kB]
 68s Get:6 http://ftpmaster.internal/ubuntu questing-proposed/restricted Sources [4716 B]
 68s Get:7 http://ftpmaster.internal/ubuntu questing-proposed/main Sources [38.3 kB]
 68s Get:8 http://ftpmaster.internal/ubuntu questing-proposed/universe Sources [426 kB]
 68s Get:9 http://ftpmaster.internal/ubuntu questing-proposed/main ppc64el Packages [66.7 kB]
 68s Get:10 http://ftpmaster.internal/ubuntu questing-proposed/restricted ppc64el Packages [724 B]
 68s Get:11 http://ftpmaster.internal/ubuntu questing-proposed/universe ppc64el Packages [340 kB]
 68s Get:12 http://ftpmaster.internal/ubuntu questing-proposed/multiverse ppc64el Packages [6448 B]
 68s Fetched 1149 kB in 0s (2413 kB/s)
 69s Reading package lists...
 70s autopkgtest [14:46:31]: upgrading testbed (apt dist-upgrade and autopurge)
 70s Reading package lists...
 70s Building dependency tree...
 70s Reading state information...
 70s Calculating upgrade...
 70s The following packages will be upgraded:
 70s   python3-requests
 70s 1 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
 70s Need to get 53.1 kB of archives.
 70s After this operation, 0 B of additional disk space will be used.
 70s Get:1 http://ftpmaster.internal/ubuntu questing-proposed/main ppc64el python3-requests all 2.32.3+dfsg-5ubuntu2 [53.1 kB]
 71s Fetched 53.1 kB in 0s (2893 kB/s)
 71s (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 ... 79652 files and directories currently installed.)
 71s Preparing to unpack .../python3-requests_2.32.3+dfsg-5ubuntu2_all.deb ...
 71s Unpacking python3-requests (2.32.3+dfsg-5ubuntu2) over (2.32.3+dfsg-5ubuntu1) ...
 71s Setting up python3-requests (2.32.3+dfsg-5ubuntu2) ...
 72s Reading package lists...
 72s Building dependency tree...
 72s Reading state information...
 72s Solving dependencies...
 72s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
 74s autopkgtest [14:46:35]: testbed running kernel: Linux 6.14.0-15-generic #15-Ubuntu SMP Sun Apr  6 14:52:42 UTC 2025
 74s autopkgtest [14:46:35]: @@@@@@@@@@@@@@@@@@@@ apt-source python-stubserver
 75s Get:1 http://ftpmaster.internal/ubuntu questing/universe python-stubserver 1.1-4 (dsc) [2185 B]
 75s Get:2 http://ftpmaster.internal/ubuntu questing/universe python-stubserver 1.1-4 (tar) [5895 B]
 75s Get:3 http://ftpmaster.internal/ubuntu questing/universe python-stubserver 1.1-4 (diff) [5984 B]
 76s gpgv: Signature made Sun Dec  4 21:20:09 2022 UTC
 76s gpgv:                using RSA key 77C9619C49D6A2CDCDF2FFAA428304A1748DCC7A
 76s gpgv: Can't check signature: No public key
 76s dpkg-source: warning: cannot verify inline signature for ./python-stubserver_1.1-4.dsc: no acceptable signature found
 76s autopkgtest [14:46:37]: testing package python-stubserver version 1.1-4
 76s autopkgtest [14:46:37]: build not needed
 76s autopkgtest [14:46:37]: test run-unit-test: preparing testbed
 76s Reading package lists...
 76s Building dependency tree...
 76s Reading state information...
 76s Solving dependencies...
 77s The following NEW packages will be installed:
 77s   python3-all python3-stubserver
 77s 0 upgraded, 2 newly installed, 0 to remove and 0 not upgraded.
 77s Need to get 8696 B of archives.
 77s After this operation, 42.0 kB of additional disk space will be used.
 77s Get:1 http://ftpmaster.internal/ubuntu questing/main ppc64el python3-all ppc64el 3.13.4-1 [880 B]
 77s Get:2 http://ftpmaster.internal/ubuntu questing/universe ppc64el python3-stubserver all 1.1-4 [7816 B]
 77s Fetched 8696 B in 0s (665 kB/s)
 77s Selecting previously unselected package python3-all.
 77s (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 ... 79652 files and directories currently installed.)
 77s Preparing to unpack .../python3-all_3.13.4-1_ppc64el.deb ...
 77s Unpacking python3-all (3.13.4-1) ...
 77s Selecting previously unselected package python3-stubserver.
 77s Preparing to unpack .../python3-stubserver_1.1-4_all.deb ...
 77s Unpacking python3-stubserver (1.1-4) ...
 77s Setting up python3-all (3.13.4-1) ...
 77s Setting up python3-stubserver (1.1-4) ...
 78s autopkgtest [14:46:39]: test run-unit-test: [-----------------------
 78s **************************************************************************
 78s # A new feature in cloud-init identified possible datasources for        #
 78s # this system as:                                                        #
 78s #   []                                                                   #
 78s # However, the datasource used was: OpenStack                            #
 78s #                                                                        #
 78s # In the future, cloud-init will only attempt to use datasources that    #
 78s # are identified or specifically configured.                             #
 78s # For more information see                                               #
 78s #   https://bugs.launchpad.net/bugs/1669675                              #
 78s #                                                                        #
 78s # If you are seeing this message, please file a bug against              #
 78s # cloud-init at                                                          #
 78s #    https://github.com/canonical/cloud-init/issues                      #
 78s # Make sure to include the cloud provider your instance is               #
 78s # running on.                                                            #
 78s #                                                                        #
 78s # After you have filed a bug, you can disable this warning by launching  #
 78s # your instance with the cloud-config below, or putting that content     #
 78s # into /etc/cloud/cloud.cfg.d/99-warnings.cfg                            #
 78s #                                                                        #
 78s # #cloud-config                                                          #
 78s # warnings:                                                              #
 78s #   dsid_missing_source: off                                             #
 78s **************************************************************************
 78s 
 78s Disable the warnings above by:
 78s   touch /home/ubuntu/.cloud-warnings.skip
 78s or
 78s   touch /var/lib/cloud/instance/warnings/.skip
 78s 'test.py' -> '/tmp/autopkgtest.SinW1O/autopkgtest_tmp/test.py'
 78s Running testsuite with python3.13:
 78s /tmp/autopkgtest.SinW1O/autopkgtest_tmp/test.py:42: SyntaxWarning: invalid escape sequence '\d'
 78s   self.server.expect(method="GET", url="/address/\d+$").and_return(mime_type="text/xml", file_content=data_file)
 78s /tmp/autopkgtest.SinW1O/autopkgtest_tmp/test.py:54: SyntaxWarning: invalid escape sequence '\d'
 78s   self.server.expect(method="PUT", url="/address/\d+$", data_capture=capture).and_return(reply_code=201)
 78s /tmp/autopkgtest.SinW1O/autopkgtest_tmp/test.py:92: SyntaxWarning: invalid escape sequence '\d'
 78s   self.server.expect(method="POST", url="address/\d+/inhabitant", data='<inhabitant name="Chris"/>').and_return(reply_code=204)
 78s /tmp/autopkgtest.SinW1O/autopkgtest_tmp/test.py:97: SyntaxWarning: invalid escape sequence '\d'
 78s   self.server.expect(method="POST", url="address/\d+/inhabitant", data='Twas brillig and the slithy toves').and_return(reply_code=204)
 78s /tmp/autopkgtest.SinW1O/autopkgtest_tmp/test.py:126: SyntaxWarning: invalid escape sequence '\d'
 78s   self.server.expect(method="POST", url="address/\d+/inhabitant", data='<inhabitant name="Chris"/>').and_return(
 87s .....................EEEE.
 87s ======================================================================
 87s ERROR: test_returns_additional_headers_for_expectation_with_data (__main__.WebTest.test_returns_additional_headers_for_expectation_with_data)
 87s ----------------------------------------------------------------------
 87s Traceback (most recent call last):
 87s   File "/tmp/autopkgtest.SinW1O/autopkgtest_tmp/test.py", line 185, in test_returns_additional_headers_for_expectation_with_data
 87s     self.assertEqual(r.headers["some_header"], "foo")
 87s                      ~~~~~~~~~^^^^^^^^^^^^^^^
 87s   File "/usr/lib/python3/dist-packages/requests/structures.py", line 52, in __getitem__
 87s     return self._store[key.lower()][1]
 87s            ~~~~~~~~~~~^^^^^^^^^^^^^
 87s KeyError: 'some_header'
 87s 
 87s ======================================================================
 87s ERROR: test_returns_additional_headers_for_expectation_with_data (__main__.WebTest.test_returns_additional_headers_for_expectation_with_data)
 87s ----------------------------------------------------------------------
 87s Traceback (most recent call last):
 87s   File "/tmp/autopkgtest.SinW1O/autopkgtest_tmp/test.py", line 22, in tearDown
 87s     self.server.stop()
 87s     ~~~~~~~~~~~~~~~~^^
 87s   File "/usr/lib/python3/dist-packages/stubserver/webserver.py", line 67, in stop
 87s     self.verify()
 87s     ~~~~~~~~~~~^^
 87s   File "/usr/lib/python3/dist-packages/stubserver/webserver.py", line 87, in verify
 87s     raise Exception("Unsatisfied expectations: " + "\n".join(failures))
 87s Exception: Unsatisfied expectations: POST /api/endpoint 
 87s  data_capture: {}
 87s 
 87s 
 87s ======================================================================
 87s ERROR: test_returns_additional_headers_for_expectation_without_data (__main__.WebTest.test_returns_additional_headers_for_expectation_without_data)
 87s ----------------------------------------------------------------------
 87s Traceback (most recent call last):
 87s   File "/tmp/autopkgtest.SinW1O/autopkgtest_tmp/test.py", line 176, in test_returns_additional_headers_for_expectation_without_data
 87s     self.assertEqual(r.headers["some_header"], "foo")
 87s                      ~~~~~~~~~^^^^^^^^^^^^^^^
 87s   File "/usr/lib/python3/dist-packages/requests/structures.py", line 52, in __getitem__
 87s     return self._store[key.lower()][1]
 87s            ~~~~~~~~~~~^^^^^^^^^^^^^
 87s KeyError: 'some_header'
 87s 
 87s ======================================================================
 87s ERROR: test_returns_additional_headers_for_expectation_without_data (__main__.WebTest.test_returns_additional_headers_for_expectation_without_data)
 87s ----------------------------------------------------------------------
 87s Traceback (most recent call last):
 87s   File "/tmp/autopkgtest.SinW1O/autopkgtest_tmp/test.py", line 22, in tearDown
 87s     self.server.stop()
 87s     ~~~~~~~~~~~~~~~~^^
 87s   File "/usr/lib/python3/dist-packages/stubserver/webserver.py", line 67, in stop
 87s     self.verify()
 87s     ~~~~~~~~~~~^^
 87s   File "/usr/lib/python3/dist-packages/stubserver/webserver.py", line 87, in verify
 87s     raise Exception("Unsatisfied expectations: " + "\n".join(failures))
 87s Exception: Unsatisfied expectations: GET /api/endpoint 
 87s  data_capture: {}
 87s 
 87s 
 87s ----------------------------------------------------------------------
 87s Ran 24 tests in 9.077s
 87s 
 87s FAILED (errors=4)
 87s autopkgtest [14:46:48]: test run-unit-test: -----------------------]
 88s autopkgtest [14:46:49]: test run-unit-test:  - - - - - - - - - - results - - - - - - - - - -
 88s run-unit-test        FAIL non-zero exit status 1
 88s autopkgtest [14:46:49]: @@@@@@@@@@@@@@@@@@@@ summary
 88s run-unit-test        FAIL non-zero exit status 1
 93s nova [W] Using flock in prodstack7-ppc64el
 93s Creating nova instance adt-questing-ppc64el-python-stubserver-20250619-144521-juju-7f2275-prod-proposed-migration-environment-21-5c3f9310-0829-4143-bea1-a147da177fbe from image adt/ubuntu-questing-ppc64el-server-20250619.img (UUID 1c97422d-c646-492e-9581-3c98f213de4b)...
 93s nova [W] Timed out waiting for 5803c11a-c9c1-46db-9da6-9709baff93d4 to get deleted.