0s autopkgtest [17:39:07]: starting date and time: 2025-10-18 17:39:07+0000 0s autopkgtest [17:39:07]: git checkout: 4b346b80 nova: make wait_reboot return success even when a no-op 0s autopkgtest [17:39:07]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.papgfm6r/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-s390x --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@bos03-s390x-10.secgroup --name adt-resolute-s390x-django-fsm-2-20251018-173906-juju-7f2275-prod-proposed-migration-environment-2-facdb571-f113-4b84-b251-e239e44f5ae5 --image adt/ubuntu-resolute-s390x-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-2 --net-id=net_prod-proposed-migration-s390x -e TERM=linux --mirror=http://ftpmaster.internal/ubuntu/ 4s Creating nova instance adt-resolute-s390x-django-fsm-2-20251018-173906-juju-7f2275-prod-proposed-migration-environment-2-facdb571-f113-4b84-b251-e239e44f5ae5 from image adt/ubuntu-resolute-s390x-server-20251018.img (UUID c47ab411-f9be-46ce-b861-20d934d06dba)... 50s autopkgtest [17:39:57]: testbed dpkg architecture: s390x 50s autopkgtest [17:39:57]: testbed apt version: 3.1.6ubuntu2 50s autopkgtest [17:39:57]: @@@@@@@@@@@@@@@@@@@@ test bed setup 51s autopkgtest [17:39:58]: testbed release detected to be: None 51s autopkgtest [17:39:58]: updating testbed package index (apt update) 52s Get:1 http://ftpmaster.internal/ubuntu resolute-proposed InRelease [83.3 kB] 52s Hit:2 http://ftpmaster.internal/ubuntu resolute InRelease 52s Hit:3 http://ftpmaster.internal/ubuntu resolute-updates InRelease 52s Hit:4 http://ftpmaster.internal/ubuntu resolute-security InRelease 52s Get:5 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse Sources [15.4 kB] 52s Get:6 http://ftpmaster.internal/ubuntu resolute-proposed/restricted Sources [5028 B] 52s Get:7 http://ftpmaster.internal/ubuntu resolute-proposed/main Sources [28.4 kB] 52s Get:8 http://ftpmaster.internal/ubuntu resolute-proposed/universe Sources [345 kB] 52s Get:9 http://ftpmaster.internal/ubuntu resolute-proposed/main s390x Packages [74.0 kB] 52s Get:10 http://ftpmaster.internal/ubuntu resolute-proposed/restricted s390x Packages [940 B] 52s Get:11 http://ftpmaster.internal/ubuntu resolute-proposed/universe s390x Packages [226 kB] 52s Get:12 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse s390x Packages [3812 B] 52s Fetched 781 kB in 1s (752 kB/s) 53s Reading package lists... 54s Hit:1 http://ftpmaster.internal/ubuntu resolute-proposed InRelease 54s Hit:2 http://ftpmaster.internal/ubuntu resolute InRelease 54s Hit:3 http://ftpmaster.internal/ubuntu resolute-updates InRelease 54s Hit:4 http://ftpmaster.internal/ubuntu resolute-security InRelease 55s Reading package lists... 55s Reading package lists... 55s Building dependency tree... 55s Reading state information... 55s Calculating upgrade... 55s The following packages will be upgraded: 55s apt gir1.2-girepository-2.0 libapt-pkg7.0 libgirepository-1.0-1 55s libpython3-stdlib lto-disabled-list python3 python3-minimal 55s 8 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 55s Need to get 2763 kB of archives. 55s After this operation, 14.3 kB of additional disk space will be used. 55s Get:1 http://ftpmaster.internal/ubuntu resolute-proposed/main s390x python3-minimal s390x 3.13.7-2 [27.8 kB] 55s Get:2 http://ftpmaster.internal/ubuntu resolute-proposed/main s390x python3 s390x 3.13.7-2 [23.9 kB] 55s Get:3 http://ftpmaster.internal/ubuntu resolute-proposed/main s390x libpython3-stdlib s390x 3.13.7-2 [10.6 kB] 55s Get:4 http://ftpmaster.internal/ubuntu resolute/main s390x libapt-pkg7.0 s390x 3.1.8ubuntu1 [1144 kB] 56s Get:5 http://ftpmaster.internal/ubuntu resolute/main s390x apt s390x 3.1.8ubuntu1 [1432 kB] 56s Get:6 http://ftpmaster.internal/ubuntu resolute/main s390x libgirepository-1.0-1 s390x 1.86.0-6 [86.9 kB] 56s Get:7 http://ftpmaster.internal/ubuntu resolute/main s390x gir1.2-girepository-2.0 s390x 1.86.0-6 [25.1 kB] 56s Get:8 http://ftpmaster.internal/ubuntu resolute/main s390x lto-disabled-list all 71 [12.5 kB] 56s dpkg-preconfigure: unable to re-open stdin: No such file or directory 56s Fetched 2763 kB in 1s (2477 kB/s) 57s (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 ... 56852 files and directories currently installed.) 57s Preparing to unpack .../python3-minimal_3.13.7-2_s390x.deb ... 57s Unpacking python3-minimal (3.13.7-2) over (3.13.7-1) ... 57s Setting up python3-minimal (3.13.7-2) ... 57s (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 ... 56852 files and directories currently installed.) 57s Preparing to unpack .../0-python3_3.13.7-2_s390x.deb ... 57s running python pre-rtupdate hooks for python3.13... 57s Unpacking python3 (3.13.7-2) over (3.13.7-1) ... 57s Preparing to unpack .../1-libpython3-stdlib_3.13.7-2_s390x.deb ... 57s Unpacking libpython3-stdlib:s390x (3.13.7-2) over (3.13.7-1) ... 57s Preparing to unpack .../2-libapt-pkg7.0_3.1.8ubuntu1_s390x.deb ... 57s Unpacking libapt-pkg7.0:s390x (3.1.8ubuntu1) over (3.1.6ubuntu2) ... 57s Preparing to unpack .../3-apt_3.1.8ubuntu1_s390x.deb ... 57s Unpacking apt (3.1.8ubuntu1) over (3.1.6ubuntu2) ... 57s Preparing to unpack .../4-libgirepository-1.0-1_1.86.0-6_s390x.deb ... 57s Unpacking libgirepository-1.0-1:s390x (1.86.0-6) over (1.84.0-1) ... 57s Preparing to unpack .../5-gir1.2-girepository-2.0_1.86.0-6_s390x.deb ... 57s Unpacking gir1.2-girepository-2.0:s390x (1.86.0-6) over (1.84.0-1) ... 57s Preparing to unpack .../6-lto-disabled-list_71_all.deb ... 57s Unpacking lto-disabled-list (71) over (69) ... 57s Setting up lto-disabled-list (71) ... 57s Setting up libgirepository-1.0-1:s390x (1.86.0-6) ... 57s Setting up libapt-pkg7.0:s390x (3.1.8ubuntu1) ... 57s Setting up libpython3-stdlib:s390x (3.13.7-2) ... 57s Setting up apt (3.1.8ubuntu1) ... 58s Setting up python3 (3.13.7-2) ... 58s running python rtupdate hooks for python3.13... 58s running python post-rtupdate hooks for python3.13... 58s Setting up gir1.2-girepository-2.0:s390x (1.86.0-6) ... 58s Processing triggers for man-db (2.13.1-1) ... 59s Processing triggers for libc-bin (2.42-0ubuntu3) ... 59s autopkgtest [17:40:06]: upgrading testbed (apt dist-upgrade and autopurge) 60s Reading package lists... 60s Building dependency tree... 60s Reading state information... 60s Calculating upgrade... 60s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 60s Reading package lists... 61s Building dependency tree... 61s Reading state information... 61s Solving dependencies... 61s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 61s autopkgtest [17:40:08]: rebooting testbed after setup commands that affected boot 74s autopkgtest [17:40:21]: testbed running kernel: Linux 6.17.0-5-generic #5-Ubuntu SMP Mon Sep 22 08:56:47 UTC 2025 77s autopkgtest [17:40:24]: @@@@@@@@@@@@@@@@@@@@ apt-source django-fsm-2 78s Get:1 http://ftpmaster.internal/ubuntu resolute/universe django-fsm-2 4.0.0-3 (dsc) [2261 B] 78s Get:2 http://ftpmaster.internal/ubuntu resolute/universe django-fsm-2 4.0.0-3 (tar) [37.2 kB] 78s Get:3 http://ftpmaster.internal/ubuntu resolute/universe django-fsm-2 4.0.0-3 (diff) [2776 B] 78s gpgv: Signature made Mon Apr 21 15:06:33 2025 UTC 78s gpgv: using RSA key 7BF5F6AC36431F5D40DC137A4CF2B218F54DAE3D 78s gpgv: Can't check signature: No public key 78s dpkg-source: warning: cannot verify inline signature for ./django-fsm-2_4.0.0-3.dsc: no acceptable signature found 78s autopkgtest [17:40:25]: testing package django-fsm-2 version 4.0.0-3 79s autopkgtest [17:40:26]: build not needed 79s autopkgtest [17:40:26]: test run-upstream-testapp: preparing testbed 79s Reading package lists... 79s Building dependency tree... 79s Reading state information... 79s Solving dependencies... 79s The following NEW packages will be installed: 79s python3-asgiref python3-django python3-django-fsm-2 python3-django-guardian 79s python3-sqlparse 80s 0 upgraded, 5 newly installed, 0 to remove and 0 not upgraded. 80s Need to get 3174 kB of archives. 80s After this operation, 27.8 MB of additional disk space will be used. 80s Get:1 http://ftpmaster.internal/ubuntu resolute/main s390x python3-asgiref all 3.8.1-1 [24.8 kB] 80s Get:2 http://ftpmaster.internal/ubuntu resolute/main s390x python3-sqlparse all 0.5.3-1 [32.9 kB] 80s Get:3 http://ftpmaster.internal/ubuntu resolute/main s390x python3-django all 3:5.2.4-1ubuntu2 [3036 kB] 81s Get:4 http://ftpmaster.internal/ubuntu resolute/universe s390x python3-django-fsm-2 all 4.0.0-3 [17.1 kB] 81s Get:5 http://ftpmaster.internal/ubuntu resolute/universe s390x python3-django-guardian all 2.4.0-4 [63.1 kB] 81s Fetched 3174 kB in 1s (2712 kB/s) 81s Selecting previously unselected package python3-asgiref. 81s (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 ... 56852 files and directories currently installed.) 81s Preparing to unpack .../python3-asgiref_3.8.1-1_all.deb ... 81s Unpacking python3-asgiref (3.8.1-1) ... 81s Selecting previously unselected package python3-sqlparse. 81s Preparing to unpack .../python3-sqlparse_0.5.3-1_all.deb ... 81s Unpacking python3-sqlparse (0.5.3-1) ... 81s Selecting previously unselected package python3-django. 81s Preparing to unpack .../python3-django_3%3a5.2.4-1ubuntu2_all.deb ... 81s Unpacking python3-django (3:5.2.4-1ubuntu2) ... 81s Selecting previously unselected package python3-django-fsm-2. 81s Preparing to unpack .../python3-django-fsm-2_4.0.0-3_all.deb ... 81s Unpacking python3-django-fsm-2 (4.0.0-3) ... 81s Selecting previously unselected package python3-django-guardian. 81s Preparing to unpack .../python3-django-guardian_2.4.0-4_all.deb ... 81s Unpacking python3-django-guardian (2.4.0-4) ... 81s Setting up python3-sqlparse (0.5.3-1) ... 81s Setting up python3-asgiref (3.8.1-1) ... 81s Setting up python3-django (3:5.2.4-1ubuntu2) ... 82s Setting up python3-django-fsm-2 (4.0.0-3) ... 82s Setting up python3-django-guardian (2.4.0-4) ... 83s Processing triggers for man-db (2.13.1-1) ... 84s autopkgtest [17:40:31]: test run-upstream-testapp: [----------------------- 84s Creating test database for alias 'default' ('file:memorydb_default?mode=memory&cache=shared')... 85s test_usecase (tests.testapp.tests.test_access_deferred_fsm_field.Test.test_usecase) ... ok 85s test_all_transitions_have_custom_data (tests.testapp.tests.test_custom_data.CustomTransitionDataTest.test_all_transitions_have_custom_data) ... ok 85s test_initial_state (tests.testapp.tests.test_custom_data.CustomTransitionDataTest.test_initial_state) ... ok 85s test_state_changed_after_fail (tests.testapp.tests.test_exception_transitions.FSMFieldExceptionTest.test_state_changed_after_fail) ... ok 85s test_state_not_changed_after_fail (tests.testapp.tests.test_exception_transitions.FSMFieldExceptionTest.test_state_not_changed_after_fail) ... ok 85s test_concurrent_modifications_after_refresh_db_succeed (tests.testapp.tests.test_lock_mixin.TestLockMixin.test_concurrent_modifications_after_refresh_db_succeed) ... ok 85s test_concurrent_modifications_raise_exception (tests.testapp.tests.test_lock_mixin.TestLockMixin.test_concurrent_modifications_raise_exception) ... ok 85s test_create_succeed (tests.testapp.tests.test_lock_mixin.TestLockMixin.test_create_succeed) ... ok 85s test_crud_succeed (tests.testapp.tests.test_lock_mixin.TestLockMixin.test_crud_succeed) ... ok 85s test_inheritance_crud_succeed (tests.testapp.tests.test_lock_mixin.TestLockMixin.test_inheritance_crud_succeed) ... ok 85s test_save_and_change_succeed (tests.testapp.tests.test_lock_mixin.TestLockMixin.test_save_and_change_succeed) ... ok 85s test_usecase (tests.testapp.tests.test_mixin_support.Test.test_usecase) ... ok 85s test_model_objects_create (tests.testapp.tests.test_model_create_with_generic.Test.test_model_objects_create) 85s Check a model with state field can be created ... ok 85s test_get_state_succeed (tests.testapp.tests.test_multi_resultstate.Test.test_get_state_succeed) ... ok 85s test_return_state_succeed (tests.testapp.tests.test_multi_resultstate.Test.test_return_state_succeed) ... ok 85s test_signals_called_with_get_state (tests.testapp.tests.test_multi_resultstate.TestSignals.test_signals_called_with_get_state) ... ok 85s test_signals_called_with_return_value (tests.testapp.tests.test_multi_resultstate.TestSignals.test_signals_called_with_return_value) ... ok 85s test_transition_method_called_once (tests.testapp.tests.test_multidecorators.TestStateProxy.test_transition_method_called_once) ... ok 85s test_object_only_access_success (tests.testapp.tests.test_object_permissions.ObjectPermissionFSMFieldTest.test_object_only_access_success) ... ok 85s test_object_only_other_access_prohibited (tests.testapp.tests.test_object_permissions.ObjectPermissionFSMFieldTest.test_object_only_other_access_prohibited) ... ok 85s test_permission_instance_method (tests.testapp.tests.test_permissions.PermissionFSMFieldTest.test_permission_instance_method) ... ok 85s test_proviledged_access_succed (tests.testapp.tests.test_permissions.PermissionFSMFieldTest.test_proviledged_access_succed) ... ok 85s test_unpriviledged_access_prohibited (tests.testapp.tests.test_permissions.PermissionFSMFieldTest.test_unpriviledged_access_prohibited) ... ok 85s test_initial_proxy_set_succeed (tests.testapp.tests.test_state_transitions.TestStateProxy.test_initial_proxy_set_succeed) ... ok 85s test_load_proxy_set (tests.testapp.tests.test_state_transitions.TestStateProxy.test_load_proxy_set) ... ok 85s test_transition_proxy_set_succeed (tests.testapp.tests.test_state_transitions.TestStateProxy.test_transition_proxy_set_succeed) ... ok 85s test_initial_state (tests.testapp.tests.test_string_field_parameter.StringFieldTestCase.test_initial_state) ... ok 85s test_usecase (tests.testapp.tests.test_transition_all_except_target.Test.test_usecase) ... ok 85s 85s ---------------------------------------------------------------------- 85s Ran 28 tests in 0.042s 85s 85s OK 85s Destroying test database for alias 'default' ('file:memorydb_default?mode=memory&cache=shared')... 85s Found 28 test(s). 85s Operations to perform: 85s Synchronize unmigrated apps: auth, contenttypes, django_fsm, guardian, testapp 85s Apply all migrations: (none) 85s Synchronizing apps without migrations: 85s Creating tables... 85s Creating table django_content_type 85s Creating table auth_permission 85s Creating table auth_group 85s Creating table auth_user 85s Creating table guardian_userobjectpermission 85s Creating table guardian_groupobjectpermission 85s Creating table testapp_application 85s Creating table testapp_fkapplication 85s Creating table testapp_dbstate 85s Creating table testapp_blogpost 85s Creating table testapp_deferrablemodel 85s Creating table testapp_blogpostwithcustomdata 85s Creating table testapp_exceptionalblogpost 85s Creating table testapp_lockedblogpost 85s Creating table testapp_extendedblogpost 85s Creating table testapp_mixinsupporttestmodel 85s Creating table testapp_ticket 85s Creating table testapp_task 85s Creating table testapp_multiresulttest 85s Creating table testapp_testmodel 85s Creating table testapp_objectpermissiontestmodel 85s Creating table testapp_insect 85s Creating table testapp_blogpostwithstringfield 85s Creating table testapp_testexcepttargettransitionshortcut 85s Running deferred SQL... 85s Running migrations: 85s No migrations to apply. 85s System check identified no issues (0 silenced). 85s autopkgtest [17:40:32]: test run-upstream-testapp: -----------------------] 85s autopkgtest [17:40:32]: test run-upstream-testapp: - - - - - - - - - - results - - - - - - - - - - 85s run-upstream-testapp PASS 86s autopkgtest [17:40:33]: @@@@@@@@@@@@@@@@@@@@ summary 86s run-upstream-testapp PASS