0s autopkgtest [22:28:46]: starting date and time: 2025-11-06 22:28:46+0000 0s autopkgtest [22:28:46]: git checkout: 4b346b80 nova: make wait_reboot return success even when a no-op 0s autopkgtest [22:28:46]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.wogdwb3r/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:python-django,src:pyinstaller,src:python-authlib --apt-upgrade django-fsm-2 --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 '--env=ADT_TEST_TRIGGERS=python-django/3:5.2.4-1ubuntu3 pyinstaller/6.16.0+ds-1 python-authlib/1.6.5-1' -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest-cpu2-ram4-disk20-amd64 --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@sto01-4.secgroup --name adt-resolute-amd64-django-fsm-2-20251106-222846-juju-7f2275-prod-proposed-migration-environment-2-46edaa7e-22e4-4415-8e91-72bd21393298 --image adt/ubuntu-resolute-amd64-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-2 --net-id=net_prod-autopkgtest-workers-amd64 -e TERM=linux --mirror=http://ftpmaster.internal/ubuntu/ 3s Creating nova instance adt-resolute-amd64-django-fsm-2-20251106-222846-juju-7f2275-prod-proposed-migration-environment-2-46edaa7e-22e4-4415-8e91-72bd21393298 from image adt/ubuntu-resolute-amd64-server-20251106.img (UUID a168ca91-dcb4-4205-b9d4-b89946e7bb01)... 37s autopkgtest [22:29:23]: testbed dpkg architecture: amd64 37s autopkgtest [22:29:23]: testbed apt version: 3.1.11 38s autopkgtest [22:29:24]: @@@@@@@@@@@@@@@@@@@@ test bed setup 38s autopkgtest [22:29:24]: testbed release detected to be: None 38s autopkgtest [22:29:24]: updating testbed package index (apt update) 39s Get:1 http://ftpmaster.internal/ubuntu resolute-proposed InRelease [87.8 kB] 39s Hit:2 http://ftpmaster.internal/ubuntu resolute InRelease 39s Hit:3 http://ftpmaster.internal/ubuntu resolute-updates InRelease 39s Hit:4 http://ftpmaster.internal/ubuntu resolute-security InRelease 39s Get:5 http://ftpmaster.internal/ubuntu resolute-proposed/universe Sources [1005 kB] 39s Get:6 http://ftpmaster.internal/ubuntu resolute-proposed/restricted Sources [9848 B] 39s Get:7 http://ftpmaster.internal/ubuntu resolute-proposed/main Sources [73.5 kB] 39s Get:8 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse Sources [22.4 kB] 39s Get:9 http://ftpmaster.internal/ubuntu resolute-proposed/main amd64 Packages [122 kB] 39s Get:10 http://ftpmaster.internal/ubuntu resolute-proposed/main i386 Packages [82.7 kB] 39s Get:11 http://ftpmaster.internal/ubuntu resolute-proposed/main amd64 c-n-f Metadata [3272 B] 40s Get:12 http://ftpmaster.internal/ubuntu resolute-proposed/restricted i386 Packages [3744 B] 40s Get:13 http://ftpmaster.internal/ubuntu resolute-proposed/restricted amd64 Packages [64.6 kB] 40s Get:14 http://ftpmaster.internal/ubuntu resolute-proposed/restricted amd64 c-n-f Metadata [336 B] 40s Get:15 http://ftpmaster.internal/ubuntu resolute-proposed/universe amd64 Packages [617 kB] 40s Get:16 http://ftpmaster.internal/ubuntu resolute-proposed/universe i386 Packages [228 kB] 40s Get:17 http://ftpmaster.internal/ubuntu resolute-proposed/universe amd64 c-n-f Metadata [17.8 kB] 40s Get:18 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse i386 Packages [5984 B] 40s Get:19 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse amd64 Packages [12.9 kB] 40s Get:20 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse amd64 c-n-f Metadata [628 B] 40s Fetched 2358 kB in 1s (1743 kB/s) 41s Reading package lists... 41s Hit:1 http://ftpmaster.internal/ubuntu resolute-proposed InRelease 41s Hit:2 http://ftpmaster.internal/ubuntu resolute InRelease 42s Hit:3 http://ftpmaster.internal/ubuntu resolute-updates InRelease 42s Hit:4 http://ftpmaster.internal/ubuntu resolute-security InRelease 42s Reading package lists... 42s Reading package lists... 42s Building dependency tree... 42s Reading state information... 42s Calculating upgrade... 42s The following packages will be upgraded: 42s gir1.2-glib-2.0 libclang-cpp20 libclang1-20 libglib2.0-0t64 libglib2.0-data 42s libllvm20 liburcu8t64 pci.ids pinentry-curses 42s 9 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 42s Need to get 55.1 MB of archives. 42s After this operation, 910 kB disk space will be freed. 42s Get:1 http://ftpmaster.internal/ubuntu resolute/main amd64 gir1.2-glib-2.0 amd64 2.86.1-2 [182 kB] 42s Get:2 http://ftpmaster.internal/ubuntu resolute/main amd64 libglib2.0-0t64 amd64 2.86.1-2 [1607 kB] 43s Get:3 http://ftpmaster.internal/ubuntu resolute/main amd64 libglib2.0-data all 2.86.1-2 [57.1 kB] 43s Get:4 http://ftpmaster.internal/ubuntu resolute/main amd64 liburcu8t64 amd64 0.15.4-1 [64.4 kB] 43s Get:5 http://ftpmaster.internal/ubuntu resolute/main amd64 pci.ids all 0.0~2025.11.04-1 [293 kB] 43s Get:6 http://ftpmaster.internal/ubuntu resolute/main amd64 libclang-cpp20 amd64 1:20.1.8-0ubuntu6 [14.2 MB] 44s Get:7 http://ftpmaster.internal/ubuntu resolute/main amd64 libllvm20 amd64 1:20.1.8-0ubuntu6 [30.4 MB] 45s Get:8 http://ftpmaster.internal/ubuntu resolute/main amd64 libclang1-20 amd64 1:20.1.8-0ubuntu6 [8269 kB] 45s Get:9 http://ftpmaster.internal/ubuntu resolute/main amd64 pinentry-curses amd64 1.3.2-3ubuntu1 [41.1 kB] 45s dpkg-preconfigure: unable to re-open stdin: No such file or directory 45s Fetched 55.1 MB in 3s (20.8 MB/s) 45s (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 ... 83325 files and directories currently installed.) 45s Preparing to unpack .../0-gir1.2-glib-2.0_2.86.1-2_amd64.deb ... 45s Unpacking gir1.2-glib-2.0:amd64 (2.86.1-2) over (2.86.1-1) ... 45s Preparing to unpack .../1-libglib2.0-0t64_2.86.1-2_amd64.deb ... 45s Unpacking libglib2.0-0t64:amd64 (2.86.1-2) over (2.86.1-1) ... 45s Preparing to unpack .../2-libglib2.0-data_2.86.1-2_all.deb ... 45s Unpacking libglib2.0-data (2.86.1-2) over (2.86.1-1) ... 45s Preparing to unpack .../3-liburcu8t64_0.15.4-1_amd64.deb ... 45s Unpacking liburcu8t64:amd64 (0.15.4-1) over (0.15.3-1) ... 45s Preparing to unpack .../4-pci.ids_0.0~2025.11.04-1_all.deb ... 45s Unpacking pci.ids (0.0~2025.11.04-1) over (0.0~2025.07.11-1) ... 46s Preparing to unpack .../5-libclang-cpp20_1%3a20.1.8-0ubuntu6_amd64.deb ... 46s Unpacking libclang-cpp20 (1:20.1.8-0ubuntu6) over (1:20.1.8-0ubuntu4) ... 46s Preparing to unpack .../6-libllvm20_1%3a20.1.8-0ubuntu6_amd64.deb ... 46s Unpacking libllvm20:amd64 (1:20.1.8-0ubuntu6) over (1:20.1.8-0ubuntu4) ... 46s Preparing to unpack .../7-libclang1-20_1%3a20.1.8-0ubuntu6_amd64.deb ... 46s Unpacking libclang1-20 (1:20.1.8-0ubuntu6) over (1:20.1.8-0ubuntu4) ... 46s Preparing to unpack .../8-pinentry-curses_1.3.2-3ubuntu1_amd64.deb ... 46s Unpacking pinentry-curses (1.3.2-3ubuntu1) over (1.3.1-2ubuntu3) ... 46s Setting up pinentry-curses (1.3.2-3ubuntu1) ... 46s Setting up liburcu8t64:amd64 (0.15.4-1) ... 46s Setting up pci.ids (0.0~2025.11.04-1) ... 46s Setting up libglib2.0-0t64:amd64 (2.86.1-2) ... 46s No schema files found: doing nothing. 46s Setting up libglib2.0-data (2.86.1-2) ... 46s Setting up libllvm20:amd64 (1:20.1.8-0ubuntu6) ... 46s Setting up gir1.2-glib-2.0:amd64 (2.86.1-2) ... 46s Setting up libclang1-20 (1:20.1.8-0ubuntu6) ... 46s Setting up libclang-cpp20 (1:20.1.8-0ubuntu6) ... 46s Processing triggers for man-db (2.13.1-1) ... 47s Processing triggers for libc-bin (2.42-0ubuntu3) ... 47s autopkgtest [22:29:33]: upgrading testbed (apt dist-upgrade and autopurge) 47s Reading package lists... 47s Building dependency tree... 47s Reading state information... 47s Calculating upgrade... 47s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 47s Reading package lists... 48s Building dependency tree... 48s Reading state information... 48s Solving dependencies... 48s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 50s autopkgtest [22:29:36]: testbed running kernel: Linux 6.17.0-5-generic #5-Ubuntu SMP PREEMPT_DYNAMIC Mon Sep 22 10:00:33 UTC 2025 50s autopkgtest [22:29:36]: @@@@@@@@@@@@@@@@@@@@ apt-source django-fsm-2 51s Get:1 http://ftpmaster.internal/ubuntu resolute/universe django-fsm-2 4.0.0-3 (dsc) [2261 B] 51s Get:2 http://ftpmaster.internal/ubuntu resolute/universe django-fsm-2 4.0.0-3 (tar) [37.2 kB] 51s Get:3 http://ftpmaster.internal/ubuntu resolute/universe django-fsm-2 4.0.0-3 (diff) [2776 B] 51s gpgv: Signature made Mon Apr 21 15:06:33 2025 UTC 51s gpgv: using RSA key 7BF5F6AC36431F5D40DC137A4CF2B218F54DAE3D 51s gpgv: Can't check signature: No public key 51s dpkg-source: warning: cannot verify inline signature for ./django-fsm-2_4.0.0-3.dsc: no acceptable signature found 51s autopkgtest [22:29:37]: testing package django-fsm-2 version 4.0.0-3 51s autopkgtest [22:29:37]: build not needed 52s autopkgtest [22:29:38]: test run-upstream-testapp: preparing testbed 52s Reading package lists... 52s Building dependency tree... 52s Reading state information... 52s Solving dependencies... 52s The following NEW packages will be installed: 52s python3-asgiref python3-django python3-django-fsm-2 python3-django-guardian 52s python3-sqlparse 52s 0 upgraded, 5 newly installed, 0 to remove and 0 not upgraded. 52s Need to get 3175 kB of archives. 52s After this operation, 27.8 MB of additional disk space will be used. 52s Get:1 http://ftpmaster.internal/ubuntu resolute/main amd64 python3-asgiref all 3.9.1-2 [24.9 kB] 52s Get:2 http://ftpmaster.internal/ubuntu resolute/main amd64 python3-sqlparse all 0.5.3-1 [32.9 kB] 52s Get:3 http://ftpmaster.internal/ubuntu resolute-proposed/main amd64 python3-django all 3:5.2.4-1ubuntu3 [3037 kB] 53s Get:4 http://ftpmaster.internal/ubuntu resolute/universe amd64 python3-django-fsm-2 all 4.0.0-3 [17.1 kB] 53s Get:5 http://ftpmaster.internal/ubuntu resolute/universe amd64 python3-django-guardian all 2.4.0-4 [63.1 kB] 53s Fetched 3175 kB in 1s (3680 kB/s) 53s Selecting previously unselected package python3-asgiref. 53s (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 ... 83325 files and directories currently installed.) 53s Preparing to unpack .../python3-asgiref_3.9.1-2_all.deb ... 53s Unpacking python3-asgiref (3.9.1-2) ... 53s Selecting previously unselected package python3-sqlparse. 53s Preparing to unpack .../python3-sqlparse_0.5.3-1_all.deb ... 53s Unpacking python3-sqlparse (0.5.3-1) ... 53s Selecting previously unselected package python3-django. 53s Preparing to unpack .../python3-django_3%3a5.2.4-1ubuntu3_all.deb ... 53s Unpacking python3-django (3:5.2.4-1ubuntu3) ... 53s Selecting previously unselected package python3-django-fsm-2. 53s Preparing to unpack .../python3-django-fsm-2_4.0.0-3_all.deb ... 53s Unpacking python3-django-fsm-2 (4.0.0-3) ... 53s Selecting previously unselected package python3-django-guardian. 53s Preparing to unpack .../python3-django-guardian_2.4.0-4_all.deb ... 53s Unpacking python3-django-guardian (2.4.0-4) ... 53s Setting up python3-sqlparse (0.5.3-1) ... 53s Setting up python3-asgiref (3.9.1-2) ... 54s Setting up python3-django (3:5.2.4-1ubuntu3) ... 54s Setting up python3-django-fsm-2 (4.0.0-3) ... 54s Setting up python3-django-guardian (2.4.0-4) ... 54s Processing triggers for man-db (2.13.1-1) ... 56s autopkgtest [22:29:42]: test run-upstream-testapp: [----------------------- 56s Creating test database for alias 'default' ('file:memorydb_default?mode=memory&cache=shared')... 56s test_usecase (tests.testapp.tests.test_access_deferred_fsm_field.Test.test_usecase) ... ok 56s test_all_transitions_have_custom_data (tests.testapp.tests.test_custom_data.CustomTransitionDataTest.test_all_transitions_have_custom_data) ... ok 56s test_initial_state (tests.testapp.tests.test_custom_data.CustomTransitionDataTest.test_initial_state) ... ok 56s test_state_changed_after_fail (tests.testapp.tests.test_exception_transitions.FSMFieldExceptionTest.test_state_changed_after_fail) ... ok 56s test_state_not_changed_after_fail (tests.testapp.tests.test_exception_transitions.FSMFieldExceptionTest.test_state_not_changed_after_fail) ... ok 56s test_concurrent_modifications_after_refresh_db_succeed (tests.testapp.tests.test_lock_mixin.TestLockMixin.test_concurrent_modifications_after_refresh_db_succeed) ... ok 56s test_concurrent_modifications_raise_exception (tests.testapp.tests.test_lock_mixin.TestLockMixin.test_concurrent_modifications_raise_exception) ... ok 56s test_create_succeed (tests.testapp.tests.test_lock_mixin.TestLockMixin.test_create_succeed) ... ok 56s test_crud_succeed (tests.testapp.tests.test_lock_mixin.TestLockMixin.test_crud_succeed) ... ok 56s test_inheritance_crud_succeed (tests.testapp.tests.test_lock_mixin.TestLockMixin.test_inheritance_crud_succeed) ... ok 56s test_save_and_change_succeed (tests.testapp.tests.test_lock_mixin.TestLockMixin.test_save_and_change_succeed) ... ok 56s test_usecase (tests.testapp.tests.test_mixin_support.Test.test_usecase) ... ok 56s test_model_objects_create (tests.testapp.tests.test_model_create_with_generic.Test.test_model_objects_create) 56s Check a model with state field can be created ... ok 56s test_get_state_succeed (tests.testapp.tests.test_multi_resultstate.Test.test_get_state_succeed) ... ok 56s test_return_state_succeed (tests.testapp.tests.test_multi_resultstate.Test.test_return_state_succeed) ... ok 56s test_signals_called_with_get_state (tests.testapp.tests.test_multi_resultstate.TestSignals.test_signals_called_with_get_state) ... ok 56s test_signals_called_with_return_value (tests.testapp.tests.test_multi_resultstate.TestSignals.test_signals_called_with_return_value) ... ok 56s test_transition_method_called_once (tests.testapp.tests.test_multidecorators.TestStateProxy.test_transition_method_called_once) ... ok 56s test_object_only_access_success (tests.testapp.tests.test_object_permissions.ObjectPermissionFSMFieldTest.test_object_only_access_success) ... ok 56s test_object_only_other_access_prohibited (tests.testapp.tests.test_object_permissions.ObjectPermissionFSMFieldTest.test_object_only_other_access_prohibited) ... ok 56s test_permission_instance_method (tests.testapp.tests.test_permissions.PermissionFSMFieldTest.test_permission_instance_method) ... ok 56s test_proviledged_access_succed (tests.testapp.tests.test_permissions.PermissionFSMFieldTest.test_proviledged_access_succed) ... ok 56s test_unpriviledged_access_prohibited (tests.testapp.tests.test_permissions.PermissionFSMFieldTest.test_unpriviledged_access_prohibited) ... ok 56s test_initial_proxy_set_succeed (tests.testapp.tests.test_state_transitions.TestStateProxy.test_initial_proxy_set_succeed) ... ok 56s test_load_proxy_set (tests.testapp.tests.test_state_transitions.TestStateProxy.test_load_proxy_set) ... ok 56s test_transition_proxy_set_succeed (tests.testapp.tests.test_state_transitions.TestStateProxy.test_transition_proxy_set_succeed) ... ok 56s test_initial_state (tests.testapp.tests.test_string_field_parameter.StringFieldTestCase.test_initial_state) ... ok 56s test_usecase (tests.testapp.tests.test_transition_all_except_target.Test.test_usecase) ... ok 56s 56s ---------------------------------------------------------------------- 56s Ran 28 tests in 0.030s 56s 56s OK 56s Destroying test database for alias 'default' ('file:memorydb_default?mode=memory&cache=shared')... 56s Found 28 test(s). 56s Operations to perform: 56s Synchronize unmigrated apps: auth, contenttypes, django_fsm, guardian, testapp 56s Apply all migrations: (none) 56s Synchronizing apps without migrations: 56s Creating tables... 56s Creating table django_content_type 56s Creating table auth_permission 56s Creating table auth_group 56s Creating table auth_user 56s Creating table guardian_userobjectpermission 56s Creating table guardian_groupobjectpermission 56s Creating table testapp_application 56s Creating table testapp_fkapplication 56s Creating table testapp_dbstate 56s Creating table testapp_blogpost 56s Creating table testapp_deferrablemodel 56s Creating table testapp_blogpostwithcustomdata 56s Creating table testapp_exceptionalblogpost 56s Creating table testapp_lockedblogpost 56s Creating table testapp_extendedblogpost 56s Creating table testapp_mixinsupporttestmodel 56s Creating table testapp_ticket 56s Creating table testapp_task 56s Creating table testapp_multiresulttest 56s Creating table testapp_testmodel 56s Creating table testapp_objectpermissiontestmodel 56s Creating table testapp_insect 56s Creating table testapp_blogpostwithstringfield 56s Creating table testapp_testexcepttargettransitionshortcut 56s Running deferred SQL... 56s Running migrations: 56s No migrations to apply. 56s System check identified no issues (0 silenced). 56s autopkgtest [22:29:42]: test run-upstream-testapp: -----------------------] 57s autopkgtest [22:29:43]: test run-upstream-testapp: - - - - - - - - - - results - - - - - - - - - - 57s run-upstream-testapp PASS 57s autopkgtest [22:29:43]: @@@@@@@@@@@@@@@@@@@@ summary 57s run-upstream-testapp PASS