0s autopkgtest [14:10:35]: starting date and time: 2024-11-13 14:10:35+0000 0s autopkgtest [14:10:35]: git checkout: 6f3be7a8 Fix armhf LXD image generation for plucky 0s autopkgtest [14:10:35]: host juju-7f2275-prod-proposed-migration-environment-20; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.49_gif5j/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:python3-defaults,src:python3-stdlib-extensions --apt-upgrade python-docx-template --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 '--env=ADT_TEST_TRIGGERS=python3-defaults/3.12.7-1 python3-stdlib-extensions/3.12.7-1' -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest-s390x --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-20@bos03-s390x-10.secgroup --name adt-plucky-s390x-python-docx-template-20241113-141035-juju-7f2275-prod-proposed-migration-environment-20-fd79071a-e77a-452b-8aeb-80cfac46e75d --image adt/ubuntu-plucky-s390x-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-20 --net-id=net_prod-proposed-migration-s390x -e TERM=linux -e ''"'"'http_proxy=http://squid.internal:3128'"'"'' -e ''"'"'https_proxy=http://squid.internal:3128'"'"'' -e ''"'"'no_proxy=127.0.0.1,127.0.1.1,login.ubuntu.com,localhost,localdomain,novalocal,internal,archive.ubuntu.com,ports.ubuntu.com,security.ubuntu.com,ddebs.ubuntu.com,changelogs.ubuntu.com,keyserver.ubuntu.com,launchpadlibrarian.net,launchpadcontent.net,launchpad.net,10.24.0.0/24,keystone.ps5.canonical.com,objectstorage.prodstack5.canonical.com'"'"'' --mirror=http://ftpmaster.internal/ubuntu/ 107s autopkgtest [14:12:22]: testbed dpkg architecture: s390x 108s autopkgtest [14:12:23]: testbed apt version: 2.9.8 108s autopkgtest [14:12:23]: @@@@@@@@@@@@@@@@@@@@ test bed setup 108s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [73.9 kB] 109s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [16.5 kB] 109s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/restricted Sources [7016 B] 109s Get:4 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [104 kB] 109s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [967 kB] 109s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x Packages [107 kB] 109s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/universe s390x Packages [641 kB] 109s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse s390x Packages [17.4 kB] 109s Fetched 1934 kB in 1s (2216 kB/s) 109s Reading package lists... 112s Reading package lists... 112s Building dependency tree... 112s Reading state information... 112s Calculating upgrade... 112s The following NEW packages will be installed: 112s python3.13-gdbm 112s The following packages will be upgraded: 112s libgpgme11t64 libpython3-stdlib python3 python3-gdbm python3-minimal 112s 5 upgraded, 1 newly installed, 0 to remove and 0 not upgraded. 112s Need to get 252 kB of archives. 112s After this operation, 98.3 kB of additional disk space will be used. 112s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x python3-minimal s390x 3.12.7-1 [27.4 kB] 112s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x python3 s390x 3.12.7-1 [24.0 kB] 112s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x libpython3-stdlib s390x 3.12.7-1 [10.0 kB] 112s Get:4 http://ftpmaster.internal/ubuntu plucky/main s390x python3.13-gdbm s390x 3.13.0-2 [31.0 kB] 112s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x python3-gdbm s390x 3.12.7-1 [8642 B] 112s Get:6 http://ftpmaster.internal/ubuntu plucky/main s390x libgpgme11t64 s390x 1.23.2-5ubuntu4 [151 kB] 113s Fetched 252 kB in 0s (609 kB/s) 113s (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 ... 55510 files and directories currently installed.) 113s Preparing to unpack .../python3-minimal_3.12.7-1_s390x.deb ... 113s Unpacking python3-minimal (3.12.7-1) over (3.12.6-0ubuntu1) ... 113s Setting up python3-minimal (3.12.7-1) ... 113s (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 ... 55510 files and directories currently installed.) 113s Preparing to unpack .../python3_3.12.7-1_s390x.deb ... 113s Unpacking python3 (3.12.7-1) over (3.12.6-0ubuntu1) ... 113s Preparing to unpack .../libpython3-stdlib_3.12.7-1_s390x.deb ... 113s Unpacking libpython3-stdlib:s390x (3.12.7-1) over (3.12.6-0ubuntu1) ... 113s Selecting previously unselected package python3.13-gdbm. 113s Preparing to unpack .../python3.13-gdbm_3.13.0-2_s390x.deb ... 113s Unpacking python3.13-gdbm (3.13.0-2) ... 113s Preparing to unpack .../python3-gdbm_3.12.7-1_s390x.deb ... 113s Unpacking python3-gdbm:s390x (3.12.7-1) over (3.12.6-1ubuntu1) ... 113s Preparing to unpack .../libgpgme11t64_1.23.2-5ubuntu4_s390x.deb ... 113s Unpacking libgpgme11t64:s390x (1.23.2-5ubuntu4) over (1.18.0-4.1ubuntu4) ... 113s Setting up libgpgme11t64:s390x (1.23.2-5ubuntu4) ... 113s Setting up python3.13-gdbm (3.13.0-2) ... 113s Setting up libpython3-stdlib:s390x (3.12.7-1) ... 113s Setting up python3 (3.12.7-1) ... 113s Setting up python3-gdbm:s390x (3.12.7-1) ... 113s Processing triggers for man-db (2.12.1-3) ... 114s Processing triggers for libc-bin (2.40-1ubuntu3) ... 114s Reading package lists... 114s Building dependency tree... 114s Reading state information... 114s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 115s Hit:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease 115s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease 115s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease 115s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease 116s Reading package lists... 116s Reading package lists... 116s Building dependency tree... 116s Reading state information... 116s Calculating upgrade... 116s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 116s Reading package lists... 117s Building dependency tree... 117s Reading state information... 117s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 119s autopkgtest [14:12:34]: testbed running kernel: Linux 6.11.0-8-generic #8-Ubuntu SMP Mon Sep 16 12:49:35 UTC 2024 119s autopkgtest [14:12:34]: @@@@@@@@@@@@@@@@@@@@ apt-source python-docx-template 121s Get:1 http://ftpmaster.internal/ubuntu plucky/universe python-docx-template 0.18.0+dfsg-1 (dsc) [2360 B] 121s Get:2 http://ftpmaster.internal/ubuntu plucky/universe python-docx-template 0.18.0+dfsg-1 (tar) [1526 kB] 121s Get:3 http://ftpmaster.internal/ubuntu plucky/universe python-docx-template 0.18.0+dfsg-1 (diff) [2816 B] 121s gpgv: Signature made Tue Jul 30 21:32:30 2024 UTC 121s gpgv: using RSA key 8F6DE104377F3B11E741748731F3144544A1741A 121s gpgv: issuer "tchet@debian.org" 121s gpgv: Can't check signature: No public key 121s dpkg-source: warning: cannot verify inline signature for ./python-docx-template_0.18.0+dfsg-1.dsc: no acceptable signature found 122s autopkgtest [14:12:36]: testing package python-docx-template version 0.18.0+dfsg-1 122s autopkgtest [14:12:37]: build not needed 123s autopkgtest [14:12:38]: test command1: preparing testbed 125s Reading package lists... 125s Building dependency tree... 125s Reading state information... 125s Starting pkgProblemResolver with broken count: 0 125s Starting 2 pkgProblemResolver with broken count: 0 125s Done 126s The following additional packages will be installed: 126s libdeflate0 libjbig0 libjpeg-turbo8 libjpeg8 libnetpbm11t64 libqrencode4 126s libsharpyuv0 libtiff6 libwebp7 libxslt1.1 netpbm python3-docx 126s python3-docxcompose python3-docxtpl python3-lxml qrencode 126s Suggested packages: 126s python-lxml-doc 126s Recommended packages: 126s ghostscript python3-bs4 python3-cssselect python3-html5lib 126s The following NEW packages will be installed: 126s autopkgtest-satdep libdeflate0 libjbig0 libjpeg-turbo8 libjpeg8 126s libnetpbm11t64 libqrencode4 libsharpyuv0 libtiff6 libwebp7 libxslt1.1 netpbm 126s python3-docx python3-docxcompose python3-docxtpl python3-lxml qrencode 126s 0 upgraded, 17 newly installed, 0 to remove and 0 not upgraded. 126s Need to get 4728 kB/4729 kB of archives. 126s After this operation, 17.5 MB of additional disk space will be used. 126s Get:1 /tmp/autopkgtest.EM0l0U/1-autopkgtest-satdep.deb autopkgtest-satdep s390x 0 [728 B] 126s Get:2 http://ftpmaster.internal/ubuntu plucky/main s390x libdeflate0 s390x 1.22-1 [46.1 kB] 126s Get:3 http://ftpmaster.internal/ubuntu plucky/main s390x libjpeg-turbo8 s390x 2.1.5-2ubuntu2 [150 kB] 126s Get:4 http://ftpmaster.internal/ubuntu plucky/main s390x libjpeg8 s390x 8c-2ubuntu11 [2146 B] 126s Get:5 http://ftpmaster.internal/ubuntu plucky/universe s390x libnetpbm11t64 s390x 2:11.08.01-1 [124 kB] 126s Get:6 http://ftpmaster.internal/ubuntu plucky/universe s390x libqrencode4 s390x 4.1.1-1build2 [27.7 kB] 126s Get:7 http://ftpmaster.internal/ubuntu plucky/main s390x libsharpyuv0 s390x 1.4.0-0.1 [16.2 kB] 126s Get:8 http://ftpmaster.internal/ubuntu plucky/main s390x libjbig0 s390x 2.1-6.1ubuntu2 [33.1 kB] 126s Get:9 http://ftpmaster.internal/ubuntu plucky/main s390x libwebp7 s390x 1.4.0-0.1 [204 kB] 126s Get:10 http://ftpmaster.internal/ubuntu plucky/main s390x libtiff6 s390x 4.5.1+git230720-4ubuntu4 [217 kB] 126s Get:11 http://ftpmaster.internal/ubuntu plucky/main s390x libxslt1.1 s390x 1.1.39-0exp1ubuntu1 [169 kB] 126s Get:12 http://ftpmaster.internal/ubuntu plucky/universe s390x netpbm s390x 2:11.08.01-1 [2202 kB] 126s Get:13 http://ftpmaster.internal/ubuntu plucky/main s390x python3-lxml s390x 5.3.0-1 [1314 kB] 126s Get:14 http://ftpmaster.internal/ubuntu plucky/universe s390x python3-docx all 1.1.2+dfsg-1 [158 kB] 126s Get:15 http://ftpmaster.internal/ubuntu plucky/universe s390x python3-docxcompose all 1.4.0-3 [20.5 kB] 126s Get:16 http://ftpmaster.internal/ubuntu plucky/universe s390x python3-docxtpl all 0.18.0+dfsg-1 [18.5 kB] 126s Get:17 http://ftpmaster.internal/ubuntu plucky/universe s390x qrencode s390x 4.1.1-1build2 [27.1 kB] 127s Fetched 4728 kB in 1s (6089 kB/s) 127s Selecting previously unselected package libdeflate0:s390x. 127s (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 ... 55517 files and directories currently installed.) 127s Preparing to unpack .../00-libdeflate0_1.22-1_s390x.deb ... 127s Unpacking libdeflate0:s390x (1.22-1) ... 127s Selecting previously unselected package libjpeg-turbo8:s390x. 127s Preparing to unpack .../01-libjpeg-turbo8_2.1.5-2ubuntu2_s390x.deb ... 127s Unpacking libjpeg-turbo8:s390x (2.1.5-2ubuntu2) ... 127s Selecting previously unselected package libjpeg8:s390x. 127s Preparing to unpack .../02-libjpeg8_8c-2ubuntu11_s390x.deb ... 127s Unpacking libjpeg8:s390x (8c-2ubuntu11) ... 127s Selecting previously unselected package libnetpbm11t64:s390x. 127s Preparing to unpack .../03-libnetpbm11t64_2%3a11.08.01-1_s390x.deb ... 127s Unpacking libnetpbm11t64:s390x (2:11.08.01-1) ... 127s Selecting previously unselected package libqrencode4:s390x. 127s Preparing to unpack .../04-libqrencode4_4.1.1-1build2_s390x.deb ... 127s Unpacking libqrencode4:s390x (4.1.1-1build2) ... 127s Selecting previously unselected package libsharpyuv0:s390x. 127s Preparing to unpack .../05-libsharpyuv0_1.4.0-0.1_s390x.deb ... 127s Unpacking libsharpyuv0:s390x (1.4.0-0.1) ... 127s Selecting previously unselected package libjbig0:s390x. 127s Preparing to unpack .../06-libjbig0_2.1-6.1ubuntu2_s390x.deb ... 127s Unpacking libjbig0:s390x (2.1-6.1ubuntu2) ... 127s Selecting previously unselected package libwebp7:s390x. 127s Preparing to unpack .../07-libwebp7_1.4.0-0.1_s390x.deb ... 127s Unpacking libwebp7:s390x (1.4.0-0.1) ... 127s Selecting previously unselected package libtiff6:s390x. 127s Preparing to unpack .../08-libtiff6_4.5.1+git230720-4ubuntu4_s390x.deb ... 127s Unpacking libtiff6:s390x (4.5.1+git230720-4ubuntu4) ... 127s Selecting previously unselected package libxslt1.1:s390x. 127s Preparing to unpack .../09-libxslt1.1_1.1.39-0exp1ubuntu1_s390x.deb ... 127s Unpacking libxslt1.1:s390x (1.1.39-0exp1ubuntu1) ... 127s Selecting previously unselected package netpbm. 127s Preparing to unpack .../10-netpbm_2%3a11.08.01-1_s390x.deb ... 127s Unpacking netpbm (2:11.08.01-1) ... 127s Selecting previously unselected package python3-lxml:s390x. 127s Preparing to unpack .../11-python3-lxml_5.3.0-1_s390x.deb ... 127s Unpacking python3-lxml:s390x (5.3.0-1) ... 127s Selecting previously unselected package python3-docx. 127s Preparing to unpack .../12-python3-docx_1.1.2+dfsg-1_all.deb ... 127s Unpacking python3-docx (1.1.2+dfsg-1) ... 127s Selecting previously unselected package python3-docxcompose. 127s Preparing to unpack .../13-python3-docxcompose_1.4.0-3_all.deb ... 127s Unpacking python3-docxcompose (1.4.0-3) ... 127s Selecting previously unselected package python3-docxtpl. 127s Preparing to unpack .../14-python3-docxtpl_0.18.0+dfsg-1_all.deb ... 127s Unpacking python3-docxtpl (0.18.0+dfsg-1) ... 127s Selecting previously unselected package qrencode. 127s Preparing to unpack .../15-qrencode_4.1.1-1build2_s390x.deb ... 127s Unpacking qrencode (4.1.1-1build2) ... 127s Selecting previously unselected package autopkgtest-satdep. 127s Preparing to unpack .../16-1-autopkgtest-satdep.deb ... 127s Unpacking autopkgtest-satdep (0) ... 127s Setting up libsharpyuv0:s390x (1.4.0-0.1) ... 127s Setting up libqrencode4:s390x (4.1.1-1build2) ... 127s Setting up qrencode (4.1.1-1build2) ... 127s Setting up libdeflate0:s390x (1.22-1) ... 127s Setting up libjbig0:s390x (2.1-6.1ubuntu2) ... 127s Setting up libnetpbm11t64:s390x (2:11.08.01-1) ... 127s Setting up libjpeg-turbo8:s390x (2.1.5-2ubuntu2) ... 127s Setting up libwebp7:s390x (1.4.0-0.1) ... 127s Setting up libxslt1.1:s390x (1.1.39-0exp1ubuntu1) ... 127s Setting up libjpeg8:s390x (8c-2ubuntu11) ... 127s Setting up python3-lxml:s390x (5.3.0-1) ... 127s Setting up libtiff6:s390x (4.5.1+git230720-4ubuntu4) ... 127s Setting up python3-docx (1.1.2+dfsg-1) ... 127s Setting up python3-docxcompose (1.4.0-3) ... 127s Setting up python3-docxtpl (0.18.0+dfsg-1) ... 127s Setting up netpbm (2:11.08.01-1) ... 127s Setting up autopkgtest-satdep (0) ... 127s Processing triggers for man-db (2.12.1-3) ... 128s Processing triggers for libc-bin (2.40-1ubuntu3) ... 130s (Reading database ... 56670 files and directories currently installed.) 130s Removing autopkgtest-satdep (0) ... 131s autopkgtest [14:12:46]: test command1: make -f debian/rules override_dh_auto_test 131s autopkgtest [14:12:46]: test command1: [----------------------- 131s qrencode --output debian/test.png TEST 131s pngtopnm debian/test.png | pnmtojpeg > debian/test.jpg 131s cp debian/test.png tests/templates/dummy_pic_for_header.png 131s cp debian/test.png tests/templates/python_logo.png 131s cp debian/test.png tests/templates/django.png 131s cp debian/test.png tests/templates/python.png 131s cp debian/test.png tests/templates/zope.png 131s cp debian/test.png tests/templates/bottle.png 131s cp debian/test.png tests/templates/tornado.png 131s cp debian/test.png tests/templates/pyramid.png 131s cp debian/test.jpg tests/templates/python_jpeg.jpg 131s cd tests && PYTHONPATH=$(find ../.pybuild -name build 2>/dev/null | xargs echo | tr ' ' :) python3 runtests.py 135s Executing "python3 -m docxtpl templates/module_execute_tpl.docx templates/module_execute.json output/module_execute.docx -o -q" ... 135s --> File output/module_execute.docx has been generated. 137s ================================================================================ 137s Generating template error for testing (so it is safe to ignore) : 137s ................................................................................ 137s Encountered unknown tag 'endif'. 137s Context: 137s I am the second paragraph. 137s I am the third paragraph. 137s I am the fourth paragraph. 137s I am the fifth paragraph. {% if test_variable %}I am part of it, too.{% endif %} {% endif %} 137s I am the sixth paragraph. 137s I am the seventh paragraph. 137s I am the eighth paragraph. 137s ................................................................................ 137s End of TemplateError Test 137s ================================================================================ 138s cellbg.py ... 138s comments.py ... 138s custom_jinja_filters.py ... 138s doc_properties.py ... 138s dynamic_table.py ... 138s embedded.py ... 138s escape.py ... 138s escape_auto.py ... 138s header_footer.py ... 138s header_footer_entities.py ... 138s header_footer_image.py ... 138s header_footer_image_file_obj.py ... 138s header_footer_inline_image.py ... 138s header_footer_utf8.py ... 138s horizontal_merge.py ... 138s inline_image.py ... 138s less_cells_after_loop.py ... 138s merge_docx.py ... 138s merge_paragraph.py ... 138s module_execute.py ... 138s multi_rendering.py ... 138s nested_for.py ... 138s order.py ... 138s preserve_spaces.py ... 138s replace_picture.py ... 138s richtext.py ... 138s richtext_and_if.py ... 138s richtext_eastAsia.py ... 138s subdoc.py ... 138s template_error.py ... 138s vertical_merge.py ... 138s vertical_merge_nested.py ... 138s word2016.py ... 138s Done. 138s autopkgtest [14:12:53]: test command1: -----------------------] 139s autopkgtest [14:12:54]: test command1: - - - - - - - - - - results - - - - - - - - - - 139s command1 PASS 139s autopkgtest [14:12:54]: @@@@@@@@@@@@@@@@@@@@ summary 139s command1 PASS 152s nova [W] Using flock in prodstack6-s390x 152s flock: timeout while waiting to get lock 152s Creating nova instance adt-plucky-s390x-python-docx-template-20241113-141035-juju-7f2275-prod-proposed-migration-environment-20-fd79071a-e77a-452b-8aeb-80cfac46e75d from image adt/ubuntu-plucky-s390x-server-20241113.img (UUID e740277e-1f72-40ae-bfbe-46030537c71c)...