0s autopkgtest [16:31:17]: starting date and time: 2025-10-18 16:31:17+0000 0s autopkgtest [16:31:17]: git checkout: 4b346b80 nova: make wait_reboot return success even when a no-op 0s autopkgtest [16:31:17]: host juju-7f2275-prod-proposed-migration-environment-20; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.0dhlhgez/out --timeout-copy=6000 -a i386 --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-20@sto01-3.secgroup --name adt-resolute-i386-django-fsm-2-20251018-163117-juju-7f2275-prod-proposed-migration-environment-20-0dee84a3-1cc4-4c2e-86ba-16003cecc6ab --image adt/ubuntu-resolute-amd64-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-20 --net-id=net_prod-autopkgtest-workers-amd64 -e TERM=linux --mirror=http://ftpmaster.internal/ubuntu/ 3s Creating nova instance adt-resolute-i386-django-fsm-2-20251018-163117-juju-7f2275-prod-proposed-migration-environment-20-0dee84a3-1cc4-4c2e-86ba-16003cecc6ab from image adt/ubuntu-resolute-amd64-server-20251018.img (UUID dd697a48-b6cc-4a02-84bf-0f9f2fad5f89)... 27s autopkgtest [16:31:44]: testbed dpkg architecture: amd64 27s autopkgtest [16:31:44]: testbed apt version: 3.1.6ubuntu2 27s autopkgtest [16:31:44]: @@@@@@@@@@@@@@@@@@@@ test bed setup 27s autopkgtest [16:31:44]: testbed release detected to be: None 28s autopkgtest [16:31:45]: 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/multiverse Sources [15.4 kB] 28s Get:7 http://ftpmaster.internal/ubuntu resolute-proposed/main Sources [28.4 kB] 28s Get:8 http://ftpmaster.internal/ubuntu resolute-proposed/universe Sources [345 kB] 29s Get:9 http://ftpmaster.internal/ubuntu resolute-proposed/main i386 Packages [46.6 kB] 29s Get:10 http://ftpmaster.internal/ubuntu resolute-proposed/main amd64 Packages [85.2 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 amd64 Packages [233 kB] 29s Get:14 http://ftpmaster.internal/ubuntu resolute-proposed/universe i386 Packages [87.6 kB] 29s Get:15 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse i386 Packages [2772 B] 29s Get:16 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse amd64 Packages [8376 B] 29s Fetched 972 kB in 1s (1486 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... 30s Building dependency tree... 30s 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] 32s Get:6 http://ftpmaster.internal/ubuntu resolute/main amd64 libgirepository-1.0-1 amd64 1.86.0-6 [85.9 kB] 32s Get:7 http://ftpmaster.internal/ubuntu resolute/main amd64 gir1.2-girepository-2.0 amd64 1.86.0-6 [25.3 kB] 32s dpkg-preconfigure: unable to re-open stdin: No such file or directory 32s Fetched 2751 kB in 1s (3086 kB/s) 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 .../python3-minimal_3.13.7-2_amd64.deb ... 32s Unpacking python3-minimal (3.13.7-2) over (3.13.7-1) ... 32s 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) ... 33s Setting up python3 (3.13.7-2) ... 33s running python rtupdate hooks for python3.13... 33s running python post-rtupdate hooks for python3.13... 33s Setting up gir1.2-girepository-2.0:amd64 (1.86.0-6) ... 33s Processing triggers for man-db (2.13.1-1) ... 34s Processing triggers for libc-bin (2.42-0ubuntu3) ... 34s autopkgtest [16:31:51]: upgrading testbed (apt dist-upgrade and autopurge) 34s Reading package lists... 34s Building dependency tree... 34s Reading state information... 35s Calculating upgrade... 35s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 35s 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 [16:31:52]: rebooting testbed after setup commands that affected boot 49s autopkgtest [16:32:06]: testbed running kernel: Linux 6.17.0-5-generic #5-Ubuntu SMP PREEMPT_DYNAMIC Mon Sep 22 10:00:33 UTC 2025 51s autopkgtest [16:32:08]: @@@@@@@@@@@@@@@@@@@@ apt-source django-fsm-2 53s Get:1 http://ftpmaster.internal/ubuntu resolute/universe django-fsm-2 4.0.0-3 (dsc) [2261 B] 53s Get:2 http://ftpmaster.internal/ubuntu resolute/universe django-fsm-2 4.0.0-3 (tar) [37.2 kB] 53s Get:3 http://ftpmaster.internal/ubuntu resolute/universe django-fsm-2 4.0.0-3 (diff) [2776 B] 53s gpgv: Signature made Mon Apr 21 15:06:33 2025 UTC 53s gpgv: using RSA key 7BF5F6AC36431F5D40DC137A4CF2B218F54DAE3D 53s gpgv: Can't check signature: No public key 53s dpkg-source: warning: cannot verify inline signature for ./django-fsm-2_4.0.0-3.dsc: no acceptable signature found 53s autopkgtest [16:32:10]: testing package django-fsm-2 version 4.0.0-3 53s autopkgtest [16:32:10]: build not needed 53s autopkgtest [16:32:10]: test run-upstream-testapp: preparing testbed 53s Reading package lists... 53s Building dependency tree... 53s Reading state information... 53s Solving dependencies... 54s The following NEW packages will be installed: 54s python3-asgiref python3-django python3-django-fsm-2 python3-django-guardian 54s python3-sqlparse 54s 0 upgraded, 5 newly installed, 0 to remove and 0 not upgraded. 54s Need to get 3174 kB of archives. 54s After this operation, 27.8 MB of additional disk space will be used. 54s Get:1 http://ftpmaster.internal/ubuntu resolute/main amd64 python3-asgiref all 3.8.1-1 [24.8 kB] 54s Get:2 http://ftpmaster.internal/ubuntu resolute/main amd64 python3-sqlparse all 0.5.3-1 [32.9 kB] 54s 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] 55s Get:5 http://ftpmaster.internal/ubuntu resolute/universe amd64 python3-django-guardian all 2.4.0-4 [63.1 kB] 55s Fetched 3174 kB in 1s (3377 kB/s) 55s Selecting previously unselected package python3-asgiref. 55s (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.) 55s Preparing to unpack .../python3-asgiref_3.8.1-1_all.deb ... 55s Unpacking python3-asgiref (3.8.1-1) ... 55s Selecting previously unselected package python3-sqlparse. 55s Preparing to unpack .../python3-sqlparse_0.5.3-1_all.deb ... 55s Unpacking python3-sqlparse (0.5.3-1) ... 55s Selecting previously unselected package python3-django. 55s Preparing to unpack .../python3-django_3%3a5.2.4-1ubuntu2_all.deb ... 55s Unpacking python3-django (3:5.2.4-1ubuntu2) ... 55s Selecting previously unselected package python3-django-fsm-2. 55s Preparing to unpack .../python3-django-fsm-2_4.0.0-3_all.deb ... 55s Unpacking python3-django-fsm-2 (4.0.0-3) ... 55s Selecting previously unselected package python3-django-guardian. 55s Preparing to unpack .../python3-django-guardian_2.4.0-4_all.deb ... 55s Unpacking python3-django-guardian (2.4.0-4) ... 55s Setting up python3-sqlparse (0.5.3-1) ... 55s Setting up python3-asgiref (3.8.1-1) ... 55s Setting up python3-django (3:5.2.4-1ubuntu2) ... 56s Setting up python3-django-fsm-2 (4.0.0-3) ... 56s Setting up python3-django-guardian (2.4.0-4) ... 56s Processing triggers for man-db (2.13.1-1) ... 57s autopkgtest [16:32:14]: test environment configured for cross building 57s autopkgtest [16:32:14]: test run-upstream-testapp: [----------------------- 58s Creating test database for alias 'default' ('file:memorydb_default?mode=memory&cache=shared')... 58s test_usecase (tests.testapp.tests.test_access_deferred_fsm_field.Test.test_usecase) ... ok 58s test_all_transitions_have_custom_data (tests.testapp.tests.test_custom_data.CustomTransitionDataTest.test_all_transitions_have_custom_data) ... ok 58s test_initial_state (tests.testapp.tests.test_custom_data.CustomTransitionDataTest.test_initial_state) ... ok 58s test_state_changed_after_fail (tests.testapp.tests.test_exception_transitions.FSMFieldExceptionTest.test_state_changed_after_fail) ... ok 58s test_state_not_changed_after_fail (tests.testapp.tests.test_exception_transitions.FSMFieldExceptionTest.test_state_not_changed_after_fail) ... ok 58s test_concurrent_modifications_after_refresh_db_succeed (tests.testapp.tests.test_lock_mixin.TestLockMixin.test_concurrent_modifications_after_refresh_db_succeed) ... ok 58s test_concurrent_modifications_raise_exception (tests.testapp.tests.test_lock_mixin.TestLockMixin.test_concurrent_modifications_raise_exception) ... ok 58s test_create_succeed (tests.testapp.tests.test_lock_mixin.TestLockMixin.test_create_succeed) ... ok 58s test_crud_succeed (tests.testapp.tests.test_lock_mixin.TestLockMixin.test_crud_succeed) ... ok 58s test_inheritance_crud_succeed (tests.testapp.tests.test_lock_mixin.TestLockMixin.test_inheritance_crud_succeed) ... ok 58s test_save_and_change_succeed (tests.testapp.tests.test_lock_mixin.TestLockMixin.test_save_and_change_succeed) ... ok 58s test_usecase (tests.testapp.tests.test_mixin_support.Test.test_usecase) ... ok 58s test_model_objects_create (tests.testapp.tests.test_model_create_with_generic.Test.test_model_objects_create) 58s Check a model with state field can be created ... ok 58s test_get_state_succeed (tests.testapp.tests.test_multi_resultstate.Test.test_get_state_succeed) ... ok 58s test_return_state_succeed (tests.testapp.tests.test_multi_resultstate.Test.test_return_state_succeed) ... ok 58s test_signals_called_with_get_state (tests.testapp.tests.test_multi_resultstate.TestSignals.test_signals_called_with_get_state) ... ok 58s test_signals_called_with_return_value (tests.testapp.tests.test_multi_resultstate.TestSignals.test_signals_called_with_return_value) ... ok 58s test_transition_method_called_once (tests.testapp.tests.test_multidecorators.TestStateProxy.test_transition_method_called_once) ... ok 58s test_object_only_access_success (tests.testapp.tests.test_object_permissions.ObjectPermissionFSMFieldTest.test_object_only_access_success) ... ok 58s test_object_only_other_access_prohibited (tests.testapp.tests.test_object_permissions.ObjectPermissionFSMFieldTest.test_object_only_other_access_prohibited) ... ok 58s test_permission_instance_method (tests.testapp.tests.test_permissions.PermissionFSMFieldTest.test_permission_instance_method) ... ok 58s test_proviledged_access_succed (tests.testapp.tests.test_permissions.PermissionFSMFieldTest.test_proviledged_access_succed) ... ok 58s test_unpriviledged_access_prohibited (tests.testapp.tests.test_permissions.PermissionFSMFieldTest.test_unpriviledged_access_prohibited) ... ok 58s test_initial_proxy_set_succeed (tests.testapp.tests.test_state_transitions.TestStateProxy.test_initial_proxy_set_succeed) ... ok 58s test_load_proxy_set (tests.testapp.tests.test_state_transitions.TestStateProxy.test_load_proxy_set) ... ok 58s test_transition_proxy_set_succeed (tests.testapp.tests.test_state_transitions.TestStateProxy.test_transition_proxy_set_succeed) ... ok 58s test_initial_state (tests.testapp.tests.test_string_field_parameter.StringFieldTestCase.test_initial_state) ... ok 58s test_usecase (tests.testapp.tests.test_transition_all_except_target.Test.test_usecase) ... ok 58s 58s ---------------------------------------------------------------------- 58s Ran 28 tests in 0.031s 58s 58s OK 58s Destroying test database for alias 'default' ('file:memorydb_default?mode=memory&cache=shared')... 58s Found 28 test(s). 58s Operations to perform: 58s Synchronize unmigrated apps: auth, contenttypes, django_fsm, guardian, testapp 58s Apply all migrations: (none) 58s Synchronizing apps without migrations: 58s Creating tables... 58s Creating table django_content_type 58s Creating table auth_permission 58s Creating table auth_group 58s Creating table auth_user 58s Creating table guardian_userobjectpermission 58s Creating table guardian_groupobjectpermission 58s Creating table testapp_application 58s Creating table testapp_fkapplication 58s Creating table testapp_dbstate 58s Creating table testapp_blogpost 58s Creating table testapp_deferrablemodel 58s Creating table testapp_blogpostwithcustomdata 58s Creating table testapp_exceptionalblogpost 58s Creating table testapp_lockedblogpost 58s Creating table testapp_extendedblogpost 58s Creating table testapp_mixinsupporttestmodel 58s Creating table testapp_ticket 58s Creating table testapp_task 58s Creating table testapp_multiresulttest 58s Creating table testapp_testmodel 58s Creating table testapp_objectpermissiontestmodel 58s Creating table testapp_insect 58s Creating table testapp_blogpostwithstringfield 58s Creating table testapp_testexcepttargettransitionshortcut 58s Running deferred SQL... 58s Running migrations: 58s No migrations to apply. 58s System check identified no issues (0 silenced). 58s autopkgtest [16:32:15]: test run-upstream-testapp: -----------------------] 58s run-upstream-testapp PASS 58s autopkgtest [16:32:15]: test run-upstream-testapp: - - - - - - - - - - results - - - - - - - - - - 59s autopkgtest [16:32:16]: @@@@@@@@@@@@@@@@@@@@ summary 59s run-upstream-testapp PASS