0s autopkgtest [18:52:23]: starting date and time: 2025-10-18 18:52:23+0000 0s autopkgtest [18:52:23]: git checkout: 4b346b80 nova: make wait_reboot return success even when a no-op 0s autopkgtest [18:52:23]: host juju-7f2275-prod-proposed-migration-environment-15; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.6p5zvort/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:python3-defaults --apt-upgrade django-fsm-2 --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=python3-defaults/3.13.7-2 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest-cpu2-ram4-disk20-amd64 --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-15@sto01-8.secgroup --name adt-resolute-amd64-django-fsm-2-20251018-185223-juju-7f2275-prod-proposed-migration-environment-15-15e42395-4c3f-42fc-801a-de8a2b606b58 --image adt/ubuntu-resolute-amd64-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-15 --net-id=net_prod-autopkgtest-workers-amd64 -e TERM=linux --mirror=http://ftpmaster.internal/ubuntu/ 4s Creating nova instance adt-resolute-amd64-django-fsm-2-20251018-185223-juju-7f2275-prod-proposed-migration-environment-15-15e42395-4c3f-42fc-801a-de8a2b606b58 from image adt/ubuntu-resolute-amd64-server-20251018.img (UUID dd697a48-b6cc-4a02-84bf-0f9f2fad5f89)... 27s autopkgtest [18:52:50]: testbed dpkg architecture: amd64 27s autopkgtest [18:52:50]: testbed apt version: 3.1.6ubuntu2 27s autopkgtest [18:52:50]: @@@@@@@@@@@@@@@@@@@@ test bed setup 27s autopkgtest [18:52:50]: testbed release detected to be: None 28s autopkgtest [18:52:51]: updating testbed package index (apt update) 28s Get:1 http://ftpmaster.internal/ubuntu resolute-proposed InRelease [83.3 kB] 28s Hit:2 http://ftpmaster.internal/ubuntu resolute InRelease 28s Hit:3 http://ftpmaster.internal/ubuntu resolute-updates InRelease 28s Hit:4 http://ftpmaster.internal/ubuntu resolute-security InRelease 28s Get:5 http://ftpmaster.internal/ubuntu resolute-proposed/restricted Sources [5028 B] 28s Get:6 http://ftpmaster.internal/ubuntu resolute-proposed/main Sources [50.7 kB] 28s Get:7 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse Sources [16.7 kB] 28s Get:8 http://ftpmaster.internal/ubuntu resolute-proposed/universe Sources [456 kB] 29s Get:9 http://ftpmaster.internal/ubuntu resolute-proposed/main i386 Packages [59.9 kB] 29s Get:10 http://ftpmaster.internal/ubuntu resolute-proposed/main amd64 Packages [104 kB] 29s Get:11 http://ftpmaster.internal/ubuntu resolute-proposed/restricted i386 Packages [3208 B] 29s Get:12 http://ftpmaster.internal/ubuntu resolute-proposed/restricted amd64 Packages [28.0 kB] 29s Get:13 http://ftpmaster.internal/ubuntu resolute-proposed/universe i386 Packages [113 kB] 29s Get:14 http://ftpmaster.internal/ubuntu resolute-proposed/universe amd64 Packages [331 kB] 29s Get:15 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse amd64 Packages [9188 B] 29s Get:16 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse i386 Packages [3088 B] 29s Fetched 1262 kB in 1s (1959 kB/s) 29s Reading package lists... 30s Hit:1 http://ftpmaster.internal/ubuntu resolute-proposed InRelease 30s Hit:2 http://ftpmaster.internal/ubuntu resolute InRelease 30s Hit:3 http://ftpmaster.internal/ubuntu resolute-updates InRelease 30s Hit:4 http://ftpmaster.internal/ubuntu resolute-security InRelease 30s Reading package lists... 30s Reading package lists... 31s Building dependency tree... 31s Reading state information... 31s Calculating upgrade... 31s The following packages will be upgraded: 31s apt gir1.2-girepository-2.0 libapt-pkg7.0 libgirepository-1.0-1 31s libpython3-stdlib python3 python3-minimal 31s 7 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 31s Need to get 2751 kB of archives. 31s After this operation, 2048 B of additional disk space will be used. 31s Get:1 http://ftpmaster.internal/ubuntu resolute-proposed/main amd64 python3-minimal amd64 3.13.7-2 [27.8 kB] 31s Get:2 http://ftpmaster.internal/ubuntu resolute-proposed/main amd64 python3 amd64 3.13.7-2 [23.9 kB] 31s Get:3 http://ftpmaster.internal/ubuntu resolute-proposed/main amd64 libpython3-stdlib amd64 3.13.7-2 [10.6 kB] 31s Get:4 http://ftpmaster.internal/ubuntu resolute/main amd64 libapt-pkg7.0 amd64 3.1.8ubuntu1 [1140 kB] 31s Get:5 http://ftpmaster.internal/ubuntu resolute/main amd64 apt amd64 3.1.8ubuntu1 [1438 kB] 31s Get:6 http://ftpmaster.internal/ubuntu resolute/main amd64 libgirepository-1.0-1 amd64 1.86.0-6 [85.9 kB] 31s Get:7 http://ftpmaster.internal/ubuntu resolute/main amd64 gir1.2-girepository-2.0 amd64 1.86.0-6 [25.3 kB] 31s dpkg-preconfigure: unable to re-open stdin: No such file or directory 31s Fetched 2751 kB in 0s (6248 kB/s) 31s (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 ... 78439 files and directories currently installed.) 31s Preparing to unpack .../python3-minimal_3.13.7-2_amd64.deb ... 31s Unpacking python3-minimal (3.13.7-2) over (3.13.7-1) ... 31s Setting up python3-minimal (3.13.7-2) ... 32s (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 ... 78439 files and directories currently installed.) 32s Preparing to unpack .../0-python3_3.13.7-2_amd64.deb ... 32s running python pre-rtupdate hooks for python3.13... 32s Unpacking python3 (3.13.7-2) over (3.13.7-1) ... 32s Preparing to unpack .../1-libpython3-stdlib_3.13.7-2_amd64.deb ... 32s Unpacking libpython3-stdlib:amd64 (3.13.7-2) over (3.13.7-1) ... 32s Preparing to unpack .../2-libapt-pkg7.0_3.1.8ubuntu1_amd64.deb ... 32s Unpacking libapt-pkg7.0:amd64 (3.1.8ubuntu1) over (3.1.6ubuntu2) ... 32s Preparing to unpack .../3-apt_3.1.8ubuntu1_amd64.deb ... 32s Unpacking apt (3.1.8ubuntu1) over (3.1.6ubuntu2) ... 32s Preparing to unpack .../4-libgirepository-1.0-1_1.86.0-6_amd64.deb ... 32s Unpacking libgirepository-1.0-1:amd64 (1.86.0-6) over (1.84.0-1) ... 32s Preparing to unpack .../5-gir1.2-girepository-2.0_1.86.0-6_amd64.deb ... 32s Unpacking gir1.2-girepository-2.0:amd64 (1.86.0-6) over (1.84.0-1) ... 32s Setting up libgirepository-1.0-1:amd64 (1.86.0-6) ... 32s Setting up libapt-pkg7.0:amd64 (3.1.8ubuntu1) ... 32s Setting up libpython3-stdlib:amd64 (3.13.7-2) ... 32s Setting up apt (3.1.8ubuntu1) ... 32s Setting up python3 (3.13.7-2) ... 32s running python rtupdate hooks for python3.13... 32s running python post-rtupdate hooks for python3.13... 32s Setting up gir1.2-girepository-2.0:amd64 (1.86.0-6) ... 32s Processing triggers for man-db (2.13.1-1) ... 33s Processing triggers for libc-bin (2.42-0ubuntu3) ... 33s autopkgtest [18:52:56]: upgrading testbed (apt dist-upgrade and autopurge) 34s Reading package lists... 34s Building dependency tree... 34s Reading state information... 34s Calculating upgrade... 34s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 34s Reading package lists... 35s Building dependency tree... 35s Reading state information... 35s Solving dependencies... 35s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 35s autopkgtest [18:52:58]: rebooting testbed after setup commands that affected boot 49s autopkgtest [18:53:12]: testbed running kernel: Linux 6.17.0-5-generic #5-Ubuntu SMP PREEMPT_DYNAMIC Mon Sep 22 10:00:33 UTC 2025 51s autopkgtest [18:53:14]: @@@@@@@@@@@@@@@@@@@@ apt-source django-fsm-2 52s Get:1 http://ftpmaster.internal/ubuntu resolute/universe django-fsm-2 4.0.0-3 (dsc) [2261 B] 52s Get:2 http://ftpmaster.internal/ubuntu resolute/universe django-fsm-2 4.0.0-3 (tar) [37.2 kB] 52s Get:3 http://ftpmaster.internal/ubuntu resolute/universe django-fsm-2 4.0.0-3 (diff) [2776 B] 52s gpgv: Signature made Mon Apr 21 15:06:33 2025 UTC 52s gpgv: using RSA key 7BF5F6AC36431F5D40DC137A4CF2B218F54DAE3D 52s gpgv: Can't check signature: No public key 52s dpkg-source: warning: cannot verify inline signature for ./django-fsm-2_4.0.0-3.dsc: no acceptable signature found 52s autopkgtest [18:53:15]: testing package django-fsm-2 version 4.0.0-3 53s autopkgtest [18:53:16]: build not needed 53s autopkgtest [18:53:16]: test run-upstream-testapp: preparing testbed 53s Reading package lists... 53s Building dependency tree... 53s Reading state information... 53s Solving dependencies... 53s The following NEW packages will be installed: 53s python3-asgiref python3-django python3-django-fsm-2 python3-django-guardian 53s python3-sqlparse 53s 0 upgraded, 5 newly installed, 0 to remove and 0 not upgraded. 53s Need to get 3174 kB of archives. 53s After this operation, 27.8 MB of additional disk space will be used. 53s Get:1 http://ftpmaster.internal/ubuntu resolute/main amd64 python3-asgiref all 3.8.1-1 [24.8 kB] 53s Get:2 http://ftpmaster.internal/ubuntu resolute/main amd64 python3-sqlparse all 0.5.3-1 [32.9 kB] 53s Get:3 http://ftpmaster.internal/ubuntu resolute/main amd64 python3-django all 3:5.2.4-1ubuntu2 [3036 kB] 54s Get:4 http://ftpmaster.internal/ubuntu resolute/universe amd64 python3-django-fsm-2 all 4.0.0-3 [17.1 kB] 54s Get:5 http://ftpmaster.internal/ubuntu resolute/universe amd64 python3-django-guardian all 2.4.0-4 [63.1 kB] 54s Fetched 3174 kB in 0s (9503 kB/s) 54s Selecting previously unselected package python3-asgiref. 54s (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 ... 78439 files and directories currently installed.) 54s Preparing to unpack .../python3-asgiref_3.8.1-1_all.deb ... 54s Unpacking python3-asgiref (3.8.1-1) ... 54s Selecting previously unselected package python3-sqlparse. 54s Preparing to unpack .../python3-sqlparse_0.5.3-1_all.deb ... 54s Unpacking python3-sqlparse (0.5.3-1) ... 54s Selecting previously unselected package python3-django. 54s Preparing to unpack .../python3-django_3%3a5.2.4-1ubuntu2_all.deb ... 54s Unpacking python3-django (3:5.2.4-1ubuntu2) ... 54s Selecting previously unselected package python3-django-fsm-2. 54s Preparing to unpack .../python3-django-fsm-2_4.0.0-3_all.deb ... 54s Unpacking python3-django-fsm-2 (4.0.0-3) ... 54s Selecting previously unselected package python3-django-guardian. 54s Preparing to unpack .../python3-django-guardian_2.4.0-4_all.deb ... 54s Unpacking python3-django-guardian (2.4.0-4) ... 54s Setting up python3-sqlparse (0.5.3-1) ... 54s Setting up python3-asgiref (3.8.1-1) ... 54s Setting up python3-django (3:5.2.4-1ubuntu2) ... 55s Setting up python3-django-fsm-2 (4.0.0-3) ... 55s Setting up python3-django-guardian (2.4.0-4) ... 55s Processing triggers for man-db (2.13.1-1) ... 56s autopkgtest [18:53:19]: test run-upstream-testapp: [----------------------- 57s Creating test database for alias 'default' ('file:memorydb_default?mode=memory&cache=shared')... 57s test_usecase (tests.testapp.tests.test_access_deferred_fsm_field.Test.test_usecase) ... ok 57s test_all_transitions_have_custom_data (tests.testapp.tests.test_custom_data.CustomTransitionDataTest.test_all_transitions_have_custom_data) ... ok 57s test_initial_state (tests.testapp.tests.test_custom_data.CustomTransitionDataTest.test_initial_state) ... ok 57s test_state_changed_after_fail (tests.testapp.tests.test_exception_transitions.FSMFieldExceptionTest.test_state_changed_after_fail) ... ok 57s test_state_not_changed_after_fail (tests.testapp.tests.test_exception_transitions.FSMFieldExceptionTest.test_state_not_changed_after_fail) ... ok 57s test_concurrent_modifications_after_refresh_db_succeed (tests.testapp.tests.test_lock_mixin.TestLockMixin.test_concurrent_modifications_after_refresh_db_succeed) ... ok 57s test_concurrent_modifications_raise_exception (tests.testapp.tests.test_lock_mixin.TestLockMixin.test_concurrent_modifications_raise_exception) ... ok 57s test_create_succeed (tests.testapp.tests.test_lock_mixin.TestLockMixin.test_create_succeed) ... ok 57s test_crud_succeed (tests.testapp.tests.test_lock_mixin.TestLockMixin.test_crud_succeed) ... ok 57s test_inheritance_crud_succeed (tests.testapp.tests.test_lock_mixin.TestLockMixin.test_inheritance_crud_succeed) ... ok 57s test_save_and_change_succeed (tests.testapp.tests.test_lock_mixin.TestLockMixin.test_save_and_change_succeed) ... ok 57s test_usecase (tests.testapp.tests.test_mixin_support.Test.test_usecase) ... ok 57s test_model_objects_create (tests.testapp.tests.test_model_create_with_generic.Test.test_model_objects_create) 57s Check a model with state field can be created ... ok 57s test_get_state_succeed (tests.testapp.tests.test_multi_resultstate.Test.test_get_state_succeed) ... ok 57s test_return_state_succeed (tests.testapp.tests.test_multi_resultstate.Test.test_return_state_succeed) ... ok 57s test_signals_called_with_get_state (tests.testapp.tests.test_multi_resultstate.TestSignals.test_signals_called_with_get_state) ... ok 57s test_signals_called_with_return_value (tests.testapp.tests.test_multi_resultstate.TestSignals.test_signals_called_with_return_value) ... ok 57s test_transition_method_called_once (tests.testapp.tests.test_multidecorators.TestStateProxy.test_transition_method_called_once) ... ok 57s test_object_only_access_success (tests.testapp.tests.test_object_permissions.ObjectPermissionFSMFieldTest.test_object_only_access_success) ... ok 57s test_object_only_other_access_prohibited (tests.testapp.tests.test_object_permissions.ObjectPermissionFSMFieldTest.test_object_only_other_access_prohibited) ... ok 57s test_permission_instance_method (tests.testapp.tests.test_permissions.PermissionFSMFieldTest.test_permission_instance_method) ... ok 57s test_proviledged_access_succed (tests.testapp.tests.test_permissions.PermissionFSMFieldTest.test_proviledged_access_succed) ... ok 57s test_unpriviledged_access_prohibited (tests.testapp.tests.test_permissions.PermissionFSMFieldTest.test_unpriviledged_access_prohibited) ... ok 57s test_initial_proxy_set_succeed (tests.testapp.tests.test_state_transitions.TestStateProxy.test_initial_proxy_set_succeed) ... ok 57s test_load_proxy_set (tests.testapp.tests.test_state_transitions.TestStateProxy.test_load_proxy_set) ... ok 57s test_transition_proxy_set_succeed (tests.testapp.tests.test_state_transitions.TestStateProxy.test_transition_proxy_set_succeed) ... ok 57s test_initial_state (tests.testapp.tests.test_string_field_parameter.StringFieldTestCase.test_initial_state) ... ok 57s Found 28 test(s). 57s Operations to perform: 57s Synchronize unmigrated apps: auth, contenttypes, django_fsm, guardian, testapp 57s Apply all migrations: (none) 57s Synchronizing apps without migrations: 57s Creating tables... 57s Creating table django_content_type 57s Creating table auth_permission 57s Creating table auth_group 57s Creating table auth_user 57s Creating table guardian_userobjectpermission 57s Creating table guardian_groupobjectpermission 57s Creating table testapp_application 57s Creating table testapp_fkapplication 57s Creating table testapp_dbstate 57s Creating table testapp_blogpost 57s Creating table testapp_deferrablemodel 57s Creating table testapp_blogpostwithcustomdata 57s Creating table testapp_exceptionalblogpost 57s Creating table testapp_lockedblogpost 57s Creating table testapp_extendedblogpost 57s Creating table testapp_mixinsupporttestmodel 57s Creating table testapp_ticket 57s Creating table testapp_task 57s Creating table testapp_multiresulttest 57s Creating table testapp_testmodel 57s Creating table testapp_objectpermissiontestmodel 57s Creating table testapp_insect 57s Creating table testapp_blogpostwithstringfield 57s Creating table testapp_testexcepttargettransitionshortcut 57s Running deferred SQL... 57s Running migrations: 57s No migrations to apply. 57s System check identified no issues (0 silenced). 57s test_usecase (tests.testapp.tests.test_transition_all_except_target.Test.test_usecase) ... ok 57s 57s ---------------------------------------------------------------------- 57s Ran 28 tests in 0.031s 57s 57s OK 57s Destroying test database for alias 'default' ('file:memorydb_default?mode=memory&cache=shared')... 57s autopkgtest [18:53:20]: test run-upstream-testapp: -----------------------] 57s autopkgtest [18:53:20]: test run-upstream-testapp: - - - - - - - - - - results - - - - - - - - - - 57s run-upstream-testapp PASS 58s autopkgtest [18:53:21]: @@@@@@@@@@@@@@@@@@@@ summary 58s run-upstream-testapp PASS